]) created on node: (an-jenkins-deploy-platform-ansible-os-5514-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5514-2)
2026-03-23 03:17:33,508 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-79912061']
2026-03-23 03:17:33,810 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-79912061'] created succesfully
2026-03-23 03:17:34,263 - DEBUG - Image by name tiny_nat_fw not found
2026-03-23 03:17:34,263 - DEBUG - Installing image tiny_nat_fw
2026-03-23 03:17:34,263 - 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-23 03:17:34,263 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-03-23 03:17:34,263 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-03-23 03:17:34,286 - 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-23 03:17:34,350 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-23 03:17:34,351 - DEBUG - Unzip image
2026-03-23 03:17:34,351 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-23 03:17:34,396 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-03-23 03:17:34,396 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-79912061']
2026-03-23 03:17:34,503 - INFO - Service template: ['default-domain', 'ctest-service_template_1-79912061'] deleted successfully.
2026-03-23 03:17:34,503 - INFO - Skip interface_detach for VM ctest-right_vm-73002465 in state BUILD
2026-03-23 03:17:34,503 - INFO - Deleting VM ctest-right_vm-73002465
2026-03-23 03:17:34,559 - ERROR - VM ctest-right_vm-73002465 has failed to come up
2026-03-23 03:17:34,559 - ERROR - Nova failed to get host of the VM
2026-03-23 03:17:34,560 - ERROR - VM ctest-right_vm-73002465 has failed to come up
2026-03-23 03:17:34,560 - ERROR - Nova failed to get host of the VM
2026-03-23 03:17:34,653 - INFO - Skip interface_detach for VM ctest-left_vm-74925391 in state BUILD
2026-03-23 03:17:34,653 - INFO - Deleting VM ctest-left_vm-74925391
2026-03-23 03:17:34,653 - ERROR - VM ctest-left_vm-74925391 has failed to come up
2026-03-23 03:17:34,653 - ERROR - Nova failed to get host of the VM
2026-03-23 03:17:34,653 - ERROR - VM ctest-left_vm-74925391 has failed to come up
2026-03-23 03:17:34,653 - ERROR - Nova failed to get host of the VM
2026-03-23 03:17:34,746 - INFO - Deleting VN ctest-right_vn-70174938
2026-03-23 03:17:34,795 - DEBUG - VN da4400d2-f978-457b-a933-37a6463ae751 still in use: Unable to complete operation on network da4400d2-f978-457b-a933-37a6463ae751. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-9c044efd-bb01-427e-9f42-29c5050a89e2']
2026-03-23 03:17:34,795 - WARNING - Deleting VN ctest-right_vn-70174938 failed..Will retry
2026-03-23 03:17:37,008 - DEBUG - Response for deleting network ()
2026-03-23 03:17:37,008 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/0e684cd6-70d8-4ffa-9bc0-4e7a559226e8
2026-03-23 03:17:37,016 - DEBUG - Response Code: 404
2026-03-23 03:17:37,016 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:17:37,032 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:17:37,054 - DEBUG - Requesting: http://10.0.0.27:8082/project/4c72cdea-caf0-4147-834e-e5c78b0bcbb6
2026-03-23 03:17:37,146 - INFO - Validated that VN ctest-right_vn-70174938 is not found in API Server
2026-03-23 03:17:37,158 - DEBUG - VN ctest-right_vn-70174938 is not present in Agent 10.0.0.249
2026-03-23 03:17:37,225 - DEBUG - VN ctest-right_vn-70174938 is not present in Agent 10.0.0.65
2026-03-23 03:17:37,225 - INFO - Validated that VN ctest-right_vn-70174938 is not in any agent
2026-03-23 03:17:37,259 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-70174938 info
2026-03-23 03:17:37,260 - INFO - Deleting VN ctest-left_vn-82067047
2026-03-23 03:17:37,428 - DEBUG - Response for deleting network ()
2026-03-23 03:17:37,428 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/16add3c5-a94e-4b3d-b57b-a5060b49b5c1
2026-03-23 03:17:37,434 - DEBUG - Response Code: 404
2026-03-23 03:17:37,435 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:17:37,451 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:17:37,471 - DEBUG - Requesting: http://10.0.0.27:8082/project/4c72cdea-caf0-4147-834e-e5c78b0bcbb6
2026-03-23 03:17:37,587 - INFO - Validated that VN ctest-left_vn-82067047 is not found in API Server
2026-03-23 03:17:37,604 - DEBUG - VN ctest-left_vn-82067047 is not present in Agent 10.0.0.249
2026-03-23 03:17:37,622 - DEBUG - VN ctest-left_vn-82067047 is not present in Agent 10.0.0.65
2026-03-23 03:17:37,622 - INFO - Validated that VN ctest-left_vn-82067047 is not in any agent
2026-03-23 03:17:37,663 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-82067047 info
2026-03-23 03:17:37,663 - INFO - Deleting VN ctest-mgmt_vn-66948619
2026-03-23 03:17:37,803 - DEBUG - Response for deleting network ()
2026-03-23 03:17:37,803 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/92e652d1-9753-476f-9a79-bd09e4a00c54
2026-03-23 03:17:37,811 - DEBUG - Response Code: 404
2026-03-23 03:17:37,811 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:17:37,819 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:17:37,855 - DEBUG - Requesting: http://10.0.0.27:8082/project/4c72cdea-caf0-4147-834e-e5c78b0bcbb6
2026-03-23 03:17:37,963 - INFO - Validated that VN ctest-mgmt_vn-66948619 is not found in API Server
2026-03-23 03:17:37,976 - DEBUG - VN ctest-mgmt_vn-66948619 is not present in Agent 10.0.0.249
2026-03-23 03:17:37,996 - DEBUG - VN ctest-mgmt_vn-66948619 is not present in Agent 10.0.0.65
2026-03-23 03:17:37,997 - INFO - Validated that VN ctest-mgmt_vn-66948619 is not in any agent
2026-03-23 03:17:38,036 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-66948619 info
2026-03-23 03:17:38,036 - INFO - Deleting VM ctest-vm-in-third-vn-85553058
2026-03-23 03:17:38,118 - INFO - Deleting VN ctest-third-vn-96612767
2026-03-23 03:17:38,167 - DEBUG - VN 2af8b791-0f54-44a7-ab46-e1ff05b96f9b still in use: Unable to complete operation on network 2af8b791-0f54-44a7-ab46-e1ff05b96f9b. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-ac3bf58d-578e-4e33-8085-1557272ccc39']
2026-03-23 03:17:38,167 - WARNING - Deleting VN ctest-third-vn-96612767 failed..Will retry
2026-03-23 03:17:40,340 - DEBUG - Response for deleting network ()
2026-03-23 03:17:41,633 - DEBUG - No XMPP flaps were noticed during the test
2026-03-23 03:17:41,633 - INFO -
2026-03-23 03:17:41,633 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:26]
2026-03-23 03:17:41,633 - INFO - --------------------------------------------------------------------------------
2026-03-23 03:17:41,637 - INFO - ================================================================================
2026-03-23 03:17:41,637 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2026-03-23 03:17:42,947 - DEBUG - Nothing to compare xmpp stats {'10.0.0.249': {'10.20.0.18': '0', '10.20.0.14': '0'}, '10.0.0.65': {'10.20.0.18': '0', '10.20.0.14': '0'}} with
2026-03-23 03:17:42,947 - INFO - Initial checks done. Running the testcase now
2026-03-23 03:17:42,947 - INFO -
2026-03-23 03:17:43,254 - DEBUG - Response for create_network : {'network': {'id': '5d30fec3-ebf9-47d8-9afc-e293d1cdb0d1', 'name': 'ctest-mgmt_vn-64427393', 'tenant_id': '4c72cdeacaf04147834ee5c78b0bcbb6', 'project_id': '4c72cdeacaf04147834ee5c78b0bcbb6', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-98027224', 'ctest-mgmt_vn-64427393'], 'port_security_enabled': True, 'description': ''}}
2026-03-23 03:17:43,516 - DEBUG - Response for create_subnet : {'subnet': {'id': '073b1c53-4816-4cd1-95de-e7326d3d9c22', 'name': '', 'tenant_id': '4c72cdeacaf04147834ee5c78b0bcbb6', 'network_id': '5d30fec3-ebf9-47d8-9afc-e293d1cdb0d1', 'ip_version': 4, 'cidr': '30.229.252.192/26', 'allocation_pools': [{'start': '30.229.252.194', 'end': '30.229.252.254'}], 'gateway_ip': '30.229.252.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '30.229.252.194', 'tags': [], 'project_id': '4c72cdeacaf04147834ee5c78b0bcbb6'}}
2026-03-23 03:17:43,545 - INFO - Created VN ctest-mgmt_vn-64427393
2026-03-23 03:17:43,556 - DEBUG - VN ctest-mgmt_vn-64427393 UUID is 5d30fec3-ebf9-47d8-9afc-e293d1cdb0d1
2026-03-23 03:17:43,639 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:17:43,647 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:17:43,664 - DEBUG - Requesting: http://10.0.0.27:8082/project/4c72cdea-caf0-4147-834e-e5c78b0bcbb6
2026-03-23 03:17:43,755 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5d30fec3-ebf9-47d8-9afc-e293d1cdb0d1
2026-03-23 03:17:43,772 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5d30fec3-ebf9-47d8-9afc-e293d1cdb0d1
2026-03-23 03:17:43,783 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/f6cda122-53ee-41b4-a397-67b6f6070c7f
2026-03-23 03:17:43,795 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/f6cda122-53ee-41b4-a397-67b6f6070c7f
2026-03-23 03:17:43,807 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/683cd850-8cba-4d27-9f96-95efdd5d5143
2026-03-23 03:17:43,817 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-23 03:17:43,817 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5d30fec3-ebf9-47d8-9afc-e293d1cdb0d1
2026-03-23 03:17:43,832 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/f6cda122-53ee-41b4-a397-67b6f6070c7f
2026-03-23 03:17:43,850 - INFO - Verified VN network id 15 for VN 5d30fec3-ebf9-47d8-9afc-e293d1cdb0d1
2026-03-23 03:17:43,850 - INFO - Verifications in API Server for VN ctest-mgmt_vn-64427393 passed
2026-03-23 03:17:43,850 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5d30fec3-ebf9-47d8-9afc-e293d1cdb0d1
2026-03-23 03:17:43,864 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/f6cda122-53ee-41b4-a397-67b6f6070c7f
2026-03-23 03:17:43,873 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/f6cda122-53ee-41b4-a397-67b6f6070c7f
2026-03-23 03:17:43,882 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/683cd850-8cba-4d27-9f96-95efdd5d5143
2026-03-23 03:17:43,895 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-98027224:ctest-mgmt_vn-64427393', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-98027224', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6715147161840469976', 'uuid-lslong': '11168050300479975633'}, 'enable': 'true', 'created': '2026-03-23T03:17:43', 'last-modified': '2026-03-23T03:17:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.420394'}
2026-03-23 03:17:43,901 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-23 03:17:43,907 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-98027224:ctest-mgmt_vn-64427393', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-98027224', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6715147161840469976', 'uuid-lslong': '11168050300479975633'}, 'enable': 'true', 'created': '2026-03-23T03:17:43', 'last-modified': '2026-03-23T03:17:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.429272'}
2026-03-23 03:17:43,915 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-23 03:17:43,921 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-98027224:ctest-mgmt_vn-64427393', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-98027224', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6715147161840469976', 'uuid-lslong': '11168050300479975633'}, 'enable': 'true', 'created': '2026-03-23T03:17:43', 'last-modified': '2026-03-23T03:17:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.451133'}
2026-03-23 03:17:43,930 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-23 03:17:43,930 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-64427393 passed
2026-03-23 03:17:43,930 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-64427393 in API_Server ======
2026-03-23 03:17:43,930 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:17:43,938 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:17:43,955 - DEBUG - Requesting: http://10.0.0.27:8082/project/4c72cdea-caf0-4147-834e-e5c78b0bcbb6
2026-03-23 03:17:44,057 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5d30fec3-ebf9-47d8-9afc-e293d1cdb0d1
2026-03-23 03:17:44,070 - DEBUG - =>VN ctest-mgmt_vn-64427393 has no policy to be verified
2026-03-23 03:17:44,070 - DEBUG - Verifying the vn in opserver
2026-03-23 03:17:44,070 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-98027224:ctest-mgmt_vn-64427393 virtual network link through opserver 10.0.0.27
2026-03-23 03:17:44,071 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-23 03:17:44,086 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-98027224:ctest-mgmt_vn-64427393', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-98027224:ctest-mgmt_vn-64427393?flat'}
2026-03-23 03:17:44,086 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-98027224:ctest-mgmt_vn-64427393 virtual network link through opserver 10.0.0.50
2026-03-23 03:17:44,086 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-03-23 03:17:44,108 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-98027224:ctest-mgmt_vn-64427393', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-98027224:ctest-mgmt_vn-64427393?flat'}
2026-03-23 03:17:44,109 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-98027224:ctest-mgmt_vn-64427393 virtual network link through opserver 10.0.0.23
2026-03-23 03:17:44,109 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-03-23 03:17:44,123 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-98027224:ctest-mgmt_vn-64427393', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-98027224:ctest-mgmt_vn-64427393?flat'}
2026-03-23 03:17:44,123 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-98027224:ctest-mgmt_vn-64427393 is found in opserver
2026-03-23 03:17:44,148 - DEBUG - Do not have enough data to verify VN in agent
2026-03-23 03:17:44,157 - DEBUG - VRF ids for VN ctest-mgmt_vn-64427393: {}
2026-03-23 03:17:44,434 - DEBUG - Response for create_network : {'network': {'id': '4f95e283-4d4d-4eb9-978b-465813abc6fc', 'name': 'ctest-left_vn-57663328', 'tenant_id': '4c72cdeacaf04147834ee5c78b0bcbb6', 'project_id': '4c72cdeacaf04147834ee5c78b0bcbb6', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-98027224', 'ctest-left_vn-57663328'], 'port_security_enabled': True, 'description': ''}}
2026-03-23 03:17:44,662 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ddb055e5-ef93-4cc5-83de-6921acee7dc5', 'name': '', 'tenant_id': '4c72cdeacaf04147834ee5c78b0bcbb6', 'network_id': '4f95e283-4d4d-4eb9-978b-465813abc6fc', 'ip_version': 4, 'cidr': '198.41.70.192/26', 'allocation_pools': [{'start': '198.41.70.194', 'end': '198.41.70.254'}], 'gateway_ip': '198.41.70.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '198.41.70.194', 'tags': [], 'project_id': '4c72cdeacaf04147834ee5c78b0bcbb6'}}
2026-03-23 03:17:44,686 - INFO - Created VN ctest-left_vn-57663328
2026-03-23 03:17:44,701 - DEBUG - VN ctest-left_vn-57663328 UUID is 4f95e283-4d4d-4eb9-978b-465813abc6fc
2026-03-23 03:17:44,801 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:17:44,810 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:17:44,825 - DEBUG - Requesting: http://10.0.0.27:8082/project/4c72cdea-caf0-4147-834e-e5c78b0bcbb6
2026-03-23 03:17:44,942 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/4f95e283-4d4d-4eb9-978b-465813abc6fc
2026-03-23 03:17:44,968 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/4f95e283-4d4d-4eb9-978b-465813abc6fc
2026-03-23 03:17:44,989 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/68a16f50-0824-4bf3-a566-cc0754295d72
2026-03-23 03:17:45,003 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/68a16f50-0824-4bf3-a566-cc0754295d72
2026-03-23 03:17:45,015 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/2515b915-df27-4e88-8ad4-2539d567ca80
2026-03-23 03:17:45,025 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-23 03:17:45,025 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/4f95e283-4d4d-4eb9-978b-465813abc6fc
2026-03-23 03:17:45,038 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/68a16f50-0824-4bf3-a566-cc0754295d72
2026-03-23 03:17:45,057 - INFO - Verified VN network id 16 for VN 4f95e283-4d4d-4eb9-978b-465813abc6fc
2026-03-23 03:17:45,057 - INFO - Verifications in API Server for VN ctest-left_vn-57663328 passed
2026-03-23 03:17:45,058 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/4f95e283-4d4d-4eb9-978b-465813abc6fc
2026-03-23 03:17:45,071 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/68a16f50-0824-4bf3-a566-cc0754295d72
2026-03-23 03:17:45,084 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/68a16f50-0824-4bf3-a566-cc0754295d72
2026-03-23 03:17:45,095 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/2515b915-df27-4e88-8ad4-2539d567ca80
2026-03-23 03:17:45,110 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-98027224:ctest-left_vn-57663328', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-98027224', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5734738754091699897', 'uuid-lslong': '10919899065590990588'}, 'enable': 'true', 'created': '2026-03-23T03:17:44', 'last-modified': '2026-03-23T03:17:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.514713'}
2026-03-23 03:17:45,118 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-23 03:17:45,128 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-98027224:ctest-left_vn-57663328', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-98027224', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5734738754091699897', 'uuid-lslong': '10919899065590990588'}, 'enable': 'true', 'created': '2026-03-23T03:17:44', 'last-modified': '2026-03-23T03:17:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.530230'}
2026-03-23 03:17:45,134 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-23 03:17:45,140 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-98027224:ctest-left_vn-57663328', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-98027224', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5734738754091699897', 'uuid-lslong': '10919899065590990588'}, 'enable': 'true', 'created': '2026-03-23T03:17:44', 'last-modified': '2026-03-23T03:17:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.542207'}
2026-03-23 03:17:45,149 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-23 03:17:45,149 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-57663328 passed
2026-03-23 03:17:45,149 - DEBUG - ====Verifying policy data for ctest-left_vn-57663328 in API_Server ======
2026-03-23 03:17:45,150 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:17:45,159 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:17:45,174 - DEBUG - Requesting: http://10.0.0.27:8082/project/4c72cdea-caf0-4147-834e-e5c78b0bcbb6
2026-03-23 03:17:45,293 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/4f95e283-4d4d-4eb9-978b-465813abc6fc
2026-03-23 03:17:45,304 - DEBUG - =>VN ctest-left_vn-57663328 has no policy to be verified
2026-03-23 03:17:45,304 - DEBUG - Verifying the vn in opserver
2026-03-23 03:17:45,304 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-98027224:ctest-left_vn-57663328 virtual network link through opserver 10.0.0.27
2026-03-23 03:17:45,304 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-23 03:17:45,317 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-98027224:ctest-left_vn-57663328', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-98027224:ctest-left_vn-57663328?flat'}
2026-03-23 03:17:45,317 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-98027224:ctest-left_vn-57663328 virtual network link through opserver 10.0.0.50
2026-03-23 03:17:45,317 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-03-23 03:17:45,330 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-98027224:ctest-left_vn-57663328', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-98027224:ctest-left_vn-57663328?flat'}
2026-03-23 03:17:45,330 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-98027224:ctest-left_vn-57663328 virtual network link through opserver 10.0.0.23
2026-03-23 03:17:45,330 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-03-23 03:17:45,341 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-98027224:ctest-left_vn-57663328', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-98027224:ctest-left_vn-57663328?flat'}
2026-03-23 03:17:45,341 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-98027224:ctest-left_vn-57663328 is found in opserver
2026-03-23 03:17:45,365 - DEBUG - Do not have enough data to verify VN in agent
2026-03-23 03:17:45,380 - DEBUG - VRF ids for VN ctest-left_vn-57663328: {}
2026-03-23 03:17:45,656 - DEBUG - Response for create_network : {'network': {'id': 'f38dee29-af72-4c6d-b0ff-84d0c65a2b10', 'name': 'ctest-right_vn-57744332', 'tenant_id': '4c72cdeacaf04147834ee5c78b0bcbb6', 'project_id': '4c72cdeacaf04147834ee5c78b0bcbb6', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-98027224', 'ctest-right_vn-57744332'], 'port_security_enabled': True, 'description': ''}}
2026-03-23 03:17:45,935 - DEBUG - Response for create_subnet : {'subnet': {'id': 'bbcb2783-7bf6-4bf9-8290-771d19082c86', 'name': '', 'tenant_id': '4c72cdeacaf04147834ee5c78b0bcbb6', 'network_id': 'f38dee29-af72-4c6d-b0ff-84d0c65a2b10', 'ip_version': 4, 'cidr': '24.180.32.192/26', 'allocation_pools': [{'start': '24.180.32.194', 'end': '24.180.32.254'}], 'gateway_ip': '24.180.32.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '24.180.32.194', 'tags': [], 'project_id': '4c72cdeacaf04147834ee5c78b0bcbb6'}}
2026-03-23 03:17:45,959 - INFO - Created VN ctest-right_vn-57744332
2026-03-23 03:17:45,969 - DEBUG - VN ctest-right_vn-57744332 UUID is f38dee29-af72-4c6d-b0ff-84d0c65a2b10
2026-03-23 03:17:46,046 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:17:46,053 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:17:46,068 - DEBUG - Requesting: http://10.0.0.27:8082/project/4c72cdea-caf0-4147-834e-e5c78b0bcbb6
2026-03-23 03:17:46,171 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/f38dee29-af72-4c6d-b0ff-84d0c65a2b10
2026-03-23 03:17:46,183 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/f38dee29-af72-4c6d-b0ff-84d0c65a2b10
2026-03-23 03:17:46,197 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/b6dc7718-6805-443b-be81-0855c6be0bda
2026-03-23 03:17:46,210 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/b6dc7718-6805-443b-be81-0855c6be0bda
2026-03-23 03:17:46,220 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/77570652-88be-437a-b76f-f42960d112e7
2026-03-23 03:17:46,229 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-23 03:17:46,229 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/f38dee29-af72-4c6d-b0ff-84d0c65a2b10
2026-03-23 03:17:46,239 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/b6dc7718-6805-443b-be81-0855c6be0bda
2026-03-23 03:17:46,255 - INFO - Verified VN network id 17 for VN f38dee29-af72-4c6d-b0ff-84d0c65a2b10
2026-03-23 03:17:46,256 - INFO - Verifications in API Server for VN ctest-right_vn-57744332 passed
2026-03-23 03:17:46,256 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/f38dee29-af72-4c6d-b0ff-84d0c65a2b10
2026-03-23 03:17:46,269 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/b6dc7718-6805-443b-be81-0855c6be0bda
2026-03-23 03:17:46,277 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/b6dc7718-6805-443b-be81-0855c6be0bda
2026-03-23 03:17:46,285 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/77570652-88be-437a-b76f-f42960d112e7
2026-03-23 03:17:46,303 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-98027224:ctest-right_vn-57744332', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-98027224', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17549945185737264237', 'uuid-lslong': '12754058701952396048'}, 'enable': 'true', 'created': '2026-03-23T03:17:45', 'last-modified': '2026-03-23T03:17:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.424182'}
2026-03-23 03:17:46,312 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-23 03:17:46,319 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-98027224:ctest-right_vn-57744332', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-98027224', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17549945185737264237', 'uuid-lslong': '12754058701952396048'}, 'enable': 'true', 'created': '2026-03-23T03:17:45', 'last-modified': '2026-03-23T03:17:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.438855'}
2026-03-23 03:17:46,325 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-23 03:17:46,330 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-98027224:ctest-right_vn-57744332', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-98027224', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17549945185737264237', 'uuid-lslong': '12754058701952396048'}, 'enable': 'true', 'created': '2026-03-23T03:17:45', 'last-modified': '2026-03-23T03:17:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.451208'}
2026-03-23 03:17:46,336 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-23 03:17:46,336 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-57744332 passed
2026-03-23 03:17:46,337 - DEBUG - ====Verifying policy data for ctest-right_vn-57744332 in API_Server ======
2026-03-23 03:17:46,337 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:17:46,345 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:17:46,358 - DEBUG - Requesting: http://10.0.0.27:8082/project/4c72cdea-caf0-4147-834e-e5c78b0bcbb6
2026-03-23 03:17:46,446 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/f38dee29-af72-4c6d-b0ff-84d0c65a2b10
2026-03-23 03:17:46,460 - DEBUG - =>VN ctest-right_vn-57744332 has no policy to be verified
2026-03-23 03:17:46,460 - DEBUG - Verifying the vn in opserver
2026-03-23 03:17:46,460 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-98027224:ctest-right_vn-57744332 virtual network link through opserver 10.0.0.27
2026-03-23 03:17:46,460 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-23 03:17:46,475 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-98027224:ctest-right_vn-57744332', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-98027224:ctest-right_vn-57744332?flat'}
2026-03-23 03:17:46,476 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-98027224:ctest-right_vn-57744332 virtual network link through opserver 10.0.0.50
2026-03-23 03:17:46,476 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-03-23 03:17:46,490 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-98027224:ctest-right_vn-57744332', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-98027224:ctest-right_vn-57744332?flat'}
2026-03-23 03:17:46,491 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-98027224:ctest-right_vn-57744332 virtual network link through opserver 10.0.0.23
2026-03-23 03:17:46,491 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-03-23 03:17:46,505 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-98027224:ctest-right_vn-57744332', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-98027224:ctest-right_vn-57744332?flat'}
2026-03-23 03:17:46,505 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-98027224:ctest-right_vn-57744332 is found in opserver
2026-03-23 03:17:46,534 - DEBUG - Do not have enough data to verify VN in agent
2026-03-23 03:17:46,545 - DEBUG - VRF ids for VN ctest-right_vn-57744332: {}
2026-03-23 03:17:46,792 - DEBUG - Response for create_network : {'network': {'id': '9be83608-8ab4-47ab-9e9a-6a6a3156d017', 'name': 'ctest-trans_left_vn-09616643', 'tenant_id': '4c72cdeacaf04147834ee5c78b0bcbb6', 'project_id': '4c72cdeacaf04147834ee5c78b0bcbb6', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-98027224', 'ctest-trans_left_vn-09616643'], 'port_security_enabled': True, 'description': ''}}
2026-03-23 03:17:47,012 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f7b30beb-ec9e-4d00-a262-617933f4672d', 'name': '', 'tenant_id': '4c72cdeacaf04147834ee5c78b0bcbb6', 'network_id': '9be83608-8ab4-47ab-9e9a-6a6a3156d017', 'ip_version': 4, 'cidr': '37.6.8.0/26', 'allocation_pools': [{'start': '37.6.8.2', 'end': '37.6.8.62'}], 'gateway_ip': '37.6.8.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '37.6.8.2', 'tags': [], 'project_id': '4c72cdeacaf04147834ee5c78b0bcbb6'}}
2026-03-23 03:17:47,052 - INFO - Created VN ctest-trans_left_vn-09616643
2026-03-23 03:17:47,062 - DEBUG - VN ctest-trans_left_vn-09616643 UUID is 9be83608-8ab4-47ab-9e9a-6a6a3156d017
2026-03-23 03:17:47,137 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:17:47,144 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:17:47,160 - DEBUG - Requesting: http://10.0.0.27:8082/project/4c72cdea-caf0-4147-834e-e5c78b0bcbb6
2026-03-23 03:17:47,248 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/9be83608-8ab4-47ab-9e9a-6a6a3156d017
2026-03-23 03:17:47,262 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/9be83608-8ab4-47ab-9e9a-6a6a3156d017
2026-03-23 03:17:47,272 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/eacbadf5-25b2-425a-941f-f6c258a17ef5
2026-03-23 03:17:47,282 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/eacbadf5-25b2-425a-941f-f6c258a17ef5
2026-03-23 03:17:47,289 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/c51bed7a-1aed-4491-b07d-5d1acbc6d185
2026-03-23 03:17:47,298 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-23 03:17:47,298 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/9be83608-8ab4-47ab-9e9a-6a6a3156d017
2026-03-23 03:17:47,308 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/eacbadf5-25b2-425a-941f-f6c258a17ef5
2026-03-23 03:17:47,326 - INFO - Verified VN network id 18 for VN 9be83608-8ab4-47ab-9e9a-6a6a3156d017
2026-03-23 03:17:47,327 - INFO - Verifications in API Server for VN ctest-trans_left_vn-09616643 passed
2026-03-23 03:17:47,327 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/9be83608-8ab4-47ab-9e9a-6a6a3156d017
2026-03-23 03:17:47,339 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/eacbadf5-25b2-425a-941f-f6c258a17ef5
2026-03-23 03:17:47,349 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/eacbadf5-25b2-425a-941f-f6c258a17ef5
2026-03-23 03:17:47,358 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/c51bed7a-1aed-4491-b07d-5d1acbc6d185
2026-03-23 03:17:47,373 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-98027224:ctest-trans_left_vn-09616643', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-98027224', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11234288680790411179', 'uuid-lslong': '11428564008732905495'}, 'enable': 'true', 'created': '2026-03-23T03:17:46', 'last-modified': '2026-03-23T03:17:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.421377'}
2026-03-23 03:17:47,381 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-23 03:17:47,389 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-98027224:ctest-trans_left_vn-09616643', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-98027224', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11234288680790411179', 'uuid-lslong': '11428564008732905495'}, 'enable': 'true', 'created': '2026-03-23T03:17:46', 'last-modified': '2026-03-23T03:17:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.432724'}
2026-03-23 03:17:47,396 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-23 03:17:47,402 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-98027224:ctest-trans_left_vn-09616643', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-98027224', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11234288680790411179', 'uuid-lslong': '11428564008732905495'}, 'enable': 'true', 'created': '2026-03-23T03:17:46', 'last-modified': '2026-03-23T03:17:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.449839'}
2026-03-23 03:17:47,408 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-23 03:17:47,408 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-09616643 passed
2026-03-23 03:17:47,408 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-09616643 in API_Server ======
2026-03-23 03:17:47,408 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:17:47,415 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:17:47,427 - DEBUG - Requesting: http://10.0.0.27:8082/project/4c72cdea-caf0-4147-834e-e5c78b0bcbb6
2026-03-23 03:17:47,524 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/9be83608-8ab4-47ab-9e9a-6a6a3156d017
2026-03-23 03:17:47,536 - DEBUG - =>VN ctest-trans_left_vn-09616643 has no policy to be verified
2026-03-23 03:17:47,536 - DEBUG - Verifying the vn in opserver
2026-03-23 03:17:47,536 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-98027224:ctest-trans_left_vn-09616643 virtual network link through opserver 10.0.0.27
2026-03-23 03:17:47,536 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-23 03:17:47,551 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-98027224:ctest-trans_left_vn-09616643', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-98027224:ctest-trans_left_vn-09616643?flat'}
2026-03-23 03:17:47,551 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-98027224:ctest-trans_left_vn-09616643 virtual network link through opserver 10.0.0.50
2026-03-23 03:17:47,551 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-03-23 03:17:47,568 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-98027224:ctest-trans_left_vn-09616643', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-98027224:ctest-trans_left_vn-09616643?flat'}
2026-03-23 03:17:47,568 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-98027224:ctest-trans_left_vn-09616643 virtual network link through opserver 10.0.0.23
2026-03-23 03:17:47,568 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-03-23 03:17:47,581 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-98027224:ctest-trans_left_vn-09616643', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-98027224:ctest-trans_left_vn-09616643?flat'}
2026-03-23 03:17:47,581 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-98027224:ctest-trans_left_vn-09616643 is found in opserver
2026-03-23 03:17:47,605 - DEBUG - Do not have enough data to verify VN in agent
2026-03-23 03:17:47,617 - DEBUG - VRF ids for VN ctest-trans_left_vn-09616643: {}
2026-03-23 03:17:47,880 - DEBUG - Response for create_network : {'network': {'id': 'ad33d863-6a24-4186-87f4-5ddc8974c5ed', 'name': 'ctest-trans_right_vn-37451697', 'tenant_id': '4c72cdeacaf04147834ee5c78b0bcbb6', 'project_id': '4c72cdeacaf04147834ee5c78b0bcbb6', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-98027224', 'ctest-trans_right_vn-37451697'], 'port_security_enabled': True, 'description': ''}}
2026-03-23 03:17:48,131 - DEBUG - Response for create_subnet : {'subnet': {'id': 'bb584b83-65df-4c31-9029-81dde02ff680', 'name': '', 'tenant_id': '4c72cdeacaf04147834ee5c78b0bcbb6', 'network_id': 'ad33d863-6a24-4186-87f4-5ddc8974c5ed', 'ip_version': 4, 'cidr': '114.159.217.192/26', 'allocation_pools': [{'start': '114.159.217.194', 'end': '114.159.217.254'}], 'gateway_ip': '114.159.217.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '114.159.217.194', 'tags': [], 'project_id': '4c72cdeacaf04147834ee5c78b0bcbb6'}}
2026-03-23 03:17:48,156 - INFO - Created VN ctest-trans_right_vn-37451697
2026-03-23 03:17:48,171 - DEBUG - VN ctest-trans_right_vn-37451697 UUID is ad33d863-6a24-4186-87f4-5ddc8974c5ed
2026-03-23 03:17:48,249 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:17:48,257 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:17:48,268 - DEBUG - Requesting: http://10.0.0.27:8082/project/4c72cdea-caf0-4147-834e-e5c78b0bcbb6
2026-03-23 03:17:48,368 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/ad33d863-6a24-4186-87f4-5ddc8974c5ed
2026-03-23 03:17:48,381 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/ad33d863-6a24-4186-87f4-5ddc8974c5ed
2026-03-23 03:17:48,391 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/0cd5c9a8-ffe7-4eb9-bb94-cfeea9e2144d
2026-03-23 03:17:48,400 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/0cd5c9a8-ffe7-4eb9-bb94-cfeea9e2144d
2026-03-23 03:17:48,408 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/d311ded3-a740-4652-9b05-4a2927bfd9fb
2026-03-23 03:17:48,416 - DEBUG - Route Targets: ['target:64512:8000009']
2026-03-23 03:17:48,416 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/ad33d863-6a24-4186-87f4-5ddc8974c5ed
2026-03-23 03:17:48,427 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/0cd5c9a8-ffe7-4eb9-bb94-cfeea9e2144d
2026-03-23 03:17:48,447 - INFO - Verified VN network id 19 for VN ad33d863-6a24-4186-87f4-5ddc8974c5ed
2026-03-23 03:17:48,447 - INFO - Verifications in API Server for VN ctest-trans_right_vn-37451697 passed
2026-03-23 03:17:48,447 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/ad33d863-6a24-4186-87f4-5ddc8974c5ed
2026-03-23 03:17:48,459 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/0cd5c9a8-ffe7-4eb9-bb94-cfeea9e2144d
2026-03-23 03:17:48,468 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/0cd5c9a8-ffe7-4eb9-bb94-cfeea9e2144d
2026-03-23 03:17:48,479 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/d311ded3-a740-4652-9b05-4a2927bfd9fb
2026-03-23 03:17:48,492 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-98027224:ctest-trans_right_vn-37451697', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-98027224', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12480556913867899270', 'uuid-lslong': '9796558291217991149'}, 'enable': 'true', 'created': '2026-03-23T03:17:47', 'last-modified': '2026-03-23T03:17:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.432368'}
2026-03-23 03:17:48,499 - DEBUG - Route Targets: ['target:64512:8000009']
2026-03-23 03:17:48,506 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-98027224:ctest-trans_right_vn-37451697', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-98027224', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12480556913867899270', 'uuid-lslong': '9796558291217991149'}, 'enable': 'true', 'created': '2026-03-23T03:17:47', 'last-modified': '2026-03-23T03:17:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.442816'}
2026-03-23 03:17:48,513 - DEBUG - Route Targets: ['target:64512:8000009']
2026-03-23 03:17:48,519 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-98027224:ctest-trans_right_vn-37451697', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-98027224', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12480556913867899270', 'uuid-lslong': '9796558291217991149'}, 'enable': 'true', 'created': '2026-03-23T03:17:47', 'last-modified': '2026-03-23T03:17:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.458292'}
2026-03-23 03:17:48,525 - DEBUG - Route Targets: ['target:64512:8000009']
2026-03-23 03:17:48,525 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-37451697 passed
2026-03-23 03:17:48,525 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-37451697 in API_Server ======
2026-03-23 03:17:48,525 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:17:48,533 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:17:48,545 - DEBUG - Requesting: http://10.0.0.27:8082/project/4c72cdea-caf0-4147-834e-e5c78b0bcbb6
2026-03-23 03:17:48,648 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/ad33d863-6a24-4186-87f4-5ddc8974c5ed
2026-03-23 03:17:48,664 - DEBUG - =>VN ctest-trans_right_vn-37451697 has no policy to be verified
2026-03-23 03:17:48,664 - DEBUG - Verifying the vn in opserver
2026-03-23 03:17:48,664 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-98027224:ctest-trans_right_vn-37451697 virtual network link through opserver 10.0.0.27
2026-03-23 03:17:48,664 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-23 03:17:48,679 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-98027224:ctest-trans_right_vn-37451697', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-98027224:ctest-trans_right_vn-37451697?flat'}
2026-03-23 03:17:48,679 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-98027224:ctest-trans_right_vn-37451697 virtual network link through opserver 10.0.0.50
2026-03-23 03:17:48,679 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-03-23 03:17:48,692 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-98027224:ctest-trans_right_vn-37451697', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-98027224:ctest-trans_right_vn-37451697?flat'}
2026-03-23 03:17:48,692 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-98027224:ctest-trans_right_vn-37451697 virtual network link through opserver 10.0.0.23
2026-03-23 03:17:48,692 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-03-23 03:17:48,704 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-98027224:ctest-trans_right_vn-37451697', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-98027224:ctest-trans_right_vn-37451697?flat'}
2026-03-23 03:17:48,704 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-98027224:ctest-trans_right_vn-37451697 is found in opserver
2026-03-23 03:17:48,729 - DEBUG - Do not have enough data to verify VN in agent
2026-03-23 03:17:48,742 - DEBUG - VRF ids for VN ctest-trans_right_vn-37451697: {}
2026-03-23 03:17:49,911 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5514-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5514-2)
2026-03-23 03:17:51,365 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5514-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5514-1)
2026-03-23 03:17:51,365 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-84130981']
2026-03-23 03:17:51,686 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-84130981'] created succesfully
2026-03-23 03:17:52,099 - DEBUG - Image by name tiny_trans_fw not found
2026-03-23 03:17:52,099 - DEBUG - Installing image tiny_trans_fw
2026-03-23 03:17:52,099 - 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-23 03:17:52,099 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-03-23 03:17:52,099 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-03-23 03:17:52,126 - 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-23 03:17:52,161 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-03-23 03:17:52,161 - DEBUG - Unzip image
2026-03-23 03:17:52,161 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-03-23 03:17:52,198 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-03-23 03:17:52,199 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-84130981']
2026-03-23 03:17:52,303 - INFO - Service template: ['default-domain', 'ctest-service_template_1-84130981'] deleted successfully.
2026-03-23 03:17:52,303 - INFO - Skip interface_detach for VM ctest-right_vm-42074199 in state BUILD
2026-03-23 03:17:52,304 - INFO - Deleting VM ctest-right_vm-42074199
2026-03-23 03:17:52,304 - ERROR - VM ctest-right_vm-42074199 has failed to come up
2026-03-23 03:17:52,304 - ERROR - Nova failed to get host of the VM
2026-03-23 03:17:52,304 - ERROR - VM ctest-right_vm-42074199 has failed to come up
2026-03-23 03:17:52,304 - ERROR - Nova failed to get host of the VM
2026-03-23 03:17:52,434 - INFO - Skip interface_detach for VM ctest-left_vm-23442924 in state BUILD
2026-03-23 03:17:52,435 - INFO - Deleting VM ctest-left_vm-23442924
2026-03-23 03:17:52,435 - ERROR - VM ctest-left_vm-23442924 has failed to come up
2026-03-23 03:17:52,435 - ERROR - Nova failed to get host of the VM
2026-03-23 03:17:52,435 - ERROR - VM ctest-left_vm-23442924 has failed to come up
2026-03-23 03:17:52,435 - ERROR - Nova failed to get host of the VM
2026-03-23 03:17:52,543 - INFO - Deleting VN ctest-trans_right_vn-37451697
2026-03-23 03:17:52,717 - DEBUG - Response for deleting network ()
2026-03-23 03:17:52,718 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/0cd5c9a8-ffe7-4eb9-bb94-cfeea9e2144d
2026-03-23 03:17:52,725 - DEBUG - Response Code: 404
2026-03-23 03:17:52,726 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:17:52,732 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:17:52,760 - DEBUG - Requesting: http://10.0.0.27:8082/project/4c72cdea-caf0-4147-834e-e5c78b0bcbb6
2026-03-23 03:17:52,856 - INFO - Validated that VN ctest-trans_right_vn-37451697 is not found in API Server
2026-03-23 03:17:52,886 - DEBUG - VN ctest-trans_right_vn-37451697 is not present in Agent 10.0.0.249
2026-03-23 03:17:52,899 - DEBUG - VN ctest-trans_right_vn-37451697 is not present in Agent 10.0.0.65
2026-03-23 03:17:52,899 - INFO - Validated that VN ctest-trans_right_vn-37451697 is not in any agent
2026-03-23 03:17:52,937 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-37451697 info
2026-03-23 03:17:52,937 - INFO - Deleting VN ctest-trans_left_vn-09616643
2026-03-23 03:17:53,107 - DEBUG - Response for deleting network ()
2026-03-23 03:17:53,107 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/eacbadf5-25b2-425a-941f-f6c258a17ef5
2026-03-23 03:17:53,114 - DEBUG - Response Code: 404
2026-03-23 03:17:53,114 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:17:53,123 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:17:53,158 - DEBUG - Requesting: http://10.0.0.27:8082/project/4c72cdea-caf0-4147-834e-e5c78b0bcbb6
2026-03-23 03:17:53,263 - INFO - Validated that VN ctest-trans_left_vn-09616643 is not found in API Server
2026-03-23 03:17:53,286 - DEBUG - VN ctest-trans_left_vn-09616643 is not present in Agent 10.0.0.249
2026-03-23 03:17:53,300 - DEBUG - VN ctest-trans_left_vn-09616643 is not present in Agent 10.0.0.65
2026-03-23 03:17:53,300 - INFO - Validated that VN ctest-trans_left_vn-09616643 is not in any agent
2026-03-23 03:17:53,346 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-09616643 info
2026-03-23 03:17:53,347 - INFO - Deleting VN ctest-right_vn-57744332
2026-03-23 03:17:53,424 - DEBUG - VN f38dee29-af72-4c6d-b0ff-84d0c65a2b10 still in use: Unable to complete operation on network f38dee29-af72-4c6d-b0ff-84d0c65a2b10. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-a2c79daa-8bb6-4a24-bd86-3e67812d9bfb']
2026-03-23 03:17:53,424 - WARNING - Deleting VN ctest-right_vn-57744332 failed..Will retry
2026-03-23 03:17:55,589 - DEBUG - Response for deleting network ()
2026-03-23 03:17:55,590 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/b6dc7718-6805-443b-be81-0855c6be0bda
2026-03-23 03:17:55,596 - DEBUG - Response Code: 404
2026-03-23 03:17:55,597 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:17:55,605 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:17:55,662 - DEBUG - Requesting: http://10.0.0.27:8082/project/4c72cdea-caf0-4147-834e-e5c78b0bcbb6
2026-03-23 03:17:55,758 - INFO - Validated that VN ctest-right_vn-57744332 is not found in API Server
2026-03-23 03:17:55,769 - DEBUG - VN ctest-right_vn-57744332 is not present in Agent 10.0.0.249
2026-03-23 03:17:55,778 - DEBUG - VN ctest-right_vn-57744332 is not present in Agent 10.0.0.65
2026-03-23 03:17:55,779 - INFO - Validated that VN ctest-right_vn-57744332 is not in any agent
2026-03-23 03:17:55,811 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-57744332 info
2026-03-23 03:17:55,811 - INFO - Deleting VN ctest-left_vn-57663328
2026-03-23 03:17:55,960 - DEBUG - Response for deleting network ()
2026-03-23 03:17:55,961 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/68a16f50-0824-4bf3-a566-cc0754295d72
2026-03-23 03:17:55,968 - DEBUG - Response Code: 404
2026-03-23 03:17:55,968 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:17:55,974 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:17:55,993 - DEBUG - Requesting: http://10.0.0.27:8082/project/4c72cdea-caf0-4147-834e-e5c78b0bcbb6
2026-03-23 03:17:56,091 - INFO - Validated that VN ctest-left_vn-57663328 is not found in API Server
2026-03-23 03:17:56,103 - DEBUG - VN ctest-left_vn-57663328 is not present in Agent 10.0.0.249
2026-03-23 03:17:56,115 - DEBUG - VN ctest-left_vn-57663328 is not present in Agent 10.0.0.65
2026-03-23 03:17:56,115 - INFO - Validated that VN ctest-left_vn-57663328 is not in any agent
2026-03-23 03:17:56,150 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-57663328 info
2026-03-23 03:17:56,150 - INFO - Deleting VN ctest-mgmt_vn-64427393
2026-03-23 03:17:56,287 - DEBUG - Response for deleting network ()
2026-03-23 03:17:56,287 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/f6cda122-53ee-41b4-a397-67b6f6070c7f
2026-03-23 03:17:56,299 - DEBUG - Response Code: 404
2026-03-23 03:17:56,299 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:17:56,312 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:17:56,327 - DEBUG - Requesting: http://10.0.0.27:8082/project/4c72cdea-caf0-4147-834e-e5c78b0bcbb6
2026-03-23 03:17:56,420 - INFO - Validated that VN ctest-mgmt_vn-64427393 is not found in API Server
2026-03-23 03:17:56,431 - DEBUG - VN ctest-mgmt_vn-64427393 is not present in Agent 10.0.0.249
2026-03-23 03:17:56,445 - DEBUG - VN ctest-mgmt_vn-64427393 is not present in Agent 10.0.0.65
2026-03-23 03:17:56,445 - INFO - Validated that VN ctest-mgmt_vn-64427393 is not in any agent
2026-03-23 03:17:56,478 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-64427393 info
2026-03-23 03:17:57,762 - DEBUG - No XMPP flaps were noticed during the test
2026-03-23 03:17:57,762 - INFO -
2026-03-23 03:17:57,762 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:16]
2026-03-23 03:17:57,762 - INFO - --------------------------------------------------------------------------------
2026-03-23 03:17:58,592 - INFO - Deleted project: ctest-TestSvcRegr-98027224, ID : 4c72cdea-caf0-4147-834e-e5c78b0bcbb6
2026-03-23 03:17:58,811 - INFO - Domain Default found not creating
2026-03-23 03:17:59,027 - INFO - Project ctest-TestSvcRegr-66442757 not found, creating it
2026-03-23 03:17:59,537 - INFO - Created Project:ctest-TestSvcRegr-66442757, ID : 6cbaad08-1574-4da2-8dd7-0b5e8191a229
2026-03-23 03:18:01,256 - INFO - ================================================================================
2026-03-23 03:18:01,256 - INFO - STARTING TEST : test_svc_CEM_22032
2026-03-23 03:18:02,540 - DEBUG - Nothing to compare xmpp stats {'10.0.0.249': {'10.20.0.18': '0', '10.20.0.14': '0'}, '10.0.0.65': {'10.20.0.18': '0', '10.20.0.14': '0'}} with
2026-03-23 03:18:02,540 - INFO - Initial checks done. Running the testcase now
2026-03-23 03:18:02,540 - INFO -
2026-03-23 03:18:03,296 - DEBUG - Response for create_network : {'network': {'id': '2ff35ed2-4557-4027-8bbd-96e8806fd838', 'name': 'ctest-mgmt_vn-67842077', 'tenant_id': '6cbaad0815744da28dd70b5e8191a229', 'project_id': '6cbaad0815744da28dd70b5e8191a229', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-66442757', 'ctest-mgmt_vn-67842077'], 'port_security_enabled': True, 'description': ''}}
2026-03-23 03:18:03,573 - DEBUG - Response for create_subnet : {'subnet': {'id': '9d3a1bec-3701-49ab-821e-ba4f95827656', 'name': '', 'tenant_id': '6cbaad0815744da28dd70b5e8191a229', 'network_id': '2ff35ed2-4557-4027-8bbd-96e8806fd838', 'ip_version': 4, 'cidr': '93.121.68.64/26', 'allocation_pools': [{'start': '93.121.68.66', 'end': '93.121.68.126'}], 'gateway_ip': '93.121.68.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '93.121.68.66', 'tags': [], 'project_id': '6cbaad0815744da28dd70b5e8191a229'}}
2026-03-23 03:18:03,601 - INFO - Created VN ctest-mgmt_vn-67842077
2026-03-23 03:18:03,612 - DEBUG - VN ctest-mgmt_vn-67842077 UUID is 2ff35ed2-4557-4027-8bbd-96e8806fd838
2026-03-23 03:18:03,698 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:18:04,032 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:18:04,079 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:18:04,094 - DEBUG - Requesting: http://10.0.0.27:8082/project/6cbaad08-1574-4da2-8dd7-0b5e8191a229
2026-03-23 03:18:04,201 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/2ff35ed2-4557-4027-8bbd-96e8806fd838
2026-03-23 03:18:04,218 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/2ff35ed2-4557-4027-8bbd-96e8806fd838
2026-03-23 03:18:04,227 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/065caad1-69e1-47a9-ae81-d1f756a2a1e4
2026-03-23 03:18:04,239 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/065caad1-69e1-47a9-ae81-d1f756a2a1e4
2026-03-23 03:18:04,247 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/42f49954-f01a-4c73-a54b-df5bc7fd1097
2026-03-23 03:18:04,255 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-23 03:18:04,255 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/2ff35ed2-4557-4027-8bbd-96e8806fd838
2026-03-23 03:18:04,267 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/065caad1-69e1-47a9-ae81-d1f756a2a1e4
2026-03-23 03:18:04,285 - INFO - Verified VN network id 15 for VN 2ff35ed2-4557-4027-8bbd-96e8806fd838
2026-03-23 03:18:04,285 - INFO - Verifications in API Server for VN ctest-mgmt_vn-67842077 passed
2026-03-23 03:18:04,285 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/2ff35ed2-4557-4027-8bbd-96e8806fd838
2026-03-23 03:18:04,302 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/065caad1-69e1-47a9-ae81-d1f756a2a1e4
2026-03-23 03:18:04,311 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/065caad1-69e1-47a9-ae81-d1f756a2a1e4
2026-03-23 03:18:04,321 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/42f49954-f01a-4c73-a54b-df5bc7fd1097
2026-03-23 03:18:04,336 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-67842077', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-66442757', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3455209596322791463', 'uuid-lslong': '10069370267201689656'}, 'enable': 'true', 'created': '2026-03-23T03:18:03', 'last-modified': '2026-03-23T03:18:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.814624'}
2026-03-23 03:18:04,343 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-23 03:18:04,350 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-67842077', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-66442757', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3455209596322791463', 'uuid-lslong': '10069370267201689656'}, 'enable': 'true', 'created': '2026-03-23T03:18:03', 'last-modified': '2026-03-23T03:18:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.830786'}
2026-03-23 03:18:04,357 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-23 03:18:04,363 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-67842077', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-66442757', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3455209596322791463', 'uuid-lslong': '10069370267201689656'}, 'enable': 'true', 'created': '2026-03-23T03:18:03', 'last-modified': '2026-03-23T03:18:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.848947'}
2026-03-23 03:18:04,369 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-23 03:18:04,369 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-67842077 passed
2026-03-23 03:18:04,369 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-67842077 in API_Server ======
2026-03-23 03:18:04,369 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:18:04,388 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:18:04,410 - DEBUG - Requesting: http://10.0.0.27:8082/project/6cbaad08-1574-4da2-8dd7-0b5e8191a229
2026-03-23 03:18:04,528 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/2ff35ed2-4557-4027-8bbd-96e8806fd838
2026-03-23 03:18:04,550 - DEBUG - =>VN ctest-mgmt_vn-67842077 has no policy to be verified
2026-03-23 03:18:04,550 - DEBUG - Verifying the vn in opserver
2026-03-23 03:18:04,550 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-67842077 virtual network link through opserver 10.0.0.27
2026-03-23 03:18:04,550 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-23 03:18:04,891 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-23 03:18:04,975 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-67842077', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-67842077?flat'}
2026-03-23 03:18:04,975 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-67842077 virtual network link through opserver 10.0.0.50
2026-03-23 03:18:04,976 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-03-23 03:18:05,287 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-03-23 03:18:05,359 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-67842077', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-67842077?flat'}
2026-03-23 03:18:05,360 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-67842077 virtual network link through opserver 10.0.0.23
2026-03-23 03:18:05,360 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-03-23 03:18:05,671 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-03-23 03:18:05,747 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-67842077', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-67842077?flat'}
2026-03-23 03:18:05,747 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-67842077 is found in opserver
2026-03-23 03:18:05,771 - DEBUG - Do not have enough data to verify VN in agent
2026-03-23 03:18:05,783 - DEBUG - VRF ids for VN ctest-mgmt_vn-67842077: {}
2026-03-23 03:18:06,065 - DEBUG - Response for create_network : {'network': {'id': 'e67f6fe3-3d03-486a-808b-376b24fdc5a3', 'name': 'service-left-vn-54180660', 'tenant_id': '6cbaad0815744da28dd70b5e8191a229', 'project_id': '6cbaad0815744da28dd70b5e8191a229', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-66442757', 'service-left-vn-54180660'], 'port_security_enabled': True, 'description': ''}}
2026-03-23 03:18:06,275 - DEBUG - Response for create_subnet : {'subnet': {'id': '2b2ef501-d54a-45c1-b63a-38db2a64bbdd', 'name': '', 'tenant_id': '6cbaad0815744da28dd70b5e8191a229', 'network_id': 'e67f6fe3-3d03-486a-808b-376b24fdc5a3', 'ip_version': 4, 'cidr': '59.111.82.64/26', 'allocation_pools': [{'start': '59.111.82.66', 'end': '59.111.82.126'}], 'gateway_ip': '59.111.82.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '59.111.82.66', 'tags': [], 'project_id': '6cbaad0815744da28dd70b5e8191a229'}}
2026-03-23 03:18:06,303 - INFO - Created VN service-left-vn-54180660
2026-03-23 03:18:06,315 - DEBUG - VN service-left-vn-54180660 UUID is e67f6fe3-3d03-486a-808b-376b24fdc5a3
2026-03-23 03:18:06,399 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:18:06,407 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:18:06,517 - DEBUG - Requesting: http://10.0.0.27:8082/project/6cbaad08-1574-4da2-8dd7-0b5e8191a229
2026-03-23 03:18:06,622 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/e67f6fe3-3d03-486a-808b-376b24fdc5a3
2026-03-23 03:18:06,636 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/e67f6fe3-3d03-486a-808b-376b24fdc5a3
2026-03-23 03:18:06,652 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1c1ac67d-6c38-45c9-a5cc-b59cdbdc9167
2026-03-23 03:18:06,661 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1c1ac67d-6c38-45c9-a5cc-b59cdbdc9167
2026-03-23 03:18:06,669 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/8ebb3cda-10a9-4b13-9b59-ed8cd16a7f49
2026-03-23 03:18:06,677 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-23 03:18:06,677 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/e67f6fe3-3d03-486a-808b-376b24fdc5a3
2026-03-23 03:18:06,690 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1c1ac67d-6c38-45c9-a5cc-b59cdbdc9167
2026-03-23 03:18:06,709 - INFO - Verified VN network id 16 for VN e67f6fe3-3d03-486a-808b-376b24fdc5a3
2026-03-23 03:18:06,709 - INFO - Verifications in API Server for VN service-left-vn-54180660 passed
2026-03-23 03:18:06,709 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/e67f6fe3-3d03-486a-808b-376b24fdc5a3
2026-03-23 03:18:06,720 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1c1ac67d-6c38-45c9-a5cc-b59cdbdc9167
2026-03-23 03:18:06,729 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1c1ac67d-6c38-45c9-a5cc-b59cdbdc9167
2026-03-23 03:18:06,737 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/8ebb3cda-10a9-4b13-9b59-ed8cd16a7f49
2026-03-23 03:18:06,755 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-66442757:service-left-vn-54180660', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-66442757', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16609116972537563242', 'uuid-lslong': '9262557991939196323'}, 'enable': 'true', 'created': '2026-03-23T03:18:06', 'last-modified': '2026-03-23T03:18:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.526443'}
2026-03-23 03:18:06,762 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-23 03:18:06,769 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-66442757:service-left-vn-54180660', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-66442757', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16609116972537563242', 'uuid-lslong': '9262557991939196323'}, 'enable': 'true', 'created': '2026-03-23T03:18:06', 'last-modified': '2026-03-23T03:18:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.537942'}
2026-03-23 03:18:06,779 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-23 03:18:06,785 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-66442757:service-left-vn-54180660', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-66442757', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16609116972537563242', 'uuid-lslong': '9262557991939196323'}, 'enable': 'true', 'created': '2026-03-23T03:18:06', 'last-modified': '2026-03-23T03:18:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.557613'}
2026-03-23 03:18:06,792 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-23 03:18:06,792 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-54180660 passed
2026-03-23 03:18:06,792 - DEBUG - ====Verifying policy data for service-left-vn-54180660 in API_Server ======
2026-03-23 03:18:06,792 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:18:06,800 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:18:06,814 - DEBUG - Requesting: http://10.0.0.27:8082/project/6cbaad08-1574-4da2-8dd7-0b5e8191a229
2026-03-23 03:18:06,920 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/e67f6fe3-3d03-486a-808b-376b24fdc5a3
2026-03-23 03:18:06,931 - DEBUG - =>VN service-left-vn-54180660 has no policy to be verified
2026-03-23 03:18:06,931 - DEBUG - Verifying the vn in opserver
2026-03-23 03:18:06,932 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-66442757:service-left-vn-54180660 virtual network link through opserver 10.0.0.27
2026-03-23 03:18:06,932 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-23 03:18:07,026 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-66442757:service-left-vn-54180660', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-66442757:service-left-vn-54180660?flat'}
2026-03-23 03:18:07,026 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-66442757:service-left-vn-54180660 virtual network link through opserver 10.0.0.50
2026-03-23 03:18:07,026 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-03-23 03:18:07,112 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-66442757:service-left-vn-54180660', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-66442757:service-left-vn-54180660?flat'}
2026-03-23 03:18:07,112 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-66442757:service-left-vn-54180660 virtual network link through opserver 10.0.0.23
2026-03-23 03:18:07,112 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-03-23 03:18:07,192 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-66442757:service-left-vn-54180660', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-66442757:service-left-vn-54180660?flat'}
2026-03-23 03:18:07,192 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-66442757:service-left-vn-54180660 is found in opserver
2026-03-23 03:18:07,224 - DEBUG - Do not have enough data to verify VN in agent
2026-03-23 03:18:07,237 - DEBUG - VRF ids for VN service-left-vn-54180660: {}
2026-03-23 03:18:07,476 - DEBUG - Response for create_network : {'network': {'id': '0e055942-9d0f-473e-bed4-64b9e399bd2c', 'name': 'service-right-vn-57853948', 'tenant_id': '6cbaad0815744da28dd70b5e8191a229', 'project_id': '6cbaad0815744da28dd70b5e8191a229', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-66442757', 'service-right-vn-57853948'], 'port_security_enabled': True, 'description': ''}}
2026-03-23 03:18:07,827 - DEBUG - Response for create_subnet : {'subnet': {'id': '76a02479-daec-4504-b89f-f620488217f8', 'name': '', 'tenant_id': '6cbaad0815744da28dd70b5e8191a229', 'network_id': '0e055942-9d0f-473e-bed4-64b9e399bd2c', 'ip_version': 4, 'cidr': '114.49.217.64/26', 'allocation_pools': [{'start': '114.49.217.66', 'end': '114.49.217.126'}], 'gateway_ip': '114.49.217.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '114.49.217.66', 'tags': [], 'project_id': '6cbaad0815744da28dd70b5e8191a229'}}
2026-03-23 03:18:07,858 - INFO - Created VN service-right-vn-57853948
2026-03-23 03:18:07,871 - DEBUG - VN service-right-vn-57853948 UUID is 0e055942-9d0f-473e-bed4-64b9e399bd2c
2026-03-23 03:18:07,955 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:18:07,962 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:18:07,977 - DEBUG - Requesting: http://10.0.0.27:8082/project/6cbaad08-1574-4da2-8dd7-0b5e8191a229
2026-03-23 03:18:08,079 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/0e055942-9d0f-473e-bed4-64b9e399bd2c
2026-03-23 03:18:08,095 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/0e055942-9d0f-473e-bed4-64b9e399bd2c
2026-03-23 03:18:08,106 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1411725a-1d4d-4257-93a7-5f48c33ce842
2026-03-23 03:18:08,113 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1411725a-1d4d-4257-93a7-5f48c33ce842
2026-03-23 03:18:08,122 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/9dfe37fd-66f4-416f-8b90-d5bc4e037fa8
2026-03-23 03:18:08,129 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-23 03:18:08,129 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/0e055942-9d0f-473e-bed4-64b9e399bd2c
2026-03-23 03:18:08,141 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1411725a-1d4d-4257-93a7-5f48c33ce842
2026-03-23 03:18:08,159 - INFO - Verified VN network id 17 for VN 0e055942-9d0f-473e-bed4-64b9e399bd2c
2026-03-23 03:18:08,159 - INFO - Verifications in API Server for VN service-right-vn-57853948 passed
2026-03-23 03:18:08,159 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/0e055942-9d0f-473e-bed4-64b9e399bd2c
2026-03-23 03:18:08,171 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1411725a-1d4d-4257-93a7-5f48c33ce842
2026-03-23 03:18:08,179 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1411725a-1d4d-4257-93a7-5f48c33ce842
2026-03-23 03:18:08,188 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/9dfe37fd-66f4-416f-8b90-d5bc4e037fa8
2026-03-23 03:18:08,200 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-66442757:service-right-vn-57853948', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-66442757', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1010311834052282174', 'uuid-lslong': '13750726311819197740'}, 'enable': 'true', 'created': '2026-03-23T03:18:07', 'last-modified': '2026-03-23T03:18:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.487946'}
2026-03-23 03:18:08,208 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-23 03:18:08,215 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-66442757:service-right-vn-57853948', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-66442757', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1010311834052282174', 'uuid-lslong': '13750726311819197740'}, 'enable': 'true', 'created': '2026-03-23T03:18:07', 'last-modified': '2026-03-23T03:18:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.509298'}
2026-03-23 03:18:08,222 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-23 03:18:08,228 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-66442757:service-right-vn-57853948', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-66442757', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1010311834052282174', 'uuid-lslong': '13750726311819197740'}, 'enable': 'true', 'created': '2026-03-23T03:18:07', 'last-modified': '2026-03-23T03:18:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.513888'}
2026-03-23 03:18:08,234 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-23 03:18:08,234 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-57853948 passed
2026-03-23 03:18:08,235 - DEBUG - ====Verifying policy data for service-right-vn-57853948 in API_Server ======
2026-03-23 03:18:08,235 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:18:08,242 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:18:08,257 - DEBUG - Requesting: http://10.0.0.27:8082/project/6cbaad08-1574-4da2-8dd7-0b5e8191a229
2026-03-23 03:18:08,355 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/0e055942-9d0f-473e-bed4-64b9e399bd2c
2026-03-23 03:18:08,366 - DEBUG - =>VN service-right-vn-57853948 has no policy to be verified
2026-03-23 03:18:08,366 - DEBUG - Verifying the vn in opserver
2026-03-23 03:18:08,366 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-66442757:service-right-vn-57853948 virtual network link through opserver 10.0.0.27
2026-03-23 03:18:08,366 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-23 03:18:08,439 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-66442757:service-right-vn-57853948', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-66442757:service-right-vn-57853948?flat'}
2026-03-23 03:18:08,439 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-66442757:service-right-vn-57853948 virtual network link through opserver 10.0.0.50
2026-03-23 03:18:08,439 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-03-23 03:18:08,513 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-66442757:service-right-vn-57853948', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-66442757:service-right-vn-57853948?flat'}
2026-03-23 03:18:08,513 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-66442757:service-right-vn-57853948 virtual network link through opserver 10.0.0.23
2026-03-23 03:18:08,513 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-03-23 03:18:08,582 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-66442757:service-right-vn-57853948', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-66442757:service-right-vn-57853948?flat'}
2026-03-23 03:18:08,582 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-66442757:service-right-vn-57853948 is found in opserver
2026-03-23 03:18:08,607 - DEBUG - Do not have enough data to verify VN in agent
2026-03-23 03:18:08,620 - DEBUG - VRF ids for VN service-right-vn-57853948: {}
2026-03-23 03:18:08,693 - DEBUG - Services list from nova: [, , , ]
2026-03-23 03:18:09,828 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5514-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5514-2)
2026-03-23 03:18:11,237 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5514-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5514-1)
2026-03-23 03:18:11,237 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-40507828']
2026-03-23 03:18:11,534 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-40507828'] created succesfully
2026-03-23 03:18:11,925 - DEBUG - Image by name tiny_nat_fw not found
2026-03-23 03:18:11,925 - DEBUG - Installing image tiny_nat_fw
2026-03-23 03:18:11,926 - 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-23 03:18:11,926 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-23 03:18:11,926 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-23 03:18:11,926 - DEBUG - Unzip image
2026-03-23 03:18:11,926 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-23 03:18:11,952 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-03-23 03:18:11,953 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-40507828']
2026-03-23 03:18:12,051 - INFO - Service template: ['default-domain', 'ctest-service_template_1-40507828'] deleted successfully.
2026-03-23 03:18:12,051 - INFO - Skip interface_detach for VM ctest-right_vm-24700167 in state BUILD
2026-03-23 03:18:12,051 - INFO - Deleting VM ctest-right_vm-24700167
2026-03-23 03:18:12,106 - ERROR - VM ctest-right_vm-24700167 has failed to come up
2026-03-23 03:18:12,106 - ERROR - Nova failed to get host of the VM
2026-03-23 03:18:12,106 - ERROR - VM ctest-right_vm-24700167 has failed to come up
2026-03-23 03:18:12,106 - ERROR - Nova failed to get host of the VM
2026-03-23 03:18:12,216 - INFO - Skip interface_detach for VM ctest-left_vm-08604250 in state BUILD
2026-03-23 03:18:12,216 - INFO - Deleting VM ctest-left_vm-08604250
2026-03-23 03:18:12,216 - ERROR - VM ctest-left_vm-08604250 has failed to come up
2026-03-23 03:18:12,216 - ERROR - Nova failed to get host of the VM
2026-03-23 03:18:12,217 - ERROR - VM ctest-left_vm-08604250 has failed to come up
2026-03-23 03:18:12,217 - ERROR - Nova failed to get host of the VM
2026-03-23 03:18:12,316 - INFO - Deleting VN service-right-vn-57853948
2026-03-23 03:18:12,384 - DEBUG - VN 0e055942-9d0f-473e-bed4-64b9e399bd2c still in use: Unable to complete operation on network 0e055942-9d0f-473e-bed4-64b9e399bd2c. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-0a82d385-96f6-4a7d-adce-f90c2ab56bd3']
2026-03-23 03:18:12,384 - WARNING - Deleting VN service-right-vn-57853948 failed..Will retry
2026-03-23 03:18:14,591 - DEBUG - Response for deleting network ()
2026-03-23 03:18:14,591 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1411725a-1d4d-4257-93a7-5f48c33ce842
2026-03-23 03:18:14,606 - DEBUG - Response Code: 404
2026-03-23 03:18:14,607 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:18:14,618 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:18:14,638 - DEBUG - Requesting: http://10.0.0.27:8082/project/6cbaad08-1574-4da2-8dd7-0b5e8191a229
2026-03-23 03:18:14,750 - INFO - Validated that VN service-right-vn-57853948 is not found in API Server
2026-03-23 03:18:14,768 - DEBUG - VN service-right-vn-57853948 is not present in Agent 10.0.0.249
2026-03-23 03:18:14,782 - DEBUG - VN service-right-vn-57853948 is not present in Agent 10.0.0.65
2026-03-23 03:18:14,782 - INFO - Validated that VN service-right-vn-57853948 is not in any agent
2026-03-23 03:18:14,825 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-57853948 info
2026-03-23 03:18:14,825 - INFO - Deleting VN service-left-vn-54180660
2026-03-23 03:18:14,985 - DEBUG - Response for deleting network ()
2026-03-23 03:18:14,985 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1c1ac67d-6c38-45c9-a5cc-b59cdbdc9167
2026-03-23 03:18:14,991 - DEBUG - Response Code: 404
2026-03-23 03:18:14,991 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:18:15,002 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:18:15,024 - DEBUG - Requesting: http://10.0.0.27:8082/project/6cbaad08-1574-4da2-8dd7-0b5e8191a229
2026-03-23 03:18:15,129 - INFO - Validated that VN service-left-vn-54180660 is not found in API Server
2026-03-23 03:18:15,142 - DEBUG - VN service-left-vn-54180660 is not present in Agent 10.0.0.249
2026-03-23 03:18:15,155 - DEBUG - VN service-left-vn-54180660 is not present in Agent 10.0.0.65
2026-03-23 03:18:15,155 - INFO - Validated that VN service-left-vn-54180660 is not in any agent
2026-03-23 03:18:15,190 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-54180660 info
2026-03-23 03:18:15,191 - INFO - Deleting VN ctest-mgmt_vn-67842077
2026-03-23 03:18:15,338 - DEBUG - Response for deleting network ()
2026-03-23 03:18:15,338 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/065caad1-69e1-47a9-ae81-d1f756a2a1e4
2026-03-23 03:18:15,348 - DEBUG - Response Code: 404
2026-03-23 03:18:15,348 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:18:15,363 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:18:15,380 - DEBUG - Requesting: http://10.0.0.27:8082/project/6cbaad08-1574-4da2-8dd7-0b5e8191a229
2026-03-23 03:18:15,477 - INFO - Validated that VN ctest-mgmt_vn-67842077 is not found in API Server
2026-03-23 03:18:15,491 - DEBUG - VN ctest-mgmt_vn-67842077 is not present in Agent 10.0.0.249
2026-03-23 03:18:15,502 - DEBUG - VN ctest-mgmt_vn-67842077 is not present in Agent 10.0.0.65
2026-03-23 03:18:15,502 - INFO - Validated that VN ctest-mgmt_vn-67842077 is not in any agent
2026-03-23 03:18:15,545 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-67842077 info
2026-03-23 03:18:16,829 - DEBUG - No XMPP flaps were noticed during the test
2026-03-23 03:18:16,829 - INFO -
2026-03-23 03:18:16,829 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:15]
2026-03-23 03:18:16,829 - INFO - --------------------------------------------------------------------------------
2026-03-23 03:18:16,833 - INFO - ================================================================================
2026-03-23 03:18:16,833 - INFO - STARTING TEST : test_svc_in_network_datapath
2026-03-23 03:18:18,127 - DEBUG - Nothing to compare xmpp stats {'10.0.0.249': {'10.20.0.18': '0', '10.20.0.14': '0'}, '10.0.0.65': {'10.20.0.18': '0', '10.20.0.14': '0'}} with
2026-03-23 03:18:18,127 - INFO - Initial checks done. Running the testcase now
2026-03-23 03:18:18,127 - INFO -
2026-03-23 03:18:18,438 - DEBUG - Response for create_network : {'network': {'id': '5d010070-28a2-4647-b03e-a8613bb8c9f0', 'name': 'ctest-mgmt_vn-76520060', 'tenant_id': '6cbaad0815744da28dd70b5e8191a229', 'project_id': '6cbaad0815744da28dd70b5e8191a229', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-66442757', 'ctest-mgmt_vn-76520060'], 'port_security_enabled': True, 'description': ''}}
2026-03-23 03:18:18,662 - DEBUG - Response for create_subnet : {'subnet': {'id': '39e8a102-574d-452b-8ff0-f09c448a1e19', 'name': '', 'tenant_id': '6cbaad0815744da28dd70b5e8191a229', 'network_id': '5d010070-28a2-4647-b03e-a8613bb8c9f0', 'ip_version': 4, 'cidr': '170.182.232.0/26', 'allocation_pools': [{'start': '170.182.232.2', 'end': '170.182.232.62'}], 'gateway_ip': '170.182.232.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '170.182.232.2', 'tags': [], 'project_id': '6cbaad0815744da28dd70b5e8191a229'}}
2026-03-23 03:18:18,688 - INFO - Created VN ctest-mgmt_vn-76520060
2026-03-23 03:18:18,698 - DEBUG - VN ctest-mgmt_vn-76520060 UUID is 5d010070-28a2-4647-b03e-a8613bb8c9f0
2026-03-23 03:18:18,786 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:18:18,794 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:18:18,807 - DEBUG - Requesting: http://10.0.0.27:8082/project/6cbaad08-1574-4da2-8dd7-0b5e8191a229
2026-03-23 03:18:18,902 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5d010070-28a2-4647-b03e-a8613bb8c9f0
2026-03-23 03:18:18,915 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5d010070-28a2-4647-b03e-a8613bb8c9f0
2026-03-23 03:18:18,926 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3351c1d9-0674-4bd9-a0af-5e0c1802a142
2026-03-23 03:18:18,938 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3351c1d9-0674-4bd9-a0af-5e0c1802a142
2026-03-23 03:18:18,948 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/e7f21fd5-15c6-4788-b4e6-6a197491ae30
2026-03-23 03:18:18,956 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-23 03:18:18,956 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5d010070-28a2-4647-b03e-a8613bb8c9f0
2026-03-23 03:18:18,966 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3351c1d9-0674-4bd9-a0af-5e0c1802a142
2026-03-23 03:18:18,984 - INFO - Verified VN network id 15 for VN 5d010070-28a2-4647-b03e-a8613bb8c9f0
2026-03-23 03:18:18,984 - INFO - Verifications in API Server for VN ctest-mgmt_vn-76520060 passed
2026-03-23 03:18:18,984 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5d010070-28a2-4647-b03e-a8613bb8c9f0
2026-03-23 03:18:18,996 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3351c1d9-0674-4bd9-a0af-5e0c1802a142
2026-03-23 03:18:19,005 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3351c1d9-0674-4bd9-a0af-5e0c1802a142
2026-03-23 03:18:19,014 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/e7f21fd5-15c6-4788-b4e6-6a197491ae30
2026-03-23 03:18:19,029 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-76520060', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-66442757', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6701638202222069319', 'uuid-lslong': '12699773134798637552'}, 'enable': 'true', 'created': '2026-03-23T03:18:18', 'last-modified': '2026-03-23T03:18:18', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.431063'}
2026-03-23 03:18:19,035 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-23 03:18:19,040 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-76520060', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-66442757', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6701638202222069319', 'uuid-lslong': '12699773134798637552'}, 'enable': 'true', 'created': '2026-03-23T03:18:18', 'last-modified': '2026-03-23T03:18:18', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.433358'}
2026-03-23 03:18:19,048 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-23 03:18:19,054 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-76520060', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-66442757', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6701638202222069319', 'uuid-lslong': '12699773134798637552'}, 'enable': 'true', 'created': '2026-03-23T03:18:18', 'last-modified': '2026-03-23T03:18:18', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.457538'}
2026-03-23 03:18:19,061 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-23 03:18:19,061 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-76520060 passed
2026-03-23 03:18:19,062 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-76520060 in API_Server ======
2026-03-23 03:18:19,062 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:18:19,069 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:18:19,083 - DEBUG - Requesting: http://10.0.0.27:8082/project/6cbaad08-1574-4da2-8dd7-0b5e8191a229
2026-03-23 03:18:19,179 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/5d010070-28a2-4647-b03e-a8613bb8c9f0
2026-03-23 03:18:19,190 - DEBUG - =>VN ctest-mgmt_vn-76520060 has no policy to be verified
2026-03-23 03:18:19,190 - DEBUG - Verifying the vn in opserver
2026-03-23 03:18:19,191 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-76520060 virtual network link through opserver 10.0.0.27
2026-03-23 03:18:19,191 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-23 03:18:19,206 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-76520060', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-76520060?flat'}
2026-03-23 03:18:19,206 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-76520060 virtual network link through opserver 10.0.0.50
2026-03-23 03:18:19,206 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-03-23 03:18:19,222 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-76520060', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-76520060?flat'}
2026-03-23 03:18:19,222 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-76520060 virtual network link through opserver 10.0.0.23
2026-03-23 03:18:19,222 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-03-23 03:18:19,235 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-76520060', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-76520060?flat'}
2026-03-23 03:18:19,235 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-66442757:ctest-mgmt_vn-76520060 is found in opserver
2026-03-23 03:18:19,260 - DEBUG - Do not have enough data to verify VN in agent
2026-03-23 03:18:19,274 - DEBUG - VRF ids for VN ctest-mgmt_vn-76520060: {}
2026-03-23 03:18:19,535 - DEBUG - Response for create_network : {'network': {'id': '3d18e936-9917-4198-87d2-50217404bff7', 'name': 'ctest-left_vn-13367854', 'tenant_id': '6cbaad0815744da28dd70b5e8191a229', 'project_id': '6cbaad0815744da28dd70b5e8191a229', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-66442757', 'ctest-left_vn-13367854'], 'port_security_enabled': True, 'description': ''}}
2026-03-23 03:18:19,827 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e9644e16-8e9f-4a6c-837c-c54d2ce6d01f', 'name': '', 'tenant_id': '6cbaad0815744da28dd70b5e8191a229', 'network_id': '3d18e936-9917-4198-87d2-50217404bff7', 'ip_version': 4, 'cidr': '186.150.177.0/26', 'allocation_pools': [{'start': '186.150.177.2', 'end': '186.150.177.62'}], 'gateway_ip': '186.150.177.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '186.150.177.2', 'tags': [], 'project_id': '6cbaad0815744da28dd70b5e8191a229'}}
2026-03-23 03:18:19,852 - INFO - Created VN ctest-left_vn-13367854
2026-03-23 03:18:19,864 - DEBUG - VN ctest-left_vn-13367854 UUID is 3d18e936-9917-4198-87d2-50217404bff7
2026-03-23 03:18:19,940 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:18:19,946 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:18:19,959 - DEBUG - Requesting: http://10.0.0.27:8082/project/6cbaad08-1574-4da2-8dd7-0b5e8191a229
2026-03-23 03:18:20,054 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/3d18e936-9917-4198-87d2-50217404bff7
2026-03-23 03:18:20,067 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/3d18e936-9917-4198-87d2-50217404bff7
2026-03-23 03:18:20,076 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/095bc99d-3d2b-4d4b-8867-b7feb9602599
2026-03-23 03:18:20,084 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/095bc99d-3d2b-4d4b-8867-b7feb9602599
2026-03-23 03:18:20,093 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/6af5d753-d04a-4f38-953c-e63c9e06e8c8
2026-03-23 03:18:20,103 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-23 03:18:20,104 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/3d18e936-9917-4198-87d2-50217404bff7
2026-03-23 03:18:20,123 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/095bc99d-3d2b-4d4b-8867-b7feb9602599
2026-03-23 03:18:20,144 - INFO - Verified VN network id 16 for VN 3d18e936-9917-4198-87d2-50217404bff7
2026-03-23 03:18:20,144 - INFO - Verifications in API Server for VN ctest-left_vn-13367854 passed
2026-03-23 03:18:20,144 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/3d18e936-9917-4198-87d2-50217404bff7
2026-03-23 03:18:20,157 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/095bc99d-3d2b-4d4b-8867-b7feb9602599
2026-03-23 03:18:20,167 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/095bc99d-3d2b-4d4b-8867-b7feb9602599
2026-03-23 03:18:20,176 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/6af5d753-d04a-4f38-953c-e63c9e06e8c8
2026-03-23 03:18:20,191 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-66442757:ctest-left_vn-13367854', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-66442757', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4402525056460603800', 'uuid-lslong': '9786973044840120311'}, 'enable': 'true', 'created': '2026-03-23T03:18:19', 'last-modified': '2026-03-23T03:18:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.435680'}
2026-03-23 03:18:20,198 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-23 03:18:20,204 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-66442757:ctest-left_vn-13367854', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-66442757', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4402525056460603800', 'uuid-lslong': '9786973044840120311'}, 'enable': 'true', 'created': '2026-03-23T03:18:19', 'last-modified': '2026-03-23T03:18:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.449829'}
2026-03-23 03:18:20,211 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-23 03:18:20,218 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-66442757:ctest-left_vn-13367854', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-66442757', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4402525056460603800', 'uuid-lslong': '9786973044840120311'}, 'enable': 'true', 'created': '2026-03-23T03:18:19', 'last-modified': '2026-03-23T03:18:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.465697'}
2026-03-23 03:18:20,225 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-23 03:18:20,226 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-13367854 passed
2026-03-23 03:18:20,226 - DEBUG - ====Verifying policy data for ctest-left_vn-13367854 in API_Server ======
2026-03-23 03:18:20,226 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:18:20,238 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:18:20,249 - DEBUG - Requesting: http://10.0.0.27:8082/project/6cbaad08-1574-4da2-8dd7-0b5e8191a229
2026-03-23 03:18:20,336 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/3d18e936-9917-4198-87d2-50217404bff7
2026-03-23 03:18:20,351 - DEBUG - =>VN ctest-left_vn-13367854 has no policy to be verified
2026-03-23 03:18:20,351 - DEBUG - Verifying the vn in opserver
2026-03-23 03:18:20,351 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-66442757:ctest-left_vn-13367854 virtual network link through opserver 10.0.0.27
2026-03-23 03:18:20,351 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-23 03:18:20,364 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-66442757:ctest-left_vn-13367854', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-66442757:ctest-left_vn-13367854?flat'}
2026-03-23 03:18:20,365 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-66442757:ctest-left_vn-13367854 virtual network link through opserver 10.0.0.50
2026-03-23 03:18:20,365 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-03-23 03:18:20,378 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-66442757:ctest-left_vn-13367854', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-66442757:ctest-left_vn-13367854?flat'}
2026-03-23 03:18:20,378 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-66442757:ctest-left_vn-13367854 virtual network link through opserver 10.0.0.23
2026-03-23 03:18:20,378 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-03-23 03:18:20,393 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-66442757:ctest-left_vn-13367854', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-66442757:ctest-left_vn-13367854?flat'}
2026-03-23 03:18:20,393 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-66442757:ctest-left_vn-13367854 is found in opserver
2026-03-23 03:18:20,419 - DEBUG - Do not have enough data to verify VN in agent
2026-03-23 03:18:20,431 - DEBUG - VRF ids for VN ctest-left_vn-13367854: {}
2026-03-23 03:18:20,705 - DEBUG - Response for create_network : {'network': {'id': '73726822-9025-4f0d-b427-62d89b3621a3', 'name': 'ctest-right_vn-04969067', 'tenant_id': '6cbaad0815744da28dd70b5e8191a229', 'project_id': '6cbaad0815744da28dd70b5e8191a229', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-66442757', 'ctest-right_vn-04969067'], 'port_security_enabled': True, 'description': ''}}
2026-03-23 03:18:22,364 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd4fd0bb0-c178-4ef4-9019-3f29f04aa4e1', 'name': '', 'tenant_id': '6cbaad0815744da28dd70b5e8191a229', 'network_id': '73726822-9025-4f0d-b427-62d89b3621a3', 'ip_version': 4, 'cidr': '172.137.249.128/26', 'allocation_pools': [{'start': '172.137.249.130', 'end': '172.137.249.190'}], 'gateway_ip': '172.137.249.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '172.137.249.130', 'tags': [], 'project_id': '6cbaad0815744da28dd70b5e8191a229'}}
2026-03-23 03:18:22,388 - INFO - Created VN ctest-right_vn-04969067
2026-03-23 03:18:22,403 - DEBUG - VN ctest-right_vn-04969067 UUID is 73726822-9025-4f0d-b427-62d89b3621a3
2026-03-23 03:18:22,477 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:18:22,485 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:18:22,499 - DEBUG - Requesting: http://10.0.0.27:8082/project/6cbaad08-1574-4da2-8dd7-0b5e8191a229
2026-03-23 03:18:22,587 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/73726822-9025-4f0d-b427-62d89b3621a3
2026-03-23 03:18:22,601 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/73726822-9025-4f0d-b427-62d89b3621a3
2026-03-23 03:18:22,611 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/edb86809-30ac-43e2-b66e-e33402b00da7
2026-03-23 03:18:22,619 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/edb86809-30ac-43e2-b66e-e33402b00da7
2026-03-23 03:18:22,626 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/05c6c0a4-0b93-4253-b886-eb41bff9f2ee
2026-03-23 03:18:22,634 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-23 03:18:22,634 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/73726822-9025-4f0d-b427-62d89b3621a3
2026-03-23 03:18:22,644 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/edb86809-30ac-43e2-b66e-e33402b00da7
2026-03-23 03:18:22,661 - INFO - Verified VN network id 17 for VN 73726822-9025-4f0d-b427-62d89b3621a3
2026-03-23 03:18:22,661 - INFO - Verifications in API Server for VN ctest-right_vn-04969067 passed
2026-03-23 03:18:22,661 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/73726822-9025-4f0d-b427-62d89b3621a3
2026-03-23 03:18:22,671 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/edb86809-30ac-43e2-b66e-e33402b00da7
2026-03-23 03:18:22,679 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/edb86809-30ac-43e2-b66e-e33402b00da7
2026-03-23 03:18:22,686 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/05c6c0a4-0b93-4253-b886-eb41bff9f2ee
2026-03-23 03:18:22,700 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-66442757:ctest-right_vn-04969067', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-66442757', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8318825959363268365', 'uuid-lslong': '12981453133375218083'}, 'enable': 'true', 'created': '2026-03-23T03:18:20', 'last-modified': '2026-03-23T03:18:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.396970'}
2026-03-23 03:18:22,708 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-23 03:18:22,713 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-66442757:ctest-right_vn-04969067', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-66442757', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8318825959363268365', 'uuid-lslong': '12981453133375218083'}, 'enable': 'true', 'created': '2026-03-23T03:18:20', 'last-modified': '2026-03-23T03:18:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.408386'}
2026-03-23 03:18:22,719 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-23 03:18:22,724 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-66442757:ctest-right_vn-04969067', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-66442757', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8318825959363268365', 'uuid-lslong': '12981453133375218083'}, 'enable': 'true', 'created': '2026-03-23T03:18:20', 'last-modified': '2026-03-23T03:18:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.420945'}
2026-03-23 03:18:22,731 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-23 03:18:22,731 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-04969067 passed
2026-03-23 03:18:22,732 - DEBUG - ====Verifying policy data for ctest-right_vn-04969067 in API_Server ======
2026-03-23 03:18:22,732 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:18:22,739 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:18:22,753 - DEBUG - Requesting: http://10.0.0.27:8082/project/6cbaad08-1574-4da2-8dd7-0b5e8191a229
2026-03-23 03:18:22,841 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/73726822-9025-4f0d-b427-62d89b3621a3
2026-03-23 03:18:22,860 - DEBUG - =>VN ctest-right_vn-04969067 has no policy to be verified
2026-03-23 03:18:22,860 - DEBUG - Verifying the vn in opserver
2026-03-23 03:18:22,860 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-66442757:ctest-right_vn-04969067 virtual network link through opserver 10.0.0.27
2026-03-23 03:18:22,860 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-23 03:18:22,876 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-66442757:ctest-right_vn-04969067', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-66442757:ctest-right_vn-04969067?flat'}
2026-03-23 03:18:22,876 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-66442757:ctest-right_vn-04969067 virtual network link through opserver 10.0.0.50
2026-03-23 03:18:22,876 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-03-23 03:18:22,891 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-66442757:ctest-right_vn-04969067', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-66442757:ctest-right_vn-04969067?flat'}
2026-03-23 03:18:22,891 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-66442757:ctest-right_vn-04969067 virtual network link through opserver 10.0.0.23
2026-03-23 03:18:22,891 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-03-23 03:18:22,903 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-66442757:ctest-right_vn-04969067', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-66442757:ctest-right_vn-04969067?flat'}
2026-03-23 03:18:22,903 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-66442757:ctest-right_vn-04969067 is found in opserver
2026-03-23 03:18:22,928 - DEBUG - Do not have enough data to verify VN in agent
2026-03-23 03:18:22,941 - DEBUG - VRF ids for VN ctest-right_vn-04969067: {}
2026-03-23 03:18:24,097 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5514-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5514-1)
2026-03-23 03:18:25,460 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5514-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5514-2)
2026-03-23 03:18:25,460 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-38708459']
2026-03-23 03:18:25,767 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-38708459'] created succesfully
2026-03-23 03:18:26,126 - DEBUG - Image by name tiny_nat_fw not found
2026-03-23 03:18:26,126 - DEBUG - Installing image tiny_nat_fw
2026-03-23 03:18:26,126 - 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-23 03:18:26,127 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-23 03:18:26,127 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-23 03:18:26,127 - DEBUG - Unzip image
2026-03-23 03:18:26,127 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-23 03:18:26,154 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-03-23 03:18:26,154 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-38708459']
2026-03-23 03:18:26,251 - INFO - Service template: ['default-domain', 'ctest-service_template_1-38708459'] deleted successfully.
2026-03-23 03:18:26,251 - INFO - Skip interface_detach for VM ctest-right_vm-94247979 in state BUILD
2026-03-23 03:18:26,251 - INFO - Deleting VM ctest-right_vm-94247979
2026-03-23 03:18:26,251 - ERROR - VM ctest-right_vm-94247979 has failed to come up
2026-03-23 03:18:26,252 - ERROR - Nova failed to get host of the VM
2026-03-23 03:18:26,252 - ERROR - VM ctest-right_vm-94247979 has failed to come up
2026-03-23 03:18:26,252 - ERROR - Nova failed to get host of the VM
2026-03-23 03:18:26,385 - INFO - Skip interface_detach for VM ctest-left_vm-75916266 in state BUILD
2026-03-23 03:18:26,386 - INFO - Deleting VM ctest-left_vm-75916266
2026-03-23 03:18:26,386 - ERROR - VM ctest-left_vm-75916266 has failed to come up
2026-03-23 03:18:26,387 - ERROR - Nova failed to get host of the VM
2026-03-23 03:18:26,387 - ERROR - VM ctest-left_vm-75916266 has failed to come up
2026-03-23 03:18:26,388 - ERROR - Nova failed to get host of the VM
2026-03-23 03:18:26,491 - INFO - Deleting VN ctest-right_vn-04969067
2026-03-23 03:18:26,548 - DEBUG - VN 73726822-9025-4f0d-b427-62d89b3621a3 still in use: Unable to complete operation on network 73726822-9025-4f0d-b427-62d89b3621a3. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-9d228105-e918-4280-b7f1-35a1c381d4ee']
2026-03-23 03:18:26,549 - WARNING - Deleting VN ctest-right_vn-04969067 failed..Will retry
2026-03-23 03:18:28,739 - DEBUG - Response for deleting network ()
2026-03-23 03:18:28,739 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/edb86809-30ac-43e2-b66e-e33402b00da7
2026-03-23 03:18:28,751 - DEBUG - Response Code: 404
2026-03-23 03:18:28,751 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:18:28,760 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:18:28,782 - DEBUG - Requesting: http://10.0.0.27:8082/project/6cbaad08-1574-4da2-8dd7-0b5e8191a229
2026-03-23 03:18:28,898 - INFO - Validated that VN ctest-right_vn-04969067 is not found in API Server
2026-03-23 03:18:28,911 - DEBUG - VN ctest-right_vn-04969067 is not present in Agent 10.0.0.249
2026-03-23 03:18:28,922 - DEBUG - VN ctest-right_vn-04969067 is not present in Agent 10.0.0.65
2026-03-23 03:18:28,922 - INFO - Validated that VN ctest-right_vn-04969067 is not in any agent
2026-03-23 03:18:28,967 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-04969067 info
2026-03-23 03:18:28,968 - INFO - Deleting VN ctest-left_vn-13367854
2026-03-23 03:18:29,142 - DEBUG - Response for deleting network ()
2026-03-23 03:18:29,143 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/095bc99d-3d2b-4d4b-8867-b7feb9602599
2026-03-23 03:18:29,150 - DEBUG - Response Code: 404
2026-03-23 03:18:29,151 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:18:29,168 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:18:29,184 - DEBUG - Requesting: http://10.0.0.27:8082/project/6cbaad08-1574-4da2-8dd7-0b5e8191a229
2026-03-23 03:18:29,296 - INFO - Validated that VN ctest-left_vn-13367854 is not found in API Server
2026-03-23 03:18:29,312 - DEBUG - VN ctest-left_vn-13367854 is not present in Agent 10.0.0.249
2026-03-23 03:18:29,325 - DEBUG - VN ctest-left_vn-13367854 is not present in Agent 10.0.0.65
2026-03-23 03:18:29,325 - INFO - Validated that VN ctest-left_vn-13367854 is not in any agent
2026-03-23 03:18:29,358 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-13367854 info
2026-03-23 03:18:29,358 - INFO - Deleting VN ctest-mgmt_vn-76520060
2026-03-23 03:18:29,527 - DEBUG - Response for deleting network ()
2026-03-23 03:18:29,528 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3351c1d9-0674-4bd9-a0af-5e0c1802a142
2026-03-23 03:18:29,544 - DEBUG - Response Code: 404
2026-03-23 03:18:29,544 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-03-23 03:18:29,556 - DEBUG - Requesting: http://10.0.0.27:8082/domain/54adab80-1c58-45eb-8fc6-565ee3803789
2026-03-23 03:18:29,572 - DEBUG - Requesting: http://10.0.0.27:8082/project/6cbaad08-1574-4da2-8dd7-0b5e8191a229
2026-03-23 03:18:29,676 - INFO - Validated that VN ctest-mgmt_vn-76520060 is not found in API Server
2026-03-23 03:18:29,687 - DEBUG - VN ctest-mgmt_vn-76520060 is not present in Agent 10.0.0.249
2026-03-23 03:18:29,701 - DEBUG - VN ctest-mgmt_vn-76520060 is not present in Agent 10.0.0.65
2026-03-23 03:18:29,701 - INFO - Validated that VN ctest-mgmt_vn-76520060 is not in any agent
2026-03-23 03:18:29,737 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-76520060 info
2026-03-23 03:18:31,034 - DEBUG - No XMPP flaps were noticed during the test
2026-03-23 03:18:31,034 - INFO -
2026-03-23 03:18:31,034 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:15]
2026-03-23 03:18:31,034 - INFO - --------------------------------------------------------------------------------
2026-03-23 03:18:31,847 - INFO - Deleted project: ctest-TestSvcRegr-66442757, ID : 6cbaad08-1574-4da2-8dd7-0b5e8191a229