issue with changeOfferingForVolume Api call

### problem

Issue with changeOfferingForVolume api call.

https://cloudstack.apache.org/api/apidocs-4.22/apis/changeOfferingForVolume.html

Api call fails even though it has performed the job successfully

### versions

ACS 4.22.1

### The steps to reproduce the bug

Steps to reproduce the issue

1. Have a cloudstack env with 2 primary storages ( p1 , p2 )

2. Assign tags to primary storage ( t1, t2)

3. Create disk offerings with storage tags t1 and t2

4. Deploy a vm with data disk offering which has tag t1 > stop the vm

5. Make sure the global setting "match.storage.pool.tags.with.disk.offering" is set to true

6. Execute the api

https://cloudstack.apache.org/api/apidocs-4.22/apis/changeOfferingForVolume.html

provide the disk offering which has tag t2 and set the automigrate to tue

```
(localcloud) 🐱 > change offeringforvolume id=f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd diskofferingid=99345133-608e-4666-ae08-b20cfe04c496 automigrate=true
{
"account": "admin",
"accountid": "79a62939-80f7-11f1-9fc6-1e00a000048d",
"cmd": "org.apache.cloudstack.api.command.user.volume.ChangeOfferingForVolumeCmd",
"completed": "2026-07-29T08:41:14+0000",
"created": "2026-07-29T08:41:14+0000",
"domainid": "22a3e371-80f7-11f1-9fc6-1e00a000048d",
"domainpath": "ROOT",
"jobid": "19c731f9-6bae-4ceb-9972-bd92eb862677",
"jobprocstatus": 0,
"jobresult": {
"errorcode": 431,
"errortext": "Selected disk offering fd706ed7-3798-4fae-921b-57a0840c72f6 does not have tags as in existing disk offering of volume f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd"
},
"jobresultcode": 431,
"jobresulttype": "object",
"jobstatus": 2,
"userid": "79a7388b-80f7-11f1-9fc6-1e00a000048d"
}
```

Logs
```
root@ref-trl-n6-k:~# cat /var/log/cloudstack/management/management-server.log |grep -i "logid:19c731f9"
2026-07-29 08:41:14,531 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl$5] (API-Job-Executor-125:[ctx-d2415054, job-6600]) (logid:19c731f9) Executing AsyncJob {"accountId":2,"cmd":"org.apache.cloudstack.api.command.user.volume.ChangeOfferingForVolumeCmd","cmdInfo":"{\"expires\":\"2026-07-29T08:56:13Z\",\"apiKey\":\"LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q\",\"signature\":\"5R9GHFiDL20UC18+OJjmLys\/g4E\\u003d\",\"sessionkey\":\"240D6gyzghTtzA8GReUc8LADKoQ\",\"httpmethod\":\"POST\",\"ctxAccountId\":\"2\",\"uuid\":\"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd\",\"automigrate\":\"true\",\"cmdEventType\":\"VOLUME.CHANGE.DISK.OFFERING\",\"diskofferingid\":\"99345133-608e-4666-ae08-b20cfe04c496\",\"signatureversion\":\"3\",\"response\":\"json\",\"ctxUserId\":\"2\",\"ctxStartEventId\":\"25610\",\"id\":\"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd\",\"ctxDetails\":\"{\\\"interface com.cloud.offering.DiskOffering\\\":\\\"99345133-608e-4666-ae08-b20cfe04c496\\\",\\\"interface com.cloud.storage.Volume\\\":\\\"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd\\\"}\"}","cmdVersion":0,"completeMsid":null,"created":null,"id":6600,"initMsid":32988033189005,"instanceId":null,"instanceType":"None","lastPolled":null,"lastUpdated":null,"processStatus":0,"removed":null,"result":null,"resultCode":0,"status":"IN_PROGRESS","userId":2,"uuid":"19c731f9-6bae-4ceb-9972-bd92eb862677"}
2026-07-29 08:41:14,707 DEBUG [c.c.c.ConfigurationManagerImpl] (API-Job-Executor-125:[ctx-d2415054, job-6600, ctx-f6ae235a]) (logid:19c731f9) Access granted to Account [{"accountName":"admin","id":2,"uuid":"79a62939-80f7-11f1-9fc6-1e00a000048d"}] to disk offering: DiskOffering {"id":268,"name":"k1d2","uuid":"99345133-608e-4666-ae08-b20cfe04c496"}. by AffinityGroupAccessChecker
2026-07-29 08:41:14,772 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-125:[ctx-d2415054, job-6600]) (logid:19c731f9) Complete async job-6600, jobStatus: FAILED, resultCode: 431, result: org.apache.cloudstack.api.response.ExceptionResponse/null/{"uuidList":[],"errorcode":"431","errortext":"Selected disk offering fd706ed7-3798-4fae-921b-57a0840c72f6 does not have tags as in existing disk offering of volume f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd"}
2026-07-29 08:41:14,773 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-125:[ctx-d2415054, job-6600]) (logid:19c731f9) Publish async job-6600 complete on message bus
2026-07-29 08:41:14,773 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-125:[ctx-d2415054, job-6600]) (logid:19c731f9) Wake up jobs related to job-6600
2026-07-29 08:41:14,773 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-125:[ctx-d2415054, job-6600]) (logid:19c731f9) Update db status for job-6600
2026-07-29 08:41:14,777 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-125:[ctx-d2415054, job-6600]) (logid:19c731f9) Wake up jobs joined with job-6600 and disjoin all subjobs created from job- 6600
2026-07-29 08:41:14,788 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl$5] (API-Job-Executor-125:[ctx-d2415054, job-6600]) (logid:19c731f9) Done executing org.apache.cloudstack.api.command.user.volume.ChangeOfferingForVolumeCmd for job-6600
2026-07-29 08:41:14,788 INFO [o.a.c.f.j.i.AsyncJobMonitor] (API-Job-Executor-125:[ctx-d2415054, job-6600]) (logid:19c731f9) Remove job-6600 from job monitoring
```

7. Change the global setting "match.storage.pool.tags.with.disk.offering" is set to false

8. Execute the api call again

```

(localcloud) 🐱 > change offeringforvolume id=f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd diskofferingid=99345133-608e-4666-ae08-b20cfe04c496 automigrate=true
{
"account": "admin",
"accountid": "79a62939-80f7-11f1-9fc6-1e00a000048d",
"cmd": "org.apache.cloudstack.api.command.user.volume.ChangeOfferingForVolumeCmd",
"completed": "2026-07-29T08:42:32+0000",
"created": "2026-07-29T08:42:28+0000",
"domainid": "22a3e371-80f7-11f1-9fc6-1e00a000048d",
"domainpath": "ROOT",
"jobid": "091aafd4-7693-4faf-975f-5786880821c1",
"jobprocstatus": 0,
"jobresult": {
"errorcode": 530,
"errortext": "Volume change offering operation failed for volume: Volume {\"id\":680,\"instanceId\":586,\"name\":\"DATA-586\",\"uuid\":\"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd\",\"volumeType\":\"DATADISK\"} migration failed to storage pool StoragePool {\"id\":2,\"name\":\"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2\",\"poolType\":\"NetworkFilesystem\",\"uuid\":\"da8d7c9d-7203-3f5f-86c0-785ffa3ed956\"} due to Volume Volume {\"id\":680,\"instanceId\":586,\"name\":\"DATA-586\",\"uuid\":\"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd\",\"volumeType\":\"DATADISK\"} is already on the destination storage pool"
},
"jobresultcode": 530,
"jobresulttype": "object",
"jobstatus": 2,
"userid": "79a7388b-80f7-11f1-9fc6-1e00a000048d"
```

logs

