]) created on node: (an-jenkins-deploy-platform-ansible-os-5896-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5896-1)
2026-06-05 17:31:47,140 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-18167569']
2026-06-05 17:31:47,547 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-18167569'] created succesfully
2026-06-05 17:31:47,960 - DEBUG - Image by name tiny_nat_fw not found
2026-06-05 17:31:47,961 - DEBUG - Installing image tiny_nat_fw
2026-06-05 17:31:47,961 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-06-05 17:31:47,961 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-06-05 17:31:47,961 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-06-05 17:31:47,980 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz -O /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-06-05 17:31:48,088 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-06-05 17:31:48,088 - DEBUG - Unzip image
2026-06-05 17:31:48,088 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-06-05 17:31:48,113 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-06-05 17:31:48,114 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-18167569']
2026-06-05 17:31:48,215 - INFO - Service template: ['default-domain', 'ctest-service_template_1-18167569'] deleted successfully.
2026-06-05 17:31:48,215 - INFO - Skip interface_detach for VM ctest-right_vm-35738654 in state BUILD
2026-06-05 17:31:48,215 - INFO - Deleting VM ctest-right_vm-35738654
2026-06-05 17:31:48,245 - ERROR - VM ctest-right_vm-35738654 has failed to come up
2026-06-05 17:31:48,245 - ERROR - Nova failed to get host of the VM
2026-06-05 17:31:48,245 - ERROR - VM ctest-right_vm-35738654 has failed to come up
2026-06-05 17:31:48,246 - ERROR - Nova failed to get host of the VM
2026-06-05 17:31:48,313 - INFO - Skip interface_detach for VM ctest-left_vm-15918356 in state BUILD
2026-06-05 17:31:48,314 - INFO - Deleting VM ctest-left_vm-15918356
2026-06-05 17:31:48,314 - ERROR - VM ctest-left_vm-15918356 has failed to come up
2026-06-05 17:31:48,314 - ERROR - Nova failed to get host of the VM
2026-06-05 17:31:48,314 - ERROR - VM ctest-left_vm-15918356 has failed to come up
2026-06-05 17:31:48,314 - ERROR - Nova failed to get host of the VM
2026-06-05 17:31:48,383 - INFO - Deleting VN ctest-right_vn-60115038
2026-06-05 17:31:48,425 - DEBUG - VN 4618483a-0448-45e7-903b-16d33e85530c still in use: Unable to complete operation on network 4618483a-0448-45e7-903b-16d33e85530c. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-91309102-a2fe-4105-926c-29877723fcf1']
2026-06-05 17:31:48,425 - WARNING - Deleting VN ctest-right_vn-60115038 failed..Will retry
2026-06-05 17:31:50,587 - DEBUG - Response for deleting network ()
2026-06-05 17:31:50,587 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c9f1144-394e-41d7-8dcf-80473efbe626
2026-06-05 17:31:50,596 - DEBUG - Response Code: 404
2026-06-05 17:31:50,596 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:31:50,608 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:31:50,643 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d19760c-3c70-4c07-be71-3d1afc0ad892
2026-06-05 17:31:50,727 - INFO - Validated that VN ctest-right_vn-60115038 is not found in API Server
2026-06-05 17:31:50,748 - DEBUG - VN ctest-right_vn-60115038 is not present in Agent 10.0.0.27
2026-06-05 17:31:50,759 - DEBUG - VN ctest-right_vn-60115038 is not present in Agent 10.0.0.19
2026-06-05 17:31:50,759 - INFO - Validated that VN ctest-right_vn-60115038 is not in any agent
2026-06-05 17:31:50,788 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-60115038 info
2026-06-05 17:31:50,788 - INFO - Deleting VN ctest-left_vn-49230365
2026-06-05 17:31:50,966 - DEBUG - Response for deleting network ()
2026-06-05 17:31:50,966 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/fa45aedb-2728-4978-8388-a7a501a6c6de
2026-06-05 17:31:50,972 - DEBUG - Response Code: 404
2026-06-05 17:31:50,972 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:31:50,984 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:31:51,002 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d19760c-3c70-4c07-be71-3d1afc0ad892
2026-06-05 17:31:51,098 - INFO - Validated that VN ctest-left_vn-49230365 is not found in API Server
2026-06-05 17:31:51,111 - DEBUG - VN ctest-left_vn-49230365 is not present in Agent 10.0.0.27
2026-06-05 17:31:51,125 - DEBUG - VN ctest-left_vn-49230365 is not present in Agent 10.0.0.19
2026-06-05 17:31:51,125 - INFO - Validated that VN ctest-left_vn-49230365 is not in any agent
2026-06-05 17:31:51,162 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-49230365 info
2026-06-05 17:31:51,162 - INFO - Deleting VN ctest-mgmt_vn-44900227
2026-06-05 17:31:51,306 - DEBUG - Response for deleting network ()
2026-06-05 17:31:51,306 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/8d029a67-1ab9-4da4-8f2f-c9cd7d3f0270
2026-06-05 17:31:51,313 - DEBUG - Response Code: 404
2026-06-05 17:31:51,313 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:31:51,329 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:31:51,345 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d19760c-3c70-4c07-be71-3d1afc0ad892
2026-06-05 17:31:51,433 - INFO - Validated that VN ctest-mgmt_vn-44900227 is not found in API Server
2026-06-05 17:31:51,446 - DEBUG - VN ctest-mgmt_vn-44900227 is not present in Agent 10.0.0.27
2026-06-05 17:31:51,458 - DEBUG - VN ctest-mgmt_vn-44900227 is not present in Agent 10.0.0.19
2026-06-05 17:31:51,458 - INFO - Validated that VN ctest-mgmt_vn-44900227 is not in any agent
2026-06-05 17:31:51,493 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-44900227 info
2026-06-05 17:31:51,493 - INFO - Deleting VM ctest-vm-in-third-vn-08161486
2026-06-05 17:31:51,560 - INFO - Deleting VN ctest-third-vn-26188065
2026-06-05 17:31:51,604 - DEBUG - VN 98d753d5-5565-4077-b22a-590665420979 still in use: Unable to complete operation on network 98d753d5-5565-4077-b22a-590665420979. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-516b554d-26f7-49fe-8ff7-5b725a179049']
2026-06-05 17:31:51,604 - WARNING - Deleting VN ctest-third-vn-26188065 failed..Will retry
2026-06-05 17:31:53,772 - DEBUG - Response for deleting network ()
2026-06-05 17:31:55,047 - DEBUG - No XMPP flaps were noticed during the test
2026-06-05 17:31:55,047 - INFO -
2026-06-05 17:31:55,047 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:25]
2026-06-05 17:31:55,047 - INFO - --------------------------------------------------------------------------------
2026-06-05 17:31:55,050 - INFO - ================================================================================
2026-06-05 17:31:55,050 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2026-06-05 17:31:56,322 - DEBUG - Nothing to compare xmpp stats {'10.0.0.27': {'10.20.0.14': '0', '10.20.0.129': '0'}, '10.0.0.19': {'10.20.0.18': '0', '10.20.0.14': '0'}} with
2026-06-05 17:31:56,322 - INFO - Initial checks done. Running the testcase now
2026-06-05 17:31:56,322 - INFO -
2026-06-05 17:31:56,592 - DEBUG - Response for create_network : {'network': {'id': 'dfda8e43-c96b-478e-834b-efe615368e37', 'name': 'ctest-mgmt_vn-67431508', 'tenant_id': '1d19760c3c704c07be713d1afc0ad892', 'project_id': '1d19760c3c704c07be713d1afc0ad892', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-61626230', 'ctest-mgmt_vn-67431508'], 'port_security_enabled': True, 'description': ''}}
2026-06-05 17:31:56,840 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c39a6e1d-02e0-46c5-8163-ddafb4a08e8b', 'name': '', 'tenant_id': '1d19760c3c704c07be713d1afc0ad892', 'network_id': 'dfda8e43-c96b-478e-834b-efe615368e37', 'ip_version': 4, 'cidr': '152.49.167.64/26', 'allocation_pools': [{'start': '152.49.167.66', 'end': '152.49.167.126'}], 'gateway_ip': '152.49.167.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '152.49.167.66', 'tags': [], 'project_id': '1d19760c3c704c07be713d1afc0ad892'}}
2026-06-05 17:31:56,861 - INFO - Created VN ctest-mgmt_vn-67431508
2026-06-05 17:31:56,875 - DEBUG - VN ctest-mgmt_vn-67431508 UUID is dfda8e43-c96b-478e-834b-efe615368e37
2026-06-05 17:31:56,948 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:31:56,954 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:31:56,965 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d19760c-3c70-4c07-be71-3d1afc0ad892
2026-06-05 17:31:57,057 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/dfda8e43-c96b-478e-834b-efe615368e37
2026-06-05 17:31:57,073 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/dfda8e43-c96b-478e-834b-efe615368e37
2026-06-05 17:31:57,083 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/9ef0c679-9894-4440-b1a2-6bffd184ab32
2026-06-05 17:31:57,093 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/9ef0c679-9894-4440-b1a2-6bffd184ab32
2026-06-05 17:31:57,099 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/088c715b-b3aa-45ca-a82f-422c598c36d8
2026-06-05 17:31:57,105 - DEBUG - Route Targets: ['target:64512:8000004']
2026-06-05 17:31:57,106 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/dfda8e43-c96b-478e-834b-efe615368e37
2026-06-05 17:31:57,114 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/9ef0c679-9894-4440-b1a2-6bffd184ab32
2026-06-05 17:31:57,128 - INFO - Verified VN network id 14 for VN dfda8e43-c96b-478e-834b-efe615368e37
2026-06-05 17:31:57,128 - INFO - Verifications in API Server for VN ctest-mgmt_vn-67431508 passed
2026-06-05 17:31:57,128 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/dfda8e43-c96b-478e-834b-efe615368e37
2026-06-05 17:31:57,138 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/9ef0c679-9894-4440-b1a2-6bffd184ab32
2026-06-05 17:31:57,144 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/9ef0c679-9894-4440-b1a2-6bffd184ab32
2026-06-05 17:31:57,151 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/088c715b-b3aa-45ca-a82f-422c598c36d8
2026-06-05 17:31:57,162 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-61626230:ctest-mgmt_vn-67431508', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-61626230', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16130361437174056846', 'uuid-lslong': '9460919213699272247'}, 'enable': 'true', 'created': '2026-06-05T17:31:56', 'last-modified': '2026-06-05T17:31:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.379835'}
2026-06-05 17:31:57,167 - DEBUG - Route Targets: ['target:64512:8000004']
2026-06-05 17:31:57,173 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-61626230:ctest-mgmt_vn-67431508', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-61626230', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16130361437174056846', 'uuid-lslong': '9460919213699272247'}, 'enable': 'true', 'created': '2026-06-05T17:31:56', 'last-modified': '2026-06-05T17:31:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.395196'}
2026-06-05 17:31:57,178 - DEBUG - Route Targets: ['target:64512:8000004']
2026-06-05 17:31:57,183 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-61626230:ctest-mgmt_vn-67431508', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-61626230', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16130361437174056846', 'uuid-lslong': '9460919213699272247'}, 'enable': 'true', 'created': '2026-06-05T17:31:56', 'last-modified': '2026-06-05T17:31:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.404504'}
2026-06-05 17:31:57,189 - DEBUG - Route Targets: ['target:64512:8000004']
2026-06-05 17:31:57,189 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-67431508 passed
2026-06-05 17:31:57,189 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-67431508 in API_Server ======
2026-06-05 17:31:57,189 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:31:57,195 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:31:57,206 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d19760c-3c70-4c07-be71-3d1afc0ad892
2026-06-05 17:31:57,300 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/dfda8e43-c96b-478e-834b-efe615368e37
2026-06-05 17:31:57,313 - DEBUG - =>VN ctest-mgmt_vn-67431508 has no policy to be verified
2026-06-05 17:31:57,313 - DEBUG - Verifying the vn in opserver
2026-06-05 17:31:57,313 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-61626230:ctest-mgmt_vn-67431508 virtual network link through opserver 10.0.0.33
2026-06-05 17:31:57,313 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-06-05 17:31:57,325 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-61626230:ctest-mgmt_vn-67431508', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-61626230:ctest-mgmt_vn-67431508?flat'}
2026-06-05 17:31:57,325 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-61626230:ctest-mgmt_vn-67431508 virtual network link through opserver 10.0.0.130
2026-06-05 17:31:57,325 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-06-05 17:31:57,338 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-61626230:ctest-mgmt_vn-67431508', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-61626230:ctest-mgmt_vn-67431508?flat'}
2026-06-05 17:31:57,338 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-61626230:ctest-mgmt_vn-67431508 virtual network link through opserver 10.0.0.38
2026-06-05 17:31:57,338 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-06-05 17:31:57,351 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-61626230:ctest-mgmt_vn-67431508', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-61626230:ctest-mgmt_vn-67431508?flat'}
2026-06-05 17:31:57,351 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-61626230:ctest-mgmt_vn-67431508 is found in opserver
2026-06-05 17:31:57,369 - DEBUG - Do not have enough data to verify VN in agent
2026-06-05 17:31:57,378 - DEBUG - VRF ids for VN ctest-mgmt_vn-67431508: {}
2026-06-05 17:31:57,650 - DEBUG - Response for create_network : {'network': {'id': 'f6f7a53b-9249-43e3-8b8b-196c158a3d0a', 'name': 'ctest-left_vn-52525535', 'tenant_id': '1d19760c3c704c07be713d1afc0ad892', 'project_id': '1d19760c3c704c07be713d1afc0ad892', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-61626230', 'ctest-left_vn-52525535'], 'port_security_enabled': True, 'description': ''}}
2026-06-05 17:31:57,906 - DEBUG - Response for create_subnet : {'subnet': {'id': '20e232fa-5e4e-4f3c-a729-d2b2586faa1d', 'name': '', 'tenant_id': '1d19760c3c704c07be713d1afc0ad892', 'network_id': 'f6f7a53b-9249-43e3-8b8b-196c158a3d0a', 'ip_version': 4, 'cidr': '176.203.196.64/26', 'allocation_pools': [{'start': '176.203.196.66', 'end': '176.203.196.126'}], 'gateway_ip': '176.203.196.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '176.203.196.66', 'tags': [], 'project_id': '1d19760c3c704c07be713d1afc0ad892'}}
2026-06-05 17:31:57,928 - INFO - Created VN ctest-left_vn-52525535
2026-06-05 17:31:57,943 - DEBUG - VN ctest-left_vn-52525535 UUID is f6f7a53b-9249-43e3-8b8b-196c158a3d0a
2026-06-05 17:31:58,011 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:31:58,018 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:31:58,028 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d19760c-3c70-4c07-be71-3d1afc0ad892
2026-06-05 17:31:58,117 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/f6f7a53b-9249-43e3-8b8b-196c158a3d0a
2026-06-05 17:31:58,130 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/f6f7a53b-9249-43e3-8b8b-196c158a3d0a
2026-06-05 17:31:58,141 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/820b3aa9-c72a-4e05-9cb6-76448d6d2098
2026-06-05 17:31:58,149 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/820b3aa9-c72a-4e05-9cb6-76448d6d2098
2026-06-05 17:31:58,155 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/d5dc28f8-2d5c-4679-a5b3-0db8feb35e6b
2026-06-05 17:31:58,161 - DEBUG - Route Targets: ['target:64512:8000005']
2026-06-05 17:31:58,161 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/f6f7a53b-9249-43e3-8b8b-196c158a3d0a
2026-06-05 17:31:58,170 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/820b3aa9-c72a-4e05-9cb6-76448d6d2098
2026-06-05 17:31:58,187 - INFO - Verified VN network id 15 for VN f6f7a53b-9249-43e3-8b8b-196c158a3d0a
2026-06-05 17:31:58,187 - INFO - Verifications in API Server for VN ctest-left_vn-52525535 passed
2026-06-05 17:31:58,187 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/f6f7a53b-9249-43e3-8b8b-196c158a3d0a
2026-06-05 17:31:58,195 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/820b3aa9-c72a-4e05-9cb6-76448d6d2098
2026-06-05 17:31:58,203 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/820b3aa9-c72a-4e05-9cb6-76448d6d2098
2026-06-05 17:31:58,209 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/d5dc28f8-2d5c-4679-a5b3-0db8feb35e6b
2026-06-05 17:31:58,221 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-61626230:ctest-left_vn-52525535', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-61626230', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17795874127853732835', 'uuid-lslong': '10055158545043307786'}, 'enable': 'true', 'created': '2026-06-05T17:31:57', 'last-modified': '2026-06-05T17:31:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.377694'}
2026-06-05 17:31:58,227 - DEBUG - Route Targets: ['target:64512:8000005']
2026-06-05 17:31:58,233 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-61626230:ctest-left_vn-52525535', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-61626230', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17795874127853732835', 'uuid-lslong': '10055158545043307786'}, 'enable': 'true', 'created': '2026-06-05T17:31:57', 'last-modified': '2026-06-05T17:31:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.390440'}
2026-06-05 17:31:58,240 - DEBUG - Route Targets: ['target:64512:8000005']
2026-06-05 17:31:58,246 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-61626230:ctest-left_vn-52525535', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-61626230', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17795874127853732835', 'uuid-lslong': '10055158545043307786'}, 'enable': 'true', 'created': '2026-06-05T17:31:57', 'last-modified': '2026-06-05T17:31:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.401242'}
2026-06-05 17:31:58,252 - DEBUG - Route Targets: ['target:64512:8000005']
2026-06-05 17:31:58,252 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-52525535 passed
2026-06-05 17:31:58,252 - DEBUG - ====Verifying policy data for ctest-left_vn-52525535 in API_Server ======
2026-06-05 17:31:58,252 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:31:58,258 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:31:58,268 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d19760c-3c70-4c07-be71-3d1afc0ad892
2026-06-05 17:31:58,371 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/f6f7a53b-9249-43e3-8b8b-196c158a3d0a
2026-06-05 17:31:58,380 - DEBUG - =>VN ctest-left_vn-52525535 has no policy to be verified
2026-06-05 17:31:58,380 - DEBUG - Verifying the vn in opserver
2026-06-05 17:31:58,380 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-61626230:ctest-left_vn-52525535 virtual network link through opserver 10.0.0.33
2026-06-05 17:31:58,380 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-06-05 17:31:58,391 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-61626230:ctest-left_vn-52525535', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-61626230:ctest-left_vn-52525535?flat'}
2026-06-05 17:31:58,391 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-61626230:ctest-left_vn-52525535 virtual network link through opserver 10.0.0.130
2026-06-05 17:31:58,391 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-06-05 17:31:58,403 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-61626230:ctest-left_vn-52525535', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-61626230:ctest-left_vn-52525535?flat'}
2026-06-05 17:31:58,403 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-61626230:ctest-left_vn-52525535 virtual network link through opserver 10.0.0.38
2026-06-05 17:31:58,403 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-06-05 17:31:58,415 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-61626230:ctest-left_vn-52525535', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-61626230:ctest-left_vn-52525535?flat'}
2026-06-05 17:31:58,415 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-61626230:ctest-left_vn-52525535 is found in opserver
2026-06-05 17:31:58,435 - DEBUG - Do not have enough data to verify VN in agent
2026-06-05 17:31:58,445 - DEBUG - VRF ids for VN ctest-left_vn-52525535: {}
2026-06-05 17:31:58,734 - DEBUG - Response for create_network : {'network': {'id': '38aea1ac-1da1-4f81-8a6e-cdd83ba2ef5f', 'name': 'ctest-right_vn-61691533', 'tenant_id': '1d19760c3c704c07be713d1afc0ad892', 'project_id': '1d19760c3c704c07be713d1afc0ad892', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-61626230', 'ctest-right_vn-61691533'], 'port_security_enabled': True, 'description': ''}}
2026-06-05 17:31:58,972 - DEBUG - Response for create_subnet : {'subnet': {'id': '6f3a78ef-2d35-4cbb-bc55-7f9824a1f446', 'name': '', 'tenant_id': '1d19760c3c704c07be713d1afc0ad892', 'network_id': '38aea1ac-1da1-4f81-8a6e-cdd83ba2ef5f', 'ip_version': 4, 'cidr': '213.101.179.192/26', 'allocation_pools': [{'start': '213.101.179.194', 'end': '213.101.179.254'}], 'gateway_ip': '213.101.179.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '213.101.179.194', 'tags': [], 'project_id': '1d19760c3c704c07be713d1afc0ad892'}}
2026-06-05 17:31:58,994 - INFO - Created VN ctest-right_vn-61691533
2026-06-05 17:31:59,005 - DEBUG - VN ctest-right_vn-61691533 UUID is 38aea1ac-1da1-4f81-8a6e-cdd83ba2ef5f
2026-06-05 17:31:59,073 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:31:59,089 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:31:59,104 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d19760c-3c70-4c07-be71-3d1afc0ad892
2026-06-05 17:31:59,218 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/38aea1ac-1da1-4f81-8a6e-cdd83ba2ef5f
2026-06-05 17:31:59,235 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/38aea1ac-1da1-4f81-8a6e-cdd83ba2ef5f
2026-06-05 17:31:59,244 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/2e9e80b8-3c51-43ec-bd19-0726da0bc365
2026-06-05 17:31:59,251 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/2e9e80b8-3c51-43ec-bd19-0726da0bc365
2026-06-05 17:31:59,257 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/b06c44d3-c55c-4d7a-8130-82856a6c8dec
2026-06-05 17:31:59,263 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-05 17:31:59,263 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/38aea1ac-1da1-4f81-8a6e-cdd83ba2ef5f
2026-06-05 17:31:59,271 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/2e9e80b8-3c51-43ec-bd19-0726da0bc365
2026-06-05 17:31:59,285 - INFO - Verified VN network id 16 for VN 38aea1ac-1da1-4f81-8a6e-cdd83ba2ef5f
2026-06-05 17:31:59,285 - INFO - Verifications in API Server for VN ctest-right_vn-61691533 passed
2026-06-05 17:31:59,285 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/38aea1ac-1da1-4f81-8a6e-cdd83ba2ef5f
2026-06-05 17:31:59,293 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/2e9e80b8-3c51-43ec-bd19-0726da0bc365
2026-06-05 17:31:59,300 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/2e9e80b8-3c51-43ec-bd19-0726da0bc365
2026-06-05 17:31:59,306 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/b06c44d3-c55c-4d7a-8130-82856a6c8dec
2026-06-05 17:31:59,317 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-61626230:ctest-right_vn-61691533', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-61626230', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4084379672675176321', 'uuid-lslong': '9975136553269391199'}, 'enable': 'true', 'created': '2026-06-05T17:31:58', 'last-modified': '2026-06-05T17:31:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.395872'}
2026-06-05 17:31:59,323 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-05 17:31:59,328 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-61626230:ctest-right_vn-61691533', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-61626230', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4084379672675176321', 'uuid-lslong': '9975136553269391199'}, 'enable': 'true', 'created': '2026-06-05T17:31:58', 'last-modified': '2026-06-05T17:31:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.410052'}
2026-06-05 17:31:59,333 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-05 17:31:59,339 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-61626230:ctest-right_vn-61691533', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-61626230', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4084379672675176321', 'uuid-lslong': '9975136553269391199'}, 'enable': 'true', 'created': '2026-06-05T17:31:58', 'last-modified': '2026-06-05T17:31:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.423385'}
2026-06-05 17:31:59,346 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-05 17:31:59,346 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-61691533 passed
2026-06-05 17:31:59,346 - DEBUG - ====Verifying policy data for ctest-right_vn-61691533 in API_Server ======
2026-06-05 17:31:59,346 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:31:59,352 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:31:59,362 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d19760c-3c70-4c07-be71-3d1afc0ad892
2026-06-05 17:31:59,468 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/38aea1ac-1da1-4f81-8a6e-cdd83ba2ef5f
2026-06-05 17:31:59,485 - DEBUG - =>VN ctest-right_vn-61691533 has no policy to be verified
2026-06-05 17:31:59,485 - DEBUG - Verifying the vn in opserver
2026-06-05 17:31:59,485 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-61626230:ctest-right_vn-61691533 virtual network link through opserver 10.0.0.33
2026-06-05 17:31:59,485 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-06-05 17:31:59,500 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-61626230:ctest-right_vn-61691533', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-61626230:ctest-right_vn-61691533?flat'}
2026-06-05 17:31:59,500 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-61626230:ctest-right_vn-61691533 virtual network link through opserver 10.0.0.130
2026-06-05 17:31:59,500 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-06-05 17:31:59,513 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-61626230:ctest-right_vn-61691533', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-61626230:ctest-right_vn-61691533?flat'}
2026-06-05 17:31:59,513 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-61626230:ctest-right_vn-61691533 virtual network link through opserver 10.0.0.38
2026-06-05 17:31:59,514 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-06-05 17:31:59,526 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-61626230:ctest-right_vn-61691533', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-61626230:ctest-right_vn-61691533?flat'}
2026-06-05 17:31:59,526 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-61626230:ctest-right_vn-61691533 is found in opserver
2026-06-05 17:31:59,549 - DEBUG - Do not have enough data to verify VN in agent
2026-06-05 17:31:59,559 - DEBUG - VRF ids for VN ctest-right_vn-61691533: {}
2026-06-05 17:31:59,852 - DEBUG - Response for create_network : {'network': {'id': '12d26fe8-80cc-400d-b86f-674545be1d8b', 'name': 'ctest-trans_left_vn-31886622', 'tenant_id': '1d19760c3c704c07be713d1afc0ad892', 'project_id': '1d19760c3c704c07be713d1afc0ad892', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-61626230', 'ctest-trans_left_vn-31886622'], 'port_security_enabled': True, 'description': ''}}
2026-06-05 17:32:00,120 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f9020f34-82ff-47f5-971a-6c2529cd08c2', 'name': '', 'tenant_id': '1d19760c3c704c07be713d1afc0ad892', 'network_id': '12d26fe8-80cc-400d-b86f-674545be1d8b', 'ip_version': 4, 'cidr': '88.62.239.192/26', 'allocation_pools': [{'start': '88.62.239.194', 'end': '88.62.239.254'}], 'gateway_ip': '88.62.239.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '88.62.239.194', 'tags': [], 'project_id': '1d19760c3c704c07be713d1afc0ad892'}}
2026-06-05 17:32:00,153 - INFO - Created VN ctest-trans_left_vn-31886622
2026-06-05 17:32:00,165 - DEBUG - VN ctest-trans_left_vn-31886622 UUID is 12d26fe8-80cc-400d-b86f-674545be1d8b
2026-06-05 17:32:00,246 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:00,252 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:00,263 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d19760c-3c70-4c07-be71-3d1afc0ad892
2026-06-05 17:32:00,357 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/12d26fe8-80cc-400d-b86f-674545be1d8b
2026-06-05 17:32:00,373 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/12d26fe8-80cc-400d-b86f-674545be1d8b
2026-06-05 17:32:00,384 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/28bec7c9-35d2-4055-b591-64a421e70012
2026-06-05 17:32:00,393 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/28bec7c9-35d2-4055-b591-64a421e70012
2026-06-05 17:32:00,400 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/378b35ae-f53b-4881-804b-8ef17a7aa4e5
2026-06-05 17:32:00,407 - DEBUG - Route Targets: ['target:64512:8000007']
2026-06-05 17:32:00,407 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/12d26fe8-80cc-400d-b86f-674545be1d8b
2026-06-05 17:32:00,419 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/28bec7c9-35d2-4055-b591-64a421e70012
2026-06-05 17:32:00,436 - INFO - Verified VN network id 17 for VN 12d26fe8-80cc-400d-b86f-674545be1d8b
2026-06-05 17:32:00,436 - INFO - Verifications in API Server for VN ctest-trans_left_vn-31886622 passed
2026-06-05 17:32:00,437 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/12d26fe8-80cc-400d-b86f-674545be1d8b
2026-06-05 17:32:00,449 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/28bec7c9-35d2-4055-b591-64a421e70012
2026-06-05 17:32:00,458 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/28bec7c9-35d2-4055-b591-64a421e70012
2026-06-05 17:32:00,466 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/378b35ae-f53b-4881-804b-8ef17a7aa4e5
2026-06-05 17:32:00,482 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-61626230:ctest-trans_left_vn-31886622', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-61626230', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1356269482175905805', 'uuid-lslong': '13289954572614114699'}, 'enable': 'true', 'created': '2026-06-05T17:31:59', 'last-modified': '2026-06-05T17:32:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.419170'}
2026-06-05 17:32:00,488 - DEBUG - Route Targets: ['target:64512:8000007']
2026-06-05 17:32:00,495 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-61626230:ctest-trans_left_vn-31886622', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-61626230', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1356269482175905805', 'uuid-lslong': '13289954572614114699'}, 'enable': 'true', 'created': '2026-06-05T17:31:59', 'last-modified': '2026-06-05T17:32:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.431564'}
2026-06-05 17:32:00,508 - DEBUG - Route Targets: ['target:64512:8000007']
2026-06-05 17:32:00,515 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-61626230:ctest-trans_left_vn-31886622', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-61626230', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1356269482175905805', 'uuid-lslong': '13289954572614114699'}, 'enable': 'true', 'created': '2026-06-05T17:31:59', 'last-modified': '2026-06-05T17:32:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.453246'}
2026-06-05 17:32:00,521 - DEBUG - Route Targets: ['target:64512:8000007']
2026-06-05 17:32:00,522 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-31886622 passed
2026-06-05 17:32:00,522 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-31886622 in API_Server ======
2026-06-05 17:32:00,522 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:00,529 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:00,542 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d19760c-3c70-4c07-be71-3d1afc0ad892
2026-06-05 17:32:00,647 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/12d26fe8-80cc-400d-b86f-674545be1d8b
2026-06-05 17:32:00,667 - DEBUG - =>VN ctest-trans_left_vn-31886622 has no policy to be verified
2026-06-05 17:32:00,667 - DEBUG - Verifying the vn in opserver
2026-06-05 17:32:00,668 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-61626230:ctest-trans_left_vn-31886622 virtual network link through opserver 10.0.0.33
2026-06-05 17:32:00,668 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-06-05 17:32:00,684 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-61626230:ctest-trans_left_vn-31886622', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-61626230:ctest-trans_left_vn-31886622?flat'}
2026-06-05 17:32:00,684 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-61626230:ctest-trans_left_vn-31886622 virtual network link through opserver 10.0.0.130
2026-06-05 17:32:00,684 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-06-05 17:32:00,699 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-61626230:ctest-trans_left_vn-31886622', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-61626230:ctest-trans_left_vn-31886622?flat'}
2026-06-05 17:32:00,699 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-61626230:ctest-trans_left_vn-31886622 virtual network link through opserver 10.0.0.38
2026-06-05 17:32:00,699 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-06-05 17:32:00,713 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-61626230:ctest-trans_left_vn-31886622', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-61626230:ctest-trans_left_vn-31886622?flat'}
2026-06-05 17:32:00,713 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-61626230:ctest-trans_left_vn-31886622 is found in opserver
2026-06-05 17:32:00,742 - DEBUG - Do not have enough data to verify VN in agent
2026-06-05 17:32:00,754 - DEBUG - VRF ids for VN ctest-trans_left_vn-31886622: {}
2026-06-05 17:32:01,093 - DEBUG - Response for create_network : {'network': {'id': '4b745ffd-ba92-41b7-bba0-2aeddbe8527f', 'name': 'ctest-trans_right_vn-89845959', 'tenant_id': '1d19760c3c704c07be713d1afc0ad892', 'project_id': '1d19760c3c704c07be713d1afc0ad892', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-61626230', 'ctest-trans_right_vn-89845959'], 'port_security_enabled': True, 'description': ''}}
2026-06-05 17:32:01,378 - DEBUG - Response for create_subnet : {'subnet': {'id': 'efa86ea8-3955-493a-a4f8-8b8144231597', 'name': '', 'tenant_id': '1d19760c3c704c07be713d1afc0ad892', 'network_id': '4b745ffd-ba92-41b7-bba0-2aeddbe8527f', 'ip_version': 4, 'cidr': '142.143.110.0/26', 'allocation_pools': [{'start': '142.143.110.2', 'end': '142.143.110.62'}], 'gateway_ip': '142.143.110.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '142.143.110.2', 'tags': [], 'project_id': '1d19760c3c704c07be713d1afc0ad892'}}
2026-06-05 17:32:01,403 - INFO - Created VN ctest-trans_right_vn-89845959
2026-06-05 17:32:01,424 - DEBUG - VN ctest-trans_right_vn-89845959 UUID is 4b745ffd-ba92-41b7-bba0-2aeddbe8527f
2026-06-05 17:32:01,503 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:01,513 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:01,525 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d19760c-3c70-4c07-be71-3d1afc0ad892
2026-06-05 17:32:01,647 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/4b745ffd-ba92-41b7-bba0-2aeddbe8527f
2026-06-05 17:32:01,662 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/4b745ffd-ba92-41b7-bba0-2aeddbe8527f
2026-06-05 17:32:01,673 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/3e1f93cb-e51f-47e5-8edc-a1a74c2ef5a4
2026-06-05 17:32:01,681 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/3e1f93cb-e51f-47e5-8edc-a1a74c2ef5a4
2026-06-05 17:32:01,691 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/f5c1a150-5add-49e9-aa7a-7cdb59c8588a
2026-06-05 17:32:01,699 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-05 17:32:01,699 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/4b745ffd-ba92-41b7-bba0-2aeddbe8527f
2026-06-05 17:32:01,712 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/3e1f93cb-e51f-47e5-8edc-a1a74c2ef5a4
2026-06-05 17:32:01,737 - INFO - Verified VN network id 18 for VN 4b745ffd-ba92-41b7-bba0-2aeddbe8527f
2026-06-05 17:32:01,737 - INFO - Verifications in API Server for VN ctest-trans_right_vn-89845959 passed
2026-06-05 17:32:01,737 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/4b745ffd-ba92-41b7-bba0-2aeddbe8527f
2026-06-05 17:32:01,749 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/3e1f93cb-e51f-47e5-8edc-a1a74c2ef5a4
2026-06-05 17:32:01,759 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/3e1f93cb-e51f-47e5-8edc-a1a74c2ef5a4
2026-06-05 17:32:01,771 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/f5c1a150-5add-49e9-aa7a-7cdb59c8588a
2026-06-05 17:32:01,788 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-61626230:ctest-trans_right_vn-89845959', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-61626230', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5437076193504543159', 'uuid-lslong': '13519853282451280511'}, 'enable': 'true', 'created': '2026-06-05T17:32:01', 'last-modified': '2026-06-05T17:32:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.485937'}
2026-06-05 17:32:01,794 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-05 17:32:01,800 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-61626230:ctest-trans_right_vn-89845959', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-61626230', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5437076193504543159', 'uuid-lslong': '13519853282451280511'}, 'enable': 'true', 'created': '2026-06-05T17:32:01', 'last-modified': '2026-06-05T17:32:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.497766'}
2026-06-05 17:32:01,807 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-05 17:32:01,814 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-61626230:ctest-trans_right_vn-89845959', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-61626230', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5437076193504543159', 'uuid-lslong': '13519853282451280511'}, 'enable': 'true', 'created': '2026-06-05T17:32:01', 'last-modified': '2026-06-05T17:32:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.511233'}
2026-06-05 17:32:01,822 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-05 17:32:01,823 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-89845959 passed
2026-06-05 17:32:01,823 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-89845959 in API_Server ======
2026-06-05 17:32:01,823 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:01,830 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:01,845 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d19760c-3c70-4c07-be71-3d1afc0ad892
2026-06-05 17:32:01,959 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/4b745ffd-ba92-41b7-bba0-2aeddbe8527f
2026-06-05 17:32:01,970 - DEBUG - =>VN ctest-trans_right_vn-89845959 has no policy to be verified
2026-06-05 17:32:01,970 - DEBUG - Verifying the vn in opserver
2026-06-05 17:32:01,970 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-61626230:ctest-trans_right_vn-89845959 virtual network link through opserver 10.0.0.33
2026-06-05 17:32:01,970 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-06-05 17:32:01,983 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-61626230:ctest-trans_right_vn-89845959', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-61626230:ctest-trans_right_vn-89845959?flat'}
2026-06-05 17:32:01,983 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-61626230:ctest-trans_right_vn-89845959 virtual network link through opserver 10.0.0.130
2026-06-05 17:32:01,983 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-06-05 17:32:01,999 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-61626230:ctest-trans_right_vn-89845959', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-61626230:ctest-trans_right_vn-89845959?flat'}
2026-06-05 17:32:01,999 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-61626230:ctest-trans_right_vn-89845959 virtual network link through opserver 10.0.0.38
2026-06-05 17:32:01,999 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-06-05 17:32:02,014 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-61626230:ctest-trans_right_vn-89845959', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-61626230:ctest-trans_right_vn-89845959?flat'}
2026-06-05 17:32:02,014 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-61626230:ctest-trans_right_vn-89845959 is found in opserver
2026-06-05 17:32:02,040 - DEBUG - Do not have enough data to verify VN in agent
2026-06-05 17:32:02,055 - DEBUG - VRF ids for VN ctest-trans_right_vn-89845959: {}
2026-06-05 17:32:03,350 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5896-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5896-1)
2026-06-05 17:32:04,978 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5896-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5896-2)
2026-06-05 17:32:04,979 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-50474532']
2026-06-05 17:32:05,281 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-50474532'] created succesfully
2026-06-05 17:32:05,739 - DEBUG - Image by name tiny_trans_fw not found
2026-06-05 17:32:05,739 - DEBUG - Installing image tiny_trans_fw
2026-06-05 17:32:05,739 - DEBUG - Image info {'name': 'tinycore-net-transparent-fw.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd'}
2026-06-05 17:32:05,740 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-06-05 17:32:05,740 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-06-05 17:32:05,761 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz -O /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-06-05 17:32:05,795 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-06-05 17:32:05,795 - DEBUG - Unzip image
2026-06-05 17:32:05,795 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-06-05 17:32:05,835 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-06-05 17:32:05,836 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-50474532']
2026-06-05 17:32:05,947 - INFO - Service template: ['default-domain', 'ctest-service_template_1-50474532'] deleted successfully.
2026-06-05 17:32:05,947 - INFO - Skip interface_detach for VM ctest-right_vm-59488767 in state BUILD
2026-06-05 17:32:05,947 - INFO - Deleting VM ctest-right_vm-59488767
2026-06-05 17:32:05,947 - ERROR - VM ctest-right_vm-59488767 has failed to come up
2026-06-05 17:32:05,947 - ERROR - Nova failed to get host of the VM
2026-06-05 17:32:05,947 - ERROR - VM ctest-right_vm-59488767 has failed to come up
2026-06-05 17:32:05,947 - ERROR - Nova failed to get host of the VM
2026-06-05 17:32:06,035 - INFO - Skip interface_detach for VM ctest-left_vm-96279791 in state BUILD
2026-06-05 17:32:06,035 - INFO - Deleting VM ctest-left_vm-96279791
2026-06-05 17:32:06,035 - ERROR - VM ctest-left_vm-96279791 has failed to come up
2026-06-05 17:32:06,036 - ERROR - Nova failed to get host of the VM
2026-06-05 17:32:06,036 - ERROR - VM ctest-left_vm-96279791 has failed to come up
2026-06-05 17:32:06,036 - ERROR - Nova failed to get host of the VM
2026-06-05 17:32:06,125 - INFO - Deleting VN ctest-trans_right_vn-89845959
2026-06-05 17:32:06,288 - DEBUG - Response for deleting network ()
2026-06-05 17:32:06,289 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/3e1f93cb-e51f-47e5-8edc-a1a74c2ef5a4
2026-06-05 17:32:06,294 - DEBUG - Response Code: 404
2026-06-05 17:32:06,294 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:06,305 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:06,326 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d19760c-3c70-4c07-be71-3d1afc0ad892
2026-06-05 17:32:06,433 - INFO - Validated that VN ctest-trans_right_vn-89845959 is not found in API Server
2026-06-05 17:32:06,444 - DEBUG - VN ctest-trans_right_vn-89845959 is not present in Agent 10.0.0.27
2026-06-05 17:32:06,462 - DEBUG - VN ctest-trans_right_vn-89845959 is not present in Agent 10.0.0.19
2026-06-05 17:32:06,462 - INFO - Validated that VN ctest-trans_right_vn-89845959 is not in any agent
2026-06-05 17:32:06,500 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-89845959 info
2026-06-05 17:32:06,501 - INFO - Deleting VN ctest-trans_left_vn-31886622
2026-06-05 17:32:06,657 - DEBUG - Response for deleting network ()
2026-06-05 17:32:06,657 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/28bec7c9-35d2-4055-b591-64a421e70012
2026-06-05 17:32:06,664 - DEBUG - Response Code: 404
2026-06-05 17:32:06,664 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:06,670 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:06,692 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d19760c-3c70-4c07-be71-3d1afc0ad892
2026-06-05 17:32:06,790 - INFO - Validated that VN ctest-trans_left_vn-31886622 is not found in API Server
2026-06-05 17:32:06,805 - DEBUG - VN ctest-trans_left_vn-31886622 is not present in Agent 10.0.0.27
2026-06-05 17:32:06,829 - DEBUG - VN ctest-trans_left_vn-31886622 is not present in Agent 10.0.0.19
2026-06-05 17:32:06,829 - INFO - Validated that VN ctest-trans_left_vn-31886622 is not in any agent
2026-06-05 17:32:06,884 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-31886622 info
2026-06-05 17:32:06,885 - INFO - Deleting VN ctest-right_vn-61691533
2026-06-05 17:32:06,946 - DEBUG - VN 38aea1ac-1da1-4f81-8a6e-cdd83ba2ef5f still in use: Unable to complete operation on network 38aea1ac-1da1-4f81-8a6e-cdd83ba2ef5f. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-4ebd3fb1-f2e8-4bc6-bc01-8d769b7ecbdb']
2026-06-05 17:32:06,946 - WARNING - Deleting VN ctest-right_vn-61691533 failed..Will retry
2026-06-05 17:32:09,121 - DEBUG - Response for deleting network ()
2026-06-05 17:32:09,121 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/2e9e80b8-3c51-43ec-bd19-0726da0bc365
2026-06-05 17:32:09,130 - DEBUG - Response Code: 404
2026-06-05 17:32:09,130 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:09,138 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:09,196 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d19760c-3c70-4c07-be71-3d1afc0ad892
2026-06-05 17:32:09,306 - INFO - Validated that VN ctest-right_vn-61691533 is not found in API Server
2026-06-05 17:32:09,316 - DEBUG - VN ctest-right_vn-61691533 is not present in Agent 10.0.0.27
2026-06-05 17:32:09,327 - DEBUG - VN ctest-right_vn-61691533 is not present in Agent 10.0.0.19
2026-06-05 17:32:09,327 - INFO - Validated that VN ctest-right_vn-61691533 is not in any agent
2026-06-05 17:32:09,359 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-61691533 info
2026-06-05 17:32:09,359 - INFO - Deleting VN ctest-left_vn-52525535
2026-06-05 17:32:09,532 - DEBUG - Response for deleting network ()
2026-06-05 17:32:09,532 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/820b3aa9-c72a-4e05-9cb6-76448d6d2098
2026-06-05 17:32:09,544 - DEBUG - Response Code: 404
2026-06-05 17:32:09,545 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:09,555 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:09,568 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d19760c-3c70-4c07-be71-3d1afc0ad892
2026-06-05 17:32:09,667 - INFO - Validated that VN ctest-left_vn-52525535 is not found in API Server
2026-06-05 17:32:09,678 - DEBUG - VN ctest-left_vn-52525535 is not present in Agent 10.0.0.27
2026-06-05 17:32:09,692 - DEBUG - VN ctest-left_vn-52525535 is not present in Agent 10.0.0.19
2026-06-05 17:32:09,692 - INFO - Validated that VN ctest-left_vn-52525535 is not in any agent
2026-06-05 17:32:09,723 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-52525535 info
2026-06-05 17:32:09,723 - INFO - Deleting VN ctest-mgmt_vn-67431508
2026-06-05 17:32:09,908 - DEBUG - Response for deleting network ()
2026-06-05 17:32:09,908 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/9ef0c679-9894-4440-b1a2-6bffd184ab32
2026-06-05 17:32:09,920 - DEBUG - Response Code: 404
2026-06-05 17:32:09,920 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:09,927 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:09,941 - DEBUG - Requesting: http://10.0.0.33:8082/project/1d19760c-3c70-4c07-be71-3d1afc0ad892
2026-06-05 17:32:10,042 - INFO - Validated that VN ctest-mgmt_vn-67431508 is not found in API Server
2026-06-05 17:32:10,056 - DEBUG - VN ctest-mgmt_vn-67431508 is not present in Agent 10.0.0.27
2026-06-05 17:32:10,069 - DEBUG - VN ctest-mgmt_vn-67431508 is not present in Agent 10.0.0.19
2026-06-05 17:32:10,069 - INFO - Validated that VN ctest-mgmt_vn-67431508 is not in any agent
2026-06-05 17:32:10,100 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-67431508 info
2026-06-05 17:32:11,370 - DEBUG - No XMPP flaps were noticed during the test
2026-06-05 17:32:11,371 - INFO -
2026-06-05 17:32:11,371 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:16]
2026-06-05 17:32:11,371 - INFO - --------------------------------------------------------------------------------
2026-06-05 17:32:12,127 - INFO - Deleted project: ctest-TestSvcRegr-61626230, ID : 1d19760c-3c70-4c07-be71-3d1afc0ad892
2026-06-05 17:32:12,303 - INFO - Domain Default found not creating
2026-06-05 17:32:12,473 - INFO - Project ctest-TestSvcRegr-34832290 not found, creating it
2026-06-05 17:32:13,031 - INFO - Created Project:ctest-TestSvcRegr-34832290, ID : a7ef9768-ef1c-4f7f-964a-cf17dd17a203
2026-06-05 17:32:14,665 - INFO - ================================================================================
2026-06-05 17:32:14,665 - INFO - STARTING TEST : test_svc_CEM_22032
2026-06-05 17:32:15,946 - DEBUG - Nothing to compare xmpp stats {'10.0.0.27': {'10.20.0.14': '0', '10.20.0.129': '0'}, '10.0.0.19': {'10.20.0.18': '0', '10.20.0.14': '0'}} with
2026-06-05 17:32:15,946 - INFO - Initial checks done. Running the testcase now
2026-06-05 17:32:15,946 - INFO -
2026-06-05 17:32:17,150 - DEBUG - Response for create_network : {'network': {'id': '5b10fa30-93c5-453f-8d93-24bd573e8b25', 'name': 'ctest-mgmt_vn-64830239', 'tenant_id': 'a7ef9768ef1c4f7f964acf17dd17a203', 'project_id': 'a7ef9768ef1c4f7f964acf17dd17a203', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-34832290', 'ctest-mgmt_vn-64830239'], 'port_security_enabled': True, 'description': ''}}
2026-06-05 17:32:17,430 - DEBUG - Response for create_subnet : {'subnet': {'id': '8b14102a-0dba-436c-b1dc-8c5f7815205a', 'name': '', 'tenant_id': 'a7ef9768ef1c4f7f964acf17dd17a203', 'network_id': '5b10fa30-93c5-453f-8d93-24bd573e8b25', 'ip_version': 4, 'cidr': '125.189.159.192/26', 'allocation_pools': [{'start': '125.189.159.194', 'end': '125.189.159.254'}], 'gateway_ip': '125.189.159.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '125.189.159.194', 'tags': [], 'project_id': 'a7ef9768ef1c4f7f964acf17dd17a203'}}
2026-06-05 17:32:17,452 - INFO - Created VN ctest-mgmt_vn-64830239
2026-06-05 17:32:17,464 - DEBUG - VN ctest-mgmt_vn-64830239 UUID is 5b10fa30-93c5-453f-8d93-24bd573e8b25
2026-06-05 17:32:17,532 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:17,881 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:17,919 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:17,933 - DEBUG - Requesting: http://10.0.0.33:8082/project/a7ef9768-ef1c-4f7f-964a-cf17dd17a203
2026-06-05 17:32:18,041 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/5b10fa30-93c5-453f-8d93-24bd573e8b25
2026-06-05 17:32:18,054 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/5b10fa30-93c5-453f-8d93-24bd573e8b25
2026-06-05 17:32:18,064 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/1e29004f-880b-40a1-a3cb-a4f027e6acc6
2026-06-05 17:32:18,074 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/1e29004f-880b-40a1-a3cb-a4f027e6acc6
2026-06-05 17:32:18,081 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/afe30386-ef9d-4851-8984-14b45193fb39
2026-06-05 17:32:18,087 - DEBUG - Route Targets: ['target:64512:8000004']
2026-06-05 17:32:18,088 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/5b10fa30-93c5-453f-8d93-24bd573e8b25
2026-06-05 17:32:18,097 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/1e29004f-880b-40a1-a3cb-a4f027e6acc6
2026-06-05 17:32:18,110 - INFO - Verified VN network id 14 for VN 5b10fa30-93c5-453f-8d93-24bd573e8b25
2026-06-05 17:32:18,111 - INFO - Verifications in API Server for VN ctest-mgmt_vn-64830239 passed
2026-06-05 17:32:18,111 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/5b10fa30-93c5-453f-8d93-24bd573e8b25
2026-06-05 17:32:18,121 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/1e29004f-880b-40a1-a3cb-a4f027e6acc6
2026-06-05 17:32:18,129 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/1e29004f-880b-40a1-a3cb-a4f027e6acc6
2026-06-05 17:32:18,137 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/afe30386-ef9d-4851-8984-14b45193fb39
2026-06-05 17:32:18,149 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-64830239', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34832290', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6562019743623365951', 'uuid-lslong': '10201537976555440933'}, 'enable': 'true', 'created': '2026-06-05T17:32:17', 'last-modified': '2026-06-05T17:32:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.770832'}
2026-06-05 17:32:18,154 - DEBUG - Route Targets: ['target:64512:8000004']
2026-06-05 17:32:18,160 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-64830239', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34832290', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6562019743623365951', 'uuid-lslong': '10201537976555440933'}, 'enable': 'true', 'created': '2026-06-05T17:32:17', 'last-modified': '2026-06-05T17:32:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.782031'}
2026-06-05 17:32:18,166 - DEBUG - Route Targets: ['target:64512:8000004']
2026-06-05 17:32:18,171 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-64830239', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34832290', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6562019743623365951', 'uuid-lslong': '10201537976555440933'}, 'enable': 'true', 'created': '2026-06-05T17:32:17', 'last-modified': '2026-06-05T17:32:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.783060'}
2026-06-05 17:32:18,176 - DEBUG - Route Targets: ['target:64512:8000004']
2026-06-05 17:32:18,176 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-64830239 passed
2026-06-05 17:32:18,176 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-64830239 in API_Server ======
2026-06-05 17:32:18,176 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:18,183 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:18,196 - DEBUG - Requesting: http://10.0.0.33:8082/project/a7ef9768-ef1c-4f7f-964a-cf17dd17a203
2026-06-05 17:32:18,293 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/5b10fa30-93c5-453f-8d93-24bd573e8b25
2026-06-05 17:32:18,308 - DEBUG - =>VN ctest-mgmt_vn-64830239 has no policy to be verified
2026-06-05 17:32:18,308 - DEBUG - Verifying the vn in opserver
2026-06-05 17:32:18,308 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-64830239 virtual network link through opserver 10.0.0.33
2026-06-05 17:32:18,308 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-06-05 17:32:18,653 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-06-05 17:32:18,719 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-64830239', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-64830239?flat'}
2026-06-05 17:32:18,719 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-64830239 virtual network link through opserver 10.0.0.130
2026-06-05 17:32:18,719 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-06-05 17:32:19,051 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-06-05 17:32:19,109 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-64830239', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-64830239?flat'}
2026-06-05 17:32:19,109 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-64830239 virtual network link through opserver 10.0.0.38
2026-06-05 17:32:19,110 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-06-05 17:32:19,443 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-06-05 17:32:19,503 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-64830239', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-64830239?flat'}
2026-06-05 17:32:19,503 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-64830239 is found in opserver
2026-06-05 17:32:19,524 - DEBUG - Do not have enough data to verify VN in agent
2026-06-05 17:32:19,536 - DEBUG - VRF ids for VN ctest-mgmt_vn-64830239: {}
2026-06-05 17:32:19,792 - DEBUG - Response for create_network : {'network': {'id': '3a598148-a89c-4548-bd9a-ebb6f43ae712', 'name': 'service-left-vn-26243470', 'tenant_id': 'a7ef9768ef1c4f7f964acf17dd17a203', 'project_id': 'a7ef9768ef1c4f7f964acf17dd17a203', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-34832290', 'service-left-vn-26243470'], 'port_security_enabled': True, 'description': ''}}
2026-06-05 17:32:19,996 - DEBUG - Response for create_subnet : {'subnet': {'id': 'cf95573e-3c4e-441c-a132-6e625e693282', 'name': '', 'tenant_id': 'a7ef9768ef1c4f7f964acf17dd17a203', 'network_id': '3a598148-a89c-4548-bd9a-ebb6f43ae712', 'ip_version': 4, 'cidr': '58.196.234.0/26', 'allocation_pools': [{'start': '58.196.234.2', 'end': '58.196.234.62'}], 'gateway_ip': '58.196.234.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '58.196.234.2', 'tags': [], 'project_id': 'a7ef9768ef1c4f7f964acf17dd17a203'}}
2026-06-05 17:32:20,023 - INFO - Created VN service-left-vn-26243470
2026-06-05 17:32:20,035 - DEBUG - VN service-left-vn-26243470 UUID is 3a598148-a89c-4548-bd9a-ebb6f43ae712
2026-06-05 17:32:20,104 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:20,110 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:20,120 - DEBUG - Requesting: http://10.0.0.33:8082/project/a7ef9768-ef1c-4f7f-964a-cf17dd17a203
2026-06-05 17:32:20,221 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/3a598148-a89c-4548-bd9a-ebb6f43ae712
2026-06-05 17:32:20,233 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/3a598148-a89c-4548-bd9a-ebb6f43ae712
2026-06-05 17:32:20,243 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/5b6c51b4-e532-4656-9ff9-86ce03a138d7
2026-06-05 17:32:20,255 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/5b6c51b4-e532-4656-9ff9-86ce03a138d7
2026-06-05 17:32:20,264 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/956971ff-8c51-4b2b-9d66-47b91fb37b86
2026-06-05 17:32:20,274 - DEBUG - Route Targets: ['target:64512:8000005']
2026-06-05 17:32:20,274 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/3a598148-a89c-4548-bd9a-ebb6f43ae712
2026-06-05 17:32:20,284 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/5b6c51b4-e532-4656-9ff9-86ce03a138d7
2026-06-05 17:32:20,300 - INFO - Verified VN network id 15 for VN 3a598148-a89c-4548-bd9a-ebb6f43ae712
2026-06-05 17:32:20,300 - INFO - Verifications in API Server for VN service-left-vn-26243470 passed
2026-06-05 17:32:20,300 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/3a598148-a89c-4548-bd9a-ebb6f43ae712
2026-06-05 17:32:20,309 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/5b6c51b4-e532-4656-9ff9-86ce03a138d7
2026-06-05 17:32:20,316 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/5b6c51b4-e532-4656-9ff9-86ce03a138d7
2026-06-05 17:32:20,323 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/956971ff-8c51-4b2b-9d66-47b91fb37b86
2026-06-05 17:32:20,333 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34832290:service-left-vn-26243470', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34832290', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4204533876193510728', 'uuid-lslong': '13662491590595897106'}, 'enable': 'true', 'created': '2026-06-05T17:32:19', 'last-modified': '2026-06-05T17:32:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.383664'}
2026-06-05 17:32:20,339 - DEBUG - Route Targets: ['target:64512:8000005']
2026-06-05 17:32:20,345 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34832290:service-left-vn-26243470', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34832290', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4204533876193510728', 'uuid-lslong': '13662491590595897106'}, 'enable': 'true', 'created': '2026-06-05T17:32:19', 'last-modified': '2026-06-05T17:32:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.410089'}
2026-06-05 17:32:20,352 - DEBUG - Route Targets: ['target:64512:8000005']
2026-06-05 17:32:20,358 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34832290:service-left-vn-26243470', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34832290', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4204533876193510728', 'uuid-lslong': '13662491590595897106'}, 'enable': 'true', 'created': '2026-06-05T17:32:19', 'last-modified': '2026-06-05T17:32:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.422052'}
2026-06-05 17:32:20,365 - DEBUG - Route Targets: ['target:64512:8000005']
2026-06-05 17:32:20,365 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-26243470 passed
2026-06-05 17:32:20,365 - DEBUG - ====Verifying policy data for service-left-vn-26243470 in API_Server ======
2026-06-05 17:32:20,366 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:20,373 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:20,385 - DEBUG - Requesting: http://10.0.0.33:8082/project/a7ef9768-ef1c-4f7f-964a-cf17dd17a203
2026-06-05 17:32:20,484 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/3a598148-a89c-4548-bd9a-ebb6f43ae712
2026-06-05 17:32:20,493 - DEBUG - =>VN service-left-vn-26243470 has no policy to be verified
2026-06-05 17:32:20,493 - DEBUG - Verifying the vn in opserver
2026-06-05 17:32:20,494 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34832290:service-left-vn-26243470 virtual network link through opserver 10.0.0.33
2026-06-05 17:32:20,494 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-06-05 17:32:20,555 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34832290:service-left-vn-26243470', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34832290:service-left-vn-26243470?flat'}
2026-06-05 17:32:20,555 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34832290:service-left-vn-26243470 virtual network link through opserver 10.0.0.130
2026-06-05 17:32:20,555 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-06-05 17:32:20,615 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34832290:service-left-vn-26243470', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34832290:service-left-vn-26243470?flat'}
2026-06-05 17:32:20,615 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34832290:service-left-vn-26243470 virtual network link through opserver 10.0.0.38
2026-06-05 17:32:20,615 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-06-05 17:32:20,676 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34832290:service-left-vn-26243470', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34832290:service-left-vn-26243470?flat'}
2026-06-05 17:32:20,676 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-34832290:service-left-vn-26243470 is found in opserver
2026-06-05 17:32:20,699 - DEBUG - Do not have enough data to verify VN in agent
2026-06-05 17:32:20,708 - DEBUG - VRF ids for VN service-left-vn-26243470: {}
2026-06-05 17:32:20,980 - DEBUG - Response for create_network : {'network': {'id': '0cb0c613-ecf3-413a-8643-562801195659', 'name': 'service-right-vn-17343158', 'tenant_id': 'a7ef9768ef1c4f7f964acf17dd17a203', 'project_id': 'a7ef9768ef1c4f7f964acf17dd17a203', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-34832290', 'service-right-vn-17343158'], 'port_security_enabled': True, 'description': ''}}
2026-06-05 17:32:21,242 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c2d77c43-5ab3-464f-9869-34f9a4346c5a', 'name': '', 'tenant_id': 'a7ef9768ef1c4f7f964acf17dd17a203', 'network_id': '0cb0c613-ecf3-413a-8643-562801195659', 'ip_version': 4, 'cidr': '15.130.121.0/26', 'allocation_pools': [{'start': '15.130.121.2', 'end': '15.130.121.62'}], 'gateway_ip': '15.130.121.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '15.130.121.2', 'tags': [], 'project_id': 'a7ef9768ef1c4f7f964acf17dd17a203'}}
2026-06-05 17:32:21,269 - INFO - Created VN service-right-vn-17343158
2026-06-05 17:32:21,283 - DEBUG - VN service-right-vn-17343158 UUID is 0cb0c613-ecf3-413a-8643-562801195659
2026-06-05 17:32:21,430 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:21,436 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:21,447 - DEBUG - Requesting: http://10.0.0.33:8082/project/a7ef9768-ef1c-4f7f-964a-cf17dd17a203
2026-06-05 17:32:21,538 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/0cb0c613-ecf3-413a-8643-562801195659
2026-06-05 17:32:21,551 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/0cb0c613-ecf3-413a-8643-562801195659
2026-06-05 17:32:21,561 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/445e8854-ad1c-492d-8a3e-4f3febe40273
2026-06-05 17:32:21,568 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/445e8854-ad1c-492d-8a3e-4f3febe40273
2026-06-05 17:32:21,576 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/0c056a16-93ab-430b-b066-60d874ae59c7
2026-06-05 17:32:21,583 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-05 17:32:21,583 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/0cb0c613-ecf3-413a-8643-562801195659
2026-06-05 17:32:21,593 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/445e8854-ad1c-492d-8a3e-4f3febe40273
2026-06-05 17:32:21,608 - INFO - Verified VN network id 16 for VN 0cb0c613-ecf3-413a-8643-562801195659
2026-06-05 17:32:21,608 - INFO - Verifications in API Server for VN service-right-vn-17343158 passed
2026-06-05 17:32:21,608 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/0cb0c613-ecf3-413a-8643-562801195659
2026-06-05 17:32:21,617 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/445e8854-ad1c-492d-8a3e-4f3febe40273
2026-06-05 17:32:21,623 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/445e8854-ad1c-492d-8a3e-4f3febe40273
2026-06-05 17:32:21,632 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/0c056a16-93ab-430b-b066-60d874ae59c7
2026-06-05 17:32:21,643 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34832290:service-right-vn-17343158', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34832290', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '914448513238253882', 'uuid-lslong': '9674671154339075673'}, 'enable': 'true', 'created': '2026-06-05T17:32:20', 'last-modified': '2026-06-05T17:32:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.448250'}
2026-06-05 17:32:21,648 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-05 17:32:21,654 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34832290:service-right-vn-17343158', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34832290', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '914448513238253882', 'uuid-lslong': '9674671154339075673'}, 'enable': 'true', 'created': '2026-06-05T17:32:20', 'last-modified': '2026-06-05T17:32:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.455004'}
2026-06-05 17:32:21,660 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-05 17:32:21,666 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34832290:service-right-vn-17343158', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34832290', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '914448513238253882', 'uuid-lslong': '9674671154339075673'}, 'enable': 'true', 'created': '2026-06-05T17:32:20', 'last-modified': '2026-06-05T17:32:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.469309'}
2026-06-05 17:32:21,673 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-05 17:32:21,673 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-17343158 passed
2026-06-05 17:32:21,673 - DEBUG - ====Verifying policy data for service-right-vn-17343158 in API_Server ======
2026-06-05 17:32:21,673 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:21,679 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:21,689 - DEBUG - Requesting: http://10.0.0.33:8082/project/a7ef9768-ef1c-4f7f-964a-cf17dd17a203
2026-06-05 17:32:21,782 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/0cb0c613-ecf3-413a-8643-562801195659
2026-06-05 17:32:21,792 - DEBUG - =>VN service-right-vn-17343158 has no policy to be verified
2026-06-05 17:32:21,792 - DEBUG - Verifying the vn in opserver
2026-06-05 17:32:21,792 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34832290:service-right-vn-17343158 virtual network link through opserver 10.0.0.33
2026-06-05 17:32:21,792 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-06-05 17:32:21,855 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34832290:service-right-vn-17343158', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34832290:service-right-vn-17343158?flat'}
2026-06-05 17:32:21,855 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34832290:service-right-vn-17343158 virtual network link through opserver 10.0.0.130
2026-06-05 17:32:21,856 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-06-05 17:32:21,915 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34832290:service-right-vn-17343158', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34832290:service-right-vn-17343158?flat'}
2026-06-05 17:32:21,915 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34832290:service-right-vn-17343158 virtual network link through opserver 10.0.0.38
2026-06-05 17:32:21,916 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-06-05 17:32:21,984 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34832290:service-right-vn-17343158', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34832290:service-right-vn-17343158?flat'}
2026-06-05 17:32:21,984 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-34832290:service-right-vn-17343158 is found in opserver
2026-06-05 17:32:22,007 - DEBUG - Do not have enough data to verify VN in agent
2026-06-05 17:32:22,020 - DEBUG - VRF ids for VN service-right-vn-17343158: {}
2026-06-05 17:32:22,076 - DEBUG - Services list from nova: [, , , ]
2026-06-05 17:32:23,211 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5896-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5896-1)
2026-06-05 17:32:24,762 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5896-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5896-2)
2026-06-05 17:32:24,762 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-77332028']
2026-06-05 17:32:25,068 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-77332028'] created succesfully
2026-06-05 17:32:25,524 - DEBUG - Image by name tiny_nat_fw not found
2026-06-05 17:32:25,524 - DEBUG - Installing image tiny_nat_fw
2026-06-05 17:32:25,524 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-06-05 17:32:25,525 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-06-05 17:32:25,525 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-06-05 17:32:25,525 - DEBUG - Unzip image
2026-06-05 17:32:25,525 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-06-05 17:32:25,552 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-06-05 17:32:25,552 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-77332028']
2026-06-05 17:32:25,651 - INFO - Service template: ['default-domain', 'ctest-service_template_1-77332028'] deleted successfully.
2026-06-05 17:32:25,651 - INFO - Skip interface_detach for VM ctest-right_vm-63753660 in state BUILD
2026-06-05 17:32:25,651 - INFO - Deleting VM ctest-right_vm-63753660
2026-06-05 17:32:25,687 - ERROR - VM ctest-right_vm-63753660 has failed to come up
2026-06-05 17:32:25,688 - ERROR - Nova failed to get host of the VM
2026-06-05 17:32:25,688 - ERROR - VM ctest-right_vm-63753660 has failed to come up
2026-06-05 17:32:25,688 - ERROR - Nova failed to get host of the VM
2026-06-05 17:32:25,758 - INFO - Skip interface_detach for VM ctest-left_vm-27663532 in state BUILD
2026-06-05 17:32:25,759 - INFO - Deleting VM ctest-left_vm-27663532
2026-06-05 17:32:25,759 - ERROR - VM ctest-left_vm-27663532 has failed to come up
2026-06-05 17:32:25,759 - ERROR - Nova failed to get host of the VM
2026-06-05 17:32:25,759 - ERROR - VM ctest-left_vm-27663532 has failed to come up
2026-06-05 17:32:25,759 - ERROR - Nova failed to get host of the VM
2026-06-05 17:32:25,831 - INFO - Deleting VN service-right-vn-17343158
2026-06-05 17:32:25,882 - DEBUG - VN 0cb0c613-ecf3-413a-8643-562801195659 still in use: Unable to complete operation on network 0cb0c613-ecf3-413a-8643-562801195659. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-41f90b39-02c2-450a-8c5b-f2ea13cb3403']
2026-06-05 17:32:25,882 - WARNING - Deleting VN service-right-vn-17343158 failed..Will retry
2026-06-05 17:32:28,059 - DEBUG - Response for deleting network ()
2026-06-05 17:32:28,059 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/445e8854-ad1c-492d-8a3e-4f3febe40273
2026-06-05 17:32:28,068 - DEBUG - Response Code: 404
2026-06-05 17:32:28,068 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:28,076 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:28,095 - DEBUG - Requesting: http://10.0.0.33:8082/project/a7ef9768-ef1c-4f7f-964a-cf17dd17a203
2026-06-05 17:32:28,219 - INFO - Validated that VN service-right-vn-17343158 is not found in API Server
2026-06-05 17:32:28,230 - DEBUG - VN service-right-vn-17343158 is not present in Agent 10.0.0.27
2026-06-05 17:32:28,248 - DEBUG - VN service-right-vn-17343158 is not present in Agent 10.0.0.19
2026-06-05 17:32:28,248 - INFO - Validated that VN service-right-vn-17343158 is not in any agent
2026-06-05 17:32:28,287 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-17343158 info
2026-06-05 17:32:28,288 - INFO - Deleting VN service-left-vn-26243470
2026-06-05 17:32:28,471 - DEBUG - Response for deleting network ()
2026-06-05 17:32:28,471 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/5b6c51b4-e532-4656-9ff9-86ce03a138d7
2026-06-05 17:32:28,483 - DEBUG - Response Code: 404
2026-06-05 17:32:28,483 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:28,499 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:28,519 - DEBUG - Requesting: http://10.0.0.33:8082/project/a7ef9768-ef1c-4f7f-964a-cf17dd17a203
2026-06-05 17:32:28,628 - INFO - Validated that VN service-left-vn-26243470 is not found in API Server
2026-06-05 17:32:28,639 - DEBUG - VN service-left-vn-26243470 is not present in Agent 10.0.0.27
2026-06-05 17:32:28,652 - DEBUG - VN service-left-vn-26243470 is not present in Agent 10.0.0.19
2026-06-05 17:32:28,653 - INFO - Validated that VN service-left-vn-26243470 is not in any agent
2026-06-05 17:32:28,681 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-26243470 info
2026-06-05 17:32:28,681 - INFO - Deleting VN ctest-mgmt_vn-64830239
2026-06-05 17:32:28,847 - DEBUG - Response for deleting network ()
2026-06-05 17:32:28,848 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/1e29004f-880b-40a1-a3cb-a4f027e6acc6
2026-06-05 17:32:28,868 - DEBUG - Response Code: 404
2026-06-05 17:32:28,868 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:28,879 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:28,932 - DEBUG - Requesting: http://10.0.0.33:8082/project/a7ef9768-ef1c-4f7f-964a-cf17dd17a203
2026-06-05 17:32:29,023 - INFO - Validated that VN ctest-mgmt_vn-64830239 is not found in API Server
2026-06-05 17:32:29,033 - DEBUG - VN ctest-mgmt_vn-64830239 is not present in Agent 10.0.0.27
2026-06-05 17:32:29,047 - DEBUG - VN ctest-mgmt_vn-64830239 is not present in Agent 10.0.0.19
2026-06-05 17:32:29,047 - INFO - Validated that VN ctest-mgmt_vn-64830239 is not in any agent
2026-06-05 17:32:29,078 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-64830239 info
2026-06-05 17:32:30,360 - DEBUG - No XMPP flaps were noticed during the test
2026-06-05 17:32:30,360 - INFO -
2026-06-05 17:32:30,360 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:16]
2026-06-05 17:32:30,360 - INFO - --------------------------------------------------------------------------------
2026-06-05 17:32:30,364 - INFO - ================================================================================
2026-06-05 17:32:30,364 - INFO - STARTING TEST : test_svc_in_network_datapath
2026-06-05 17:32:31,662 - DEBUG - Nothing to compare xmpp stats {'10.0.0.27': {'10.20.0.14': '0', '10.20.0.129': '0'}, '10.0.0.19': {'10.20.0.18': '0', '10.20.0.14': '0'}} with
2026-06-05 17:32:31,662 - INFO - Initial checks done. Running the testcase now
2026-06-05 17:32:31,662 - INFO -
2026-06-05 17:32:31,937 - DEBUG - Response for create_network : {'network': {'id': 'a209cdc8-2ba2-4a10-85e6-f3a1a045a7a8', 'name': 'ctest-mgmt_vn-86471856', 'tenant_id': 'a7ef9768ef1c4f7f964acf17dd17a203', 'project_id': 'a7ef9768ef1c4f7f964acf17dd17a203', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-34832290', 'ctest-mgmt_vn-86471856'], 'port_security_enabled': True, 'description': ''}}
2026-06-05 17:32:32,194 - DEBUG - Response for create_subnet : {'subnet': {'id': '46ac7e7b-dc7d-4028-b282-78242d10d292', 'name': '', 'tenant_id': 'a7ef9768ef1c4f7f964acf17dd17a203', 'network_id': 'a209cdc8-2ba2-4a10-85e6-f3a1a045a7a8', 'ip_version': 4, 'cidr': '40.197.139.0/26', 'allocation_pools': [{'start': '40.197.139.2', 'end': '40.197.139.62'}], 'gateway_ip': '40.197.139.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '40.197.139.2', 'tags': [], 'project_id': 'a7ef9768ef1c4f7f964acf17dd17a203'}}
2026-06-05 17:32:32,222 - INFO - Created VN ctest-mgmt_vn-86471856
2026-06-05 17:32:32,236 - DEBUG - VN ctest-mgmt_vn-86471856 UUID is a209cdc8-2ba2-4a10-85e6-f3a1a045a7a8
2026-06-05 17:32:32,322 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:32,328 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:32,339 - DEBUG - Requesting: http://10.0.0.33:8082/project/a7ef9768-ef1c-4f7f-964a-cf17dd17a203
2026-06-05 17:32:32,429 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/a209cdc8-2ba2-4a10-85e6-f3a1a045a7a8
2026-06-05 17:32:32,452 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/a209cdc8-2ba2-4a10-85e6-f3a1a045a7a8
2026-06-05 17:32:32,462 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/93d2141d-20fd-45fe-8dcd-8223ef0a60be
2026-06-05 17:32:32,469 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/93d2141d-20fd-45fe-8dcd-8223ef0a60be
2026-06-05 17:32:32,476 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/0357335d-b75e-4f59-8d6b-fd54ac49a309
2026-06-05 17:32:32,483 - DEBUG - Route Targets: ['target:64512:8000004']
2026-06-05 17:32:32,483 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/a209cdc8-2ba2-4a10-85e6-f3a1a045a7a8
2026-06-05 17:32:32,492 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/93d2141d-20fd-45fe-8dcd-8223ef0a60be
2026-06-05 17:32:32,506 - INFO - Verified VN network id 14 for VN a209cdc8-2ba2-4a10-85e6-f3a1a045a7a8
2026-06-05 17:32:32,506 - INFO - Verifications in API Server for VN ctest-mgmt_vn-86471856 passed
2026-06-05 17:32:32,507 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/a209cdc8-2ba2-4a10-85e6-f3a1a045a7a8
2026-06-05 17:32:32,515 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/93d2141d-20fd-45fe-8dcd-8223ef0a60be
2026-06-05 17:32:32,522 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/93d2141d-20fd-45fe-8dcd-8223ef0a60be
2026-06-05 17:32:32,529 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/0357335d-b75e-4f59-8d6b-fd54ac49a309
2026-06-05 17:32:32,541 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-86471856', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34832290', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11676089768543930896', 'uuid-lslong': '9648667127192070056'}, 'enable': 'true', 'created': '2026-06-05T17:32:31', 'last-modified': '2026-06-05T17:32:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.435004'}
2026-06-05 17:32:32,547 - DEBUG - Route Targets: ['target:64512:8000004']
2026-06-05 17:32:32,555 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-86471856', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34832290', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11676089768543930896', 'uuid-lslong': '9648667127192070056'}, 'enable': 'true', 'created': '2026-06-05T17:32:31', 'last-modified': '2026-06-05T17:32:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.457050'}
2026-06-05 17:32:32,562 - DEBUG - Route Targets: ['target:64512:8000004']
2026-06-05 17:32:32,567 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-86471856', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34832290', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11676089768543930896', 'uuid-lslong': '9648667127192070056'}, 'enable': 'true', 'created': '2026-06-05T17:32:31', 'last-modified': '2026-06-05T17:32:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.472426'}
2026-06-05 17:32:32,573 - DEBUG - Route Targets: ['target:64512:8000004']
2026-06-05 17:32:32,573 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-86471856 passed
2026-06-05 17:32:32,573 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-86471856 in API_Server ======
2026-06-05 17:32:32,574 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:32,579 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:32,590 - DEBUG - Requesting: http://10.0.0.33:8082/project/a7ef9768-ef1c-4f7f-964a-cf17dd17a203
2026-06-05 17:32:32,693 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/a209cdc8-2ba2-4a10-85e6-f3a1a045a7a8
2026-06-05 17:32:32,710 - DEBUG - =>VN ctest-mgmt_vn-86471856 has no policy to be verified
2026-06-05 17:32:32,710 - DEBUG - Verifying the vn in opserver
2026-06-05 17:32:32,710 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-86471856 virtual network link through opserver 10.0.0.33
2026-06-05 17:32:32,710 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-06-05 17:32:32,723 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-86471856', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-86471856?flat'}
2026-06-05 17:32:32,723 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-86471856 virtual network link through opserver 10.0.0.130
2026-06-05 17:32:32,723 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-06-05 17:32:32,738 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-86471856', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-86471856?flat'}
2026-06-05 17:32:32,738 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-86471856 virtual network link through opserver 10.0.0.38
2026-06-05 17:32:32,738 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-06-05 17:32:32,751 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-86471856', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-86471856?flat'}
2026-06-05 17:32:32,751 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-34832290:ctest-mgmt_vn-86471856 is found in opserver
2026-06-05 17:32:32,771 - DEBUG - Do not have enough data to verify VN in agent
2026-06-05 17:32:32,781 - DEBUG - VRF ids for VN ctest-mgmt_vn-86471856: {}
2026-06-05 17:32:33,039 - DEBUG - Response for create_network : {'network': {'id': '25b7805e-3f6d-411f-b8e1-cdd17c7cac3c', 'name': 'ctest-left_vn-92682006', 'tenant_id': 'a7ef9768ef1c4f7f964acf17dd17a203', 'project_id': 'a7ef9768ef1c4f7f964acf17dd17a203', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-34832290', 'ctest-left_vn-92682006'], 'port_security_enabled': True, 'description': ''}}
2026-06-05 17:32:33,246 - DEBUG - Response for create_subnet : {'subnet': {'id': '127d563b-98a5-411c-aa6a-2b488243e384', 'name': '', 'tenant_id': 'a7ef9768ef1c4f7f964acf17dd17a203', 'network_id': '25b7805e-3f6d-411f-b8e1-cdd17c7cac3c', 'ip_version': 4, 'cidr': '134.5.46.0/26', 'allocation_pools': [{'start': '134.5.46.2', 'end': '134.5.46.62'}], 'gateway_ip': '134.5.46.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '134.5.46.2', 'tags': [], 'project_id': 'a7ef9768ef1c4f7f964acf17dd17a203'}}
2026-06-05 17:32:33,268 - INFO - Created VN ctest-left_vn-92682006
2026-06-05 17:32:33,280 - DEBUG - VN ctest-left_vn-92682006 UUID is 25b7805e-3f6d-411f-b8e1-cdd17c7cac3c
2026-06-05 17:32:33,367 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:33,373 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:33,453 - DEBUG - Requesting: http://10.0.0.33:8082/project/a7ef9768-ef1c-4f7f-964a-cf17dd17a203
2026-06-05 17:32:33,585 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/25b7805e-3f6d-411f-b8e1-cdd17c7cac3c
2026-06-05 17:32:33,608 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/25b7805e-3f6d-411f-b8e1-cdd17c7cac3c
2026-06-05 17:32:33,621 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/ce362dd4-15be-4484-9ecd-fecfec6d7768
2026-06-05 17:32:33,632 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/ce362dd4-15be-4484-9ecd-fecfec6d7768
2026-06-05 17:32:33,652 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/77c8f262-f974-4c7e-bda8-e49d4309f29e
2026-06-05 17:32:33,661 - DEBUG - Route Targets: ['target:64512:8000005']
2026-06-05 17:32:33,661 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/25b7805e-3f6d-411f-b8e1-cdd17c7cac3c
2026-06-05 17:32:33,671 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/ce362dd4-15be-4484-9ecd-fecfec6d7768
2026-06-05 17:32:33,692 - INFO - Verified VN network id 15 for VN 25b7805e-3f6d-411f-b8e1-cdd17c7cac3c
2026-06-05 17:32:33,692 - INFO - Verifications in API Server for VN ctest-left_vn-92682006 passed
2026-06-05 17:32:33,692 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/25b7805e-3f6d-411f-b8e1-cdd17c7cac3c
2026-06-05 17:32:33,704 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/ce362dd4-15be-4484-9ecd-fecfec6d7768
2026-06-05 17:32:33,714 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/ce362dd4-15be-4484-9ecd-fecfec6d7768
2026-06-05 17:32:33,721 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/77c8f262-f974-4c7e-bda8-e49d4309f29e
2026-06-05 17:32:33,734 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34832290:ctest-left_vn-92682006', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34832290', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2717782042420789535', 'uuid-lslong': '13322155472359042108'}, 'enable': 'true', 'created': '2026-06-05T17:32:32', 'last-modified': '2026-06-05T17:32:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.539001'}
2026-06-05 17:32:33,752 - DEBUG - Route Targets: ['target:64512:8000005']
2026-06-05 17:32:33,762 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34832290:ctest-left_vn-92682006', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34832290', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2717782042420789535', 'uuid-lslong': '13322155472359042108'}, 'enable': 'true', 'created': '2026-06-05T17:32:32', 'last-modified': '2026-06-05T17:32:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.562124'}
2026-06-05 17:32:33,775 - DEBUG - Route Targets: ['target:64512:8000005']
2026-06-05 17:32:33,781 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34832290:ctest-left_vn-92682006', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34832290', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2717782042420789535', 'uuid-lslong': '13322155472359042108'}, 'enable': 'true', 'created': '2026-06-05T17:32:32', 'last-modified': '2026-06-05T17:32:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.586799'}
2026-06-05 17:32:33,790 - DEBUG - Route Targets: ['target:64512:8000005']
2026-06-05 17:32:33,790 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-92682006 passed
2026-06-05 17:32:33,790 - DEBUG - ====Verifying policy data for ctest-left_vn-92682006 in API_Server ======
2026-06-05 17:32:33,791 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:33,799 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:33,811 - DEBUG - Requesting: http://10.0.0.33:8082/project/a7ef9768-ef1c-4f7f-964a-cf17dd17a203
2026-06-05 17:32:33,911 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/25b7805e-3f6d-411f-b8e1-cdd17c7cac3c
2026-06-05 17:32:33,947 - DEBUG - =>VN ctest-left_vn-92682006 has no policy to be verified
2026-06-05 17:32:33,947 - DEBUG - Verifying the vn in opserver
2026-06-05 17:32:33,947 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34832290:ctest-left_vn-92682006 virtual network link through opserver 10.0.0.33
2026-06-05 17:32:33,947 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-06-05 17:32:33,968 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34832290:ctest-left_vn-92682006', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34832290:ctest-left_vn-92682006?flat'}
2026-06-05 17:32:33,968 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34832290:ctest-left_vn-92682006 virtual network link through opserver 10.0.0.130
2026-06-05 17:32:33,968 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-06-05 17:32:33,987 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34832290:ctest-left_vn-92682006', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34832290:ctest-left_vn-92682006?flat'}
2026-06-05 17:32:33,987 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34832290:ctest-left_vn-92682006 virtual network link through opserver 10.0.0.38
2026-06-05 17:32:33,987 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-06-05 17:32:34,008 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34832290:ctest-left_vn-92682006', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34832290:ctest-left_vn-92682006?flat'}
2026-06-05 17:32:34,008 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-34832290:ctest-left_vn-92682006 is found in opserver
2026-06-05 17:32:34,031 - DEBUG - Do not have enough data to verify VN in agent
2026-06-05 17:32:34,050 - DEBUG - VRF ids for VN ctest-left_vn-92682006: {}
2026-06-05 17:32:34,337 - DEBUG - Response for create_network : {'network': {'id': '31e14dc4-3065-4f97-aca1-b304eb2a3cf2', 'name': 'ctest-right_vn-06871815', 'tenant_id': 'a7ef9768ef1c4f7f964acf17dd17a203', 'project_id': 'a7ef9768ef1c4f7f964acf17dd17a203', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-34832290', 'ctest-right_vn-06871815'], 'port_security_enabled': True, 'description': ''}}
2026-06-05 17:32:34,548 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd44ba636-3e96-432b-93a4-cd05ba9c0dc1', 'name': '', 'tenant_id': 'a7ef9768ef1c4f7f964acf17dd17a203', 'network_id': '31e14dc4-3065-4f97-aca1-b304eb2a3cf2', 'ip_version': 4, 'cidr': '1.82.109.128/26', 'allocation_pools': [{'start': '1.82.109.130', 'end': '1.82.109.190'}], 'gateway_ip': '1.82.109.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '1.82.109.130', 'tags': [], 'project_id': 'a7ef9768ef1c4f7f964acf17dd17a203'}}
2026-06-05 17:32:34,571 - INFO - Created VN ctest-right_vn-06871815
2026-06-05 17:32:34,583 - DEBUG - VN ctest-right_vn-06871815 UUID is 31e14dc4-3065-4f97-aca1-b304eb2a3cf2
2026-06-05 17:32:34,666 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:34,675 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:34,688 - DEBUG - Requesting: http://10.0.0.33:8082/project/a7ef9768-ef1c-4f7f-964a-cf17dd17a203
2026-06-05 17:32:34,779 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/31e14dc4-3065-4f97-aca1-b304eb2a3cf2
2026-06-05 17:32:34,791 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/31e14dc4-3065-4f97-aca1-b304eb2a3cf2
2026-06-05 17:32:34,809 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/cb05e245-f3af-4892-8a26-5026ea9937c8
2026-06-05 17:32:34,819 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/cb05e245-f3af-4892-8a26-5026ea9937c8
2026-06-05 17:32:34,825 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/c1b2a424-7e88-4f53-bafe-537616e0993f
2026-06-05 17:32:34,831 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-05 17:32:34,831 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/31e14dc4-3065-4f97-aca1-b304eb2a3cf2
2026-06-05 17:32:34,841 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/cb05e245-f3af-4892-8a26-5026ea9937c8
2026-06-05 17:32:34,856 - INFO - Verified VN network id 16 for VN 31e14dc4-3065-4f97-aca1-b304eb2a3cf2
2026-06-05 17:32:34,856 - INFO - Verifications in API Server for VN ctest-right_vn-06871815 passed
2026-06-05 17:32:34,856 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/31e14dc4-3065-4f97-aca1-b304eb2a3cf2
2026-06-05 17:32:34,867 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/cb05e245-f3af-4892-8a26-5026ea9937c8
2026-06-05 17:32:34,876 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/cb05e245-f3af-4892-8a26-5026ea9937c8
2026-06-05 17:32:34,882 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/c1b2a424-7e88-4f53-bafe-537616e0993f
2026-06-05 17:32:34,894 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34832290:ctest-right_vn-06871815', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34832290', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3594239482639241111', 'uuid-lslong': '12439420479480675570'}, 'enable': 'true', 'created': '2026-06-05T17:32:34', 'last-modified': '2026-06-05T17:32:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.404864'}
2026-06-05 17:32:34,902 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-05 17:32:34,908 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34832290:ctest-right_vn-06871815', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34832290', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3594239482639241111', 'uuid-lslong': '12439420479480675570'}, 'enable': 'true', 'created': '2026-06-05T17:32:34', 'last-modified': '2026-06-05T17:32:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.416775'}
2026-06-05 17:32:34,914 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-05 17:32:34,919 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34832290:ctest-right_vn-06871815', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34832290', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3594239482639241111', 'uuid-lslong': '12439420479480675570'}, 'enable': 'true', 'created': '2026-06-05T17:32:34', 'last-modified': '2026-06-05T17:32:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.429434'}
2026-06-05 17:32:34,925 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-05 17:32:34,925 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-06871815 passed
2026-06-05 17:32:34,925 - DEBUG - ====Verifying policy data for ctest-right_vn-06871815 in API_Server ======
2026-06-05 17:32:34,925 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:34,932 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:34,943 - DEBUG - Requesting: http://10.0.0.33:8082/project/a7ef9768-ef1c-4f7f-964a-cf17dd17a203
2026-06-05 17:32:35,037 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/31e14dc4-3065-4f97-aca1-b304eb2a3cf2
2026-06-05 17:32:35,048 - DEBUG - =>VN ctest-right_vn-06871815 has no policy to be verified
2026-06-05 17:32:35,048 - DEBUG - Verifying the vn in opserver
2026-06-05 17:32:35,048 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34832290:ctest-right_vn-06871815 virtual network link through opserver 10.0.0.33
2026-06-05 17:32:35,048 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-06-05 17:32:35,062 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34832290:ctest-right_vn-06871815', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34832290:ctest-right_vn-06871815?flat'}
2026-06-05 17:32:35,062 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34832290:ctest-right_vn-06871815 virtual network link through opserver 10.0.0.130
2026-06-05 17:32:35,062 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-06-05 17:32:35,075 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34832290:ctest-right_vn-06871815', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34832290:ctest-right_vn-06871815?flat'}
2026-06-05 17:32:35,075 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34832290:ctest-right_vn-06871815 virtual network link through opserver 10.0.0.38
2026-06-05 17:32:35,075 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-06-05 17:32:35,087 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34832290:ctest-right_vn-06871815', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34832290:ctest-right_vn-06871815?flat'}
2026-06-05 17:32:35,087 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-34832290:ctest-right_vn-06871815 is found in opserver
2026-06-05 17:32:35,110 - DEBUG - Do not have enough data to verify VN in agent
2026-06-05 17:32:35,121 - DEBUG - VRF ids for VN ctest-right_vn-06871815: {}
2026-06-05 17:32:36,294 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5896-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5896-2)
2026-06-05 17:32:37,831 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5896-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5896-1)
2026-06-05 17:32:37,832 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-93006175']
2026-06-05 17:32:38,146 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-93006175'] created succesfully
2026-06-05 17:32:38,571 - DEBUG - Image by name tiny_nat_fw not found
2026-06-05 17:32:38,571 - DEBUG - Installing image tiny_nat_fw
2026-06-05 17:32:38,571 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-06-05 17:32:38,572 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-06-05 17:32:38,572 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-06-05 17:32:38,572 - DEBUG - Unzip image
2026-06-05 17:32:38,572 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-06-05 17:32:38,608 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-06-05 17:32:38,610 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-93006175']
2026-06-05 17:32:38,747 - INFO - Service template: ['default-domain', 'ctest-service_template_1-93006175'] deleted successfully.
2026-06-05 17:32:38,747 - INFO - Skip interface_detach for VM ctest-right_vm-29083715 in state BUILD
2026-06-05 17:32:38,747 - INFO - Deleting VM ctest-right_vm-29083715
2026-06-05 17:32:38,747 - ERROR - VM ctest-right_vm-29083715 has failed to come up
2026-06-05 17:32:38,747 - ERROR - Nova failed to get host of the VM
2026-06-05 17:32:38,747 - ERROR - VM ctest-right_vm-29083715 has failed to come up
2026-06-05 17:32:38,747 - ERROR - Nova failed to get host of the VM
2026-06-05 17:32:38,822 - INFO - Skip interface_detach for VM ctest-left_vm-33411932 in state BUILD
2026-06-05 17:32:38,822 - INFO - Deleting VM ctest-left_vm-33411932
2026-06-05 17:32:38,822 - ERROR - VM ctest-left_vm-33411932 has failed to come up
2026-06-05 17:32:38,822 - ERROR - Nova failed to get host of the VM
2026-06-05 17:32:38,822 - ERROR - VM ctest-left_vm-33411932 has failed to come up
2026-06-05 17:32:38,822 - ERROR - Nova failed to get host of the VM
2026-06-05 17:32:38,905 - INFO - Deleting VN ctest-right_vn-06871815
2026-06-05 17:32:38,955 - DEBUG - VN 31e14dc4-3065-4f97-aca1-b304eb2a3cf2 still in use: Unable to complete operation on network 31e14dc4-3065-4f97-aca1-b304eb2a3cf2. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-b77eb9d9-b7ce-4fda-b65d-19677563128f']
2026-06-05 17:32:38,955 - WARNING - Deleting VN ctest-right_vn-06871815 failed..Will retry
2026-06-05 17:32:41,169 - DEBUG - Response for deleting network ()
2026-06-05 17:32:41,169 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/cb05e245-f3af-4892-8a26-5026ea9937c8
2026-06-05 17:32:41,177 - DEBUG - Response Code: 404
2026-06-05 17:32:41,177 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:41,183 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:41,244 - DEBUG - Requesting: http://10.0.0.33:8082/project/a7ef9768-ef1c-4f7f-964a-cf17dd17a203
2026-06-05 17:32:41,350 - INFO - Validated that VN ctest-right_vn-06871815 is not found in API Server
2026-06-05 17:32:41,361 - DEBUG - VN ctest-right_vn-06871815 is not present in Agent 10.0.0.27
2026-06-05 17:32:41,373 - DEBUG - VN ctest-right_vn-06871815 is not present in Agent 10.0.0.19
2026-06-05 17:32:41,373 - INFO - Validated that VN ctest-right_vn-06871815 is not in any agent
2026-06-05 17:32:41,401 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-06871815 info
2026-06-05 17:32:41,402 - INFO - Deleting VN ctest-left_vn-92682006
2026-06-05 17:32:41,612 - DEBUG - Response for deleting network ()
2026-06-05 17:32:41,612 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/ce362dd4-15be-4484-9ecd-fecfec6d7768
2026-06-05 17:32:41,618 - DEBUG - Response Code: 404
2026-06-05 17:32:41,618 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:41,625 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:41,637 - DEBUG - Requesting: http://10.0.0.33:8082/project/a7ef9768-ef1c-4f7f-964a-cf17dd17a203
2026-06-05 17:32:41,729 - INFO - Validated that VN ctest-left_vn-92682006 is not found in API Server
2026-06-05 17:32:41,740 - DEBUG - VN ctest-left_vn-92682006 is not present in Agent 10.0.0.27
2026-06-05 17:32:41,751 - DEBUG - VN ctest-left_vn-92682006 is not present in Agent 10.0.0.19
2026-06-05 17:32:41,751 - INFO - Validated that VN ctest-left_vn-92682006 is not in any agent
2026-06-05 17:32:41,783 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-92682006 info
2026-06-05 17:32:41,783 - INFO - Deleting VN ctest-mgmt_vn-86471856
2026-06-05 17:32:41,935 - DEBUG - Response for deleting network ()
2026-06-05 17:32:41,935 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/93d2141d-20fd-45fe-8dcd-8223ef0a60be
2026-06-05 17:32:41,940 - DEBUG - Response Code: 404
2026-06-05 17:32:41,941 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-05 17:32:41,951 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2afd8c56-3066-40b1-96ed-768ec91ed6e8
2026-06-05 17:32:41,980 - DEBUG - Requesting: http://10.0.0.33:8082/project/a7ef9768-ef1c-4f7f-964a-cf17dd17a203
2026-06-05 17:32:42,071 - INFO - Validated that VN ctest-mgmt_vn-86471856 is not found in API Server
2026-06-05 17:32:42,082 - DEBUG - VN ctest-mgmt_vn-86471856 is not present in Agent 10.0.0.27
2026-06-05 17:32:42,093 - DEBUG - VN ctest-mgmt_vn-86471856 is not present in Agent 10.0.0.19
2026-06-05 17:32:42,093 - INFO - Validated that VN ctest-mgmt_vn-86471856 is not in any agent
2026-06-05 17:32:42,122 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-86471856 info
2026-06-05 17:32:43,376 - DEBUG - No XMPP flaps were noticed during the test
2026-06-05 17:32:43,376 - INFO -
2026-06-05 17:32:43,376 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:13]
2026-06-05 17:32:43,376 - INFO - --------------------------------------------------------------------------------
2026-06-05 17:32:44,163 - INFO - Deleted project: ctest-TestSvcRegr-34832290, ID : a7ef9768-ef1c-4f7f-964a-cf17dd17a203