gistfile1.txt

2019/10/29 12:06:54 [INFO] Terraform version: 0.12.12  
2019/10/29 12:06:54 [INFO] Go runtime version: go1.12.9
2019/10/29 12:06:54 [INFO] CLI args: []string{"/usr/local/bin/terraform", "apply", "myplan"}
2019/10/29 12:06:54 [DEBUG] Attempting to open CLI config file: /Users/mferree/.terraformrc
2019/10/29 12:06:54 [DEBUG] File doesn't exist, but doesn't need to. Ignoring.
2019/10/29 12:06:54 [DEBUG] checking for credentials in "/Users/mferree/.terraform.d/plugins"
2019/10/29 12:06:54 [INFO] CLI command args: []string{"apply", "myplan"}
2019/10/29 12:06:54 [TRACE] Meta.BackendForPlan: instantiated backend of type *local.Local
2019/10/29 12:06:54 [DEBUG] checking for provider in "."
2019/10/29 12:06:54 [DEBUG] checking for provider in "/usr/local/bin"
2019/10/29 12:06:54 [DEBUG] checking for provider in ".terraform/plugins/darwin_amd64"
2019/10/29 12:06:54 [DEBUG] found provider "terraform-provider-aws_v2.33.0_x4"
2019/10/29 12:06:54 [DEBUG] checking for provider in "/Users/mferree/.terraform.d/plugins"
2019/10/29 12:06:54 [DEBUG] found valid plugin: "aws", "2.33.0", "/Users/mferree/Projects/scratch/cloudfront-bug-poc/.terraform/plugins/darwin_amd64/terraform-provider-aws_v2.33.0_x4"
2019/10/29 12:06:54 [DEBUG] checking for provisioner in "."
2019/10/29 12:06:54 [DEBUG] checking for provisioner in "/usr/local/bin"
2019/10/29 12:06:54 [DEBUG] checking for provisioner in ".terraform/plugins/darwin_amd64"
2019/10/29 12:06:54 [DEBUG] checking for provisioner in "/Users/mferree/.terraform.d/plugins"
2019/10/29 12:06:54 [TRACE] Meta.BackendForPlan: backend *local.Local supports operations
2019/10/29 12:06:54 [INFO] backend/local: starting Apply operation
2019/10/29 12:06:54 [TRACE] backend/local: requesting state manager for workspace "default"
2019/10/29 12:06:54 [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
2019/10/29 12:06:54 [TRACE] backend/local: requesting state lock for workspace "default"
2019/10/29 12:06:54 [TRACE] statemgr.Filesystem: preparing to manage state snapshots at terraform.tfstate
2019/10/29 12:06:54 [TRACE] statemgr.Filesystem: existing snapshot has lineage "ba60d23c-633d-ea2f-bbb1-61ec056205d7" serial 52
2019/10/29 12:06:54 [TRACE] statemgr.Filesystem: locking terraform.tfstate using fcntl flock
2019/10/29 12:06:54 [TRACE] statemgr.Filesystem: writing lock metadata to .terraform.tfstate.lock.info
2019/10/29 12:06:54 [TRACE] backend/local: reading remote state for workspace "default"
2019/10/29 12:06:54 [TRACE] statemgr.Filesystem: reading latest snapshot from terraform.tfstate
2019/10/29 12:06:54 [TRACE] statemgr.Filesystem: read snapshot with lineage "ba60d23c-633d-ea2f-bbb1-61ec056205d7" serial 52
2019/10/29 12:06:54 [TRACE] backend/local: retrieving local state snapshot for workspace "default"
2019/10/29 12:06:54 [TRACE] backend/local: building context from plan file
2019/10/29 12:06:54 [TRACE] terraform.NewContext: starting
2019/10/29 12:06:54 [TRACE] terraform.NewContext: resolving provider version selections
2019/10/29 12:06:55 [TRACE] terraform.NewContext: loading provider schemas
2019/10/29 12:06:55 [TRACE] LoadSchemas: retrieving schema for provider type "aws"
2019-10-29T12:06:55.154-0700 [INFO]  plugin: configuring client automatic mTLS
2019-10-29T12:06:55.180-0700 [DEBUG] plugin: starting plugin: path=/Users/mferree/Projects/scratch/cloudfront-bug-poc/.terraform/plugins/darwin_amd64/terraform-provider-aws_v2.33.0_x4 args=[/Users/mferree/Projects/scratch/cloudfront-bug-poc/.terraform/plugins/darwin_amd64/terraform-provider-aws_v2.33.0_x4]
2019-10-29T12:06:55.199-0700 [DEBUG] plugin: plugin started: path=/Users/mferree/Projects/scratch/cloudfront-bug-poc/.terraform/plugins/darwin_amd64/terraform-provider-aws_v2.33.0_x4 pid=94544
2019-10-29T12:06:55.199-0700 [DEBUG] plugin: waiting for RPC address: path=/Users/mferree/Projects/scratch/cloudfront-bug-poc/.terraform/plugins/darwin_amd64/terraform-provider-aws_v2.33.0_x4
2019-10-29T12:06:55.222-0700 [INFO]  plugin.terraform-provider-aws_v2.33.0_x4: configuring server automatic mTLS: timestamp=2019-10-29T12:06:55.222-0700
2019-10-29T12:06:55.251-0700 [DEBUG] plugin: using plugin: version=5
2019-10-29T12:06:55.251-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: plugin address: address=/var/folders/jb/r58w5f0d57d16d409vz2y0n80000gp/T/plugin296404135 network=unix timestamp=2019-10-29T12:06:55.251-0700
2019/10/29 12:06:55 [TRACE] GRPCProvider: GetSchema
2019/10/29 12:06:55 [TRACE] GRPCProvider: Close
2019-10-29T12:06:55.347-0700 [DEBUG] plugin: plugin process exited: path=/Users/mferree/Projects/scratch/cloudfront-bug-poc/.terraform/plugins/darwin_amd64/terraform-provider-aws_v2.33.0_x4 pid=94544
2019-10-29T12:06:55.347-0700 [DEBUG] plugin: plugin exited
2019/10/29 12:06:55 [TRACE] terraform.NewContext: complete
2019/10/29 12:06:55 [TRACE] backend/local: finished building terraform.Context
2019/10/29 12:06:55 [INFO] backend/local: apply calling Apply
2019/10/29 12:06:55 [INFO] terraform: building graph: GraphTypeApply
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.ConfigTransformer
2019/10/29 12:06:55 [TRACE] ConfigTransformer: Starting for path: 
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.ConfigTransformer with new graph:
aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
------
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.DiffTransformer
2019/10/29 12:06:55 [TRACE] DiffTransformer starting
2019/10/29 12:06:55 [TRACE] DiffTransformer: found Create change for aws_s3_bucket.my_bucket 
2019/10/29 12:06:55 [TRACE] DiffTransformer: aws_s3_bucket.my_bucket will be represented by aws_s3_bucket.my_bucket
2019/10/29 12:06:55 [TRACE] DiffTransformer: found Create change for aws_cloudfront_distribution.s3_distribution 
2019/10/29 12:06:55 [TRACE] DiffTransformer: aws_cloudfront_distribution.s3_distribution will be represented by aws_cloudfront_distribution.s3_distribution
2019/10/29 12:06:55 [TRACE] DiffTransformer complete
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.DiffTransformer with new graph:
aws_cloudfront_distribution.s3_distribution - *terraform.NodeApplyableResourceInstance
  aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
aws_s3_bucket.my_bucket - *terraform.NodeApplyableResourceInstance
  aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
------
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.OrphanResourceTransformer
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.OrphanResourceTransformer (no changes)
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.OrphanOutputTransformer
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.OrphanOutputTransformer (no changes)
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.AttachResourceConfigTransformer
2019/10/29 12:06:55 [TRACE] AttachResourceConfigTransformer: attaching to "aws_cloudfront_distribution.s3_distribution (prepare state)" (*terraform.NodeApplyableResource) config from cdn.tf:6,1-57
2019/10/29 12:06:55 [TRACE] AttachResourceConfigTransformer: attaching to "aws_s3_bucket.my_bucket (prepare state)" (*terraform.NodeApplyableResource) config from cdn.tf:1,1-37
2019/10/29 12:06:55 [TRACE] AttachResourceConfigTransformer: attaching to "aws_s3_bucket.my_bucket" (*terraform.NodeApplyableResourceInstance) config from cdn.tf:1,1-37
2019/10/29 12:06:55 [TRACE] AttachResourceConfigTransformer: attaching to "aws_cloudfront_distribution.s3_distribution" (*terraform.NodeApplyableResourceInstance) config from cdn.tf:6,1-57
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.AttachResourceConfigTransformer (no changes)
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.AttachStateTransformer
2019/10/29 12:06:55 [DEBUG] Resource state not found for node "aws_s3_bucket.my_bucket", instance aws_s3_bucket.my_bucket
2019/10/29 12:06:55 [DEBUG] Resource state not found for node "aws_cloudfront_distribution.s3_distribution", instance aws_cloudfront_distribution.s3_distribution
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.DestroyEdgeTransformer
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.DestroyEdgeTransformer (no changes)
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.CBDEdgeTransformer
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.CBDEdgeTransformer (no changes)
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.MissingProvisionerTransformer
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.MissingProvisionerTransformer (no changes)
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.ProvisionerTransformer
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.ProvisionerTransformer (no changes)
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.RootVariableTransformer
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.RootVariableTransformer (no changes)
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.LocalTransformer
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.LocalTransformer (no changes)
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.OutputTransformer
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.OutputTransformer (no changes)
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.ModuleVariableTransformer
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.ModuleVariableTransformer (no changes)
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.graphTransformerMulti
2019/10/29 12:06:55 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderConfigTransformer
2019/10/29 12:06:55 [TRACE] ProviderConfigTransformer: attaching to "provider.aws" provider configuration from providers.tf:3,1-15
2019/10/29 12:06:55 [TRACE] ProviderConfigTransformer: attaching to "provider.aws.us-east-1" provider configuration from providers.tf:10,1-15
2019/10/29 12:06:55 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderConfigTransformer with new graph:
aws_cloudfront_distribution.s3_distribution - *terraform.NodeApplyableResourceInstance
  aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
aws_s3_bucket.my_bucket - *terraform.NodeApplyableResourceInstance
  aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
provider.aws - *terraform.NodeApplyableProvider
provider.aws.us-east-1 - *terraform.NodeApplyableProvider
------
2019/10/29 12:06:55 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.MissingProviderTransformer
2019/10/29 12:06:55 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.MissingProviderTransformer (no changes)
2019/10/29 12:06:55 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderTransformer
2019/10/29 12:06:55 [TRACE] ProviderTransformer: aws_cloudfront_distribution.s3_distribution (prepare state) is provided by provider.aws or inherited equivalent
2019/10/29 12:06:55 [TRACE] ProviderTransformer: aws_s3_bucket.my_bucket (prepare state) is provided by provider.aws or inherited equivalent
2019/10/29 12:06:55 [TRACE] ProviderTransformer: aws_s3_bucket.my_bucket is provided by provider.aws or inherited equivalent
2019/10/29 12:06:55 [TRACE] ProviderTransformer: aws_cloudfront_distribution.s3_distribution is provided by provider.aws or inherited equivalent
2019/10/29 12:06:55 [TRACE] ProviderTransformer: exact match for provider.aws serving aws_s3_bucket.my_bucket (prepare state)
2019/10/29 12:06:55 [DEBUG] ProviderTransformer: "aws_s3_bucket.my_bucket (prepare state)" (*terraform.NodeApplyableResource) needs provider.aws
2019/10/29 12:06:55 [TRACE] ProviderTransformer: exact match for provider.aws serving aws_s3_bucket.my_bucket
2019/10/29 12:06:55 [DEBUG] ProviderTransformer: "aws_s3_bucket.my_bucket" (*terraform.NodeApplyableResourceInstance) needs provider.aws
2019/10/29 12:06:55 [TRACE] ProviderTransformer: exact match for provider.aws serving aws_cloudfront_distribution.s3_distribution
2019/10/29 12:06:55 [DEBUG] ProviderTransformer: "aws_cloudfront_distribution.s3_distribution" (*terraform.NodeApplyableResourceInstance) needs provider.aws
2019/10/29 12:06:55 [TRACE] ProviderTransformer: exact match for provider.aws serving aws_cloudfront_distribution.s3_distribution (prepare state)
2019/10/29 12:06:55 [DEBUG] ProviderTransformer: "aws_cloudfront_distribution.s3_distribution (prepare state)" (*terraform.NodeApplyableResource) needs provider.aws
2019/10/29 12:06:55 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderTransformer with new graph:
aws_cloudfront_distribution.s3_distribution - *terraform.NodeApplyableResourceInstance
  aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_s3_bucket.my_bucket - *terraform.NodeApplyableResourceInstance
  aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
provider.aws - *terraform.NodeApplyableProvider
provider.aws.us-east-1 - *terraform.NodeApplyableProvider
------
2019/10/29 12:06:55 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.PruneProviderTransformer
2019/10/29 12:06:55 [DEBUG] pruning unused provider.aws.us-east-1
2019/10/29 12:06:55 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.PruneProviderTransformer with new graph:
aws_cloudfront_distribution.s3_distribution - *terraform.NodeApplyableResourceInstance
  aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_s3_bucket.my_bucket - *terraform.NodeApplyableResourceInstance
  aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
provider.aws - *terraform.NodeApplyableProvider
------
2019/10/29 12:06:55 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ParentProviderTransformer
2019/10/29 12:06:55 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ParentProviderTransformer (no changes)
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.graphTransformerMulti with new graph:
aws_cloudfront_distribution.s3_distribution - *terraform.NodeApplyableResourceInstance
  aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_s3_bucket.my_bucket - *terraform.NodeApplyableResourceInstance
  aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
provider.aws - *terraform.NodeApplyableProvider
------
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.RemovedModuleTransformer
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.RemovedModuleTransformer (no changes)
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.AttachSchemaTransformer
2019/10/29 12:06:55 [TRACE] AttachSchemaTransformer: attaching resource schema to aws_cloudfront_distribution.s3_distribution (prepare state)
2019/10/29 12:06:55 [TRACE] AttachSchemaTransformer: attaching resource schema to aws_s3_bucket.my_bucket (prepare state)
2019/10/29 12:06:55 [TRACE] AttachSchemaTransformer: attaching resource schema to aws_s3_bucket.my_bucket
2019/10/29 12:06:55 [TRACE] AttachSchemaTransformer: attaching resource schema to aws_cloudfront_distribution.s3_distribution
2019/10/29 12:06:55 [TRACE] AttachSchemaTransformer: attaching provider config schema to provider.aws
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.AttachSchemaTransformer (no changes)
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.ReferenceTransformer
2019/10/29 12:06:55 [DEBUG] ReferenceTransformer: "aws_cloudfront_distribution.s3_distribution (prepare state)" references: []
2019/10/29 12:06:55 [DEBUG] ReferenceTransformer: "aws_s3_bucket.my_bucket (prepare state)" references: []
2019/10/29 12:06:55 [DEBUG] ReferenceTransformer: "aws_s3_bucket.my_bucket" references: []
2019/10/29 12:06:55 [DEBUG] ReferenceTransformer: "aws_cloudfront_distribution.s3_distribution" references: [aws_s3_bucket.my_bucket (prepare state) aws_s3_bucket.my_bucket aws_s3_bucket.my_bucket]
2019/10/29 12:06:55 [DEBUG] ReferenceTransformer: "provider.aws" references: []
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.ReferenceTransformer with new graph:
aws_cloudfront_distribution.s3_distribution - *terraform.NodeApplyableResourceInstance
  aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  aws_s3_bucket.my_bucket - *terraform.NodeApplyableResourceInstance
  aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_s3_bucket.my_bucket - *terraform.NodeApplyableResourceInstance
  aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
provider.aws - *terraform.NodeApplyableProvider
------
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.CountBoundaryTransformer
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.CountBoundaryTransformer with new graph:
aws_cloudfront_distribution.s3_distribution - *terraform.NodeApplyableResourceInstance
  aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  aws_s3_bucket.my_bucket - *terraform.NodeApplyableResourceInstance
  aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_s3_bucket.my_bucket - *terraform.NodeApplyableResourceInstance
  aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
  aws_cloudfront_distribution.s3_distribution - *terraform.NodeApplyableResourceInstance
  aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  aws_s3_bucket.my_bucket - *terraform.NodeApplyableResourceInstance
  aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
provider.aws - *terraform.NodeApplyableProvider
------
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.TargetsTransformer
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.CloseProviderTransformer
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.CloseProviderTransformer with new graph:
aws_cloudfront_distribution.s3_distribution - *terraform.NodeApplyableResourceInstance
  aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  aws_s3_bucket.my_bucket - *terraform.NodeApplyableResourceInstance
  aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_s3_bucket.my_bucket - *terraform.NodeApplyableResourceInstance
  aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
  aws_cloudfront_distribution.s3_distribution - *terraform.NodeApplyableResourceInstance
  aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  aws_s3_bucket.my_bucket - *terraform.NodeApplyableResourceInstance
  aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
provider.aws - *terraform.NodeApplyableProvider
provider.aws (close) - *terraform.graphNodeCloseProvider
  aws_cloudfront_distribution.s3_distribution - *terraform.NodeApplyableResourceInstance
  aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  aws_s3_bucket.my_bucket - *terraform.NodeApplyableResourceInstance
  aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
------
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.CloseProvisionerTransformer
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.CloseProvisionerTransformer (no changes)
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.RootTransformer
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.RootTransformer with new graph:
aws_cloudfront_distribution.s3_distribution - *terraform.NodeApplyableResourceInstance
  aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  aws_s3_bucket.my_bucket - *terraform.NodeApplyableResourceInstance
  aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_s3_bucket.my_bucket - *terraform.NodeApplyableResourceInstance
  aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
  aws_cloudfront_distribution.s3_distribution - *terraform.NodeApplyableResourceInstance
  aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  aws_s3_bucket.my_bucket - *terraform.NodeApplyableResourceInstance
  aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
provider.aws - *terraform.NodeApplyableProvider
provider.aws (close) - *terraform.graphNodeCloseProvider
  aws_cloudfront_distribution.s3_distribution - *terraform.NodeApplyableResourceInstance
  aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  aws_s3_bucket.my_bucket - *terraform.NodeApplyableResourceInstance
  aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
root - terraform.graphNodeRoot
  meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
  provider.aws (close) - *terraform.graphNodeCloseProvider
------
2019/10/29 12:06:55 [TRACE] Executing graph transform *terraform.TransitiveReductionTransformer
2019/10/29 12:06:55 [TRACE] Completed graph transform *terraform.TransitiveReductionTransformer with new graph:
aws_cloudfront_distribution.s3_distribution - *terraform.NodeApplyableResourceInstance
  aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  aws_s3_bucket.my_bucket - *terraform.NodeApplyableResourceInstance
aws_cloudfront_distribution.s3_distribution (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
aws_s3_bucket.my_bucket - *terraform.NodeApplyableResourceInstance
  aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
aws_s3_bucket.my_bucket (prepare state) - *terraform.NodeApplyableResource
  provider.aws - *terraform.NodeApplyableProvider
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
  aws_cloudfront_distribution.s3_distribution - *terraform.NodeApplyableResourceInstance
provider.aws - *terraform.NodeApplyableProvider
provider.aws (close) - *terraform.graphNodeCloseProvider
  aws_cloudfront_distribution.s3_distribution - *terraform.NodeApplyableResourceInstance
root - terraform.graphNodeRoot
  meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
  provider.aws (close) - *terraform.graphNodeCloseProvider
------
2019/10/29 12:06:55 [DEBUG] Starting graph walk: walkApply
2019/10/29 12:06:55 [TRACE] dag/walk: updating graph
2019/10/29 12:06:55 [TRACE] dag/walk: added new vertex: "aws_s3_bucket.my_bucket"
2019/10/29 12:06:55 [TRACE] dag/walk: added new vertex: "aws_cloudfront_distribution.s3_distribution"
2019/10/29 12:06:55 [TRACE] dag/walk: added new vertex: "provider.aws"
2019/10/29 12:06:55 [TRACE] dag/walk: added new vertex: "meta.count-boundary (EachMode fixup)"
2019/10/29 12:06:55 [TRACE] dag/walk: added new vertex: "provider.aws (close)"
2019/10/29 12:06:55 [TRACE] dag/walk: added new vertex: "root"
2019/10/29 12:06:55 [TRACE] dag/walk: added new vertex: "aws_cloudfront_distribution.s3_distribution (prepare state)"
2019/10/29 12:06:55 [TRACE] dag/walk: added new vertex: "aws_s3_bucket.my_bucket (prepare state)"
2019/10/29 12:06:55 [TRACE] dag/walk: added edge: "meta.count-boundary (EachMode fixup)" waiting on "aws_cloudfront_distribution.s3_distribution"
2019/10/29 12:06:55 [TRACE] dag/walk: added edge: "root" waiting on "meta.count-boundary (EachMode fixup)"
2019/10/29 12:06:55 [TRACE] dag/walk: added edge: "root" waiting on "provider.aws (close)"
2019/10/29 12:06:55 [TRACE] dag/walk: added edge: "aws_s3_bucket.my_bucket (prepare state)" waiting on "provider.aws"
2019/10/29 12:06:55 [TRACE] dag/walk: added edge: "provider.aws (close)" waiting on "aws_cloudfront_distribution.s3_distribution"
2019/10/29 12:06:55 [TRACE] dag/walk: added edge: "aws_cloudfront_distribution.s3_distribution (prepare state)" waiting on "provider.aws"
2019/10/29 12:06:55 [TRACE] dag/walk: added edge: "aws_s3_bucket.my_bucket" waiting on "aws_s3_bucket.my_bucket (prepare state)"
2019/10/29 12:06:55 [TRACE] dag/walk: added edge: "aws_cloudfront_distribution.s3_distribution" waiting on "aws_cloudfront_distribution.s3_distribution (prepare state)"
2019/10/29 12:06:55 [TRACE] dag/walk: added edge: "aws_cloudfront_distribution.s3_distribution" waiting on "aws_s3_bucket.my_bucket"
2019/10/29 12:06:55 [TRACE] dag/walk: dependencies changed for "aws_s3_bucket.my_bucket (prepare state)", sending new deps
2019/10/29 12:06:55 [TRACE] dag/walk: dependencies changed for "provider.aws (close)", sending new deps
2019/10/29 12:06:55 [TRACE] dag/walk: dependencies changed for "aws_cloudfront_distribution.s3_distribution (prepare state)", sending new deps
2019/10/29 12:06:55 [TRACE] dag/walk: dependencies changed for "aws_s3_bucket.my_bucket", sending new deps
2019/10/29 12:06:55 [TRACE] dag/walk: dependencies changed for "aws_cloudfront_distribution.s3_distribution", sending new deps
2019/10/29 12:06:55 [TRACE] dag/walk: dependencies changed for "meta.count-boundary (EachMode fixup)", sending new deps
2019/10/29 12:06:55 [TRACE] dag/walk: dependencies changed for "root", sending new deps
2019/10/29 12:06:55 [TRACE] dag/walk: visiting "provider.aws"
2019/10/29 12:06:55 [TRACE] vertex "provider.aws": starting visit (*terraform.NodeApplyableProvider)
2019/10/29 12:06:55 [TRACE] vertex "provider.aws": evaluating
2019/10/29 12:06:55 [TRACE] [walkApply] Entering eval tree: provider.aws
2019/10/29 12:06:55 [TRACE] <root>: eval: *terraform.EvalSequence
2019/10/29 12:06:55 [TRACE] <root>: eval: *terraform.EvalInitProvider
2019-10-29T12:06:55.350-0700 [INFO]  plugin: configuring client automatic mTLS
2019-10-29T12:06:55.374-0700 [DEBUG] plugin: starting plugin: path=/Users/mferree/Projects/scratch/cloudfront-bug-poc/.terraform/plugins/darwin_amd64/terraform-provider-aws_v2.33.0_x4 args=[/Users/mferree/Projects/scratch/cloudfront-bug-poc/.terraform/plugins/darwin_amd64/terraform-provider-aws_v2.33.0_x4]
2019-10-29T12:06:55.394-0700 [DEBUG] plugin: plugin started: path=/Users/mferree/Projects/scratch/cloudfront-bug-poc/.terraform/plugins/darwin_amd64/terraform-provider-aws_v2.33.0_x4 pid=94545
2019-10-29T12:06:55.394-0700 [DEBUG] plugin: waiting for RPC address: path=/Users/mferree/Projects/scratch/cloudfront-bug-poc/.terraform/plugins/darwin_amd64/terraform-provider-aws_v2.33.0_x4
2019-10-29T12:06:55.416-0700 [INFO]  plugin.terraform-provider-aws_v2.33.0_x4: configuring server automatic mTLS: timestamp=2019-10-29T12:06:55.416-0700
2019-10-29T12:06:55.445-0700 [DEBUG] plugin: using plugin: version=5
2019-10-29T12:06:55.445-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: plugin address: address=/var/folders/jb/r58w5f0d57d16d409vz2y0n80000gp/T/plugin172139604 network=unix timestamp=2019-10-29T12:06:55.445-0700
2019/10/29 12:06:55 [TRACE] BuiltinEvalContext: Initialized "aws" provider for provider.aws
2019/10/29 12:06:55 [TRACE] <root>: eval: terraform.EvalNoop
2019/10/29 12:06:55 [TRACE] <root>: eval: terraform.EvalNoop
2019/10/29 12:06:55 [TRACE] <root>: eval: *terraform.EvalOpFilter
2019/10/29 12:06:55 [TRACE] <root>: eval: *terraform.EvalSequence
2019/10/29 12:06:55 [TRACE] <root>: eval: *terraform.EvalGetProvider
2019/10/29 12:06:55 [TRACE] <root>: eval: *terraform.EvalOpFilter
2019/10/29 12:06:55 [TRACE] <root>: eval: *terraform.EvalSequence
2019/10/29 12:06:55 [TRACE] <root>: eval: *terraform.EvalConfigProvider
2019/10/29 12:06:55 [TRACE] buildProviderConfig for provider.aws: using explicit config only
2019/10/29 12:06:55 [TRACE] GRPCProvider: GetSchema
2019/10/29 12:06:55 [TRACE] GRPCProvider: Configure
2019-10-29T12:06:55.538-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:55 [INFO] No assume_role block read from configuration
2019-10-29T12:06:55.538-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:55 [INFO] Building AWS auth structure
2019-10-29T12:06:55.538-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:55 [INFO] Setting AWS metadata API timeout to 100ms
2019-10-29T12:06:56.256-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:56 [INFO] Ignoring AWS metadata API endpoint at default location as it doesn't return any instance-id
2019-10-29T12:06:56.257-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:56 [INFO] AWS Auth provider used: "SharedCredentialsProvider"
2019-10-29T12:06:56.258-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:56 [DEBUG] Trying to get account information via sts:GetCallerIdentity
2019-10-29T12:06:56.714-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:56 [DEBUG] Trying to get account information via sts:GetCallerIdentity
2019/10/29 12:06:57 [TRACE] [walkApply] Exiting eval tree: provider.aws
2019/10/29 12:06:57 [TRACE] vertex "provider.aws": visit complete
2019/10/29 12:06:57 [TRACE] dag/walk: visiting "aws_s3_bucket.my_bucket (prepare state)"
2019/10/29 12:06:57 [TRACE] vertex "aws_s3_bucket.my_bucket (prepare state)": starting visit (*terraform.NodeApplyableResource)
2019/10/29 12:06:57 [TRACE] vertex "aws_s3_bucket.my_bucket (prepare state)": evaluating
2019/10/29 12:06:57 [TRACE] [walkApply] Entering eval tree: aws_s3_bucket.my_bucket (prepare state)
2019/10/29 12:06:57 [TRACE] <root>: eval: *terraform.EvalWriteResourceState
2019/10/29 12:06:57 [TRACE] dag/walk: visiting "aws_cloudfront_distribution.s3_distribution (prepare state)"
2019/10/29 12:06:57 [TRACE] [walkApply] Exiting eval tree: aws_s3_bucket.my_bucket (prepare state)
2019/10/29 12:06:57 [TRACE] vertex "aws_s3_bucket.my_bucket (prepare state)": visit complete
2019/10/29 12:06:57 [TRACE] vertex "aws_cloudfront_distribution.s3_distribution (prepare state)": starting visit (*terraform.NodeApplyableResource)
2019/10/29 12:06:57 [TRACE] dag/walk: visiting "aws_s3_bucket.my_bucket"
2019/10/29 12:06:57 [TRACE] vertex "aws_s3_bucket.my_bucket": starting visit (*terraform.NodeApplyableResourceInstance)
2019/10/29 12:06:57 [TRACE] vertex "aws_cloudfront_distribution.s3_distribution (prepare state)": evaluating
2019/10/29 12:06:57 [TRACE] [walkApply] Entering eval tree: aws_cloudfront_distribution.s3_distribution (prepare state)
2019/10/29 12:06:57 [TRACE] <root>: eval: *terraform.EvalWriteResourceState
2019/10/29 12:06:57 [TRACE] [walkApply] Exiting eval tree: aws_cloudfront_distribution.s3_distribution (prepare state)
2019/10/29 12:06:57 [TRACE] vertex "aws_cloudfront_distribution.s3_distribution (prepare state)": visit complete
2019/10/29 12:06:57 [TRACE] vertex "aws_s3_bucket.my_bucket": evaluating
2019/10/29 12:06:57 [TRACE] [walkApply] Entering eval tree: aws_s3_bucket.my_bucket
2019/10/29 12:06:57 [TRACE] <root>: eval: *terraform.EvalSequence
2019/10/29 12:06:57 [TRACE] <root>: eval: *terraform.EvalGetProvider
2019/10/29 12:06:57 [TRACE] <root>: eval: *terraform.EvalReadDiff
2019/10/29 12:06:57 [TRACE] EvalReadDiff: Read Create change from plan for aws_s3_bucket.my_bucket
2019/10/29 12:06:57 [TRACE] <root>: eval: *terraform.EvalIf
2019/10/29 12:06:57 [TRACE] <root>: eval: terraform.EvalNoop
2019/10/29 12:06:57 [TRACE] <root>: eval: *terraform.EvalIf
2019/10/29 12:06:57 [TRACE] <root>: eval: *terraform.EvalReadState
2019/10/29 12:06:57 [TRACE] EvalReadState: reading state for aws_s3_bucket.my_bucket
2019/10/29 12:06:57 [TRACE] EvalReadState: no state present for aws_s3_bucket.my_bucket
2019/10/29 12:06:57 [TRACE] <root>: eval: *terraform.EvalReadDiff
2019/10/29 12:06:57 [TRACE] EvalReadDiff: Read Create change from plan for aws_s3_bucket.my_bucket
2019/10/29 12:06:57 [TRACE] <root>: eval: *terraform.EvalDiff
2019/10/29 12:06:57 [TRACE] Re-validating config for "aws_s3_bucket.my_bucket"
2019/10/29 12:06:57 [TRACE] GRPCProvider: ValidateResourceTypeConfig
2019/10/29 12:06:57 [TRACE] GRPCProvider: PlanResourceChange
2019/10/29 12:06:57 [WARN] Provider "aws" produced an invalid plan for aws_s3_bucket.my_bucket, but we are tolerating it because it is using the legacy plugin SDK.
    The following problems may be the cause of any confusing errors from downstream operations:
      - .force_destroy: planned value cty.False does not match config value cty.NullVal(cty.Bool)
      - .versioning: attribute representing nested block must not be unknown itself; set nested attribute values to unknown instead
2019/10/29 12:06:57 [TRACE] <root>: eval: *terraform.EvalCheckPlannedChange
2019/10/29 12:06:57 [TRACE] EvalCheckPlannedChange: Verifying that actual change (action Create) matches planned change (action Create)
2019/10/29 12:06:57 [TRACE] <root>: eval: *terraform.EvalGetProvider
2019/10/29 12:06:57 [TRACE] <root>: eval: *terraform.EvalReadState
2019/10/29 12:06:57 [TRACE] EvalReadState: reading state for aws_s3_bucket.my_bucket
2019/10/29 12:06:57 [TRACE] EvalReadState: no state present for aws_s3_bucket.my_bucket
2019/10/29 12:06:57 [TRACE] <root>: eval: *terraform.EvalReduceDiff
2019/10/29 12:06:57 [TRACE] <root>: eval: *terraform.EvalIf
2019/10/29 12:06:57 [TRACE] <root>: eval: terraform.EvalNoop
2019/10/29 12:06:57 [TRACE] <root>: eval: *terraform.EvalApplyPre
2019/10/29 12:06:57 [TRACE] <root>: eval: *terraform.EvalApply
2019/10/29 12:06:57 [DEBUG] aws_s3_bucket.my_bucket: applying the planned Create change
2019/10/29 12:06:57 [TRACE] GRPCProvider: ApplyResourceChange
2019-10-29T12:06:57.238-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:57 [DEBUG] setting computed for "versioning" from ComputedKeys
2019-10-29T12:06:57.238-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:57 [DEBUG] S3 bucket create: testing-terraform-provider-my-bucket, ACL: private
2019-10-29T12:06:57.238-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:57 [DEBUG] S3 bucket create: testing-terraform-provider-my-bucket, using region: us-west-2
2019-10-29T12:06:57.239-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:57 [DEBUG] Waiting for state to become: [success]
2019-10-29T12:06:57.239-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:57 [DEBUG] Trying to create new S3 bucket: "testing-terraform-provider-my-bucket"
2019-10-29T12:06:58.225-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:58 [DEBUG] Waiting for state to become: [success]
2019-10-29T12:06:58.385-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:58 [DEBUG] Waiting for state to become: [success]
2019-10-29T12:06:58.549-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:58 [DEBUG] Waiting for state to become: [success]
2019-10-29T12:06:58.713-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:58 [DEBUG] Waiting for state to become: [success]
2019-10-29T12:06:58.874-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:58 [DEBUG] Waiting for state to become: [success]
2019-10-29T12:06:59.031-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:59 [DEBUG] Waiting for state to become: [success]
2019-10-29T12:06:59.189-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:59 [DEBUG] Waiting for state to become: [success]
2019-10-29T12:06:59.347-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:59 [DEBUG] Waiting for state to become: [success]
2019-10-29T12:06:59.520-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:59 [DEBUG] Waiting for state to become: [success]
2019-10-29T12:06:59.673-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:59 [DEBUG] Waiting for state to become: [success]
2019-10-29T12:06:59.830-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:59 [DEBUG] Waiting for state to become: [success]
2019-10-29T12:06:59.980-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:06:59 [DEBUG] Waiting for state to become: [success]
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalMaybeTainted
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalWriteState
2019/10/29 12:07:00 [TRACE] EvalWriteState: writing current state object for aws_s3_bucket.my_bucket
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalApplyProvisioners
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalMaybeTainted
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalWriteState
2019/10/29 12:07:00 [TRACE] EvalWriteState: writing current state object for aws_s3_bucket.my_bucket
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalIf
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalIf
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalWriteDiff
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalApplyPost
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalUpdateStateHook
2019/10/29 12:07:00 [TRACE] statemgr.Filesystem: creating backup snapshot at terraform.tfstate.backup
2019/10/29 12:07:00 [TRACE] statemgr.Filesystem: state has changed since last snapshot, so incrementing serial to 53
2019/10/29 12:07:00 [TRACE] statemgr.Filesystem: writing snapshot at terraform.tfstate
2019/10/29 12:07:00 [TRACE] [walkApply] Exiting eval tree: aws_s3_bucket.my_bucket
2019/10/29 12:07:00 [TRACE] vertex "aws_s3_bucket.my_bucket": visit complete
2019/10/29 12:07:00 [TRACE] dag/walk: visiting "aws_cloudfront_distribution.s3_distribution"
2019/10/29 12:07:00 [TRACE] vertex "aws_cloudfront_distribution.s3_distribution": starting visit (*terraform.NodeApplyableResourceInstance)
2019/10/29 12:07:00 [TRACE] vertex "aws_cloudfront_distribution.s3_distribution": evaluating
2019/10/29 12:07:00 [TRACE] [walkApply] Entering eval tree: aws_cloudfront_distribution.s3_distribution
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalSequence
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalGetProvider
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalReadDiff
2019/10/29 12:07:00 [TRACE] EvalReadDiff: Read Create change from plan for aws_cloudfront_distribution.s3_distribution
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalIf
2019/10/29 12:07:00 [TRACE] <root>: eval: terraform.EvalNoop
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalIf
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalReadState
2019/10/29 12:07:00 [TRACE] EvalReadState: reading state for aws_cloudfront_distribution.s3_distribution
2019/10/29 12:07:00 [TRACE] EvalReadState: no state present for aws_cloudfront_distribution.s3_distribution
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalReadDiff
2019/10/29 12:07:00 [TRACE] EvalReadDiff: Read Create change from plan for aws_cloudfront_distribution.s3_distribution
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalDiff
2019/10/29 12:07:00 [TRACE] Re-validating config for "aws_cloudfront_distribution.s3_distribution"
2019/10/29 12:07:00 [TRACE] GRPCProvider: ValidateResourceTypeConfig
2019/10/29 12:07:00 [TRACE] GRPCProvider: PlanResourceChange
2019/10/29 12:07:00 [WARN] Provider "aws" produced an invalid plan for aws_cloudfront_distribution.s3_distribution, but we are tolerating it because it is using the legacy plugin SDK.
    The following problems may be the cause of any confusing errors from downstream operations:
      - .http_version: planned value cty.StringVal("http2") does not match config value cty.NullVal(cty.String)
      - .is_ipv6_enabled: planned value cty.False does not match config value cty.NullVal(cty.Bool)
      - .wait_for_deployment: planned value cty.True does not match config value cty.NullVal(cty.Bool)
      - .retain_on_delete: planned value cty.False does not match config value cty.NullVal(cty.Bool)
      - .default_cache_behavior[0].compress: planned value cty.False does not match config value cty.NullVal(cty.Bool)
      - .viewer_certificate[0].minimum_protocol_version: planned value cty.StringVal("TLSv1") does not match config value cty.NullVal(cty.String)
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalCheckPlannedChange
2019/10/29 12:07:00 [TRACE] EvalCheckPlannedChange: Verifying that actual change (action Create) matches planned change (action Create)
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalGetProvider
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalReadState
2019/10/29 12:07:00 [TRACE] EvalReadState: reading state for aws_cloudfront_distribution.s3_distribution
2019/10/29 12:07:00 [TRACE] EvalReadState: no state present for aws_cloudfront_distribution.s3_distribution
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalReduceDiff
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalIf
2019/10/29 12:07:00 [TRACE] <root>: eval: terraform.EvalNoop
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalApplyPre
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalApply
2019/10/29 12:07:00 [DEBUG] aws_cloudfront_distribution.s3_distribution: applying the planned Create change
2019/10/29 12:07:00 [TRACE] GRPCProvider: ApplyResourceChange
2019-10-29T12:07:00.339-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 2019/10/29 12:07:00 [DEBUG] setting computed for "active_trusted_signers" from ComputedKeys
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: panic: interface conversion: interface {} is nil, not map[string]interface {}
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: goroutine 232 [running]:
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: github.com/terraform-providers/terraform-provider-aws/aws.expandRestrictions(...)
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 	/opt/teamcity-agent/work/5d79fe75d4460a2f/src/github.com/terraform-providers/terraform-provider-aws/aws/cloudfront_distribution_configuration_structure.go:1027
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: github.com/terraform-providers/terraform-provider-aws/aws.expandDistributionConfig(0xc0002dfd50, 0x102cb41)
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 	/opt/teamcity-agent/work/5d79fe75d4460a2f/src/github.com/terraform-providers/terraform-provider-aws/aws/cloudfront_distribution_configuration_structure.go:65 +0xc8a
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: github.com/terraform-providers/terraform-provider-aws/aws.resourceAwsCloudFrontDistributionCreate(0xc0002dfd50, 0x4861a60, 0xc000592000, 0x2, 0x8a51ee0)
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 	/opt/teamcity-agent/work/5d79fe75d4460a2f/src/github.com/terraform-providers/terraform-provider-aws/aws/resource_aws_cloudfront_distribution.go:750 +0x6c
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: github.com/hashicorp/terraform-plugin-sdk/helper/schema.(*Resource).Apply(0xc000252f80, 0xc0007c02d0, 0xc0008f3a00, 0x4861a60, 0xc000592000, 0xc000b0b401, 0xc000abe6f0, 0xc000b0b4f0)
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 	/opt/teamcity-agent/work/5d79fe75d4460a2f/pkg/mod/github.com/hashicorp/[email protected]/helper/schema/resource.go:305 +0x365
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: github.com/hashicorp/terraform-plugin-sdk/helper/schema.(*Provider).Apply(0xc0006ef900, 0xc000c5b918, 0xc0007c02d0, 0xc0008f3a00, 0xc000a5c2c8, 0xc0000ae950, 0x4da17a0)
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 	/opt/teamcity-agent/work/5d79fe75d4460a2f/pkg/mod/github.com/hashicorp/[email protected]/helper/schema/provider.go:294 +0x99
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: github.com/hashicorp/terraform-plugin-sdk/internal/helper/plugin.(*GRPCProviderServer).ApplyResourceChange(0xc00058cd18, 0x6092ca0, 0xc000dee0f0, 0xc000114720, 0xc00058cd18, 0xc000dee0f0, 0xc00097fa80)
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 	/opt/teamcity-agent/work/5d79fe75d4460a2f/pkg/mod/github.com/hashicorp/[email protected]/internal/helper/plugin/grpc_provider.go:885 +0x882
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: github.com/hashicorp/terraform-plugin-sdk/internal/tfplugin5._Provider_ApplyResourceChange_Handler(0x56ec9c0, 0xc00058cd18, 0x6092ca0, 0xc000dee0f0, 0xc0001143c0, 0x0, 0x6092ca0, 0xc000dee0f0, 0xc0008c4000, 0xa04)
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 	/opt/teamcity-agent/work/5d79fe75d4460a2f/pkg/mod/github.com/hashicorp/[email protected]/internal/tfplugin5/tfplugin5.pb.go:3189 +0x217
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: google.golang.org/grpc.(*Server).processUnaryRPC(0xc00058a2c0, 0x60b1f60, 0xc0000b2a80, 0xc0008be000, 0xc0006e9b60, 0x8a24780, 0x0, 0x0, 0x0)
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 	/opt/teamcity-agent/work/5d79fe75d4460a2f/pkg/mod/google.golang.org/[email protected]/server.go:995 +0x460
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: google.golang.org/grpc.(*Server).handleStream(0xc00058a2c0, 0x60b1f60, 0xc0000b2a80, 0xc0008be000, 0x0)
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 	/opt/teamcity-agent/work/5d79fe75d4460a2f/pkg/mod/google.golang.org/[email protected]/server.go:1275 +0xd97
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: google.golang.org/grpc.(*Server).serveStreams.func1.1(0xc000034330, 0xc00058a2c0, 0x60b1f60, 0xc0000b2a80, 0xc0008be000)
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 	/opt/teamcity-agent/work/5d79fe75d4460a2f/pkg/mod/google.golang.org/[email protected]/server.go:710 +0xbb
2019-10-29T12:07:00.343-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: created by google.golang.org/grpc.(*Server).serveStreams.func1
2019-10-29T12:07:00.344-0700 [DEBUG] plugin.terraform-provider-aws_v2.33.0_x4: 	/opt/teamcity-agent/work/5d79fe75d4460a2f/pkg/mod/google.golang.org/[email protected]/server.go:708 +0xa1
2019/10/29 12:07:00 [TRACE] dag/walk: vertex "provider.aws (close)" is waiting for "aws_cloudfront_distribution.s3_distribution"
2019/10/29 12:07:00 [TRACE] dag/walk: vertex "root" is waiting for "provider.aws (close)"
2019/10/29 12:07:00 [TRACE] dag/walk: vertex "meta.count-boundary (EachMode fixup)" is waiting for "aws_cloudfront_distribution.s3_distribution"
2019/10/29 12:07:00 [DEBUG] aws_cloudfront_distribution.s3_distribution: apply errored, but we're indicating that via the Error pointer rather than returning it: rpc error: code = Unavailable desc = transport is closing
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalMaybeTainted
2019/10/29 12:07:00 [TRACE] EvalMaybeTainted: aws_cloudfront_distribution.s3_distribution encountered an error during creation, so it is now marked as tainted
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalWriteState
2019/10/29 12:07:00 [TRACE] EvalWriteState: removing state object for aws_cloudfront_distribution.s3_distribution
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalApplyProvisioners
2019/10/29 12:07:00 [TRACE] EvalApplyProvisioners: aws_cloudfront_distribution.s3_distribution has no state, so skipping provisioners
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalMaybeTainted
2019/10/29 12:07:00 [TRACE] EvalMaybeTainted: aws_cloudfront_distribution.s3_distribution encountered an error during creation, so it is now marked as tainted
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalWriteState
2019/10/29 12:07:00 [TRACE] EvalWriteState: removing state object for aws_cloudfront_distribution.s3_distribution
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalIf
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalIf
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalWriteDiff
2019/10/29 12:07:00 [TRACE] <root>: eval: *terraform.EvalApplyPost
2019/10/29 12:07:00 [ERROR] <root>: eval: *terraform.EvalApplyPost, err: rpc error: code = Unavailable desc = transport is closing
2019-10-29T12:07:00.351-0700 [DEBUG] plugin: plugin process exited: path=/Users/mferree/Projects/scratch/cloudfront-bug-poc/.terraform/plugins/darwin_amd64/terraform-provider-aws_v2.33.0_x4 pid=94545 error="exit status 2"
2019/10/29 12:07:00 [ERROR] <root>: eval: *terraform.EvalSequence, err: rpc error: code = Unavailable desc = transport is closing
2019/10/29 12:07:00 [TRACE] [walkApply] Exiting eval tree: aws_cloudfront_distribution.s3_distribution
2019/10/29 12:07:00 [TRACE] vertex "aws_cloudfront_distribution.s3_distribution": visit complete
2019/10/29 12:07:00 [TRACE] dag/walk: upstream of "provider.aws (close)" errored, so skipping
2019/10/29 12:07:00 [TRACE] dag/walk: upstream of "meta.count-boundary (EachMode fixup)" errored, so skipping
2019/10/29 12:07:00 [TRACE] dag/walk: upstream of "root" errored, so skipping
2019/10/29 12:07:00 [TRACE] statemgr.Filesystem: have already backed up original terraform.tfstate to terraform.tfstate.backup on a previous write
2019/10/29 12:07:00 [TRACE] statemgr.Filesystem: state has changed since last snapshot, so incrementing serial to 54
2019/10/29 12:07:00 [TRACE] statemgr.Filesystem: writing snapshot at terraform.tfstate
2019/10/29 12:07:00 [TRACE] statemgr.Filesystem: removing lock metadata file .terraform.tfstate.lock.info
2019/10/29 12:07:00 [TRACE] statemgr.Filesystem: unlocking terraform.tfstate using fcntl flock
2019-10-29T12:07:00.365-0700 [DEBUG] plugin: plugin exited