2025-10-08 15:42:35,180 - INFO - Domain Default found not creating
2025-10-08 15:42:35,378 - INFO - Project ctest-TestRbacBasic-15231640 not found, creating it
2025-10-08 15:42:35,953 - INFO - Created Project:ctest-TestRbacBasic-15231640, ID : 28151b41-cfd3-4d53-9ebd-afad869d9413
2025-10-08 15:42:39,771 - INFO - ================================================================================
2025-10-08 15:42:39,771 - INFO - STARTING TEST : test_perms2_owner
2025-10-08 15:42:39,771 - INFO - TEST DESCRIPTION :
Validate perms2 tenant ownership
steps:
1. Create Project1 and Project2
2. Add user1 as role1 under project1 and project2
3. create domain acl rule 'VirtualNetwork.* role1:CRUD'
4. create VN1 under Project1
4. create VN2 under Project2
5. user1 shouldnt be able to read VN1 using project2 creds
6. admin should be able to read VN1 though he isnt member of the project
7. Network list with respective project creds should list corresponding VNs
8. Change ownership of VN1 to Project2
9. user1 should now be able to read VN1 using Project2 creds
10. Network list with Project2 creds should list both VNs,
Project1 creds should list VN1 alone, admin should list both VNs
2025-10-08 15:42:41,043 - DEBUG - Skipping xmpp flap check
2025-10-08 15:42:41,049 - INFO - Initial checks done. Running the testcase now
2025-10-08 15:42:41,049 - INFO -
2025-10-08 15:42:41,453 - INFO - Project ctest-TestRbacBasic-37916700 not found, creating it
2025-10-08 15:42:42,084 - INFO - Created Project:ctest-TestRbacBasic-37916700, ID : 295d2be8-59f8-42c5-a296-fbf075ca5497
2025-10-08 15:42:42,485 - INFO - Project ctest-TestRbacBasic-68657658 not found, creating it
2025-10-08 15:42:43,072 - INFO - Created Project:ctest-TestRbacBasic-68657658, ID : 7c284c49-6eb3-4c5c-9782-659a1fe21d19
2025-10-08 15:42:45,129 - DEBUG - Requesting: http://10.0.0.133:8082/api-access-list/77f1cc9f-a4c2-4767-bf91-6578ca7e348f
2025-10-08 15:42:45,497 - DEBUG - Requesting: http://10.0.0.133:8082/api-access-list/77f1cc9f-a4c2-4767-bf91-6578ca7e348f
2025-10-08 15:42:45,580 - DEBUG - API access-list (77f1cc9f-a4c2-4767-bf91-6578ca7e348f) found in api server
2025-10-08 15:42:45,580 - INFO - API access-list 77f1cc9f-a4c2-4767-bf91-6578ca7e348f verify on api server passed
2025-10-08 15:42:46,336 - INFO - Created VN ctest-TestRbacBasic-37916700-55715266, UUID :61bddfb3-8fcc-462b-ab7e-bde19c1c8a4d
2025-10-08 15:42:47,760 - INFO - Created VN ctest-TestRbacBasic-68657658-57029968, UUID :07b8d057-d9c1-4ccb-b459-dc9e878ac059
2025-10-08 15:42:48,436 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/61bddfb3-8fcc-462b-ab7e-bde19c1c8a4d
2025-10-08 15:42:48,743 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/61bddfb3-8fcc-462b-ab7e-bde19c1c8a4d
2025-10-08 15:42:48,813 - INFO - API Server: Read VN 61bddfb3-8fcc-462b-ab7e-bde19c1c8a4d
2025-10-08 15:42:48,813 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/61bddfb3-8fcc-462b-ab7e-bde19c1c8a4d
2025-10-08 15:42:49,132 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/61bddfb3-8fcc-462b-ab7e-bde19c1c8a4d
2025-10-08 15:42:49,187 - DEBUG - Virtual Network ID: 61bddfb3-8fcc-462b-ab7e-bde19c1c8a4d not found
2025-10-08 15:42:49,187 - INFO - API Server: Permission Denied to read VN 61bddfb3-8fcc-462b-ab7e-bde19c1c8a4d
2025-10-08 15:42:49,187 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/61bddfb3-8fcc-462b-ab7e-bde19c1c8a4d
2025-10-08 15:42:49,201 - INFO - API Server: Read VN 61bddfb3-8fcc-462b-ab7e-bde19c1c8a4d
2025-10-08 15:42:49,201 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-networks
2025-10-08 15:42:49,244 - INFO - API Server: List VN ['61bddfb3-8fcc-462b-ab7e-bde19c1c8a4d']
2025-10-08 15:42:49,245 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-networks
2025-10-08 15:42:49,295 - INFO - API Server: List VN ['07b8d057-d9c1-4ccb-b459-dc9e878ac059']
2025-10-08 15:42:49,380 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-networks
2025-10-08 15:42:49,449 - INFO - API Server: List VN []
2025-10-08 15:42:49,449 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-networks
2025-10-08 15:42:49,494 - INFO - API Server: List VN ['61bddfb3-8fcc-462b-ab7e-bde19c1c8a4d', '07b8d057-d9c1-4ccb-b459-dc9e878ac059']
2025-10-08 15:42:49,494 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-networks
2025-10-08 15:42:49,503 - INFO - API Server: List VN ['546c88ec-7760-45a4-ab26-cc04f903dac6', '61bddfb3-8fcc-462b-ab7e-bde19c1c8a4d', '07b8d057-d9c1-4ccb-b459-dc9e878ac059', '9047a333-1446-4364-b1d9-09ef857b7387', '8fec18a5-428b-4198-8bf1-633673320130', 'c2838383-e2f7-4ceb-a57b-f44c6b97bf64', '9573c2be-d4f0-47dd-8ba9-e4c79c1e7a8e']
2025-10-08 15:42:49,563 - INFO - Deleting VN ctest-TestRbacBasic-68657658-57029968
2025-10-08 15:42:49,725 - INFO - Deleting VN ctest-TestRbacBasic-37916700-55715266
2025-10-08 15:42:49,914 - DEBUG - Requesting: http://10.0.0.133:8082/api-access-list/77f1cc9f-a4c2-4767-bf91-6578ca7e348f
2025-10-08 15:42:49,920 - DEBUG - Response Code: 404
2025-10-08 15:42:49,921 - INFO - API access-list (77f1cc9f-a4c2-4767-bf91-6578ca7e348f) got deleted in api server
2025-10-08 15:42:51,161 - INFO - Deleted project: ctest-TestRbacBasic-68657658, ID : 7c284c49-6eb3-4c5c-9782-659a1fe21d19
2025-10-08 15:42:51,986 - INFO - Deleted project: ctest-TestRbacBasic-37916700, ID : 295d2be8-59f8-42c5-a296-fbf075ca5497
2025-10-08 15:42:53,268 - DEBUG - Skipping xmpp flap check
2025-10-08 15:42:53,269 - INFO - END TEST : test_perms2_owner : PASSED[0:00:14]
2025-10-08 15:42:53,269 - INFO - --------------------------------------------------------------------------------
2025-10-08 15:42:53,271 - INFO - ================================================================================
2025-10-08 15:42:53,272 - INFO - STARTING TEST : test_rbac_acl_different_roles
2025-10-08 15:42:53,272 - INFO - TEST DESCRIPTION :
Validate via vnc_apis CRUD of rbac acl and objects
steps:
1. Add user1 as role1 and user2 as role2 to the project
2. Both user1 and user2 shouldnt be able to create VNs/STs
3. Create Rbac ACL under project with VN.* role1:CRUD rule
4. user1 should be able to create VN, but not Service-Template
5. Create Rbac ACL under domain with ST.* role1:CRUD rule
6. user1 should be able to create Service-Template
7. user2 shouldnt be able to read the created VN/ST or create new
8. Update the acl rule with Read perms for role2
9. user2 should be able to read created VN but not create new VNs
10. user2 should be able to read created ST but not create new STs
11. Delete the acl rule with Read perms for role2
12. user2 shouldnt be able to read the created ST/VN or create new VN/ST
13. Update global acl with role2:R for both VN and ST
14. user2 should be able to read VN and ST
13. Delete both project and domain acls
14. user1 shouldnt be able to read/delete VN/ST
15. Update global acl with role1:CRUD for both VN/ST
16. user1 should now be able to delete both VN and ST
17. Delete global acl
pass : acl creation and update should complete scucessfully.
2025-10-08 15:42:54,556 - DEBUG - Skipping xmpp flap check
2025-10-08 15:42:54,562 - INFO - Initial checks done. Running the testcase now
2025-10-08 15:42:54,562 - INFO -
2025-10-08 15:42:57,148 - INFO - Permission denied to create/update VirtualNetwork
2025-10-08 15:42:57,148 - DEBUG - Creating service template: ['default-domain', 'ctest-TestRbacBasic-15231640-89439809']
2025-10-08 15:42:57,552 - DEBUG - Requesting: http://10.0.0.133:8082/api-access-list/4d6a7008-afdd-48a7-ba68-d3c359923a11
2025-10-08 15:42:57,566 - DEBUG - API access-list (4d6a7008-afdd-48a7-ba68-d3c359923a11) found in api server
2025-10-08 15:42:57,566 - INFO - API access-list 4d6a7008-afdd-48a7-ba68-d3c359923a11 verify on api server passed
2025-10-08 15:42:57,920 - INFO - Created VN ctest-TestRbacBasic-15231640-76754698, UUID :7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:42:58,792 - DEBUG - Fetched VN: default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-76754698(7b28084a-80fd-44b8-8c0f-a331053d21a6) with subnets ['166.166.159.192/26']
2025-10-08 15:42:58,793 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2025-10-08 15:42:58,801 - DEBUG - Requesting: http://10.0.0.133:8082/domain/adc52b80-2ed1-485c-90d4-83e78c8e1400
2025-10-08 15:42:58,817 - DEBUG - Requesting: http://10.0.0.133:8082/project/28151b41-cfd3-4d53-9ebd-afad869d9413
2025-10-08 15:42:58,927 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:42:58,943 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:42:58,955 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/8f5a36b8-dda3-4bc5-89ae-2a85655d76fd
2025-10-08 15:42:58,967 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/8f5a36b8-dda3-4bc5-89ae-2a85655d76fd
2025-10-08 15:42:58,975 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/caed3961-5089-4fa3-b8e4-16d2b9729f9b
2025-10-08 15:42:58,984 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-08 15:42:58,984 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:42:58,997 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/8f5a36b8-dda3-4bc5-89ae-2a85655d76fd
2025-10-08 15:42:59,017 - INFO - Verified VN network id 14 for VN 7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:42:59,017 - INFO - Verifications in API Server for VN ctest-TestRbacBasic-15231640-76754698 passed
2025-10-08 15:42:59,017 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:42:59,031 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/8f5a36b8-dda3-4bc5-89ae-2a85655d76fd
2025-10-08 15:42:59,040 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/8f5a36b8-dda3-4bc5-89ae-2a85655d76fd
2025-10-08 15:42:59,049 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/caed3961-5089-4fa3-b8e4-16d2b9729f9b
2025-10-08 15:42:59,064 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-76754698', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestRbacBasic-39779729', 'owner-access': '7', 'group': 'ctest-TestRbacBasic-31463353', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8874352181818246328', 'uuid-lslong': '10092464720897188262'}, 'enable': 'true', 'created': '2025-10-08T15:42:57', 'last-modified': '2025-10-08T15:42:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.915471'}
2025-10-08 15:42:59,072 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-08 15:42:59,079 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-76754698', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestRbacBasic-39779729', 'owner-access': '7', 'group': 'ctest-TestRbacBasic-31463353', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8874352181818246328', 'uuid-lslong': '10092464720897188262'}, 'enable': 'true', 'created': '2025-10-08T15:42:57', 'last-modified': '2025-10-08T15:42:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.926162'}
2025-10-08 15:42:59,086 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-08 15:42:59,093 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-76754698', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestRbacBasic-39779729', 'owner-access': '7', 'group': 'ctest-TestRbacBasic-31463353', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8874352181818246328', 'uuid-lslong': '10092464720897188262'}, 'enable': 'true', 'created': '2025-10-08T15:42:57', 'last-modified': '2025-10-08T15:42:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.944740'}
2025-10-08 15:42:59,102 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-08 15:42:59,102 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-TestRbacBasic-15231640-76754698 passed
2025-10-08 15:42:59,103 - DEBUG - ====Verifying policy data for ctest-TestRbacBasic-15231640-76754698 in API_Server ======
2025-10-08 15:42:59,103 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2025-10-08 15:42:59,111 - DEBUG - Requesting: http://10.0.0.133:8082/domain/adc52b80-2ed1-485c-90d4-83e78c8e1400
2025-10-08 15:42:59,127 - DEBUG - Requesting: http://10.0.0.133:8082/project/28151b41-cfd3-4d53-9ebd-afad869d9413
2025-10-08 15:42:59,241 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:42:59,257 - DEBUG - =>VN ctest-TestRbacBasic-15231640-76754698 has no policy to be verified
2025-10-08 15:42:59,257 - DEBUG - Verifying the vn in opserver
2025-10-08 15:42:59,257 - DEBUG - Verifying the default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-76754698 virtual network link through opserver 10.0.0.133
2025-10-08 15:42:59,257 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2025-10-08 15:42:59,582 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2025-10-08 15:42:59,670 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-76754698', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-76754698?flat'}
2025-10-08 15:42:59,670 - DEBUG - Verifying the default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-76754698 virtual network link through opserver 10.0.0.50
2025-10-08 15:42:59,670 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-10-08 15:42:59,977 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-10-08 15:43:00,071 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-76754698', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-76754698?flat'}
2025-10-08 15:43:00,071 - DEBUG - Verifying the default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-76754698 virtual network link through opserver 10.0.0.242
2025-10-08 15:43:00,071 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2025-10-08 15:43:00,388 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2025-10-08 15:43:00,467 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-76754698', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-76754698?flat'}
2025-10-08 15:43:00,467 - INFO - Validated that VN default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-76754698 is found in opserver
2025-10-08 15:43:00,494 - DEBUG - Do not have enough data to verify VN in agent
2025-10-08 15:43:00,507 - DEBUG - VRF ids for VN ctest-TestRbacBasic-15231640-76754698: {}
2025-10-08 15:43:00,507 - DEBUG - Creating service template: ['default-domain', 'ctest-TestRbacBasic-15231640-76140844']
2025-10-08 15:43:00,900 - DEBUG - Requesting: http://10.0.0.133:8082/api-access-list/aae7259f-d6f8-4cfe-8de3-6a2f557607bd
2025-10-08 15:43:00,913 - DEBUG - API access-list (aae7259f-d6f8-4cfe-8de3-6a2f557607bd) found in api server
2025-10-08 15:43:00,913 - INFO - API access-list aae7259f-d6f8-4cfe-8de3-6a2f557607bd verify on api server passed
2025-10-08 15:43:00,914 - DEBUG - Creating service template: ['default-domain', 'ctest-TestRbacBasic-15231640-65764163']
2025-10-08 15:43:01,394 - DEBUG - Service template: ['default-domain', 'ctest-TestRbacBasic-15231640-65764163'] created succesfully
2025-10-08 15:43:01,394 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:43:01,702 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:43:01,762 - DEBUG - Virtual Network ID: 7b28084a-80fd-44b8-8c0f-a331053d21a6 not found
2025-10-08 15:43:01,762 - INFO - API Server: Permission Denied to read VN 7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:43:01,762 - DEBUG - Requesting: http://10.0.0.133:8082/service-template/cc2ddc83-1648-4ab7-94d4-7f0544a25658
2025-10-08 15:43:02,082 - DEBUG - Requesting: http://10.0.0.133:8082/service-template/cc2ddc83-1648-4ab7-94d4-7f0544a25658
2025-10-08 15:43:02,132 - INFO - API Server: Permission Denied to read ST cc2ddc83-1648-4ab7-94d4-7f0544a25658
2025-10-08 15:43:02,200 - DEBUG - Requesting: http://10.0.0.133:8082/api-access-list/4d6a7008-afdd-48a7-ba68-d3c359923a11
2025-10-08 15:43:02,211 - DEBUG - API access-list (4d6a7008-afdd-48a7-ba68-d3c359923a11) found in api server
2025-10-08 15:43:02,211 - INFO - API access-list 4d6a7008-afdd-48a7-ba68-d3c359923a11 verify on api server passed
2025-10-08 15:43:02,212 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:43:02,241 - INFO - API Server: Read VN 7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:43:02,868 - INFO - Permission denied to create/update VirtualNetwork
2025-10-08 15:43:02,868 - DEBUG - Requesting: http://10.0.0.133:8082/service-template/cc2ddc83-1648-4ab7-94d4-7f0544a25658
2025-10-08 15:43:03,211 - DEBUG - Requesting: http://10.0.0.133:8082/service-template/cc2ddc83-1648-4ab7-94d4-7f0544a25658
2025-10-08 15:43:03,263 - INFO - API Server: Permission Denied to read ST cc2ddc83-1648-4ab7-94d4-7f0544a25658
2025-10-08 15:43:03,328 - DEBUG - Requesting: http://10.0.0.133:8082/api-access-list/aae7259f-d6f8-4cfe-8de3-6a2f557607bd
2025-10-08 15:43:03,341 - DEBUG - API access-list (aae7259f-d6f8-4cfe-8de3-6a2f557607bd) found in api server
2025-10-08 15:43:03,341 - INFO - API access-list aae7259f-d6f8-4cfe-8de3-6a2f557607bd verify on api server passed
2025-10-08 15:43:03,341 - DEBUG - Requesting: http://10.0.0.133:8082/service-template/cc2ddc83-1648-4ab7-94d4-7f0544a25658
2025-10-08 15:43:03,368 - INFO - API Server: Read Service-Template cc2ddc83-1648-4ab7-94d4-7f0544a25658
2025-10-08 15:43:03,368 - DEBUG - Creating service template: ['default-domain', 'ctest-TestRbacBasic-15231640-83026223']
2025-10-08 15:43:03,664 - DEBUG - Requesting: http://10.0.0.133:8082/api-access-list/4d6a7008-afdd-48a7-ba68-d3c359923a11
2025-10-08 15:43:03,675 - DEBUG - API access-list (4d6a7008-afdd-48a7-ba68-d3c359923a11) found in api server
2025-10-08 15:43:03,675 - INFO - API access-list 4d6a7008-afdd-48a7-ba68-d3c359923a11 verify on api server passed
2025-10-08 15:43:03,784 - DEBUG - Requesting: http://10.0.0.133:8082/api-access-list/aae7259f-d6f8-4cfe-8de3-6a2f557607bd
2025-10-08 15:43:03,795 - DEBUG - API access-list (aae7259f-d6f8-4cfe-8de3-6a2f557607bd) found in api server
2025-10-08 15:43:03,795 - INFO - API access-list aae7259f-d6f8-4cfe-8de3-6a2f557607bd verify on api server passed
2025-10-08 15:43:03,795 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:43:04,125 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:43:04,175 - DEBUG - Virtual Network ID: 7b28084a-80fd-44b8-8c0f-a331053d21a6 not found
2025-10-08 15:43:04,175 - INFO - API Server: Permission Denied to read VN 7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:43:04,175 - DEBUG - Requesting: http://10.0.0.133:8082/service-template/cc2ddc83-1648-4ab7-94d4-7f0544a25658
2025-10-08 15:43:04,509 - DEBUG - Requesting: http://10.0.0.133:8082/service-template/cc2ddc83-1648-4ab7-94d4-7f0544a25658
2025-10-08 15:43:04,569 - INFO - API Server: Permission Denied to read ST cc2ddc83-1648-4ab7-94d4-7f0544a25658
2025-10-08 15:43:04,636 - DEBUG - Requesting: http://10.0.0.133:8082/service-template/cc2ddc83-1648-4ab7-94d4-7f0544a25658
2025-10-08 15:43:04,668 - INFO - API Server: Read Service-Template cc2ddc83-1648-4ab7-94d4-7f0544a25658
2025-10-08 15:43:04,668 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:43:04,702 - INFO - API Server: Read VN 7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:43:04,747 - DEBUG - Requesting: http://10.0.0.133:8082/api-access-list/4d6a7008-afdd-48a7-ba68-d3c359923a11
2025-10-08 15:43:04,756 - DEBUG - Response Code: 404
2025-10-08 15:43:04,756 - INFO - API access-list (4d6a7008-afdd-48a7-ba68-d3c359923a11) got deleted in api server
2025-10-08 15:43:04,791 - DEBUG - Requesting: http://10.0.0.133:8082/api-access-list/aae7259f-d6f8-4cfe-8de3-6a2f557607bd
2025-10-08 15:43:04,801 - DEBUG - Response Code: 404
2025-10-08 15:43:04,802 - INFO - API access-list (aae7259f-d6f8-4cfe-8de3-6a2f557607bd) got deleted in api server
2025-10-08 15:43:04,802 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:43:05,110 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:43:05,164 - DEBUG - Virtual Network ID: 7b28084a-80fd-44b8-8c0f-a331053d21a6 not found
2025-10-08 15:43:05,165 - INFO - API Server: Permission Denied to read VN 7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:43:05,165 - DEBUG - Requesting: http://10.0.0.133:8082/service-template/cc2ddc83-1648-4ab7-94d4-7f0544a25658
2025-10-08 15:43:05,505 - DEBUG - Requesting: http://10.0.0.133:8082/service-template/cc2ddc83-1648-4ab7-94d4-7f0544a25658
2025-10-08 15:43:05,556 - INFO - API Server: Permission Denied to read ST cc2ddc83-1648-4ab7-94d4-7f0544a25658
2025-10-08 15:43:05,632 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:43:05,661 - INFO - API Server: Read VN 7b28084a-80fd-44b8-8c0f-a331053d21a6
2025-10-08 15:43:05,662 - DEBUG - Requesting: http://10.0.0.133:8082/service-template/cc2ddc83-1648-4ab7-94d4-7f0544a25658
2025-10-08 15:43:05,684 - INFO - API Server: Read Service-Template cc2ddc83-1648-4ab7-94d4-7f0544a25658
2025-10-08 15:43:05,684 - DEBUG - Deleting service template: ['default-domain', 'ctest-TestRbacBasic-15231640-65764163']
2025-10-08 15:43:05,856 - INFO - Service template: ['default-domain', 'ctest-TestRbacBasic-15231640-65764163'] deleted successfully.
2025-10-08 15:43:05,856 - INFO - Deleting VN ctest-TestRbacBasic-15231640-76754698
2025-10-08 15:43:07,701 - DEBUG - Skipping xmpp flap check
2025-10-08 15:43:07,701 - INFO - END TEST : test_rbac_acl_different_roles : PASSED[0:00:14]
2025-10-08 15:43:07,701 - INFO - --------------------------------------------------------------------------------
2025-10-08 15:43:07,704 - INFO - ================================================================================
2025-10-08 15:43:07,704 - INFO - STARTING TEST : test_rbac_create_delete_vm
2025-10-08 15:43:07,704 - INFO - TEST DESCRIPTION :
Validate creds passed via orchestrator(nova/neutron)
steps:
1. Add user1 as role1
2. Create Rbac ACL under project with role1:CRUD perms for
a. VN.*
b. VM.*
c. VMI.*
d. IIP.*
e. SG.*
f. LR.*
g. FIP-Pool.*
h. ACL.*
3. user1 should be able to create VN and VM via orchestrator
4. Validate the VN and VM
pass: user should be able to create and delete VN and VM
2025-10-08 15:43:08,976 - DEBUG - Skipping xmpp flap check
2025-10-08 15:43:08,982 - INFO - Initial checks done. Running the testcase now
2025-10-08 15:43:08,982 - INFO -
2025-10-08 15:43:09,413 - DEBUG - Response for create_network : {'network': {'id': '2c559b39-99ab-4574-9b4d-1db6723ef4d7', 'name': 'ctest-TestRbacBasic-15231640-22349125', 'tenant_id': '28151b41cfd34d539ebdafad869d9413', 'project_id': '28151b41cfd34d539ebdafad869d9413', 'admin_state_up': True, 'shared': True, 'status': 'ACTIVE', 'router:external': True, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRbacBasic-15231640', 'ctest-TestRbacBasic-15231640-22349125'], 'port_security_enabled': True, 'description': ''}}
2025-10-08 15:43:09,629 - DEBUG - Response for create_subnet : {'subnet': {'id': 'b6cf9f32-3e43-49b2-bf26-b2ae16894094', 'name': '', 'tenant_id': '28151b41cfd34d539ebdafad869d9413', 'network_id': '2c559b39-99ab-4574-9b4d-1db6723ef4d7', 'ip_version': 4, 'cidr': '41.219.40.0/26', 'allocation_pools': [{'start': '41.219.40.2', 'end': '41.219.40.62'}], 'gateway_ip': '41.219.40.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '41.219.40.2', 'tags': [], 'project_id': '28151b41cfd34d539ebdafad869d9413'}}
2025-10-08 15:43:09,657 - INFO - Created VN ctest-TestRbacBasic-15231640-22349125
2025-10-08 15:43:09,670 - DEBUG - VN ctest-TestRbacBasic-15231640-22349125 UUID is 2c559b39-99ab-4574-9b4d-1db6723ef4d7
2025-10-08 15:43:09,841 - DEBUG - Fetched VN: default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-22349125(2c559b39-99ab-4574-9b4d-1db6723ef4d7) with subnets ['41.219.40.0/26']
2025-10-08 15:43:09,841 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2025-10-08 15:43:09,849 - DEBUG - Requesting: http://10.0.0.133:8082/domain/adc52b80-2ed1-485c-90d4-83e78c8e1400
2025-10-08 15:43:09,868 - DEBUG - Requesting: http://10.0.0.133:8082/project/28151b41-cfd3-4d53-9ebd-afad869d9413
2025-10-08 15:43:10,005 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/2c559b39-99ab-4574-9b4d-1db6723ef4d7
2025-10-08 15:43:10,026 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/2c559b39-99ab-4574-9b4d-1db6723ef4d7
2025-10-08 15:43:10,041 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/d4593701-0e41-45ee-b94d-d5c7f05e70e3
2025-10-08 15:43:10,052 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/d4593701-0e41-45ee-b94d-d5c7f05e70e3
2025-10-08 15:43:10,062 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/61ae9ec8-a1f4-45ab-84d7-7d4f74dee458
2025-10-08 15:43:10,072 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-08 15:43:10,072 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/2c559b39-99ab-4574-9b4d-1db6723ef4d7
2025-10-08 15:43:10,089 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/d4593701-0e41-45ee-b94d-d5c7f05e70e3
2025-10-08 15:43:10,108 - INFO - Verified VN network id 14 for VN 2c559b39-99ab-4574-9b4d-1db6723ef4d7
2025-10-08 15:43:10,109 - INFO - Verifications in API Server for VN ctest-TestRbacBasic-15231640-22349125 passed
2025-10-08 15:43:10,109 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/2c559b39-99ab-4574-9b4d-1db6723ef4d7
2025-10-08 15:43:10,121 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/d4593701-0e41-45ee-b94d-d5c7f05e70e3
2025-10-08 15:43:10,131 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/d4593701-0e41-45ee-b94d-d5c7f05e70e3
2025-10-08 15:43:10,141 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/61ae9ec8-a1f4-45ab-84d7-7d4f74dee458
2025-10-08 15:43:10,156 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-22349125', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestRbacBasic-15231640', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3194630182382814580', 'uuid-lslong': '11190633318523532503'}, 'enable': 'true', 'created': '2025-10-08T15:43:09', 'last-modified': '2025-10-08T15:43:09', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.580745'}
2025-10-08 15:43:10,163 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-08 15:43:10,169 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-22349125', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestRbacBasic-15231640', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3194630182382814580', 'uuid-lslong': '11190633318523532503'}, 'enable': 'true', 'created': '2025-10-08T15:43:09', 'last-modified': '2025-10-08T15:43:09', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.594251'}
2025-10-08 15:43:10,176 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-08 15:43:10,185 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-22349125', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestRbacBasic-15231640', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3194630182382814580', 'uuid-lslong': '11190633318523532503'}, 'enable': 'true', 'created': '2025-10-08T15:43:09', 'last-modified': '2025-10-08T15:43:09', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.607364'}
2025-10-08 15:43:10,192 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-08 15:43:10,192 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-TestRbacBasic-15231640-22349125 passed
2025-10-08 15:43:10,193 - DEBUG - ====Verifying policy data for ctest-TestRbacBasic-15231640-22349125 in API_Server ======
2025-10-08 15:43:10,193 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2025-10-08 15:43:10,203 - DEBUG - Requesting: http://10.0.0.133:8082/domain/adc52b80-2ed1-485c-90d4-83e78c8e1400
2025-10-08 15:43:10,218 - DEBUG - Requesting: http://10.0.0.133:8082/project/28151b41-cfd3-4d53-9ebd-afad869d9413
2025-10-08 15:43:10,324 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/2c559b39-99ab-4574-9b4d-1db6723ef4d7
2025-10-08 15:43:10,345 - DEBUG - =>VN ctest-TestRbacBasic-15231640-22349125 has no policy to be verified
2025-10-08 15:43:10,345 - DEBUG - Verifying the vn in opserver
2025-10-08 15:43:10,345 - DEBUG - Verifying the default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-22349125 virtual network link through opserver 10.0.0.133
2025-10-08 15:43:10,345 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2025-10-08 15:43:10,549 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-22349125', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-22349125?flat'}
2025-10-08 15:43:10,549 - DEBUG - Verifying the default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-22349125 virtual network link through opserver 10.0.0.50
2025-10-08 15:43:10,549 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-10-08 15:43:10,620 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-22349125', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-22349125?flat'}
2025-10-08 15:43:10,620 - DEBUG - Verifying the default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-22349125 virtual network link through opserver 10.0.0.242
2025-10-08 15:43:10,620 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2025-10-08 15:43:10,705 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-22349125', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-22349125?flat'}
2025-10-08 15:43:10,705 - INFO - Validated that VN default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-22349125 is found in opserver
2025-10-08 15:43:10,729 - DEBUG - Do not have enough data to verify VN in agent
2025-10-08 15:43:10,742 - DEBUG - VRF ids for VN ctest-TestRbacBasic-15231640-22349125: {}
2025-10-08 15:43:10,969 - DEBUG - Requesting: http://10.0.0.133:8082/api-access-list/66de42d6-8bf9-4925-aaa3-ce3dc8f98b72
2025-10-08 15:43:10,983 - DEBUG - API access-list (66de42d6-8bf9-4925-aaa3-ce3dc8f98b72) found in api server
2025-10-08 15:43:10,983 - INFO - API access-list 66de42d6-8bf9-4925-aaa3-ce3dc8f98b72 verify on api server passed
2025-10-08 15:43:12,112 - DEBUG - Response for create_network : {'network': {'id': '0bf45027-83a8-418d-9908-bf59c3ecfe85', 'name': 'ctest-TestRbacBasic-15231640-88387372', 'tenant_id': '28151b41cfd34d539ebdafad869d9413', 'project_id': '28151b41cfd34d539ebdafad869d9413', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRbacBasic-15231640', 'ctest-TestRbacBasic-15231640-88387372'], 'port_security_enabled': True, 'description': ''}}
2025-10-08 15:43:12,565 - DEBUG - Response for create_subnet : {'subnet': {'id': '765f3393-8a87-4ade-b9af-df73bdd2dad4', 'name': '', 'tenant_id': '28151b41cfd34d539ebdafad869d9413', 'network_id': '0bf45027-83a8-418d-9908-bf59c3ecfe85', 'ip_version': 4, 'cidr': '150.42.118.64/26', 'allocation_pools': [{'start': '150.42.118.66', 'end': '150.42.118.126'}], 'gateway_ip': '150.42.118.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '150.42.118.66', 'tags': [], 'project_id': '28151b41cfd34d539ebdafad869d9413'}}
2025-10-08 15:43:12,634 - INFO - Created VN ctest-TestRbacBasic-15231640-88387372
2025-10-08 15:43:12,691 - DEBUG - VN ctest-TestRbacBasic-15231640-88387372 UUID is 0bf45027-83a8-418d-9908-bf59c3ecfe85
2025-10-08 15:43:13,032 - DEBUG - Fetched VN: default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372(0bf45027-83a8-418d-9908-bf59c3ecfe85) with subnets ['150.42.118.64/26']
2025-10-08 15:43:13,033 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2025-10-08 15:43:13,040 - DEBUG - Requesting: http://10.0.0.133:8082/domain/adc52b80-2ed1-485c-90d4-83e78c8e1400
2025-10-08 15:43:13,057 - DEBUG - Requesting: http://10.0.0.133:8082/project/28151b41-cfd3-4d53-9ebd-afad869d9413
2025-10-08 15:43:13,160 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/0bf45027-83a8-418d-9908-bf59c3ecfe85
2025-10-08 15:43:13,174 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/0bf45027-83a8-418d-9908-bf59c3ecfe85
2025-10-08 15:43:13,186 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/f47a2b4c-33b8-4034-a5e4-376a77e131f2
2025-10-08 15:43:13,197 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/f47a2b4c-33b8-4034-a5e4-376a77e131f2
2025-10-08 15:43:13,206 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/10a032cb-3858-405c-893d-c026005b42f6
2025-10-08 15:43:13,218 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-08 15:43:13,218 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/0bf45027-83a8-418d-9908-bf59c3ecfe85
2025-10-08 15:43:13,228 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/f47a2b4c-33b8-4034-a5e4-376a77e131f2
2025-10-08 15:43:13,246 - INFO - Verified VN network id 15 for VN 0bf45027-83a8-418d-9908-bf59c3ecfe85
2025-10-08 15:43:13,246 - INFO - Verifications in API Server for VN ctest-TestRbacBasic-15231640-88387372 passed
2025-10-08 15:43:13,246 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/0bf45027-83a8-418d-9908-bf59c3ecfe85
2025-10-08 15:43:13,260 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/f47a2b4c-33b8-4034-a5e4-376a77e131f2
2025-10-08 15:43:13,271 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/f47a2b4c-33b8-4034-a5e4-376a77e131f2
2025-10-08 15:43:13,281 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/10a032cb-3858-405c-893d-c026005b42f6
2025-10-08 15:43:13,299 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestRbacBasic-39779729', 'owner-access': '7', 'group': 'ctest-TestRbacBasic-31463353', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '861401559377396109', 'uuid-lslong': '11027274079876742789'}, 'enable': 'true', 'created': '2025-10-08T15:43:11', 'last-modified': '2025-10-08T15:43:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.820622'}
2025-10-08 15:43:13,307 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-08 15:43:13,314 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestRbacBasic-39779729', 'owner-access': '7', 'group': 'ctest-TestRbacBasic-31463353', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '861401559377396109', 'uuid-lslong': '11027274079876742789'}, 'enable': 'true', 'created': '2025-10-08T15:43:11', 'last-modified': '2025-10-08T15:43:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.830603'}
2025-10-08 15:43:13,320 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-08 15:43:13,327 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestRbacBasic-39779729', 'owner-access': '7', 'group': 'ctest-TestRbacBasic-31463353', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '861401559377396109', 'uuid-lslong': '11027274079876742789'}, 'enable': 'true', 'created': '2025-10-08T15:43:11', 'last-modified': '2025-10-08T15:43:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.846329'}
2025-10-08 15:43:13,334 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-08 15:43:13,335 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-TestRbacBasic-15231640-88387372 passed
2025-10-08 15:43:13,335 - DEBUG - ====Verifying policy data for ctest-TestRbacBasic-15231640-88387372 in API_Server ======
2025-10-08 15:43:13,335 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2025-10-08 15:43:13,343 - DEBUG - Requesting: http://10.0.0.133:8082/domain/adc52b80-2ed1-485c-90d4-83e78c8e1400
2025-10-08 15:43:13,358 - DEBUG - Requesting: http://10.0.0.133:8082/project/28151b41-cfd3-4d53-9ebd-afad869d9413
2025-10-08 15:43:13,479 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/0bf45027-83a8-418d-9908-bf59c3ecfe85
2025-10-08 15:43:13,499 - DEBUG - =>VN ctest-TestRbacBasic-15231640-88387372 has no policy to be verified
2025-10-08 15:43:13,499 - DEBUG - Verifying the vn in opserver
2025-10-08 15:43:13,500 - DEBUG - Verifying the default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372 virtual network link through opserver 10.0.0.133
2025-10-08 15:43:13,500 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2025-10-08 15:43:13,611 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372?flat'}
2025-10-08 15:43:13,612 - DEBUG - Verifying the default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372 virtual network link through opserver 10.0.0.50
2025-10-08 15:43:13,612 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-10-08 15:43:13,692 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372?flat'}
2025-10-08 15:43:13,692 - DEBUG - Verifying the default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372 virtual network link through opserver 10.0.0.242
2025-10-08 15:43:13,692 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2025-10-08 15:43:13,760 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372?flat'}
2025-10-08 15:43:13,760 - INFO - Validated that VN default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372 is found in opserver
2025-10-08 15:43:13,782 - DEBUG - Do not have enough data to verify VN in agent
2025-10-08 15:43:13,794 - DEBUG - VRF ids for VN ctest-TestRbacBasic-15231640-88387372: {}
2025-10-08 15:43:13,820 - INFO - Creating Security group: ['default-domain', 'ctest-TestRbacBasic-15231640', 'ctest-TestRbacBasic-15231640-53916092']
2025-10-08 15:43:15,404 - DEBUG - Security group: ['default-domain', 'ctest-TestRbacBasic-15231640', 'ctest-TestRbacBasic-15231640-53916092'] created succesfully
2025-10-08 15:43:15,405 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2025-10-08 15:43:15,433 - DEBUG - Requesting: http://10.0.0.133:8082/domain/adc52b80-2ed1-485c-90d4-83e78c8e1400
2025-10-08 15:43:15,474 - DEBUG - Requesting: http://10.0.0.133:8082/project/28151b41-cfd3-4d53-9ebd-afad869d9413
2025-10-08 15:43:15,555 - DEBUG - Requesting: http://10.0.0.133:8082/security-group/de0b8063-e3b6-4ade-9f95-d84e2023ad80
2025-10-08 15:43:15,581 - INFO - Security group ctest-TestRbacBasic-15231640-53916092 found in the API Server
2025-10-08 15:43:15,581 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2025-10-08 15:43:15,607 - DEBUG - Requesting: http://10.0.0.133:8082/domain/adc52b80-2ed1-485c-90d4-83e78c8e1400
2025-10-08 15:43:15,651 - DEBUG - Requesting: http://10.0.0.133:8082/project/28151b41-cfd3-4d53-9ebd-afad869d9413
2025-10-08 15:43:15,750 - DEBUG - Requesting: http://10.0.0.133:8082/access-control-lists
2025-10-08 15:43:15,823 - INFO - Validated that ACLs for Security group ctest-TestRbacBasic-15231640-53916092 are present in API Server
2025-10-08 15:43:15,835 - INFO - Validated that Security group ctest-TestRbacBasic-15231640-53916092 is found in control node 10.0.0.133
2025-10-08 15:43:15,843 - DEBUG - Security group ctest-TestRbacBasic-15231640-53916092 ACLs found in the control node 10.0.0.133
2025-10-08 15:43:15,851 - INFO - Validated that Security group ctest-TestRbacBasic-15231640-53916092 is found in control node 10.0.0.50
2025-10-08 15:43:15,860 - DEBUG - Security group ctest-TestRbacBasic-15231640-53916092 ACLs found in the control node 10.0.0.50
2025-10-08 15:43:15,870 - INFO - Validated that Security group ctest-TestRbacBasic-15231640-53916092 is found in control node 10.0.0.242
2025-10-08 15:43:15,876 - DEBUG - Security group ctest-TestRbacBasic-15231640-53916092 ACLs found in the control node 10.0.0.242
2025-10-08 15:43:15,876 - INFO - Validated SG ctest-TestRbacBasic-15231640-53916092 in Control nodes
2025-10-08 15:43:16,779 - WARNING - Unable to get the list of compute nodes
2025-10-08 15:43:18,450 - INFO - VM ([]) created on node: (None), Zone: (None)
2025-10-08 15:43:18,538 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-10-08 15:43:23,640 - DEBUG - VM is in ACTIVE state now
2025-10-08 15:43:23,640 - INFO - VM name : ctest-TestRbacBasic-15231640-87195767
2025-10-08 15:43:23,737 - DEBUG - VM ctest-TestRbacBasic-15231640-87195767 ID is aa762a6f-5ac3-43ee-93b4-1a32ea435d1f
2025-10-08 15:43:23,830 - DEBUG - VM is in ACTIVE state now
2025-10-08 15:43:23,871 - DEBUG - VM ctest-TestRbacBasic-15231640-87195767 launched on Node an-jenkins-deploy-platform-ansible-os-4236-1
2025-10-08 15:43:23,987 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine/aa762a6f-5ac3-43ee-93b4-1a32ea435d1f
2025-10-08 15:43:24,340 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine/aa762a6f-5ac3-43ee-93b4-1a32ea435d1f
2025-10-08 15:43:24,403 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine/aa762a6f-5ac3-43ee-93b4-1a32ea435d1f
2025-10-08 15:43:24,429 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine-interface/87c252fc-2456-43a0-a77b-c35072b3b146
2025-10-08 15:43:24,460 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine/aa762a6f-5ac3-43ee-93b4-1a32ea435d1f
2025-10-08 15:43:24,488 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine-interface/87c252fc-2456-43a0-a77b-c35072b3b146
2025-10-08 15:43:24,516 - DEBUG - Requesting: http://10.0.0.242:8082/instance-ip/a9e65ad5-2b3f-4e77-89cc-39c437b9161f
2025-10-08 15:43:24,561 - DEBUG - Verifying in api server 10.0.0.242
2025-10-08 15:43:24,561 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine/aa762a6f-5ac3-43ee-93b4-1a32ea435d1f
2025-10-08 15:43:24,588 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine-interface/87c252fc-2456-43a0-a77b-c35072b3b146
2025-10-08 15:43:24,617 - DEBUG - Requesting: http://10.0.0.242:8082/instance-ip/a9e65ad5-2b3f-4e77-89cc-39c437b9161f
2025-10-08 15:43:24,641 - INFO - VM ctest-TestRbacBasic-15231640-87195767 verfication in all API Servers passed
2025-10-08 15:43:24,666 - DEBUG - VM ctest-TestRbacBasic-15231640-87195767 Tap interface: {'index': '3', 'name': 'tap87c252fc-24', 'uuid': '87c252fc-2456-43a0-a77b-c35072b3b146', 'vrf_name': 'default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372:ctest-TestRbacBasic-15231640-88387372', 'active': 'Active', 'ipv4_active': 'Active', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Enable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Enable', 'type': 'vport', 'label': '24', 'l2_label': '29', 'vxlan_id': '15', 'vn_name': 'default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372', 'vm_uuid': 'aa762a6f-5ac3-43ee-93b4-1a32ea435d1f', 'vm_name': 'ctest-TestRbacBasic-15231640-87195767', 'ip_addr': '150.42.118.67', 'mac_addr': '02:87:c2:52:fc:24', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.3', 'service_vlan_list': None, 'os_ifindex': '125', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestRbacBasic-15231640:87c252fc-2456-43a0-a77b-c35072b3b146', 'sg_uuid_list': ['01fc4607-97e4-46d0-b778-b1982f4cf97c'], 'static_route_list': None, 'vm_project_uuid': '28151b41-cfd3-4d53-9ebd-afad869d9413', 'admin_state': 'Enabled', 'flow_key_idx': '25', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Active', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '00000000-0000-0000-0000-000000000000', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []}
2025-10-08 15:43:24,666 - DEBUG - Agent 10.0.0.61 vrf name: default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372:ctest-TestRbacBasic-15231640-88387372
2025-10-08 15:43:24,674 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372:ctest-TestRbacBasic-15231640-88387372', 'ucindex': '2', 'mcindex': '2', 'l2index': '2', 'source': 'Config; ', 'uc6index': '2', 'vn': 'default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372', 'table_label': '-1', 'vxlan_id': '15', 'evpnindex': '2', 'brindex': '2', 'mplsindex': '0', 'RD': '10.20.0.241:2', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]}
2025-10-08 15:43:25,490 - DEBUG - VM ctest-TestRbacBasic-15231640-87195767 : Tap interface tap87c252fc-24 is set to Active
2025-10-08 15:43:25,491 - DEBUG - Tap interface tap87c252fc-24 detail : {'index': '3', 'name': 'tap87c252fc-24', 'uuid': '87c252fc-2456-43a0-a77b-c35072b3b146', 'vrf_name': 'default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372:ctest-TestRbacBasic-15231640-88387372', 'active': 'Active', 'ipv4_active': 'Active', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Enable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Enable', 'type': 'vport', 'label': '24', 'l2_label': '29', 'vxlan_id': '15', 'vn_name': 'default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372', 'vm_uuid': 'aa762a6f-5ac3-43ee-93b4-1a32ea435d1f', 'vm_name': 'ctest-TestRbacBasic-15231640-87195767', 'ip_addr': '150.42.118.67', 'mac_addr': '02:87:c2:52:fc:24', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.3', 'service_vlan_list': None, 'os_ifindex': '125', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestRbacBasic-15231640:87c252fc-2456-43a0-a77b-c35072b3b146', 'sg_uuid_list': ['01fc4607-97e4-46d0-b778-b1982f4cf97c'], 'static_route_list': None, 'vm_project_uuid': '28151b41-cfd3-4d53-9ebd-afad869d9413', 'admin_state': 'Enabled', 'flow_key_idx': '25', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Active', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '00000000-0000-0000-0000-000000000000', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []}
2025-10-08 15:43:25,664 - DEBUG - Starting Layer 2 verification in Agent
2025-10-08 15:43:25,680 - DEBUG - Layer 2 path is seen for VM MAC 02:87:c2:52:fc:24 in agent 10.0.0.61
2025-10-08 15:43:25,680 - DEBUG - Active layer 2 route in agent is present for VMI tap87c252fc-24
2025-10-08 15:43:25,680 - DEBUG - L2 label(29) matches bw route table and interface table
2025-10-08 15:43:25,691 - DEBUG - VN default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372 is found in Agent of node 10.0.0.61
2025-10-08 15:43:25,875 - DEBUG - VRF IDs of VN default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372 is consistent in agent 10.0.0.61
2025-10-08 15:43:25,875 - DEBUG - Route for VM IP ['150.42.118.67'] is consistent in agent 10.0.0.61
2025-10-08 15:43:25,875 - DEBUG - VN default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372 verification for VM ctest-TestRbacBasic-15231640-87195767 in Agent 10.0.0.61 passed
2025-10-08 15:43:26,055 - DEBUG - Starting all layer 2 verification in agent 10.0.0.61
2025-10-08 15:43:26,068 - DEBUG - Route for VM MAC 02:87:c2:52:fc:24 is consistent in agent 10.0.0.61
2025-10-08 15:43:29,337 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1010ms')
2025-10-08 15:43:29,337 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestRbacBasic-15231640-87195767 failed!
2025-10-08 15:43:29,387 - DEBUG - Gateway for vn default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372 is 150.42.118.65 and allocation pool is NOT set
2025-10-08 15:43:31,459 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=5.33 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.390 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.390/2.861/5.333/2.471 ms')
2025-10-08 15:43:31,459 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestRbacBasic-15231640-87195767 passed
2025-10-08 15:43:31,459 - INFO - VM ctest-TestRbacBasic-15231640-87195767 verifications in Compute nodes passed
2025-10-08 15:43:31,731 - DEBUG - Validated VM route 150.42.118.67 in vrouter of 10.0.0.61
2025-10-08 15:43:31,737 - DEBUG - Remote Nh validation passed. Expected Tunnel, label: None, 0; Got None,0
2025-10-08 15:43:31,737 - INFO - Validated routes of VM ctest-TestRbacBasic-15231640-87195767 in all vrouters
2025-10-08 15:43:32,304 - INFO - Verification in Control-nodes for VM ctest-TestRbacBasic-15231640-87195767 passed
2025-10-08 15:43:32,305 - DEBUG - Verifying the vm in opserver
2025-10-08 15:43:32,305 - DEBUG - Verifying in collector 10.0.0.242 ...
2025-10-08 15:43:32,305 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-machine/aa762a6f-5ac3-43ee-93b4-1a32ea435d1f?flat
2025-10-08 15:43:32,876 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-machine/aa762a6f-5ac3-43ee-93b4-1a32ea435d1f?flat
2025-10-08 15:43:32,999 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestRbacBasic-15231640:87c252fc-2456-43a0-a77b-c35072b3b146?flat
2025-10-08 15:43:33,302 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestRbacBasic-15231640:87c252fc-2456-43a0-a77b-c35072b3b146?flat
2025-10-08 15:43:33,464 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestRbacBasic-15231640:87c252fc-2456-43a0-a77b-c35072b3b146?flat
2025-10-08 15:43:33,538 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-machine/aa762a6f-5ac3-43ee-93b4-1a32ea435d1f?flat
2025-10-08 15:43:33,613 - DEBUG - Verifying vm in vn uve
2025-10-08 15:43:33,613 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestRbacBasic-15231640:87c252fc-2456-43a0-a77b-c35072b3b146?flat
2025-10-08 15:43:33,679 - DEBUG - VM uve shows interface as {'vm_uuid': 'aa762a6f-5ac3-43ee-93b4-1a32ea435d1f', 'fixed_ip4_list': ['150.42.118.67'], 'mac_address': '02:87:c2:52:fc:24', 'admin_state': True, 'l2_active': True, 'rx_vlan': 65535, 'tx_vlan': 65535, 'gateway': '150.42.118.65', 'port_mirror_enabled': False, 'ip4_active': True, 'ip_address': '150.42.118.67', 'vn_uuid': '0bf45027-83a8-418d-9908-bf59c3ecfe85', 'virtual_network': 'default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372', 'vhostuser_mode': 0, 'uuid': '87c252fc-2456-43a0-a77b-c35072b3b146', 'active': True, 'label': 24, 'ip6_address': '::', 'vm_name': 'ctest-TestRbacBasic-15231640-87195767', '__T': 1759938207923318, 'ip6_active': False, 'is_health_check_active': True}
2025-10-08 15:43:33,679 - DEBUG - VM uve shows ip address as ['150.42.118.67', '::']
2025-10-08 15:43:33,679 - DEBUG - VM uve shows virtual network as default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372
2025-10-08 15:43:33,679 - INFO - Verifying through opserver in 10.0.0.133
2025-10-08 15:43:33,679 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372?flat
2025-10-08 15:43:33,784 - DEBUG - expected vm list aa762a6f-5ac3-43ee-93b4-1a32ea435d1f
2025-10-08 15:43:33,784 - DEBUG - Extracted vm list ['aa762a6f-5ac3-43ee-93b4-1a32ea435d1f']
2025-10-08 15:43:33,784 - INFO - VM aa762a6f-5ac3-43ee-93b4-1a32ea435d1f is present in default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372
2025-10-08 15:43:33,784 - DEBUG - Verifying vm in vrouter uve
2025-10-08 15:43:33,785 - DEBUG - Getting info from collector 10.0.0.242..
2025-10-08 15:43:33,785 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-machine/aa762a6f-5ac3-43ee-93b4-1a32ea435d1f?flat
2025-10-08 15:43:33,836 - DEBUG - VM uve shows vrouter as ['an-jenkins-deploy-platform-ansible-os-4236-1']
2025-10-08 15:43:33,837 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4236-1:Compute:contrail-vrouter-agent:0?flat
2025-10-08 15:43:34,220 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4236-1:Compute:contrail-vrouter-agent:0?flat
2025-10-08 15:43:34,316 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4236-1:Compute:contrail-vrouter-agent:0?flat
2025-10-08 15:43:34,373 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4236-1?flat
2025-10-08 15:43:34,406 - DEBUG - VM aa762a6f-5ac3-43ee-93b4-1a32ea435d1f is present in vrouter an-jenkins-deploy-platform-ansible-os-4236-1 uve
2025-10-08 15:43:34,406 - DEBUG - Validated that VM ctest-TestRbacBasic-15231640-87195767 is in Vrouter an-jenkins-deploy-platform-ansible-os-4236-1 UVE
2025-10-08 15:43:34,406 - DEBUG - Verifying vm tap interface/vn in vrouter uve
2025-10-08 15:43:34,414 - DEBUG - Expected tap interface of VM uuid aa762a6f-5ac3-43ee-93b4-1a32ea435d1f is default-domain:ctest-TestRbacBasic-15231640:87c252fc-2456-43a0-a77b-c35072b3b146
2025-10-08 15:43:34,414 - DEBUG - Expected VN of VM uuid aa762a6f-5ac3-43ee-93b4-1a32ea435d1f is default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372
2025-10-08 15:43:34,414 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4236-1:Compute:contrail-vrouter-agent:0?flat
2025-10-08 15:43:34,766 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4236-1:Compute:contrail-vrouter-agent:0?flat
2025-10-08 15:43:34,861 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4236-1:Compute:contrail-vrouter-agent:0?flat
2025-10-08 15:43:34,915 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4236-1?flat
2025-10-08 15:43:34,943 - DEBUG - VM aa762a6f-5ac3-43ee-93b4-1a32ea435d1f is present in vrouter an-jenkins-deploy-platform-ansible-os-4236-1 uve
2025-10-08 15:43:34,943 - INFO - tap interface default-domain:ctest-TestRbacBasic-15231640:87c252fc-2456-43a0-a77b-c35072b3b146 of vm aa762a6f-5ac3-43ee-93b4-1a32ea435d1f is present in vrouter an-jenkins-deploy-platform-ansible-os-4236-1 uve
2025-10-08 15:43:34,944 - DEBUG - Connected network default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372 of vm aa762a6f-5ac3-43ee-93b4-1a32ea435d1f is present in vrouter an-jenkins-deploy-platform-ansible-os-4236-1 uve
2025-10-08 15:43:34,944 - DEBUG - Verifying the aa762a6f-5ac3-43ee-93b4-1a32ea435d1f virtual network link through opserver 10.0.0.133
2025-10-08 15:43:34,944 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-machines
2025-10-08 15:43:35,001 - DEBUG - VM link and name as {'name': 'aa762a6f-5ac3-43ee-93b4-1a32ea435d1f', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-machine/aa762a6f-5ac3-43ee-93b4-1a32ea435d1f?flat'}
2025-10-08 15:43:35,001 - DEBUG - Verifying the aa762a6f-5ac3-43ee-93b4-1a32ea435d1f virtual network link through opserver 10.0.0.50
2025-10-08 15:43:35,001 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-machines
2025-10-08 15:43:35,314 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-machines
2025-10-08 15:43:35,431 - DEBUG - VM link and name as {'name': 'aa762a6f-5ac3-43ee-93b4-1a32ea435d1f', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-machine/aa762a6f-5ac3-43ee-93b4-1a32ea435d1f?flat'}
2025-10-08 15:43:35,431 - DEBUG - Verifying the aa762a6f-5ac3-43ee-93b4-1a32ea435d1f virtual network link through opserver 10.0.0.242
2025-10-08 15:43:35,431 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-machines
2025-10-08 15:43:35,485 - DEBUG - VM link and name as {'name': 'aa762a6f-5ac3-43ee-93b4-1a32ea435d1f', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-machine/aa762a6f-5ac3-43ee-93b4-1a32ea435d1f?flat'}
2025-10-08 15:43:35,485 - INFO - VM ctest-TestRbacBasic-15231640-87195767 validations in Opserver passed
2025-10-08 15:43:35,841 - DEBUG - FIP pool floating-ip-pool already present, not creating it
2025-10-08 15:43:36,482 - DEBUG - Associating FIP:23e6bd9c-cabf-4f60-a1a1-0df7d4996a96 with VMI:aa762a6f-5ac3-43ee-93b4-1a32ea435d1f
2025-10-08 15:43:36,752 - INFO - FIP 41.219.40.3 verification for passed on all Control-nodes
2025-10-08 15:43:36,753 - INFO - FIP ID 23e6bd9c-cabf-4f60-a1a1-0df7d4996a96(41.219.40.3) validation in Control node passed
2025-10-08 15:43:36,776 - DEBUG - agent_label query returned:{'nh': {'type': 'interface', 'ref_count': '14', 'valid': 'true', 'policy': 'enabled', 'itf': 'tap87c252fc-24', 'mac': ['2:87:c2:52:fc:24'], 'mcast': 'disabled', 'nh_index': '25', 'vxlan_flag': 'false', 'intf_flags': '1', 'isid': '0', 'learning_enabled': 'false', 'etree_leaf': 'false', 'layer2_control_word': 'false', 'crypt_all_traffic': 'false', 'crypt_path_available': 'false', 'crypt_interface': None}, 'label': '24', 'vxlan_id': '0', 'peer': '10.20.0.249', 'dest_vn_list': ['default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-22349125'], 'unresolved': 'false', 'sg_list': ['8000007'], 'supported_tunnel_type': 'MPLSoGRE MPLSoUDP ', 'active_tunnel_type': 'MPLSoUDP', 'stale': 'false', 'path_preference_data': {'sequence': '0', 'preference': '200', 'ecmp': 'true'}, 'active_label': '24', 'ecmp_hashing_fields': 'l3-source-address,l3-destination-address,l4-protocol,l4-source-port,l4-destination-port,', 'communities': None, 'peer_sequence_number': '1', 'etree_leaf': 'false', 'layer2_control_word': 'false', 'tag_list': None, 'inactive': 'false', 'origin_vn': None}
2025-10-08 15:43:36,776 - DEBUG - Route for FIP IP 41.219.40.3 is present in agent 10.0.0.61
2025-10-08 15:43:36,776 - DEBUG - FIP 41.219.40.3 verification for VM ctest-TestRbacBasic-15231640-87195767 in Agent 10.0.0.61 passed
2025-10-08 15:43:36,782 - INFO - FIP ID 23e6bd9c-cabf-4f60-a1a1-0df7d4996a96(41.219.40.3) validation in agents passed
2025-10-08 15:43:36,782 - DEBUG - Requesting: http://10.0.0.133:8082/floating-ip/23e6bd9c-cabf-4f60-a1a1-0df7d4996a96
2025-10-08 15:43:36,813 - DEBUG - FIP 23e6bd9c-cabf-4f60-a1a1-0df7d4996a96 is present in API server
2025-10-08 15:43:36,813 - INFO - FIP ID 23e6bd9c-cabf-4f60-a1a1-0df7d4996a96(41.219.40.3) validation in API Server passed
2025-10-08 15:43:37,561 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine/aa762a6f-5ac3-43ee-93b4-1a32ea435d1f
2025-10-08 15:43:37,602 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine-interface/87c252fc-2456-43a0-a77b-c35072b3b146
2025-10-08 15:43:37,639 - DEBUG - Security group ctest-TestRbacBasic-15231640-53916092 is attached to the VM ctest-TestRbacBasic-15231640-87195767
2025-10-08 15:43:37,732 - DEBUG - Agent: Security group ctest-TestRbacBasic-15231640-53916092 is attached to the VM ctest-TestRbacBasic-15231640-87195767
2025-10-08 15:43:37,929 - INFO - Validated that SG ctest-TestRbacBasic-15231640-53916092 is bound to VM ctest-TestRbacBasic-15231640-87195767
2025-10-08 15:43:38,040 - INFO - Deleting VM ctest-TestRbacBasic-15231640-87195767
2025-10-08 15:43:38,138 - DEBUG - Verifying in api server 10.0.0.242
2025-10-08 15:43:38,138 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine/aa762a6f-5ac3-43ee-93b4-1a32ea435d1f
2025-10-08 15:43:38,167 - DEBUG - VM ID aa762a6f-5ac3-43ee-93b4-1a32ea435d1f of VM ctest-TestRbacBasic-15231640-87195767 is still found in API Server
2025-10-08 15:43:40,168 - DEBUG - Verifying in api server 10.0.0.242
2025-10-08 15:43:40,168 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine/aa762a6f-5ac3-43ee-93b4-1a32ea435d1f
2025-10-08 15:43:40,190 - DEBUG - Response Code: 404
2025-10-08 15:43:40,191 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine/aa762a6f-5ac3-43ee-93b4-1a32ea435d1f
2025-10-08 15:43:40,212 - DEBUG - Response Code: 404
2025-10-08 15:43:40,212 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine/aa762a6f-5ac3-43ee-93b4-1a32ea435d1f
2025-10-08 15:43:40,241 - DEBUG - Response Code: 404
2025-10-08 15:43:40,241 - INFO - VM ctest-TestRbacBasic-15231640-87195767 is fully removed in API-Server
2025-10-08 15:43:40,406 - DEBUG - Skipping VM-deletion-check in nova db since mysql_token is not found
2025-10-08 15:43:40,450 - DEBUG - Validated that vrouter 10.0.0.61 does not have VMs route for VN default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372
2025-10-08 15:43:40,462 - DEBUG - Validated that vrouter 10.0.0.241 does not have VMs route for VN default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372
2025-10-08 15:43:40,463 - INFO - Validated that all vrouters do not have VMs route for VN default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372
2025-10-08 15:43:40,463 - INFO - VM ctest-TestRbacBasic-15231640-87195767 is removed in Compute, and routes are removed in all compute nodes
2025-10-08 15:43:40,728 - INFO - Routes for VM ctest-TestRbacBasic-15231640-87195767 is removed in all control-nodes
2025-10-08 15:43:40,729 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4236-1:Compute:contrail-vrouter-agent:0?flat
2025-10-08 15:43:41,128 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4236-1:Compute:contrail-vrouter-agent:0?flat
2025-10-08 15:43:41,234 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4236-1:Compute:contrail-vrouter-agent:0?flat
2025-10-08 15:43:41,285 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4236-1?flat
2025-10-08 15:43:41,320 - DEBUG - VM aa762a6f-5ac3-43ee-93b4-1a32ea435d1f is still present in vrouter an-jenkins-deploy-platform-ansible-os-4236-1 uve
2025-10-08 15:43:41,320 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-10-08 15:43:41,320 - DEBUG - interface for vm aa762a6f-5ac3-43ee-93b4-1a32ea435d1f deleted from vrouter uve ...
2025-10-08 15:43:41,320 - DEBUG - Deleted interface not in error interface list ...
2025-10-08 15:43:44,321 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4236-1:Compute:contrail-vrouter-agent:0?flat
2025-10-08 15:43:44,389 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4236-1?flat
2025-10-08 15:43:44,423 - DEBUG - VM aa762a6f-5ac3-43ee-93b4-1a32ea435d1f is still present in vrouter an-jenkins-deploy-platform-ansible-os-4236-1 uve
2025-10-08 15:43:44,424 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-10-08 15:43:44,424 - DEBUG - interface for vm aa762a6f-5ac3-43ee-93b4-1a32ea435d1f deleted from vrouter uve ...
2025-10-08 15:43:44,424 - DEBUG - Deleted interface not in error interface list ...
2025-10-08 15:43:47,425 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4236-1:Compute:contrail-vrouter-agent:0?flat
2025-10-08 15:43:47,487 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4236-1?flat
2025-10-08 15:43:47,517 - DEBUG - VM aa762a6f-5ac3-43ee-93b4-1a32ea435d1f is still present in vrouter an-jenkins-deploy-platform-ansible-os-4236-1 uve
2025-10-08 15:43:47,517 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-10-08 15:43:47,517 - DEBUG - interface for vm aa762a6f-5ac3-43ee-93b4-1a32ea435d1f deleted from vrouter uve ...
2025-10-08 15:43:47,518 - DEBUG - Deleted interface not in error interface list ...
2025-10-08 15:43:50,518 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4236-1:Compute:contrail-vrouter-agent:0?flat
2025-10-08 15:43:50,570 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4236-1?flat
2025-10-08 15:43:50,601 - DEBUG - VM aa762a6f-5ac3-43ee-93b4-1a32ea435d1f is still present in vrouter an-jenkins-deploy-platform-ansible-os-4236-1 uve
2025-10-08 15:43:50,602 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-10-08 15:43:50,602 - DEBUG - interface for vm aa762a6f-5ac3-43ee-93b4-1a32ea435d1f deleted from vrouter uve ...
2025-10-08 15:43:50,602 - DEBUG - Deleted interface not in error interface list ...
2025-10-08 15:43:53,602 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4236-1:Compute:contrail-vrouter-agent:0?flat
2025-10-08 15:43:53,660 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4236-1?flat
2025-10-08 15:43:53,696 - DEBUG - VM aa762a6f-5ac3-43ee-93b4-1a32ea435d1f is still present in vrouter an-jenkins-deploy-platform-ansible-os-4236-1 uve
2025-10-08 15:43:53,696 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-10-08 15:43:53,696 - DEBUG - interface for vm aa762a6f-5ac3-43ee-93b4-1a32ea435d1f deleted from vrouter uve ...
2025-10-08 15:43:53,696 - DEBUG - Deleted interface not in error interface list ...
2025-10-08 15:43:56,696 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4236-1:Compute:contrail-vrouter-agent:0?flat
2025-10-08 15:43:56,759 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4236-1?flat
2025-10-08 15:43:56,791 - DEBUG - VM aa762a6f-5ac3-43ee-93b4-1a32ea435d1f is still present in vrouter an-jenkins-deploy-platform-ansible-os-4236-1 uve
2025-10-08 15:43:56,791 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-10-08 15:43:56,791 - DEBUG - interface for vm aa762a6f-5ac3-43ee-93b4-1a32ea435d1f deleted from vrouter uve ...
2025-10-08 15:43:56,791 - DEBUG - Deleted interface not in error interface list ...
2025-10-08 15:43:59,792 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4236-1:Compute:contrail-vrouter-agent:0?flat
2025-10-08 15:43:59,844 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4236-1?flat
2025-10-08 15:43:59,876 - DEBUG - VM aa762a6f-5ac3-43ee-93b4-1a32ea435d1f is not present in vrouter an-jenkins-deploy-platform-ansible-os-4236-1 uve
2025-10-08 15:43:59,876 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-10-08 15:43:59,876 - DEBUG - interface for vm aa762a6f-5ac3-43ee-93b4-1a32ea435d1f deleted from vrouter uve ...
2025-10-08 15:43:59,876 - DEBUG - Deleted interface not in error interface list ...
2025-10-08 15:43:59,876 - DEBUG - Validated that VM aa762a6f-5ac3-43ee-93b4-1a32ea435d1f is removed in Vrouter UVE
2025-10-08 15:43:59,876 - DEBUG - Verifying through opserver in 10.0.0.133
2025-10-08 15:43:59,876 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372?flat
2025-10-08 15:43:59,900 - DEBUG - aa762a6f-5ac3-43ee-93b4-1a32ea435d1f BM not in default-domain:ctest-TestRbacBasic-15231640:ctest-TestRbacBasic-15231640-88387372 uve
2025-10-08 15:43:59,900 - DEBUG - Validated that VM aa762a6f-5ac3-43ee-93b4-1a32ea435d1f is not present in the VN UVE
2025-10-08 15:43:59,900 - DEBUG - Verifying the aa762a6f-5ac3-43ee-93b4-1a32ea435d1f virtual network link through opserver 10.0.0.133
2025-10-08 15:43:59,901 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-machines
2025-10-08 15:43:59,916 - INFO - aa762a6f-5ac3-43ee-93b4-1a32ea435d1f vm uve deleted from opserver
2025-10-08 15:43:59,916 - DEBUG - Verifying the aa762a6f-5ac3-43ee-93b4-1a32ea435d1f virtual network link through opserver 10.0.0.50
2025-10-08 15:43:59,916 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-machines
2025-10-08 15:43:59,930 - INFO - aa762a6f-5ac3-43ee-93b4-1a32ea435d1f vm uve deleted from opserver
2025-10-08 15:43:59,930 - DEBUG - Verifying the aa762a6f-5ac3-43ee-93b4-1a32ea435d1f virtual network link through opserver 10.0.0.242
2025-10-08 15:43:59,930 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-machines
2025-10-08 15:43:59,947 - INFO - aa762a6f-5ac3-43ee-93b4-1a32ea435d1f vm uve deleted from opserver
2025-10-08 15:43:59,947 - INFO - Validated that VM aa762a6f-5ac3-43ee-93b4-1a32ea435d1f is removed from Opserver
2025-10-08 15:43:59,947 - INFO - Deleting Security group: ['default-domain', 'ctest-TestRbacBasic-15231640', 'ctest-TestRbacBasic-15231640-53916092']
2025-10-08 15:44:00,153 - INFO - Security group: ['default-domain', 'ctest-TestRbacBasic-15231640', 'ctest-TestRbacBasic-15231640-53916092'] deleted successfully.
2025-10-08 15:44:00,153 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2025-10-08 15:44:00,201 - DEBUG - Requesting: http://10.0.0.133:8082/domain/adc52b80-2ed1-485c-90d4-83e78c8e1400
2025-10-08 15:44:00,242 - DEBUG - Requesting: http://10.0.0.133:8082/project/28151b41-cfd3-4d53-9ebd-afad869d9413
2025-10-08 15:44:00,325 - INFO - Security group ctest-TestRbacBasic-15231640-53916092 removed from the API Server
2025-10-08 15:44:00,325 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2025-10-08 15:44:00,351 - DEBUG - Requesting: http://10.0.0.133:8082/domain/adc52b80-2ed1-485c-90d4-83e78c8e1400
2025-10-08 15:44:00,394 - DEBUG - Requesting: http://10.0.0.133:8082/project/28151b41-cfd3-4d53-9ebd-afad869d9413
2025-10-08 15:44:00,499 - DEBUG - Requesting: http://10.0.0.133:8082/access-control-lists
2025-10-08 15:44:00,548 - DEBUG - ACLs for Security group ctest-TestRbacBasic-15231640-53916092 removed from the API Server
2025-10-08 15:44:00,554 - INFO - security group ctest-TestRbacBasic-15231640-53916092 removed from Control-node 10.0.0.133
2025-10-08 15:44:00,561 - DEBUG - Security group ctest-TestRbacBasic-15231640-53916092 ACLs removed from the control node 10.0.0.133
2025-10-08 15:44:00,567 - INFO - security group ctest-TestRbacBasic-15231640-53916092 removed from Control-node 10.0.0.50
2025-10-08 15:44:00,574 - DEBUG - Security group ctest-TestRbacBasic-15231640-53916092 ACLs removed from the control node 10.0.0.50
2025-10-08 15:44:00,583 - INFO - security group ctest-TestRbacBasic-15231640-53916092 removed from Control-node 10.0.0.242
2025-10-08 15:44:00,591 - DEBUG - Security group ctest-TestRbacBasic-15231640-53916092 ACLs removed from the control node 10.0.0.242
2025-10-08 15:44:00,591 - INFO - Validated that SG ctest-TestRbacBasic-15231640-53916092 is not in control nodes
2025-10-08 15:44:00,591 - INFO - Deleting VN ctest-TestRbacBasic-15231640-88387372
2025-10-08 15:44:00,868 - DEBUG - Response for deleting network ()
2025-10-08 15:44:00,922 - DEBUG - Requesting: http://10.0.0.133:8082/api-access-list/66de42d6-8bf9-4925-aaa3-ce3dc8f98b72
2025-10-08 15:44:00,935 - DEBUG - Response Code: 404
2025-10-08 15:44:00,935 - INFO - API access-list (66de42d6-8bf9-4925-aaa3-ce3dc8f98b72) got deleted in api server
2025-10-08 15:44:01,067 - INFO - Deleting VN ctest-TestRbacBasic-15231640-22349125
2025-10-08 15:44:01,273 - DEBUG - Response for deleting network ()
2025-10-08 15:44:02,549 - DEBUG - Skipping xmpp flap check
2025-10-08 15:44:02,549 - INFO - END TEST : test_rbac_create_delete_vm : PASSED[0:00:55]
2025-10-08 15:44:02,549 - INFO - --------------------------------------------------------------------------------
2025-10-08 15:44:04,270 - INFO - Deleted project: ctest-TestRbacBasic-15231640, ID : 28151b41-cfd3-4d53-9ebd-afad869d9413