templatefile returns with inconsistent result as of 1.13+

[faust64]

Terraform Version

Terraform v1.13.3
on linux_amd64
+ provider registry.terraform.io/hashicorp/local v2.5.3

Terraform Configuration Files

locals {
  rendered_repo_readme = templatefile("${path.root}/stuff.tftpl", { foo = "bar" })
}
resource "local_file" "repo_readme" {
  content  = local.rendered_repo_readme
  filename = "${path.root}/README.md"
}

And stuff.tftpl:

Last generated on ${timestamp()}.

Debug Output

$> terraform plan -out plan
...
Terraform used the selected providers to generate the following execution plan. Resource actions are indicated with the following symbols:
  + create

Terraform will perform the following actions:

  # local_file.repo_readme will be created
  + resource "local_file" "repo_readme" {
      + content              = (known after apply)
      + content_base64sha256 = (known after apply)
      + content_base64sha512 = (known after apply)
      + content_md5          = (known after apply)
      + content_sha1         = (known after apply)
      + content_sha256       = (known after apply)
      + content_sha512       = (known after apply)
      + directory_permission = "0777"
      + file_permission      = "0777"
      + filename             = "./README.md"
      + id                   = (known after apply)
    }

Plan: 1 to add, 0 to change, 0 to destroy.

$> TF_LOG=trace tf apply plan
2025-10-24T12:41:10.795Z [INFO]  Terraform version: 1.13.3
2025-10-24T12:41:10.795Z [DEBUG] using github.com/hashicorp/go-tfe v1.74.1
2025-10-24T12:41:10.795Z [DEBUG] using github.com/hashicorp/hcl/v2 v2.24.0
2025-10-24T12:41:10.795Z [DEBUG] using github.com/hashicorp/terraform-svchost v0.1.1
2025-10-24T12:41:10.795Z [DEBUG] using github.com/zclconf/go-cty v1.16.3
2025-10-24T12:41:10.795Z [INFO]  Go runtime version: go1.24.5
2025-10-24T12:41:10.796Z [INFO]  CLI args: []string{"terraform", "apply", "plan"}
2025-10-24T12:41:10.796Z [TRACE] Stdout is a terminal of width 258
2025-10-24T12:41:10.796Z [TRACE] Stderr is a terminal of width 258
2025-10-24T12:41:10.796Z [TRACE] Stdin is a terminal
2025-10-24T12:41:10.796Z [DEBUG] Attempting to open CLI config file: /home/foo/.terraformrc
2025-10-24T12:41:10.796Z [INFO]  Loading CLI configuration from /home/foo/.terraformrc
2025-10-24T12:41:10.796Z [DEBUG] checking for credentials in "/home/foo/.terraform.d/plugins"
2025-10-24T12:41:10.796Z [DEBUG] ignoring non-existing provider search directory terraform.d/plugins
2025-10-24T12:41:10.796Z [DEBUG] will search for provider plugins in /home/foo/.terraform.d/plugins
2025-10-24T12:41:10.796Z [DEBUG] ignoring non-existing provider search directory /home/foo/.local/share/terraform/plugins
2025-10-24T12:41:10.796Z [DEBUG] ignoring non-existing provider search directory /home/foo/.local/share/flatpak/exports/share/terraform/plugins
2025-10-24T12:41:10.796Z [DEBUG] ignoring non-existing provider search directory /var/lib/flatpak/exports/share/terraform/plugins
2025-10-24T12:41:10.796Z [DEBUG] ignoring non-existing provider search directory /usr/local/share/terraform/plugins
2025-10-24T12:41:10.796Z [DEBUG] ignoring non-existing provider search directory /usr/share/terraform/plugins
2025-10-24T12:41:10.796Z [INFO]  CLI command args: []string{"apply", "plan"}
2025-10-24T12:41:10.797Z [TRACE] Meta.BackendForLocalPlan: instantiated backend of type *local.Local
2025-10-24T12:41:10.797Z [TRACE] providercache.fillMetaCache: scanning directory .terraform/providers
2025-10-24T12:41:10.797Z [TRACE] getproviders.SearchLocalDirectory: found registry.terraform.io/hashicorp/local v2.5.3 for linux_amd64 at .terraform/providers/registry.terraform.io/hashicorp/local/2.5.3/linux_amd64
2025-10-24T12:41:10.797Z [TRACE] providercache.fillMetaCache: including .terraform/providers/registry.terraform.io/hashicorp/local/2.5.3/linux_amd64 as a candidate package for registry.terraform.io/hashicorp/local 2.5.3
2025-10-24T12:41:10.812Z [DEBUG] checking for provisioner in "."
2025-10-24T12:41:10.812Z [DEBUG] checking for provisioner in "/usr/local/bin"
2025-10-24T12:41:10.812Z [DEBUG] checking for provisioner in "/home/foo/.terraform.d/plugins"
2025-10-24T12:41:10.812Z [TRACE] Meta.BackendForPlan: backend *local.Local supports operations
2025-10-24T12:41:10.813Z [INFO]  backend/local: starting Apply operation
2025-10-24T12:41:10.813Z [TRACE] backend/local: requesting state manager for workspace "default"
2025-10-24T12:41:10.813Z [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
2025-10-24T12:41:10.813Z [TRACE] backend/local: requesting state lock for workspace "default"
2025-10-24T12:41:10.813Z [TRACE] statemgr.Filesystem: preparing to manage state snapshots at terraform.tfstate
2025-10-24T12:41:10.813Z [TRACE] statemgr.Filesystem: existing snapshot has lineage "d773628b-53d9-6c4b-c855-ea5267f4a531" serial 1
2025-10-24T12:41:10.813Z [TRACE] statemgr.Filesystem: locking terraform.tfstate using fcntl flock
2025-10-24T12:41:10.813Z [TRACE] statemgr.Filesystem: writing lock metadata to .terraform.tfstate.lock.info
2025-10-24T12:41:10.813Z [TRACE] backend/local: reading remote state for workspace "default"
2025-10-24T12:41:10.813Z [TRACE] statemgr.Filesystem: reading latest snapshot from terraform.tfstate
2025-10-24T12:41:10.813Z [TRACE] statemgr.Filesystem: read snapshot with lineage "d773628b-53d9-6c4b-c855-ea5267f4a531" serial 1
2025-10-24T12:41:10.813Z [TRACE] backend/local: populating backendrun.LocalRun from plan file
2025-10-24T12:41:10.813Z [TRACE] Config.VerifyDependencySelections: provider registry.terraform.io/hashicorp/local has 2.5.3 to satisfy ""
2025-10-24T12:41:10.814Z [TRACE] terraform.NewContext: starting
2025-10-24T12:41:10.814Z [TRACE] terraform.NewContext: complete
2025-10-24T12:41:10.814Z [TRACE] LoadSchemas: retrieving schema for provider type "registry.terraform.io/hashicorp/local"
2025-10-24T12:41:10.814Z [TRACE] terraform.contextPlugins: Initializing provider "registry.terraform.io/hashicorp/local" to read its schema
2025-10-24T12:41:10.814Z [DEBUG] created provider logger: level=trace
2025-10-24T12:41:10.814Z [INFO]  provider: configuring client automatic mTLS
2025-10-24T12:41:10.824Z [DEBUG] provider: starting plugin: path=.terraform/providers/registry.terraform.io/hashicorp/local/2.5.3/linux_amd64/terraform-provider-local_v2.5.3_x5 args=[".terraform/providers/registry.terraform.io/hashicorp/local/2.5.3/linux_amd64/terraform-provider-local_v2.5.3_x5"]
2025-10-24T12:41:10.825Z [DEBUG] provider: plugin started: path=.terraform/providers/registry.terraform.io/hashicorp/local/2.5.3/linux_amd64/terraform-provider-local_v2.5.3_x5 pid=18801
2025-10-24T12:41:10.825Z [DEBUG] provider: waiting for RPC address: plugin=.terraform/providers/registry.terraform.io/hashicorp/local/2.5.3/linux_amd64/terraform-provider-local_v2.5.3_x5
2025-10-24T12:41:10.828Z [INFO]  provider.terraform-provider-local_v2.5.3_x5: configuring server automatic mTLS: timestamp=2025-10-24T12:41:10.828Z
2025-10-24T12:41:10.839Z [DEBUG] provider: using plugin: version=5
2025-10-24T12:41:10.839Z [DEBUG] provider.terraform-provider-local_v2.5.3_x5: plugin address: address=/tmp/plugin391151188 network=unix timestamp=2025-10-24T12:41:10.839Z
2025-10-24T12:41:10.846Z [TRACE] GRPCProvider: GetProviderSchema
2025-10-24T12:41:10.847Z [TRACE] provider.stdio: waiting for stdio data
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Received request: @caller=github.com/hashicorp/terraform-plugin-go@v0.26.0/tfprotov5/tf5server/server.go:522 tf_proto_version=5.8 tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 @module=sdk.proto tf_provider_addr=registry.terraform.io/hashicorp/local tf_rpc=GetProviderSchema timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Sending request downstream: tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-go@v0.26.0/tfprotov5/internal/tf5serverlogging/downstream_request.go:22 @module=sdk.proto tf_proto_version=5.8 tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Checking ProviderSchema lock: @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:389 timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Calling provider defined Provider Schema: @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:400 timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Called provider defined Provider Schema: @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:402 timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Checking ResourceTypes lock: @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:539 timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Checking ProviderTypeName lock: @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:366 @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_rpc=GetProviderSchema timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Calling provider defined Provider Metadata: @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:377 timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Called provider defined Provider Metadata: tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:379 @module=sdk.framework timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Calling provider defined Provider Resources: @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:550 timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Called provider defined Provider Resources: @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:552 timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Found resource type: tf_rpc=GetProviderSchema tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_resource_type=local_file @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:573 @module=sdk.framework timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Found resource type: tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_resource_type=local_sensitive_file tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:573 @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Calling provider defined Resource Schema method: @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_resource_type=local_file tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:669 timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Called provider defined Resource Schema method: @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:671 @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local tf_rpc=GetProviderSchema tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_resource_type=local_file timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Calling provider defined Resource Schema method: tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:669 @module=sdk.framework tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_resource_type=local_sensitive_file tf_provider_addr=registry.terraform.io/hashicorp/local timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Called provider defined Resource Schema method: @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:671 tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 @module=sdk.framework tf_resource_type=local_sensitive_file tf_rpc=GetProviderSchema timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Checking DataSourceTypes lock: @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:210 timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Checking ProviderTypeName lock: tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:366 @module=sdk.framework timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Calling provider defined Provider DataSources: tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:221 @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Called provider defined Provider DataSources: @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:223 timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Found data source type: @module=sdk.framework tf_data_source_type=local_file tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:244 tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Found data source type: tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:244 @module=sdk.framework tf_data_source_type=local_sensitive_file tf_rpc=GetProviderSchema timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Calling provider defined DataSource Schema: tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 @module=sdk.framework tf_data_source_type=local_file tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:340 timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Called provider defined DataSource Schema: @module=sdk.framework tf_data_source_type=local_file tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:342 timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Calling provider defined DataSource Schema: tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:340 @module=sdk.framework tf_data_source_type=local_sensitive_file tf_rpc=GetProviderSchema timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Called provider defined DataSource Schema: @module=sdk.framework tf_data_source_type=local_sensitive_file tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:342 tf_provider_addr=registry.terraform.io/hashicorp/local tf_rpc=GetProviderSchema timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Checking FunctionTypes lock: tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server_functions.go:124 @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Calling provider defined Provider Functions: tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server_functions.go:142 @module=sdk.framework timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Called provider defined Provider Functions: tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server_functions.go:144 @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Found function: @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server_functions.go:163 tf_function_name=direxists timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.847Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Calling provider defined Function Definition: tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server_functions.go:91 tf_provider_addr=registry.terraform.io/hashicorp/local tf_rpc=GetProviderSchema @module=sdk.framework tf_function_name=direxists timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.848Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Called provider defined Function Definition: tf_rpc=GetProviderSchema @module=sdk.framework tf_function_name=direxists @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server_functions.go:93 tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.848Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Checking EphemeralResourceFuncs lock: tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server_ephemeralresources.go:38 @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.848Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Checking ProviderTypeName lock: tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:366 @module=sdk.framework timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.848Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Received downstream response: diagnostic_warning_count=0 tf_proto_version=5.8 tf_req_duration_ms=0 tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 diagnostic_error_count=0 tf_provider_addr=registry.terraform.io/hashicorp/local tf_rpc=GetProviderSchema @caller=github.com/hashicorp/terraform-plugin-go@v0.26.0/tfprotov5/internal/tf5serverlogging/downstream_request.go:42 @module=sdk.proto timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.848Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Announced server capabilities: tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_rpc=GetProviderSchema tf_server_capability_move_resource_state=true @module=sdk.proto tf_proto_version=5.8 tf_server_capability_get_provider_schema_optional=true tf_server_capability_plan_destroy=true @caller=github.com/hashicorp/terraform-plugin-go@v0.26.0/tfprotov5/internal/tf5serverlogging/server_capabilities.go:27 timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.848Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Served request: @caller=github.com/hashicorp/terraform-plugin-go@v0.26.0/tfprotov5/tf5server/server.go:541 @module=sdk.proto tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=a157e0f8-c1ea-2d6a-363a-30e5923764f9 tf_proto_version=5.8 tf_rpc=GetProviderSchema timestamp=2025-10-24T12:41:10.847Z
2025-10-24T12:41:10.848Z [DEBUG] No provider meta schema returned
2025-10-24T12:41:10.848Z [TRACE] GRPCProvider: Close
2025-10-24T12:41:10.849Z [DEBUG] provider.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = error reading from server: EOF"
2025-10-24T12:41:10.850Z [INFO]  provider: plugin process exited: plugin=.terraform/providers/registry.terraform.io/hashicorp/local/2.5.3/linux_amd64/terraform-provider-local_v2.5.3_x5 id=18801
2025-10-24T12:41:10.850Z [DEBUG] provider: plugin exited
2025-10-24T12:41:10.850Z [INFO]  backend/local: apply calling Apply
2025-10-24T12:41:10.850Z [DEBUG] Building and walking apply graph for NormalMode plan
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.ConfigTransformer
2025-10-24T12:41:10.850Z [TRACE] ConfigTransformer: Starting for path:
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.RootVariableTransformer
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.ModuleVariableTransformer
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.variableValidationTransformer
2025-10-24T12:41:10.850Z [TRACE] variableValidationTransformer: adding validation nodes for any existing variable evaluation nodes
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.LocalTransformer
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.OutputTransformer
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.DiffTransformer
2025-10-24T12:41:10.850Z [TRACE] DiffTransformer starting
2025-10-24T12:41:10.850Z [TRACE] DiffTransformer: found Create change for local_file.repo_readme
2025-10-24T12:41:10.850Z [TRACE] DiffTransformer: local_file.repo_readme will be represented by local_file.repo_readme
2025-10-24T12:41:10.850Z [TRACE] DiffTransformer complete
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.DeferredTransformer
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.checkTransformer
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.AttachStateTransformer
2025-10-24T12:41:10.850Z [DEBUG] Resource state not found for node "local_file.repo_readme", instance local_file.repo_readme
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.OrphanOutputTransformer
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.AttachResourceConfigTransformer
2025-10-24T12:41:10.850Z [TRACE] AttachResourceConfigTransformer: attaching to "local_file.repo_readme (expand)" (*terraform.nodeExpandApplyableResource) config from hcl.Range{Filename:"reproduce.tf", Start:hcl.Pos{Line:4, Column:1, Byte:94}, End:hcl.Pos{Line:4, Column:36, Byte:129}}
2025-10-24T12:41:10.850Z [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to local_file.repo_readme (expand)
2025-10-24T12:41:10.850Z [TRACE] AttachResourceConfigTransformer: attaching to "local_file.repo_readme" (*terraform.NodeApplyableResourceInstance) config from hcl.Range{Filename:"reproduce.tf", Start:hcl.Pos{Line:4, Column:1, Byte:94}, End:hcl.Pos{Line:4, Column:36, Byte:129}}
2025-10-24T12:41:10.850Z [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to local_file.repo_readme
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.graphTransformerMulti
2025-10-24T12:41:10.850Z [TRACE] (graphTransformerMulti) Executing graph transform *terraform.externalProviderTransformer
2025-10-24T12:41:10.850Z [TRACE] (graphTransformerMulti) Completed graph transform *terraform.externalProviderTransformer with new graph:
  local.rendered_repo_readme (expand) - *terraform.nodeExpandLocal
  local_file.repo_readme - *terraform.NodeApplyableResourceInstance
    local_file.repo_readme (expand) - *terraform.nodeExpandApplyableResource
  local_file.repo_readme (expand) - *terraform.nodeExpandApplyableResource
  ------
2025-10-24T12:41:10.850Z [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderConfigTransformer
2025-10-24T12:41:10.850Z [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderConfigTransformer (no changes)
2025-10-24T12:41:10.850Z [TRACE] (graphTransformerMulti) Executing graph transform *terraform.MissingProviderTransformer
2025-10-24T12:41:10.850Z [DEBUG] adding implicit provider configuration provider["registry.terraform.io/hashicorp/local"], implied first by local_file.repo_readme (expand)
2025-10-24T12:41:10.850Z [TRACE] (graphTransformerMulti) Completed graph transform *terraform.MissingProviderTransformer with new graph:
  local.rendered_repo_readme (expand) - *terraform.nodeExpandLocal
  local_file.repo_readme - *terraform.NodeApplyableResourceInstance
    local_file.repo_readme (expand) - *terraform.nodeExpandApplyableResource
  local_file.repo_readme (expand) - *terraform.nodeExpandApplyableResource
  provider["registry.terraform.io/hashicorp/local"] - *terraform.NodeApplyableProvider
  ------
2025-10-24T12:41:10.850Z [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderTransformer
2025-10-24T12:41:10.850Z [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/local"] serving local_file.repo_readme (expand)
2025-10-24T12:41:10.850Z [DEBUG] ProviderTransformer: "local_file.repo_readme (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/local"]
2025-10-24T12:41:10.850Z [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/local"] serving local_file.repo_readme
2025-10-24T12:41:10.850Z [DEBUG] ProviderTransformer: "local_file.repo_readme" (*terraform.NodeApplyableResourceInstance) needs provider["registry.terraform.io/hashicorp/local"]
2025-10-24T12:41:10.850Z [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderTransformer with new graph:
  local.rendered_repo_readme (expand) - *terraform.nodeExpandLocal
  local_file.repo_readme - *terraform.NodeApplyableResourceInstance
    local_file.repo_readme (expand) - *terraform.nodeExpandApplyableResource
    provider["registry.terraform.io/hashicorp/local"] - *terraform.NodeApplyableProvider
  local_file.repo_readme (expand) - *terraform.nodeExpandApplyableResource
    provider["registry.terraform.io/hashicorp/local"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/local"] - *terraform.NodeApplyableProvider
  ------
2025-10-24T12:41:10.850Z [TRACE] (graphTransformerMulti) Executing graph transform *terraform.PruneProviderTransformer
2025-10-24T12:41:10.850Z [TRACE] (graphTransformerMulti) Completed graph transform *terraform.PruneProviderTransformer (no changes)
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.RemovedModuleTransformer
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.AttachSchemaTransformer
2025-10-24T12:41:10.850Z [TRACE] terraform.contextPlugins: Schema for provider "registry.terraform.io/hashicorp/local" is in the global cache
2025-10-24T12:41:10.850Z [TRACE] AttachSchemaTransformer: attaching provider config schema to provider["registry.terraform.io/hashicorp/local"]
2025-10-24T12:41:10.850Z [TRACE] terraform.contextPlugins: Schema for provider "registry.terraform.io/hashicorp/local" is in the global cache
2025-10-24T12:41:10.850Z [TRACE] AttachSchemaTransformer: attaching resource schema to local_file.repo_readme (expand)
2025-10-24T12:41:10.850Z [TRACE] terraform.contextPlugins: Schema for provider "registry.terraform.io/hashicorp/local" is in the global cache
2025-10-24T12:41:10.850Z [TRACE] AttachSchemaTransformer: attaching resource schema to local_file.repo_readme
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.ModuleExpansionTransformer
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.ExternalReferenceTransformer
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.ReferenceTransformer
2025-10-24T12:41:10.850Z [DEBUG] ReferenceTransformer: "local_file.repo_readme (expand)" references: [local.rendered_repo_readme (expand)]
2025-10-24T12:41:10.850Z [DEBUG] ReferenceTransformer: "local.rendered_repo_readme (expand)" references: []
2025-10-24T12:41:10.850Z [DEBUG] ReferenceTransformer: "local_file.repo_readme" references: [local.rendered_repo_readme (expand)]
2025-10-24T12:41:10.850Z [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/local\"]" references: []
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.AttachDependenciesTransformer
2025-10-24T12:41:10.850Z [TRACE] AttachDependenciesTransformer: local_file.repo_readme depends on []
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.checkStartTransformer
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.ForcedCBDTransformer
2025-10-24T12:41:10.850Z [TRACE] ForcedCBDTransformer: "local_file.repo_readme (expand)" (*terraform.nodeExpandApplyableResource) has no CBD descendant, so skipping
2025-10-24T12:41:10.850Z [TRACE] ForcedCBDTransformer: "local_file.repo_readme" (*terraform.NodeApplyableResourceInstance) has no CBD descendant, so skipping
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.DestroyEdgeTransformer
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.CBDEdgeTransformer
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.pruneUnusedNodesTransformer
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.TargetsTransformer
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.ephemeralResourceCloseTransformer
2025-10-24T12:41:10.850Z [TRACE] Executing graph transform *terraform.CloseProviderTransformer
2025-10-24T12:41:10.851Z [TRACE] Executing graph transform *terraform.CloseRootModuleTransformer
2025-10-24T12:41:10.851Z [TRACE] Executing graph transform *terraform.TransitiveReductionTransformer
2025-10-24T12:41:10.851Z [TRACE] Completed graph transform:
local.rendered_repo_readme (expand) - *terraform.nodeExpandLocal
local_file.repo_readme - *terraform.NodeApplyableResourceInstance
  local_file.repo_readme (expand) - *terraform.nodeExpandApplyableResource
local_file.repo_readme (expand) - *terraform.nodeExpandApplyableResource
  local.rendered_repo_readme (expand) - *terraform.nodeExpandLocal
  provider["registry.terraform.io/hashicorp/local"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/local"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/local"] (close) - *terraform.graphNodeCloseProvider
  local_file.repo_readme - *terraform.NodeApplyableResourceInstance
root - *terraform.nodeCloseModule
  provider["registry.terraform.io/hashicorp/local"] (close) - *terraform.graphNodeCloseProvider
  ------
2025-10-24T12:41:10.851Z [TRACE] LoadSchemas: retrieving schema for provider type "registry.terraform.io/hashicorp/local"
2025-10-24T12:41:10.851Z [TRACE] terraform.contextPlugins: Schema for provider "registry.terraform.io/hashicorp/local" is in the global cache
2025-10-24T12:41:10.851Z [DEBUG] Starting graph walk: walkApply
2025-10-24T12:41:10.851Z [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/local\"]": starting visit (*terraform.NodeApplyableProvider)
2025-10-24T12:41:10.851Z [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/local\"]": belongs to
2025-10-24T12:41:10.851Z [TRACE] vertex "local.rendered_repo_readme (expand)": starting visit (*terraform.nodeExpandLocal)
2025-10-24T12:41:10.851Z [TRACE] vertex "local.rendered_repo_readme (expand)": does not belong to any module instance
2025-10-24T12:41:10.851Z [TRACE] vertex "local.rendered_repo_readme (expand)": expanding dynamic subgraph
2025-10-24T12:41:10.851Z [TRACE] Expanding local: adding local.rendered_repo_readme as *terraform.NodeLocal
2025-10-24T12:41:10.851Z [TRACE] vertex "local.rendered_repo_readme (expand)": entering dynamic subgraph
2025-10-24T12:41:10.851Z [DEBUG] created provider logger: level=trace
2025-10-24T12:41:10.851Z [INFO]  provider: configuring client automatic mTLS
2025-10-24T12:41:10.851Z [TRACE] vertex "local.rendered_repo_readme": starting visit (*terraform.NodeLocal)
2025-10-24T12:41:10.851Z [TRACE] vertex "local.rendered_repo_readme": belongs to
2025-10-24T12:41:10.851Z [ERROR] function templatefile returned an inconsistent result with args: []cty.Value{cty.StringVal("./stuff.tftpl"), cty.ObjectVal(map[string]cty.Value{"foo":cty.StringVal("bar")})}
2025-10-24T12:41:10.851Z [ERROR] vertex "local.rendered_repo_readme" error: Error in function call
2025-10-24T12:41:10.851Z [TRACE] vertex "local.rendered_repo_readme": visit complete, with errors
2025-10-24T12:41:10.851Z [TRACE] dag/walk: upstream of "root" errored, so skipping
2025-10-24T12:41:10.851Z [TRACE] vertex "local.rendered_repo_readme (expand)": dynamic subgraph encountered errors: Error in function call
2025-10-24T12:41:10.851Z [ERROR] vertex "local.rendered_repo_readme (expand)" error: Error in function call
2025-10-24T12:41:10.851Z [TRACE] vertex "local.rendered_repo_readme (expand)": visit complete, with errors
2025-10-24T12:41:10.855Z [DEBUG] provider: starting plugin: path=.terraform/providers/registry.terraform.io/hashicorp/local/2.5.3/linux_amd64/terraform-provider-local_v2.5.3_x5 args=[".terraform/providers/registry.terraform.io/hashicorp/local/2.5.3/linux_amd64/terraform-provider-local_v2.5.3_x5"]
2025-10-24T12:41:10.856Z [DEBUG] provider: plugin started: path=.terraform/providers/registry.terraform.io/hashicorp/local/2.5.3/linux_amd64/terraform-provider-local_v2.5.3_x5 pid=18809
2025-10-24T12:41:10.856Z [DEBUG] provider: waiting for RPC address: plugin=.terraform/providers/registry.terraform.io/hashicorp/local/2.5.3/linux_amd64/terraform-provider-local_v2.5.3_x5
2025-10-24T12:41:10.859Z [INFO]  provider.terraform-provider-local_v2.5.3_x5: configuring server automatic mTLS: timestamp=2025-10-24T12:41:10.859Z
2025-10-24T12:41:10.869Z [DEBUG] provider: using plugin: version=5
2025-10-24T12:41:10.869Z [DEBUG] provider.terraform-provider-local_v2.5.3_x5: plugin address: address=/tmp/plugin3844152290 network=unix timestamp=2025-10-24T12:41:10.869Z
2025-10-24T12:41:10.877Z [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/hashicorp/local\"]" provider for provider["registry.terraform.io/hashicorp/local"]
2025-10-24T12:41:10.877Z [TRACE] provider.stdio: waiting for stdio data
2025-10-24T12:41:10.877Z [TRACE] terraform.contextPlugins: Schema for provider "registry.terraform.io/hashicorp/local" is in the global cache
2025-10-24T12:41:10.877Z [TRACE] NodeApplyableProvider: configuring provider["registry.terraform.io/hashicorp/local"]
2025-10-24T12:41:10.877Z [TRACE] buildProviderConfig for provider["registry.terraform.io/hashicorp/local"]: no configuration at all
2025-10-24T12:41:10.877Z [TRACE] GRPCProvider: GetProviderSchema
2025-10-24T12:41:10.877Z [TRACE] GRPCProvider: returning cached schema: EXTRA_VALUE_AT_END=registry.terraform.io/hashicorp/local
2025-10-24T12:41:10.877Z [TRACE] GRPCProvider: ValidateProviderConfig
2025-10-24T12:41:10.877Z [TRACE] GRPCProvider: GetProviderSchema
2025-10-24T12:41:10.877Z [TRACE] GRPCProvider: returning cached schema: EXTRA_VALUE_AT_END=registry.terraform.io/hashicorp/local
2025-10-24T12:41:10.878Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Received request: @module=sdk.proto tf_proto_version=5.8 tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=95cd6193-dfcb-0ef5-e4ac-79470ae64bb6 tf_rpc=PrepareProviderConfig @caller=github.com/hashicorp/terraform-plugin-go@v0.26.0/tfprotov5/tf5server/server.go:549 timestamp=2025-10-24T12:41:10.878Z
2025-10-24T12:41:10.878Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Skipping protocol data file writing because no data directory is set. Use the TF_LOG_SDK_PROTO_DATA_DIR environment variable to enable this functionality.: @module=sdk.proto tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=95cd6193-dfcb-0ef5-e4ac-79470ae64bb6 @caller=github.com/hashicorp/terraform-plugin-go@v0.26.0/internal/logging/protocol_data.go:41 tf_proto_version=5.8 tf_rpc=PrepareProviderConfig timestamp=2025-10-24T12:41:10.878Z
2025-10-24T12:41:10.878Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Sending request downstream: tf_proto_version=5.8 tf_provider_addr=registry.terraform.io/hashicorp/local @module=sdk.proto tf_req_id=95cd6193-dfcb-0ef5-e4ac-79470ae64bb6 tf_rpc=PrepareProviderConfig @caller=github.com/hashicorp/terraform-plugin-go@v0.26.0/tfprotov5/internal/tf5serverlogging/downstream_request.go:22 timestamp=2025-10-24T12:41:10.878Z
2025-10-24T12:41:10.878Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Checking ProviderSchema lock: @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=95cd6193-dfcb-0ef5-e4ac-79470ae64bb6 tf_rpc=PrepareProviderConfig @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:389 timestamp=2025-10-24T12:41:10.878Z
2025-10-24T12:41:10.878Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Calling provider defined Provider Schema: @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:400 @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=95cd6193-dfcb-0ef5-e4ac-79470ae64bb6 tf_rpc=PrepareProviderConfig timestamp=2025-10-24T12:41:10.878Z
2025-10-24T12:41:10.878Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Called provider defined Provider Schema: tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=95cd6193-dfcb-0ef5-e4ac-79470ae64bb6 tf_rpc=PrepareProviderConfig @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:402 @module=sdk.framework timestamp=2025-10-24T12:41:10.878Z
2025-10-24T12:41:10.878Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Received downstream response: diagnostic_error_count=0 tf_proto_version=5.8 tf_req_duration_ms=0 @caller=github.com/hashicorp/terraform-plugin-go@v0.26.0/tfprotov5/internal/tf5serverlogging/downstream_request.go:42 diagnostic_warning_count=0 tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=95cd6193-dfcb-0ef5-e4ac-79470ae64bb6 tf_rpc=PrepareProviderConfig @module=sdk.proto timestamp=2025-10-24T12:41:10.878Z
2025-10-24T12:41:10.878Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Served request: tf_proto_version=5.8 tf_rpc=PrepareProviderConfig @caller=github.com/hashicorp/terraform-plugin-go@v0.26.0/tfprotov5/tf5server/server.go:570 @module=sdk.proto tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=95cd6193-dfcb-0ef5-e4ac-79470ae64bb6 timestamp=2025-10-24T12:41:10.878Z
2025-10-24T12:41:10.878Z [TRACE] GRPCProvider: ConfigureProvider
2025-10-24T12:41:10.878Z [TRACE] GRPCProvider: GetProviderSchema
2025-10-24T12:41:10.878Z [TRACE] GRPCProvider: returning cached schema: EXTRA_VALUE_AT_END=registry.terraform.io/hashicorp/local
2025-10-24T12:41:10.879Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Received request: tf_req_id=6de9e51a-de98-acca-926d-233cf7934f9b tf_proto_version=5.8 tf_provider_addr=registry.terraform.io/hashicorp/local tf_rpc=Configure @caller=github.com/hashicorp/terraform-plugin-go@v0.26.0/tfprotov5/tf5server/server.go:578 @module=sdk.proto timestamp=2025-10-24T12:41:10.878Z
2025-10-24T12:41:10.879Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Announced client capabilities: @caller=github.com/hashicorp/terraform-plugin-go@v0.26.0/tfprotov5/internal/tf5serverlogging/client_capabilities.go:38 @module=sdk.proto tf_proto_version=5.8 tf_client_capability_deferral_allowed=true tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=6de9e51a-de98-acca-926d-233cf7934f9b tf_rpc=Configure timestamp=2025-10-24T12:41:10.878Z
2025-10-24T12:41:10.879Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Sending request downstream: tf_proto_version=5.8 tf_req_id=6de9e51a-de98-acca-926d-233cf7934f9b @caller=github.com/hashicorp/terraform-plugin-go@v0.26.0/tfprotov5/internal/tf5serverlogging/downstream_request.go:22 @module=sdk.proto tf_provider_addr=registry.terraform.io/hashicorp/local tf_rpc=Configure timestamp=2025-10-24T12:41:10.878Z
2025-10-24T12:41:10.879Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Checking ProviderSchema lock: tf_req_id=6de9e51a-de98-acca-926d-233cf7934f9b tf_rpc=Configure @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server.go:389 @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local timestamp=2025-10-24T12:41:10.879Z
2025-10-24T12:41:10.879Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Calling provider defined Provider Configure: tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=6de9e51a-de98-acca-926d-233cf7934f9b tf_rpc=Configure @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server_configureprovider.go:15 @module=sdk.framework timestamp=2025-10-24T12:41:10.879Z
2025-10-24T12:41:10.879Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Called provider defined Provider Configure: tf_req_id=6de9e51a-de98-acca-926d-233cf7934f9b tf_rpc=Configure @caller=github.com/hashicorp/terraform-plugin-framework@v1.14.1/internal/fwserver/server_configureprovider.go:23 @module=sdk.framework tf_provider_addr=registry.terraform.io/hashicorp/local timestamp=2025-10-24T12:41:10.879Z
2025-10-24T12:41:10.879Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Received downstream response: @module=sdk.proto diagnostic_error_count=0 diagnostic_warning_count=0 tf_rpc=Configure tf_proto_version=5.8 tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_duration_ms=0 tf_req_id=6de9e51a-de98-acca-926d-233cf7934f9b @caller=github.com/hashicorp/terraform-plugin-go@v0.26.0/tfprotov5/internal/tf5serverlogging/downstream_request.go:42 timestamp=2025-10-24T12:41:10.879Z
2025-10-24T12:41:10.879Z [TRACE] provider.terraform-provider-local_v2.5.3_x5: Served request: tf_provider_addr=registry.terraform.io/hashicorp/local tf_req_id=6de9e51a-de98-acca-926d-233cf7934f9b tf_rpc=Configure @caller=github.com/hashicorp/terraform-plugin-go@v0.26.0/tfprotov5/tf5server/server.go:598 @module=sdk.proto tf_proto_version=5.8 timestamp=2025-10-24T12:41:10.879Z
2025-10-24T12:41:10.879Z [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/local\"]": visit complete
2025-10-24T12:41:10.879Z [TRACE] dag/walk: upstream of "local_file.repo_readme (expand)" errored, so skipping
2025-10-24T12:41:10.879Z [TRACE] dag/walk: upstream of "local_file.repo_readme" errored, so skipping
2025-10-24T12:41:10.879Z [TRACE] dag/walk: upstream of "provider[\"registry.terraform.io/hashicorp/local\"] (close)" errored, so skipping
2025-10-24T12:41:10.879Z [TRACE] dag/walk: upstream of "root" errored, so skipping
2025-10-24T12:41:10.879Z [TRACE] statemgr.Filesystem: not making a backup, because the new snapshot is identical to the old
2025-10-24T12:41:10.879Z [TRACE] statemgr.Filesystem: no state changes since last snapshot
2025-10-24T12:41:10.879Z [TRACE] statemgr.Filesystem: writing snapshot at terraform.tfstate
╷
│ Error: Error in function call
│
│   on reproduce.tf line 2, in locals:
│    2:   rendered_repo_readme = templatefile("${path.root}/stuff.tftpl", { foo = "bar" })
│     ├────────────────
│     │ while calling templatefile(path, vars)
│     │ path.root is "."
│
│ Call to function "templatefile" failed: function returned an inconsistent result.
╵
2025-10-24T12:41:10.882Z [TRACE] statemgr.Filesystem: removing lock metadata file .terraform.tfstate.lock.info
2025-10-24T12:41:10.883Z [TRACE] statemgr.Filesystem: unlocking terraform.tfstate using fcntl flock
2025-10-24T12:41:10.883Z [DEBUG] provider.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = error reading from server: EOF"
2025-10-24T12:41:10.884Z [INFO]  provider: plugin process

Expected Behavior

Up until terraform 1.12.2 included, we could generate some readmes, including a timestamp of when file was last generated.

Actual Behavior

With 1.13.3, or 1.14.0-rc1, terraform returns an error:

╷
│ Error: Error in function call
│
│   on reproduce.tf line 2, in locals:
│    2:   rendered_repo_readme = templatefile("${path.root}/stuff.tftpl", { foo = "bar" })
│     ├────────────────
│     │ while calling templatefile(path, vars)
│     │ path.root is "."
│
│ Call to function "templatefile" failed: function returned an inconsistent result.

Steps to Reproduce

• terraform init
• terraform apply

Additional Context

No response

References

No response

Generative AI / LLM assisted development?

No response

[jbardin]

Hi @faust64,

Thanks for filling the issue. This is as intentional change made in #37001 to avoid corrupted data and crashes during apply. All non-ephemeral data must evaluate consistently between plan and apply, and if you were to change the stuff.tftpl file between plan and apply you would see that it causes terraform to return a provider error because it caused the local_file plan to become invalid.

The timestamp function from within the template however it an interesting loophole, but it should not cause this use case to fail because timestamp will be unknown until the final apply step. I think the nesting of the function call from within a template threw off some of the expectations here, but it shouldn't be too hard to pick up the unknown case wherever it was missed.