kiranchavala opened a new issue, #13741:
URL: https://github.com/apache/cloudstack/issues/13741

   ### 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\\\",\\\"in
 terface 
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\\\",\\\"in
 terface 
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\\\",\\\"int
 erface 
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 


-- 
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.

To unsubscribe, e-mail: [email protected]

For queries about this service, please contact Infrastructure at:
[email protected]

Reply via email to