VMware-Forum

Inoffizielles, unabhängiges deutsches VMware-Forum
https://vmware-forum.de/

.. the migration has exceeded the maximum switchover time

https://vmware-forum.de/viewtopic.php?f=36&t=28888

Seite 1 von 1

.. the migration has exceeded the maximum switchover time

Verfasst: 26.08.2013, 11:04
von Thogus
Hallo zusammen,

nachdem ich im offiziellen Community-Forum von vmware bis heute keine Antwort auf mein Problem bekommen habe, versuche ich es bei euch in der Hoffnung, dass mir hier jemand helfen kann.

Unser Aufbau:

2x ESX 5.1 Hosts
2x Switches
2x SANs

Anbindung über 10Gbit iSCSI
Maschinen laufen nur auf dem esxhost-A, esxhost-B ist ausschließlich als Hotstandby-Maschine aktiv (vCenter-Server und HA-Funktion vorhanden)

Sachverhalt:

Wir sind, was die Ressourcen der Hosts angeht, an das Maximum des Arbeitsspeichers gelangt und waren gezwungen, diesen zu erweitern. Durch unsere Redundanz schien mir das kein Problem zu sein, ohne eine Downtime der rund 30 Maschinen anzusetzen.

Gedanke: "Einfach esxhost-B runterfahren, Speicher erweitern, esxhost-B hochfahren, alle Maschinen von esxhost-A nach esxhost-B migrieren, esxhost-A runterfahren, Speicher erweitern, wieder hochfahren und schlussendlich die Maschinen wieder zurück migrieren."

Alles funktionierte auch bis auf den letzten Schritt. Die Migration zurück auf das A-System schlägt bei allen Maschinen fehl (Fehler im Anhang).

Aktuell laufen somit alle Maschinen auf dem esxhost-B und bei einem Ausfall würde die HA-Funktion nicht greifen können, da die Hot-migration von B -> A nicht funktioniert.

Ich habe testweise eine Maschine heruntergefahren und dann migriert. Das funktionierte ohne Probleme. Ich konnte diese VM auch vom esxhost-A zum esxhost-B migrieren während sie lief, jedoch dann wiederrum nicht zurück zum esxhost-A migrieren. Das Problem scheint somit auf dem B-System zu liegen. Die Logdateien zeigen mir jedoch nicht wirklich, wo das Problem liegt.


Fehlermeldung im vSphere Client:

Bild

Vielen Dank im Voraus und ich hoffe, ihr könnt mir helfen. Wenn noch Informationen notwendig sind, ich stelle gerne alles bereit, was ich bereitstellen kann ;)

Mit freundlichen Grüßen
Thomas

hostd.log vom 21.08.2013

Verfasst: 26.08.2013, 11:10
von Thogus
hostd.log vom 21.08.2013 (zu dieser Zeit trat der Fehler auch auf):

Code: Alles auswählen

2013-08-21T08:26:10.331Z [4842FB90 info 'Snmpsvc'] VmConfigListener: vm state change received, queueing reload request
SIOC: SIOC is notified not to start injector
2013-08-21T08:26:10.334Z [482DBB90 verbose 'VMotionSrc (1377073575569460)' opID=5DB0DEC8-00001F2D-d8-50-ba] Migration changed state from NONE to BEGIN
2013-08-21T08:26:10.334Z [482DBB90 info 'VMotion' opID=5DB0DEC8-00001F2D-d8-50-ba] Completed scheduling PrepareSourceEx [1377073575569460].
2013-08-21T08:26:10.334Z [48116B90 info 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx']  Disconnect check in progress.
2013-08-21T08:26:10.341Z [48320B90 info 'ha-host'] vmxSwapEnabled = true vmmOvhd.anonymous: 12048 vmmOvhd.paged: 50002 vmmOvhd.nonpaged: 12485
2013-08-21T08:26:10.341Z [48320B90 info 'ha-host'] vmkOvhd.fixd = 303104 vmkOvhd.variable: 2050 vmkOvhd.selfSwap: 3145728
2013-08-21T08:26:10.341Z [48320B90 info 'ha-host'] Computed from lib overhead: 100487168 for (memPages: 262144, fbSize: 1024, #vcpus: 1, #lsiscsi: 1, #pvscsi: 0, #passthru: 0, #network: 1) vmkOverhead: 5548032
2013-08-21T08:26:10.341Z [48320B90 info 'ha-host'] overhead result (no CBRC): 106033152
2013-08-21T08:26:10.341Z [48320B90 info 'ha-host'] Predicted overhead: 106033152 for (memory: 1073741824, video: 4194304, #vcpus: 1, autodetect: false, enable3D: false, svgaPtFbSize: 4194304, cbrcOverhead: 0
2013-08-21T08:26:10.342Z [FFCADD20 info 'ha-host'] vmxSwapEnabled = true vmmOvhd.anonymous: 12048 vmmOvhd.paged: 50002 vmmOvhd.nonpaged: 12485
2013-08-21T08:26:10.342Z [FFCADD20 info 'ha-host'] vmkOvhd.fixd = 303104 vmkOvhd.variable: 2050 vmkOvhd.selfSwap: 3145728
2013-08-21T08:26:10.342Z [FFCADD20 info 'ha-host'] Computed from lib overhead: 100487168 for (memPages: 262144, fbSize: 1024, #vcpus: 1, #lsiscsi: 1, #pvscsi: 0, #passthru: 0, #network: 1) vmkOverhead: 5548032
2013-08-21T08:26:10.342Z [FFCADD20 info 'ha-host'] overhead result (no CBRC): 106033152
2013-08-21T08:26:10.342Z [FFCADD20 info 'ha-host'] Predicted overhead: 106033152 for (memory: 1073741824, video: 4194304, #vcpus: 1, autodetect: false, enable3D: false, svgaPtFbSize: 4194304, cbrcOverhead: 0
2013-08-21T08:26:10.388Z [48320B90 info 'ha-host'] vmxSwapEnabled = true vmmOvhd.anonymous: 12048 vmmOvhd.paged: 50002 vmmOvhd.nonpaged: 12485
2013-08-21T08:26:10.388Z [48320B90 info 'ha-host'] vmkOvhd.fixd = 303104 vmkOvhd.variable: 2050 vmkOvhd.selfSwap: 3145728
2013-08-21T08:26:10.389Z [48320B90 info 'ha-host'] Computed from lib overhead: 100487168 for (memPages: 262144, fbSize: 1024, #vcpus: 1, #lsiscsi: 1, #pvscsi: 0, #passthru: 0, #network: 1) vmkOverhead: 5548032
2013-08-21T08:26:10.389Z [48320B90 info 'ha-host'] overhead result (no CBRC): 106033152
2013-08-21T08:26:10.389Z [48320B90 info 'ha-host'] Predicted overhead: 106033152 for (memory: 1073741824, video: 4194304, #vcpus: 1, autodetect: false, enable3D: false, svgaPtFbSize: 4194304, cbrcOverhead: 0
2013-08-21T08:26:10.389Z [48320B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] Time to gather config: 6 (msecs)
2013-08-21T08:26:10.389Z [482DBB90 verbose 'Hbrsvc'] Replicator: ReconfigListener triggered for config VM 11
2013-08-21T08:26:10.396Z [48320B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] VMotionLastStatusCb:: hostlog state changed from none to emigrating
2013-08-21T08:26:10.396Z [48320B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] VMotionCmdCb [1377073575569460] 'to': done
2013-08-21T08:26:10.396Z [482DBB90 verbose 'Hbrsvc'] Replicator: VmReconfig ignoring VM 11 not configured for replication
2013-08-21T08:26:10.397Z [482DBB90 info 'Snmpsvc'] VmConfigListener: vm state change received, queueing reload request
2013-08-21T08:26:10.397Z [482DBB90 info 'Snmpsvc'] QueueReloadRequest: reload already scheduled, discarding event
2013-08-21T08:26:10.398Z [48320B90 info 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] VMotionCmdCb [1377073575569460] : Prepare task completed successfully
2013-08-21T08:26:10.404Z [FFCADD20 info 'ha-host'] vmxSwapEnabled = true vmmOvhd.anonymous: 12048 vmmOvhd.paged: 50002 vmmOvhd.nonpaged: 12485
2013-08-21T08:26:10.404Z [FFCADD20 info 'ha-host'] vmkOvhd.fixd = 303104 vmkOvhd.variable: 2050 vmkOvhd.selfSwap: 3145728
2013-08-21T08:26:10.404Z [FFCADD20 info 'ha-host'] Computed from lib overhead: 100487168 for (memPages: 262144, fbSize: 1024, #vcpus: 1, #lsiscsi: 1, #pvscsi: 0, #passthru: 0, #network: 1) vmkOverhead: 5548032
2013-08-21T08:26:10.404Z [FFCADD20 info 'ha-host'] overhead result (no CBRC): 106033152
2013-08-21T08:26:10.404Z [FFCADD20 info 'ha-host'] Predicted overhead: 106033152 for (memory: 1073741824, video: 4194304, #vcpus: 1, autodetect: false, enable3D: false, svgaPtFbSize: 4194304, cbrcOverhead: 0
2013-08-21T08:26:10.406Z [483ADB90 info 'ha-host'] vmxSwapEnabled = true vmmOvhd.anonymous: 12048 vmmOvhd.paged: 50002 vmmOvhd.nonpaged: 12485
2013-08-21T08:26:10.406Z [483ADB90 info 'ha-host'] vmkOvhd.fixd = 303104 vmkOvhd.variable: 2050 vmkOvhd.selfSwap: 3145728
2013-08-21T08:26:10.406Z [483ADB90 info 'ha-host'] Computed from lib overhead: 100487168 for (memPages: 262144, fbSize: 1024, #vcpus: 1, #lsiscsi: 1, #pvscsi: 0, #passthru: 0, #network: 1) vmkOverhead: 5548032
2013-08-21T08:26:10.406Z [483ADB90 info 'ha-host'] overhead result (no CBRC): 106033152
2013-08-21T08:26:10.406Z [483ADB90 info 'ha-host'] Predicted overhead: 106033152 for (memory: 1073741824, video: 4194304, #vcpus: 1, autodetect: false, enable3D: false, svgaPtFbSize: 4194304, cbrcOverhead: 0
2013-08-21T08:26:11.142Z [4842FB90 info 'VMotion' opID=5DB0DEC8-00001F2D-d8-50-53] InitiateSource [1377073575569460], WID = 122315
2013-08-21T08:26:11.142Z [4842FB90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx' opID=5DB0DEC8-00001F2D-d8-50-53] GetWid: begin ReadSynchronized
2013-08-21T08:26:11.142Z [4842FB90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx' opID=5DB0DEC8-00001F2D-d8-50-53] GetWid: end ReadSynchronized
2013-08-21T08:26:11.142Z [4842FB90 info 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx' opID=5DB0DEC8-00001F2D-d8-50-53] GetWid: returning 13628
2013-08-21T08:26:11.142Z [4842FB90 verbose 'Default' opID=5DB0DEC8-00001F2D-d8-50-53] Datastore Accessibility cannot be inferred from relative filepath: ./Foswikitest-d325fe96.hlog
2013-08-21T08:26:11.142Z [4842FB90 verbose 'VMotionSrc (1377073575569460)' opID=5DB0DEC8-00001F2D-d8-50-53] JrnlBegin: VM objID=11 srcIp=172.29.5.129 migrateType=MIGRATE_TYPE_VMOTION
2013-08-21T08:26:11.143Z [4842FB90 verbose 'VMotionSrc (1377073575569460)' opID=5DB0DEC8-00001F2D-d8-50-53] JrnlPutWid: Wrote wid=13628
2013-08-21T08:26:11.143Z [4842FB90 info 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx' opID=5DB0DEC8-00001F2D-d8-50-53] VMotionInitiateSrc (1377073575569460): wid=122315
2013-08-21T08:26:11.143Z [4842FB90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx' opID=5DB0DEC8-00001F2D-d8-50-53] VMotionInitiateSrc: begin ReadSynchronized
2013-08-21T08:26:11.143Z [4842FB90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx' opID=5DB0DEC8-00001F2D-d8-50-53] VMotionInitiateSrc: end ReadSynchronized
2013-08-21T08:26:11.143Z [4842FB90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx' opID=5DB0DEC8-00001F2D-d8-50-53] VMotionInitiateSrc: begin Commit
2013-08-21T08:26:11.143Z [4842FB90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx' opID=5DB0DEC8-00001F2D-d8-50-53] VMotionInitiateSrc: end Commit
2013-08-21T08:26:11.143Z [4842FB90 verbose 'VMotionSrc (1377073575569460)' opID=5DB0DEC8-00001F2D-d8-50-53] Migration changed state from BEGIN to MIGRATING
2013-08-21T08:26:11.143Z [48116B90 info 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx']  Disconnect check in progress.
2013-08-21T08:26:11.150Z [482DBB90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] VMotionCmdCb [1377073575569460] 'start': done
2013-08-21T08:26:15.334Z [47B81B90 info 'Snmpsvc'] DoReport: VM Poll State cache - report starting
2013-08-21T08:26:15.336Z [47B81B90 info 'Snmpsvc'] ReportVMs: processing vm 1
2013-08-21T08:26:15.337Z [47B81B90 info 'Snmpsvc'] ReportVMs: processing vm 2
2013-08-21T08:26:15.339Z [47B81B90 info 'Snmpsvc'] ReportVMs: processing vm 3
2013-08-21T08:26:15.340Z [47B81B90 info 'Snmpsvc'] ReportVMs: processing vm 4
2013-08-21T08:26:15.342Z [47B81B90 info 'Snmpsvc'] ReportVMs: processing vm 5
2013-08-21T08:26:15.343Z [47B81B90 info 'Snmpsvc'] ReportVMs: processing vm 6
2013-08-21T08:26:15.345Z [47B81B90 info 'Snmpsvc'] ReportVMs: processing vm 7
2013-08-21T08:26:15.347Z [47B81B90 info 'Snmpsvc'] ReportVMs: processing vm 8
2013-08-21T08:26:15.348Z [47B81B90 info 'Snmpsvc'] ReportVMs: processing vm 9
2013-08-21T08:26:15.350Z [47B81B90 info 'Snmpsvc'] ReportVMs: processing vm 10
2013-08-21T08:26:15.351Z [47B81B90 info 'Snmpsvc'] ReportVMs: processing vm 11
2013-08-21T08:26:15.353Z [47B81B90 info 'Snmpsvc'] ReportVMs: processing vm 12
2013-08-21T08:26:15.354Z [47B81B90 info 'Snmpsvc'] ReportVMs: processing vm 13
2013-08-21T08:26:15.356Z [47B81B90 info 'Snmpsvc'] ReportVMs: processing vm 14
2013-08-21T08:26:15.358Z [47B81B90 info 'Snmpsvc'] ReportVMs: processing vm 15
2013-08-21T08:26:15.359Z [47B81B90 info 'Snmpsvc'] ReportVMs: processing vm 16
2013-08-21T08:26:15.361Z [47B81B90 info 'Snmpsvc'] ReportVMs: processing vm 17
2013-08-21T08:26:15.362Z [47B81B90 info 'Snmpsvc'] ReportVMs: processing vm 18
2013-08-21T08:26:15.364Z [47B81B90 info 'Snmpsvc'] ReportVMs: processing vm 20
2013-08-21T08:26:15.364Z [47B81B90 info 'Snmpsvc'] ReportVMs: serialized 19 out of 19 vms
2013-08-21T08:26:15.364Z [47B81B90 info 'Snmpsvc'] GenerateFullReport: report file /tmp/.vm-report.xml generated, size 977 bytes.
2013-08-21T08:26:15.364Z [47B81B90 info 'Snmpsvc'] PublishReport: file /tmp/.vm-report.xml published as /tmp/vm-report.xml
2013-08-21T08:26:15.364Z [47B81B90 info 'Snmpsvc'] NotifyAgent: write(81, /var/run/snmp.ctl, V) 1 bytes to snmpd
2013-08-21T08:26:15.364Z [47B81B90 info 'Snmpsvc'] GenerateFullReport: notified snmpd to update vm cache
2013-08-21T08:26:15.364Z [47B81B90 info 'Snmpsvc'] DoReport: VM Poll State cache - report completed ok
2013-08-21T08:26:25.152Z [48470B90 info 'Snmpsvc'] UpdateStats: report cimom converter stats started
2013-08-21T08:26:25.153Z [48470B90 info 'Snmpsvc'] DumpStats: cimom stats file /tmp/.cvtcimsnmp.xml generated, size 294 bytes.
2013-08-21T08:26:25.153Z [48470B90 info 'Snmpsvc'] PublishReport: file /tmp/.cvtcimsnmp.xml published as /tmp/cvtcimsnmp.xml
2013-08-21T08:26:25.153Z [48470B90 info 'Snmpsvc'] DumpStats: cimom stats file published
2013-08-21T08:26:25.153Z [48470B90 info 'Snmpsvc'] NotifyAgent: write(81, /var/run/snmp.ctl, N) 1 bytes to snmpd
2013-08-21T08:26:25.153Z [48470B90 info 'Snmpsvc'] UpdateStats: report cimom converter stats completed
2013-08-21T08:26:26.974Z [482DBB90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:26:27.916Z [48592B90 verbose 'Cimsvc'] Ticket issued for CIMOM version 1.0, user root
2013-08-21T08:26:36.171Z [48320B90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:26:39.958Z [FFCADD20 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:26:53.942Z [4842FB90 verbose 'Locale' opID=HB-host-26@4005-77e348ed-b7] Default resource used for 'counter.sys.resourceMemConsumed.summary' expected in module 'perf'.
2013-08-21T08:26:53.969Z [483ADB90 verbose 'ha-license-manager' opID=HB-host-26@4005-77e348ed-b7] Load: Loading existing file: /etc/vmware/license.cfg
2013-08-21T08:26:53.984Z [483ADB90 verbose 'Default' opID=HB-host-26@4005-77e348ed-b7] ha-license-manager:Validate -> Valid license detected for "VMware ESX Server 5.0" (lastError=0, desc.IsValid:Yes)
2013-08-21T08:26:53.994Z [483ADB90 error 'Default' opID=HB-host-26@4005-77e348ed-b7] Unable to parse MaxRam value:
2013-08-21T08:26:53.994Z [483ADB90 error 'Default' opID=HB-host-26@4005-77e348ed-b7] Unable to parse MaxRamPerCpu value:
2013-08-21T08:26:53.994Z [483ADB90 error 'Default' opID=HB-host-26@4005-77e348ed-b7] Unable to parse MinRamPerCpu value:
2013-08-21T08:26:55.694Z [48320B90 verbose 'ResourcePool ha-root-pool'] Root pool capacity changed from 21520MHz/92508MB to 19340MHz/92469MB
2013-08-21T08:26:56.975Z [482DBB90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:26:59.176Z [4842FB90 verbose 'Hbrsvc'] Replicator: VmFileProviderCallback VM (id=1)
2013-08-21T08:26:59.177Z [4842FB90 verbose 'Hbrsvc'] Replicator: VM 1 Disk (Key=2000,Id=RDID-3cd338a0-7b9e-4ffe-8575-82fc588b564f) has psf: [datastore_san2b_1] APCUPSD5(1)/hbr-persistent-state-RDID-3cd338a0-7b9e-4ffe-8575-82fc588b564f.psf
2013-08-21T08:26:59.177Z [4842FB90 verbose 'vm:/vmfs/volumes/511bac0f-489f3769-59f6-00259058b960/APCUPSD5(1)/APCUPSD5.vmx'] uniqueSet unset for [datastore_san2b_1] APCUPSD5(1)/hbr-persistent-state-RDID-3cd338a0-7b9e-4ffe-8575-82fc588b564f.psf. Using size.
2013-08-21T08:26:59.196Z [483ADB90 verbose 'Hbrsvc'] Replicator: VmFileProviderCallback VM (id=2)
2013-08-21T08:26:59.205Z [48592B90 verbose 'Hbrsvc'] Replicator: VmFileProviderCallback VM (id=3)
2013-08-21T08:26:59.206Z [48592B90 verbose 'Hbrsvc'] Replicator: VM 3 Disk (Key=2000,Id=RDID-716f7ac5-0d13-4b98-9d79-5a6145e97181) has psf: [datastore_san2a_1] DSA10A/hbr-persistent-state-RDID-716f7ac5-0d13-4b98-9d79-5a6145e97181.psf
2013-08-21T08:26:59.206Z [48592B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/DSA10A/DSA10A.vmx'] uniqueSet unset for [datastore_san2a_1] DSA10A/hbr-persistent-state-RDID-716f7ac5-0d13-4b98-9d79-5a6145e97181.psf. Using size.
2013-08-21T08:26:59.221Z [48470B90 verbose 'Hbrsvc'] Replicator: VmFileProviderCallback VM (id=4)
2013-08-21T08:26:59.221Z [48470B90 verbose 'Hbrsvc'] Replicator: VM 4 Disk (Key=2000,Id=RDID-b0586625-2265-4d06-9f10-757351d2822b) has psf: [datastore_san2a_1] DSA1A/hbr-persistent-state-RDID-b0586625-2265-4d06-9f10-757351d2822b.psf
2013-08-21T08:26:59.222Z [48470B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/DSA1A/DSA1A.vmx'] uniqueSet unset for [datastore_san2a_1] DSA1A/hbr-persistent-state-RDID-b0586625-2265-4d06-9f10-757351d2822b.psf. Using size.
2013-08-21T08:26:59.236Z [482DBB90 verbose 'Hbrsvc'] Replicator: VmFileProviderCallback VM (id=5)
2013-08-21T08:26:59.237Z [482DBB90 verbose 'Hbrsvc'] Replicator: VM 5 Disk (Key=2000,Id=RDID-692719e2-6fca-474b-bb13-6553b3a787fe) has psf: [datastore_san2a_1] DSA8A/hbr-persistent-state-RDID-692719e2-6fca-474b-bb13-6553b3a787fe.psf
2013-08-21T08:26:59.237Z [482DBB90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/DSA8A/DSA8A.vmx'] uniqueSet unset for [datastore_san2a_1] DSA8A/hbr-persistent-state-RDID-692719e2-6fca-474b-bb13-6553b3a787fe.psf. Using size.
2013-08-21T08:26:59.245Z [483EEB90 verbose 'Hbrsvc'] Replicator: VmFileProviderCallback VM (id=6)
2013-08-21T08:26:59.245Z [483EEB90 verbose 'Hbrsvc'] Replicator: VM 6 Disk (Key=2000,Id=RDID-5a679678-cf29-4a99-995f-438d9c2dc43a) has psf: [datastore_san2a_1] DSA-NT4/hbr-persistent-state-RDID-5a679678-cf29-4a99-995f-438d9c2dc43a.psf
2013-08-21T08:26:59.245Z [483EEB90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/DSA-NT4/DSA-NT4.vmx'] uniqueSet unset for [datastore_san2a_1] DSA-NT4/hbr-persistent-state-RDID-5a679678-cf29-4a99-995f-438d9c2dc43a.psf. Using size.
2013-08-21T08:26:59.256Z [FFCADD20 verbose 'Hbrsvc'] Replicator: VmFileProviderCallback VM (id=7)
2013-08-21T08:26:59.257Z [FFCADD20 verbose 'Hbrsvc'] Replicator: VM 7 Disk (Key=2000,Id=RDID-df568907-7d31-4a0c-89e8-0a263f8da48c) has psf: [datastore_san2a_1] Testlink/hbr-persistent-state-RDID-df568907-7d31-4a0c-89e8-0a263f8da48c.psf
2013-08-21T08:26:59.257Z [FFCADD20 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Testlink/Testlink.vmx'] uniqueSet unset for [datastore_san2a_1] Testlink/hbr-persistent-state-RDID-df568907-7d31-4a0c-89e8-0a263f8da48c.psf. Using size.
2013-08-21T08:26:59.265Z [48592B90 verbose 'Hbrsvc'] Replicator: VmFileProviderCallback VM (id=8)
2013-08-21T08:26:59.266Z [48592B90 verbose 'Hbrsvc'] Replicator: VM 8 Disk (Key=2000,Id=RDID-67682abb-b41a-45de-97c3-74178eeec096) has psf: [datastore_san2a_1] vm-mc3update-test/hbr-persistent-state-RDID-67682abb-b41a-45de-97c3-74178eeec096.psf
2013-08-21T08:26:59.266Z [48592B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/vm-mc3update-test/vm-mc3update-test.vmx'] uniqueSet unset for [datastore_san2a_1] vm-mc3update-test/hbr-persistent-state-RDID-67682abb-b41a-45de-97c3-74178eeec096.psf. Using size.
2013-08-21T08:26:59.274Z [483ADB90 verbose 'Hbrsvc'] Replicator: VmFileProviderCallback VM (id=9)
2013-08-21T08:26:59.274Z [483ADB90 verbose 'Hbrsvc'] Replicator: VM 9 Disk (Key=2000,Id=RDID-91183caf-9945-4830-8aa2-d32d74bb32d4) has psf: [datastore_san2a_1] LicenseCentral/hbr-persistent-state-RDID-91183caf-9945-4830-8aa2-d32d74bb32d4.psf
2013-08-21T08:26:59.274Z [483ADB90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/LicenseCentral/LicenseCentral.vmx'] uniqueSet unset for [datastore_san2a_1] LicenseCentral/hbr-persistent-state-RDID-91183caf-9945-4830-8aa2-d32d74bb32d4.psf. Using size.
2013-08-21T08:26:59.282Z [48592B90 verbose 'Hbrsvc'] Replicator: VmFileProviderCallback VM (id=10)
2013-08-21T08:26:59.283Z [48592B90 verbose 'Hbrsvc'] Replicator: VM 10 Disk (Key=2000,Id=RDID-607fd301-4ca5-4e0c-a9cd-1119c24b677f) has psf: [datastore_san2a_1] VMEADB/hbr-persistent-state-RDID-607fd301-4ca5-4e0c-a9cd-1119c24b677f.psf
2013-08-21T08:26:59.283Z [48592B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/VMEADB/VMEADB.vmx'] uniqueSet unset for [datastore_san2a_1] VMEADB/hbr-persistent-state-RDID-607fd301-4ca5-4e0c-a9cd-1119c24b677f.psf. Using size.
2013-08-21T08:26:59.298Z [FFCADD20 verbose 'Hbrsvc'] Replicator: VmFileProviderCallback VM (id=12)
2013-08-21T08:26:59.299Z [FFCADD20 verbose 'Hbrsvc'] Replicator: VM 12 Disk (Key=2000,Id=RDID-b232bf7d-41c4-4925-9c8f-e9d48628e5d8) has psf: [datastore_san2a_1] VMSSK1/hbr-persistent-state-RDID-b232bf7d-41c4-4925-9c8f-e9d48628e5d8.psf
2013-08-21T08:26:59.299Z [FFCADD20 verbose 'Hbrsvc'] Replicator: VM 12 Disk (Key=2001,Id=RDID-2690c73b-2c54-454d-b880-0d307d6f8889) has psf: [datastore_san2a_1] VMSSK1/hbr-persistent-state-RDID-2690c73b-2c54-454d-b880-0d307d6f8889.psf
2013-08-21T08:26:59.299Z [FFCADD20 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/VMSSK1/VMSSK1.vmx'] uniqueSet unset for [datastore_san2a_1] VMSSK1/hbr-persistent-state-RDID-b232bf7d-41c4-4925-9c8f-e9d48628e5d8.psf. Using size.
2013-08-21T08:26:59.299Z [FFCADD20 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/VMSSK1/VMSSK1.vmx'] uniqueSet unset for [datastore_san2a_1] VMSSK1/hbr-persistent-state-RDID-2690c73b-2c54-454d-b880-0d307d6f8889.psf. Using size.
2013-08-21T08:26:59.308Z [48C80B90 verbose 'Hbrsvc'] Replicator: VmFileProviderCallback VM (id=13)
2013-08-21T08:26:59.308Z [48C80B90 verbose 'Hbrsvc'] Replicator: VM 13 Disk (Key=2000,Id=RDID-1f22253c-d94e-447c-aeb5-184eb1405a77) has psf: [datastore_san2a_1] ResourceSpace/hbr-persistent-state-RDID-1f22253c-d94e-447c-aeb5-184eb1405a77.psf
2013-08-21T08:26:59.309Z [48C80B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/ResourceSpace/ResourceSpace.vmx'] uniqueSet unset for [datastore_san2a_1] ResourceSpace/hbr-persistent-state-RDID-1f22253c-d94e-447c-aeb5-184eb1405a77.psf. Using size.
2013-08-21T08:26:59.326Z [47F40B90 verbose 'Hbrsvc'] Replicator: VmFileProviderCallback VM (id=14)
2013-08-21T08:26:59.334Z [483ADB90 verbose 'Hbrsvc'] Replicator: VmFileProviderCallback VM (id=15)
2013-08-21T08:26:59.335Z [483ADB90 verbose 'Hbrsvc'] Replicator: VM 15 Disk (Key=3000,Id=RDID-246f1aa5-504d-4a86-ad00-8c6612e80396) has psf: [datastore_san2a_1] WANOptimizer/hbr-persistent-state-RDID-246f1aa5-504d-4a86-ad00-8c6612e80396.psf
2013-08-21T08:26:59.335Z [483ADB90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/WANOptimizer/WANOptimizer.vmx'] uniqueSet unset for [datastore_san2a_1] WANOptimizer/hbr-persistent-state-RDID-246f1aa5-504d-4a86-ad00-8c6612e80396.psf. Using size.
2013-08-21T08:26:59.342Z [47B81B90 verbose 'Hbrsvc'] Replicator: VmFileProviderCallback VM (id=16)
2013-08-21T08:26:59.343Z [47B81B90 verbose 'Hbrsvc'] Replicator: VM 16 Disk (Key=2000,Id=RDID-821a634d-8e9c-4e8c-92dd-04c0c7721464) has psf: [datastore_san2a_1] UPSServer/hbr-persistent-state-RDID-821a634d-8e9c-4e8c-92dd-04c0c7721464.psf
2013-08-21T08:26:59.343Z [47B81B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/UPSServer/UPSServer.vmx'] uniqueSet unset for [datastore_san2a_1] UPSServer/hbr-persistent-state-RDID-821a634d-8e9c-4e8c-92dd-04c0c7721464.psf. Using size.
2013-08-21T08:26:59.351Z [48320B90 verbose 'Hbrsvc'] Replicator: VmFileProviderCallback VM (id=17)
2013-08-21T08:26:59.352Z [48320B90 verbose 'Hbrsvc'] Replicator: VM 17 Disk (Key=2000,Id=RDID-558f1ae0-343d-479f-842f-d60673e164a8) has psf: [datastore_san2a_1] Foswiki/hbr-persistent-state-RDID-558f1ae0-343d-479f-842f-d60673e164a8.psf
2013-08-21T08:26:59.352Z [48320B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswiki/Foswiki.vmx'] uniqueSet unset for [datastore_san2a_1] Foswiki/hbr-persistent-state-RDID-558f1ae0-343d-479f-842f-d60673e164a8.psf. Using size.
2013-08-21T08:26:59.366Z [48470B90 verbose 'Hbrsvc'] Replicator: VmFileProviderCallback VM (id=18)
2013-08-21T08:26:59.366Z [48470B90 verbose 'Hbrsvc'] Replicator: VM 18 Disk (Key=2000,Id=RDID-4a2def33-63c4-47b4-a484-bad45a973cac) has psf: [datastore_san2a_1] EPOServer/hbr-persistent-state-RDID-4a2def33-63c4-47b4-a484-bad45a973cac.psf
2013-08-21T08:26:59.367Z [48470B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/EPOServer/EPOServer.vmx'] uniqueSet unset for [datastore_san2a_1] EPOServer/hbr-persistent-state-RDID-4a2def33-63c4-47b4-a484-bad45a973cac.psf. Using size.
2013-08-21T08:26:59.374Z [483ADB90 verbose 'Hbrsvc'] Replicator: VmFileProviderCallback VM (id=20)
2013-08-21T08:26:59.375Z [483ADB90 verbose 'Hbrsvc'] Replicator: VM 20 Disk (Key=2000,Id=RDID-872538fe-a7ae-4ea1-a02b-21098da9125f) has psf: [datastore_san2a_1] VMShadowProtect/hbr-persistent-state-RDID-872538fe-a7ae-4ea1-a02b-21098da9125f.psf
2013-08-21T08:26:59.375Z [483ADB90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/VMShadowProtect/VMShadowProtect.vmx'] uniqueSet unset for [datastore_san2a_1] VMShadowProtect/hbr-persistent-state-RDID-872538fe-a7ae-4ea1-a02b-21098da9125f.psf. Using size.
2013-08-21T08:27:03.943Z [4842FB90 verbose 'Locale' opID=HB-host-26@4042-b6b145f-8b] Default resource used for 'counter.sys.resourceMemConsumed.summary' expected in module 'perf'.
2013-08-21T08:27:03.970Z [482DBB90 verbose 'ha-license-manager' opID=HB-host-26@4042-b6b145f-8b] Load: Loading existing file: /etc/vmware/license.cfg
2013-08-21T08:27:03.985Z [482DBB90 verbose 'Default' opID=HB-host-26@4042-b6b145f-8b] ha-license-manager:Validate -> Valid license detected for "VMware ESX Server 5.0" (lastError=0, desc.IsValid:Yes)
2013-08-21T08:27:03.996Z [482DBB90 error 'Default' opID=HB-host-26@4042-b6b145f-8b] Unable to parse MaxRam value:
2013-08-21T08:27:03.996Z [482DBB90 error 'Default' opID=HB-host-26@4042-b6b145f-8b] Unable to parse MaxRamPerCpu value:
2013-08-21T08:27:03.996Z [482DBB90 error 'Default' opID=HB-host-26@4042-b6b145f-8b] Unable to parse MinRamPerCpu value:
2013-08-21T08:27:06.172Z [48361B90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:27:09.960Z [48470B90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:27:22.253Z [47F40B90 trivia 'Snmpsvc:http.HTTPService'] HTTP Response: Setting Content-Length: -1
2013-08-21T08:27:22.253Z [47F40B90 verbose 'Snmpsvc:http.HTTPService.HttpConnection'] User agent is 'No-User-Agent'
2013-08-21T08:27:22.253Z [47F40B90 trivia 'Snmpsvc:http.HTTPService.HttpConnection'] User agent 'No-User-Agent' is non-chunking: false
2013-08-21T08:27:22.253Z [47F40B90 trivia 'Snmpsvc:http.HTTPService.HttpConnection'] User agent 'No-User-Agent' needs Content-Length: false
2013-08-21T08:27:22.253Z [47F40B90 trivia 'Snmpsvc:http.HTTPService.HttpConnection'] Lookup handler by prefix for: /
2013-08-21T08:27:22.253Z [47F40B90 trivia 'Snmpsvc:http.HTTPService.HttpConnection'] Inspecting path: /
2013-08-21T08:27:22.253Z [47F40B90 trivia 'Snmpsvc:http.HTTPService.HttpConnection'] No match found for: /
2013-08-21T08:27:22.253Z [47F40B90 trivia 'Snmpsvc:http.HTTPService.HttpConnection'] ProcessRequest: using default handler
2013-08-21T08:27:22.253Z [47F40B90 verbose 'Snmpsvc-env'] HandlePost
2013-08-21T08:27:22.254Z [47F40B90 verbose 'Snmpsvc-env'] HandleRequest
2013-08-21T08:27:22.254Z [47F40B90 verbose 'Snmpsvc-env'] Push starting indication parser
2013-08-21T08:27:22.254Z [47F40B90 verbose 'Snmpsvc-env'] ProcessIndications started threadid=1207176080
2013-08-21T08:27:23.255Z [47F40B90 verbose 'Snmpsvc-env'] FetchClassDef: connect to cimom @ 127.0.0.1:5988
2013-08-21T08:27:23.256Z [47F40B90 verbose 'Snmpsvc-env'] FetchClassDef: making request class VMware_CIMHeartbeat, ns root/cimv2
2013-08-21T08:27:23.260Z [47F40B90 verbose 'Snmpsvc-env'] FetchClassDef: got response from cimom
2013-08-21T08:27:23.260Z [47F40B90 verbose 'Snmpsvc-env'] FetchClassDef: http response code from cimom: 200 OK
2013-08-21T08:27:23.261Z [47F40B90 error 'Snmpsvc-env'] OnEndElement: no _props to update value, skipping
2013-08-21T08:27:23.261Z [47F40B90 verbose 'Snmpsvc-env'] parse class definition msg ok: WBEMHandler @0x5006c30 = {_state: 3, _mode: 5, _className: VMware_CIMHeartbeat, _identifier: MIB.IETF| 1.3.6.1.4.1.6876.4.90.0.401, _props = { (IndicationTime,datetime,MIB.IETF|1| 1.3.6.1.4.1.6876.4.30.3.0,0), }}
2013-08-21T08:27:23.261Z [47F40B90 verbose 'Snmpsvc-env'] GenerateVarbinds skipping property name='stamp', value='534', no oid info from class def keys:(IndicationTime, )
2013-08-21T08:27:23.261Z [47F40B90 verbose 'Snmpsvc-env'] GenerateVarbinds skipping property name='hostname', value='esxserver2b.dsa-ac.de', no oid info from class def keys:(IndicationTime, )
2013-08-21T08:27:23.261Z [47F40B90 verbose 'Snmpsvc-env'] GenerateVarbinds skipping property name='SequenceNumber', value='', no oid info from class def keys:(IndicationTime, )
2013-08-21T08:27:23.261Z [47F40B90 verbose 'Snmpsvc-env'] GenerateVarbinds skipping property name='SequenceContext', value='', no oid info from class def keys:(IndicationTime, )
2013-08-21T08:27:23.261Z [47F40B90 verbose 'Snmpsvc-env'] GenerateVarbinds skipping property name='IndicationFilterName', value='com.vmware:vim.snmpagent-root/cimv2', no oid info from class def keys:(IndicationTime, )
2013-08-21T08:27:23.261Z [47F40B90 verbose 'Snmpsvc-env'] GenerateVarbinds skipping property name='OtherSeverity', value='', no oid info from class def keys:(IndicationTime, )
2013-08-21T08:27:23.261Z [47F40B90 verbose 'Snmpsvc-env'] GenerateVarbinds skipping property name='PerceivedSeverity', value='', no oid info from class def keys:(IndicationTime, )
2013-08-21T08:27:23.261Z [47F40B90 verbose 'Snmpsvc-env'] GenerateVarbinds skipping property name='CorrelatedIndications', value='', no oid info from class def keys:(IndicationTime, )
2013-08-21T08:27:23.261Z [47F40B90 verbose 'Snmpsvc-env'] GenerateVarbinds skipping property name='IndicationIdentifier', value='', no oid info from class def keys:(IndicationTime, )
2013-08-21T08:27:23.261Z [47F40B90 verbose 'Snmpsvc-env'] GenerateVarbinds indication VMware_CIMHeartbeat(1.3.6.1.4.1.6876.4.90.0.401) has 1 properties with mapping qualifiers. Indication had 10, ClassDef had 1 props each.
2013-08-21T08:27:23.261Z [47F40B90 verbose 'Snmpsvc'] GenEvent: oid: 1.3.6.1.4.1.6876.4.90.0.401
2013-08-21T08:27:23.261Z [47F40B90 verbose 'Snmpsvc'] ConvertId: ent:1.3.6.1.4.1.6876.4.90 spec 401
2013-08-21T08:27:23.261Z [47F40B90 info 'Snmpsvc'] ConvertVarbinds: convert id=1.3.6.1.4.1.6876.4.30.3.0: type=dateTimeTC, value=20130821082722.000000+000
2013-08-21T08:27:23.261Z [47F40B90 info 'Snmpsvc'] GenEvent: sending trap (generic=6 specific=401 ent_sz=9) with id: 1.3.6.1.4.1.6876.4.90., vbs: 1
2013-08-21T08:27:23.262Z [47F40B90 info 'Snmpsvc'] WriteV1Trap: generic 6 specific 401
2013-08-21T08:27:23.262Z [47F40B90 info 'Snmpsvc'] WriteV1Trap: serialized 1 varbinds
2013-08-21T08:27:23.262Z [47F40B90 info 'Snmpsvc'] WriteV1Trap: wrote 88 bytes
2013-08-21T08:27:23.262Z [47F40B90 info 'Snmpsvc'] NotifyAgent: write(154, /var/run/snmp.ctl, N) 1 bytes to snmpd
2013-08-21T08:27:23.262Z [47F40B90 info 'Snmpsvc'] WriteV1Trap: agent was  notified
2013-08-21T08:27:23.262Z [47F40B90 verbose 'Snmpsvc:http.HTTPService'] HTTP Response: Complete (processed 0 bytes)
2013-08-21T08:27:23.262Z [47F40B90 trivia 'Snmpsvc:http.HTTPService'] HTTP Response: Flush(lastBlock = true)
2013-08-21T08:27:23.262Z [47F40B90 trivia 'Snmpsvc:http.HTTPService'] HTTP Response: Client: NeedsContentLength: false UnderstandsChunking: true CanKeepAlive: true (PresetContentLength -1)
2013-08-21T08:27:23.262Z [47F40B90 trivia 'Snmpsvc:http.HTTPService'] HTTP Response: SetKeepAlive(true)
2013-08-21T08:27:23.262Z [47F40B90 trivia 'Snmpsvc:http.HTTPService'] HTTP Response: Setting Content-Length: 0
2013-08-21T08:27:23.262Z [47F40B90 trivia 'Snmpsvc:http.HTTPService'] HTTP Response: Header size is 163
2013-08-21T08:27:23.262Z [47F40B90 trivia 'Snmpsvc:http.HTTPService'] HTTP Response: Writing 163 bytes to stream
2013-08-21T08:27:23.262Z [47F40B90 trivia 'Snmpsvc:http.HTTPService.HttpConnection'] ResponseCompleted(false), request keep alive true, closeStream false
2013-08-21T08:27:23.262Z [47F40B90 verbose 'Snmpsvc-env'] ProcessIndications completed, 1 indication(s) processed
2013-08-21T08:27:23.262Z [47F40B90 trivia 'Snmpsvc:http.HTTPService'] HTTP Response: Setting Content-Length: -1
2013-08-21T08:27:23.948Z [483EEB90 verbose 'Locale' opID=HB-host-26@4043-d4d3ed42-a8] Default resource used for 'counter.sys.resourceMemConsumed.summary' expected in module 'perf'.
2013-08-21T08:27:23.975Z [48320B90 verbose 'ha-license-manager' opID=HB-host-26@4043-d4d3ed42-a8] Load: Loading existing file: /etc/vmware/license.cfg
2013-08-21T08:27:23.990Z [48320B90 verbose 'Default' opID=HB-host-26@4043-d4d3ed42-a8] ha-license-manager:Validate -> Valid license detected for "VMware ESX Server 5.0" (lastError=0, desc.IsValid:Yes)
2013-08-21T08:27:24.001Z [48320B90 error 'Default' opID=HB-host-26@4043-d4d3ed42-a8] Unable to parse MaxRam value:
2013-08-21T08:27:24.001Z [48320B90 error 'Default' opID=HB-host-26@4043-d4d3ed42-a8] Unable to parse MaxRamPerCpu value:
2013-08-21T08:27:24.001Z [48320B90 error 'Default' opID=HB-host-26@4043-d4d3ed42-a8] Unable to parse MinRamPerCpu value:
2013-08-21T08:27:24.262Z [483ADB90 verbose 'HttpConnectionPool-000000'] [RemoveConnection] Connection removed; cnx: TCPClientSocket(this=47a3b890, state=CLOSED, _connectSocket=TCP(null), error=(null)) TCP(<null>); pooled: 0
2013-08-21T08:27:25.155Z [482DBB90 info 'Snmpsvc'] UpdateStats: report cimom converter stats started
2013-08-21T08:27:25.155Z [482DBB90 info 'Snmpsvc'] DumpStats: cimom stats file /tmp/.cvtcimsnmp.xml generated, size 294 bytes.
2013-08-21T08:27:25.155Z [482DBB90 info 'Snmpsvc'] PublishReport: file /tmp/.cvtcimsnmp.xml published as /tmp/cvtcimsnmp.xml
2013-08-21T08:27:25.155Z [482DBB90 info 'Snmpsvc'] DumpStats: cimom stats file published
2013-08-21T08:27:25.155Z [482DBB90 info 'Snmpsvc'] NotifyAgent: write(146, /var/run/snmp.ctl, N) 1 bytes to snmpd
2013-08-21T08:27:25.155Z [482DBB90 info 'Snmpsvc'] UpdateStats: report cimom converter stats completed
2013-08-21T08:27:26.977Z [483ADB90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:27:36.175Z [FFCADD20 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:27:39.962Z [48C80B90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:27:53.954Z [47B81B90 verbose 'Locale' opID=HB-host-26@4044-142ef25f-fd] Default resource used for 'counter.sys.resourceMemConsumed.summary' expected in module 'perf'.
2013-08-21T08:27:53.981Z [47B81B90 verbose 'ha-license-manager' opID=HB-host-26@4044-142ef25f-fd] Load: Loading existing file: /etc/vmware/license.cfg
2013-08-21T08:27:53.995Z [47B81B90 verbose 'Default' opID=HB-host-26@4044-142ef25f-fd] ha-license-manager:Validate -> Valid license detected for "VMware ESX Server 5.0" (lastError=0, desc.IsValid:Yes)
2013-08-21T08:27:54.006Z [47B81B90 error 'Default' opID=HB-host-26@4044-142ef25f-fd] Unable to parse MaxRam value:
2013-08-21T08:27:54.006Z [47B81B90 error 'Default' opID=HB-host-26@4044-142ef25f-fd] Unable to parse MaxRamPerCpu value:
2013-08-21T08:27:54.006Z [47B81B90 error 'Default' opID=HB-host-26@4044-142ef25f-fd] Unable to parse MinRamPerCpu value:
2013-08-21T08:27:56.978Z [48C80B90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:27:59.243Z [482DBB90 verbose 'Cimsvc'] Ticket issued for CIMOM version 1.0, user root
2013-08-21T08:28:06.178Z [482DBB90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:28:09.965Z [4842FB90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:28:22.860Z [47F40B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] Tools guest daemon status changed to: 0
2013-08-21T08:28:23.960Z [48470B90 verbose 'Locale' opID=HB-host-26@4045-be2dd685-18] Default resource used for 'counter.sys.resourceMemConsumed.summary' expected in module 'perf'.
2013-08-21T08:28:23.987Z [483ADB90 verbose 'ha-license-manager' opID=HB-host-26@4045-be2dd685-18] Load: Loading existing file: /etc/vmware/license.cfg
2013-08-21T08:28:24.002Z [483ADB90 verbose 'Default' opID=HB-host-26@4045-be2dd685-18] ha-license-manager:Validate -> Valid license detected for "VMware ESX Server 5.0" (lastError=0, desc.IsValid:Yes)
2013-08-21T08:28:24.012Z [483ADB90 error 'Default' opID=HB-host-26@4045-be2dd685-18] Unable to parse MaxRam value:
2013-08-21T08:28:24.012Z [483ADB90 error 'Default' opID=HB-host-26@4045-be2dd685-18] Unable to parse MaxRamPerCpu value:
2013-08-21T08:28:24.012Z [483ADB90 error 'Default' opID=HB-host-26@4045-be2dd685-18] Unable to parse MinRamPerCpu value:
2013-08-21T08:28:25.157Z [47F40B90 info 'Snmpsvc'] UpdateStats: report cimom converter stats started
2013-08-21T08:28:25.157Z [47F40B90 info 'Snmpsvc'] DumpStats: cimom stats file /tmp/.cvtcimsnmp.xml generated, size 294 bytes.
2013-08-21T08:28:25.157Z [47F40B90 info 'Snmpsvc'] PublishReport: file /tmp/.cvtcimsnmp.xml published as /tmp/cvtcimsnmp.xml
2013-08-21T08:28:25.157Z [47F40B90 info 'Snmpsvc'] DumpStats: cimom stats file published
2013-08-21T08:28:25.157Z [47F40B90 info 'Snmpsvc'] NotifyAgent: write(72, /var/run/snmp.ctl, N) 1 bytes to snmpd
2013-08-21T08:28:25.157Z [47F40B90 info 'Snmpsvc'] UpdateStats: report cimom converter stats completed
2013-08-21T08:28:26.980Z [47F40B90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:28:36.179Z [48C80B90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:28:39.967Z [48361B90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:28:55.699Z [483ADB90 verbose 'ResourcePool ha-root-pool'] Root pool capacity changed from 19340MHz/92469MB to 19340MHz/92468MB
2013-08-21T08:28:56.982Z [4842FB90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:29:04.902Z [48470B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] Actual VM overhead: 28823552 bytes
2013-08-21T08:29:04.904Z [48470B90 verbose 'Vmsvc'] RefreshVms updated overhead for 1 VM
2013-08-21T08:29:06.180Z [48320B90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:29:09.968Z [47F40B90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:29:25.159Z [48592B90 info 'Snmpsvc'] UpdateStats: report cimom converter stats started
2013-08-21T08:29:25.159Z [48592B90 info 'Snmpsvc'] DumpStats: cimom stats file /tmp/.cvtcimsnmp.xml generated, size 294 bytes.
2013-08-21T08:29:25.159Z [48592B90 info 'Snmpsvc'] PublishReport: file /tmp/.cvtcimsnmp.xml published as /tmp/cvtcimsnmp.xml
2013-08-21T08:29:25.159Z [48592B90 info 'Snmpsvc'] DumpStats: cimom stats file published
2013-08-21T08:29:25.159Z [48592B90 info 'Snmpsvc'] NotifyAgent: write(82, /var/run/snmp.ctl, N) 1 bytes to snmpd
2013-08-21T08:29:25.159Z [48592B90 info 'Snmpsvc'] UpdateStats: report cimom converter stats completed
2013-08-21T08:29:26.983Z [48361B90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:29:30.573Z [48320B90 verbose 'Cimsvc'] Ticket issued for CIMOM version 1.0, user root
2013-08-21T08:29:36.181Z [47F40B90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:29:39.970Z [FFCADD20 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:29:53.980Z [48361B90 verbose 'Locale' opID=HB-host-26@4046-9001f28a-90] Default resource used for 'counter.sys.resourceMemConsumed.summary' expected in module 'perf'.
2013-08-21T08:29:54.007Z [47B81B90 verbose 'ha-license-manager' opID=HB-host-26@4046-9001f28a-90] Load: Loading existing file: /etc/vmware/license.cfg
2013-08-21T08:29:54.021Z [47B81B90 verbose 'Default' opID=HB-host-26@4046-9001f28a-90] ha-license-manager:Validate -> Valid license detected for "VMware ESX Server 5.0" (lastError=0, desc.IsValid:Yes)
2013-08-21T08:29:54.032Z [47B81B90 error 'Default' opID=HB-host-26@4046-9001f28a-90] Unable to parse MaxRam value:
2013-08-21T08:29:54.032Z [47B81B90 error 'Default' opID=HB-host-26@4046-9001f28a-90] Unable to parse MaxRamPerCpu value:
2013-08-21T08:29:54.032Z [47B81B90 error 'Default' opID=HB-host-26@4046-9001f28a-90] Unable to parse MinRamPerCpu value:
2013-08-21T08:29:56.984Z [47F40B90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:29:57.822Z [FFCADD20 verbose 'DvsManager'] PersistAllDvsInfo called
2013-08-21T08:30:01.619Z [4842FB90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:30:03.595Z [482DBB90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] Handling message _vmx5: The migration has exceeded the maximum switchover time of 100 second(s). ESX has preemptively failed the migration to allow the VM to continue running on the source.  To avoid this failure, either increase the maximum allowable switchover time or wait until the VM is performing a less intensive workload.
-->
2013-08-21T08:30:03.595Z [482DBB90 warning 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] Failed to find activation record, event user unknown.
2013-08-21T08:30:03.595Z [48116B90 info 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx']  Disconnect check in progress.
2013-08-21T08:30:03.596Z [482DBB90 warning 'Locale'] FormatField: Invalid (vim.vm.Message.1)
2013-08-21T08:30:03.596Z [482DBB90 warning 'Locale'] FormatField: Invalid (vim.vm.Message.1)
2013-08-21T08:30:03.596Z [482DBB90 info 'ha-eventmgr'] Event 480 : Error message on Foswikitest on esxserver2b.dsa-ac.de in ha-datacenter: The migration has exceeded the maximum switchover time of 100 second(s). ESX has preemptively failed the migration to allow the VM to continue running on the source.  To avoid this failure, either increase the maximum allowable switchover time or wait until the VM is performing a less intensive workload.
-->
2013-08-21T08:30:03.596Z [48592B90 warning 'Locale'] FormatField: Invalid (vim.vm.Message.1)
2013-08-21T08:30:03.597Z [47B81B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] VMotionLastStatusCb: Failed with error 4: The migration has exceeded the maximum switchover time of 100 second(s). ESX has preemptively failed the migration to allow the VM to continue running on the source.  To avoid this failure, either increase the maximum allowable switchover time or wait until the VM is performing a less intensive workload.
-->
2013-08-21T08:30:03.597Z [48116B90 info 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx']  Disconnect check in progress.
2013-08-21T08:30:03.604Z [47B81B90 info 'ha-host'] vmxSwapEnabled = true vmmOvhd.anonymous: 12048 vmmOvhd.paged: 50002 vmmOvhd.nonpaged: 12485
2013-08-21T08:30:03.604Z [47B81B90 info 'ha-host'] vmkOvhd.fixd = 303104 vmkOvhd.variable: 2050 vmkOvhd.selfSwap: 3145728
2013-08-21T08:30:03.604Z [47B81B90 info 'ha-host'] Computed from lib overhead: 100487168 for (memPages: 262144, fbSize: 1024, #vcpus: 1, #lsiscsi: 1, #pvscsi: 0, #passthru: 0, #network: 1) vmkOverhead: 5548032
2013-08-21T08:30:03.604Z [47B81B90 info 'ha-host'] overhead result (no CBRC): 106033152
2013-08-21T08:30:03.604Z [47B81B90 info 'ha-host'] Predicted overhead: 106033152 for (memory: 1073741824, video: 4194304, #vcpus: 1, autodetect: false, enable3D: false, svgaPtFbSize: 4194304, cbrcOverhead: 0
2013-08-21T08:30:03.604Z [47B81B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] Time to gather config: 7 (msecs)
2013-08-21T08:30:03.605Z [FFCADD20 verbose 'Hbrsvc'] Replicator: ReconfigListener triggered for config VM 11
2013-08-21T08:30:03.608Z [48116B90 info 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx']  Disconnect check in progress.
2013-08-21T08:30:03.612Z [47B81B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] VMotionLastStatusCb:: hostlog state changed from emigrating to failure
2013-08-21T08:30:03.612Z [47B81B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] VMotionResolveCheck: Operation in progress
2013-08-21T08:30:03.612Z [48320B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] Retrieved current VM state from foundry 4, 8
2013-08-21T08:30:03.612Z [483ADB90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] Retrieved current VM state from foundry 4, 8
2013-08-21T08:30:03.612Z [FFCADD20 verbose 'Hbrsvc'] Replicator: VmReconfig ignoring VM 11 not configured for replication
2013-08-21T08:30:03.613Z [FFCADD20 info 'Snmpsvc'] VmConfigListener: vm state change received, queueing reload request
2013-08-21T08:30:03.614Z [48470B90 info 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] Answered question _vmx5
2013-08-21T08:30:03.614Z [47B81B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] VMotionStatusCb: Completed
2013-08-21T08:30:03.614Z [47B81B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] VMotionResolveCheck: Firing ResolveCb
2013-08-21T08:30:03.614Z [483ADB90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] VMotionResolveCheck: Already resolved
2013-08-21T08:30:03.614Z [47B81B90 info 'VMotionSrc (1377073575569460)'] ResolveCb: VMX reports needsUnregister = false for migrateType MIGRATE_TYPE_VMOTION
2013-08-21T08:30:03.614Z [48320B90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] VMotionResolveCheck: Already resolved
2013-08-21T08:30:03.614Z [47B81B90 info 'VMotionSrc (1377073575569460)'] ResolveCb: Failed with fault: (vmodl.fault.SystemError) {
-->    dynamicType = <unset>,
-->    faultCause = (vmodl.MethodFault) null,
-->    faultMessage = (vmodl.LocalizableMessage) [
-->       (vmodl.LocalizableMessage) {
-->          dynamicType = <unset>,
-->          key = "msg.checkpoint.migration.maxSwitchoverTimeExceeded",
-->          arg = (vmodl.KeyAnyValue) [
-->             (vmodl.KeyAnyValue) {
-->                dynamicType = <unset>,
-->                key = "1",
-->                value = "100",
-->             }
-->          ],
-->          message = "The migration has exceeded the maximum switchover time of 100 second(s). ESX has preemptively failed the migration to allow the VM to continue running on the source.  To avoid this failure, either increase the maximum allowable switchover time or wait until the VM is performing a less intensive workload.
--> ",
-->       }
-->    ],
-->    reason = "The migration has exceeded the maximum switchover time of 100 second(s). ESX has preemptively failed the migration to allow the VM to continue running on the source.  To avoid this failure, either increase the maximum allowable switchover time or wait until the VM is performing a less intensive workload.
--> ",
-->    msg = ""
--> }
2013-08-21T08:30:03.615Z [47B81B90 verbose 'VMotionSrc (1377073575569460)'] Migration changed state from MIGRATING to DONE
2013-08-21T08:30:03.615Z [47B81B90 verbose 'VMotionSrc (1377073575569460)'] Finish called
2013-08-21T08:30:03.617Z [47B81B90 info 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] State Transition (VM_STATE_EMIGRATING -> VM_STATE_ON)
2013-08-21T08:30:03.617Z [48592B90 verbose 'HostsvcPlugin'] Received state change for VM '11'
2013-08-21T08:30:03.617Z [48592B90 info 'GuestFileTransferImpl'] Entered VmPowerStateListener
2013-08-21T08:30:03.617Z [48592B90 info 'GuestFileTransferImpl'] VmPowerStateListener succeeded
2013-08-21T08:30:03.617Z [48592B90 info 'Hbrsvc'] Replicator: powerstate change VM: 11 Old: 1 New: 1
2013-08-21T08:30:03.618Z [47B81B90 info 'HostsvcPlugin'] Decremented SIOC Injector Flag2
2013-08-21T08:30:03.618Z [47B81B90 info 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] VMotion cleanup completed
2013-08-21T08:30:03.618Z [47B81B90 verbose 'VMotionSrc (1377073575569460)'] JrnlEnd: Wrote active=0
2013-08-21T08:30:03.618Z [47B81B90 verbose 'VMotionSrc (1377073575569460)'] JrnlEnd: Finished journal
2013-08-21T08:30:03.618Z [47B81B90 verbose 'VMotionSrc (1377073575569460)'] [JrnlFilePersistenceProvider::DeleteJournal] Deleting /var/lib/vmware/hostd/journal/1377073570.29.
2013-08-21T08:30:03.618Z [47B81B90 verbose 'VMotionSrc (1377073575569460)'] JrnlDelete: Deleted journal
2013-08-21T08:30:03.618Z [48592B90 verbose 'Hbrsvc'] Replicator: Remove group no matching entry for VM (id=11)
2013-08-21T08:30:03.619Z [48592B90 verbose 'vim.PerformanceManager'] Adding vm 11 to poweredOnVms list
2013-08-21T08:30:03.623Z [483EEB90 info 'ha-host'] vmxSwapEnabled = true vmmOvhd.anonymous: 12048 vmmOvhd.paged: 50002 vmmOvhd.nonpaged: 12485
2013-08-21T08:30:03.623Z [47B81B90 info 'ha-host'] vmxSwapEnabled = true vmmOvhd.anonymous: 12048 vmmOvhd.paged: 50002 vmmOvhd.nonpaged: 12485
2013-08-21T08:30:03.623Z [483EEB90 info 'ha-host'] vmkOvhd.fixd = 303104 vmkOvhd.variable: 2050 vmkOvhd.selfSwap: 3145728
2013-08-21T08:30:03.623Z [47B81B90 info 'ha-host'] vmkOvhd.fixd = 303104 vmkOvhd.variable: 2050 vmkOvhd.selfSwap: 3145728
2013-08-21T08:30:03.623Z [483EEB90 info 'ha-host'] Computed from lib overhead: 100487168 for (memPages: 262144, fbSize: 1024, #vcpus: 1, #lsiscsi: 1, #pvscsi: 0, #passthru: 0, #network: 1) vmkOverhead: 5548032
2013-08-21T08:30:03.623Z [47B81B90 info 'ha-host'] Computed from lib overhead: 100487168 for (memPages: 262144, fbSize: 1024, #vcpus: 1, #lsiscsi: 1, #pvscsi: 0, #passthru: 0, #network: 1) vmkOverhead: 5548032
2013-08-21T08:30:03.624Z [483EEB90 info 'ha-host'] overhead result (no CBRC): 106033152
2013-08-21T08:30:03.624Z [47B81B90 info 'ha-host'] overhead result (no CBRC): 106033152
2013-08-21T08:30:03.624Z [483EEB90 info 'ha-host'] Predicted overhead: 106033152 for (memory: 1073741824, video: 4194304, #vcpus: 1, autodetect: false, enable3D: false, svgaPtFbSize: 4194304, cbrcOverhead: 0
2013-08-21T08:30:03.624Z [47B81B90 info 'ha-host'] Predicted overhead: 106033152 for (memory: 1073741824, video: 4194304, #vcpus: 1, autodetect: false, enable3D: false, svgaPtFbSize: 4194304, cbrcOverhead: 0
2013-08-21T08:30:06.182Z [48C80B90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:30:08.232Z [48361B90 info 'VMotion' opID=5DB0DEC8-00001F2D-d8-50-cf] CompleteSource [1377073575569460]
2013-08-21T08:30:08.247Z [FFCADD20 verbose 'Locale' opID=dd75c89e] Default resource used for 'counter.sys.resourceMemConsumed.summary' expected in module 'perf'.
2013-08-21T08:30:08.373Z [47B81B90 verbose 'ha-license-manager' opID=dd75c89e] Load: Loading existing file: /etc/vmware/license.cfg
2013-08-21T08:30:08.388Z [47B81B90 verbose 'Default' opID=dd75c89e] ha-license-manager:Validate -> Valid license detected for "VMware ESX Server 5.0" (lastError=0, desc.IsValid:Yes)
2013-08-21T08:30:08.399Z [47B81B90 error 'Default' opID=dd75c89e] Unable to parse MaxRam value:
2013-08-21T08:30:08.399Z [47B81B90 error 'Default' opID=dd75c89e] Unable to parse MaxRamPerCpu value:
2013-08-21T08:30:08.399Z [47B81B90 error 'Default' opID=dd75c89e] Unable to parse MinRamPerCpu value:
2013-08-21T08:30:08.587Z [483ADB90 info 'VMotion' opID=5DB0DEC8-00001F2D-d8-50-32] CompleteSource [1377073575569460]
2013-08-21T08:30:08.587Z [483ADB90 warning 'VMotion' opID=5DB0DEC8-00001F2D-d8-50-32] CompleteSource: Map entry not found
2013-08-21T08:30:08.613Z [482DBB90 info 'Snmpsvc'] DoReport: VM Poll State cache - report starting
2013-08-21T08:30:08.616Z [482DBB90 info 'Snmpsvc'] ReportVMs: processing vm 1
2013-08-21T08:30:08.617Z [482DBB90 info 'Snmpsvc'] ReportVMs: processing vm 2
2013-08-21T08:30:08.619Z [482DBB90 info 'Snmpsvc'] ReportVMs: processing vm 3
2013-08-21T08:30:08.620Z [482DBB90 info 'Snmpsvc'] ReportVMs: processing vm 4
2013-08-21T08:30:08.622Z [482DBB90 info 'Snmpsvc'] ReportVMs: processing vm 5
2013-08-21T08:30:08.623Z [482DBB90 info 'Snmpsvc'] ReportVMs: processing vm 6
2013-08-21T08:30:08.625Z [482DBB90 info 'Snmpsvc'] ReportVMs: processing vm 7
2013-08-21T08:30:08.627Z [482DBB90 info 'Snmpsvc'] ReportVMs: processing vm 8
2013-08-21T08:30:08.628Z [482DBB90 info 'Snmpsvc'] ReportVMs: processing vm 9
2013-08-21T08:30:08.630Z [482DBB90 info 'Snmpsvc'] ReportVMs: processing vm 10
2013-08-21T08:30:08.632Z [482DBB90 info 'Snmpsvc'] ReportVMs: processing vm 11
2013-08-21T08:30:08.633Z [482DBB90 info 'Snmpsvc'] ReportVMs: processing vm 12
2013-08-21T08:30:08.635Z [482DBB90 info 'Snmpsvc'] ReportVMs: processing vm 13
2013-08-21T08:30:08.636Z [482DBB90 info 'Snmpsvc'] ReportVMs: processing vm 14
2013-08-21T08:30:08.638Z [482DBB90 info 'Snmpsvc'] ReportVMs: processing vm 15
2013-08-21T08:30:08.640Z [482DBB90 info 'Snmpsvc'] ReportVMs: processing vm 16
2013-08-21T08:30:08.641Z [482DBB90 info 'Snmpsvc'] ReportVMs: processing vm 17
2013-08-21T08:30:08.642Z [482DBB90 info 'Snmpsvc'] ReportVMs: processing vm 18
2013-08-21T08:30:08.644Z [482DBB90 info 'Snmpsvc'] ReportVMs: processing vm 20
2013-08-21T08:30:08.644Z [482DBB90 info 'Snmpsvc'] ReportVMs: serialized 19 out of 19 vms
2013-08-21T08:30:08.645Z [482DBB90 info 'Snmpsvc'] GenerateFullReport: report file /tmp/.vm-report.xml generated, size 977 bytes.
2013-08-21T08:30:08.645Z [482DBB90 info 'Snmpsvc'] PublishReport: file /tmp/.vm-report.xml published as /tmp/vm-report.xml
2013-08-21T08:30:08.645Z [482DBB90 info 'Snmpsvc'] NotifyAgent: write(115, /var/run/snmp.ctl, V) 1 bytes to snmpd
2013-08-21T08:30:08.645Z [482DBB90 info 'Snmpsvc'] GenerateFullReport: notified snmpd to update vm cache
2013-08-21T08:30:08.645Z [482DBB90 info 'Snmpsvc'] DoReport: VM Poll State cache - report completed ok
2013-08-21T08:30:09.973Z [48320B90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:30:20.019Z [48470B90 warning 'vim.PerformanceManager'] Calculating read OIO for scsi0:0 - delta is negative, prevTime = 1377073700 curTime = 1377073820 previIOTime = 795222 curIOTime = 0
2013-08-21T08:30:20.019Z [48470B90 warning 'vim.PerformanceManager'] Calculating read I/O size for scsi0:0 -- commands delta is negative,prevBytes = 21962752 curBytes = 0 prevCommands = 434curCommands = 0
2013-08-21T08:30:20.019Z [48470B90 warning 'vim.PerformanceManager'] Calculating write OIO for scsi0:0 - delta is negative, prevTime = 1377073700 curTime = 1377073820 previIOTime = 56679503 curIOTime = 127334
2013-08-21T08:30:20.019Z [48470B90 warning 'vim.PerformanceManager'] Calculating write I/O size for scsi0:0 -- commands delta is negative,prevBytes = 319721472 curBytes = 204800 prevCommands = 17600curCommands = 23
2013-08-21T08:30:25.159Z [482DBB90 info 'Snmpsvc'] UpdateStats: report cimom converter stats started
2013-08-21T08:30:25.160Z [482DBB90 info 'Snmpsvc'] DumpStats: cimom stats file /tmp/.cvtcimsnmp.xml generated, size 294 bytes.
2013-08-21T08:30:25.160Z [482DBB90 info 'Snmpsvc'] PublishReport: file /tmp/.cvtcimsnmp.xml published as /tmp/cvtcimsnmp.xml
2013-08-21T08:30:25.160Z [482DBB90 info 'Snmpsvc'] DumpStats: cimom stats file published
2013-08-21T08:30:25.160Z [482DBB90 info 'Snmpsvc'] NotifyAgent: write(115, /var/run/snmp.ctl, N) 1 bytes to snmpd
2013-08-21T08:30:25.160Z [482DBB90 info 'Snmpsvc'] UpdateStats: report cimom converter stats completed
2013-08-21T08:30:26.986Z [47F40B90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:30:36.185Z [47B81B90 verbose 'SoapAdapter'] Responded to service state request
2013-08-21T08:30:39.975Z [48592B90 verbose 'SoapAdapter'] Responded to service state request

vmware.log

Verfasst: 26.08.2013, 11:11
von Thogus
die vmware.log ist zu groß, um sie hier zu posten :( und ich darf keine Attachements hinzufügen. Wenn diese Logdatei benötigt wird, lade ich sie gern noch hoch.

Verfasst: 26.08.2013, 15:23
von Dayworker
2013-08-21T08:30:03.595Z [482DBB90 verbose 'vm:/vmfs/volumes/50f7d78b-db38717c-bcb9-00259077fbb9/Foswikitest/Foswikitest.vmx'] Handling message _vmx5: The migration has exceeded the maximum switchover time of 100 second(s). ESX has preemptively failed the migration to allow the VM to continue running on the source. To avoid this failure, either increase the maximum allowable switchover time or wait until the VM is performing a less intensive workload.
Das dürfte der entscheidende Passus sein.
Da die VM namens "Foswikitest" häufiger auftaucht, was ist an dieser so besonders?
Alle Zeiten sind UTC+01:00
Seite 1 von 1
Powered by phpBB® Forum Software © phpBB Limited
https://www.phpbb.com/