Skip to content

Instantly share code, notes, and snippets.

@rolandcrosby
Created June 24, 2020 04:06
Show Gist options
  • Save rolandcrosby/dcc27d668267990234a6916a5faf6a03 to your computer and use it in GitHub Desktop.
Save rolandcrosby/dcc27d668267990234a6916a5faf6a03 to your computer and use it in GitHub Desktop.
Terraform log for Docker provider bug
2020/06/24 04:05:13 [INFO] Terraform version: 0.12.26
2020/06/24 04:05:13 [INFO] Go runtime version: go1.12.13
2020/06/24 04:05:13 [INFO] CLI args: []string{"/home/ubuntu/bin/terraform", "apply"}
2020/06/24 04:05:13 [DEBUG] Attempting to open CLI config file: /home/ubuntu/.terraformrc
2020/06/24 04:05:13 [DEBUG] File doesn't exist, but doesn't need to. Ignoring.
2020/06/24 04:05:13 [DEBUG] checking for credentials in "/home/ubuntu/.terraform.d/plugins"
2020/06/24 04:05:13 [INFO] CLI command args: []string{"apply"}
2020/06/24 04:05:13 [TRACE] Meta.Backend: no config given or present on disk, so returning nil config
2020/06/24 04:05:13 [TRACE] Meta.Backend: backend has not previously been initialized in this working directory
2020/06/24 04:05:13 [DEBUG] New state was assigned lineage "b22ad3fd-fc8e-83df-088c-d7bbc4b9afed"
2020/06/24 04:05:13 [TRACE] Meta.Backend: using default local state only (no backend configuration, and no existing initialized backend)
2020/06/24 04:05:13 [TRACE] Meta.Backend: instantiated backend of type <nil>
2020/06/24 04:05:13 [DEBUG] checking for provider in "."
2020/06/24 04:05:13 [DEBUG] checking for provider in "/home/ubuntu/bin"
2020/06/24 04:05:13 [DEBUG] checking for provider in ".terraform/plugins/linux_amd64"
2020/06/24 04:05:13 [DEBUG] found provider "terraform-provider-docker_v2.7.1_x4"
2020/06/24 04:05:13 [DEBUG] checking for provider in "/home/ubuntu/.terraform.d/plugins"
2020/06/24 04:05:13 [ERROR] ignoring non-file /home/ubuntu/.terraform.d/plugins/terraform-provider-docker
2020/06/24 04:05:13 [DEBUG] found valid plugin: "docker", "2.7.1", "/home/ubuntu/temp/bug/.terraform/plugins/linux_amd64/terraform-provider-docker_v2.7.1_x4"
2020/06/24 04:05:13 [DEBUG] checking for provisioner in "."
2020/06/24 04:05:13 [DEBUG] checking for provisioner in "/home/ubuntu/bin"
2020/06/24 04:05:13 [DEBUG] checking for provisioner in ".terraform/plugins/linux_amd64"
2020/06/24 04:05:13 [DEBUG] checking for provisioner in "/home/ubuntu/.terraform.d/plugins"
2020/06/24 04:05:13 [TRACE] Meta.Backend: backend <nil> does not support operations, so wrapping it in a local backend
2020/06/24 04:05:13 [INFO] backend/local: starting Apply operation
2020/06/24 04:05:13 [TRACE] backend/local: requesting state manager for workspace "default"
2020/06/24 04:05:13 [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/06/24 04:05:13 [TRACE] backend/local: requesting state lock for workspace "default"
2020/06/24 04:05:13 [TRACE] statemgr.Filesystem: preparing to manage state snapshots at terraform.tfstate
2020/06/24 04:05:13 [TRACE] statemgr.Filesystem: existing snapshot has lineage "158dc599-376d-cd23-706b-cb225cb53b28" serial 1
2020/06/24 04:05:13 [TRACE] statemgr.Filesystem: locking terraform.tfstate using fcntl flock
2020/06/24 04:05:13 [TRACE] statemgr.Filesystem: writing lock metadata to .terraform.tfstate.lock.info
2020/06/24 04:05:13 [TRACE] backend/local: reading remote state for workspace "default"
2020/06/24 04:05:13 [TRACE] statemgr.Filesystem: reading latest snapshot from terraform.tfstate
2020/06/24 04:05:13 [TRACE] statemgr.Filesystem: read snapshot with lineage "158dc599-376d-cd23-706b-cb225cb53b28" serial 1
2020/06/24 04:05:13 [TRACE] backend/local: retrieving local state snapshot for workspace "default"
2020/06/24 04:05:13 [TRACE] backend/local: building context for current working directory
2020/06/24 04:05:13 [TRACE] terraform.NewContext: starting
2020/06/24 04:05:13 [TRACE] terraform.NewContext: resolving provider version selections
2020/06/24 04:05:13 [TRACE] terraform.NewContext: loading provider schemas
2020/06/24 04:05:13 [TRACE] LoadSchemas: retrieving schema for provider type "docker"
2020-06-24T04:05:13.483Z [INFO] plugin: configuring client automatic mTLS
2020-06-24T04:05:13.529Z [DEBUG] plugin: starting plugin: path=/home/ubuntu/temp/bug/.terraform/plugins/linux_amd64/terraform-provider-docker_v2.7.1_x4 args=[/home/ubuntu/temp/bug/.terraform/plugins/linux_amd64/terraform-provider-docker_v2.7.1_x4]
2020-06-24T04:05:13.531Z [DEBUG] plugin: plugin started: path=/home/ubuntu/temp/bug/.terraform/plugins/linux_amd64/terraform-provider-docker_v2.7.1_x4 pid=564243
2020-06-24T04:05:13.531Z [DEBUG] plugin: waiting for RPC address: path=/home/ubuntu/temp/bug/.terraform/plugins/linux_amd64/terraform-provider-docker_v2.7.1_x4
2020-06-24T04:05:13.568Z [INFO] plugin.terraform-provider-docker_v2.7.1_x4: configuring server automatic mTLS: timestamp=2020-06-24T04:05:13.568Z
2020-06-24T04:05:13.614Z [DEBUG] plugin.terraform-provider-docker_v2.7.1_x4: plugin address: address=/tmp/plugin484544868 network=unix timestamp=2020-06-24T04:05:13.614Z
2020-06-24T04:05:13.614Z [DEBUG] plugin: using plugin: version=5
2020/06/24 04:05:13 [TRACE] GRPCProvider: GetSchema
2020-06-24T04:05:13.716Z [TRACE] plugin.stdio: waiting for stdio data
2020-06-24T04:05:13.718Z [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2020/06/24 04:05:13 [TRACE] GRPCProvider: Close
2020-06-24T04:05:13.726Z [DEBUG] plugin: plugin process exited: path=/home/ubuntu/temp/bug/.terraform/plugins/linux_amd64/terraform-provider-docker_v2.7.1_x4 pid=564243
2020-06-24T04:05:13.726Z [DEBUG] plugin: plugin exited
2020/06/24 04:05:13 [TRACE] terraform.NewContext: complete
2020/06/24 04:05:13 [TRACE] backend/local: finished building terraform.Context
2020/06/24 04:05:13 [TRACE] backend/local: requesting interactive input, if necessary
2020/06/24 04:05:13 [TRACE] Context.Input: Prompting for provider arguments
2020/06/24 04:05:13 [TRACE] Context.Input: Provider provider.docker declared at main.tf:5,1-18
2020/06/24 04:05:13 [TRACE] Context.Input: Input for provider.docker: map[string]cty.Value{}
2020/06/24 04:05:13 [TRACE] backend/local: running validation operation
2020/06/24 04:05:13 [INFO] terraform: building graph: GraphTypeValidate
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.ConfigTransformer
2020/06/24 04:05:13 [TRACE] ConfigTransformer: Starting for path:
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.ConfigTransformer with new graph:
docker_image.hello_world - *terraform.NodeValidatableResource
------
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.LocalTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.LocalTransformer with new graph:
docker_image.hello_world - *terraform.NodeValidatableResource
local.docker_registry_url - *terraform.NodeLocal
------
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.OutputTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.OutputTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.OrphanResourceInstanceTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.OrphanResourceInstanceTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.StateTransformer
2020/06/24 04:05:13 [TRACE] StateTransformer: state is empty, so nothing to do
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.StateTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.OrphanOutputTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.OrphanOutputTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.AttachResourceConfigTransformer
2020/06/24 04:05:13 [TRACE] AttachResourceConfigTransformer: attaching to "docker_image.hello_world" (*terraform.NodeValidatableResource) config from main.tf:14,1-38
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.AttachResourceConfigTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.AttachStateTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.RootVariableTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.RootVariableTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.MissingProvisionerTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.MissingProvisionerTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.ProvisionerTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.ProvisionerTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.ModuleVariableTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.ModuleVariableTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.graphTransformerMulti
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderConfigTransformer
2020/06/24 04:05:13 [TRACE] ProviderConfigTransformer: attaching to "provider.docker" provider configuration from main.tf:5,1-18
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderConfigTransformer with new graph:
docker_image.hello_world - *terraform.NodeValidatableResource
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
------
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.MissingProviderTransformer
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.MissingProviderTransformer (no changes)
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderTransformer
2020/06/24 04:05:13 [TRACE] ProviderTransformer: docker_image.hello_world is provided by provider.docker or inherited equivalent
2020/06/24 04:05:13 [TRACE] ProviderTransformer: exact match for provider.docker serving docker_image.hello_world
2020/06/24 04:05:13 [DEBUG] ProviderTransformer: "docker_image.hello_world" (*terraform.NodeValidatableResource) needs provider.docker
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderTransformer with new graph:
docker_image.hello_world - *terraform.NodeValidatableResource
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
------
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.PruneProviderTransformer
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.PruneProviderTransformer (no changes)
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ParentProviderTransformer
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ParentProviderTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.graphTransformerMulti with new graph:
docker_image.hello_world - *terraform.NodeValidatableResource
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
------
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.RemovedModuleTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.RemovedModuleTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.AttachSchemaTransformer
2020/06/24 04:05:13 [TRACE] AttachSchemaTransformer: attaching provider config schema to provider.docker
2020/06/24 04:05:13 [TRACE] AttachSchemaTransformer: attaching resource schema to docker_image.hello_world
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.AttachSchemaTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.ReferenceTransformer
2020/06/24 04:05:13 [DEBUG] ReferenceTransformer: "docker_image.hello_world" references: [local.docker_registry_url]
2020/06/24 04:05:13 [DEBUG] ReferenceTransformer: "local.docker_registry_url" references: []
2020/06/24 04:05:13 [DEBUG] ReferenceTransformer: "provider.docker" references: [local.docker_registry_url]
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.ReferenceTransformer with new graph:
docker_image.hello_world - *terraform.NodeValidatableResource
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
------
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.CountBoundaryTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.CountBoundaryTransformer with new graph:
docker_image.hello_world - *terraform.NodeValidatableResource
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
docker_image.hello_world - *terraform.NodeValidatableResource
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
------
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.TargetsTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.ForcedCBDTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.ForcedCBDTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.CloseProviderTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.CloseProviderTransformer with new graph:
docker_image.hello_world - *terraform.NodeValidatableResource
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
docker_image.hello_world - *terraform.NodeValidatableResource
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
provider.docker (close) - *terraform.graphNodeCloseProvider
docker_image.hello_world - *terraform.NodeValidatableResource
provider.docker - *terraform.NodeApplyableProvider
------
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.CloseProvisionerTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.CloseProvisionerTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.RootTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.RootTransformer with new graph:
docker_image.hello_world - *terraform.NodeValidatableResource
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
docker_image.hello_world - *terraform.NodeValidatableResource
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
provider.docker (close) - *terraform.graphNodeCloseProvider
docker_image.hello_world - *terraform.NodeValidatableResource
provider.docker - *terraform.NodeApplyableProvider
root - terraform.graphNodeRoot
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
provider.docker (close) - *terraform.graphNodeCloseProvider
------
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.TransitiveReductionTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.TransitiveReductionTransformer with new graph:
docker_image.hello_world - *terraform.NodeValidatableResource
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
docker_image.hello_world - *terraform.NodeValidatableResource
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
provider.docker (close) - *terraform.graphNodeCloseProvider
docker_image.hello_world - *terraform.NodeValidatableResource
root - terraform.graphNodeRoot
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
provider.docker (close) - *terraform.graphNodeCloseProvider
------
2020/06/24 04:05:13 [DEBUG] Starting graph walk: walkValidate
2020/06/24 04:05:13 [TRACE] dag/walk: updating graph
2020/06/24 04:05:13 [TRACE] dag/walk: added new vertex: "provider.docker (close)"
2020/06/24 04:05:13 [TRACE] dag/walk: added new vertex: "root"
2020/06/24 04:05:13 [TRACE] dag/walk: added new vertex: "docker_image.hello_world"
2020/06/24 04:05:13 [TRACE] dag/walk: added new vertex: "local.docker_registry_url"
2020/06/24 04:05:13 [TRACE] dag/walk: added new vertex: "provider.docker"
2020/06/24 04:05:13 [TRACE] dag/walk: added new vertex: "meta.count-boundary (EachMode fixup)"
2020/06/24 04:05:13 [TRACE] dag/walk: added edge: "provider.docker (close)" waiting on "docker_image.hello_world"
2020/06/24 04:05:13 [TRACE] dag/walk: added edge: "root" waiting on "meta.count-boundary (EachMode fixup)"
2020/06/24 04:05:13 [TRACE] dag/walk: added edge: "provider.docker" waiting on "local.docker_registry_url"
2020/06/24 04:05:13 [TRACE] dag/walk: added edge: "meta.count-boundary (EachMode fixup)" waiting on "docker_image.hello_world"
2020/06/24 04:05:13 [TRACE] dag/walk: added edge: "root" waiting on "provider.docker (close)"
2020/06/24 04:05:13 [TRACE] dag/walk: added edge: "docker_image.hello_world" waiting on "provider.docker"
2020/06/24 04:05:13 [TRACE] dag/walk: dependencies changed for "provider.docker", sending new deps
2020/06/24 04:05:13 [TRACE] dag/walk: dependencies changed for "meta.count-boundary (EachMode fixup)", sending new deps
2020/06/24 04:05:13 [TRACE] dag/walk: dependencies changed for "docker_image.hello_world", sending new deps
2020/06/24 04:05:13 [TRACE] dag/walk: dependencies changed for "provider.docker (close)", sending new deps
2020/06/24 04:05:13 [TRACE] dag/walk: dependencies changed for "root", sending new deps
2020/06/24 04:05:13 [TRACE] dag/walk: visiting "local.docker_registry_url"
2020/06/24 04:05:13 [TRACE] vertex "local.docker_registry_url": starting visit (*terraform.NodeLocal)
2020/06/24 04:05:13 [TRACE] vertex "local.docker_registry_url": evaluating
2020/06/24 04:05:13 [TRACE] [walkValidate] Entering eval tree: local.docker_registry_url
2020/06/24 04:05:13 [TRACE] <root>: eval: *terraform.EvalLocal
2020/06/24 04:05:13 [TRACE] [walkValidate] Exiting eval tree: local.docker_registry_url
2020/06/24 04:05:13 [TRACE] vertex "local.docker_registry_url": visit complete
2020/06/24 04:05:13 [TRACE] dag/walk: visiting "provider.docker"
2020/06/24 04:05:13 [TRACE] vertex "provider.docker": starting visit (*terraform.NodeApplyableProvider)
2020/06/24 04:05:13 [TRACE] vertex "provider.docker": evaluating
2020/06/24 04:05:13 [TRACE] [walkValidate] Entering eval tree: provider.docker
2020/06/24 04:05:13 [TRACE] <root>: eval: *terraform.EvalSequence
2020/06/24 04:05:13 [TRACE] <root>: eval: *terraform.EvalInitProvider
2020-06-24T04:05:13.729Z [INFO] plugin: configuring client automatic mTLS
2020-06-24T04:05:13.787Z [DEBUG] plugin: starting plugin: path=/home/ubuntu/temp/bug/.terraform/plugins/linux_amd64/terraform-provider-docker_v2.7.1_x4 args=[/home/ubuntu/temp/bug/.terraform/plugins/linux_amd64/terraform-provider-docker_v2.7.1_x4]
2020-06-24T04:05:13.787Z [DEBUG] plugin: plugin started: path=/home/ubuntu/temp/bug/.terraform/plugins/linux_amd64/terraform-provider-docker_v2.7.1_x4 pid=564254
2020-06-24T04:05:13.787Z [DEBUG] plugin: waiting for RPC address: path=/home/ubuntu/temp/bug/.terraform/plugins/linux_amd64/terraform-provider-docker_v2.7.1_x4
2020-06-24T04:05:13.805Z [INFO] plugin.terraform-provider-docker_v2.7.1_x4: configuring server automatic mTLS: timestamp=2020-06-24T04:05:13.805Z
2020-06-24T04:05:13.860Z [DEBUG] plugin.terraform-provider-docker_v2.7.1_x4: plugin address: network=unix address=/tmp/plugin694025383 timestamp=2020-06-24T04:05:13.860Z
2020-06-24T04:05:13.861Z [DEBUG] plugin: using plugin: version=5
2020/06/24 04:05:13 [TRACE] BuiltinEvalContext: Initialized "docker" provider for provider.docker
2020/06/24 04:05:13 [TRACE] <root>: eval: terraform.EvalNoop
2020/06/24 04:05:13 [TRACE] <root>: eval: *terraform.EvalOpFilter
2020/06/24 04:05:13 [TRACE] <root>: eval: *terraform.EvalSequence
2020/06/24 04:05:13 [TRACE] <root>: eval: *terraform.EvalGetProvider
2020/06/24 04:05:13 [TRACE] <root>: eval: *terraform.EvalValidateProvider
2020/06/24 04:05:13 [TRACE] buildProviderConfig for provider.docker: using explicit config only
2020/06/24 04:05:13 [TRACE] GRPCProvider: GetSchema
2020-06-24T04:05:13.958Z [TRACE] plugin.stdio: waiting for stdio data
2020-06-24T04:05:13.959Z [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2020/06/24 04:05:13 [TRACE] GRPCProvider: PrepareProviderConfig
2020/06/24 04:05:13 [TRACE] <root>: eval: terraform.EvalNoop
2020/06/24 04:05:13 [TRACE] <root>: eval: terraform.EvalNoop
2020/06/24 04:05:13 [TRACE] [walkValidate] Exiting eval tree: provider.docker
2020/06/24 04:05:13 [TRACE] vertex "provider.docker": visit complete
2020/06/24 04:05:13 [TRACE] dag/walk: visiting "docker_image.hello_world"
2020/06/24 04:05:13 [TRACE] vertex "docker_image.hello_world": starting visit (*terraform.NodeValidatableResource)
2020/06/24 04:05:13 [TRACE] vertex "docker_image.hello_world": evaluating
2020/06/24 04:05:13 [TRACE] [walkValidate] Entering eval tree: docker_image.hello_world
2020/06/24 04:05:13 [TRACE] <root>: eval: *terraform.EvalSequence
2020/06/24 04:05:13 [TRACE] <root>: eval: *terraform.EvalGetProvider
2020/06/24 04:05:13 [TRACE] <root>: eval: *terraform.EvalValidateResource
2020/06/24 04:05:13 [TRACE] GRPCProvider: ValidateResourceTypeConfig
2020/06/24 04:05:13 [TRACE] [walkValidate] Exiting eval tree: docker_image.hello_world
2020/06/24 04:05:13 [TRACE] vertex "docker_image.hello_world": visit complete
2020/06/24 04:05:13 [TRACE] dag/walk: visiting "provider.docker (close)"
2020/06/24 04:05:13 [TRACE] vertex "provider.docker (close)": starting visit (*terraform.graphNodeCloseProvider)
2020/06/24 04:05:13 [TRACE] vertex "provider.docker (close)": evaluating
2020/06/24 04:05:13 [TRACE] [walkValidate] Entering eval tree: provider.docker (close)
2020/06/24 04:05:13 [TRACE] <root>: eval: *terraform.EvalCloseProvider
2020/06/24 04:05:13 [TRACE] GRPCProvider: Close
2020/06/24 04:05:13 [TRACE] dag/walk: visiting "meta.count-boundary (EachMode fixup)"
2020/06/24 04:05:13 [TRACE] vertex "meta.count-boundary (EachMode fixup)": starting visit (*terraform.NodeCountBoundary)
2020/06/24 04:05:13 [TRACE] vertex "meta.count-boundary (EachMode fixup)": evaluating
2020/06/24 04:05:13 [TRACE] [walkValidate] Entering eval tree: meta.count-boundary (EachMode fixup)
2020/06/24 04:05:13 [TRACE] <root>: eval: *terraform.EvalCountFixZeroOneBoundaryGlobal
2020/06/24 04:05:13 [TRACE] [walkValidate] Exiting eval tree: meta.count-boundary (EachMode fixup)
2020/06/24 04:05:13 [TRACE] vertex "meta.count-boundary (EachMode fixup)": visit complete
2020-06-24T04:05:13.978Z [DEBUG] plugin: plugin process exited: path=/home/ubuntu/temp/bug/.terraform/plugins/linux_amd64/terraform-provider-docker_v2.7.1_x4 pid=564254
2020-06-24T04:05:13.978Z [DEBUG] plugin: plugin exited
2020/06/24 04:05:13 [TRACE] [walkValidate] Exiting eval tree: provider.docker (close)
2020/06/24 04:05:13 [TRACE] vertex "provider.docker (close)": visit complete
2020/06/24 04:05:13 [TRACE] dag/walk: visiting "root"
2020/06/24 04:05:13 [TRACE] vertex "root": starting visit (terraform.graphNodeRoot)
2020/06/24 04:05:13 [TRACE] vertex "root": visit complete
2020/06/24 04:05:13 [INFO] backend/local: apply calling Refresh
2020/06/24 04:05:13 [INFO] terraform: building graph: GraphTypeRefresh
2020/06/24 04:05:13 [TRACE] No managed resources in state during refresh; skipping managed resource transformer
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.ConfigTransformer
2020/06/24 04:05:13 [TRACE] ConfigTransformer: Starting for path:
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.ConfigTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.OrphanResourceInstanceTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.OrphanResourceInstanceTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.StateTransformer
2020/06/24 04:05:13 [TRACE] StateTransformer: state is empty, so nothing to do
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.StateTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.AttachStateTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.AttachResourceConfigTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.AttachResourceConfigTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.RootVariableTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.RootVariableTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.LocalTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.LocalTransformer with new graph:
local.docker_registry_url - *terraform.NodeLocal
------
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.OutputTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.OutputTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.ModuleVariableTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.ModuleVariableTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.graphTransformerMulti
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderConfigTransformer
2020/06/24 04:05:13 [TRACE] ProviderConfigTransformer: attaching to "provider.docker" provider configuration from main.tf:5,1-18
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderConfigTransformer with new graph:
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
------
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.MissingProviderTransformer
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.MissingProviderTransformer (no changes)
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderTransformer
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderTransformer (no changes)
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.PruneProviderTransformer
2020/06/24 04:05:13 [DEBUG] pruning unused provider.docker
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.PruneProviderTransformer with new graph:
local.docker_registry_url - *terraform.NodeLocal
------
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ParentProviderTransformer
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ParentProviderTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.graphTransformerMulti (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.AttachSchemaTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.AttachSchemaTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.ReferenceTransformer
2020/06/24 04:05:13 [DEBUG] ReferenceTransformer: "local.docker_registry_url" references: []
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.ReferenceTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.AttachDependenciesTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.AttachDependenciesTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.TargetsTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.CloseProviderTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.CloseProviderTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.RootTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.RootTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.TransitiveReductionTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.TransitiveReductionTransformer (no changes)
2020/06/24 04:05:13 [DEBUG] Starting graph walk: walkRefresh
2020/06/24 04:05:13 [TRACE] dag/walk: updating graph
2020/06/24 04:05:13 [TRACE] dag/walk: added new vertex: "local.docker_registry_url"
2020/06/24 04:05:13 [TRACE] dag/walk: visiting "local.docker_registry_url"
2020/06/24 04:05:13 [TRACE] vertex "local.docker_registry_url": starting visit (*terraform.NodeLocal)
2020/06/24 04:05:13 [TRACE] vertex "local.docker_registry_url": evaluating
2020/06/24 04:05:13 [TRACE] [walkRefresh] Entering eval tree: local.docker_registry_url
2020/06/24 04:05:13 [TRACE] <root>: eval: *terraform.EvalLocal
2020/06/24 04:05:13 [TRACE] [walkRefresh] Exiting eval tree: local.docker_registry_url
2020/06/24 04:05:13 [TRACE] vertex "local.docker_registry_url": visit complete
2020/06/24 04:05:13 [INFO] backend/local: apply calling Plan
2020/06/24 04:05:13 [INFO] terraform: building graph: GraphTypePlan
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.ConfigTransformer
2020/06/24 04:05:13 [TRACE] ConfigTransformer: Starting for path:
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.ConfigTransformer with new graph:
docker_image.hello_world - *terraform.NodePlannableResource
------
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.LocalTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.LocalTransformer with new graph:
docker_image.hello_world - *terraform.NodePlannableResource
local.docker_registry_url - *terraform.NodeLocal
------
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.OutputTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.OutputTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.OrphanResourceInstanceTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.OrphanResourceInstanceTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.StateTransformer
2020/06/24 04:05:13 [TRACE] StateTransformer: state is empty, so nothing to do
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.StateTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.OrphanOutputTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.OrphanOutputTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.AttachResourceConfigTransformer
2020/06/24 04:05:13 [TRACE] AttachResourceConfigTransformer: attaching to "docker_image.hello_world" (*terraform.NodePlannableResource) config from main.tf:14,1-38
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.AttachResourceConfigTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.AttachStateTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.RootVariableTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.RootVariableTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.MissingProvisionerTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.MissingProvisionerTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.ProvisionerTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.ProvisionerTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.ModuleVariableTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.ModuleVariableTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.graphTransformerMulti
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderConfigTransformer
2020/06/24 04:05:13 [TRACE] ProviderConfigTransformer: attaching to "provider.docker" provider configuration from main.tf:5,1-18
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderConfigTransformer with new graph:
docker_image.hello_world - *terraform.NodePlannableResource
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
------
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.MissingProviderTransformer
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.MissingProviderTransformer (no changes)
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderTransformer
2020/06/24 04:05:13 [TRACE] ProviderTransformer: docker_image.hello_world is provided by provider.docker or inherited equivalent
2020/06/24 04:05:13 [TRACE] ProviderTransformer: exact match for provider.docker serving docker_image.hello_world
2020/06/24 04:05:13 [DEBUG] ProviderTransformer: "docker_image.hello_world" (*terraform.NodePlannableResource) needs provider.docker
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderTransformer with new graph:
docker_image.hello_world - *terraform.NodePlannableResource
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
------
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.PruneProviderTransformer
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.PruneProviderTransformer (no changes)
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ParentProviderTransformer
2020/06/24 04:05:13 [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ParentProviderTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.graphTransformerMulti with new graph:
docker_image.hello_world - *terraform.NodePlannableResource
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
------
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.RemovedModuleTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.RemovedModuleTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.AttachSchemaTransformer
2020/06/24 04:05:13 [TRACE] AttachSchemaTransformer: attaching resource schema to docker_image.hello_world
2020/06/24 04:05:13 [TRACE] AttachSchemaTransformer: attaching provider config schema to provider.docker
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.AttachSchemaTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.ReferenceTransformer
2020/06/24 04:05:13 [DEBUG] ReferenceTransformer: "docker_image.hello_world" references: [local.docker_registry_url]
2020/06/24 04:05:13 [DEBUG] ReferenceTransformer: "local.docker_registry_url" references: []
2020/06/24 04:05:13 [DEBUG] ReferenceTransformer: "provider.docker" references: [local.docker_registry_url]
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.ReferenceTransformer with new graph:
docker_image.hello_world - *terraform.NodePlannableResource
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
------
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.CountBoundaryTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.CountBoundaryTransformer with new graph:
docker_image.hello_world - *terraform.NodePlannableResource
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
docker_image.hello_world - *terraform.NodePlannableResource
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
------
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.TargetsTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.ForcedCBDTransformer
2020/06/24 04:05:13 [TRACE] ForcedCBDTransformer: "docker_image.hello_world" (*terraform.NodePlannableResource) has no CBD descendent, so skipping
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.ForcedCBDTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.CloseProviderTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.CloseProviderTransformer with new graph:
docker_image.hello_world - *terraform.NodePlannableResource
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
docker_image.hello_world - *terraform.NodePlannableResource
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
provider.docker (close) - *terraform.graphNodeCloseProvider
docker_image.hello_world - *terraform.NodePlannableResource
provider.docker - *terraform.NodeApplyableProvider
------
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.CloseProvisionerTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.CloseProvisionerTransformer (no changes)
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.RootTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.RootTransformer with new graph:
docker_image.hello_world - *terraform.NodePlannableResource
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
docker_image.hello_world - *terraform.NodePlannableResource
local.docker_registry_url - *terraform.NodeLocal
provider.docker - *terraform.NodeApplyableProvider
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
provider.docker (close) - *terraform.graphNodeCloseProvider
docker_image.hello_world - *terraform.NodePlannableResource
provider.docker - *terraform.NodeApplyableProvider
root - terraform.graphNodeRoot
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
provider.docker (close) - *terraform.graphNodeCloseProvider
------
2020/06/24 04:05:13 [TRACE] Executing graph transform *terraform.TransitiveReductionTransformer
2020/06/24 04:05:13 [TRACE] Completed graph transform *terraform.TransitiveReductionTransformer with new graph:
docker_image.hello_world - *terraform.NodePlannableResource
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
docker_image.hello_world - *terraform.NodePlannableResource
provider.docker - *terraform.NodeApplyableProvider
local.docker_registry_url - *terraform.NodeLocal
provider.docker (close) - *terraform.graphNodeCloseProvider
docker_image.hello_world - *terraform.NodePlannableResource
root - terraform.graphNodeRoot
meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
provider.docker (close) - *terraform.graphNodeCloseProvider
------
2020/06/24 04:05:13 [DEBUG] Starting graph walk: walkPlan
2020/06/24 04:05:13 [TRACE] dag/walk: updating graph
2020/06/24 04:05:13 [TRACE] dag/walk: added new vertex: "docker_image.hello_world"
2020/06/24 04:05:13 [TRACE] dag/walk: added new vertex: "local.docker_registry_url"
2020/06/24 04:05:13 [TRACE] dag/walk: added new vertex: "provider.docker"
2020/06/24 04:05:13 [TRACE] dag/walk: added new vertex: "meta.count-boundary (EachMode fixup)"
2020/06/24 04:05:13 [TRACE] dag/walk: added new vertex: "provider.docker (close)"
2020/06/24 04:05:13 [TRACE] dag/walk: added new vertex: "root"
2020/06/24 04:05:13 [TRACE] dag/walk: added edge: "provider.docker" waiting on "local.docker_registry_url"
2020/06/24 04:05:13 [TRACE] dag/walk: added edge: "meta.count-boundary (EachMode fixup)" waiting on "docker_image.hello_world"
2020/06/24 04:05:13 [TRACE] dag/walk: added edge: "provider.docker (close)" waiting on "docker_image.hello_world"
2020/06/24 04:05:13 [TRACE] dag/walk: added edge: "root" waiting on "provider.docker (close)"
2020/06/24 04:05:13 [TRACE] dag/walk: added edge: "root" waiting on "meta.count-boundary (EachMode fixup)"
2020/06/24 04:05:13 [TRACE] dag/walk: added edge: "docker_image.hello_world" waiting on "provider.docker"
2020/06/24 04:05:13 [TRACE] dag/walk: dependencies changed for "meta.count-boundary (EachMode fixup)", sending new deps
2020/06/24 04:05:13 [TRACE] dag/walk: dependencies changed for "provider.docker (close)", sending new deps
2020/06/24 04:05:13 [TRACE] dag/walk: dependencies changed for "root", sending new deps
2020/06/24 04:05:13 [TRACE] dag/walk: dependencies changed for "docker_image.hello_world", sending new deps
2020/06/24 04:05:13 [TRACE] dag/walk: dependencies changed for "provider.docker", sending new deps
2020/06/24 04:05:13 [TRACE] dag/walk: visiting "local.docker_registry_url"
2020/06/24 04:05:13 [TRACE] vertex "local.docker_registry_url": starting visit (*terraform.NodeLocal)
2020/06/24 04:05:13 [TRACE] vertex "local.docker_registry_url": evaluating
2020/06/24 04:05:13 [TRACE] [walkPlan] Entering eval tree: local.docker_registry_url
2020/06/24 04:05:13 [TRACE] <root>: eval: *terraform.EvalLocal
2020/06/24 04:05:13 [TRACE] [walkPlan] Exiting eval tree: local.docker_registry_url
2020/06/24 04:05:13 [TRACE] vertex "local.docker_registry_url": visit complete
2020/06/24 04:05:13 [TRACE] dag/walk: visiting "provider.docker"
2020/06/24 04:05:13 [TRACE] vertex "provider.docker": starting visit (*terraform.NodeApplyableProvider)
2020/06/24 04:05:13 [TRACE] vertex "provider.docker": evaluating
2020/06/24 04:05:13 [TRACE] [walkPlan] Entering eval tree: provider.docker
2020/06/24 04:05:13 [TRACE] <root>: eval: *terraform.EvalSequence
2020/06/24 04:05:13 [TRACE] <root>: eval: *terraform.EvalInitProvider
2020-06-24T04:05:13.981Z [INFO] plugin: configuring client automatic mTLS
2020-06-24T04:05:14.039Z [DEBUG] plugin: starting plugin: path=/home/ubuntu/temp/bug/.terraform/plugins/linux_amd64/terraform-provider-docker_v2.7.1_x4 args=[/home/ubuntu/temp/bug/.terraform/plugins/linux_amd64/terraform-provider-docker_v2.7.1_x4]
2020-06-24T04:05:14.042Z [DEBUG] plugin: plugin started: path=/home/ubuntu/temp/bug/.terraform/plugins/linux_amd64/terraform-provider-docker_v2.7.1_x4 pid=564263
2020-06-24T04:05:14.042Z [DEBUG] plugin: waiting for RPC address: path=/home/ubuntu/temp/bug/.terraform/plugins/linux_amd64/terraform-provider-docker_v2.7.1_x4
2020-06-24T04:05:14.062Z [INFO] plugin.terraform-provider-docker_v2.7.1_x4: configuring server automatic mTLS: timestamp=2020-06-24T04:05:14.062Z
2020-06-24T04:05:14.113Z [DEBUG] plugin: using plugin: version=5
2020-06-24T04:05:14.115Z [DEBUG] plugin.terraform-provider-docker_v2.7.1_x4: plugin address: address=/tmp/plugin447407781 network=unix timestamp=2020-06-24T04:05:14.113Z
2020/06/24 04:05:14 [TRACE] BuiltinEvalContext: Initialized "docker" provider for provider.docker
2020/06/24 04:05:14 [TRACE] <root>: eval: terraform.EvalNoop
2020/06/24 04:05:14 [TRACE] <root>: eval: terraform.EvalNoop
2020/06/24 04:05:14 [TRACE] <root>: eval: *terraform.EvalOpFilter
2020/06/24 04:05:14 [TRACE] <root>: eval: *terraform.EvalSequence
2020/06/24 04:05:14 [TRACE] <root>: eval: *terraform.EvalGetProvider
2020/06/24 04:05:14 [TRACE] <root>: eval: *terraform.EvalOpFilter
2020/06/24 04:05:14 [TRACE] <root>: eval: *terraform.EvalSequence
2020/06/24 04:05:14 [TRACE] <root>: eval: *terraform.EvalConfigProvider
2020/06/24 04:05:14 [TRACE] buildProviderConfig for provider.docker: using explicit config only
2020/06/24 04:05:14 [TRACE] GRPCProvider: GetSchema
2020-06-24T04:05:14.235Z [TRACE] plugin.stdio: waiting for stdio data
2020-06-24T04:05:14.237Z [WARN] plugin.stdio: received EOF, stopping recv loop: err="rpc error: code = Unimplemented desc = unknown service plugin.GRPCStdio"
2020/06/24 04:05:14 [TRACE] GRPCProvider: Configure
2020-06-24T04:05:14.245Z [DEBUG] plugin.terraform-provider-docker_v2.7.1_x4: 2020/06/24 04:05:14 [DEBUG] Parsing file content for registry auths: {"credsStore":"ecr-login"}
2020-06-24T04:05:14.245Z [DEBUG] plugin.terraform-provider-docker_v2.7.1_x4: 2020/06/24 04:05:14 [DEBUG] Parsing Docker config file
2020/06/24 04:05:14 [ERROR] <root>: eval: *terraform.EvalConfigProvider, err: Error loading registry auth config: Error parsing docker registry config json: json: cannot unmarshal string into Go value of type docker.dockerConfig
2020/06/24 04:05:14 [ERROR] <root>: eval: *terraform.EvalSequence, err: Error loading registry auth config: Error parsing docker registry config json: json: cannot unmarshal string into Go value of type docker.dockerConfig
2020/06/24 04:05:14 [ERROR] <root>: eval: *terraform.EvalOpFilter, err: Error loading registry auth config: Error parsing docker registry config json: json: cannot unmarshal string into Go value of type docker.dockerConfig
2020/06/24 04:05:14 [ERROR] <root>: eval: *terraform.EvalSequence, err: Error loading registry auth config: Error parsing docker registry config json: json: cannot unmarshal string into Go value of type docker.dockerConfig
2020/06/24 04:05:14 [TRACE] [walkPlan] Exiting eval tree: provider.docker
2020/06/24 04:05:14 [TRACE] vertex "provider.docker": visit complete
2020/06/24 04:05:14 [TRACE] dag/walk: upstream of "docker_image.hello_world" errored, so skipping
2020/06/24 04:05:14 [TRACE] dag/walk: upstream of "meta.count-boundary (EachMode fixup)" errored, so skipping
2020/06/24 04:05:14 [TRACE] dag/walk: upstream of "provider.docker (close)" errored, so skipping
2020/06/24 04:05:14 [TRACE] dag/walk: upstream of "root" errored, so skipping

Error: Error loading registry auth config: Error parsing docker registry config json: json: cannot unmarshal string into Go value of type docker.dockerConfig
 on main.tf line 5, in provider "docker":
5: provider "docker" {

2020/06/24 04:05:14 [TRACE] statemgr.Filesystem: removing lock metadata file .terraform.tfstate.lock.info
2020/06/24 04:05:14 [TRACE] statemgr.Filesystem: unlocking terraform.tfstate using fcntl flock

2020-06-24T04:05:14.248Z [DEBUG] plugin: plugin process exited: path=/home/ubuntu/temp/bug/.terraform/plugins/linux_amd64/terraform-provider-docker_v2.7.1_x4 pid=564263
2020-06-24T04:05:14.248Z [DEBUG] plugin: plugin exited
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment