Hi All,
Terraform 1.2.5
terraform-provider-vsphere_v2.2.0_x5
ESXi 6.7
We have two ESXi clusters, Pre-prod and Production.
In Pre-prod, I have managed to get the following Terraform code spinning up vm’s with the NIC’s connecting automatically. In Prod, NIC’s show up as “Disconnected”.
provider "vsphere" {
user = "${var.vsphere_user}"
password = "${var.vsphere_password}"
vsphere_server = "${var.vsphere_server}"
}
data "vsphere_datacenter" "dc" {
name = "${var.datacentre_name}"
}
data "vsphere_network" "network-revenue" {
name = "${var.revenue_name}"
datacenter_id = "${data.vsphere_datacenter.dc.id}"
}
data "vsphere_network" "network-orch" {
name = "xxxxx"
datacenter_id = "${data.vsphere_datacenter.dc.id}"
}
data "vsphere_compute_cluster" "cluster" {
name = "${var.cluster_name}"
datacenter_id = "${data.vsphere_datacenter.dc.id}"
}
data "vsphere_datastore" "datastore" {
name = "${var.datastore_name}"
datacenter_id = "${data.vsphere_datacenter.dc.id}"
}
data "vsphere_virtual_machine" "template" {
name = "RHEL8-updated-template"
datacenter_id = "${data.vsphere_datacenter.dc.id}"
}
resource "vsphere_virtual_machine" "vm" {
name = "${var.host_prefix}-terraform"
folder = "${var.folder_name}"
num_cpus = 1
memory = 3072
firmware = "efi"
guest_id = "${data.vsphere_virtual_machine.template.guest_id}"
scsi_type = "${data.vsphere_virtual_machine.template.scsi_type}"
resource_pool_id = "${data.vsphere_compute_cluster.cluster.resource_pool_id}"
datastore_id = "${data.vsphere_datastore.datastore.id}"
wait_for_guest_net_routable = false
wait_for_guest_net_timeout = 0
network_interface {
network_id = "${data.vsphere_network.network-revenue.id}"
adapter_type = "vmxnet3"
}
network_interface {
network_id = "${data.vsphere_network.network-orch.id}"
adapter_type = "vmxnet3"
}
disk {
label = "disk0"
size = "${data.vsphere_virtual_machine.template.disks.0.size}"
eagerly_scrub = "${data.vsphere_virtual_machine.template.disks.0.eagerly_scrub}"
thin_provisioned = "${data.vsphere_virtual_machine.template.disks.0.thin_provisioned}"
}
clone {
template_uuid = "${data.vsphere_virtual_machine.template.id}"
customize {
linux_options {
host_name = "${var.host_prefix}-terraform"
domain = "${var.domain}"
}
network_interface {
ipv4_address = "${var.revenue_address}"
ipv4_netmask = "${var.revenue_netmask}"
}
network_interface {
ipv4_address = "${var.orch_address}"
ipv4_netmask = "${var.orch_netmask}"
}
ipv4_gateway = "${var.revenue_gateway}"
}
}
}
2022-07-28T15:12:23.151+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:23 [DEBUG] VM “/PDC Datacentre/vm/IS19/pdc-terraform” is powered off, attempting to power on.: timestamp=2022-07-28T15:12:23.151+1200
2022-07-28T15:12:24.155+1200 [TRACE] dag/walk: vertex “root” is waiting for “provider["registry.terraform.io/hashicorp/vsphere"] (close)”
2022-07-28T15:12:24.155+1200 [TRACE] dag/walk: vertex “provider["registry.terraform.io/hashicorp/vsphere"] (close)” is waiting for “vsphere_virtual_machine.vm[0]”
2022-07-28T15:12:24.216+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:24 [DEBUG] PowerOn task for VM “/PDC Datacentre/vm/IS19/pdc-terraform” was successful.: timestamp=2022-07-28T15:12:24.216+1200
2022-07-28T15:12:24.216+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:24 [DEBUG] vsphere_virtual_machine (ID = 4201586a-214e-9328-8b2d-f1a9d4f86a01): Waiting for VM customization to complete: timestamp=2022-07-28T15:12:24.216+1200
2022-07-28T15:12:29.155+1200 [TRACE] dag/walk: vertex “provider["registry.terraform.io/hashicorp/vsphere"] (close)” is waiting for “vsphere_virtual_machine.vm[0]”
2022-07-28T15:12:29.156+1200 [TRACE] dag/walk: vertex “root” is waiting for “provider["registry.terraform.io/hashicorp/vsphere"] (close)”
vsphere_virtual_machine.vm[0]: Still creating… [30s elapsed]
2022-07-28T15:12:34.156+1200 [TRACE] dag/walk: vertex “root” is waiting for “provider["registry.terraform.io/hashicorp/vsphere"] (close)”
2022-07-28T15:12:34.156+1200 [TRACE] dag/walk: vertex “provider["registry.terraform.io/hashicorp/vsphere"] (close)” is waiting for “vsphere_virtual_machine.vm[0]”
2022-07-28T15:12:39.156+1200 [TRACE] dag/walk: vertex “provider["registry.terraform.io/hashicorp/vsphere"] (close)” is waiting for “vsphere_virtual_machine.vm[0]”
2022-07-28T15:12:39.156+1200 [TRACE] dag/walk: vertex “root” is waiting for “provider["registry.terraform.io/hashicorp/vsphere"] (close)”
vsphere_virtual_machine.vm[0]: Still creating… [40s elapsed]
2022-07-28T15:12:44.158+1200 [TRACE] dag/walk: vertex “root” is waiting for “provider["registry.terraform.io/hashicorp/vsphere"] (close)”
2022-07-28T15:12:44.158+1200 [TRACE] dag/walk: vertex “provider["registry.terraform.io/hashicorp/vsphere"] (close)” is waiting for “vsphere_virtual_machine.vm[0]”
2022-07-28T15:12:47.590+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] Fetching properties for VM “/PDC Datacentre/vm/IS19/pdc-terraform”: timestamp=2022-07-28T15:12:47.590+1200
2022-07-28T15:12:47.599+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] Skipping IP waiter for VM “/PDC Datacentre/vm/IS19/pdc-terraform”: timestamp=2022-07-28T15:12:47.599+1200
2022-07-28T15:12:47.599+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] Skipping network waiter for VM “/PDC Datacentre/vm/IS19/pdc-terraform”: timestamp=2022-07-28T15:12:47.599+1200
2022-07-28T15:12:47.599+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] vsphere_virtual_machine (ID = 4201586a-214e-9328-8b2d-f1a9d4f86a01): Create complete: timestamp=2022-07-28T15:12:47.599+1200
2022-07-28T15:12:47.599+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] vsphere_virtual_machine (ID = 4201586a-214e-9328-8b2d-f1a9d4f86a01): Reading state of virtual machine: timestamp=2022-07-28T15:12:47.599+1200
2022-07-28T15:12:47.599+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] Locating virtual machine with UUID “4201586a-214e-9328-8b2d-f1a9d4f86a01”: timestamp=2022-07-28T15:12:47.599+1200
2022-07-28T15:12:47.599+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] Using SearchIndex to look up UUID “4201586a-214e-9328-8b2d-f1a9d4f86a01”: timestamp=2022-07-28T15:12:47.599+1200
2022-07-28T15:12:47.603+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] VM “/PDC Datacentre/vm/IS19/pdc-terraform” found for UUID “4201586a-214e-9328-8b2d-f1a9d4f86a01”: timestamp=2022-07-28T15:12:47.603+1200
2022-07-28T15:12:47.603+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] Fetching properties for VM “/PDC Datacentre/vm/IS19/pdc-terraform”: timestamp=2022-07-28T15:12:47.603+1200
2022-07-28T15:12:47.611+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] MOID for VM “/PDC Datacentre/vm/IS19/pdc-terraform” is “vm-294289”: timestamp=2022-07-28T15:12:47.611+1200
2022-07-28T15:12:47.611+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] Locating vApp container with ID resgroup-147463: timestamp=2022-07-28T15:12:47.611+1200
2022-07-28T15:12:47.615+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] Locating datastore with ID “datastore-151890”: timestamp=2022-07-28T15:12:47.615+1200
2022-07-28T15:12:47.616+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] Datastore with ID “datastore-151890” found: timestamp=2022-07-28T15:12:47.616+1200
2022-07-28T15:12:47.627+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] queryAssociatedProfile: Retrieving storage policy of server object of type [virtualMachine] and key [vm-294289].: timestamp=2022-07-28T15:12:47.627+1200
2022-07-28T15:12:47.633+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] ReadSCSIBusType: SCSI controller layout for first 1 controllers: pvscsi-1000: timestamp=2022-07-28T15:12:47.633+1200
2022-07-28T15:12:47.633+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] ReadSCSIBusSharing: SCSI controller layout for first 1 controllers: pvscsi-1000: timestamp=2022-07-28T15:12:47.633+1200
2022-07-28T15:12:47.633+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] DiskRefreshOperation: Beginning refresh: timestamp=2022-07-28T15:12:47.633+1200
2022-07-28T15:12:47.633+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] DiskRefreshOperation: Found controller “controller-1000” for device “disk-1000-0”: timestamp=2022-07-28T15:12:47.633+1200
2022-07-28T15:12:47.633+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] DiskRefreshOperation: Disk devices located: disk-1000-0: timestamp=2022-07-28T15:12:47.633+1200
2022-07-28T15:12:47.633+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] DiskRefreshOperation: Current resource set from state: (key 2000 at scsi:0:0): timestamp=2022-07-28T15:12:47.633+1200
2022-07-28T15:12:47.633+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] DiskRefreshOperation: Looking for freshly-created or re-assigned resources to read in: timestamp=2022-07-28T15:12:47.633+1200
2022-07-28T15:12:47.633+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] DiskRefreshOperation: Disk devices after created/re-assigned device search: disk-1000-0: timestamp=2022-07-28T15:12:47.633+1200
2022-07-28T15:12:47.633+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] DiskRefreshOperation: Resource set to write after created/re-assigned device search:: timestamp=2022-07-28T15:12:47.633+1200
2022-07-28T15:12:47.633+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] DiskRefreshOperation: Looking for devices known in state: timestamp=2022-07-28T15:12:47.633+1200
2022-07-28T15:12:47.633+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] disk.0 (key 2000 at scsi:0:0) (7ffee162-1c8e-8c29-d232-ac1f6bc235b8/pdc-terraform_2.vmdk): Reading state: timestamp=2022-07-28T15:12:47.633+1200
2022-07-28T15:12:47.633+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] Locating virtual machine with UUID “4201586a-214e-9328-8b2d-f1a9d4f86a01”: timestamp=2022-07-28T15:12:47.633+1200
2022-07-28T15:12:47.633+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] Using SearchIndex to look up UUID “4201586a-214e-9328-8b2d-f1a9d4f86a01”: timestamp=2022-07-28T15:12:47.633+1200
2022-07-28T15:12:47.637+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] VM “/PDC Datacentre/vm/IS19/pdc-terraform” found for UUID “4201586a-214e-9328-8b2d-f1a9d4f86a01”: timestamp=2022-07-28T15:12:47.637+1200
2022-07-28T15:12:47.643+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] queryAssociatedProfile: Retrieving storage policy of server object of type [virtualDiskId] and key [vm-294289:2000].: timestamp=2022-07-28T15:12:47.643+1200
2022-07-28T15:12:47.651+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] disk.0 (key 2000 at scsi:0:0) (7ffee162-1c8e-8c29-d232-ac1f6bc235b8/pdc-terraform_2.vmdk): Read finished (key and device address may have changed): timestamp=2022-07-28T15:12:47.651+1200
2022-07-28T15:12:47.651+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] DiskRefreshOperation: Resource set to write after known device search: (key 2000 at scsi:0:0): timestamp=2022-07-28T15:12:47.651+1200
2022-07-28T15:12:47.651+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] DiskRefreshOperation: Probable orphaned disk devices:: timestamp=2022-07-28T15:12:47.651+1200
2022-07-28T15:12:47.651+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] DiskRefreshOperation: Adding orphaned devices: timestamp=2022-07-28T15:12:47.651+1200
2022-07-28T15:12:47.651+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] DiskRefreshOperation: Resource set to write after adding orphaned devices: (key 2000 at scsi:0:0): timestamp=2022-07-28T15:12:47.651+1200
2022-07-28T15:12:47.651+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] DiskRefreshOperation: Final (sorted) resource set to write: (key 2000 at scsi:0:0): timestamp=2022-07-28T15:12:47.651+1200
2022-07-28T15:12:47.651+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] DiskRefreshOperation: Refresh operation complete, sending new resource set: timestamp=2022-07-28T15:12:47.651+1200
2022-07-28T15:12:47.651+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] NetworkInterfaceRefreshOperation: Beginning refresh: timestamp=2022-07-28T15:12:47.651+1200
2022-07-28T15:12:47.651+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] NetworkInterfaceRefreshOperation: Network devices located: ethernet-0,ethernet-1: timestamp=2022-07-28T15:12:47.651+1200
2022-07-28T15:12:47.651+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] NetworkInterfaceRefreshOperation: Current resource set from state: (key 4000 at pci:0:7),(key 4001 at pci:0:8): timestamp=2022-07-28T15:12:47.651+1200
2022-07-28T15:12:47.651+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] NetworkInterfaceRefreshOperation: 2 devices over a 2 unit range: timestamp=2022-07-28T15:12:47.651+1200
2022-07-28T15:12:47.651+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] NetworkInterfaceRefreshOperation: Looking for freshly-created resources to read in: timestamp=2022-07-28T15:12:47.651+1200
2022-07-28T15:12:47.651+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] NetworkInterfaceRefreshOperation: Network devices after freshly-created device search: ethernet-0,ethernet-1: timestamp=2022-07-28T15:12:47.651+1200
2022-07-28T15:12:47.651+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] NetworkInterfaceRefreshOperation: Resource set to write after freshly-created device search: (),(): timestamp=2022-07-28T15:12:47.651+1200
2022-07-28T15:12:47.651+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] NetworkInterfaceRefreshOperation: Looking for devices known in state: timestamp=2022-07-28T15:12:47.651+1200
2022-07-28T15:12:47.651+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] network_interface.0 (key 4000 at pci:0:7): Reading state: timestamp=2022-07-28T15:12:47.651+1200
2022-07-28T15:12:47.651+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] FindVirtualDevice: Looking for device with key 4000: timestamp=2022-07-28T15:12:47.651+1200
2022-07-28T15:12:47.651+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] FindVirtualDevice: Device found: ethernet-0: timestamp=2022-07-28T15:12:47.651+1200
2022-07-28T15:12:47.654+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] network_interface.0 (key 4000 at pci:0:7): Read finished (key and device address may have changed): timestamp=2022-07-28T15:12:47.654+1200
2022-07-28T15:12:47.654+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] network_interface.1 (key 4001 at pci:0:8): Reading state: timestamp=2022-07-28T15:12:47.654+1200
2022-07-28T15:12:47.654+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] FindVirtualDevice: Looking for device with key 4001: timestamp=2022-07-28T15:12:47.654+1200
2022-07-28T15:12:47.654+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] FindVirtualDevice: Device found: ethernet-1: timestamp=2022-07-28T15:12:47.654+1200
2022-07-28T15:12:47.657+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] network_interface.1 (key 4001 at pci:0:8): Read finished (key and device address may have changed): timestamp=2022-07-28T15:12:47.657+1200
2022-07-28T15:12:47.657+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] NetworkInterfaceRefreshOperation: Resource set to write after known device search: (key 4000 at pci:0:7),(key 4001 at pci:0:8): timestamp=2022-07-28T15:12:47.657+1200
2022-07-28T15:12:47.658+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] NetworkInterfaceRefreshOperation: Probable orphaned network interfaces:: timestamp=2022-07-28T15:12:47.657+1200
2022-07-28T15:12:47.658+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] NetworkInterfaceRefreshOperation: Adding orphaned devices: timestamp=2022-07-28T15:12:47.657+1200
2022-07-28T15:12:47.658+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] NetworkInterfaceRefreshOperation: Resource set to write after adding orphaned devices: (key 4000 at pci:0:7),(key 4001 at pci:0:8): timestamp=2022-07-28T15:12:47.657+1200
2022-07-28T15:12:47.658+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] NetworkInterfaceRefreshOperation: Refresh operation complete, sending new resource set: timestamp=2022-07-28T15:12:47.657+1200
2022-07-28T15:12:47.658+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] CdromRefreshOperation: Beginning refresh: timestamp=2022-07-28T15:12:47.658+1200
2022-07-28T15:12:47.658+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] CdromRefreshOperation: CDROM devices located:: timestamp=2022-07-28T15:12:47.658+1200
2022-07-28T15:12:47.658+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] CdromRefreshOperation: Current resource set from state:: timestamp=2022-07-28T15:12:47.658+1200
2022-07-28T15:12:47.658+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] CdromRefreshOperation: Looking for freshly-created resources to read in: timestamp=2022-07-28T15:12:47.658+1200
2022-07-28T15:12:47.658+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] CdromRefreshOperation: CDROM devices after freshly-created device search:: timestamp=2022-07-28T15:12:47.658+1200
2022-07-28T15:12:47.658+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] CdromRefreshOperation: Resource set to write after freshly-created device search:: timestamp=2022-07-28T15:12:47.658+1200
2022-07-28T15:12:47.658+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] CdromRefreshOperation: Looking for devices known in state: timestamp=2022-07-28T15:12:47.658+1200
2022-07-28T15:12:47.658+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] CdromRefreshOperation: Resource set to write after known device search:: timestamp=2022-07-28T15:12:47.658+1200
2022-07-28T15:12:47.658+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] CdromRefreshOperation: Probable orphaned CDROM devices:: timestamp=2022-07-28T15:12:47.658+1200
2022-07-28T15:12:47.658+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] CdromRefreshOperation: Resource set to write after adding orphaned devices:: timestamp=2022-07-28T15:12:47.658+1200
2022-07-28T15:12:47.658+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] CdromRefreshOperation: Refresh operation complete, sending new resource set: timestamp=2022-07-28T15:12:47.658+1200
2022-07-28T15:12:47.658+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] Reading tags for object “vm-294289”: timestamp=2022-07-28T15:12:47.658+1200
2022-07-28T15:12:47.766+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] Tags for object “vm-294289”:: timestamp=2022-07-28T15:12:47.766+1200
2022-07-28T15:12:47.766+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] vsphere_virtual_machine (ID = 4201586a-214e-9328-8b2d-f1a9d4f86a01): Checking guest networking state: timestamp=2022-07-28T15:12:47.766+1200
2022-07-28T15:12:47.766+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] vsphere_virtual_machine (ID = 4201586a-214e-9328-8b2d-f1a9d4f86a01): No IP addresses found in guest state: timestamp=2022-07-28T15:12:47.766+1200
2022-07-28T15:12:47.766+1200 [INFO] provider.terraform-provider-vsphere_v2.2.0_x5: 2022/07/28 15:12:47 [DEBUG] vsphere_virtual_machine (ID = 4201586a-214e-9328-8b2d-f1a9d4f86a01): Read complete: timestamp=2022-07-28T15:12:47.766+1200
2022-07-28T15:12:47.766+1200 [TRACE] provider.terraform-provider-vsphere_v2.2.0_x5: Called downstream: tf_resource_type=vsphere_virtual_machine @module=sdk.helper_schema tf_req_id=8f01a35d-c1b2-af7a-a9be-7f297044d6ab tf_rpc=ApplyResourceChange @caller=github.com/hashicorp/terraform-plugin-sdk/v2@v2.17.0/helper/schema/resource.go:838 tf_provider_addr=provider timestamp=2022-07-28T15:12:47.766+1200
2022-07-28T15:12:47.768+1200 [TRACE] provider.terraform-provider-vsphere_v2.2.0_x5: Called downstream: @caller=github.com/hashicorp/terraform-plugin-go@v0.9.1/tfprotov5/tf5server/server.go:817 @module=sdk.proto tf_proto_version=5.2 tf_provider_addr=provider tf_req_id=8f01a35d-c1b2-af7a-a9be-7f297044d6ab tf_resource_type=vsphere_virtual_machine tf_rpc=ApplyResourceChange timestamp=2022-07-28T15:12:47.768+1200
2022-07-28T15:12:47.768+1200 [TRACE] provider.terraform-provider-vsphere_v2.2.0_x5: Served request: tf_proto_version=5.2 tf_provider_addr=provider tf_req_id=8f01a35d-c1b2-af7a-a9be-7f297044d6ab tf_rpc=ApplyResourceChange @caller=github.com/hashicorp/terraform-plugin-go@v0.9.1/tfprotov5/tf5server/server.go:824 tf_resource_type=vsphere_virtual_machine @module=sdk.proto timestamp=2022-07-28T15:12:47.768+1200
2022-07-28T15:12:47.769+1200 [WARN] Provider “provider["registry.terraform.io/hashicorp/vsphere"]” produced an unexpected new value for vsphere_virtual_machine.vm[0], but we are tolerating it because it is using the legacy plugin SDK.
The following problems may be the cause of any confusing errors from downstream operations:
- .memory_hot_add_enabled: was null, but now cty.False
- .sync_time_with_host: was null, but now cty.False
- .boot_delay: was null, but now cty.NumberIntVal(0)
- .cpu_hot_remove_enabled: was null, but now cty.False
- .cpu_performance_counters_enabled: was null, but now cty.False
- .cpu_reservation: was null, but now cty.NumberIntVal(0)
- .vvtd_enabled: was null, but now cty.False
- .alternate_guest_name: was null, but now cty.StringVal(“”)
- .sync_time_with_host_periodically: was null, but now cty.False
- .run_tools_scripts_before_guest_reboot: was null, but now cty.False
- .nested_hv_enabled: was null, but now cty.False
- .memory_reservation: was null, but now cty.NumberIntVal(0)
- .vbs_enabled: was null, but now cty.False
- .enable_logging: was null, but now cty.False
- .cpu_hot_add_enabled: was null, but now cty.False
- .enable_disk_uuid: was null, but now cty.False
- .boot_retry_enabled: was null, but now cty.False
- .efi_secure_boot_enabled: was null, but now cty.False
- .clone[0].linked_clone: was null, but now cty.False
- .clone[0].customize[0].ipv6_gateway: was null, but now cty.StringVal(“”)
- .clone[0].customize[0].windows_sysprep_text: inconsistent values for sensitive attribute
- .clone[0].customize[0].linux_options[0].script_text: inconsistent values for sensitive attribute
- .clone[0].customize[0].linux_options[0].time_zone: was null, but now cty.StringVal(“”)
- .clone[0].customize[0].network_interface[0].ipv6_address: was null, but now cty.StringVal(“”)
- .clone[0].customize[0].network_interface[0].ipv6_netmask: was null, but now cty.NumberIntVal(0)
- .clone[0].customize[0].network_interface[0].dns_domain: was null, but now cty.StringVal(“”)
- .clone[0].customize[0].network_interface[1].ipv6_address: was null, but now cty.StringVal(“”)
- .clone[0].customize[0].network_interface[1].ipv6_netmask: was null, but now cty.NumberIntVal(0)
- .clone[0].customize[0].network_interface[1].dns_domain: was null, but now cty.StringVal(“”)
- .disk[0].key: was cty.NumberIntVal(0), but now cty.NumberIntVal(2000)
- .disk[0].io_share_count: was cty.NumberIntVal(0), but now cty.NumberIntVal(1000)
- .disk[0].datastore_id: was cty.StringVal(“”), but now cty.StringVal(“datastore-151890”)
- .network_interface[0].use_static_mac: was null, but now cty.False
- .network_interface[0].ovf_mapping: was null, but now cty.StringVal(“”)
- .network_interface[1].ovf_mapping: was null, but now cty.StringVal(“”)
- .network_interface[1].use_static_mac: was null, but now cty.False
2022-07-28T15:12:47.769+1200 [TRACE] NodeAbstractResouceInstance.writeResourceInstanceState to workingState for vsphere_virtual_machine.vm[0]
2022-07-28T15:12:47.769+1200 [TRACE] NodeAbstractResouceInstance.writeResourceInstanceState: writing state object for vsphere_virtual_machine.vm[0]
2022-07-28T15:12:47.771+1200 [TRACE] NodeAbstractResouceInstance.writeResourceInstanceState to workingState for vsphere_virtual_machine.vm[0]
2022-07-28T15:12:47.771+1200 [TRACE] NodeAbstractResouceInstance.writeResourceInstanceState: writing state object for vsphere_virtual_machine.vm[0]
vsphere_virtual_machine.vm[0]: Creation complete after 48s [id=4201586a-214e-9328-8b2d-f1a9d4f86a01]
2022-07-28T15:12:47.772+1200 [TRACE] statemgr.Filesystem: creating backup snapshot at terraform.tfstate.backup
2022-07-28T15:12:47.772+1200 [TRACE] statemgr.Filesystem: state has changed since last snapshot, so incrementing serial to 45
2022-07-28T15:12:47.772+1200 [TRACE] statemgr.Filesystem: writing snapshot at terraform.tfstate
2022-07-28T15:12:47.774+1200 [TRACE] vertex “vsphere_virtual_machine.vm[0]”: visit complete
2022-07-28T15:12:47.774+1200 [TRACE] vertex “provider["registry.terraform.io/hashicorp/vsphere"] (close)”: starting visit (*terraform.graphNodeCloseProvider)
2022-07-28T15:12:47.774+1200 [TRACE] GRPCProvider: Close
2022-07-28T15:12:47.775+1200 [DEBUG] provider.stdio: received EOF, stopping recv loop: err=“rpc error: code = Unavailable desc = transport is closing”
2022-07-28T15:12:47.777+1200 [DEBUG] provider: plugin process exited: path=.terraform/providers/registry.terraform.io/hashicorp/vsphere/2.2.0/linux_amd64/terraform-provider-vsphere_v2.2.0_x5 pid=33949
2022-07-28T15:12:47.777+1200 [DEBUG] provider: plugin exited
2022-07-28T15:12:47.777+1200 [TRACE] vertex “provider["registry.terraform.io/hashicorp/vsphere"] (close)”: visit complete
2022-07-28T15:12:47.777+1200 [TRACE] vertex “root”: starting visit (*terraform.nodeCloseModule)
2022-07-28T15:12:47.777+1200 [TRACE] vertex “root”: visit complete
2022-07-28T15:12:47.777+1200 [TRACE] statemgr.Filesystem: have already backed up original terraform.tfstate to terraform.tfstate.backup on a previous write
2022-07-28T15:12:47.778+1200 [TRACE] statemgr.Filesystem: state has changed since last snapshot, so incrementing serial to 46
2022-07-28T15:12:47.778+1200 [TRACE] statemgr.Filesystem: writing snapshot at terraform.tfstate
2022-07-28T15:12:47.779+1200 [TRACE] statemgr.Filesystem: removing lock metadata file .terraform.tfstate.lock.info
2022-07-28T15:12:47.779+1200 [TRACE] statemgr.Filesystem: unlocking terraform.tfstate using fcntl flockApply complete! Resources: 1 added, 0 changed, 0 destroyed.