Skip to content

Instantly share code, notes, and snippets.

@alisdair

alisdair/crash.log Secret

Created September 18, 2020 17:50
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save alisdair/41b3d884a275f3d15b44dcd746d8fd01 to your computer and use it in GitHub Desktop.
Save alisdair/41b3d884a275f3d15b44dcd746d8fd01 to your computer and use it in GitHub Desktop.
Download ZIP
Raw
crash.log
2020/09/18 13:49:39 [INFO] Terraform version: 0.14.0 dev
2020/09/18 13:49:39 [INFO] Go runtime version: go1.14.7
2020/09/18 13:49:39 [INFO] CLI args: []string{"/Users/alisdair/go/bin/terraform", "apply", "-auto-approve"}
2020/09/18 13:49:39 [DEBUG] Attempting to open CLI config file: /Users/alisdair/.terraformrc
2020/09/18 13:49:39 [DEBUG] File doesn't exist, but doesn't need to. Ignoring.
2020/09/18 13:49:39 [DEBUG] checking for credentials in "/Users/alisdair/.terraform.d/plugins"
2020/09/18 13:49:39 [WARN] found legacy credentials "terraform-credentials-env"
2020/09/18 13:49:39 [WARN] found legacy credentials "terraform-credentials-keychain"
2020/09/18 13:49:39 [DEBUG] ignoring non-existing provider search directory terraform.d/plugins
2020/09/18 13:49:39 [DEBUG] will search for provider plugins in /Users/alisdair/.terraform.d/plugins
2020/09/18 13:49:39 [TRACE] getproviders.SearchLocalDirectory: /Users/alisdair/.terraform.d/plugins is a symlink to /Users/alisdair/.terraform.d/plugins
2020/09/18 13:49:39 [DEBUG] ignoring non-existing provider search directory /Users/alisdair/Library/Application Support/io.terraform/plugins
2020/09/18 13:49:39 [DEBUG] ignoring non-existing provider search directory /Library/Application Support/io.terraform/plugins
2020/09/18 13:49:39 [INFO] CLI command args: []string{"apply", "-auto-approve"}
2020/09/18 13:49:39 [TRACE] Meta.Backend: no config given or present on disk, so returning nil config
2020/09/18 13:49:39 [TRACE] Meta.Backend: backend has not previously been initialized in this working directory
2020/09/18 13:49:39 [DEBUG] New state was assigned lineage "afe895d2-68a9-98d7-30f8-d9d0230e5897"
2020/09/18 13:49:39 [TRACE] Meta.Backend: using default local state only (no backend configuration, and no existing initialized backend)
2020/09/18 13:49:39 [TRACE] Meta.Backend: instantiated backend of type <nil>
2020/09/18 13:49:39 [TRACE] providercache.fillMetaCache: scanning directory .terraform/plugins
2020/09/18 13:49:39 [TRACE] getproviders.SearchLocalDirectory: .terraform/plugins is a symlink to .terraform/plugins
2020/09/18 13:49:39 [TRACE] getproviders.SearchLocalDirectory: found registry.terraform.io/hashicorp/archive v1.3.0 for darwin_amd64 at .terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64
2020/09/18 13:49:39 [TRACE] getproviders.SearchLocalDirectory: found registry.terraform.io/hashicorp/null v2.1.2 for darwin_amd64 at .terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64
2020/09/18 13:49:39 [TRACE] providercache.fillMetaCache: including .terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64 as a candidate package for registry.terraform.io/hashicorp/null 2.1.2
2020/09/18 13:49:39 [TRACE] providercache.fillMetaCache: including .terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64 as a candidate package for registry.terraform.io/hashicorp/archive 1.3.0
2020/09/18 13:49:39 [TRACE] providercache.fillMetaCache: using cached result from previous scan of .terraform/plugins
2020/09/18 13:49:39 [DEBUG] checking for provisioner in "."
2020/09/18 13:49:39 [DEBUG] checking for provisioner in "/Users/alisdair/go/bin"
2020/09/18 13:49:39 [DEBUG] checking for provisioner in "/Users/alisdair/.terraform.d/plugins"
2020/09/18 13:49:39 [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
2020/09/18 13:49:39 [TRACE] Meta.Backend: backend <nil> does not support operations, so wrapping it in a local backend
2020/09/18 13:49:39 [INFO] backend/local: starting Apply operation
2020/09/18 13:49:39 [TRACE] backend/local: requesting state manager for workspace "default"
2020/09/18 13:49:39 [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
2020/09/18 13:49:39 [TRACE] backend/local: requesting state lock for workspace "default"
2020/09/18 13:49:39 [TRACE] statemgr.Filesystem: preparing to manage state snapshots at terraform.tfstate
2020/09/18 13:49:39 [TRACE] statemgr.Filesystem: no previously-stored snapshot exists
2020/09/18 13:49:39 [TRACE] statemgr.Filesystem: locking terraform.tfstate using fcntl flock
2020/09/18 13:49:39 [TRACE] statemgr.Filesystem: writing lock metadata to .terraform.tfstate.lock.info
2020/09/18 13:49:39 [TRACE] backend/local: reading remote state for workspace "default"
2020/09/18 13:49:39 [TRACE] statemgr.Filesystem: reading latest snapshot from terraform.tfstate
2020/09/18 13:49:39 [TRACE] statemgr.Filesystem: snapshot file has nil snapshot, but that's okay
2020/09/18 13:49:39 [TRACE] statemgr.Filesystem: read nil snapshot
2020/09/18 13:49:39 [TRACE] backend/local: retrieving local state snapshot for workspace "default"
2020/09/18 13:49:39 [TRACE] backend/local: building context for current working directory
2020/09/18 13:49:39 [TRACE] terraform.NewContext: starting
2020/09/18 13:49:39 [TRACE] terraform.NewContext: loading provider schemas
2020/09/18 13:49:39 [TRACE] LoadSchemas: retrieving schema for provider type "registry.terraform.io/hashicorp/archive"
2020-09-18T13:49:39.744-0400 [INFO] plugin: configuring client automatic mTLS
2020-09-18T13:49:39.768-0400 [DEBUG] plugin: starting plugin: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 args=[.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4]
2020-09-18T13:49:39.770-0400 [DEBUG] plugin: plugin started: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 pid=11940
2020-09-18T13:49:39.770-0400 [DEBUG] plugin: waiting for RPC address: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4
2020-09-18T13:49:39.780-0400 [INFO] plugin.terraform-provider-archive_v1.3.0_x4: configuring server automatic mTLS: timestamp=2020-09-18T13:49:39.780-0400
2020-09-18T13:49:39.810-0400 [DEBUG] plugin.terraform-provider-archive_v1.3.0_x4: plugin address: network=unix address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin289282395 timestamp=2020-09-18T13:49:39.810-0400
2020-09-18T13:49:39.810-0400 [DEBUG] plugin: using plugin: version=5
2020/09/18 13:49:39 [TRACE] GRPCProvider: GetSchema
2020-09-18T13:49:39.862-0400 [TRACE] plugin.stdio: waiting for stdio data
2020-09-18T13:49:39.863-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2020/09/18 13:49:39 [TRACE] No provider meta schema returned
2020/09/18 13:49:39 [TRACE] GRPCProvider: Close
2020-09-18T13:49:39.865-0400 [DEBUG] plugin: plugin process exited: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 pid=11940
2020-09-18T13:49:39.865-0400 [DEBUG] plugin: plugin exited
2020/09/18 13:49:39 [TRACE] LoadSchemas: retrieving schema for provider type "registry.terraform.io/hashicorp/null"
2020-09-18T13:49:39.866-0400 [INFO] plugin: configuring client automatic mTLS
2020-09-18T13:49:39.891-0400 [DEBUG] plugin: starting plugin: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 args=[.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4]
2020-09-18T13:49:39.893-0400 [DEBUG] plugin: plugin started: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 pid=11941
2020-09-18T13:49:39.893-0400 [DEBUG] plugin: waiting for RPC address: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4
2020-09-18T13:49:39.901-0400 [INFO] plugin.terraform-provider-null_v2.1.2_x4: configuring server automatic mTLS: timestamp=2020-09-18T13:49:39.901-0400
2020-09-18T13:49:39.926-0400 [DEBUG] plugin: using plugin: version=5
2020-09-18T13:49:39.926-0400 [DEBUG] plugin.terraform-provider-null_v2.1.2_x4: plugin address: address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin385469424 network=unix timestamp=2020-09-18T13:49:39.926-0400
2020/09/18 13:49:39 [TRACE] GRPCProvider: GetSchema
2020-09-18T13:49:39.977-0400 [TRACE] plugin.stdio: waiting for stdio data
2020-09-18T13:49:39.978-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2020/09/18 13:49:39 [TRACE] No provider meta schema returned
2020/09/18 13:49:39 [TRACE] GRPCProvider: Close
2020-09-18T13:49:39.980-0400 [DEBUG] plugin: plugin process exited: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 pid=11941
2020-09-18T13:49:39.980-0400 [DEBUG] plugin: plugin exited
2020/09/18 13:49:39 [TRACE] LoadSchemas: retrieving schema for provisioner "local-exec"
2020-09-18T13:49:39.980-0400 [DEBUG] plugin: starting plugin: path=/Users/alisdair/go/bin/terraform args=[/Users/alisdair/go/bin/terraform, internal-plugin, provisioner, local-exec]
2020-09-18T13:49:39.982-0400 [DEBUG] plugin: plugin started: path=/Users/alisdair/go/bin/terraform pid=11942
2020-09-18T13:49:39.982-0400 [DEBUG] plugin: waiting for RPC address: path=/Users/alisdair/go/bin/terraform
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] Terraform version: 0.14.0 dev
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] Go runtime version: go1.14.7
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] CLI args: []string{"/Users/alisdair/go/bin/terraform", "internal-plugin", "provisioner", "local-exec"}
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] Attempting to open CLI config file: /Users/alisdair/.terraformrc
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] File doesn't exist, but doesn't need to. Ignoring.
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] checking for credentials in "/Users/alisdair/.terraform.d/plugins"
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [WARN] found legacy credentials "terraform-credentials-env"
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [WARN] found legacy credentials "terraform-credentials-keychain"
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory terraform.d/plugins
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] will search for provider plugins in /Users/alisdair/.terraform.d/plugins
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [TRACE] getproviders.SearchLocalDirectory: /Users/alisdair/.terraform.d/plugins is a symlink to /Users/alisdair/.terraform.d/plugins
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory /Users/alisdair/Library/Application Support/io.terraform/plugins
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory /Library/Application Support/io.terraform/plugins
2020-09-18T13:49:40.036-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] CLI command args: []string{"internal-plugin", "provisioner", "local-exec"}
2020-09-18T13:49:40.037-0400 [DEBUG] plugin.terraform: local-exec-provisioner (internal) 2020/09/18 13:49:40 [INFO] Starting provisioner plugin local-exec
2020-09-18T13:49:40.037-0400 [DEBUG] plugin.terraform: plugin address: network=unix address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin893486730 timestamp=2020-09-18T13:49:40.037-0400
2020-09-18T13:49:40.037-0400 [DEBUG] plugin: using plugin: version=5
2020-09-18T13:49:40.038-0400 [TRACE] plugin.stdio: waiting for stdio data
2020-09-18T13:49:40.040-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = transport is closing"
2020-09-18T13:49:40.045-0400 [DEBUG] plugin: plugin process exited: path=/Users/alisdair/go/bin/terraform pid=11942
2020-09-18T13:49:40.045-0400 [DEBUG] plugin: plugin exited
2020/09/18 13:49:40 [TRACE] terraform.NewContext: complete
2020/09/18 13:49:40 [TRACE] backend/local: finished building terraform.Context
2020/09/18 13:49:40 [TRACE] backend/local: requesting interactive input, if necessary
2020/09/18 13:49:40 [TRACE] Context.Input: Prompting for provider arguments
2020/09/18 13:49:40 [TRACE] Context.Input: Provider provider.null implied by resource block at main.tf:1,1-39
2020/09/18 13:49:40 [TRACE] Context.Input: Provider provider.archive implied by data block at main.tf:7,1-26
2020/09/18 13:49:40 [TRACE] Context.Input: Input for provider.null: map[string]cty.Value{}
2020/09/18 13:49:40 [TRACE] Context.Input: Input for provider.archive: map[string]cty.Value{}
2020/09/18 13:49:40 [TRACE] backend/local: running validation operation
2020/09/18 13:49:40 [INFO] terraform: building graph: GraphTypeValidate
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ConfigTransformer
2020/09/18 13:49:40 [TRACE] ConfigTransformer: Starting for path:
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ConfigTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.LocalTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.LocalTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.OutputTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.OutputTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.OrphanResourceInstanceTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.OrphanResourceInstanceTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.StateTransformer
2020/09/18 13:49:40 [TRACE] StateTransformer: state is empty, so nothing to do
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.StateTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.OrphanOutputTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.OrphanOutputTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachResourceConfigTransformer
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching to "null_resource.create_file" (*terraform.NodeValidatableResource) config from main.tf:1,1-39
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to null_resource.create_file
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching to "data.archive_file.foo" (*terraform.NodeValidatableResource) config from hcl.Range{Filename:"main.tf", Start:hcl.Pos{Line:7, Column:1, Byte:137}, End:hcl.Pos{Line:7, Column:26, Byte:162}}
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to data.archive_file.foo
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachResourceConfigTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachStateTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.RootVariableTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.RootVariableTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.MissingProvisionerTransformer
2020/09/18 13:49:40 [TRACE] MissingProviderTransformer: added implicit provisioner local-exec, first implied by null_resource.create_file
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.MissingProvisionerTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ProvisionerTransformer
2020/09/18 13:49:40 [TRACE] ProvisionerTransformer: null_resource.create_file is provisioned by local-exec ("provisioner.local-exec")
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ProvisionerTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ModuleVariableTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ModuleVariableTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.graphTransformerMulti
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderConfigTransformer
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderConfigTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.MissingProviderTransformer
2020/09/18 13:49:40 [DEBUG] adding implicit provider configuration provider["registry.terraform.io/hashicorp/null"], implied first by null_resource.create_file
2020/09/18 13:49:40 [DEBUG] adding implicit provider configuration provider["registry.terraform.io/hashicorp/archive"], implied first by data.archive_file.foo
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.MissingProviderTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderTransformer
2020/09/18 13:49:40 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/null"] serving null_resource.create_file
2020/09/18 13:49:40 [DEBUG] ProviderTransformer: "null_resource.create_file" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/hashicorp/null"]
2020/09/18 13:49:40 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/archive"] serving data.archive_file.foo
2020/09/18 13:49:40 [DEBUG] ProviderTransformer: "data.archive_file.foo" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/hashicorp/archive"]
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.PruneProviderTransformer
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.PruneProviderTransformer (no changes)
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ParentProviderTransformer
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ParentProviderTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.graphTransformerMulti with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.RemovedModuleTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.RemovedModuleTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachSchemaTransformer
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching resource schema to null_resource.create_file
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching provisioner "local-exec" config schema to null_resource.create_file
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching resource schema to data.archive_file.foo
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching provider config schema to provider["registry.terraform.io/hashicorp/null"]
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching provider config schema to provider["registry.terraform.io/hashicorp/archive"]
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachSchemaTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ModuleExpansionTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ModuleExpansionTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ReferenceTransformer
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "null_resource.create_file" references: []
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "data.archive_file.foo" references: [null_resource.create_file]
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "provisioner.local-exec" references: []
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/null\"]" references: []
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/archive\"]" references: []
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ReferenceTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.attachDataResourceDependenciesTransformer
2020/09/18 13:49:40 [TRACE] attachDataDependenciesTransformer: data.archive_file.foo depends on [null_resource.create_file]
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.attachDataResourceDependenciesTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.TargetsTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ForcedCBDTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ForcedCBDTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CountBoundaryTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CountBoundaryTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CloseProviderTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CloseProviderTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CloseProvisionerTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CloseProvisionerTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
null_resource.create_file - *terraform.NodeValidatableResource
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CloseRootModuleTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CloseRootModuleTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
null_resource.create_file - *terraform.NodeValidatableResource
root - *terraform.nodeCloseModule
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.TransitiveReductionTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.TransitiveReductionTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file - *terraform.NodeValidatableResource
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
null_resource.create_file - *terraform.NodeValidatableResource
root - *terraform.nodeCloseModule
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
------
2020/09/18 13:49:40 [DEBUG] Starting graph walk: walkValidate
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provisioner.local-exec"
2020/09/18 13:49:40 [TRACE] vertex "provisioner.local-exec": starting visit (*terraform.NodeProvisioner)
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/archive\"]"
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/null\"]"
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/archive\"]": starting visit (*terraform.NodeApplyableProvider)
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/null\"]": starting visit (*terraform.NodeApplyableProvider)
2020-09-18T13:49:40.048-0400 [DEBUG] plugin: starting plugin: path=/Users/alisdair/go/bin/terraform args=[/Users/alisdair/go/bin/terraform, internal-plugin, provisioner, local-exec]
2020-09-18T13:49:40.049-0400 [INFO] plugin: configuring client automatic mTLS
2020-09-18T13:49:40.049-0400 [DEBUG] plugin: plugin started: path=/Users/alisdair/go/bin/terraform pid=11944
2020-09-18T13:49:40.049-0400 [DEBUG] plugin: waiting for RPC address: path=/Users/alisdair/go/bin/terraform
2020-09-18T13:49:40.080-0400 [DEBUG] plugin: starting plugin: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 args=[.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4]
2020-09-18T13:49:40.082-0400 [DEBUG] plugin: plugin started: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 pid=11946
2020-09-18T13:49:40.082-0400 [DEBUG] plugin: waiting for RPC address: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4
2020-09-18T13:49:40.093-0400 [INFO] plugin.terraform-provider-archive_v1.3.0_x4: configuring server automatic mTLS: timestamp=2020-09-18T13:49:40.093-0400
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] Terraform version: 0.14.0 dev
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] Go runtime version: go1.14.7
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] CLI args: []string{"/Users/alisdair/go/bin/terraform", "internal-plugin", "provisioner", "local-exec"}
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] Attempting to open CLI config file: /Users/alisdair/.terraformrc
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] File doesn't exist, but doesn't need to. Ignoring.
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] checking for credentials in "/Users/alisdair/.terraform.d/plugins"
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [WARN] found legacy credentials "terraform-credentials-env"
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [WARN] found legacy credentials "terraform-credentials-keychain"
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory terraform.d/plugins
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] will search for provider plugins in /Users/alisdair/.terraform.d/plugins
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [TRACE] getproviders.SearchLocalDirectory: /Users/alisdair/.terraform.d/plugins is a symlink to /Users/alisdair/.terraform.d/plugins
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory /Users/alisdair/Library/Application Support/io.terraform/plugins
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory /Library/Application Support/io.terraform/plugins
2020-09-18T13:49:40.105-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] CLI command args: []string{"internal-plugin", "provisioner", "local-exec"}
2020-09-18T13:49:40.107-0400 [DEBUG] plugin.terraform: local-exec-provisioner (internal) 2020/09/18 13:49:40 [INFO] Starting provisioner plugin local-exec
2020-09-18T13:49:40.108-0400 [DEBUG] plugin: using plugin: version=5
2020-09-18T13:49:40.108-0400 [DEBUG] plugin.terraform: plugin address: address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin053579316 network=unix timestamp=2020-09-18T13:49:40.107-0400
2020/09/18 13:49:40 [TRACE] vertex "provisioner.local-exec": visit complete
2020-09-18T13:49:40.110-0400 [TRACE] plugin.stdio: waiting for stdio data
2020-09-18T13:49:40.125-0400 [DEBUG] plugin: using plugin: version=5
2020-09-18T13:49:40.125-0400 [DEBUG] plugin.terraform-provider-archive_v1.3.0_x4: plugin address: address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin254569497 network=unix timestamp=2020-09-18T13:49:40.125-0400
2020/09/18 13:49:40 [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/hashicorp/archive\"]" provider for provider["registry.terraform.io/hashicorp/archive"]
2020/09/18 13:49:40 [TRACE] buildProviderConfig for provider["registry.terraform.io/hashicorp/archive"]: no configuration at all
2020/09/18 13:49:40 [TRACE] GRPCProvider: GetSchema
2020-09-18T13:49:40.177-0400 [TRACE] plugin.stdio: waiting for stdio data
2020-09-18T13:49:40.178-0400 [INFO] plugin: configuring client automatic mTLS
2020-09-18T13:49:40.178-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2020/09/18 13:49:40 [TRACE] No provider meta schema returned
2020/09/18 13:49:40 [TRACE] GRPCProvider: PrepareProviderConfig
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/archive\"]": visit complete
2020-09-18T13:49:40.204-0400 [DEBUG] plugin: starting plugin: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 args=[.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4]
2020-09-18T13:49:40.205-0400 [DEBUG] plugin: plugin started: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 pid=11947
2020-09-18T13:49:40.205-0400 [DEBUG] plugin: waiting for RPC address: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4
2020-09-18T13:49:40.214-0400 [INFO] plugin.terraform-provider-null_v2.1.2_x4: configuring server automatic mTLS: timestamp=2020-09-18T13:49:40.214-0400
2020-09-18T13:49:40.240-0400 [DEBUG] plugin.terraform-provider-null_v2.1.2_x4: plugin address: address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin654093766 network=unix timestamp=2020-09-18T13:49:40.240-0400
2020-09-18T13:49:40.240-0400 [DEBUG] plugin: using plugin: version=5
2020-09-18T13:49:40.292-0400 [TRACE] plugin.stdio: waiting for stdio data
2020/09/18 13:49:40 [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/hashicorp/null\"]" provider for provider["registry.terraform.io/hashicorp/null"]
2020/09/18 13:49:40 [TRACE] buildProviderConfig for provider["registry.terraform.io/hashicorp/null"]: no configuration at all
2020/09/18 13:49:40 [TRACE] GRPCProvider: GetSchema
2020-09-18T13:49:40.293-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2020/09/18 13:49:40 [TRACE] No provider meta schema returned
2020/09/18 13:49:40 [TRACE] GRPCProvider: PrepareProviderConfig
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/null\"]": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "null_resource.create_file"
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": starting visit (*terraform.NodeValidatableResource)
2020/09/18 13:49:40 [TRACE] GRPCProvider: ValidateResourceTypeConfig
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provisioner.local-exec (close)"
2020/09/18 13:49:40 [TRACE] vertex "provisioner.local-exec (close)": starting visit (*terraform.graphNodeCloseProvisioner)
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "data.archive_file.foo"
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": starting visit (*terraform.NodeValidatableResource)
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/null\"] (close)"
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/null\"] (close)": starting visit (*terraform.graphNodeCloseProvider)
2020/09/18 13:49:40 [TRACE] GRPCProvider: Close
2020/09/18 13:49:40 [TRACE] GRPCProvider: ValidateDataSourceConfig
2020-09-18T13:49:40.297-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = transport is closing"
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "meta.count-boundary (EachMode fixup)"
2020/09/18 13:49:40 [TRACE] vertex "meta.count-boundary (EachMode fixup)": starting visit (*terraform.NodeCountBoundary)
2020/09/18 13:49:40 [TRACE] vertex "meta.count-boundary (EachMode fixup)": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/archive\"] (close)"
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/archive\"] (close)": starting visit (*terraform.graphNodeCloseProvider)
2020-09-18T13:49:40.298-0400 [DEBUG] plugin: plugin process exited: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 pid=11947
2020-09-18T13:49:40.298-0400 [DEBUG] plugin: plugin exited
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/null\"] (close)": visit complete
2020/09/18 13:49:40 [TRACE] GRPCProvider: Close
2020-09-18T13:49:40.300-0400 [DEBUG] plugin: plugin process exited: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 pid=11946
2020-09-18T13:49:40.300-0400 [DEBUG] plugin: plugin exited
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/archive\"] (close)": visit complete
2020-09-18T13:49:40.303-0400 [DEBUG] plugin: plugin process exited: path=/Users/alisdair/go/bin/terraform pid=11944
2020-09-18T13:49:40.303-0400 [DEBUG] plugin: plugin exited
2020/09/18 13:49:40 [TRACE] vertex "provisioner.local-exec (close)": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "root"
2020/09/18 13:49:40 [TRACE] vertex "root": starting visit (*terraform.nodeCloseModule)
2020/09/18 13:49:40 [TRACE] vertex "root": visit complete
2020/09/18 13:49:40 [INFO] backend/local: apply calling Plan
2020/09/18 13:49:40 [INFO] terraform: building graph: GraphTypePlan
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ConfigTransformer
2020/09/18 13:49:40 [TRACE] ConfigTransformer: Starting for path:
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ConfigTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.LocalTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.LocalTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.OutputTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.OutputTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.OrphanResourceInstanceTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.OrphanResourceInstanceTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.StateTransformer
2020/09/18 13:49:40 [TRACE] StateTransformer: state is empty, so nothing to do
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.StateTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.OrphanOutputTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.OrphanOutputTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachResourceConfigTransformer
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching to "null_resource.create_file (expand)" (*terraform.nodeExpandPlannableResource) config from main.tf:1,1-39
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to null_resource.create_file (expand)
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching to "data.archive_file.foo (expand)" (*terraform.nodeExpandPlannableResource) config from hcl.Range{Filename:"main.tf", Start:hcl.Pos{Line:7, Column:1, Byte:137}, End:hcl.Pos{Line:7, Column:26, Byte:162}}
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to data.archive_file.foo (expand)
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachResourceConfigTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachStateTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.RootVariableTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.RootVariableTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.MissingProvisionerTransformer
2020/09/18 13:49:40 [TRACE] MissingProviderTransformer: added implicit provisioner local-exec, first implied by null_resource.create_file (expand)
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.MissingProvisionerTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ProvisionerTransformer
2020/09/18 13:49:40 [TRACE] ProvisionerTransformer: null_resource.create_file (expand) is provisioned by local-exec ("provisioner.local-exec")
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ProvisionerTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ModuleVariableTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ModuleVariableTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.graphTransformerMulti
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderConfigTransformer
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderConfigTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.MissingProviderTransformer
2020/09/18 13:49:40 [DEBUG] adding implicit provider configuration provider["registry.terraform.io/hashicorp/null"], implied first by null_resource.create_file (expand)
2020/09/18 13:49:40 [DEBUG] adding implicit provider configuration provider["registry.terraform.io/hashicorp/archive"], implied first by data.archive_file.foo (expand)
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.MissingProviderTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderTransformer
2020/09/18 13:49:40 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/null"] serving null_resource.create_file (expand)
2020/09/18 13:49:40 [DEBUG] ProviderTransformer: "null_resource.create_file (expand)" (*terraform.nodeExpandPlannableResource) needs provider["registry.terraform.io/hashicorp/null"]
2020/09/18 13:49:40 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/archive"] serving data.archive_file.foo (expand)
2020/09/18 13:49:40 [DEBUG] ProviderTransformer: "data.archive_file.foo (expand)" (*terraform.nodeExpandPlannableResource) needs provider["registry.terraform.io/hashicorp/archive"]
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.PruneProviderTransformer
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.PruneProviderTransformer (no changes)
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ParentProviderTransformer
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ParentProviderTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.graphTransformerMulti with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.RemovedModuleTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.RemovedModuleTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachSchemaTransformer
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching provider config schema to provider["registry.terraform.io/hashicorp/archive"]
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching resource schema to null_resource.create_file (expand)
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching provisioner "local-exec" config schema to null_resource.create_file (expand)
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching resource schema to data.archive_file.foo (expand)
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching provider config schema to provider["registry.terraform.io/hashicorp/null"]
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachSchemaTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ModuleExpansionTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ModuleExpansionTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ReferenceTransformer
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "data.archive_file.foo (expand)" references: [null_resource.create_file (expand)]
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "provisioner.local-exec" references: []
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/null\"]" references: []
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/archive\"]" references: []
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "null_resource.create_file (expand)" references: []
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ReferenceTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.attachDataResourceDependenciesTransformer
2020/09/18 13:49:40 [TRACE] attachDataDependenciesTransformer: data.archive_file.foo depends on [null_resource.create_file]
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.attachDataResourceDependenciesTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.TargetsTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ForcedCBDTransformer
2020/09/18 13:49:40 [TRACE] ForcedCBDTransformer: "null_resource.create_file (expand)" (*terraform.nodeExpandPlannableResource) has no CBD descendent, so skipping
2020/09/18 13:49:40 [TRACE] ForcedCBDTransformer: "data.archive_file.foo (expand)" (*terraform.nodeExpandPlannableResource) has no CBD descendent, so skipping
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ForcedCBDTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CountBoundaryTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CountBoundaryTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CloseProviderTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CloseProviderTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CloseProvisionerTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CloseProvisionerTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CloseRootModuleTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CloseRootModuleTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
root - *terraform.nodeCloseModule
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.TransitiveReductionTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.TransitiveReductionTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
root - *terraform.nodeCloseModule
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
------
2020/09/18 13:49:40 [DEBUG] Starting graph walk: walkPlan
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provisioner.local-exec"
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/archive\"]"
2020/09/18 13:49:40 [TRACE] vertex "provisioner.local-exec": starting visit (*terraform.NodeProvisioner)
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/null\"]"
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/null\"]": starting visit (*terraform.NodeApplyableProvider)
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/archive\"]": starting visit (*terraform.NodeApplyableProvider)
2020-09-18T13:49:40.306-0400 [DEBUG] plugin: starting plugin: path=/Users/alisdair/go/bin/terraform args=[/Users/alisdair/go/bin/terraform, internal-plugin, provisioner, local-exec]
2020-09-18T13:49:40.307-0400 [INFO] plugin: configuring client automatic mTLS
2020-09-18T13:49:40.308-0400 [DEBUG] plugin: plugin started: path=/Users/alisdair/go/bin/terraform pid=11948
2020-09-18T13:49:40.308-0400 [DEBUG] plugin: waiting for RPC address: path=/Users/alisdair/go/bin/terraform
2020-09-18T13:49:40.339-0400 [DEBUG] plugin: starting plugin: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 args=[.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4]
2020-09-18T13:49:40.343-0400 [DEBUG] plugin: plugin started: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 pid=11950
2020-09-18T13:49:40.343-0400 [DEBUG] plugin: waiting for RPC address: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4
2020-09-18T13:49:40.352-0400 [INFO] plugin.terraform-provider-null_v2.1.2_x4: configuring server automatic mTLS: timestamp=2020-09-18T13:49:40.351-0400
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] Terraform version: 0.14.0 dev
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] Go runtime version: go1.14.7
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] CLI args: []string{"/Users/alisdair/go/bin/terraform", "internal-plugin", "provisioner", "local-exec"}
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] Attempting to open CLI config file: /Users/alisdair/.terraformrc
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] File doesn't exist, but doesn't need to. Ignoring.
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] checking for credentials in "/Users/alisdair/.terraform.d/plugins"
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [WARN] found legacy credentials "terraform-credentials-env"
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [WARN] found legacy credentials "terraform-credentials-keychain"
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory terraform.d/plugins
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] will search for provider plugins in /Users/alisdair/.terraform.d/plugins
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [TRACE] getproviders.SearchLocalDirectory: /Users/alisdair/.terraform.d/plugins is a symlink to /Users/alisdair/.terraform.d/plugins
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory /Users/alisdair/Library/Application Support/io.terraform/plugins
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory /Library/Application Support/io.terraform/plugins
2020-09-18T13:49:40.359-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] CLI command args: []string{"internal-plugin", "provisioner", "local-exec"}
2020-09-18T13:49:40.361-0400 [DEBUG] plugin.terraform: local-exec-provisioner (internal) 2020/09/18 13:49:40 [INFO] Starting provisioner plugin local-exec
2020-09-18T13:49:40.361-0400 [DEBUG] plugin.terraform: plugin address: address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin794784624 network=unix timestamp=2020-09-18T13:49:40.360-0400
2020-09-18T13:49:40.361-0400 [DEBUG] plugin: using plugin: version=5
2020/09/18 13:49:40 [TRACE] vertex "provisioner.local-exec": visit complete
2020-09-18T13:49:40.361-0400 [TRACE] plugin.stdio: waiting for stdio data
2020-09-18T13:49:40.381-0400 [DEBUG] plugin.terraform-provider-null_v2.1.2_x4: plugin address: address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin018834565 network=unix timestamp=2020-09-18T13:49:40.381-0400
2020-09-18T13:49:40.381-0400 [DEBUG] plugin: using plugin: version=5
2020/09/18 13:49:40 [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/hashicorp/null\"]" provider for provider["registry.terraform.io/hashicorp/null"]
2020-09-18T13:49:40.431-0400 [TRACE] plugin.stdio: waiting for stdio data
2020-09-18T13:49:40.432-0400 [INFO] plugin: configuring client automatic mTLS
2020-09-18T13:49:40.432-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2020-09-18T13:49:40.456-0400 [DEBUG] plugin: starting plugin: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 args=[.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4]
2020-09-18T13:49:40.458-0400 [DEBUG] plugin: plugin started: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 pid=11951
2020-09-18T13:49:40.458-0400 [DEBUG] plugin: waiting for RPC address: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4
2020-09-18T13:49:40.468-0400 [INFO] plugin.terraform-provider-archive_v1.3.0_x4: configuring server automatic mTLS: timestamp=2020-09-18T13:49:40.468-0400
2020-09-18T13:49:40.494-0400 [DEBUG] plugin.terraform-provider-archive_v1.3.0_x4: plugin address: address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin492946994 network=unix timestamp=2020-09-18T13:49:40.493-0400
2020-09-18T13:49:40.494-0400 [DEBUG] plugin: using plugin: version=5
2020/09/18 13:49:40 [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/hashicorp/archive\"]" provider for provider["registry.terraform.io/hashicorp/archive"]
2020-09-18T13:49:40.543-0400 [TRACE] plugin.stdio: waiting for stdio data
2020/09/18 13:49:40 [TRACE] buildProviderConfig for provider["registry.terraform.io/hashicorp/archive"]: no configuration at all
2020/09/18 13:49:40 [TRACE] GRPCProvider: GetSchema
2020/09/18 13:49:40 [TRACE] buildProviderConfig for provider["registry.terraform.io/hashicorp/null"]: no configuration at all
2020/09/18 13:49:40 [TRACE] GRPCProvider: GetSchema
2020-09-18T13:49:40.543-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2020/09/18 13:49:40 [TRACE] No provider meta schema returned
2020/09/18 13:49:40 [TRACE] No provider meta schema returned
2020/09/18 13:49:40 [TRACE] GRPCProvider: Configure
2020/09/18 13:49:40 [TRACE] GRPCProvider: Configure
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/null\"]": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "null_resource.create_file (expand)"
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file (expand)": starting visit (*terraform.nodeExpandPlannableResource)
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file (expand)": expanding dynamic subgraph
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/archive\"]": visit complete
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file (expand)": entering dynamic subgraph
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "null_resource.create_file"
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": starting visit (*terraform.NodePlannableResource)
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": evaluating
2020/09/18 13:49:40 [TRACE] [walkPlan] Entering eval tree: null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteResourceState
2020/09/18 13:49:40 [TRACE] [walkPlan] Exiting eval tree: null_resource.create_file
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": expanding dynamic subgraph
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ResourceCountTransformer
2020/09/18 13:49:40 [TRACE] ResourceCountTransformer: adding null_resource.create_file as *terraform.NodePlannableResourceInstance
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ResourceCountTransformer with new graph:
null_resource.create_file - *terraform.NodePlannableResourceInstance
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.OrphanResourceInstanceCountTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.OrphanResourceInstanceCountTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachStateTransformer
2020/09/18 13:49:40 [DEBUG] Resource instance state not found for node "null_resource.create_file", instance null_resource.create_file
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.TargetsTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ReferenceTransformer
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "null_resource.create_file" references: []
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ReferenceTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.RootTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.RootTransformer (no changes)
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": entering dynamic subgraph
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "null_resource.create_file"
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": starting visit (*terraform.NodePlannableResourceInstance)
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": evaluating
2020/09/18 13:49:40 [TRACE] [walkPlan] Entering eval tree: null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalSequence
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalGetProvider
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalValidateSelfRef
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalReadState
2020/09/18 13:49:40 [TRACE] EvalReadState: reading state for null_resource.create_file
2020/09/18 13:49:40 [TRACE] EvalReadState: no state present for null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalRefreshDependencies
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalRefresh
2020/09/18 13:49:40 [DEBUG] refresh: null_resource.create_file: no state, so not refreshing
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteState
2020/09/18 13:49:40 [TRACE] EvalWriteState: using RefreshState for null_resource.create_file
2020/09/18 13:49:40 [TRACE] EvalWriteState: removing state object for null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalDiff
2020/09/18 13:49:40 [TRACE] Re-validating config for "null_resource.create_file"
2020/09/18 13:49:40 [TRACE] GRPCProvider: ValidateResourceTypeConfig
2020/09/18 13:49:40 [TRACE] GRPCProvider: PlanResourceChange
2020-09-18T13:49:40.546-0400 [DEBUG] plugin.terraform-provider-null_v2.1.2_x4: 2020/09/18 13:49:40 [DEBUG] Instance Diff is nil in SimpleDiff()
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalCheckPreventDestroy
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteState
2020/09/18 13:49:40 [TRACE] EvalWriteState: writing current state object for null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteDiff
2020/09/18 13:49:40 [TRACE] EvalWriteDiff: recorded Create change for null_resource.create_file
2020/09/18 13:49:40 [TRACE] [walkPlan] Exiting eval tree: null_resource.create_file
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": visit complete
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": dynamic subgraph completed successfully
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": visit complete
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file (expand)": dynamic subgraph completed successfully
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file (expand)": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/null\"] (close)"
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "data.archive_file.foo (expand)"
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo (expand)": starting visit (*terraform.nodeExpandPlannableResource)
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provisioner.local-exec (close)"
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo (expand)": expanding dynamic subgraph
2020/09/18 13:49:40 [TRACE] vertex "provisioner.local-exec (close)": starting visit (*terraform.graphNodeCloseProvisioner)
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo (expand)": entering dynamic subgraph
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/null\"] (close)": starting visit (*terraform.graphNodeCloseProvider)
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "data.archive_file.foo"
2020/09/18 13:49:40 [TRACE] GRPCProvider: Close
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": starting visit (*terraform.NodePlannableResource)
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": evaluating
2020/09/18 13:49:40 [TRACE] [walkPlan] Entering eval tree: data.archive_file.foo
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteResourceState
2020/09/18 13:49:40 [TRACE] [walkPlan] Exiting eval tree: data.archive_file.foo
2020-09-18T13:49:40.547-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = transport is closing"
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": expanding dynamic subgraph
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ResourceCountTransformer
2020/09/18 13:49:40 [TRACE] ResourceCountTransformer: adding data.archive_file.foo as *terraform.NodePlannableResourceInstance
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ResourceCountTransformer with new graph:
data.archive_file.foo - *terraform.NodePlannableResourceInstance
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.OrphanResourceInstanceCountTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.OrphanResourceInstanceCountTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachStateTransformer
2020/09/18 13:49:40 [DEBUG] Resource instance state not found for node "data.archive_file.foo", instance data.archive_file.foo
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.TargetsTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ReferenceTransformer
2020/09/18 13:49:40 [WARN] ReferenceTransformer: reference not found: "null_resource.create_file"
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "data.archive_file.foo" references: []
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ReferenceTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.RootTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.RootTransformer (no changes)
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": entering dynamic subgraph
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "data.archive_file.foo"
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": starting visit (*terraform.NodePlannableResourceInstance)
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": evaluating
2020/09/18 13:49:40 [TRACE] [walkPlan] Entering eval tree: data.archive_file.foo
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalSequence
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalGetProvider
2020-09-18T13:49:40.550-0400 [DEBUG] plugin: plugin process exited: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 pid=11950
2020-09-18T13:49:40.550-0400 [DEBUG] plugin: plugin exited
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/null\"] (close)": visit complete
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalReadState
2020/09/18 13:49:40 [TRACE] EvalReadState: reading state for data.archive_file.foo
2020/09/18 13:49:40 [TRACE] EvalReadState: no state present for data.archive_file.foo
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalValidateSelfRef
2020/09/18 13:49:40 [TRACE] eval: *terraform.evalReadDataPlan
2020/09/18 13:49:40 [TRACE] evalReadDataPlan: data.archive_file.foo configuration is fully known, but we're forcing a read plan to be created
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteState
2020/09/18 13:49:40 [TRACE] EvalWriteState: using RefreshState for data.archive_file.foo
2020/09/18 13:49:40 [TRACE] EvalWriteState: writing current state object for data.archive_file.foo
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteState
2020/09/18 13:49:40 [TRACE] EvalWriteState: writing current state object for data.archive_file.foo
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteDiff
2020/09/18 13:49:40 [TRACE] EvalWriteDiff: recorded Read change for data.archive_file.foo
2020/09/18 13:49:40 [TRACE] [walkPlan] Exiting eval tree: data.archive_file.foo
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": visit complete
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": dynamic subgraph completed successfully
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": visit complete
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo (expand)": dynamic subgraph completed successfully
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo (expand)": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/archive\"] (close)"
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/archive\"] (close)": starting visit (*terraform.graphNodeCloseProvider)
2020/09/18 13:49:40 [TRACE] GRPCProvider: Close
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "meta.count-boundary (EachMode fixup)"
2020/09/18 13:49:40 [TRACE] vertex "meta.count-boundary (EachMode fixup)": starting visit (*terraform.NodeCountBoundary)
2020/09/18 13:49:40 [TRACE] vertex "meta.count-boundary (EachMode fixup)": visit complete
2020-09-18T13:49:40.554-0400 [DEBUG] plugin: plugin process exited: path=/Users/alisdair/go/bin/terraform pid=11948
2020-09-18T13:49:40.554-0400 [DEBUG] plugin: plugin exited
2020-09-18T13:49:40.554-0400 [DEBUG] plugin: plugin process exited: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 pid=11951
2020/09/18 13:49:40 [TRACE] vertex "provisioner.local-exec (close)": visit complete
2020-09-18T13:49:40.554-0400 [DEBUG] plugin: plugin exited
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/archive\"] (close)": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "root"
2020/09/18 13:49:40 [TRACE] vertex "root": starting visit (*terraform.nodeCloseModule)
2020/09/18 13:49:40 [TRACE] vertex "root": visit complete
2020/09/18 13:49:40 [INFO] backend/local: apply calling Apply
2020/09/18 13:49:40 [INFO] terraform: building graph: GraphTypeApply
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ConfigTransformer
2020/09/18 13:49:40 [TRACE] ConfigTransformer: Starting for path:
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ConfigTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.DiffTransformer
2020/09/18 13:49:40 [TRACE] DiffTransformer starting
2020/09/18 13:49:40 [TRACE] DiffTransformer: found Create change for null_resource.create_file
2020/09/18 13:49:40 [TRACE] DiffTransformer: null_resource.create_file will be represented by null_resource.create_file
2020/09/18 13:49:40 [TRACE] DiffTransformer: found Read change for data.archive_file.foo
2020/09/18 13:49:40 [TRACE] DiffTransformer: data.archive_file.foo will be represented by data.archive_file.foo
2020/09/18 13:49:40 [TRACE] DiffTransformer complete
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.DiffTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.OrphanOutputTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.OrphanOutputTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachResourceConfigTransformer
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching to "data.archive_file.foo (expand)" (*terraform.nodeExpandApplyableResource) config from hcl.Range{Filename:"main.tf", Start:hcl.Pos{Line:7, Column:1, Byte:137}, End:hcl.Pos{Line:7, Column:26, Byte:162}}
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to data.archive_file.foo (expand)
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching to "null_resource.create_file" (*terraform.NodeApplyableResourceInstance) config from main.tf:1,1-39
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to null_resource.create_file
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching to "data.archive_file.foo" (*terraform.NodeApplyableResourceInstance) config from hcl.Range{Filename:"main.tf", Start:hcl.Pos{Line:7, Column:1, Byte:137}, End:hcl.Pos{Line:7, Column:26, Byte:162}}
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to data.archive_file.foo
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching to "null_resource.create_file (expand)" (*terraform.nodeExpandApplyableResource) config from main.tf:1,1-39
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to null_resource.create_file (expand)
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachResourceConfigTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachStateTransformer
2020/09/18 13:49:40 [DEBUG] Resource state not found for node "null_resource.create_file", instance null_resource.create_file
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.MissingProvisionerTransformer
2020/09/18 13:49:40 [TRACE] MissingProviderTransformer: added implicit provisioner local-exec, first implied by null_resource.create_file
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.MissingProvisionerTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ProvisionerTransformer
2020/09/18 13:49:40 [TRACE] ProvisionerTransformer: null_resource.create_file (expand) is provisioned by local-exec ("provisioner.local-exec")
2020/09/18 13:49:40 [TRACE] ProvisionerTransformer: null_resource.create_file is provisioned by local-exec ("provisioner.local-exec")
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ProvisionerTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.RootVariableTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.RootVariableTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.LocalTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.LocalTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.OutputTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.OutputTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ModuleVariableTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ModuleVariableTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.graphTransformerMulti
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderConfigTransformer
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderConfigTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.MissingProviderTransformer
2020/09/18 13:49:40 [DEBUG] adding implicit provider configuration provider["registry.terraform.io/hashicorp/archive"], implied first by data.archive_file.foo
2020/09/18 13:49:40 [DEBUG] adding implicit provider configuration provider["registry.terraform.io/hashicorp/null"], implied first by null_resource.create_file (expand)
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.MissingProviderTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderTransformer
2020/09/18 13:49:40 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/archive"] serving data.archive_file.foo (expand)
2020/09/18 13:49:40 [DEBUG] ProviderTransformer: "data.archive_file.foo (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/archive"]
2020/09/18 13:49:40 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/null"] serving null_resource.create_file
2020/09/18 13:49:40 [DEBUG] ProviderTransformer: "null_resource.create_file" (*terraform.NodeApplyableResourceInstance) needs provider["registry.terraform.io/hashicorp/null"]
2020/09/18 13:49:40 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/archive"] serving data.archive_file.foo
2020/09/18 13:49:40 [DEBUG] ProviderTransformer: "data.archive_file.foo" (*terraform.NodeApplyableResourceInstance) needs provider["registry.terraform.io/hashicorp/archive"]
2020/09/18 13:49:40 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/null"] serving null_resource.create_file (expand)
2020/09/18 13:49:40 [DEBUG] ProviderTransformer: "null_resource.create_file (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/null"]
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.PruneProviderTransformer
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.PruneProviderTransformer (no changes)
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ParentProviderTransformer
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ParentProviderTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.graphTransformerMulti with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.RemovedModuleTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.RemovedModuleTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachSchemaTransformer
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching resource schema to null_resource.create_file (expand)
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching provisioner "local-exec" config schema to null_resource.create_file (expand)
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching resource schema to data.archive_file.foo (expand)
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching resource schema to null_resource.create_file
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching provisioner "local-exec" config schema to null_resource.create_file
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching resource schema to data.archive_file.foo
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching provider config schema to provider["registry.terraform.io/hashicorp/archive"]
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching provider config schema to provider["registry.terraform.io/hashicorp/null"]
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachSchemaTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ModuleExpansionTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ModuleExpansionTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ReferenceTransformer
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "null_resource.create_file" references: []
2020/09/18 13:49:40 [WARN] ReferenceTransformer: reference not found: "null_resource.create_file#destroy"
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "data.archive_file.foo" references: [null_resource.create_file null_resource.create_file null_resource.create_file (expand)]
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "provisioner.local-exec" references: []
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/archive\"]" references: []
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/null\"]" references: []
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "null_resource.create_file (expand)" references: []
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "data.archive_file.foo (expand)" references: []
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ReferenceTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachDependenciesTransformer
2020/09/18 13:49:40 [TRACE] AttachDependenciesTransformer: null_resource.create_file depends on []
2020/09/18 13:49:40 [TRACE] AttachDependenciesTransformer: data.archive_file.foo depends on [null_resource.create_file]
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachDependenciesTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ForcedCBDTransformer
2020/09/18 13:49:40 [TRACE] ForcedCBDTransformer: "null_resource.create_file" (*terraform.NodeApplyableResourceInstance) has no CBD descendent, so skipping
2020/09/18 13:49:40 [TRACE] ForcedCBDTransformer: "data.archive_file.foo" (*terraform.NodeApplyableResourceInstance) has no CBD descendent, so skipping
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ForcedCBDTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.DestroyEdgeTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.DestroyEdgeTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CBDEdgeTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CBDEdgeTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.destroyRootOutputTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.destroyRootOutputTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.pruneUnusedNodesTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.pruneUnusedNodesTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.TargetsTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CountBoundaryTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CountBoundaryTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CloseProviderTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CloseProviderTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CloseProvisionerTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CloseProvisionerTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.applyDestroyNodeReferenceFixupTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.applyDestroyNodeReferenceFixupTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CloseRootModuleTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CloseRootModuleTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
root - *terraform.nodeCloseModule
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.TransitiveReductionTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.TransitiveReductionTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file - *terraform.NodeApplyableResourceInstance
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
null_resource.create_file - *terraform.NodeApplyableResourceInstance
root - *terraform.nodeCloseModule
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
------
2020/09/18 13:49:40 [DEBUG] Starting graph walk: walkApply
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/null\"]"
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/null\"]": starting visit (*terraform.NodeApplyableProvider)
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/archive\"]"
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/archive\"]": starting visit (*terraform.NodeApplyableProvider)
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provisioner.local-exec"
2020/09/18 13:49:40 [TRACE] vertex "provisioner.local-exec": starting visit (*terraform.NodeProvisioner)
2020-09-18T13:49:40.558-0400 [DEBUG] plugin: starting plugin: path=/Users/alisdair/go/bin/terraform args=[/Users/alisdair/go/bin/terraform, internal-plugin, provisioner, local-exec]
2020-09-18T13:49:40.559-0400 [INFO] plugin: configuring client automatic mTLS
2020-09-18T13:49:40.560-0400 [DEBUG] plugin: plugin started: path=/Users/alisdair/go/bin/terraform pid=11952
2020-09-18T13:49:40.560-0400 [DEBUG] plugin: waiting for RPC address: path=/Users/alisdair/go/bin/terraform
2020-09-18T13:49:40.590-0400 [DEBUG] plugin: starting plugin: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 args=[.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4]
2020-09-18T13:49:40.592-0400 [DEBUG] plugin: plugin started: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 pid=11954
2020-09-18T13:49:40.592-0400 [DEBUG] plugin: waiting for RPC address: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4
2020-09-18T13:49:40.601-0400 [INFO] plugin.terraform-provider-null_v2.1.2_x4: configuring server automatic mTLS: timestamp=2020-09-18T13:49:40.600-0400
2020-09-18T13:49:40.608-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] Terraform version: 0.14.0 dev
2020-09-18T13:49:40.608-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] Go runtime version: go1.14.7
2020-09-18T13:49:40.608-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] CLI args: []string{"/Users/alisdair/go/bin/terraform", "internal-plugin", "provisioner", "local-exec"}
2020-09-18T13:49:40.608-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] Attempting to open CLI config file: /Users/alisdair/.terraformrc
2020-09-18T13:49:40.609-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] File doesn't exist, but doesn't need to. Ignoring.
2020-09-18T13:49:40.609-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] checking for credentials in "/Users/alisdair/.terraform.d/plugins"
2020-09-18T13:49:40.609-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [WARN] found legacy credentials "terraform-credentials-env"
2020-09-18T13:49:40.612-0400 [DEBUG] plugin: using plugin: version=5
2020/09/18 13:49:40 [TRACE] vertex "provisioner.local-exec": visit complete
2020-09-18T13:49:40.613-0400 [TRACE] plugin.stdio: waiting for stdio data
2020-09-18T13:49:40.614-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [WARN] found legacy credentials "terraform-credentials-keychain"
2020-09-18T13:49:40.614-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory terraform.d/plugins
2020-09-18T13:49:40.614-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] will search for provider plugins in /Users/alisdair/.terraform.d/plugins
2020-09-18T13:49:40.614-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [TRACE] getproviders.SearchLocalDirectory: /Users/alisdair/.terraform.d/plugins is a symlink to /Users/alisdair/.terraform.d/plugins
2020-09-18T13:49:40.614-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory /Users/alisdair/Library/Application Support/io.terraform/plugins
2020-09-18T13:49:40.614-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory /Library/Application Support/io.terraform/plugins
2020-09-18T13:49:40.614-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] CLI command args: []string{"internal-plugin", "provisioner", "local-exec"}
2020-09-18T13:49:40.614-0400 [DEBUG] plugin.terraform: local-exec-provisioner (internal) 2020/09/18 13:49:40 [INFO] Starting provisioner plugin local-exec
2020-09-18T13:49:40.614-0400 [DEBUG] plugin.terraform: plugin address: address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin339621132 network=unix timestamp=2020-09-18T13:49:40.610-0400
2020-09-18T13:49:40.629-0400 [DEBUG] plugin: using plugin: version=5
2020-09-18T13:49:40.629-0400 [DEBUG] plugin.terraform-provider-null_v2.1.2_x4: plugin address: address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin239422241 network=unix timestamp=2020-09-18T13:49:40.629-0400
2020/09/18 13:49:40 [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/hashicorp/null\"]" provider for provider["registry.terraform.io/hashicorp/null"]
2020-09-18T13:49:40.682-0400 [TRACE] plugin.stdio: waiting for stdio data
2020/09/18 13:49:40 [TRACE] buildProviderConfig for provider["registry.terraform.io/hashicorp/null"]: no configuration at all
2020/09/18 13:49:40 [TRACE] GRPCProvider: GetSchema
2020-09-18T13:49:40.682-0400 [INFO] plugin: configuring client automatic mTLS
2020/09/18 13:49:40 [TRACE] No provider meta schema returned
2020-09-18T13:49:40.682-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2020-09-18T13:49:40.705-0400 [DEBUG] plugin: starting plugin: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 args=[.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4]
2020-09-18T13:49:40.708-0400 [DEBUG] plugin: plugin started: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 pid=11955
2020-09-18T13:49:40.708-0400 [DEBUG] plugin: waiting for RPC address: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4
2020-09-18T13:49:40.719-0400 [INFO] plugin.terraform-provider-archive_v1.3.0_x4: configuring server automatic mTLS: timestamp=2020-09-18T13:49:40.719-0400
2020-09-18T13:49:40.746-0400 [DEBUG] plugin: using plugin: version=5
2020-09-18T13:49:40.746-0400 [DEBUG] plugin.terraform-provider-archive_v1.3.0_x4: plugin address: address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin685247502 network=unix timestamp=2020-09-18T13:49:40.745-0400
2020/09/18 13:49:40 [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/hashicorp/archive\"]" provider for provider["registry.terraform.io/hashicorp/archive"]
2020/09/18 13:49:40 [TRACE] buildProviderConfig for provider["registry.terraform.io/hashicorp/archive"]: no configuration at all
2020/09/18 13:49:40 [TRACE] GRPCProvider: GetSchema
2020/09/18 13:49:40 [TRACE] GRPCProvider: Configure
2020-09-18T13:49:40.801-0400 [TRACE] plugin.stdio: waiting for stdio data
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/null\"]": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "null_resource.create_file (expand)"
2020-09-18T13:49:40.801-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file (expand)": starting visit (*terraform.nodeExpandApplyableResource)
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file (expand)": expanding dynamic subgraph
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file (expand)": entering dynamic subgraph
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "null_resource.create_file"
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": starting visit (*terraform.NodeApplyableResource)
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": evaluating
2020/09/18 13:49:40 [TRACE] [walkApply] Entering eval tree: null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteResourceState
2020/09/18 13:49:40 [TRACE] [walkApply] Exiting eval tree: null_resource.create_file
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": visit complete
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file (expand)": dynamic subgraph completed successfully
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file (expand)": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "null_resource.create_file"
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": starting visit (*terraform.NodeApplyableResourceInstance)
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": evaluating
2020/09/18 13:49:40 [TRACE] [walkApply] Entering eval tree: null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalSequence
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalGetProvider
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalReadDiff
2020/09/18 13:49:40 [TRACE] EvalReadDiff: Read Create change from plan for null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalIf
2020/09/18 13:49:40 [TRACE] eval: terraform.EvalNoop
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalIf
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalReadState
2020/09/18 13:49:40 [TRACE] EvalReadState: reading state for null_resource.create_file
2020/09/18 13:49:40 [TRACE] EvalReadState: no state present for null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalReadDiff
2020/09/18 13:49:40 [TRACE] EvalReadDiff: Read Create change from plan for null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalDiff
2020/09/18 13:49:40 [TRACE] No provider meta schema returned
2020/09/18 13:49:40 [TRACE] Re-validating config for "null_resource.create_file"
2020/09/18 13:49:40 [TRACE] GRPCProvider: ValidateResourceTypeConfig
2020/09/18 13:49:40 [TRACE] GRPCProvider: Configure
2020/09/18 13:49:40 [TRACE] GRPCProvider: PlanResourceChange
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/archive\"]": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "data.archive_file.foo (expand)"
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo (expand)": starting visit (*terraform.nodeExpandApplyableResource)
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo (expand)": expanding dynamic subgraph
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo (expand)": entering dynamic subgraph
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "data.archive_file.foo"
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": starting visit (*terraform.NodeApplyableResource)
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": evaluating
2020/09/18 13:49:40 [TRACE] [walkApply] Entering eval tree: data.archive_file.foo
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteResourceState
2020/09/18 13:49:40 [TRACE] [walkApply] Exiting eval tree: data.archive_file.foo
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": visit complete
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo (expand)": dynamic subgraph completed successfully
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo (expand)": visit complete
2020-09-18T13:49:40.803-0400 [DEBUG] plugin.terraform-provider-null_v2.1.2_x4: 2020/09/18 13:49:40 [DEBUG] Instance Diff is nil in SimpleDiff()
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalCheckPlannedChange
2020/09/18 13:49:40 [TRACE] EvalCheckPlannedChange: Verifying that actual change (action Create) matches planned change (action Create)
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalGetProvider
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalReadState
2020/09/18 13:49:40 [TRACE] EvalReadState: reading state for null_resource.create_file
2020/09/18 13:49:40 [TRACE] EvalReadState: no state present for null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalReduceDiff
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalIf
2020/09/18 13:49:40 [TRACE] eval: terraform.EvalNoop
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalApplyPre
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalApply
2020/09/18 13:49:40 [DEBUG] EvalApply: ProviderMeta config value set
2020/09/18 13:49:40 [DEBUG] null_resource.create_file: applying the planned Create change
2020/09/18 13:49:40 [TRACE] GRPCProvider: ApplyResourceChange
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalMaybeTainted
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteState
2020/09/18 13:49:40 [TRACE] EvalWriteState: recording 0 dependencies for null_resource.create_file
2020/09/18 13:49:40 [TRACE] EvalWriteState: writing current state object for null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalApplyProvisioners
2020/09/18 13:49:40 [TRACE] EvalApplyProvisioners: provisioning null_resource.create_file with "local-exec"
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalMaybeTainted
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteState
2020/09/18 13:49:40 [TRACE] EvalWriteState: recording 0 dependencies for null_resource.create_file
2020/09/18 13:49:40 [TRACE] EvalWriteState: writing current state object for null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalIf
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalIf
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteDiff
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalApplyPost
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalUpdateStateHook
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: reading latest snapshot from terraform.tfstate
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: snapshot file has nil snapshot, but that's okay
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: read nil snapshot
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: no original state snapshot to back up
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: state has changed since last snapshot, so incrementing serial to 1
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: writing snapshot at terraform.tfstate
2020/09/18 13:49:40 [ERROR] eval: *terraform.EvalUpdateStateHook, err: Failed to serialize resource instance in state: Instance data.archive_file.foo has status ObjectPlanned, which cannot be saved in state.
2020/09/18 13:49:40 [ERROR] eval: *terraform.EvalSequence, err: Failed to serialize resource instance in state: Instance data.archive_file.foo has status ObjectPlanned, which cannot be saved in state.
2020/09/18 13:49:40 [TRACE] [walkApply] Exiting eval tree: null_resource.create_file
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: upstream of "provisioner.local-exec (close)" errored, so skipping
2020/09/18 13:49:40 [TRACE] dag/walk: upstream of "data.archive_file.foo" errored, so skipping
2020/09/18 13:49:40 [TRACE] dag/walk: upstream of "provider[\"registry.terraform.io/hashicorp/null\"] (close)" errored, so skipping
2020/09/18 13:49:40 [TRACE] dag/walk: upstream of "provider[\"registry.terraform.io/hashicorp/archive\"] (close)" errored, so skipping
2020/09/18 13:49:40 [TRACE] dag/walk: upstream of "meta.count-boundary (EachMode fixup)" errored, so skipping
2020/09/18 13:49:40 [TRACE] dag/walk: upstream of "root" errored, so skipping
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: reading latest snapshot from terraform.tfstate
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: read snapshot with lineage "b17e5e66-42dd-e6ab-cd40-3eb44a7f972f" serial 1
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: no original state snapshot to back up
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: removing lock metadata file .terraform.tfstate.lock.info
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: unlocking terraform.tfstate using fcntl flock
panic: Failed to serialize resource instance in state: Instance data.archive_file.foo has status ObjectPlanned, which cannot be saved in state.
goroutine 9 [running]:
github.com/hashicorp/terraform/states/statefile.StatesMarshalEqual(0xc0006241b0, 0xc0006241a0, 0x0)
/Users/alisdair/code/terraform/states/statefile/marshal_equal.go:31 +0x23b
github.com/hashicorp/terraform/states/statemgr.(*Filesystem).writeState(0xc00061a300, 0xc000624138, 0x0, 0x0, 0x0)
/Users/alisdair/code/terraform/states/statemgr/filesystem.go:201 +0x507
github.com/hashicorp/terraform/states/statemgr.(*Filesystem).WriteState(0xc00061a300, 0xc000624138, 0x0, 0x0)
/Users/alisdair/code/terraform/states/statemgr/filesystem.go:136 +0x7f
github.com/hashicorp/terraform/states/statemgr.WriteAndPersist(0xd353e48, 0xc00061a300, 0xc000624138, 0xd353e48, 0xc00061a300)
/Users/alisdair/code/terraform/states/statemgr/helper.go:48 +0x3f
github.com/hashicorp/terraform/backend/local.(*Local).opApply(0xc00062ef70, 0x38d6dc0, 0xc000100b40, 0x38d6dc0, 0xc000100b80, 0xc00020a2a0, 0xc000100b00)
/Users/alisdair/code/terraform/backend/local/backend_apply.go:171 +0x733
github.com/hashicorp/terraform/backend/local.(*Local).Operation.func1(0xc0006323d0, 0xc0006323e0, 0xc0006323f0, 0xc00062ef70, 0xc0006323c0, 0x38d6dc0, 0xc000100b40, 0x38d6dc0, 0xc000100b80, 0xc00020a2a0, ...)
/Users/alisdair/code/terraform/backend/local/backend.go:340 +0xe8
created by github.com/hashicorp/terraform/backend/local.(*Local).Operation
/Users/alisdair/code/terraform/backend/local/backend.go:334 +0x366
Raw
debug.log
2020/09/18 13:49:39 [INFO] Terraform version: 0.14.0 dev
2020/09/18 13:49:39 [INFO] Go runtime version: go1.14.7
2020/09/18 13:49:39 [INFO] CLI args: []string{"/Users/alisdair/go/bin/terraform", "apply", "-auto-approve"}
2020/09/18 13:49:39 [DEBUG] Attempting to open CLI config file: /Users/alisdair/.terraformrc
2020/09/18 13:49:39 [DEBUG] File doesn't exist, but doesn't need to. Ignoring.
2020/09/18 13:49:39 [DEBUG] checking for credentials in "/Users/alisdair/.terraform.d/plugins"
2020/09/18 13:49:39 [WARN] found legacy credentials "terraform-credentials-env"
2020/09/18 13:49:39 [WARN] found legacy credentials "terraform-credentials-keychain"
2020/09/18 13:49:39 [DEBUG] ignoring non-existing provider search directory terraform.d/plugins
2020/09/18 13:49:39 [DEBUG] will search for provider plugins in /Users/alisdair/.terraform.d/plugins
2020/09/18 13:49:39 [TRACE] getproviders.SearchLocalDirectory: /Users/alisdair/.terraform.d/plugins is a symlink to /Users/alisdair/.terraform.d/plugins
2020/09/18 13:49:39 [DEBUG] ignoring non-existing provider search directory /Users/alisdair/Library/Application Support/io.terraform/plugins
2020/09/18 13:49:39 [DEBUG] ignoring non-existing provider search directory /Library/Application Support/io.terraform/plugins
2020/09/18 13:49:39 [INFO] CLI command args: []string{"apply", "-auto-approve"}
2020/09/18 13:49:39 [TRACE] Meta.Backend: no config given or present on disk, so returning nil config
2020/09/18 13:49:39 [TRACE] Meta.Backend: backend has not previously been initialized in this working directory
2020/09/18 13:49:39 [DEBUG] New state was assigned lineage "afe895d2-68a9-98d7-30f8-d9d0230e5897"
2020/09/18 13:49:39 [TRACE] Meta.Backend: using default local state only (no backend configuration, and no existing initialized backend)
2020/09/18 13:49:39 [TRACE] Meta.Backend: instantiated backend of type <nil>
2020/09/18 13:49:39 [TRACE] providercache.fillMetaCache: scanning directory .terraform/plugins
2020/09/18 13:49:39 [TRACE] getproviders.SearchLocalDirectory: .terraform/plugins is a symlink to .terraform/plugins
2020/09/18 13:49:39 [TRACE] getproviders.SearchLocalDirectory: found registry.terraform.io/hashicorp/archive v1.3.0 for darwin_amd64 at .terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64
2020/09/18 13:49:39 [TRACE] getproviders.SearchLocalDirectory: found registry.terraform.io/hashicorp/null v2.1.2 for darwin_amd64 at .terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64
2020/09/18 13:49:39 [TRACE] providercache.fillMetaCache: including .terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64 as a candidate package for registry.terraform.io/hashicorp/null 2.1.2
2020/09/18 13:49:39 [TRACE] providercache.fillMetaCache: including .terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64 as a candidate package for registry.terraform.io/hashicorp/archive 1.3.0
2020/09/18 13:49:39 [TRACE] providercache.fillMetaCache: using cached result from previous scan of .terraform/plugins
2020/09/18 13:49:39 [DEBUG] checking for provisioner in "."
2020/09/18 13:49:39 [DEBUG] checking for provisioner in "/Users/alisdair/go/bin"
2020/09/18 13:49:39 [DEBUG] checking for provisioner in "/Users/alisdair/.terraform.d/plugins"
2020/09/18 13:49:39 [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
2020/09/18 13:49:39 [TRACE] Meta.Backend: backend <nil> does not support operations, so wrapping it in a local backend
2020/09/18 13:49:39 [INFO] backend/local: starting Apply operation
2020/09/18 13:49:39 [TRACE] backend/local: requesting state manager for workspace "default"
2020/09/18 13:49:39 [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
2020/09/18 13:49:39 [TRACE] backend/local: requesting state lock for workspace "default"
2020/09/18 13:49:39 [TRACE] statemgr.Filesystem: preparing to manage state snapshots at terraform.tfstate
2020/09/18 13:49:39 [TRACE] statemgr.Filesystem: no previously-stored snapshot exists
2020/09/18 13:49:39 [TRACE] statemgr.Filesystem: locking terraform.tfstate using fcntl flock
2020/09/18 13:49:39 [TRACE] statemgr.Filesystem: writing lock metadata to .terraform.tfstate.lock.info
2020/09/18 13:49:39 [TRACE] backend/local: reading remote state for workspace "default"
2020/09/18 13:49:39 [TRACE] statemgr.Filesystem: reading latest snapshot from terraform.tfstate
2020/09/18 13:49:39 [TRACE] statemgr.Filesystem: snapshot file has nil snapshot, but that's okay
2020/09/18 13:49:39 [TRACE] statemgr.Filesystem: read nil snapshot
2020/09/18 13:49:39 [TRACE] backend/local: retrieving local state snapshot for workspace "default"
2020/09/18 13:49:39 [TRACE] backend/local: building context for current working directory
2020/09/18 13:49:39 [TRACE] terraform.NewContext: starting
2020/09/18 13:49:39 [TRACE] terraform.NewContext: loading provider schemas
2020/09/18 13:49:39 [TRACE] LoadSchemas: retrieving schema for provider type "registry.terraform.io/hashicorp/archive"
2020-09-18T13:49:39.744-0400 [INFO] plugin: configuring client automatic mTLS
2020-09-18T13:49:39.768-0400 [DEBUG] plugin: starting plugin: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 args=[.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4]
2020-09-18T13:49:39.770-0400 [DEBUG] plugin: plugin started: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 pid=11940
2020-09-18T13:49:39.770-0400 [DEBUG] plugin: waiting for RPC address: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4
2020-09-18T13:49:39.780-0400 [INFO] plugin.terraform-provider-archive_v1.3.0_x4: configuring server automatic mTLS: timestamp=2020-09-18T13:49:39.780-0400
2020-09-18T13:49:39.810-0400 [DEBUG] plugin.terraform-provider-archive_v1.3.0_x4: plugin address: network=unix address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin289282395 timestamp=2020-09-18T13:49:39.810-0400
2020-09-18T13:49:39.810-0400 [DEBUG] plugin: using plugin: version=5
2020/09/18 13:49:39 [TRACE] GRPCProvider: GetSchema
2020-09-18T13:49:39.862-0400 [TRACE] plugin.stdio: waiting for stdio data
2020-09-18T13:49:39.863-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2020/09/18 13:49:39 [TRACE] No provider meta schema returned
2020/09/18 13:49:39 [TRACE] GRPCProvider: Close
2020-09-18T13:49:39.865-0400 [DEBUG] plugin: plugin process exited: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 pid=11940
2020-09-18T13:49:39.865-0400 [DEBUG] plugin: plugin exited
2020/09/18 13:49:39 [TRACE] LoadSchemas: retrieving schema for provider type "registry.terraform.io/hashicorp/null"
2020-09-18T13:49:39.866-0400 [INFO] plugin: configuring client automatic mTLS
2020-09-18T13:49:39.891-0400 [DEBUG] plugin: starting plugin: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 args=[.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4]
2020-09-18T13:49:39.893-0400 [DEBUG] plugin: plugin started: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 pid=11941
2020-09-18T13:49:39.893-0400 [DEBUG] plugin: waiting for RPC address: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4
2020-09-18T13:49:39.901-0400 [INFO] plugin.terraform-provider-null_v2.1.2_x4: configuring server automatic mTLS: timestamp=2020-09-18T13:49:39.901-0400
2020-09-18T13:49:39.926-0400 [DEBUG] plugin: using plugin: version=5
2020-09-18T13:49:39.926-0400 [DEBUG] plugin.terraform-provider-null_v2.1.2_x4: plugin address: address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin385469424 network=unix timestamp=2020-09-18T13:49:39.926-0400
2020/09/18 13:49:39 [TRACE] GRPCProvider: GetSchema
2020-09-18T13:49:39.977-0400 [TRACE] plugin.stdio: waiting for stdio data
2020-09-18T13:49:39.978-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2020/09/18 13:49:39 [TRACE] No provider meta schema returned
2020/09/18 13:49:39 [TRACE] GRPCProvider: Close
2020-09-18T13:49:39.980-0400 [DEBUG] plugin: plugin process exited: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 pid=11941
2020-09-18T13:49:39.980-0400 [DEBUG] plugin: plugin exited
2020/09/18 13:49:39 [TRACE] LoadSchemas: retrieving schema for provisioner "local-exec"
2020-09-18T13:49:39.980-0400 [DEBUG] plugin: starting plugin: path=/Users/alisdair/go/bin/terraform args=[/Users/alisdair/go/bin/terraform, internal-plugin, provisioner, local-exec]
2020-09-18T13:49:39.982-0400 [DEBUG] plugin: plugin started: path=/Users/alisdair/go/bin/terraform pid=11942
2020-09-18T13:49:39.982-0400 [DEBUG] plugin: waiting for RPC address: path=/Users/alisdair/go/bin/terraform
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] Terraform version: 0.14.0 dev
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] Go runtime version: go1.14.7
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] CLI args: []string{"/Users/alisdair/go/bin/terraform", "internal-plugin", "provisioner", "local-exec"}
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] Attempting to open CLI config file: /Users/alisdair/.terraformrc
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] File doesn't exist, but doesn't need to. Ignoring.
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] checking for credentials in "/Users/alisdair/.terraform.d/plugins"
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [WARN] found legacy credentials "terraform-credentials-env"
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [WARN] found legacy credentials "terraform-credentials-keychain"
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory terraform.d/plugins
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] will search for provider plugins in /Users/alisdair/.terraform.d/plugins
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [TRACE] getproviders.SearchLocalDirectory: /Users/alisdair/.terraform.d/plugins is a symlink to /Users/alisdair/.terraform.d/plugins
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory /Users/alisdair/Library/Application Support/io.terraform/plugins
2020-09-18T13:49:40.035-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory /Library/Application Support/io.terraform/plugins
2020-09-18T13:49:40.036-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] CLI command args: []string{"internal-plugin", "provisioner", "local-exec"}
2020-09-18T13:49:40.037-0400 [DEBUG] plugin.terraform: local-exec-provisioner (internal) 2020/09/18 13:49:40 [INFO] Starting provisioner plugin local-exec
2020-09-18T13:49:40.037-0400 [DEBUG] plugin.terraform: plugin address: network=unix address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin893486730 timestamp=2020-09-18T13:49:40.037-0400
2020-09-18T13:49:40.037-0400 [DEBUG] plugin: using plugin: version=5
2020-09-18T13:49:40.038-0400 [TRACE] plugin.stdio: waiting for stdio data
2020-09-18T13:49:40.040-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = transport is closing"
2020-09-18T13:49:40.045-0400 [DEBUG] plugin: plugin process exited: path=/Users/alisdair/go/bin/terraform pid=11942
2020-09-18T13:49:40.045-0400 [DEBUG] plugin: plugin exited
2020/09/18 13:49:40 [TRACE] terraform.NewContext: complete
2020/09/18 13:49:40 [TRACE] backend/local: finished building terraform.Context
2020/09/18 13:49:40 [TRACE] backend/local: requesting interactive input, if necessary
2020/09/18 13:49:40 [TRACE] Context.Input: Prompting for provider arguments
2020/09/18 13:49:40 [TRACE] Context.Input: Provider provider.null implied by resource block at main.tf:1,1-39
2020/09/18 13:49:40 [TRACE] Context.Input: Provider provider.archive implied by data block at main.tf:7,1-26
2020/09/18 13:49:40 [TRACE] Context.Input: Input for provider.null: map[string]cty.Value{}
2020/09/18 13:49:40 [TRACE] Context.Input: Input for provider.archive: map[string]cty.Value{}
2020/09/18 13:49:40 [TRACE] backend/local: running validation operation
2020/09/18 13:49:40 [INFO] terraform: building graph: GraphTypeValidate
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ConfigTransformer
2020/09/18 13:49:40 [TRACE] ConfigTransformer: Starting for path:
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ConfigTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.LocalTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.LocalTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.OutputTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.OutputTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.OrphanResourceInstanceTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.OrphanResourceInstanceTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.StateTransformer
2020/09/18 13:49:40 [TRACE] StateTransformer: state is empty, so nothing to do
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.StateTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.OrphanOutputTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.OrphanOutputTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachResourceConfigTransformer
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching to "null_resource.create_file" (*terraform.NodeValidatableResource) config from main.tf:1,1-39
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to null_resource.create_file
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching to "data.archive_file.foo" (*terraform.NodeValidatableResource) config from hcl.Range{Filename:"main.tf", Start:hcl.Pos{Line:7, Column:1, Byte:137}, End:hcl.Pos{Line:7, Column:26, Byte:162}}
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to data.archive_file.foo
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachResourceConfigTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachStateTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.RootVariableTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.RootVariableTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.MissingProvisionerTransformer
2020/09/18 13:49:40 [TRACE] MissingProviderTransformer: added implicit provisioner local-exec, first implied by null_resource.create_file
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.MissingProvisionerTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ProvisionerTransformer
2020/09/18 13:49:40 [TRACE] ProvisionerTransformer: null_resource.create_file is provisioned by local-exec ("provisioner.local-exec")
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ProvisionerTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ModuleVariableTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ModuleVariableTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.graphTransformerMulti
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderConfigTransformer
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderConfigTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.MissingProviderTransformer
2020/09/18 13:49:40 [DEBUG] adding implicit provider configuration provider["registry.terraform.io/hashicorp/null"], implied first by null_resource.create_file
2020/09/18 13:49:40 [DEBUG] adding implicit provider configuration provider["registry.terraform.io/hashicorp/archive"], implied first by data.archive_file.foo
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.MissingProviderTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderTransformer
2020/09/18 13:49:40 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/null"] serving null_resource.create_file
2020/09/18 13:49:40 [DEBUG] ProviderTransformer: "null_resource.create_file" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/hashicorp/null"]
2020/09/18 13:49:40 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/archive"] serving data.archive_file.foo
2020/09/18 13:49:40 [DEBUG] ProviderTransformer: "data.archive_file.foo" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/hashicorp/archive"]
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.PruneProviderTransformer
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.PruneProviderTransformer (no changes)
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ParentProviderTransformer
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ParentProviderTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.graphTransformerMulti with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.RemovedModuleTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.RemovedModuleTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachSchemaTransformer
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching resource schema to null_resource.create_file
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching provisioner "local-exec" config schema to null_resource.create_file
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching resource schema to data.archive_file.foo
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching provider config schema to provider["registry.terraform.io/hashicorp/null"]
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching provider config schema to provider["registry.terraform.io/hashicorp/archive"]
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachSchemaTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ModuleExpansionTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ModuleExpansionTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ReferenceTransformer
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "null_resource.create_file" references: []
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "data.archive_file.foo" references: [null_resource.create_file]
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "provisioner.local-exec" references: []
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/null\"]" references: []
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/archive\"]" references: []
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ReferenceTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.attachDataResourceDependenciesTransformer
2020/09/18 13:49:40 [TRACE] attachDataDependenciesTransformer: data.archive_file.foo depends on [null_resource.create_file]
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.attachDataResourceDependenciesTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.TargetsTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ForcedCBDTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ForcedCBDTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CountBoundaryTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CountBoundaryTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CloseProviderTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CloseProviderTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CloseProvisionerTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CloseProvisionerTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
null_resource.create_file - *terraform.NodeValidatableResource
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CloseRootModuleTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CloseRootModuleTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
null_resource.create_file - *terraform.NodeValidatableResource
root - *terraform.nodeCloseModule
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.TransitiveReductionTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.TransitiveReductionTransformer with new graph:
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo - *terraform.NodeValidatableResource
null_resource.create_file - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo - *terraform.NodeValidatableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file - *terraform.NodeValidatableResource
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
null_resource.create_file - *terraform.NodeValidatableResource
root - *terraform.nodeCloseModule
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
------
2020/09/18 13:49:40 [DEBUG] Starting graph walk: walkValidate
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provisioner.local-exec"
2020/09/18 13:49:40 [TRACE] vertex "provisioner.local-exec": starting visit (*terraform.NodeProvisioner)
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/archive\"]"
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/null\"]"
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/archive\"]": starting visit (*terraform.NodeApplyableProvider)
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/null\"]": starting visit (*terraform.NodeApplyableProvider)
2020-09-18T13:49:40.048-0400 [DEBUG] plugin: starting plugin: path=/Users/alisdair/go/bin/terraform args=[/Users/alisdair/go/bin/terraform, internal-plugin, provisioner, local-exec]
2020-09-18T13:49:40.049-0400 [INFO] plugin: configuring client automatic mTLS
2020-09-18T13:49:40.049-0400 [DEBUG] plugin: plugin started: path=/Users/alisdair/go/bin/terraform pid=11944
2020-09-18T13:49:40.049-0400 [DEBUG] plugin: waiting for RPC address: path=/Users/alisdair/go/bin/terraform
2020-09-18T13:49:40.080-0400 [DEBUG] plugin: starting plugin: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 args=[.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4]
2020-09-18T13:49:40.082-0400 [DEBUG] plugin: plugin started: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 pid=11946
2020-09-18T13:49:40.082-0400 [DEBUG] plugin: waiting for RPC address: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4
2020-09-18T13:49:40.093-0400 [INFO] plugin.terraform-provider-archive_v1.3.0_x4: configuring server automatic mTLS: timestamp=2020-09-18T13:49:40.093-0400
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] Terraform version: 0.14.0 dev
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] Go runtime version: go1.14.7
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] CLI args: []string{"/Users/alisdair/go/bin/terraform", "internal-plugin", "provisioner", "local-exec"}
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] Attempting to open CLI config file: /Users/alisdair/.terraformrc
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] File doesn't exist, but doesn't need to. Ignoring.
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] checking for credentials in "/Users/alisdair/.terraform.d/plugins"
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [WARN] found legacy credentials "terraform-credentials-env"
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [WARN] found legacy credentials "terraform-credentials-keychain"
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory terraform.d/plugins
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] will search for provider plugins in /Users/alisdair/.terraform.d/plugins
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [TRACE] getproviders.SearchLocalDirectory: /Users/alisdair/.terraform.d/plugins is a symlink to /Users/alisdair/.terraform.d/plugins
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory /Users/alisdair/Library/Application Support/io.terraform/plugins
2020-09-18T13:49:40.104-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory /Library/Application Support/io.terraform/plugins
2020-09-18T13:49:40.105-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] CLI command args: []string{"internal-plugin", "provisioner", "local-exec"}
2020-09-18T13:49:40.107-0400 [DEBUG] plugin.terraform: local-exec-provisioner (internal) 2020/09/18 13:49:40 [INFO] Starting provisioner plugin local-exec
2020-09-18T13:49:40.108-0400 [DEBUG] plugin: using plugin: version=5
2020-09-18T13:49:40.108-0400 [DEBUG] plugin.terraform: plugin address: address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin053579316 network=unix timestamp=2020-09-18T13:49:40.107-0400
2020/09/18 13:49:40 [TRACE] vertex "provisioner.local-exec": visit complete
2020-09-18T13:49:40.110-0400 [TRACE] plugin.stdio: waiting for stdio data
2020-09-18T13:49:40.125-0400 [DEBUG] plugin: using plugin: version=5
2020-09-18T13:49:40.125-0400 [DEBUG] plugin.terraform-provider-archive_v1.3.0_x4: plugin address: address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin254569497 network=unix timestamp=2020-09-18T13:49:40.125-0400
2020/09/18 13:49:40 [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/hashicorp/archive\"]" provider for provider["registry.terraform.io/hashicorp/archive"]
2020/09/18 13:49:40 [TRACE] buildProviderConfig for provider["registry.terraform.io/hashicorp/archive"]: no configuration at all
2020/09/18 13:49:40 [TRACE] GRPCProvider: GetSchema
2020-09-18T13:49:40.177-0400 [TRACE] plugin.stdio: waiting for stdio data
2020-09-18T13:49:40.178-0400 [INFO] plugin: configuring client automatic mTLS
2020-09-18T13:49:40.178-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2020/09/18 13:49:40 [TRACE] No provider meta schema returned
2020/09/18 13:49:40 [TRACE] GRPCProvider: PrepareProviderConfig
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/archive\"]": visit complete
2020-09-18T13:49:40.204-0400 [DEBUG] plugin: starting plugin: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 args=[.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4]
2020-09-18T13:49:40.205-0400 [DEBUG] plugin: plugin started: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 pid=11947
2020-09-18T13:49:40.205-0400 [DEBUG] plugin: waiting for RPC address: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4
2020-09-18T13:49:40.214-0400 [INFO] plugin.terraform-provider-null_v2.1.2_x4: configuring server automatic mTLS: timestamp=2020-09-18T13:49:40.214-0400
2020-09-18T13:49:40.240-0400 [DEBUG] plugin.terraform-provider-null_v2.1.2_x4: plugin address: address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin654093766 network=unix timestamp=2020-09-18T13:49:40.240-0400
2020-09-18T13:49:40.240-0400 [DEBUG] plugin: using plugin: version=5
2020-09-18T13:49:40.292-0400 [TRACE] plugin.stdio: waiting for stdio data
2020/09/18 13:49:40 [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/hashicorp/null\"]" provider for provider["registry.terraform.io/hashicorp/null"]
2020/09/18 13:49:40 [TRACE] buildProviderConfig for provider["registry.terraform.io/hashicorp/null"]: no configuration at all
2020/09/18 13:49:40 [TRACE] GRPCProvider: GetSchema
2020-09-18T13:49:40.293-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2020/09/18 13:49:40 [TRACE] No provider meta schema returned
2020/09/18 13:49:40 [TRACE] GRPCProvider: PrepareProviderConfig
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/null\"]": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "null_resource.create_file"
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": starting visit (*terraform.NodeValidatableResource)
2020/09/18 13:49:40 [TRACE] GRPCProvider: ValidateResourceTypeConfig
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provisioner.local-exec (close)"
2020/09/18 13:49:40 [TRACE] vertex "provisioner.local-exec (close)": starting visit (*terraform.graphNodeCloseProvisioner)
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "data.archive_file.foo"
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": starting visit (*terraform.NodeValidatableResource)
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/null\"] (close)"
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/null\"] (close)": starting visit (*terraform.graphNodeCloseProvider)
2020/09/18 13:49:40 [TRACE] GRPCProvider: Close
2020/09/18 13:49:40 [TRACE] GRPCProvider: ValidateDataSourceConfig
2020-09-18T13:49:40.297-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = transport is closing"
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "meta.count-boundary (EachMode fixup)"
2020/09/18 13:49:40 [TRACE] vertex "meta.count-boundary (EachMode fixup)": starting visit (*terraform.NodeCountBoundary)
2020/09/18 13:49:40 [TRACE] vertex "meta.count-boundary (EachMode fixup)": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/archive\"] (close)"
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/archive\"] (close)": starting visit (*terraform.graphNodeCloseProvider)
2020-09-18T13:49:40.298-0400 [DEBUG] plugin: plugin process exited: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 pid=11947
2020-09-18T13:49:40.298-0400 [DEBUG] plugin: plugin exited
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/null\"] (close)": visit complete
2020/09/18 13:49:40 [TRACE] GRPCProvider: Close
2020-09-18T13:49:40.300-0400 [DEBUG] plugin: plugin process exited: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 pid=11946
2020-09-18T13:49:40.300-0400 [DEBUG] plugin: plugin exited
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/archive\"] (close)": visit complete
2020-09-18T13:49:40.303-0400 [DEBUG] plugin: plugin process exited: path=/Users/alisdair/go/bin/terraform pid=11944
2020-09-18T13:49:40.303-0400 [DEBUG] plugin: plugin exited
2020/09/18 13:49:40 [TRACE] vertex "provisioner.local-exec (close)": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "root"
2020/09/18 13:49:40 [TRACE] vertex "root": starting visit (*terraform.nodeCloseModule)
2020/09/18 13:49:40 [TRACE] vertex "root": visit complete
2020/09/18 13:49:40 [INFO] backend/local: apply calling Plan
2020/09/18 13:49:40 [INFO] terraform: building graph: GraphTypePlan
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ConfigTransformer
2020/09/18 13:49:40 [TRACE] ConfigTransformer: Starting for path:
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ConfigTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.LocalTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.LocalTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.OutputTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.OutputTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.OrphanResourceInstanceTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.OrphanResourceInstanceTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.StateTransformer
2020/09/18 13:49:40 [TRACE] StateTransformer: state is empty, so nothing to do
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.StateTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.OrphanOutputTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.OrphanOutputTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachResourceConfigTransformer
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching to "null_resource.create_file (expand)" (*terraform.nodeExpandPlannableResource) config from main.tf:1,1-39
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to null_resource.create_file (expand)
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching to "data.archive_file.foo (expand)" (*terraform.nodeExpandPlannableResource) config from hcl.Range{Filename:"main.tf", Start:hcl.Pos{Line:7, Column:1, Byte:137}, End:hcl.Pos{Line:7, Column:26, Byte:162}}
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to data.archive_file.foo (expand)
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachResourceConfigTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachStateTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.RootVariableTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.RootVariableTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.MissingProvisionerTransformer
2020/09/18 13:49:40 [TRACE] MissingProviderTransformer: added implicit provisioner local-exec, first implied by null_resource.create_file (expand)
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.MissingProvisionerTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ProvisionerTransformer
2020/09/18 13:49:40 [TRACE] ProvisionerTransformer: null_resource.create_file (expand) is provisioned by local-exec ("provisioner.local-exec")
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ProvisionerTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ModuleVariableTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ModuleVariableTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.graphTransformerMulti
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderConfigTransformer
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderConfigTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.MissingProviderTransformer
2020/09/18 13:49:40 [DEBUG] adding implicit provider configuration provider["registry.terraform.io/hashicorp/null"], implied first by null_resource.create_file (expand)
2020/09/18 13:49:40 [DEBUG] adding implicit provider configuration provider["registry.terraform.io/hashicorp/archive"], implied first by data.archive_file.foo (expand)
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.MissingProviderTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderTransformer
2020/09/18 13:49:40 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/null"] serving null_resource.create_file (expand)
2020/09/18 13:49:40 [DEBUG] ProviderTransformer: "null_resource.create_file (expand)" (*terraform.nodeExpandPlannableResource) needs provider["registry.terraform.io/hashicorp/null"]
2020/09/18 13:49:40 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/archive"] serving data.archive_file.foo (expand)
2020/09/18 13:49:40 [DEBUG] ProviderTransformer: "data.archive_file.foo (expand)" (*terraform.nodeExpandPlannableResource) needs provider["registry.terraform.io/hashicorp/archive"]
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.PruneProviderTransformer
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.PruneProviderTransformer (no changes)
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ParentProviderTransformer
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ParentProviderTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.graphTransformerMulti with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.RemovedModuleTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.RemovedModuleTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachSchemaTransformer
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching provider config schema to provider["registry.terraform.io/hashicorp/archive"]
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching resource schema to null_resource.create_file (expand)
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching provisioner "local-exec" config schema to null_resource.create_file (expand)
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching resource schema to data.archive_file.foo (expand)
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching provider config schema to provider["registry.terraform.io/hashicorp/null"]
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachSchemaTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ModuleExpansionTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ModuleExpansionTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ReferenceTransformer
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "data.archive_file.foo (expand)" references: [null_resource.create_file (expand)]
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "provisioner.local-exec" references: []
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/null\"]" references: []
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/archive\"]" references: []
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "null_resource.create_file (expand)" references: []
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ReferenceTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.attachDataResourceDependenciesTransformer
2020/09/18 13:49:40 [TRACE] attachDataDependenciesTransformer: data.archive_file.foo depends on [null_resource.create_file]
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.attachDataResourceDependenciesTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.TargetsTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ForcedCBDTransformer
2020/09/18 13:49:40 [TRACE] ForcedCBDTransformer: "null_resource.create_file (expand)" (*terraform.nodeExpandPlannableResource) has no CBD descendent, so skipping
2020/09/18 13:49:40 [TRACE] ForcedCBDTransformer: "data.archive_file.foo (expand)" (*terraform.nodeExpandPlannableResource) has no CBD descendent, so skipping
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ForcedCBDTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CountBoundaryTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CountBoundaryTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CloseProviderTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CloseProviderTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CloseProvisionerTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CloseProvisionerTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CloseRootModuleTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CloseRootModuleTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
root - *terraform.nodeCloseModule
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.TransitiveReductionTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.TransitiveReductionTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo (expand) - *terraform.nodeExpandPlannableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandPlannableResource
root - *terraform.nodeCloseModule
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
------
2020/09/18 13:49:40 [DEBUG] Starting graph walk: walkPlan
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provisioner.local-exec"
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/archive\"]"
2020/09/18 13:49:40 [TRACE] vertex "provisioner.local-exec": starting visit (*terraform.NodeProvisioner)
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/null\"]"
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/null\"]": starting visit (*terraform.NodeApplyableProvider)
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/archive\"]": starting visit (*terraform.NodeApplyableProvider)
2020-09-18T13:49:40.306-0400 [DEBUG] plugin: starting plugin: path=/Users/alisdair/go/bin/terraform args=[/Users/alisdair/go/bin/terraform, internal-plugin, provisioner, local-exec]
2020-09-18T13:49:40.307-0400 [INFO] plugin: configuring client automatic mTLS
2020-09-18T13:49:40.308-0400 [DEBUG] plugin: plugin started: path=/Users/alisdair/go/bin/terraform pid=11948
2020-09-18T13:49:40.308-0400 [DEBUG] plugin: waiting for RPC address: path=/Users/alisdair/go/bin/terraform
2020-09-18T13:49:40.339-0400 [DEBUG] plugin: starting plugin: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 args=[.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4]
2020-09-18T13:49:40.343-0400 [DEBUG] plugin: plugin started: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 pid=11950
2020-09-18T13:49:40.343-0400 [DEBUG] plugin: waiting for RPC address: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4
2020-09-18T13:49:40.352-0400 [INFO] plugin.terraform-provider-null_v2.1.2_x4: configuring server automatic mTLS: timestamp=2020-09-18T13:49:40.351-0400
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] Terraform version: 0.14.0 dev
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] Go runtime version: go1.14.7
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] CLI args: []string{"/Users/alisdair/go/bin/terraform", "internal-plugin", "provisioner", "local-exec"}
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] Attempting to open CLI config file: /Users/alisdair/.terraformrc
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] File doesn't exist, but doesn't need to. Ignoring.
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] checking for credentials in "/Users/alisdair/.terraform.d/plugins"
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [WARN] found legacy credentials "terraform-credentials-env"
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [WARN] found legacy credentials "terraform-credentials-keychain"
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory terraform.d/plugins
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] will search for provider plugins in /Users/alisdair/.terraform.d/plugins
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [TRACE] getproviders.SearchLocalDirectory: /Users/alisdair/.terraform.d/plugins is a symlink to /Users/alisdair/.terraform.d/plugins
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory /Users/alisdair/Library/Application Support/io.terraform/plugins
2020-09-18T13:49:40.358-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory /Library/Application Support/io.terraform/plugins
2020-09-18T13:49:40.359-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] CLI command args: []string{"internal-plugin", "provisioner", "local-exec"}
2020-09-18T13:49:40.361-0400 [DEBUG] plugin.terraform: local-exec-provisioner (internal) 2020/09/18 13:49:40 [INFO] Starting provisioner plugin local-exec
2020-09-18T13:49:40.361-0400 [DEBUG] plugin.terraform: plugin address: address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin794784624 network=unix timestamp=2020-09-18T13:49:40.360-0400
2020-09-18T13:49:40.361-0400 [DEBUG] plugin: using plugin: version=5
2020/09/18 13:49:40 [TRACE] vertex "provisioner.local-exec": visit complete
2020-09-18T13:49:40.361-0400 [TRACE] plugin.stdio: waiting for stdio data
2020-09-18T13:49:40.381-0400 [DEBUG] plugin.terraform-provider-null_v2.1.2_x4: plugin address: address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin018834565 network=unix timestamp=2020-09-18T13:49:40.381-0400
2020-09-18T13:49:40.381-0400 [DEBUG] plugin: using plugin: version=5
2020/09/18 13:49:40 [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/hashicorp/null\"]" provider for provider["registry.terraform.io/hashicorp/null"]
2020-09-18T13:49:40.431-0400 [TRACE] plugin.stdio: waiting for stdio data
2020-09-18T13:49:40.432-0400 [INFO] plugin: configuring client automatic mTLS
2020-09-18T13:49:40.432-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2020-09-18T13:49:40.456-0400 [DEBUG] plugin: starting plugin: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 args=[.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4]
2020-09-18T13:49:40.458-0400 [DEBUG] plugin: plugin started: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 pid=11951
2020-09-18T13:49:40.458-0400 [DEBUG] plugin: waiting for RPC address: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4
2020-09-18T13:49:40.468-0400 [INFO] plugin.terraform-provider-archive_v1.3.0_x4: configuring server automatic mTLS: timestamp=2020-09-18T13:49:40.468-0400
2020-09-18T13:49:40.494-0400 [DEBUG] plugin.terraform-provider-archive_v1.3.0_x4: plugin address: address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin492946994 network=unix timestamp=2020-09-18T13:49:40.493-0400
2020-09-18T13:49:40.494-0400 [DEBUG] plugin: using plugin: version=5
2020/09/18 13:49:40 [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/hashicorp/archive\"]" provider for provider["registry.terraform.io/hashicorp/archive"]
2020-09-18T13:49:40.543-0400 [TRACE] plugin.stdio: waiting for stdio data
2020/09/18 13:49:40 [TRACE] buildProviderConfig for provider["registry.terraform.io/hashicorp/archive"]: no configuration at all
2020/09/18 13:49:40 [TRACE] GRPCProvider: GetSchema
2020/09/18 13:49:40 [TRACE] buildProviderConfig for provider["registry.terraform.io/hashicorp/null"]: no configuration at all
2020/09/18 13:49:40 [TRACE] GRPCProvider: GetSchema
2020-09-18T13:49:40.543-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2020/09/18 13:49:40 [TRACE] No provider meta schema returned
2020/09/18 13:49:40 [TRACE] No provider meta schema returned
2020/09/18 13:49:40 [TRACE] GRPCProvider: Configure
2020/09/18 13:49:40 [TRACE] GRPCProvider: Configure
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/null\"]": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "null_resource.create_file (expand)"
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file (expand)": starting visit (*terraform.nodeExpandPlannableResource)
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file (expand)": expanding dynamic subgraph
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/archive\"]": visit complete
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file (expand)": entering dynamic subgraph
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "null_resource.create_file"
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": starting visit (*terraform.NodePlannableResource)
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": evaluating
2020/09/18 13:49:40 [TRACE] [walkPlan] Entering eval tree: null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteResourceState
2020/09/18 13:49:40 [TRACE] [walkPlan] Exiting eval tree: null_resource.create_file
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": expanding dynamic subgraph
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ResourceCountTransformer
2020/09/18 13:49:40 [TRACE] ResourceCountTransformer: adding null_resource.create_file as *terraform.NodePlannableResourceInstance
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ResourceCountTransformer with new graph:
null_resource.create_file - *terraform.NodePlannableResourceInstance
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.OrphanResourceInstanceCountTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.OrphanResourceInstanceCountTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachStateTransformer
2020/09/18 13:49:40 [DEBUG] Resource instance state not found for node "null_resource.create_file", instance null_resource.create_file
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.TargetsTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ReferenceTransformer
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "null_resource.create_file" references: []
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ReferenceTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.RootTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.RootTransformer (no changes)
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": entering dynamic subgraph
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "null_resource.create_file"
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": starting visit (*terraform.NodePlannableResourceInstance)
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": evaluating
2020/09/18 13:49:40 [TRACE] [walkPlan] Entering eval tree: null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalSequence
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalGetProvider
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalValidateSelfRef
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalReadState
2020/09/18 13:49:40 [TRACE] EvalReadState: reading state for null_resource.create_file
2020/09/18 13:49:40 [TRACE] EvalReadState: no state present for null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalRefreshDependencies
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalRefresh
2020/09/18 13:49:40 [DEBUG] refresh: null_resource.create_file: no state, so not refreshing
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteState
2020/09/18 13:49:40 [TRACE] EvalWriteState: using RefreshState for null_resource.create_file
2020/09/18 13:49:40 [TRACE] EvalWriteState: removing state object for null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalDiff
2020/09/18 13:49:40 [TRACE] Re-validating config for "null_resource.create_file"
2020/09/18 13:49:40 [TRACE] GRPCProvider: ValidateResourceTypeConfig
2020/09/18 13:49:40 [TRACE] GRPCProvider: PlanResourceChange
2020-09-18T13:49:40.546-0400 [DEBUG] plugin.terraform-provider-null_v2.1.2_x4: 2020/09/18 13:49:40 [DEBUG] Instance Diff is nil in SimpleDiff()
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalCheckPreventDestroy
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteState
2020/09/18 13:49:40 [TRACE] EvalWriteState: writing current state object for null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteDiff
2020/09/18 13:49:40 [TRACE] EvalWriteDiff: recorded Create change for null_resource.create_file
2020/09/18 13:49:40 [TRACE] [walkPlan] Exiting eval tree: null_resource.create_file
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": visit complete
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": dynamic subgraph completed successfully
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": visit complete
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file (expand)": dynamic subgraph completed successfully
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file (expand)": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/null\"] (close)"
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "data.archive_file.foo (expand)"
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo (expand)": starting visit (*terraform.nodeExpandPlannableResource)
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provisioner.local-exec (close)"
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo (expand)": expanding dynamic subgraph
2020/09/18 13:49:40 [TRACE] vertex "provisioner.local-exec (close)": starting visit (*terraform.graphNodeCloseProvisioner)
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo (expand)": entering dynamic subgraph
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/null\"] (close)": starting visit (*terraform.graphNodeCloseProvider)
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "data.archive_file.foo"
2020/09/18 13:49:40 [TRACE] GRPCProvider: Close
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": starting visit (*terraform.NodePlannableResource)
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": evaluating
2020/09/18 13:49:40 [TRACE] [walkPlan] Entering eval tree: data.archive_file.foo
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteResourceState
2020/09/18 13:49:40 [TRACE] [walkPlan] Exiting eval tree: data.archive_file.foo
2020-09-18T13:49:40.547-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = transport is closing"
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": expanding dynamic subgraph
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ResourceCountTransformer
2020/09/18 13:49:40 [TRACE] ResourceCountTransformer: adding data.archive_file.foo as *terraform.NodePlannableResourceInstance
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ResourceCountTransformer with new graph:
data.archive_file.foo - *terraform.NodePlannableResourceInstance
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.OrphanResourceInstanceCountTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.OrphanResourceInstanceCountTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachStateTransformer
2020/09/18 13:49:40 [DEBUG] Resource instance state not found for node "data.archive_file.foo", instance data.archive_file.foo
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.TargetsTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ReferenceTransformer
2020/09/18 13:49:40 [WARN] ReferenceTransformer: reference not found: "null_resource.create_file"
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "data.archive_file.foo" references: []
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ReferenceTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.RootTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.RootTransformer (no changes)
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": entering dynamic subgraph
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "data.archive_file.foo"
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": starting visit (*terraform.NodePlannableResourceInstance)
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": evaluating
2020/09/18 13:49:40 [TRACE] [walkPlan] Entering eval tree: data.archive_file.foo
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalSequence
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalGetProvider
2020-09-18T13:49:40.550-0400 [DEBUG] plugin: plugin process exited: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 pid=11950
2020-09-18T13:49:40.550-0400 [DEBUG] plugin: plugin exited
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/null\"] (close)": visit complete
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalReadState
2020/09/18 13:49:40 [TRACE] EvalReadState: reading state for data.archive_file.foo
2020/09/18 13:49:40 [TRACE] EvalReadState: no state present for data.archive_file.foo
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalValidateSelfRef
2020/09/18 13:49:40 [TRACE] eval: *terraform.evalReadDataPlan
2020/09/18 13:49:40 [TRACE] evalReadDataPlan: data.archive_file.foo configuration is fully known, but we're forcing a read plan to be created
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteState
2020/09/18 13:49:40 [TRACE] EvalWriteState: using RefreshState for data.archive_file.foo
2020/09/18 13:49:40 [TRACE] EvalWriteState: writing current state object for data.archive_file.foo
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteState
2020/09/18 13:49:40 [TRACE] EvalWriteState: writing current state object for data.archive_file.foo
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteDiff
2020/09/18 13:49:40 [TRACE] EvalWriteDiff: recorded Read change for data.archive_file.foo
2020/09/18 13:49:40 [TRACE] [walkPlan] Exiting eval tree: data.archive_file.foo
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": visit complete
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": dynamic subgraph completed successfully
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": visit complete
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo (expand)": dynamic subgraph completed successfully
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo (expand)": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/archive\"] (close)"
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/archive\"] (close)": starting visit (*terraform.graphNodeCloseProvider)
2020/09/18 13:49:40 [TRACE] GRPCProvider: Close
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "meta.count-boundary (EachMode fixup)"
2020/09/18 13:49:40 [TRACE] vertex "meta.count-boundary (EachMode fixup)": starting visit (*terraform.NodeCountBoundary)
2020/09/18 13:49:40 [TRACE] vertex "meta.count-boundary (EachMode fixup)": visit complete
2020-09-18T13:49:40.554-0400 [DEBUG] plugin: plugin process exited: path=/Users/alisdair/go/bin/terraform pid=11948
2020-09-18T13:49:40.554-0400 [DEBUG] plugin: plugin exited
2020-09-18T13:49:40.554-0400 [DEBUG] plugin: plugin process exited: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 pid=11951
2020/09/18 13:49:40 [TRACE] vertex "provisioner.local-exec (close)": visit complete
2020-09-18T13:49:40.554-0400 [DEBUG] plugin: plugin exited
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/archive\"] (close)": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "root"
2020/09/18 13:49:40 [TRACE] vertex "root": starting visit (*terraform.nodeCloseModule)
2020/09/18 13:49:40 [TRACE] vertex "root": visit complete
2020/09/18 13:49:40 [INFO] backend/local: apply calling Apply
2020/09/18 13:49:40 [INFO] terraform: building graph: GraphTypeApply
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ConfigTransformer
2020/09/18 13:49:40 [TRACE] ConfigTransformer: Starting for path:
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ConfigTransformer with new graph:
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.DiffTransformer
2020/09/18 13:49:40 [TRACE] DiffTransformer starting
2020/09/18 13:49:40 [TRACE] DiffTransformer: found Create change for null_resource.create_file
2020/09/18 13:49:40 [TRACE] DiffTransformer: null_resource.create_file will be represented by null_resource.create_file
2020/09/18 13:49:40 [TRACE] DiffTransformer: found Read change for data.archive_file.foo
2020/09/18 13:49:40 [TRACE] DiffTransformer: data.archive_file.foo will be represented by data.archive_file.foo
2020/09/18 13:49:40 [TRACE] DiffTransformer complete
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.DiffTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.OrphanOutputTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.OrphanOutputTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachResourceConfigTransformer
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching to "data.archive_file.foo (expand)" (*terraform.nodeExpandApplyableResource) config from hcl.Range{Filename:"main.tf", Start:hcl.Pos{Line:7, Column:1, Byte:137}, End:hcl.Pos{Line:7, Column:26, Byte:162}}
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to data.archive_file.foo (expand)
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching to "null_resource.create_file" (*terraform.NodeApplyableResourceInstance) config from main.tf:1,1-39
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to null_resource.create_file
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching to "data.archive_file.foo" (*terraform.NodeApplyableResourceInstance) config from hcl.Range{Filename:"main.tf", Start:hcl.Pos{Line:7, Column:1, Byte:137}, End:hcl.Pos{Line:7, Column:26, Byte:162}}
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to data.archive_file.foo
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching to "null_resource.create_file (expand)" (*terraform.nodeExpandApplyableResource) config from main.tf:1,1-39
2020/09/18 13:49:40 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to null_resource.create_file (expand)
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachResourceConfigTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachStateTransformer
2020/09/18 13:49:40 [DEBUG] Resource state not found for node "null_resource.create_file", instance null_resource.create_file
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.MissingProvisionerTransformer
2020/09/18 13:49:40 [TRACE] MissingProviderTransformer: added implicit provisioner local-exec, first implied by null_resource.create_file
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.MissingProvisionerTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ProvisionerTransformer
2020/09/18 13:49:40 [TRACE] ProvisionerTransformer: null_resource.create_file (expand) is provisioned by local-exec ("provisioner.local-exec")
2020/09/18 13:49:40 [TRACE] ProvisionerTransformer: null_resource.create_file is provisioned by local-exec ("provisioner.local-exec")
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ProvisionerTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.RootVariableTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.RootVariableTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.LocalTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.LocalTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.OutputTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.OutputTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ModuleVariableTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ModuleVariableTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.graphTransformerMulti
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderConfigTransformer
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderConfigTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.MissingProviderTransformer
2020/09/18 13:49:40 [DEBUG] adding implicit provider configuration provider["registry.terraform.io/hashicorp/archive"], implied first by data.archive_file.foo
2020/09/18 13:49:40 [DEBUG] adding implicit provider configuration provider["registry.terraform.io/hashicorp/null"], implied first by null_resource.create_file (expand)
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.MissingProviderTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderTransformer
2020/09/18 13:49:40 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/archive"] serving data.archive_file.foo (expand)
2020/09/18 13:49:40 [DEBUG] ProviderTransformer: "data.archive_file.foo (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/archive"]
2020/09/18 13:49:40 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/null"] serving null_resource.create_file
2020/09/18 13:49:40 [DEBUG] ProviderTransformer: "null_resource.create_file" (*terraform.NodeApplyableResourceInstance) needs provider["registry.terraform.io/hashicorp/null"]
2020/09/18 13:49:40 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/archive"] serving data.archive_file.foo
2020/09/18 13:49:40 [DEBUG] ProviderTransformer: "data.archive_file.foo" (*terraform.NodeApplyableResourceInstance) needs provider["registry.terraform.io/hashicorp/archive"]
2020/09/18 13:49:40 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/null"] serving null_resource.create_file (expand)
2020/09/18 13:49:40 [DEBUG] ProviderTransformer: "null_resource.create_file (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/hashicorp/null"]
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.PruneProviderTransformer
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.PruneProviderTransformer (no changes)
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ParentProviderTransformer
2020/09/18 13:49:40 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ParentProviderTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.graphTransformerMulti with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.RemovedModuleTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.RemovedModuleTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachSchemaTransformer
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching resource schema to null_resource.create_file (expand)
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching provisioner "local-exec" config schema to null_resource.create_file (expand)
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching resource schema to data.archive_file.foo (expand)
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching resource schema to null_resource.create_file
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching provisioner "local-exec" config schema to null_resource.create_file
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching resource schema to data.archive_file.foo
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching provider config schema to provider["registry.terraform.io/hashicorp/archive"]
2020/09/18 13:49:40 [TRACE] AttachSchemaTransformer: attaching provider config schema to provider["registry.terraform.io/hashicorp/null"]
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachSchemaTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ModuleExpansionTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ModuleExpansionTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ReferenceTransformer
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "null_resource.create_file" references: []
2020/09/18 13:49:40 [WARN] ReferenceTransformer: reference not found: "null_resource.create_file#destroy"
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "data.archive_file.foo" references: [null_resource.create_file null_resource.create_file null_resource.create_file (expand)]
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "provisioner.local-exec" references: []
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/archive\"]" references: []
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/null\"]" references: []
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "null_resource.create_file (expand)" references: []
2020/09/18 13:49:40 [DEBUG] ReferenceTransformer: "data.archive_file.foo (expand)" references: []
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ReferenceTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.AttachDependenciesTransformer
2020/09/18 13:49:40 [TRACE] AttachDependenciesTransformer: null_resource.create_file depends on []
2020/09/18 13:49:40 [TRACE] AttachDependenciesTransformer: data.archive_file.foo depends on [null_resource.create_file]
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.AttachDependenciesTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.ForcedCBDTransformer
2020/09/18 13:49:40 [TRACE] ForcedCBDTransformer: "null_resource.create_file" (*terraform.NodeApplyableResourceInstance) has no CBD descendent, so skipping
2020/09/18 13:49:40 [TRACE] ForcedCBDTransformer: "data.archive_file.foo" (*terraform.NodeApplyableResourceInstance) has no CBD descendent, so skipping
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.ForcedCBDTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.DestroyEdgeTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.DestroyEdgeTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CBDEdgeTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CBDEdgeTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.destroyRootOutputTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.destroyRootOutputTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.pruneUnusedNodesTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.pruneUnusedNodesTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.TargetsTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CountBoundaryTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CountBoundaryTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CloseProviderTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CloseProviderTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CloseProvisionerTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CloseProvisionerTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.applyDestroyNodeReferenceFixupTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.applyDestroyNodeReferenceFixupTransformer (no changes)
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.CloseRootModuleTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.CloseRootModuleTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
root - *terraform.nodeCloseModule
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
------
2020/09/18 13:49:40 [TRACE] Executing graph transform *terraform.TransitiveReductionTransformer
2020/09/18 13:49:40 [TRACE] Completed graph transform *terraform.TransitiveReductionTransformer with new graph:
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file - *terraform.NodeApplyableResourceInstance
data.archive_file.foo (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
null_resource.create_file - *terraform.NodeApplyableResourceInstance
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
null_resource.create_file (expand) - *terraform.nodeExpandApplyableResource
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provisioner.local-exec - *terraform.NodeProvisioner
provider["registry.terraform.io/hashicorp/archive"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
data.archive_file.foo - *terraform.NodeApplyableResourceInstance
provider["registry.terraform.io/hashicorp/null"] - *terraform.NodeApplyableProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
null_resource.create_file - *terraform.NodeApplyableResourceInstance
provisioner.local-exec - *terraform.NodeProvisioner
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
null_resource.create_file - *terraform.NodeApplyableResourceInstance
root - *terraform.nodeCloseModule
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
provider["registry.terraform.io/hashicorp/archive"] (close) - *terraform.graphNodeCloseProvider
provider["registry.terraform.io/hashicorp/null"] (close) - *terraform.graphNodeCloseProvider
provisioner.local-exec (close) - *terraform.graphNodeCloseProvisioner
------
2020/09/18 13:49:40 [DEBUG] Starting graph walk: walkApply
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/null\"]"
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/null\"]": starting visit (*terraform.NodeApplyableProvider)
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/archive\"]"
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/archive\"]": starting visit (*terraform.NodeApplyableProvider)
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "provisioner.local-exec"
2020/09/18 13:49:40 [TRACE] vertex "provisioner.local-exec": starting visit (*terraform.NodeProvisioner)
2020-09-18T13:49:40.558-0400 [DEBUG] plugin: starting plugin: path=/Users/alisdair/go/bin/terraform args=[/Users/alisdair/go/bin/terraform, internal-plugin, provisioner, local-exec]
2020-09-18T13:49:40.559-0400 [INFO] plugin: configuring client automatic mTLS
2020-09-18T13:49:40.560-0400 [DEBUG] plugin: plugin started: path=/Users/alisdair/go/bin/terraform pid=11952
2020-09-18T13:49:40.560-0400 [DEBUG] plugin: waiting for RPC address: path=/Users/alisdair/go/bin/terraform
2020-09-18T13:49:40.590-0400 [DEBUG] plugin: starting plugin: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 args=[.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4]
2020-09-18T13:49:40.592-0400 [DEBUG] plugin: plugin started: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4 pid=11954
2020-09-18T13:49:40.592-0400 [DEBUG] plugin: waiting for RPC address: path=.terraform/plugins/registry.terraform.io/hashicorp/null/2.1.2/darwin_amd64/terraform-provider-null_v2.1.2_x4
2020-09-18T13:49:40.601-0400 [INFO] plugin.terraform-provider-null_v2.1.2_x4: configuring server automatic mTLS: timestamp=2020-09-18T13:49:40.600-0400
2020-09-18T13:49:40.608-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] Terraform version: 0.14.0 dev
2020-09-18T13:49:40.608-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] Go runtime version: go1.14.7
2020-09-18T13:49:40.608-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] CLI args: []string{"/Users/alisdair/go/bin/terraform", "internal-plugin", "provisioner", "local-exec"}
2020-09-18T13:49:40.608-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] Attempting to open CLI config file: /Users/alisdair/.terraformrc
2020-09-18T13:49:40.609-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] File doesn't exist, but doesn't need to. Ignoring.
2020-09-18T13:49:40.609-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] checking for credentials in "/Users/alisdair/.terraform.d/plugins"
2020-09-18T13:49:40.609-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [WARN] found legacy credentials "terraform-credentials-env"
2020-09-18T13:49:40.612-0400 [DEBUG] plugin: using plugin: version=5
2020/09/18 13:49:40 [TRACE] vertex "provisioner.local-exec": visit complete
2020-09-18T13:49:40.613-0400 [TRACE] plugin.stdio: waiting for stdio data
2020-09-18T13:49:40.614-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [WARN] found legacy credentials "terraform-credentials-keychain"
2020-09-18T13:49:40.614-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory terraform.d/plugins
2020-09-18T13:49:40.614-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] will search for provider plugins in /Users/alisdair/.terraform.d/plugins
2020-09-18T13:49:40.614-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [TRACE] getproviders.SearchLocalDirectory: /Users/alisdair/.terraform.d/plugins is a symlink to /Users/alisdair/.terraform.d/plugins
2020-09-18T13:49:40.614-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory /Users/alisdair/Library/Application Support/io.terraform/plugins
2020-09-18T13:49:40.614-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [DEBUG] ignoring non-existing provider search directory /Library/Application Support/io.terraform/plugins
2020-09-18T13:49:40.614-0400 [DEBUG] plugin.terraform: 2020/09/18 13:49:40 [INFO] CLI command args: []string{"internal-plugin", "provisioner", "local-exec"}
2020-09-18T13:49:40.614-0400 [DEBUG] plugin.terraform: local-exec-provisioner (internal) 2020/09/18 13:49:40 [INFO] Starting provisioner plugin local-exec
2020-09-18T13:49:40.614-0400 [DEBUG] plugin.terraform: plugin address: address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin339621132 network=unix timestamp=2020-09-18T13:49:40.610-0400
2020-09-18T13:49:40.629-0400 [DEBUG] plugin: using plugin: version=5
2020-09-18T13:49:40.629-0400 [DEBUG] plugin.terraform-provider-null_v2.1.2_x4: plugin address: address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin239422241 network=unix timestamp=2020-09-18T13:49:40.629-0400
2020/09/18 13:49:40 [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/hashicorp/null\"]" provider for provider["registry.terraform.io/hashicorp/null"]
2020-09-18T13:49:40.682-0400 [TRACE] plugin.stdio: waiting for stdio data
2020/09/18 13:49:40 [TRACE] buildProviderConfig for provider["registry.terraform.io/hashicorp/null"]: no configuration at all
2020/09/18 13:49:40 [TRACE] GRPCProvider: GetSchema
2020-09-18T13:49:40.682-0400 [INFO] plugin: configuring client automatic mTLS
2020/09/18 13:49:40 [TRACE] No provider meta schema returned
2020-09-18T13:49:40.682-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2020-09-18T13:49:40.705-0400 [DEBUG] plugin: starting plugin: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 args=[.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4]
2020-09-18T13:49:40.708-0400 [DEBUG] plugin: plugin started: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4 pid=11955
2020-09-18T13:49:40.708-0400 [DEBUG] plugin: waiting for RPC address: path=.terraform/plugins/registry.terraform.io/hashicorp/archive/1.3.0/darwin_amd64/terraform-provider-archive_v1.3.0_x4
2020-09-18T13:49:40.719-0400 [INFO] plugin.terraform-provider-archive_v1.3.0_x4: configuring server automatic mTLS: timestamp=2020-09-18T13:49:40.719-0400
2020-09-18T13:49:40.746-0400 [DEBUG] plugin: using plugin: version=5
2020-09-18T13:49:40.746-0400 [DEBUG] plugin.terraform-provider-archive_v1.3.0_x4: plugin address: address=/var/folders/d6/3gfl83ks03sf7j34c0c9125r0000gn/T/plugin685247502 network=unix timestamp=2020-09-18T13:49:40.745-0400
2020/09/18 13:49:40 [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/hashicorp/archive\"]" provider for provider["registry.terraform.io/hashicorp/archive"]
2020/09/18 13:49:40 [TRACE] buildProviderConfig for provider["registry.terraform.io/hashicorp/archive"]: no configuration at all
2020/09/18 13:49:40 [TRACE] GRPCProvider: GetSchema
2020/09/18 13:49:40 [TRACE] GRPCProvider: Configure
2020-09-18T13:49:40.801-0400 [TRACE] plugin.stdio: waiting for stdio data
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/null\"]": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "null_resource.create_file (expand)"
2020-09-18T13:49:40.801-0400 [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file (expand)": starting visit (*terraform.nodeExpandApplyableResource)
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file (expand)": expanding dynamic subgraph
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file (expand)": entering dynamic subgraph
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "null_resource.create_file"
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": starting visit (*terraform.NodeApplyableResource)
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": evaluating
2020/09/18 13:49:40 [TRACE] [walkApply] Entering eval tree: null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteResourceState
2020/09/18 13:49:40 [TRACE] [walkApply] Exiting eval tree: null_resource.create_file
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": visit complete
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file (expand)": dynamic subgraph completed successfully
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file (expand)": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "null_resource.create_file"
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": starting visit (*terraform.NodeApplyableResourceInstance)
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": evaluating
2020/09/18 13:49:40 [TRACE] [walkApply] Entering eval tree: null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalSequence
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalGetProvider
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalReadDiff
2020/09/18 13:49:40 [TRACE] EvalReadDiff: Read Create change from plan for null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalIf
2020/09/18 13:49:40 [TRACE] eval: terraform.EvalNoop
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalIf
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalReadState
2020/09/18 13:49:40 [TRACE] EvalReadState: reading state for null_resource.create_file
2020/09/18 13:49:40 [TRACE] EvalReadState: no state present for null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalReadDiff
2020/09/18 13:49:40 [TRACE] EvalReadDiff: Read Create change from plan for null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalDiff
2020/09/18 13:49:40 [TRACE] No provider meta schema returned
2020/09/18 13:49:40 [TRACE] Re-validating config for "null_resource.create_file"
2020/09/18 13:49:40 [TRACE] GRPCProvider: ValidateResourceTypeConfig
2020/09/18 13:49:40 [TRACE] GRPCProvider: Configure
2020/09/18 13:49:40 [TRACE] GRPCProvider: PlanResourceChange
2020/09/18 13:49:40 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/archive\"]": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "data.archive_file.foo (expand)"
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo (expand)": starting visit (*terraform.nodeExpandApplyableResource)
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo (expand)": expanding dynamic subgraph
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo (expand)": entering dynamic subgraph
2020/09/18 13:49:40 [TRACE] dag/walk: visiting "data.archive_file.foo"
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": starting visit (*terraform.NodeApplyableResource)
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": evaluating
2020/09/18 13:49:40 [TRACE] [walkApply] Entering eval tree: data.archive_file.foo
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteResourceState
2020/09/18 13:49:40 [TRACE] [walkApply] Exiting eval tree: data.archive_file.foo
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo": visit complete
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo (expand)": dynamic subgraph completed successfully
2020/09/18 13:49:40 [TRACE] vertex "data.archive_file.foo (expand)": visit complete
2020-09-18T13:49:40.803-0400 [DEBUG] plugin.terraform-provider-null_v2.1.2_x4: 2020/09/18 13:49:40 [DEBUG] Instance Diff is nil in SimpleDiff()
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalCheckPlannedChange
2020/09/18 13:49:40 [TRACE] EvalCheckPlannedChange: Verifying that actual change (action Create) matches planned change (action Create)
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalGetProvider
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalReadState
2020/09/18 13:49:40 [TRACE] EvalReadState: reading state for null_resource.create_file
2020/09/18 13:49:40 [TRACE] EvalReadState: no state present for null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalReduceDiff
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalIf
2020/09/18 13:49:40 [TRACE] eval: terraform.EvalNoop
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalApplyPre
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalApply
null_resource.create_file: Creating...
2020/09/18 13:49:40 [DEBUG] EvalApply: ProviderMeta config value set
2020/09/18 13:49:40 [DEBUG] null_resource.create_file: applying the planned Create change
2020/09/18 13:49:40 [TRACE] GRPCProvider: ApplyResourceChange
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalMaybeTainted
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteState
2020/09/18 13:49:40 [TRACE] EvalWriteState: recording 0 dependencies for null_resource.create_file
2020/09/18 13:49:40 [TRACE] EvalWriteState: writing current state object for null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalApplyProvisioners
2020/09/18 13:49:40 [TRACE] EvalApplyProvisioners: provisioning null_resource.create_file with "local-exec"
null_resource.create_file: Provisioning with 'local-exec'...
null_resource.create_file (local-exec): Executing: ["/bin/sh" "-c" "mkdir -p files && echo foo > files/test.txt"]
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalMaybeTainted
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteState
2020/09/18 13:49:40 [TRACE] EvalWriteState: recording 0 dependencies for null_resource.create_file
2020/09/18 13:49:40 [TRACE] EvalWriteState: writing current state object for null_resource.create_file
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalIf
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalIf
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalWriteDiff
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalApplyPost
2020/09/18 13:49:40 [TRACE] eval: *terraform.EvalUpdateStateHook
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: reading latest snapshot from terraform.tfstate
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: snapshot file has nil snapshot, but that's okay
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: read nil snapshot
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: no original state snapshot to back up
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: state has changed since last snapshot, so incrementing serial to 1
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: writing snapshot at terraform.tfstate
null_resource.create_file: Creation complete after 0s [id=7974741222615163738]
2020/09/18 13:49:40 [ERROR] eval: *terraform.EvalUpdateStateHook, err: Failed to serialize resource instance in state: Instance data.archive_file.foo has status ObjectPlanned, which cannot be saved in state.
2020/09/18 13:49:40 [ERROR] eval: *terraform.EvalSequence, err: Failed to serialize resource instance in state: Instance data.archive_file.foo has status ObjectPlanned, which cannot be saved in state.
2020/09/18 13:49:40 [TRACE] [walkApply] Exiting eval tree: null_resource.create_file
2020/09/18 13:49:40 [TRACE] vertex "null_resource.create_file": visit complete
2020/09/18 13:49:40 [TRACE] dag/walk: upstream of "provisioner.local-exec (close)" errored, so skipping
2020/09/18 13:49:40 [TRACE] dag/walk: upstream of "data.archive_file.foo" errored, so skipping
2020/09/18 13:49:40 [TRACE] dag/walk: upstream of "provider[\"registry.terraform.io/hashicorp/null\"] (close)" errored, so skipping
2020/09/18 13:49:40 [TRACE] dag/walk: upstream of "provider[\"registry.terraform.io/hashicorp/archive\"] (close)" errored, so skipping
2020/09/18 13:49:40 [TRACE] dag/walk: upstream of "meta.count-boundary (EachMode fixup)" errored, so skipping
2020/09/18 13:49:40 [TRACE] dag/walk: upstream of "root" errored, so skipping
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: reading latest snapshot from terraform.tfstate
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: read snapshot with lineage "b17e5e66-42dd-e6ab-cd40-3eb44a7f972f" serial 1
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: no original state snapshot to back up
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: removing lock metadata file .terraform.tfstate.lock.info
2020/09/18 13:49:40 [TRACE] statemgr.Filesystem: unlocking terraform.tfstate using fcntl flock
panic: Failed to serialize resource instance in state: Instance data.archive_file.foo has status ObjectPlanned, which cannot be saved in state.
goroutine 9 [running]:
github.com/hashicorp/terraform/states/statefile.StatesMarshalEqual(0xc0006241b0, 0xc0006241a0, 0x0)
/Users/alisdair/code/terraform/states/statefile/marshal_equal.go:31 +0x23b
github.com/hashicorp/terraform/states/statemgr.(*Filesystem).writeState(0xc00061a300, 0xc000624138, 0x0, 0x0, 0x0)
/Users/alisdair/code/terraform/states/statemgr/filesystem.go:201 +0x507
github.com/hashicorp/terraform/states/statemgr.(*Filesystem).WriteState(0xc00061a300, 0xc000624138, 0x0, 0x0)
/Users/alisdair/code/terraform/states/statemgr/filesystem.go:136 +0x7f
github.com/hashicorp/terraform/states/statemgr.WriteAndPersist(0xd353e48, 0xc00061a300, 0xc000624138, 0xd353e48, 0xc00061a300)
/Users/alisdair/code/terraform/states/statemgr/helper.go:48 +0x3f
github.com/hashicorp/terraform/backend/local.(*Local).opApply(0xc00062ef70, 0x38d6dc0, 0xc000100b40, 0x38d6dc0, 0xc000100b80, 0xc00020a2a0, 0xc000100b00)
/Users/alisdair/code/terraform/backend/local/backend_apply.go:171 +0x733
github.com/hashicorp/terraform/backend/local.(*Local).Operation.func1(0xc0006323d0, 0xc0006323e0, 0xc0006323f0, 0xc00062ef70, 0xc0006323c0, 0x38d6dc0, 0xc000100b40, 0x38d6dc0, 0xc000100b80, 0xc00020a2a0, ...)
/Users/alisdair/code/terraform/backend/local/backend.go:340 +0xe8
created by github.com/hashicorp/terraform/backend/local.(*Local).Operation
/Users/alisdair/code/terraform/backend/local/backend.go:334 +0x366
panic: Failed to serialize resource instance in state: Instance data.archive_file.foo has status ObjectPlanned, which cannot be saved in state.
goroutine 9 [running]:
github.com/hashicorp/terraform/states/statefile.StatesMarshalEqual(0xc0006241b0, 0xc0006241a0, 0x0)
/Users/alisdair/code/terraform/states/statefile/marshal_equal.go:31 +0x23b
github.com/hashicorp/terraform/states/statemgr.(*Filesystem).writeState(0xc00061a300, 0xc000624138, 0x0, 0x0, 0x0)
/Users/alisdair/code/terraform/states/statemgr/filesystem.go:201 +0x507
github.com/hashicorp/terraform/states/statemgr.(*Filesystem).WriteState(0xc00061a300, 0xc000624138, 0x0, 0x0)
/Users/alisdair/code/terraform/states/statemgr/filesystem.go:136 +0x7f
github.com/hashicorp/terraform/states/statemgr.WriteAndPersist(0xd353e48, 0xc00061a300, 0xc000624138, 0xd353e48, 0xc00061a300)
/Users/alisdair/code/terraform/states/statemgr/helper.go:48 +0x3f
github.com/hashicorp/terraform/backend/local.(*Local).opApply(0xc00062ef70, 0x38d6dc0, 0xc000100b40, 0x38d6dc0, 0xc000100b80, 0xc00020a2a0, 0xc000100b00)
/Users/alisdair/code/terraform/backend/local/backend_apply.go:171 +0x733
github.com/hashicorp/terraform/backend/local.(*Local).Operation.func1(0xc0006323d0, 0xc0006323e0, 0xc0006323f0, 0xc00062ef70, 0xc0006323c0, 0x38d6dc0, 0xc000100b40, 0x38d6dc0, 0xc000100b80, 0xc00020a2a0, ...)
/Users/alisdair/code/terraform/backend/local/backend.go:340 +0xe8
created by github.com/hashicorp/terraform/backend/local.(*Local).Operation
/Users/alisdair/code/terraform/backend/local/backend.go:334 +0x366
!!!!!!!!!!!!!!!!!!!!!!!!!!! TERRAFORM CRASH !!!!!!!!!!!!!!!!!!!!!!!!!!!!
Terraform crashed! This is always indicative of a bug within Terraform.
A crash log has been placed at "crash.log" relative to your current
working directory. It would be immensely helpful if you could please
report the crash with Terraform[1] so that we can fix this.
When reporting bugs, please include your terraform version. That
information is available on the first line of crash.log. You can also
get it by running 'terraform --version' on the command line.
SECURITY WARNING: the "crash.log" file that was created may contain
sensitive information that must be redacted before it is safe to share
on the issue tracker.
[1]: https://github.com/hashicorp/terraform/issues
!!!!!!!!!!!!!!!!!!!!!!!!!!! TERRAFORM CRASH !!!!!!!!!!!!!!!!!!!!!!!!!!!!
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment