vSphere TF provider debug log

gistfile1.txt

2022-08-05T19:26:04.742Z [INFO]  Terraform version: 1.2.6
2022-08-05T19:26:04.742Z [DEBUG] using github.com/hashicorp/go-tfe v1.0.0
2022-08-05T19:26:04.742Z [DEBUG] using github.com/hashicorp/hcl/v2 v2.12.0
2022-08-05T19:26:04.742Z [DEBUG] using github.com/hashicorp/terraform-config-inspect v0.0.0-20210209133302-4fd17a0faac2
2022-08-05T19:26:04.742Z [DEBUG] using github.com/hashicorp/terraform-svchost v0.0.0-20200729002733-f050f53b9734
2022-08-05T19:26:04.742Z [DEBUG] using github.com/zclconf/go-cty v1.10.0
2022-08-05T19:26:04.742Z [INFO]  Go runtime version: go1.18.1
2022-08-05T19:26:04.742Z [INFO]  CLI args: []string{"terraform", "apply", "--auto-approve"}
2022-08-05T19:26:04.742Z [DEBUG] Attempting to open CLI config file: /home/vncuser/.terraformrc
2022-08-05T19:26:04.742Z [DEBUG] File doesn't exist, but doesn't need to. Ignoring.
2022-08-05T19:26:04.743Z [DEBUG] ignoring non-existing provider search directory terraform.d/plugins
2022-08-05T19:26:04.743Z [DEBUG] ignoring non-existing provider search directory /home/vncuser/.terraform.d/plugins
2022-08-05T19:26:04.743Z [DEBUG] ignoring non-existing provider search directory /home/vncuser/.local/share/terraform/plugins
2022-08-05T19:26:04.743Z [DEBUG] ignoring non-existing provider search directory /home/vncuser/.local/share/flatpak/exports/share/terraform/plugins
2022-08-05T19:26:04.743Z [DEBUG] ignoring non-existing provider search directory /var/lib/flatpak/exports/share/terraform/plugins
2022-08-05T19:26:04.743Z [DEBUG] ignoring non-existing provider search directory /usr/local/share/terraform/plugins
2022-08-05T19:26:04.743Z [DEBUG] ignoring non-existing provider search directory /usr/share/terraform/plugins
2022-08-05T19:26:04.743Z [INFO]  CLI command args: []string{"apply", "--auto-approve"}
2022-08-05T19:26:04.745Z [DEBUG] New state was assigned lineage "8a638210-77a5-75be-3710-fe053a517629"
2022-08-05T19:26:04.817Z [DEBUG] checking for provisioner in "."
2022-08-05T19:26:04.820Z [DEBUG] checking for provisioner in "/usr/bin"
2022-08-05T19:26:04.820Z [INFO]  backend/local: starting Apply operation
2022-08-05T19:26:04.822Z [DEBUG] created provider logger: level=debug
2022-08-05T19:26:04.822Z [INFO]  provider: configuring client automatic mTLS
2022-08-05T19:26:04.840Z [DEBUG] provider: starting plugin: path=.terraform/providers/registry.terraform.io/hashicorp/vsphere/2.2.0/linux_amd64/terraform-provider-vsphere_v2.2.0_x5 args=[.terraform/providers/registry.terraform.io/hashicorp/vsphere/2.2.0/linux_amd64/terraform-provider-vsphere_v2.2.0_x5]
2022-08-05T19:26:04.840Z [DEBUG] provider: plugin started: path=.terraform/providers/registry.terraform.io/hashicorp/vsphere/2.2.0/linux_amd64/terraform-provider-vsphere_v2.2.0_x5 pid=99018
2022-08-05T19:26:04.840Z [DEBUG] provider: waiting for RPC address: path=.terraform/providers/registry.terraform.io/hashicorp/vsphere/2.2.0/linux_amd64/terraform-provider-vsphere_v2.2.0_x5
2022-08-05T19:26:04.848Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: configuring server automatic mTLS: timestamp=2022-08-05T19:26:04.848Z
2022-08-05T19:26:04.868Z [DEBUG] provider: using plugin: version=5
2022-08-05T19:26:04.868Z [DEBUG] provider.terraform-provider-vsphere_v2.2.0_x5: plugin address: address=/tmp/plugin261295072 network=unix timestamp=2022-08-05T19:26:04.868Z
2022-08-05T19:26:04.910Z [DEBUG] provider.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = transport is closing"
2022-08-05T19:26:04.911Z [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=99018
2022-08-05T19:26:04.911Z [DEBUG] provider: plugin exited
2022-08-05T19:26:04.911Z [DEBUG] Building and walking validate graph
2022-08-05T19:26:04.912Z [DEBUG] ProviderTransformer: "data.vsphere_network.vmw-apic-gw-frontend-subnet" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:04.912Z [DEBUG] ProviderTransformer: "data.vsphere_network.vmw-apic-subsys-subnet" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:04.912Z [DEBUG] ProviderTransformer: "data.vsphere_folder.folder" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:04.912Z [DEBUG] ProviderTransformer: "vsphere_virtual_machine.management-vm" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:04.912Z [DEBUG] ProviderTransformer: "data.vsphere_ovf_vm_template.management-ova" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:04.912Z [DEBUG] ProviderTransformer: "vsphere_file.management-iso" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:04.912Z [DEBUG] ProviderTransformer: "data.vsphere_compute_cluster.cluster" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:04.912Z [DEBUG] ProviderTransformer: "data.vsphere_resource_pool.default" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:04.912Z [DEBUG] ProviderTransformer: "data.vsphere_network.vmw-apic-gw-backend-subnet" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:04.912Z [DEBUG] ProviderTransformer: "data.vsphere_datacenter.datacenter" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:04.912Z [DEBUG] ProviderTransformer: "data.vsphere_datastore.datastore" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:04.912Z [DEBUG] ProviderTransformer: "data.vsphere_host.esxi-host" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "vsphere_virtual_machine.management-vm" references: [data.vsphere_datacenter.datacenter data.vsphere_host.esxi-host data.vsphere_resource_pool.default data.vsphere_ovf_vm_template.management-ova data.vsphere_folder.folder data.vsphere_datastore.datastore data.vsphere_ovf_vm_template.management-ova data.vsphere_ovf_vm_template.management-ova data.vsphere_ovf_vm_template.management-ova data.vsphere_ovf_vm_template.management-ova data.vsphere_ovf_vm_template.management-ova vsphere_file.management-iso data.vsphere_datastore.datastore]
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "data.vsphere_network.vmw-apic-gw-backend-subnet" references: [data.vsphere_datacenter.datacenter var.vmw-apic-gw-backend-subnet-name]
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "var.vmw-apic-subsys-subnet-name" references: []
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "data.vsphere_network.vmw-apic-gw-frontend-subnet" references: [var.vmw-apic-gw-frontend-subnet-name data.vsphere_datacenter.datacenter]
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "data.vsphere_resource_pool.default" references: [data.vsphere_datacenter.datacenter data.vsphere_compute_cluster.cluster]
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "data.vsphere_ovf_vm_template.management-ova" references: [data.vsphere_host.esxi-host var.apic-management-ova-path data.vsphere_network.vmw-apic-subsys-subnet data.vsphere_resource_pool.default data.vsphere_datastore.datastore]
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "data.vsphere_datacenter.datacenter" references: []
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "data.vsphere_datastore.datastore" references: [data.vsphere_datacenter.datacenter]
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "vsphere_file.management-iso" references: [var.apic-management-iso-path data.vsphere_datacenter.datacenter data.vsphere_datastore.datastore]
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "data.vsphere_host.esxi-host" references: [data.vsphere_datacenter.datacenter]
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "data.vsphere_compute_cluster.cluster" references: [data.vsphere_datacenter.datacenter]
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "var.vsphere_server" references: []
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "var.vmw-apic-gw-frontend-subnet-name" references: []
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "data.vsphere_network.vmw-apic-subsys-subnet" references: [var.vmw-apic-subsys-subnet-name data.vsphere_datacenter.datacenter]
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "var.apic-management-iso-path" references: []
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "var.vsphere_user" references: []
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "var.vmw-apic-gw-backend-subnet-name" references: []
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/vsphere\"]" references: [var.vsphere_server var.vsphere_password var.vsphere_user]
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "data.vsphere_folder.folder" references: [data.vsphere_datacenter.datacenter]
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "var.apic-management-ova-path" references: []
2022-08-05T19:26:04.913Z [DEBUG] ReferenceTransformer: "var.vsphere_password" references: []
2022-08-05T19:26:04.915Z [DEBUG] Starting graph walk: walkValidate
2022-08-05T19:26:04.915Z [DEBUG] created provider logger: level=debug
2022-08-05T19:26:04.915Z [INFO]  provider: configuring client automatic mTLS
2022-08-05T19:26:04.932Z [DEBUG] provider: starting plugin: path=.terraform/providers/registry.terraform.io/hashicorp/vsphere/2.2.0/linux_amd64/terraform-provider-vsphere_v2.2.0_x5 args=[.terraform/providers/registry.terraform.io/hashicorp/vsphere/2.2.0/linux_amd64/terraform-provider-vsphere_v2.2.0_x5]
2022-08-05T19:26:04.933Z [DEBUG] provider: plugin started: path=.terraform/providers/registry.terraform.io/hashicorp/vsphere/2.2.0/linux_amd64/terraform-provider-vsphere_v2.2.0_x5 pid=99025
2022-08-05T19:26:04.933Z [DEBUG] provider: waiting for RPC address: path=.terraform/providers/registry.terraform.io/hashicorp/vsphere/2.2.0/linux_amd64/terraform-provider-vsphere_v2.2.0_x5
2022-08-05T19:26:04.940Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: configuring server automatic mTLS: timestamp=2022-08-05T19:26:04.940Z
2022-08-05T19:26:04.960Z [DEBUG] provider: using plugin: version=5
2022-08-05T19:26:04.960Z [DEBUG] provider.terraform-provider-vsphere_v2.2.0_x5: plugin address: network=unix address=/tmp/plugin202573619 timestamp=2022-08-05T19:26:04.960Z
2022-08-05T19:26:05.013Z [DEBUG] provider.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = transport is closing"
2022-08-05T19:26:05.014Z [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=99025
2022-08-05T19:26:05.014Z [DEBUG] provider: plugin exited
2022-08-05T19:26:05.014Z [INFO]  backend/local: apply calling Plan
2022-08-05T19:26:05.014Z [DEBUG] Building and walking plan graph for NormalMode
2022-08-05T19:26:05.015Z [DEBUG] ProviderTransformer: "data.vsphere_datastore.datastore (expand)" (*terraform.nodeExpandPlannableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.015Z [DEBUG] ProviderTransformer: "data.vsphere_network.vmw-apic-gw-backend-subnet (expand)" (*terraform.nodeExpandPlannableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.015Z [DEBUG] ProviderTransformer: "data.vsphere_ovf_vm_template.management-ova (expand)" (*terraform.nodeExpandPlannableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.015Z [DEBUG] ProviderTransformer: "data.vsphere_network.vmw-apic-gw-frontend-subnet (expand)" (*terraform.nodeExpandPlannableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.015Z [DEBUG] ProviderTransformer: "data.vsphere_compute_cluster.cluster (expand)" (*terraform.nodeExpandPlannableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.015Z [DEBUG] ProviderTransformer: "data.vsphere_folder.folder (expand)" (*terraform.nodeExpandPlannableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.015Z [DEBUG] ProviderTransformer: "vsphere_virtual_machine.management-vm (expand)" (*terraform.nodeExpandPlannableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.015Z [DEBUG] ProviderTransformer: "data.vsphere_datacenter.datacenter (expand)" (*terraform.nodeExpandPlannableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.015Z [DEBUG] ProviderTransformer: "vsphere_file.management-iso (expand)" (*terraform.nodeExpandPlannableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.015Z [DEBUG] ProviderTransformer: "data.vsphere_host.esxi-host (expand)" (*terraform.nodeExpandPlannableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.015Z [DEBUG] ProviderTransformer: "data.vsphere_network.vmw-apic-subsys-subnet (expand)" (*terraform.nodeExpandPlannableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.015Z [DEBUG] ProviderTransformer: "data.vsphere_resource_pool.default (expand)" (*terraform.nodeExpandPlannableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "var.vmw-apic-gw-backend-subnet-name" references: []
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "var.apic-management-iso-path" references: []
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/vsphere\"]" references: [var.vsphere_server var.vsphere_password var.vsphere_user]
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "var.vsphere_password" references: []
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "var.vsphere_server" references: []
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "var.vmw-apic-gw-frontend-subnet-name" references: []
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "data.vsphere_compute_cluster.cluster (expand)" references: [data.vsphere_datacenter.datacenter (expand)]
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "data.vsphere_folder.folder (expand)" references: [data.vsphere_datacenter.datacenter (expand)]
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "data.vsphere_network.vmw-apic-subsys-subnet (expand)" references: [data.vsphere_datacenter.datacenter (expand) var.vmw-apic-subsys-subnet-name]
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "var.vmw-apic-subsys-subnet-name" references: []
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "vsphere_file.management-iso (expand)" references: [data.vsphere_datastore.datastore (expand) var.apic-management-iso-path data.vsphere_datacenter.datacenter (expand)]
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "data.vsphere_network.vmw-apic-gw-frontend-subnet (expand)" references: [var.vmw-apic-gw-frontend-subnet-name data.vsphere_datacenter.datacenter (expand)]
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "data.vsphere_host.esxi-host (expand)" references: [data.vsphere_datacenter.datacenter (expand)]
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "vsphere_virtual_machine.management-vm (expand)" references: [data.vsphere_ovf_vm_template.management-ova (expand) data.vsphere_datacenter.datacenter (expand) data.vsphere_folder.folder (expand) data.vsphere_ovf_vm_template.management-ova (expand) data.vsphere_datastore.datastore (expand) data.vsphere_host.esxi-host (expand) data.vsphere_resource_pool.default (expand) data.vsphere_ovf_vm_template.management-ova (expand) data.vsphere_ovf_vm_template.management-ova (expand) data.vsphere_ovf_vm_template.management-ova (expand) data.vsphere_ovf_vm_template.management-ova (expand) data.vsphere_datastore.datastore (expand) vsphere_file.management-iso (expand)]
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "data.vsphere_datacenter.datacenter (expand)" references: []
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "data.vsphere_resource_pool.default (expand)" references: [data.vsphere_compute_cluster.cluster (expand) data.vsphere_datacenter.datacenter (expand)]
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "var.apic-management-ova-path" references: []
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "var.vsphere_user" references: []
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "data.vsphere_datastore.datastore (expand)" references: [data.vsphere_datacenter.datacenter (expand)]
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "data.vsphere_network.vmw-apic-gw-backend-subnet (expand)" references: [var.vmw-apic-gw-backend-subnet-name data.vsphere_datacenter.datacenter (expand)]
2022-08-05T19:26:05.016Z [DEBUG] ReferenceTransformer: "data.vsphere_ovf_vm_template.management-ova (expand)" references: [data.vsphere_resource_pool.default (expand) data.vsphere_datastore.datastore (expand) var.apic-management-ova-path data.vsphere_network.vmw-apic-subsys-subnet (expand) data.vsphere_host.esxi-host (expand)]
2022-08-05T19:26:05.018Z [DEBUG] Starting graph walk: walkPlan
2022-08-05T19:26:05.018Z [DEBUG] created provider logger: level=debug
2022-08-05T19:26:05.019Z [INFO]  provider: configuring client automatic mTLS
2022-08-05T19:26:05.036Z [DEBUG] provider: starting plugin: path=.terraform/providers/registry.terraform.io/hashicorp/vsphere/2.2.0/linux_amd64/terraform-provider-vsphere_v2.2.0_x5 args=[.terraform/providers/registry.terraform.io/hashicorp/vsphere/2.2.0/linux_amd64/terraform-provider-vsphere_v2.2.0_x5]
2022-08-05T19:26:05.036Z [DEBUG] provider: plugin started: path=.terraform/providers/registry.terraform.io/hashicorp/vsphere/2.2.0/linux_amd64/terraform-provider-vsphere_v2.2.0_x5 pid=99032
2022-08-05T19:26:05.036Z [DEBUG] provider: waiting for RPC address: path=.terraform/providers/registry.terraform.io/hashicorp/vsphere/2.2.0/linux_amd64/terraform-provider-vsphere_v2.2.0_x5
2022-08-05T19:26:05.044Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: configuring server automatic mTLS: timestamp=2022-08-05T19:26:05.044Z
2022-08-05T19:26:05.064Z [DEBUG] provider: using plugin: version=5
2022-08-05T19:26:05.064Z [DEBUG] provider.terraform-provider-vsphere_v2.2.0_x5: plugin address: address=/tmp/plugin3237982277 network=unix timestamp=2022-08-05T19:26:05.064Z
2022-08-05T19:26:05.108Z [WARN]  ValidateProviderConfig from "provider[\"registry.terraform.io/hashicorp/vsphere\"]" changed the config value, but that value is unused
2022-08-05T19:26:05.109Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] Cached SOAP client session data not valid or persistence not enabled, new session necessary: timestamp=2022-08-05T19:26:05.109Z
2022-08-05T19:26:05.109Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] Creating new SOAP API session on endpoint vcenter.vmware.ibmcloud.local:443: timestamp=2022-08-05T19:26:05.109Z
2022-08-05T19:26:05.169Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] SOAP API session creation successful: timestamp=2022-08-05T19:26:05.169Z
2022-08-05T19:26:05.169Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] VMWare vSphere Client configured for URL: vcenter.vmware.ibmcloud.local:443: timestamp=2022-08-05T19:26:05.169Z
2022-08-05T19:26:05.169Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] Setting up REST client: timestamp=2022-08-05T19:26:05.169Z
2022-08-05T19:26:05.439Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] CIS REST client configuration successful: timestamp=2022-08-05T19:26:05.439Z
2022-08-05T19:26:05.449Z [DEBUG] ReferenceTransformer: "data.vsphere_datacenter.datacenter" references: []
2022-08-05T19:26:05.456Z [DEBUG] ReferenceTransformer: "data.vsphere_datastore.datastore" references: []
2022-08-05T19:26:05.456Z [DEBUG] ReferenceTransformer: "data.vsphere_host.esxi-host" references: []
2022-08-05T19:26:05.457Z [INFO]  ReferenceTransformer: reference not found: "var.vmw-apic-gw-frontend-subnet-name"
2022-08-05T19:26:05.457Z [DEBUG] ReferenceTransformer: "data.vsphere_network.vmw-apic-gw-frontend-subnet" references: []
2022-08-05T19:26:05.457Z [INFO]  ReferenceTransformer: reference not found: "var.vmw-apic-subsys-subnet-name"
2022-08-05T19:26:05.457Z [DEBUG] ReferenceTransformer: "data.vsphere_network.vmw-apic-subsys-subnet" references: []
2022-08-05T19:26:05.457Z [DEBUG] ReferenceTransformer: "data.vsphere_folder.folder" references: []
2022-08-05T19:26:05.458Z [DEBUG] ReferenceTransformer: "data.vsphere_compute_cluster.cluster" references: []
2022-08-05T19:26:05.458Z [INFO]  ReferenceTransformer: reference not found: "var.vmw-apic-gw-backend-subnet-name"
2022-08-05T19:26:05.458Z [DEBUG] ReferenceTransformer: "data.vsphere_network.vmw-apic-gw-backend-subnet" references: []
2022-08-05T19:26:05.480Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] Looking for cluster "Cluster-eu-de" in datacenter "/VMware-On-IBM-Cloud-VPC": timestamp=2022-08-05T19:26:05.480Z
2022-08-05T19:26:05.480Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] Attempting to locate compute cluster "Cluster-eu-de" in datacenter "/VMware-On-IBM-Cloud-VPC": timestamp=2022-08-05T19:26:05.480Z
2022-08-05T19:26:05.513Z [INFO]  ReferenceTransformer: reference not found: "var.apic-management-iso-path"
2022-08-05T19:26:05.513Z [DEBUG] ReferenceTransformer: "vsphere_file.management-iso" references: []
2022-08-05T19:26:05.516Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] reading file: &schema.ResourceData{schema:map[string]*schema.Schema{"create_directories":(*schema.Schema)(0xc000504c80), "datacenter":(*schema.Schema)(0xc000504500), "datastore":(*schema.Schema)(0xc000504780), "destination_file":(*schema.Schema)(0xc000504b40), "source_datacenter":(*schema.Schema)(0xc000504640), "source_datastore":(*schema.Schema)(0xc0005048c0), "source_file":(*schema.Schema)(0xc000504a00)}, config:(*terraform.ResourceConfig)(nil), state:(*terraform.InstanceState)(0xc0002732b0), diff:(*terraform.InstanceDiff)(nil), meta:map[string]interface {}(nil), timeouts:(*schema.ResourceTimeout)(0xc000709080), providerMeta:cty.Value{ty:cty.Type{typeImpl:cty.typeObject{typeImplSigil:cty.typeImplSigil{}, AttrTypes:map[string]cty.Type{}}}, v:interface {}(nil)}, multiReader:(*schema.MultiLevelFieldReader)(nil), setWriter:(*schema.MapFieldWriter)(nil), newState:(*terraform.InstanceState)(nil), partial:false, once:sync.Once{done:0x0, m:sync.Mutex{state:0, sema:0x0}}, isNew:false, panicOnError:false}: timestamp=2022-08-05T19:26:05.516Z
2022-08-05T19:26:05.522Z [DEBUG] ReferenceTransformer: "data.vsphere_resource_pool.default" references: []
2022-08-05T19:26:05.534Z [INFO]  ReferenceTransformer: reference not found: "var.apic-management-ova-path"
2022-08-05T19:26:05.534Z [DEBUG] ReferenceTransformer: "data.vsphere_ovf_vm_template.management-ova" references: []
2022-08-05T19:26:05.537Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] Locating resource pool with ID resgroup-30: timestamp=2022-08-05T19:26:05.537Z
2022-08-05T19:26:05.539Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] Resource pool found: resgroup-30: timestamp=2022-08-05T19:26:05.538Z
2022-08-05T19:26:05.539Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] Locating folder at path "" relative to virtual machine root: timestamp=2022-08-05T19:26:05.539Z
2022-08-05T19:26:05.545Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] Folder located: "/VMware-On-IBM-Cloud-VPC/vm": timestamp=2022-08-05T19:26:05.545Z
2022-08-05T19:26:05.545Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] Locating host system ID host-21: timestamp=2022-08-05T19:26:05.545Z
2022-08-05T19:26:05.547Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] Host system found: host-21: timestamp=2022-08-05T19:26:05.547Z
2022-08-05T19:26:05.547Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] Locating datastore with ID "datastore-32": timestamp=2022-08-05T19:26:05.547Z
2022-08-05T19:26:05.549Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] Datastore with ID "datastore-32" found: timestamp=2022-08-05T19:26:05.549Z
2022-08-05T19:26:05.649Z [DEBUG] Resource instance state not found for node "vsphere_virtual_machine.management-vm", instance vsphere_virtual_machine.management-vm
2022-08-05T19:26:05.649Z [DEBUG] ReferenceTransformer: "vsphere_virtual_machine.management-vm" references: []
2022-08-05T19:26:05.649Z [DEBUG] refresh: vsphere_virtual_machine.management-vm: no state, so not refreshing
2022-08-05T19:26:05.663Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] vsphere_virtual_machine (ID = <new resource>): Performing diff customization and validation: timestamp=2022-08-05T19:26:05.663Z
2022-08-05T19:26:05.663Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] NetworkInterfaceDiffOperation: Beginning diff validation: timestamp=2022-08-05T19:26:05.663Z
2022-08-05T19:26:05.663Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] NetworkInterfaceDiffOperation: Diff validation complete: timestamp=2022-08-05T19:26:05.663Z
2022-08-05T19:26:05.663Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] Locating vApp container with ID resgroup-30: timestamp=2022-08-05T19:26:05.663Z
2022-08-05T19:26:05.666Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] VAppDiffOperation: Verifying configuration meets requirements for vApp transport: timestamp=2022-08-05T19:26:05.666Z
2022-08-05T19:26:05.666Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] VAppDiffOperation: ISO transport is not supported on this virtual machine or multiple transport options exist: timestamp=2022-08-05T19:26:05.666Z
2022-08-05T19:26:05.666Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] vsphere_virtual_machine (ID = <new resource>): Diff customization and validation complete: timestamp=2022-08-05T19:26:05.666Z
2022-08-05T19:26:05.668Z [WARN]  Provider "registry.terraform.io/hashicorp/vsphere" produced an invalid plan for vsphere_virtual_machine.management-vm, 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:
      - .scsi_controller_count: planned value cty.NumberIntVal(1) for a non-computed attribute
      - .boot_retry_delay: planned value cty.NumberIntVal(10000) for a non-computed attribute
      - .memory_share_level: planned value cty.StringVal("normal") for a non-computed attribute
      - .tools_upgrade_policy: planned value cty.StringVal("manual") for a non-computed attribute
      - .cpu_limit: planned value cty.NumberIntVal(-1) for a non-computed attribute
      - .folder: planned value cty.StringVal("VMware-On-IBM-Cloud-VPC/vm/apic-vms") does not match config value cty.StringVal("/VMware-On-IBM-Cloud-VPC/vm/apic-vms")
      - .run_tools_scripts_after_power_on: planned value cty.True for a non-computed attribute
      - .run_tools_scripts_before_guest_standby: planned value cty.True for a non-computed attribute
      - .ept_rvi_mode: planned value cty.StringVal("automatic") for a non-computed attribute
      - .force_power_off: planned value cty.True for a non-computed attribute
      - .num_cores_per_socket: planned value cty.NumberIntVal(1) for a non-computed attribute
      - .ide_controller_count: planned value cty.NumberIntVal(2) for a non-computed attribute
      - .scsi_bus_sharing: planned value cty.StringVal("noSharing") for a non-computed attribute
      - .swap_placement_policy: planned value cty.StringVal("inherit") for a non-computed attribute
      - .wait_for_guest_net_routable: planned value cty.True for a non-computed attribute
      - .firmware: planned value cty.StringVal("bios") for a non-computed attribute
      - .memory_limit: planned value cty.NumberIntVal(-1) for a non-computed attribute
      - .cpu_share_level: planned value cty.StringVal("normal") for a non-computed attribute
      - .poweron_timeout: planned value cty.NumberIntVal(300) for a non-computed attribute
      - .shutdown_wait_timeout: planned value cty.NumberIntVal(3) for a non-computed attribute
      - .migrate_wait_timeout: planned value cty.NumberIntVal(30) for a non-computed attribute
      - .num_cpus: planned value cty.NumberIntVal(1) for a non-computed attribute
      - .run_tools_scripts_after_resume: planned value cty.True for a non-computed attribute
      - .sata_controller_count: planned value cty.NumberIntVal(0) for a non-computed attribute
      - .hv_mode: planned value cty.StringVal("hvAuto") for a non-computed attribute
      - .run_tools_scripts_before_guest_shutdown: planned value cty.True for a non-computed attribute
      - .latency_sensitivity: planned value cty.StringVal("normal") for a non-computed attribute
      - .memory: planned value cty.NumberIntVal(1024) for a non-computed attribute
      - .disk: attribute representing nested block must not be unknown itself; set nested attribute values to unknown instead
      - .ovf_deploy[0].enable_hidden_properties: planned value cty.False for a non-computed attribute
2022-08-05T19:26:05.670Z [DEBUG] provider.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = transport is closing"
2022-08-05T19:26:05.672Z [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=99032
2022-08-05T19:26:05.672Z [DEBUG] provider: plugin exited
2022-08-05T19:26:05.672Z [DEBUG] building apply graph to check for errors
2022-08-05T19:26:05.672Z [DEBUG] Resource state not found for node "vsphere_virtual_machine.management-vm", instance vsphere_virtual_machine.management-vm
2022-08-05T19:26:05.673Z [DEBUG] ProviderTransformer: "vsphere_virtual_machine.management-vm" (*terraform.NodeApplyableResourceInstance) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.673Z [DEBUG] ProviderTransformer: "data.vsphere_network.vmw-apic-gw-backend-subnet (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.673Z [DEBUG] ProviderTransformer: "data.vsphere_host.esxi-host (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.673Z [DEBUG] ProviderTransformer: "data.vsphere_resource_pool.default (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.673Z [DEBUG] ProviderTransformer: "data.vsphere_datastore.datastore (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.673Z [DEBUG] ProviderTransformer: "vsphere_virtual_machine.management-vm (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.673Z [DEBUG] ProviderTransformer: "vsphere_file.management-iso (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.673Z [DEBUG] ProviderTransformer: "data.vsphere_network.vmw-apic-subsys-subnet (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.673Z [DEBUG] ProviderTransformer: "data.vsphere_compute_cluster.cluster (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.673Z [DEBUG] ProviderTransformer: "data.vsphere_network.vmw-apic-gw-frontend-subnet (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.673Z [DEBUG] ProviderTransformer: "data.vsphere_folder.folder (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.673Z [DEBUG] ProviderTransformer: "data.vsphere_datacenter.datacenter (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.673Z [DEBUG] ProviderTransformer: "data.vsphere_ovf_vm_template.management-ova (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "vsphere_file.management-iso (expand)" references: []
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "vsphere_virtual_machine.management-vm" references: [data.vsphere_ovf_vm_template.management-ova (expand) data.vsphere_datacenter.datacenter (expand) data.vsphere_folder.folder (expand) data.vsphere_host.esxi-host (expand) data.vsphere_ovf_vm_template.management-ova (expand) data.vsphere_resource_pool.default (expand) data.vsphere_ovf_vm_template.management-ova (expand) data.vsphere_datastore.datastore (expand) data.vsphere_ovf_vm_template.management-ova (expand) data.vsphere_ovf_vm_template.management-ova (expand) data.vsphere_ovf_vm_template.management-ova (expand) data.vsphere_datastore.datastore (expand) vsphere_file.management-iso (expand)]
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "var.vmw-apic-gw-frontend-subnet-name" references: []
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "data.vsphere_host.esxi-host (expand)" references: []
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "data.vsphere_compute_cluster.cluster (expand)" references: []
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "data.vsphere_ovf_vm_template.management-ova (expand)" references: []
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "data.vsphere_network.vmw-apic-subsys-subnet (expand)" references: []
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "data.vsphere_network.vmw-apic-gw-backend-subnet (expand)" references: []
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "var.apic-management-ova-path" references: []
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "data.vsphere_network.vmw-apic-gw-frontend-subnet (expand)" references: []
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "data.vsphere_resource_pool.default (expand)" references: []
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "var.vsphere_password" references: []
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "var.vsphere_server" references: []
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "var.vsphere_user" references: []
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "var.vmw-apic-subsys-subnet-name" references: []
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "vsphere_virtual_machine.management-vm (expand)" references: []
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "data.vsphere_datacenter.datacenter (expand)" references: []
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "data.vsphere_datastore.datastore (expand)" references: []
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "data.vsphere_folder.folder (expand)" references: []
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "var.vmw-apic-gw-backend-subnet-name" references: []
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "var.apic-management-iso-path" references: []
2022-08-05T19:26:05.674Z [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/vsphere\"]" references: [var.vsphere_user var.vsphere_server var.vsphere_password]
2022-08-05T19:26:05.675Z [DEBUG] pruneUnusedNodes: data.vsphere_network.vmw-apic-subsys-subnet (expand) is no longer needed, removing
2022-08-05T19:26:05.675Z [DEBUG] pruneUnusedNodes: data.vsphere_network.vmw-apic-gw-backend-subnet (expand) is no longer needed, removing
2022-08-05T19:26:05.675Z [DEBUG] pruneUnusedNodes: data.vsphere_compute_cluster.cluster (expand) is no longer needed, removing
2022-08-05T19:26:05.675Z [DEBUG] pruneUnusedNodes: data.vsphere_network.vmw-apic-gw-frontend-subnet (expand) is no longer needed, removing
2022-08-05T19:26:05.689Z [INFO]  backend/local: apply calling Apply
2022-08-05T19:26:05.689Z [DEBUG] Building and walking apply graph for NormalMode plan
2022-08-05T19:26:05.689Z [DEBUG] Resource state not found for node "vsphere_virtual_machine.management-vm", instance vsphere_virtual_machine.management-vm
2022-08-05T19:26:05.689Z [DEBUG] ProviderTransformer: "vsphere_file.management-iso (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.689Z [DEBUG] ProviderTransformer: "data.vsphere_host.esxi-host (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.689Z [DEBUG] ProviderTransformer: "data.vsphere_ovf_vm_template.management-ova (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.689Z [DEBUG] ProviderTransformer: "vsphere_virtual_machine.management-vm (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.689Z [DEBUG] ProviderTransformer: "data.vsphere_folder.folder (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.690Z [DEBUG] ProviderTransformer: "data.vsphere_network.vmw-apic-gw-frontend-subnet (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.690Z [DEBUG] ProviderTransformer: "data.vsphere_network.vmw-apic-gw-backend-subnet (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.690Z [DEBUG] ProviderTransformer: "vsphere_virtual_machine.management-vm" (*terraform.NodeApplyableResourceInstance) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.690Z [DEBUG] ProviderTransformer: "data.vsphere_datastore.datastore (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.690Z [DEBUG] ProviderTransformer: "data.vsphere_network.vmw-apic-subsys-subnet (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.690Z [DEBUG] ProviderTransformer: "data.vsphere_datacenter.datacenter (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.690Z [DEBUG] ProviderTransformer: "data.vsphere_resource_pool.default (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.690Z [DEBUG] ProviderTransformer: "data.vsphere_compute_cluster.cluster (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/vsphere"]
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "data.vsphere_compute_cluster.cluster (expand)" references: []
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "data.vsphere_network.vmw-apic-gw-backend-subnet (expand)" references: []
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "vsphere_virtual_machine.management-vm" references: [data.vsphere_datacenter.datacenter (expand) data.vsphere_resource_pool.default (expand) data.vsphere_ovf_vm_template.management-ova (expand) data.vsphere_folder.folder (expand) data.vsphere_host.esxi-host (expand) data.vsphere_datastore.datastore (expand) data.vsphere_ovf_vm_template.management-ova (expand) data.vsphere_ovf_vm_template.management-ova (expand) data.vsphere_ovf_vm_template.management-ova (expand) data.vsphere_ovf_vm_template.management-ova (expand) data.vsphere_ovf_vm_template.management-ova (expand) data.vsphere_datastore.datastore (expand) vsphere_file.management-iso (expand)]
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/vsphere\"]" references: [var.vsphere_password var.vsphere_user var.vsphere_server]
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "vsphere_file.management-iso (expand)" references: []
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "data.vsphere_host.esxi-host (expand)" references: []
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "data.vsphere_ovf_vm_template.management-ova (expand)" references: []
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "data.vsphere_datastore.datastore (expand)" references: []
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "data.vsphere_network.vmw-apic-subsys-subnet (expand)" references: []
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "var.vsphere_password" references: []
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "var.vsphere_server" references: []
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "var.vmw-apic-subsys-subnet-name" references: []
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "var.vmw-apic-gw-frontend-subnet-name" references: []
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "var.vmw-apic-gw-backend-subnet-name" references: []
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "var.apic-management-iso-path" references: []
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "var.vsphere_user" references: []
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "vsphere_virtual_machine.management-vm (expand)" references: []
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "data.vsphere_datacenter.datacenter (expand)" references: []
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "data.vsphere_folder.folder (expand)" references: []
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "data.vsphere_resource_pool.default (expand)" references: []
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "var.apic-management-ova-path" references: []
2022-08-05T19:26:05.690Z [DEBUG] ReferenceTransformer: "data.vsphere_network.vmw-apic-gw-frontend-subnet (expand)" references: []
2022-08-05T19:26:05.690Z [DEBUG] pruneUnusedNodes: data.vsphere_compute_cluster.cluster (expand) is no longer needed, removing
2022-08-05T19:26:05.690Z [DEBUG] pruneUnusedNodes: data.vsphere_network.vmw-apic-gw-backend-subnet (expand) is no longer needed, removing
2022-08-05T19:26:05.690Z [DEBUG] pruneUnusedNodes: data.vsphere_network.vmw-apic-subsys-subnet (expand) is no longer needed, removing
2022-08-05T19:26:05.690Z [DEBUG] pruneUnusedNodes: data.vsphere_network.vmw-apic-gw-frontend-subnet (expand) is no longer needed, removing
2022-08-05T19:26:05.691Z [DEBUG] Starting graph walk: walkApply
2022-08-05T19:26:05.691Z [DEBUG] created provider logger: level=debug
2022-08-05T19:26:05.691Z [INFO]  provider: configuring client automatic mTLS
2022-08-05T19:26:05.708Z [DEBUG] provider: starting plugin: path=.terraform/providers/registry.terraform.io/hashicorp/vsphere/2.2.0/linux_amd64/terraform-provider-vsphere_v2.2.0_x5 args=[.terraform/providers/registry.terraform.io/hashicorp/vsphere/2.2.0/linux_amd64/terraform-provider-vsphere_v2.2.0_x5]
2022-08-05T19:26:05.709Z [DEBUG] provider: plugin started: path=.terraform/providers/registry.terraform.io/hashicorp/vsphere/2.2.0/linux_amd64/terraform-provider-vsphere_v2.2.0_x5 pid=99039
2022-08-05T19:26:05.709Z [DEBUG] provider: waiting for RPC address: path=.terraform/providers/registry.terraform.io/hashicorp/vsphere/2.2.0/linux_amd64/terraform-provider-vsphere_v2.2.0_x5
2022-08-05T19:26:05.718Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: configuring server automatic mTLS: timestamp=2022-08-05T19:26:05.717Z
2022-08-05T19:26:05.738Z [DEBUG] provider: using plugin: version=5
2022-08-05T19:26:05.738Z [DEBUG] provider.terraform-provider-vsphere_v2.2.0_x5: plugin address: address=/tmp/plugin1283928703 network=unix timestamp=2022-08-05T19:26:05.737Z
2022-08-05T19:26:05.785Z [WARN]  ValidateProviderConfig from "provider[\"registry.terraform.io/hashicorp/vsphere\"]" changed the config value, but that value is unused
2022-08-05T19:26:05.786Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] Cached SOAP client session data not valid or persistence not enabled, new session necessary: timestamp=2022-08-05T19:26:05.785Z
2022-08-05T19:26:05.786Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] Creating new SOAP API session on endpoint vcenter.vmware.ibmcloud.local:443: timestamp=2022-08-05T19:26:05.785Z
2022-08-05T19:26:05.841Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] SOAP API session creation successful: timestamp=2022-08-05T19:26:05.841Z
2022-08-05T19:26:05.841Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] VMWare vSphere Client configured for URL: vcenter.vmware.ibmcloud.local:443: timestamp=2022-08-05T19:26:05.841Z
2022-08-05T19:26:05.841Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:05 [DEBUG] Setting up REST client: timestamp=2022-08-05T19:26:05.841Z
2022-08-05T19:26:06.018Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] CIS REST client configuration successful: timestamp=2022-08-05T19:26:06.017Z
2022-08-05T19:26:06.041Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] vsphere_virtual_machine (ID = <new resource>): Performing diff customization and validation: timestamp=2022-08-05T19:26:06.041Z
2022-08-05T19:26:06.041Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] NetworkInterfaceDiffOperation: Beginning diff validation: timestamp=2022-08-05T19:26:06.041Z
2022-08-05T19:26:06.041Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] NetworkInterfaceDiffOperation: Diff validation complete: timestamp=2022-08-05T19:26:06.041Z
2022-08-05T19:26:06.041Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] Locating vApp container with ID resgroup-30: timestamp=2022-08-05T19:26:06.041Z
2022-08-05T19:26:06.045Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] VAppDiffOperation: Verifying configuration meets requirements for vApp transport: timestamp=2022-08-05T19:26:06.045Z
2022-08-05T19:26:06.045Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] VAppDiffOperation: ISO transport is not supported on this virtual machine or multiple transport options exist: timestamp=2022-08-05T19:26:06.045Z
2022-08-05T19:26:06.045Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] vsphere_virtual_machine (ID = <new resource>): Diff customization and validation complete: timestamp=2022-08-05T19:26:06.045Z
2022-08-05T19:26:06.047Z [WARN]  Provider "registry.terraform.io/hashicorp/vsphere" produced an invalid plan for vsphere_virtual_machine.management-vm, 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:
      - .ide_controller_count: planned value cty.NumberIntVal(2) for a non-computed attribute
      - .scsi_bus_sharing: planned value cty.StringVal("noSharing") for a non-computed attribute
      - .swap_placement_policy: planned value cty.StringVal("inherit") for a non-computed attribute
      - .firmware: planned value cty.StringVal("bios") for a non-computed attribute
      - .wait_for_guest_net_routable: planned value cty.True for a non-computed attribute
      - .memory_limit: planned value cty.NumberIntVal(-1) for a non-computed attribute
      - .cpu_share_level: planned value cty.StringVal("normal") for a non-computed attribute
      - .poweron_timeout: planned value cty.NumberIntVal(300) for a non-computed attribute
      - .shutdown_wait_timeout: planned value cty.NumberIntVal(3) for a non-computed attribute
      - .migrate_wait_timeout: planned value cty.NumberIntVal(30) for a non-computed attribute
      - .num_cpus: planned value cty.NumberIntVal(1) for a non-computed attribute
      - .run_tools_scripts_after_resume: planned value cty.True for a non-computed attribute
      - .sata_controller_count: planned value cty.NumberIntVal(0) for a non-computed attribute
      - .hv_mode: planned value cty.StringVal("hvAuto") for a non-computed attribute
      - .latency_sensitivity: planned value cty.StringVal("normal") for a non-computed attribute
      - .memory: planned value cty.NumberIntVal(1024) for a non-computed attribute
      - .run_tools_scripts_before_guest_shutdown: planned value cty.True for a non-computed attribute
      - .boot_retry_delay: planned value cty.NumberIntVal(10000) for a non-computed attribute
      - .scsi_controller_count: planned value cty.NumberIntVal(1) for a non-computed attribute
      - .cpu_limit: planned value cty.NumberIntVal(-1) for a non-computed attribute
      - .folder: planned value cty.StringVal("VMware-On-IBM-Cloud-VPC/vm/apic-vms") does not match config value cty.StringVal("/VMware-On-IBM-Cloud-VPC/vm/apic-vms")
      - .memory_share_level: planned value cty.StringVal("normal") for a non-computed attribute
      - .tools_upgrade_policy: planned value cty.StringVal("manual") for a non-computed attribute
      - .ept_rvi_mode: planned value cty.StringVal("automatic") for a non-computed attribute
      - .force_power_off: planned value cty.True for a non-computed attribute
      - .num_cores_per_socket: planned value cty.NumberIntVal(1) for a non-computed attribute
      - .run_tools_scripts_after_power_on: planned value cty.True for a non-computed attribute
      - .run_tools_scripts_before_guest_standby: planned value cty.True for a non-computed attribute
      - .disk: attribute representing nested block must not be unknown itself; set nested attribute values to unknown instead
      - .ovf_deploy[0].enable_hidden_properties: planned value cty.False for a non-computed attribute
2022-08-05T19:26:06.048Z [INFO]  Starting apply for vsphere_virtual_machine.management-vm
2022-08-05T19:26:06.049Z [DEBUG] vsphere_virtual_machine.management-vm: applying the planned Create change
2022-08-05T19:26:06.052Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] setting computed for "guest_ip_addresses" from ComputedKeys: timestamp=2022-08-05T19:26:06.052Z
2022-08-05T19:26:06.052Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] setting computed for "disk" from ComputedKeys: timestamp=2022-08-05T19:26:06.052Z
2022-08-05T19:26:06.052Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] setting computed for "vapp_transport" from ComputedKeys: timestamp=2022-08-05T19:26:06.052Z
2022-08-05T19:26:06.052Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] vsphere_virtual_machine (ID = <new resource>): Beginning create: timestamp=2022-08-05T19:26:06.052Z
2022-08-05T19:26:06.052Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] tagsClientIfDefined: No tags configured, skipping loading of tagging client: timestamp=2022-08-05T19:26:06.052Z
2022-08-05T19:26:06.052Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] Locating resource pool with ID resgroup-30: timestamp=2022-08-05T19:26:06.052Z
2022-08-05T19:26:06.055Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] Resource pool found: resgroup-30: timestamp=2022-08-05T19:26:06.055Z
2022-08-05T19:26:06.055Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] Locating folder at path "/VMware-On-IBM-Cloud-VPC/vm/apic-vms" relative to virtual machine root: timestamp=2022-08-05T19:26:06.055Z
2022-08-05T19:26:06.065Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] Folder located: "/VMware-On-IBM-Cloud-VPC/vm/apic-vms": timestamp=2022-08-05T19:26:06.065Z
2022-08-05T19:26:06.065Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] Locating host system ID host-21: timestamp=2022-08-05T19:26:06.065Z
2022-08-05T19:26:06.068Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] Host system found: host-21: timestamp=2022-08-05T19:26:06.068Z
2022-08-05T19:26:06.068Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] Locating datastore with ID "datastore-32": timestamp=2022-08-05T19:26:06.068Z
2022-08-05T19:26:06.070Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 [DEBUG] Datastore with ID "datastore-32" found: timestamp=2022-08-05T19:26:06.070Z
2022-08-05T19:26:06.108Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06  [DEBUG] start deploying from ovf/ova Template: timestamp=2022-08-05T19:26:06.107Z
2022-08-05T19:26:06.420Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 Total size of files to upload is 12696661504 bytes: timestamp=2022-08-05T19:26:06.420Z
2022-08-05T19:26:06.420Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:06 Uploaded 0 of 12696661504 Bytes: timestamp=2022-08-05T19:26:06.420Z
2022-08-05T19:26:16.422Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:16 Uploaded 516587520 of 12696661504 Bytes: timestamp=2022-08-05T19:26:16.422Z
2022-08-05T19:26:26.424Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:26 Uploaded 1097891840 of 12696661504 Bytes: timestamp=2022-08-05T19:26:26.424Z
2022-08-05T19:26:36.426Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:36 Uploaded 1702756352 of 12696661504 Bytes: timestamp=2022-08-05T19:26:36.426Z
2022-08-05T19:26:46.428Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:46 Uploaded 2194374656 of 12696661504 Bytes: timestamp=2022-08-05T19:26:46.428Z
2022-08-05T19:26:56.431Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:26:56 Uploaded 2683273216 of 12696661504 Bytes: timestamp=2022-08-05T19:26:56.430Z
2022-08-05T19:27:06.434Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:27:06 Uploaded 3177021440 of 12696661504 Bytes: timestamp=2022-08-05T19:27:06.433Z
2022-08-05T19:27:16.436Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:27:16 Uploaded 3668148224 of 12696661504 Bytes: timestamp=2022-08-05T19:27:16.436Z
2022-08-05T19:27:26.439Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:27:26 Uploaded 4159275008 of 12696661504 Bytes: timestamp=2022-08-05T19:27:26.439Z
2022-08-05T19:27:36.441Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:27:36 Uploaded 4650663936 of 12696661504 Bytes: timestamp=2022-08-05T19:27:36.441Z
2022-08-05T19:27:46.444Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:27:46 Uploaded 5142052864 of 12696661504 Bytes: timestamp=2022-08-05T19:27:46.444Z
2022-08-05T19:27:56.446Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:27:56 Uploaded 5633376256 of 12696661504 Bytes: timestamp=2022-08-05T19:27:56.446Z
2022-08-05T19:28:06.449Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:28:06 Uploaded 6124437504 of 12696661504 Bytes: timestamp=2022-08-05T19:28:06.449Z
2022-08-05T19:28:16.453Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:28:16 Uploaded 6615957504 of 12696661504 Bytes: timestamp=2022-08-05T19:28:16.453Z
2022-08-05T19:28:26.456Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:28:26 Uploaded 7107215360 of 12696661504 Bytes: timestamp=2022-08-05T19:28:26.456Z
2022-08-05T19:28:36.458Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:28:36 Uploaded 7598604288 of 12696661504 Bytes: timestamp=2022-08-05T19:28:36.458Z
2022-08-05T19:28:46.461Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:28:46 Uploaded 8089993216 of 12696661504 Bytes: timestamp=2022-08-05T19:28:46.461Z
2022-08-05T19:28:56.463Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:28:56 Uploaded 8581251072 of 12696661504 Bytes: timestamp=2022-08-05T19:28:56.462Z
2022-08-05T19:29:06.465Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:29:06 Uploaded 9072640000 of 12696661504 Bytes: timestamp=2022-08-05T19:29:06.465Z
2022-08-05T19:29:16.468Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:29:16 Uploaded 9564028928 of 12696661504 Bytes: timestamp=2022-08-05T19:29:16.468Z
2022-08-05T19:29:26.472Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:29:26 Uploaded 10055417856 of 12696661504 Bytes: timestamp=2022-08-05T19:29:26.472Z
2022-08-05T19:29:36.474Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:29:36 Uploaded 10546544640 of 12696661504 Bytes: timestamp=2022-08-05T19:29:36.474Z
2022-08-05T19:29:46.477Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:29:46 Uploaded 11037933568 of 12696661504 Bytes: timestamp=2022-08-05T19:29:46.477Z
2022-08-05T19:29:56.481Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:29:56 Uploaded 11529191424 of 12696661504 Bytes: timestamp=2022-08-05T19:29:56.480Z
2022-08-05T19:30:06.485Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:06 Uploaded 12020711424 of 12696661504 Bytes: timestamp=2022-08-05T19:30:06.485Z
2022-08-05T19:30:16.488Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:16 Uploaded 12511707136 of 12696661504 Bytes: timestamp=2022-08-05T19:30:16.488Z
2022-08-05T19:30:20.335Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:20  DEBUG : Completed uploading the vmdk fileAPIConnect-management.vmdk: timestamp=2022-08-05T19:30:20.335Z
2022-08-05T19:30:26.490Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 Uploaded 12696661504 of 12696661504 Bytes: timestamp=2022-08-05T19:30:26.490Z
2022-08-05T19:30:26.598Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Fetching properties for VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management": timestamp=2022-08-05T19:30:26.598Z
2022-08-05T19:30:26.609Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management" - UUID is "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:26.609Z
2022-08-05T19:30:26.609Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Locating virtual machine with UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:26.609Z
2022-08-05T19:30:26.609Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Using SearchIndex to look up UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:26.609Z
2022-08-05T19:30:26.613Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management" found for UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:26.613Z
2022-08-05T19:30:26.613Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Fetching properties for VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management": timestamp=2022-08-05T19:30:26.613Z
2022-08-05T19:30:26.620Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Reconfiguring virtual machine "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management": timestamp=2022-08-05T19:30:26.620Z
2022-08-05T19:30:26.703Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Locating resource pool with ID resgroup-30: timestamp=2022-08-05T19:30:26.703Z
2022-08-05T19:30:26.705Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Resource pool found: resgroup-30: timestamp=2022-08-05T19:30:26.705Z
2022-08-05T19:30:26.705Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Fetching properties for VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management": timestamp=2022-08-05T19:30:26.705Z
2022-08-05T19:30:26.712Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management" - UUID is "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:26.712Z
2022-08-05T19:30:26.712Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] vsphere_virtual_machine (ID = 4214742d-4ff5-4f15-b47b-8a7f1d4e1166): Building config spec: timestamp=2022-08-05T19:30:26.712Z
2022-08-05T19:30:26.712Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Locating virtual machine with UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:26.712Z
2022-08-05T19:30:26.712Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Using SearchIndex to look up UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:26.712Z
2022-08-05T19:30:26.716Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management" found for UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:26.716Z
2022-08-05T19:30:26.716Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Fetching properties for VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management": timestamp=2022-08-05T19:30:26.716Z
2022-08-05T19:30:26.723Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] vsphere_virtual_machine (ID = 4214742d-4ff5-4f15-b47b-8a7f1d4e1166): Resource argument "guest_id" requires a VM restart: timestamp=2022-08-05T19:30:26.723Z
2022-08-05T19:30:26.723Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] vsphere_virtual_machine (ID = 4214742d-4ff5-4f15-b47b-8a7f1d4e1166): Resource argument "tools_upgrade_policy" requires a VM restart: timestamp=2022-08-05T19:30:26.723Z
2022-08-05T19:30:26.723Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] vsphere_virtual_machine (ID = 4214742d-4ff5-4f15-b47b-8a7f1d4e1166): Resource argument "hv_mode" requires a VM restart: timestamp=2022-08-05T19:30:26.723Z
2022-08-05T19:30:26.723Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] vsphere_virtual_machine (ID = 4214742d-4ff5-4f15-b47b-8a7f1d4e1166): Resource argument "ept_rvi_mode" requires a VM restart: timestamp=2022-08-05T19:30:26.723Z
2022-08-05T19:30:26.723Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] vsphere_virtual_machine (ID = 4214742d-4ff5-4f15-b47b-8a7f1d4e1166): CPU operation requires a VM restart: timestamp=2022-08-05T19:30:26.723Z
2022-08-05T19:30:26.723Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] vsphere_virtual_machine (ID = 4214742d-4ff5-4f15-b47b-8a7f1d4e1166): Resource argument "num_cores_per_socket" requires a VM restart: timestamp=2022-08-05T19:30:26.723Z
2022-08-05T19:30:26.723Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] vsphere_virtual_machine (ID = 4214742d-4ff5-4f15-b47b-8a7f1d4e1166): Memory operation requires a VM restart: timestamp=2022-08-05T19:30:26.723Z
2022-08-05T19:30:26.723Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] vsphere_virtual_machine (ID = 4214742d-4ff5-4f15-b47b-8a7f1d4e1166): Resource argument "swap_placement_policy" requires a VM restart: timestamp=2022-08-05T19:30:26.723Z
2022-08-05T19:30:26.723Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] vsphere_virtual_machine (ID = 4214742d-4ff5-4f15-b47b-8a7f1d4e1166): Resource argument "firmware" requires a VM restart: timestamp=2022-08-05T19:30:26.723Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] NormalizeBus: Normalizing first 1 controllers on SCSI bus to device type pvscsi: timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] NormalizeBus: Normalizing first 0 controllers on SATA bus: timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] NormalizeBus: Normalizing first 2 controllers on IDE bus: timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] NormalizeBus: Current SCSI bus contents: pvscsi-1000: timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] NormalizeBus: Current SATA bus contents:: timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] NormalizeBus: Current IDE bus contents: device-200,device-201: timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] NormalizeBus: Outgoing device list: ide-200,ide-201,ps2-300,pci-100,sio-400,keyboard-600,pointing-700,video-500,vmci-12000,pvscsi-1000,cdrom-3002,disk-1000-0,disk-1000-1,ethernet-0: timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] NormalizeBus: Outgoing device config spec:: timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] DiskPostCloneOperation: Looking for disk device changes post-clone: timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] DiskRefreshOperation: Found controller "controller-1000" for device "disk-1000-0": timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] DiskRefreshOperation: Found controller "controller-1000" for device "disk-1000-1": timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] DiskPostCloneOperation: Disk devices located: disk-1000-0,disk-1000-1: timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] DiskPostCloneOperation: Disk devices order after sort: disk-1000-0,disk-1000-1: timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] DiskPostCloneOperation: Current resource set:: timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] DiskPostCloneOperation: Resource set order after sort:: timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] DiskPostCloneOperation: Looking for and applying device changes in source disks: timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] disk.0 (key 2000 at scsi:0:0) (<unknown>): Reading state: timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] FindVirtualDevice: Looking for device with key 2000: timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] FindVirtualDevice: Device found: disk-1000-0: timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Locating virtual machine with UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.724Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Using SearchIndex to look up UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:26.724Z
2022-08-05T19:30:26.728Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management" found for UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:26.728Z
2022-08-05T19:30:26.735Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] queryAssociatedProfile: Retrieving storage policy of server object of type [virtualDiskId] and key [vm-47:2000].: timestamp=2022-08-05T19:30:26.735Z
2022-08-05T19:30:26.767Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] disk.0 (key 2000 at scsi:0:0) (APIConnect-management_6/APIConnect-management.vmdk): Read finished (key and device address may have changed): timestamp=2022-08-05T19:30:26.766Z
2022-08-05T19:30:26.767Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] disk.1 (key 2001 at scsi:0:1) (<unknown>): Reading state: timestamp=2022-08-05T19:30:26.767Z
2022-08-05T19:30:26.767Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] FindVirtualDevice: Looking for device with key 2001: timestamp=2022-08-05T19:30:26.767Z
2022-08-05T19:30:26.767Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] FindVirtualDevice: Device found: disk-1000-1: timestamp=2022-08-05T19:30:26.767Z
2022-08-05T19:30:26.767Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Locating virtual machine with UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:26.767Z
2022-08-05T19:30:26.767Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Using SearchIndex to look up UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:26.767Z
2022-08-05T19:30:26.771Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management" found for UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:26.771Z
2022-08-05T19:30:26.784Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] queryAssociatedProfile: Retrieving storage policy of server object of type [virtualDiskId] and key [vm-47:2001].: timestamp=2022-08-05T19:30:26.784Z
2022-08-05T19:30:26.794Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] disk.1 (key 2001 at scsi:0:1) (APIConnect-management_6/APIConnect-management_1.vmdk): Read finished (key and device address may have changed): timestamp=2022-08-05T19:30:26.794Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] DiskPostCloneOperation: Post-clone final resource list: (key 2000 at scsi:0:0),(key 2001 at scsi:0:1): timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] DiskPostCloneOperation: Device list at end of operation: ide-200,ide-201,ps2-300,pci-100,sio-400,keyboard-600,pointing-700,video-500,vmci-12000,pvscsi-1000,cdrom-3002,disk-1000-0,disk-1000-1,ethernet-0: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] DiskPostCloneOperation: Device config operations from post-clone:: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] DiskPostCloneOperation: Operation complete, returning updated spec: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] NetworkInterfacePostCloneOperation: Looking for post-clone device changes: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] NetworkInterfacePostCloneOperation: Network devices located: ethernet-0: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] NetworkInterfacePostCloneOperation: Current resource set from configuration:: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] NetworkInterfacePostCloneOperation: Layout from source: 1 devices over a 1 unit range: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] NetworkInterfacePostCloneOperation: Reading existing devices: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] network_interface.0 (key 4000 at pci:0:7): Reading state: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] FindVirtualDevice: Looking for device with key 4000: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] FindVirtualDevice: Device found: ethernet-0: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] network_interface.0 (key 4000 at pci:0:7): Read finished (key and device address may have changed): timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] network_interface.0 (key 4000 at pci:0:7): Beginning delete: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] FindVirtualDevice: Looking for device with key 4000: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] FindVirtualDevice: Device found: ethernet-0: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] network_interface.0 (key 4000 at pci:0:7): Resource argument "<device delete>" requires a VM restart: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] network_interface.0 (key 4000 at pci:0:7): Device config operations from update: (remove: *types.VirtualVmxnet3 at key 4000): timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] network_interface.0 (key 4000 at pci:0:7): Delete completed: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] applyDeviceChange: Applying changes: (remove: *types.VirtualVmxnet3 at key 4000): timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] applyDeviceChange: Device list before changes: ide-200,ide-201,ps2-300,pci-100,sio-400,keyboard-600,pointing-700,video-500,vmci-12000,pvscsi-1000,cdrom-3002,disk-1000-0,disk-1000-1,ethernet-0: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] applyDeviceChange: Device list after changes: ide-200,ide-201,ps2-300,pci-100,sio-400,keyboard-600,pointing-700,video-500,vmci-12000,pvscsi-1000,cdrom-3002,disk-1000-0,disk-1000-1: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] NetworkInterfacePostCloneOperation: Post-clone final resource list:: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] NetworkInterfacePostCloneOperation: Device list at end of operation: ide-200,ide-201,ps2-300,pci-100,sio-400,keyboard-600,pointing-700,video-500,vmci-12000,pvscsi-1000,cdrom-3002,disk-1000-0,disk-1000-1: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] NetworkInterfacePostCloneOperation: Device config operations from post-clone: (remove: *types.VirtualVmxnet3 at key 4000): timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] NetworkInterfacePostCloneOperation: Operation complete, returning updated spec: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] CdromPostCloneOperation: Looking for post-clone device changes: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.795Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] CdromPostCloneOperation: CDROM devices located: cdrom-3002: timestamp=2022-08-05T19:30:26.795Z
2022-08-05T19:30:26.796Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] CdromPostCloneOperation: Current resource set from configuration: (key 0 at <new device>): timestamp=2022-08-05T19:30:26.796Z
2022-08-05T19:30:26.796Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] CdromPostCloneOperation: Reading existing devices: timestamp=2022-08-05T19:30:26.796Z
2022-08-05T19:30:26.796Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] cdrom.0 (key 3002 at ide:1:0): Reading state: timestamp=2022-08-05T19:30:26.796Z
2022-08-05T19:30:26.796Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] FindVirtualDevice: Looking for device with key 3002: timestamp=2022-08-05T19:30:26.796Z
2022-08-05T19:30:26.796Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] FindVirtualDevice: Device found: cdrom-3002: timestamp=2022-08-05T19:30:26.796Z
2022-08-05T19:30:26.796Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 cdrom.0 (key 3002 at ide:1:0): [DEBUG] Unknown CDROM type *types.VirtualCdromRemotePassthroughBackingInfo, clearing all attributes: timestamp=2022-08-05T19:30:26.796Z
2022-08-05T19:30:26.796Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] cdrom.0 (key 3002 at ide:1:0): Read finished (key and device address may have changed): timestamp=2022-08-05T19:30:26.796Z
2022-08-05T19:30:26.796Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] cdrom.0 (key 3002 at ide:1:0): Beginning update: timestamp=2022-08-05T19:30:26.796Z
2022-08-05T19:30:26.796Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] cdrom.0 (key 3002 at ide:1:0): Beginning CDROM configuration validation: timestamp=2022-08-05T19:30:26.796Z
2022-08-05T19:30:26.796Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] cdrom.0 (key 3002 at ide:1:0): Config validation complete: timestamp=2022-08-05T19:30:26.796Z
2022-08-05T19:30:26.796Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] FindVirtualDevice: Looking for device with key 3002: timestamp=2022-08-05T19:30:26.796Z
2022-08-05T19:30:26.796Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] FindVirtualDevice: Device found: cdrom-3002: timestamp=2022-08-05T19:30:26.796Z
2022-08-05T19:30:26.796Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Locating datastore with ID "datastore-32": timestamp=2022-08-05T19:30:26.796Z
2022-08-05T19:30:26.799Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Datastore with ID "datastore-32" found: timestamp=2022-08-05T19:30:26.799Z
2022-08-05T19:30:26.802Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] cdrom.0 (key 3002 at ide:1:0): Device config operations from update: (edit: *types.VirtualCdrom at key 3002): timestamp=2022-08-05T19:30:26.802Z
2022-08-05T19:30:26.802Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] cdrom.0 (key 3002 at ide:1:0): Update complete: timestamp=2022-08-05T19:30:26.802Z
2022-08-05T19:30:26.802Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] applyDeviceChange: Applying changes: (edit: *types.VirtualCdrom at key 3002): timestamp=2022-08-05T19:30:26.802Z
2022-08-05T19:30:26.802Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] applyDeviceChange: Device list before changes: ide-200,ide-201,ps2-300,pci-100,sio-400,keyboard-600,pointing-700,video-500,vmci-12000,pvscsi-1000,cdrom-3002,disk-1000-0,disk-1000-1: timestamp=2022-08-05T19:30:26.802Z
2022-08-05T19:30:26.802Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] applyDeviceChange: Device list after changes: ide-200,ide-201,ps2-300,pci-100,sio-400,keyboard-600,pointing-700,video-500,vmci-12000,pvscsi-1000,cdrom-3002,disk-1000-0,disk-1000-1: timestamp=2022-08-05T19:30:26.802Z
2022-08-05T19:30:26.802Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] CdromPostCloneOperation: Post-clone final resource list: (key 3002 at ide:1:0): timestamp=2022-08-05T19:30:26.802Z
2022-08-05T19:30:26.802Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] CdromPostCloneOperation: Device list at end of operation: ide-200,ide-201,ps2-300,pci-100,sio-400,keyboard-600,pointing-700,video-500,vmci-12000,pvscsi-1000,cdrom-3002,disk-1000-0,disk-1000-1: timestamp=2022-08-05T19:30:26.802Z
2022-08-05T19:30:26.802Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] CdromPostCloneOperation: Device config operations from post-clone: (edit: *types.VirtualCdrom at key 3002): timestamp=2022-08-05T19:30:26.802Z
2022-08-05T19:30:26.802Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] CdromPostCloneOperation: Operation complete, returning updated spec: timestamp=2022-08-05T19:30:26.802Z
2022-08-05T19:30:26.803Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] vsphere_virtual_machine (ID = 4214742d-4ff5-4f15-b47b-8a7f1d4e1166): Final device list: ide-200,ide-201,ps2-300,pci-100,sio-400,keyboard-600,pointing-700,video-500,vmci-12000,pvscsi-1000,cdrom-3002,disk-1000-0,disk-1000-1: timestamp=2022-08-05T19:30:26.803Z
2022-08-05T19:30:26.803Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] vsphere_virtual_machine (ID = 4214742d-4ff5-4f15-b47b-8a7f1d4e1166): Final device change cfgSpec: (remove: *types.VirtualVmxnet3 at key 4000),(edit: *types.VirtualCdrom at key 3002): timestamp=2022-08-05T19:30:26.803Z
2022-08-05T19:30:26.803Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Reconfiguring virtual machine "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management": timestamp=2022-08-05T19:30:26.803Z
2022-08-05T19:30:26.931Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Fetching properties for VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management": timestamp=2022-08-05T19:30:26.931Z
2022-08-05T19:30:26.940Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Fetching properties for VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management": timestamp=2022-08-05T19:30:26.940Z
2022-08-05T19:30:26.945Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Fetching configuration options for VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management": timestamp=2022-08-05T19:30:26.945Z
2022-08-05T19:30:26.984Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Found current hardware version: 10: timestamp=2022-08-05T19:30:26.984Z
2022-08-05T19:30:26.984Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Powering on virtual machine "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management": timestamp=2022-08-05T19:30:26.984Z
2022-08-05T19:30:26.984Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] blockUntilReadyForMethod: Going to block until "PowerOnVM_Task" is no longer in the Disabled Methods list for vm vm-47: timestamp=2022-08-05T19:30:26.984Z
2022-08-05T19:30:26.985Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:26 [DEBUG] Fetching properties for VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management": timestamp=2022-08-05T19:30:26.984Z
2022-08-05T19:30:31.993Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:31 [DEBUG] blockUntilReadyForMethod: "PowerOnVM_Task" still disabled for vm vm-47, about to check again: timestamp=2022-08-05T19:30:31.993Z
2022-08-05T19:30:31.993Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:31 [DEBUG] Fetching properties for VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management": timestamp=2022-08-05T19:30:31.993Z
2022-08-05T19:30:31.998Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:31 [DEBUG] blockUntilReadyForMethod: "PowerOnVM_Task" no longer disabled for vm vm-47: timestamp=2022-08-05T19:30:31.998Z
2022-08-05T19:30:32.499Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:32 [DEBUG] Fetching properties for VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management": timestamp=2022-08-05T19:30:32.499Z
2022-08-05T19:30:32.505Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:32 [DEBUG] VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management" is powered off, attempting to power on.: timestamp=2022-08-05T19:30:32.505Z
2022-08-05T19:30:32.993Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:32 [DEBUG] PowerOn task for VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management" was successful.: timestamp=2022-08-05T19:30:32.993Z
2022-08-05T19:30:32.993Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:32 [DEBUG] Fetching properties for VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management": timestamp=2022-08-05T19:30:32.993Z
2022-08-05T19:30:33.001Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] Skipping IP waiter for VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management": timestamp=2022-08-05T19:30:33.001Z
2022-08-05T19:30:33.001Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] Skipping network waiter for VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management": timestamp=2022-08-05T19:30:33.001Z
2022-08-05T19:30:33.001Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] vsphere_virtual_machine (ID = 4214742d-4ff5-4f15-b47b-8a7f1d4e1166): Create complete: timestamp=2022-08-05T19:30:33.001Z
2022-08-05T19:30:33.001Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] vsphere_virtual_machine (ID = 4214742d-4ff5-4f15-b47b-8a7f1d4e1166): Reading state of virtual machine: timestamp=2022-08-05T19:30:33.001Z
2022-08-05T19:30:33.001Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] Locating virtual machine with UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:33.001Z
2022-08-05T19:30:33.001Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] Using SearchIndex to look up UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:33.001Z
2022-08-05T19:30:33.006Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management" found for UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:33.005Z
2022-08-05T19:30:33.006Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] Fetching properties for VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management": timestamp=2022-08-05T19:30:33.005Z
2022-08-05T19:30:33.012Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] MOID for VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management" is "vm-47": timestamp=2022-08-05T19:30:33.012Z
2022-08-05T19:30:33.012Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] Locating vApp container with ID resgroup-30: timestamp=2022-08-05T19:30:33.012Z
2022-08-05T19:30:33.014Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] Locating datastore with ID "datastore-32": timestamp=2022-08-05T19:30:33.014Z
2022-08-05T19:30:33.016Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] Datastore with ID "datastore-32" found: timestamp=2022-08-05T19:30:33.016Z
2022-08-05T19:30:33.035Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] queryAssociatedProfile: Retrieving storage policy of server object of type [virtualMachine] and key [vm-47].: timestamp=2022-08-05T19:30:33.035Z
2022-08-05T19:30:33.044Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] ReadSCSIBusType: SCSI controller layout for first 1 controllers: pvscsi-1000: timestamp=2022-08-05T19:30:33.044Z
2022-08-05T19:30:33.044Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] ReadSCSIBusSharing: SCSI controller layout for first 1 controllers: pvscsi-1000: timestamp=2022-08-05T19:30:33.044Z
2022-08-05T19:30:33.044Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] DiskRefreshOperation: Beginning refresh: timestamp=2022-08-05T19:30:33.044Z
2022-08-05T19:30:33.044Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] DiskRefreshOperation: Found controller "controller-1000" for device "disk-1000-0": timestamp=2022-08-05T19:30:33.044Z
2022-08-05T19:30:33.044Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] DiskRefreshOperation: Found controller "controller-1000" for device "disk-1000-1": timestamp=2022-08-05T19:30:33.044Z
2022-08-05T19:30:33.044Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] DiskRefreshOperation: Disk devices located: disk-1000-0,disk-1000-1: timestamp=2022-08-05T19:30:33.044Z
2022-08-05T19:30:33.045Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] DiskRefreshOperation: Current resource set from state: (key 2000 at scsi:0:0),(key 2001 at scsi:0:1): timestamp=2022-08-05T19:30:33.045Z
2022-08-05T19:30:33.045Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] DiskRefreshOperation: Looking for freshly-created or re-assigned resources to read in: timestamp=2022-08-05T19:30:33.045Z
2022-08-05T19:30:33.045Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] DiskRefreshOperation: Disk devices after created/re-assigned device search: disk-1000-0,disk-1000-1: timestamp=2022-08-05T19:30:33.045Z
2022-08-05T19:30:33.045Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] DiskRefreshOperation: Resource set to write after created/re-assigned device search:: timestamp=2022-08-05T19:30:33.045Z
2022-08-05T19:30:33.045Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] DiskRefreshOperation: Looking for devices known in state: timestamp=2022-08-05T19:30:33.045Z
2022-08-05T19:30:33.045Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] disk.0 (key 2000 at scsi:0:0) (APIConnect-management_6/APIConnect-management.vmdk): Reading state: timestamp=2022-08-05T19:30:33.045Z
2022-08-05T19:30:33.045Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] Locating virtual machine with UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:33.045Z
2022-08-05T19:30:33.045Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] Using SearchIndex to look up UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:33.045Z
2022-08-05T19:30:33.051Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management" found for UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:33.051Z
2022-08-05T19:30:33.059Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] queryAssociatedProfile: Retrieving storage policy of server object of type [virtualDiskId] and key [vm-47:2000].: timestamp=2022-08-05T19:30:33.059Z
2022-08-05T19:30:33.070Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] disk.0 (key 2000 at scsi:0:0) (APIConnect-management_6/APIConnect-management.vmdk): Read finished (key and device address may have changed): timestamp=2022-08-05T19:30:33.070Z
2022-08-05T19:30:33.070Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] disk.1 (key 2001 at scsi:0:1) (APIConnect-management_6/APIConnect-management_1.vmdk): Reading state: timestamp=2022-08-05T19:30:33.070Z
2022-08-05T19:30:33.070Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] Locating virtual machine with UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:33.070Z
2022-08-05T19:30:33.070Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] Using SearchIndex to look up UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:33.070Z
2022-08-05T19:30:33.075Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] VM "/VMware-On-IBM-Cloud-VPC/vm/apic-vms/APIConnect-management" found for UUID "4214742d-4ff5-4f15-b47b-8a7f1d4e1166": timestamp=2022-08-05T19:30:33.075Z
2022-08-05T19:30:33.083Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] queryAssociatedProfile: Retrieving storage policy of server object of type [virtualDiskId] and key [vm-47:2001].: timestamp=2022-08-05T19:30:33.083Z
2022-08-05T19:30:33.094Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] disk.1 (key 2001 at scsi:0:1) (APIConnect-management_6/APIConnect-management_1.vmdk): Read finished (key and device address may have changed): timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.094Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] DiskRefreshOperation: Resource set to write after known device search: (key 2000 at scsi:0:0),(key 2001 at scsi:0:1): timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.094Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] DiskRefreshOperation: Probable orphaned disk devices:: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.094Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] DiskRefreshOperation: Adding orphaned devices: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.094Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] DiskRefreshOperation: Resource set to write after adding orphaned devices: (key 2000 at scsi:0:0),(key 2001 at scsi:0:1): timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.094Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] DiskRefreshOperation: Final (sorted) resource set to write: (key 2000 at scsi:0:0),(key 2001 at scsi:0:1): timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.094Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] DiskRefreshOperation: Refresh operation complete, sending new resource set: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.094Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] NetworkInterfaceRefreshOperation: Beginning refresh: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.094Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] NetworkInterfaceRefreshOperation: Network devices located:: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.094Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] NetworkInterfaceRefreshOperation: Current resource set from state:: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] NetworkInterfaceRefreshOperation: 0 devices over a 0 unit range: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] NetworkInterfaceRefreshOperation: Looking for freshly-created resources to read in: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] NetworkInterfaceRefreshOperation: Network devices after freshly-created device search:: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] NetworkInterfaceRefreshOperation: Resource set to write after freshly-created device search:: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] NetworkInterfaceRefreshOperation: Looking for devices known in state: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] NetworkInterfaceRefreshOperation: Resource set to write after known device search:: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] NetworkInterfaceRefreshOperation: Probable orphaned network interfaces:: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] NetworkInterfaceRefreshOperation: Adding orphaned devices: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] NetworkInterfaceRefreshOperation: Resource set to write after adding orphaned devices:: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] NetworkInterfaceRefreshOperation: Refresh operation complete, sending new resource set: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] CdromRefreshOperation: Beginning refresh: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] CdromRefreshOperation: CDROM devices located: cdrom-3002: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] CdromRefreshOperation: Current resource set from state: (key 3002 at ide:1:0): timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] CdromRefreshOperation: Looking for freshly-created resources to read in: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] CdromRefreshOperation: CDROM devices after freshly-created device search: cdrom-3002: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] CdromRefreshOperation: Resource set to write after freshly-created device search:: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] CdromRefreshOperation: Looking for devices known in state: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] IsVAppCdrom: Checking if CDROM is using a vApp ISO: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] IsVAppCdrom: ISO is name does not match vApp ISO naming pattern (<vmname>/_ovfenv-<vmname>.iso): apic-iso/pr-apic-mgr.nsb.local.iso: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] cdrom.0 (key 3002 at ide:1:0): Reading state: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] FindVirtualDevice: Looking for device with key 3002: timestamp=2022-08-05T19:30:33.094Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] FindVirtualDevice: Device found: cdrom-3002: timestamp=2022-08-05T19:30:33.095Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] cdrom.0 (key 3002 at ide:1:0): Read finished (key and device address may have changed): timestamp=2022-08-05T19:30:33.095Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] CdromRefreshOperation: Resource set to write after known device search: (key 3002 at ide:1:0): timestamp=2022-08-05T19:30:33.095Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] CdromRefreshOperation: Probable orphaned CDROM devices:: timestamp=2022-08-05T19:30:33.095Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] CdromRefreshOperation: Resource set to write after adding orphaned devices: (key 3002 at ide:1:0): timestamp=2022-08-05T19:30:33.095Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] CdromRefreshOperation: Refresh operation complete, sending new resource set: timestamp=2022-08-05T19:30:33.095Z
2022-08-05T19:30:33.095Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] Reading tags for object "vm-47": timestamp=2022-08-05T19:30:33.095Z
2022-08-05T19:30:33.269Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] Tags for object "vm-47":: timestamp=2022-08-05T19:30:33.269Z
2022-08-05T19:30:33.269Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] vsphere_virtual_machine (ID = 4214742d-4ff5-4f15-b47b-8a7f1d4e1166): Checking guest networking state: timestamp=2022-08-05T19:30:33.269Z
2022-08-05T19:30:33.269Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] vsphere_virtual_machine (ID = 4214742d-4ff5-4f15-b47b-8a7f1d4e1166): No IP addresses found in guest state: timestamp=2022-08-05T19:30:33.269Z
2022-08-05T19:30:33.269Z [INFO]  provider.terraform-provider-vsphere_v2.2.0_x5: 2022/08/05 19:30:33 [DEBUG] vsphere_virtual_machine (ID = 4214742d-4ff5-4f15-b47b-8a7f1d4e1166): Read complete: timestamp=2022-08-05T19:30:33.269Z
2022-08-05T19:30:33.272Z [WARN]  Provider "provider[\"registry.terraform.io/hashicorp/vsphere\"]" produced an unexpected new value for vsphere_virtual_machine.management-vm, 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_reservation: was null, but now cty.NumberIntVal(0)
      - .cpu_performance_counters_enabled: was null, but now cty.False
      - .folder: was cty.StringVal("VMware-On-IBM-Cloud-VPC/vm/apic-vms"), but now cty.StringVal("apic-vms")
      - .sync_time_with_host_periodically: was null, but now cty.False
      - .vbs_enabled: was null, but now cty.False
      - .cpu_hot_remove_enabled: was null, but now cty.False
      - .cpu_reservation: was null, but now cty.NumberIntVal(0)
      - .run_tools_scripts_before_guest_reboot: was null, but now cty.False
      - .cpu_hot_add_enabled: was null, but now cty.False
      - .boot_delay: was null, but now cty.NumberIntVal(0)
      - .efi_secure_boot_enabled: was null, but now cty.False
      - .vvtd_enabled: was null, but now cty.False
      - .boot_retry_enabled: was null, but now cty.False
      - .sync_time_with_host: was null, but now cty.False
      - .alternate_guest_name: was null, but now cty.StringVal("")
      - .enable_logging: was null, but now cty.False
      - .memory_hot_add_enabled: was null, but now cty.False
      - .enable_disk_uuid: was null, but now cty.False
      - .cdrom[0].path: was cty.StringVal("/apic-iso/pr-apic-mgr.nsb.local.iso"), but now cty.StringVal("apic-iso/pr-apic-mgr.nsb.local.iso")
      - .cdrom[0].client_device: was null, but now cty.False
      - .ovf_deploy[0].remote_ovf_url: was null, but now cty.StringVal("")
2022-08-05T19:30:33.283Z [DEBUG] provider.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = transport is closing"
2022-08-05T19:30:33.296Z [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=99039
2022-08-05T19:30:33.296Z [DEBUG] provider: plugin exited