2026-10-27 15:03:53,325 - DEBUG - Parsing Test data successful
2026-10-27 15:03:53,326 - DEBUG - Payload: {'account': 'admin', 'command': 'listUsers', 'response': 'json'}
2026-10-27 15:03:53,326 - DEBUG - ========Sending GET Cmd : listUsers=======
2026-10-27 15:03:53,340 - DEBUG - Response : [{id : 'c1166b9d-d1fe-11f1-81aa-1e0044000301', username : 'admin', firstname : 'admin', lastname : 'cloud', created : '2026-10-27T12:05:51+0000', state : 'enabled', account : 'admin', accounttype : 1, usersource : 'native', roleid : '87d83eed-d1fe-11f1-81aa-1e0044000301', roletype : 'Admin', rolename : 'Root Admin', domainid : '54e5326a-d1fe-11f1-81aa-1e0044000301', domain : 'ROOT', apikey : 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', accountid : 'c1154605-d1fe-11f1-81aa-1e0044000301', iscallerchilddomain : False, isdefault : True, is2faenabled : False, is2famandated : False, apikeyaccess : 'INHERIT'}]
2026-10-27 15:03:53,340 - DEBUG - Payload: {'id': 'c1166b9d-d1fe-11f1-81aa-1e0044000301', 'command': 'getUserKeys', 'response': 'json'}
2026-10-27 15:03:53,340 - DEBUG - ========Sending GET Cmd : getUserKeys=======
2026-10-27 15:03:53,350 - DEBUG - Response : {apikey : 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', secretkey : 'R6QPwRUz09TVXBjXNwZk7grTjcPtsFRphH6xhN1oPvnc12YUk296t4KHytg8zRLczDA0X5NsLVi4d8rfMMx3yg', apikeyaccess : True}
2026-10-27 15:03:53,351 - DEBUG - ==== Test Client Creation Successful ====
2026-10-27 15:03:53,526 - DEBUG - Payload: {'name': 'pr14320-n151-kvm-ubuntu26', 'command': 'listZones', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'XMCUV0BgKtT0u2lrAUb+/yrR07A='}
2026-10-27 15:03:53,526 - DEBUG - ========Sending GET Cmd : listZones=======
2026-10-27 15:03:53,559 - DEBUG - Response : [{id : 'f630bd38-52a4-422f-9829-a3efc24896fe', name : 'pr14320-n151-kvm-ubuntu26', dns1 : '10.0.32.1', dns2 : '8.8.8.8', internaldns1 : '10.0.32.1', internaldns2 : '8.8.4.4', guestcidraddress : '10.1.1.0/24', networktype : 'Advanced', securitygroupsenabled : False, gputotal : 0, gpuused : 0, allocationstate : 'Enabled', zonetoken : '0808943c-497a-3662-b9bc-14ca6b8458e6', dhcpprovider : 'VirtualRouter', localstorageenabled : False, tags : [], allowuserspecifyvrmtu : False, routerprivateinterfacemaxmtu : 1500, routerpublicinterfacemaxmtu : 1500, type : 'Core', isnsxenabled : False, ismultiarch : False, asnrange : '', routedmodeenabled : True, hasannotations : False}]
2026-10-27 15:03:53,559 - DEBUG - Payload: {'name': 'ext-TW5QVX', 'type': 'Orchestrator', 'command': 'createExtension', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'ZEogagI+0RLvE4RYKDRYdWQ4reA='}
2026-10-27 15:03:53,560 - DEBUG - ========Sending GET Cmd : createExtension=======
2026-10-27 15:03:53,757 - DEBUG - Response : {id : '0511c3a3-0643-4077-bd6c-077451ecb3e1', name : 'ext-TW5QVX', type : 'Orchestrator', path : '/usr/share/cloudstack-management/extensions/ext-tw5qvx/ext-tw5qvx.sh', pathready : True, isuserdefined : True, state : 'Enabled', created : '2026-10-27T15:03:54+0000'}
2026-10-27 15:03:53,758 - DEBUG - ::::::::::::STARTED : TC: test_01_extension_create_custom_action :::::::::::
2026-10-27 15:03:53,759 - DEBUG - Payload: {'extensionid': '0511c3a3-0643-4077-bd6c-077451ecb3e1', 'name': '96I2JT', 'details[0].abc': 'xyz', 'parameters[0].name': 'Name', 'parameters[0].type': 'STRING', 'parameters[0].validationformat': 'NONE', 'parameters[0].required': True, 'command': 'addCustomAction', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'1F9TvP7aR1BQyS7icvu67lt6nHM='}
2026-10-27 15:03:53,759 - DEBUG - ========Sending GET Cmd : addCustomAction=======
2026-10-27 15:03:53,900 - DEBUG - Response : {id : '0cf132e0-d609-4384-b566-d367fc6ee23a', name : '96I2JT', extensionid : '0511c3a3-0643-4077-bd6c-077451ecb3e1', extensionname : 'ext-TW5QVX', resourcetype : 'VirtualMachine', allowedroletypes : ['Admin'], timeout : 3, enabled : False, details : {abc : 'xyz'}, parameters : [{name : 'Name', type : 'STRING', validationformat : 'NONE', required : True}], created : '2026-10-27T15:03:54+0000'}
2026-10-27 15:03:53,901 - DEBUG - Payload: {'extensionid': '0511c3a3-0643-4077-bd6c-077451ecb3e1', 'command': 'listCustomActions', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'B8WQxbu3iVEZmqdWiSLASCsCF/I='}
2026-10-27 15:03:53,902 - DEBUG - ========Sending GET Cmd : listCustomActions=======
2026-10-27 15:03:53,920 - DEBUG - Response : [{id : '0cf132e0-d609-4384-b566-d367fc6ee23a', name : '96I2JT', extensionid : '0511c3a3-0643-4077-bd6c-077451ecb3e1', extensionname : 'ext-TW5QVX', resourcetype : 'VirtualMachine', allowedroletypes : ['Admin'], timeout : 3, enabled : False, details : {abc : 'xyz'}, parameters : [{name : 'Name', type : 'STRING', validationformat : 'NONE', required : True}], created : '2026-10-27T15:03:54+0000'}]
2026-10-27 15:03:53,921 - DEBUG - Cleaning up the resources
2026-10-27 15:03:53,921 - DEBUG - Payload: {'id': '0cf132e0-d609-4384-b566-d367fc6ee23a', 'command': 'deleteCustomAction', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'T31aKCnZlZTAtFaf87N5venkaEA='}
2026-10-27 15:03:53,921 - DEBUG - ========Sending GET Cmd : deleteCustomAction=======
2026-10-27 15:03:53,976 - DEBUG - Response : {success : True}
2026-10-27 15:03:53,977 - DEBUG - TestCaseName: test_01_extension_create_custom_action; Time Taken: 0 Seconds; StartTime: Tue Oct 27 15:03:53 2026; EndTime: Tue Oct 27 15:03:53 2026; Result: SUCCESS
2026-10-27 15:03:53,978 - DEBUG - ::::::::::::STARTED : TC: test_02_extension_create_custom_action_name_fail :::::::::::
2026-10-27 15:03:53,978 - DEBUG - Payload: {'extensionid': '0511c3a3-0643-4077-bd6c-077451ecb3e1', 'name': 'KMGU82', 'command': 'addCustomAction', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'3BditzaR+QomOXm711jrmORbXFU='}
2026-10-27 15:03:53,978 - DEBUG - ========Sending GET Cmd : addCustomAction=======
2026-10-27 15:03:54,074 - DEBUG - Response : {id : '3c96431e-a6ec-441b-9c7c-e348c739ef66', name : 'KMGU82', extensionid : '0511c3a3-0643-4077-bd6c-077451ecb3e1', extensionname : 'ext-TW5QVX', resourcetype : 'VirtualMachine', allowedroletypes : ['Admin'], timeout : 3, enabled : False, details : {}, parameters : [], created : '2026-10-27T15:03:54+0000'}
2026-10-27 15:03:54,075 - DEBUG - Payload: {'extensionid': '0511c3a3-0643-4077-bd6c-077451ecb3e1', 'name': 'KMGU82', 'command': 'addCustomAction', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'3BditzaR+QomOXm711jrmORbXFU='}
2026-10-27 15:03:54,075 - DEBUG - ========Sending GET Cmd : addCustomAction=======
2026-10-27 15:03:54,130 - ERROR - Exception:['Traceback (most recent call last):\n', '  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 309, in __parseAndGetResponse\n    ret = jsonHelper.getResultObj(\n', '  File "/usr/local/lib/python3.9/site-packages/marvin/jsonHelper.py", line 155, in getResultObj\n    raise cloudstackException.CloudstackAPIException(respname, errMsg)\n', 'marvin.cloudstackException.CloudstackAPIException: Execute cmd: addcustomaction failed, due to: errorCode: 530, errorText:Action by name already exists\n']
Traceback (most recent call last):
  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 309, in __parseAndGetResponse
    ret = jsonHelper.getResultObj(
  File "/usr/local/lib/python3.9/site-packages/marvin/jsonHelper.py", line 155, in getResultObj
    raise cloudstackException.CloudstackAPIException(respname, errMsg)
marvin.cloudstackException.CloudstackAPIException: Execute cmd: addcustomaction failed, due to: errorCode: 530, errorText:Action by name already exists
2026-10-27 15:03:54,131 - ERROR - marvinRequest : CmdName: <marvin.cloudstackAPI.addCustomAction.addCustomActionCmd object at 0x7efcba0d8ca0> Exception: ['Traceback (most recent call last):\n', '  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 377, in marvinRequest\n    raise self.__lastError\n', '  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 309, in __parseAndGetResponse\n    ret = jsonHelper.getResultObj(\n', '  File "/usr/local/lib/python3.9/site-packages/marvin/jsonHelper.py", line 155, in getResultObj\n    raise cloudstackException.CloudstackAPIException(respname, errMsg)\n', 'marvin.cloudstackException.CloudstackAPIException: Execute cmd: addcustomaction failed, due to: errorCode: 530, errorText:Action by name already exists\n']
Traceback (most recent call last):
  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 377, in marvinRequest
    raise self.__lastError
  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 309, in __parseAndGetResponse
    ret = jsonHelper.getResultObj(
  File "/usr/local/lib/python3.9/site-packages/marvin/jsonHelper.py", line 155, in getResultObj
    raise cloudstackException.CloudstackAPIException(respname, errMsg)
marvin.cloudstackException.CloudstackAPIException: Execute cmd: addcustomaction failed, due to: errorCode: 530, errorText:Action by name already exists
2026-10-27 15:03:54,131 - DEBUG - Cleaning up the resources
2026-10-27 15:03:54,131 - DEBUG - TestCaseName: test_02_extension_create_custom_action_name_fail; Time Taken: 0 Seconds; StartTime: Tue Oct 27 15:03:53 2026; EndTime: Tue Oct 27 15:03:54 2026; Result: SUCCESS
2026-10-27 15:03:54,131 - DEBUG - ::::::::::::STARTED : TC: test_03_extension_create_custom_action_resourcetype_fail :::::::::::
2026-10-27 15:03:54,132 - DEBUG - Payload: {'extensionid': '0511c3a3-0643-4077-bd6c-077451ecb3e1', 'name': 'QKS738', 'resourcetype': 'Host', 'command': 'addCustomAction', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'ZOtf/RH1WGHEOZVfoLdi6mSjGPQ='}
2026-10-27 15:03:54,132 - DEBUG - ========Sending GET Cmd : addCustomAction=======
2026-10-27 15:03:54,163 - ERROR - Exception:['Traceback (most recent call last):\n', '  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 309, in __parseAndGetResponse\n    ret = jsonHelper.getResultObj(\n', '  File "/usr/local/lib/python3.9/site-packages/marvin/jsonHelper.py", line 155, in getResultObj\n    raise cloudstackException.CloudstackAPIException(respname, errMsg)\n', 'marvin.cloudstackException.CloudstackAPIException: Execute cmd: addcustomaction failed, due to: errorCode: 431, errorText:Invalid resource type specified: Host. Valid values are: [VirtualMachine, Network, Vpc]\n']
Traceback (most recent call last):
  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 309, in __parseAndGetResponse
    ret = jsonHelper.getResultObj(
  File "/usr/local/lib/python3.9/site-packages/marvin/jsonHelper.py", line 155, in getResultObj
    raise cloudstackException.CloudstackAPIException(respname, errMsg)
marvin.cloudstackException.CloudstackAPIException: Execute cmd: addcustomaction failed, due to: errorCode: 431, errorText:Invalid resource type specified: Host. Valid values are: [VirtualMachine, Network, Vpc]
2026-10-27 15:03:54,163 - ERROR - marvinRequest : CmdName: <marvin.cloudstackAPI.addCustomAction.addCustomActionCmd object at 0x7efcba0d8d30> Exception: ['Traceback (most recent call last):\n', '  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 377, in marvinRequest\n    raise self.__lastError\n', '  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 309, in __parseAndGetResponse\n    ret = jsonHelper.getResultObj(\n', '  File "/usr/local/lib/python3.9/site-packages/marvin/jsonHelper.py", line 155, in getResultObj\n    raise cloudstackException.CloudstackAPIException(respname, errMsg)\n', 'marvin.cloudstackException.CloudstackAPIException: Execute cmd: addcustomaction failed, due to: errorCode: 431, errorText:Invalid resource type specified: Host. Valid values are: [VirtualMachine, Network, Vpc]\n']
Traceback (most recent call last):
  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 377, in marvinRequest
    raise self.__lastError
  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 309, in __parseAndGetResponse
    ret = jsonHelper.getResultObj(
  File "/usr/local/lib/python3.9/site-packages/marvin/jsonHelper.py", line 155, in getResultObj
    raise cloudstackException.CloudstackAPIException(respname, errMsg)
marvin.cloudstackException.CloudstackAPIException: Execute cmd: addcustomaction failed, due to: errorCode: 431, errorText:Invalid resource type specified: Host. Valid values are: [VirtualMachine, Network, Vpc]
2026-10-27 15:03:54,164 - DEBUG - Cleaning up the resources
2026-10-27 15:03:54,164 - DEBUG - TestCaseName: test_03_extension_create_custom_action_resourcetype_fail; Time Taken: 0 Seconds; StartTime: Tue Oct 27 15:03:54 2026; EndTime: Tue Oct 27 15:03:54 2026; Result: SUCCESS
2026-10-27 15:03:54,164 - DEBUG - ::::::::::::STARTED : TC: test_04_extension_update_custom_action :::::::::::
2026-10-27 15:03:54,165 - DEBUG - Payload: {'extensionid': '0511c3a3-0643-4077-bd6c-077451ecb3e1', 'name': 'NZMSKV', 'details[0].abc': 'xyz', 'parameters[0].name': 'Name', 'parameters[0].type': 'STRING', 'parameters[0].validationformat': 'NONE', 'parameters[0].required': True, 'command': 'addCustomAction', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'VIBuaYRsIlKmPRa90Dmd5T1bCV8='}
2026-10-27 15:03:54,165 - DEBUG - ========Sending GET Cmd : addCustomAction=======
2026-10-27 15:03:54,228 - DEBUG - Response : {id : '41e83d79-7f65-48c0-b485-56ea93ed1586', name : 'NZMSKV', extensionid : '0511c3a3-0643-4077-bd6c-077451ecb3e1', extensionname : 'ext-TW5QVX', resourcetype : 'VirtualMachine', allowedroletypes : ['Admin'], timeout : 3, enabled : False, details : {abc : 'xyz'}, parameters : [{name : 'Name', type : 'STRING', validationformat : 'NONE', required : True}], created : '2026-10-27T15:03:54+0000'}
2026-10-27 15:03:54,229 - DEBUG - Payload: {'description': 'Updated test description', 'enabled': True, 'id': '41e83d79-7f65-48c0-b485-56ea93ed1586', 'details[0].abc': 'xyz', 'details[0].bca': 'yzx', 'parameters[0].name': 'Name', 'parameters[0].type': 'STRING', 'parameters[0].validationformat': 'NONE', 'parameters[0].required': True, 'parameters[1].name': 'COUNT', 'parameters[1].type': 'NUMBER', 'parameters[1].validationformat': 'NONE', 'parameters[1].required': False, 'parameters[1].valueoptions': '10,100,1000', 'command': 'updateCustomAction', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'3VsowyoS6qYh+e3M7jTF6UEYBOo='}
2026-10-27 15:03:54,229 - DEBUG - ========Sending GET Cmd : updateCustomAction=======
2026-10-27 15:03:54,273 - DEBUG - Response : {extensioncustomaction : {id : '41e83d79-7f65-48c0-b485-56ea93ed1586', name : 'NZMSKV', description : 'Updated test description', extensionid : '0511c3a3-0643-4077-bd6c-077451ecb3e1', extensionname : 'ext-TW5QVX', resourcetype : 'VirtualMachine', allowedroletypes : ['Admin'], timeout : 3, enabled : True, details : {bca : 'yzx', abc : 'xyz'}, parameters : [{name : 'Name', type : 'STRING', validationformat : 'NONE', required : True}, {name : 'COUNT', type : 'NUMBER', validationformat : 'NONE', valueoptions : [10, 100, 1000], required : False}], created : '2026-10-27T15:03:54+0000'}}
2026-10-27 15:03:54,274 - DEBUG - Cleaning up the resources
2026-10-27 15:03:54,274 - DEBUG - Payload: {'id': '41e83d79-7f65-48c0-b485-56ea93ed1586', 'command': 'deleteCustomAction', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'Erwigea0PUxn4wrBZxk8xtyDkug='}
2026-10-27 15:03:54,274 - DEBUG - ========Sending GET Cmd : deleteCustomAction=======
2026-10-27 15:03:54,297 - DEBUG - Response : {success : True}
2026-10-27 15:03:54,297 - DEBUG - TestCaseName: test_04_extension_update_custom_action; Time Taken: 0 Seconds; StartTime: Tue Oct 27 15:03:54 2026; EndTime: Tue Oct 27 15:03:54 2026; Result: SUCCESS
2026-10-27 15:03:54,298 - DEBUG - ::::::::::::STARTED : TC: test_05_extension_run_custom_action_invalid_resource_type_fail :::::::::::
2026-10-27 15:03:54,298 - DEBUG - Payload: {'enabled': True, 'extensionid': '0511c3a3-0643-4077-bd6c-077451ecb3e1', 'name': '816M45', 'command': 'addCustomAction', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'hIwgs3hFbMWnlKHzZdKK/yxEL+4='}
2026-10-27 15:03:54,298 - DEBUG - ========Sending GET Cmd : addCustomAction=======
2026-10-27 15:03:54,327 - DEBUG - Response : {id : 'bf47ae55-6f44-4cd6-8f7d-79a43ea9d367', name : '816M45', extensionid : '0511c3a3-0643-4077-bd6c-077451ecb3e1', extensionname : 'ext-TW5QVX', resourcetype : 'VirtualMachine', allowedroletypes : ['Admin'], timeout : 3, enabled : True, details : {}, parameters : [], created : '2026-10-27T15:03:54+0000'}
2026-10-27 15:03:54,328 - DEBUG - Payload: {'customactionid': 'bf47ae55-6f44-4cd6-8f7d-79a43ea9d367', 'resourceid': 'abcd', 'resourcetype': 'Host', 'command': 'runCustomAction', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'F7L3KkpeFMix6OTXp9XhmcKRvzM='}
2026-10-27 15:03:54,328 - DEBUG - ========Sending GET Cmd : runCustomAction=======
2026-10-27 15:03:54,363 - DEBUG - === Jobid: d24028ac-6f4e-40de-8412-eb5992cf1767 Started ===
2026-10-27 15:03:54,363 - DEBUG - Payload: {'jobid': 'd24028ac-6f4e-40de-8412-eb5992cf1767', 'command': 'queryAsyncJobResult', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'B0zgqJ/O0TtisN+eSLpPgG4D5aM='}
2026-10-27 15:03:54,364 - DEBUG - ========Sending GET Cmd : queryAsyncJobResult=======
2026-10-27 15:03:54,390 - DEBUG - Response : {accountid : 'c1154605-d1fe-11f1-81aa-1e0044000301', account : 'admin', domainid : '54e5326a-d1fe-11f1-81aa-1e0044000301', domainpath : 'ROOT', userid : 'c1166b9d-d1fe-11f1-81aa-1e0044000301', cmd : 'org.apache.cloudstack.framework.extensions.api.RunCustomActionCmd', jobprocstatus : 0, jobresultcode : 530, jobresulttype : 'object', jobresult : {errorcode : 530, errortext : 'Internal error running action'}, created : '2026-10-27T15:03:54+0000', completed : '2026-10-27T15:03:54+0000', jobid : 'd24028ac-6f4e-40de-8412-eb5992cf1767', jobstatus : 2}
2026-10-27 15:03:54,390 - ERROR - ==== __poll: Exception Occurred :Job failed: {accountid : 'c1154605-d1fe-11f1-81aa-1e0044000301', account : 'admin', domainid : '54e5326a-d1fe-11f1-81aa-1e0044000301', domainpath : 'ROOT', userid : 'c1166b9d-d1fe-11f1-81aa-1e0044000301', cmd : 'org.apache.cloudstack.framework.extensions.api.RunCustomActionCmd', jobprocstatus : 0, jobresultcode : 530, jobresulttype : 'object', jobresult : {errorcode : 530, errortext : 'Internal error running action'}, created : '2026-10-27T15:03:54+0000', completed : '2026-10-27T15:03:54+0000', jobid : 'd24028ac-6f4e-40de-8412-eb5992cf1767', jobstatus : 2} ====
Traceback (most recent call last):
  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 104, in __poll
    raise Exception("Job failed: %s"\
Exception: Job failed: {accountid : 'c1154605-d1fe-11f1-81aa-1e0044000301', account : 'admin', domainid : '54e5326a-d1fe-11f1-81aa-1e0044000301', domainpath : 'ROOT', userid : 'c1166b9d-d1fe-11f1-81aa-1e0044000301', cmd : 'org.apache.cloudstack.framework.extensions.api.RunCustomActionCmd', jobprocstatus : 0, jobresultcode : 530, jobresulttype : 'object', jobresult : {errorcode : 530, errortext : 'Internal error running action'}, created : '2026-10-27T15:03:54+0000', completed : '2026-10-27T15:03:54+0000', jobid : 'd24028ac-6f4e-40de-8412-eb5992cf1767', jobstatus : 2}
2026-10-27 15:03:54,391 - DEBUG - Response : FAILED
2026-10-27 15:03:54,391 - ERROR - marvinRequest : CmdName: <marvin.cloudstackAPI.runCustomAction.runCustomActionCmd object at 0x7efcba0d8be0> Exception: ['Traceback (most recent call last):\n', '  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 377, in marvinRequest\n    raise self.__lastError\n', '  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 104, in __poll\n    raise Exception("Job failed: %s"\\\n', "Exception: Job failed: {accountid : 'c1154605-d1fe-11f1-81aa-1e0044000301', account : 'admin', domainid : '54e5326a-d1fe-11f1-81aa-1e0044000301', domainpath : 'ROOT', userid : 'c1166b9d-d1fe-11f1-81aa-1e0044000301', cmd : 'org.apache.cloudstack.framework.extensions.api.RunCustomActionCmd', jobprocstatus : 0, jobresultcode : 530, jobresulttype : 'object', jobresult : {errorcode : 530, errortext : 'Internal error running action'}, created : '2026-10-27T15:03:54+0000', completed : '2026-10-27T15:03:54+0000', jobid : 'd24028ac-6f4e-40de-8412-eb5992cf1767', jobstatus : 2}\n"]
Traceback (most recent call last):
  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 377, in marvinRequest
    raise self.__lastError
  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 104, in __poll
    raise Exception("Job failed: %s"\
Exception: Job failed: {accountid : 'c1154605-d1fe-11f1-81aa-1e0044000301', account : 'admin', domainid : '54e5326a-d1fe-11f1-81aa-1e0044000301', domainpath : 'ROOT', userid : 'c1166b9d-d1fe-11f1-81aa-1e0044000301', cmd : 'org.apache.cloudstack.framework.extensions.api.RunCustomActionCmd', jobprocstatus : 0, jobresultcode : 530, jobresulttype : 'object', jobresult : {errorcode : 530, errortext : 'Internal error running action'}, created : '2026-10-27T15:03:54+0000', completed : '2026-10-27T15:03:54+0000', jobid : 'd24028ac-6f4e-40de-8412-eb5992cf1767', jobstatus : 2}
2026-10-27 15:03:54,391 - DEBUG - Cleaning up the resources
2026-10-27 15:03:54,391 - DEBUG - Payload: {'id': 'bf47ae55-6f44-4cd6-8f7d-79a43ea9d367', 'command': 'deleteCustomAction', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'oTCsNg/pfU5JT3Eo2DDqAW9XKM8='}
2026-10-27 15:03:54,391 - DEBUG - ========Sending GET Cmd : deleteCustomAction=======
2026-10-27 15:03:54,427 - DEBUG - Response : {success : True}
2026-10-27 15:03:54,427 - DEBUG - TestCaseName: test_05_extension_run_custom_action_invalid_resource_type_fail; Time Taken: 0 Seconds; StartTime: Tue Oct 27 15:03:54 2026; EndTime: Tue Oct 27 15:03:54 2026; Result: SUCCESS
2026-10-27 15:03:54,428 - DEBUG - ::::::::::::STARTED : TC: test_06_extension_run_custom_action_fail :::::::::::
2026-10-27 15:03:54,428 - DEBUG - Payload: {'enabled': True, 'extensionid': '0511c3a3-0643-4077-bd6c-077451ecb3e1', 'name': 'X71ZV7', 'command': 'addCustomAction', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'Gsj24gP7fBpt+pgfB/rtn67B/8k='}
2026-10-27 15:03:54,428 - DEBUG - ========Sending GET Cmd : addCustomAction=======
2026-10-27 15:03:54,471 - DEBUG - Response : {id : '10673588-da6e-4661-9199-78f5eff52433', name : 'X71ZV7', extensionid : '0511c3a3-0643-4077-bd6c-077451ecb3e1', extensionname : 'ext-TW5QVX', resourcetype : 'VirtualMachine', allowedroletypes : ['Admin'], timeout : 3, enabled : True, details : {}, parameters : [], created : '2026-10-27T15:03:54+0000'}
2026-10-27 15:03:54,472 - DEBUG - Payload: {'customactionid': '10673588-da6e-4661-9199-78f5eff52433', 'resourceid': 'abcd', 'command': 'runCustomAction', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'9QakCE78uFvUTnDlu/nfJcpjRE8='}
2026-10-27 15:03:54,472 - DEBUG - ========Sending GET Cmd : runCustomAction=======
2026-10-27 15:03:54,521 - DEBUG - === Jobid: fdddcd99-6832-4d87-9875-cd5f8066e010 Started ===
2026-10-27 15:03:54,521 - DEBUG - Payload: {'jobid': 'fdddcd99-6832-4d87-9875-cd5f8066e010', 'command': 'queryAsyncJobResult', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'rRwCslI1NPDm7XLZhNHK9yl1xHY='}
2026-10-27 15:03:54,521 - DEBUG - ========Sending GET Cmd : queryAsyncJobResult=======
2026-10-27 15:03:54,567 - DEBUG - Response : {accountid : 'c1154605-d1fe-11f1-81aa-1e0044000301', account : 'admin', domainid : '54e5326a-d1fe-11f1-81aa-1e0044000301', domainpath : 'ROOT', userid : 'c1166b9d-d1fe-11f1-81aa-1e0044000301', cmd : 'org.apache.cloudstack.framework.extensions.api.RunCustomActionCmd', jobprocstatus : 0, jobresultcode : 530, jobresulttype : 'object', jobresult : {errorcode : 530, errortext : 'Internal error running action'}, created : '2026-10-27T15:03:55+0000', completed : '2026-10-27T15:03:55+0000', jobid : 'fdddcd99-6832-4d87-9875-cd5f8066e010', jobstatus : 2}
2026-10-27 15:03:54,567 - ERROR - ==== __poll: Exception Occurred :Job failed: {accountid : 'c1154605-d1fe-11f1-81aa-1e0044000301', account : 'admin', domainid : '54e5326a-d1fe-11f1-81aa-1e0044000301', domainpath : 'ROOT', userid : 'c1166b9d-d1fe-11f1-81aa-1e0044000301', cmd : 'org.apache.cloudstack.framework.extensions.api.RunCustomActionCmd', jobprocstatus : 0, jobresultcode : 530, jobresulttype : 'object', jobresult : {errorcode : 530, errortext : 'Internal error running action'}, created : '2026-10-27T15:03:55+0000', completed : '2026-10-27T15:03:55+0000', jobid : 'fdddcd99-6832-4d87-9875-cd5f8066e010', jobstatus : 2} ====
Traceback (most recent call last):
  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 104, in __poll
    raise Exception("Job failed: %s"\
Exception: Job failed: {accountid : 'c1154605-d1fe-11f1-81aa-1e0044000301', account : 'admin', domainid : '54e5326a-d1fe-11f1-81aa-1e0044000301', domainpath : 'ROOT', userid : 'c1166b9d-d1fe-11f1-81aa-1e0044000301', cmd : 'org.apache.cloudstack.framework.extensions.api.RunCustomActionCmd', jobprocstatus : 0, jobresultcode : 530, jobresulttype : 'object', jobresult : {errorcode : 530, errortext : 'Internal error running action'}, created : '2026-10-27T15:03:55+0000', completed : '2026-10-27T15:03:55+0000', jobid : 'fdddcd99-6832-4d87-9875-cd5f8066e010', jobstatus : 2}
2026-10-27 15:03:54,568 - DEBUG - Response : FAILED
2026-10-27 15:03:54,568 - ERROR - marvinRequest : CmdName: <marvin.cloudstackAPI.runCustomAction.runCustomActionCmd object at 0x7efcba0d8a00> Exception: ['Traceback (most recent call last):\n', '  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 377, in marvinRequest\n    raise self.__lastError\n', '  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 104, in __poll\n    raise Exception("Job failed: %s"\\\n', "Exception: Job failed: {accountid : 'c1154605-d1fe-11f1-81aa-1e0044000301', account : 'admin', domainid : '54e5326a-d1fe-11f1-81aa-1e0044000301', domainpath : 'ROOT', userid : 'c1166b9d-d1fe-11f1-81aa-1e0044000301', cmd : 'org.apache.cloudstack.framework.extensions.api.RunCustomActionCmd', jobprocstatus : 0, jobresultcode : 530, jobresulttype : 'object', jobresult : {errorcode : 530, errortext : 'Internal error running action'}, created : '2026-10-27T15:03:55+0000', completed : '2026-10-27T15:03:55+0000', jobid : 'fdddcd99-6832-4d87-9875-cd5f8066e010', jobstatus : 2}\n"]
Traceback (most recent call last):
  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 377, in marvinRequest
    raise self.__lastError
  File "/usr/local/lib/python3.9/site-packages/marvin/cloudstackConnection.py", line 104, in __poll
    raise Exception("Job failed: %s"\
Exception: Job failed: {accountid : 'c1154605-d1fe-11f1-81aa-1e0044000301', account : 'admin', domainid : '54e5326a-d1fe-11f1-81aa-1e0044000301', domainpath : 'ROOT', userid : 'c1166b9d-d1fe-11f1-81aa-1e0044000301', cmd : 'org.apache.cloudstack.framework.extensions.api.RunCustomActionCmd', jobprocstatus : 0, jobresultcode : 530, jobresulttype : 'object', jobresult : {errorcode : 530, errortext : 'Internal error running action'}, created : '2026-10-27T15:03:55+0000', completed : '2026-10-27T15:03:55+0000', jobid : 'fdddcd99-6832-4d87-9875-cd5f8066e010', jobstatus : 2}
2026-10-27 15:03:54,568 - DEBUG - Cleaning up the resources
2026-10-27 15:03:54,569 - DEBUG - Payload: {'id': '10673588-da6e-4661-9199-78f5eff52433', 'command': 'deleteCustomAction', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'e7zh7dumeEkNlm+9NNMmO1oP5Wc='}
2026-10-27 15:03:54,569 - DEBUG - ========Sending GET Cmd : deleteCustomAction=======
2026-10-27 15:03:54,602 - DEBUG - Response : {success : True}
2026-10-27 15:03:54,602 - DEBUG - TestCaseName: test_06_extension_run_custom_action_fail; Time Taken: 0 Seconds; StartTime: Tue Oct 27 15:03:54 2026; EndTime: Tue Oct 27 15:03:54 2026; Result: SUCCESS
2026-10-27 15:03:54,602 - DEBUG - Cleaning up the resources
2026-10-27 15:03:54,603 - DEBUG - Payload: {'id': '0511c3a3-0643-4077-bd6c-077451ecb3e1', 'command': 'listExtensions', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'ZOMN0C0NknZyeATuhi/0fQULblM='}
2026-10-27 15:03:54,603 - DEBUG - ========Sending GET Cmd : listExtensions=======
2026-10-27 15:03:54,628 - DEBUG - Response : [{id : '0511c3a3-0643-4077-bd6c-077451ecb3e1', name : 'ext-TW5QVX', type : 'Orchestrator', path : '/usr/share/cloudstack-management/extensions/ext-tw5qvx/ext-tw5qvx.sh', pathready : True, isuserdefined : True, state : 'Enabled', created : '2026-10-27T15:03:54+0000'}]
2026-10-27 15:03:54,629 - DEBUG - Payload: {'extensionid': '0511c3a3-0643-4077-bd6c-077451ecb3e1', 'command': 'listCustomActions', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'B8WQxbu3iVEZmqdWiSLASCsCF/I='}
2026-10-27 15:03:54,630 - DEBUG - ========Sending GET Cmd : listCustomActions=======
2026-10-27 15:03:54,648 - DEBUG - Response : [{id : '3c96431e-a6ec-441b-9c7c-e348c739ef66', name : 'KMGU82', extensionid : '0511c3a3-0643-4077-bd6c-077451ecb3e1', extensionname : 'ext-TW5QVX', resourcetype : 'VirtualMachine', allowedroletypes : ['Admin'], timeout : 3, enabled : False, details : {}, parameters : [], created : '2026-10-27T15:03:54+0000'}]
2026-10-27 15:03:54,649 - DEBUG - Payload: {'id': '3c96431e-a6ec-441b-9c7c-e348c739ef66', 'command': 'deleteCustomAction', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'xP0LFVs+BoUq8E8tS6r6F+Ahn5c='}
2026-10-27 15:03:54,649 - DEBUG - ========Sending GET Cmd : deleteCustomAction=======
2026-10-27 15:03:54,736 - DEBUG - Response : {success : True}
2026-10-27 15:03:54,737 - DEBUG - Payload: {'cleanup': True, 'id': '0511c3a3-0643-4077-bd6c-077451ecb3e1', 'command': 'deleteExtension', 'response': 'json', 'apiKey': 'LIN6rqXuaJwMPfGYFh13qDwYz5VNNz1J2J6qIOWcd3oLQOq0WtD4CwRundBL6rzXToa3lQOC_vKjI3nkHtiD8Q', 'signature': b'sMCWXmZKaCvHftixbrsR2e3BAEE='}
2026-10-27 15:03:54,737 - DEBUG - ========Sending GET Cmd : deleteExtension=======
2026-10-27 15:03:54,802 - DEBUG - Response : {success : True}
