Skip to content

Instantly share code, notes, and snippets.

@damonconway
Created April 13, 2021 15:47
Show Gist options
  • Save damonconway/1d3a3675baa333a6564a0846e39a5efe to your computer and use it in GitHub Desktop.
Save damonconway/1d3a3675baa333a6564a0846e39a5efe to your computer and use it in GitHub Desktop.
Terraform trace showing buggy element implementation
2021-04-13T10:44:35.309-0500 [DEBUG] Adding temp file log sink: /var/folders/mf/5139pykx5bn88h5fxswjym4h0000gn/T/terraform-log451205439
2021-04-13T10:44:35.309-0500 [INFO] Terraform version: 0.15.0 rc2
2021-04-13T10:44:35.309-0500 [INFO] Go runtime version: go1.16.2
2021-04-13T10:44:35.309-0500 [INFO] CLI args: []string{"/usr/local/Cellar/tfenv/2.2.0/versions/0.15.0-rc2/terraform", "plan"}
2021-04-13T10:44:35.309-0500 [TRACE] Stdout is not a terminal
2021-04-13T10:44:35.309-0500 [TRACE] Stderr is not a terminal
2021-04-13T10:44:35.309-0500 [TRACE] Stdin is a terminal
2021-04-13T10:44:35.309-0500 [DEBUG] Attempting to open CLI config file: /Users/damonconway/.terraformrc
2021-04-13T10:44:35.309-0500 [DEBUG] File doesn't exist, but doesn't need to. Ignoring.
2021-04-13T10:44:35.309-0500 [DEBUG] checking for credentials in "/Users/damonconway/.terraform.d/plugins"
2021-04-13T10:44:35.309-0500 [DEBUG] checking for credentials in "/Users/damonconway/.terraform.d/plugins/darwin_amd64"
2021-04-13T10:44:35.309-0500 [DEBUG] ignoring non-existing provider search directory terraform.d/plugins
2021-04-13T10:44:35.309-0500 [DEBUG] will search for provider plugins in /Users/damonconway/.terraform.d/plugins
2021-04-13T10:44:35.310-0500 [DEBUG] ignoring non-existing provider search directory /Users/damonconway/Library/Application Support/io.terraform/plugins
2021-04-13T10:44:35.310-0500 [DEBUG] ignoring non-existing provider search directory /Library/Application Support/io.terraform/plugins
2021-04-13T10:44:35.310-0500 [INFO] CLI command args: []string{"plan"}
2021-04-13T10:44:35.311-0500 [TRACE] Meta.Backend: no config given or present on disk, so returning nil config
2021-04-13T10:44:35.311-0500 [TRACE] Meta.Backend: backend has not previously been initialized in this working directory
2021-04-13T10:44:35.311-0500 [DEBUG] New state was assigned lineage "927172f0-b9c9-4284-ba12-5f9051fad2b3"
2021-04-13T10:44:35.311-0500 [TRACE] Meta.Backend: using default local state only (no backend configuration, and no existing initialized backend)
2021-04-13T10:44:35.311-0500 [TRACE] Meta.Backend: instantiated backend of type <nil>
2021-04-13T10:44:35.311-0500 [TRACE] providercache.fillMetaCache: scanning directory .terraform/providers
2021-04-13T10:44:35.312-0500 [TRACE] getproviders.SearchLocalDirectory: found registry.terraform.io/hashicorp/template v2.2.0 for darwin_amd64 at .terraform/providers/registry.terraform.io/hashicorp/template/2.2.0/darwin_amd64
2021-04-13T10:44:35.312-0500 [TRACE] providercache.fillMetaCache: including .terraform/providers/registry.terraform.io/hashicorp/template/2.2.0/darwin_amd64 as a candidate package for registry.terraform.io/hashicorp/template 2.2.0
2021-04-13T10:44:35.368-0500 [DEBUG] checking for provisioner in "."
2021-04-13T10:44:35.368-0500 [DEBUG] checking for provisioner in "/usr/local/Cellar/tfenv/2.2.0/versions/0.15.0-rc2"
2021-04-13T10:44:35.368-0500 [DEBUG] checking for provisioner in "/Users/damonconway/.terraform.d/plugins"
2021-04-13T10:44:35.368-0500 [DEBUG] checking for provisioner in "/Users/damonconway/.terraform.d/plugins/darwin_amd64"
2021-04-13T10:44:35.369-0500 [INFO] Failed to read plugin lock file .terraform/plugins/darwin_amd64/lock.json: open .terraform/plugins/darwin_amd64/lock.json: no such file or directory
2021-04-13T10:44:35.369-0500 [TRACE] Meta.Backend: backend <nil> does not support operations, so wrapping it in a local backend
2021-04-13T10:44:35.369-0500 [INFO] backend/local: starting Plan operation
2021-04-13T10:44:35.369-0500 [TRACE] backend/local: requesting state manager for workspace "default"
2021-04-13T10:44:35.369-0500 [TRACE] backend/local: state manager for workspace "default" will:
- read initial snapshot from terraform.tfstate
- write new snapshots to terraform.tfstate
- create any backup at terraform.tfstate.backup
2021-04-13T10:44:35.369-0500 [TRACE] backend/local: requesting state lock for workspace "default"
2021-04-13T10:44:35.369-0500 [TRACE] statemgr.Filesystem: preparing to manage state snapshots at terraform.tfstate
2021-04-13T10:44:35.369-0500 [TRACE] statemgr.Filesystem: no previously-stored snapshot exists
2021-04-13T10:44:35.369-0500 [TRACE] statemgr.Filesystem: locking terraform.tfstate using fcntl flock
2021-04-13T10:44:35.369-0500 [TRACE] statemgr.Filesystem: writing lock metadata to .terraform.tfstate.lock.info
2021-04-13T10:44:35.369-0500 [TRACE] backend/local: reading remote state for workspace "default"
2021-04-13T10:44:35.369-0500 [TRACE] statemgr.Filesystem: reading latest snapshot from terraform.tfstate
2021-04-13T10:44:35.369-0500 [TRACE] statemgr.Filesystem: snapshot file has nil snapshot, but that's okay
2021-04-13T10:44:35.369-0500 [TRACE] statemgr.Filesystem: read nil snapshot
2021-04-13T10:44:35.369-0500 [TRACE] backend/local: retrieving local state snapshot for workspace "default"
2021-04-13T10:44:35.369-0500 [TRACE] backend/local: building context for current working directory
2021-04-13T10:44:35.370-0500 [TRACE] terraform.NewContext: starting
2021-04-13T10:44:35.370-0500 [TRACE] terraform.NewContext: loading provider schemas
2021-04-13T10:44:35.370-0500 [TRACE] LoadSchemas: retrieving schema for provider type "registry.terraform.io/hashicorp/template"
2021-04-13T10:44:35.370-0500 [DEBUG] created provider logger: level=trace
2021-04-13T10:44:35.370-0500 [INFO] provider: configuring client automatic mTLS
2021-04-13T10:44:35.400-0500 [DEBUG] provider: starting plugin: path=.terraform/providers/registry.terraform.io/hashicorp/template/2.2.0/darwin_amd64/terraform-provider-template_v2.2.0_x4 args=[.terraform/providers/registry.terraform.io/hashicorp/template/2.2.0/darwin_amd64/terraform-provider-template_v2.2.0_x4]
2021-04-13T10:44:35.402-0500 [DEBUG] provider: plugin started: path=.terraform/providers/registry.terraform.io/hashicorp/template/2.2.0/darwin_amd64/terraform-provider-template_v2.2.0_x4 pid=81827
2021-04-13T10:44:35.403-0500 [DEBUG] provider: waiting for RPC address: path=.terraform/providers/registry.terraform.io/hashicorp/template/2.2.0/darwin_amd64/terraform-provider-template_v2.2.0_x4
2021-04-13T10:44:35.412-0500 [INFO] provider.terraform-provider-template_v2.2.0_x4: configuring server automatic mTLS: timestamp=2021-04-13T10:44:35.411-0500
2021-04-13T10:44:35.442-0500 [DEBUG] provider.terraform-provider-template_v2.2.0_x4: plugin address: address=/var/folders/mf/5139pykx5bn88h5fxswjym4h0000gn/T/plugin679545518 network=unix timestamp=2021-04-13T10:44:35.441-0500
2021-04-13T10:44:35.442-0500 [DEBUG] provider: using plugin: version=5
2021-04-13T10:44:35.488-0500 [TRACE] GRPCProvider: GetProviderSchema
2021-04-13T10:44:35.488-0500 [TRACE] provider.stdio: waiting for stdio data
2021-04-13T10:44:35.490-0500 [DEBUG] provider.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2021-04-13T10:44:35.490-0500 [DEBUG] No provider meta schema returned
2021-04-13T10:44:35.490-0500 [TRACE] GRPCProvider: Close
2021-04-13T10:44:35.491-0500 [DEBUG] provider: plugin process exited: path=.terraform/providers/registry.terraform.io/hashicorp/template/2.2.0/darwin_amd64/terraform-provider-template_v2.2.0_x4 pid=81827
2021-04-13T10:44:35.491-0500 [DEBUG] provider: plugin exited
2021-04-13T10:44:35.491-0500 [TRACE] terraform.NewContext: complete
2021-04-13T10:44:35.491-0500 [TRACE] backend/local: finished building terraform.Context
2021-04-13T10:44:35.491-0500 [TRACE] backend/local: requesting interactive input, if necessary
2021-04-13T10:44:35.491-0500 [TRACE] Context.Input: Prompting for provider arguments
2021-04-13T10:44:35.492-0500 [TRACE] Context.Input: Provider provider.template implied by data block at main.tf:1,1-29
2021-04-13T10:44:35.492-0500 [TRACE] Context.Input: Input for provider.template: map[string]cty.Value{}
2021-04-13T10:44:35.492-0500 [TRACE] backend/local: running validation operation
2021-04-13T10:44:35.492-0500 [INFO] terraform: building graph: GraphTypeValidate
2021-04-13T10:44:35.492-0500 [TRACE] Executing graph transform *terraform.ConfigTransformer
2021-04-13T10:44:35.492-0500 [TRACE] ConfigTransformer: Starting for path:
2021-04-13T10:44:35.492-0500 [TRACE] Completed graph transform *terraform.ConfigTransformer with new graph:
data.template_file.test1 - *terraform.NodeValidatableResource
data.template_file.test2 - *terraform.NodeValidatableResource
------
2021-04-13T10:44:35.492-0500 [TRACE] Executing graph transform *terraform.RootVariableTransformer
2021-04-13T10:44:35.492-0500 [TRACE] Completed graph transform *terraform.RootVariableTransformer (no changes)
2021-04-13T10:44:35.492-0500 [TRACE] Executing graph transform *terraform.ModuleVariableTransformer
2021-04-13T10:44:35.492-0500 [TRACE] Completed graph transform *terraform.ModuleVariableTransformer (no changes)
2021-04-13T10:44:35.492-0500 [TRACE] Executing graph transform *terraform.LocalTransformer
2021-04-13T10:44:35.492-0500 [TRACE] Completed graph transform *terraform.LocalTransformer (no changes)
2021-04-13T10:44:35.492-0500 [TRACE] Executing graph transform *terraform.OutputTransformer
2021-04-13T10:44:35.492-0500 [TRACE] Completed graph transform *terraform.OutputTransformer (no changes)
2021-04-13T10:44:35.492-0500 [TRACE] Executing graph transform *terraform.OrphanResourceInstanceTransformer
2021-04-13T10:44:35.492-0500 [TRACE] Completed graph transform *terraform.OrphanResourceInstanceTransformer (no changes)
2021-04-13T10:44:35.492-0500 [TRACE] Executing graph transform *terraform.StateTransformer
2021-04-13T10:44:35.492-0500 [TRACE] StateTransformer: state is empty, so nothing to do
2021-04-13T10:44:35.492-0500 [TRACE] Completed graph transform *terraform.StateTransformer (no changes)
2021-04-13T10:44:35.492-0500 [TRACE] Executing graph transform *terraform.AttachStateTransformer
2021-04-13T10:44:35.492-0500 [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2021-04-13T10:44:35.492-0500 [TRACE] Executing graph transform *terraform.OrphanOutputTransformer
2021-04-13T10:44:35.492-0500 [TRACE] Completed graph transform *terraform.OrphanOutputTransformer (no changes)
2021-04-13T10:44:35.492-0500 [TRACE] Executing graph transform *terraform.AttachResourceConfigTransformer
2021-04-13T10:44:35.492-0500 [TRACE] AttachResourceConfigTransformer: attaching to "data.template_file.test1" (*terraform.NodeValidatableResource) config from hcl.Range{Filename:"main.tf", Start:hcl.Pos{Line:1, Column:1, Byte:0}, End:hcl.Pos{Line:1, Column:29, Byte:28}}
2021-04-13T10:44:35.492-0500 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to data.template_file.test1
2021-04-13T10:44:35.492-0500 [TRACE] AttachResourceConfigTransformer: attaching to "data.template_file.test2" (*terraform.NodeValidatableResource) config from hcl.Range{Filename:"main.tf", Start:hcl.Pos{Line:8, Column:1, Byte:97}, End:hcl.Pos{Line:8, Column:29, Byte:125}}
2021-04-13T10:44:35.492-0500 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to data.template_file.test2
2021-04-13T10:44:35.492-0500 [TRACE] Completed graph transform *terraform.AttachResourceConfigTransformer (no changes)
2021-04-13T10:44:35.492-0500 [TRACE] Executing graph transform *terraform.graphTransformerMulti
2021-04-13T10:44:35.492-0500 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderConfigTransformer
2021-04-13T10:44:35.492-0500 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderConfigTransformer with new graph:
data.template_file.test1 - *terraform.NodeValidatableResource
data.template_file.test2 - *terraform.NodeValidatableResource
------
2021-04-13T10:44:35.492-0500 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.MissingProviderTransformer
2021-04-13T10:44:35.492-0500 [DEBUG] adding implicit provider configuration provider["registry.terraform.io/hashicorp/template"], implied first by data.template_file.test1
2021-04-13T10:44:35.492-0500 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.MissingProviderTransformer with new graph:
data.template_file.test1 - *terraform.NodeValidatableResource
data.template_file.test2 - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
------
2021-04-13T10:44:35.492-0500 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderTransformer
2021-04-13T10:44:35.492-0500 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/template"] serving data.template_file.test1
2021-04-13T10:44:35.492-0500 [DEBUG] ProviderTransformer: "data.template_file.test1" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/hashicorp/template"]
2021-04-13T10:44:35.492-0500 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/template"] serving data.template_file.test2
2021-04-13T10:44:35.492-0500 [DEBUG] ProviderTransformer: "data.template_file.test2" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/hashicorp/template"]
2021-04-13T10:44:35.492-0500 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderTransformer with new graph:
data.template_file.test1 - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
data.template_file.test2 - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
------
2021-04-13T10:44:35.492-0500 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.PruneProviderTransformer
2021-04-13T10:44:35.492-0500 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.PruneProviderTransformer (no changes)
2021-04-13T10:44:35.492-0500 [TRACE] Completed graph transform *terraform.graphTransformerMulti with new graph:
data.template_file.test1 - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
data.template_file.test2 - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
------
2021-04-13T10:44:35.492-0500 [TRACE] Executing graph transform *terraform.RemovedModuleTransformer
2021-04-13T10:44:35.492-0500 [TRACE] Completed graph transform *terraform.RemovedModuleTransformer (no changes)
2021-04-13T10:44:35.492-0500 [TRACE] Executing graph transform *terraform.AttachSchemaTransformer
2021-04-13T10:44:35.492-0500 [TRACE] AttachSchemaTransformer: attaching provider config schema to provider["registry.terraform.io/hashicorp/template"]
2021-04-13T10:44:35.492-0500 [TRACE] AttachSchemaTransformer: attaching resource schema to data.template_file.test1
2021-04-13T10:44:35.492-0500 [TRACE] AttachSchemaTransformer: attaching resource schema to data.template_file.test2
2021-04-13T10:44:35.492-0500 [TRACE] Completed graph transform *terraform.AttachSchemaTransformer (no changes)
2021-04-13T10:44:35.492-0500 [TRACE] Executing graph transform *terraform.ModuleExpansionTransformer
2021-04-13T10:44:35.492-0500 [TRACE] Completed graph transform *terraform.ModuleExpansionTransformer (no changes)
2021-04-13T10:44:35.492-0500 [TRACE] Executing graph transform *terraform.ReferenceTransformer
2021-04-13T10:44:35.492-0500 [DEBUG] ReferenceTransformer: "data.template_file.test1" references: []
2021-04-13T10:44:35.492-0500 [INFO] ReferenceTransformer: reference not found: "count.index"
2021-04-13T10:44:35.492-0500 [DEBUG] ReferenceTransformer: "data.template_file.test2" references: [data.template_file.test1]
2021-04-13T10:44:35.492-0500 [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/template\"]" references: []
2021-04-13T10:44:35.492-0500 [TRACE] Completed graph transform *terraform.ReferenceTransformer with new graph:
data.template_file.test1 - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
data.template_file.test2 - *terraform.NodeValidatableResource
data.template_file.test1 - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
------
2021-04-13T10:44:35.492-0500 [TRACE] Executing graph transform *terraform.AttachDependenciesTransformer
2021-04-13T10:44:35.492-0500 [TRACE] Completed graph transform *terraform.AttachDependenciesTransformer (no changes)
2021-04-13T10:44:35.492-0500 [TRACE] Executing graph transform *terraform.attachDataResourceDependsOnTransformer
2021-04-13T10:44:35.492-0500 [TRACE] attachDataDependenciesTransformer: data.template_file.test1 depends on []
2021-04-13T10:44:35.493-0500 [TRACE] attachDataDependenciesTransformer: data.template_file.test2 depends on []
2021-04-13T10:44:35.493-0500 [TRACE] Completed graph transform *terraform.attachDataResourceDependsOnTransformer (no changes)
2021-04-13T10:44:35.493-0500 [TRACE] Executing graph transform *terraform.TargetsTransformer
2021-04-13T10:44:35.493-0500 [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2021-04-13T10:44:35.493-0500 [TRACE] Executing graph transform *terraform.ForcedCBDTransformer
2021-04-13T10:44:35.493-0500 [TRACE] Completed graph transform *terraform.ForcedCBDTransformer (no changes)
2021-04-13T10:44:35.493-0500 [TRACE] Executing graph transform *terraform.CountBoundaryTransformer
2021-04-13T10:44:35.493-0500 [TRACE] Completed graph transform *terraform.CountBoundaryTransformer with new graph:
data.template_file.test1 - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
data.template_file.test2 - *terraform.NodeValidatableResource
data.template_file.test1 - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.template_file.test1 - *terraform.NodeValidatableResource
data.template_file.test2 - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
------
2021-04-13T10:44:35.493-0500 [TRACE] Executing graph transform *terraform.CloseProviderTransformer
2021-04-13T10:44:35.493-0500 [TRACE] Completed graph transform *terraform.CloseProviderTransformer with new graph:
data.template_file.test1 - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
data.template_file.test2 - *terraform.NodeValidatableResource
data.template_file.test1 - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.template_file.test1 - *terraform.NodeValidatableResource
data.template_file.test2 - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/template"] (close) - *terraform.graphNodeCloseProvider
data.template_file.test1 - *terraform.NodeValidatableResource
data.template_file.test2 - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
------
2021-04-13T10:44:35.493-0500 [TRACE] Executing graph transform *terraform.CloseRootModuleTransformer
2021-04-13T10:44:35.493-0500 [TRACE] Completed graph transform *terraform.CloseRootModuleTransformer with new graph:
data.template_file.test1 - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
data.template_file.test2 - *terraform.NodeValidatableResource
data.template_file.test1 - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.template_file.test1 - *terraform.NodeValidatableResource
data.template_file.test2 - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/template"] (close) - *terraform.graphNodeCloseProvider
data.template_file.test1 - *terraform.NodeValidatableResource
data.template_file.test2 - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
root - *terraform.nodeCloseModule
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
provider["registry.terraform.io/hashicorp/template"] (close) - *terraform.graphNodeCloseProvider
------
2021-04-13T10:44:35.493-0500 [TRACE] Executing graph transform *terraform.TransitiveReductionTransformer
2021-04-13T10:44:35.493-0500 [TRACE] Completed graph transform *terraform.TransitiveReductionTransformer with new graph:
data.template_file.test1 - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
data.template_file.test2 - *terraform.NodeValidatableResource
data.template_file.test1 - *terraform.NodeValidatableResource
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.template_file.test2 - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/template"] (close) - *terraform.graphNodeCloseProvider
data.template_file.test2 - *terraform.NodeValidatableResource
root - *terraform.nodeCloseModule
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
provider["registry.terraform.io/hashicorp/template"] (close) - *terraform.graphNodeCloseProvider
------
2021-04-13T10:44:35.493-0500 [DEBUG] Starting graph walk: walkValidate
2021-04-13T10:44:35.493-0500 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/template\"]": starting visit (*terraform.NodeApplyableProvider)
2021-04-13T10:44:35.493-0500 [DEBUG] created provider logger: level=trace
2021-04-13T10:44:35.493-0500 [INFO] provider: configuring client automatic mTLS
2021-04-13T10:44:35.523-0500 [DEBUG] provider: starting plugin: path=.terraform/providers/registry.terraform.io/hashicorp/template/2.2.0/darwin_amd64/terraform-provider-template_v2.2.0_x4 args=[.terraform/providers/registry.terraform.io/hashicorp/template/2.2.0/darwin_amd64/terraform-provider-template_v2.2.0_x4]
2021-04-13T10:44:35.526-0500 [DEBUG] provider: plugin started: path=.terraform/providers/registry.terraform.io/hashicorp/template/2.2.0/darwin_amd64/terraform-provider-template_v2.2.0_x4 pid=81830
2021-04-13T10:44:35.526-0500 [DEBUG] provider: waiting for RPC address: path=.terraform/providers/registry.terraform.io/hashicorp/template/2.2.0/darwin_amd64/terraform-provider-template_v2.2.0_x4
2021-04-13T10:44:35.535-0500 [INFO] provider.terraform-provider-template_v2.2.0_x4: configuring server automatic mTLS: timestamp=2021-04-13T10:44:35.535-0500
2021-04-13T10:44:35.565-0500 [DEBUG] provider: using plugin: version=5
2021-04-13T10:44:35.565-0500 [DEBUG] provider.terraform-provider-template_v2.2.0_x4: plugin address: network=unix address=/var/folders/mf/5139pykx5bn88h5fxswjym4h0000gn/T/plugin059745525 timestamp=2021-04-13T10:44:35.564-0500
2021-04-13T10:44:35.606-0500 [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/hashicorp/template\"]" provider for provider["registry.terraform.io/hashicorp/template"]
2021-04-13T10:44:35.606-0500 [TRACE] provider.stdio: waiting for stdio data
2021-04-13T10:44:35.606-0500 [TRACE] buildProviderConfig for provider["registry.terraform.io/hashicorp/template"]: no configuration at all
2021-04-13T10:44:35.606-0500 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/template\"]": visit complete
2021-04-13T10:44:35.606-0500 [TRACE] vertex "data.template_file.test1": starting visit (*terraform.NodeValidatableResource)
2021-04-13T10:44:35.607-0500 [TRACE] GRPCProvider: ValidateDataResourceConfig
2021-04-13T10:44:35.607-0500 [TRACE] GRPCProvider: GetProviderSchema
2021-04-13T10:44:35.607-0500 [DEBUG] provider.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2021-04-13T10:44:35.607-0500 [DEBUG] No provider meta schema returned
2021-04-13T10:44:35.608-0500 [TRACE] vertex "data.template_file.test1": visit complete
2021-04-13T10:44:35.608-0500 [TRACE] vertex "data.template_file.test2": starting visit (*terraform.NodeValidatableResource)
2021-04-13T10:44:35.608-0500 [TRACE] GRPCProvider: ValidateDataResourceConfig
2021-04-13T10:44:35.608-0500 [TRACE] vertex "data.template_file.test2": visit complete
2021-04-13T10:44:35.608-0500 [TRACE] vertex "meta.count-boundary (EachMode fixup)": starting visit (*terraform.NodeCountBoundary)
2021-04-13T10:44:35.608-0500 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/template\"] (close)": starting visit (*terraform.graphNodeCloseProvider)
2021-04-13T10:44:35.608-0500 [TRACE] GRPCProvider: Close
2021-04-13T10:44:35.608-0500 [TRACE] vertex "meta.count-boundary (EachMode fixup)": visit complete
2021-04-13T10:44:35.610-0500 [DEBUG] provider: plugin process exited: path=.terraform/providers/registry.terraform.io/hashicorp/template/2.2.0/darwin_amd64/terraform-provider-template_v2.2.0_x4 pid=81830
2021-04-13T10:44:35.610-0500 [DEBUG] provider: plugin exited
2021-04-13T10:44:35.610-0500 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/template\"] (close)": visit complete
2021-04-13T10:44:35.610-0500 [TRACE] vertex "root": starting visit (*terraform.nodeCloseModule)
2021-04-13T10:44:35.610-0500 [TRACE] vertex "root": visit complete
2021-04-13T10:44:35.610-0500 [INFO] backend/local: plan calling Plan
2021-04-13T10:44:35.610-0500 [INFO] terraform: building graph: GraphTypePlan
2021-04-13T10:44:35.610-0500 [TRACE] Executing graph transform *terraform.ConfigTransformer
2021-04-13T10:44:35.610-0500 [TRACE] ConfigTransformer: Starting for path:
2021-04-13T10:44:35.610-0500 [TRACE] Completed graph transform *terraform.ConfigTransformer with new graph:
data.template_file.test1 (expand) - *terraform.nodeExpandPlannableResource
data.template_file.test2 (expand) - *terraform.nodeExpandPlannableResource
------
2021-04-13T10:44:35.610-0500 [TRACE] Executing graph transform *terraform.RootVariableTransformer
2021-04-13T10:44:35.610-0500 [TRACE] Completed graph transform *terraform.RootVariableTransformer (no changes)
2021-04-13T10:44:35.610-0500 [TRACE] Executing graph transform *terraform.ModuleVariableTransformer
2021-04-13T10:44:35.610-0500 [TRACE] Completed graph transform *terraform.ModuleVariableTransformer (no changes)
2021-04-13T10:44:35.610-0500 [TRACE] Executing graph transform *terraform.LocalTransformer
2021-04-13T10:44:35.610-0500 [TRACE] Completed graph transform *terraform.LocalTransformer (no changes)
2021-04-13T10:44:35.610-0500 [TRACE] Executing graph transform *terraform.OutputTransformer
2021-04-13T10:44:35.610-0500 [TRACE] Completed graph transform *terraform.OutputTransformer (no changes)
2021-04-13T10:44:35.610-0500 [TRACE] Executing graph transform *terraform.OrphanResourceInstanceTransformer
2021-04-13T10:44:35.610-0500 [TRACE] Completed graph transform *terraform.OrphanResourceInstanceTransformer (no changes)
2021-04-13T10:44:35.610-0500 [TRACE] Executing graph transform *terraform.StateTransformer
2021-04-13T10:44:35.610-0500 [TRACE] StateTransformer: state is empty, so nothing to do
2021-04-13T10:44:35.610-0500 [TRACE] Completed graph transform *terraform.StateTransformer (no changes)
2021-04-13T10:44:35.610-0500 [TRACE] Executing graph transform *terraform.AttachStateTransformer
2021-04-13T10:44:35.610-0500 [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2021-04-13T10:44:35.610-0500 [TRACE] Executing graph transform *terraform.OrphanOutputTransformer
2021-04-13T10:44:35.610-0500 [TRACE] Completed graph transform *terraform.OrphanOutputTransformer (no changes)
2021-04-13T10:44:35.610-0500 [TRACE] Executing graph transform *terraform.AttachResourceConfigTransformer
2021-04-13T10:44:35.610-0500 [TRACE] AttachResourceConfigTransformer: attaching to "data.template_file.test2 (expand)" (*terraform.nodeExpandPlannableResource) config from hcl.Range{Filename:"main.tf", Start:hcl.Pos{Line:8, Column:1, Byte:97}, End:hcl.Pos{Line:8, Column:29, Byte:125}}
2021-04-13T10:44:35.610-0500 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to data.template_file.test2 (expand)
2021-04-13T10:44:35.610-0500 [TRACE] AttachResourceConfigTransformer: attaching to "data.template_file.test1 (expand)" (*terraform.nodeExpandPlannableResource) config from hcl.Range{Filename:"main.tf", Start:hcl.Pos{Line:1, Column:1, Byte:0}, End:hcl.Pos{Line:1, Column:29, Byte:28}}
2021-04-13T10:44:35.610-0500 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to data.template_file.test1 (expand)
2021-04-13T10:44:35.610-0500 [TRACE] Completed graph transform *terraform.AttachResourceConfigTransformer (no changes)
2021-04-13T10:44:35.610-0500 [TRACE] Executing graph transform *terraform.graphTransformerMulti
2021-04-13T10:44:35.611-0500 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderConfigTransformer
2021-04-13T10:44:35.611-0500 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderConfigTransformer with new graph:
data.template_file.test1 (expand) - *terraform.nodeExpandPlannableResource
data.template_file.test2 (expand) - *terraform.nodeExpandPlannableResource
------
2021-04-13T10:44:35.611-0500 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.MissingProviderTransformer
2021-04-13T10:44:35.611-0500 [DEBUG] adding implicit provider configuration provider["registry.terraform.io/hashicorp/template"], implied first by data.template_file.test2 (expand)
2021-04-13T10:44:35.611-0500 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.MissingProviderTransformer with new graph:
data.template_file.test1 (expand) - *terraform.nodeExpandPlannableResource
data.template_file.test2 (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
------
2021-04-13T10:44:35.611-0500 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderTransformer
2021-04-13T10:44:35.611-0500 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/template"] serving data.template_file.test2 (expand)
2021-04-13T10:44:35.611-0500 [DEBUG] ProviderTransformer: "data.template_file.test2 (expand)" (*terraform.nodeExpandPlannableResource) needs provider["registry.terraform.io/hashicorp/template"]
2021-04-13T10:44:35.611-0500 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/template"] serving data.template_file.test1 (expand)
2021-04-13T10:44:35.611-0500 [DEBUG] ProviderTransformer: "data.template_file.test1 (expand)" (*terraform.nodeExpandPlannableResource) needs provider["registry.terraform.io/hashicorp/template"]
2021-04-13T10:44:35.611-0500 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderTransformer with new graph:
data.template_file.test1 (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
data.template_file.test2 (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
------
2021-04-13T10:44:35.611-0500 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.PruneProviderTransformer
2021-04-13T10:44:35.611-0500 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.PruneProviderTransformer (no changes)
2021-04-13T10:44:35.611-0500 [TRACE] Completed graph transform *terraform.graphTransformerMulti with new graph:
data.template_file.test1 (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
data.template_file.test2 (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
------
2021-04-13T10:44:35.611-0500 [TRACE] Executing graph transform *terraform.RemovedModuleTransformer
2021-04-13T10:44:35.611-0500 [TRACE] Completed graph transform *terraform.RemovedModuleTransformer (no changes)
2021-04-13T10:44:35.611-0500 [TRACE] Executing graph transform *terraform.AttachSchemaTransformer
2021-04-13T10:44:35.611-0500 [TRACE] AttachSchemaTransformer: attaching resource schema to data.template_file.test2 (expand)
2021-04-13T10:44:35.611-0500 [TRACE] AttachSchemaTransformer: attaching resource schema to data.template_file.test1 (expand)
2021-04-13T10:44:35.611-0500 [TRACE] AttachSchemaTransformer: attaching provider config schema to provider["registry.terraform.io/hashicorp/template"]
2021-04-13T10:44:35.611-0500 [TRACE] Completed graph transform *terraform.AttachSchemaTransformer (no changes)
2021-04-13T10:44:35.611-0500 [TRACE] Executing graph transform *terraform.ModuleExpansionTransformer
2021-04-13T10:44:35.611-0500 [TRACE] Completed graph transform *terraform.ModuleExpansionTransformer (no changes)
2021-04-13T10:44:35.611-0500 [TRACE] Executing graph transform *terraform.ReferenceTransformer
2021-04-13T10:44:35.611-0500 [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/template\"]" references: []
2021-04-13T10:44:35.611-0500 [INFO] ReferenceTransformer: reference not found: "count.index"
2021-04-13T10:44:35.611-0500 [DEBUG] ReferenceTransformer: "data.template_file.test2 (expand)" references: [data.template_file.test1 (expand)]
2021-04-13T10:44:35.611-0500 [DEBUG] ReferenceTransformer: "data.template_file.test1 (expand)" references: []
2021-04-13T10:44:35.611-0500 [TRACE] Completed graph transform *terraform.ReferenceTransformer with new graph:
data.template_file.test1 (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
data.template_file.test2 (expand) - *terraform.nodeExpandPlannableResource
data.template_file.test1 (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
------
2021-04-13T10:44:35.611-0500 [TRACE] Executing graph transform *terraform.AttachDependenciesTransformer
2021-04-13T10:44:35.611-0500 [TRACE] AttachDependenciesTransformer: data.template_file.test2 depends on [data.template_file.test1]
2021-04-13T10:44:35.611-0500 [TRACE] AttachDependenciesTransformer: data.template_file.test1 depends on []
2021-04-13T10:44:35.611-0500 [TRACE] Completed graph transform *terraform.AttachDependenciesTransformer (no changes)
2021-04-13T10:44:35.611-0500 [TRACE] Executing graph transform *terraform.attachDataResourceDependsOnTransformer
2021-04-13T10:44:35.611-0500 [TRACE] attachDataDependenciesTransformer: data.template_file.test2 depends on []
2021-04-13T10:44:35.611-0500 [TRACE] attachDataDependenciesTransformer: data.template_file.test1 depends on []
2021-04-13T10:44:35.611-0500 [TRACE] Completed graph transform *terraform.attachDataResourceDependsOnTransformer (no changes)
2021-04-13T10:44:35.611-0500 [TRACE] Executing graph transform *terraform.TargetsTransformer
2021-04-13T10:44:35.611-0500 [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2021-04-13T10:44:35.611-0500 [TRACE] Executing graph transform *terraform.ForcedCBDTransformer
2021-04-13T10:44:35.611-0500 [TRACE] ForcedCBDTransformer: "data.template_file.test2 (expand)" (*terraform.nodeExpandPlannableResource) has no CBD descendent, so skipping
2021-04-13T10:44:35.611-0500 [TRACE] ForcedCBDTransformer: "data.template_file.test1 (expand)" (*terraform.nodeExpandPlannableResource) has no CBD descendent, so skipping
2021-04-13T10:44:35.611-0500 [TRACE] Completed graph transform *terraform.ForcedCBDTransformer (no changes)
2021-04-13T10:44:35.611-0500 [TRACE] Executing graph transform *terraform.CountBoundaryTransformer
2021-04-13T10:44:35.611-0500 [TRACE] Completed graph transform *terraform.CountBoundaryTransformer with new graph:
data.template_file.test1 (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
data.template_file.test2 (expand) - *terraform.nodeExpandPlannableResource
data.template_file.test1 (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.template_file.test1 (expand) - *terraform.nodeExpandPlannableResource
data.template_file.test2 (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
------
2021-04-13T10:44:35.611-0500 [TRACE] Executing graph transform *terraform.CloseProviderTransformer
2021-04-13T10:44:35.611-0500 [TRACE] Completed graph transform *terraform.CloseProviderTransformer with new graph:
data.template_file.test1 (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
data.template_file.test2 (expand) - *terraform.nodeExpandPlannableResource
data.template_file.test1 (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.template_file.test1 (expand) - *terraform.nodeExpandPlannableResource
data.template_file.test2 (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/template"] (close) - *terraform.graphNodeCloseProvider
data.template_file.test1 (expand) - *terraform.nodeExpandPlannableResource
data.template_file.test2 (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
------
2021-04-13T10:44:35.611-0500 [TRACE] Executing graph transform *terraform.CloseRootModuleTransformer
2021-04-13T10:44:35.611-0500 [TRACE] Completed graph transform *terraform.CloseRootModuleTransformer with new graph:
data.template_file.test1 (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
data.template_file.test2 (expand) - *terraform.nodeExpandPlannableResource
data.template_file.test1 (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.template_file.test1 (expand) - *terraform.nodeExpandPlannableResource
data.template_file.test2 (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/template"] (close) - *terraform.graphNodeCloseProvider
data.template_file.test1 (expand) - *terraform.nodeExpandPlannableResource
data.template_file.test2 (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
root - *terraform.nodeCloseModule
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
provider["registry.terraform.io/hashicorp/template"] (close) - *terraform.graphNodeCloseProvider
------
2021-04-13T10:44:35.611-0500 [TRACE] Executing graph transform *terraform.TransitiveReductionTransformer
2021-04-13T10:44:35.611-0500 [TRACE] Completed graph transform *terraform.TransitiveReductionTransformer with new graph:
data.template_file.test1 (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
data.template_file.test2 (expand) - *terraform.nodeExpandPlannableResource
data.template_file.test1 (expand) - *terraform.nodeExpandPlannableResource
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.template_file.test2 (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/template"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/template"] (close) - *terraform.graphNodeCloseProvider
data.template_file.test2 (expand) - *terraform.nodeExpandPlannableResource
root - *terraform.nodeCloseModule
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
provider["registry.terraform.io/hashicorp/template"] (close) - *terraform.graphNodeCloseProvider
------
2021-04-13T10:44:35.611-0500 [DEBUG] Starting graph walk: walkPlan
2021-04-13T10:44:35.611-0500 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/template\"]": starting visit (*terraform.NodeApplyableProvider)
2021-04-13T10:44:35.612-0500 [DEBUG] created provider logger: level=trace
2021-04-13T10:44:35.612-0500 [INFO] provider: configuring client automatic mTLS
2021-04-13T10:44:35.640-0500 [DEBUG] provider: starting plugin: path=.terraform/providers/registry.terraform.io/hashicorp/template/2.2.0/darwin_amd64/terraform-provider-template_v2.2.0_x4 args=[.terraform/providers/registry.terraform.io/hashicorp/template/2.2.0/darwin_amd64/terraform-provider-template_v2.2.0_x4]
2021-04-13T10:44:35.643-0500 [DEBUG] provider: plugin started: path=.terraform/providers/registry.terraform.io/hashicorp/template/2.2.0/darwin_amd64/terraform-provider-template_v2.2.0_x4 pid=81831
2021-04-13T10:44:35.643-0500 [DEBUG] provider: waiting for RPC address: path=.terraform/providers/registry.terraform.io/hashicorp/template/2.2.0/darwin_amd64/terraform-provider-template_v2.2.0_x4
2021-04-13T10:44:35.650-0500 [INFO] provider.terraform-provider-template_v2.2.0_x4: configuring server automatic mTLS: timestamp=2021-04-13T10:44:35.650-0500
2021-04-13T10:44:35.673-0500 [DEBUG] provider.terraform-provider-template_v2.2.0_x4: plugin address: address=/var/folders/mf/5139pykx5bn88h5fxswjym4h0000gn/T/plugin076095234 network=unix timestamp=2021-04-13T10:44:35.673-0500
2021-04-13T10:44:35.673-0500 [DEBUG] provider: using plugin: version=5
2021-04-13T10:44:35.714-0500 [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/hashicorp/template\"]" provider for provider["registry.terraform.io/hashicorp/template"]
2021-04-13T10:44:35.714-0500 [TRACE] provider.stdio: waiting for stdio data
2021-04-13T10:44:35.714-0500 [TRACE] buildProviderConfig for provider["registry.terraform.io/hashicorp/template"]: no configuration at all
2021-04-13T10:44:35.714-0500 [TRACE] GRPCProvider: GetProviderSchema
2021-04-13T10:44:35.715-0500 [DEBUG] provider.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2021-04-13T10:44:35.715-0500 [DEBUG] No provider meta schema returned
2021-04-13T10:44:35.715-0500 [TRACE] GRPCProvider: ValidateProviderConfig
2021-04-13T10:44:35.716-0500 [TRACE] GRPCProvider: ConfigureProvider
2021-04-13T10:44:35.716-0500 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/template\"]": visit complete
2021-04-13T10:44:35.716-0500 [TRACE] vertex "data.template_file.test1 (expand)": starting visit (*terraform.nodeExpandPlannableResource)
2021-04-13T10:44:35.716-0500 [TRACE] vertex "data.template_file.test1 (expand)": expanding dynamic subgraph
2021-04-13T10:44:35.716-0500 [TRACE] vertex "data.template_file.test1 (expand)": entering dynamic subgraph
2021-04-13T10:44:35.716-0500 [TRACE] vertex "data.template_file.test1": starting visit (*terraform.NodePlannableResource)
2021-04-13T10:44:35.716-0500 [TRACE] vertex "data.template_file.test1": expanding dynamic subgraph
2021-04-13T10:44:35.716-0500 [TRACE] Executing graph transform *terraform.ResourceCountTransformer
2021-04-13T10:44:35.716-0500 [TRACE] ResourceCountTransformer: adding data.template_file.test1 as *terraform.NodePlannableResourceInstance
2021-04-13T10:44:35.716-0500 [TRACE] Completed graph transform *terraform.ResourceCountTransformer with new graph:
data.template_file.test1 - *terraform.NodePlannableResourceInstance
------
2021-04-13T10:44:35.716-0500 [TRACE] Executing graph transform *terraform.OrphanResourceInstanceCountTransformer
2021-04-13T10:44:35.716-0500 [TRACE] Completed graph transform *terraform.OrphanResourceInstanceCountTransformer (no changes)
2021-04-13T10:44:35.716-0500 [TRACE] Executing graph transform *terraform.AttachStateTransformer
2021-04-13T10:44:35.716-0500 [DEBUG] Resource instance state not found for node "data.template_file.test1", instance data.template_file.test1
2021-04-13T10:44:35.716-0500 [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2021-04-13T10:44:35.716-0500 [TRACE] Executing graph transform *terraform.TargetsTransformer
2021-04-13T10:44:35.716-0500 [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2021-04-13T10:44:35.716-0500 [TRACE] Executing graph transform *terraform.ReferenceTransformer
2021-04-13T10:44:35.716-0500 [DEBUG] ReferenceTransformer: "data.template_file.test1" references: []
2021-04-13T10:44:35.716-0500 [TRACE] Completed graph transform *terraform.ReferenceTransformer (no changes)
2021-04-13T10:44:35.716-0500 [TRACE] Executing graph transform *terraform.RootTransformer
2021-04-13T10:44:35.716-0500 [TRACE] Completed graph transform *terraform.RootTransformer (no changes)
2021-04-13T10:44:35.716-0500 [TRACE] vertex "data.template_file.test1": entering dynamic subgraph
2021-04-13T10:44:35.716-0500 [TRACE] vertex "data.template_file.test1": starting visit (*terraform.NodePlannableResourceInstance)
2021-04-13T10:44:35.716-0500 [TRACE] readResourceInstanceState: reading state for data.template_file.test1
2021-04-13T10:44:35.716-0500 [TRACE] readResourceInstanceState: no state present for data.template_file.test1
2021-04-13T10:44:35.717-0500 [TRACE] readDataSource: Re-validating config for data.template_file.test1
2021-04-13T10:44:35.717-0500 [TRACE] GRPCProvider: ValidateDataResourceConfig
2021-04-13T10:44:35.717-0500 [TRACE] readDataSource: data.template_file.test1 configuration is complete, so reading from provider
2021-04-13T10:44:35.717-0500 [TRACE] GRPCProvider: ReadDataSource
2021-04-13T10:44:35.717-0500 [TRACE] writeResourceInstanceState: using RefreshState for data.template_file.test1
2021-04-13T10:44:35.717-0500 [TRACE] writeResourceInstanceState: writing current state object for data.template_file.test1
2021-04-13T10:44:35.717-0500 [TRACE] writeResourceInstanceState: writing current state object for data.template_file.test1
2021-04-13T10:44:35.717-0500 [TRACE] vertex "data.template_file.test1": visit complete
2021-04-13T10:44:35.717-0500 [TRACE] vertex "data.template_file.test1": dynamic subgraph completed successfully
2021-04-13T10:44:35.717-0500 [TRACE] vertex "data.template_file.test1": visit complete
2021-04-13T10:44:35.718-0500 [TRACE] vertex "data.template_file.test1 (expand)": dynamic subgraph completed successfully
2021-04-13T10:44:35.718-0500 [TRACE] vertex "data.template_file.test1 (expand)": visit complete
2021-04-13T10:44:35.718-0500 [TRACE] vertex "data.template_file.test2 (expand)": starting visit (*terraform.nodeExpandPlannableResource)
2021-04-13T10:44:35.718-0500 [TRACE] vertex "data.template_file.test2 (expand)": expanding dynamic subgraph
2021-04-13T10:44:35.718-0500 [TRACE] vertex "data.template_file.test2 (expand)": entering dynamic subgraph
2021-04-13T10:44:35.718-0500 [TRACE] vertex "data.template_file.test2": starting visit (*terraform.NodePlannableResource)
2021-04-13T10:44:35.718-0500 [TRACE] vertex "data.template_file.test2": expanding dynamic subgraph
2021-04-13T10:44:35.718-0500 [TRACE] Executing graph transform *terraform.ResourceCountTransformer
2021-04-13T10:44:35.718-0500 [TRACE] ResourceCountTransformer: adding data.template_file.test2[0] as *terraform.NodePlannableResourceInstance
2021-04-13T10:44:35.718-0500 [TRACE] ResourceCountTransformer: adding data.template_file.test2[1] as *terraform.NodePlannableResourceInstance
2021-04-13T10:44:35.718-0500 [TRACE] Completed graph transform *terraform.ResourceCountTransformer with new graph:
data.template_file.test2[0] - *terraform.NodePlannableResourceInstance
data.template_file.test2[1] - *terraform.NodePlannableResourceInstance
------
2021-04-13T10:44:35.718-0500 [TRACE] Executing graph transform *terraform.OrphanResourceInstanceCountTransformer
2021-04-13T10:44:35.718-0500 [TRACE] Completed graph transform *terraform.OrphanResourceInstanceCountTransformer (no changes)
2021-04-13T10:44:35.718-0500 [TRACE] Executing graph transform *terraform.AttachStateTransformer
2021-04-13T10:44:35.718-0500 [DEBUG] Resource instance state not found for node "data.template_file.test2[0]", instance data.template_file.test2[0]
2021-04-13T10:44:35.718-0500 [DEBUG] Resource instance state not found for node "data.template_file.test2[1]", instance data.template_file.test2[1]
2021-04-13T10:44:35.718-0500 [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2021-04-13T10:44:35.718-0500 [TRACE] Executing graph transform *terraform.TargetsTransformer
2021-04-13T10:44:35.718-0500 [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2021-04-13T10:44:35.718-0500 [TRACE] Executing graph transform *terraform.ReferenceTransformer
2021-04-13T10:44:35.718-0500 [INFO] ReferenceTransformer: reference not found: "data.template_file.test1"
2021-04-13T10:44:35.718-0500 [INFO] ReferenceTransformer: reference not found: "count.index"
2021-04-13T10:44:35.718-0500 [DEBUG] ReferenceTransformer: "data.template_file.test2[0]" references: []
2021-04-13T10:44:35.718-0500 [INFO] ReferenceTransformer: reference not found: "data.template_file.test1"
2021-04-13T10:44:35.718-0500 [INFO] ReferenceTransformer: reference not found: "count.index"
2021-04-13T10:44:35.718-0500 [DEBUG] ReferenceTransformer: "data.template_file.test2[1]" references: []
2021-04-13T10:44:35.718-0500 [TRACE] Completed graph transform *terraform.ReferenceTransformer (no changes)
2021-04-13T10:44:35.718-0500 [TRACE] Executing graph transform *terraform.RootTransformer
2021-04-13T10:44:35.718-0500 [TRACE] Completed graph transform *terraform.RootTransformer with new graph:
data.template_file.test2[0] - *terraform.NodePlannableResourceInstance
data.template_file.test2[1] - *terraform.NodePlannableResourceInstance
root - terraform.graphNodeRoot
data.template_file.test2[0] - *terraform.NodePlannableResourceInstance
data.template_file.test2[1] - *terraform.NodePlannableResourceInstance
------
2021-04-13T10:44:35.718-0500 [TRACE] vertex "data.template_file.test2": entering dynamic subgraph
2021-04-13T10:44:35.718-0500 [TRACE] vertex "data.template_file.test2[0]": starting visit (*terraform.NodePlannableResourceInstance)
2021-04-13T10:44:35.718-0500 [TRACE] vertex "data.template_file.test2[1]": starting visit (*terraform.NodePlannableResourceInstance)
2021-04-13T10:44:35.718-0500 [TRACE] readResourceInstanceState: reading state for data.template_file.test2[0]
2021-04-13T10:44:35.718-0500 [TRACE] readResourceInstanceState: no state present for data.template_file.test2[0]
2021-04-13T10:44:35.718-0500 [TRACE] readResourceInstanceState: reading state for data.template_file.test2[1]
2021-04-13T10:44:35.718-0500 [TRACE] readResourceInstanceState: no state present for data.template_file.test2[1]
2021-04-13T10:44:35.718-0500 [TRACE] readDataSource: Re-validating config for data.template_file.test2[1]
2021-04-13T10:44:35.718-0500 [TRACE] GRPCProvider: ValidateDataResourceConfig
2021-04-13T10:44:35.718-0500 [TRACE] readDataSource: Re-validating config for data.template_file.test2[0]
2021-04-13T10:44:35.718-0500 [TRACE] GRPCProvider: ValidateDataResourceConfig
2021-04-13T10:44:35.719-0500 [TRACE] readDataSource: data.template_file.test2[0] configuration is complete, so reading from provider
2021-04-13T10:44:35.719-0500 [TRACE] GRPCProvider: ReadDataSource
2021-04-13T10:44:35.719-0500 [TRACE] readDataSource: data.template_file.test2[1] configuration is complete, so reading from provider
2021-04-13T10:44:35.719-0500 [TRACE] GRPCProvider: ReadDataSource
2021-04-13T10:44:35.719-0500 [TRACE] writeResourceInstanceState: using RefreshState for data.template_file.test2[0]
2021-04-13T10:44:35.719-0500 [TRACE] writeResourceInstanceState: using RefreshState for data.template_file.test2[1]
2021-04-13T10:44:35.719-0500 [TRACE] writeResourceInstanceState: writing current state object for data.template_file.test2[1]
2021-04-13T10:44:35.719-0500 [TRACE] writeResourceInstanceState: writing current state object for data.template_file.test2[0]
2021-04-13T10:44:35.719-0500 [TRACE] writeResourceInstanceState: writing current state object for data.template_file.test2[1]
2021-04-13T10:44:35.719-0500 [TRACE] writeResourceInstanceState: writing current state object for data.template_file.test2[0]
2021-04-13T10:44:35.719-0500 [TRACE] vertex "data.template_file.test2[1]": visit complete
2021-04-13T10:44:35.719-0500 [TRACE] vertex "data.template_file.test2[0]": visit complete
2021-04-13T10:44:35.719-0500 [TRACE] vertex "root": starting visit (terraform.graphNodeRoot)
2021-04-13T10:44:35.719-0500 [TRACE] vertex "root": visit complete
2021-04-13T10:44:35.719-0500 [TRACE] vertex "data.template_file.test2": dynamic subgraph completed successfully
2021-04-13T10:44:35.719-0500 [TRACE] vertex "data.template_file.test2": visit complete
2021-04-13T10:44:35.719-0500 [TRACE] vertex "data.template_file.test2 (expand)": dynamic subgraph completed successfully
2021-04-13T10:44:35.719-0500 [TRACE] vertex "data.template_file.test2 (expand)": visit complete
2021-04-13T10:44:35.719-0500 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/template\"] (close)": starting visit (*terraform.graphNodeCloseProvider)
2021-04-13T10:44:35.719-0500 [TRACE] GRPCProvider: Close
2021-04-13T10:44:35.719-0500 [TRACE] vertex "meta.count-boundary (EachMode fixup)": starting visit (*terraform.NodeCountBoundary)
2021-04-13T10:44:35.719-0500 [TRACE] vertex "meta.count-boundary (EachMode fixup)": visit complete
2021-04-13T10:44:35.721-0500 [DEBUG] provider: plugin process exited: path=.terraform/providers/registry.terraform.io/hashicorp/template/2.2.0/darwin_amd64/terraform-provider-template_v2.2.0_x4 pid=81831
2021-04-13T10:44:35.721-0500 [DEBUG] provider: plugin exited
2021-04-13T10:44:35.721-0500 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/template\"] (close)": visit complete
data.template_file.test2[1] - *terraform.NodePlannableResourceInstance
root - terraform.graphNodeRoot
data.template_file.test2[0] - *terraform.NodePlannableResourceInstance
data.template_file.test2[1] - *terraform.NodePlannableResourceInstance
------
2021-04-13T10:44:35.718-0500 [TRACE] vertex "data.template_file.test2": entering dynamic subgraph
2021-04-13T10:44:35.718-0500 [TRACE] vertex "data.template_file.test2[0]": starting visit (*terraform.NodePlannableResourceInstance)
2021-04-13T10:44:35.718-0500 [TRACE] vertex "data.template_file.test2[1]": starting visit (*terraform.NodePlannableResourceInstance)
2021-04-13T10:44:35.718-0500 [TRACE] readResourceInstanceState: reading state for data.template_file.test2[0]
2021-04-13T10:44:35.718-0500 [TRACE] readResourceInstanceState: no state present for data.template_file.test2[0]
2021-04-13T10:44:35.718-0500 [TRACE] readResourceInstanceState: reading state for data.template_file.test2[1]
2021-04-13T10:44:35.718-0500 [TRACE] readResourceInstanceState: no state present for data.template_file.test2[1]
2021-04-13T10:44:35.718-0500 [TRACE] readDataSource: Re-validating config for data.template_file.test2[1]
2021-04-13T10:44:35.718-0500 [TRACE] GRPCProvider: ValidateDataResourceConfig
2021-04-13T10:44:35.718-0500 [TRACE] readDataSource: Re-validating config for data.template_file.test2[0]
2021-04-13T10:44:35.718-0500 [TRACE] GRPCProvider: ValidateDataResourceConfig
2021-04-13T10:44:35.719-0500 [TRACE] readDataSource: data.template_file.test2[0] configuration is complete, so reading from provider
2021-04-13T10:44:35.719-0500 [TRACE] GRPCProvider: ReadDataSource
2021-04-13T10:44:35.719-0500 [TRACE] readDataSource: data.template_file.test2[1] configuration is complete, so reading from provider
2021-04-13T10:44:35.719-0500 [TRACE] GRPCProvider: ReadDataSource
2021-04-13T10:44:35.719-0500 [TRACE] writeResourceInstanceState: using RefreshState for data.template_file.test2[0]
2021-04-13T10:44:35.719-0500 [TRACE] writeResourceInstanceState: using RefreshState for data.template_file.test2[1]
2021-04-13T10:44:35.719-0500 [TRACE] writeResourceInstanceState: writing current state object for data.template_file.test2[1]
2021-04-13T10:44:35.719-0500 [TRACE] writeResourceInstanceState: writing current state object for data.template_file.test2[0]
2021-04-13T10:44:35.719-0500 [TRACE] writeResourceInstanceState: writing current state object for data.template_file.test2[1]
2021-04-13T10:44:35.719-0500 [TRACE] writeResourceInstanceState: writing current state object for data.template_file.test2[0]
2021-04-13T10:44:35.719-0500 [TRACE] vertex "data.template_file.test2[1]": visit complete
2021-04-13T10:44:35.719-0500 [TRACE] vertex "data.template_file.test2[0]": visit complete
2021-04-13T10:44:35.719-0500 [TRACE] vertex "root": starting visit (terraform.graphNodeRoot)
2021-04-13T10:44:35.719-0500 [TRACE] vertex "root": visit complete
2021-04-13T10:44:35.719-0500 [TRACE] vertex "data.template_file.test2": dynamic subgraph completed successfully
2021-04-13T10:44:35.719-0500 [TRACE] vertex "data.template_file.test2": visit complete
2021-04-13T10:44:35.719-0500 [TRACE] vertex "data.template_file.test2 (expand)": dynamic subgraph completed successfully
2021-04-13T10:44:35.719-0500 [TRACE] vertex "data.template_file.test2 (expand)": visit complete
2021-04-13T10:44:35.719-0500 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/template\"] (close)": starting visit (*terraform.graphNodeCloseProvider)
2021-04-13T10:44:35.719-0500 [TRACE] GRPCProvider: Close
2021-04-13T10:44:35.719-0500 [TRACE] vertex "meta.count-boundary (EachMode fixup)": starting visit (*terraform.NodeCountBoundary)
2021-04-13T10:44:35.719-0500 [TRACE] vertex "meta.count-boundary (EachMode fixup)": visit complete
2021-04-13T10:44:35.721-0500 [DEBUG] provider: plugin process exited: path=.terraform/providers/registry.terraform.io/hashicorp/template/2.2.0/darwin_amd64/terraform-provider-template_v2.2.0_x4 pid=81831
2021-04-13T10:44:35.721-0500 [DEBUG] provider: plugin exited
2021-04-13T10:44:35.721-0500 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/template\"] (close)": visit complete
2021-04-13T10:44:35.721-0500 [TRACE] vertex "root": starting visit (*terraform.nodeCloseModule)
2021-04-13T10:44:35.721-0500 [TRACE] vertex "root": visit complete
2021-04-13T10:44:35.721-0500 [INFO] backend/local: plan operation completed
No changes. Infrastructure is up-to-date.
This means that Terraform did not detect any differences between your
configuration and the remote system(s). As a result, there are no actions to
take.
2021-04-13T10:44:35.721-0500 [TRACE] statemgr.Filesystem: removing lock metadata file .terraform.tfstate.lock.info
2021-04-13T10:44:35.721-0500 [TRACE] statemgr.Filesystem: unlocking terraform.tfstate using fcntl flock
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment