Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

terraform destroy command is not working and seems to be hanging on Mac OS Big Sur #27350

Open
arunstiwari opened this issue Dec 21, 2020 · 14 comments
Open

terraform destroy command is not working and seems to be hanging on Mac OS Big Sur #27350

arunstiwari opened this issue Dec 21, 2020 · 14 comments
Labels
bug new new issue not yet triaged waiting for reproduction unable to reproduce issue without further information

Comments

@arunstiwari
Copy link

arunstiwari commented Dec 21, 2020 •
edited by jbardin

Terraform Version

Terraform v0.14.2

Debug Output

Crash Output

2020/12/21 13:31:20 [INFO] Terraform version: 0.14.2  
2020/12/21 13:31:20 [INFO] Go runtime version: go1.15.2
2020/12/21 13:31:20 [INFO] CLI args: []string{"/opt/local/bin/terraform", "destroy"}
2020/12/21 13:31:20 [DEBUG] Attempting to open CLI config file: /Users/arunstiwari/.terraformrc
2020/12/21 13:31:20 [DEBUG] File doesn't exist, but doesn't need to. Ignoring.
2020/12/21 13:31:20 [DEBUG] ignoring non-existing provider search directory terraform.d/plugins
2020/12/21 13:31:20 [DEBUG] ignoring non-existing provider search directory /Users/arunstiwari/.terraform.d/plugins
2020/12/21 13:31:20 [DEBUG] ignoring non-existing provider search directory /Users/arunstiwari/Library/Application Support/io.terraform/plugins
2020/12/21 13:31:20 [DEBUG] ignoring non-existing provider search directory /Library/Application Support/io.terraform/plugins
2020/12/21 13:31:20 [INFO] CLI command args: []string{"destroy"}
2020/12/21 13:31:20 [TRACE] Meta.Backend: no config given or present on disk, so returning nil config
2020/12/21 13:31:20 [TRACE] Meta.Backend: backend has not previously been initialized in this working directory
2020/12/21 13:31:20 [DEBUG] New state was assigned lineage "f177d066-3254-2986-bad8-3eed2b73f916"
2020/12/21 13:31:20 [TRACE] Meta.Backend: using default local state only (no backend configuration, and no existing initialized backend)
2020/12/21 13:31:20 [TRACE] Meta.Backend: instantiated backend of type <nil>
2020/12/21 13:31:20 [TRACE] providercache.fillMetaCache: scanning directory .terraform/providers
2020/12/21 13:31:20 [TRACE] getproviders.SearchLocalDirectory: .terraform/providers is a symlink to .terraform/providers
2020/12/21 13:31:20 [TRACE] getproviders.SearchLocalDirectory: found registry.terraform.io/hashicorp/aws v3.22.0 for darwin_amd64 at .terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64
2020/12/21 13:31:20 [TRACE] providercache.fillMetaCache: including .terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64 as a candidate package for registry.terraform.io/hashicorp/aws 3.22.0
2020/12/21 13:31:21 [DEBUG] checking for provisioner in "."
2020/12/21 13:31:21 [DEBUG] checking for provisioner in "/opt/local/bin"
2020/12/21 13:31:21 [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/12/21 13:31:21 [TRACE] Meta.Backend: backend <nil> does not support operations, so wrapping it in a local backend
2020/12/21 13:31:21 [INFO] backend/local: starting Apply operation
2020/12/21 13:31:21 [TRACE] backend/local: requesting state manager for workspace "default"
2020/12/21 13:31:21 [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/12/21 13:31:21 [TRACE] backend/local: requesting state lock for workspace "default"
2020/12/21 13:31:21 [TRACE] statemgr.Filesystem: preparing to manage state snapshots at terraform.tfstate
2020/12/21 13:31:21 [TRACE] statemgr.Filesystem: existing snapshot has lineage "4436e001-618c-bef9-7337-fcf4c3c5938f" serial 3
2020/12/21 13:31:21 [TRACE] statemgr.Filesystem: locking terraform.tfstate using fcntl flock
2020/12/21 13:31:21 [TRACE] statemgr.Filesystem: writing lock metadata to .terraform.tfstate.lock.info
2020/12/21 13:31:21 [TRACE] backend/local: reading remote state for workspace "default"
2020/12/21 13:31:21 [TRACE] statemgr.Filesystem: reading latest snapshot from terraform.tfstate
2020/12/21 13:31:21 [TRACE] statemgr.Filesystem: read snapshot with lineage "4436e001-618c-bef9-7337-fcf4c3c5938f" serial 3
2020/12/21 13:31:21 [TRACE] backend/local: retrieving local state snapshot for workspace "default"
2020/12/21 13:31:21 [TRACE] backend/local: building context for current working directory
2020/12/21 13:31:21 [TRACE] terraform.NewContext: starting
2020/12/21 13:31:21 [TRACE] terraform.NewContext: loading provider schemas
2020/12/21 13:31:21 [TRACE] LoadSchemas: retrieving schema for provider type "registry.terraform.io/hashicorp/aws"
2020-12-21T13:31:21.123+0530 [INFO]  plugin: configuring client automatic mTLS
2020-12-21T13:31:21.169+0530 [DEBUG] plugin: starting plugin: path=.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5 args=[.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5]
2020-12-21T13:31:21.177+0530 [DEBUG] plugin: plugin started: path=.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5 pid=3059
2020-12-21T13:31:21.177+0530 [DEBUG] plugin: waiting for RPC address: path=.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5
2020-12-21T13:31:21.240+0530 [INFO]  plugin.terraform-provider-aws_v3.22.0_x5: configuring server automatic mTLS: timestamp=2020-12-21T13:31:21.240+0530
2020-12-21T13:31:21.288+0530 [DEBUG] plugin.terraform-provider-aws_v3.22.0_x5: plugin address: network=unix address=/var/folders/cn/xl8ghpn91fsg2t_vz9jfcjr80000gn/T/plugin806262438 timestamp=2020-12-21T13:31:21.288+0530
2020-12-21T13:31:21.288+0530 [DEBUG] plugin: using plugin: version=5
2020/12/21 13:31:21 [TRACE] GRPCProvider: GetSchema
2020-12-21T13:31:21.393+0530 [TRACE] plugin.stdio: waiting for stdio data
2020/12/21 13:31:21 [TRACE] GRPCProvider: Close
2020-12-21T13:31:21.467+0530 [WARN]  plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = transport is closing"
2020-12-21T13:31:21.470+0530 [DEBUG] plugin: plugin process exited: path=.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5 pid=3059
2020-12-21T13:31:21.470+0530 [DEBUG] plugin: plugin exited
2020/12/21 13:31:21 [TRACE] terraform.NewContext: complete
2020/12/21 13:31:21 [TRACE] backend/local: finished building terraform.Context
2020/12/21 13:31:21 [TRACE] backend/local: requesting interactive input, if necessary
2020/12/21 13:31:21 [TRACE] Context.Input: Prompting for provider arguments
2020/12/21 13:31:21 [TRACE] Context.Input: Provider provider.aws declared at 02_1_provider.tf:1,1-15
2020/12/21 13:31:21 [TRACE] Context.Input: Provider provider.aws.virginia declared at 02_1_provider.tf:5,1-15
2020/12/21 13:31:21 [TRACE] Context.Input: Input for provider.aws: map[string]cty.Value{}
2020/12/21 13:31:21 [TRACE] Context.Input: Input for provider.aws.virginia: map[string]cty.Value{}
2020/12/21 13:31:21 [TRACE] backend/local: running validation operation
2020/12/21 13:31:21 [INFO] terraform: building graph: GraphTypeValidate
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.ConfigTransformer
2020/12/21 13:31:21 [TRACE] ConfigTransformer: Starting for path: 
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.ConfigTransformer with new graph:
  aws_s3_bucket.default - *terraform.NodeValidatableResource
  aws_s3_bucket.virginia_bucket - *terraform.NodeValidatableResource
  ------
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.RootVariableTransformer
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.RootVariableTransformer (no changes)
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.ModuleVariableTransformer
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.ModuleVariableTransformer (no changes)
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.LocalTransformer
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.LocalTransformer (no changes)
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.OutputTransformer
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.OutputTransformer (no changes)
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.OrphanResourceInstanceTransformer
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.OrphanResourceInstanceTransformer (no changes)
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.StateTransformer
2020/12/21 13:31:21 [TRACE] StateTransformer: state is empty, so nothing to do
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.StateTransformer (no changes)
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.AttachStateTransformer
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.OrphanOutputTransformer
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.OrphanOutputTransformer (no changes)
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.AttachResourceConfigTransformer
2020/12/21 13:31:21 [TRACE] AttachResourceConfigTransformer: attaching to "aws_s3_bucket.virginia_bucket" (*terraform.NodeValidatableResource) config from 02_1_provider.tf:10,1-43
2020/12/21 13:31:21 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to aws_s3_bucket.virginia_bucket
2020/12/21 13:31:21 [TRACE] AttachResourceConfigTransformer: attaching to "aws_s3_bucket.default" (*terraform.NodeValidatableResource) config from 02_1_provider.tf:15,1-35
2020/12/21 13:31:21 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to aws_s3_bucket.default
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.AttachResourceConfigTransformer (no changes)
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.MissingProvisionerTransformer
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.MissingProvisionerTransformer (no changes)
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.ProvisionerTransformer
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.ProvisionerTransformer (no changes)
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.graphTransformerMulti
2020/12/21 13:31:21 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderConfigTransformer
2020/12/21 13:31:21 [TRACE] ProviderConfigTransformer: attaching to "provider[\"registry.terraform.io/hashicorp/aws\"]" provider configuration from 02_1_provider.tf:1,1-15
2020/12/21 13:31:21 [TRACE] ProviderConfigTransformer: attaching to "provider[\"registry.terraform.io/hashicorp/aws\"].virginia" provider configuration from 02_1_provider.tf:5,1-15
2020/12/21 13:31:21 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderConfigTransformer with new graph:
  aws_s3_bucket.default - *terraform.NodeValidatableResource
  aws_s3_bucket.virginia_bucket - *terraform.NodeValidatableResource
  provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  ------
2020/12/21 13:31:21 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.MissingProviderTransformer
2020/12/21 13:31:21 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.MissingProviderTransformer (no changes)
2020/12/21 13:31:21 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderTransformer
2020/12/21 13:31:21 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/aws"].virginia serving aws_s3_bucket.virginia_bucket
2020/12/21 13:31:21 [DEBUG] ProviderTransformer: "aws_s3_bucket.virginia_bucket" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/hashicorp/aws"].virginia
2020/12/21 13:31:21 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/aws"] serving aws_s3_bucket.default
2020/12/21 13:31:21 [DEBUG] ProviderTransformer: "aws_s3_bucket.default" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/hashicorp/aws"]
2020/12/21 13:31:21 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderTransformer with new graph:
  aws_s3_bucket.default - *terraform.NodeValidatableResource
    provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  aws_s3_bucket.virginia_bucket - *terraform.NodeValidatableResource
    provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  ------
2020/12/21 13:31:21 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.PruneProviderTransformer
2020/12/21 13:31:21 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.PruneProviderTransformer (no changes)
2020/12/21 13:31:21 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ParentProviderTransformer
2020/12/21 13:31:21 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ParentProviderTransformer (no changes)
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.graphTransformerMulti with new graph:
  aws_s3_bucket.default - *terraform.NodeValidatableResource
    provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  aws_s3_bucket.virginia_bucket - *terraform.NodeValidatableResource
    provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  ------
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.RemovedModuleTransformer
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.RemovedModuleTransformer (no changes)
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.AttachSchemaTransformer
2020/12/21 13:31:21 [TRACE] AttachSchemaTransformer: attaching provider config schema to provider["registry.terraform.io/hashicorp/aws"]
2020/12/21 13:31:21 [TRACE] AttachSchemaTransformer: attaching provider config schema to provider["registry.terraform.io/hashicorp/aws"].virginia
2020/12/21 13:31:21 [TRACE] AttachSchemaTransformer: attaching resource schema to aws_s3_bucket.virginia_bucket
2020/12/21 13:31:21 [TRACE] AttachSchemaTransformer: attaching resource schema to aws_s3_bucket.default
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.AttachSchemaTransformer (no changes)
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.ModuleExpansionTransformer
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.ModuleExpansionTransformer (no changes)
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.ReferenceTransformer
2020/12/21 13:31:21 [DEBUG] ReferenceTransformer: "aws_s3_bucket.default" references: []
2020/12/21 13:31:21 [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/aws\"]" references: []
2020/12/21 13:31:21 [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/hashicorp/aws\"].virginia" references: []
2020/12/21 13:31:21 [DEBUG] ReferenceTransformer: "aws_s3_bucket.virginia_bucket" references: []
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.ReferenceTransformer (no changes)
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.AttachDependenciesTransformer
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.AttachDependenciesTransformer (no changes)
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.attachDataResourceDependenciesTransformer
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.attachDataResourceDependenciesTransformer (no changes)
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.TargetsTransformer
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.ForcedCBDTransformer
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.ForcedCBDTransformer (no changes)
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.CountBoundaryTransformer
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.CountBoundaryTransformer with new graph:
  aws_s3_bucket.default - *terraform.NodeValidatableResource
    provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  aws_s3_bucket.virginia_bucket - *terraform.NodeValidatableResource
    provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    aws_s3_bucket.default - *terraform.NodeValidatableResource
    aws_s3_bucket.virginia_bucket - *terraform.NodeValidatableResource
    provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
    provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  ------
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.CloseProviderTransformer
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.CloseProviderTransformer with new graph:
  aws_s3_bucket.default - *terraform.NodeValidatableResource
    provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  aws_s3_bucket.virginia_bucket - *terraform.NodeValidatableResource
    provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    aws_s3_bucket.default - *terraform.NodeValidatableResource
    aws_s3_bucket.virginia_bucket - *terraform.NodeValidatableResource
    provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
    provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"] (close) - *terraform.graphNodeCloseProvider
    aws_s3_bucket.default - *terraform.NodeValidatableResource
    provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"].virginia (close) - *terraform.graphNodeCloseProvider
    aws_s3_bucket.virginia_bucket - *terraform.NodeValidatableResource
    provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  ------
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.CloseRootModuleTransformer
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.CloseRootModuleTransformer with new graph:
  aws_s3_bucket.default - *terraform.NodeValidatableResource
    provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  aws_s3_bucket.virginia_bucket - *terraform.NodeValidatableResource
    provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    aws_s3_bucket.default - *terraform.NodeValidatableResource
    aws_s3_bucket.virginia_bucket - *terraform.NodeValidatableResource
    provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
    provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"] (close) - *terraform.graphNodeCloseProvider
    aws_s3_bucket.default - *terraform.NodeValidatableResource
    provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"].virginia (close) - *terraform.graphNodeCloseProvider
    aws_s3_bucket.virginia_bucket - *terraform.NodeValidatableResource
    provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  root - *terraform.nodeCloseModule
    meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    provider["registry.terraform.io/hashicorp/aws"] (close) - *terraform.graphNodeCloseProvider
    provider["registry.terraform.io/hashicorp/aws"].virginia (close) - *terraform.graphNodeCloseProvider
  ------
2020/12/21 13:31:21 [TRACE] Executing graph transform *terraform.TransitiveReductionTransformer
2020/12/21 13:31:21 [TRACE] Completed graph transform *terraform.TransitiveReductionTransformer with new graph:
  aws_s3_bucket.default - *terraform.NodeValidatableResource
    provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  aws_s3_bucket.virginia_bucket - *terraform.NodeValidatableResource
    provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    aws_s3_bucket.default - *terraform.NodeValidatableResource
    aws_s3_bucket.virginia_bucket - *terraform.NodeValidatableResource
  provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"] (close) - *terraform.graphNodeCloseProvider
    aws_s3_bucket.default - *terraform.NodeValidatableResource
  provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"].virginia (close) - *terraform.graphNodeCloseProvider
    aws_s3_bucket.virginia_bucket - *terraform.NodeValidatableResource
  root - *terraform.nodeCloseModule
    meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    provider["registry.terraform.io/hashicorp/aws"] (close) - *terraform.graphNodeCloseProvider
    provider["registry.terraform.io/hashicorp/aws"].virginia (close) - *terraform.graphNodeCloseProvider
  ------
2020/12/21 13:31:21 [DEBUG] Starting graph walk: walkValidate
2020/12/21 13:31:21 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/aws\"].virginia"
2020/12/21 13:31:21 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/aws\"].virginia": starting visit (*terraform.NodeApplyableProvider)
2020/12/21 13:31:21 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/aws\"]"
2020/12/21 13:31:21 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/aws\"]": starting visit (*terraform.NodeApplyableProvider)
2020-12-21T13:31:21.478+0530 [INFO]  plugin: configuring client automatic mTLS
2020-12-21T13:31:21.524+0530 [DEBUG] plugin: starting plugin: path=.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5 args=[.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5]
2020-12-21T13:31:21.534+0530 [DEBUG] plugin: plugin started: path=.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5 pid=3060
2020-12-21T13:31:21.534+0530 [DEBUG] plugin: waiting for RPC address: path=.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5
2020-12-21T13:31:21.611+0530 [INFO]  plugin.terraform-provider-aws_v3.22.0_x5: configuring server automatic mTLS: timestamp=2020-12-21T13:31:21.611+0530
2020-12-21T13:31:21.657+0530 [DEBUG] plugin: using plugin: version=5
2020-12-21T13:31:21.657+0530 [DEBUG] plugin.terraform-provider-aws_v3.22.0_x5: plugin address: address=/var/folders/cn/xl8ghpn91fsg2t_vz9jfcjr80000gn/T/plugin266405307 network=unix timestamp=2020-12-21T13:31:21.657+0530
2020-12-21T13:31:21.749+0530 [TRACE] plugin.stdio: waiting for stdio data
2020/12/21 13:31:21 [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/hashicorp/aws\"]" provider for provider["registry.terraform.io/hashicorp/aws"]
2020-12-21T13:31:21.749+0530 [INFO]  plugin: configuring client automatic mTLS
2020-12-21T13:31:21.791+0530 [DEBUG] plugin: starting plugin: path=.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5 args=[.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5]
2020-12-21T13:31:21.798+0530 [DEBUG] plugin: plugin started: path=.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5 pid=3061
2020-12-21T13:31:21.798+0530 [DEBUG] plugin: waiting for RPC address: path=.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5
2020-12-21T13:31:21.867+0530 [INFO]  plugin.terraform-provider-aws_v3.22.0_x5: configuring server automatic mTLS: timestamp=2020-12-21T13:31:21.867+0530
2020-12-21T13:31:21.915+0530 [DEBUG] plugin: using plugin: version=5
2020-12-21T13:31:21.915+0530 [DEBUG] plugin.terraform-provider-aws_v3.22.0_x5: plugin address: address=/var/folders/cn/xl8ghpn91fsg2t_vz9jfcjr80000gn/T/plugin323137664 network=unix timestamp=2020-12-21T13:31:21.915+0530
2020-12-21T13:31:22.014+0530 [TRACE] plugin.stdio: waiting for stdio data
2020/12/21 13:31:22 [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/hashicorp/aws\"].virginia" provider for provider["registry.terraform.io/hashicorp/aws"].virginia
2020/12/21 13:31:22 [TRACE] buildProviderConfig for provider["registry.terraform.io/hashicorp/aws"].virginia: using explicit config only
2020/12/21 13:31:22 [TRACE] buildProviderConfig for provider["registry.terraform.io/hashicorp/aws"]: using explicit config only
2020/12/21 13:31:22 [TRACE] GRPCProvider: GetSchema
2020/12/21 13:31:22 [TRACE] GRPCProvider: GetSchema
2020/12/21 13:31:22 [TRACE] GRPCProvider: PrepareProviderConfig
2020/12/21 13:31:22 [TRACE] GRPCProvider: PrepareProviderConfig
2020/12/21 13:31:22 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/aws\"]": visit complete
2020/12/21 13:31:22 [TRACE] dag/walk: visiting "aws_s3_bucket.default"
2020/12/21 13:31:22 [TRACE] vertex "aws_s3_bucket.default": starting visit (*terraform.NodeValidatableResource)
2020/12/21 13:31:22 [TRACE] GRPCProvider: ValidateResourceTypeConfig
2020/12/21 13:31:22 [TRACE] vertex "aws_s3_bucket.default": visit complete
2020/12/21 13:31:22 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:31:22 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)": starting visit (*terraform.graphNodeCloseProvider)
2020/12/21 13:31:22 [TRACE] GRPCProvider: Close
2020/12/21 13:31:22 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/aws\"].virginia": visit complete
2020/12/21 13:31:22 [TRACE] dag/walk: visiting "aws_s3_bucket.virginia_bucket"
2020/12/21 13:31:22 [TRACE] vertex "aws_s3_bucket.virginia_bucket": starting visit (*terraform.NodeValidatableResource)
2020-12-21T13:31:22.156+0530 [WARN]  plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = transport is closing"
2020-12-21T13:31:22.161+0530 [DEBUG] plugin: plugin process exited: path=.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5 pid=3060
2020-12-21T13:31:22.161+0530 [DEBUG] plugin: plugin exited
2020/12/21 13:31:22 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)": visit complete
2020/12/21 13:31:22 [TRACE] GRPCProvider: ValidateResourceTypeConfig
2020/12/21 13:31:22 [TRACE] vertex "aws_s3_bucket.virginia_bucket": visit complete
2020/12/21 13:31:22 [TRACE] dag/walk: visiting "meta.count-boundary (EachMode fixup)"
2020/12/21 13:31:22 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/aws\"].virginia (close)"
2020/12/21 13:31:22 [TRACE] vertex "meta.count-boundary (EachMode fixup)": starting visit (*terraform.NodeCountBoundary)
2020/12/21 13:31:22 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/aws\"].virginia (close)": starting visit (*terraform.graphNodeCloseProvider)
2020/12/21 13:31:22 [TRACE] GRPCProvider: Close
2020/12/21 13:31:22 [TRACE] vertex "meta.count-boundary (EachMode fixup)": visit complete
2020-12-21T13:31:22.163+0530 [WARN]  plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = transport is closing"
2020-12-21T13:31:22.166+0530 [DEBUG] plugin: plugin process exited: path=.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5 pid=3061
2020-12-21T13:31:22.166+0530 [DEBUG] plugin: plugin exited
2020/12/21 13:31:22 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/aws\"].virginia (close)": visit complete
2020/12/21 13:31:22 [TRACE] dag/walk: visiting "root"
2020/12/21 13:31:22 [TRACE] vertex "root": starting visit (*terraform.nodeCloseModule)
2020/12/21 13:31:22 [TRACE] vertex "root": visit complete
2020/12/21 13:31:22 [INFO] backend/local: apply calling Plan
2020/12/21 13:31:22 [INFO] terraform: building graph: GraphTypePlanDestroy
2020/12/21 13:31:22 [TRACE] Executing graph transform *terraform.StateTransformer
2020/12/21 13:31:22 [TRACE] StateTransformer: creating nodes for both current and deposed instance objects
2020/12/21 13:31:22 [TRACE] StateTransformer: added *terraform.NodePlanDestroyableResourceInstance for aws_s3_bucket.default current object
2020/12/21 13:31:22 [TRACE] StateTransformer: added *terraform.NodePlanDestroyableResourceInstance for aws_s3_bucket.virginia_bucket current object
2020/12/21 13:31:22 [TRACE] Completed graph transform *terraform.StateTransformer with new graph:
  aws_s3_bucket.default - *terraform.NodePlanDestroyableResourceInstance
  aws_s3_bucket.virginia_bucket - *terraform.NodePlanDestroyableResourceInstance
  ------
2020/12/21 13:31:22 [TRACE] Executing graph transform *terraform.OutputTransformer
2020/12/21 13:31:22 [TRACE] Completed graph transform *terraform.OutputTransformer (no changes)
2020/12/21 13:31:22 [TRACE] Executing graph transform *terraform.AttachStateTransformer
2020/12/21 13:31:22 [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2020/12/21 13:31:22 [TRACE] Executing graph transform *terraform.AttachResourceConfigTransformer
2020/12/21 13:31:22 [TRACE] AttachResourceConfigTransformer: attaching to "aws_s3_bucket.default" (*terraform.NodePlanDestroyableResourceInstance) config from 02_1_provider.tf:15,1-35
2020/12/21 13:31:22 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to aws_s3_bucket.default
2020/12/21 13:31:22 [TRACE] AttachResourceConfigTransformer: attaching to "aws_s3_bucket.virginia_bucket" (*terraform.NodePlanDestroyableResourceInstance) config from 02_1_provider.tf:10,1-43
2020/12/21 13:31:22 [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to aws_s3_bucket.virginia_bucket
2020/12/21 13:31:22 [TRACE] Completed graph transform *terraform.AttachResourceConfigTransformer (no changes)
2020/12/21 13:31:22 [TRACE] Executing graph transform *terraform.graphTransformerMulti
2020/12/21 13:31:22 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderConfigTransformer
2020/12/21 13:31:22 [TRACE] ProviderConfigTransformer: attaching to "provider[\"registry.terraform.io/hashicorp/aws\"]" provider configuration from 02_1_provider.tf:1,1-15
2020/12/21 13:31:22 [TRACE] ProviderConfigTransformer: attaching to "provider[\"registry.terraform.io/hashicorp/aws\"].virginia" provider configuration from 02_1_provider.tf:5,1-15
2020/12/21 13:31:22 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderConfigTransformer with new graph:
  aws_s3_bucket.default - *terraform.NodePlanDestroyableResourceInstance
  aws_s3_bucket.virginia_bucket - *terraform.NodePlanDestroyableResourceInstance
  provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  ------
2020/12/21 13:31:22 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.MissingProviderTransformer
2020/12/21 13:31:22 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.MissingProviderTransformer (no changes)
2020/12/21 13:31:22 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderTransformer
2020/12/21 13:31:22 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/aws"] serving aws_s3_bucket.default
2020/12/21 13:31:22 [DEBUG] ProviderTransformer: "aws_s3_bucket.default" (*terraform.NodePlanDestroyableResourceInstance) needs provider["registry.terraform.io/hashicorp/aws"]
2020/12/21 13:31:22 [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/hashicorp/aws"].virginia serving aws_s3_bucket.virginia_bucket
2020/12/21 13:31:22 [DEBUG] ProviderTransformer: "aws_s3_bucket.virginia_bucket" (*terraform.NodePlanDestroyableResourceInstance) needs provider["registry.terraform.io/hashicorp/aws"].virginia
2020/12/21 13:31:22 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderTransformer with new graph:
  aws_s3_bucket.default - *terraform.NodePlanDestroyableResourceInstance
    provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  aws_s3_bucket.virginia_bucket - *terraform.NodePlanDestroyableResourceInstance
    provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  ------
2020/12/21 13:31:22 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.PruneProviderTransformer
2020/12/21 13:31:22 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.PruneProviderTransformer (no changes)
2020/12/21 13:31:22 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ParentProviderTransformer
2020/12/21 13:31:22 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ParentProviderTransformer (no changes)
2020/12/21 13:31:22 [TRACE] Completed graph transform *terraform.graphTransformerMulti with new graph:
  aws_s3_bucket.default - *terraform.NodePlanDestroyableResourceInstance
    provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  aws_s3_bucket.virginia_bucket - *terraform.NodePlanDestroyableResourceInstance
    provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  ------
2020/12/21 13:31:22 [TRACE] Executing graph transform *terraform.DestroyEdgeTransformer
2020/12/21 13:31:22 [TRACE] DestroyEdgeTransformer: "aws_s3_bucket.default" (*terraform.NodePlanDestroyableResourceInstance) destroys aws_s3_bucket.default
2020/12/21 13:31:22 [TRACE] DestroyEdgeTransformer: "aws_s3_bucket.virginia_bucket" (*terraform.NodePlanDestroyableResourceInstance) destroys aws_s3_bucket.virginia_bucket
2020/12/21 13:31:22 [TRACE] Completed graph transform *terraform.DestroyEdgeTransformer (no changes)
2020/12/21 13:31:22 [TRACE] Executing graph transform *terraform.TargetsTransformer
2020/12/21 13:31:22 [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2020/12/21 13:31:22 [TRACE] Executing graph transform *terraform.CloseProviderTransformer
2020/12/21 13:31:22 [TRACE] Completed graph transform *terraform.CloseProviderTransformer with new graph:
  aws_s3_bucket.default - *terraform.NodePlanDestroyableResourceInstance
    provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  aws_s3_bucket.virginia_bucket - *terraform.NodePlanDestroyableResourceInstance
    provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"] (close) - *terraform.graphNodeCloseProvider
    aws_s3_bucket.default - *terraform.NodePlanDestroyableResourceInstance
    provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"].virginia (close) - *terraform.graphNodeCloseProvider
    aws_s3_bucket.virginia_bucket - *terraform.NodePlanDestroyableResourceInstance
    provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  ------
2020/12/21 13:31:22 [TRACE] Executing graph transform *terraform.CloseRootModuleTransformer
2020/12/21 13:31:22 [TRACE] Completed graph transform *terraform.CloseRootModuleTransformer with new graph:
  aws_s3_bucket.default - *terraform.NodePlanDestroyableResourceInstance
    provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  aws_s3_bucket.virginia_bucket - *terraform.NodePlanDestroyableResourceInstance
    provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"] (close) - *terraform.graphNodeCloseProvider
    aws_s3_bucket.default - *terraform.NodePlanDestroyableResourceInstance
    provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"].virginia (close) - *terraform.graphNodeCloseProvider
    aws_s3_bucket.virginia_bucket - *terraform.NodePlanDestroyableResourceInstance
    provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  root - *terraform.nodeCloseModule
    provider["registry.terraform.io/hashicorp/aws"] (close) - *terraform.graphNodeCloseProvider
    provider["registry.terraform.io/hashicorp/aws"].virginia (close) - *terraform.graphNodeCloseProvider
  ------
2020/12/21 13:31:22 [TRACE] Executing graph transform *terraform.TransitiveReductionTransformer
2020/12/21 13:31:22 [TRACE] Completed graph transform *terraform.TransitiveReductionTransformer with new graph:
  aws_s3_bucket.default - *terraform.NodePlanDestroyableResourceInstance
    provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  aws_s3_bucket.virginia_bucket - *terraform.NodePlanDestroyableResourceInstance
    provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"] (close) - *terraform.graphNodeCloseProvider
    aws_s3_bucket.default - *terraform.NodePlanDestroyableResourceInstance
  provider["registry.terraform.io/hashicorp/aws"].virginia - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/hashicorp/aws"].virginia (close) - *terraform.graphNodeCloseProvider
    aws_s3_bucket.virginia_bucket - *terraform.NodePlanDestroyableResourceInstance
  root - *terraform.nodeCloseModule
    provider["registry.terraform.io/hashicorp/aws"] (close) - *terraform.graphNodeCloseProvider
    provider["registry.terraform.io/hashicorp/aws"].virginia (close) - *terraform.graphNodeCloseProvider
  ------
2020/12/21 13:31:22 [DEBUG] Starting graph walk: walkPlanDestroy
2020/12/21 13:31:22 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/aws\"].virginia"
2020/12/21 13:31:22 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/aws\"]"
2020/12/21 13:31:22 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/aws\"].virginia": starting visit (*terraform.NodeApplyableProvider)
2020/12/21 13:31:22 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/aws\"]": starting visit (*terraform.NodeApplyableProvider)
2020-12-21T13:31:22.168+0530 [INFO]  plugin: configuring client automatic mTLS
2020-12-21T13:31:22.215+0530 [DEBUG] plugin: starting plugin: path=.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5 args=[.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5]
2020-12-21T13:31:22.223+0530 [DEBUG] plugin: plugin started: path=.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5 pid=3062
2020-12-21T13:31:22.223+0530 [DEBUG] plugin: waiting for RPC address: path=.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5
2020-12-21T13:31:22.301+0530 [INFO]  plugin.terraform-provider-aws_v3.22.0_x5: configuring server automatic mTLS: timestamp=2020-12-21T13:31:22.301+0530
2020-12-21T13:31:22.355+0530 [DEBUG] plugin: using plugin: version=5
2020-12-21T13:31:22.355+0530 [DEBUG] plugin.terraform-provider-aws_v3.22.0_x5: plugin address: address=/var/folders/cn/xl8ghpn91fsg2t_vz9jfcjr80000gn/T/plugin897735845 network=unix timestamp=2020-12-21T13:31:22.355+0530
2020/12/21 13:31:22 [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/hashicorp/aws\"].virginia" provider for provider["registry.terraform.io/hashicorp/aws"].virginia
2020-12-21T13:31:22.459+0530 [TRACE] plugin.stdio: waiting for stdio data
2020/12/21 13:31:22 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/aws\"].virginia": visit complete
2020-12-21T13:31:22.460+0530 [INFO]  plugin: configuring client automatic mTLS
2020/12/21 13:31:22 [TRACE] dag/walk: visiting "aws_s3_bucket.virginia_bucket"
2020/12/21 13:31:22 [TRACE] vertex "aws_s3_bucket.virginia_bucket": starting visit (*terraform.NodePlanDestroyableResourceInstance)
2020-12-21T13:31:22.509+0530 [DEBUG] plugin: starting plugin: path=.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5 args=[.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5]
2020-12-21T13:31:22.515+0530 [DEBUG] plugin: plugin started: path=.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5 pid=3068
2020-12-21T13:31:22.515+0530 [DEBUG] plugin: waiting for RPC address: path=.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5
2020-12-21T13:31:22.569+0530 [INFO]  plugin.terraform-provider-aws_v3.22.0_x5: configuring server automatic mTLS: timestamp=2020-12-21T13:31:22.569+0530
2020-12-21T13:31:22.620+0530 [DEBUG] plugin.terraform-provider-aws_v3.22.0_x5: plugin address: address=/var/folders/cn/xl8ghpn91fsg2t_vz9jfcjr80000gn/T/plugin744417683 network=unix timestamp=2020-12-21T13:31:22.620+0530
2020-12-21T13:31:22.620+0530 [DEBUG] plugin: using plugin: version=5
2020-12-21T13:31:22.724+0530 [TRACE] plugin.stdio: waiting for stdio data
2020/12/21 13:31:22 [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/hashicorp/aws\"]" provider for provider["registry.terraform.io/hashicorp/aws"]
2020/12/21 13:31:22 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/aws\"]": visit complete
2020/12/21 13:31:22 [TRACE] dag/walk: visiting "aws_s3_bucket.default"
2020/12/21 13:31:22 [TRACE] vertex "aws_s3_bucket.default": starting visit (*terraform.NodePlanDestroyableResourceInstance)
2020/12/21 13:31:22 [TRACE] ReadResourceInstanceState: reading state for aws_s3_bucket.virginia_bucket
2020/12/21 13:31:22 [TRACE] ReadResourceInstanceState: reading state for aws_s3_bucket.default
2020/12/21 13:31:22 [TRACE] UpgradeResourceState: schema version of aws_s3_bucket.virginia_bucket is still 0; calling provider "aws" for any other minor fixups
2020/12/21 13:31:22 [TRACE] UpgradeResourceState: schema version of aws_s3_bucket.default is still 0; calling provider "aws" for any other minor fixups
2020/12/21 13:31:22 [TRACE] GRPCProvider: UpgradeResourceState
2020/12/21 13:31:22 [TRACE] GRPCProvider: GetSchema
2020/12/21 13:31:22 [TRACE] GRPCProvider: UpgradeResourceState
2020/12/21 13:31:22 [TRACE] GRPCProvider: GetSchema
2020-12-21T13:31:22.745+0530 [DEBUG] plugin.terraform-provider-aws_v3.22.0_x5: assertion failed [inst.has_value()]: failed to decode instruction: 0x0
2020-12-21T13:31:22.745+0530 [DEBUG] plugin.terraform-provider-aws_v3.22.0_x5: (StateRecovery.cpp:336 determine_state_recovery_action_forward_branches)
2020/12/21 13:31:22 [TRACE] EvalWriteDiff: recorded Delete change for aws_s3_bucket.virginia_bucket
2020/12/21 13:31:22 [TRACE] vertex "aws_s3_bucket.virginia_bucket": visit complete
2020/12/21 13:31:22 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/aws\"].virginia (close)"
2020/12/21 13:31:22 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/aws\"].virginia (close)": starting visit (*terraform.graphNodeCloseProvider)
2020/12/21 13:31:22 [TRACE] GRPCProvider: Close
2020-12-21T13:31:22.802+0530 [WARN]  plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = transport is closing"
2020-12-21T13:31:22.807+0530 [DEBUG] plugin: plugin process exited: path=.terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5 pid=3062
2020-12-21T13:31:22.807+0530 [DEBUG] plugin: plugin exited
2020/12/21 13:31:22 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/aws\"].virginia (close)": visit complete
2020/12/21 13:31:27 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:31:27 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:31:32 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:31:32 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:31:37 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:31:37 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:31:42 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:31:42 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:31:47 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:31:47 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:31:52 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:31:52 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:31:57 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:31:57 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:32:02 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:32:02 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:32:07 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:32:07 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:32:12 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:32:12 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:32:17 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:32:17 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:32:22 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:32:22 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:32:27 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:32:27 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:32:32 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:32:32 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:32:37 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:32:37 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:32:42 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:32:42 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:32:47 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:32:47 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:32:52 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:32:52 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:32:57 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:32:57 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:33:02 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:33:02 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:33:07 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:33:07 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020-12-21T13:33:10.269+0530 [DEBUG] plugin.terraform-provider-aws_v3.22.0_x5: assertion failed [inst.has_value()]: failed to decode instruction: 0x0
2020-12-21T13:33:10.269+0530 [DEBUG] plugin.terraform-provider-aws_v3.22.0_x5: (StateRecovery.cpp:336 determine_state_recovery_action_forward_branches)
2020/12/21 13:33:12 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:33:12 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:33:17 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:33:17 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:33:22 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:33:22 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:33:27 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:33:27 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:33:32 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:33:32 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:33:37 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:33:37 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:33:42 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:33:42 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:33:47 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:33:47 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:33:52 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:33:52 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:33:57 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:33:57 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:34:02 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:34:02 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:34:07 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:34:07 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:34:12 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:34:12 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:34:17 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:34:17 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:34:22 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:34:22 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:34:27 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:34:27 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:34:32 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:34:32 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:34:37 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:34:37 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:34:42 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:34:42 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:34:47 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:34:47 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:34:52 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:34:52 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:34:57 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:34:57 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:35:02 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:35:02 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:35:07 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:35:07 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:35:12 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:35:12 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:35:17 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:35:17 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:35:22 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:35:22 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:35:27 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:35:27 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:35:32 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:35:32 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:35:37 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:35:37 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:35:42 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:35:42 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:35:47 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:35:47 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:35:52 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:35:52 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:35:57 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:35:57 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:36:02 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:36:03 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:36:07 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:36:08 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:36:12 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:36:13 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:36:17 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:36:18 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:36:22 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:36:23 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:36:27 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:36:28 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:36:32 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:36:33 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:36:37 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:36:38 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:36:42 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:36:43 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:36:47 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:36:48 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:36:52 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:36:53 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:36:57 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:36:58 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:37:02 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:37:03 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:37:07 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:37:08 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:37:12 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:37:13 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:37:17 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:37:18 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:37:22 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:37:23 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:37:27 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:37:28 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:37:32 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:37:33 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:37:37 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:37:38 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:37:42 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:37:43 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:37:47 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:37:48 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:37:52 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:37:53 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:37:57 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:37:58 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:38:02 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:38:03 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:38:07 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:38:08 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:38:12 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:38:13 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:38:17 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:38:18 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:38:22 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:38:23 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:38:27 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:38:28 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 13:54:42 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 13:54:43 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:10:45 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:10:46 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:10:50 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:10:51 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:10:55 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:10:56 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:11:00 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:11:01 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:11:05 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:11:06 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:11:10 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:11:11 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:11:15 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:11:16 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:11:20 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:11:21 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:11:25 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:11:26 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:11:30 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:11:31 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:16:19 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:16:20 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:16:24 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:16:25 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:16:29 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:16:30 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:16:34 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:16:35 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:23:39 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:23:40 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:23:45 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:23:45 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:23:50 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:23:50 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020-12-21T14:23:53.363+0530 [TRACE] plugin.terraform-provider-aws_v3.22.0_x5: plugin received interrupt signal, ignoring: count=1 timestamp=2020-12-21T14:23:53.362+0530
2020/12/21 14:23:55 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:23:55 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:24:00 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:24:00 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:24:05 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:24:05 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:24:10 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:24:10 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:24:15 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:24:15 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:24:20 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:24:20 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:24:25 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:24:25 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:24:30 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:24:30 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:24:35 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:24:35 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:24:40 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:24:40 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:24:45 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:24:45 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:24:50 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:24:50 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:24:55 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:24:55 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:25:00 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:25:00 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:25:05 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:25:05 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:25:10 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:25:10 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:25:15 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:25:15 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:25:20 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:25:20 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:25:25 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:25:25 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:25:30 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:25:30 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:25:35 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:25:35 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:25:40 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:25:40 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:25:45 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:25:45 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:25:50 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:25:50 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:25:55 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:25:55 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:26:00 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:26:00 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:26:05 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:26:05 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:26:10 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:26:10 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:26:15 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:26:15 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:26:20 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:26:20 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:26:25 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:26:25 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:26:30 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:26:30 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:26:35 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:26:35 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:36:45 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:36:45 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:36:50 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:36:50 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:37:24 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:37:24 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:37:29 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:37:29 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:37:34 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:37:34 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:37:39 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:37:39 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020-12-21T14:37:41.356+0530 [TRACE] plugin.terraform-provider-aws_v3.22.0_x5: plugin received interrupt signal, ignoring: count=2 timestamp=2020-12-21T14:37:41.356+0530
2020-12-21T14:37:42.871+0530 [TRACE] plugin.terraform-provider-aws_v3.22.0_x5: plugin received interrupt signal, ignoring: count=3 timestamp=2020-12-21T14:37:42.871+0530
2020-12-21T14:37:43.303+0530 [TRACE] plugin.terraform-provider-aws_v3.22.0_x5: plugin received interrupt signal, ignoring: count=4 timestamp=2020-12-21T14:37:43.303+0530
2020-12-21T14:37:43.575+0530 [TRACE] plugin.terraform-provider-aws_v3.22.0_x5: plugin received interrupt signal, ignoring: count=5 timestamp=2020-12-21T14:37:43.575+0530
2020/12/21 14:37:44 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)" is waiting for "aws_s3_bucket.default"
2020/12/21 14:37:44 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020-12-21T14:37:46.362+0530 [WARN]  plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = transport is closing"
2020/12/21 14:37:46 [TRACE] vertex "aws_s3_bucket.default": visit complete
2020/12/21 14:37:46 [TRACE] dag/walk: visiting "provider[\"registry.terraform.io/hashicorp/aws\"] (close)"
2020/12/21 14:37:46 [TRACE] vertex "provider[\"registry.terraform.io/hashicorp/aws\"] (close)": starting visit (*terraform.graphNodeCloseProvider)
2020/12/21 14:37:46 [TRACE] GRPCProvider: Close
2020-12-21T14:37:46.362+0530 [WARN]  plugin: error closing client during Kill: err="rpc error: code = Canceled desc = grpc: the client connection is closing"
2020-12-21T14:37:46.362+0530 [WARN]  plugin: plugin failed to exit gracefully
panic: rpc error: code = Unavailable desc = transport is closing

goroutine 140 [running]:
github.com/hashicorp/terraform/plugin.(*GRPCProvider).getSchema(0xc0000a6300, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0)
	/home/circleci/project/project/plugin/grpc_provider.go:80 +0x2b9
github.com/hashicorp/terraform/plugin.(*GRPCProvider).getResourceSchema(0xc0000a6300, 0xc000134960, 0xd, 0x0, 0x0)
	/home/circleci/project/project/plugin/grpc_provider.go:89 +0x45
github.com/hashicorp/terraform/plugin.(*GRPCProvider).UpgradeResourceState(0xc0000a6300, 0xc000134960, 0xd, 0x0, 0xc002dfd400, 0x4b8, 0x4b8, 0x0, 0x0, 0x0, ...)
	/home/circleci/project/project/plugin/grpc_provider.go:255 +0xa8
github.com/hashicorp/terraform/terraform.UpgradeResourceState(0x0, 0x0, 0x0, 0x4d, 0xc000134960, 0xd, 0xc000134957, 0x7, 0x0, 0x0, ...)
	/home/circleci/project/project/terraform/eval_state_upgrade.go:87 +0x302
github.com/hashicorp/terraform/terraform.(*NodeAbstractResource).ReadResourceInstanceState(0xc00078f880, 0x388a660, 0xc002dd3c70, 0x0, 0x0, 0x0, 0x4d, 0xc000134960, 0xd, 0xc000134957, ...)
	/home/circleci/project/project/terraform/node_resource_abstract.go:376 +0x325
github.com/hashicorp/terraform/terraform.(*NodePlanDestroyableResourceInstance).Execute(0xc00068c490, 0x388a660, 0xc002dd3c70, 0xc00003a003, 0x309dce0, 0x33aa960)
	/home/circleci/project/project/terraform/node_resource_plan_destroy.go:49 +0x238
github.com/hashicorp/terraform/terraform.(*ContextGraphWalker).Execute(0xc002dd3040, 0x388a660, 0xc002dd3c70, 0x31199520, 0xc00068c490, 0x0, 0x0, 0x0)
	/home/circleci/project/project/terraform/graph_walk_context.go:127 +0xbc
github.com/hashicorp/terraform/terraform.(*Graph).walk.func1(0x33aa960, 0xc00068c490, 0x0, 0x0, 0x0)
	/home/circleci/project/project/terraform/graph.go:59 +0x962
github.com/hashicorp/terraform/dag.(*Walker).walkVertex(0xc000531bc0, 0x33aa960, 0xc00068c490, 0xc000a27280)
	/home/circleci/project/project/dag/walk.go:387 +0x375
created by github.com/hashicorp/terraform/dag.(*Walker).Update
	/home/circleci/project/project/dag/walk.go:309 +0x1246

Expected Behavior

terraform destroy should have destroyed the created infrastructure.

Actual Behavior

On executing the terraform destroy command on terminal, the command was in hanging state for good amount of time. Then I tried to exit out of shell by doing ctrl+c but it didn't exit

Steps to Reproduce

terraform destroy

Additional Context

I was running this command on macOS Big Sur
@arunstiwari arunstiwari added bug new new issue not yet triaged labels Dec 21, 2020
@danieldreier
Copy link
Contributor

Hi! Thanks for reporting this. I believe that you're having a real issue here and I'd like to reproduce it locally. To do that, I have to be able to run this and run it on my workstation without inventing any details in order to be confident we're seeing the same behavior. As-is, I have tried some simple create/destroys on my M1 Macbook running Big Sur and it worked, and so I'm stuck - I need to understand your specific use case.

Can you please restate your reproduction case such that I can copy-paste it and run it locally? Ideally, this would use the null resource provider rather than a real provider in order to minimize external dependencies.

Also, can you explain what hardware you're using? Is this on an M1 ARM platform or an X86 mac?

@danieldreier danieldreier added the waiting for reproduction unable to reproduce issue without further information label Dec 22, 2020
@jk563
Copy link

jk563 commented Dec 25, 2020 •
edited

I've had a similar issue on my M1 on Big Sur creating a few basic AWS resources. It isn't 100% reproducible yet, sometimes the apply/destroy works, sometimes it does not. I've not seen it on just the null provider yet, but I have seen it with just an aws vpc resource. It may be more than one issue, or a single root cause, I'm not sure. I've seen:

destroy fail with an error: destroy.log
apply waiting in a (seemingly) infinite loop: apply.log (killed proc and it still kept looping)
destroy failing with rpc error: rpc-destroy.log

TF Version: 0.14.2

TF:

resource "aws_vpc" "main" {
  cidr_block       = "10.10.0.0/16"
}

provider "aws" {
  region = "eu-west-2"
}

Let me know if there is anything more I can provide / do to help.

@rtoma
Copy link

rtoma commented Dec 25, 2020 •
edited

I am experiencing the same on my M1 MBP. Some runs are lightning fast. And some runs hang.

I believe this has to do with M1's rosetta2 translating the x86-64 plugin. When a run hangs, the process takes 100-140% CPU.

Since investigation requires reproducibility, I made this crude tester:

$ for x in {1..100}; do echo "# $x"; .terraform/providers/registry.terraform.io/hashicorp/aws/3.22.0/darwin_amd64/terraform-provider-aws_v3.22.0_x5 ;done

With this I get reliable hangs. Happening at a random iteration, but they do happen. Following output had a quick hang:

# 1
This binary is a plugin. These are not meant to be executed directly.
Please execute the program that consumes these plugins, which will
load any plugins automatically
# 2
This binary is a plugin. These are not meant to be executed directly.
Please execute the program that consumes these plugins, which will
load any plugins automatically
# 3
This binary is a plugin. These are not meant to be executed directly.
Please execute the program that consumes these plugins, which will
load any plugins automatically
# 4
assertion failed [inst.has_value()]: failed to decode instruction: 0x0
(StateRecovery.cpp:336 determine_state_recovery_action_forward_branches) <-- hangs a long time (10+ minutes?)
assertion failed [inst.has_value()]: failed to decode instruction: 0x0
(StateRecovery.cpp:336 determine_state_recovery_action_forward_branches) <-- again hangs

I have sampled the hanging process. The output is at https://gist.github.com/rtoma/0da8efd5c9204345fb82d72b68100cdc for someone able to interpret it.

@rtoma
Copy link

rtoma commented Dec 25, 2020

Searching for StateRecovery I found golang/go#42700 (via pulumi/pulumi#5859) suggesting workaround:

export GODEBUG=asyncpreemptoff=1

This stops the issue for me.

@arunstiwari
Copy link
Author

Hi! Thanks for reporting this. I believe that you're having a real issue here and I'd like to reproduce it locally. To do that, I have to be able to run this and run it on my workstation without inventing any details in order to be confident we're seeing the same behavior. As-is, I have tried some simple create/destroys on my M1 Macbook running Big Sur and it worked, and so I'm stuck - I need to understand your specific use case.

Can you please restate your reproduction case such that I can copy-paste it and run it locally? Ideally, this would use the null resource provider rather than a real provider in order to minimize external dependencies.

Also, can you explain what hardware you're using? Is this on an M1 ARM platform or an X86 mac?

I am not getting the issue consistently every time. Few times it runs fine but in 20% of the cases it fails executing the same script. My hardware configuration is MacBook Air (M1, 2020) , Chip - Apple M1, RAM - 16 GB, Storage - 1 TB SSD

@arunstiwari
Copy link
Author

Searching for StateRecovery I found golang/go#42700 (via pulumi/pulumi#5859) suggesting workaround:

export GODEBUG=asyncpreemptoff=1

This stops the issue for me.

Thanks.. seems like with this setting it has been working for me. I did not see the hanging issue manifesting after setting the value suggested by you

@lado936
Copy link

lado936 commented Dec 28, 2020

Searching for StateRecovery I found golang/go#42700 (via pulumi/pulumi#5859) suggesting workaround:

export GODEBUG=asyncpreemptoff=1

This stops the issue for me.

Can confirm this solved terraform apply stage hanging issue for me on M1 chip also.

@shousper shousper mentioned this issue Jan 6, 2021
Closed
@hashicorp hashicorp deleted a comment from roslee77 Jun 16, 2021
@jckuester jckuester mentioned this issue Jul 8, 2021
Closed
@bun913 bun913 mentioned this issue Mar 1, 2022
Closed
@jorhett
Copy link

jorhett commented Apr 11, 2022 •
edited

@danieldreier So we have diagnosed this 15 months ago. Why does this remain a problem with Terraform? Why haven't the arm64 binaries been fixed?

We see it constantly with Terraform 1.x versions up through 1.1.8 (latest as of this comment) on Big Sur or Monterey.

@crw
Copy link
Collaborator

crw commented Apr 15, 2022

Per #27350 (comment), this seems to be an issue with Rosetta2 and providers for Terraform that have not been compiled for darwin_arm64. #27350 (comment) has a work-around, and I would also recommend checking out this Discuss thread for more on M1 + terraform (this is more about tfenv than providers, though). To date, this appears to be an issue with Rosetta2, rather than an issue with terraform itself.

@jorhett can you confirm you are seeing this issue with arm64 terraform and arm64 providers? If so, that would be a new issue as I am understanding this thread.

@apparentlymart
Copy link
Member

That environment variable to override some behavior in the Go runtime does seem to be a suggested workaround for a number of different Go runtime bugs, some of which have already been fixed and some are still under investigation. Here are some I'm aware of:

These and others seem to trace back to golang/go#24543, which is a runtime goroutine preemption technique which on Unix systems like macOS is implemented by asking the OS to interrupt the program using signals. Signals can potentially interrupt active system calls, which must then be handled by any code that was waiting for those system calls to complete, and it seems that at least some of these problems have a root cause that some other part of the Go runtime is not properly handling being interrupted in that way.

(I focused above on listing ones that seemed to be related to macOS here, but I note that there are similar problems on other platforms which include this signal-based preemption scheme.)

Emulation layers such as Rosetta add extra tricky interactions to a signal-based scheme like this, because presumably Rosetta is the one initially receiving the signal, translating it to make sense in the emulated amd64 context, and delivering it to the Go runtime. Although about QEMU rather than Rosetta, golang/go#36981 is an example of such a problem which arises only in the case of user-mode emulation where there's an extra level of indirection between the OS and the program.

This GODEBUG=asyncpreemptoff=1 environment variable tells the Go runtime to return to the original co-operative preemption scheme where a busy CPU-intensive loop can potentially block other concurrent code from running altogether, but has the advantage of not relying on OS signals.

With all of this said, it seems like the best we can do here is keep updating to newer versions of the Go runtime as they become available. Given how many different ways these problems seem to be appearing in Go, I don't know that we'll ever be able to confidently say that all problems with this root cause have been addressed, but if we keep this issue focused primarily on the situation of running amd64 Terraform under Rosetta emulation on M1 Macs as @crw proposed then at least we have a more constrained problem space to focus on.

The darwin_amd64 port of Terraform running under Rosetta emulation isn't an officially supported platform, so if you are using Terraform in that way then I would suggest planning to migrate to using the native darwin_arm64 port instead. That may require you to upgrade certain providers or stop using certain obsolete providers which do not have Apple Silicon ports available, so I understand it's not a "quick fix" and you may need to keep using Rosetta emulation in the meantime, but userspace instruction set emulation like this is always a tricky problem and I expect Apple will eventually reach a point where they perceive diminishing returns and stop addressing newly-discovered quirks once there's an Apple Silicon-native port available of most commonly-used software.

@jorhett
Copy link

jorhett commented Apr 20, 2022

@jorhett can you confirm you are seeing this issue with arm64 terraform and arm64 providers?

Sorry, I found that tfenv's confused handling caused us to have intermingled amd/arm64 versions in different repos. Upgrading to 2.2.3 and removing all versions solved it. Ignore my comments about it failing on arm64

ikuwow added a commit to ikuwow/dotfiles that referenced this issue May 14, 2022
@ikuwow
Workaround for terraform errors
3f2f333 
hashicorp/terraform#27350 (comment)
@lkolchin
Copy link

lkolchin commented Jul 5, 2022

Still the case on MacOS Monterey 12.4

$ terraform --version
Terraform v1.1.6
on darwin_amd64
+ provider registry.terraform.io/hashicorp/aws v3.73.0

Your version of Terraform is out of date! The latest version
is 1.2.4. You can update by downloading from https://www.terraform.io/downloads.html

Using darwin_amd64 instead of arm64 with rosetta :(

Sporadically spewing errors:

$ terraform apply
╷
│ Error: Unrecognized remote plugin message:
│
│ This usually means that the plugin is either invalid or simply
│ needs to be recompiled to support the latest protocol.
│
│
╵
$ terraform plan
╷
│ Error: Plugin did not respond
│
│   with provider["registry.terraform.io/hashicorp/aws"].test,
│   on providers.tf line 37, in provider "aws":
│   37: provider "aws" {
│
│ The plugin encountered an error, and failed to respond to the plugin.(*GRPCProvider).ValidateProviderConfig call. 
The plugin logs may contain more details.
╵

@rubber-ant
Copy link

intermittently it's happening to me too:

MacOS Monterey 12.4 , M1 Pro

terraform --version
Terraform v1.1.7
on darwin_amd64
+ provider registry.terraform.io/hashicorp/aws v4.6.0

Your version of Terraform is out of date! The latest version
is 1.2.5. You can update by downloading from https://www.terraform.io/downloads.html

│ Error: Plugin did not respond
│
│   with provider["registry.terraform.io/hashicorp/aws"],
│   on main.tf line 9, in provider "aws":
│    9: provider "aws" {
│
│ The plugin encountered an error, and failed to respond to the plugin.(*GRPCProvider).ValidateProviderConfig call. The plugin logs may contain more details.

@apparentlymart
Copy link
Member

These two recent messages seem to suggest that it was the provider itself rather than Terraform CLI which crashed, although providers are subject to the same constraints Terraform CLI is: we build the darwin_amd64 packages for use on real amd64 processors and the darwin_arm64 packages for use on M1 processors. Although you may have some success running these packages in the Rosetta emulator, we cannot explicitly support using Terraform in that way.

The best answer is to use the executables that were built for the actual platform you are using.

If you cannot do that for some reason, discussion above suggests that you can tell the Go runtime to use its old scheduling technique by setting the environment variable GODEBUG=asyncpreemptoff=1, which some have reported will avoid hitting some bugs in Rosetta that can make Terraform or its providers fail when running in that context.

However, this is only a workaround and we do not intend to invest in ensuring that the darwin_amd64 packages fully compatible with all of Rosetta's bugs and quirks, since the opportunity cost is too high. Anyone currently depending on the darwin_amd64 builds of Terraform on an M1 Mac should make plans to migrate to the darwin_arm64 builds at the earliest opportunity, even if the workaround above is working for you in the interim.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
bug new new issue not yet triaged waiting for reproduction unable to reproduce issue without further information
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
11 participants
@apparentlymart @crw @jorhett @rtoma @rubber-ant @jk563 @danieldreier @arunstiwari @lado936 @lkolchin and others