VMware Cloud Community
benni0707
Contributor
Contributor

Not all Autostart VMs starting after Boot

VMS.PNGHallo,

I have a Problem only Autostart VM 1 and 3 is starting.

Why is the second Autostart VM not starting and what mean this errors?

Log:

2017-11-04T09:11:46.701Z cpu2:67981)World: vm 68020: 7375: Starting world vmm0:Windows_Server_2012R2_VCenter of type 8

2017-11-04T09:11:46.702Z cpu2:67981)Sched: vm 68020: 6184: Adding world 'vmm0:Windows_Server_2012R2_VCenter', group 'host/user', cpu: shares=-3 min=0 minLimit=-1 max=-1, mem: shares=-3 min=0 minLimit=-1 max=-1

2017-11-04T09:11:46.702Z cpu2:67981)Sched: vm 68020: 6199: renamed group 12663 to vm.67981

2017-11-04T09:11:46.702Z cpu2:67981)Sched: vm 68020: 6216: group 12663 is located under group 4

2017-11-04T09:11:46.820Z cpu2:67981)World: vm 68038: 7375: Starting world vmm1:Windows_Server_2012R2_VCenter of type 8

2017-11-04T09:11:46.821Z cpu2:67981)World: vm 68039: 7375: Starting world vmm2:Windows_Server_2012R2_VCenter of type 8

2017-11-04T09:11:46.821Z cpu2:67981)World: vm 68040: 7375: Starting world vmm3:Windows_Server_2012R2_VCenter of type 8

2017-11-04T09:11:46.932Z cpu2:67981)VSCSI: 3787: handle 8192(vscsi0:0):Creating Virtual Device for world 68020 (FSS handle 68921) numBlocks=83886080 (bs=512)

2017-11-04T09:11:46.932Z cpu2:67981)VSCSI: 273: handle 8192(vscsi0:0):Input values: res=0 limit=-2 bw=-1 Shares=1000

2017-11-04T09:11:46.987Z cpu10:68020)VMMVMKCall: 218: Received INIT from world 68020

2017-11-04T09:11:46.989Z cpu10:68020)LSI: 1805: LSI: Initialized rings for scsi0 async=1

2017-11-04T09:11:46.990Z cpu9:68038)VMMVMKCall: 218: Received INIT from world 68038

2017-11-04T09:11:46.990Z cpu12:68039)VMMVMKCall: 218: Received INIT from world 68039

2017-11-04T09:11:46.990Z cpu2:68040)VMMVMKCall: 218: Received INIT from world 68040

2017-11-04T09:11:46.994Z cpu1:68086)WARNING: NetDVS: 681: portAlias is NULL

2017-11-04T09:11:46.994Z cpu1:68086)Net: 2524: connected Windows Server 2012R2 VCenter eth0 to VM Network, portID 0x2000005

2017-11-04T09:11:46.997Z cpu4:67836)Config: 706: "SIOControlFlag2" = 0, Old Value: 1, (Status: 0x0)

2017-11-04T09:11:47.821Z cpu3:68020)VSCSI: 2611: handle 8192(vscsi0:0):Reset request on FSS handle 68921 (0 outstanding commands) from (vmm0:Windows_Server_2012R2_VCenter)

2017-11-04T09:11:47.821Z cpu0:65770)VSCSI: 2891: handle 8192(vscsi0:0):Reset [Retries: 0/0] from (vmm0:Windows_Server_2012R2_VCenter)

2017-11-04T09:11:47.821Z cpu0:65770)VSCSI: 2679: handle 8192(vscsi0:0):Completing reset (0 outstanding commands)

2017-11-04T09:11:54.725Z cpu4:68040)VSCSI: 2611: handle 8192(vscsi0:0):Reset request on FSS handle 68921 (0 outstanding commands) from (vmm0:Windows_Server_2012R2_VCenter)

2017-11-04T09:11:54.726Z cpu0:65770)VSCSI: 2891: handle 8192(vscsi0:0):Reset [Retries: 0/0] from (vmm0:Windows_Server_2012R2_VCenter)

2017-11-04T09:11:54.726Z cpu0:65770)VSCSI: 2679: handle 8192(vscsi0:0):Completing reset (0 outstanding commands)

2017-11-04T09:11:56.330Z cpu7:68090)Vmxnet3: 17265: Disable Rx queuing; queue size 512 is larger than Vmxnet3RxQueueLimit limit of 64.

2017-11-04T09:11:56.330Z cpu7:68090)Vmxnet3: 17623: Using default queue delivery for vmxnet3 for port 0x2000005

2017-11-04T09:11:56.330Z cpu7:68090)NetPort: 1660: enabled port 0x2000005 with mac 00:0c:29:a9:ad:bc

2017-11-04T09:11:56.336Z cpu3:68088)NetPort: 1879: disabled port 0x2000005

2017-11-04T09:11:56.337Z cpu3:68088)Vmxnet3: 17265: Disable Rx queuing; queue size 512 is larger than Vmxnet3RxQueueLimit limit of 64.

2017-11-04T09:11:56.337Z cpu3:68088)Vmxnet3: 17623: Using default queue delivery for vmxnet3 for port 0x2000005

2017-11-04T09:11:56.337Z cpu3:68088)NetPort: 1660: enabled port 0x2000005 with mac 00:0c:29:a9:ad:bc

2017-11-04T09:13:33.283Z cpu1:68038)nhpsa: hpsa_vmkScsiCmdDone:5238: Sense data: error code: 0x70, key: 0x5, info:00 00 00 00 , cmdInfo:00 00 00 00 , CmdSN: 0x0, worldId: 0x1081b, Cmd: 0x85, ASC: 0x20, ASCQ: 0x0
2017-11-04T09:13:33.283Z cpu9:66242)ScsiDeviceIO: 2948: Cmd(0x439d007230c0) 0x85, CmdSN 0x0 from world 67611 to dev "naa.600508b1001c9663bd569f0d865c482e" failed H:0x0 D:0x2 P:0x0 Valid sense data: 0x5 0x20 0x0.
2017-11-04T09:13:33.294Z cpu1:68038)nhpsa: hpsa_vmkScsiCmdDone:5238: Sense data: error code: 0x70, key: 0x5, info:00 00 00 00 , cmdInfo:00 00 00 00 , CmdSN: 0x1, worldId: 0x1081b, Cmd: 0x4d, ASC: 0x20, ASCQ: 0x0
2017-11-04T09:13:33.294Z cpu1:68038)nhpsa: hpsa_vmkScsiCmdDone:5238: Sense data: error code: 0x70, key: 0x5, info:00 00 00 00 , cmdInfo:00 00 00 00 , CmdSN: 0x2, worldId: 0x1081b, Cmd: 0x1a, ASC: 0x24, ASCQ: 0x0
2017-11-04T09:13:33.306Z cpu1:68038)nhpsa: hpsa_vmkScsiCmdDone:5238: Sense data: error code: 0x70, key: 0x5, info:00 00 00 00 , cmdInfo:00 00 00 00 , CmdSN: 0x3, worldId: 0x1081b, Cmd: 0x85, ASC: 0x20, ASCQ: 0x0
2017-11-04T09:13:33.314Z cpu8:65577)ScsiDeviceIO: 2948: Cmd(0x439d007230c0) 0x85, CmdSN 0x4 from world 67611 to dev "naa.2020030102060804" failed H:0x0 D:0x2 P:0x0 Valid sense data: 0x5 0x20 0x0.
2017-11-04T09:13:33.334Z cpu1:68038)nhpsa: hpsa_vmkScsiCmdDone:5238: Sense data: error code: 0x70, key: 0x5, info:00 00 00 00 , cmdInfo:00 00 00 00 , CmdSN: 0x5, worldId: 0x1081b, Cmd: 0x85, ASC: 0x20, ASCQ: 0x0
2017-11-04T09:13:33.334Z cpu9:66242)ScsiDeviceIO: 2948: Cmd(0x439d007230c0) 0x85, CmdSN 0x5 from world 67611 to dev "naa.600508b1001c3a9afd32d159eadf56b3" failed H:0x0 D:0x2 P:0x0 Valid sense data: 0x5 0x20 0x0.
2017-11-04T09:13:33.345Z cpu1:68038)nhpsa: hpsa_vmkScsiCmdDone:5238: Sense data: error code: 0x70, key: 0x5, info:00 00 00 00 , cmdInfo:00 00 00 00 , CmdSN: 0x6, worldId: 0x1081b, Cmd: 0x4d, ASC: 0x20, ASCQ: 0x0
2017-11-04T09:13:33.345Z cpu1:68038)nhpsa: hpsa_vmkScsiCmdDone:5238: Sense data: error code: 0x70, key: 0x5, info:00 00 00 00 , cmdInfo:00 00 00 00 , CmdSN: 0x7, worldId: 0x1081b, Cmd: 0x1a, ASC: 0x24, ASCQ: 0x0
2017-11-04T09:13:33.358Z cpu1:68038)nhpsa: hpsa_vmkScsiCmdDone:5238: Sense data: error code: 0x70, key: 0x5, info:00 00 00 00 , cmdInfo:00 00 00 00 , CmdSN: 0x8, worldId: 0x1081b, Cmd: 0x85, ASC: 0x20, ASCQ: 0x0
2017-11-04T09:13:33.463Z cpu1:68038)nhpsa: hpsa_vmkScsiCmdDone:5238: Sense data: error code: 0x70, key: 0x5, info:00 00 00 00 , cmdInfo:00 00 00 00 , CmdSN: 0x9, worldId: 0x1081b, Cmd: 0x85, ASC: 0x20, ASCQ: 0x0
2017-11-04T09:13:33.463Z cpu9:66242)ScsiDeviceIO: 2948: Cmd(0x439d007230c0) 0x85, CmdSN 0x9 from world 67611 to dev "naa.600508b1001cc71bc5d5a23e0d74bee7" failed H:0x0 D:0x2 P:0x0 Valid sense data: 0x5 0x20 0x0.
2017-11-04T09:13:33.474Z cpu1:68038)nhpsa: hpsa_vmkScsiCmdDone:5238: Sense data: error code: 0x70, key: 0x5, info:00 00 00 00 , cmdInfo:00 00 00 00 , CmdSN: 0xa, worldId: 0x1081b, Cmd: 0x4d, ASC: 0x20, ASCQ: 0x0
2017-11-04T09:13:33.474Z cpu1:68038)nhpsa: hpsa_vmkScsiCmdDone:5238: Sense data: error code: 0x70, key: 0x5, info:00 00 00 00 , cmdInfo:00 00 00 00 , CmdSN: 0xb, worldId: 0x1081b, Cmd: 0x1a, ASC: 0x24, ASCQ: 0x0
2017-11-04T09:13:33.486Z cpu1:68038)nhpsa: hpsa_vmkScsiCmdDone:5238: Sense data: error code: 0x70, key: 0x5, info:00 00 00 00 , cmdInfo:00 00 00 00 , CmdSN: 0xc, worldId: 0x1081b, Cmd: 0x85, ASC: 0x20, ASCQ: 0x0