```
root@ref-trl-~# cat /var/log/cloudstack/management/management-server.log |grep -i "logid:19c731f9"
2026-07-29 08:41:14,531 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl$5] (API-Job-Executor-125:[ctx-d2415054, job-6600]) (logid:19c731f9) Executing AsyncJob {"accountId":2,"cmd":"org.apache.cloudstack.api.command.user.volume.ChangeOfferingForVolumeCmd","cmdInfo":"{\"expires\":\"2026-07-29T08:56:13Z\",\"apiKey\":\"LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q\",\"signature\":\"5R9GHFiDL20UC18+OJjmLys\/g4E\\u003d\",\"sessionkey\":\"240D6gyzghTtzA8GReUc8LADKoQ\",\"httpmethod\":\"POST\",\"ctxAccountId\":\"2\",\"uuid\":\"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd\",\"automigrate\":\"true\",\"cmdEventType\":\"VOLUME.CHANGE.DISK.OFFERING\",\"diskofferingid\":\"99345133-608e-4666-ae08-b20cfe04c496\",\"signatureversion\":\"3\",\"response\":\"json\",\"ctxUserId\":\"2\",\"ctxStartEventId\":\"25610\",\"id\":\"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd\",\"ctxDetails\":\"{\\\"interface com.cloud.offering.DiskOffering\\\":\\\"99345133-608e-4666-ae08-b20cfe04c496\\\",\\\"interface com.cloud.storage.Volume\\\":\\\"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd\\\"}\"}","cmdVersion":0,"completeMsid":null,"created":null,"id":6600,"initMsid":32988033189005,"instanceId":null,"instanceType":"None","lastPolled":null,"lastUpdated":null,"processStatus":0,"removed":null,"result":null,"resultCode":0,"status":"IN_PROGRESS","userId":2,"uuid":"19c731f9-6bae-4ceb-9972-bd92eb862677"}
2026-07-29 08:41:14,707 DEBUG [c.c.c.ConfigurationManagerImpl] (API-Job-Executor-125:[ctx-d2415054, job-6600, ctx-f6ae235a]) (logid:19c731f9) Access granted to Account [{"accountName":"admin","id":2,"uuid":"79a62939-80f7-11f1-9fc6-1e00a000048d"}] to disk offering: DiskOffering {"id":268,"name":"k1d2","uuid":"99345133-608e-4666-ae08-b20cfe04c496"}. by AffinityGroupAccessChecker
2026-07-29 08:41:14,772 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-125:[ctx-d2415054, job-6600]) (logid:19c731f9) Complete async job-6600, jobStatus: FAILED, resultCode: 431, result: org.apache.cloudstack.api.response.ExceptionResponse/null/{"uuidList":[],"errorcode":"431","errortext":"Selected disk offering fd706ed7-3798-4fae-921b-57a0840c72f6 does not have tags as in existing disk offering of volume f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd"}
2026-07-29 08:41:14,773 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-125:[ctx-d2415054, job-6600]) (logid:19c731f9) Publish async job-6600 complete on message bus
2026-07-29 08:41:14,773 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-125:[ctx-d2415054, job-6600]) (logid:19c731f9) Wake up jobs related to job-6600
2026-07-29 08:41:14,773 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-125:[ctx-d2415054, job-6600]) (logid:19c731f9) Update db status for job-6600
2026-07-29 08:41:14,777 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-125:[ctx-d2415054, job-6600]) (logid:19c731f9) Wake up jobs joined with job-6600 and disjoin all subjobs created from job- 6600
2026-07-29 08:41:14,788 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl$5] (API-Job-Executor-125:[ctx-d2415054, job-6600]) (logid:19c731f9) Done executing org.apache.cloudstack.api.command.user.volume.ChangeOfferingForVolumeCmd for job-6600
2026-07-29 08:41:14,788 INFO [o.a.c.f.j.i.AsyncJobMonitor] (API-Job-Executor-125:[ctx-d2415054, job-6600]) (logid:19c731f9) Remove job-6600 from job monitoring
root@ref-trl-n6-k-Mu26-wei-zhou-mgmt1:~# cat /var/log/cloudstack/management/management-server.log |grep -i "logid:091aafd4"
2026-07-29 08:42:28,170 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl$5] (API-Job-Executor-1:[ctx-b17e8967, job-6601]) (logid:091aafd4) Executing AsyncJob {"accountId":2,"cmd":"org.apache.cloudstack.api.command.user.volume.ChangeOfferingForVolumeCmd","cmdInfo":"{\"expires\":\"2026-07-29T08:57:27Z\",\"apiKey\":\"LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q\",\"signature\":\"eEWG\/t+8yOeRw38xlErau\/xWxqM\\u003d\",\"sessionkey\":\"--p3FV9YJoENFWGX1dBXWCmcViA\",\"httpmethod\":\"POST\",\"ctxAccountId\":\"2\",\"uuid\":\"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd\",\"automigrate\":\"true\",\"cmdEventType\":\"VOLUME.CHANGE.DISK.OFFERING\",\"diskofferingid\":\"99345133-608e-4666-ae08-b20cfe04c496\",\"signatureversion\":\"3\",\"response\":\"json\",\"ctxUserId\":\"2\",\"ctxStartEventId\":\"25615\",\"id\":\"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd\",\"ctxDetails\":\"{\\\"interface com.cloud.offering.DiskOffering\\\":\\\"99345133-608e-4666-ae08-b20cfe04c496\\\",\\\"interface com.cloud.storage.Volume\\\":\\\"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd\\\"}\"}","cmdVersion":0,"completeMsid":null,"created":null,"id":6601,"initMsid":32988033189005,"instanceId":null,"instanceType":"None","lastPolled":null,"lastUpdated":null,"processStatus":0,"removed":null,"result":null,"resultCode":0,"status":"IN_PROGRESS","userId":2,"uuid":"091aafd4-7693-4faf-975f-5786880821c1"}
2026-07-29 08:42:28,180 DEBUG [c.c.c.ConfigurationManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Access granted to Account [{"accountName":"admin","id":2,"uuid":"79a62939-80f7-11f1-9fc6-1e00a000048d"}] to disk offering: DiskOffering {"id":268,"name":"k1d2","uuid":"99345133-608e-4666-ae08-b20cfe04c496"}. by AffinityGroupAccessChecker
2026-07-29 08:42:28,188 DEBUG [o.a.c.e.o.VolumeOrchestrator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Found [0] snapshots [[]] that have checkpoints for volume with id [679].
2026-07-29 08:42:28,213 INFO [c.c.s.ManagementServerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Volume Volume {"id":679,"instanceId":586,"name":"DATA-586","uuid":"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd","volumeType":"DATADISK"} isn't attached to any running Instance. Looking for storage pools in the cluster to which this volumes can be migrated.
2026-07-29 08:42:28,219 DEBUG [o.a.c.s.a.LocalStoragePoolAllocator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) LocalStoragePoolAllocator is returning null since the disk profile does not use local storage and bypassStorageTypeCheck is false.
2026-07-29 08:42:28,220 INFO [o.a.c.s.a.LocalStoragePoolAllocator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) There are no pools to reorder.
2026-07-29 08:42:28,220 DEBUG [o.a.c.s.a.ClusterScopeStoragePoolAllocator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Looking for pools in dc [1], pod [1], cluster [1], and having tags [[t2]]. Disabled pools will be ignored.
2026-07-29 08:42:28,230 DEBUG [o.a.c.s.a.ClusterScopeStoragePoolAllocator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Found pools [[StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"}]] that match with tags [[t2]].
2026-07-29 08:42:28,232 DEBUG [o.a.c.s.a.ClusterScopeStoragePoolAllocator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Checking if storage pool [StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"}] is suitable to disk [DskChr[DATADISK|2147483648|]].
2026-07-29 08:42:28,236 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Pool [StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"}] is compatible with volume [Volume {"id":679,"instanceId":586,"name":"DATA-586","uuid":"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd","volumeType":"DATADISK"}].
2026-07-29 08:42:28,236 INFO [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Storage pool StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} does not supply IOPS capacity, assuming enough capacity
2026-07-29 08:42:28,240 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Checking pool StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} for storage, totalSize: 3757022642176, usedBytes: 2676623409152, usedPct: 0.712432067644327, disable threshold: 0.98
2026-07-29 08:42:28,241 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Destination pool: StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"}
2026-07-29 08:42:28,253 DEBUG [o.a.c.e.o.VolumeOrchestrator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Found [0] snapshots [[]] that have checkpoints for volume with id [679].
2026-07-29 08:42:28,253 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Pool ID for the volume Volume {"id":679,"instanceId":586,"name":"DATA-586","uuid":"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd","volumeType":"DATADISK"} is 1
2026-07-29 08:42:28,255 DEBUG [o.a.c.e.o.VolumeOrchestrator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Found [0] snapshots [[]] that have checkpoints for volume with id [679].
2026-07-29 08:42:28,256 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Found storage pool StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} of type NetworkFilesystem with overprovisioning factor 2
2026-07-29 08:42:28,257 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Total over provisioned capacity calculated is 2 * (3.4170 TB) 3757022642176
2026-07-29 08:42:28,257 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Total capacity of the pool StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} is (6.8340 TB) 7514045284352
2026-07-29 08:42:28,259 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Checking pool: StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} for storage allocation , maxSize : (6.8340 TB) 7514045284352, totalAllocatedSize : (26.77 GB) 28739764432, askingSize : (2.00 GB) 2147483648, allocated disable threshold: 0.98
2026-07-29 08:42:28,259 DEBUG [o.a.c.s.a.ClusterScopeStoragePoolAllocator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Found suitable cluster storage pool [StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"}] to allocate disk [DskChr[DATADISK|2147483648|]] to it, adding to list.
2026-07-29 08:42:28,259 DEBUG [o.a.c.s.a.ClusterScopeStoragePoolAllocator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) [ClusterScopeStoragePoolAllocator] is returning [1] suitable storage pools [[StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"}]].
2026-07-29 08:42:28,259 INFO [o.a.c.s.a.ClusterScopeStoragePoolAllocator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Reordering [1] pools
2026-07-29 08:42:28,260 INFO [o.a.c.s.a.ClusterScopeStoragePoolAllocator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Using volume allocation algorithm random to reorder pools.
2026-07-29 08:42:28,260 DEBUG [o.a.c.s.a.ClusterScopeStoragePoolAllocator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Pools to shuffle: [[StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"}]]
2026-07-29 08:42:28,260 DEBUG [o.a.c.s.a.ClusterScopeStoragePoolAllocator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Shuffled list of pools to choose from: [[StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"}]]
2026-07-29 08:42:28,266 DEBUG [o.a.c.s.a.ZoneWideStoragePoolAllocator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Could not find any zone wide storage pool that matched with any of the following tags [[t2]].
2026-07-29 08:42:28,268 DEBUG [o.a.c.s.a.ZoneWideStoragePoolAllocator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) [ZoneWideStoragePoolAllocator] is returning [0] suitable storage pools [[]].
2026-07-29 08:42:28,269 INFO [o.a.c.s.a.ZoneWideStoragePoolAllocator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Reordering [0] pools
2026-07-29 08:42:28,269 INFO [o.a.c.s.a.ZoneWideStoragePoolAllocator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Using volume allocation algorithm random to reorder pools.
2026-07-29 08:42:28,269 DEBUG [o.a.c.s.a.ZoneWideStoragePoolAllocator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Pools to shuffle: [[]]
2026-07-29 08:42:28,269 DEBUG [o.a.c.s.a.ZoneWideStoragePoolAllocator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Shuffled list of pools to choose from: [[]]
2026-07-29 08:42:28,283 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Checking pool StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} for storage, totalSize: 3757022642176, usedBytes: 2676623409152, usedPct: 0.712432067644327, disable threshold: 0.98
2026-07-29 08:42:28,283 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Destination pool: StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"}
2026-07-29 08:42:28,286 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Found storage pool StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} of type NetworkFilesystem with overprovisioning factor 2
2026-07-29 08:42:28,287 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Total over provisioned capacity calculated is 2 * (3.4170 TB) 3757022642176
2026-07-29 08:42:28,287 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Total capacity of the pool StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} is (6.8340 TB) 7514045284352
2026-07-29 08:42:28,288 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Checking pool: StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} for storage allocation , maxSize : (6.8340 TB) 7514045284352, totalAllocatedSize : (26.77 GB) 28739764432, askingSize : (3.00 GB) 3221225472, allocated disable threshold: 0.98
2026-07-29 08:42:28,327 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Pool [StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"}] is compatible with volume [Volume {"id":679,"instanceId":586,"name":"DATA-586","uuid":"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd","volumeType":"DATADISK"}].
2026-07-29 08:42:28,329 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Checking pool StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} for storage, totalSize: 3757022642176, usedBytes: 2676623409152, usedPct: 0.712432067644327, disable threshold: 0.98
2026-07-29 08:42:28,329 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Destination pool: StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"}
2026-07-29 08:42:28,336 DEBUG [o.a.c.e.o.VolumeOrchestrator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Found [0] snapshots [[]] that have checkpoints for volume with id [679].
2026-07-29 08:42:28,337 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Pool ID for the volume Volume {"id":679,"instanceId":586,"name":"DATA-586","uuid":"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd","volumeType":"DATADISK"} is 1
2026-07-29 08:42:28,343 DEBUG [o.a.c.e.o.VolumeOrchestrator] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Found [0] snapshots [[]] that have checkpoints for volume with id [679].
2026-07-29 08:42:28,345 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Found storage pool StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} of type NetworkFilesystem with overprovisioning factor 2
2026-07-29 08:42:28,345 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Total over provisioned capacity calculated is 2 * (3.4170 TB) 3757022642176
2026-07-29 08:42:28,345 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Total capacity of the pool StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} is (6.8340 TB) 7514045284352
2026-07-29 08:42:28,347 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Checking pool: StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} for storage allocation , maxSize : (6.8340 TB) 7514045284352, totalAllocatedSize : (26.77 GB) 28739764432, askingSize : (2.00 GB) 2147483648, allocated disable threshold: 0.98
2026-07-29 08:42:28,349 DEBUG [c.c.u.AccountManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Access granted to Account [{"accountName":"admin","id":2,"uuid":"79a62939-80f7-11f1-9fc6-1e00a000048d"}] to DiskOffering {"id":268,"name":"k1d2","uuid":"99345133-608e-4666-ae08-b20cfe04c496"}. by AffinityGroupAccessChecker
2026-07-29 08:42:28,369 DEBUG [c.c.s.VolumeApiServiceImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Destination storage pool [{}] accepts tags [{}]? {}
2026-07-29 08:42:28,371 WARN [c.c.s.VolumeApiServiceImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) You are migrating a volume [Volume {"id":679,"instanceId":586,"name":"DATA-586","uuid":"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd","volumeType":"DATADISK"}] and changing the disk offering[from DiskOffering {"id":267,"name":"k1d1","uuid":"fd706ed7-3798-4fae-921b-57a0840c72f6"}. to DiskOffering {"id":268,"name":"k1d2","uuid":"99345133-608e-4666-ae08-b20cfe04c496"}.] to reflect this migration. However, the sizes of the volume and the new disk offering are different.
2026-07-29 08:42:28,372 INFO [c.c.s.VolumeApiServiceImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Changing disk offering to [DiskOffering {"id":268,"name":"k1d2","uuid":"99345133-608e-4666-ae08-b20cfe04c496"}.] while migrating volume [Volume {"id":679,"instanceId":586,"name":"DATA-586","uuid":"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd","volumeType":"DATADISK"}].
2026-07-29 08:42:28,425 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Sync job-6602 execution on object VmWorkJobQueue.586
2026-07-29 08:42:31,550 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Sync job-6603 execution on object VmWorkJobQueue.586
2026-07-29 08:42:31,977 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl$5] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603]) (logid:091aafd4) Executing AsyncJob {"accountId":2,"cmd":"com.cloud.vm.VmWorkResizeVolume","cmdInfo":"rO0ABXNyAB9jb20uY2xvdWQudm0uVm1Xb3JrUmVzaXplVm9sdW1lVNN8x9BXvoICAAhKAAtjdXJyZW50U2l6ZUoAB25ld1NpemVaAAhzaHJpbmtPa0oACHZvbHVtZUlkTAAcbmV3SHlwZXJ2aXNvclNuYXBzaG90UmVzZXJ2ZXQAE0xqYXZhL2xhbmcvSW50ZWdlcjtMAApuZXdNYXhJb3BzdAAQTGphdmEvbGFuZy9Mb25nO0wACm5ld01pbklvcHNxAH4AAkwAFG5ld1NlcnZpY2VPZmZlcmluZ0lkcQB-AAJ4cgATY29tLmNsb3VkLnZtLlZtV29ya5-ZtlbwJWdrAgAESgAJYWNjb3VudElkSgAGdXNlcklkSgAEdm1JZEwAC2hhbmRsZXJOYW1ldAASTGphdmEvbGFuZy9TdHJpbmc7eHAAAAAAAAAAAgAAAAAAAAACAAAAAAAAAkp0ABRWb2x1bWVBcGlTZXJ2aWNlSW1wbAAAAACAAAAAAAAAAMAAAAAAAAAAAAAAAqhwcHBzcgAOamF2YS5sYW5nLkxvbmc7i-SQzI8j3wIAAUoABXZhbHVleHIAEGphdmEubGFuZy5OdW1iZXKGrJUdC5TgiwIAAHhwAAAAAAAAAQw","cmdVersion":0,"completeMsid":null,"created":"Wed Jul 29 08:42:31 UTC 2026","id":6603,"initMsid":32988033189005,"instanceId":null,"instanceType":null,"lastPolled":null,"lastUpdated":null,"processStatus":0,"removed":null,"result":null,"resultCode":0,"status":"IN_PROGRESS","userId":2,"uuid":"0f707c80-7c88-46a1-b676-0ebc3186b939"}
2026-07-29 08:42:32,022 DEBUG [c.c.v.VmWorkJobDispatcher] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603]) (logid:091aafd4) Run VM work job: com.cloud.vm.VmWorkResizeVolume for VM 586, job origin: 6601
2026-07-29 08:42:32,023 DEBUG [c.c.v.VmWorkJobHandlerProxy] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) Execute VM work job: com.cloud.vm.VmWorkResizeVolume{"volumeId":680,"currentSize":2147483648,"newSize":3221225472,"newServiceOfferingId":268,"shrinkOk":false,"userId":2,"accountId":2,"vmId":586,"handlerName":"VolumeApiServiceImpl"}
2026-07-29 08:42:32,027 DEBUG [c.c.s.StorageManagerImpl] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) Checking pool StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} for storage, totalSize: 3757022642176, usedBytes: 2676623409152, usedPct: 0.712432067644327, disable threshold: 0.98
2026-07-29 08:42:32,028 DEBUG [c.c.s.StorageManagerImpl] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) Destination pool: StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"}
2026-07-29 08:42:32,032 DEBUG [c.c.s.StorageManagerImpl] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) Found storage pool StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} of type NetworkFilesystem with overprovisioning factor 2
2026-07-29 08:42:32,033 DEBUG [c.c.s.StorageManagerImpl] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) Total over provisioned capacity calculated is 2 * (3.4170 TB) 3757022642176
2026-07-29 08:42:32,033 DEBUG [c.c.s.StorageManagerImpl] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) Total capacity of the pool StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} is (6.8340 TB) 7514045284352
2026-07-29 08:42:32,034 DEBUG [c.c.s.StorageManagerImpl] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) Checking pool: StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} for storage allocation , maxSize : (6.8340 TB) 7514045284352, totalAllocatedSize : (28.77 GB) 30887248080, askingSize : (1.00 GB) 1073741824, allocated disable threshold: 0.98
2026-07-29 08:42:32,038 DEBUG [o.a.c.e.o.VolumeOrchestrator] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) Found [0] snapshots [[]] that have checkpoints for volume with id [680].
2026-07-29 08:42:32,103 DEBUG [c.c.h.XenServerGuru] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) We are returning the default host to execute commands because the command is not of Copy type.
2026-07-29 08:42:32,103 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) Wait time setting on com.cloud.agent.api.storage.ResizeVolumeCommand is 1800 seconds
2026-07-29 08:42:32,104 DEBUG [c.c.a.m.ClusteredAgentAttache] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) Seq 2-2381841252925610698: Routed from 32988033189005
2026-07-29 08:42:32,105 DEBUG [c.c.a.t.Request] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) Seq 1-2381841252925610698: Sending { Cmd , MgmtId: 32988033189005, via: 1(ref-trl-n6-k-Mu26-wei-zhou-kvm1), Ver: v1, Flags: 100011, [{"com.cloud.agent.api.storage.ResizeVolumeCommand":{"path":"b8f8d9d4-5d5f-4d42-9d4e-8629221e4747.qcow2","pool":{"id":"2","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956","host":"10.0.32.4","path":"/acs/primary/ref-trl-n6-k-Mu26-wei-zhou/ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","port":"2049","type":"NetworkFilesystem"},"currentSize":"2147483648","newSize":"(3.00 GB) 3221225472","shrinkOk":"false","vmInstance":"i-2-586-VM","managed":"false","wait":"0","bypassHostMaintenance":"false"}}] }
2026-07-29 08:42:32,264 DEBUG [c.c.a.t.Request] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) Seq 1-2381841252925610698: Received: { Ans: , MgmtId: 32988033189005, via: 1(ref-trl-n6-k-Mu26-wei-zhou-kvm1), Ver: v1, Flags: 10, { ResizeVolumeAnswer } }
2026-07-29 08:42:32,265 DEBUG [o.a.c.s.d.d.CloudStackPrimaryDataStoreDriverImpl] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) Resize: volume started at size: (2.00 GB) 2147483648 and ended at size: (3.00 GB) 3221225472
2026-07-29 08:42:32,340 DEBUG [c.c.r.ResourceLimitManagerImpl] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) Updating resource Type = primary_storage count for Account with id = 2 Operation = increasing Amount = (1.00 GB) 1073741824
2026-07-29 08:42:32,363 DEBUG [c.c.v.VmWorkJobHandlerProxy] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) Done executing VM work job: com.cloud.vm.VmWorkResizeVolume{"volumeId":680,"currentSize":2147483648,"newSize":3221225472,"newServiceOfferingId":268,"shrinkOk":false,"userId":2,"accountId":2,"vmId":586,"handlerName":"VolumeApiServiceImpl"}
2026-07-29 08:42:32,364 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) Complete async job-6603, jobStatus: SUCCEEDED, resultCode: 0, result: rO0ABXNyAA5qYXZhLmxhbmcuTG9uZzuL5JDMjyPfAgABSgAFdmFsdWV4cgAQamF2YS5sYW5nLk51bWJlcoaslR0LlOCLAgAAeHAAAAAAAAACqA
2026-07-29 08:42:32,365 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) Publish async job-6603 complete on message bus
2026-07-29 08:42:32,365 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) Wake up jobs related to job-6603
2026-07-29 08:42:32,365 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) Update db status for job-6603
2026-07-29 08:42:32,366 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603, ctx-5793ee9b]) (logid:091aafd4) Wake up jobs joined with job-6603 and disjoin all subjobs created from job- 6603
2026-07-29 08:42:32,385 DEBUG [c.c.v.VmWorkJobDispatcher] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603]) (logid:091aafd4) Done with run of VM work job: com.cloud.vm.VmWorkResizeVolume for VM 586, job origin: 6601
2026-07-29 08:42:32,385 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl$5] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603]) (logid:091aafd4) Done executing com.cloud.vm.VmWorkResizeVolume for job-6603
2026-07-29 08:42:32,386 INFO [o.a.c.f.j.i.AsyncJobMonitor] (Work-Job-Executor-49:[ctx-5c3c739e, job-6601/job-6603]) (logid:091aafd4) Remove job-6603 from job monitoring
2026-07-29 08:42:32,404 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Checking pool StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} for storage, totalSize: 3757022642176, usedBytes: 2676623409152, usedPct: 0.712432067644327, disable threshold: 0.98
2026-07-29 08:42:32,404 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Destination pool: StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"}
2026-07-29 08:42:32,408 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Found storage pool StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} of type NetworkFilesystem with overprovisioning factor 2
2026-07-29 08:42:32,408 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Total over provisioned capacity calculated is 2 * (3.4170 TB) 3757022642176
2026-07-29 08:42:32,408 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Total capacity of the pool StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} is (6.8340 TB) 7514045284352
2026-07-29 08:42:32,410 DEBUG [c.c.s.StorageManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601, ctx-7940959b]) (logid:091aafd4) Checking pool: StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} for storage allocation , maxSize : (6.8340 TB) 7514045284352, totalAllocatedSize : (29.77 GB) 31960989904, askingSize : (3.00 GB) 3221225472, allocated disable threshold: 0.98
2026-07-29 08:42:32,519 ERROR [c.c.a.ApiAsyncJobDispatcher] (API-Job-Executor-1:[ctx-b17e8967, job-6601]) (logid:091aafd4) Unexpected exception while executing org.apache.cloudstack.api.command.user.volume.ChangeOfferingForVolumeCmd com.cloud.utils.exception.CloudRuntimeException: Volume change offering operation failed for volume: Volume {"id":680,"instanceId":586,"name":"DATA-586","uuid":"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd","volumeType":"DATADISK"} migration failed to storage pool StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} due to Volume Volume {"id":680,"instanceId":586,"name":"DATA-586","uuid":"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd","volumeType":"DATADISK"} is already on the destination storage pool
2026-07-29 08:42:32,520 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601]) (logid:091aafd4) Complete async job-6601, jobStatus: FAILED, resultCode: 530, result: org.apache.cloudstack.api.response.ExceptionResponse/null/{"uuidList":[],"errorcode":"530","errortext":"Volume change offering operation failed for volume: Volume {"id":680,"instanceId":586,"name":"DATA-586","uuid":"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd","volumeType":"DATADISK"} migration failed to storage pool StoragePool {"id":2,"name":"ref-trl-n6-k-Mu26-wei-zhou-kvm-pri2","poolType":"NetworkFilesystem","uuid":"da8d7c9d-7203-3f5f-86c0-785ffa3ed956"} due to Volume Volume {"id":680,"instanceId":586,"name":"DATA-586","uuid":"f790f2fc-77f0-4f18-b5e7-97b0c8bc7dfd","volumeType":"DATADISK"} is already on the destination storage pool"}
2026-07-29 08:42:32,521 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601]) (logid:091aafd4) Publish async job-6601 complete on message bus
2026-07-29 08:42:32,521 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601]) (logid:091aafd4) Wake up jobs related to job-6601
2026-07-29 08:42:32,521 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601]) (logid:091aafd4) Update db status for job-6601
2026-07-29 08:42:32,523 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-1:[ctx-b17e8967, job-6601]) (logid:091aafd4) Wake up jobs joined with job-6601 and disjoin all subjobs created from job- 6601
2026-07-29 08:42:32,554 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl$5] (API-Job-Executor-1:[ctx-b17e8967, job-6601]) (logid:091aafd4) Done executing org.apache.cloudstack.api.command.user.volume.ChangeOfferingForVolumeCmd for job-6601
2026-07-29 08:42:32,555 INFO [o.a.c.f.j.i.AsyncJobMonitor] (API-Job-Executor-1:[ctx-b17e8967, job-6601]) (logid:091aafd4) Remove job-6601 from job monitoring
```

9. Volume got migrated to the destination storage and the disk offering also got changed

### What to do about it?

Expected behaviour

No exception should be thrown when the api call is executed successfully

Start at the ChangeOfferingForVolumeCmd API entry point and compare the management-server.log traces for the two changeOfferingForVolume calls. Follow the volume offering and storage-pool migration path far enough to determine why the API reports failure after the operation, including the disk-offering tag and already-on-destination errors. Done means the API result accurately reflects the operation outcome in both setting configurations.

Scritto dal modello di indicizzazione a partire dal testo della issue.