Skip to content

Instantly share code, notes, and snippets.

@oboxodo

oboxodo/tail-of-trace.log

Last active November 14, 2022 22:10
Show Gist options
  • Save oboxodo/f463c7217a0b119669cb901b5062cdab to your computer and use it in GitHub Desktop.
Save oboxodo/f463c7217a0b119669cb901b5062cdab to your computer and use it in GitHub Desktop.
Download ZIP
Debugging to get help from Heroku's Terraform provider on a plan. Nothing secret in this log. (https://github.com/heroku/terraform-provider-heroku/issues/350)
Raw
tail-of-trace.log
2022-11-14T18:07:42.268-0300 [TRACE] vertex "provider[\"registry.terraform.io/heroku/heroku\"]": visit complete
2022-11-14T18:07:42.268-0300 [TRACE] vertex "heroku_config.production (expand)": starting visit (*terraform.nodeExpandApplyableResource)
2022-11-14T18:07:42.268-0300 [TRACE] vertex "heroku_config.production (expand)": expanding dynamic subgraph
2022-11-14T18:07:42.268-0300 [TRACE] vertex "heroku_config.production (expand)": entering dynamic subgraph
2022-11-14T18:07:42.268-0300 [TRACE] vertex "heroku_config.production": starting visit (*terraform.NodeApplyableResource)
2022-11-14T18:07:42.268-0300 [TRACE] vertex "heroku_config.production": visit complete
2022-11-14T18:07:42.268-0300 [TRACE] vertex "heroku_config.production (expand)": dynamic subgraph completed successfully
2022-11-14T18:07:42.268-0300 [TRACE] vertex "heroku_config.production (expand)": visit complete
2022-11-14T18:07:42.268-0300 [TRACE] vertex "heroku_config.production": starting visit (*terraform.NodeApplyableResourceInstance)
2022-11-14T18:07:42.269-0300 [TRACE] readDiff: Read Update change from plan for heroku_config.production
2022-11-14T18:07:42.269-0300 [TRACE] readResourceInstanceState: reading state for heroku_config.production
2022-11-14T18:07:42.269-0300 [TRACE] upgradeResourceState: schema version of heroku_config.production is still 0; calling provider "heroku" for any other minor fixups
2022-11-14T18:07:42.269-0300 [TRACE] GRPCProvider: UpgradeResourceState
2022-11-14T18:07:42.269-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Received request: tf_provider_addr=provider tf_resource_type=heroku_config tf_rpc=UpgradeResourceState @module=sdk.proto tf_proto_version=5.2 tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx1 @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-go/tfprotov5/tf5server/server.go:707 timestamp=2022-11-14T18:07:42.269-0300
2022-11-14T18:07:42.269-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Calling downstream: @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-go/tfprotov5/tf5server/server.go:714 tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx1 tf_resource_type=heroku_config tf_rpc=UpgradeResourceState @module=sdk.proto tf_proto_version=5.2 tf_provider_addr=provider timestamp=2022-11-14T18:07:42.269-0300
2022-11-14T18:07:42.269-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Upgrading JSON state: tf_resource_type=heroku_config @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-sdk/v2/helper/schema/grpc_provider.go:323 @module=sdk.helper_schema tf_provider_addr=provider tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx1 tf_rpc=UpgradeResourceState timestamp=2022-11-14T18:07:42.269-0300
2022-11-14T18:07:42.270-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Called downstream: tf_resource_type=heroku_config tf_proto_version=5.2 @module=sdk.proto tf_provider_addr=provider tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx1 tf_rpc=UpgradeResourceState @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-go/tfprotov5/tf5server/server.go:720 timestamp=2022-11-14T18:07:42.270-0300
2022-11-14T18:07:42.270-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Served request: @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-go/tfprotov5/tf5server/server.go:727 tf_proto_version=5.2 tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx1 @module=sdk.proto tf_provider_addr=provider tf_resource_type=heroku_config tf_rpc=UpgradeResourceState timestamp=2022-11-14T18:07:42.270-0300
2022-11-14T18:07:42.272-0300 [TRACE] readDiff: Read Update change from plan for heroku_config.production
2022-11-14T18:07:42.272-0300 [TRACE] Re-validating config for "heroku_config.production"
2022-11-14T18:07:42.272-0300 [TRACE] GRPCProvider: ValidateResourceConfig
2022-11-14T18:07:42.272-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Received request: tf_provider_addr=provider tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx2 tf_rpc=ValidateResourceTypeConfig @module=sdk.proto tf_proto_version=5.2 @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-go/tfprotov5/tf5server/server.go:678 tf_resource_type=heroku_config timestamp=2022-11-14T18:07:42.272-0300
2022-11-14T18:07:42.272-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Calling downstream: @module=sdk.proto tf_proto_version=5.2 tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx2 tf_rpc=ValidateResourceTypeConfig @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-go/tfprotov5/tf5server/server.go:686 tf_resource_type=heroku_config tf_provider_addr=provider timestamp=2022-11-14T18:07:42.272-0300
2022-11-14T18:07:42.273-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Calling downstream: tf_provider_addr=provider tf_resource_type=heroku_config @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-sdk/v2/helper/schema/grpc_provider.go:245 @module=sdk.helper_schema tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx2 tf_rpc=ValidateResourceTypeConfig timestamp=2022-11-14T18:07:42.273-0300
2022-11-14T18:07:42.273-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Called downstream: tf_rpc=ValidateResourceTypeConfig @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-sdk/v2/helper/schema/grpc_provider.go:247 @module=sdk.helper_schema tf_provider_addr=provider tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx2 tf_resource_type=heroku_config timestamp=2022-11-14T18:07:42.273-0300
2022-11-14T18:07:42.273-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Called downstream: @module=sdk.proto tf_proto_version=5.2 tf_resource_type=heroku_config @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-go/tfprotov5/tf5server/server.go:692 tf_provider_addr=provider tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx2 tf_rpc=ValidateResourceTypeConfig timestamp=2022-11-14T18:07:42.273-0300
2022-11-14T18:07:42.273-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Served request: tf_rpc=ValidateResourceTypeConfig @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-go/tfprotov5/tf5server/server.go:698 tf_proto_version=5.2 tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx2 tf_resource_type=heroku_config @module=sdk.proto tf_provider_addr=provider timestamp=2022-11-14T18:07:42.273-0300
2022-11-14T18:07:42.273-0300 [TRACE] GRPCProvider: PlanResourceChange
2022-11-14T18:07:42.274-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Received request: tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx3 @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-go/tfprotov5/tf5server/server.go:767 tf_proto_version=5.2 @module=sdk.proto tf_provider_addr=provider tf_resource_type=heroku_config tf_rpc=PlanResourceChange timestamp=2022-11-14T18:07:42.274-0300
2022-11-14T18:07:42.274-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Calling downstream: tf_proto_version=5.2 tf_resource_type=heroku_config tf_rpc=PlanResourceChange @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-go/tfprotov5/tf5server/server.go:778 @module=sdk.proto tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx3 tf_provider_addr=provider timestamp=2022-11-14T18:07:42.274-0300
2022-11-14T18:07:42.275-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Called downstream: @module=sdk.proto tf_proto_version=5.2 tf_rpc=PlanResourceChange @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-go/tfprotov5/tf5server/server.go:784 tf_provider_addr=provider tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx3 tf_resource_type=heroku_config timestamp=2022-11-14T18:07:42.275-0300
2022-11-14T18:07:42.275-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Served request: tf_proto_version=5.2 tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx3 tf_provider_addr=provider tf_resource_type=heroku_config tf_rpc=PlanResourceChange @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-go/tfprotov5/tf5server/server.go:791 @module=sdk.proto timestamp=2022-11-14T18:07:42.275-0300
2022-11-14T18:07:42.276-0300 [TRACE] checkPlannedChange: Verifying that actual change (action Update) matches planned change (action Update)
2022-11-14T18:07:42.277-0300 [INFO] Starting apply for heroku_config.production
2022-11-14T18:07:42.277-0300 [DEBUG] heroku_config.production: applying the planned Update change
2022-11-14T18:07:42.278-0300 [TRACE] GRPCProvider: ApplyResourceChange
2022-11-14T18:07:42.278-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Received request: tf_proto_version=5.2 tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx4 tf_resource_type=heroku_config tf_rpc=ApplyResourceChange @module=sdk.proto tf_provider_addr=provider @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-go/tfprotov5/tf5server/server.go:800 timestamp=2022-11-14T18:07:42.278-0300
2022-11-14T18:07:42.278-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Calling downstream: tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx4 tf_rpc=ApplyResourceChange @module=sdk.proto tf_provider_addr=provider @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-go/tfprotov5/tf5server/server.go:811 tf_proto_version=5.2 tf_resource_type=heroku_config timestamp=2022-11-14T18:07:42.278-0300
2022-11-14T18:07:42.281-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Calling downstream: tf_rpc=ApplyResourceChange tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx4 tf_resource_type=heroku_config @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-sdk/v2/helper/schema/resource.go:846 @module=sdk.helper_schema tf_provider_addr=provider timestamp=2022-11-14T18:07:42.281-0300
2022-11-14T18:07:42.281-0300 [INFO] provider.terraform-provider-heroku_v5.1.5: 2022/11/14 18:07:42 [INFO] List of Duplicate config vars (if any) []: timestamp=2022-11-14T18:07:42.281-0300
2022-11-14T18:07:42.281-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Called downstream: tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx4 tf_resource_type=heroku_config tf_rpc=ApplyResourceChange @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-sdk/v2/helper/schema/resource.go:848 @module=sdk.helper_schema tf_provider_addr=provider timestamp=2022-11-14T18:07:42.281-0300
2022-11-14T18:07:42.282-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Called downstream: @module=sdk.proto tf_provider_addr=provider tf_rpc=ApplyResourceChange @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-go/tfprotov5/tf5server/server.go:817 tf_proto_version=5.2 tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx4 tf_resource_type=heroku_config timestamp=2022-11-14T18:07:42.282-0300
2022-11-14T18:07:42.282-0300 [TRACE] provider.terraform-provider-heroku_v5.1.5: Served request: @caller=/home/runner/work/terraform-provider-heroku/terraform-provider-heroku/vendor/github.com/hashicorp/terraform-plugin-go/tfprotov5/tf5server/server.go:824 tf_provider_addr=provider tf_req_id=xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxx4 tf_rpc=ApplyResourceChange @module=sdk.proto tf_proto_version=5.2 tf_resource_type=heroku_config timestamp=2022-11-14T18:07:42.282-0300
2022-11-14T18:07:42.283-0300 [TRACE] NodeAbstractResouceInstance.writeResourceInstanceState to workingState for heroku_config.production
2022-11-14T18:07:42.283-0300 [TRACE] NodeAbstractResouceInstance.writeResourceInstanceState: writing state object for heroku_config.production
2022-11-14T18:07:42.283-0300 [TRACE] evalApplyProvisioners: heroku_config.production is not freshly-created, so no provisioning is required
2022-11-14T18:07:42.283-0300 [TRACE] NodeAbstractResouceInstance.writeResourceInstanceState to workingState for heroku_config.production
2022-11-14T18:07:42.283-0300 [TRACE] NodeAbstractResouceInstance.writeResourceInstanceState: writing state object for heroku_config.production
2022-11-14T18:07:42.283-0300 [TRACE] vertex "heroku_config.production": visit complete
2022-11-14T18:07:42.283-0300 [TRACE] vertex "provider[\"registry.terraform.io/heroku/heroku\"] (close)": starting visit (*terraform.graphNodeCloseProvider)
2022-11-14T18:07:42.284-0300 [TRACE] GRPCProvider: Close
2022-11-14T18:07:42.284-0300 [DEBUG] provider.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = error reading from server: EOF"
2022-11-14T18:07:42.285-0300 [DEBUG] provider: plugin process exited: path=.terraform/providers/registry.terraform.io/heroku/heroku/5.1.5/linux_amd64/terraform-provider-heroku_v5.1.5 pid=211912
2022-11-14T18:07:42.302-0300 [DEBUG] provider: plugin exited
2022-11-14T18:07:42.302-0300 [TRACE] vertex "provider[\"registry.terraform.io/heroku/heroku\"] (close)": visit complete
2022-11-14T18:07:42.302-0300 [TRACE] vertex "root": starting visit (*terraform.nodeCloseModule)
2022-11-14T18:07:42.302-0300 [TRACE] vertex "root": visit complete
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment