Die Foren-SW läuft ohne erkennbare Probleme. Sollte doch etwas nicht funktionieren, bitte gerne hier jederzeit melden und wir kümmern uns zeitnah darum. Danke!

eine von 6 VMs reagierte nicht mehr (freeze), Ursachensuchen

Alles zum Thema vSphere 6.7, ESXi 6.7 und vCenter Server.

Moderatoren: irix, Dayworker

Member
Beiträge: 108
Registriert: 22.11.2016, 18:40

eine von 6 VMs reagierte nicht mehr (freeze), Ursachensuchen

Beitragvon vmware-admin2016 » 10.08.2021, 09:33

Hallo,

die Terminalsever VM ist in den letzten Wochen 3-6x gefreezed tagsüber.
Die anderen VMs funktionierten.
Im Webadmin unter Console reagierte die VMware auch nicht mehr so das nur ausschalten half. (es wurde Sperrbildschild STRG+ALT+ENTF) angezeigt
Im Windows Eventlog konnten leider keine "sachdienlichen Hinweise" gefunden werden wegen der Fehlerursache.
In welchem Vmware Log könnte etwas erhellendes stehen?
Besten dank!

Guru
Beiträge: 2731
Registriert: 23.02.2012, 12:26

Re: eine von 6 VMs reagierte nicht mehr (freeze), Ursachensuchen

Beitragvon ~thc » 10.08.2021, 09:50

Zunächst mal im Log der virtuellen Maschine selbst (in Ihrem Verzeichnis).

Member
Beiträge: 108
Registriert: 22.11.2016, 18:40

Re: eine von 6 VMs reagierte nicht mehr (freeze), Ursachensuchen

Beitragvon vmware-admin2016 » 10.08.2021, 12:04

vmware.log

2021-08-09T18:43:48.303Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T18:44:40.345Z| vmx| I125: GuestRpc: Got RPCI vsocket connection 9707, assigned to channel 2.
2021-08-09T18:44:43.346Z| vmx| I125: GuestRpc: Got error for channel 2 connection 9709: Remote disconnected
2021-08-09T18:44:43.346Z| vmx| I125: GuestRpc: Closing channel 2 connection 9709
2021-08-09T18:45:28.377Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T18:46:10.407Z| vmx| I125: GuestRpc: Got RPCI vsocket connection 9807, assigned to channel 2.
2021-08-09T18:46:11.795Z| vmx| I125: GuestRpc: Got error for channel 3 connection 9810: Remote disconnected
2021-08-09T18:46:11.795Z| vmx| I125: GuestRpc: Closing channel 3 connection 9810
2021-08-09T18:47:00.443Z| vmx| I125: GuestRpc: Got RPCI vsocket connection 9907, assigned to channel 2.
2021-08-09T18:47:01.833Z| vmx| I125: GuestRpc: Got error for channel 3 connection 9910: Remote disconnected
2021-08-09T18:47:01.833Z| vmx| I125: GuestRpc: Closing channel 3 connection 9910
2021-08-09T18:47:08.450Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T18:47:50.493Z| vmx| I125: GuestRpc: Got RPCI vsocket connection 10007, assigned to channel 2.
2021-08-09T18:47:51.867Z| vmx| I125: GuestRpc: Got error for channel 3 connection 10010: Remote disconnected
2021-08-09T18:47:51.867Z| vmx| I125: GuestRpc: Closing channel 3 connection 10010
2021-08-09T18:48:48.543Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T18:49:34.860Z| vmx| I125: Guest: toolbox-dnd: Version: build-5541682
2021-08-09T18:50:01.594Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T18:50:51.635Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T18:51:41.681Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T18:52:31.733Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T18:53:21.770Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T18:54:11.808Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T18:55:01.848Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T18:55:51.917Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T18:56:41.966Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T18:57:32.005Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T18:58:22.053Z| vcpu-6| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T18:59:12.093Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:00:02.134Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:00:52.170Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:01:42.210Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:02:32.248Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:03:22.290Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:04:12.323Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:05:02.361Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:05:52.403Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:06:42.441Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:07:32.473Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:08:22.515Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:09:12.554Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:10:02.588Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:10:52.624Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:11:42.661Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:12:32.697Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:13:22.737Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:14:12.780Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:15:02.849Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:15:52.895Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T19:55:03.800Z| vmx| I125: GuestRpc: Got RPCI vsocket connection 20007, assigned to channel 2.
2021-08-09T19:55:05.407Z| vmx| I125: GuestRpc: Got error for channel 3 connection 20008: Remote disconnected
2021-08-09T19:55:05.407Z| vmx| I125: GuestRpc: Closing channel 3 connection 20008
2021-08-09T20:37:00.944Z| vcpu-12| I125: GuestRpc: Reinitializing Channel 1(toolbox-dnd)
2021-08-09T20:37:01.513Z| vcpu-1| W115: GuestRpc: application toolbox-dnd, changing channel 65535 -> 1
2021-08-09T20:37:01.513Z| vcpu-1| I125: GuestRpc: Channel 1, guest application toolbox-dnd.
2021-08-09T20:41:33.034Z| vcpu-5| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T21:18:01.920Z| vmx| I125: GuestRpc: Got RPCI vsocket connection 30007, assigned to channel 3.
2021-08-09T21:18:03.676Z| vmx| I125: GuestRpc: Got error for channel 2 connection 30008: Remote disconnected
2021-08-09T21:18:03.676Z| vmx| I125: GuestRpc: Closing channel 2 connection 30008
2021-08-09T21:38:14.322Z| vcpu-1| I125: GuestRpc: Reinitializing Channel 1(toolbox-dnd)
2021-08-09T21:38:14.669Z| vcpu-5| W115: GuestRpc: application toolbox-dnd, changing channel 65535 -> 1
2021-08-09T21:38:14.669Z| vcpu-5| I125: GuestRpc: Channel 1, guest application toolbox-dnd.
2021-08-10T02:18:26.106Z| vmx| I125: GuestRpc: Got RPCI vsocket connection 40007, assigned to channel 2.
2021-08-10T02:18:28.114Z| vmx| I125: GuestRpc: Got error for channel 2 connection 40009: Remote disconnected
2021-08-10T02:18:28.114Z| vmx| I125: GuestRpc: Closing channel 2 connection 40009
2021-08-10T04:43:48.181Z| vcpu-11| I125: CDROM: Emulate GET CONFIGURATION RT 1 starting feature 0
2021-08-10T04:44:05.446Z| vmx| I125: Guest: toolbox-dnd: Version: build-5541682
2021-08-10T05:02:35.027Z| vmx| I125: Guest: toolbox-dnd: Version: build-5541682
2021-08-10T05:07:42.356Z| vmx| I125: Guest: toolbox-dnd: Version: build-5541682
2021-08-10T05:10:20.125Z| vcpu-9| I125: CDROM: Emulate GET CONFIGURATION RT 1 starting feature 0

Member
Beiträge: 108
Registriert: 22.11.2016, 18:40

Re: eine von 6 VMs reagierte nicht mehr (freeze), Ursachensuchen

Beitragvon vmware-admin2016 » 10.08.2021, 12:05

vmware15.log

2021-08-09T11:58:00.011Z| vcpu-0| I125: CDROM: Emulate GET CONFIGURATION RT 1 starting feature 0
2021-08-09T12:02:29.965Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T12:05:13.301Z| vcpu-0| I125: CDROM: Emulate GET CONFIGURATION RT 1 starting feature 0
2021-08-09T12:05:33.027Z| vmx| I125: Guest: toolbox-dnd: Version: build-5541682
2021-08-09T12:09:30.965Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T12:10:02.728Z| vcpu-9| I125: GuestMsg: Too many channels opened.
2021-08-09T12:10:02.728Z| vcpu-9| I125: GuestMsg: Too many channels opened.
2021-08-09T12:10:04.164Z| vcpu-1| I125: GuestMsg: Too many channels opened.
2021-08-09T12:10:04.164Z| vcpu-15| I125: GuestMsg: Too many channels opened.
2021-08-09T12:10:04.164Z| vcpu-15| I125: GuestMsg: Too many channels opened.
2021-08-09T12:10:04.164Z| vcpu-1| I125: GuestMsg: Too many channels opened.
2021-08-09T12:30:01.399Z| vcpu-5| I125: CDROM: Emulate GET CONFIGURATION RT 1 starting feature 0
2021-08-09T12:30:20.731Z| vmx| I125: Guest: toolbox-dnd: Version: build-5541682
2021-08-09T12:46:23.468Z| vcpu-9| I125: CDROM: Emulate GET CONFIGURATION RT 1 starting feature 0
2021-08-09T12:54:14.955Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T12:57:50.371Z| vcpu-4| I125: GuestMsg: Too many channels opened.
2021-08-09T12:57:50.371Z| vcpu-4| I125: GuestMsg: Too many channels opened.
2021-08-09T13:01:44.587Z| vcpu-6| I125: GuestRpc: Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1
2021-08-09T13:08:16.955Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:09:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:10:14.953Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:11:14.953Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:12:14.953Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:13:14.954Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:14:14.954Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:15:14.954Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:16:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:17:14.953Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:18:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:19:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:20:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:20:49.588Z| vcpu-2| I125: GuestMsg: Too many channels opened.
2021-08-09T13:21:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:22:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:23:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:24:14.953Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:25:14.953Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:26:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:27:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:28:14.953Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:29:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:30:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:31:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:32:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:33:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:34:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:35:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:36:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:37:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:38:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:39:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:40:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:41:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:42:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:43:14.954Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:43:36.954Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:44:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:45:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:46:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:47:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:48:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:49:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:50:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:51:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:52:14.953Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:53:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:54:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:55:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:56:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:56:41.571Z| vcpu-1| I125: CDROM: Emulate GET CONFIGURATION RT 1 starting feature 0
2021-08-09T13:56:41.793Z| vcpu-4| I125: CDROM: Emulate GET CONFIGURATION RT 1 starting feature 0
2021-08-09T13:57:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:58:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:59:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T13:59:15.957Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:00:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:00:15.956Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:01:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:01:15.956Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:02:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:02:15.955Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:03:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:03:15.956Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:04:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:04:15.955Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:05:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:05:15.956Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:06:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:06:15.955Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:07:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:07:15.956Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:08:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:08:15.956Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:09:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:09:15.955Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:10:14.953Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:10:15.957Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:11:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:11:15.955Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:12:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:12:15.956Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:12:22.755Z| vcpu-3| I125: CDROM: Emulate GET CONFIGURATION RT 1 starting feature 0
2021-08-09T14:12:41.288Z| vmx| I125: Guest: toolbox-dnd: Version: build-5541682
2021-08-09T14:13:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:13:15.955Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:13:42.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:14:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:14:15.955Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:15:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:15:15.955Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:15:37.963Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:16:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:16:15.955Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:17:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:17:15.955Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:18:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:18:15.955Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:19:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:19:15.956Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:20:14.953Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:20:15.955Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:21:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:21:15.956Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:22:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:23:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:24:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:25:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:26:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:27:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:27:54.948Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:28:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:29:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:30:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:31:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:32:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:33:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:34:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:35:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:36:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:37:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:38:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:39:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:40:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:41:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:42:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:43:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:44:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:45:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:46:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:47:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:48:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:49:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:50:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:51:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:52:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:53:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:54:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:55:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:56:14.953Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:56:47.779Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:57:14.953Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:58:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T14:59:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:00:01.762Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:00:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:01:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:02:14.953Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:03:14.953Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:04:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:05:09.994Z| vcpu-2| I125: CDROM: Emulate GET CONFIGURATION RT 1 starting feature 0
2021-08-09T15:05:10.169Z| vcpu-5| I125: CDROM: Emulate GET CONFIGURATION RT 1 starting feature 0
2021-08-09T15:05:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:06:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:07:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:08:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:09:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:09:39.665Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:10:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:11:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:12:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:13:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:14:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:15:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:16:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:17:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:18:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:19:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:19:27.948Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:20:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:21:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:22:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:23:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:24:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:25:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:26:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:27:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:28:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:29:14.953Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:30:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:31:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:32:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:33:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:34:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:35:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:36:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:37:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:38:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:39:05.298Z| vcpu-2| I125: CDROM: Emulate GET CONFIGURATION RT 1 starting feature 0
2021-08-09T15:39:05.453Z| vcpu-1| I125: CDROM: Emulate GET CONFIGURATION RT 1 starting feature 0
2021-08-09T15:39:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:39:42.327Z| vcpu-4| I125: CDROM: Emulate GET CONFIGURATION RT 1 starting feature 0
2021-08-09T15:39:42.470Z| vcpu-1| I125: CDROM: Emulate GET CONFIGURATION RT 1 starting feature 0
2021-08-09T15:40:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:41:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:42:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:43:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:44:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:45:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:46:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:47:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:48:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:49:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:50:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:51:14.954Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:52:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:53:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:54:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:55:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:56:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:57:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:58:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:59:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T15:59:22.173Z| vcpu-2| I125: CDROM: Emulate GET CONFIGURATION RT 1 starting feature 0
2021-08-09T15:59:22.306Z| vcpu-4| I125: CDROM: Emulate GET CONFIGURATION RT 1 starting feature 0
2021-08-09T16:00:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:01:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:02:14.953Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:03:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:04:14.954Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:05:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:06:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:07:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:08:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:09:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:10:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:10:49.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:10:50.953Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:11:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:12:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:13:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:14:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:15:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:16:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:17:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:18:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:19:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:20:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:21:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:22:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:23:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:24:14.952Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:24:52.096Z| vmx| I125: GuestRpcSendTimedOut: message to toolbox timed out.
2021-08-09T16:25:12.100Z| vmx| I125: GuestRpcSendTimedOut: message to toolbox timed out.
2021-08-09T16:25:12.101Z| vmx| I125: GuestRpc: app toolbox's second ping timeout; assuming app is down
2021-08-09T16:25:12.102Z| vmx| I125: GuestRpc: Reinitializing Channel 0(toolbox)
2021-08-09T16:25:12.102Z| vmx| I125: GuestMsg: Channel 0, Cannot unpost because the previous post is already completed
2021-08-09T16:25:14.951Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:26:00.216Z| vmx| I125: GuestRpcSendTimedOut: message to toolbox-dnd timed out.
2021-08-09T16:26:10.818Z| vcpu-0| I125: Tools: Tools heartbeat timeout.
2021-08-09T16:26:10.818Z| vcpu-0| I125: Tools: Running status rpc handler: 1 => 0.
2021-08-09T16:26:10.818Z| vcpu-0| I125: Tools: Changing running status: 1 => 0.
2021-08-09T16:26:20.217Z| vmx| I125: GuestRpcSendTimedOut: message to toolbox-dnd timed out.
2021-08-09T16:26:20.218Z| vmx| I125: GuestRpc: app toolbox-dnd's second ping timeout; assuming app is down
2021-08-09T16:26:20.218Z| vmx| I125: GuestRpc: Reinitializing Channel 1(toolbox-dnd)
2021-08-09T16:26:20.218Z| vmx| I125: GuestMsg: Channel 1, Cannot unpost because the previous post is already completed
2021-08-09T16:48:13.417Z| svga| I125: MKSScreenShotMgr: Taking a screenshot
2021-08-09T16:48:16.309Z| vmx| I125: VigorTransportProcessClientPayload: opID=esxui-381b-4646 seq=73694: Receiving MKS.IssueTicket request.
2021-08-09T16:48:16.310Z| vmx| I125: SOCKET creating new socket listening on /var/run/vmware/ticket/802e8c5920215ac8
2021-08-09T16:48:16.310Z| vmx| I125: SOCKET 4784399 (48) creating new listening socket on port -1
2021-08-09T16:48:16.310Z| vmx| I125: Issuing new webmks ticket 802e8c... (120 seconds)
2021-08-09T16:48:16.310Z| vmx| I125: VigorTransport_ServerSendResponse opID=esxui-381b-4646 seq=73694: Completed MKS request with messages.

Member
Beiträge: 108
Registriert: 22.11.2016, 18:40

Re: eine von 6 VMs reagierte nicht mehr (freeze), Ursachensuchen

Beitragvon vmware-admin2016 » 10.08.2021, 12:05

vmware15.log fortsetzung

2021-08-09T16:48:16.341Z| mks| I125: Accepting connection for webmks ticket 802e8c...
2021-08-09T16:48:16.341Z| mks| I125: Expiring webmks ticket 802e8c...
2021-08-09T16:48:16.341Z| mks| I125: SOCKET 4784400 (173) AsyncTCPSocketSetOption: Option layer/level [6], option/name [1]: successfully set OS option for TCP socket.
2021-08-09T16:48:16.341Z| mks| W115: SOCKET 4784401 (173) unable to determine remote IP address
2021-08-09T16:48:16.342Z| mks| I125: SOCKET 4784400 (173) AsyncTCPSocketSetOption: sendLowLatencyMode set to [1].
2021-08-09T16:48:16.342Z| mks| I125: SOCKET 4784401 (173) Creating VNC remote connection.
2021-08-09T16:48:16.342Z| mks| I125: MKSControlMgr: New VNC connection 0
2021-08-09T16:48:16.342Z| svga| I125: VNCENCODE 4784401 VNCEncode: VNCEncode_ServerSetTopology - original root: (0, 0) size: (984, 738)
2021-08-09T16:48:16.342Z| svga| I125: VNCENCODE 4784401 VNCEncode: Number of screens changed from 0 to 1
2021-08-09T16:48:16.342Z| svga| I125: VNCENCODE 4784401 VNCEncode: screen: 0 BoundingBox: (984x738) Screen (984x738) @ (0,0) bytesPerLine: 3936
2021-08-09T16:48:16.406Z| mks| W115: VNCENCODE 4784401 JPEG quality levels (min, mid, max). Input: (25, 35, 90) Clamped: (25, 35, 90)
2021-08-09T16:48:16.406Z| mks| W115: VNCENCODE 4784401 failed to allocate VNCBlitDetect
2021-08-09T16:48:16.406Z| mks| I125: VNCENCODE 4784401 VNCEncodeChooseRegionEncoder: region encoder adaptive. Screen 1/1 @ Resolution: 984 x 738
2021-08-09T16:48:17.375Z| vmx| I125: Tools_SetGuestResolution: Sending rpcMsg = Resolution_Set 984 738
2021-08-09T16:49:13.416Z| svga| I125: MKSScreenShotMgr: Taking a screenshot
2021-08-09T16:49:17.376Z| vmx| I125: GuestRpcSendTimedOut: message to toolbox timed out.
2021-08-09T16:49:28.991Z| mks| I125: SOCKET 4784401 (173) Received websocket close frame with empty status code
2021-08-09T16:49:28.991Z| mks| I125: SOCKET 4784401 (173) Sending websocket close frame, status code = 1000
2021-08-09T16:49:28.991Z| mks| I125: SOCKET 4784401 (173) VNC Remote Disconnect: socket closed.
2021-08-09T16:49:28.991Z| mks| I125: MKSControlMgr: Remove VNC connection 0
2021-08-09T16:50:13.417Z| svga| I125: MKSScreenShotMgr: Taking a screenshot
2021-08-09T16:50:18.760Z| vmx| I125: VigorTransportProcessClientPayload: opID=esxui-417b-466d seq=73721: Receiving PowerState.InitiatePowerOff request.
2021-08-09T16:50:18.760Z| vmx| I125: Vix: [vmxCommands.c:557]: VMAutomation_InitiatePowerOff. Trying hard powerOff
2021-08-09T16:50:18.760Z| vmx| I125: VigorTransport_ServerSendResponse opID=esxui-417b-466d seq=73721: Completed PowerState request with messages.
2021-08-09T16:50:18.760Z| vmx| I125: Stopping VCPU threads...
2021-08-09T16:50:18.760Z| vcpu-7| I125: VMMon_WaitForExit: vcpu-7: worldID=2101068
2021-08-09T16:50:18.760Z| vcpu-10| I125: VMMon_WaitForExit: vcpu-10: worldID=2101071
2021-08-09T16:50:18.760Z| vcpu-0| I125: VMMon_WaitForExit: vcpu-0: worldID=2101058
2021-08-09T16:50:18.760Z| vcpu-11| I125: VMMon_WaitForExit: vcpu-11: worldID=2101072
2021-08-09T16:50:18.760Z| vcpu-8| I125: VMMon_WaitForExit: vcpu-8: worldID=2101069
2021-08-09T16:50:18.760Z| vcpu-12| I125: VMMon_WaitForExit: vcpu-12: worldID=2101073
2021-08-09T16:50:18.760Z| vcpu-5| I125: VMMon_WaitForExit: vcpu-5: worldID=2101066
2021-08-09T16:50:18.760Z| vcpu-15| I125: VMMon_WaitForExit: vcpu-15: worldID=2101076
2021-08-09T16:50:18.760Z| vcpu-14| I125: VMMon_WaitForExit: vcpu-14: worldID=2101075
2021-08-09T16:50:18.760Z| vcpu-2| I125: VMMon_WaitForExit: vcpu-2: worldID=2101063
2021-08-09T16:50:18.760Z| vcpu-9| I125: VMMon_WaitForExit: vcpu-9: worldID=2101070
2021-08-09T16:50:18.760Z| vcpu-4| I125: VMMon_WaitForExit: vcpu-4: worldID=2101065
2021-08-09T16:50:18.760Z| vcpu-3| I125: VMMon_WaitForExit: vcpu-3: worldID=2101064
2021-08-09T16:50:18.760Z| vcpu-1| I125: VMMon_WaitForExit: vcpu-1: worldID=2101062
2021-08-09T16:50:18.760Z| vcpu-6| I125: VMMon_WaitForExit: vcpu-6: worldID=2101067
2021-08-09T16:50:18.760Z| vcpu-13| I125: VMMon_WaitForExit: vcpu-13: worldID=2101074
2021-08-09T16:50:18.762Z| svga| I125: SVGA thread is exiting
2021-08-09T16:50:18.762Z| vmx| I125: MKS thread is stopped
2021-08-09T16:50:18.762Z| vmx| I125: USB: Disconnecting device 0x200000050e0f0003
2021-08-09T16:50:18.762Z| vmx| I125:
2021-08-09T16:50:18.762Z| vmx| I125+ OvhdMem: Final (Power Off) Overheads
2021-08-09T16:50:18.762Z| vmx| I125: reserved | used
2021-08-09T16:50:18.762Z| vmx| I125: OvhdMem excluded cur max avg | cur max avg
2021-08-09T16:50:18.762Z| vmx| I125: OvhdMem OvhdUser_MainMem : 33554432 33554432 - | 33554432 33554432 -
2021-08-09T16:50:18.762Z| vmx| I125: OvhdMem OvhdUser_VmxText : 7168 7168 - | 0 0 -
2021-08-09T16:50:18.762Z| vmx| I125: OvhdMem OvhdUser_VmxTextLibs : 15360 15360 - | 0 0 -
2021-08-09T16:50:18.762Z| vmx| I125: OvhdMem Total excluded : 33576960 33576960 - | - - -
2021-08-09T16:50:18.762Z| vmx| I125: OvhdMem Actual maximum : 33576960 | -
2021-08-09T16:50:18.762Z| vmx| I125+
2021-08-09T16:50:18.762Z| vmx| I125: reserved | used
2021-08-09T16:50:18.762Z| vmx| I125: OvhdMem paged cur max avg | cur max avg
2021-08-09T16:50:18.762Z| vmx| I125: OvhdMem OvhdUser_KSTATS_vmm : 0 0 - | 0 0 -
2021-08-09T16:50:18.762Z| vmx| I125: OvhdMem OvhdUser_STATS_vmm : 32 32 - | 0 0 -
2021-08-09T16:50:18.762Z| vmx| I125: OvhdMem OvhdUser_KSTATS_device : 0 0 - | 0 0 -
2021-08-09T16:50:18.762Z| vmx| I125: OvhdMem OvhdUser_STATS_device : 16 16 - | 0 0 -
2021-08-09T16:50:18.762Z| vmx| I125: OvhdMem OvhdUser_KSTATS_migrate : 0 0 - | 0 0 -
2021-08-09T16:50:18.762Z| vmx| I125: OvhdMem OvhdUser_IOFiltersMalloc : 0 0 - | 0 0 -
2021-08-09T16:50:18.762Z| vmx| I125: OvhdMem OvhdUser_DiskLibMemUsed : 3075 3075 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaSurfaceTable : 5 5 - | 1 1 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaBESurfaceTable : 6 6 - | 2 2 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaHBTables : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaHBMobListTable : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaHBShaderTable : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaRestoreBufferArray : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaSDirtyCache : 48 48 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaShaderTable : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaShaderText : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaContextCache : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaMobCache : 264 264 - | 24 25 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaDXRTViewTable : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaDXDSViewTable : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaDXSRViewTable : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaDXBlendStateTable : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaDXElementLayoutTable : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaDXDepthStencilTable : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaDXRasterizerStateTable : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaDXSamplerTable : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaDXContextTable : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaDXShaderTable : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaDXShaderText : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaDXStreamOutTable : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaDXQueryTable : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaVAProcessorTable : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SvgaVADecoderTable : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxAllocTrack : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxASAN : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxCallStackProf : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxGlobals : 1216 1216 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxGlobalsLibs : 3584 3584 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxHeap : 8704 8704 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxHeapFreeList : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxMks : 33 33 - | 1 10 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxMksRenderOps : 16 16 - | 3 3 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxMks3d : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxMksHBMobs : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxMksGLRenderer : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxMksGLTransient : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxMksLLVM : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxMksScreenTemp : 5378 5378 - | 0 187 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxMksVnc : 2682 2682 - | 0 1035 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxMksScreen : 2051 2051 - | 0 1419 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxMksSVGAVO : 4096 4096 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxMksVMVA : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxPhysMemRingBuf : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxPhysMemErrPages : 10 10 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxFTCptOutputBuf : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxSLEntryBuf : 128 128 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VmxThreads : 26112 26112 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem Total paged : 57456 57456 - | 31 2682 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem Actual maximum : 57456 | 2486
2021-08-09T16:50:18.763Z| vmx| I125+
2021-08-09T16:50:18.763Z| vmx| I125: reserved | used
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem nonpaged cur max avg | cur max avg
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SharedArea : 267 267 - | 201 201 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_BusMemTraceBitmap : 1027 1027 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_PFrame : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VProbe : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VIDE_KSEG : 16 16 - | 16 16 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VGA : 64 64 - | 64 64 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_BalloonMPN : 1 1 - | 1 1 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_P2MUpdateBuffer : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_ServicesMPN : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_LocalApic : 16 16 - | 16 16 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_BusError : 1 1 - | 1 1 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VBIOS : 8 8 - | 8 8 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VnicGuest : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VnicMmap : 1 1 - | 1 1 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_TestDev : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_LSIBIOS : 4 4 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_LSIRings : 4 4 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_PCIPBIOS : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_PVSCSIBIOS : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_PVSCSIKickReg : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SAS1068BIOS : 4 4 - | 4 4 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SBIOS : 16 16 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_AHCIBIOS : 16 16 - | 16 16 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_NVMEBIOS : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_FlashRam : 128 128 - | 128 128 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_IOFiltersMMap : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_IOFiltersGlobal : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SMM : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SVGAFB : 1024 1024 - | 1024 1024 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_SVGAMEM : 64 512 - | 64 64 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_HDAudioReg : 3 3 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_EHCIRegister : 1 1 - | 1 1 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_XhciRegister : 1 1 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_PhysMemDebug : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_HyperV : 2 2 - | 2 2 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_ExtCfg : 3 3 - | 3 3 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_HV : 50 50 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_HVIOBitmap : 3 3 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_HVMSRBitmap : 2 2 - | 1 1 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_VHVGuestMSRBitmap : 2 2 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_vhvCachedVMCS : 16 16 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_vhvNestedAPIC : 16 16 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_PCIP : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_MigrateCpt : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_MonBootstrap : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_MonWired : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_MonLow : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_MonWiredNuma : 0 272 - | 15 16 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_MonNuma : 0 835 - | 0 792 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_MonOther : 624 624 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_FTCpt : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_NVDC : 1 1 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_NVDIMM : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdUser_EPC : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem Total nonpaged : 3385 4940 - | 1566 2359 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem Actual maximum : 4940 | 2359
2021-08-09T16:50:18.763Z| vmx| I125+
2021-08-09T16:50:18.763Z| vmx| I125: reserved | used
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem anonymous cur max avg | cur max avg
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_Alloc : 1264 1264 - | 260 794 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_BusMemFrame : 32834 32842 - | 32834 32834 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_BusMem2MInfo : 512 512 - | 512 512 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_BusMem1GInfo : 1 1 - | 1 1 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_BusMemZapListMPN : 1 1 - | 1 1 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_MonAS : 32 32 - | 2 2 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_GuestMem : 384 384 - | 384 384 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_TC : 8208 15600 - | 7408 12964 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_Island : 64 64 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_BusMemMonAS : 69 69 - | 69 69 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_PlatformMonAS : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_HVNuma : 48 48 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_HV : 16 16 - | 16 16 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_VHV : 48 48 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_VNPTShadow : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_VNPTShadowCache : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_VNPTBackmap : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_SVMIDT : 16 16 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_CallStackProfAnon : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_Numa : 130 130 - | 14 68 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_NumaTextRodata : 195 195 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_NumaDataBss : 640 640 - | 624 624 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_NumaLargeData : 8192 8192 - | 0 7169 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_WiredNuma : 272 272 - | 272 272 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_Bootstrap : 0 3 - | 0 3 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_GPhysTraced : 13164 13164 - | 617 804 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_GPhysHWMMU : 65953 65953 - | 416 477 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_GPhysGIM : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_GPhysNoTrace : 3291 3291 - | 108 108 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_PhysMemGart : 88 88 - | 80 80 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_PhysMemErr : 21 21 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_TraceALot : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_VIDE : 4 4 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_VMXNETWake : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_BusLogic : 4 4 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_Ahci : 32 32 - | 1 1 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_Nvme : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_NVMERings : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_PVSCSIShadowRing : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_LSIRings : 8 8 - | 8 8 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_FTCptMonAS : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_Hba : 2 2 - | 2 2 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_VProbe : 1 1 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem OvhdMon_PT : 0 0 - | 0 0 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem Total anonymous : 135494 142897 - | 43629 57193 -
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem Actual maximum : 142886 | 50381
2021-08-09T16:50:18.763Z| vmx| I125+
2021-08-09T16:50:18.763Z| vmx| I125: OvhdMem: memsize 131072 MB VMK fixed 3462 pages var(mem) 529 pages var(cpu) 8 cbrcOverhead 0 pages total 71345 pages
2021-08-09T16:50:18.763Z| vmx| I125: VMMEM: Maximum Reservation: 801MB (MainMem=131072MB) VMK=278MB
2021-08-09T16:50:18.764Z| vmx| I125: TOOLS using cached value 1 for isoImageExists (refreshCount=1, lastCount=1).
2021-08-09T16:50:18.764Z| vmx| I125: ToolsISO: Refreshing imageName for 'windows9srv-64' (refreshCount=1, lastCount=1).
2021-08-09T16:50:18.766Z| vmx| I125: ToolsISO: Updated cached value for imageName to 'windows.iso'.
2021-08-09T16:50:18.766Z| vmx| I125: ToolsISO: Selected Tools ISO 'windows.iso' for 'windows9srv-64' guest.
2021-08-09T16:50:18.767Z| vmx| I125: MsgHint: msg.tools.toolsImage
2021-08-09T16:50:18.767Z| vmx| I125+ The VMware Tools package is not running in this virtual machine. The package might be necessary for the guest operating system to run at resolutions higher than 640x480 with 16 colors. The package provides significant performance benefits as well. To install it, choose VM > Install VMware Tools… after the guest operating system starts.
2021-08-09T16:50:18.767Z| vmx| I125+ VMware ESX can remind you to install the VMware Tools package when you power on the VM. Select OK to enable the reminder.
2021-08-09T16:50:18.767Z| vmx| I125+ ---------------------------------------
2021-08-09T16:50:18.768Z| vmx| I125: TOOLS INSTALL User requested VMware Tools installation reminder
2021-08-09T16:50:18.768Z| vmx| A100: ConfigDB: Setting tools.remindInstall = "TRUE"
2021-08-09T16:50:18.867Z| vmx| I125: Tools: ToolsRunningStatus_Exit, delayedRequest is 0x0
2021-08-09T16:50:18.867Z| vmx| I125: SVMotion_PowerOff: Not running Storage vMotion. Nothing to do
2021-08-09T16:50:18.869Z| vmx| I125: USB: Disconnecting device 0x10e0f0002
2021-08-09T16:50:18.870Z| vmx| I125: Destroying virtual dev for scsi0:0 vscsi=8202
2021-08-09T16:50:18.870Z| vmx| I125: VMMon_VSCSIStopVports: No such target on adapter
2021-08-09T16:50:18.870Z| vmx| I125: Destroying virtual dev for scsi0:1 vscsi=8203
2021-08-09T16:50:18.870Z| vmx| I125: VMMon_VSCSIStopVports: No such target on adapter
2021-08-09T16:50:18.871Z| vmx| I125: MKS thread was already stopped
2021-08-09T16:50:18.871Z| mks| I125: MKS-RenderMain: Stopping MKSBasicOps
2021-08-09T16:50:18.872Z| mks| I125: MKS PowerOff
2021-08-09T16:50:18.872Z| mks| I125: MKS thread is exiting
2021-08-09T16:50:18.872Z| vmx| I125: SVMotion_PowerOff: Not running Storage vMotion. Nothing to do
2021-08-09T16:50:18.872Z| vmx| I125: scsi0:1: numIOs = 0 numMergedIOs = 0 numSplitIOs = 0 ( 0.0%)
2021-08-09T16:50:18.872Z| vmx| I125: Closing disk 'scsi0:1'
2021-08-09T16:50:18.876Z| vmx| I125: DISKLIB-CBT : Shutting down change tracking for untracked fid 1378152.
2021-08-09T16:50:18.876Z| vmx| I125: DISKLIB-CBT : Successfully disconnected CBT node.
2021-08-09T16:50:19.053Z| vmx| I125: DISKLIB-VMFS : "/vmfs/volumes/5eeb219e-9c163cc0-ca4b-a4bf01583636/endkunde-TS3/endkunde-TS3_1-flat.vmdk" : closed.
2021-08-09T16:50:19.054Z| vmx| I125: scsi0:0: numIOs = 0 numMergedIOs = 0 numSplitIOs = 0 ( 0.0%)
2021-08-09T16:50:19.054Z| vmx| I125: Closing disk 'scsi0:0'
2021-08-09T16:50:19.058Z| vmx| I125: DISKLIB-CBT : Shutting down change tracking for untracked fid 2819943.
2021-08-09T16:50:19.058Z| vmx| I125: DISKLIB-CBT : Successfully disconnected CBT node.
2021-08-09T16:50:19.200Z| vmx| I125: DISKLIB-VMFS : "/vmfs/volumes/5eeb219e-9c163cc0-ca4b-a4bf01583636/endkunde-TS3/endkunde-TS3-flat.vmdk" : closed.
2021-08-09T16:50:19.203Z| vmx| I125: Vix: [mainDispatch.c:1180]: VMAutomationPowerOff: Powering off.
2021-08-09T16:50:19.209Z| vmx| I125: WORKER: asyncOps=4 maxActiveOps=2 maxPending=1 maxCompleted=0
2021-08-09T16:50:23.600Z| vmx| I125: Vix: [mainDispatch.c:4239]: VMAutomation_ReportPowerOpFinished: statevar=1, newAppState=1873, success=1 additionalError=0
2021-08-09T16:50:23.600Z| vmx| I125: Vix: [mainDispatch.c:4258]: VMAutomation: Ignoring ReportPowerOpFinished because the VMX is shutting down.
2021-08-09T16:50:23.600Z| vmx| A100: ConfigDB: Setting cleanShutdown = "TRUE"
2021-08-09T16:50:23.603Z| vmx| I125: Vix: [mainDispatch.c:4239]: VMAutomation_ReportPowerOpFinished: statevar=0, newAppState=1870, success=1 additionalError=0
2021-08-09T16:50:23.603Z| vmx| I125: Vix: [mainDispatch.c:4258]: VMAutomation: Ignoring ReportPowerOpFinished because the VMX is shutting down.
2021-08-09T16:50:23.603Z| vmx| I125: Transitioned vmx/execState/val to poweredOff
2021-08-09T16:50:23.603Z| vmx| I125: Vigor_ClientRequestCb: failed to do op=3 on unregistered device 'Tools' (cmd=queryFields)
2021-08-09T16:50:23.603Z| vmx| I125: VMX idle exit
2021-08-09T16:50:23.621Z| vmx| I125: Vix: [mainDispatch.c:832]: VMAutomation_LateShutdown()
2021-08-09T16:50:23.621Z| vmx| I125: Vix: [mainDispatch.c:781]: VMAutomationCloseListenerSocket. Closing listener socket.
2021-08-09T16:50:23.622Z| vmx| I125: Flushing VMX VMDB connections
2021-08-09T16:50:23.622Z| vmx| I125: VigorTransport_ServerCloseClient: Closing transport 4BB701B900 (err = 0)
2021-08-09T16:50:23.622Z| vmx| I125: VigorTransport_ServerDestroy: server destroyed.
2021-08-09T16:50:23.622Z| vmx| I125: VMX exit (0).
2021-08-09T16:50:23.623Z| vmx| I125: OBJLIB-LIB: ObjLib cleanup done.
2021-08-09T16:50:23.623Z| vmx| I125: AIOMGR-S : stat o=7 r=27 w=1 i=2 br=205296 bw=128
2021-08-09T16:50:23.623Z| vmx| W115: VMX has left the building: 0.

