]) created on node: (an-jenkins-deploy-platform-ansible-os-5545-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5545-2)
2026-03-26 03:17:02,233 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-53457320']
2026-03-26 03:17:02,535 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-53457320'] created succesfully
2026-03-26 03:17:03,100 - DEBUG - Image by name tiny_nat_fw not found
2026-03-26 03:17:03,100 - DEBUG - Installing image tiny_nat_fw
2026-03-26 03:17:03,100 - 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-03-26 03:17:03,100 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-03-26 03:17:03,100 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-03-26 03:17:03,159 - 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-03-26 03:17:03,237 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-26 03:17:03,241 - DEBUG - Unzip image
2026-03-26 03:17:03,241 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-26 03:17:03,274 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-03-26 03:17:03,274 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-53457320']
2026-03-26 03:17:03,387 - INFO - Service template: ['default-domain', 'ctest-service_template_1-53457320'] deleted successfully.
2026-03-26 03:17:03,387 - INFO - Skip interface_detach for VM ctest-right_vm-60709001 in state BUILD
2026-03-26 03:17:03,387 - INFO - Deleting VM ctest-right_vm-60709001
2026-03-26 03:17:03,420 - ERROR - VM ctest-right_vm-60709001 has failed to come up
2026-03-26 03:17:03,420 - ERROR - Nova failed to get host of the VM
2026-03-26 03:17:03,420 - ERROR - VM ctest-right_vm-60709001 has failed to come up
2026-03-26 03:17:03,420 - ERROR - Nova failed to get host of the VM
2026-03-26 03:17:03,497 - INFO - Skip interface_detach for VM ctest-left_vm-08320271 in state BUILD
2026-03-26 03:17:03,498 - INFO - Deleting VM ctest-left_vm-08320271
2026-03-26 03:17:03,498 - ERROR - VM ctest-left_vm-08320271 has failed to come up
2026-03-26 03:17:03,498 - ERROR - Nova failed to get host of the VM
2026-03-26 03:17:03,498 - ERROR - VM ctest-left_vm-08320271 has failed to come up
2026-03-26 03:17:03,498 - ERROR - Nova failed to get host of the VM
2026-03-26 03:17:03,573 - INFO - Deleting VN ctest-right_vn-70291198
2026-03-26 03:17:03,619 - DEBUG - VN 67f0bf4d-c480-47fe-b004-d73ad8b8c50e still in use: Unable to complete operation on network 67f0bf4d-c480-47fe-b004-d73ad8b8c50e. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-68c8cffa-e8e1-47a8-83a9-36473f79eef3']
2026-03-26 03:17:03,619 - WARNING - Deleting VN ctest-right_vn-70291198 failed..Will retry
2026-03-26 03:17:05,773 - DEBUG - Response for deleting network ()
2026-03-26 03:17:05,773 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/fe0ec0dd-9148-4e52-a69a-99185f1cfe3a
2026-03-26 03:17:05,784 - DEBUG - Response Code: 404
2026-03-26 03:17:05,784 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:05,794 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:05,827 - DEBUG - Requesting: http://10.0.0.240:8082/project/5aec9403-357b-498f-b9fc-be93a6846c8c
2026-03-26 03:17:05,928 - INFO - Validated that VN ctest-right_vn-70291198 is not found in API Server
2026-03-26 03:17:05,940 - DEBUG - VN ctest-right_vn-70291198 is not present in Agent 10.0.0.38
2026-03-26 03:17:05,950 - DEBUG - VN ctest-right_vn-70291198 is not present in Agent 10.0.0.23
2026-03-26 03:17:05,950 - INFO - Validated that VN ctest-right_vn-70291198 is not in any agent
2026-03-26 03:17:05,989 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-70291198 info
2026-03-26 03:17:05,990 - INFO - Deleting VN ctest-left_vn-36658085
2026-03-26 03:17:06,161 - DEBUG - Response for deleting network ()
2026-03-26 03:17:06,161 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e7eab45f-8c91-4527-83b9-5579094b7aba
2026-03-26 03:17:06,168 - DEBUG - Response Code: 404
2026-03-26 03:17:06,168 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:06,174 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:06,192 - DEBUG - Requesting: http://10.0.0.240:8082/project/5aec9403-357b-498f-b9fc-be93a6846c8c
2026-03-26 03:17:06,299 - INFO - Validated that VN ctest-left_vn-36658085 is not found in API Server
2026-03-26 03:17:06,314 - DEBUG - VN ctest-left_vn-36658085 is not present in Agent 10.0.0.38
2026-03-26 03:17:06,325 - DEBUG - VN ctest-left_vn-36658085 is not present in Agent 10.0.0.23
2026-03-26 03:17:06,325 - INFO - Validated that VN ctest-left_vn-36658085 is not in any agent
2026-03-26 03:17:06,359 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-36658085 info
2026-03-26 03:17:06,359 - INFO - Deleting VN ctest-mgmt_vn-19783786
2026-03-26 03:17:06,503 - DEBUG - Response for deleting network ()
2026-03-26 03:17:06,503 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/22ba0402-c3d0-469a-8715-43dd0040adcb
2026-03-26 03:17:06,510 - DEBUG - Response Code: 404
2026-03-26 03:17:06,510 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:06,515 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:06,569 - DEBUG - Requesting: http://10.0.0.240:8082/project/5aec9403-357b-498f-b9fc-be93a6846c8c
2026-03-26 03:17:06,658 - INFO - Validated that VN ctest-mgmt_vn-19783786 is not found in API Server
2026-03-26 03:17:06,670 - DEBUG - VN ctest-mgmt_vn-19783786 is not present in Agent 10.0.0.38
2026-03-26 03:17:06,682 - DEBUG - VN ctest-mgmt_vn-19783786 is not present in Agent 10.0.0.23
2026-03-26 03:17:06,682 - INFO - Validated that VN ctest-mgmt_vn-19783786 is not in any agent
2026-03-26 03:17:06,715 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-19783786 info
2026-03-26 03:17:06,715 - INFO - Deleting VM ctest-vm-in-third-vn-71960118
2026-03-26 03:17:06,809 - INFO - Deleting VN ctest-third-vn-75354852
2026-03-26 03:17:06,860 - DEBUG - VN 52e566ba-9ac7-46c9-86ff-246db927a971 still in use: Unable to complete operation on network 52e566ba-9ac7-46c9-86ff-246db927a971. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-19c988cf-a3ef-4459-bec1-2df489330415']
2026-03-26 03:17:06,860 - WARNING - Deleting VN ctest-third-vn-75354852 failed..Will retry
2026-03-26 03:17:09,022 - DEBUG - Response for deleting network ()
2026-03-26 03:17:10,326 - DEBUG - No XMPP flaps were noticed during the test
2026-03-26 03:17:10,327 - INFO -
2026-03-26 03:17:10,327 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:26]
2026-03-26 03:17:10,327 - INFO - --------------------------------------------------------------------------------
2026-03-26 03:17:10,330 - INFO - ================================================================================
2026-03-26 03:17:10,330 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2026-03-26 03:17:11,604 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.18': '0', '10.20.0.14': '0'}, '10.0.0.23': {'10.20.0.254': '0', '10.20.0.18': '0'}} with
2026-03-26 03:17:11,604 - INFO - Initial checks done. Running the testcase now
2026-03-26 03:17:11,604 - INFO -
2026-03-26 03:17:11,974 - DEBUG - Response for create_network : {'network': {'id': '5dfa2804-ddb8-4a31-b8f2-5ce3c1a56ff0', 'name': 'ctest-mgmt_vn-24991196', 'tenant_id': '5aec9403357b498fb9fcbe93a6846c8c', 'project_id': '5aec9403357b498fb9fcbe93a6846c8c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-95375600', 'ctest-mgmt_vn-24991196'], 'port_security_enabled': True, 'description': ''}}
2026-03-26 03:17:12,190 - DEBUG - Response for create_subnet : {'subnet': {'id': '2515729a-0054-4740-86ad-de669e92322c', 'name': '', 'tenant_id': '5aec9403357b498fb9fcbe93a6846c8c', 'network_id': '5dfa2804-ddb8-4a31-b8f2-5ce3c1a56ff0', 'ip_version': 4, 'cidr': '150.208.83.0/26', 'allocation_pools': [{'start': '150.208.83.2', 'end': '150.208.83.62'}], 'gateway_ip': '150.208.83.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '150.208.83.2', 'tags': [], 'project_id': '5aec9403357b498fb9fcbe93a6846c8c'}}
2026-03-26 03:17:12,215 - INFO - Created VN ctest-mgmt_vn-24991196
2026-03-26 03:17:12,227 - DEBUG - VN ctest-mgmt_vn-24991196 UUID is 5dfa2804-ddb8-4a31-b8f2-5ce3c1a56ff0
2026-03-26 03:17:12,305 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:12,311 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:12,324 - DEBUG - Requesting: http://10.0.0.240:8082/project/5aec9403-357b-498f-b9fc-be93a6846c8c
2026-03-26 03:17:12,432 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/5dfa2804-ddb8-4a31-b8f2-5ce3c1a56ff0
2026-03-26 03:17:12,452 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/5dfa2804-ddb8-4a31-b8f2-5ce3c1a56ff0
2026-03-26 03:17:12,465 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/4ae8c2a7-1b4a-4374-a9b5-6570304723a8
2026-03-26 03:17:12,477 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/4ae8c2a7-1b4a-4374-a9b5-6570304723a8
2026-03-26 03:17:12,492 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/8be6b169-8c86-4e5c-909b-cd4622e8c139
2026-03-26 03:17:12,508 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-26 03:17:12,508 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/5dfa2804-ddb8-4a31-b8f2-5ce3c1a56ff0
2026-03-26 03:17:12,522 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/4ae8c2a7-1b4a-4374-a9b5-6570304723a8
2026-03-26 03:17:12,542 - INFO - Verified VN network id 18 for VN 5dfa2804-ddb8-4a31-b8f2-5ce3c1a56ff0
2026-03-26 03:17:12,543 - INFO - Verifications in API Server for VN ctest-mgmt_vn-24991196 passed
2026-03-26 03:17:12,544 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/5dfa2804-ddb8-4a31-b8f2-5ce3c1a56ff0
2026-03-26 03:17:12,556 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/4ae8c2a7-1b4a-4374-a9b5-6570304723a8
2026-03-26 03:17:12,565 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/4ae8c2a7-1b4a-4374-a9b5-6570304723a8
2026-03-26 03:17:12,575 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/8be6b169-8c86-4e5c-909b-cd4622e8c139
2026-03-26 03:17:12,590 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95375600:ctest-mgmt_vn-24991196', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95375600', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6771768991069784625', 'uuid-lslong': '13326816380618895344'}, 'enable': 'true', 'created': '2026-03-26T03:17:11', 'last-modified': '2026-03-26T03:17:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.437510'}
2026-03-26 03:17:12,596 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-26 03:17:12,604 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95375600:ctest-mgmt_vn-24991196', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95375600', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6771768991069784625', 'uuid-lslong': '13326816380618895344'}, 'enable': 'true', 'created': '2026-03-26T03:17:11', 'last-modified': '2026-03-26T03:17:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.453810'}
2026-03-26 03:17:12,616 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-26 03:17:12,622 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95375600:ctest-mgmt_vn-24991196', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95375600', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6771768991069784625', 'uuid-lslong': '13326816380618895344'}, 'enable': 'true', 'created': '2026-03-26T03:17:11', 'last-modified': '2026-03-26T03:17:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.472725'}
2026-03-26 03:17:12,628 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-26 03:17:12,628 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-24991196 passed
2026-03-26 03:17:12,629 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-24991196 in API_Server ======
2026-03-26 03:17:12,629 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:12,636 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:12,648 - DEBUG - Requesting: http://10.0.0.240:8082/project/5aec9403-357b-498f-b9fc-be93a6846c8c
2026-03-26 03:17:12,750 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/5dfa2804-ddb8-4a31-b8f2-5ce3c1a56ff0
2026-03-26 03:17:12,764 - DEBUG - =>VN ctest-mgmt_vn-24991196 has no policy to be verified
2026-03-26 03:17:12,764 - DEBUG - Verifying the vn in opserver
2026-03-26 03:17:12,764 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95375600:ctest-mgmt_vn-24991196 virtual network link through opserver 10.0.0.240
2026-03-26 03:17:12,764 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-03-26 03:17:12,780 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95375600:ctest-mgmt_vn-24991196', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95375600:ctest-mgmt_vn-24991196?flat'}
2026-03-26 03:17:12,780 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95375600:ctest-mgmt_vn-24991196 virtual network link through opserver 10.0.0.22
2026-03-26 03:17:12,780 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-03-26 03:17:12,795 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95375600:ctest-mgmt_vn-24991196', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95375600:ctest-mgmt_vn-24991196?flat'}
2026-03-26 03:17:12,795 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95375600:ctest-mgmt_vn-24991196 virtual network link through opserver 10.0.0.65
2026-03-26 03:17:12,795 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-26 03:17:12,807 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95375600:ctest-mgmt_vn-24991196', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95375600:ctest-mgmt_vn-24991196?flat'}
2026-03-26 03:17:12,807 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-95375600:ctest-mgmt_vn-24991196 is found in opserver
2026-03-26 03:17:12,829 - DEBUG - Do not have enough data to verify VN in agent
2026-03-26 03:17:12,840 - DEBUG - VRF ids for VN ctest-mgmt_vn-24991196: {}
2026-03-26 03:17:13,112 - DEBUG - Response for create_network : {'network': {'id': 'ab87506f-2b0c-4c52-bd7f-b6110cce166e', 'name': 'ctest-left_vn-87362083', 'tenant_id': '5aec9403357b498fb9fcbe93a6846c8c', 'project_id': '5aec9403357b498fb9fcbe93a6846c8c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-95375600', 'ctest-left_vn-87362083'], 'port_security_enabled': True, 'description': ''}}
2026-03-26 03:17:13,309 - DEBUG - Response for create_subnet : {'subnet': {'id': '82efda78-f9e4-4179-8d75-bcbf91d3ddac', 'name': '', 'tenant_id': '5aec9403357b498fb9fcbe93a6846c8c', 'network_id': 'ab87506f-2b0c-4c52-bd7f-b6110cce166e', 'ip_version': 4, 'cidr': '132.95.100.128/26', 'allocation_pools': [{'start': '132.95.100.130', 'end': '132.95.100.190'}], 'gateway_ip': '132.95.100.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '132.95.100.130', 'tags': [], 'project_id': '5aec9403357b498fb9fcbe93a6846c8c'}}
2026-03-26 03:17:13,339 - INFO - Created VN ctest-left_vn-87362083
2026-03-26 03:17:13,351 - DEBUG - VN ctest-left_vn-87362083 UUID is ab87506f-2b0c-4c52-bd7f-b6110cce166e
2026-03-26 03:17:13,425 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:13,431 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:13,442 - DEBUG - Requesting: http://10.0.0.240:8082/project/5aec9403-357b-498f-b9fc-be93a6846c8c
2026-03-26 03:17:13,535 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/ab87506f-2b0c-4c52-bd7f-b6110cce166e
2026-03-26 03:17:13,548 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/ab87506f-2b0c-4c52-bd7f-b6110cce166e
2026-03-26 03:17:13,560 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/4d41c526-6973-4b6a-89a7-fc2911796aee
2026-03-26 03:17:13,569 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/4d41c526-6973-4b6a-89a7-fc2911796aee
2026-03-26 03:17:13,576 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/ae9057d9-86cf-468a-9aaa-49ce0b39ad39
2026-03-26 03:17:13,583 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-26 03:17:13,583 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/ab87506f-2b0c-4c52-bd7f-b6110cce166e
2026-03-26 03:17:13,592 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/4d41c526-6973-4b6a-89a7-fc2911796aee
2026-03-26 03:17:13,607 - INFO - Verified VN network id 19 for VN ab87506f-2b0c-4c52-bd7f-b6110cce166e
2026-03-26 03:17:13,607 - INFO - Verifications in API Server for VN ctest-left_vn-87362083 passed
2026-03-26 03:17:13,607 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/ab87506f-2b0c-4c52-bd7f-b6110cce166e
2026-03-26 03:17:13,618 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/4d41c526-6973-4b6a-89a7-fc2911796aee
2026-03-26 03:17:13,629 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/4d41c526-6973-4b6a-89a7-fc2911796aee
2026-03-26 03:17:13,638 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/ae9057d9-86cf-468a-9aaa-49ce0b39ad39
2026-03-26 03:17:13,652 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95375600:ctest-left_vn-87362083', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95375600', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12359936140735433810', 'uuid-lslong': '13654832779556165230'}, 'enable': 'true', 'created': '2026-03-26T03:17:13', 'last-modified': '2026-03-26T03:17:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.387006'}
2026-03-26 03:17:13,657 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-26 03:17:13,664 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95375600:ctest-left_vn-87362083', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95375600', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12359936140735433810', 'uuid-lslong': '13654832779556165230'}, 'enable': 'true', 'created': '2026-03-26T03:17:13', 'last-modified': '2026-03-26T03:17:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.395896'}
2026-03-26 03:17:13,671 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-26 03:17:13,677 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95375600:ctest-left_vn-87362083', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95375600', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12359936140735433810', 'uuid-lslong': '13654832779556165230'}, 'enable': 'true', 'created': '2026-03-26T03:17:13', 'last-modified': '2026-03-26T03:17:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.415602'}
2026-03-26 03:17:13,684 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-26 03:17:13,684 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-87362083 passed
2026-03-26 03:17:13,684 - DEBUG - ====Verifying policy data for ctest-left_vn-87362083 in API_Server ======
2026-03-26 03:17:13,684 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:13,693 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:13,706 - DEBUG - Requesting: http://10.0.0.240:8082/project/5aec9403-357b-498f-b9fc-be93a6846c8c
2026-03-26 03:17:13,803 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/ab87506f-2b0c-4c52-bd7f-b6110cce166e
2026-03-26 03:17:13,816 - DEBUG - =>VN ctest-left_vn-87362083 has no policy to be verified
2026-03-26 03:17:13,816 - DEBUG - Verifying the vn in opserver
2026-03-26 03:17:13,816 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95375600:ctest-left_vn-87362083 virtual network link through opserver 10.0.0.240
2026-03-26 03:17:13,816 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-03-26 03:17:13,830 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95375600:ctest-left_vn-87362083', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95375600:ctest-left_vn-87362083?flat'}
2026-03-26 03:17:13,830 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95375600:ctest-left_vn-87362083 virtual network link through opserver 10.0.0.22
2026-03-26 03:17:13,830 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-03-26 03:17:13,842 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95375600:ctest-left_vn-87362083', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95375600:ctest-left_vn-87362083?flat'}
2026-03-26 03:17:13,842 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95375600:ctest-left_vn-87362083 virtual network link through opserver 10.0.0.65
2026-03-26 03:17:13,842 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-26 03:17:13,855 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95375600:ctest-left_vn-87362083', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95375600:ctest-left_vn-87362083?flat'}
2026-03-26 03:17:13,855 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-95375600:ctest-left_vn-87362083 is found in opserver
2026-03-26 03:17:13,877 - DEBUG - Do not have enough data to verify VN in agent
2026-03-26 03:17:13,887 - DEBUG - VRF ids for VN ctest-left_vn-87362083: {}
2026-03-26 03:17:14,153 - DEBUG - Response for create_network : {'network': {'id': '7878aef8-ccfc-45d8-a25c-8adb9af5cfb2', 'name': 'ctest-right_vn-24608712', 'tenant_id': '5aec9403357b498fb9fcbe93a6846c8c', 'project_id': '5aec9403357b498fb9fcbe93a6846c8c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-95375600', 'ctest-right_vn-24608712'], 'port_security_enabled': True, 'description': ''}}
2026-03-26 03:17:14,396 - DEBUG - Response for create_subnet : {'subnet': {'id': '71bc330a-6c56-45ff-9d83-88067f82d8b0', 'name': '', 'tenant_id': '5aec9403357b498fb9fcbe93a6846c8c', 'network_id': '7878aef8-ccfc-45d8-a25c-8adb9af5cfb2', 'ip_version': 4, 'cidr': '150.136.156.0/26', 'allocation_pools': [{'start': '150.136.156.2', 'end': '150.136.156.62'}], 'gateway_ip': '150.136.156.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '150.136.156.2', 'tags': [], 'project_id': '5aec9403357b498fb9fcbe93a6846c8c'}}
2026-03-26 03:17:14,425 - INFO - Created VN ctest-right_vn-24608712
2026-03-26 03:17:14,442 - DEBUG - VN ctest-right_vn-24608712 UUID is 7878aef8-ccfc-45d8-a25c-8adb9af5cfb2
2026-03-26 03:17:14,528 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:14,535 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:14,549 - DEBUG - Requesting: http://10.0.0.240:8082/project/5aec9403-357b-498f-b9fc-be93a6846c8c
2026-03-26 03:17:14,646 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/7878aef8-ccfc-45d8-a25c-8adb9af5cfb2
2026-03-26 03:17:14,662 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/7878aef8-ccfc-45d8-a25c-8adb9af5cfb2
2026-03-26 03:17:14,672 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/a53eb096-f1a0-4ce2-9b88-b294a50b71f4
2026-03-26 03:17:14,683 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/a53eb096-f1a0-4ce2-9b88-b294a50b71f4
2026-03-26 03:17:14,691 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/8c2054b1-d625-4d9d-9442-a3c1f41932b0
2026-03-26 03:17:14,698 - DEBUG - Route Targets: ['target:64512:8000009']
2026-03-26 03:17:14,698 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/7878aef8-ccfc-45d8-a25c-8adb9af5cfb2
2026-03-26 03:17:14,708 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/a53eb096-f1a0-4ce2-9b88-b294a50b71f4
2026-03-26 03:17:14,724 - INFO - Verified VN network id 20 for VN 7878aef8-ccfc-45d8-a25c-8adb9af5cfb2
2026-03-26 03:17:14,724 - INFO - Verifications in API Server for VN ctest-right_vn-24608712 passed
2026-03-26 03:17:14,725 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/7878aef8-ccfc-45d8-a25c-8adb9af5cfb2
2026-03-26 03:17:14,735 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/a53eb096-f1a0-4ce2-9b88-b294a50b71f4
2026-03-26 03:17:14,743 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/a53eb096-f1a0-4ce2-9b88-b294a50b71f4
2026-03-26 03:17:14,750 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/8c2054b1-d625-4d9d-9442-a3c1f41932b0
2026-03-26 03:17:14,762 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95375600:ctest-right_vn-24608712', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95375600', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8680880665370838488', 'uuid-lslong': '11699378607803977650'}, 'enable': 'true', 'created': '2026-03-26T03:17:14', 'last-modified': '2026-03-26T03:17:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.418439'}
2026-03-26 03:17:14,770 - DEBUG - Route Targets: ['target:64512:8000009']
2026-03-26 03:17:14,778 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95375600:ctest-right_vn-24608712', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95375600', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8680880665370838488', 'uuid-lslong': '11699378607803977650'}, 'enable': 'true', 'created': '2026-03-26T03:17:14', 'last-modified': '2026-03-26T03:17:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.425750'}
2026-03-26 03:17:14,785 - DEBUG - Route Targets: ['target:64512:8000009']
2026-03-26 03:17:14,791 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95375600:ctest-right_vn-24608712', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95375600', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8680880665370838488', 'uuid-lslong': '11699378607803977650'}, 'enable': 'true', 'created': '2026-03-26T03:17:14', 'last-modified': '2026-03-26T03:17:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.445480'}
2026-03-26 03:17:14,797 - DEBUG - Route Targets: ['target:64512:8000009']
2026-03-26 03:17:14,797 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-24608712 passed
2026-03-26 03:17:14,798 - DEBUG - ====Verifying policy data for ctest-right_vn-24608712 in API_Server ======
2026-03-26 03:17:14,798 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:14,804 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:14,817 - DEBUG - Requesting: http://10.0.0.240:8082/project/5aec9403-357b-498f-b9fc-be93a6846c8c
2026-03-26 03:17:14,920 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/7878aef8-ccfc-45d8-a25c-8adb9af5cfb2
2026-03-26 03:17:14,933 - DEBUG - =>VN ctest-right_vn-24608712 has no policy to be verified
2026-03-26 03:17:14,933 - DEBUG - Verifying the vn in opserver
2026-03-26 03:17:14,933 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95375600:ctest-right_vn-24608712 virtual network link through opserver 10.0.0.240
2026-03-26 03:17:14,933 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-03-26 03:17:14,947 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95375600:ctest-right_vn-24608712', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95375600:ctest-right_vn-24608712?flat'}
2026-03-26 03:17:14,947 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95375600:ctest-right_vn-24608712 virtual network link through opserver 10.0.0.22
2026-03-26 03:17:14,947 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-03-26 03:17:14,962 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95375600:ctest-right_vn-24608712', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95375600:ctest-right_vn-24608712?flat'}
2026-03-26 03:17:14,962 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95375600:ctest-right_vn-24608712 virtual network link through opserver 10.0.0.65
2026-03-26 03:17:14,962 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-26 03:17:14,978 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95375600:ctest-right_vn-24608712', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95375600:ctest-right_vn-24608712?flat'}
2026-03-26 03:17:14,978 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-95375600:ctest-right_vn-24608712 is found in opserver
2026-03-26 03:17:15,000 - DEBUG - Do not have enough data to verify VN in agent
2026-03-26 03:17:15,010 - DEBUG - VRF ids for VN ctest-right_vn-24608712: {}
2026-03-26 03:17:15,340 - DEBUG - Response for create_network : {'network': {'id': '4f8b6410-81b4-4fb9-a214-63199e8e1e9b', 'name': 'ctest-trans_left_vn-77281165', 'tenant_id': '5aec9403357b498fb9fcbe93a6846c8c', 'project_id': '5aec9403357b498fb9fcbe93a6846c8c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-95375600', 'ctest-trans_left_vn-77281165'], 'port_security_enabled': True, 'description': ''}}
2026-03-26 03:17:15,603 - DEBUG - Response for create_subnet : {'subnet': {'id': '9b56a3ed-39b8-4c82-afbd-ab4d24b4ee91', 'name': '', 'tenant_id': '5aec9403357b498fb9fcbe93a6846c8c', 'network_id': '4f8b6410-81b4-4fb9-a214-63199e8e1e9b', 'ip_version': 4, 'cidr': '64.177.204.192/26', 'allocation_pools': [{'start': '64.177.204.194', 'end': '64.177.204.254'}], 'gateway_ip': '64.177.204.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '64.177.204.194', 'tags': [], 'project_id': '5aec9403357b498fb9fcbe93a6846c8c'}}
2026-03-26 03:17:15,626 - INFO - Created VN ctest-trans_left_vn-77281165
2026-03-26 03:17:15,638 - DEBUG - VN ctest-trans_left_vn-77281165 UUID is 4f8b6410-81b4-4fb9-a214-63199e8e1e9b
2026-03-26 03:17:15,723 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:15,731 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:15,745 - DEBUG - Requesting: http://10.0.0.240:8082/project/5aec9403-357b-498f-b9fc-be93a6846c8c
2026-03-26 03:17:15,841 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/4f8b6410-81b4-4fb9-a214-63199e8e1e9b
2026-03-26 03:17:15,858 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/4f8b6410-81b4-4fb9-a214-63199e8e1e9b
2026-03-26 03:17:15,867 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/3bfd0f27-cbc1-4b2d-a9ce-59cf9b050b06
2026-03-26 03:17:15,878 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/3bfd0f27-cbc1-4b2d-a9ce-59cf9b050b06
2026-03-26 03:17:15,885 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/b0ac858d-a49f-43e3-a245-33bfbbc16915
2026-03-26 03:17:15,892 - DEBUG - Route Targets: ['target:64512:8000010']
2026-03-26 03:17:15,892 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/4f8b6410-81b4-4fb9-a214-63199e8e1e9b
2026-03-26 03:17:15,901 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/3bfd0f27-cbc1-4b2d-a9ce-59cf9b050b06
2026-03-26 03:17:15,917 - INFO - Verified VN network id 21 for VN 4f8b6410-81b4-4fb9-a214-63199e8e1e9b
2026-03-26 03:17:15,918 - INFO - Verifications in API Server for VN ctest-trans_left_vn-77281165 passed
2026-03-26 03:17:15,918 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/4f8b6410-81b4-4fb9-a214-63199e8e1e9b
2026-03-26 03:17:15,927 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/3bfd0f27-cbc1-4b2d-a9ce-59cf9b050b06
2026-03-26 03:17:15,934 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/3bfd0f27-cbc1-4b2d-a9ce-59cf9b050b06
2026-03-26 03:17:15,941 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/b0ac858d-a49f-43e3-a245-33bfbbc16915
2026-03-26 03:17:15,952 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95375600:ctest-trans_left_vn-77281165', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95375600', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5731784972817420217', 'uuid-lslong': '11679068695363985051'}, 'enable': 'true', 'created': '2026-03-26T03:17:15', 'last-modified': '2026-03-26T03:17:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.411874'}
2026-03-26 03:17:15,958 - DEBUG - Route Targets: ['target:64512:8000010']
2026-03-26 03:17:15,963 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95375600:ctest-trans_left_vn-77281165', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95375600', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5731784972817420217', 'uuid-lslong': '11679068695363985051'}, 'enable': 'true', 'created': '2026-03-26T03:17:15', 'last-modified': '2026-03-26T03:17:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.424238'}
2026-03-26 03:17:15,969 - DEBUG - Route Targets: ['target:64512:8000010']
2026-03-26 03:17:15,976 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95375600:ctest-trans_left_vn-77281165', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95375600', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5731784972817420217', 'uuid-lslong': '11679068695363985051'}, 'enable': 'true', 'created': '2026-03-26T03:17:15', 'last-modified': '2026-03-26T03:17:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.435910'}
2026-03-26 03:17:15,982 - DEBUG - Route Targets: ['target:64512:8000010']
2026-03-26 03:17:15,982 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-77281165 passed
2026-03-26 03:17:15,983 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-77281165 in API_Server ======
2026-03-26 03:17:15,983 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:15,989 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:16,002 - DEBUG - Requesting: http://10.0.0.240:8082/project/5aec9403-357b-498f-b9fc-be93a6846c8c
2026-03-26 03:17:16,110 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/4f8b6410-81b4-4fb9-a214-63199e8e1e9b
2026-03-26 03:17:16,125 - DEBUG - =>VN ctest-trans_left_vn-77281165 has no policy to be verified
2026-03-26 03:17:16,125 - DEBUG - Verifying the vn in opserver
2026-03-26 03:17:16,125 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95375600:ctest-trans_left_vn-77281165 virtual network link through opserver 10.0.0.240
2026-03-26 03:17:16,125 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-03-26 03:17:16,139 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95375600:ctest-trans_left_vn-77281165', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95375600:ctest-trans_left_vn-77281165?flat'}
2026-03-26 03:17:16,139 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95375600:ctest-trans_left_vn-77281165 virtual network link through opserver 10.0.0.22
2026-03-26 03:17:16,139 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-03-26 03:17:16,161 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95375600:ctest-trans_left_vn-77281165', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95375600:ctest-trans_left_vn-77281165?flat'}
2026-03-26 03:17:16,161 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95375600:ctest-trans_left_vn-77281165 virtual network link through opserver 10.0.0.65
2026-03-26 03:17:16,161 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-26 03:17:16,176 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95375600:ctest-trans_left_vn-77281165', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95375600:ctest-trans_left_vn-77281165?flat'}
2026-03-26 03:17:16,176 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-95375600:ctest-trans_left_vn-77281165 is found in opserver
2026-03-26 03:17:16,202 - DEBUG - Do not have enough data to verify VN in agent
2026-03-26 03:17:16,213 - DEBUG - VRF ids for VN ctest-trans_left_vn-77281165: {}
2026-03-26 03:17:16,550 - DEBUG - Response for create_network : {'network': {'id': '874ec9d5-98c5-4973-8c1c-d022d8d6f732', 'name': 'ctest-trans_right_vn-61013700', 'tenant_id': '5aec9403357b498fb9fcbe93a6846c8c', 'project_id': '5aec9403357b498fb9fcbe93a6846c8c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-95375600', 'ctest-trans_right_vn-61013700'], 'port_security_enabled': True, 'description': ''}}
2026-03-26 03:17:16,737 - DEBUG - Response for create_subnet : {'subnet': {'id': '5300b2b0-007b-4c07-b995-521e2e869b3d', 'name': '', 'tenant_id': '5aec9403357b498fb9fcbe93a6846c8c', 'network_id': '874ec9d5-98c5-4973-8c1c-d022d8d6f732', 'ip_version': 4, 'cidr': '77.215.19.192/26', 'allocation_pools': [{'start': '77.215.19.194', 'end': '77.215.19.254'}], 'gateway_ip': '77.215.19.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '77.215.19.194', 'tags': [], 'project_id': '5aec9403357b498fb9fcbe93a6846c8c'}}
2026-03-26 03:17:16,760 - INFO - Created VN ctest-trans_right_vn-61013700
2026-03-26 03:17:16,771 - DEBUG - VN ctest-trans_right_vn-61013700 UUID is 874ec9d5-98c5-4973-8c1c-d022d8d6f732
2026-03-26 03:17:16,849 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:16,854 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:16,867 - DEBUG - Requesting: http://10.0.0.240:8082/project/5aec9403-357b-498f-b9fc-be93a6846c8c
2026-03-26 03:17:16,981 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/874ec9d5-98c5-4973-8c1c-d022d8d6f732
2026-03-26 03:17:16,997 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/874ec9d5-98c5-4973-8c1c-d022d8d6f732
2026-03-26 03:17:17,008 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/69045a9d-c83a-4cc6-968a-0699f2640c5f
2026-03-26 03:17:17,020 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/69045a9d-c83a-4cc6-968a-0699f2640c5f
2026-03-26 03:17:17,028 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/ac7f28d1-3f30-4f44-966f-bc3dbc0602ac
2026-03-26 03:17:17,035 - DEBUG - Route Targets: ['target:64512:8000011']
2026-03-26 03:17:17,035 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/874ec9d5-98c5-4973-8c1c-d022d8d6f732
2026-03-26 03:17:17,045 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/69045a9d-c83a-4cc6-968a-0699f2640c5f
2026-03-26 03:17:17,061 - INFO - Verified VN network id 22 for VN 874ec9d5-98c5-4973-8c1c-d022d8d6f732
2026-03-26 03:17:17,061 - INFO - Verifications in API Server for VN ctest-trans_right_vn-61013700 passed
2026-03-26 03:17:17,061 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/874ec9d5-98c5-4973-8c1c-d022d8d6f732
2026-03-26 03:17:17,071 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/69045a9d-c83a-4cc6-968a-0699f2640c5f
2026-03-26 03:17:17,077 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/69045a9d-c83a-4cc6-968a-0699f2640c5f
2026-03-26 03:17:17,085 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/ac7f28d1-3f30-4f44-966f-bc3dbc0602ac
2026-03-26 03:17:17,096 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95375600:ctest-trans_right_vn-61013700', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95375600', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9749952162531985779', 'uuid-lslong': '10096173312743241522'}, 'enable': 'true', 'created': '2026-03-26T03:17:16', 'last-modified': '2026-03-26T03:17:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.415330'}
2026-03-26 03:17:17,103 - DEBUG - Route Targets: ['target:64512:8000011']
2026-03-26 03:17:17,109 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95375600:ctest-trans_right_vn-61013700', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95375600', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9749952162531985779', 'uuid-lslong': '10096173312743241522'}, 'enable': 'true', 'created': '2026-03-26T03:17:16', 'last-modified': '2026-03-26T03:17:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.420531'}
2026-03-26 03:17:17,115 - DEBUG - Route Targets: ['target:64512:8000011']
2026-03-26 03:17:17,121 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95375600:ctest-trans_right_vn-61013700', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95375600', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9749952162531985779', 'uuid-lslong': '10096173312743241522'}, 'enable': 'true', 'created': '2026-03-26T03:17:16', 'last-modified': '2026-03-26T03:17:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.439855'}
2026-03-26 03:17:17,127 - DEBUG - Route Targets: ['target:64512:8000011']
2026-03-26 03:17:17,127 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-61013700 passed
2026-03-26 03:17:17,127 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-61013700 in API_Server ======
2026-03-26 03:17:17,127 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:17,133 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:17,145 - DEBUG - Requesting: http://10.0.0.240:8082/project/5aec9403-357b-498f-b9fc-be93a6846c8c
2026-03-26 03:17:17,243 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/874ec9d5-98c5-4973-8c1c-d022d8d6f732
2026-03-26 03:17:17,253 - DEBUG - =>VN ctest-trans_right_vn-61013700 has no policy to be verified
2026-03-26 03:17:17,253 - DEBUG - Verifying the vn in opserver
2026-03-26 03:17:17,253 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95375600:ctest-trans_right_vn-61013700 virtual network link through opserver 10.0.0.240
2026-03-26 03:17:17,253 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-03-26 03:17:17,266 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95375600:ctest-trans_right_vn-61013700', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95375600:ctest-trans_right_vn-61013700?flat'}
2026-03-26 03:17:17,266 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95375600:ctest-trans_right_vn-61013700 virtual network link through opserver 10.0.0.22
2026-03-26 03:17:17,266 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-03-26 03:17:17,280 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95375600:ctest-trans_right_vn-61013700', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95375600:ctest-trans_right_vn-61013700?flat'}
2026-03-26 03:17:17,280 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95375600:ctest-trans_right_vn-61013700 virtual network link through opserver 10.0.0.65
2026-03-26 03:17:17,280 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-26 03:17:17,292 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95375600:ctest-trans_right_vn-61013700', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95375600:ctest-trans_right_vn-61013700?flat'}
2026-03-26 03:17:17,292 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-95375600:ctest-trans_right_vn-61013700 is found in opserver
2026-03-26 03:17:17,312 - DEBUG - Do not have enough data to verify VN in agent
2026-03-26 03:17:17,323 - DEBUG - VRF ids for VN ctest-trans_right_vn-61013700: {}
2026-03-26 03:17:18,749 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5545-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5545-2)
2026-03-26 03:17:20,232 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5545-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5545-1)
2026-03-26 03:17:20,232 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-88721147']
2026-03-26 03:17:20,527 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-88721147'] created succesfully
2026-03-26 03:17:20,962 - DEBUG - Image by name tiny_trans_fw not found
2026-03-26 03:17:20,962 - DEBUG - Installing image tiny_trans_fw
2026-03-26 03:17:20,962 - 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-03-26 03:17:20,963 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-03-26 03:17:20,963 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-03-26 03:17:20,984 - 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-03-26 03:17:21,038 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-03-26 03:17:21,038 - DEBUG - Unzip image
2026-03-26 03:17:21,038 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-03-26 03:17:21,061 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-03-26 03:17:21,066 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-88721147']
2026-03-26 03:17:21,167 - INFO - Service template: ['default-domain', 'ctest-service_template_1-88721147'] deleted successfully.
2026-03-26 03:17:21,167 - INFO - Skip interface_detach for VM ctest-right_vm-40040628 in state BUILD
2026-03-26 03:17:21,167 - INFO - Deleting VM ctest-right_vm-40040628
2026-03-26 03:17:21,167 - ERROR - VM ctest-right_vm-40040628 has failed to come up
2026-03-26 03:17:21,167 - ERROR - Nova failed to get host of the VM
2026-03-26 03:17:21,168 - ERROR - VM ctest-right_vm-40040628 has failed to come up
2026-03-26 03:17:21,168 - ERROR - Nova failed to get host of the VM
2026-03-26 03:17:21,260 - INFO - Skip interface_detach for VM ctest-left_vm-52540938 in state BUILD
2026-03-26 03:17:21,261 - INFO - Deleting VM ctest-left_vm-52540938
2026-03-26 03:17:21,261 - ERROR - VM ctest-left_vm-52540938 has failed to come up
2026-03-26 03:17:21,261 - ERROR - Nova failed to get host of the VM
2026-03-26 03:17:21,261 - ERROR - VM ctest-left_vm-52540938 has failed to come up
2026-03-26 03:17:21,261 - ERROR - Nova failed to get host of the VM
2026-03-26 03:17:21,341 - INFO - Deleting VN ctest-trans_right_vn-61013700
2026-03-26 03:17:21,498 - DEBUG - Response for deleting network ()
2026-03-26 03:17:21,498 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/69045a9d-c83a-4cc6-968a-0699f2640c5f
2026-03-26 03:17:21,510 - DEBUG - Response Code: 404
2026-03-26 03:17:21,510 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:21,529 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:21,545 - DEBUG - Requesting: http://10.0.0.240:8082/project/5aec9403-357b-498f-b9fc-be93a6846c8c
2026-03-26 03:17:21,646 - INFO - Validated that VN ctest-trans_right_vn-61013700 is not found in API Server
2026-03-26 03:17:21,660 - DEBUG - VN ctest-trans_right_vn-61013700 is not present in Agent 10.0.0.38
2026-03-26 03:17:21,670 - DEBUG - VN ctest-trans_right_vn-61013700 is not present in Agent 10.0.0.23
2026-03-26 03:17:21,670 - INFO - Validated that VN ctest-trans_right_vn-61013700 is not in any agent
2026-03-26 03:17:21,701 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-61013700 info
2026-03-26 03:17:21,701 - INFO - Deleting VN ctest-trans_left_vn-77281165
2026-03-26 03:17:21,834 - DEBUG - Response for deleting network ()
2026-03-26 03:17:21,834 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/3bfd0f27-cbc1-4b2d-a9ce-59cf9b050b06
2026-03-26 03:17:21,840 - DEBUG - Response Code: 404
2026-03-26 03:17:21,840 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:21,846 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:21,866 - DEBUG - Requesting: http://10.0.0.240:8082/project/5aec9403-357b-498f-b9fc-be93a6846c8c
2026-03-26 03:17:21,981 - INFO - Validated that VN ctest-trans_left_vn-77281165 is not found in API Server
2026-03-26 03:17:21,994 - DEBUG - VN ctest-trans_left_vn-77281165 is not present in Agent 10.0.0.38
2026-03-26 03:17:22,022 - DEBUG - VN ctest-trans_left_vn-77281165 is not present in Agent 10.0.0.23
2026-03-26 03:17:22,022 - INFO - Validated that VN ctest-trans_left_vn-77281165 is not in any agent
2026-03-26 03:17:22,105 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-77281165 info
2026-03-26 03:17:22,105 - INFO - Deleting VN ctest-right_vn-24608712
2026-03-26 03:17:22,192 - DEBUG - VN 7878aef8-ccfc-45d8-a25c-8adb9af5cfb2 still in use: Unable to complete operation on network 7878aef8-ccfc-45d8-a25c-8adb9af5cfb2. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-6b266a86-e4e6-4c12-8d52-35f32baeb9d2']
2026-03-26 03:17:22,193 - WARNING - Deleting VN ctest-right_vn-24608712 failed..Will retry
2026-03-26 03:17:24,336 - DEBUG - Response for deleting network ()
2026-03-26 03:17:24,336 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/a53eb096-f1a0-4ce2-9b88-b294a50b71f4
2026-03-26 03:17:24,342 - DEBUG - Response Code: 404
2026-03-26 03:17:24,342 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:24,348 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:24,406 - DEBUG - Requesting: http://10.0.0.240:8082/project/5aec9403-357b-498f-b9fc-be93a6846c8c
2026-03-26 03:17:24,507 - INFO - Validated that VN ctest-right_vn-24608712 is not found in API Server
2026-03-26 03:17:24,518 - DEBUG - VN ctest-right_vn-24608712 is not present in Agent 10.0.0.38
2026-03-26 03:17:24,531 - DEBUG - VN ctest-right_vn-24608712 is not present in Agent 10.0.0.23
2026-03-26 03:17:24,531 - INFO - Validated that VN ctest-right_vn-24608712 is not in any agent
2026-03-26 03:17:24,562 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-24608712 info
2026-03-26 03:17:24,562 - INFO - Deleting VN ctest-left_vn-87362083
2026-03-26 03:17:24,740 - DEBUG - Response for deleting network ()
2026-03-26 03:17:24,740 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/4d41c526-6973-4b6a-89a7-fc2911796aee
2026-03-26 03:17:24,746 - DEBUG - Response Code: 404
2026-03-26 03:17:24,747 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:24,759 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:24,771 - DEBUG - Requesting: http://10.0.0.240:8082/project/5aec9403-357b-498f-b9fc-be93a6846c8c
2026-03-26 03:17:24,866 - INFO - Validated that VN ctest-left_vn-87362083 is not found in API Server
2026-03-26 03:17:24,880 - DEBUG - VN ctest-left_vn-87362083 is not present in Agent 10.0.0.38
2026-03-26 03:17:24,891 - DEBUG - VN ctest-left_vn-87362083 is not present in Agent 10.0.0.23
2026-03-26 03:17:24,891 - INFO - Validated that VN ctest-left_vn-87362083 is not in any agent
2026-03-26 03:17:24,924 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-87362083 info
2026-03-26 03:17:24,925 - INFO - Deleting VN ctest-mgmt_vn-24991196
2026-03-26 03:17:25,084 - DEBUG - Response for deleting network ()
2026-03-26 03:17:25,085 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/4ae8c2a7-1b4a-4374-a9b5-6570304723a8
2026-03-26 03:17:25,091 - DEBUG - Response Code: 404
2026-03-26 03:17:25,092 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:25,104 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:25,121 - DEBUG - Requesting: http://10.0.0.240:8082/project/5aec9403-357b-498f-b9fc-be93a6846c8c
2026-03-26 03:17:25,219 - INFO - Validated that VN ctest-mgmt_vn-24991196 is not found in API Server
2026-03-26 03:17:25,231 - DEBUG - VN ctest-mgmt_vn-24991196 is not present in Agent 10.0.0.38
2026-03-26 03:17:25,242 - DEBUG - VN ctest-mgmt_vn-24991196 is not present in Agent 10.0.0.23
2026-03-26 03:17:25,242 - INFO - Validated that VN ctest-mgmt_vn-24991196 is not in any agent
2026-03-26 03:17:25,275 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-24991196 info
2026-03-26 03:17:26,569 - DEBUG - No XMPP flaps were noticed during the test
2026-03-26 03:17:26,569 - INFO -
2026-03-26 03:17:26,569 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:16]
2026-03-26 03:17:26,569 - INFO - --------------------------------------------------------------------------------
2026-03-26 03:17:27,366 - INFO - Deleted project: ctest-TestSvcRegr-95375600, ID : 5aec9403-357b-498f-b9fc-be93a6846c8c
2026-03-26 03:17:27,591 - INFO - Domain Default found not creating
2026-03-26 03:17:27,821 - INFO - Project ctest-TestSvcRegr-49210623 not found, creating it
2026-03-26 03:17:28,370 - INFO - Created Project:ctest-TestSvcRegr-49210623, ID : 423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b
2026-03-26 03:17:30,119 - INFO - ================================================================================
2026-03-26 03:17:30,120 - INFO - STARTING TEST : test_svc_CEM_22032
2026-03-26 03:17:31,384 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.18': '0', '10.20.0.14': '0'}, '10.0.0.23': {'10.20.0.254': '0', '10.20.0.18': '0'}} with
2026-03-26 03:17:31,384 - INFO - Initial checks done. Running the testcase now
2026-03-26 03:17:31,388 - INFO -
2026-03-26 03:17:32,168 - DEBUG - Response for create_network : {'network': {'id': '7b3fbcdc-5203-4422-acb6-afd813118d88', 'name': 'ctest-mgmt_vn-75685918', 'tenant_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b', 'project_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-49210623', 'ctest-mgmt_vn-75685918'], 'port_security_enabled': True, 'description': ''}}
2026-03-26 03:17:32,533 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f82c77d4-1ee8-4675-8f2d-3f7fafc6e07d', 'name': '', 'tenant_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b', 'network_id': '7b3fbcdc-5203-4422-acb6-afd813118d88', 'ip_version': 4, 'cidr': '223.229.180.0/26', 'allocation_pools': [{'start': '223.229.180.2', 'end': '223.229.180.62'}], 'gateway_ip': '223.229.180.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '223.229.180.2', 'tags': [], 'project_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b'}}
2026-03-26 03:17:32,556 - INFO - Created VN ctest-mgmt_vn-75685918
2026-03-26 03:17:32,568 - DEBUG - VN ctest-mgmt_vn-75685918 UUID is 7b3fbcdc-5203-4422-acb6-afd813118d88
2026-03-26 03:17:32,648 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:33,002 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:33,037 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:33,053 - DEBUG - Requesting: http://10.0.0.240:8082/project/423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b
2026-03-26 03:17:33,144 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/7b3fbcdc-5203-4422-acb6-afd813118d88
2026-03-26 03:17:33,156 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/7b3fbcdc-5203-4422-acb6-afd813118d88
2026-03-26 03:17:33,165 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/0b8b94cd-6deb-4490-8e39-7ca609895bf9
2026-03-26 03:17:33,173 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/0b8b94cd-6deb-4490-8e39-7ca609895bf9
2026-03-26 03:17:33,180 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/ed0fba8e-d09c-4815-8feb-077623b5fb46
2026-03-26 03:17:33,187 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-26 03:17:33,187 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/7b3fbcdc-5203-4422-acb6-afd813118d88
2026-03-26 03:17:33,196 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/0b8b94cd-6deb-4490-8e39-7ca609895bf9
2026-03-26 03:17:33,212 - INFO - Verified VN network id 18 for VN 7b3fbcdc-5203-4422-acb6-afd813118d88
2026-03-26 03:17:33,212 - INFO - Verifications in API Server for VN ctest-mgmt_vn-75685918 passed
2026-03-26 03:17:33,212 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/7b3fbcdc-5203-4422-acb6-afd813118d88
2026-03-26 03:17:33,222 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/0b8b94cd-6deb-4490-8e39-7ca609895bf9
2026-03-26 03:17:33,229 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/0b8b94cd-6deb-4490-8e39-7ca609895bf9
2026-03-26 03:17:33,237 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/ed0fba8e-d09c-4815-8feb-077623b5fb46
2026-03-26 03:17:33,248 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-75685918', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-49210623', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8881024644652680226', 'uuid-lslong': '12445327962852658568'}, 'enable': 'true', 'created': '2026-03-26T03:17:32', 'last-modified': '2026-03-26T03:17:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.794225'}
2026-03-26 03:17:33,254 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-26 03:17:33,259 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-75685918', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-49210623', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8881024644652680226', 'uuid-lslong': '12445327962852658568'}, 'enable': 'true', 'created': '2026-03-26T03:17:32', 'last-modified': '2026-03-26T03:17:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.803313'}
2026-03-26 03:17:33,265 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-26 03:17:33,272 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-75685918', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-49210623', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8881024644652680226', 'uuid-lslong': '12445327962852658568'}, 'enable': 'true', 'created': '2026-03-26T03:17:32', 'last-modified': '2026-03-26T03:17:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.816691'}
2026-03-26 03:17:33,279 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-26 03:17:33,279 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-75685918 passed
2026-03-26 03:17:33,279 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-75685918 in API_Server ======
2026-03-26 03:17:33,279 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:33,286 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:33,298 - DEBUG - Requesting: http://10.0.0.240:8082/project/423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b
2026-03-26 03:17:33,407 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/7b3fbcdc-5203-4422-acb6-afd813118d88
2026-03-26 03:17:33,417 - DEBUG - =>VN ctest-mgmt_vn-75685918 has no policy to be verified
2026-03-26 03:17:33,417 - DEBUG - Verifying the vn in opserver
2026-03-26 03:17:33,417 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-75685918 virtual network link through opserver 10.0.0.240
2026-03-26 03:17:33,417 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-03-26 03:17:33,771 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-03-26 03:17:33,861 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-75685918', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-75685918?flat'}
2026-03-26 03:17:33,861 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-75685918 virtual network link through opserver 10.0.0.22
2026-03-26 03:17:33,861 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-03-26 03:17:34,204 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-03-26 03:17:34,286 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-75685918', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-75685918?flat'}
2026-03-26 03:17:34,287 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-75685918 virtual network link through opserver 10.0.0.65
2026-03-26 03:17:34,287 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-26 03:17:34,624 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-26 03:17:34,695 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-75685918', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-75685918?flat'}
2026-03-26 03:17:34,695 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-75685918 is found in opserver
2026-03-26 03:17:34,720 - DEBUG - Do not have enough data to verify VN in agent
2026-03-26 03:17:34,730 - DEBUG - VRF ids for VN ctest-mgmt_vn-75685918: {}
2026-03-26 03:17:35,072 - DEBUG - Response for create_network : {'network': {'id': 'd4e5665b-7102-48d8-b191-6b8e3498242d', 'name': 'service-left-vn-23896024', 'tenant_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b', 'project_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-49210623', 'service-left-vn-23896024'], 'port_security_enabled': True, 'description': ''}}
2026-03-26 03:17:35,351 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c2bf641c-e0dd-49bf-a76f-d0194d8f644d', 'name': '', 'tenant_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b', 'network_id': 'd4e5665b-7102-48d8-b191-6b8e3498242d', 'ip_version': 4, 'cidr': '194.64.234.0/26', 'allocation_pools': [{'start': '194.64.234.2', 'end': '194.64.234.62'}], 'gateway_ip': '194.64.234.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '194.64.234.2', 'tags': [], 'project_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b'}}
2026-03-26 03:17:35,375 - INFO - Created VN service-left-vn-23896024
2026-03-26 03:17:35,386 - DEBUG - VN service-left-vn-23896024 UUID is d4e5665b-7102-48d8-b191-6b8e3498242d
2026-03-26 03:17:35,460 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:35,467 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:35,483 - DEBUG - Requesting: http://10.0.0.240:8082/project/423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b
2026-03-26 03:17:35,604 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/d4e5665b-7102-48d8-b191-6b8e3498242d
2026-03-26 03:17:35,632 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/d4e5665b-7102-48d8-b191-6b8e3498242d
2026-03-26 03:17:35,645 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/7c9c40d1-039d-46a7-9871-6df4c9028de0
2026-03-26 03:17:35,663 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/7c9c40d1-039d-46a7-9871-6df4c9028de0
2026-03-26 03:17:35,671 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/3e68cca2-27e1-45d9-8a44-fe416ce466c9
2026-03-26 03:17:35,684 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-26 03:17:35,684 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/d4e5665b-7102-48d8-b191-6b8e3498242d
2026-03-26 03:17:35,701 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/7c9c40d1-039d-46a7-9871-6df4c9028de0
2026-03-26 03:17:35,726 - INFO - Verified VN network id 19 for VN d4e5665b-7102-48d8-b191-6b8e3498242d
2026-03-26 03:17:35,727 - INFO - Verifications in API Server for VN service-left-vn-23896024 passed
2026-03-26 03:17:35,728 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/d4e5665b-7102-48d8-b191-6b8e3498242d
2026-03-26 03:17:35,748 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/7c9c40d1-039d-46a7-9871-6df4c9028de0
2026-03-26 03:17:35,756 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/7c9c40d1-039d-46a7-9871-6df4c9028de0
2026-03-26 03:17:35,763 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/3e68cca2-27e1-45d9-8a44-fe416ce466c9
2026-03-26 03:17:35,781 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-49210623:service-left-vn-23896024', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-49210623', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15340780248631494872', 'uuid-lslong': '12795126274848203821'}, 'enable': 'true', 'created': '2026-03-26T03:17:34', 'last-modified': '2026-03-26T03:17:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.506505'}
2026-03-26 03:17:35,787 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-26 03:17:35,793 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-49210623:service-left-vn-23896024', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-49210623', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15340780248631494872', 'uuid-lslong': '12795126274848203821'}, 'enable': 'true', 'created': '2026-03-26T03:17:34', 'last-modified': '2026-03-26T03:17:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.519449'}
2026-03-26 03:17:35,799 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-26 03:17:35,808 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-49210623:service-left-vn-23896024', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-49210623', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15340780248631494872', 'uuid-lslong': '12795126274848203821'}, 'enable': 'true', 'created': '2026-03-26T03:17:34', 'last-modified': '2026-03-26T03:17:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.534873'}
2026-03-26 03:17:35,815 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-26 03:17:35,815 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-23896024 passed
2026-03-26 03:17:35,816 - DEBUG - ====Verifying policy data for service-left-vn-23896024 in API_Server ======
2026-03-26 03:17:35,816 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:35,832 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:35,848 - DEBUG - Requesting: http://10.0.0.240:8082/project/423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b
2026-03-26 03:17:35,950 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/d4e5665b-7102-48d8-b191-6b8e3498242d
2026-03-26 03:17:35,959 - DEBUG - =>VN service-left-vn-23896024 has no policy to be verified
2026-03-26 03:17:35,959 - DEBUG - Verifying the vn in opserver
2026-03-26 03:17:35,959 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-49210623:service-left-vn-23896024 virtual network link through opserver 10.0.0.240
2026-03-26 03:17:35,959 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-03-26 03:17:36,039 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-49210623:service-left-vn-23896024', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-49210623:service-left-vn-23896024?flat'}
2026-03-26 03:17:36,039 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-49210623:service-left-vn-23896024 virtual network link through opserver 10.0.0.22
2026-03-26 03:17:36,039 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-03-26 03:17:36,114 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-49210623:service-left-vn-23896024', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-49210623:service-left-vn-23896024?flat'}
2026-03-26 03:17:36,114 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-49210623:service-left-vn-23896024 virtual network link through opserver 10.0.0.65
2026-03-26 03:17:36,114 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-26 03:17:36,176 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-49210623:service-left-vn-23896024', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-49210623:service-left-vn-23896024?flat'}
2026-03-26 03:17:36,176 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-49210623:service-left-vn-23896024 is found in opserver
2026-03-26 03:17:36,197 - DEBUG - Do not have enough data to verify VN in agent
2026-03-26 03:17:36,207 - DEBUG - VRF ids for VN service-left-vn-23896024: {}
2026-03-26 03:17:36,539 - DEBUG - Response for create_network : {'network': {'id': '23a6d5d3-fe22-4a30-beeb-6aff20cd6db0', 'name': 'service-right-vn-68364268', 'tenant_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b', 'project_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-49210623', 'service-right-vn-68364268'], 'port_security_enabled': True, 'description': ''}}
2026-03-26 03:17:36,842 - DEBUG - Response for create_subnet : {'subnet': {'id': '055a1743-159f-431e-bd35-c302114f672e', 'name': '', 'tenant_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b', 'network_id': '23a6d5d3-fe22-4a30-beeb-6aff20cd6db0', 'ip_version': 4, 'cidr': '213.54.8.0/26', 'allocation_pools': [{'start': '213.54.8.2', 'end': '213.54.8.62'}], 'gateway_ip': '213.54.8.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '213.54.8.2', 'tags': [], 'project_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b'}}
2026-03-26 03:17:36,868 - INFO - Created VN service-right-vn-68364268
2026-03-26 03:17:36,884 - DEBUG - VN service-right-vn-68364268 UUID is 23a6d5d3-fe22-4a30-beeb-6aff20cd6db0
2026-03-26 03:17:36,969 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:36,977 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:37,001 - DEBUG - Requesting: http://10.0.0.240:8082/project/423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b
2026-03-26 03:17:37,118 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/23a6d5d3-fe22-4a30-beeb-6aff20cd6db0
2026-03-26 03:17:37,139 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/23a6d5d3-fe22-4a30-beeb-6aff20cd6db0
2026-03-26 03:17:37,152 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e2be4900-2e52-4f1c-be8f-8b1ce4319faa
2026-03-26 03:17:37,161 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e2be4900-2e52-4f1c-be8f-8b1ce4319faa
2026-03-26 03:17:37,169 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/b64683b0-e7a9-4971-b6f8-04e6b3ac97dc
2026-03-26 03:17:37,178 - DEBUG - Route Targets: ['target:64512:8000009']
2026-03-26 03:17:37,178 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/23a6d5d3-fe22-4a30-beeb-6aff20cd6db0
2026-03-26 03:17:37,190 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e2be4900-2e52-4f1c-be8f-8b1ce4319faa
2026-03-26 03:17:37,222 - INFO - Verified VN network id 20 for VN 23a6d5d3-fe22-4a30-beeb-6aff20cd6db0
2026-03-26 03:17:37,222 - INFO - Verifications in API Server for VN service-right-vn-68364268 passed
2026-03-26 03:17:37,222 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/23a6d5d3-fe22-4a30-beeb-6aff20cd6db0
2026-03-26 03:17:37,240 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e2be4900-2e52-4f1c-be8f-8b1ce4319faa
2026-03-26 03:17:37,249 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e2be4900-2e52-4f1c-be8f-8b1ce4319faa
2026-03-26 03:17:37,261 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/b64683b0-e7a9-4971-b6f8-04e6b3ac97dc
2026-03-26 03:17:37,291 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-49210623:service-right-vn-68364268', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-49210623', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2568975743939922480', 'uuid-lslong': '13757207130732850608'}, 'enable': 'true', 'created': '2026-03-26T03:17:36', 'last-modified': '2026-03-26T03:17:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.533785'}
2026-03-26 03:17:37,301 - DEBUG - Route Targets: ['target:64512:8000009']
2026-03-26 03:17:37,307 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-49210623:service-right-vn-68364268', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-49210623', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2568975743939922480', 'uuid-lslong': '13757207130732850608'}, 'enable': 'true', 'created': '2026-03-26T03:17:36', 'last-modified': '2026-03-26T03:17:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.548509'}
2026-03-26 03:17:37,315 - DEBUG - Route Targets: ['target:64512:8000009']
2026-03-26 03:17:37,323 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-49210623:service-right-vn-68364268', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-49210623', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2568975743939922480', 'uuid-lslong': '13757207130732850608'}, 'enable': 'true', 'created': '2026-03-26T03:17:36', 'last-modified': '2026-03-26T03:17:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.559613'}
2026-03-26 03:17:37,334 - DEBUG - Route Targets: ['target:64512:8000009']
2026-03-26 03:17:37,334 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-68364268 passed
2026-03-26 03:17:37,334 - DEBUG - ====Verifying policy data for service-right-vn-68364268 in API_Server ======
2026-03-26 03:17:37,335 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:37,342 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:37,355 - DEBUG - Requesting: http://10.0.0.240:8082/project/423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b
2026-03-26 03:17:37,445 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/23a6d5d3-fe22-4a30-beeb-6aff20cd6db0
2026-03-26 03:17:37,463 - DEBUG - =>VN service-right-vn-68364268 has no policy to be verified
2026-03-26 03:17:37,463 - DEBUG - Verifying the vn in opserver
2026-03-26 03:17:37,463 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-49210623:service-right-vn-68364268 virtual network link through opserver 10.0.0.240
2026-03-26 03:17:37,463 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-03-26 03:17:37,545 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-49210623:service-right-vn-68364268', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-49210623:service-right-vn-68364268?flat'}
2026-03-26 03:17:37,545 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-49210623:service-right-vn-68364268 virtual network link through opserver 10.0.0.22
2026-03-26 03:17:37,545 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-03-26 03:17:37,647 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-49210623:service-right-vn-68364268', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-49210623:service-right-vn-68364268?flat'}
2026-03-26 03:17:37,647 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-49210623:service-right-vn-68364268 virtual network link through opserver 10.0.0.65
2026-03-26 03:17:37,647 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-26 03:17:37,727 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-49210623:service-right-vn-68364268', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-49210623:service-right-vn-68364268?flat'}
2026-03-26 03:17:37,727 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-49210623:service-right-vn-68364268 is found in opserver
2026-03-26 03:17:37,751 - DEBUG - Do not have enough data to verify VN in agent
2026-03-26 03:17:37,762 - DEBUG - VRF ids for VN service-right-vn-68364268: {}
2026-03-26 03:17:37,934 - DEBUG - Services list from nova: [, , , ]
2026-03-26 03:17:39,268 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5545-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5545-2)
2026-03-26 03:17:40,895 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5545-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5545-1)
2026-03-26 03:17:40,895 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-63928420']
2026-03-26 03:17:41,198 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-63928420'] created succesfully
2026-03-26 03:17:41,653 - DEBUG - Image by name tiny_nat_fw not found
2026-03-26 03:17:41,653 - DEBUG - Installing image tiny_nat_fw
2026-03-26 03:17:41,653 - 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-03-26 03:17:41,654 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-26 03:17:41,654 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-26 03:17:41,654 - DEBUG - Unzip image
2026-03-26 03:17:41,654 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-26 03:17:41,704 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-03-26 03:17:41,704 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-63928420']
2026-03-26 03:17:41,815 - INFO - Service template: ['default-domain', 'ctest-service_template_1-63928420'] deleted successfully.
2026-03-26 03:17:41,815 - INFO - Skip interface_detach for VM ctest-right_vm-92588365 in state BUILD
2026-03-26 03:17:41,815 - INFO - Deleting VM ctest-right_vm-92588365
2026-03-26 03:17:41,862 - ERROR - VM ctest-right_vm-92588365 has failed to come up
2026-03-26 03:17:41,862 - ERROR - Nova failed to get host of the VM
2026-03-26 03:17:41,862 - ERROR - VM ctest-right_vm-92588365 has failed to come up
2026-03-26 03:17:41,862 - ERROR - Nova failed to get host of the VM
2026-03-26 03:17:41,948 - INFO - Skip interface_detach for VM ctest-left_vm-29068954 in state BUILD
2026-03-26 03:17:41,948 - INFO - Deleting VM ctest-left_vm-29068954
2026-03-26 03:17:41,948 - ERROR - VM ctest-left_vm-29068954 has failed to come up
2026-03-26 03:17:41,949 - ERROR - Nova failed to get host of the VM
2026-03-26 03:17:41,949 - ERROR - VM ctest-left_vm-29068954 has failed to come up
2026-03-26 03:17:41,949 - ERROR - Nova failed to get host of the VM
2026-03-26 03:17:42,057 - INFO - Deleting VN service-right-vn-68364268
2026-03-26 03:17:42,109 - DEBUG - VN 23a6d5d3-fe22-4a30-beeb-6aff20cd6db0 still in use: Unable to complete operation on network 23a6d5d3-fe22-4a30-beeb-6aff20cd6db0. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-d76b2b1e-f16f-462d-b08f-bdc9ec23d2db']
2026-03-26 03:17:42,109 - WARNING - Deleting VN service-right-vn-68364268 failed..Will retry
2026-03-26 03:17:44,292 - DEBUG - Response for deleting network ()
2026-03-26 03:17:44,292 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/e2be4900-2e52-4f1c-be8f-8b1ce4319faa
2026-03-26 03:17:44,301 - DEBUG - Response Code: 404
2026-03-26 03:17:44,302 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:44,307 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:44,364 - DEBUG - Requesting: http://10.0.0.240:8082/project/423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b
2026-03-26 03:17:44,460 - INFO - Validated that VN service-right-vn-68364268 is not found in API Server
2026-03-26 03:17:44,472 - DEBUG - VN service-right-vn-68364268 is not present in Agent 10.0.0.38
2026-03-26 03:17:44,484 - DEBUG - VN service-right-vn-68364268 is not present in Agent 10.0.0.23
2026-03-26 03:17:44,485 - INFO - Validated that VN service-right-vn-68364268 is not in any agent
2026-03-26 03:17:44,516 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-68364268 info
2026-03-26 03:17:44,516 - INFO - Deleting VN service-left-vn-23896024
2026-03-26 03:17:44,667 - DEBUG - Response for deleting network ()
2026-03-26 03:17:44,668 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/7c9c40d1-039d-46a7-9871-6df4c9028de0
2026-03-26 03:17:44,675 - DEBUG - Response Code: 404
2026-03-26 03:17:44,676 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:44,681 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:44,700 - DEBUG - Requesting: http://10.0.0.240:8082/project/423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b
2026-03-26 03:17:44,789 - INFO - Validated that VN service-left-vn-23896024 is not found in API Server
2026-03-26 03:17:44,802 - DEBUG - VN service-left-vn-23896024 is not present in Agent 10.0.0.38
2026-03-26 03:17:44,813 - DEBUG - VN service-left-vn-23896024 is not present in Agent 10.0.0.23
2026-03-26 03:17:44,813 - INFO - Validated that VN service-left-vn-23896024 is not in any agent
2026-03-26 03:17:44,845 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-23896024 info
2026-03-26 03:17:44,845 - INFO - Deleting VN ctest-mgmt_vn-75685918
2026-03-26 03:17:45,032 - DEBUG - Response for deleting network ()
2026-03-26 03:17:45,032 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/0b8b94cd-6deb-4490-8e39-7ca609895bf9
2026-03-26 03:17:45,038 - DEBUG - Response Code: 404
2026-03-26 03:17:45,038 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:45,044 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:45,056 - DEBUG - Requesting: http://10.0.0.240:8082/project/423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b
2026-03-26 03:17:45,139 - INFO - Validated that VN ctest-mgmt_vn-75685918 is not found in API Server
2026-03-26 03:17:45,151 - DEBUG - VN ctest-mgmt_vn-75685918 is not present in Agent 10.0.0.38
2026-03-26 03:17:45,162 - DEBUG - VN ctest-mgmt_vn-75685918 is not present in Agent 10.0.0.23
2026-03-26 03:17:45,162 - INFO - Validated that VN ctest-mgmt_vn-75685918 is not in any agent
2026-03-26 03:17:45,194 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-75685918 info
2026-03-26 03:17:46,486 - DEBUG - No XMPP flaps were noticed during the test
2026-03-26 03:17:46,486 - INFO -
2026-03-26 03:17:46,487 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:16]
2026-03-26 03:17:46,487 - INFO - --------------------------------------------------------------------------------
2026-03-26 03:17:46,490 - INFO - ================================================================================
2026-03-26 03:17:46,490 - INFO - STARTING TEST : test_svc_in_network_datapath
2026-03-26 03:17:47,775 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.18': '0', '10.20.0.14': '0'}, '10.0.0.23': {'10.20.0.254': '0', '10.20.0.18': '0'}} with
2026-03-26 03:17:47,775 - INFO - Initial checks done. Running the testcase now
2026-03-26 03:17:47,776 - INFO -
2026-03-26 03:17:48,049 - DEBUG - Response for create_network : {'network': {'id': '65d67722-d814-4f3d-8181-babaaa974847', 'name': 'ctest-mgmt_vn-74780744', 'tenant_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b', 'project_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-49210623', 'ctest-mgmt_vn-74780744'], 'port_security_enabled': True, 'description': ''}}
2026-03-26 03:17:48,249 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c192e2e2-96c0-425b-8a93-cd67da4fbfb1', 'name': '', 'tenant_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b', 'network_id': '65d67722-d814-4f3d-8181-babaaa974847', 'ip_version': 4, 'cidr': '180.136.228.128/26', 'allocation_pools': [{'start': '180.136.228.130', 'end': '180.136.228.190'}], 'gateway_ip': '180.136.228.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '180.136.228.130', 'tags': [], 'project_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b'}}
2026-03-26 03:17:48,273 - INFO - Created VN ctest-mgmt_vn-74780744
2026-03-26 03:17:48,284 - DEBUG - VN ctest-mgmt_vn-74780744 UUID is 65d67722-d814-4f3d-8181-babaaa974847
2026-03-26 03:17:48,362 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:48,369 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:48,381 - DEBUG - Requesting: http://10.0.0.240:8082/project/423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b
2026-03-26 03:17:48,473 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/65d67722-d814-4f3d-8181-babaaa974847
2026-03-26 03:17:48,489 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/65d67722-d814-4f3d-8181-babaaa974847
2026-03-26 03:17:48,499 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/c5334438-2ce6-4c11-bfe4-0d5b522fa079
2026-03-26 03:17:48,506 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/c5334438-2ce6-4c11-bfe4-0d5b522fa079
2026-03-26 03:17:48,513 - DEBUG - Route Targets: []
2026-03-26 03:17:48,513 - DEBUG - RT names not yet present for VN ctest-mgmt_vn-74780744
2026-03-26 03:17:53,515 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:53,522 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:53,535 - DEBUG - Requesting: http://10.0.0.240:8082/project/423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b
2026-03-26 03:17:53,636 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/65d67722-d814-4f3d-8181-babaaa974847
2026-03-26 03:17:53,649 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/65d67722-d814-4f3d-8181-babaaa974847
2026-03-26 03:17:53,659 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/c5334438-2ce6-4c11-bfe4-0d5b522fa079
2026-03-26 03:17:53,670 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/c5334438-2ce6-4c11-bfe4-0d5b522fa079
2026-03-26 03:17:53,677 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/3a0790ba-1154-4b9c-9a09-2cef2bdf21d5
2026-03-26 03:17:53,685 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-26 03:17:53,685 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/65d67722-d814-4f3d-8181-babaaa974847
2026-03-26 03:17:53,694 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/c5334438-2ce6-4c11-bfe4-0d5b522fa079
2026-03-26 03:17:53,712 - INFO - Verified VN network id 18 for VN 65d67722-d814-4f3d-8181-babaaa974847
2026-03-26 03:17:53,712 - INFO - Verifications in API Server for VN ctest-mgmt_vn-74780744 passed
2026-03-26 03:17:53,713 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/65d67722-d814-4f3d-8181-babaaa974847
2026-03-26 03:17:53,725 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/c5334438-2ce6-4c11-bfe4-0d5b522fa079
2026-03-26 03:17:53,734 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/c5334438-2ce6-4c11-bfe4-0d5b522fa079
2026-03-26 03:17:53,741 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/3a0790ba-1154-4b9c-9a09-2cef2bdf21d5
2026-03-26 03:17:53,753 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-74780744', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-49210623', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7338183634384604989', 'uuid-lslong': '9331945213777102919'}, 'enable': 'true', 'created': '2026-03-26T03:17:47', 'last-modified': '2026-03-26T03:17:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.547147'}
2026-03-26 03:17:53,759 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-26 03:17:53,766 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-74780744', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-49210623', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7338183634384604989', 'uuid-lslong': '9331945213777102919'}, 'enable': 'true', 'created': '2026-03-26T03:17:47', 'last-modified': '2026-03-26T03:17:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.556888'}
2026-03-26 03:17:53,772 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-26 03:17:53,777 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-74780744', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-49210623', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7338183634384604989', 'uuid-lslong': '9331945213777102919'}, 'enable': 'true', 'created': '2026-03-26T03:17:47', 'last-modified': '2026-03-26T03:17:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.573820'}
2026-03-26 03:17:53,783 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-26 03:17:53,784 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-74780744 passed
2026-03-26 03:17:53,784 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-74780744 in API_Server ======
2026-03-26 03:17:53,784 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:53,790 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:53,803 - DEBUG - Requesting: http://10.0.0.240:8082/project/423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b
2026-03-26 03:17:53,908 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/65d67722-d814-4f3d-8181-babaaa974847
2026-03-26 03:17:53,922 - DEBUG - =>VN ctest-mgmt_vn-74780744 has no policy to be verified
2026-03-26 03:17:53,922 - DEBUG - Verifying the vn in opserver
2026-03-26 03:17:53,922 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-74780744 virtual network link through opserver 10.0.0.240
2026-03-26 03:17:53,922 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-03-26 03:17:53,938 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-74780744', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-74780744?flat'}
2026-03-26 03:17:53,938 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-74780744 virtual network link through opserver 10.0.0.22
2026-03-26 03:17:53,938 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-03-26 03:17:53,952 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-74780744', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-74780744?flat'}
2026-03-26 03:17:53,952 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-74780744 virtual network link through opserver 10.0.0.65
2026-03-26 03:17:53,952 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-26 03:17:53,965 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-74780744', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-74780744?flat'}
2026-03-26 03:17:53,965 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-49210623:ctest-mgmt_vn-74780744 is found in opserver
2026-03-26 03:17:53,988 - DEBUG - Do not have enough data to verify VN in agent
2026-03-26 03:17:54,000 - DEBUG - VRF ids for VN ctest-mgmt_vn-74780744: {}
2026-03-26 03:17:54,273 - DEBUG - Response for create_network : {'network': {'id': 'b2c1b156-7b86-4a30-b580-b4fa6936e748', 'name': 'ctest-left_vn-43908288', 'tenant_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b', 'project_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-49210623', 'ctest-left_vn-43908288'], 'port_security_enabled': True, 'description': ''}}
2026-03-26 03:17:54,546 - DEBUG - Response for create_subnet : {'subnet': {'id': '8c598f92-974f-4aea-a666-ac7c374ae686', 'name': '', 'tenant_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b', 'network_id': 'b2c1b156-7b86-4a30-b580-b4fa6936e748', 'ip_version': 4, 'cidr': '110.98.255.192/26', 'allocation_pools': [{'start': '110.98.255.194', 'end': '110.98.255.254'}], 'gateway_ip': '110.98.255.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '110.98.255.194', 'tags': [], 'project_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b'}}
2026-03-26 03:17:54,567 - INFO - Created VN ctest-left_vn-43908288
2026-03-26 03:17:54,578 - DEBUG - VN ctest-left_vn-43908288 UUID is b2c1b156-7b86-4a30-b580-b4fa6936e748
2026-03-26 03:17:54,652 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:54,659 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:54,670 - DEBUG - Requesting: http://10.0.0.240:8082/project/423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b
2026-03-26 03:17:54,768 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/b2c1b156-7b86-4a30-b580-b4fa6936e748
2026-03-26 03:17:54,789 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/b2c1b156-7b86-4a30-b580-b4fa6936e748
2026-03-26 03:17:54,800 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/ed16aa88-997a-4556-ad23-71dc2d8896db
2026-03-26 03:17:54,811 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/ed16aa88-997a-4556-ad23-71dc2d8896db
2026-03-26 03:17:54,819 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/41f73df6-c286-41af-a0a6-73bfaea5e547
2026-03-26 03:17:54,827 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-26 03:17:54,828 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/b2c1b156-7b86-4a30-b580-b4fa6936e748
2026-03-26 03:17:54,838 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/ed16aa88-997a-4556-ad23-71dc2d8896db
2026-03-26 03:17:54,854 - INFO - Verified VN network id 19 for VN b2c1b156-7b86-4a30-b580-b4fa6936e748
2026-03-26 03:17:54,854 - INFO - Verifications in API Server for VN ctest-left_vn-43908288 passed
2026-03-26 03:17:54,855 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/b2c1b156-7b86-4a30-b580-b4fa6936e748
2026-03-26 03:17:54,867 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/ed16aa88-997a-4556-ad23-71dc2d8896db
2026-03-26 03:17:54,876 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/ed16aa88-997a-4556-ad23-71dc2d8896db
2026-03-26 03:17:54,884 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/41f73df6-c286-41af-a0a6-73bfaea5e547
2026-03-26 03:17:54,898 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-49210623:ctest-left_vn-43908288', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-49210623', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12880771394254031408', 'uuid-lslong': '13078652305483949896'}, 'enable': 'true', 'created': '2026-03-26T03:17:54', 'last-modified': '2026-03-26T03:17:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.410788'}
2026-03-26 03:17:54,906 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-26 03:17:54,913 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-49210623:ctest-left_vn-43908288', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-49210623', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12880771394254031408', 'uuid-lslong': '13078652305483949896'}, 'enable': 'true', 'created': '2026-03-26T03:17:54', 'last-modified': '2026-03-26T03:17:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.424277'}
2026-03-26 03:17:54,919 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-26 03:17:54,926 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-49210623:ctest-left_vn-43908288', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-49210623', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12880771394254031408', 'uuid-lslong': '13078652305483949896'}, 'enable': 'true', 'created': '2026-03-26T03:17:54', 'last-modified': '2026-03-26T03:17:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.439551'}
2026-03-26 03:17:54,933 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-26 03:17:54,933 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-43908288 passed
2026-03-26 03:17:54,934 - DEBUG - ====Verifying policy data for ctest-left_vn-43908288 in API_Server ======
2026-03-26 03:17:54,934 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:54,941 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:54,951 - DEBUG - Requesting: http://10.0.0.240:8082/project/423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b
2026-03-26 03:17:55,048 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/b2c1b156-7b86-4a30-b580-b4fa6936e748
2026-03-26 03:17:55,058 - DEBUG - =>VN ctest-left_vn-43908288 has no policy to be verified
2026-03-26 03:17:55,058 - DEBUG - Verifying the vn in opserver
2026-03-26 03:17:55,058 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-49210623:ctest-left_vn-43908288 virtual network link through opserver 10.0.0.240
2026-03-26 03:17:55,058 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-03-26 03:17:55,071 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-49210623:ctest-left_vn-43908288', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-49210623:ctest-left_vn-43908288?flat'}
2026-03-26 03:17:55,071 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-49210623:ctest-left_vn-43908288 virtual network link through opserver 10.0.0.22
2026-03-26 03:17:55,071 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-03-26 03:17:55,085 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-49210623:ctest-left_vn-43908288', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-49210623:ctest-left_vn-43908288?flat'}
2026-03-26 03:17:55,085 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-49210623:ctest-left_vn-43908288 virtual network link through opserver 10.0.0.65
2026-03-26 03:17:55,085 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-26 03:17:55,099 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-49210623:ctest-left_vn-43908288', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-49210623:ctest-left_vn-43908288?flat'}
2026-03-26 03:17:55,099 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-49210623:ctest-left_vn-43908288 is found in opserver
2026-03-26 03:17:55,120 - DEBUG - Do not have enough data to verify VN in agent
2026-03-26 03:17:55,131 - DEBUG - VRF ids for VN ctest-left_vn-43908288: {}
2026-03-26 03:17:55,398 - DEBUG - Response for create_network : {'network': {'id': '1871f1dd-7933-4092-900f-6ce67fd342df', 'name': 'ctest-right_vn-09469668', 'tenant_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b', 'project_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-49210623', 'ctest-right_vn-09469668'], 'port_security_enabled': True, 'description': ''}}
2026-03-26 03:17:55,588 - DEBUG - Response for create_subnet : {'subnet': {'id': '4792e5b5-e590-48d9-bdbf-b4e70ad4d418', 'name': '', 'tenant_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b', 'network_id': '1871f1dd-7933-4092-900f-6ce67fd342df', 'ip_version': 4, 'cidr': '222.24.162.64/26', 'allocation_pools': [{'start': '222.24.162.66', 'end': '222.24.162.126'}], 'gateway_ip': '222.24.162.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '222.24.162.66', 'tags': [], 'project_id': '423c3fe0befe4ea8ba6cb0e8672fbe7b'}}
2026-03-26 03:17:55,611 - INFO - Created VN ctest-right_vn-09469668
2026-03-26 03:17:55,624 - DEBUG - VN ctest-right_vn-09469668 UUID is 1871f1dd-7933-4092-900f-6ce67fd342df
2026-03-26 03:17:55,694 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:55,700 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:55,711 - DEBUG - Requesting: http://10.0.0.240:8082/project/423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b
2026-03-26 03:17:55,805 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/1871f1dd-7933-4092-900f-6ce67fd342df
2026-03-26 03:17:55,817 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/1871f1dd-7933-4092-900f-6ce67fd342df
2026-03-26 03:17:55,827 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/0da9db81-0c76-4de4-9682-c505358734d6
2026-03-26 03:17:55,834 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/0da9db81-0c76-4de4-9682-c505358734d6
2026-03-26 03:17:55,841 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/42d11a35-6741-4cfa-9af7-8c43ad744018
2026-03-26 03:17:55,848 - DEBUG - Route Targets: ['target:64512:8000009']
2026-03-26 03:17:55,848 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/1871f1dd-7933-4092-900f-6ce67fd342df
2026-03-26 03:17:55,857 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/0da9db81-0c76-4de4-9682-c505358734d6
2026-03-26 03:17:55,873 - INFO - Verified VN network id 20 for VN 1871f1dd-7933-4092-900f-6ce67fd342df
2026-03-26 03:17:55,873 - INFO - Verifications in API Server for VN ctest-right_vn-09469668 passed
2026-03-26 03:17:55,873 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/1871f1dd-7933-4092-900f-6ce67fd342df
2026-03-26 03:17:55,882 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/0da9db81-0c76-4de4-9682-c505358734d6
2026-03-26 03:17:55,889 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/0da9db81-0c76-4de4-9682-c505358734d6
2026-03-26 03:17:55,897 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/42d11a35-6741-4cfa-9af7-8c43ad744018
2026-03-26 03:17:55,909 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-49210623:ctest-right_vn-09469668', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-49210623', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1761454862802043026', 'uuid-lslong': '10380635403355112159'}, 'enable': 'true', 'created': '2026-03-26T03:17:55', 'last-modified': '2026-03-26T03:17:55', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.370090'}
2026-03-26 03:17:55,916 - DEBUG - Route Targets: ['target:64512:8000009']
2026-03-26 03:17:55,922 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-49210623:ctest-right_vn-09469668', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-49210623', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1761454862802043026', 'uuid-lslong': '10380635403355112159'}, 'enable': 'true', 'created': '2026-03-26T03:17:55', 'last-modified': '2026-03-26T03:17:55', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.384141'}
2026-03-26 03:17:55,929 - DEBUG - Route Targets: ['target:64512:8000009']
2026-03-26 03:17:55,936 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-49210623:ctest-right_vn-09469668', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-49210623', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1761454862802043026', 'uuid-lslong': '10380635403355112159'}, 'enable': 'true', 'created': '2026-03-26T03:17:55', 'last-modified': '2026-03-26T03:17:55', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.397140'}
2026-03-26 03:17:55,943 - DEBUG - Route Targets: ['target:64512:8000009']
2026-03-26 03:17:55,943 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-09469668 passed
2026-03-26 03:17:55,943 - DEBUG - ====Verifying policy data for ctest-right_vn-09469668 in API_Server ======
2026-03-26 03:17:55,943 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:17:55,952 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:17:55,967 - DEBUG - Requesting: http://10.0.0.240:8082/project/423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b
2026-03-26 03:17:56,069 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/1871f1dd-7933-4092-900f-6ce67fd342df
2026-03-26 03:17:56,079 - DEBUG - =>VN ctest-right_vn-09469668 has no policy to be verified
2026-03-26 03:17:56,079 - DEBUG - Verifying the vn in opserver
2026-03-26 03:17:56,079 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-49210623:ctest-right_vn-09469668 virtual network link through opserver 10.0.0.240
2026-03-26 03:17:56,079 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-03-26 03:17:56,093 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-49210623:ctest-right_vn-09469668', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-49210623:ctest-right_vn-09469668?flat'}
2026-03-26 03:17:56,093 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-49210623:ctest-right_vn-09469668 virtual network link through opserver 10.0.0.22
2026-03-26 03:17:56,093 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-03-26 03:17:56,106 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-49210623:ctest-right_vn-09469668', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-49210623:ctest-right_vn-09469668?flat'}
2026-03-26 03:17:56,106 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-49210623:ctest-right_vn-09469668 virtual network link through opserver 10.0.0.65
2026-03-26 03:17:56,106 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-26 03:17:56,120 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-49210623:ctest-right_vn-09469668', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-49210623:ctest-right_vn-09469668?flat'}
2026-03-26 03:17:56,120 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-49210623:ctest-right_vn-09469668 is found in opserver
2026-03-26 03:17:56,141 - DEBUG - Do not have enough data to verify VN in agent
2026-03-26 03:17:56,152 - DEBUG - VRF ids for VN ctest-right_vn-09469668: {}
2026-03-26 03:17:57,602 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5545-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5545-1)
2026-03-26 03:17:59,101 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5545-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5545-2)
2026-03-26 03:17:59,102 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-74886555']
2026-03-26 03:17:59,402 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-74886555'] created succesfully
2026-03-26 03:17:59,829 - DEBUG - Image by name tiny_nat_fw not found
2026-03-26 03:17:59,829 - DEBUG - Installing image tiny_nat_fw
2026-03-26 03:17:59,829 - 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-03-26 03:17:59,829 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-26 03:17:59,829 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-26 03:17:59,829 - DEBUG - Unzip image
2026-03-26 03:17:59,830 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-26 03:17:59,849 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-03-26 03:17:59,849 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-74886555']
2026-03-26 03:17:59,971 - INFO - Service template: ['default-domain', 'ctest-service_template_1-74886555'] deleted successfully.
2026-03-26 03:17:59,971 - INFO - Skip interface_detach for VM ctest-right_vm-81736953 in state BUILD
2026-03-26 03:17:59,971 - INFO - Deleting VM ctest-right_vm-81736953
2026-03-26 03:17:59,972 - ERROR - VM ctest-right_vm-81736953 has failed to come up
2026-03-26 03:17:59,972 - ERROR - Nova failed to get host of the VM
2026-03-26 03:17:59,972 - ERROR - VM ctest-right_vm-81736953 has failed to come up
2026-03-26 03:17:59,972 - ERROR - Nova failed to get host of the VM
2026-03-26 03:18:00,053 - INFO - Skip interface_detach for VM ctest-left_vm-81421962 in state BUILD
2026-03-26 03:18:00,054 - INFO - Deleting VM ctest-left_vm-81421962
2026-03-26 03:18:00,054 - ERROR - VM ctest-left_vm-81421962 has failed to come up
2026-03-26 03:18:00,054 - ERROR - Nova failed to get host of the VM
2026-03-26 03:18:00,054 - ERROR - VM ctest-left_vm-81421962 has failed to come up
2026-03-26 03:18:00,054 - ERROR - Nova failed to get host of the VM
2026-03-26 03:18:00,141 - INFO - Deleting VN ctest-right_vn-09469668
2026-03-26 03:18:00,190 - DEBUG - VN 1871f1dd-7933-4092-900f-6ce67fd342df still in use: Unable to complete operation on network 1871f1dd-7933-4092-900f-6ce67fd342df. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-f70922f7-6f8b-4c30-84a6-bf16dd2ca28d']
2026-03-26 03:18:00,190 - WARNING - Deleting VN ctest-right_vn-09469668 failed..Will retry
2026-03-26 03:18:02,391 - DEBUG - Response for deleting network ()
2026-03-26 03:18:02,391 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/0da9db81-0c76-4de4-9682-c505358734d6
2026-03-26 03:18:02,397 - DEBUG - Response Code: 404
2026-03-26 03:18:02,397 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:18:02,415 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:18:02,440 - DEBUG - Requesting: http://10.0.0.240:8082/project/423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b
2026-03-26 03:18:02,532 - INFO - Validated that VN ctest-right_vn-09469668 is not found in API Server
2026-03-26 03:18:02,544 - DEBUG - VN ctest-right_vn-09469668 is not present in Agent 10.0.0.38
2026-03-26 03:18:02,556 - DEBUG - VN ctest-right_vn-09469668 is not present in Agent 10.0.0.23
2026-03-26 03:18:02,556 - INFO - Validated that VN ctest-right_vn-09469668 is not in any agent
2026-03-26 03:18:02,590 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-09469668 info
2026-03-26 03:18:02,591 - INFO - Deleting VN ctest-left_vn-43908288
2026-03-26 03:18:02,754 - DEBUG - Response for deleting network ()
2026-03-26 03:18:02,754 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/ed16aa88-997a-4556-ad23-71dc2d8896db
2026-03-26 03:18:02,760 - DEBUG - Response Code: 404
2026-03-26 03:18:02,760 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:18:02,773 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:18:02,787 - DEBUG - Requesting: http://10.0.0.240:8082/project/423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b
2026-03-26 03:18:02,884 - INFO - Validated that VN ctest-left_vn-43908288 is not found in API Server
2026-03-26 03:18:02,895 - DEBUG - VN ctest-left_vn-43908288 is not present in Agent 10.0.0.38
2026-03-26 03:18:02,906 - DEBUG - VN ctest-left_vn-43908288 is not present in Agent 10.0.0.23
2026-03-26 03:18:02,906 - INFO - Validated that VN ctest-left_vn-43908288 is not in any agent
2026-03-26 03:18:02,939 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-43908288 info
2026-03-26 03:18:02,939 - INFO - Deleting VN ctest-mgmt_vn-74780744
2026-03-26 03:18:03,094 - DEBUG - Response for deleting network ()
2026-03-26 03:18:03,094 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/c5334438-2ce6-4c11-bfe4-0d5b522fa079
2026-03-26 03:18:03,102 - DEBUG - Response Code: 404
2026-03-26 03:18:03,102 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-03-26 03:18:03,112 - DEBUG - Requesting: http://10.0.0.240:8082/domain/b07ef41d-f358-4169-a694-2c6c20158c87
2026-03-26 03:18:03,152 - DEBUG - Requesting: http://10.0.0.240:8082/project/423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b
2026-03-26 03:18:03,261 - INFO - Validated that VN ctest-mgmt_vn-74780744 is not found in API Server
2026-03-26 03:18:03,272 - DEBUG - VN ctest-mgmt_vn-74780744 is not present in Agent 10.0.0.38
2026-03-26 03:18:03,290 - DEBUG - VN ctest-mgmt_vn-74780744 is not present in Agent 10.0.0.23
2026-03-26 03:18:03,290 - INFO - Validated that VN ctest-mgmt_vn-74780744 is not in any agent
2026-03-26 03:18:03,349 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-74780744 info
2026-03-26 03:18:04,666 - DEBUG - No XMPP flaps were noticed during the test
2026-03-26 03:18:04,666 - INFO -
2026-03-26 03:18:04,666 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:18]
2026-03-26 03:18:04,666 - INFO - --------------------------------------------------------------------------------
2026-03-26 03:18:06,107 - INFO - Deleted project: ctest-TestSvcRegr-49210623, ID : 423c3fe0-befe-4ea8-ba6c-b0e8672fbe7b