2026-03-23 03:13:14,682 - INFO - Domain Default found not creating 2026-03-23 03:13:14,872 - INFO - Project ctest-SecurityGroupBasicRegressionTests1-14095770 not found, creating it 2026-03-23 03:13:15,414 - INFO - Created Project:ctest-SecurityGroupBasicRegressionTests1-14095770, ID : 4497f961-ee7b-4520-b614-e7d5f204481d 2026-03-23 03:13:17,108 - INFO - ================================================================================ 2026-03-23 03:13:17,108 - INFO - STARTING TEST : test_sec_group_basic 2026-03-23 03:13:17,108 - 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-03-23 03:13:18,396 - DEBUG - Nothing to compare xmpp stats {'10.0.0.249': {'10.20.0.18': '0', '10.20.0.14': '0'}, '10.0.0.65': {'10.20.0.18': '0', '10.20.0.14': '0'}} with 2026-03-23 03:13:18,396 - INFO - Initial checks done. Running the testcase now 2026-03-23 03:13:18,396 - INFO - 2026-03-23 03:13:18,762 - INFO - Creating Security group: ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-14095770', 'ctest-test_sec_group-06917502'] 2026-03-23 03:13:19,884 - DEBUG - Security group: ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-14095770', 'ctest-test_sec_group-06917502'] created succesfully 2026-03-23 03:13:19,884 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 03:13:20,201 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 03:13:20,236 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 03:13:20,252 - DEBUG - Requesting: http://10.0.0.27:8082/project/4497f961-ee7b-4520-b614-e7d5f204481d 2026-03-23 03:13:20,347 - DEBUG - Requesting: http://10.0.0.27:8082/security-group/4e3498e3-4848-4686-854b-3130df74e83f 2026-03-23 03:13:20,359 - INFO - Security group ctest-test_sec_group-06917502 found in the API Server 2026-03-23 03:13:20,360 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 03:13:20,368 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 03:13:20,380 - DEBUG - Requesting: http://10.0.0.27:8082/project/4497f961-ee7b-4520-b614-e7d5f204481d 2026-03-23 03:13:20,482 - DEBUG - Requesting: http://10.0.0.27:8082/access-control-lists 2026-03-23 03:13:20,494 - INFO - Validated that ACLs for Security group ctest-test_sec_group-06917502 are present in API Server 2026-03-23 03:13:20,501 - INFO - Validated that Security group ctest-test_sec_group-06917502 is found in control node 10.0.0.27 2026-03-23 03:13:20,508 - DEBUG - Security group ctest-test_sec_group-06917502 ACLs found in the control node 10.0.0.27 2026-03-23 03:13:20,514 - INFO - Validated that Security group ctest-test_sec_group-06917502 is found in control node 10.0.0.50 2026-03-23 03:13:20,521 - DEBUG - Security group ctest-test_sec_group-06917502 ACLs found in the control node 10.0.0.50 2026-03-23 03:13:20,527 - INFO - Validated that Security group ctest-test_sec_group-06917502 is found in control node 10.0.0.23 2026-03-23 03:13:20,535 - DEBUG - Security group ctest-test_sec_group-06917502 ACLs found in the control node 10.0.0.23 2026-03-23 03:13:20,535 - INFO - Validated SG ctest-test_sec_group-06917502 in Control nodes 2026-03-23 03:13:20,535 - INFO - Deleting Security group: ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-14095770', 'ctest-test_sec_group-06917502'] 2026-03-23 03:13:20,617 - INFO - Security group: ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-14095770', 'ctest-test_sec_group-06917502'] deleted successfully. 2026-03-23 03:13:20,618 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 03:13:20,624 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 03:13:20,646 - DEBUG - Requesting: http://10.0.0.27:8082/project/4497f961-ee7b-4520-b614-e7d5f204481d 2026-03-23 03:13:20,739 - INFO - Security group ctest-test_sec_group-06917502 removed from the API Server 2026-03-23 03:13:20,739 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 03:13:20,754 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 03:13:20,768 - DEBUG - Requesting: http://10.0.0.27:8082/project/4497f961-ee7b-4520-b614-e7d5f204481d 2026-03-23 03:13:20,864 - DEBUG - Requesting: http://10.0.0.27:8082/access-control-lists 2026-03-23 03:13:20,881 - DEBUG - ACLs for Security group ctest-test_sec_group-06917502 removed from the API Server 2026-03-23 03:13:20,887 - INFO - security group ctest-test_sec_group-06917502 removed from Control-node 10.0.0.27 2026-03-23 03:13:20,893 - DEBUG - Security group ctest-test_sec_group-06917502 ACLs removed from the control node 10.0.0.27 2026-03-23 03:13:20,898 - INFO - security group ctest-test_sec_group-06917502 removed from Control-node 10.0.0.50 2026-03-23 03:13:20,904 - DEBUG - Security group ctest-test_sec_group-06917502 ACLs removed from the control node 10.0.0.50 2026-03-23 03:13:20,910 - INFO - security group ctest-test_sec_group-06917502 removed from Control-node 10.0.0.23 2026-03-23 03:13:20,915 - DEBUG - Security group ctest-test_sec_group-06917502 ACLs removed from the control node 10.0.0.23 2026-03-23 03:13:20,915 - INFO - Validated that SG ctest-test_sec_group-06917502 is not in control nodes 2026-03-23 03:13:20,921 - INFO - Creating Security group: ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-14095770', 'ctest-test_sec_group-06917502'] 2026-03-23 03:13:21,884 - DEBUG - Security group: ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-14095770', 'ctest-test_sec_group-06917502'] created succesfully 2026-03-23 03:13:21,885 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 03:13:21,894 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 03:13:21,908 - DEBUG - Requesting: http://10.0.0.27:8082/project/4497f961-ee7b-4520-b614-e7d5f204481d 2026-03-23 03:13:21,998 - DEBUG - Requesting: http://10.0.0.27:8082/security-group/168408dc-bffa-4630-b47a-42b61ce8d8aa 2026-03-23 03:13:22,011 - INFO - Security group ctest-test_sec_group-06917502 found in the API Server 2026-03-23 03:13:22,012 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 03:13:22,020 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 03:13:22,032 - DEBUG - Requesting: http://10.0.0.27:8082/project/4497f961-ee7b-4520-b614-e7d5f204481d 2026-03-23 03:13:22,127 - DEBUG - Requesting: http://10.0.0.27:8082/access-control-lists 2026-03-23 03:13:22,138 - INFO - Validated that ACLs for Security group ctest-test_sec_group-06917502 are present in API Server 2026-03-23 03:13:22,146 - INFO - Validated that Security group ctest-test_sec_group-06917502 is found in control node 10.0.0.27 2026-03-23 03:13:22,154 - DEBUG - Security group ctest-test_sec_group-06917502 ACLs found in the control node 10.0.0.27 2026-03-23 03:13:22,161 - INFO - Validated that Security group ctest-test_sec_group-06917502 is found in control node 10.0.0.50 2026-03-23 03:13:22,168 - DEBUG - Security group ctest-test_sec_group-06917502 ACLs found in the control node 10.0.0.50 2026-03-23 03:13:22,175 - INFO - Validated that Security group ctest-test_sec_group-06917502 is found in control node 10.0.0.23 2026-03-23 03:13:22,182 - DEBUG - Security group ctest-test_sec_group-06917502 ACLs found in the control node 10.0.0.23 2026-03-23 03:13:22,182 - INFO - Validated SG ctest-test_sec_group-06917502 in Control nodes 2026-03-23 03:13:22,182 - DEBUG - Replace all the rules of this security group ctest-test_sec_group-06917502 with the new rules 2026-03-23 03:13:22,182 - DEBUG - [{'protocol': 'tcp', 'dst_addresses': [{'subnet': {'ip_prefix': '165.64.92.128', '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': '165.64.92.128', '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-03-23 03:13:23,150 - DEBUG - Response for create_network : {'network': {'id': 'bb2dea8b-3e86-4184-99fa-8d343d41357c', 'name': 'ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', 'tenant_id': '4497f961ee7b4520b614e7d5f204481d', 'project_id': '4497f961ee7b4520b614e7d5f204481d', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-14095770', 'ctest-SecurityGroupBasicRegressionTests1-14095770-24658722'], 'port_security_enabled': True, 'description': ''}} 2026-03-23 03:13:23,391 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e362d2ca-9b41-4c05-8913-d09ae8cdc813', 'name': '', 'tenant_id': '4497f961ee7b4520b614e7d5f204481d', 'network_id': 'bb2dea8b-3e86-4184-99fa-8d343d41357c', 'ip_version': 4, 'cidr': '165.64.92.128/26', 'allocation_pools': [{'start': '165.64.92.130', 'end': '165.64.92.190'}], 'gateway_ip': '165.64.92.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '165.64.92.130', 'tags': [], 'project_id': '4497f961ee7b4520b614e7d5f204481d'}} 2026-03-23 03:13:23,416 - INFO - Created VN ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 2026-03-23 03:13:23,428 - DEBUG - VN ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 UUID is bb2dea8b-3e86-4184-99fa-8d343d41357c 2026-03-23 03:13:23,510 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 03:13:23,517 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 03:13:23,531 - DEBUG - Requesting: http://10.0.0.27:8082/project/4497f961-ee7b-4520-b614-e7d5f204481d 2026-03-23 03:13:23,627 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/bb2dea8b-3e86-4184-99fa-8d343d41357c 2026-03-23 03:13:23,642 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/bb2dea8b-3e86-4184-99fa-8d343d41357c 2026-03-23 03:13:23,656 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/da5ef24b-8d48-488f-8f61-c51641e6f482 2026-03-23 03:13:23,675 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/da5ef24b-8d48-488f-8f61-c51641e6f482 2026-03-23 03:13:23,685 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/d6ad29b8-9c7a-4ade-b598-bcf2abf8caeb 2026-03-23 03:13:23,697 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-23 03:13:23,697 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/bb2dea8b-3e86-4184-99fa-8d343d41357c 2026-03-23 03:13:23,710 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/da5ef24b-8d48-488f-8f61-c51641e6f482 2026-03-23 03:13:23,734 - INFO - Verified VN network id 15 for VN bb2dea8b-3e86-4184-99fa-8d343d41357c 2026-03-23 03:13:23,734 - INFO - Verifications in API Server for VN ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 passed 2026-03-23 03:13:23,734 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/bb2dea8b-3e86-4184-99fa-8d343d41357c 2026-03-23 03:13:23,746 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/da5ef24b-8d48-488f-8f61-c51641e6f482 2026-03-23 03:13:23,755 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/da5ef24b-8d48-488f-8f61-c51641e6f482 2026-03-23 03:13:23,764 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/d6ad29b8-9c7a-4ade-b598-bcf2abf8caeb 2026-03-23 03:13:23,783 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-SecurityGroupBasicRegressionTests1-14095770', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13487694342814843268', 'uuid-lslong': '11095335887486137724'}, 'enable': 'true', 'created': '2026-03-23T03:13:23', 'last-modified': '2026-03-23T03:13:23', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.456476'} 2026-03-23 03:13:23,796 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-23 03:13:23,803 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-SecurityGroupBasicRegressionTests1-14095770', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13487694342814843268', 'uuid-lslong': '11095335887486137724'}, 'enable': 'true', 'created': '2026-03-23T03:13:23', 'last-modified': '2026-03-23T03:13:23', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.470571'} 2026-03-23 03:13:23,812 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-23 03:13:23,818 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-SecurityGroupBasicRegressionTests1-14095770', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13487694342814843268', 'uuid-lslong': '11095335887486137724'}, 'enable': 'true', 'created': '2026-03-23T03:13:23', 'last-modified': '2026-03-23T03:13:23', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.491678'} 2026-03-23 03:13:23,825 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-23 03:13:23,825 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 passed 2026-03-23 03:13:23,825 - DEBUG - ====Verifying policy data for ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 in API_Server ====== 2026-03-23 03:13:23,825 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 03:13:23,832 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 03:13:23,846 - DEBUG - Requesting: http://10.0.0.27:8082/project/4497f961-ee7b-4520-b614-e7d5f204481d 2026-03-23 03:13:23,959 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/bb2dea8b-3e86-4184-99fa-8d343d41357c 2026-03-23 03:13:23,985 - DEBUG - =>VN ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 has no policy to be verified 2026-03-23 03:13:23,985 - DEBUG - Verifying the vn in opserver 2026-03-23 03:13:23,985 - DEBUG - Verifying the default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 virtual network link through opserver 10.0.0.27 2026-03-23 03:13:23,985 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2026-03-23 03:13:24,352 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2026-03-23 03:13:24,435 - DEBUG - vn link and name as {'name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722?flat'} 2026-03-23 03:13:24,435 - DEBUG - Verifying the default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 virtual network link through opserver 10.0.0.50 2026-03-23 03:13:24,435 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-03-23 03:13:24,747 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-03-23 03:13:24,849 - DEBUG - vn link and name as {'name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722?flat'} 2026-03-23 03:13:24,849 - DEBUG - Verifying the default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 virtual network link through opserver 10.0.0.23 2026-03-23 03:13:24,849 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks 2026-03-23 03:13:25,165 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks 2026-03-23 03:13:25,237 - DEBUG - vn link and name as {'name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722?flat'} 2026-03-23 03:13:25,237 - INFO - Validated that VN default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is found in opserver 2026-03-23 03:13:25,264 - DEBUG - Do not have enough data to verify VN in agent 2026-03-23 03:13:25,276 - DEBUG - VRF ids for VN ctest-SecurityGroupBasicRegressionTests1-14095770-24658722: {} 2026-03-23 03:13:25,347 - DEBUG - Services list from nova: [, , , ] 2026-03-23 03:13:26,763 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5514-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5514-2) 2026-03-23 03:13:28,382 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5514-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5514-1) 2026-03-23 03:13:28,476 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-03-23 03:13:33,574 - DEBUG - VM is in ACTIVE state now 2026-03-23 03:13:33,574 - INFO - VM name : ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 2026-03-23 03:13:33,657 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 ID is 508527b8-8f1f-4f1b-b470-ea0d400bb94b 2026-03-23 03:13:33,741 - DEBUG - VM is in ACTIVE state now 2026-03-23 03:13:33,768 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 launched on Node an-jenkins-deploy-platform-ansible-os-5514-2 2026-03-23 03:13:33,868 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/508527b8-8f1f-4f1b-b470-ea0d400bb94b 2026-03-23 03:13:34,197 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/508527b8-8f1f-4f1b-b470-ea0d400bb94b 2026-03-23 03:13:34,257 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/508527b8-8f1f-4f1b-b470-ea0d400bb94b 2026-03-23 03:13:34,265 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/825bfe4b-5448-456b-aa12-b818ae58498a 2026-03-23 03:13:34,276 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/508527b8-8f1f-4f1b-b470-ea0d400bb94b 2026-03-23 03:13:34,284 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/825bfe4b-5448-456b-aa12-b818ae58498a 2026-03-23 03:13:34,297 - DEBUG - Requesting: http://10.0.0.23:8082/instance-ip/61b2ce99-4bed-480e-8b97-05478ce56cec 2026-03-23 03:13:34,310 - DEBUG - Verifying in api server 10.0.0.23 2026-03-23 03:13:34,310 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/508527b8-8f1f-4f1b-b470-ea0d400bb94b 2026-03-23 03:13:34,319 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/825bfe4b-5448-456b-aa12-b818ae58498a 2026-03-23 03:13:34,335 - DEBUG - Requesting: http://10.0.0.23:8082/instance-ip/61b2ce99-4bed-480e-8b97-05478ce56cec 2026-03-23 03:13:34,345 - INFO - VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 verfication in all API Servers passed 2026-03-23 03:13:34,365 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 Tap interface: {'index': '3', 'name': 'tap825bfe4b-54', 'uuid': '825bfe4b-5448-456b-aa12-b818ae58498a', 'vrf_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', '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': '25', 'l2_label': '29', 'vxlan_id': '15', 'vn_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', 'vm_uuid': '508527b8-8f1f-4f1b-b470-ea0d400bb94b', 'vm_name': 'ctest-SecurityGroupBasicRegressionTests1-14095770-77263394', 'ip_addr': '165.64.92.131', 'mac_addr': '02:82:5b:fe:4b:54', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.3', 'service_vlan_list': None, 'os_ifindex': '78', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:825bfe4b-5448-456b-aa12-b818ae58498a', 'sg_uuid_list': ['168408dc-bffa-4630-b47a-42b61ce8d8aa'], 'static_route_list': None, 'vm_project_uuid': '4497f961-ee7b-4520-b614-e7d5f204481d', 'admin_state': 'Enabled', 'flow_key_idx': '31', '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-03-23 03:13:34,366 - DEBUG - Agent 10.0.0.65 vrf name: default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 2026-03-23 03:13:34,374 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', 'ucindex': '2', 'mcindex': '2', 'l2index': '2', 'source': 'Config; ', 'uc6index': '2', 'vn': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', 'table_label': '-1', 'vxlan_id': '15', 'evpnindex': '2', 'brindex': '2', 'mplsindex': '0', 'RD': '10.20.0.201:2', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]} 2026-03-23 03:13:34,466 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 : Tap interface tap825bfe4b-54 is set to Active 2026-03-23 03:13:34,466 - DEBUG - Tap interface tap825bfe4b-54 detail : {'index': '3', 'name': 'tap825bfe4b-54', 'uuid': '825bfe4b-5448-456b-aa12-b818ae58498a', 'vrf_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', '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': '25', 'l2_label': '29', 'vxlan_id': '15', 'vn_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', 'vm_uuid': '508527b8-8f1f-4f1b-b470-ea0d400bb94b', 'vm_name': 'ctest-SecurityGroupBasicRegressionTests1-14095770-77263394', 'ip_addr': '165.64.92.131', 'mac_addr': '02:82:5b:fe:4b:54', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.3', 'service_vlan_list': None, 'os_ifindex': '78', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:825bfe4b-5448-456b-aa12-b818ae58498a', 'sg_uuid_list': ['168408dc-bffa-4630-b47a-42b61ce8d8aa'], 'static_route_list': None, 'vm_project_uuid': '4497f961-ee7b-4520-b614-e7d5f204481d', 'admin_state': 'Enabled', 'flow_key_idx': '31', '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-03-23 03:13:34,580 - DEBUG - Starting Layer 2 verification in Agent 2026-03-23 03:13:34,597 - DEBUG - Layer 2 path is seen for VM MAC 02:82:5b:fe:4b:54 in agent 10.0.0.65 2026-03-23 03:13:34,597 - DEBUG - Active layer 2 route in agent is present for VMI tap825bfe4b-54 2026-03-23 03:13:34,597 - DEBUG - L2 label(29) matches bw route table and interface table 2026-03-23 03:13:34,603 - DEBUG - VN default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is found in Agent of node 10.0.0.249 2026-03-23 03:13:34,742 - DEBUG - VRF IDs of VN default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is consistent in agent 10.0.0.249 2026-03-23 03:13:34,742 - DEBUG - Route for VM IP ['165.64.92.131'] is consistent in agent 10.0.0.249 2026-03-23 03:13:34,742 - DEBUG - VN default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 verification for VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 in Agent 10.0.0.249 passed 2026-03-23 03:13:34,851 - DEBUG - Starting all layer 2 verification in agent 10.0.0.249 2026-03-23 03:13:34,864 - DEBUG - Route for VM MAC 02:82:5b:fe:4b:54 is consistent in agent 10.0.0.249 2026-03-23 03:13:34,872 - DEBUG - VN default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is found in Agent of node 10.0.0.65 2026-03-23 03:13:35,005 - DEBUG - VRF IDs of VN default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is consistent in agent 10.0.0.65 2026-03-23 03:13:35,005 - DEBUG - Route for VM IP ['165.64.92.131'] is consistent in agent 10.0.0.65 2026-03-23 03:13:35,005 - DEBUG - VN default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 verification for VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 in Agent 10.0.0.65 passed 2026-03-23 03:13:35,116 - DEBUG - Starting all layer 2 verification in agent 10.0.0.65 2026-03-23 03:13:35,129 - DEBUG - Route for VM MAC 02:82:5b:fe:4b:54 is consistent in agent 10.0.0.65 2026-03-23 03:13:38,316 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1010ms') 2026-03-23 03:13:38,316 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 failed! 2026-03-23 03:13:38,335 - DEBUG - Gateway for vn default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is 165.64.92.129 and allocation pool is NOT set 2026-03-23 03:13:42,408 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1007ms') 2026-03-23 03:13:42,408 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 failed! 2026-03-23 03:13:42,425 - DEBUG - Gateway for vn default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is 165.64.92.129 and allocation pool is NOT set 2026-03-23 03:13:46,500 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1013ms') 2026-03-23 03:13:46,500 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 failed! 2026-03-23 03:13:46,515 - DEBUG - Gateway for vn default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is 165.64.92.129 and allocation pool is NOT set 2026-03-23 03:13:50,599 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1019ms') 2026-03-23 03:13:50,599 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 failed! 2026-03-23 03:13:50,616 - DEBUG - Gateway for vn default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is 165.64.92.129 and allocation pool is NOT set 2026-03-23 03:13:54,693 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1018ms') 2026-03-23 03:13:54,693 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 failed! 2026-03-23 03:13:54,707 - DEBUG - Gateway for vn default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is 165.64.92.129 and allocation pool is NOT set 2026-03-23 03:13:58,794 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1021ms') 2026-03-23 03:13:58,794 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 failed! 2026-03-23 03:13:58,810 - DEBUG - Gateway for vn default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is 165.64.92.129 and allocation pool is NOT set 2026-03-23 03:14:02,889 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-03-23 03:14:02,889 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 failed! 2026-03-23 03:14:02,905 - DEBUG - Gateway for vn default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is 165.64.92.129 and allocation pool is NOT set 2026-03-23 03:14:06,987 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-03-23 03:14:06,987 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 failed! 2026-03-23 03:14:07,002 - DEBUG - Gateway for vn default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is 165.64.92.129 and allocation pool is NOT set 2026-03-23 03:14:09,069 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=12.5 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=3.31 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 3.308/7.903/12.498/4.595 ms') 2026-03-23 03:14:09,069 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 passed 2026-03-23 03:14:09,069 - INFO - VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 verifications in Compute nodes passed 2026-03-23 03:14:09,282 - DEBUG - Validated VM route 165.64.92.131 in vrouter of 10.0.0.249 2026-03-23 03:14:09,289 - DEBUG - Remote Nh validation passed. Expected Tunnel, label: 10.20.0.201, 25; Got 10.20.0.201,25 2026-03-23 03:14:09,289 - DEBUG - Validated VM route 165.64.92.131 in vrouter of 10.0.0.249 2026-03-23 03:14:09,413 - DEBUG - Validated VM route 165.64.92.131 in vrouter of 10.0.0.65 2026-03-23 03:14:09,420 - DEBUG - Remote Nh validation passed. Expected Tunnel, label: None, 0; Got None,0 2026-03-23 03:14:09,420 - INFO - Validated routes of VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 in all vrouters 2026-03-23 03:14:09,832 - DEBUG - Starting all layer2 verification in 10.0.0.23 Control Node 2026-03-23 03:14:09,959 - DEBUG - Layer2 route found for VM MAC 02:82:5b:fe:4b:54 in Control-node 10.0.0.23 2026-03-23 03:14:09,959 - DEBUG - L2 Label for VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 same between Control-node 10.0.0.23 and Agent, Expected: 29, Seen: 29 2026-03-23 03:14:09,959 - DEBUG - Starting all layer2 verification in 10.0.0.27 Control Node 2026-03-23 03:14:10,087 - DEBUG - Layer2 route found for VM MAC 02:82:5b:fe:4b:54 in Control-node 10.0.0.27 2026-03-23 03:14:10,087 - DEBUG - L2 Label for VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 same between Control-node 10.0.0.27 and Agent, Expected: 29, Seen: 29 2026-03-23 03:14:10,087 - INFO - Verification in Control-nodes for VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 passed 2026-03-23 03:14:10,088 - DEBUG - Verifying the vm in opserver 2026-03-23 03:14:10,088 - DEBUG - Verifying in collector 10.0.0.23 ... 2026-03-23 03:14:10,088 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-machine/508527b8-8f1f-4f1b-b470-ea0d400bb94b?flat 2026-03-23 03:14:10,162 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:825bfe4b-5448-456b-aa12-b818ae58498a?flat 2026-03-23 03:14:10,253 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:825bfe4b-5448-456b-aa12-b818ae58498a?flat 2026-03-23 03:14:10,338 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-machine/508527b8-8f1f-4f1b-b470-ea0d400bb94b?flat 2026-03-23 03:14:10,433 - DEBUG - Verifying vm in vn uve 2026-03-23 03:14:10,433 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:825bfe4b-5448-456b-aa12-b818ae58498a?flat 2026-03-23 03:14:10,457 - DEBUG - VM uve shows interface as {'vn_uuid': 'bb2dea8b-3e86-4184-99fa-8d343d41357c', 'mac_address': '02:82:5b:fe:4b:54', 'is_health_check_active': True, 'virtual_network': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', 'ip6_active': False, 'fixed_ip4_list': ['165.64.92.131'], 'label': 25, 'tx_vlan': 65535, 'vhostuser_mode': 0, 'vm_name': 'ctest-SecurityGroupBasicRegressionTests1-14095770-77263394', 'ip_address': '165.64.92.131', 'vm_uuid': '508527b8-8f1f-4f1b-b470-ea0d400bb94b', 'l2_active': True, 'admin_state': True, 'rx_vlan': 65535, 'ip6_address': '::', '__T': 1774235618260005, 'gateway': '165.64.92.129', 'ip4_active': True, 'uuid': '825bfe4b-5448-456b-aa12-b818ae58498a', 'active': True, 'port_mirror_enabled': False} 2026-03-23 03:14:10,457 - DEBUG - VM uve shows ip address as ['165.64.92.131', '::'] 2026-03-23 03:14:10,457 - DEBUG - VM uve shows virtual network as default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 2026-03-23 03:14:10,457 - INFO - Verifying through opserver in 10.0.0.27 2026-03-23 03:14:10,457 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722?flat 2026-03-23 03:14:10,484 - DEBUG - expected vm list 508527b8-8f1f-4f1b-b470-ea0d400bb94b 2026-03-23 03:14:10,484 - DEBUG - Extracted vm list ['508527b8-8f1f-4f1b-b470-ea0d400bb94b'] 2026-03-23 03:14:10,484 - INFO - VM 508527b8-8f1f-4f1b-b470-ea0d400bb94b is present in default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 2026-03-23 03:14:10,485 - DEBUG - Verifying vm in vrouter uve 2026-03-23 03:14:10,485 - DEBUG - Getting info from collector 10.0.0.23.. 2026-03-23 03:14:10,485 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-machine/508527b8-8f1f-4f1b-b470-ea0d400bb94b?flat 2026-03-23 03:14:10,500 - DEBUG - VM uve shows vrouter as ['an-jenkins-deploy-platform-ansible-os-5514-2'] 2026-03-23 03:14:10,500 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-2:Compute:contrail-vrouter-agent:0?flat 2026-03-23 03:14:10,549 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-2?flat 2026-03-23 03:14:10,583 - DEBUG - VM 508527b8-8f1f-4f1b-b470-ea0d400bb94b is present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 03:14:10,583 - DEBUG - Validated that VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 is in Vrouter an-jenkins-deploy-platform-ansible-os-5514-2 UVE 2026-03-23 03:14:10,583 - DEBUG - Verifying vm tap interface/vn in vrouter uve 2026-03-23 03:14:10,594 - DEBUG - Expected tap interface of VM uuid 508527b8-8f1f-4f1b-b470-ea0d400bb94b is default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:825bfe4b-5448-456b-aa12-b818ae58498a 2026-03-23 03:14:10,594 - DEBUG - Expected VN of VM uuid 508527b8-8f1f-4f1b-b470-ea0d400bb94b is default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 2026-03-23 03:14:10,594 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-2:Compute:contrail-vrouter-agent:0?flat 2026-03-23 03:14:10,631 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-2?flat 2026-03-23 03:14:10,663 - DEBUG - VM 508527b8-8f1f-4f1b-b470-ea0d400bb94b is present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 03:14:10,663 - INFO - tap interface default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:825bfe4b-5448-456b-aa12-b818ae58498a of vm 508527b8-8f1f-4f1b-b470-ea0d400bb94b is present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 03:14:10,663 - DEBUG - Connected network default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 of vm 508527b8-8f1f-4f1b-b470-ea0d400bb94b is present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 03:14:10,663 - DEBUG - Verifying the 508527b8-8f1f-4f1b-b470-ea0d400bb94b virtual network link through opserver 10.0.0.27 2026-03-23 03:14:10,663 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-machines 2026-03-23 03:14:10,679 - DEBUG - VM link and name as {'name': '508527b8-8f1f-4f1b-b470-ea0d400bb94b', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-machine/508527b8-8f1f-4f1b-b470-ea0d400bb94b?flat'} 2026-03-23 03:14:10,679 - DEBUG - Verifying the 508527b8-8f1f-4f1b-b470-ea0d400bb94b virtual network link through opserver 10.0.0.50 2026-03-23 03:14:10,679 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-machines 2026-03-23 03:14:10,751 - DEBUG - VM link and name as {'name': '508527b8-8f1f-4f1b-b470-ea0d400bb94b', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-machine/508527b8-8f1f-4f1b-b470-ea0d400bb94b?flat'} 2026-03-23 03:14:10,752 - DEBUG - Verifying the 508527b8-8f1f-4f1b-b470-ea0d400bb94b virtual network link through opserver 10.0.0.23 2026-03-23 03:14:10,752 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-machines 2026-03-23 03:14:10,767 - DEBUG - VM link and name as {'name': '508527b8-8f1f-4f1b-b470-ea0d400bb94b', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-machine/508527b8-8f1f-4f1b-b470-ea0d400bb94b?flat'} 2026-03-23 03:14:10,767 - INFO - VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 validations in Opserver passed 2026-03-23 03:14:10,767 - INFO - Waiting for VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 to be up.. 2026-03-23 03:14:10,767 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-23 03:14:10,767 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/508527b8-8f1f-4f1b-b470-ea0d400bb94b 2026-03-23 03:14:10,775 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/825bfe4b-5448-456b-aa12-b818ae58498a 2026-03-23 03:14:11,947 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=4.20 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.741 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.741/2.472/4.203/1.731 ms') 2026-03-23 03:14:11,947 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 passed 2026-03-23 03:14:12,015 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-23 03:14:12,015 - DEBUG - Waiting to SSH to VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394, IP 165.64.92.131, Port 22 2026-03-23 03:14:12,083 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-03-23 03:14:12,202 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 is NOT ready for SSH connections, VM status: ACTIVE 2026-03-23 03:14:17,203 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-23 03:14:17,203 - DEBUG - Waiting to SSH to VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394, IP 165.64.92.131, Port 22 2026-03-23 03:14:17,272 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-03-23 03:14:17,364 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 is NOT ready for SSH connections, VM status: ACTIVE 2026-03-23 03:14:22,365 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-23 03:14:22,365 - DEBUG - Waiting to SSH to VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394, IP 165.64.92.131, Port 22 2026-03-23 03:14:22,433 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-03-23 03:14:22,526 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 is NOT ready for SSH connections, VM status: ACTIVE 2026-03-23 03:14:27,527 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-23 03:14:27,527 - DEBUG - Waiting to SSH to VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394, IP 165.64.92.131, Port 22 2026-03-23 03:14:27,596 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-03-23 03:14:27,692 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 is NOT ready for SSH connections, VM status: ACTIVE 2026-03-23 03:14:32,692 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-23 03:14:32,692 - DEBUG - Waiting to SSH to VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394, IP 165.64.92.131, Port 22 2026-03-23 03:14:32,860 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 is ready for SSH connections 2026-03-23 03:14:33,000 - DEBUG - VM is in ACTIVE state now 2026-03-23 03:14:33,000 - INFO - VM name : ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 2026-03-23 03:14:33,094 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 ID is 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 2026-03-23 03:14:33,186 - DEBUG - VM is in ACTIVE state now 2026-03-23 03:14:33,186 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 launched on Node an-jenkins-deploy-platform-ansible-os-5514-1 2026-03-23 03:14:33,274 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/81be1bbf-9f57-4d1d-8688-f9a88f493ab1 2026-03-23 03:14:33,287 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/81be1bbf-9f57-4d1d-8688-f9a88f493ab1 2026-03-23 03:14:33,295 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/9aa61b73-eb5b-4885-91bb-2f548275de3c 2026-03-23 03:14:33,306 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/81be1bbf-9f57-4d1d-8688-f9a88f493ab1 2026-03-23 03:14:33,315 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/9aa61b73-eb5b-4885-91bb-2f548275de3c 2026-03-23 03:14:33,329 - DEBUG - Requesting: http://10.0.0.23:8082/instance-ip/5413bb2e-5dd7-459b-9add-fc251c1b4dba 2026-03-23 03:14:33,338 - DEBUG - Verifying in api server 10.0.0.23 2026-03-23 03:14:33,338 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/81be1bbf-9f57-4d1d-8688-f9a88f493ab1 2026-03-23 03:14:33,344 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/9aa61b73-eb5b-4885-91bb-2f548275de3c 2026-03-23 03:14:33,357 - DEBUG - Requesting: http://10.0.0.23:8082/instance-ip/5413bb2e-5dd7-459b-9add-fc251c1b4dba 2026-03-23 03:14:33,364 - INFO - VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 verfication in all API Servers passed 2026-03-23 03:14:33,384 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 Tap interface: {'index': '3', 'name': 'tap9aa61b73-eb', 'uuid': '9aa61b73-eb5b-4885-91bb-2f548275de3c', 'vrf_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', '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': '25', 'l2_label': '29', 'vxlan_id': '15', 'vn_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', 'vm_uuid': '81be1bbf-9f57-4d1d-8688-f9a88f493ab1', 'vm_name': 'ctest-SecurityGroupBasicRegressionTests1-14095770-48666379', 'ip_addr': '165.64.92.132', 'mac_addr': '02:9a:a6:1b:73:eb', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.3', 'service_vlan_list': None, 'os_ifindex': '66', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:9aa61b73-eb5b-4885-91bb-2f548275de3c', 'sg_uuid_list': ['168408dc-bffa-4630-b47a-42b61ce8d8aa'], 'static_route_list': None, 'vm_project_uuid': '4497f961-ee7b-4520-b614-e7d5f204481d', 'admin_state': 'Enabled', 'flow_key_idx': '31', '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-03-23 03:14:33,384 - DEBUG - Agent 10.0.0.249 vrf name: default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 2026-03-23 03:14:33,391 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', 'ucindex': '2', 'mcindex': '2', 'l2index': '2', 'source': 'Config; ', 'uc6index': '2', 'vn': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', 'table_label': '-1', 'vxlan_id': '15', 'evpnindex': '2', 'brindex': '2', 'mplsindex': '0', 'RD': '10.20.0.192:2', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]} 2026-03-23 03:14:33,466 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 : Tap interface tap9aa61b73-eb is set to Active 2026-03-23 03:14:33,467 - DEBUG - Tap interface tap9aa61b73-eb detail : {'index': '3', 'name': 'tap9aa61b73-eb', 'uuid': '9aa61b73-eb5b-4885-91bb-2f548275de3c', 'vrf_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', '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': '25', 'l2_label': '29', 'vxlan_id': '15', 'vn_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', 'vm_uuid': '81be1bbf-9f57-4d1d-8688-f9a88f493ab1', 'vm_name': 'ctest-SecurityGroupBasicRegressionTests1-14095770-48666379', 'ip_addr': '165.64.92.132', 'mac_addr': '02:9a:a6:1b:73:eb', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.3', 'service_vlan_list': None, 'os_ifindex': '66', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:9aa61b73-eb5b-4885-91bb-2f548275de3c', 'sg_uuid_list': ['168408dc-bffa-4630-b47a-42b61ce8d8aa'], 'static_route_list': None, 'vm_project_uuid': '4497f961-ee7b-4520-b614-e7d5f204481d', 'admin_state': 'Enabled', 'flow_key_idx': '31', '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-03-23 03:14:33,579 - DEBUG - Starting Layer 2 verification in Agent 2026-03-23 03:14:33,593 - DEBUG - Layer 2 path is seen for VM MAC 02:9a:a6:1b:73:eb in agent 10.0.0.249 2026-03-23 03:14:33,593 - DEBUG - Active layer 2 route in agent is present for VMI tap9aa61b73-eb 2026-03-23 03:14:33,593 - DEBUG - L2 label(29) matches bw route table and interface table 2026-03-23 03:14:33,601 - DEBUG - VN default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is found in Agent of node 10.0.0.249 2026-03-23 03:14:33,741 - DEBUG - VRF IDs of VN default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is consistent in agent 10.0.0.249 2026-03-23 03:14:33,742 - DEBUG - Route for VM IP ['165.64.92.132'] is consistent in agent 10.0.0.249 2026-03-23 03:14:33,742 - DEBUG - VN default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 verification for VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 in Agent 10.0.0.249 passed 2026-03-23 03:14:33,857 - DEBUG - Starting all layer 2 verification in agent 10.0.0.249 2026-03-23 03:14:33,872 - DEBUG - Route for VM MAC 02:9a:a6:1b:73:eb is consistent in agent 10.0.0.249 2026-03-23 03:14:33,879 - DEBUG - VN default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is found in Agent of node 10.0.0.65 2026-03-23 03:14:34,010 - DEBUG - VRF IDs of VN default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is consistent in agent 10.0.0.65 2026-03-23 03:14:34,011 - DEBUG - Route for VM IP ['165.64.92.132'] is consistent in agent 10.0.0.65 2026-03-23 03:14:34,011 - DEBUG - VN default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 verification for VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 in Agent 10.0.0.65 passed 2026-03-23 03:14:34,120 - DEBUG - Starting all layer 2 verification in agent 10.0.0.65 2026-03-23 03:14:34,134 - DEBUG - Route for VM MAC 02:9a:a6:1b:73:eb is consistent in agent 10.0.0.65 2026-03-23 03:14:35,314 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=4.81 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.16 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 1.156/2.982/4.809/1.826 ms') 2026-03-23 03:14:35,314 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 passed 2026-03-23 03:14:35,315 - INFO - VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 verifications in Compute nodes passed 2026-03-23 03:14:35,529 - DEBUG - Validated VM route 165.64.92.132 in vrouter of 10.0.0.249 2026-03-23 03:14:35,534 - DEBUG - Remote Nh validation passed. Expected Tunnel, label: None, 0; Got None,0 2026-03-23 03:14:35,659 - DEBUG - Validated VM route 165.64.92.132 in vrouter of 10.0.0.65 2026-03-23 03:14:35,666 - DEBUG - Remote Nh validation passed. Expected Tunnel, label: 10.20.0.192, 25; Got 10.20.0.192,25 2026-03-23 03:14:35,666 - DEBUG - Validated VM route 165.64.92.132 in vrouter of 10.0.0.65 2026-03-23 03:14:35,666 - INFO - Validated routes of VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 in all vrouters 2026-03-23 03:14:36,092 - DEBUG - Starting all layer2 verification in 10.0.0.23 Control Node 2026-03-23 03:14:36,219 - DEBUG - Layer2 route found for VM MAC 02:9a:a6:1b:73:eb in Control-node 10.0.0.23 2026-03-23 03:14:36,219 - DEBUG - L2 Label for VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 same between Control-node 10.0.0.23 and Agent, Expected: 29, Seen: 29 2026-03-23 03:14:36,219 - DEBUG - Starting all layer2 verification in 10.0.0.27 Control Node 2026-03-23 03:14:36,351 - DEBUG - Layer2 route found for VM MAC 02:9a:a6:1b:73:eb in Control-node 10.0.0.27 2026-03-23 03:14:36,351 - DEBUG - L2 Label for VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 same between Control-node 10.0.0.27 and Agent, Expected: 29, Seen: 29 2026-03-23 03:14:36,351 - INFO - Verification in Control-nodes for VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 passed 2026-03-23 03:14:36,351 - DEBUG - Verifying the vm in opserver 2026-03-23 03:14:36,351 - DEBUG - Verifying in collector 10.0.0.23 ... 2026-03-23 03:14:36,351 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-machine/81be1bbf-9f57-4d1d-8688-f9a88f493ab1?flat 2026-03-23 03:14:36,368 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:9aa61b73-eb5b-4885-91bb-2f548275de3c?flat 2026-03-23 03:14:36,397 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:9aa61b73-eb5b-4885-91bb-2f548275de3c?flat 2026-03-23 03:14:36,425 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-machine/81be1bbf-9f57-4d1d-8688-f9a88f493ab1?flat 2026-03-23 03:14:36,444 - DEBUG - Verifying vm in vn uve 2026-03-23 03:14:36,444 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:9aa61b73-eb5b-4885-91bb-2f548275de3c?flat 2026-03-23 03:14:36,473 - DEBUG - VM uve shows interface as {'vn_uuid': 'bb2dea8b-3e86-4184-99fa-8d343d41357c', 'mac_address': '02:9a:a6:1b:73:eb', 'is_health_check_active': True, 'virtual_network': 'default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722', 'ip6_active': False, 'fixed_ip4_list': ['165.64.92.132'], 'label': 25, 'tx_vlan': 65535, 'vhostuser_mode': 0, 'vm_name': 'ctest-SecurityGroupBasicRegressionTests1-14095770-48666379', 'ip_address': '165.64.92.132', 'vm_uuid': '81be1bbf-9f57-4d1d-8688-f9a88f493ab1', 'l2_active': True, 'admin_state': True, 'rx_vlan': 65535, 'ip6_address': '::', '__T': 1774235621678365, 'gateway': '165.64.92.129', 'ip4_active': True, 'uuid': '9aa61b73-eb5b-4885-91bb-2f548275de3c', 'active': True, 'port_mirror_enabled': False} 2026-03-23 03:14:36,473 - DEBUG - VM uve shows ip address as ['165.64.92.132', '::'] 2026-03-23 03:14:36,473 - DEBUG - VM uve shows virtual network as default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 2026-03-23 03:14:36,473 - INFO - Verifying through opserver in 10.0.0.27 2026-03-23 03:14:36,474 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722?flat 2026-03-23 03:14:36,514 - DEBUG - expected vm list 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 2026-03-23 03:14:36,514 - DEBUG - Extracted vm list ['81be1bbf-9f57-4d1d-8688-f9a88f493ab1'] 2026-03-23 03:14:36,514 - INFO - VM 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 is present in default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 2026-03-23 03:14:36,514 - DEBUG - Verifying vm in vrouter uve 2026-03-23 03:14:36,514 - DEBUG - Getting info from collector 10.0.0.23.. 2026-03-23 03:14:36,514 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-machine/81be1bbf-9f57-4d1d-8688-f9a88f493ab1?flat 2026-03-23 03:14:36,535 - DEBUG - VM uve shows vrouter as ['an-jenkins-deploy-platform-ansible-os-5514-1'] 2026-03-23 03:14:36,535 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-1:Compute:contrail-vrouter-agent:0?flat 2026-03-23 03:14:36,578 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-1?flat 2026-03-23 03:14:36,617 - DEBUG - VM 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 is present in vrouter an-jenkins-deploy-platform-ansible-os-5514-1 uve 2026-03-23 03:14:36,617 - DEBUG - Validated that VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 is in Vrouter an-jenkins-deploy-platform-ansible-os-5514-1 UVE 2026-03-23 03:14:36,617 - DEBUG - Verifying vm tap interface/vn in vrouter uve 2026-03-23 03:14:36,631 - DEBUG - Expected tap interface of VM uuid 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 is default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:9aa61b73-eb5b-4885-91bb-2f548275de3c 2026-03-23 03:14:36,631 - DEBUG - Expected VN of VM uuid 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 is default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 2026-03-23 03:14:36,631 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-1:Compute:contrail-vrouter-agent:0?flat 2026-03-23 03:14:36,674 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-1?flat 2026-03-23 03:14:36,706 - DEBUG - VM 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 is present in vrouter an-jenkins-deploy-platform-ansible-os-5514-1 uve 2026-03-23 03:14:36,706 - INFO - tap interface default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:9aa61b73-eb5b-4885-91bb-2f548275de3c of vm 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 is present in vrouter an-jenkins-deploy-platform-ansible-os-5514-1 uve 2026-03-23 03:14:36,706 - DEBUG - Connected network default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 of vm 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 is present in vrouter an-jenkins-deploy-platform-ansible-os-5514-1 uve 2026-03-23 03:14:36,706 - DEBUG - Verifying the 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 virtual network link through opserver 10.0.0.27 2026-03-23 03:14:36,706 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-machines 2026-03-23 03:14:36,719 - DEBUG - VM link and name as {'name': '81be1bbf-9f57-4d1d-8688-f9a88f493ab1', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-machine/81be1bbf-9f57-4d1d-8688-f9a88f493ab1?flat'} 2026-03-23 03:14:36,719 - DEBUG - Verifying the 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 virtual network link through opserver 10.0.0.50 2026-03-23 03:14:36,719 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-machines 2026-03-23 03:14:36,732 - DEBUG - VM link and name as {'name': '81be1bbf-9f57-4d1d-8688-f9a88f493ab1', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-machine/81be1bbf-9f57-4d1d-8688-f9a88f493ab1?flat'} 2026-03-23 03:14:36,732 - DEBUG - Verifying the 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 virtual network link through opserver 10.0.0.23 2026-03-23 03:14:36,732 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-machines 2026-03-23 03:14:36,746 - DEBUG - VM link and name as {'name': '81be1bbf-9f57-4d1d-8688-f9a88f493ab1', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-machine/81be1bbf-9f57-4d1d-8688-f9a88f493ab1?flat'} 2026-03-23 03:14:36,746 - INFO - VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 validations in Opserver passed 2026-03-23 03:14:36,746 - INFO - Waiting for VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 to be up.. 2026-03-23 03:14:36,746 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-23 03:14:36,746 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/81be1bbf-9f57-4d1d-8688-f9a88f493ab1 2026-03-23 03:14:36,754 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/9aa61b73-eb5b-4885-91bb-2f548275de3c 2026-03-23 03:14:37,921 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=1.82 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.33 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 1.334/1.578/1.822/0.244 ms') 2026-03-23 03:14:37,921 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 passed 2026-03-23 03:14:37,988 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-23 03:14:37,988 - DEBUG - Waiting to SSH to VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379, IP 165.64.92.132, Port 22 2026-03-23 03:14:38,154 - DEBUG - VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 is ready for SSH connections 2026-03-23 03:14:38,154 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/508527b8-8f1f-4f1b-b470-ea0d400bb94b 2026-03-23 03:14:38,163 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/825bfe4b-5448-456b-aa12-b818ae58498a 2026-03-23 03:14:38,174 - DEBUG - Security group ctest-test_sec_group-06917502 is attached to the VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 2026-03-23 03:14:38,191 - DEBUG - Agent: Security group ctest-test_sec_group-06917502 is attached to the VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 2026-03-23 03:14:38,282 - INFO - Validated that SG ctest-test_sec_group-06917502 is bound to VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 2026-03-23 03:14:38,282 - INFO - Remove security group ctest-test_sec_group-06917502 from VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 2026-03-23 03:14:38,503 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/508527b8-8f1f-4f1b-b470-ea0d400bb94b 2026-03-23 03:14:38,512 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/825bfe4b-5448-456b-aa12-b818ae58498a 2026-03-23 03:14:38,522 - WARNING - Security group ctest-test_sec_group-06917502 is not attached to the VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 2026-03-23 03:14:38,743 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/508527b8-8f1f-4f1b-b470-ea0d400bb94b 2026-03-23 03:14:38,757 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/825bfe4b-5448-456b-aa12-b818ae58498a 2026-03-23 03:14:38,771 - DEBUG - Security group ctest-test_sec_group-06917502 is attached to the VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 2026-03-23 03:14:38,788 - DEBUG - Agent: Security group ctest-test_sec_group-06917502 is attached to the VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 2026-03-23 03:14:38,877 - INFO - Validated that SG ctest-test_sec_group-06917502 is bound to VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 2026-03-23 03:14:38,877 - INFO - Try deleting the security group ctest-test_sec_group-06917502 with back ref. 2026-03-23 03:14:38,877 - INFO - Deleting Security group: ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-14095770', 'ctest-test_sec_group-06917502'] 2026-03-23 03:14:38,908 - INFO - Security Group 168408dc-bffa-4630-b47a-42b61ce8d8aa in use. Neutron server returns request_ids: ['req-1e8336d1-2284-428a-a398-5dea5cc44de8'] 2026-03-23 03:14:38,908 - INFO - Not able to delete the security group with back ref as expected 2026-03-23 03:14:38,908 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-23 03:14:38,908 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 165.64.92.132, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.65, gateway password: c0ntrail123 2026-03-23 03:14:38,908 - DEBUG - ping -s 56 -c 3 -W 1 165.64.92.132 2026-03-23 03:15:32,106 - DEBUG - PING 165.64.92.132 (165.64.92.132) 56(84) bytes of data. --- 165.64.92.132 ping statistics --- 3 packets transmitted, 0 received, 100% packet loss, time 1999ms 2026-03-23 03:15:32,107 - WARNING - Ping to IP 165.64.92.132 from VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 failed 2026-03-23 03:15:32,107 - INFO - Ping FAILED as expected 2026-03-23 03:15:32,107 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-23 03:15:32,107 - DEBUG - Running remote_cmd, Cmd : rm -f testfile;ls -la;nc -ll -p 10000 > testfile, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.249, gateway password: c0ntrail123 2026-03-23 03:15:32,107 - DEBUG - nohup rm -f testfile;ls -la;nc -ll -p 10000 > testfile & 2026-03-23 03:16:18,734 - DEBUG - total 132 drwxr-xr-x 11 ubuntu ubuntu 4096 Dec 29 2017 . drwxr-xr-x 3 root root 4096 Jan 4 2013 .. -rw------- 1 ubuntu ubuntu 2689 Dec 29 2017 .bash_history -rw-r--r-- 1 ubuntu ubuntu 220 Apr 3 2012 .bash_logout -rw-r--r-- 1 ubuntu ubuntu 3486 Apr 3 2012 .bashrc drwx------ 2 ubuntu ubuntu 4096 Jan 9 2013 .cache -rwxrwxr-x 1 ubuntu ubuntu 1431 Feb 5 2015 flow_test_pktgen.sh drwxr-xr-x 2 ubuntu ubuntu 4096 Jan 9 2013 .fontconfig drwxrwxr-x 2 ubuntu ubuntu 4096 Jan 9 2013 .fvwm drwxrwxr-x 3 ubuntu ubuntu 4096 Nov 29 2016 .jenkins -rw------- 1 ubuntu ubuntu 52 Jul 2 2014 .lesshst drwx------ 4 ubuntu ubuntu 4096 Jan 9 2013 .mozilla -rwxrwxr-x 1 ubuntu ubuntu 1378 Jun 27 2014 pktgen_new.sh -rw-r--r-- 1 ubuntu ubuntu 675 Apr 3 2012 .profile drwxr-xr-x 2 ubuntu ubuntu 4096 Jun 27 2014 scr drwx------ 2 ubuntu ubuntu 4096 Feb 3 2015 .ssh -rw-r--r-- 1 ubuntu ubuntu 0 Jan 9 2013 .sudo_as_admin_successful drwxr-xr-x 2 ubuntu ubuntu 4096 Jun 27 2014 traffic drwxr-xr-x 4 root root 4096 Jun 27 2014 traffic-1.0 -rw-rw-r-- 1 ubuntu ubuntu 16361 Jan 9 2015 traffic-1.0.tar.gz -rw------- 1 root root 4695 Dec 17 2017 .viminfo -rw------- 1 ubuntu ubuntu 152 Jul 2 2014 .Xauthority -rw------- 1 ubuntu ubuntu 29828 Jan 9 2013 .xsession-errors 2026-03-23 03:16:18,734 - DEBUG - Running remote_cmd, Cmd : nc -ll 10000 > testfile, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.249, gateway password: c0ntrail123 2026-03-23 03:16:18,735 - DEBUG - nohup nc -ll 10000 > testfile & 2026-03-23 03:16:19,257 - DEBUG - None 2026-03-23 03:16:19,257 - DEBUG - Running remote_cmd, Cmd : dd bs=100 count=1 if=/dev/zero of=testfile;nc -p 10001 165.64.92.132 10000 < testfile, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.65, gateway password: c0ntrail123 2026-03-23 03:16:19,257 - DEBUG - dd bs=100 count=1 if=/dev/zero of=testfile;nc -p 10001 165.64.92.132 10000 < testfile 2026-03-23 03:16:19,866 - DEBUG - 1+0 records in 1+0 records out 100 bytes (100 B) copied, 0.000817028 s, 122 kB/s 2026-03-23 03:16:19,866 - DEBUG - Running remote_cmd, Cmd : ls -l testfile, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.249, gateway password: c0ntrail123 2026-03-23 03:16:19,866 - DEBUG - ls -l testfile 2026-03-23 03:16:20,241 - DEBUG - -rw-r--r-- 1 root root 100 Mar 23 03:16 testfile 2026-03-23 03:16:20,242 - INFO - File transfer verification for file size 100 passed on the VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 2026-03-23 03:16:20,242 - DEBUG - Replace all the rules of this security group ctest-test_sec_group-06917502 with the new rules 2026-03-23 03:16:20,242 - DEBUG - [{'protocol': '1', 'dst_addresses': [{'subnet': {'ip_prefix': '165.64.92.128', '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': '1', 'src_addresses': [{'subnet': {'ip_prefix': '165.64.92.128', '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-03-23 03:16:21,071 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-23 03:16:21,071 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 165.64.92.132, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.65, gateway password: c0ntrail123 2026-03-23 03:16:21,072 - DEBUG - ping -s 56 -c 3 -W 1 165.64.92.132 2026-03-23 03:16:23,559 - DEBUG - PING 165.64.92.132 (165.64.92.132) 56(84) bytes of data. 64 bytes from 165.64.92.132: icmp_req=1 ttl=64 time=4.08 ms 64 bytes from 165.64.92.132: icmp_req=2 ttl=64 time=1.47 ms 64 bytes from 165.64.92.132: icmp_req=3 ttl=64 time=1.37 ms --- 165.64.92.132 ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2004ms rtt min/avg/max/mdev = 1.374/2.310/4.085/1.256 ms 2026-03-23 03:16:23,559 - INFO - Ping to IP 165.64.92.132 from VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 passed 2026-03-23 03:16:23,559 - INFO - Removing the security group from VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 2026-03-23 03:16:23,782 - INFO - Deleting VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 2026-03-23 03:16:23,872 - DEBUG - Verifying in api server 10.0.0.23 2026-03-23 03:16:23,872 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/81be1bbf-9f57-4d1d-8688-f9a88f493ab1 2026-03-23 03:16:23,882 - DEBUG - VM ID 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 of VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 is still found in API Server 2026-03-23 03:16:25,882 - DEBUG - Verifying in api server 10.0.0.23 2026-03-23 03:16:25,882 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/81be1bbf-9f57-4d1d-8688-f9a88f493ab1 2026-03-23 03:16:25,889 - DEBUG - Response Code: 404 2026-03-23 03:16:25,890 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/81be1bbf-9f57-4d1d-8688-f9a88f493ab1 2026-03-23 03:16:25,897 - DEBUG - Response Code: 404 2026-03-23 03:16:25,897 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/81be1bbf-9f57-4d1d-8688-f9a88f493ab1 2026-03-23 03:16:25,905 - DEBUG - Response Code: 404 2026-03-23 03:16:25,905 - INFO - VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 is fully removed in API-Server 2026-03-23 03:16:26,066 - DEBUG - Skipping VM-deletion-check in nova db since mysql_token is not found 2026-03-23 03:16:26,109 - DEBUG - Validated that vrouter 10.0.0.249 does not have VMs route for VN default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 2026-03-23 03:16:26,240 - DEBUG - VM route 165.64.92.132 has been marked for discard in VN default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 of compute 10.0.0.65 2026-03-23 03:16:26,245 - DEBUG - Validated that vrouter 10.0.0.65 does not have VMs route for VN default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 2026-03-23 03:16:26,245 - INFO - Validated that all vrouters do not have VMs route for VN default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 2026-03-23 03:16:26,246 - INFO - VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 is removed in Compute, and routes are removed in all compute nodes 2026-03-23 03:16:26,453 - INFO - Routes for VM ctest-SecurityGroupBasicRegressionTests1-14095770-48666379 is removed in all control-nodes 2026-03-23 03:16:26,453 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-1:Compute:contrail-vrouter-agent:0?flat 2026-03-23 03:16:26,500 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-1?flat 2026-03-23 03:16:26,532 - DEBUG - VM 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-1 uve 2026-03-23 03:16:26,532 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 03:16:26,532 - DEBUG - interface for vm 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 deleted from vrouter uve ... 2026-03-23 03:16:26,532 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 03:16:29,533 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-1:Compute:contrail-vrouter-agent:0?flat 2026-03-23 03:16:29,569 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-1?flat 2026-03-23 03:16:29,605 - DEBUG - VM 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-1 uve 2026-03-23 03:16:29,606 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 03:16:29,606 - DEBUG - interface for vm 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 deleted from vrouter uve ... 2026-03-23 03:16:29,606 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 03:16:32,606 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-1:Compute:contrail-vrouter-agent:0?flat 2026-03-23 03:16:32,648 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-1?flat 2026-03-23 03:16:32,684 - DEBUG - VM 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-1 uve 2026-03-23 03:16:32,684 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 03:16:32,684 - DEBUG - interface for vm 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 deleted from vrouter uve ... 2026-03-23 03:16:32,684 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 03:16:35,685 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-1:Compute:contrail-vrouter-agent:0?flat 2026-03-23 03:16:35,721 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-1?flat 2026-03-23 03:16:35,754 - DEBUG - VM 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-1 uve 2026-03-23 03:16:35,754 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 03:16:35,754 - DEBUG - interface for vm 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 deleted from vrouter uve ... 2026-03-23 03:16:35,754 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 03:16:38,755 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-1:Compute:contrail-vrouter-agent:0?flat 2026-03-23 03:16:38,792 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-1?flat 2026-03-23 03:16:38,827 - DEBUG - VM 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-1 uve 2026-03-23 03:16:38,827 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 03:16:38,827 - DEBUG - interface for vm 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 deleted from vrouter uve ... 2026-03-23 03:16:38,827 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 03:16:41,828 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-1:Compute:contrail-vrouter-agent:0?flat 2026-03-23 03:16:41,867 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-1?flat 2026-03-23 03:16:41,912 - DEBUG - VM 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 is not present in vrouter an-jenkins-deploy-platform-ansible-os-5514-1 uve 2026-03-23 03:16:41,912 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 03:16:41,912 - DEBUG - interface for vm 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 deleted from vrouter uve ... 2026-03-23 03:16:41,912 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 03:16:41,912 - DEBUG - Validated that VM 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 is removed in Vrouter UVE 2026-03-23 03:16:41,912 - DEBUG - Verifying through opserver in 10.0.0.27 2026-03-23 03:16:41,913 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722?flat 2026-03-23 03:16:41,948 - DEBUG - 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 BM not in default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 uve 2026-03-23 03:16:41,948 - DEBUG - Validated that VM 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 is not present in the VN UVE 2026-03-23 03:16:41,948 - DEBUG - Verifying the 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 virtual network link through opserver 10.0.0.27 2026-03-23 03:16:41,948 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-machines 2026-03-23 03:16:41,962 - INFO - 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 vm uve deleted from opserver 2026-03-23 03:16:41,962 - DEBUG - Verifying the 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 virtual network link through opserver 10.0.0.50 2026-03-23 03:16:41,962 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-machines 2026-03-23 03:16:42,029 - INFO - 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 vm uve deleted from opserver 2026-03-23 03:16:42,029 - DEBUG - Verifying the 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 virtual network link through opserver 10.0.0.23 2026-03-23 03:16:42,030 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-machines 2026-03-23 03:16:42,043 - INFO - 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 vm uve deleted from opserver 2026-03-23 03:16:42,043 - INFO - Validated that VM 81be1bbf-9f57-4d1d-8688-f9a88f493ab1 is removed from Opserver 2026-03-23 03:16:42,043 - INFO - Removing the security group from VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 2026-03-23 03:16:42,308 - INFO - Deleting VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 2026-03-23 03:16:42,399 - DEBUG - Verifying in api server 10.0.0.23 2026-03-23 03:16:42,399 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/508527b8-8f1f-4f1b-b470-ea0d400bb94b 2026-03-23 03:16:42,412 - DEBUG - VM ID 508527b8-8f1f-4f1b-b470-ea0d400bb94b of VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 is still found in API Server 2026-03-23 03:16:44,412 - DEBUG - Verifying in api server 10.0.0.23 2026-03-23 03:16:44,412 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/508527b8-8f1f-4f1b-b470-ea0d400bb94b 2026-03-23 03:16:44,419 - DEBUG - Response Code: 404 2026-03-23 03:16:44,420 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/508527b8-8f1f-4f1b-b470-ea0d400bb94b 2026-03-23 03:16:44,425 - DEBUG - Response Code: 404 2026-03-23 03:16:44,425 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/508527b8-8f1f-4f1b-b470-ea0d400bb94b 2026-03-23 03:16:44,431 - DEBUG - Response Code: 404 2026-03-23 03:16:44,431 - INFO - VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 is fully removed in API-Server 2026-03-23 03:16:44,582 - DEBUG - Skipping VM-deletion-check in nova db since mysql_token is not found 2026-03-23 03:16:44,631 - DEBUG - Validated that vrouter 10.0.0.249 does not have VMs route for VN default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 2026-03-23 03:16:44,644 - DEBUG - Validated that vrouter 10.0.0.65 does not have VMs route for VN default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 2026-03-23 03:16:44,644 - INFO - Validated that all vrouters do not have VMs route for VN default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 2026-03-23 03:16:44,644 - INFO - VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 is removed in Compute, and routes are removed in all compute nodes 2026-03-23 03:16:44,845 - INFO - Routes for VM ctest-SecurityGroupBasicRegressionTests1-14095770-77263394 is removed in all control-nodes 2026-03-23 03:16:44,845 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-2:Compute:contrail-vrouter-agent:0?flat 2026-03-23 03:16:44,885 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-2?flat 2026-03-23 03:16:44,923 - DEBUG - VM 508527b8-8f1f-4f1b-b470-ea0d400bb94b is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 03:16:44,923 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 03:16:44,923 - DEBUG - interface for vm 508527b8-8f1f-4f1b-b470-ea0d400bb94b deleted from vrouter uve ... 2026-03-23 03:16:44,923 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 03:16:47,924 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-2:Compute:contrail-vrouter-agent:0?flat 2026-03-23 03:16:47,970 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-2?flat 2026-03-23 03:16:48,000 - DEBUG - VM 508527b8-8f1f-4f1b-b470-ea0d400bb94b is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 03:16:48,000 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 03:16:48,000 - DEBUG - interface for vm 508527b8-8f1f-4f1b-b470-ea0d400bb94b deleted from vrouter uve ... 2026-03-23 03:16:48,000 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 03:16:51,001 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-2:Compute:contrail-vrouter-agent:0?flat 2026-03-23 03:16:51,046 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-2?flat 2026-03-23 03:16:51,079 - DEBUG - VM 508527b8-8f1f-4f1b-b470-ea0d400bb94b is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 03:16:51,079 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 03:16:51,079 - DEBUG - interface for vm 508527b8-8f1f-4f1b-b470-ea0d400bb94b deleted from vrouter uve ... 2026-03-23 03:16:51,079 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 03:16:54,079 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-2:Compute:contrail-vrouter-agent:0?flat 2026-03-23 03:16:54,121 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-2?flat 2026-03-23 03:16:54,156 - DEBUG - VM 508527b8-8f1f-4f1b-b470-ea0d400bb94b is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 03:16:54,156 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 03:16:54,156 - DEBUG - interface for vm 508527b8-8f1f-4f1b-b470-ea0d400bb94b deleted from vrouter uve ... 2026-03-23 03:16:54,156 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 03:16:57,157 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-2:Compute:contrail-vrouter-agent:0?flat 2026-03-23 03:16:57,199 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-2?flat 2026-03-23 03:16:57,236 - DEBUG - VM 508527b8-8f1f-4f1b-b470-ea0d400bb94b is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 03:16:57,236 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 03:16:57,236 - DEBUG - interface for vm 508527b8-8f1f-4f1b-b470-ea0d400bb94b deleted from vrouter uve ... 2026-03-23 03:16:57,236 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 03:17:00,236 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-2:Compute:contrail-vrouter-agent:0?flat 2026-03-23 03:17:00,282 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-2?flat 2026-03-23 03:17:00,328 - DEBUG - VM 508527b8-8f1f-4f1b-b470-ea0d400bb94b is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 03:17:00,328 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 03:17:00,328 - DEBUG - interface for vm 508527b8-8f1f-4f1b-b470-ea0d400bb94b deleted from vrouter uve ... 2026-03-23 03:17:00,328 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 03:17:03,329 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-2:Compute:contrail-vrouter-agent:0?flat 2026-03-23 03:17:03,371 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-2?flat 2026-03-23 03:17:03,404 - DEBUG - VM 508527b8-8f1f-4f1b-b470-ea0d400bb94b is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 03:17:03,404 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 03:17:03,404 - DEBUG - interface for vm 508527b8-8f1f-4f1b-b470-ea0d400bb94b deleted from vrouter uve ... 2026-03-23 03:17:03,404 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 03:17:06,405 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-2:Compute:contrail-vrouter-agent:0?flat 2026-03-23 03:17:06,442 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-2?flat 2026-03-23 03:17:06,473 - DEBUG - VM 508527b8-8f1f-4f1b-b470-ea0d400bb94b is still present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 03:17:06,474 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 03:17:06,474 - DEBUG - interface for vm 508527b8-8f1f-4f1b-b470-ea0d400bb94b deleted from vrouter uve ... 2026-03-23 03:17:06,474 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 03:17:09,475 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5514-2:Compute:contrail-vrouter-agent:0?flat 2026-03-23 03:17:09,520 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5514-2?flat 2026-03-23 03:17:09,552 - DEBUG - VM 508527b8-8f1f-4f1b-b470-ea0d400bb94b is not present in vrouter an-jenkins-deploy-platform-ansible-os-5514-2 uve 2026-03-23 03:17:09,552 - DEBUG - Verifying if the vm interface deleted from vroter uve... 2026-03-23 03:17:09,552 - DEBUG - interface for vm 508527b8-8f1f-4f1b-b470-ea0d400bb94b deleted from vrouter uve ... 2026-03-23 03:17:09,552 - DEBUG - Deleted interface not in error interface list ... 2026-03-23 03:17:09,552 - DEBUG - Validated that VM 508527b8-8f1f-4f1b-b470-ea0d400bb94b is removed in Vrouter UVE 2026-03-23 03:17:09,552 - DEBUG - Verifying through opserver in 10.0.0.27 2026-03-23 03:17:09,552 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722?flat 2026-03-23 03:17:09,570 - DEBUG - 508527b8-8f1f-4f1b-b470-ea0d400bb94b BM not in default-domain:ctest-SecurityGroupBasicRegressionTests1-14095770:ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 uve 2026-03-23 03:17:09,570 - DEBUG - Validated that VM 508527b8-8f1f-4f1b-b470-ea0d400bb94b is not present in the VN UVE 2026-03-23 03:17:09,570 - DEBUG - Verifying the 508527b8-8f1f-4f1b-b470-ea0d400bb94b virtual network link through opserver 10.0.0.27 2026-03-23 03:17:09,570 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-machines 2026-03-23 03:17:09,583 - DEBUG - No links retuned for 508527b8-8f1f-4f1b-b470-ea0d400bb94b 2026-03-23 03:17:09,584 - INFO - 508527b8-8f1f-4f1b-b470-ea0d400bb94b vm uve deleted from opserver 2026-03-23 03:17:09,584 - DEBUG - Verifying the 508527b8-8f1f-4f1b-b470-ea0d400bb94b virtual network link through opserver 10.0.0.50 2026-03-23 03:17:09,584 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-machines 2026-03-23 03:17:09,596 - DEBUG - No links retuned for 508527b8-8f1f-4f1b-b470-ea0d400bb94b 2026-03-23 03:17:09,596 - INFO - 508527b8-8f1f-4f1b-b470-ea0d400bb94b vm uve deleted from opserver 2026-03-23 03:17:09,596 - DEBUG - Verifying the 508527b8-8f1f-4f1b-b470-ea0d400bb94b virtual network link through opserver 10.0.0.23 2026-03-23 03:17:09,596 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-machines 2026-03-23 03:17:09,607 - DEBUG - No links retuned for 508527b8-8f1f-4f1b-b470-ea0d400bb94b 2026-03-23 03:17:09,607 - INFO - 508527b8-8f1f-4f1b-b470-ea0d400bb94b vm uve deleted from opserver 2026-03-23 03:17:09,607 - INFO - Validated that VM 508527b8-8f1f-4f1b-b470-ea0d400bb94b is removed from Opserver 2026-03-23 03:17:09,607 - INFO - Deleting VN ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 2026-03-23 03:17:09,775 - DEBUG - Response for deleting network () 2026-03-23 03:17:09,775 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/da5ef24b-8d48-488f-8f61-c51641e6f482 2026-03-23 03:17:09,789 - DEBUG - Response Code: 404 2026-03-23 03:17:09,789 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 03:17:09,797 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 03:17:09,860 - DEBUG - Requesting: http://10.0.0.27:8082/project/4497f961-ee7b-4520-b614-e7d5f204481d 2026-03-23 03:17:09,956 - INFO - Validated that VN ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is not found in API Server 2026-03-23 03:17:09,976 - DEBUG - VN ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is not present in Agent 10.0.0.249 2026-03-23 03:17:09,991 - DEBUG - VN ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is not present in Agent 10.0.0.65 2026-03-23 03:17:09,991 - INFO - Validated that VN ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 is not in any agent 2026-03-23 03:17:10,028 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-SecurityGroupBasicRegressionTests1-14095770-24658722 info 2026-03-23 03:17:10,028 - INFO - Deleting Security group: ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-14095770', 'ctest-test_sec_group-06917502'] 2026-03-23 03:17:10,108 - INFO - Security group: ['default-domain', 'ctest-SecurityGroupBasicRegressionTests1-14095770', 'ctest-test_sec_group-06917502'] deleted successfully. 2026-03-23 03:17:10,108 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 03:17:10,116 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 03:17:10,145 - DEBUG - Requesting: http://10.0.0.27:8082/project/4497f961-ee7b-4520-b614-e7d5f204481d 2026-03-23 03:17:10,247 - INFO - Security group ctest-test_sec_group-06917502 removed from the API Server 2026-03-23 03:17:10,247 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-03-23 03:17:10,255 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789 2026-03-23 03:17:10,269 - DEBUG - Requesting: http://10.0.0.27:8082/project/4497f961-ee7b-4520-b614-e7d5f204481d 2026-03-23 03:17:10,373 - DEBUG - Requesting: http://10.0.0.27:8082/access-control-lists 2026-03-23 03:17:10,382 - DEBUG - ACLs for Security group ctest-test_sec_group-06917502 removed from the API Server 2026-03-23 03:17:10,387 - INFO - security group ctest-test_sec_group-06917502 removed from Control-node 10.0.0.27 2026-03-23 03:17:10,396 - DEBUG - Security group ctest-test_sec_group-06917502 ACLs removed from the control node 10.0.0.27 2026-03-23 03:17:10,401 - INFO - security group ctest-test_sec_group-06917502 removed from Control-node 10.0.0.50 2026-03-23 03:17:10,406 - DEBUG - Security group ctest-test_sec_group-06917502 ACLs removed from the control node 10.0.0.50 2026-03-23 03:17:10,411 - INFO - security group ctest-test_sec_group-06917502 removed from Control-node 10.0.0.23 2026-03-23 03:17:10,416 - DEBUG - Security group ctest-test_sec_group-06917502 ACLs removed from the control node 10.0.0.23 2026-03-23 03:17:10,416 - INFO - Validated that SG ctest-test_sec_group-06917502 is not in control nodes 2026-03-23 03:17:11,695 - DEBUG - No XMPP flaps were noticed during the test

2026-03-23 03:17:11,695 - INFO - END TEST : test_sec_group_basic : PASSED[0:03:54]

2026-03-23 03:17:11,695 - INFO - -------------------------------------------------------------------------------- 2026-03-23 03:17:12,472 - INFO - Deleted project: ctest-SecurityGroupBasicRegressionTests1-14095770, ID : 4497f961-ee7b-4520-b614-e7d5f204481d