2026-06-01 03:04:29,795 - INFO - Domain Default found not creating
2026-06-01 03:04:29,959 - INFO - Project ctest-SecurityGroupBasicRegressionTests1-41651543 not found, creating it
2026-06-01 03:04:30,569 - INFO - Created Project:ctest-SecurityGroupBasicRegressionTests1-41651543, ID : fd6e7240-94af-49c8-8f47-7f93d49d1220
2026-06-01 03:04:32,048 - INFO - ================================================================================
2026-06-01 03:04:32,048 - INFO - STARTING TEST : test_sec_group_basic
2026-06-01 03:04:32,048 - INFO - TEST DESCRIPTION :
Description: Test basic SG features
1. Security group create and delete
2. Create security group with custom rules and then update it for tcp
3. Launch VM with custom created security group and verify
4. Remove secuity group association with VM
5. Add back custom security group to VM and verify
6. Try to delete security group with association to VM. It should fail.
7. Test with ping, which should fail
8. Test with TCP which should pass
9. Update the rules to allow icmp, ping should pass now.
2026-06-01 03:04:33,367 - DEBUG - Nothing to compare xmpp stats {'10.0.0.130': {'10.20.0.193': '0', '10.20.0.129': '0'}, '10.0.0.73': {'10.20.0.193': '0', '10.20.0.129': '0'}} with
2026-06-01 03:04:33,367 - INFO - Initial checks done. Running the testcase now
2026-06-01 03:04:33,367 - INFO -
2026-06-01 03:04:33,756 - INFO - Creating Security group: ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-test_sec_group-92070023']
2026-06-01 03:04:35,180 - DEBUG - Security group: ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-test_sec_group-92070023'] created succesfully
2026-06-01 03:04:35,180 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:04:35,474 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:04:35,509 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:04:35,525 - DEBUG - Requesting: http://10.0.0.240:8082/project/fd6e7240-94af-49c8-8f47-7f93d49d1220
2026-06-01 03:04:35,621 - DEBUG - Requesting: http://10.0.0.240:8082/security-group/cec2cd41-e1ce-4c8f-b132-6f28b3684249
2026-06-01 03:04:35,631 - INFO - Security group ctest-test_sec_group-92070023 found in the API Server
2026-06-01 03:04:35,631 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:04:35,638 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:04:35,649 - DEBUG - Requesting: http://10.0.0.240:8082/project/fd6e7240-94af-49c8-8f47-7f93d49d1220
2026-06-01 03:04:35,740 - DEBUG - Requesting: http://10.0.0.240:8082/access-control-lists
2026-06-01 03:04:35,749 - INFO - Validated that ACLs for Security group ctest-test_sec_group-92070023 are present in API Server
2026-06-01 03:04:35,755 - INFO - Validated that Security group ctest-test_sec_group-92070023 is found in control node 10.0.0.240
2026-06-01 03:04:35,761 - DEBUG - Security group ctest-test_sec_group-92070023 ACLs found in the control node 10.0.0.240
2026-06-01 03:04:35,767 - INFO - Validated that Security group ctest-test_sec_group-92070023 is found in control node 10.0.0.249
2026-06-01 03:04:35,774 - DEBUG - Security group ctest-test_sec_group-92070023 ACLs found in the control node 10.0.0.249
2026-06-01 03:04:35,781 - INFO - Validated that Security group ctest-test_sec_group-92070023 is found in control node 10.0.0.65
2026-06-01 03:04:35,787 - DEBUG - Security group ctest-test_sec_group-92070023 ACLs found in the control node 10.0.0.65
2026-06-01 03:04:35,787 - INFO - Validated SG ctest-test_sec_group-92070023 in Control nodes
2026-06-01 03:04:35,788 - INFO - Deleting Security group: ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-test_sec_group-92070023']
2026-06-01 03:04:35,866 - INFO - Security group: ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-test_sec_group-92070023'] deleted successfully.
2026-06-01 03:04:35,867 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:04:35,879 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:04:35,895 - DEBUG - Requesting: http://10.0.0.240:8082/project/fd6e7240-94af-49c8-8f47-7f93d49d1220
2026-06-01 03:04:35,998 - INFO - Security group ctest-test_sec_group-92070023 removed from the API Server
2026-06-01 03:04:35,999 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:04:36,008 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:04:36,019 - DEBUG - Requesting: http://10.0.0.240:8082/project/fd6e7240-94af-49c8-8f47-7f93d49d1220
2026-06-01 03:04:36,125 - DEBUG - Requesting: http://10.0.0.240:8082/access-control-lists
2026-06-01 03:04:36,138 - DEBUG - ACLs for Security group ctest-test_sec_group-92070023 removed from the API Server
2026-06-01 03:04:36,145 - INFO - security group ctest-test_sec_group-92070023 removed from Control-node 10.0.0.240
2026-06-01 03:04:36,152 - DEBUG - Security group ctest-test_sec_group-92070023 ACLs removed from the control node 10.0.0.240
2026-06-01 03:04:36,159 - INFO - security group ctest-test_sec_group-92070023 removed from Control-node 10.0.0.249
2026-06-01 03:04:36,167 - DEBUG - Security group ctest-test_sec_group-92070023 ACLs removed from the control node 10.0.0.249
2026-06-01 03:04:36,173 - INFO - security group ctest-test_sec_group-92070023 removed from Control-node 10.0.0.65
2026-06-01 03:04:36,179 - DEBUG - Security group ctest-test_sec_group-92070023 ACLs removed from the control node 10.0.0.65
2026-06-01 03:04:36,179 - INFO - Validated that SG ctest-test_sec_group-92070023 is not in control nodes
2026-06-01 03:04:36,187 - INFO - Creating Security group: ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-test_sec_group-92070023']
2026-06-01 03:04:37,294 - DEBUG - Security group: ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-test_sec_group-92070023'] created succesfully
2026-06-01 03:04:37,294 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:04:37,305 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:04:37,319 - DEBUG - Requesting: http://10.0.0.240:8082/project/fd6e7240-94af-49c8-8f47-7f93d49d1220
2026-06-01 03:04:37,408 - DEBUG - Requesting: http://10.0.0.240:8082/security-group/059befd2-9eb7-4d03-babf-6d4280451db1
2026-06-01 03:04:37,422 - INFO - Security group ctest-test_sec_group-92070023 found in the API Server
2026-06-01 03:04:37,422 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:04:37,430 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:04:37,445 - DEBUG - Requesting: http://10.0.0.240:8082/project/fd6e7240-94af-49c8-8f47-7f93d49d1220
2026-06-01 03:04:37,550 - DEBUG - Requesting: http://10.0.0.240:8082/access-control-lists
2026-06-01 03:04:37,560 - INFO - Validated that ACLs for Security group ctest-test_sec_group-92070023 are present in API Server
2026-06-01 03:04:37,565 - INFO - Validated that Security group ctest-test_sec_group-92070023 is found in control node 10.0.0.240
2026-06-01 03:04:37,573 - DEBUG - Security group ctest-test_sec_group-92070023 ACLs found in the control node 10.0.0.240
2026-06-01 03:04:37,579 - INFO - Validated that Security group ctest-test_sec_group-92070023 is found in control node 10.0.0.249
2026-06-01 03:04:37,585 - DEBUG - Security group ctest-test_sec_group-92070023 ACLs found in the control node 10.0.0.249
2026-06-01 03:04:37,590 - INFO - Validated that Security group ctest-test_sec_group-92070023 is found in control node 10.0.0.65
2026-06-01 03:04:37,596 - DEBUG - Security group ctest-test_sec_group-92070023 ACLs found in the control node 10.0.0.65
2026-06-01 03:04:37,596 - INFO - Validated SG ctest-test_sec_group-92070023 in Control nodes
2026-06-01 03:04:37,596 - DEBUG - Replace all the rules of this security group ctest-test_sec_group-92070023 with the new rules
2026-06-01 03:04:37,596 - DEBUG - [{'protocol': 'tcp', 'dst_addresses': [{'subnet': {'ip_prefix': '4.54.174.0', 'ip_prefix_len': '26'}}], 'dst_ports': [{'start_port': 0, 'end_port': -1}], 'src_ports': [{'start_port': 0, 'end_port': -1}], 'src_addresses': [{'security_group': 'local'}]}, {'protocol': 'tcp', 'src_addresses': [{'subnet': {'ip_prefix': '4.54.174.0', 'ip_prefix_len': '26'}}], 'dst_ports': [{'start_port': 0, 'end_port': -1}], 'src_ports': [{'start_port': 0, 'end_port': -1}], 'dst_addresses': [{'security_group': 'local'}]}]
2026-06-01 03:04:38,566 - DEBUG - Response for create_network : {'network': {'id': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'name': 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', 'tenant_id': 'fd6e724094af49c88f477f93d49d1220', 'project_id': 'fd6e724094af49c88f477f93d49d1220', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'port_security_enabled': True, 'description': ''}}
2026-06-01 03:04:38,902 - DEBUG - Response for create_subnet : {'subnet': {'id': '14c2fd61-c776-4875-9419-731c2bf8ccd2', 'name': '', 'tenant_id': 'fd6e724094af49c88f477f93d49d1220', 'network_id': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'ip_version': 4, 'cidr': '4.54.174.0/26', 'allocation_pools': [{'start': '4.54.174.2', 'end': '4.54.174.62'}], 'gateway_ip': '4.54.174.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '4.54.174.2', 'tags': [], 'project_id': 'fd6e724094af49c88f477f93d49d1220'}}
2026-06-01 03:04:38,929 - INFO - Created VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924
2026-06-01 03:04:38,952 - DEBUG - VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 UUID is 6f2c174e-47bf-4561-8ed1-e28d22eab842
2026-06-01 03:04:39,040 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:04:39,047 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:04:39,059 - DEBUG - Requesting: http://10.0.0.240:8082/project/fd6e7240-94af-49c8-8f47-7f93d49d1220
2026-06-01 03:04:39,159 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842
2026-06-01 03:04:39,176 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842
2026-06-01 03:04:39,187 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e3c73bdc-46cc-43d3-bf17-331832e7b677
2026-06-01 03:04:39,195 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e3c73bdc-46cc-43d3-bf17-331832e7b677
2026-06-01 03:04:39,204 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/38dc4e05-444e-4d5c-a086-5c46d5326503
2026-06-01 03:04:39,212 - DEBUG - Route Targets: ['target:64512:8000005']
2026-06-01 03:04:39,212 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842
2026-06-01 03:04:39,221 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e3c73bdc-46cc-43d3-bf17-331832e7b677
2026-06-01 03:04:39,239 - INFO - Verified VN network id 15 for VN 6f2c174e-47bf-4561-8ed1-e28d22eab842
2026-06-01 03:04:39,239 - INFO - Verifications in API Server for VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 passed
2026-06-01 03:04:39,239 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842
2026-06-01 03:04:39,252 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e3c73bdc-46cc-43d3-bf17-331832e7b677
2026-06-01 03:04:39,260 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e3c73bdc-46cc-43d3-bf17-331832e7b677
2026-06-01 03:04:39,269 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/38dc4e05-444e-4d5c-a086-5c46d5326503
2026-06-01 03:04:39,283 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8010803462163875169', 'uuid-lslong': '10291255719322368066'}, 'enable': 'true', 'created': '2026-06-01T03:04:38', 'last-modified': '2026-06-01T03:04:38', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.500375'}
2026-06-01 03:04:39,291 - DEBUG - Route Targets: ['target:64512:8000005']
2026-06-01 03:04:39,297 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8010803462163875169', 'uuid-lslong': '10291255719322368066'}, 'enable': 'true', 'created': '2026-06-01T03:04:38', 'last-modified': '2026-06-01T03:04:38', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.510665'}
2026-06-01 03:04:39,304 - DEBUG - Route Targets: ['target:64512:8000005']
2026-06-01 03:04:39,311 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8010803462163875169', 'uuid-lslong': '10291255719322368066'}, 'enable': 'true', 'created': '2026-06-01T03:04:38', 'last-modified': '2026-06-01T03:04:38', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.527757'}
2026-06-01 03:04:39,318 - DEBUG - Route Targets: ['target:64512:8000005']
2026-06-01 03:04:39,318 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 passed
2026-06-01 03:04:39,318 - DEBUG - ====Verifying policy data for ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 in API_Server ======
2026-06-01 03:04:39,319 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:04:39,326 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:04:39,338 - DEBUG - Requesting: http://10.0.0.240:8082/project/fd6e7240-94af-49c8-8f47-7f93d49d1220
2026-06-01 03:04:39,448 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842
2026-06-01 03:04:39,470 - DEBUG - =>VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 has no policy to be verified
2026-06-01 03:04:39,470 - DEBUG - Verifying the vn in opserver
2026-06-01 03:04:39,470 - DEBUG - Verifying the default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 virtual network link through opserver 10.0.0.240
2026-06-01 03:04:39,470 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-06-01 03:04:39,788 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-06-01 03:04:39,870 - DEBUG - vn link and name as {'name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924?flat'}
2026-06-01 03:04:39,870 - DEBUG - Verifying the default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 virtual network link through opserver 10.0.0.249
2026-06-01 03:04:39,870 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-06-01 03:04:40,167 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-06-01 03:04:40,256 - DEBUG - vn link and name as {'name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924?flat'}
2026-06-01 03:04:40,256 - DEBUG - Verifying the default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 virtual network link through opserver 10.0.0.65
2026-06-01 03:04:40,256 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-06-01 03:04:40,563 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-06-01 03:04:40,636 - DEBUG - vn link and name as {'name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924?flat'}
2026-06-01 03:04:40,636 - INFO - Validated that VN default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is found in opserver
2026-06-01 03:04:40,656 - DEBUG - Do not have enough data to verify VN in agent
2026-06-01 03:04:40,666 - DEBUG - VRF ids for VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924: {}
2026-06-01 03:04:40,854 - DEBUG - Services list from nova: [, , , ]
2026-06-01 03:04:42,193 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5860-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5860-2)
2026-06-01 03:04:43,771 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5860-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5860-1)
2026-06-01 03:04:43,871 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-06-01 03:04:48,959 - DEBUG - VM is in ACTIVE state now
2026-06-01 03:04:48,959 - INFO - VM name : ctest-SecurityGroupBasicRegressionTests1-41651543-50979008
2026-06-01 03:04:49,038 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 ID is 50520956-45d7-455e-ab41-aeb73042463d
2026-06-01 03:04:49,139 - DEBUG - VM is in ACTIVE state now
2026-06-01 03:04:49,168 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 launched on Node an-jenkins-deploy-platform-ansible-os-5860-2
2026-06-01 03:04:49,254 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/50520956-45d7-455e-ab41-aeb73042463d
2026-06-01 03:04:49,557 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/50520956-45d7-455e-ab41-aeb73042463d
2026-06-01 03:04:49,594 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/50520956-45d7-455e-ab41-aeb73042463d
2026-06-01 03:04:49,601 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/0f818c11-e489-4d8e-80dd-f7f162a93d38
2026-06-01 03:04:49,612 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/50520956-45d7-455e-ab41-aeb73042463d
2026-06-01 03:04:49,620 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/0f818c11-e489-4d8e-80dd-f7f162a93d38
2026-06-01 03:04:49,632 - DEBUG - Requesting: http://10.0.0.65:8082/instance-ip/91537e44-ca93-4f51-89a5-a4186039a4ca
2026-06-01 03:04:49,645 - DEBUG - Verifying in api server 10.0.0.65
2026-06-01 03:04:49,645 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/50520956-45d7-455e-ab41-aeb73042463d
2026-06-01 03:04:49,657 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/0f818c11-e489-4d8e-80dd-f7f162a93d38
2026-06-01 03:04:49,668 - DEBUG - Requesting: http://10.0.0.65:8082/instance-ip/91537e44-ca93-4f51-89a5-a4186039a4ca
2026-06-01 03:04:49,679 - INFO - VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 verfication in all API Servers passed
2026-06-01 03:04:49,705 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 Tap interface: {'index': '4', 'name': 'tap0f818c11-e4', 'uuid': '0f818c11-e489-4d8e-80dd-f7f162a93d38', 'vrf_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', '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': '32', 'l2_label': '36', 'vxlan_id': '15', 'vn_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', 'vm_uuid': '50520956-45d7-455e-ab41-aeb73042463d', 'vm_name': 'ctest-SecurityGroupBasicRegressionTests1-41651543-50979008', 'ip_addr': '4.54.174.3', 'mac_addr': '02:0f:81:8c:11:e4', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.4', 'service_vlan_list': None, 'os_ifindex': '77', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:0f818c11-e489-4d8e-80dd-f7f162a93d38', 'sg_uuid_list': ['059befd2-9eb7-4d03-babf-6d4280451db1'], 'static_route_list': None, 'vm_project_uuid': 'fd6e7240-94af-49c8-8f47-7f93d49d1220', 'admin_state': 'Enabled', 'flow_key_idx': '41', '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': []}
2026-06-01 03:04:49,706 - DEBUG - Agent 10.0.0.73 vrf name: default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924
2026-06-01 03:04:49,713 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', 'ucindex': '3', 'mcindex': '3', 'l2index': '3', 'source': 'Config; ', 'uc6index': '3', 'vn': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', 'table_label': '-1', 'vxlan_id': '15', 'evpnindex': '3', 'brindex': '3', 'mplsindex': '0', 'RD': '10.20.0.192:3', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]}
2026-06-01 03:04:49,798 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 : Tap interface tap0f818c11-e4 is set to Active
2026-06-01 03:04:49,798 - DEBUG - Tap interface tap0f818c11-e4 detail : {'index': '4', 'name': 'tap0f818c11-e4', 'uuid': '0f818c11-e489-4d8e-80dd-f7f162a93d38', 'vrf_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', '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': '32', 'l2_label': '36', 'vxlan_id': '15', 'vn_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', 'vm_uuid': '50520956-45d7-455e-ab41-aeb73042463d', 'vm_name': 'ctest-SecurityGroupBasicRegressionTests1-41651543-50979008', 'ip_addr': '4.54.174.3', 'mac_addr': '02:0f:81:8c:11:e4', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.4', 'service_vlan_list': None, 'os_ifindex': '77', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:0f818c11-e489-4d8e-80dd-f7f162a93d38', 'sg_uuid_list': ['059befd2-9eb7-4d03-babf-6d4280451db1'], 'static_route_list': None, 'vm_project_uuid': 'fd6e7240-94af-49c8-8f47-7f93d49d1220', 'admin_state': 'Enabled', 'flow_key_idx': '41', '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': []}
2026-06-01 03:04:49,911 - DEBUG - Starting Layer 2 verification in Agent
2026-06-01 03:04:49,925 - DEBUG - Layer 2 path is seen for VM MAC 02:0f:81:8c:11:e4 in agent 10.0.0.73
2026-06-01 03:04:49,926 - DEBUG - Active layer 2 route in agent is present for VMI tap0f818c11-e4
2026-06-01 03:04:49,926 - DEBUG - L2 label(36) matches bw route table and interface table
2026-06-01 03:04:49,933 - DEBUG - VN default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is found in Agent of node 10.0.0.130
2026-06-01 03:04:50,067 - DEBUG - VRF IDs of VN default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is consistent in agent 10.0.0.130
2026-06-01 03:04:50,067 - DEBUG - Route for VM IP ['4.54.174.3'] is consistent in agent 10.0.0.130
2026-06-01 03:04:50,067 - DEBUG - VN default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 verification for VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 in Agent 10.0.0.130 passed
2026-06-01 03:04:50,184 - DEBUG - Starting all layer 2 verification in agent 10.0.0.130
2026-06-01 03:04:50,198 - DEBUG - Route for VM MAC 02:0f:81:8c:11:e4 is consistent in agent 10.0.0.130
2026-06-01 03:04:50,206 - DEBUG - VN default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is found in Agent of node 10.0.0.73
2026-06-01 03:04:50,339 - DEBUG - VRF IDs of VN default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is consistent in agent 10.0.0.73
2026-06-01 03:04:50,340 - DEBUG - Route for VM IP ['4.54.174.3'] is consistent in agent 10.0.0.73
2026-06-01 03:04:50,340 - DEBUG - VN default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 verification for VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 in Agent 10.0.0.73 passed
2026-06-01 03:04:50,460 - DEBUG - Starting all layer 2 verification in agent 10.0.0.73
2026-06-01 03:04:50,474 - DEBUG - Route for VM MAC 02:0f:81:8c:11:e4 is consistent in agent 10.0.0.73
2026-06-01 03:04:53,672 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1019ms')
2026-06-01 03:04:53,673 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 failed!
2026-06-01 03:04:53,687 - DEBUG - Gateway for vn default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is 4.54.174.1 and allocation pool is NOT set
2026-06-01 03:04:57,771 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1023ms')
2026-06-01 03:04:57,771 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 failed!
2026-06-01 03:04:57,787 - DEBUG - Gateway for vn default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is 4.54.174.1 and allocation pool is NOT set
2026-06-01 03:05:01,866 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1011ms')
2026-06-01 03:05:01,866 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 failed!
2026-06-01 03:05:01,887 - DEBUG - Gateway for vn default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is 4.54.174.1 and allocation pool is NOT set
2026-06-01 03:05:05,957 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1012ms')
2026-06-01 03:05:05,957 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 failed!
2026-06-01 03:05:05,972 - DEBUG - Gateway for vn default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is 4.54.174.1 and allocation pool is NOT set
2026-06-01 03:05:10,048 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1015ms')
2026-06-01 03:05:10,048 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 failed!
2026-06-01 03:05:10,065 - DEBUG - Gateway for vn default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is 4.54.174.1 and allocation pool is NOT set
2026-06-01 03:05:14,151 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1021ms')
2026-06-01 03:05:14,151 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 failed!
2026-06-01 03:05:14,165 - DEBUG - Gateway for vn default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is 4.54.174.1 and allocation pool is NOT set
2026-06-01 03:05:18,248 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1019ms')
2026-06-01 03:05:18,248 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 failed!
2026-06-01 03:05:18,264 - DEBUG - Gateway for vn default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is 4.54.174.1 and allocation pool is NOT set
2026-06-01 03:05:22,343 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms')
2026-06-01 03:05:22,344 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 failed!
2026-06-01 03:05:22,359 - DEBUG - Gateway for vn default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is 4.54.174.1 and allocation pool is NOT set
2026-06-01 03:05:24,424 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n64 bytes from 169.254.0.4: icmp_seq=1 ttl=63 time=5.89 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.766 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.766/3.325/5.885/2.559 ms')
2026-06-01 03:05:24,424 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 passed
2026-06-01 03:05:24,425 - INFO - VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 verifications in Compute nodes passed
2026-06-01 03:05:24,618 - DEBUG - Validated VM route 4.54.174.3 in vrouter of 10.0.0.130
2026-06-01 03:05:24,622 - DEBUG - Remote Nh validation passed. Expected Tunnel, label: 10.20.0.192, 32; Got 10.20.0.192,32
2026-06-01 03:05:24,622 - DEBUG - Validated VM route 4.54.174.3 in vrouter of 10.0.0.130
2026-06-01 03:05:24,748 - DEBUG - Validated VM route 4.54.174.3 in vrouter of 10.0.0.73
2026-06-01 03:05:24,754 - DEBUG - Remote Nh validation passed. Expected Tunnel, label: None, 0; Got None,0
2026-06-01 03:05:24,754 - INFO - Validated routes of VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 in all vrouters
2026-06-01 03:05:25,171 - DEBUG - Starting all layer2 verification in 10.0.0.249 Control Node
2026-06-01 03:05:25,298 - DEBUG - Layer2 route found for VM MAC 02:0f:81:8c:11:e4 in Control-node 10.0.0.249
2026-06-01 03:05:25,298 - DEBUG - L2 Label for VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 same between Control-node 10.0.0.249 and Agent, Expected: 36, Seen: 36
2026-06-01 03:05:25,298 - DEBUG - Starting all layer2 verification in 10.0.0.65 Control Node
2026-06-01 03:05:25,422 - DEBUG - Layer2 route found for VM MAC 02:0f:81:8c:11:e4 in Control-node 10.0.0.65
2026-06-01 03:05:25,423 - DEBUG - L2 Label for VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 same between Control-node 10.0.0.65 and Agent, Expected: 36, Seen: 36
2026-06-01 03:05:25,423 - INFO - Verification in Control-nodes for VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 passed
2026-06-01 03:05:25,423 - DEBUG - Verifying the vm in opserver
2026-06-01 03:05:25,423 - DEBUG - Verifying in collector 10.0.0.65 ...
2026-06-01 03:05:25,423 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-machine/50520956-45d7-455e-ab41-aeb73042463d?flat
2026-06-01 03:05:25,491 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:0f818c11-e489-4d8e-80dd-f7f162a93d38?flat
2026-06-01 03:05:25,566 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:0f818c11-e489-4d8e-80dd-f7f162a93d38?flat
2026-06-01 03:05:25,676 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-machine/50520956-45d7-455e-ab41-aeb73042463d?flat
2026-06-01 03:05:25,691 - DEBUG - Verifying vm in vn uve
2026-06-01 03:05:25,691 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:0f818c11-e489-4d8e-80dd-f7f162a93d38?flat
2026-06-01 03:05:25,722 - DEBUG - VM uve shows interface as {'ip_address': '4.54.174.3', 'mac_address': '02:0f:81:8c:11:e4', 'vhostuser_mode': 0, 'rx_vlan': 65535, 'l2_active': True, '__T': 1780283095038592, 'vm_uuid': '50520956-45d7-455e-ab41-aeb73042463d', 'ip6_address': '::', 'vm_name': 'ctest-SecurityGroupBasicRegressionTests1-41651543-50979008', 'port_mirror_enabled': False, 'ip6_active': False, 'uuid': '0f818c11-e489-4d8e-80dd-f7f162a93d38', 'admin_state': True, 'virtual_network': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', 'ip4_active': True, 'is_health_check_active': True, 'label': 32, 'tx_vlan': 65535, 'gateway': '4.54.174.1', 'vn_uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'fixed_ip4_list': ['4.54.174.3'], 'active': True}
2026-06-01 03:05:25,722 - DEBUG - VM uve shows ip address as ['4.54.174.3', '::']
2026-06-01 03:05:25,722 - DEBUG - VM uve shows virtual network as default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924
2026-06-01 03:05:25,722 - INFO - Verifying through opserver in 10.0.0.240
2026-06-01 03:05:25,723 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924?flat
2026-06-01 03:05:25,749 - DEBUG - expected vm list 50520956-45d7-455e-ab41-aeb73042463d
2026-06-01 03:05:25,749 - DEBUG - Extracted vm list ['50520956-45d7-455e-ab41-aeb73042463d']
2026-06-01 03:05:25,749 - INFO - VM 50520956-45d7-455e-ab41-aeb73042463d is present in default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924
2026-06-01 03:05:25,749 - DEBUG - Verifying vm in vrouter uve
2026-06-01 03:05:25,749 - DEBUG - Getting info from collector 10.0.0.65..
2026-06-01 03:05:25,749 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-machine/50520956-45d7-455e-ab41-aeb73042463d?flat
2026-06-01 03:05:25,820 - DEBUG - VM uve shows vrouter as ['an-jenkins-deploy-platform-ansible-os-5860-2']
2026-06-01 03:05:25,820 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5860-2:Compute:contrail-vrouter-agent:0?flat
2026-06-01 03:05:25,855 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5860-2?flat
2026-06-01 03:05:25,891 - DEBUG - VM 50520956-45d7-455e-ab41-aeb73042463d is present in vrouter an-jenkins-deploy-platform-ansible-os-5860-2 uve
2026-06-01 03:05:25,891 - DEBUG - Validated that VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 is in Vrouter an-jenkins-deploy-platform-ansible-os-5860-2 UVE
2026-06-01 03:05:25,891 - DEBUG - Verifying vm tap interface/vn in vrouter uve
2026-06-01 03:05:25,900 - DEBUG - Expected tap interface of VM uuid 50520956-45d7-455e-ab41-aeb73042463d is default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:0f818c11-e489-4d8e-80dd-f7f162a93d38
2026-06-01 03:05:25,900 - DEBUG - Expected VN of VM uuid 50520956-45d7-455e-ab41-aeb73042463d is default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924
2026-06-01 03:05:25,900 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5860-2:Compute:contrail-vrouter-agent:0?flat
2026-06-01 03:05:25,953 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5860-2?flat
2026-06-01 03:05:25,982 - DEBUG - VM 50520956-45d7-455e-ab41-aeb73042463d is present in vrouter an-jenkins-deploy-platform-ansible-os-5860-2 uve
2026-06-01 03:05:25,982 - INFO - tap interface default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:0f818c11-e489-4d8e-80dd-f7f162a93d38 of vm 50520956-45d7-455e-ab41-aeb73042463d is present in vrouter an-jenkins-deploy-platform-ansible-os-5860-2 uve
2026-06-01 03:05:25,982 - DEBUG - Connected network default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 of vm 50520956-45d7-455e-ab41-aeb73042463d is present in vrouter an-jenkins-deploy-platform-ansible-os-5860-2 uve
2026-06-01 03:05:25,982 - DEBUG - Verifying the 50520956-45d7-455e-ab41-aeb73042463d virtual network link through opserver 10.0.0.240
2026-06-01 03:05:25,982 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-machines
2026-06-01 03:05:25,997 - DEBUG - VM link and name as {'name': '50520956-45d7-455e-ab41-aeb73042463d', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-machine/50520956-45d7-455e-ab41-aeb73042463d?flat'}
2026-06-01 03:05:25,997 - DEBUG - Verifying the 50520956-45d7-455e-ab41-aeb73042463d virtual network link through opserver 10.0.0.249
2026-06-01 03:05:25,997 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-machines
2026-06-01 03:05:26,075 - DEBUG - VM link and name as {'name': '50520956-45d7-455e-ab41-aeb73042463d', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-machine/50520956-45d7-455e-ab41-aeb73042463d?flat'}
2026-06-01 03:05:26,075 - DEBUG - Verifying the 50520956-45d7-455e-ab41-aeb73042463d virtual network link through opserver 10.0.0.65
2026-06-01 03:05:26,075 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-machines
2026-06-01 03:05:26,089 - DEBUG - VM link and name as {'name': '50520956-45d7-455e-ab41-aeb73042463d', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-machine/50520956-45d7-455e-ab41-aeb73042463d?flat'}
2026-06-01 03:05:26,089 - INFO - VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 validations in Opserver passed
2026-06-01 03:05:26,090 - INFO - Waiting for VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 to be up..
2026-06-01 03:05:26,090 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-01 03:05:26,090 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/50520956-45d7-455e-ab41-aeb73042463d
2026-06-01 03:05:26,100 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/0f818c11-e489-4d8e-80dd-f7f162a93d38
2026-06-01 03:05:27,281 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n64 bytes from 169.254.0.4: icmp_seq=1 ttl=63 time=2.05 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=3.26 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 2.054/2.657/3.260/0.603 ms')
2026-06-01 03:05:27,281 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 passed
2026-06-01 03:05:27,350 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-01 03:05:27,350 - DEBUG - Waiting to SSH to VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008, IP 4.54.174.3, Port 22
2026-06-01 03:05:27,417 - DEBUG - Error on ssh to ubuntu@169.254.0.4:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.4/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.4/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.4/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-01 03:05:27,505 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-01 03:05:32,506 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-01 03:05:32,506 - DEBUG - Waiting to SSH to VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008, IP 4.54.174.3, Port 22
2026-06-01 03:05:32,563 - DEBUG - Error on ssh to ubuntu@169.254.0.4:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.4/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.4/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.4/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-01 03:05:32,652 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-01 03:05:37,653 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-01 03:05:37,653 - DEBUG - Waiting to SSH to VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008, IP 4.54.174.3, Port 22
2026-06-01 03:05:37,721 - DEBUG - Error on ssh to ubuntu@169.254.0.4:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.4/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.4/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.4/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-01 03:05:37,808 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-01 03:05:42,808 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-01 03:05:42,809 - DEBUG - Waiting to SSH to VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008, IP 4.54.174.3, Port 22
2026-06-01 03:05:42,971 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008 is ready for SSH connections
2026-06-01 03:05:43,077 - DEBUG - VM is in ACTIVE state now
2026-06-01 03:05:43,077 - INFO - VM name : ctest-SecurityGroupBasicRegressionTests1-41651543-88817616
2026-06-01 03:05:43,196 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-41651543-88817616 ID is 8e2169b9-149d-4493-86ba-d5174c774436
2026-06-01 03:05:43,301 - DEBUG - VM is in ACTIVE state now
2026-06-01 03:05:43,301 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-41651543-88817616 launched on Node an-jenkins-deploy-platform-ansible-os-5860-1
2026-06-01 03:05:43,415 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/8e2169b9-149d-4493-86ba-d5174c774436
2026-06-01 03:05:43,425 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/8e2169b9-149d-4493-86ba-d5174c774436
2026-06-01 03:05:43,433 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/9d197517-7eb0-4acd-b3d1-7a4e3cd58a11
2026-06-01 03:05:43,445 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/8e2169b9-149d-4493-86ba-d5174c774436
2026-06-01 03:05:43,453 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/9d197517-7eb0-4acd-b3d1-7a4e3cd58a11
2026-06-01 03:05:43,466 - DEBUG - Requesting: http://10.0.0.65:8082/instance-ip/d84e0565-c921-41a9-abec-f634ac684e02
2026-06-01 03:05:43,478 - DEBUG - Verifying in api server 10.0.0.65
2026-06-01 03:05:43,478 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/8e2169b9-149d-4493-86ba-d5174c774436
2026-06-01 03:05:43,487 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/9d197517-7eb0-4acd-b3d1-7a4e3cd58a11
2026-06-01 03:05:43,497 - DEBUG - Requesting: http://10.0.0.65:8082/instance-ip/d84e0565-c921-41a9-abec-f634ac684e02
2026-06-01 03:05:43,505 - INFO - VM ctest-SecurityGroupBasicRegressionTests1-41651543-88817616 verfication in all API Servers passed
2026-06-01 03:05:43,525 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-41651543-88817616 Tap interface: {'index': '4', 'name': 'tap9d197517-7e', 'uuid': '9d197517-7eb0-4acd-b3d1-7a4e3cd58a11', 'vrf_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', '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': '32', 'l2_label': '36', 'vxlan_id': '15', 'vn_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', 'vm_uuid': '8e2169b9-149d-4493-86ba-d5174c774436', 'vm_name': 'ctest-SecurityGroupBasicRegressionTests1-41651543-88817616', 'ip_addr': '4.54.174.4', 'mac_addr': '02:9d:19:75:17:7e', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.4', 'service_vlan_list': None, 'os_ifindex': '65', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:9d197517-7eb0-4acd-b3d1-7a4e3cd58a11', 'sg_uuid_list': ['059befd2-9eb7-4d03-babf-6d4280451db1'], 'static_route_list': None, 'vm_project_uuid': 'fd6e7240-94af-49c8-8f47-7f93d49d1220', 'admin_state': 'Enabled', 'flow_key_idx': '41', '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': []}
2026-06-01 03:05:43,525 - DEBUG - Agent 10.0.0.130 vrf name: default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924
2026-06-01 03:05:43,532 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', 'ucindex': '3', 'mcindex': '3', 'l2index': '3', 'source': 'Config; ', 'uc6index': '3', 'vn': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', 'table_label': '-1', 'vxlan_id': '15', 'evpnindex': '3', 'brindex': '3', 'mplsindex': '0', 'RD': '10.20.0.18:3', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]}
2026-06-01 03:05:43,613 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-41651543-88817616 : Tap interface tap9d197517-7e is set to Active
2026-06-01 03:05:43,613 - DEBUG - Tap interface tap9d197517-7e detail : {'index': '4', 'name': 'tap9d197517-7e', 'uuid': '9d197517-7eb0-4acd-b3d1-7a4e3cd58a11', 'vrf_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', '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': '32', 'l2_label': '36', 'vxlan_id': '15', 'vn_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', 'vm_uuid': '8e2169b9-149d-4493-86ba-d5174c774436', 'vm_name': 'ctest-SecurityGroupBasicRegressionTests1-41651543-88817616', 'ip_addr': '4.54.174.4', 'mac_addr': '02:9d:19:75:17:7e', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.4', 'service_vlan_list': None, 'os_ifindex': '65', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:9d197517-7eb0-4acd-b3d1-7a4e3cd58a11', 'sg_uuid_list': ['059befd2-9eb7-4d03-babf-6d4280451db1'], 'static_route_list': None, 'vm_project_uuid': 'fd6e7240-94af-49c8-8f47-7f93d49d1220', 'admin_state': 'Enabled', 'flow_key_idx': '41', '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': []}
2026-06-01 03:05:43,725 - DEBUG - Starting Layer 2 verification in Agent
2026-06-01 03:05:43,737 - DEBUG - Layer 2 path is seen for VM MAC 02:9d:19:75:17:7e in agent 10.0.0.130
2026-06-01 03:05:43,737 - DEBUG - Active layer 2 route in agent is present for VMI tap9d197517-7e
2026-06-01 03:05:43,738 - DEBUG - L2 label(36) matches bw route table and interface table
2026-06-01 03:05:43,744 - DEBUG - VN default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is found in Agent of node 10.0.0.130
2026-06-01 03:05:43,877 - DEBUG - VRF IDs of VN default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is consistent in agent 10.0.0.130
2026-06-01 03:05:43,877 - DEBUG - Route for VM IP ['4.54.174.4'] is consistent in agent 10.0.0.130
2026-06-01 03:05:43,877 - DEBUG - VN default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 verification for VM ctest-SecurityGroupBasicRegressionTests1-41651543-88817616 in Agent 10.0.0.130 passed
2026-06-01 03:05:43,990 - DEBUG - Starting all layer 2 verification in agent 10.0.0.130
2026-06-01 03:05:44,006 - DEBUG - Route for VM MAC 02:9d:19:75:17:7e is consistent in agent 10.0.0.130
2026-06-01 03:05:44,017 - DEBUG - VN default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is found in Agent of node 10.0.0.73
2026-06-01 03:05:44,152 - DEBUG - VRF IDs of VN default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is consistent in agent 10.0.0.73
2026-06-01 03:05:44,152 - DEBUG - Route for VM IP ['4.54.174.4'] is consistent in agent 10.0.0.73
2026-06-01 03:05:44,152 - DEBUG - VN default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 verification for VM ctest-SecurityGroupBasicRegressionTests1-41651543-88817616 in Agent 10.0.0.73 passed
2026-06-01 03:05:44,265 - DEBUG - Starting all layer 2 verification in agent 10.0.0.73
2026-06-01 03:05:44,279 - DEBUG - Route for VM MAC 02:9d:19:75:17:7e is consistent in agent 10.0.0.73
2026-06-01 03:05:45,462 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n64 bytes from 169.254.0.4: icmp_seq=1 ttl=63 time=5.20 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=3.35 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 3.345/4.270/5.196/0.925 ms')
2026-06-01 03:05:45,462 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-SecurityGroupBasicRegressionTests1-41651543-88817616 passed
2026-06-01 03:05:45,462 - INFO - VM ctest-SecurityGroupBasicRegressionTests1-41651543-88817616 verifications in Compute nodes passed
2026-06-01 03:05:45,647 - DEBUG - Validated VM route 4.54.174.4 in vrouter of 10.0.0.130
2026-06-01 03:05:45,651 - DEBUG - Remote Nh validation passed. Expected Tunnel, label: None, 0; Got None,0
2026-06-01 03:05:45,777 - DEBUG - Validated VM route 4.54.174.4 in vrouter of 10.0.0.73
2026-06-01 03:05:45,786 - DEBUG - Remote Nh validation passed. Expected Tunnel, label: 10.20.0.18, 32; Got 10.20.0.18,32
2026-06-01 03:05:45,786 - DEBUG - Validated VM route 4.54.174.4 in vrouter of 10.0.0.73
2026-06-01 03:05:45,787 - INFO - Validated routes of VM ctest-SecurityGroupBasicRegressionTests1-41651543-88817616 in all vrouters
2026-06-01 03:05:46,241 - DEBUG - Starting all layer2 verification in 10.0.0.249 Control Node
2026-06-01 03:05:46,370 - DEBUG - Layer2 route found for VM MAC 02:9d:19:75:17:7e in Control-node 10.0.0.249
2026-06-01 03:05:46,370 - DEBUG - L2 Label for VM ctest-SecurityGroupBasicRegressionTests1-41651543-88817616 same between Control-node 10.0.0.249 and Agent, Expected: 36, Seen: 36
2026-06-01 03:05:46,370 - DEBUG - Starting all layer2 verification in 10.0.0.65 Control Node
2026-06-01 03:05:46,493 - DEBUG - Layer2 route found for VM MAC 02:9d:19:75:17:7e in Control-node 10.0.0.65
2026-06-01 03:05:46,493 - DEBUG - L2 Label for VM ctest-SecurityGroupBasicRegressionTests1-41651543-88817616 same between Control-node 10.0.0.65 and Agent, Expected: 36, Seen: 36
2026-06-01 03:05:46,493 - INFO - Verification in Control-nodes for VM ctest-SecurityGroupBasicRegressionTests1-41651543-88817616 passed
2026-06-01 03:05:46,493 - DEBUG - Verifying the vm in opserver
2026-06-01 03:05:46,493 - DEBUG - Verifying in collector 10.0.0.65 ...
2026-06-01 03:05:46,493 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-machine/8e2169b9-149d-4493-86ba-d5174c774436?flat
2026-06-01 03:05:46,509 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:9d197517-7eb0-4acd-b3d1-7a4e3cd58a11?flat
2026-06-01 03:05:46,529 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:9d197517-7eb0-4acd-b3d1-7a4e3cd58a11?flat
2026-06-01 03:05:46,548 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-machine/8e2169b9-149d-4493-86ba-d5174c774436?flat
2026-06-01 03:05:46,563 - DEBUG - Verifying vm in vn uve
2026-06-01 03:05:46,563 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:9d197517-7eb0-4acd-b3d1-7a4e3cd58a11?flat
2026-06-01 03:05:46,582 - DEBUG - VM uve shows interface as {'ip_address': '4.54.174.4', 'mac_address': '02:9d:19:75:17:7e', 'vhostuser_mode': 0, 'rx_vlan': 65535, 'l2_active': True, '__T': 1780283095640916, 'vm_uuid': '8e2169b9-149d-4493-86ba-d5174c774436', 'ip6_address': '::', 'vm_name': 'ctest-SecurityGroupBasicRegressionTests1-41651543-88817616', 'port_mirror_enabled': False, 'ip6_active': False, 'uuid': '9d197517-7eb0-4acd-b3d1-7a4e3cd58a11', 'admin_state': True, 'virtual_network': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924', 'ip4_active': True, 'is_health_check_active': True, 'label': 32, 'tx_vlan': 65535, 'gateway': '4.54.174.1', 'vn_uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'fixed_ip4_list': ['4.54.174.4'], 'active': True}
2026-06-01 03:05:46,582 - DEBUG - VM uve shows ip address as ['4.54.174.4', '::']
2026-06-01 03:05:46,583 - DEBUG - VM uve shows virtual network as default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924
2026-06-01 03:05:46,583 - INFO - Verifying through opserver in 10.0.0.240
2026-06-01 03:05:46,583 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924?flat
2026-06-01 03:05:46,608 - DEBUG - expected vm list 8e2169b9-149d-4493-86ba-d5174c774436
2026-06-01 03:05:46,608 - DEBUG - Extracted vm list ['8e2169b9-149d-4493-86ba-d5174c774436']
2026-06-01 03:05:46,608 - INFO - VM 8e2169b9-149d-4493-86ba-d5174c774436 is present in default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924
2026-06-01 03:05:46,608 - DEBUG - Verifying vm in vrouter uve
2026-06-01 03:05:46,608 - DEBUG - Getting info from collector 10.0.0.65..
2026-06-01 03:05:46,608 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-machine/8e2169b9-149d-4493-86ba-d5174c774436?flat
2026-06-01 03:05:46,629 - DEBUG - VM uve shows vrouter as ['an-jenkins-deploy-platform-ansible-os-5860-1']
2026-06-01 03:05:46,630 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5860-1:Compute:contrail-vrouter-agent:0?flat
2026-06-01 03:05:46,667 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5860-1?flat
2026-06-01 03:05:46,703 - DEBUG - VM 8e2169b9-149d-4493-86ba-d5174c774436 is present in vrouter an-jenkins-deploy-platform-ansible-os-5860-1 uve
2026-06-01 03:05:46,703 - DEBUG - Validated that VM ctest-SecurityGroupBasicRegressionTests1-41651543-88817616 is in Vrouter an-jenkins-deploy-platform-ansible-os-5860-1 UVE
2026-06-01 03:05:46,703 - DEBUG - Verifying vm tap interface/vn in vrouter uve
2026-06-01 03:05:46,715 - DEBUG - Expected tap interface of VM uuid 8e2169b9-149d-4493-86ba-d5174c774436 is default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:9d197517-7eb0-4acd-b3d1-7a4e3cd58a11
2026-06-01 03:05:46,715 - DEBUG - Expected VN of VM uuid 8e2169b9-149d-4493-86ba-d5174c774436 is default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924
2026-06-01 03:05:46,715 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5860-1:Compute:contrail-vrouter-agent:0?flat
2026-06-01 03:05:46,751 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5860-1?flat
2026-06-01 03:05:46,788 - DEBUG - VM 8e2169b9-149d-4493-86ba-d5174c774436 is present in vrouter an-jenkins-deploy-platform-ansible-os-5860-1 uve
2026-06-01 03:05:46,788 - INFO - tap interface default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:9d197517-7eb0-4acd-b3d1-7a4e3cd58a11 of vm 8e2169b9-149d-4493-86ba-d5174c774436 is present in vrouter an-jenkins-deploy-platform-ansible-os-5860-1 uve
2026-06-01 03:05:46,788 - DEBUG - Connected network default-domain:ctest-SecurityGroupBasicRegressionTests1-41651543:ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 of vm 8e2169b9-149d-4493-86ba-d5174c774436 is present in vrouter an-jenkins-deploy-platform-ansible-os-5860-1 uve
2026-06-01 03:05:46,788 - DEBUG - Verifying the 8e2169b9-149d-4493-86ba-d5174c774436 virtual network link through opserver 10.0.0.240
2026-06-01 03:05:46,788 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-machines
2026-06-01 03:05:46,802 - DEBUG - VM link and name as {'name': '8e2169b9-149d-4493-86ba-d5174c774436', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-machine/8e2169b9-149d-4493-86ba-d5174c774436?flat'}
2026-06-01 03:05:46,803 - DEBUG - Verifying the 8e2169b9-149d-4493-86ba-d5174c774436 virtual network link through opserver 10.0.0.249
2026-06-01 03:05:46,803 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-machines
2026-06-01 03:05:46,819 - DEBUG - VM link and name as {'name': '8e2169b9-149d-4493-86ba-d5174c774436', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-machine/8e2169b9-149d-4493-86ba-d5174c774436?flat'}
2026-06-01 03:05:46,819 - DEBUG - Verifying the 8e2169b9-149d-4493-86ba-d5174c774436 virtual network link through opserver 10.0.0.65
2026-06-01 03:05:46,819 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-machines
2026-06-01 03:05:46,833 - DEBUG - VM link and name as {'name': '8e2169b9-149d-4493-86ba-d5174c774436', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-machine/8e2169b9-149d-4493-86ba-d5174c774436?flat'}
2026-06-01 03:05:46,833 - INFO - VM ctest-SecurityGroupBasicRegressionTests1-41651543-88817616 validations in Opserver passed
2026-06-01 03:05:46,833 - INFO - Waiting for VM ctest-SecurityGroupBasicRegressionTests1-41651543-88817616 to be up..
2026-06-01 03:05:46,833 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-01 03:05:46,833 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/8e2169b9-149d-4493-86ba-d5174c774436
2026-06-01 03:05:46,842 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/9d197517-7eb0-4acd-b3d1-7a4e3cd58a11
2026-06-01 03:05:48,023 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n64 bytes from 169.254.0.4: icmp_seq=1 ttl=63 time=1.95 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=3.90 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 1.954/2.928/3.902/0.974 ms')
2026-06-01 03:05:48,023 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-SecurityGroupBasicRegressionTests1-41651543-88817616 passed
2026-06-01 03:05:48,093 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-01 03:05:48,094 - DEBUG - Waiting to SSH to VM ctest-SecurityGroupBasicRegressionTests1-41651543-88817616, IP 4.54.174.4, Port 22
2026-06-01 03:05:48,259 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-41651543-88817616 is ready for SSH connections
2026-06-01 03:05:48,259 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/50520956-45d7-455e-ab41-aeb73042463d
2026-06-01 03:05:48,267 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/0f818c11-e489-4d8e-80dd-f7f162a93d38
2026-06-01 03:05:48,278 - DEBUG - Security group ctest-test_sec_group-92070023 is attached to the VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008
2026-06-01 03:05:48,299 - DEBUG - Agent: Security group ctest-test_sec_group-92070023 is attached to the VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008
2026-06-01 03:05:48,393 - INFO - Validated that SG ctest-test_sec_group-92070023 is bound to VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008
2026-06-01 03:05:48,393 - INFO - Remove security group ctest-test_sec_group-92070023 from VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008
2026-06-01 03:05:48,721 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/50520956-45d7-455e-ab41-aeb73042463d
2026-06-01 03:05:48,728 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/0f818c11-e489-4d8e-80dd-f7f162a93d38
2026-06-01 03:05:48,741 - WARNING - Security group ctest-test_sec_group-92070023 is not attached to the VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008
2026-06-01 03:05:48,977 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/50520956-45d7-455e-ab41-aeb73042463d
2026-06-01 03:05:48,986 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/0f818c11-e489-4d8e-80dd-f7f162a93d38
2026-06-01 03:05:48,999 - DEBUG - Security group ctest-test_sec_group-92070023 is attached to the VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008
2026-06-01 03:05:49,018 - DEBUG - Agent: Security group ctest-test_sec_group-92070023 is attached to the VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008
2026-06-01 03:05:49,109 - INFO - Validated that SG ctest-test_sec_group-92070023 is bound to VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008
2026-06-01 03:05:49,110 - INFO - Try deleting the security group ctest-test_sec_group-92070023 with back ref.
2026-06-01 03:05:49,110 - INFO - Deleting Security group: ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-test_sec_group-92070023']
2026-06-01 03:05:49,293 - INFO - Security group: ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-test_sec_group-92070023'] deleted successfully.
2026-06-01 03:05:49,293 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:05:49,300 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:05:49,325 - DEBUG - Requesting: http://10.0.0.240:8082/project/fd6e7240-94af-49c8-8f47-7f93d49d1220
2026-06-01 03:05:49,443 - INFO - Security group ctest-test_sec_group-92070023 removed from the API Server
2026-06-01 03:05:49,443 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:05:49,453 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:05:49,468 - DEBUG - Requesting: http://10.0.0.240:8082/project/fd6e7240-94af-49c8-8f47-7f93d49d1220
2026-06-01 03:05:49,567 - DEBUG - Requesting: http://10.0.0.240:8082/access-control-lists
2026-06-01 03:05:49,574 - DEBUG - ACLs for Security group ctest-test_sec_group-92070023 removed from the API Server
2026-06-01 03:05:49,578 - INFO - security group ctest-test_sec_group-92070023 removed from Control-node 10.0.0.240
2026-06-01 03:05:49,585 - DEBUG - Security group ctest-test_sec_group-92070023 ACLs removed from the control node 10.0.0.240
2026-06-01 03:05:49,594 - INFO - security group ctest-test_sec_group-92070023 removed from Control-node 10.0.0.249
2026-06-01 03:05:49,601 - DEBUG - Security group ctest-test_sec_group-92070023 ACLs removed from the control node 10.0.0.249
2026-06-01 03:05:49,606 - INFO - security group ctest-test_sec_group-92070023 removed from Control-node 10.0.0.65
2026-06-01 03:05:49,611 - DEBUG - Security group ctest-test_sec_group-92070023 ACLs removed from the control node 10.0.0.65
2026-06-01 03:05:49,611 - INFO - Validated that SG ctest-test_sec_group-92070023 is not in control nodes
2026-06-01 03:05:49,616 - ERROR - Security group deleted, when it is attached to a VM.
2026-06-01 03:05:49,617 - INFO - Removing the security group from VM ctest-SecurityGroupBasicRegressionTests1-41651543-88817616
2026-06-01 03:05:49,729 - INFO - Removing the security group from VM ctest-SecurityGroupBasicRegressionTests1-41651543-50979008
2026-06-01 03:05:49,894 - INFO - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924
2026-06-01 03:05:49,944 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-47f95c0f-fe37-4966-86ff-86ae8bcbd08f']
2026-06-01 03:05:49,944 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:05:51,998 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-2e91e87b-df9d-4976-ab7b-69542c3e51ce']
2026-06-01 03:05:51,999 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:05:54,043 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-593f2456-9b4f-4f1c-a336-016a2c6f88e2']
2026-06-01 03:05:54,043 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:05:56,093 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-3359dc8b-3d22-4688-8b4d-6195ae99528f']
2026-06-01 03:05:56,093 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:05:58,141 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-4acf5994-879c-45dd-a2fb-614b717629f7']
2026-06-01 03:05:58,141 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:00,189 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-e4abaa01-9a5b-4b19-8668-7e840d40f220']
2026-06-01 03:06:00,189 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:02,241 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-3be86ee5-83c1-4a89-bea5-bded8992a69f']
2026-06-01 03:06:02,241 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:04,283 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-13d4f62b-72e5-4bb9-a16b-fdb0b56553a2']
2026-06-01 03:06:04,283 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:06,332 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-a0958143-8bce-458a-9431-9b9057a2c870']
2026-06-01 03:06:06,332 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:08,374 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-b0dfa782-b26c-44c7-a163-24801049e7b5']
2026-06-01 03:06:08,374 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:10,416 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-82653a07-b753-4392-a31b-1cef22634c53']
2026-06-01 03:06:10,416 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:12,460 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-93b7da74-4610-4054-80c1-2d2b1cb53d69']
2026-06-01 03:06:12,460 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:14,505 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-4d5cc410-1419-4f68-ad45-ccf5dd5379a5']
2026-06-01 03:06:14,505 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:16,552 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-174c938f-2a0a-4d60-a702-cd8853afef31']
2026-06-01 03:06:16,552 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:18,602 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-171833aa-cbed-4c55-a5de-32b0b1738f35']
2026-06-01 03:06:18,603 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:20,654 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-c312262f-6c58-4581-98c1-dc57807b2a5c']
2026-06-01 03:06:20,654 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:22,699 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-f761b8c2-5e54-4475-b57a-7e4e1abb3488']
2026-06-01 03:06:22,699 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:24,744 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-785650ff-e5a0-4e64-a8b5-83f0688a3278']
2026-06-01 03:06:24,744 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:26,785 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-d28c3b41-0005-44dc-9df8-beee72c94fd2']
2026-06-01 03:06:26,786 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:28,835 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-4c6f0e26-d7b2-43f5-b9a6-cb0b33d26a45']
2026-06-01 03:06:28,836 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:30,881 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-87bd9900-14bc-4ab9-83e3-95cb95453372']
2026-06-01 03:06:30,881 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:32,923 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-72827acc-c93a-4951-a76d-09359200b514']
2026-06-01 03:06:32,923 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:34,969 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-f0c2df07-8d0e-4251-b620-4762d517e0cc']
2026-06-01 03:06:34,969 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:37,011 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-c3e4da70-0bd4-493c-81e3-33adedd8428d']
2026-06-01 03:06:37,011 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:39,058 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-d8647a35-d01e-463d-b7cd-e8f192772c0b']
2026-06-01 03:06:39,058 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:41,108 - DEBUG - VN 6f2c174e-47bf-4561-8ed1-e28d22eab842 still in use: Unable to complete operation on network 6f2c174e-47bf-4561-8ed1-e28d22eab842. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-addbf2d3-6b45-4dc0-92d4-12a512778741']
2026-06-01 03:06:41,108 - WARNING - Deleting VN ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 failed..Will retry
2026-06-01 03:06:41,108 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e3c73bdc-46cc-43d3-bf17-331832e7b677
2026-06-01 03:06:41,123 - WARNING - RI ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is still found in API-Server
2026-06-01 03:06:46,124 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e3c73bdc-46cc-43d3-bf17-331832e7b677
2026-06-01 03:06:46,133 - WARNING - RI ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is still found in API-Server
2026-06-01 03:06:51,134 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e3c73bdc-46cc-43d3-bf17-331832e7b677
2026-06-01 03:06:51,146 - WARNING - RI ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is still found in API-Server
2026-06-01 03:06:56,146 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e3c73bdc-46cc-43d3-bf17-331832e7b677
2026-06-01 03:06:56,158 - WARNING - RI ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is still found in API-Server
2026-06-01 03:07:01,159 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e3c73bdc-46cc-43d3-bf17-331832e7b677
2026-06-01 03:07:01,171 - WARNING - RI ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is still found in API-Server
2026-06-01 03:07:06,172 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e3c73bdc-46cc-43d3-bf17-331832e7b677
2026-06-01 03:07:06,181 - WARNING - RI ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is still found in API-Server
2026-06-01 03:07:11,182 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e3c73bdc-46cc-43d3-bf17-331832e7b677
2026-06-01 03:07:11,191 - WARNING - RI ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is still found in API-Server
2026-06-01 03:07:16,193 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e3c73bdc-46cc-43d3-bf17-331832e7b677
2026-06-01 03:07:16,201 - WARNING - RI ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is still found in API-Server
2026-06-01 03:07:21,202 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e3c73bdc-46cc-43d3-bf17-331832e7b677
2026-06-01 03:07:21,211 - WARNING - RI ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is still found in API-Server
2026-06-01 03:07:26,212 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e3c73bdc-46cc-43d3-bf17-331832e7b677
2026-06-01 03:07:26,221 - WARNING - RI ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is still found in API-Server
2026-06-01 03:07:31,222 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e3c73bdc-46cc-43d3-bf17-331832e7b677
2026-06-01 03:07:31,230 - WARNING - RI ctest-SecurityGroupBasicRegressionTests1-41651543-71249924 is still found in API-Server
2026-06-01 03:07:31,231 - INFO - Deleting Security group: ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-test_sec_group-92070023']
2026-06-01 03:07:32,519 - ERROR - AssertionError
Python 3.9.25: /usr/bin/python3
Mon Jun 1 03:05:49 2026
A problem occurred in a Python script. Here is the sequence of
function calls leading up to the error, in the order they occurred.
/contrail-test/tcutils/wrappers.py in wrapper(self=, *args=(), **kwargs={})
78 log.info('Initial checks done. Running the testcase now')
79 log.info('')
80 result = function(self, *args, **kwargs)
81 if self.inputs.upgrade:
82 pid = os.getpid()
result = None
function =
self =
args = ()
kwargs = {}
/contrail-test/scripts/securitygroup/test_regression_basic.py in test_sec_group_basic(self=)
127 errmsg = "Security group deleted, when it is attached to a VM."
128 self.logger.error(errmsg)
129 assert False, errmsg
130
131 #Ping test, should fail
errmsg = 'Security group deleted, when it is attached to a VM.'
AssertionError: Security group deleted, when it is attached to a VM.
__cause__ = None
__class__ =
__context__ = NoIdError('Error: oper 1 url /fqname-to-id body ...\n \'ctest-test_sec_group-92070023\'] not found')
__delattr__ =
__dict__ = {}
__dir__ =
__doc__ = 'Assertion failed.'
__eq__ =
__format__ =
__ge__ =
__getattribute__ =
__gt__ =
__hash__ =
__init__ =
__init_subclass__ =
__le__ =
__lt__ =
__ne__ =
__new__ =
__reduce__ =
__reduce_ex__ =
__repr__ =
__setattr__ =
__setstate__ =
__sizeof__ =
__str__ =
__subclasshook__ =
__suppress_context__ = False
__traceback__ =
args = ('Security group deleted, when it is attached to a VM.',)
with_traceback =
The above is a description of an error in a Python program. Here is
the original traceback:
Traceback (most recent call last):
File "/contrail-test/scripts/securitygroup/test_regression_basic.py", line 122, in test_sec_group_basic
secgroup = self.vnc_lib.security_group_read(
File "/usr/local/lib/python3.9/site-packages/vnc_api/vnc_api.py", line 52, in wrapper
return func(self, *args, **kwargs)
File "/usr/local/lib/python3.9/site-packages/vnc_api/vnc_api.py", line 700, in _object_read
(args_ok, result) = self._read_args_to_id(
File "/usr/local/lib/python3.9/site-packages/vnc_api/vnc_api.py", line 1114, in _read_args_to_id
return (True, self.fq_name_to_id(res_type, fq_name))
File "/usr/local/lib/python3.9/site-packages/vnc_api/vnc_api.py", line 52, in wrapper
return func(self, *args, **kwargs)
File "/usr/local/lib/python3.9/site-packages/vnc_api/vnc_api.py", line 1395, in fq_name_to_id
content = self._request_server(OP_POST, uri, data=json_body)
File "/usr/local/lib/python3.9/site-packages/vnc_api/vnc_api.py", line 1126, in _request_server
return self._request(
File "/usr/local/lib/python3.9/site-packages/vnc_api/vnc_api.py", line 1180, in _request
raise NoIdError('Error: oper %s url %s body %s response %s'
vnc_api.exceptions.NoIdError: Unknown id: Error: oper 1 url /fqname-to-id body {"type": "security-group", "fq_name": ["default-domain", "ctest-SecurityGroupBasicRegressionTests1-41651543", "ctest-test_sec_group-92070023"]} response Name ['default-domain',
'ctest-SecurityGroupBasicRegressionTests1-41651543',
'ctest-test_sec_group-92070023'] not found
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "/contrail-test/tcutils/wrappers.py", line 80, in wrapper
result = function(self, *args, **kwargs)
File "/contrail-test/scripts/securitygroup/test_regression_basic.py", line 129, in test_sec_group_basic
assert False, errmsg
AssertionError: Security group deleted, when it is attached to a VM.
2026-06-01 03:07:32,534 - DEBUG - No XMPP flaps were noticed during the test
2026-06-01 03:07:32,534 - INFO -
2026-06-01 03:07:32,534 - INFO - END TEST : test_sec_group_basic : FAILED[0:03:00]
2026-06-01 03:07:32,534 - INFO - --------------------------------------------------------------------------------
2026-06-01 03:07:32,717 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:07:34,845 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:07:37,009 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:07:39,161 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:07:41,337 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:07:43,477 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:07:45,613 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:07:47,761 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:07:49,913 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:07:52,053 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:07:54,177 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:07:56,321 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:07:58,453 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:08:00,613 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:08:02,761 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:08:04,889 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:08:07,061 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:08:09,225 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:08:11,357 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:08:13,509 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:08:15,637 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:08:17,765 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:08:19,921 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:08:22,061 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:08:24,217 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:08:26,353 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:08:28,481 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:08:30,621 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:08:32,757 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:08:34,885 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:08:37,029 - WARNING - Project ctest-SecurityGroupBasicRegressionTests1-41651543 still has VNs [{'to': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-41651543', 'ctest-SecurityGroupBasicRegressionTests1-41651543-71249924'], 'uuid': '6f2c174e-47bf-4561-8ed1-e28d22eab842', 'href': 'http://10.0.0.65:8082/virtual-network/6f2c174e-47bf-4561-8ed1-e28d22eab842'}] before deletion
2026-06-01 03:08:37,029 - WARNING - One or more references still present, will not delete the project ctest-SecurityGroupBasicRegressionTests1-41651543