]) created on node: (an-jenkins-deploy-platform-ansible-os-5305-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5305-2)
2026-02-12 03:13:07,974 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-68980090']
2026-02-12 03:13:08,282 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-68980090'] created succesfully
2026-02-12 03:13:08,647 - DEBUG - Image by name tiny_nat_fw not found
2026-02-12 03:13:08,647 - DEBUG - Installing image tiny_nat_fw
2026-02-12 03:13:08,647 - 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-02-12 03:13:08,648 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-02-12 03:13:08,648 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-02-12 03:13:08,663 - 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-02-12 03:13:08,814 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-12 03:13:08,814 - DEBUG - Unzip image
2026-02-12 03:13:08,814 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-12 03:13:08,833 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-02-12 03:13:08,834 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-68980090']
2026-02-12 03:13:08,917 - INFO - Service template: ['default-domain', 'ctest-service_template_1-68980090'] deleted successfully.
2026-02-12 03:13:08,917 - INFO - Skip interface_detach for VM ctest-right_vm-29747834 in state BUILD
2026-02-12 03:13:08,917 - INFO - Deleting VM ctest-right_vm-29747834
2026-02-12 03:13:08,943 - ERROR - VM ctest-right_vm-29747834 has failed to come up
2026-02-12 03:13:08,943 - ERROR - Nova failed to get host of the VM
2026-02-12 03:13:08,943 - ERROR - VM ctest-right_vm-29747834 has failed to come up
2026-02-12 03:13:08,943 - ERROR - Nova failed to get host of the VM
2026-02-12 03:13:09,010 - INFO - Skip interface_detach for VM ctest-left_vm-23890238 in state BUILD
2026-02-12 03:13:09,010 - INFO - Deleting VM ctest-left_vm-23890238
2026-02-12 03:13:09,010 - ERROR - VM ctest-left_vm-23890238 has failed to come up
2026-02-12 03:13:09,010 - ERROR - Nova failed to get host of the VM
2026-02-12 03:13:09,010 - ERROR - VM ctest-left_vm-23890238 has failed to come up
2026-02-12 03:13:09,010 - ERROR - Nova failed to get host of the VM
2026-02-12 03:13:09,078 - INFO - Deleting VN ctest-right_vn-97744310
2026-02-12 03:13:09,119 - DEBUG - VN 292ee58d-54a9-4363-8f17-8c251d2855c9 still in use: Unable to complete operation on network 292ee58d-54a9-4363-8f17-8c251d2855c9. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-fd465fb9-bd53-41e7-8f14-30d13363c439']
2026-02-12 03:13:09,120 - WARNING - Deleting VN ctest-right_vn-97744310 failed..Will retry
2026-02-12 03:13:11,289 - DEBUG - Response for deleting network ()
2026-02-12 03:13:11,289 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/5c5ae379-9d0a-44c6-84b9-c22ed9f04acd
2026-02-12 03:13:11,296 - DEBUG - Response Code: 404
2026-02-12 03:13:11,296 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:11,307 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:11,328 - DEBUG - Requesting: http://10.0.0.130:8082/project/66cb7e9e-b21f-4d7d-8e19-e6c99b47ab93
2026-02-12 03:13:11,420 - INFO - Validated that VN ctest-right_vn-97744310 is not found in API Server
2026-02-12 03:13:11,431 - DEBUG - VN ctest-right_vn-97744310 is not present in Agent 10.0.0.141
2026-02-12 03:13:11,441 - DEBUG - VN ctest-right_vn-97744310 is not present in Agent 10.0.0.131
2026-02-12 03:13:11,441 - INFO - Validated that VN ctest-right_vn-97744310 is not in any agent
2026-02-12 03:13:11,471 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-97744310 info
2026-02-12 03:13:11,471 - INFO - Deleting VN ctest-left_vn-81067441
2026-02-12 03:13:11,632 - DEBUG - Response for deleting network ()
2026-02-12 03:13:11,632 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/383cfb64-39d8-43ea-af0c-5684bec8841d
2026-02-12 03:13:11,642 - DEBUG - Response Code: 404
2026-02-12 03:13:11,642 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:11,653 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:11,668 - DEBUG - Requesting: http://10.0.0.130:8082/project/66cb7e9e-b21f-4d7d-8e19-e6c99b47ab93
2026-02-12 03:13:11,773 - INFO - Validated that VN ctest-left_vn-81067441 is not found in API Server
2026-02-12 03:13:11,792 - DEBUG - VN ctest-left_vn-81067441 is not present in Agent 10.0.0.141
2026-02-12 03:13:11,807 - DEBUG - VN ctest-left_vn-81067441 is not present in Agent 10.0.0.131
2026-02-12 03:13:11,807 - INFO - Validated that VN ctest-left_vn-81067441 is not in any agent
2026-02-12 03:13:11,849 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-81067441 info
2026-02-12 03:13:11,849 - INFO - Deleting VN ctest-mgmt_vn-46568563
2026-02-12 03:13:12,017 - DEBUG - Response for deleting network ()
2026-02-12 03:13:12,017 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/d18ceb52-0eca-461b-8dfc-b84e59bf27a3
2026-02-12 03:13:12,024 - DEBUG - Response Code: 404
2026-02-12 03:13:12,024 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:12,040 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:12,096 - DEBUG - Requesting: http://10.0.0.130:8082/project/66cb7e9e-b21f-4d7d-8e19-e6c99b47ab93
2026-02-12 03:13:12,183 - INFO - Validated that VN ctest-mgmt_vn-46568563 is not found in API Server
2026-02-12 03:13:12,193 - DEBUG - VN ctest-mgmt_vn-46568563 is not present in Agent 10.0.0.141
2026-02-12 03:13:12,207 - DEBUG - VN ctest-mgmt_vn-46568563 is not present in Agent 10.0.0.131
2026-02-12 03:13:12,207 - INFO - Validated that VN ctest-mgmt_vn-46568563 is not in any agent
2026-02-12 03:13:12,245 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-46568563 info
2026-02-12 03:13:12,245 - INFO - Deleting VM ctest-vm-in-third-vn-11995550
2026-02-12 03:13:12,342 - INFO - Deleting VN ctest-third-vn-10523068
2026-02-12 03:13:12,380 - DEBUG - VN 6e426d03-0e5b-4640-9cdc-a2828d5722ff still in use: Unable to complete operation on network 6e426d03-0e5b-4640-9cdc-a2828d5722ff. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-c9b4b602-88cb-4f24-8046-16336d13d2fa']
2026-02-12 03:13:12,381 - WARNING - Deleting VN ctest-third-vn-10523068 failed..Will retry
2026-02-12 03:13:14,552 - DEBUG - Response for deleting network ()
2026-02-12 03:13:15,856 - DEBUG - No XMPP flaps were noticed during the test
2026-02-12 03:13:15,856 - INFO -
2026-02-12 03:13:15,856 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:24]
2026-02-12 03:13:15,856 - INFO - --------------------------------------------------------------------------------
2026-02-12 03:13:15,859 - INFO - ================================================================================
2026-02-12 03:13:15,859 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2026-02-12 03:13:17,136 - DEBUG - Nothing to compare xmpp stats {'10.0.0.141': {'10.20.0.254': '0', '10.20.0.14': '0'}, '10.0.0.131': {'10.20.0.254': '0', '10.20.0.14': '0'}} with
2026-02-12 03:13:17,136 - INFO - Initial checks done. Running the testcase now
2026-02-12 03:13:17,136 - INFO -
2026-02-12 03:13:17,400 - DEBUG - Response for create_network : {'network': {'id': 'cb8f9cb6-4344-4761-9fd0-1f883a76a73a', 'name': 'ctest-mgmt_vn-91670106', 'tenant_id': '66cb7e9eb21f4d7d8e19e6c99b47ab93', 'project_id': '66cb7e9eb21f4d7d8e19e6c99b47ab93', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-34778258', 'ctest-mgmt_vn-91670106'], 'port_security_enabled': True, 'description': ''}}
2026-02-12 03:13:17,600 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ec9014c3-51af-426a-8e58-ae2547cae337', 'name': '', 'tenant_id': '66cb7e9eb21f4d7d8e19e6c99b47ab93', 'network_id': 'cb8f9cb6-4344-4761-9fd0-1f883a76a73a', 'ip_version': 4, 'cidr': '91.102.76.0/26', 'allocation_pools': [{'start': '91.102.76.2', 'end': '91.102.76.62'}], 'gateway_ip': '91.102.76.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '91.102.76.2', 'tags': [], 'project_id': '66cb7e9eb21f4d7d8e19e6c99b47ab93'}}
2026-02-12 03:13:17,624 - INFO - Created VN ctest-mgmt_vn-91670106
2026-02-12 03:13:17,633 - DEBUG - VN ctest-mgmt_vn-91670106 UUID is cb8f9cb6-4344-4761-9fd0-1f883a76a73a
2026-02-12 03:13:17,706 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:17,712 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:17,722 - DEBUG - Requesting: http://10.0.0.130:8082/project/66cb7e9e-b21f-4d7d-8e19-e6c99b47ab93
2026-02-12 03:13:17,810 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/cb8f9cb6-4344-4761-9fd0-1f883a76a73a
2026-02-12 03:13:17,831 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/cb8f9cb6-4344-4761-9fd0-1f883a76a73a
2026-02-12 03:13:17,839 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/2283d61f-2e15-4914-a343-68a8ed325710
2026-02-12 03:13:17,845 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/2283d61f-2e15-4914-a343-68a8ed325710
2026-02-12 03:13:17,851 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/2f29c610-feb2-4915-9c0c-57c615d5eb88
2026-02-12 03:13:17,857 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-12 03:13:17,857 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/cb8f9cb6-4344-4761-9fd0-1f883a76a73a
2026-02-12 03:13:17,864 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/2283d61f-2e15-4914-a343-68a8ed325710
2026-02-12 03:13:17,879 - INFO - Verified VN network id 15 for VN cb8f9cb6-4344-4761-9fd0-1f883a76a73a
2026-02-12 03:13:17,879 - INFO - Verifications in API Server for VN ctest-mgmt_vn-91670106 passed
2026-02-12 03:13:17,879 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/cb8f9cb6-4344-4761-9fd0-1f883a76a73a
2026-02-12 03:13:17,888 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/2283d61f-2e15-4914-a343-68a8ed325710
2026-02-12 03:13:17,896 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/2283d61f-2e15-4914-a343-68a8ed325710
2026-02-12 03:13:17,903 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/2f29c610-feb2-4915-9c0c-57c615d5eb88
2026-02-12 03:13:17,914 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34778258:ctest-mgmt_vn-91670106', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34778258', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14668114817995523937', 'uuid-lslong': '11515738917143226170'}, 'enable': 'true', 'created': '2026-02-12T03:13:17', 'last-modified': '2026-02-12T03:13:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.373432'}
2026-02-12 03:13:17,920 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-12 03:13:17,925 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34778258:ctest-mgmt_vn-91670106', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34778258', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14668114817995523937', 'uuid-lslong': '11515738917143226170'}, 'enable': 'true', 'created': '2026-02-12T03:13:17', 'last-modified': '2026-02-12T03:13:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.381272'}
2026-02-12 03:13:17,930 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-12 03:13:17,935 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34778258:ctest-mgmt_vn-91670106', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34778258', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14668114817995523937', 'uuid-lslong': '11515738917143226170'}, 'enable': 'true', 'created': '2026-02-12T03:13:17', 'last-modified': '2026-02-12T03:13:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.389374'}
2026-02-12 03:13:17,941 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-12 03:13:17,941 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-91670106 passed
2026-02-12 03:13:17,941 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-91670106 in API_Server ======
2026-02-12 03:13:17,941 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:17,946 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:17,956 - DEBUG - Requesting: http://10.0.0.130:8082/project/66cb7e9e-b21f-4d7d-8e19-e6c99b47ab93
2026-02-12 03:13:18,053 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/cb8f9cb6-4344-4761-9fd0-1f883a76a73a
2026-02-12 03:13:18,064 - DEBUG - =>VN ctest-mgmt_vn-91670106 has no policy to be verified
2026-02-12 03:13:18,064 - DEBUG - Verifying the vn in opserver
2026-02-12 03:13:18,064 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34778258:ctest-mgmt_vn-91670106 virtual network link through opserver 10.0.0.130
2026-02-12 03:13:18,064 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-02-12 03:13:18,078 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34778258:ctest-mgmt_vn-91670106', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34778258:ctest-mgmt_vn-91670106?flat'}
2026-02-12 03:13:18,078 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34778258:ctest-mgmt_vn-91670106 virtual network link through opserver 10.0.0.22
2026-02-12 03:13:18,078 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-12 03:13:18,089 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34778258:ctest-mgmt_vn-91670106', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34778258:ctest-mgmt_vn-91670106?flat'}
2026-02-12 03:13:18,089 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34778258:ctest-mgmt_vn-91670106 virtual network link through opserver 10.0.0.23
2026-02-12 03:13:18,089 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-12 03:13:18,101 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34778258:ctest-mgmt_vn-91670106', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34778258:ctest-mgmt_vn-91670106?flat'}
2026-02-12 03:13:18,102 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-34778258:ctest-mgmt_vn-91670106 is found in opserver
2026-02-12 03:13:18,122 - DEBUG - Do not have enough data to verify VN in agent
2026-02-12 03:13:18,131 - DEBUG - VRF ids for VN ctest-mgmt_vn-91670106: {}
2026-02-12 03:13:18,422 - DEBUG - Response for create_network : {'network': {'id': '2efcd6ff-bb9c-44a9-9524-b999750d9874', 'name': 'ctest-left_vn-97957544', 'tenant_id': '66cb7e9eb21f4d7d8e19e6c99b47ab93', 'project_id': '66cb7e9eb21f4d7d8e19e6c99b47ab93', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-34778258', 'ctest-left_vn-97957544'], 'port_security_enabled': True, 'description': ''}}
2026-02-12 03:13:18,610 - DEBUG - Response for create_subnet : {'subnet': {'id': '2c556c0f-5b3c-47e5-80bd-80333a4df465', 'name': '', 'tenant_id': '66cb7e9eb21f4d7d8e19e6c99b47ab93', 'network_id': '2efcd6ff-bb9c-44a9-9524-b999750d9874', 'ip_version': 4, 'cidr': '43.247.245.0/26', 'allocation_pools': [{'start': '43.247.245.2', 'end': '43.247.245.62'}], 'gateway_ip': '43.247.245.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '43.247.245.2', 'tags': [], 'project_id': '66cb7e9eb21f4d7d8e19e6c99b47ab93'}}
2026-02-12 03:13:18,634 - INFO - Created VN ctest-left_vn-97957544
2026-02-12 03:13:18,646 - DEBUG - VN ctest-left_vn-97957544 UUID is 2efcd6ff-bb9c-44a9-9524-b999750d9874
2026-02-12 03:13:18,720 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:18,726 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:18,736 - DEBUG - Requesting: http://10.0.0.130:8082/project/66cb7e9e-b21f-4d7d-8e19-e6c99b47ab93
2026-02-12 03:13:18,827 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/2efcd6ff-bb9c-44a9-9524-b999750d9874
2026-02-12 03:13:18,838 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/2efcd6ff-bb9c-44a9-9524-b999750d9874
2026-02-12 03:13:18,847 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/e78ed5c8-6640-4339-a137-90ccc5e7906d
2026-02-12 03:13:18,855 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/e78ed5c8-6640-4339-a137-90ccc5e7906d
2026-02-12 03:13:18,861 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/a9472c47-50ea-4d89-ae3d-207e246fe9ad
2026-02-12 03:13:18,866 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-12 03:13:18,866 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/2efcd6ff-bb9c-44a9-9524-b999750d9874
2026-02-12 03:13:18,875 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/e78ed5c8-6640-4339-a137-90ccc5e7906d
2026-02-12 03:13:18,888 - INFO - Verified VN network id 16 for VN 2efcd6ff-bb9c-44a9-9524-b999750d9874
2026-02-12 03:13:18,889 - INFO - Verifications in API Server for VN ctest-left_vn-97957544 passed
2026-02-12 03:13:18,889 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/2efcd6ff-bb9c-44a9-9524-b999750d9874
2026-02-12 03:13:18,897 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/e78ed5c8-6640-4339-a137-90ccc5e7906d
2026-02-12 03:13:18,903 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/e78ed5c8-6640-4339-a137-90ccc5e7906d
2026-02-12 03:13:18,909 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/a9472c47-50ea-4d89-ae3d-207e246fe9ad
2026-02-12 03:13:18,918 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34778258:ctest-left_vn-97957544', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34778258', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3385817413728355497', 'uuid-lslong': '10746918679557806196'}, 'enable': 'true', 'created': '2026-02-12T03:13:18', 'last-modified': '2026-02-12T03:13:18', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.353359'}
2026-02-12 03:13:18,923 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-12 03:13:18,928 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34778258:ctest-left_vn-97957544', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34778258', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3385817413728355497', 'uuid-lslong': '10746918679557806196'}, 'enable': 'true', 'created': '2026-02-12T03:13:18', 'last-modified': '2026-02-12T03:13:18', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.362618'}
2026-02-12 03:13:18,933 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-12 03:13:18,938 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34778258:ctest-left_vn-97957544', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34778258', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3385817413728355497', 'uuid-lslong': '10746918679557806196'}, 'enable': 'true', 'created': '2026-02-12T03:13:18', 'last-modified': '2026-02-12T03:13:18', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.372282'}
2026-02-12 03:13:18,943 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-12 03:13:18,943 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-97957544 passed
2026-02-12 03:13:18,944 - DEBUG - ====Verifying policy data for ctest-left_vn-97957544 in API_Server ======
2026-02-12 03:13:18,944 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:18,949 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:18,962 - DEBUG - Requesting: http://10.0.0.130:8082/project/66cb7e9e-b21f-4d7d-8e19-e6c99b47ab93
2026-02-12 03:13:19,055 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/2efcd6ff-bb9c-44a9-9524-b999750d9874
2026-02-12 03:13:19,065 - DEBUG - =>VN ctest-left_vn-97957544 has no policy to be verified
2026-02-12 03:13:19,065 - DEBUG - Verifying the vn in opserver
2026-02-12 03:13:19,065 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34778258:ctest-left_vn-97957544 virtual network link through opserver 10.0.0.130
2026-02-12 03:13:19,065 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-02-12 03:13:19,078 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34778258:ctest-left_vn-97957544', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34778258:ctest-left_vn-97957544?flat'}
2026-02-12 03:13:19,078 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34778258:ctest-left_vn-97957544 virtual network link through opserver 10.0.0.22
2026-02-12 03:13:19,078 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-12 03:13:19,090 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34778258:ctest-left_vn-97957544', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34778258:ctest-left_vn-97957544?flat'}
2026-02-12 03:13:19,091 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34778258:ctest-left_vn-97957544 virtual network link through opserver 10.0.0.23
2026-02-12 03:13:19,091 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-12 03:13:19,102 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34778258:ctest-left_vn-97957544', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34778258:ctest-left_vn-97957544?flat'}
2026-02-12 03:13:19,102 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-34778258:ctest-left_vn-97957544 is found in opserver
2026-02-12 03:13:19,125 - DEBUG - Do not have enough data to verify VN in agent
2026-02-12 03:13:19,136 - DEBUG - VRF ids for VN ctest-left_vn-97957544: {}
2026-02-12 03:13:19,371 - DEBUG - Response for create_network : {'network': {'id': '4225a844-1228-45d5-a7e3-4d82554616ba', 'name': 'ctest-right_vn-67551317', 'tenant_id': '66cb7e9eb21f4d7d8e19e6c99b47ab93', 'project_id': '66cb7e9eb21f4d7d8e19e6c99b47ab93', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-34778258', 'ctest-right_vn-67551317'], 'port_security_enabled': True, 'description': ''}}
2026-02-12 03:13:19,648 - DEBUG - Response for create_subnet : {'subnet': {'id': '51786453-69f7-43e2-b3e1-62e089e90dfc', 'name': '', 'tenant_id': '66cb7e9eb21f4d7d8e19e6c99b47ab93', 'network_id': '4225a844-1228-45d5-a7e3-4d82554616ba', 'ip_version': 4, 'cidr': '14.227.104.64/26', 'allocation_pools': [{'start': '14.227.104.66', 'end': '14.227.104.126'}], 'gateway_ip': '14.227.104.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '14.227.104.66', 'tags': [], 'project_id': '66cb7e9eb21f4d7d8e19e6c99b47ab93'}}
2026-02-12 03:13:19,669 - INFO - Created VN ctest-right_vn-67551317
2026-02-12 03:13:19,684 - DEBUG - VN ctest-right_vn-67551317 UUID is 4225a844-1228-45d5-a7e3-4d82554616ba
2026-02-12 03:13:19,754 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:19,761 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:19,776 - DEBUG - Requesting: http://10.0.0.130:8082/project/66cb7e9e-b21f-4d7d-8e19-e6c99b47ab93
2026-02-12 03:13:19,871 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/4225a844-1228-45d5-a7e3-4d82554616ba
2026-02-12 03:13:19,885 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/4225a844-1228-45d5-a7e3-4d82554616ba
2026-02-12 03:13:19,897 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/8e4f4a60-ceda-422d-aa3a-5bea17250cfe
2026-02-12 03:13:19,907 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/8e4f4a60-ceda-422d-aa3a-5bea17250cfe
2026-02-12 03:13:19,916 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/d3944a4b-2b1d-4df3-b1cf-e5e7b1f3a15f
2026-02-12 03:13:19,926 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-12 03:13:19,926 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/4225a844-1228-45d5-a7e3-4d82554616ba
2026-02-12 03:13:19,937 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/8e4f4a60-ceda-422d-aa3a-5bea17250cfe
2026-02-12 03:13:19,954 - INFO - Verified VN network id 17 for VN 4225a844-1228-45d5-a7e3-4d82554616ba
2026-02-12 03:13:19,954 - INFO - Verifications in API Server for VN ctest-right_vn-67551317 passed
2026-02-12 03:13:19,954 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/4225a844-1228-45d5-a7e3-4d82554616ba
2026-02-12 03:13:19,964 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/8e4f4a60-ceda-422d-aa3a-5bea17250cfe
2026-02-12 03:13:19,971 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/8e4f4a60-ceda-422d-aa3a-5bea17250cfe
2026-02-12 03:13:19,977 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/d3944a4b-2b1d-4df3-b1cf-e5e7b1f3a15f
2026-02-12 03:13:19,987 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34778258:ctest-right_vn-67551317', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34778258', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4766400790957409749', 'uuid-lslong': '12097598246219028154'}, 'enable': 'true', 'created': '2026-02-12T03:13:19', 'last-modified': '2026-02-12T03:13:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.398653'}
2026-02-12 03:13:19,992 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-12 03:13:19,997 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34778258:ctest-right_vn-67551317', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34778258', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4766400790957409749', 'uuid-lslong': '12097598246219028154'}, 'enable': 'true', 'created': '2026-02-12T03:13:19', 'last-modified': '2026-02-12T03:13:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.412926'}
2026-02-12 03:13:20,002 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-12 03:13:20,008 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34778258:ctest-right_vn-67551317', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34778258', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4766400790957409749', 'uuid-lslong': '12097598246219028154'}, 'enable': 'true', 'created': '2026-02-12T03:13:19', 'last-modified': '2026-02-12T03:13:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.423472'}
2026-02-12 03:13:20,013 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-12 03:13:20,013 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-67551317 passed
2026-02-12 03:13:20,014 - DEBUG - ====Verifying policy data for ctest-right_vn-67551317 in API_Server ======
2026-02-12 03:13:20,014 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:20,026 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:20,042 - DEBUG - Requesting: http://10.0.0.130:8082/project/66cb7e9e-b21f-4d7d-8e19-e6c99b47ab93
2026-02-12 03:13:20,132 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/4225a844-1228-45d5-a7e3-4d82554616ba
2026-02-12 03:13:20,141 - DEBUG - =>VN ctest-right_vn-67551317 has no policy to be verified
2026-02-12 03:13:20,141 - DEBUG - Verifying the vn in opserver
2026-02-12 03:13:20,141 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34778258:ctest-right_vn-67551317 virtual network link through opserver 10.0.0.130
2026-02-12 03:13:20,141 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-02-12 03:13:20,153 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34778258:ctest-right_vn-67551317', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34778258:ctest-right_vn-67551317?flat'}
2026-02-12 03:13:20,153 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34778258:ctest-right_vn-67551317 virtual network link through opserver 10.0.0.22
2026-02-12 03:13:20,153 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-12 03:13:20,166 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34778258:ctest-right_vn-67551317', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34778258:ctest-right_vn-67551317?flat'}
2026-02-12 03:13:20,166 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34778258:ctest-right_vn-67551317 virtual network link through opserver 10.0.0.23
2026-02-12 03:13:20,166 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-12 03:13:20,181 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34778258:ctest-right_vn-67551317', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34778258:ctest-right_vn-67551317?flat'}
2026-02-12 03:13:20,181 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-34778258:ctest-right_vn-67551317 is found in opserver
2026-02-12 03:13:20,203 - DEBUG - Do not have enough data to verify VN in agent
2026-02-12 03:13:20,217 - DEBUG - VRF ids for VN ctest-right_vn-67551317: {}
2026-02-12 03:13:20,501 - DEBUG - Response for create_network : {'network': {'id': 'a72b10b4-18fc-48ec-a36d-5470dd7326b2', 'name': 'ctest-trans_left_vn-25977000', 'tenant_id': '66cb7e9eb21f4d7d8e19e6c99b47ab93', 'project_id': '66cb7e9eb21f4d7d8e19e6c99b47ab93', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-34778258', 'ctest-trans_left_vn-25977000'], 'port_security_enabled': True, 'description': ''}}
2026-02-12 03:13:20,759 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c2d92e91-abfa-48a5-929f-7be81858b979', 'name': '', 'tenant_id': '66cb7e9eb21f4d7d8e19e6c99b47ab93', 'network_id': 'a72b10b4-18fc-48ec-a36d-5470dd7326b2', 'ip_version': 4, 'cidr': '105.25.243.0/26', 'allocation_pools': [{'start': '105.25.243.2', 'end': '105.25.243.62'}], 'gateway_ip': '105.25.243.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '105.25.243.2', 'tags': [], 'project_id': '66cb7e9eb21f4d7d8e19e6c99b47ab93'}}
2026-02-12 03:13:20,782 - INFO - Created VN ctest-trans_left_vn-25977000
2026-02-12 03:13:20,791 - DEBUG - VN ctest-trans_left_vn-25977000 UUID is a72b10b4-18fc-48ec-a36d-5470dd7326b2
2026-02-12 03:13:20,875 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:20,882 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:20,896 - DEBUG - Requesting: http://10.0.0.130:8082/project/66cb7e9e-b21f-4d7d-8e19-e6c99b47ab93
2026-02-12 03:13:20,996 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/a72b10b4-18fc-48ec-a36d-5470dd7326b2
2026-02-12 03:13:21,011 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/a72b10b4-18fc-48ec-a36d-5470dd7326b2
2026-02-12 03:13:21,020 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/bee687c5-2ace-4a3a-adbe-f615d0706747
2026-02-12 03:13:21,027 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/bee687c5-2ace-4a3a-adbe-f615d0706747
2026-02-12 03:13:21,034 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/7031881e-d168-4cd2-9504-693e7fc061aa
2026-02-12 03:13:21,041 - DEBUG - Route Targets: ['target:64512:8000008']
2026-02-12 03:13:21,041 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/a72b10b4-18fc-48ec-a36d-5470dd7326b2
2026-02-12 03:13:21,050 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/bee687c5-2ace-4a3a-adbe-f615d0706747
2026-02-12 03:13:21,066 - INFO - Verified VN network id 18 for VN a72b10b4-18fc-48ec-a36d-5470dd7326b2
2026-02-12 03:13:21,066 - INFO - Verifications in API Server for VN ctest-trans_left_vn-25977000 passed
2026-02-12 03:13:21,066 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/a72b10b4-18fc-48ec-a36d-5470dd7326b2
2026-02-12 03:13:21,075 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/bee687c5-2ace-4a3a-adbe-f615d0706747
2026-02-12 03:13:21,086 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/bee687c5-2ace-4a3a-adbe-f615d0706747
2026-02-12 03:13:21,093 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/7031881e-d168-4cd2-9504-693e7fc061aa
2026-02-12 03:13:21,105 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34778258:ctest-trans_left_vn-25977000', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34778258', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12045739994031868140', 'uuid-lslong': '11776161444372096690'}, 'enable': 'true', 'created': '2026-02-12T03:13:20', 'last-modified': '2026-02-12T03:13:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.392773'}
2026-02-12 03:13:21,115 - DEBUG - Route Targets: ['target:64512:8000008']
2026-02-12 03:13:21,121 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34778258:ctest-trans_left_vn-25977000', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34778258', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12045739994031868140', 'uuid-lslong': '11776161444372096690'}, 'enable': 'true', 'created': '2026-02-12T03:13:20', 'last-modified': '2026-02-12T03:13:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.411271'}
2026-02-12 03:13:21,127 - DEBUG - Route Targets: ['target:64512:8000008']
2026-02-12 03:13:21,132 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34778258:ctest-trans_left_vn-25977000', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34778258', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12045739994031868140', 'uuid-lslong': '11776161444372096690'}, 'enable': 'true', 'created': '2026-02-12T03:13:20', 'last-modified': '2026-02-12T03:13:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.420458'}
2026-02-12 03:13:21,138 - DEBUG - Route Targets: ['target:64512:8000008']
2026-02-12 03:13:21,138 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-25977000 passed
2026-02-12 03:13:21,138 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-25977000 in API_Server ======
2026-02-12 03:13:21,138 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:21,144 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:21,154 - DEBUG - Requesting: http://10.0.0.130:8082/project/66cb7e9e-b21f-4d7d-8e19-e6c99b47ab93
2026-02-12 03:13:21,253 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/a72b10b4-18fc-48ec-a36d-5470dd7326b2
2026-02-12 03:13:21,262 - DEBUG - =>VN ctest-trans_left_vn-25977000 has no policy to be verified
2026-02-12 03:13:21,262 - DEBUG - Verifying the vn in opserver
2026-02-12 03:13:21,263 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34778258:ctest-trans_left_vn-25977000 virtual network link through opserver 10.0.0.130
2026-02-12 03:13:21,263 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-02-12 03:13:21,275 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34778258:ctest-trans_left_vn-25977000', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34778258:ctest-trans_left_vn-25977000?flat'}
2026-02-12 03:13:21,275 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34778258:ctest-trans_left_vn-25977000 virtual network link through opserver 10.0.0.22
2026-02-12 03:13:21,275 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-12 03:13:21,286 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34778258:ctest-trans_left_vn-25977000', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34778258:ctest-trans_left_vn-25977000?flat'}
2026-02-12 03:13:21,286 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34778258:ctest-trans_left_vn-25977000 virtual network link through opserver 10.0.0.23
2026-02-12 03:13:21,286 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-12 03:13:21,300 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34778258:ctest-trans_left_vn-25977000', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34778258:ctest-trans_left_vn-25977000?flat'}
2026-02-12 03:13:21,300 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-34778258:ctest-trans_left_vn-25977000 is found in opserver
2026-02-12 03:13:21,321 - DEBUG - Do not have enough data to verify VN in agent
2026-02-12 03:13:21,332 - DEBUG - VRF ids for VN ctest-trans_left_vn-25977000: {}
2026-02-12 03:13:21,591 - DEBUG - Response for create_network : {'network': {'id': '25a6215e-e0eb-4228-81e8-6d92f181f7f6', 'name': 'ctest-trans_right_vn-96652860', 'tenant_id': '66cb7e9eb21f4d7d8e19e6c99b47ab93', 'project_id': '66cb7e9eb21f4d7d8e19e6c99b47ab93', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-34778258', 'ctest-trans_right_vn-96652860'], 'port_security_enabled': True, 'description': ''}}
2026-02-12 03:13:21,844 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e897081f-cab2-4800-86ee-4d83b8c8976f', 'name': '', 'tenant_id': '66cb7e9eb21f4d7d8e19e6c99b47ab93', 'network_id': '25a6215e-e0eb-4228-81e8-6d92f181f7f6', 'ip_version': 4, 'cidr': '186.43.17.128/26', 'allocation_pools': [{'start': '186.43.17.130', 'end': '186.43.17.190'}], 'gateway_ip': '186.43.17.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '186.43.17.130', 'tags': [], 'project_id': '66cb7e9eb21f4d7d8e19e6c99b47ab93'}}
2026-02-12 03:13:21,865 - INFO - Created VN ctest-trans_right_vn-96652860
2026-02-12 03:13:21,877 - DEBUG - VN ctest-trans_right_vn-96652860 UUID is 25a6215e-e0eb-4228-81e8-6d92f181f7f6
2026-02-12 03:13:21,948 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:21,955 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:21,967 - DEBUG - Requesting: http://10.0.0.130:8082/project/66cb7e9e-b21f-4d7d-8e19-e6c99b47ab93
2026-02-12 03:13:22,065 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/25a6215e-e0eb-4228-81e8-6d92f181f7f6
2026-02-12 03:13:22,077 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/25a6215e-e0eb-4228-81e8-6d92f181f7f6
2026-02-12 03:13:22,088 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/c2bd0e78-5b0f-4f72-9188-843129190a89
2026-02-12 03:13:22,098 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/c2bd0e78-5b0f-4f72-9188-843129190a89
2026-02-12 03:13:22,105 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/c06475e4-3162-4547-b580-29ba3c64536a
2026-02-12 03:13:22,113 - DEBUG - Route Targets: ['target:64512:8000009']
2026-02-12 03:13:22,113 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/25a6215e-e0eb-4228-81e8-6d92f181f7f6
2026-02-12 03:13:22,124 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/c2bd0e78-5b0f-4f72-9188-843129190a89
2026-02-12 03:13:22,139 - INFO - Verified VN network id 19 for VN 25a6215e-e0eb-4228-81e8-6d92f181f7f6
2026-02-12 03:13:22,139 - INFO - Verifications in API Server for VN ctest-trans_right_vn-96652860 passed
2026-02-12 03:13:22,139 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/25a6215e-e0eb-4228-81e8-6d92f181f7f6
2026-02-12 03:13:22,149 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/c2bd0e78-5b0f-4f72-9188-843129190a89
2026-02-12 03:13:22,158 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/c2bd0e78-5b0f-4f72-9188-843129190a89
2026-02-12 03:13:22,167 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/c06475e4-3162-4547-b580-29ba3c64536a
2026-02-12 03:13:22,181 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34778258:ctest-trans_right_vn-96652860', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34778258', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2712892516921459240', 'uuid-lslong': '9360852303374055414'}, 'enable': 'true', 'created': '2026-02-12T03:13:21', 'last-modified': '2026-02-12T03:13:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.375486'}
2026-02-12 03:13:22,192 - DEBUG - Route Targets: ['target:64512:8000009']
2026-02-12 03:13:22,197 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34778258:ctest-trans_right_vn-96652860', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34778258', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2712892516921459240', 'uuid-lslong': '9360852303374055414'}, 'enable': 'true', 'created': '2026-02-12T03:13:21', 'last-modified': '2026-02-12T03:13:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.391448'}
2026-02-12 03:13:22,202 - DEBUG - Route Targets: ['target:64512:8000009']
2026-02-12 03:13:22,207 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-34778258:ctest-trans_right_vn-96652860', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-34778258', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2712892516921459240', 'uuid-lslong': '9360852303374055414'}, 'enable': 'true', 'created': '2026-02-12T03:13:21', 'last-modified': '2026-02-12T03:13:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.404431'}
2026-02-12 03:13:22,212 - DEBUG - Route Targets: ['target:64512:8000009']
2026-02-12 03:13:22,213 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-96652860 passed
2026-02-12 03:13:22,213 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-96652860 in API_Server ======
2026-02-12 03:13:22,213 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:22,219 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:22,229 - DEBUG - Requesting: http://10.0.0.130:8082/project/66cb7e9e-b21f-4d7d-8e19-e6c99b47ab93
2026-02-12 03:13:22,339 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/25a6215e-e0eb-4228-81e8-6d92f181f7f6
2026-02-12 03:13:22,349 - DEBUG - =>VN ctest-trans_right_vn-96652860 has no policy to be verified
2026-02-12 03:13:22,349 - DEBUG - Verifying the vn in opserver
2026-02-12 03:13:22,349 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34778258:ctest-trans_right_vn-96652860 virtual network link through opserver 10.0.0.130
2026-02-12 03:13:22,349 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-02-12 03:13:22,361 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34778258:ctest-trans_right_vn-96652860', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34778258:ctest-trans_right_vn-96652860?flat'}
2026-02-12 03:13:22,361 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34778258:ctest-trans_right_vn-96652860 virtual network link through opserver 10.0.0.22
2026-02-12 03:13:22,361 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-12 03:13:22,373 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34778258:ctest-trans_right_vn-96652860', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34778258:ctest-trans_right_vn-96652860?flat'}
2026-02-12 03:13:22,373 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-34778258:ctest-trans_right_vn-96652860 virtual network link through opserver 10.0.0.23
2026-02-12 03:13:22,373 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-12 03:13:22,385 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-34778258:ctest-trans_right_vn-96652860', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-34778258:ctest-trans_right_vn-96652860?flat'}
2026-02-12 03:13:22,385 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-34778258:ctest-trans_right_vn-96652860 is found in opserver
2026-02-12 03:13:22,406 - DEBUG - Do not have enough data to verify VN in agent
2026-02-12 03:13:22,415 - DEBUG - VRF ids for VN ctest-trans_right_vn-96652860: {}
2026-02-12 03:13:23,499 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5305-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5305-2)
2026-02-12 03:13:24,768 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5305-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5305-1)
2026-02-12 03:13:24,768 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-05948717']
2026-02-12 03:13:25,084 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-05948717'] created succesfully
2026-02-12 03:13:25,471 - DEBUG - Image by name tiny_trans_fw not found
2026-02-12 03:13:25,471 - DEBUG - Installing image tiny_trans_fw
2026-02-12 03:13:25,471 - 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-02-12 03:13:25,471 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-02-12 03:13:25,471 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-02-12 03:13:25,489 - 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-02-12 03:13:25,552 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-02-12 03:13:25,552 - DEBUG - Unzip image
2026-02-12 03:13:25,552 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-02-12 03:13:25,574 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-02-12 03:13:25,574 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-05948717']
2026-02-12 03:13:25,669 - INFO - Service template: ['default-domain', 'ctest-service_template_1-05948717'] deleted successfully.
2026-02-12 03:13:25,669 - INFO - Skip interface_detach for VM ctest-right_vm-50911612 in state BUILD
2026-02-12 03:13:25,669 - INFO - Deleting VM ctest-right_vm-50911612
2026-02-12 03:13:25,669 - ERROR - VM ctest-right_vm-50911612 has failed to come up
2026-02-12 03:13:25,669 - ERROR - Nova failed to get host of the VM
2026-02-12 03:13:25,669 - ERROR - VM ctest-right_vm-50911612 has failed to come up
2026-02-12 03:13:25,669 - ERROR - Nova failed to get host of the VM
2026-02-12 03:13:25,742 - INFO - Skip interface_detach for VM ctest-left_vm-24078266 in state BUILD
2026-02-12 03:13:25,742 - INFO - Deleting VM ctest-left_vm-24078266
2026-02-12 03:13:25,742 - ERROR - VM ctest-left_vm-24078266 has failed to come up
2026-02-12 03:13:25,742 - ERROR - Nova failed to get host of the VM
2026-02-12 03:13:25,743 - ERROR - VM ctest-left_vm-24078266 has failed to come up
2026-02-12 03:13:25,743 - ERROR - Nova failed to get host of the VM
2026-02-12 03:13:25,809 - INFO - Deleting VN ctest-trans_right_vn-96652860
2026-02-12 03:13:25,944 - DEBUG - Response for deleting network ()
2026-02-12 03:13:25,944 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/c2bd0e78-5b0f-4f72-9188-843129190a89
2026-02-12 03:13:25,950 - DEBUG - Response Code: 404
2026-02-12 03:13:25,950 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:25,962 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:25,982 - DEBUG - Requesting: http://10.0.0.130:8082/project/66cb7e9e-b21f-4d7d-8e19-e6c99b47ab93
2026-02-12 03:13:26,086 - INFO - Validated that VN ctest-trans_right_vn-96652860 is not found in API Server
2026-02-12 03:13:26,101 - DEBUG - VN ctest-trans_right_vn-96652860 is not present in Agent 10.0.0.141
2026-02-12 03:13:26,111 - DEBUG - VN ctest-trans_right_vn-96652860 is not present in Agent 10.0.0.131
2026-02-12 03:13:26,111 - INFO - Validated that VN ctest-trans_right_vn-96652860 is not in any agent
2026-02-12 03:13:26,144 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-96652860 info
2026-02-12 03:13:26,144 - INFO - Deleting VN ctest-trans_left_vn-25977000
2026-02-12 03:13:26,294 - DEBUG - Response for deleting network ()
2026-02-12 03:13:26,294 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/bee687c5-2ace-4a3a-adbe-f615d0706747
2026-02-12 03:13:26,303 - DEBUG - Response Code: 404
2026-02-12 03:13:26,303 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:26,327 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:26,343 - DEBUG - Requesting: http://10.0.0.130:8082/project/66cb7e9e-b21f-4d7d-8e19-e6c99b47ab93
2026-02-12 03:13:26,427 - INFO - Validated that VN ctest-trans_left_vn-25977000 is not found in API Server
2026-02-12 03:13:26,454 - DEBUG - VN ctest-trans_left_vn-25977000 is not present in Agent 10.0.0.141
2026-02-12 03:13:26,469 - DEBUG - VN ctest-trans_left_vn-25977000 is not present in Agent 10.0.0.131
2026-02-12 03:13:26,469 - INFO - Validated that VN ctest-trans_left_vn-25977000 is not in any agent
2026-02-12 03:13:26,550 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-25977000 info
2026-02-12 03:13:26,551 - INFO - Deleting VN ctest-right_vn-67551317
2026-02-12 03:13:26,604 - DEBUG - VN 4225a844-1228-45d5-a7e3-4d82554616ba still in use: Unable to complete operation on network 4225a844-1228-45d5-a7e3-4d82554616ba. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-c572ce50-2122-49b1-a500-7a441135cc91']
2026-02-12 03:13:26,604 - WARNING - Deleting VN ctest-right_vn-67551317 failed..Will retry
2026-02-12 03:13:28,743 - DEBUG - Response for deleting network ()
2026-02-12 03:13:28,743 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/8e4f4a60-ceda-422d-aa3a-5bea17250cfe
2026-02-12 03:13:28,748 - DEBUG - Response Code: 404
2026-02-12 03:13:28,749 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:28,760 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:28,772 - DEBUG - Requesting: http://10.0.0.130:8082/project/66cb7e9e-b21f-4d7d-8e19-e6c99b47ab93
2026-02-12 03:13:28,873 - INFO - Validated that VN ctest-right_vn-67551317 is not found in API Server
2026-02-12 03:13:28,884 - DEBUG - VN ctest-right_vn-67551317 is not present in Agent 10.0.0.141
2026-02-12 03:13:28,893 - DEBUG - VN ctest-right_vn-67551317 is not present in Agent 10.0.0.131
2026-02-12 03:13:28,893 - INFO - Validated that VN ctest-right_vn-67551317 is not in any agent
2026-02-12 03:13:28,924 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-67551317 info
2026-02-12 03:13:28,924 - INFO - Deleting VN ctest-left_vn-97957544
2026-02-12 03:13:29,069 - DEBUG - Response for deleting network ()
2026-02-12 03:13:29,069 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/e78ed5c8-6640-4339-a137-90ccc5e7906d
2026-02-12 03:13:29,078 - DEBUG - Response Code: 404
2026-02-12 03:13:29,078 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:29,084 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:29,096 - DEBUG - Requesting: http://10.0.0.130:8082/project/66cb7e9e-b21f-4d7d-8e19-e6c99b47ab93
2026-02-12 03:13:29,194 - INFO - Validated that VN ctest-left_vn-97957544 is not found in API Server
2026-02-12 03:13:29,206 - DEBUG - VN ctest-left_vn-97957544 is not present in Agent 10.0.0.141
2026-02-12 03:13:29,216 - DEBUG - VN ctest-left_vn-97957544 is not present in Agent 10.0.0.131
2026-02-12 03:13:29,216 - INFO - Validated that VN ctest-left_vn-97957544 is not in any agent
2026-02-12 03:13:29,249 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-97957544 info
2026-02-12 03:13:29,250 - INFO - Deleting VN ctest-mgmt_vn-91670106
2026-02-12 03:13:29,410 - DEBUG - Response for deleting network ()
2026-02-12 03:13:29,410 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/2283d61f-2e15-4914-a343-68a8ed325710
2026-02-12 03:13:29,417 - DEBUG - Response Code: 404
2026-02-12 03:13:29,417 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:29,428 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:29,486 - DEBUG - Requesting: http://10.0.0.130:8082/project/66cb7e9e-b21f-4d7d-8e19-e6c99b47ab93
2026-02-12 03:13:29,573 - INFO - Validated that VN ctest-mgmt_vn-91670106 is not found in API Server
2026-02-12 03:13:29,583 - DEBUG - VN ctest-mgmt_vn-91670106 is not present in Agent 10.0.0.141
2026-02-12 03:13:29,593 - DEBUG - VN ctest-mgmt_vn-91670106 is not present in Agent 10.0.0.131
2026-02-12 03:13:29,593 - INFO - Validated that VN ctest-mgmt_vn-91670106 is not in any agent
2026-02-12 03:13:29,621 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-91670106 info
2026-02-12 03:13:30,912 - DEBUG - No XMPP flaps were noticed during the test
2026-02-12 03:13:30,912 - INFO -
2026-02-12 03:13:30,912 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:15]
2026-02-12 03:13:30,912 - INFO - --------------------------------------------------------------------------------
2026-02-12 03:13:31,663 - INFO - Deleted project: ctest-TestSvcRegr-34778258, ID : 66cb7e9e-b21f-4d7d-8e19-e6c99b47ab93
2026-02-12 03:13:31,871 - INFO - Domain Default found not creating
2026-02-12 03:13:32,038 - INFO - Project ctest-TestSvcRegr-57284616 not found, creating it
2026-02-12 03:13:32,624 - INFO - Created Project:ctest-TestSvcRegr-57284616, ID : 30c4942c-9abc-4f41-9cc6-bf8925d5616d
2026-02-12 03:13:34,166 - INFO - ================================================================================
2026-02-12 03:13:34,166 - INFO - STARTING TEST : test_svc_CEM_22032
2026-02-12 03:13:35,439 - DEBUG - Nothing to compare xmpp stats {'10.0.0.141': {'10.20.0.254': '0', '10.20.0.14': '0'}, '10.0.0.131': {'10.20.0.254': '0', '10.20.0.14': '0'}} with
2026-02-12 03:13:35,439 - INFO - Initial checks done. Running the testcase now
2026-02-12 03:13:35,439 - INFO -
2026-02-12 03:13:36,684 - DEBUG - Response for create_network : {'network': {'id': '9c630ff0-73fa-4cb5-8bde-8d6f02b32ecd', 'name': 'ctest-mgmt_vn-62350766', 'tenant_id': '30c4942c9abc4f419cc6bf8925d5616d', 'project_id': '30c4942c9abc4f419cc6bf8925d5616d', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-57284616', 'ctest-mgmt_vn-62350766'], 'port_security_enabled': True, 'description': ''}}
2026-02-12 03:13:36,971 - DEBUG - Response for create_subnet : {'subnet': {'id': '38ba3223-1e48-4d00-b8f9-c90acbd2b17e', 'name': '', 'tenant_id': '30c4942c9abc4f419cc6bf8925d5616d', 'network_id': '9c630ff0-73fa-4cb5-8bde-8d6f02b32ecd', 'ip_version': 4, 'cidr': '98.237.79.192/26', 'allocation_pools': [{'start': '98.237.79.194', 'end': '98.237.79.254'}], 'gateway_ip': '98.237.79.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '98.237.79.194', 'tags': [], 'project_id': '30c4942c9abc4f419cc6bf8925d5616d'}}
2026-02-12 03:13:36,995 - INFO - Created VN ctest-mgmt_vn-62350766
2026-02-12 03:13:37,009 - DEBUG - VN ctest-mgmt_vn-62350766 UUID is 9c630ff0-73fa-4cb5-8bde-8d6f02b32ecd
2026-02-12 03:13:37,095 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:37,395 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:37,422 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:37,439 - DEBUG - Requesting: http://10.0.0.130:8082/project/30c4942c-9abc-4f41-9cc6-bf8925d5616d
2026-02-12 03:13:37,536 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/9c630ff0-73fa-4cb5-8bde-8d6f02b32ecd
2026-02-12 03:13:37,546 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/9c630ff0-73fa-4cb5-8bde-8d6f02b32ecd
2026-02-12 03:13:37,554 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/1b29adef-049b-48db-be00-1b452951759e
2026-02-12 03:13:37,561 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/1b29adef-049b-48db-be00-1b452951759e
2026-02-12 03:13:37,567 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/4ae63c66-c23c-4073-a6fe-be4ab3a7774e
2026-02-12 03:13:37,572 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-12 03:13:37,572 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/9c630ff0-73fa-4cb5-8bde-8d6f02b32ecd
2026-02-12 03:13:37,579 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/1b29adef-049b-48db-be00-1b452951759e
2026-02-12 03:13:37,594 - INFO - Verified VN network id 15 for VN 9c630ff0-73fa-4cb5-8bde-8d6f02b32ecd
2026-02-12 03:13:37,594 - INFO - Verifications in API Server for VN ctest-mgmt_vn-62350766 passed
2026-02-12 03:13:37,594 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/9c630ff0-73fa-4cb5-8bde-8d6f02b32ecd
2026-02-12 03:13:37,603 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/1b29adef-049b-48db-be00-1b452951759e
2026-02-12 03:13:37,610 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/1b29adef-049b-48db-be00-1b452951759e
2026-02-12 03:13:37,616 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/4ae63c66-c23c-4073-a6fe-be4ab3a7774e
2026-02-12 03:13:37,628 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-62350766', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57284616', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11268868218023464117', 'uuid-lslong': '10078648524027932365'}, 'enable': 'true', 'created': '2026-02-12T03:13:36', 'last-modified': '2026-02-12T03:13:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.712010'}
2026-02-12 03:13:37,634 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-12 03:13:37,639 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-62350766', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57284616', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11268868218023464117', 'uuid-lslong': '10078648524027932365'}, 'enable': 'true', 'created': '2026-02-12T03:13:36', 'last-modified': '2026-02-12T03:13:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.716159'}
2026-02-12 03:13:37,644 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-12 03:13:37,649 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-62350766', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57284616', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11268868218023464117', 'uuid-lslong': '10078648524027932365'}, 'enable': 'true', 'created': '2026-02-12T03:13:36', 'last-modified': '2026-02-12T03:13:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.725903'}
2026-02-12 03:13:37,654 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-12 03:13:37,654 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-62350766 passed
2026-02-12 03:13:37,655 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-62350766 in API_Server ======
2026-02-12 03:13:37,655 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:37,661 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:37,671 - DEBUG - Requesting: http://10.0.0.130:8082/project/30c4942c-9abc-4f41-9cc6-bf8925d5616d
2026-02-12 03:13:37,758 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/9c630ff0-73fa-4cb5-8bde-8d6f02b32ecd
2026-02-12 03:13:37,770 - DEBUG - =>VN ctest-mgmt_vn-62350766 has no policy to be verified
2026-02-12 03:13:37,770 - DEBUG - Verifying the vn in opserver
2026-02-12 03:13:37,770 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-62350766 virtual network link through opserver 10.0.0.130
2026-02-12 03:13:37,770 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-02-12 03:13:38,067 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-02-12 03:13:38,133 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-62350766', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-62350766?flat'}
2026-02-12 03:13:38,133 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-62350766 virtual network link through opserver 10.0.0.22
2026-02-12 03:13:38,133 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-12 03:13:38,432 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-12 03:13:38,491 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-62350766', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-62350766?flat'}
2026-02-12 03:13:38,491 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-62350766 virtual network link through opserver 10.0.0.23
2026-02-12 03:13:38,491 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-12 03:13:38,785 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-12 03:13:38,842 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-62350766', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-62350766?flat'}
2026-02-12 03:13:38,842 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-62350766 is found in opserver
2026-02-12 03:13:38,863 - DEBUG - Do not have enough data to verify VN in agent
2026-02-12 03:13:38,872 - DEBUG - VRF ids for VN ctest-mgmt_vn-62350766: {}
2026-02-12 03:13:39,125 - DEBUG - Response for create_network : {'network': {'id': '8d8568c4-2769-4488-957d-e265d9e84336', 'name': 'service-left-vn-49471148', 'tenant_id': '30c4942c9abc4f419cc6bf8925d5616d', 'project_id': '30c4942c9abc4f419cc6bf8925d5616d', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-57284616', 'service-left-vn-49471148'], 'port_security_enabled': True, 'description': ''}}
2026-02-12 03:13:39,343 - DEBUG - Response for create_subnet : {'subnet': {'id': '5443147f-e66e-4e2b-8729-96df88867c63', 'name': '', 'tenant_id': '30c4942c9abc4f419cc6bf8925d5616d', 'network_id': '8d8568c4-2769-4488-957d-e265d9e84336', 'ip_version': 4, 'cidr': '89.212.203.128/26', 'allocation_pools': [{'start': '89.212.203.130', 'end': '89.212.203.190'}], 'gateway_ip': '89.212.203.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '89.212.203.130', 'tags': [], 'project_id': '30c4942c9abc4f419cc6bf8925d5616d'}}
2026-02-12 03:13:39,371 - INFO - Created VN service-left-vn-49471148
2026-02-12 03:13:39,382 - DEBUG - VN service-left-vn-49471148 UUID is 8d8568c4-2769-4488-957d-e265d9e84336
2026-02-12 03:13:39,457 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:39,462 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:39,472 - DEBUG - Requesting: http://10.0.0.130:8082/project/30c4942c-9abc-4f41-9cc6-bf8925d5616d
2026-02-12 03:13:39,558 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/8d8568c4-2769-4488-957d-e265d9e84336
2026-02-12 03:13:39,576 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/8d8568c4-2769-4488-957d-e265d9e84336
2026-02-12 03:13:39,588 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/64384031-f8e3-48f3-9926-6bc7885a9289
2026-02-12 03:13:39,599 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/64384031-f8e3-48f3-9926-6bc7885a9289
2026-02-12 03:13:39,611 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/f0e9a90a-ff23-4af0-99d2-dfae2bc8c157
2026-02-12 03:13:39,621 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-12 03:13:39,621 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/8d8568c4-2769-4488-957d-e265d9e84336
2026-02-12 03:13:39,633 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/64384031-f8e3-48f3-9926-6bc7885a9289
2026-02-12 03:13:39,652 - INFO - Verified VN network id 16 for VN 8d8568c4-2769-4488-957d-e265d9e84336
2026-02-12 03:13:39,652 - INFO - Verifications in API Server for VN service-left-vn-49471148 passed
2026-02-12 03:13:39,652 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/8d8568c4-2769-4488-957d-e265d9e84336
2026-02-12 03:13:39,667 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/64384031-f8e3-48f3-9926-6bc7885a9289
2026-02-12 03:13:39,676 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/64384031-f8e3-48f3-9926-6bc7885a9289
2026-02-12 03:13:39,684 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/f0e9a90a-ff23-4af0-99d2-dfae2bc8c157
2026-02-12 03:13:39,697 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57284616:service-left-vn-49471148', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57284616', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10197672122934445192', 'uuid-lslong': '10772014810815546166'}, 'enable': 'true', 'created': '2026-02-12T03:13:39', 'last-modified': '2026-02-12T03:13:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.413370'}
2026-02-12 03:13:39,706 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-12 03:13:39,712 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57284616:service-left-vn-49471148', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57284616', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10197672122934445192', 'uuid-lslong': '10772014810815546166'}, 'enable': 'true', 'created': '2026-02-12T03:13:39', 'last-modified': '2026-02-12T03:13:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.425805'}
2026-02-12 03:13:39,718 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-12 03:13:39,724 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57284616:service-left-vn-49471148', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57284616', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10197672122934445192', 'uuid-lslong': '10772014810815546166'}, 'enable': 'true', 'created': '2026-02-12T03:13:39', 'last-modified': '2026-02-12T03:13:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.438829'}
2026-02-12 03:13:39,730 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-12 03:13:39,730 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-49471148 passed
2026-02-12 03:13:39,730 - DEBUG - ====Verifying policy data for service-left-vn-49471148 in API_Server ======
2026-02-12 03:13:39,730 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:39,736 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:39,746 - DEBUG - Requesting: http://10.0.0.130:8082/project/30c4942c-9abc-4f41-9cc6-bf8925d5616d
2026-02-12 03:13:39,844 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/8d8568c4-2769-4488-957d-e265d9e84336
2026-02-12 03:13:39,856 - DEBUG - =>VN service-left-vn-49471148 has no policy to be verified
2026-02-12 03:13:39,856 - DEBUG - Verifying the vn in opserver
2026-02-12 03:13:39,856 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57284616:service-left-vn-49471148 virtual network link through opserver 10.0.0.130
2026-02-12 03:13:39,856 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-02-12 03:13:39,924 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57284616:service-left-vn-49471148', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57284616:service-left-vn-49471148?flat'}
2026-02-12 03:13:39,924 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57284616:service-left-vn-49471148 virtual network link through opserver 10.0.0.22
2026-02-12 03:13:39,924 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-12 03:13:39,987 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57284616:service-left-vn-49471148', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57284616:service-left-vn-49471148?flat'}
2026-02-12 03:13:39,988 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57284616:service-left-vn-49471148 virtual network link through opserver 10.0.0.23
2026-02-12 03:13:39,988 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-12 03:13:40,062 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57284616:service-left-vn-49471148', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57284616:service-left-vn-49471148?flat'}
2026-02-12 03:13:40,062 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-57284616:service-left-vn-49471148 is found in opserver
2026-02-12 03:13:40,087 - DEBUG - Do not have enough data to verify VN in agent
2026-02-12 03:13:40,098 - DEBUG - VRF ids for VN service-left-vn-49471148: {}
2026-02-12 03:13:40,381 - DEBUG - Response for create_network : {'network': {'id': 'f0190c04-2994-4cf9-90f8-eb221abe161f', 'name': 'service-right-vn-48953404', 'tenant_id': '30c4942c9abc4f419cc6bf8925d5616d', 'project_id': '30c4942c9abc4f419cc6bf8925d5616d', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-57284616', 'service-right-vn-48953404'], 'port_security_enabled': True, 'description': ''}}
2026-02-12 03:13:40,627 - DEBUG - Response for create_subnet : {'subnet': {'id': '7477ca20-a30d-4b8a-ace5-959cc40e6b5a', 'name': '', 'tenant_id': '30c4942c9abc4f419cc6bf8925d5616d', 'network_id': 'f0190c04-2994-4cf9-90f8-eb221abe161f', 'ip_version': 4, 'cidr': '190.183.67.64/26', 'allocation_pools': [{'start': '190.183.67.66', 'end': '190.183.67.126'}], 'gateway_ip': '190.183.67.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '190.183.67.66', 'tags': [], 'project_id': '30c4942c9abc4f419cc6bf8925d5616d'}}
2026-02-12 03:13:40,650 - INFO - Created VN service-right-vn-48953404
2026-02-12 03:13:40,662 - DEBUG - VN service-right-vn-48953404 UUID is f0190c04-2994-4cf9-90f8-eb221abe161f
2026-02-12 03:13:40,748 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:40,757 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:40,768 - DEBUG - Requesting: http://10.0.0.130:8082/project/30c4942c-9abc-4f41-9cc6-bf8925d5616d
2026-02-12 03:13:40,866 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/f0190c04-2994-4cf9-90f8-eb221abe161f
2026-02-12 03:13:40,880 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/f0190c04-2994-4cf9-90f8-eb221abe161f
2026-02-12 03:13:40,891 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/323f3afe-9ab0-4d63-873c-b10967fbe43b
2026-02-12 03:13:40,903 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/323f3afe-9ab0-4d63-873c-b10967fbe43b
2026-02-12 03:13:40,912 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/2f6bbe46-9876-4cdb-a2b3-00f0b2fb5e38
2026-02-12 03:13:40,920 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-12 03:13:40,920 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/f0190c04-2994-4cf9-90f8-eb221abe161f
2026-02-12 03:13:40,940 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/323f3afe-9ab0-4d63-873c-b10967fbe43b
2026-02-12 03:13:40,958 - INFO - Verified VN network id 17 for VN f0190c04-2994-4cf9-90f8-eb221abe161f
2026-02-12 03:13:40,958 - INFO - Verifications in API Server for VN service-right-vn-48953404 passed
2026-02-12 03:13:40,958 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/f0190c04-2994-4cf9-90f8-eb221abe161f
2026-02-12 03:13:40,969 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/323f3afe-9ab0-4d63-873c-b10967fbe43b
2026-02-12 03:13:40,977 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/323f3afe-9ab0-4d63-873c-b10967fbe43b
2026-02-12 03:13:40,983 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/2f6bbe46-9876-4cdb-a2b3-00f0b2fb5e38
2026-02-12 03:13:40,993 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57284616:service-right-vn-48953404', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57284616', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17300872655537458425', 'uuid-lslong': '10446357867395946015'}, 'enable': 'true', 'created': '2026-02-12T03:13:40', 'last-modified': '2026-02-12T03:13:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.411608'}
2026-02-12 03:13:41,000 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-12 03:13:41,005 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57284616:service-right-vn-48953404', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57284616', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17300872655537458425', 'uuid-lslong': '10446357867395946015'}, 'enable': 'true', 'created': '2026-02-12T03:13:40', 'last-modified': '2026-02-12T03:13:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.425754'}
2026-02-12 03:13:41,011 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-12 03:13:41,016 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57284616:service-right-vn-48953404', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57284616', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17300872655537458425', 'uuid-lslong': '10446357867395946015'}, 'enable': 'true', 'created': '2026-02-12T03:13:40', 'last-modified': '2026-02-12T03:13:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.429113'}
2026-02-12 03:13:41,021 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-12 03:13:41,021 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-48953404 passed
2026-02-12 03:13:41,021 - DEBUG - ====Verifying policy data for service-right-vn-48953404 in API_Server ======
2026-02-12 03:13:41,022 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:41,027 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:41,038 - DEBUG - Requesting: http://10.0.0.130:8082/project/30c4942c-9abc-4f41-9cc6-bf8925d5616d
2026-02-12 03:13:41,125 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/f0190c04-2994-4cf9-90f8-eb221abe161f
2026-02-12 03:13:41,133 - DEBUG - =>VN service-right-vn-48953404 has no policy to be verified
2026-02-12 03:13:41,133 - DEBUG - Verifying the vn in opserver
2026-02-12 03:13:41,133 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57284616:service-right-vn-48953404 virtual network link through opserver 10.0.0.130
2026-02-12 03:13:41,133 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-02-12 03:13:41,189 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57284616:service-right-vn-48953404', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57284616:service-right-vn-48953404?flat'}
2026-02-12 03:13:41,189 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57284616:service-right-vn-48953404 virtual network link through opserver 10.0.0.22
2026-02-12 03:13:41,189 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-12 03:13:41,247 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57284616:service-right-vn-48953404', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57284616:service-right-vn-48953404?flat'}
2026-02-12 03:13:41,247 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57284616:service-right-vn-48953404 virtual network link through opserver 10.0.0.23
2026-02-12 03:13:41,247 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-12 03:13:41,300 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57284616:service-right-vn-48953404', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57284616:service-right-vn-48953404?flat'}
2026-02-12 03:13:41,300 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-57284616:service-right-vn-48953404 is found in opserver
2026-02-12 03:13:41,322 - DEBUG - Do not have enough data to verify VN in agent
2026-02-12 03:13:41,333 - DEBUG - VRF ids for VN service-right-vn-48953404: {}
2026-02-12 03:13:41,385 - DEBUG - Services list from nova: [, , , ]
2026-02-12 03:13:42,483 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5305-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5305-2)
2026-02-12 03:13:43,839 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5305-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5305-1)
2026-02-12 03:13:43,840 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-15400373']
2026-02-12 03:13:44,153 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-15400373'] created succesfully
2026-02-12 03:13:44,501 - DEBUG - Image by name tiny_nat_fw not found
2026-02-12 03:13:44,501 - DEBUG - Installing image tiny_nat_fw
2026-02-12 03:13:44,501 - 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-02-12 03:13:44,501 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-12 03:13:44,501 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-12 03:13:44,502 - DEBUG - Unzip image
2026-02-12 03:13:44,502 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-12 03:13:44,523 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-02-12 03:13:44,523 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-15400373']
2026-02-12 03:13:44,625 - INFO - Service template: ['default-domain', 'ctest-service_template_1-15400373'] deleted successfully.
2026-02-12 03:13:44,625 - INFO - Skip interface_detach for VM ctest-right_vm-91884990 in state BUILD
2026-02-12 03:13:44,625 - INFO - Deleting VM ctest-right_vm-91884990
2026-02-12 03:13:44,667 - ERROR - VM ctest-right_vm-91884990 has failed to come up
2026-02-12 03:13:44,667 - ERROR - Nova failed to get host of the VM
2026-02-12 03:13:44,667 - ERROR - VM ctest-right_vm-91884990 has failed to come up
2026-02-12 03:13:44,667 - ERROR - Nova failed to get host of the VM
2026-02-12 03:13:44,737 - INFO - Skip interface_detach for VM ctest-left_vm-90470429 in state BUILD
2026-02-12 03:13:44,737 - INFO - Deleting VM ctest-left_vm-90470429
2026-02-12 03:13:44,737 - ERROR - VM ctest-left_vm-90470429 has failed to come up
2026-02-12 03:13:44,738 - ERROR - Nova failed to get host of the VM
2026-02-12 03:13:44,738 - ERROR - VM ctest-left_vm-90470429 has failed to come up
2026-02-12 03:13:44,738 - ERROR - Nova failed to get host of the VM
2026-02-12 03:13:44,814 - INFO - Deleting VN service-right-vn-48953404
2026-02-12 03:13:44,855 - DEBUG - VN f0190c04-2994-4cf9-90f8-eb221abe161f still in use: Unable to complete operation on network f0190c04-2994-4cf9-90f8-eb221abe161f. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-92a1d1df-c92b-444a-8b36-d50794cbd365']
2026-02-12 03:13:44,855 - WARNING - Deleting VN service-right-vn-48953404 failed..Will retry
2026-02-12 03:13:47,038 - DEBUG - Response for deleting network ()
2026-02-12 03:13:47,038 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/323f3afe-9ab0-4d63-873c-b10967fbe43b
2026-02-12 03:13:47,044 - DEBUG - Response Code: 404
2026-02-12 03:13:47,047 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:47,059 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:47,086 - DEBUG - Requesting: http://10.0.0.130:8082/project/30c4942c-9abc-4f41-9cc6-bf8925d5616d
2026-02-12 03:13:47,181 - INFO - Validated that VN service-right-vn-48953404 is not found in API Server
2026-02-12 03:13:47,191 - DEBUG - VN service-right-vn-48953404 is not present in Agent 10.0.0.141
2026-02-12 03:13:47,200 - DEBUG - VN service-right-vn-48953404 is not present in Agent 10.0.0.131
2026-02-12 03:13:47,200 - INFO - Validated that VN service-right-vn-48953404 is not in any agent
2026-02-12 03:13:47,226 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-48953404 info
2026-02-12 03:13:47,227 - INFO - Deleting VN service-left-vn-49471148
2026-02-12 03:13:47,397 - DEBUG - Response for deleting network ()
2026-02-12 03:13:47,397 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/64384031-f8e3-48f3-9926-6bc7885a9289
2026-02-12 03:13:47,407 - DEBUG - Response Code: 404
2026-02-12 03:13:47,407 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:47,415 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:47,471 - DEBUG - Requesting: http://10.0.0.130:8082/project/30c4942c-9abc-4f41-9cc6-bf8925d5616d
2026-02-12 03:13:47,562 - INFO - Validated that VN service-left-vn-49471148 is not found in API Server
2026-02-12 03:13:47,573 - DEBUG - VN service-left-vn-49471148 is not present in Agent 10.0.0.141
2026-02-12 03:13:47,583 - DEBUG - VN service-left-vn-49471148 is not present in Agent 10.0.0.131
2026-02-12 03:13:47,583 - INFO - Validated that VN service-left-vn-49471148 is not in any agent
2026-02-12 03:13:47,609 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-49471148 info
2026-02-12 03:13:47,609 - INFO - Deleting VN ctest-mgmt_vn-62350766
2026-02-12 03:13:47,725 - DEBUG - Response for deleting network ()
2026-02-12 03:13:47,726 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/1b29adef-049b-48db-be00-1b452951759e
2026-02-12 03:13:47,732 - DEBUG - Response Code: 404
2026-02-12 03:13:47,732 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:47,738 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:47,752 - DEBUG - Requesting: http://10.0.0.130:8082/project/30c4942c-9abc-4f41-9cc6-bf8925d5616d
2026-02-12 03:13:47,851 - INFO - Validated that VN ctest-mgmt_vn-62350766 is not found in API Server
2026-02-12 03:13:47,862 - DEBUG - VN ctest-mgmt_vn-62350766 is not present in Agent 10.0.0.141
2026-02-12 03:13:47,871 - DEBUG - VN ctest-mgmt_vn-62350766 is not present in Agent 10.0.0.131
2026-02-12 03:13:47,871 - INFO - Validated that VN ctest-mgmt_vn-62350766 is not in any agent
2026-02-12 03:13:47,898 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-62350766 info
2026-02-12 03:13:49,174 - DEBUG - No XMPP flaps were noticed during the test
2026-02-12 03:13:49,175 - INFO -
2026-02-12 03:13:49,175 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:15]
2026-02-12 03:13:49,175 - INFO - --------------------------------------------------------------------------------
2026-02-12 03:13:49,178 - INFO - ================================================================================
2026-02-12 03:13:49,178 - INFO - STARTING TEST : test_svc_in_network_datapath
2026-02-12 03:13:50,445 - DEBUG - Nothing to compare xmpp stats {'10.0.0.141': {'10.20.0.254': '0', '10.20.0.14': '0'}, '10.0.0.131': {'10.20.0.254': '0', '10.20.0.14': '0'}} with
2026-02-12 03:13:50,445 - INFO - Initial checks done. Running the testcase now
2026-02-12 03:13:50,445 - INFO -
2026-02-12 03:13:50,713 - DEBUG - Response for create_network : {'network': {'id': 'c9b3d6b5-d60e-42b1-a2e0-ccf6ced6b16b', 'name': 'ctest-mgmt_vn-00795307', 'tenant_id': '30c4942c9abc4f419cc6bf8925d5616d', 'project_id': '30c4942c9abc4f419cc6bf8925d5616d', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-57284616', 'ctest-mgmt_vn-00795307'], 'port_security_enabled': True, 'description': ''}}
2026-02-12 03:13:50,920 - DEBUG - Response for create_subnet : {'subnet': {'id': 'cce0089e-09d4-4202-bf69-59d88ed7f669', 'name': '', 'tenant_id': '30c4942c9abc4f419cc6bf8925d5616d', 'network_id': 'c9b3d6b5-d60e-42b1-a2e0-ccf6ced6b16b', 'ip_version': 4, 'cidr': '39.118.45.64/26', 'allocation_pools': [{'start': '39.118.45.66', 'end': '39.118.45.126'}], 'gateway_ip': '39.118.45.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '39.118.45.66', 'tags': [], 'project_id': '30c4942c9abc4f419cc6bf8925d5616d'}}
2026-02-12 03:13:50,947 - INFO - Created VN ctest-mgmt_vn-00795307
2026-02-12 03:13:50,959 - DEBUG - VN ctest-mgmt_vn-00795307 UUID is c9b3d6b5-d60e-42b1-a2e0-ccf6ced6b16b
2026-02-12 03:13:51,040 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:51,045 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:51,055 - DEBUG - Requesting: http://10.0.0.130:8082/project/30c4942c-9abc-4f41-9cc6-bf8925d5616d
2026-02-12 03:13:51,146 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/c9b3d6b5-d60e-42b1-a2e0-ccf6ced6b16b
2026-02-12 03:13:51,163 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/c9b3d6b5-d60e-42b1-a2e0-ccf6ced6b16b
2026-02-12 03:13:51,174 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/c0d21c53-a153-4563-8e16-b32e4299a9d7
2026-02-12 03:13:51,183 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/c0d21c53-a153-4563-8e16-b32e4299a9d7
2026-02-12 03:13:51,193 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/10344736-4fef-4a66-8fe6-585486462f92
2026-02-12 03:13:51,201 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-12 03:13:51,201 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/c9b3d6b5-d60e-42b1-a2e0-ccf6ced6b16b
2026-02-12 03:13:51,212 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/c0d21c53-a153-4563-8e16-b32e4299a9d7
2026-02-12 03:13:51,229 - INFO - Verified VN network id 15 for VN c9b3d6b5-d60e-42b1-a2e0-ccf6ced6b16b
2026-02-12 03:13:51,229 - INFO - Verifications in API Server for VN ctest-mgmt_vn-00795307 passed
2026-02-12 03:13:51,229 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/c9b3d6b5-d60e-42b1-a2e0-ccf6ced6b16b
2026-02-12 03:13:51,241 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/c0d21c53-a153-4563-8e16-b32e4299a9d7
2026-02-12 03:13:51,253 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/c0d21c53-a153-4563-8e16-b32e4299a9d7
2026-02-12 03:13:51,261 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/10344736-4fef-4a66-8fe6-585486462f92
2026-02-12 03:13:51,274 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-00795307', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57284616', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14534196498923406001', 'uuid-lslong': '11736605989331710315'}, 'enable': 'true', 'created': '2026-02-12T03:13:50', 'last-modified': '2026-02-12T03:13:50', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.412931'}
2026-02-12 03:13:51,281 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-12 03:13:51,287 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-00795307', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57284616', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14534196498923406001', 'uuid-lslong': '11736605989331710315'}, 'enable': 'true', 'created': '2026-02-12T03:13:50', 'last-modified': '2026-02-12T03:13:50', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.426126'}
2026-02-12 03:13:51,295 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-12 03:13:51,301 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-00795307', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57284616', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14534196498923406001', 'uuid-lslong': '11736605989331710315'}, 'enable': 'true', 'created': '2026-02-12T03:13:50', 'last-modified': '2026-02-12T03:13:50', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.440119'}
2026-02-12 03:13:51,308 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-12 03:13:51,308 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-00795307 passed
2026-02-12 03:13:51,309 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-00795307 in API_Server ======
2026-02-12 03:13:51,309 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:51,317 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:51,329 - DEBUG - Requesting: http://10.0.0.130:8082/project/30c4942c-9abc-4f41-9cc6-bf8925d5616d
2026-02-12 03:13:51,418 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/c9b3d6b5-d60e-42b1-a2e0-ccf6ced6b16b
2026-02-12 03:13:51,427 - DEBUG - =>VN ctest-mgmt_vn-00795307 has no policy to be verified
2026-02-12 03:13:51,427 - DEBUG - Verifying the vn in opserver
2026-02-12 03:13:51,427 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-00795307 virtual network link through opserver 10.0.0.130
2026-02-12 03:13:51,427 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-02-12 03:13:51,439 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-00795307', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-00795307?flat'}
2026-02-12 03:13:51,439 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-00795307 virtual network link through opserver 10.0.0.22
2026-02-12 03:13:51,439 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-12 03:13:51,452 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-00795307', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-00795307?flat'}
2026-02-12 03:13:51,452 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-00795307 virtual network link through opserver 10.0.0.23
2026-02-12 03:13:51,452 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-12 03:13:51,463 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-00795307', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-00795307?flat'}
2026-02-12 03:13:51,463 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-57284616:ctest-mgmt_vn-00795307 is found in opserver
2026-02-12 03:13:51,484 - DEBUG - Do not have enough data to verify VN in agent
2026-02-12 03:13:51,495 - DEBUG - VRF ids for VN ctest-mgmt_vn-00795307: {}
2026-02-12 03:13:51,763 - DEBUG - Response for create_network : {'network': {'id': '89acf1b9-1bae-4025-a332-cad25673da11', 'name': 'ctest-left_vn-24861197', 'tenant_id': '30c4942c9abc4f419cc6bf8925d5616d', 'project_id': '30c4942c9abc4f419cc6bf8925d5616d', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-57284616', 'ctest-left_vn-24861197'], 'port_security_enabled': True, 'description': ''}}
2026-02-12 03:13:51,992 - DEBUG - Response for create_subnet : {'subnet': {'id': '09ae2771-866a-460b-bae8-d6de3632ae38', 'name': '', 'tenant_id': '30c4942c9abc4f419cc6bf8925d5616d', 'network_id': '89acf1b9-1bae-4025-a332-cad25673da11', 'ip_version': 4, 'cidr': '108.14.233.0/26', 'allocation_pools': [{'start': '108.14.233.2', 'end': '108.14.233.62'}], 'gateway_ip': '108.14.233.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '108.14.233.2', 'tags': [], 'project_id': '30c4942c9abc4f419cc6bf8925d5616d'}}
2026-02-12 03:13:52,018 - INFO - Created VN ctest-left_vn-24861197
2026-02-12 03:13:52,031 - DEBUG - VN ctest-left_vn-24861197 UUID is 89acf1b9-1bae-4025-a332-cad25673da11
2026-02-12 03:13:52,102 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:52,110 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:52,122 - DEBUG - Requesting: http://10.0.0.130:8082/project/30c4942c-9abc-4f41-9cc6-bf8925d5616d
2026-02-12 03:13:52,228 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/89acf1b9-1bae-4025-a332-cad25673da11
2026-02-12 03:13:52,245 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/89acf1b9-1bae-4025-a332-cad25673da11
2026-02-12 03:13:52,256 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/8d041e10-ca7b-4c5b-9fd6-559414a177da
2026-02-12 03:13:52,265 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/8d041e10-ca7b-4c5b-9fd6-559414a177da
2026-02-12 03:13:52,273 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/1ff31209-b4d4-492c-ba33-3791cf2aeec3
2026-02-12 03:13:52,281 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-12 03:13:52,281 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/89acf1b9-1bae-4025-a332-cad25673da11
2026-02-12 03:13:52,296 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/8d041e10-ca7b-4c5b-9fd6-559414a177da
2026-02-12 03:13:52,314 - INFO - Verified VN network id 16 for VN 89acf1b9-1bae-4025-a332-cad25673da11
2026-02-12 03:13:52,314 - INFO - Verifications in API Server for VN ctest-left_vn-24861197 passed
2026-02-12 03:13:52,315 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/89acf1b9-1bae-4025-a332-cad25673da11
2026-02-12 03:13:52,331 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/8d041e10-ca7b-4c5b-9fd6-559414a177da
2026-02-12 03:13:52,345 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/8d041e10-ca7b-4c5b-9fd6-559414a177da
2026-02-12 03:13:52,355 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/1ff31209-b4d4-492c-ba33-3791cf2aeec3
2026-02-12 03:13:52,378 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57284616:ctest-left_vn-24861197', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57284616', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9920569856526008357', 'uuid-lslong': '11759684581760162321'}, 'enable': 'true', 'created': '2026-02-12T03:13:51', 'last-modified': '2026-02-12T03:13:51', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.439219'}
2026-02-12 03:13:52,383 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-12 03:13:52,390 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57284616:ctest-left_vn-24861197', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57284616', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9920569856526008357', 'uuid-lslong': '11759684581760162321'}, 'enable': 'true', 'created': '2026-02-12T03:13:51', 'last-modified': '2026-02-12T03:13:51', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.437935'}
2026-02-12 03:13:52,398 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-12 03:13:52,405 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57284616:ctest-left_vn-24861197', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57284616', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9920569856526008357', 'uuid-lslong': '11759684581760162321'}, 'enable': 'true', 'created': '2026-02-12T03:13:51', 'last-modified': '2026-02-12T03:13:51', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.453217'}
2026-02-12 03:13:52,412 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-12 03:13:52,412 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-24861197 passed
2026-02-12 03:13:52,412 - DEBUG - ====Verifying policy data for ctest-left_vn-24861197 in API_Server ======
2026-02-12 03:13:52,412 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:52,419 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:52,430 - DEBUG - Requesting: http://10.0.0.130:8082/project/30c4942c-9abc-4f41-9cc6-bf8925d5616d
2026-02-12 03:13:52,554 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/89acf1b9-1bae-4025-a332-cad25673da11
2026-02-12 03:13:52,564 - DEBUG - =>VN ctest-left_vn-24861197 has no policy to be verified
2026-02-12 03:13:52,564 - DEBUG - Verifying the vn in opserver
2026-02-12 03:13:52,564 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57284616:ctest-left_vn-24861197 virtual network link through opserver 10.0.0.130
2026-02-12 03:13:52,564 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-02-12 03:13:52,578 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57284616:ctest-left_vn-24861197', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57284616:ctest-left_vn-24861197?flat'}
2026-02-12 03:13:52,578 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57284616:ctest-left_vn-24861197 virtual network link through opserver 10.0.0.22
2026-02-12 03:13:52,578 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-12 03:13:52,592 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57284616:ctest-left_vn-24861197', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57284616:ctest-left_vn-24861197?flat'}
2026-02-12 03:13:52,592 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57284616:ctest-left_vn-24861197 virtual network link through opserver 10.0.0.23
2026-02-12 03:13:52,593 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-12 03:13:52,607 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57284616:ctest-left_vn-24861197', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57284616:ctest-left_vn-24861197?flat'}
2026-02-12 03:13:52,607 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-57284616:ctest-left_vn-24861197 is found in opserver
2026-02-12 03:13:52,638 - DEBUG - Do not have enough data to verify VN in agent
2026-02-12 03:13:52,650 - DEBUG - VRF ids for VN ctest-left_vn-24861197: {}
2026-02-12 03:13:52,939 - DEBUG - Response for create_network : {'network': {'id': '0abb44d4-f1d2-421c-a294-7d9f6e9e53af', 'name': 'ctest-right_vn-20076985', 'tenant_id': '30c4942c9abc4f419cc6bf8925d5616d', 'project_id': '30c4942c9abc4f419cc6bf8925d5616d', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-57284616', 'ctest-right_vn-20076985'], 'port_security_enabled': True, 'description': ''}}
2026-02-12 03:13:53,213 - DEBUG - Response for create_subnet : {'subnet': {'id': '5eadff7b-ff78-46bd-8f1e-a6dfa1787dbf', 'name': '', 'tenant_id': '30c4942c9abc4f419cc6bf8925d5616d', 'network_id': '0abb44d4-f1d2-421c-a294-7d9f6e9e53af', 'ip_version': 4, 'cidr': '100.183.246.0/26', 'allocation_pools': [{'start': '100.183.246.2', 'end': '100.183.246.62'}], 'gateway_ip': '100.183.246.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '100.183.246.2', 'tags': [], 'project_id': '30c4942c9abc4f419cc6bf8925d5616d'}}
2026-02-12 03:13:53,238 - INFO - Created VN ctest-right_vn-20076985
2026-02-12 03:13:53,248 - DEBUG - VN ctest-right_vn-20076985 UUID is 0abb44d4-f1d2-421c-a294-7d9f6e9e53af
2026-02-12 03:13:53,320 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:53,327 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:53,339 - DEBUG - Requesting: http://10.0.0.130:8082/project/30c4942c-9abc-4f41-9cc6-bf8925d5616d
2026-02-12 03:13:53,448 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/0abb44d4-f1d2-421c-a294-7d9f6e9e53af
2026-02-12 03:13:53,461 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/0abb44d4-f1d2-421c-a294-7d9f6e9e53af
2026-02-12 03:13:53,471 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/c5d58662-177d-454d-9f90-3b45986eb9bd
2026-02-12 03:13:53,480 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/c5d58662-177d-454d-9f90-3b45986eb9bd
2026-02-12 03:13:53,487 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/fe8ebdc9-04bf-430c-854d-cb2f3526ee05
2026-02-12 03:13:53,494 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-12 03:13:53,494 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/0abb44d4-f1d2-421c-a294-7d9f6e9e53af
2026-02-12 03:13:53,505 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/c5d58662-177d-454d-9f90-3b45986eb9bd
2026-02-12 03:13:53,523 - INFO - Verified VN network id 17 for VN 0abb44d4-f1d2-421c-a294-7d9f6e9e53af
2026-02-12 03:13:53,523 - INFO - Verifications in API Server for VN ctest-right_vn-20076985 passed
2026-02-12 03:13:53,523 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/0abb44d4-f1d2-421c-a294-7d9f6e9e53af
2026-02-12 03:13:53,534 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/c5d58662-177d-454d-9f90-3b45986eb9bd
2026-02-12 03:13:53,543 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/c5d58662-177d-454d-9f90-3b45986eb9bd
2026-02-12 03:13:53,552 - DEBUG - Requesting: http://10.0.0.130:8082/route-target/fe8ebdc9-04bf-430c-854d-cb2f3526ee05
2026-02-12 03:13:53,565 - DEBUG - Control-node 10.0.0.130 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57284616:ctest-right_vn-20076985', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57284616', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '773287442405016092', 'uuid-lslong': '11715126654406644655'}, 'enable': 'true', 'created': '2026-02-12T03:13:52', 'last-modified': '2026-02-12T03:13:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.394584'}
2026-02-12 03:13:53,571 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-12 03:13:53,577 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57284616:ctest-right_vn-20076985', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57284616', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '773287442405016092', 'uuid-lslong': '11715126654406644655'}, 'enable': 'true', 'created': '2026-02-12T03:13:52', 'last-modified': '2026-02-12T03:13:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.424737'}
2026-02-12 03:13:53,583 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-12 03:13:53,588 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57284616:ctest-right_vn-20076985', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57284616', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '773287442405016092', 'uuid-lslong': '11715126654406644655'}, 'enable': 'true', 'created': '2026-02-12T03:13:52', 'last-modified': '2026-02-12T03:13:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.428187'}
2026-02-12 03:13:53,594 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-12 03:13:53,594 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-20076985 passed
2026-02-12 03:13:53,594 - DEBUG - ====Verifying policy data for ctest-right_vn-20076985 in API_Server ======
2026-02-12 03:13:53,594 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:53,601 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:53,612 - DEBUG - Requesting: http://10.0.0.130:8082/project/30c4942c-9abc-4f41-9cc6-bf8925d5616d
2026-02-12 03:13:53,711 - DEBUG - Requesting: http://10.0.0.130:8082/virtual-network/0abb44d4-f1d2-421c-a294-7d9f6e9e53af
2026-02-12 03:13:53,721 - DEBUG - =>VN ctest-right_vn-20076985 has no policy to be verified
2026-02-12 03:13:53,721 - DEBUG - Verifying the vn in opserver
2026-02-12 03:13:53,721 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57284616:ctest-right_vn-20076985 virtual network link through opserver 10.0.0.130
2026-02-12 03:13:53,721 - DEBUG - Requesting: http://10.0.0.130:8081/analytics/uves/virtual-networks
2026-02-12 03:13:53,736 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57284616:ctest-right_vn-20076985', 'href': 'http://10.0.0.130:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57284616:ctest-right_vn-20076985?flat'}
2026-02-12 03:13:53,736 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57284616:ctest-right_vn-20076985 virtual network link through opserver 10.0.0.22
2026-02-12 03:13:53,736 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-12 03:13:53,750 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57284616:ctest-right_vn-20076985', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57284616:ctest-right_vn-20076985?flat'}
2026-02-12 03:13:53,750 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57284616:ctest-right_vn-20076985 virtual network link through opserver 10.0.0.23
2026-02-12 03:13:53,750 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-12 03:13:53,763 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57284616:ctest-right_vn-20076985', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57284616:ctest-right_vn-20076985?flat'}
2026-02-12 03:13:53,763 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-57284616:ctest-right_vn-20076985 is found in opserver
2026-02-12 03:13:53,786 - DEBUG - Do not have enough data to verify VN in agent
2026-02-12 03:13:53,798 - DEBUG - VRF ids for VN ctest-right_vn-20076985: {}
2026-02-12 03:13:54,837 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5305-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5305-1)
2026-02-12 03:13:56,128 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5305-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5305-2)
2026-02-12 03:13:56,128 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-86251571']
2026-02-12 03:13:56,442 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-86251571'] created succesfully
2026-02-12 03:13:56,799 - DEBUG - Image by name tiny_nat_fw not found
2026-02-12 03:13:56,799 - DEBUG - Installing image tiny_nat_fw
2026-02-12 03:13:56,799 - 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-02-12 03:13:56,799 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-12 03:13:56,799 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-12 03:13:56,800 - DEBUG - Unzip image
2026-02-12 03:13:56,800 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-12 03:13:56,819 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-02-12 03:13:56,819 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-86251571']
2026-02-12 03:13:56,929 - INFO - Service template: ['default-domain', 'ctest-service_template_1-86251571'] deleted successfully.
2026-02-12 03:13:56,929 - INFO - Skip interface_detach for VM ctest-right_vm-98401419 in state BUILD
2026-02-12 03:13:56,929 - INFO - Deleting VM ctest-right_vm-98401419
2026-02-12 03:13:56,929 - ERROR - VM ctest-right_vm-98401419 has failed to come up
2026-02-12 03:13:56,929 - ERROR - Nova failed to get host of the VM
2026-02-12 03:13:56,929 - ERROR - VM ctest-right_vm-98401419 has failed to come up
2026-02-12 03:13:56,929 - ERROR - Nova failed to get host of the VM
2026-02-12 03:13:57,022 - INFO - Skip interface_detach for VM ctest-left_vm-07873781 in state BUILD
2026-02-12 03:13:57,022 - INFO - Deleting VM ctest-left_vm-07873781
2026-02-12 03:13:57,022 - ERROR - VM ctest-left_vm-07873781 has failed to come up
2026-02-12 03:13:57,022 - ERROR - Nova failed to get host of the VM
2026-02-12 03:13:57,022 - ERROR - VM ctest-left_vm-07873781 has failed to come up
2026-02-12 03:13:57,022 - ERROR - Nova failed to get host of the VM
2026-02-12 03:13:57,132 - INFO - Deleting VN ctest-right_vn-20076985
2026-02-12 03:13:57,171 - DEBUG - VN 0abb44d4-f1d2-421c-a294-7d9f6e9e53af still in use: Unable to complete operation on network 0abb44d4-f1d2-421c-a294-7d9f6e9e53af. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-bb1eaced-65cb-46c9-a487-e2972ae80caf']
2026-02-12 03:13:57,172 - WARNING - Deleting VN ctest-right_vn-20076985 failed..Will retry
2026-02-12 03:13:59,320 - DEBUG - Response for deleting network ()
2026-02-12 03:13:59,320 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/c5d58662-177d-454d-9f90-3b45986eb9bd
2026-02-12 03:13:59,326 - DEBUG - Response Code: 404
2026-02-12 03:13:59,326 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:59,346 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:59,361 - DEBUG - Requesting: http://10.0.0.130:8082/project/30c4942c-9abc-4f41-9cc6-bf8925d5616d
2026-02-12 03:13:59,474 - INFO - Validated that VN ctest-right_vn-20076985 is not found in API Server
2026-02-12 03:13:59,487 - DEBUG - VN ctest-right_vn-20076985 is not present in Agent 10.0.0.141
2026-02-12 03:13:59,501 - DEBUG - VN ctest-right_vn-20076985 is not present in Agent 10.0.0.131
2026-02-12 03:13:59,501 - INFO - Validated that VN ctest-right_vn-20076985 is not in any agent
2026-02-12 03:13:59,531 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-20076985 info
2026-02-12 03:13:59,531 - INFO - Deleting VN ctest-left_vn-24861197
2026-02-12 03:13:59,701 - DEBUG - Response for deleting network ()
2026-02-12 03:13:59,701 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/8d041e10-ca7b-4c5b-9fd6-559414a177da
2026-02-12 03:13:59,716 - DEBUG - Response Code: 404
2026-02-12 03:13:59,716 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:13:59,725 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:13:59,740 - DEBUG - Requesting: http://10.0.0.130:8082/project/30c4942c-9abc-4f41-9cc6-bf8925d5616d
2026-02-12 03:13:59,852 - INFO - Validated that VN ctest-left_vn-24861197 is not found in API Server
2026-02-12 03:13:59,863 - DEBUG - VN ctest-left_vn-24861197 is not present in Agent 10.0.0.141
2026-02-12 03:13:59,873 - DEBUG - VN ctest-left_vn-24861197 is not present in Agent 10.0.0.131
2026-02-12 03:13:59,873 - INFO - Validated that VN ctest-left_vn-24861197 is not in any agent
2026-02-12 03:13:59,903 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-24861197 info
2026-02-12 03:13:59,903 - INFO - Deleting VN ctest-mgmt_vn-00795307
2026-02-12 03:14:00,039 - DEBUG - Response for deleting network ()
2026-02-12 03:14:00,039 - DEBUG - Requesting: http://10.0.0.130:8082/routing-instance/c0d21c53-a153-4563-8e16-b32e4299a9d7
2026-02-12 03:14:00,045 - DEBUG - Response Code: 404
2026-02-12 03:14:00,045 - DEBUG - Requesting: http://10.0.0.130:8082/domains
2026-02-12 03:14:00,051 - DEBUG - Requesting: http://10.0.0.130:8082/domain/dbbdb6d5-ac40-4bc8-b2c9-9c29259fb031
2026-02-12 03:14:00,063 - DEBUG - Requesting: http://10.0.0.130:8082/project/30c4942c-9abc-4f41-9cc6-bf8925d5616d
2026-02-12 03:14:00,170 - INFO - Validated that VN ctest-mgmt_vn-00795307 is not found in API Server
2026-02-12 03:14:00,190 - DEBUG - VN ctest-mgmt_vn-00795307 is not present in Agent 10.0.0.141
2026-02-12 03:14:00,201 - DEBUG - VN ctest-mgmt_vn-00795307 is not present in Agent 10.0.0.131
2026-02-12 03:14:00,201 - INFO - Validated that VN ctest-mgmt_vn-00795307 is not in any agent
2026-02-12 03:14:00,237 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-00795307 info
2026-02-12 03:14:01,500 - DEBUG - No XMPP flaps were noticed during the test
2026-02-12 03:14:01,500 - INFO -
2026-02-12 03:14:01,500 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:12]
2026-02-12 03:14:01,500 - INFO - --------------------------------------------------------------------------------
2026-02-12 03:14:02,220 - INFO - Deleted project: ctest-TestSvcRegr-57284616, ID : 30c4942c-9abc-4f41-9cc6-bf8925d5616d