Skip to content

Instantly share code, notes, and snippets.

@kepi
Created January 13, 2024 11:00
Show Gist options
  • Save kepi/c8d8a8af6fe09cb05ec5bf9cafe01e0a to your computer and use it in GitHub Desktop.
Save kepi/c8d8a8af6fe09cb05ec5bf9cafe01e0a to your computer and use it in GitHub Desktop.
debug from terraform apply when creating virtual network resource
2024-01-13T11:57:06.486+0100 [INFO] Terraform version: 1.6.6
2024-01-13T11:57:06.486+0100 [DEBUG] using github.com/hashicorp/go-tfe v1.36.0
2024-01-13T11:57:06.486+0100 [DEBUG] using github.com/hashicorp/hcl/v2 v2.19.1
2024-01-13T11:57:06.486+0100 [DEBUG] using github.com/hashicorp/terraform-svchost v0.1.1
2024-01-13T11:57:06.486+0100 [DEBUG] using github.com/zclconf/go-cty v1.14.1
2024-01-13T11:57:06.486+0100 [INFO] Go runtime version: go1.21.5
2024-01-13T11:57:06.486+0100 [INFO] CLI args: []string{"terraform", "apply"}
2024-01-13T11:57:06.487+0100 [DEBUG] Attempting to open CLI config file: /home/ansible/.terraformrc
2024-01-13T11:57:06.487+0100 [DEBUG] File doesn't exist, but doesn't need to. Ignoring.
2024-01-13T11:57:06.487+0100 [DEBUG] ignoring non-existing provider search directory terraform.d/plugins
2024-01-13T11:57:06.487+0100 [DEBUG] ignoring non-existing provider search directory /home/ansible/.terraform.d/plugins
2024-01-13T11:57:06.487+0100 [DEBUG] ignoring non-existing provider search directory /home/ansible/.local/share/terraform/plugins
2024-01-13T11:57:06.487+0100 [DEBUG] ignoring non-existing provider search directory /usr/local/share/terraform/plugins
2024-01-13T11:57:06.487+0100 [DEBUG] ignoring non-existing provider search directory /usr/share/terraform/plugins
2024-01-13T11:57:06.487+0100 [INFO] CLI command args: []string{"apply"}
2024-01-13T11:57:06.489+0100 [DEBUG] New state was assigned lineage "f31ea2f9-1300-198d-3c77-2ee28aad8a61"
2024-01-13T11:57:06.615+0100 [DEBUG] checking for provisioner in "."
2024-01-13T11:57:06.620+0100 [DEBUG] checking for provisioner in "/usr/bin"
2024-01-13T11:57:06.621+0100 [INFO] backend/local: starting Apply operation
2024-01-13T11:57:06.623+0100 [DEBUG] created provider logger: level=debug
2024-01-13T11:57:06.623+0100 [INFO] provider: configuring client automatic mTLS
2024-01-13T11:57:06.640+0100 [DEBUG] provider: starting plugin: path=.terraform/providers/registry.terraform.io/opennebula/opennebula/1.3.1/linux_amd64/terraform-provider-opennebula_v1.3.1 args=[".terraform/providers/registry.terraform.io/opennebula/opennebula/1.3.1/linux_amd64/terraform-provider-opennebula_v1.3.1"]
2024-01-13T11:57:06.641+0100 [DEBUG] provider: plugin started: path=.terraform/providers/registry.terraform.io/opennebula/opennebula/1.3.1/linux_amd64/terraform-provider-opennebula_v1.3.1 pid=13985
2024-01-13T11:57:06.641+0100 [DEBUG] provider: waiting for RPC address: path=.terraform/providers/registry.terraform.io/opennebula/opennebula/1.3.1/linux_amd64/terraform-provider-opennebula_v1.3.1
2024-01-13T11:57:06.652+0100 [INFO] provider.terraform-provider-opennebula_v1.3.1: configuring server automatic mTLS: timestamp="2024-01-13T11:57:06.652+0100"
2024-01-13T11:57:06.679+0100 [DEBUG] provider: using plugin: version=5
2024-01-13T11:57:06.679+0100 [DEBUG] provider.terraform-provider-opennebula_v1.3.1: plugin address: address=/tmp/plugin3541217101 network=unix timestamp="2024-01-13T11:57:06.679+0100"
2024-01-13T11:57:06.734+0100 [DEBUG] provider.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = error reading from server: EOF"
2024-01-13T11:57:06.736+0100 [DEBUG] provider: plugin process exited: path=.terraform/providers/registry.terraform.io/opennebula/opennebula/1.3.1/linux_amd64/terraform-provider-opennebula_v1.3.1 pid=13985
2024-01-13T11:57:06.736+0100 [DEBUG] provider: plugin exited
2024-01-13T11:57:06.736+0100 [DEBUG] Building and walking validate graph
2024-01-13T11:57:06.736+0100 [DEBUG] ProviderTransformer: "opennebula_virtual_network.reproduce" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/opennebula/opennebula"]
2024-01-13T11:57:06.737+0100 [DEBUG] ReferenceTransformer: "opennebula_virtual_network.reproduce" references: []
2024-01-13T11:57:06.737+0100 [DEBUG] ReferenceTransformer: "var.one_endpoint" references: []
2024-01-13T11:57:06.737+0100 [DEBUG] ReferenceTransformer: "var.one_username" references: []
2024-01-13T11:57:06.737+0100 [DEBUG] ReferenceTransformer: "var.one_password" references: []
2024-01-13T11:57:06.737+0100 [DEBUG] ReferenceTransformer: "var.one_flow_endpoint" references: []
2024-01-13T11:57:06.737+0100 [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/opennebula/opennebula\"]" references: [var.one_flow_endpoint var.one_password var.one_username var.one_endpoint]
2024-01-13T11:57:06.737+0100 [DEBUG] Starting graph walk: walkValidate
2024-01-13T11:57:06.738+0100 [DEBUG] created provider logger: level=debug
2024-01-13T11:57:06.738+0100 [INFO] provider: configuring client automatic mTLS
2024-01-13T11:57:06.745+0100 [DEBUG] provider: starting plugin: path=.terraform/providers/registry.terraform.io/opennebula/opennebula/1.3.1/linux_amd64/terraform-provider-opennebula_v1.3.1 args=[".terraform/providers/registry.terraform.io/opennebula/opennebula/1.3.1/linux_amd64/terraform-provider-opennebula_v1.3.1"]
2024-01-13T11:57:06.745+0100 [DEBUG] provider: plugin started: path=.terraform/providers/registry.terraform.io/opennebula/opennebula/1.3.1/linux_amd64/terraform-provider-opennebula_v1.3.1 pid=13998
2024-01-13T11:57:06.745+0100 [DEBUG] provider: waiting for RPC address: path=.terraform/providers/registry.terraform.io/opennebula/opennebula/1.3.1/linux_amd64/terraform-provider-opennebula_v1.3.1
2024-01-13T11:57:06.756+0100 [INFO] provider.terraform-provider-opennebula_v1.3.1: configuring server automatic mTLS: timestamp="2024-01-13T11:57:06.756+0100"
2024-01-13T11:57:06.785+0100 [DEBUG] provider: using plugin: version=5
2024-01-13T11:57:06.785+0100 [DEBUG] provider.terraform-provider-opennebula_v1.3.1: plugin address: address=/tmp/plugin1275748094 network=unix timestamp="2024-01-13T11:57:06.785+0100"
2024-01-13T11:57:06.834+0100 [DEBUG] provider.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = error reading from server: EOF"
2024-01-13T11:57:06.836+0100 [DEBUG] provider: plugin process exited: path=.terraform/providers/registry.terraform.io/opennebula/opennebula/1.3.1/linux_amd64/terraform-provider-opennebula_v1.3.1 pid=13998
2024-01-13T11:57:06.836+0100 [DEBUG] provider: plugin exited
2024-01-13T11:57:06.836+0100 [INFO] backend/local: apply calling Plan
2024-01-13T11:57:06.836+0100 [DEBUG] Building and walking plan graph for NormalMode
2024-01-13T11:57:06.847+0100 [DEBUG] ProviderTransformer: "opennebula_virtual_network.reproduce (expand)" (*terraform.nodeExpandPlannableResource) needs provider["registry.terraform.io/opennebula/opennebula"]
2024-01-13T11:57:06.847+0100 [DEBUG] ReferenceTransformer: "var.one_password" references: []
2024-01-13T11:57:06.847+0100 [DEBUG] ReferenceTransformer: "var.one_flow_endpoint" references: []
2024-01-13T11:57:06.847+0100 [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/opennebula/opennebula\"]" references: [var.one_password var.one_username var.one_endpoint var.one_flow_endpoint]
2024-01-13T11:57:06.847+0100 [DEBUG] ReferenceTransformer: "opennebula_virtual_network.reproduce (expand)" references: []
2024-01-13T11:57:06.847+0100 [DEBUG] ReferenceTransformer: "var.one_endpoint" references: []
2024-01-13T11:57:06.847+0100 [DEBUG] ReferenceTransformer: "var.one_username" references: []
2024-01-13T11:57:06.848+0100 [DEBUG] Starting graph walk: walkPlan
2024-01-13T11:57:06.849+0100 [DEBUG] created provider logger: level=debug
2024-01-13T11:57:06.849+0100 [INFO] provider: configuring client automatic mTLS
2024-01-13T11:57:06.856+0100 [DEBUG] provider: starting plugin: path=.terraform/providers/registry.terraform.io/opennebula/opennebula/1.3.1/linux_amd64/terraform-provider-opennebula_v1.3.1 args=[".terraform/providers/registry.terraform.io/opennebula/opennebula/1.3.1/linux_amd64/terraform-provider-opennebula_v1.3.1"]
2024-01-13T11:57:06.856+0100 [DEBUG] provider: plugin started: path=.terraform/providers/registry.terraform.io/opennebula/opennebula/1.3.1/linux_amd64/terraform-provider-opennebula_v1.3.1 pid=14009
2024-01-13T11:57:06.856+0100 [DEBUG] provider: waiting for RPC address: path=.terraform/providers/registry.terraform.io/opennebula/opennebula/1.3.1/linux_amd64/terraform-provider-opennebula_v1.3.1
2024-01-13T11:57:06.871+0100 [INFO] provider.terraform-provider-opennebula_v1.3.1: configuring server automatic mTLS: timestamp="2024-01-13T11:57:06.871+0100"
2024-01-13T11:57:06.898+0100 [DEBUG] provider.terraform-provider-opennebula_v1.3.1: plugin address: address=/tmp/plugin1523695386 network=unix timestamp="2024-01-13T11:57:06.898+0100"
2024-01-13T11:57:06.899+0100 [DEBUG] provider: using plugin: version=5
2024-01-13T11:57:06.948+0100 [WARN] ValidateProviderConfig from "provider[\"registry.terraform.io/opennebula/opennebula\"]" changed the config value, but that value is unused
2024-01-13T11:57:06.992+0100 [INFO] provider.terraform-provider-opennebula_v1.3.1: 2024/01/13 11:57:06 [INFO] OpenNebula version: 6.6.1.1: timestamp="2024-01-13T11:57:06.992+0100"
2024-01-13T11:57:06.993+0100 [DEBUG] Resource instance state not found for node "opennebula_virtual_network.reproduce", instance opennebula_virtual_network.reproduce
2024-01-13T11:57:06.993+0100 [DEBUG] ReferenceTransformer: "opennebula_virtual_network.reproduce" references: []
2024-01-13T11:57:06.994+0100 [DEBUG] refresh: opennebula_virtual_network.reproduce: no state, so not refreshing
2024-01-13T11:57:07.022+0100 [WARN] Provider "registry.terraform.io/opennebula/opennebula" produced an invalid plan for opennebula_virtual_network.reproduce, 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:
- .mtu: planned value cty.NumberIntVal(1500) for a non-computed attribute
- .reservation_ar_id: planned value cty.NumberIntVal(-1) for a non-computed attribute
- .reservation_vnet: planned value cty.NumberIntVal(-1) for a non-computed attribute
- .guest_mtu: planned value cty.NumberIntVal(1500) for a non-computed attribute
2024-01-13T11:57:07.024+0100 [DEBUG] provider.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = error reading from server: EOF"
2024-01-13T11:57:07.028+0100 [DEBUG] provider: plugin process exited: path=.terraform/providers/registry.terraform.io/opennebula/opennebula/1.3.1/linux_amd64/terraform-provider-opennebula_v1.3.1 pid=14009
2024-01-13T11:57:07.028+0100 [DEBUG] provider: plugin exited
2024-01-13T11:57:07.028+0100 [DEBUG] building apply graph to check for errors
2024-01-13T11:57:07.028+0100 [DEBUG] Resource state not found for node "opennebula_virtual_network.reproduce", instance opennebula_virtual_network.reproduce
2024-01-13T11:57:07.028+0100 [DEBUG] ProviderTransformer: "opennebula_virtual_network.reproduce" (*terraform.NodeApplyableResourceInstance) needs provider["registry.terraform.io/opennebula/opennebula"]
2024-01-13T11:57:07.028+0100 [DEBUG] ProviderTransformer: "opennebula_virtual_network.reproduce (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/opennebula/opennebula"]
2024-01-13T11:57:07.029+0100 [DEBUG] ReferenceTransformer: "var.one_flow_endpoint" references: []
2024-01-13T11:57:07.029+0100 [DEBUG] ReferenceTransformer: "opennebula_virtual_network.reproduce" references: []
2024-01-13T11:57:07.029+0100 [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/opennebula/opennebula\"]" references: [var.one_username var.one_endpoint var.one_flow_endpoint var.one_password]
2024-01-13T11:57:07.029+0100 [DEBUG] ReferenceTransformer: "opennebula_virtual_network.reproduce (expand)" references: []
2024-01-13T11:57:07.029+0100 [DEBUG] ReferenceTransformer: "var.one_endpoint" references: []
2024-01-13T11:57:07.029+0100 [DEBUG] ReferenceTransformer: "var.one_username" references: []
2024-01-13T11:57:07.029+0100 [DEBUG] ReferenceTransformer: "var.one_password" references: []
2024-01-13T11:57:07.031+0100 [DEBUG] command: asking for input: "\nDo you want to perform these actions?"
2024-01-13T11:57:08.515+0100 [INFO] backend/local: apply calling Apply
2024-01-13T11:57:08.515+0100 [DEBUG] Building and walking apply graph for NormalMode plan
2024-01-13T11:57:08.515+0100 [DEBUG] Resource state not found for node "opennebula_virtual_network.reproduce", instance opennebula_virtual_network.reproduce
2024-01-13T11:57:08.515+0100 [DEBUG] ProviderTransformer: "opennebula_virtual_network.reproduce (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/opennebula/opennebula"]
2024-01-13T11:57:08.515+0100 [DEBUG] ProviderTransformer: "opennebula_virtual_network.reproduce" (*terraform.NodeApplyableResourceInstance) needs provider["registry.terraform.io/opennebula/opennebula"]
2024-01-13T11:57:08.515+0100 [DEBUG] ReferenceTransformer: "var.one_flow_endpoint" references: []
2024-01-13T11:57:08.515+0100 [DEBUG] ReferenceTransformer: "var.one_endpoint" references: []
2024-01-13T11:57:08.515+0100 [DEBUG] ReferenceTransformer: "var.one_username" references: []
2024-01-13T11:57:08.516+0100 [DEBUG] ReferenceTransformer: "opennebula_virtual_network.reproduce" references: []
2024-01-13T11:57:08.516+0100 [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/opennebula/opennebula\"]" references: [var.one_password var.one_username var.one_endpoint var.one_flow_endpoint]
2024-01-13T11:57:08.516+0100 [DEBUG] ReferenceTransformer: "opennebula_virtual_network.reproduce (expand)" references: []
2024-01-13T11:57:08.516+0100 [DEBUG] ReferenceTransformer: "var.one_password" references: []
2024-01-13T11:57:08.516+0100 [DEBUG] Starting graph walk: walkApply
2024-01-13T11:57:08.516+0100 [DEBUG] created provider logger: level=debug
2024-01-13T11:57:08.517+0100 [INFO] provider: configuring client automatic mTLS
2024-01-13T11:57:08.524+0100 [DEBUG] provider: starting plugin: path=.terraform/providers/registry.terraform.io/opennebula/opennebula/1.3.1/linux_amd64/terraform-provider-opennebula_v1.3.1 args=[".terraform/providers/registry.terraform.io/opennebula/opennebula/1.3.1/linux_amd64/terraform-provider-opennebula_v1.3.1"]
2024-01-13T11:57:08.525+0100 [DEBUG] provider: plugin started: path=.terraform/providers/registry.terraform.io/opennebula/opennebula/1.3.1/linux_amd64/terraform-provider-opennebula_v1.3.1 pid=14022
2024-01-13T11:57:08.525+0100 [DEBUG] provider: waiting for RPC address: path=.terraform/providers/registry.terraform.io/opennebula/opennebula/1.3.1/linux_amd64/terraform-provider-opennebula_v1.3.1
2024-01-13T11:57:08.548+0100 [INFO] provider.terraform-provider-opennebula_v1.3.1: configuring server automatic mTLS: timestamp="2024-01-13T11:57:08.547+0100"
2024-01-13T11:57:08.576+0100 [DEBUG] provider: using plugin: version=5
2024-01-13T11:57:08.576+0100 [DEBUG] provider.terraform-provider-opennebula_v1.3.1: plugin address: address=/tmp/plugin1846128475 network=unix timestamp="2024-01-13T11:57:08.576+0100"
2024-01-13T11:57:08.615+0100 [WARN] ValidateProviderConfig from "provider[\"registry.terraform.io/opennebula/opennebula\"]" changed the config value, but that value is unused
2024-01-13T11:57:08.658+0100 [INFO] provider.terraform-provider-opennebula_v1.3.1: 2024/01/13 11:57:08 [INFO] OpenNebula version: 6.6.1.1: timestamp="2024-01-13T11:57:08.658+0100"
2024-01-13T11:57:08.667+0100 [WARN] Provider "registry.terraform.io/opennebula/opennebula" produced an invalid plan for opennebula_virtual_network.reproduce, 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:
- .reservation_ar_id: planned value cty.NumberIntVal(-1) for a non-computed attribute
- .reservation_vnet: planned value cty.NumberIntVal(-1) for a non-computed attribute
- .mtu: planned value cty.NumberIntVal(1500) for a non-computed attribute
- .guest_mtu: planned value cty.NumberIntVal(1500) for a non-computed attribute
2024-01-13T11:57:08.668+0100 [INFO] Starting apply for opennebula_virtual_network.reproduce
2024-01-13T11:57:08.668+0100 [DEBUG] opennebula_virtual_network.reproduce: applying the planned Create change
2024-01-13T11:57:08.670+0100 [INFO] provider.terraform-provider-opennebula_v1.3.1: 2024/01/13 11:57:08 [DEBUG] setting computed for "tags_all" from ComputedKeys: timestamp="2024-01-13T11:57:08.670+0100"
2024-01-13T11:57:08.670+0100 [INFO] provider.terraform-provider-opennebula_v1.3.1: 2024/01/13 11:57:08 [DEBUG] setting computed for "security_groups" from ComputedKeys: timestamp="2024-01-13T11:57:08.670+0100"
2024-01-13T11:57:08.670+0100 [INFO] provider.terraform-provider-opennebula_v1.3.1: 2024/01/13 11:57:08 [DEBUG] setting computed for "default_tags" from ComputedKeys: timestamp="2024-01-13T11:57:08.670+0100"
2024-01-13T11:57:08.670+0100 [INFO] provider.terraform-provider-opennebula_v1.3.1: 2024/01/13 11:57:08 [INFO] VNET definition: NAME="reproduce-public"
VN_MAD="ovswitch"
BRIDGE="ovs-pub": timestamp="2024-01-13T11:57:08.670+0100"
2024-01-13T11:57:08.870+0100 [INFO] provider.terraform-provider-opennebula_v1.3.1: 2024/01/13 11:57:08 [DEBUG] Waiting for state to become: [READY]: timestamp="2024-01-13T11:57:08.870+0100"
2024-01-13T11:57:13.871+0100 [INFO] provider.terraform-provider-opennebula_v1.3.1: 2024/01/13 11:57:13 Refreshing virtual network state...: timestamp="2024-01-13T11:57:13.871+0100"
2024-01-13T11:57:13.890+0100 [INFO] provider.terraform-provider-opennebula_v1.3.1: 2024/01/13 11:57:13 virtual network (ID:77, name:reproduce-public) is currently in state READY: timestamp="2024-01-13T11:57:13.890+0100"
2024-01-13T11:57:14.225+0100 [INFO] provider.terraform-provider-opennebula_v1.3.1: 2024/01/13 11:57:13 [INFO] VNET template: MTU="1500"
GUEST_MTU="1500"
DNS="10.128.2.1"
GATEWAY="10.128.2.1": timestamp="2024-01-13T11:57:13.890+0100"
2024-01-13T11:57:14.225+0100 [INFO] provider.terraform-provider-opennebula_v1.3.1: 2024/01/13 11:57:13 [INFO] ARs: []: timestamp="2024-01-13T11:57:13.942+0100"
2024-01-13T11:57:14.225+0100 [INFO] provider.terraform-provider-opennebula_v1.3.1: 2024/01/13 11:57:13 [INFO] ARConfigs: []: timestamp="2024-01-13T11:57:13.942+0100"
2024-01-13T11:57:13.944+0100 [WARN] Provider "provider[\"registry.terraform.io/opennebula/opennebula\"]" produced an unexpected new value for opennebula_virtual_network.reproduce, 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:
- .network_address: was null, but now cty.StringVal("")
- .reservation_first_ip: was null, but now cty.StringVal("")
- .network_mask: was null, but now cty.StringVal("")
- .reservation_size: was null, but now cty.NumberIntVal(0)
- .search_domain: was null, but now cty.StringVal("")
- .description: was null, but now cty.StringVal("")
2024-01-13T11:57:14.289+0100 [DEBUG] State storage *statemgr.Filesystem declined to persist a state snapshot
2024-01-13T11:57:14.290+0100 [DEBUG] provider.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = error reading from server: EOF"
2024-01-13T11:57:14.302+0100 [DEBUG] provider: plugin process exited: path=.terraform/providers/registry.terraform.io/opennebula/opennebula/1.3.1/linux_amd64/terraform-provider-opennebula_v1.3.1 pid=14022
2024-01-13T11:57:14.302+0100 [DEBUG] provider: plugin exited
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment