Busy polling in disk upload operations?

[tomeon]

Describe the bug

Note
If this is indeed a bug, it may be in oVirt/go-ovirt-client.

I am hitting an issue using the ovirt_disk_from_image resource: the disk data transfer appears to succeed, but almost immediately afterward Terraform bails out with this error:

╷
│ Error: Failed to create disk.
│
│   with ovirt_disk_from_image.nixos-template,
│   on config.tf.json line 39, in resource.ovirt_disk_from_image.nixos-template:
│   39:       }
│
│ timeout: maximum retries reached while waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, giving up (pending: Transfer is in phase finalizing_success)

I generated a Terraform debug log, which appears to show busy polling of disk status checks:

Debug log excerpt

2025-02-14T11:44:41.389-0500 [TRACE] provider.terraform-provider-ovirt: Sending request downstream: @module=sdk.proto tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=2494c865-2d54-7a91-54ed-3aca054ba1d0 tf_resource_type=ovirt_template tf_rpc=ApplyResourceChange @caller=/path/of/.go/pkg/mod/github.com/hashicorp/[email protected]/tfprotov5/internal/tf5serverlogging/downstream_request.go:17 tf_proto_version=5.3 timestamp=2025-02-14T11:44:41.389-0500
2025-02-14T11:44:41.389-0500 [TRACE] provider.terraform-provider-ovirt: Calling downstream: @module=sdk.helper_schema tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_template tf_rpc=ApplyResourceChange @caller=/path/of/.go/pkg/mod/github.com/hashicorp/terraform-plugin-sdk/[email protected]/helper/schema/resource.go:805 tf_req_id=2494c865-2d54-7a91-54ed-3aca054ba1d0 timestamp=2025-02-14T11:44:41.389-0500
2025-02-14T11:44:41.390-0500 [INFO]  provider.terraform-provider-ovirt: Removing template 9c7266b8-87c0-4d8e-9be5-b73a5f46b4fd...: tf_req_id=2494c865-2d54-7a91-54ed-3aca054ba1d0 @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_template tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 timestamp=2025-02-14T11:44:41.389-0500
2025-02-14T11:44:41.440-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for job with correlation ID disk_create_BdRZM to finish, retrying... (pending: job for correlation ID disk_create_BdRZM still pending): @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_rpc=ApplyResourceChange timestamp=2025-02-14T11:44:41.440-0500
2025-02-14T11:44:41.641-0500 [INFO]  provider.terraform-provider-ovirt: Completed removing template 9c7266b8-87c0-4d8e-9be5-b73a5f46b4fd.: tf_resource_type=ovirt_template tf_rpc=ApplyResourceChange @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=2494c865-2d54-7a91-54ed-3aca054ba1d0 @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 timestamp=2025-02-14T11:44:41.641-0500
2025-02-14T11:44:41.642-0500 [TRACE] provider.terraform-provider-ovirt: Called downstream: tf_req_id=2494c865-2d54-7a91-54ed-3aca054ba1d0 tf_resource_type=ovirt_template @caller=/path/of/.go/pkg/mod/github.com/hashicorp/terraform-plugin-sdk/[email protected]/helper/schema/resource.go:807 @module=sdk.helper_schema tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_rpc=ApplyResourceChange timestamp=2025-02-14T11:44:41.641-0500
2025-02-14T11:44:41.642-0500 [TRACE] provider.terraform-provider-ovirt: Received downstream response: tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_duration_ms=252 tf_req_id=2494c865-2d54-7a91-54ed-3aca054ba1d0 @module=sdk.proto diagnostic_error_count=0 diagnostic_warning_count=0 tf_proto_version=5.3 tf_resource_type=ovirt_template tf_rpc=ApplyResourceChange @caller=/path/of/.go/pkg/mod/github.com/hashicorp/[email protected]/tfprotov5/internal/tf5serverlogging/downstream_request.go:37 timestamp=2025-02-14T11:44:41.641-0500
--
2025-02-14T11:44:42.008-0500 [TRACE] provider.terraform-provider-ovirt: Sending request downstream: tf_rpc=ApplyResourceChange @caller=/path/of/.go/pkg/mod/github.com/hashicorp/[email protected]/tfprotov5/internal/tf5serverlogging/downstream_request.go:17 tf_proto_version=5.3 tf_resource_type=ovirt_vm @module=sdk.proto tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=7058d11d-d4b3-c590-4ee1-09315ee2d080 timestamp=2025-02-14T11:44:42.008-0500
2025-02-14T11:44:42.008-0500 [TRACE] provider.terraform-provider-ovirt: Calling downstream: tf_req_id=7058d11d-d4b3-c590-4ee1-09315ee2d080 @caller=/path/of/.go/pkg/mod/github.com/hashicorp/terraform-plugin-sdk/[email protected]/helper/schema/resource.go:836 @module=sdk.helper_schema tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_vm tf_rpc=ApplyResourceChange timestamp=2025-02-14T11:44:42.008-0500
2025-02-14T11:44:42.008-0500 [INFO]  provider.terraform-provider-ovirt: Creating VM nixos-template...: @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 tf_req_id=7058d11d-d4b3-c590-4ee1-09315ee2d080 tf_resource_type=ovirt_vm tf_rpc=ApplyResourceChange @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt timestamp=2025-02-14T11:44:42.008-0500
2025-02-14T11:44:42.498-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for job with correlation ID disk_create_BdRZM to finish, retrying... (pending: job for correlation ID disk_create_BdRZM still pending): tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt tf_rpc=ApplyResourceChange timestamp=2025-02-14T11:44:42.497-0500
2025-02-14T11:44:42.938-0500 [INFO]  provider.terraform-provider-ovirt: Completed creating VM nixos-template.: @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=7058d11d-d4b3-c590-4ee1-09315ee2d080 tf_resource_type=ovirt_vm tf_rpc=ApplyResourceChange timestamp=2025-02-14T11:44:42.938-0500
2025-02-14T11:44:42.938-0500 [TRACE] provider.terraform-provider-ovirt: Called downstream: @caller=/path/of/.go/pkg/mod/github.com/hashicorp/terraform-plugin-sdk/[email protected]/helper/schema/resource.go:838 tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_rpc=ApplyResourceChange @module=sdk.helper_schema tf_req_id=7058d11d-d4b3-c590-4ee1-09315ee2d080 tf_resource_type=ovirt_vm timestamp=2025-02-14T11:44:42.938-0500
2025-02-14T11:44:42.938-0500 [TRACE] provider.terraform-provider-ovirt: Received downstream response: @caller=/path/of/.go/pkg/mod/github.com/hashicorp/[email protected]/tfprotov5/internal/tf5serverlogging/downstream_request.go:37 tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=7058d11d-d4b3-c590-4ee1-09315ee2d080 tf_resource_type=ovirt_vm tf_rpc=ApplyResourceChange @module=sdk.proto diagnostic_error_count=0 diagnostic_warning_count=0 tf_proto_version=5.3 tf_req_duration_ms=930 timestamp=2025-02-14T11:44:42.938-0500
--
2025-02-14T11:44:43.477-0500 [TRACE] provider.terraform-provider-ovirt: Calling downstream: tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=1614fac6-b70c-974a-41cc-28aeb046609d tf_resource_type=ovirt_vm tf_rpc=ApplyResourceChange @caller=/path/of/.go/pkg/mod/github.com/hashicorp/terraform-plugin-sdk/[email protected]/helper/schema/resource.go:836 @module=sdk.helper_schema timestamp=2025-02-14T11:44:43.477-0500
2025-02-14T11:44:43.477-0500 [INFO]  provider.terraform-provider-ovirt: Creating VM nixos-test...: tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_vm tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 @module=ovirt tf_req_id=1614fac6-b70c-974a-41cc-28aeb046609d timestamp=2025-02-14T11:44:43.477-0500
2025-02-14T11:44:43.633-0500 [DEBUG] provider.terraform-provider-ovirt: Failed creating VM nixos-test, retrying... (Fault reason is "Operation Failed". Fault detail is "[Cannot add VM. Template ${TemplateName} is being created.]". HTTP response code is "409". HTTP response message is "409 Conflict".): tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 tf_req_id=1614fac6-b70c-974a-41cc-28aeb046609d tf_resource_type=ovirt_vm @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt timestamp=2025-02-14T11:44:43.633-0500
2025-02-14T11:44:44.562-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for job with correlation ID disk_create_BdRZM to finish, retrying... (pending: job for correlation ID disk_create_BdRZM still pending): @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange timestamp=2025-02-14T11:44:44.562-0500
2025-02-14T11:44:44.767-0500 [DEBUG] provider.terraform-provider-ovirt: Failed creating VM nixos-test, retrying... (Fault reason is "Operation Failed". Fault detail is "[Cannot add VM. Template ${TemplateName} is being created.]". HTTP response code is "409". HTTP response message is "409 Conflict".): tf_rpc=ApplyResourceChange @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=1614fac6-b70c-974a-41cc-28aeb046609d tf_resource_type=ovirt_vm @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 timestamp=2025-02-14T11:44:44.767-0500
2025-02-14T11:44:47.695-0500 [INFO]  provider.terraform-provider-ovirt: Completed creating VM nixos-test.: tf_req_id=1614fac6-b70c-974a-41cc-28aeb046609d tf_resource_type=ovirt_vm tf_rpc=ApplyResourceChange @module=ovirt @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 tf_provider_addr=registry.terraform.io/oVirt/ovirt timestamp=2025-02-14T11:44:47.695-0500
2025-02-14T11:44:47.695-0500 [TRACE] provider.terraform-provider-ovirt: Called downstream: tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=1614fac6-b70c-974a-41cc-28aeb046609d tf_resource_type=ovirt_vm @caller=/path/of/.go/pkg/mod/github.com/hashicorp/terraform-plugin-sdk/[email protected]/helper/schema/resource.go:838 @module=sdk.helper_schema tf_rpc=ApplyResourceChange timestamp=2025-02-14T11:44:47.695-0500
--
2025-02-14T12:13:48.236-0500 [INFO]  provider.terraform-provider-ovirt: Finalizing image for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624...: tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 timestamp=2025-02-14T12:13:48.236-0500
2025-02-14T12:13:48.327-0500 [INFO]  provider.terraform-provider-ovirt: Completed finalizing image for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624.: @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 tf_provider_addr=registry.terraform.io/oVirt/ovirt @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:48.327-0500
2025-02-14T12:13:48.327-0500 [INFO]  provider.terraform-provider-ovirt: Waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624...: tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 @module=ovirt tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:48.327-0500
2025-02-14T12:13:48.387-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase finalizing_success): @module=ovirt tf_resource_type=ovirt_disk_from_image tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 tf_provider_addr=registry.terraform.io/oVirt/ovirt timestamp=2025-02-14T12:13:48.386-0500
2025-02-14T12:13:48.449-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase finalizing_success): tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange tf_provider_addr=registry.terraform.io/oVirt/ovirt @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 timestamp=2025-02-14T12:13:48.449-0500
2025-02-14T12:13:48.493-0500 [TRACE] dag/walk: vertex "ovirt_disk_attachment.nixos-template" is waiting for "ovirt_disk_attachment.nixos-template (expand)"
2025-02-14T12:13:48.493-0500 [TRACE] dag/walk: vertex "ovirt_disk_attachment.nixos-test" is waiting for "ovirt_disk_attachment.nixos-test (expand)"
2025-02-14T12:13:48.493-0500 [TRACE] dag/walk: vertex "root" is waiting for "provider[\"registry.terraform.io/ovirt/ovirt\"] (close)"
--
2025-02-14T12:13:48.494-0500 [TRACE] dag/walk: vertex "ovirt_disk_attachment.nixos-test (expand)" is waiting for "ovirt_disk_from_image.nixos-template"
2025-02-14T12:13:48.494-0500 [TRACE] dag/walk: vertex "ovirt_vm_start.nixos-test (expand)" is waiting for "ovirt_disk_attachment.nixos-test"
2025-02-14T12:13:48.494-0500 [TRACE] dag/walk: vertex "provider[\"registry.terraform.io/ovirt/ovirt\"] (close)" is waiting for "ovirt_vm_start.nixos-test"
2025-02-14T12:13:48.510-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase finalizing_success): @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 timestamp=2025-02-14T12:13:48.510-0500
2025-02-14T12:13:48.572-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase finalizing_success): @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:48.572-0500
2025-02-14T12:13:48.631-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase finalizing_success): tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image @module=ovirt @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:48.631-0500
2025-02-14T12:13:48.695-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase finalizing_success): @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_disk_from_image timestamp=2025-02-14T12:13:48.695-0500
2025-02-14T12:13:48.753-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase finalizing_success): @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_rpc=ApplyResourceChange tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image timestamp=2025-02-14T12:13:48.752-0500
2025-02-14T12:13:48.812-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase finalizing_success): tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt timestamp=2025-02-14T12:13:48.812-0500
2025-02-14T12:13:48.869-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase finalizing_success): @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 timestamp=2025-02-14T12:13:48.869-0500
2025-02-14T12:13:48.928-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase finalizing_success): tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt timestamp=2025-02-14T12:13:48.928-0500
2025-02-14T12:13:48.989-0500 [INFO]  provider.terraform-provider-ovirt: Giving up waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624 (timeout: maximum retries reached while waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, giving up (pending: Transfer is in phase finalizing_success)): @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:48.989-0500
2025-02-14T12:13:48.990-0500 [INFO]  provider.terraform-provider-ovirt: Canceling transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624...: tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 @module=ovirt tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:48.989-0500
2025-02-14T12:13:49.098-0500 [INFO]  provider.terraform-provider-ovirt: Completed canceling transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624.: @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:49.098-0500
2025-02-14T12:13:49.098-0500 [INFO]  provider.terraform-provider-ovirt: Waiting for aborting image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624...: tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_rpc=ApplyResourceChange tf_resource_type=ovirt_disk_from_image @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt timestamp=2025-02-14T12:13:49.098-0500
2025-02-14T12:13:49.160-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for aborting image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase cancelled_user): tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image tf_provider_addr=registry.terraform.io/oVirt/ovirt timestamp=2025-02-14T12:13:49.160-0500
2025-02-14T12:13:49.220-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for aborting image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase cancelled_user): tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt timestamp=2025-02-14T12:13:49.220-0500
2025-02-14T12:13:49.277-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for aborting image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase cancelled_user): @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt tf_resource_type=ovirt_disk_from_image tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_rpc=ApplyResourceChange tf_provider_addr=registry.terraform.io/oVirt/ovirt timestamp=2025-02-14T12:13:49.277-0500
2025-02-14T12:13:49.338-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for aborting image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase cancelled_user): @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:49.338-0500
2025-02-14T12:13:49.397-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for aborting image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase cancelled_user): @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 timestamp=2025-02-14T12:13:49.397-0500
2025-02-14T12:13:49.464-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for aborting image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase cancelled_user): tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 @module=ovirt tf_resource_type=ovirt_disk_from_image timestamp=2025-02-14T12:13:49.463-0500
2025-02-14T12:13:49.521-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for aborting image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase cancelled_user): @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_rpc=ApplyResourceChange @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_disk_from_image timestamp=2025-02-14T12:13:49.521-0500
2025-02-14T12:13:49.581-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for aborting image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase cancelled_user): tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt tf_resource_type=ovirt_disk_from_image tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 timestamp=2025-02-14T12:13:49.581-0500
2025-02-14T12:13:49.643-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for aborting image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase cancelled_user): tf_resource_type=ovirt_disk_from_image @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:49.643-0500
2025-02-14T12:13:49.703-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for aborting image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase cancelled_user): tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt tf_resource_type=ovirt_disk_from_image tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 timestamp=2025-02-14T12:13:49.703-0500
2025-02-14T12:13:49.761-0500 [INFO]  provider.terraform-provider-ovirt: Giving up waiting for aborting image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624 (timeout: maximum retries reached while waiting for aborting image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, giving up (pending: Transfer is in phase cancelled_user)): @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_disk_from_image @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:49.761-0500
2025-02-14T12:13:49.761-0500 [WARN]  provider.terraform-provider-ovirt: failed to wait for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624 to return to OK state after aborting transfer: @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:37 tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_disk_from_image timestamp=2025-02-14T12:13:49.761-0500
2025-02-14T12:13:49.761-0500 [INFO]  provider.terraform-provider-ovirt: Waiting for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624 to become OK...: @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 tf_provider_addr=registry.terraform.io/oVirt/ovirt timestamp=2025-02-14T12:13:49.761-0500
2025-02-14T12:13:49.761-0500 [INFO]  provider.terraform-provider-ovirt: Getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624...: tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 @module=ovirt timestamp=2025-02-14T12:13:49.761-0500
2025-02-14T12:13:49.858-0500 [INFO]  provider.terraform-provider-ovirt: Completed getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624.: @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange tf_provider_addr=registry.terraform.io/oVirt/ovirt timestamp=2025-02-14T12:13:49.858-0500
2025-02-14T12:13:49.858-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624 to become OK, retrying... (pending: disk status is locked, not ok): @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image timestamp=2025-02-14T12:13:49.858-0500
2025-02-14T12:13:49.858-0500 [INFO]  provider.terraform-provider-ovirt: Getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624...: @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 timestamp=2025-02-14T12:13:49.858-0500
2025-02-14T12:13:49.950-0500 [INFO]  provider.terraform-provider-ovirt: Completed getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624.: @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 tf_resource_type=ovirt_disk_from_image timestamp=2025-02-14T12:13:49.950-0500
2025-02-14T12:13:49.950-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624 to become OK, retrying... (pending: disk status is locked, not ok): tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_disk_from_image @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:49.950-0500
2025-02-14T12:13:49.951-0500 [INFO]  provider.terraform-provider-ovirt: Getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624...: @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:49.950-0500
2025-02-14T12:13:50.050-0500 [INFO]  provider.terraform-provider-ovirt: Completed getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624.: @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:50.050-0500
2025-02-14T12:13:50.050-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624 to become OK, retrying... (pending: disk status is locked, not ok): tf_resource_type=ovirt_disk_from_image @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:50.050-0500
2025-02-14T12:13:50.050-0500 [INFO]  provider.terraform-provider-ovirt: Getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624...: @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:50.050-0500
2025-02-14T12:13:50.195-0500 [INFO]  provider.terraform-provider-ovirt: Completed getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624.: tf_rpc=ApplyResourceChange @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 tf_provider_addr=registry.terraform.io/oVirt/ovirt timestamp=2025-02-14T12:13:50.195-0500
2025-02-14T12:13:50.195-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624 to become OK, retrying... (pending: disk status is locked, not ok): tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_disk_from_image @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:50.195-0500
2025-02-14T12:13:50.195-0500 [INFO]  provider.terraform-provider-ovirt: Getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624...: @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:50.195-0500
2025-02-14T12:13:50.309-0500 [INFO]  provider.terraform-provider-ovirt: Completed getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624.: tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 timestamp=2025-02-14T12:13:50.309-0500
2025-02-14T12:13:50.309-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624 to become OK, retrying... (pending: disk status is locked, not ok): tf_provider_addr=registry.terraform.io/oVirt/ovirt @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 timestamp=2025-02-14T12:13:50.309-0500
2025-02-14T12:13:50.309-0500 [INFO]  provider.terraform-provider-ovirt: Getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624...: tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 @module=ovirt tf_resource_type=ovirt_disk_from_image tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 timestamp=2025-02-14T12:13:50.309-0500
2025-02-14T12:13:50.400-0500 [INFO]  provider.terraform-provider-ovirt: Completed getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624.: tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 tf_provider_addr=registry.terraform.io/oVirt/ovirt @module=ovirt tf_resource_type=ovirt_disk_from_image timestamp=2025-02-14T12:13:50.400-0500
2025-02-14T12:13:50.400-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624 to become OK, retrying... (pending: disk status is locked, not ok): tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_disk_from_image timestamp=2025-02-14T12:13:50.400-0500
2025-02-14T12:13:50.400-0500 [INFO]  provider.terraform-provider-ovirt: Getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624...: tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 timestamp=2025-02-14T12:13:50.400-0500
2025-02-14T12:13:50.486-0500 [INFO]  provider.terraform-provider-ovirt: Completed getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624.: @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:50.486-0500
2025-02-14T12:13:50.486-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624 to become OK, retrying... (pending: disk status is locked, not ok): tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:50.486-0500
2025-02-14T12:13:50.486-0500 [INFO]  provider.terraform-provider-ovirt: Getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624...: @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:50.486-0500
2025-02-14T12:13:50.581-0500 [INFO]  provider.terraform-provider-ovirt: Completed getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624.: @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 @module=ovirt tf_rpc=ApplyResourceChange tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image timestamp=2025-02-14T12:13:50.581-0500
2025-02-14T12:13:50.581-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624 to become OK, retrying... (pending: disk status is locked, not ok): tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:50.581-0500
2025-02-14T12:13:50.581-0500 [INFO]  provider.terraform-provider-ovirt: Getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624...: @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 timestamp=2025-02-14T12:13:50.581-0500
2025-02-14T12:13:50.677-0500 [INFO]  provider.terraform-provider-ovirt: Completed getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624.: @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image timestamp=2025-02-14T12:13:50.677-0500
2025-02-14T12:13:50.677-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624 to become OK, retrying... (pending: disk status is locked, not ok): @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:50.677-0500
2025-02-14T12:13:50.677-0500 [INFO]  provider.terraform-provider-ovirt: Getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624...: tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt timestamp=2025-02-14T12:13:50.677-0500
2025-02-14T12:13:50.767-0500 [INFO]  provider.terraform-provider-ovirt: Completed getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624.: @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 tf_provider_addr=registry.terraform.io/oVirt/ovirt timestamp=2025-02-14T12:13:50.767-0500
2025-02-14T12:13:50.767-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624 to become OK, retrying... (pending: disk status is locked, not ok): tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 timestamp=2025-02-14T12:13:50.767-0500
2025-02-14T12:13:50.767-0500 [INFO]  provider.terraform-provider-ovirt: Getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624...: tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 timestamp=2025-02-14T12:13:50.767-0500
2025-02-14T12:13:50.830-0500 [INFO]  provider.terraform-provider-ovirt: Completed getting disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624.: @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 @module=ovirt tf_resource_type=ovirt_disk_from_image tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:50.830-0500
2025-02-14T12:13:50.830-0500 [INFO]  provider.terraform-provider-ovirt: Giving up waiting for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624 to become OK (timeout: maximum retries reached while waiting for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624 to become OK, giving up (pending: disk status is locked, not ok)): tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_rpc=ApplyResourceChange @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 timestamp=2025-02-14T12:13:50.830-0500

In particular, notice the small durations between these events:

2025-02-14T12:13:48.387-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase finalizing_success): @module=ovirt tf_resource_type=ovirt_disk_from_image tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 tf_provider_addr=registry.terraform.io/oVirt/ovirt timestamp=2025-02-14T12:13:48.386-0500
2025-02-14T12:13:48.449-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase finalizing_success): tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange tf_provider_addr=registry.terraform.io/oVirt/ovirt @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 timestamp=2025-02-14T12:13:48.449-0500
2025-02-14T12:13:48.510-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase finalizing_success): @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 timestamp=2025-02-14T12:13:48.510-0500
2025-02-14T12:13:48.572-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase finalizing_success): @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:48.572-0500
2025-02-14T12:13:48.631-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase finalizing_success): tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image @module=ovirt @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:48.631-0500
2025-02-14T12:13:48.695-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase finalizing_success): @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_disk_from_image timestamp=2025-02-14T12:13:48.695-0500
2025-02-14T12:13:48.753-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase finalizing_success): @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_rpc=ApplyResourceChange tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image timestamp=2025-02-14T12:13:48.752-0500
2025-02-14T12:13:48.812-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase finalizing_success): tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt tf_provider_addr=registry.terraform.io/oVirt/ovirt timestamp=2025-02-14T12:13:48.812-0500
2025-02-14T12:13:48.869-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase finalizing_success): @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 timestamp=2025-02-14T12:13:48.869-0500
2025-02-14T12:13:48.928-0500 [DEBUG] provider.terraform-provider-ovirt: Still waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, retrying... (pending: Transfer is in phase finalizing_success): tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:23 @module=ovirt timestamp=2025-02-14T12:13:48.928-0500
2025-02-14T12:13:48.989-0500 [INFO]  provider.terraform-provider-ovirt: Giving up waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624 (timeout: maximum retries reached while waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, giving up (pending: Transfer is in phase finalizing_success)): @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 @module=ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_disk_from_image tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:48.989-0500
2025-02-14T12:13:50.830-0500 [INFO]  provider.terraform-provider-ovirt: Image upload to new disk failed, removing created disk (timeout: maximum retries reached while waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, giving up (pending: Transfer is in phase finalizing_success)): @module=ovirt tf_rpc=ApplyResourceChange tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 tf_resource_type=ovirt_disk_from_image @caller=/path/of/src/github.com/terraform-provider-ovirt/internal/ovirt/logger.go:30 timestamp=2025-02-14T12:13:50.830-0500
2025-02-14T12:13:52.329-0500 [ERROR] provider.terraform-provider-ovirt: Response contains error diagnostic: diagnostic_severity=ERROR tf_proto_version=5.3 tf_req_id=b0b9fe50-ee0f-93fa-f524-3090ea8d8d50 diagnostic_detail="timeout: maximum retries reached while waiting for finalizing image transfer for disk 4e7bf110-a5b0-444c-ab7a-ea44eea97624, giving up (pending: Transfer is in phase finalizing_success)" diagnostic_summary="Failed to create disk." tf_provider_addr=registry.terraform.io/oVirt/ovirt tf_resource_type=ovirt_disk_from_image @caller=/path/of/.go/pkg/mod/github.com/hashicorp/[email protected]/tfprotov5/internal/diag/diagnostics.go:55 @module=sdk.proto tf_rpc=ApplyResourceChange timestamp=2025-02-14T12:13:52.329-0500

There are similarly short durations between checks for "aborting image transfer".

To Reproduce

I have tested this on both v2.1.5 and master. The issue occurs with both raw and qcow images. Not sure how to reproduce outside of my environment.

Please note that, in my environment, uploading these raw and qcow images using the oVirt web UI succeed.

Expected behavior

Disk upload completes successfully. Disk upload status checks wait more than a few hundredths of a second before retrying.

Thanks in advance for any help you can offer.