Member
Beiträge: 108
Registriert: 22.11.2016, 18:40

Re: eine von 6 VMs reagierte nicht mehr (freeze), Ursachensuchen

Beitragvon vmware-admin2016 » 10.08.2021, 12:09

cold-Reset war gestern am 9.8.2021 ca. 19 Uhr

Es sind die beiden Logs aus dem Vmware Ordner in dem auch die VM (terminalserver Windows Server 2016) selbst gespeichert ist.

Rechtsklick auf die VM > Gastbetriebssystem > VMware Tools aktualisieren wird angeboten, die anderen Einträge sind ausgegraut.

Der Host hat: 6.7.0 Update 3 (Build 15160138)

Habe die Vermutung vmware.log habe ich etwas falsch hier im Forum eingefügt.

Guru
Beiträge: 2731
Registriert: 23.02.2012, 12:26

Re: eine von 6 VMs reagierte nicht mehr (freeze), Ursachensuchen

Beitragvon ~thc » 10.08.2021, 16:54

Sucht man die Fehlermeldungen im Log, findet man definitiv Hinweise, dass das

1. EIn Problem der VM ist
2. MS Terminalserver betrifft, die sich aufhängen
3. Mit den TCP-Parametern der virtuellen Netzwerkkarten zusammenzuhängen scheint.

Such einfach nach "Channel conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 1" oder "GuestMsg: Too many channels opened."

King of the Hill
Beiträge: 13561
Registriert: 01.10.2008, 12:54
Wohnort: laut USV-Log am Ende der Welt...

Re: eine von 6 VMs reagierte nicht mehr (freeze), Ursachensuchen

Beitragvon Dayworker » 11.08.2021, 15:30

Warum postet man Logschnipsel, anstatt die Logs komprimiert an den Post anzuhängen???
Die Foren-SW macht aber einer gewissen Zeichenzahl zu und zerstört dabei auch noch jedes halbwegs vorhandenes Layout...

Bitte beim nächsten Mal das/die Log(s) anhängen.


Zurück zu „vSphere 6.7“

Wer ist online?

Mitglieder in diesem Forum: 0 Mitglieder und 5 Gäste