2017-11-04T09:13:46.587Z cpu11:67749 opID=483d06d9)World: 12230: VC opID vim-cmd-f2-edfe-eed9 maps to vmkernel opID 483d06d9

2017-11-04T09:13:46.587Z cpu11:67749 opID=483d06d9)Config: 706: "SIOControlFlag2" = 1, Old Value: 0, (Status: 0x0)

2017-11-04T09:13:46.758Z cpu2:68392)MemSched: vm 68392: 6366: extended swap to 28160 pgs

2017-11-04T09:13:47.003Z cpu2:68392)World: vm 68393: 7375: Starting world vmm0:Windows_XP of type 8

2017-11-04T09:13:47.004Z cpu2:68392)Sched: vm 68393: 6184: Adding world 'vmm0:Windows_XP', group 'host/user', cpu: shares=-3 min=0 minLimit=-1 max=-1, mem: shares=-3 min=0 minLimit=-1 max=-1

2017-11-04T09:13:47.004Z cpu2:68392)Sched: vm 68393: 6199: renamed group 15326 to vm.68392

2017-11-04T09:13:47.004Z cpu2:68392)Sched: vm 68393: 6216: group 15326 is located under group 4

2017-11-04T09:13:47.134Z cpu2:68392)World: vm 68397: 7375: Starting world vmm1:Windows_XP of type 8

2017-11-04T09:13:47.350Z cpu14:68392)VSCSI: 3787: handle 8193(vscsi0:0):Creating Virtual Device for world 68393 (FSS handle 396663) numBlocks=16777216 (bs=512)

2017-11-04T09:13:47.350Z cpu14:68392)VSCSI: 273: handle 8193(vscsi0:0):Input values: res=0 limit=-1 bw=-1 Shares=-1

2017-11-04T09:13:47.391Z cpu2:68393)VMMVMKCall: 218: Received INIT from world 68393

2017-11-04T09:13:47.392Z cpu2:68393)LSI: 1805: LSI: Initialized rings for scsi0 async=1

2017-11-04T09:13:47.394Z cpu9:68397)VMMVMKCall: 218: Received INIT from world 68397

2017-11-04T09:13:47.397Z cpu15:68401)WARNING: NetDVS: 681: portAlias is NULL

2017-11-04T09:13:47.397Z cpu15:68401)Net: 2524: connected Windows XP eth0 to VM Network, portID 0x2000006

2017-11-04T09:13:47.428Z cpu13:66977)Config: 706: "SIOControlFlag2" = 0, Old Value: 1, (Status: 0x0)

2017-11-04T09:13:48.155Z cpu12:68393)VSCSI: 2611: handle 8193(vscsi0:0):Reset request on FSS handle 396663 (0 outstanding commands) from (vmm0:Windows_XP)

2017-11-04T09:13:48.155Z cpu0:65770)VSCSI: 2891: handle 8193(vscsi0:0):Reset [Retries: 0/0] from (vmm0:Windows_XP)

2017-11-04T09:13:48.155Z cpu0:65770)VSCSI: 2679: handle 8193(vscsi0:0):Completing reset (0 outstanding commands)

2017-11-04T09:13:54.539Z cpu14:68393)VSCSI: 2611: handle 8193(vscsi0:0):Reset request on FSS handle 396663 (0 outstanding commands) from (vmm0:Windows_XP)

0 Kudos
2 Replies
mhampto
VMware Employee
VMware Employee

Not seeing anything stick out in those logs.  In the vmware.log file for the VM's is there any failures in there? Can you post those logs?

0 Kudos
benni0707
Contributor
Contributor

Sorry for the late answer. There are no vmware.log files exist for the autostart, only older logs are available.

0 Kudos