]) created on node: (an-jenkins-deploy-platform-ansible-os-4339-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4339-1)
2025-10-16 03:15:58,753 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-48182512']
2025-10-16 03:15:59,036 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-48182512'] created succesfully
2025-10-16 03:15:59,437 - DEBUG - Image by name tiny_nat_fw not found
2025-10-16 03:15:59,437 - DEBUG - Installing image tiny_nat_fw
2025-10-16 03:15:59,437 - 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'"}
2025-10-16 03:15:59,438 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2025-10-16 03:15:59,438 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2025-10-16 03:15:59,476 - 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
2025-10-16 03:15:59,545 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-10-16 03:15:59,545 - DEBUG - Unzip image
2025-10-16 03:15:59,545 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-10-16 03:15:59,581 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2025-10-16 03:15:59,581 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-48182512']
2025-10-16 03:15:59,682 - INFO - Service template: ['default-domain', 'ctest-service_template_1-48182512'] deleted successfully.
2025-10-16 03:15:59,682 - INFO - Skip interface_detach for VM ctest-right_vm-76411411 in state BUILD
2025-10-16 03:15:59,682 - INFO - Deleting VM ctest-right_vm-76411411
2025-10-16 03:15:59,732 - ERROR - VM ctest-right_vm-76411411 has failed to come up
2025-10-16 03:15:59,732 - ERROR - Nova failed to get host of the VM
2025-10-16 03:15:59,732 - ERROR - VM ctest-right_vm-76411411 has failed to come up
2025-10-16 03:15:59,732 - ERROR - Nova failed to get host of the VM
2025-10-16 03:15:59,816 - INFO - Skip interface_detach for VM ctest-left_vm-19368781 in state BUILD
2025-10-16 03:15:59,816 - INFO - Deleting VM ctest-left_vm-19368781
2025-10-16 03:15:59,816 - ERROR - VM ctest-left_vm-19368781 has failed to come up
2025-10-16 03:15:59,816 - ERROR - Nova failed to get host of the VM
2025-10-16 03:15:59,816 - ERROR - VM ctest-left_vm-19368781 has failed to come up
2025-10-16 03:15:59,817 - ERROR - Nova failed to get host of the VM
2025-10-16 03:15:59,880 - INFO - Deleting VN ctest-right_vn-79657098
2025-10-16 03:15:59,918 - DEBUG - VN 27d20a3f-c0dd-40b3-a333-f852603abd59 still in use: Unable to complete operation on network 27d20a3f-c0dd-40b3-a333-f852603abd59. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-f29ded4d-a7de-495b-96be-0caecf4face0']
2025-10-16 03:15:59,918 - WARNING - Deleting VN ctest-right_vn-79657098 failed..Will retry
2025-10-16 03:16:02,097 - DEBUG - Response for deleting network ()
2025-10-16 03:16:02,097 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/cad9631b-5817-4715-a62b-dfe9b9045b48
2025-10-16 03:16:02,123 - DEBUG - Response Code: 404
2025-10-16 03:16:02,123 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:02,130 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:02,148 - DEBUG - Requesting: http://10.0.0.19:8082/project/ef702d23-9ebf-4835-a58a-7d638b92e2a9
2025-10-16 03:16:02,277 - INFO - Validated that VN ctest-right_vn-79657098 is not found in API Server
2025-10-16 03:16:02,288 - DEBUG - VN ctest-right_vn-79657098 is not present in Agent 10.0.0.38
2025-10-16 03:16:02,299 - DEBUG - VN ctest-right_vn-79657098 is not present in Agent 10.0.0.129
2025-10-16 03:16:02,299 - INFO - Validated that VN ctest-right_vn-79657098 is not in any agent
2025-10-16 03:16:02,332 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-79657098 info
2025-10-16 03:16:02,332 - INFO - Deleting VN ctest-left_vn-30465327
2025-10-16 03:16:02,544 - DEBUG - Response for deleting network ()
2025-10-16 03:16:02,544 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/da9180e9-b55b-495d-8563-24652c05b434
2025-10-16 03:16:02,552 - DEBUG - Response Code: 404
2025-10-16 03:16:02,553 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:02,560 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:02,576 - DEBUG - Requesting: http://10.0.0.19:8082/project/ef702d23-9ebf-4835-a58a-7d638b92e2a9
2025-10-16 03:16:02,675 - INFO - Validated that VN ctest-left_vn-30465327 is not found in API Server
2025-10-16 03:16:02,689 - DEBUG - VN ctest-left_vn-30465327 is not present in Agent 10.0.0.38
2025-10-16 03:16:02,699 - DEBUG - VN ctest-left_vn-30465327 is not present in Agent 10.0.0.129
2025-10-16 03:16:02,700 - INFO - Validated that VN ctest-left_vn-30465327 is not in any agent
2025-10-16 03:16:02,736 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-30465327 info
2025-10-16 03:16:02,736 - INFO - Deleting VN ctest-mgmt_vn-63319275
2025-10-16 03:16:02,870 - DEBUG - Response for deleting network ()
2025-10-16 03:16:02,870 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/4a5f7f7e-b2ad-4403-b557-b1b5179160eb
2025-10-16 03:16:02,878 - DEBUG - Response Code: 404
2025-10-16 03:16:02,878 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:02,886 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:02,901 - DEBUG - Requesting: http://10.0.0.19:8082/project/ef702d23-9ebf-4835-a58a-7d638b92e2a9
2025-10-16 03:16:03,005 - INFO - Validated that VN ctest-mgmt_vn-63319275 is not found in API Server
2025-10-16 03:16:03,020 - DEBUG - VN ctest-mgmt_vn-63319275 is not present in Agent 10.0.0.38
2025-10-16 03:16:03,032 - DEBUG - VN ctest-mgmt_vn-63319275 is not present in Agent 10.0.0.129
2025-10-16 03:16:03,032 - INFO - Validated that VN ctest-mgmt_vn-63319275 is not in any agent
2025-10-16 03:16:03,069 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-63319275 info
2025-10-16 03:16:03,069 - INFO - Deleting VM ctest-vm-in-third-vn-32028685
2025-10-16 03:16:03,151 - INFO - Deleting VN ctest-third-vn-39728681
2025-10-16 03:16:03,211 - DEBUG - VN 5be985c6-ef4a-4143-b40e-62c6ef63b3c0 still in use: Unable to complete operation on network 5be985c6-ef4a-4143-b40e-62c6ef63b3c0. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-817ba32f-c03f-4974-8c13-64d17c78bf74']
2025-10-16 03:16:03,211 - WARNING - Deleting VN ctest-third-vn-39728681 failed..Will retry
2025-10-16 03:16:05,376 - DEBUG - Response for deleting network ()
2025-10-16 03:16:06,663 - DEBUG - No XMPP flaps were noticed during the test
2025-10-16 03:16:06,663 - INFO -
2025-10-16 03:16:06,664 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:24]
2025-10-16 03:16:06,664 - INFO - --------------------------------------------------------------------------------
2025-10-16 03:16:06,667 - INFO - ================================================================================
2025-10-16 03:16:06,667 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2025-10-16 03:16:07,940 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.252': '0', '10.20.0.5': '0'}, '10.0.0.129': {'10.20.0.5': '0', '10.20.0.252': '0'}} with
2025-10-16 03:16:07,940 - INFO - Initial checks done. Running the testcase now
2025-10-16 03:16:07,940 - INFO -
2025-10-16 03:16:08,173 - DEBUG - Response for create_network : {'network': {'id': '5ee58ee5-9e18-4f72-806e-0246f798bd5c', 'name': 'ctest-mgmt_vn-22801618', 'tenant_id': 'ef702d239ebf4835a58a7d638b92e2a9', 'project_id': 'ef702d239ebf4835a58a7d638b92e2a9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-68345150', 'ctest-mgmt_vn-22801618'], 'port_security_enabled': True, 'description': ''}}
2025-10-16 03:16:08,364 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd44f905b-8f6b-4835-9946-2cd35bddd652', 'name': '', 'tenant_id': 'ef702d239ebf4835a58a7d638b92e2a9', 'network_id': '5ee58ee5-9e18-4f72-806e-0246f798bd5c', 'ip_version': 4, 'cidr': '22.230.100.64/26', 'allocation_pools': [{'start': '22.230.100.66', 'end': '22.230.100.126'}], 'gateway_ip': '22.230.100.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '22.230.100.66', 'tags': [], 'project_id': 'ef702d239ebf4835a58a7d638b92e2a9'}}
2025-10-16 03:16:08,386 - INFO - Created VN ctest-mgmt_vn-22801618
2025-10-16 03:16:08,398 - DEBUG - VN ctest-mgmt_vn-22801618 UUID is 5ee58ee5-9e18-4f72-806e-0246f798bd5c
2025-10-16 03:16:08,468 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:08,473 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:08,486 - DEBUG - Requesting: http://10.0.0.19:8082/project/ef702d23-9ebf-4835-a58a-7d638b92e2a9
2025-10-16 03:16:08,580 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/5ee58ee5-9e18-4f72-806e-0246f798bd5c
2025-10-16 03:16:08,594 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/5ee58ee5-9e18-4f72-806e-0246f798bd5c
2025-10-16 03:16:08,605 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/0b38b61d-182c-41a6-8cac-f9763a200117
2025-10-16 03:16:08,612 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/0b38b61d-182c-41a6-8cac-f9763a200117
2025-10-16 03:16:08,619 - DEBUG - Route Targets: []
2025-10-16 03:16:08,619 - DEBUG - RT names not yet present for VN ctest-mgmt_vn-22801618
2025-10-16 03:16:13,620 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:13,631 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:13,648 - DEBUG - Requesting: http://10.0.0.19:8082/project/ef702d23-9ebf-4835-a58a-7d638b92e2a9
2025-10-16 03:16:13,750 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/5ee58ee5-9e18-4f72-806e-0246f798bd5c
2025-10-16 03:16:13,772 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/5ee58ee5-9e18-4f72-806e-0246f798bd5c
2025-10-16 03:16:13,787 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/0b38b61d-182c-41a6-8cac-f9763a200117
2025-10-16 03:16:13,799 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/0b38b61d-182c-41a6-8cac-f9763a200117
2025-10-16 03:16:13,807 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/d0841bf4-1ad5-4004-a727-26f1dea35a2a
2025-10-16 03:16:13,816 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-16 03:16:13,816 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/5ee58ee5-9e18-4f72-806e-0246f798bd5c
2025-10-16 03:16:13,827 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/0b38b61d-182c-41a6-8cac-f9763a200117
2025-10-16 03:16:13,844 - INFO - Verified VN network id 11 for VN 5ee58ee5-9e18-4f72-806e-0246f798bd5c
2025-10-16 03:16:13,846 - INFO - Verifications in API Server for VN ctest-mgmt_vn-22801618 passed
2025-10-16 03:16:13,846 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/5ee58ee5-9e18-4f72-806e-0246f798bd5c
2025-10-16 03:16:13,857 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/0b38b61d-182c-41a6-8cac-f9763a200117
2025-10-16 03:16:13,866 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/0b38b61d-182c-41a6-8cac-f9763a200117
2025-10-16 03:16:13,874 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/d0841bf4-1ad5-4004-a727-26f1dea35a2a
2025-10-16 03:16:13,888 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-68345150:ctest-mgmt_vn-22801618', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-68345150', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6838028726083014514', 'uuid-lslong': '9254336788117896540'}, 'enable': 'true', 'created': '2025-10-16T03:16:08', 'last-modified': '2025-10-16T03:16:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.574311'}
2025-10-16 03:16:13,895 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-16 03:16:13,901 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-68345150:ctest-mgmt_vn-22801618', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-68345150', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6838028726083014514', 'uuid-lslong': '9254336788117896540'}, 'enable': 'true', 'created': '2025-10-16T03:16:08', 'last-modified': '2025-10-16T03:16:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.583452'}
2025-10-16 03:16:13,907 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-16 03:16:13,912 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-68345150:ctest-mgmt_vn-22801618', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-68345150', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6838028726083014514', 'uuid-lslong': '9254336788117896540'}, 'enable': 'true', 'created': '2025-10-16T03:16:08', 'last-modified': '2025-10-16T03:16:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.592381'}
2025-10-16 03:16:13,918 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-16 03:16:13,918 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-22801618 passed
2025-10-16 03:16:13,918 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-22801618 in API_Server ======
2025-10-16 03:16:13,918 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:13,924 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:13,943 - DEBUG - Requesting: http://10.0.0.19:8082/project/ef702d23-9ebf-4835-a58a-7d638b92e2a9
2025-10-16 03:16:14,043 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/5ee58ee5-9e18-4f72-806e-0246f798bd5c
2025-10-16 03:16:14,052 - DEBUG - =>VN ctest-mgmt_vn-22801618 has no policy to be verified
2025-10-16 03:16:14,052 - DEBUG - Verifying the vn in opserver
2025-10-16 03:16:14,052 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-68345150:ctest-mgmt_vn-22801618 virtual network link through opserver 10.0.0.19
2025-10-16 03:16:14,052 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-10-16 03:16:14,062 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-68345150:ctest-mgmt_vn-22801618', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-68345150:ctest-mgmt_vn-22801618?flat'}
2025-10-16 03:16:14,063 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-68345150:ctest-mgmt_vn-22801618 virtual network link through opserver 10.0.0.57
2025-10-16 03:16:14,063 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-10-16 03:16:14,074 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-68345150:ctest-mgmt_vn-22801618', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-68345150:ctest-mgmt_vn-22801618?flat'}
2025-10-16 03:16:14,074 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-68345150:ctest-mgmt_vn-22801618 virtual network link through opserver 10.0.0.23
2025-10-16 03:16:14,074 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-10-16 03:16:14,085 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-68345150:ctest-mgmt_vn-22801618', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-68345150:ctest-mgmt_vn-22801618?flat'}
2025-10-16 03:16:14,085 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-68345150:ctest-mgmt_vn-22801618 is found in opserver
2025-10-16 03:16:14,107 - DEBUG - Do not have enough data to verify VN in agent
2025-10-16 03:16:14,117 - DEBUG - VRF ids for VN ctest-mgmt_vn-22801618: {}
2025-10-16 03:16:14,403 - DEBUG - Response for create_network : {'network': {'id': 'ff034aae-2795-43a4-8c8d-388731519f2e', 'name': 'ctest-left_vn-58240837', 'tenant_id': 'ef702d239ebf4835a58a7d638b92e2a9', 'project_id': 'ef702d239ebf4835a58a7d638b92e2a9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-68345150', 'ctest-left_vn-58240837'], 'port_security_enabled': True, 'description': ''}}
2025-10-16 03:16:14,641 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f012d76b-d1b6-4cfc-ba07-9fa8aaa1d88f', 'name': '', 'tenant_id': 'ef702d239ebf4835a58a7d638b92e2a9', 'network_id': 'ff034aae-2795-43a4-8c8d-388731519f2e', 'ip_version': 4, 'cidr': '153.205.100.0/26', 'allocation_pools': [{'start': '153.205.100.2', 'end': '153.205.100.62'}], 'gateway_ip': '153.205.100.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '153.205.100.2', 'tags': [], 'project_id': 'ef702d239ebf4835a58a7d638b92e2a9'}}
2025-10-16 03:16:14,665 - INFO - Created VN ctest-left_vn-58240837
2025-10-16 03:16:14,676 - DEBUG - VN ctest-left_vn-58240837 UUID is ff034aae-2795-43a4-8c8d-388731519f2e
2025-10-16 03:16:14,757 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:14,764 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:14,779 - DEBUG - Requesting: http://10.0.0.19:8082/project/ef702d23-9ebf-4835-a58a-7d638b92e2a9
2025-10-16 03:16:14,877 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/ff034aae-2795-43a4-8c8d-388731519f2e
2025-10-16 03:16:14,888 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/ff034aae-2795-43a4-8c8d-388731519f2e
2025-10-16 03:16:14,897 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/381dc85e-01fc-47cc-9033-10c90a403b32
2025-10-16 03:16:14,903 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/381dc85e-01fc-47cc-9033-10c90a403b32
2025-10-16 03:16:14,910 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/decd75b2-5ce1-44ca-80e6-7c3780dddbd7
2025-10-16 03:16:14,916 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-16 03:16:14,916 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/ff034aae-2795-43a4-8c8d-388731519f2e
2025-10-16 03:16:14,926 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/381dc85e-01fc-47cc-9033-10c90a403b32
2025-10-16 03:16:14,942 - INFO - Verified VN network id 12 for VN ff034aae-2795-43a4-8c8d-388731519f2e
2025-10-16 03:16:14,942 - INFO - Verifications in API Server for VN ctest-left_vn-58240837 passed
2025-10-16 03:16:14,942 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/ff034aae-2795-43a4-8c8d-388731519f2e
2025-10-16 03:16:14,953 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/381dc85e-01fc-47cc-9033-10c90a403b32
2025-10-16 03:16:14,962 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/381dc85e-01fc-47cc-9033-10c90a403b32
2025-10-16 03:16:14,969 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/decd75b2-5ce1-44ca-80e6-7c3780dddbd7
2025-10-16 03:16:14,980 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-68345150:ctest-left_vn-58240837', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-68345150', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18375613016450614180', 'uuid-lslong': '10127813290325286702'}, 'enable': 'true', 'created': '2025-10-16T03:16:14', 'last-modified': '2025-10-16T03:16:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.390743'}
2025-10-16 03:16:14,987 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-16 03:16:14,992 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-68345150:ctest-left_vn-58240837', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-68345150', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18375613016450614180', 'uuid-lslong': '10127813290325286702'}, 'enable': 'true', 'created': '2025-10-16T03:16:14', 'last-modified': '2025-10-16T03:16:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.412425'}
2025-10-16 03:16:15,000 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-16 03:16:15,005 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-68345150:ctest-left_vn-58240837', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-68345150', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18375613016450614180', 'uuid-lslong': '10127813290325286702'}, 'enable': 'true', 'created': '2025-10-16T03:16:14', 'last-modified': '2025-10-16T03:16:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.424610'}
2025-10-16 03:16:15,012 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-16 03:16:15,012 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-58240837 passed
2025-10-16 03:16:15,012 - DEBUG - ====Verifying policy data for ctest-left_vn-58240837 in API_Server ======
2025-10-16 03:16:15,012 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:15,020 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:15,030 - DEBUG - Requesting: http://10.0.0.19:8082/project/ef702d23-9ebf-4835-a58a-7d638b92e2a9
2025-10-16 03:16:15,124 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/ff034aae-2795-43a4-8c8d-388731519f2e
2025-10-16 03:16:15,133 - DEBUG - =>VN ctest-left_vn-58240837 has no policy to be verified
2025-10-16 03:16:15,133 - DEBUG - Verifying the vn in opserver
2025-10-16 03:16:15,133 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-68345150:ctest-left_vn-58240837 virtual network link through opserver 10.0.0.19
2025-10-16 03:16:15,133 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-10-16 03:16:15,146 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-68345150:ctest-left_vn-58240837', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-68345150:ctest-left_vn-58240837?flat'}
2025-10-16 03:16:15,146 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-68345150:ctest-left_vn-58240837 virtual network link through opserver 10.0.0.57
2025-10-16 03:16:15,146 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-10-16 03:16:15,159 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-68345150:ctest-left_vn-58240837', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-68345150:ctest-left_vn-58240837?flat'}
2025-10-16 03:16:15,159 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-68345150:ctest-left_vn-58240837 virtual network link through opserver 10.0.0.23
2025-10-16 03:16:15,159 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-10-16 03:16:15,171 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-68345150:ctest-left_vn-58240837', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-68345150:ctest-left_vn-58240837?flat'}
2025-10-16 03:16:15,171 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-68345150:ctest-left_vn-58240837 is found in opserver
2025-10-16 03:16:15,197 - DEBUG - Do not have enough data to verify VN in agent
2025-10-16 03:16:15,208 - DEBUG - VRF ids for VN ctest-left_vn-58240837: {}
2025-10-16 03:16:15,504 - DEBUG - Response for create_network : {'network': {'id': 'd98da927-35de-434d-8b10-d40574a10f45', 'name': 'ctest-right_vn-19943578', 'tenant_id': 'ef702d239ebf4835a58a7d638b92e2a9', 'project_id': 'ef702d239ebf4835a58a7d638b92e2a9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-68345150', 'ctest-right_vn-19943578'], 'port_security_enabled': True, 'description': ''}}
2025-10-16 03:16:15,696 - DEBUG - Response for create_subnet : {'subnet': {'id': '5fef709b-26d9-4404-b2cd-be6cfc0b68eb', 'name': '', 'tenant_id': 'ef702d239ebf4835a58a7d638b92e2a9', 'network_id': 'd98da927-35de-434d-8b10-d40574a10f45', 'ip_version': 4, 'cidr': '167.238.41.0/26', 'allocation_pools': [{'start': '167.238.41.2', 'end': '167.238.41.62'}], 'gateway_ip': '167.238.41.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '167.238.41.2', 'tags': [], 'project_id': 'ef702d239ebf4835a58a7d638b92e2a9'}}
2025-10-16 03:16:15,717 - INFO - Created VN ctest-right_vn-19943578
2025-10-16 03:16:15,726 - DEBUG - VN ctest-right_vn-19943578 UUID is d98da927-35de-434d-8b10-d40574a10f45
2025-10-16 03:16:15,796 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:15,802 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:15,814 - DEBUG - Requesting: http://10.0.0.19:8082/project/ef702d23-9ebf-4835-a58a-7d638b92e2a9
2025-10-16 03:16:15,910 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/d98da927-35de-434d-8b10-d40574a10f45
2025-10-16 03:16:15,924 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/d98da927-35de-434d-8b10-d40574a10f45
2025-10-16 03:16:15,934 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/fcf1ed4d-850d-4782-bb93-0b519a0ed640
2025-10-16 03:16:15,944 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/fcf1ed4d-850d-4782-bb93-0b519a0ed640
2025-10-16 03:16:15,951 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/0a273bcd-fcb5-489d-b1c2-8fe941adb2b6
2025-10-16 03:16:15,959 - DEBUG - Route Targets: ['target:64512:8000007']
2025-10-16 03:16:15,960 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/d98da927-35de-434d-8b10-d40574a10f45
2025-10-16 03:16:15,970 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/fcf1ed4d-850d-4782-bb93-0b519a0ed640
2025-10-16 03:16:15,988 - INFO - Verified VN network id 13 for VN d98da927-35de-434d-8b10-d40574a10f45
2025-10-16 03:16:15,988 - INFO - Verifications in API Server for VN ctest-right_vn-19943578 passed
2025-10-16 03:16:15,988 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/d98da927-35de-434d-8b10-d40574a10f45
2025-10-16 03:16:16,000 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/fcf1ed4d-850d-4782-bb93-0b519a0ed640
2025-10-16 03:16:16,008 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/fcf1ed4d-850d-4782-bb93-0b519a0ed640
2025-10-16 03:16:16,015 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/0a273bcd-fcb5-489d-b1c2-8fe941adb2b6
2025-10-16 03:16:16,026 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-68345150:ctest-right_vn-19943578', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-68345150', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15676371863819141965', 'uuid-lslong': '10020742290795990853'}, 'enable': 'true', 'created': '2025-10-16T03:16:15', 'last-modified': '2025-10-16T03:16:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.375717'}
2025-10-16 03:16:16,036 - DEBUG - Route Targets: ['target:64512:8000007']
2025-10-16 03:16:16,042 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-68345150:ctest-right_vn-19943578', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-68345150', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15676371863819141965', 'uuid-lslong': '10020742290795990853'}, 'enable': 'true', 'created': '2025-10-16T03:16:15', 'last-modified': '2025-10-16T03:16:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.389183'}
2025-10-16 03:16:16,048 - DEBUG - Route Targets: ['target:64512:8000007']
2025-10-16 03:16:16,055 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-68345150:ctest-right_vn-19943578', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-68345150', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15676371863819141965', 'uuid-lslong': '10020742290795990853'}, 'enable': 'true', 'created': '2025-10-16T03:16:15', 'last-modified': '2025-10-16T03:16:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.404238'}
2025-10-16 03:16:16,061 - DEBUG - Route Targets: ['target:64512:8000007']
2025-10-16 03:16:16,061 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-19943578 passed
2025-10-16 03:16:16,061 - DEBUG - ====Verifying policy data for ctest-right_vn-19943578 in API_Server ======
2025-10-16 03:16:16,061 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:16,067 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:16,078 - DEBUG - Requesting: http://10.0.0.19:8082/project/ef702d23-9ebf-4835-a58a-7d638b92e2a9
2025-10-16 03:16:16,185 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/d98da927-35de-434d-8b10-d40574a10f45
2025-10-16 03:16:16,197 - DEBUG - =>VN ctest-right_vn-19943578 has no policy to be verified
2025-10-16 03:16:16,197 - DEBUG - Verifying the vn in opserver
2025-10-16 03:16:16,197 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-68345150:ctest-right_vn-19943578 virtual network link through opserver 10.0.0.19
2025-10-16 03:16:16,197 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-10-16 03:16:16,211 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-68345150:ctest-right_vn-19943578', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-68345150:ctest-right_vn-19943578?flat'}
2025-10-16 03:16:16,211 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-68345150:ctest-right_vn-19943578 virtual network link through opserver 10.0.0.57
2025-10-16 03:16:16,211 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-10-16 03:16:16,237 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-68345150:ctest-right_vn-19943578', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-68345150:ctest-right_vn-19943578?flat'}
2025-10-16 03:16:16,237 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-68345150:ctest-right_vn-19943578 virtual network link through opserver 10.0.0.23
2025-10-16 03:16:16,238 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-10-16 03:16:16,251 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-68345150:ctest-right_vn-19943578', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-68345150:ctest-right_vn-19943578?flat'}
2025-10-16 03:16:16,251 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-68345150:ctest-right_vn-19943578 is found in opserver
2025-10-16 03:16:16,277 - DEBUG - Do not have enough data to verify VN in agent
2025-10-16 03:16:16,291 - DEBUG - VRF ids for VN ctest-right_vn-19943578: {}
2025-10-16 03:16:16,549 - DEBUG - Response for create_network : {'network': {'id': '485d8f44-db47-403f-9f50-5c71231a084a', 'name': 'ctest-trans_left_vn-18985157', 'tenant_id': 'ef702d239ebf4835a58a7d638b92e2a9', 'project_id': 'ef702d239ebf4835a58a7d638b92e2a9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-68345150', 'ctest-trans_left_vn-18985157'], 'port_security_enabled': True, 'description': ''}}
2025-10-16 03:16:16,834 - DEBUG - Response for create_subnet : {'subnet': {'id': '0e3b007e-2817-4288-87ba-dc35afb949cb', 'name': '', 'tenant_id': 'ef702d239ebf4835a58a7d638b92e2a9', 'network_id': '485d8f44-db47-403f-9f50-5c71231a084a', 'ip_version': 4, 'cidr': '42.235.73.128/26', 'allocation_pools': [{'start': '42.235.73.130', 'end': '42.235.73.190'}], 'gateway_ip': '42.235.73.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '42.235.73.130', 'tags': [], 'project_id': 'ef702d239ebf4835a58a7d638b92e2a9'}}
2025-10-16 03:16:16,856 - INFO - Created VN ctest-trans_left_vn-18985157
2025-10-16 03:16:16,870 - DEBUG - VN ctest-trans_left_vn-18985157 UUID is 485d8f44-db47-403f-9f50-5c71231a084a
2025-10-16 03:16:16,950 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:16,956 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:16,971 - DEBUG - Requesting: http://10.0.0.19:8082/project/ef702d23-9ebf-4835-a58a-7d638b92e2a9
2025-10-16 03:16:17,066 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/485d8f44-db47-403f-9f50-5c71231a084a
2025-10-16 03:16:17,085 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/485d8f44-db47-403f-9f50-5c71231a084a
2025-10-16 03:16:17,097 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7ff93263-a065-47df-b6e2-076948357597
2025-10-16 03:16:17,113 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7ff93263-a065-47df-b6e2-076948357597
2025-10-16 03:16:17,120 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/cba2bacb-944c-409c-8200-213f80532033
2025-10-16 03:16:17,127 - DEBUG - Route Targets: ['target:64512:8000008']
2025-10-16 03:16:17,127 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/485d8f44-db47-403f-9f50-5c71231a084a
2025-10-16 03:16:17,136 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7ff93263-a065-47df-b6e2-076948357597
2025-10-16 03:16:17,152 - INFO - Verified VN network id 14 for VN 485d8f44-db47-403f-9f50-5c71231a084a
2025-10-16 03:16:17,152 - INFO - Verifications in API Server for VN ctest-trans_left_vn-18985157 passed
2025-10-16 03:16:17,152 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/485d8f44-db47-403f-9f50-5c71231a084a
2025-10-16 03:16:17,165 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7ff93263-a065-47df-b6e2-076948357597
2025-10-16 03:16:17,173 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7ff93263-a065-47df-b6e2-076948357597
2025-10-16 03:16:17,179 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/cba2bacb-944c-409c-8200-213f80532033
2025-10-16 03:16:17,198 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-68345150:ctest-trans_left_vn-18985157', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-68345150', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5214481469464330303', 'uuid-lslong': '11479777091157362762'}, 'enable': 'true', 'created': '2025-10-16T03:16:16', 'last-modified': '2025-10-16T03:16:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.424110'}
2025-10-16 03:16:17,211 - DEBUG - Route Targets: ['target:64512:8000008']
2025-10-16 03:16:17,218 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-68345150:ctest-trans_left_vn-18985157', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-68345150', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5214481469464330303', 'uuid-lslong': '11479777091157362762'}, 'enable': 'true', 'created': '2025-10-16T03:16:16', 'last-modified': '2025-10-16T03:16:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.449076'}
2025-10-16 03:16:17,224 - DEBUG - Route Targets: ['target:64512:8000008']
2025-10-16 03:16:17,229 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-68345150:ctest-trans_left_vn-18985157', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-68345150', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5214481469464330303', 'uuid-lslong': '11479777091157362762'}, 'enable': 'true', 'created': '2025-10-16T03:16:16', 'last-modified': '2025-10-16T03:16:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.457095'}
2025-10-16 03:16:17,235 - DEBUG - Route Targets: ['target:64512:8000008']
2025-10-16 03:16:17,235 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-18985157 passed
2025-10-16 03:16:17,235 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-18985157 in API_Server ======
2025-10-16 03:16:17,235 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:17,241 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:17,252 - DEBUG - Requesting: http://10.0.0.19:8082/project/ef702d23-9ebf-4835-a58a-7d638b92e2a9
2025-10-16 03:16:17,341 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/485d8f44-db47-403f-9f50-5c71231a084a
2025-10-16 03:16:17,352 - DEBUG - =>VN ctest-trans_left_vn-18985157 has no policy to be verified
2025-10-16 03:16:17,352 - DEBUG - Verifying the vn in opserver
2025-10-16 03:16:17,352 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-68345150:ctest-trans_left_vn-18985157 virtual network link through opserver 10.0.0.19
2025-10-16 03:16:17,352 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-10-16 03:16:17,364 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-68345150:ctest-trans_left_vn-18985157', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-68345150:ctest-trans_left_vn-18985157?flat'}
2025-10-16 03:16:17,364 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-68345150:ctest-trans_left_vn-18985157 virtual network link through opserver 10.0.0.57
2025-10-16 03:16:17,364 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-10-16 03:16:17,378 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-68345150:ctest-trans_left_vn-18985157', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-68345150:ctest-trans_left_vn-18985157?flat'}
2025-10-16 03:16:17,378 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-68345150:ctest-trans_left_vn-18985157 virtual network link through opserver 10.0.0.23
2025-10-16 03:16:17,378 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-10-16 03:16:17,389 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-68345150:ctest-trans_left_vn-18985157', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-68345150:ctest-trans_left_vn-18985157?flat'}
2025-10-16 03:16:17,389 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-68345150:ctest-trans_left_vn-18985157 is found in opserver
2025-10-16 03:16:17,409 - DEBUG - Do not have enough data to verify VN in agent
2025-10-16 03:16:17,419 - DEBUG - VRF ids for VN ctest-trans_left_vn-18985157: {}
2025-10-16 03:16:17,704 - DEBUG - Response for create_network : {'network': {'id': '8eea241b-97ba-4375-87b8-e895f66d384c', 'name': 'ctest-trans_right_vn-06968639', 'tenant_id': 'ef702d239ebf4835a58a7d638b92e2a9', 'project_id': 'ef702d239ebf4835a58a7d638b92e2a9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-68345150', 'ctest-trans_right_vn-06968639'], 'port_security_enabled': True, 'description': ''}}
2025-10-16 03:16:17,952 - DEBUG - Response for create_subnet : {'subnet': {'id': '3399b1c5-40b0-4e03-877f-13474a28f1f3', 'name': '', 'tenant_id': 'ef702d239ebf4835a58a7d638b92e2a9', 'network_id': '8eea241b-97ba-4375-87b8-e895f66d384c', 'ip_version': 4, 'cidr': '6.141.25.0/26', 'allocation_pools': [{'start': '6.141.25.2', 'end': '6.141.25.62'}], 'gateway_ip': '6.141.25.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '6.141.25.2', 'tags': [], 'project_id': 'ef702d239ebf4835a58a7d638b92e2a9'}}
2025-10-16 03:16:17,978 - INFO - Created VN ctest-trans_right_vn-06968639
2025-10-16 03:16:17,987 - DEBUG - VN ctest-trans_right_vn-06968639 UUID is 8eea241b-97ba-4375-87b8-e895f66d384c
2025-10-16 03:16:18,060 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:18,073 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:18,083 - DEBUG - Requesting: http://10.0.0.19:8082/project/ef702d23-9ebf-4835-a58a-7d638b92e2a9
2025-10-16 03:16:18,195 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/8eea241b-97ba-4375-87b8-e895f66d384c
2025-10-16 03:16:18,208 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/8eea241b-97ba-4375-87b8-e895f66d384c
2025-10-16 03:16:18,217 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/8887907a-7827-474c-94cf-8d79badf2ec2
2025-10-16 03:16:18,224 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/8887907a-7827-474c-94cf-8d79badf2ec2
2025-10-16 03:16:18,230 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/a122e1da-a023-4577-a829-0685fe5c7639
2025-10-16 03:16:18,237 - DEBUG - Route Targets: ['target:64512:8000009']
2025-10-16 03:16:18,237 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/8eea241b-97ba-4375-87b8-e895f66d384c
2025-10-16 03:16:18,247 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/8887907a-7827-474c-94cf-8d79badf2ec2
2025-10-16 03:16:18,262 - INFO - Verified VN network id 15 for VN 8eea241b-97ba-4375-87b8-e895f66d384c
2025-10-16 03:16:18,262 - INFO - Verifications in API Server for VN ctest-trans_right_vn-06968639 passed
2025-10-16 03:16:18,262 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/8eea241b-97ba-4375-87b8-e895f66d384c
2025-10-16 03:16:18,272 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/8887907a-7827-474c-94cf-8d79badf2ec2
2025-10-16 03:16:18,280 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/8887907a-7827-474c-94cf-8d79badf2ec2
2025-10-16 03:16:18,287 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/a122e1da-a023-4577-a829-0685fe5c7639
2025-10-16 03:16:18,300 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-68345150:ctest-trans_right_vn-06968639', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-68345150', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10298083198864343925', 'uuid-lslong': '9779822321617156172'}, 'enable': 'true', 'created': '2025-10-16T03:16:17', 'last-modified': '2025-10-16T03:16:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.399559'}
2025-10-16 03:16:18,307 - DEBUG - Route Targets: ['target:64512:8000009']
2025-10-16 03:16:18,313 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-68345150:ctest-trans_right_vn-06968639', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-68345150', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10298083198864343925', 'uuid-lslong': '9779822321617156172'}, 'enable': 'true', 'created': '2025-10-16T03:16:17', 'last-modified': '2025-10-16T03:16:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.418005'}
2025-10-16 03:16:18,318 - DEBUG - Route Targets: ['target:64512:8000009']
2025-10-16 03:16:18,324 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-68345150:ctest-trans_right_vn-06968639', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-68345150', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10298083198864343925', 'uuid-lslong': '9779822321617156172'}, 'enable': 'true', 'created': '2025-10-16T03:16:17', 'last-modified': '2025-10-16T03:16:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.419533'}
2025-10-16 03:16:18,329 - DEBUG - Route Targets: ['target:64512:8000009']
2025-10-16 03:16:18,330 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-06968639 passed
2025-10-16 03:16:18,330 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-06968639 in API_Server ======
2025-10-16 03:16:18,330 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:18,336 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:18,352 - DEBUG - Requesting: http://10.0.0.19:8082/project/ef702d23-9ebf-4835-a58a-7d638b92e2a9
2025-10-16 03:16:18,456 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/8eea241b-97ba-4375-87b8-e895f66d384c
2025-10-16 03:16:18,468 - DEBUG - =>VN ctest-trans_right_vn-06968639 has no policy to be verified
2025-10-16 03:16:18,468 - DEBUG - Verifying the vn in opserver
2025-10-16 03:16:18,469 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-68345150:ctest-trans_right_vn-06968639 virtual network link through opserver 10.0.0.19
2025-10-16 03:16:18,469 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-10-16 03:16:18,481 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-68345150:ctest-trans_right_vn-06968639', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-68345150:ctest-trans_right_vn-06968639?flat'}
2025-10-16 03:16:18,481 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-68345150:ctest-trans_right_vn-06968639 virtual network link through opserver 10.0.0.57
2025-10-16 03:16:18,482 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-10-16 03:16:18,506 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-68345150:ctest-trans_right_vn-06968639', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-68345150:ctest-trans_right_vn-06968639?flat'}
2025-10-16 03:16:18,506 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-68345150:ctest-trans_right_vn-06968639 virtual network link through opserver 10.0.0.23
2025-10-16 03:16:18,506 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-10-16 03:16:18,518 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-68345150:ctest-trans_right_vn-06968639', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-68345150:ctest-trans_right_vn-06968639?flat'}
2025-10-16 03:16:18,518 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-68345150:ctest-trans_right_vn-06968639 is found in opserver
2025-10-16 03:16:18,542 - DEBUG - Do not have enough data to verify VN in agent
2025-10-16 03:16:18,554 - DEBUG - VRF ids for VN ctest-trans_right_vn-06968639: {}
2025-10-16 03:16:19,587 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4339-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4339-1)
2025-10-16 03:16:20,902 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4339-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4339-2)
2025-10-16 03:16:20,902 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-13137973']
2025-10-16 03:16:21,193 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-13137973'] created succesfully
2025-10-16 03:16:21,546 - DEBUG - Image by name tiny_trans_fw not found
2025-10-16 03:16:21,546 - DEBUG - Installing image tiny_trans_fw
2025-10-16 03:16:21,546 - 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'}
2025-10-16 03:16:21,547 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2025-10-16 03:16:21,547 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2025-10-16 03:16:21,563 - 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
2025-10-16 03:16:21,591 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-10-16 03:16:21,591 - DEBUG - Unzip image
2025-10-16 03:16:21,591 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-10-16 03:16:21,609 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2025-10-16 03:16:21,609 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-13137973']
2025-10-16 03:16:21,710 - INFO - Service template: ['default-domain', 'ctest-service_template_1-13137973'] deleted successfully.
2025-10-16 03:16:21,710 - INFO - Skip interface_detach for VM ctest-right_vm-67515815 in state BUILD
2025-10-16 03:16:21,711 - INFO - Deleting VM ctest-right_vm-67515815
2025-10-16 03:16:21,711 - ERROR - VM ctest-right_vm-67515815 has failed to come up
2025-10-16 03:16:21,711 - ERROR - Nova failed to get host of the VM
2025-10-16 03:16:21,711 - ERROR - VM ctest-right_vm-67515815 has failed to come up
2025-10-16 03:16:21,711 - ERROR - Nova failed to get host of the VM
2025-10-16 03:16:21,807 - INFO - Skip interface_detach for VM ctest-left_vm-43396425 in state BUILD
2025-10-16 03:16:21,807 - INFO - Deleting VM ctest-left_vm-43396425
2025-10-16 03:16:21,807 - ERROR - VM ctest-left_vm-43396425 has failed to come up
2025-10-16 03:16:21,808 - ERROR - Nova failed to get host of the VM
2025-10-16 03:16:21,808 - ERROR - VM ctest-left_vm-43396425 has failed to come up
2025-10-16 03:16:21,808 - ERROR - Nova failed to get host of the VM
2025-10-16 03:16:21,875 - INFO - Deleting VN ctest-trans_right_vn-06968639
2025-10-16 03:16:22,034 - DEBUG - Response for deleting network ()
2025-10-16 03:16:22,035 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/8887907a-7827-474c-94cf-8d79badf2ec2
2025-10-16 03:16:22,040 - DEBUG - Response Code: 404
2025-10-16 03:16:22,041 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:22,054 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:22,110 - DEBUG - Requesting: http://10.0.0.19:8082/project/ef702d23-9ebf-4835-a58a-7d638b92e2a9
2025-10-16 03:16:22,198 - INFO - Validated that VN ctest-trans_right_vn-06968639 is not found in API Server
2025-10-16 03:16:22,213 - DEBUG - VN ctest-trans_right_vn-06968639 is not present in Agent 10.0.0.38
2025-10-16 03:16:22,223 - DEBUG - VN ctest-trans_right_vn-06968639 is not present in Agent 10.0.0.129
2025-10-16 03:16:22,223 - INFO - Validated that VN ctest-trans_right_vn-06968639 is not in any agent
2025-10-16 03:16:22,260 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-06968639 info
2025-10-16 03:16:22,260 - INFO - Deleting VN ctest-trans_left_vn-18985157
2025-10-16 03:16:22,388 - DEBUG - Response for deleting network ()
2025-10-16 03:16:22,388 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7ff93263-a065-47df-b6e2-076948357597
2025-10-16 03:16:22,397 - DEBUG - Response Code: 404
2025-10-16 03:16:22,397 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:22,418 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:22,431 - DEBUG - Requesting: http://10.0.0.19:8082/project/ef702d23-9ebf-4835-a58a-7d638b92e2a9
2025-10-16 03:16:22,560 - INFO - Validated that VN ctest-trans_left_vn-18985157 is not found in API Server
2025-10-16 03:16:22,572 - DEBUG - VN ctest-trans_left_vn-18985157 is not present in Agent 10.0.0.38
2025-10-16 03:16:22,607 - DEBUG - VN ctest-trans_left_vn-18985157 is not present in Agent 10.0.0.129
2025-10-16 03:16:22,607 - INFO - Validated that VN ctest-trans_left_vn-18985157 is not in any agent
2025-10-16 03:16:22,688 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-18985157 info
2025-10-16 03:16:22,688 - INFO - Deleting VN ctest-right_vn-19943578
2025-10-16 03:16:22,732 - DEBUG - VN d98da927-35de-434d-8b10-d40574a10f45 still in use: Unable to complete operation on network d98da927-35de-434d-8b10-d40574a10f45. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-f99c33ec-91b4-451a-838f-25f98f558596']
2025-10-16 03:16:22,732 - WARNING - Deleting VN ctest-right_vn-19943578 failed..Will retry
2025-10-16 03:16:24,888 - DEBUG - Response for deleting network ()
2025-10-16 03:16:24,888 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/fcf1ed4d-850d-4782-bb93-0b519a0ed640
2025-10-16 03:16:24,897 - DEBUG - Response Code: 404
2025-10-16 03:16:24,897 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:24,904 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:24,915 - DEBUG - Requesting: http://10.0.0.19:8082/project/ef702d23-9ebf-4835-a58a-7d638b92e2a9
2025-10-16 03:16:25,000 - INFO - Validated that VN ctest-right_vn-19943578 is not found in API Server
2025-10-16 03:16:25,012 - DEBUG - VN ctest-right_vn-19943578 is not present in Agent 10.0.0.38
2025-10-16 03:16:25,022 - DEBUG - VN ctest-right_vn-19943578 is not present in Agent 10.0.0.129
2025-10-16 03:16:25,022 - INFO - Validated that VN ctest-right_vn-19943578 is not in any agent
2025-10-16 03:16:25,052 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-19943578 info
2025-10-16 03:16:25,052 - INFO - Deleting VN ctest-left_vn-58240837
2025-10-16 03:16:25,225 - DEBUG - Response for deleting network ()
2025-10-16 03:16:25,225 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/381dc85e-01fc-47cc-9033-10c90a403b32
2025-10-16 03:16:25,232 - DEBUG - Response Code: 404
2025-10-16 03:16:25,233 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:25,249 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:25,305 - DEBUG - Requesting: http://10.0.0.19:8082/project/ef702d23-9ebf-4835-a58a-7d638b92e2a9
2025-10-16 03:16:25,407 - INFO - Validated that VN ctest-left_vn-58240837 is not found in API Server
2025-10-16 03:16:25,417 - DEBUG - VN ctest-left_vn-58240837 is not present in Agent 10.0.0.38
2025-10-16 03:16:25,427 - DEBUG - VN ctest-left_vn-58240837 is not present in Agent 10.0.0.129
2025-10-16 03:16:25,427 - INFO - Validated that VN ctest-left_vn-58240837 is not in any agent
2025-10-16 03:16:25,457 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-58240837 info
2025-10-16 03:16:25,457 - INFO - Deleting VN ctest-mgmt_vn-22801618
2025-10-16 03:16:25,589 - DEBUG - Response for deleting network ()
2025-10-16 03:16:25,590 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/0b38b61d-182c-41a6-8cac-f9763a200117
2025-10-16 03:16:25,595 - DEBUG - Response Code: 404
2025-10-16 03:16:25,595 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:25,606 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:25,618 - DEBUG - Requesting: http://10.0.0.19:8082/project/ef702d23-9ebf-4835-a58a-7d638b92e2a9
2025-10-16 03:16:25,704 - INFO - Validated that VN ctest-mgmt_vn-22801618 is not found in API Server
2025-10-16 03:16:25,714 - DEBUG - VN ctest-mgmt_vn-22801618 is not present in Agent 10.0.0.38
2025-10-16 03:16:25,727 - DEBUG - VN ctest-mgmt_vn-22801618 is not present in Agent 10.0.0.129
2025-10-16 03:16:25,727 - INFO - Validated that VN ctest-mgmt_vn-22801618 is not in any agent
2025-10-16 03:16:25,756 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-22801618 info
2025-10-16 03:16:27,037 - DEBUG - No XMPP flaps were noticed during the test
2025-10-16 03:16:27,037 - INFO -
2025-10-16 03:16:27,037 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:21]
2025-10-16 03:16:27,037 - INFO - --------------------------------------------------------------------------------
2025-10-16 03:16:27,701 - INFO - Deleted project: ctest-TestSvcRegr-68345150, ID : ef702d23-9ebf-4835-a58a-7d638b92e2a9
2025-10-16 03:16:27,865 - INFO - Domain Default found not creating
2025-10-16 03:16:28,017 - INFO - Project ctest-TestSvcRegr-09553435 not found, creating it
2025-10-16 03:16:28,522 - INFO - Created Project:ctest-TestSvcRegr-09553435, ID : b6d662e6-560e-455b-8d6d-79be24b12b1b
2025-10-16 03:16:29,962 - INFO - ================================================================================
2025-10-16 03:16:29,962 - INFO - STARTING TEST : test_svc_CEM_22032
2025-10-16 03:16:31,233 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.252': '0', '10.20.0.5': '0'}, '10.0.0.129': {'10.20.0.5': '0', '10.20.0.252': '0'}} with
2025-10-16 03:16:31,233 - INFO - Initial checks done. Running the testcase now
2025-10-16 03:16:31,233 - INFO -
2025-10-16 03:16:31,911 - DEBUG - Response for create_network : {'network': {'id': 'f720e226-6b7b-4fd3-ae10-3a30ed6bc468', 'name': 'ctest-mgmt_vn-60473414', 'tenant_id': 'b6d662e6560e455b8d6d79be24b12b1b', 'project_id': 'b6d662e6560e455b8d6d79be24b12b1b', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-09553435', 'ctest-mgmt_vn-60473414'], 'port_security_enabled': True, 'description': ''}}
2025-10-16 03:16:32,179 - DEBUG - Response for create_subnet : {'subnet': {'id': '695f5af0-25ef-4992-8ea0-10a7a0d54b31', 'name': '', 'tenant_id': 'b6d662e6560e455b8d6d79be24b12b1b', 'network_id': 'f720e226-6b7b-4fd3-ae10-3a30ed6bc468', 'ip_version': 4, 'cidr': '139.60.164.64/26', 'allocation_pools': [{'start': '139.60.164.66', 'end': '139.60.164.126'}], 'gateway_ip': '139.60.164.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '139.60.164.66', 'tags': [], 'project_id': 'b6d662e6560e455b8d6d79be24b12b1b'}}
2025-10-16 03:16:32,202 - INFO - Created VN ctest-mgmt_vn-60473414
2025-10-16 03:16:32,211 - DEBUG - VN ctest-mgmt_vn-60473414 UUID is f720e226-6b7b-4fd3-ae10-3a30ed6bc468
2025-10-16 03:16:32,296 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:32,610 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:32,645 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:32,662 - DEBUG - Requesting: http://10.0.0.19:8082/project/b6d662e6-560e-455b-8d6d-79be24b12b1b
2025-10-16 03:16:32,752 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/f720e226-6b7b-4fd3-ae10-3a30ed6bc468
2025-10-16 03:16:32,763 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/f720e226-6b7b-4fd3-ae10-3a30ed6bc468
2025-10-16 03:16:32,773 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/bf85d354-821a-494c-9ae1-6f3f76fdd6db
2025-10-16 03:16:32,782 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/bf85d354-821a-494c-9ae1-6f3f76fdd6db
2025-10-16 03:16:32,789 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/a48425e9-f570-418c-94a3-35ef082748f1
2025-10-16 03:16:32,796 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-16 03:16:32,796 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/f720e226-6b7b-4fd3-ae10-3a30ed6bc468
2025-10-16 03:16:32,808 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/bf85d354-821a-494c-9ae1-6f3f76fdd6db
2025-10-16 03:16:32,824 - INFO - Verified VN network id 11 for VN f720e226-6b7b-4fd3-ae10-3a30ed6bc468
2025-10-16 03:16:32,824 - INFO - Verifications in API Server for VN ctest-mgmt_vn-60473414 passed
2025-10-16 03:16:32,824 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/f720e226-6b7b-4fd3-ae10-3a30ed6bc468
2025-10-16 03:16:32,834 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/bf85d354-821a-494c-9ae1-6f3f76fdd6db
2025-10-16 03:16:32,841 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/bf85d354-821a-494c-9ae1-6f3f76fdd6db
2025-10-16 03:16:32,848 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/a48425e9-f570-418c-94a3-35ef082748f1
2025-10-16 03:16:32,860 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-60473414', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09553435', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17807481581262819283', 'uuid-lslong': '12542588944042935400'}, 'enable': 'true', 'created': '2025-10-16T03:16:31', 'last-modified': '2025-10-16T03:16:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.726490'}
2025-10-16 03:16:32,865 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-16 03:16:32,870 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-60473414', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09553435', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17807481581262819283', 'uuid-lslong': '12542588944042935400'}, 'enable': 'true', 'created': '2025-10-16T03:16:31', 'last-modified': '2025-10-16T03:16:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.739806'}
2025-10-16 03:16:32,876 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-16 03:16:32,882 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-60473414', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09553435', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17807481581262819283', 'uuid-lslong': '12542588944042935400'}, 'enable': 'true', 'created': '2025-10-16T03:16:31', 'last-modified': '2025-10-16T03:16:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.751623'}
2025-10-16 03:16:32,888 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-16 03:16:32,888 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-60473414 passed
2025-10-16 03:16:32,888 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-60473414 in API_Server ======
2025-10-16 03:16:32,888 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:32,894 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:32,905 - DEBUG - Requesting: http://10.0.0.19:8082/project/b6d662e6-560e-455b-8d6d-79be24b12b1b
2025-10-16 03:16:32,994 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/f720e226-6b7b-4fd3-ae10-3a30ed6bc468
2025-10-16 03:16:33,004 - DEBUG - =>VN ctest-mgmt_vn-60473414 has no policy to be verified
2025-10-16 03:16:33,004 - DEBUG - Verifying the vn in opserver
2025-10-16 03:16:33,004 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-60473414 virtual network link through opserver 10.0.0.19
2025-10-16 03:16:33,004 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-10-16 03:16:33,301 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-10-16 03:16:33,364 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-60473414', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-60473414?flat'}
2025-10-16 03:16:33,364 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-60473414 virtual network link through opserver 10.0.0.57
2025-10-16 03:16:33,364 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-10-16 03:16:33,668 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-10-16 03:16:33,733 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-60473414', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-60473414?flat'}
2025-10-16 03:16:33,733 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-60473414 virtual network link through opserver 10.0.0.23
2025-10-16 03:16:33,733 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-10-16 03:16:34,034 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-10-16 03:16:34,085 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-60473414', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-60473414?flat'}
2025-10-16 03:16:34,085 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-60473414 is found in opserver
2025-10-16 03:16:34,111 - DEBUG - Do not have enough data to verify VN in agent
2025-10-16 03:16:34,120 - DEBUG - VRF ids for VN ctest-mgmt_vn-60473414: {}
2025-10-16 03:16:34,359 - DEBUG - Response for create_network : {'network': {'id': '9f1eb437-fc36-490b-b3dc-59c2942c22dc', 'name': 'service-left-vn-42160532', 'tenant_id': 'b6d662e6560e455b8d6d79be24b12b1b', 'project_id': 'b6d662e6560e455b8d6d79be24b12b1b', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-09553435', 'service-left-vn-42160532'], 'port_security_enabled': True, 'description': ''}}
2025-10-16 03:16:34,572 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e9c2c029-e7b6-4a84-946d-9e9666701978', 'name': '', 'tenant_id': 'b6d662e6560e455b8d6d79be24b12b1b', 'network_id': '9f1eb437-fc36-490b-b3dc-59c2942c22dc', 'ip_version': 4, 'cidr': '89.201.151.64/26', 'allocation_pools': [{'start': '89.201.151.66', 'end': '89.201.151.126'}], 'gateway_ip': '89.201.151.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '89.201.151.66', 'tags': [], 'project_id': 'b6d662e6560e455b8d6d79be24b12b1b'}}
2025-10-16 03:16:34,600 - INFO - Created VN service-left-vn-42160532
2025-10-16 03:16:34,616 - DEBUG - VN service-left-vn-42160532 UUID is 9f1eb437-fc36-490b-b3dc-59c2942c22dc
2025-10-16 03:16:34,698 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:34,705 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:34,715 - DEBUG - Requesting: http://10.0.0.19:8082/project/b6d662e6-560e-455b-8d6d-79be24b12b1b
2025-10-16 03:16:34,805 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/9f1eb437-fc36-490b-b3dc-59c2942c22dc
2025-10-16 03:16:34,831 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/9f1eb437-fc36-490b-b3dc-59c2942c22dc
2025-10-16 03:16:34,844 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/1f28e2ae-488a-428d-a606-ae8354102349
2025-10-16 03:16:34,853 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/1f28e2ae-488a-428d-a606-ae8354102349
2025-10-16 03:16:34,861 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/9978eddd-f1b1-4492-838c-a12a874cba40
2025-10-16 03:16:34,870 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-16 03:16:34,870 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/9f1eb437-fc36-490b-b3dc-59c2942c22dc
2025-10-16 03:16:34,882 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/1f28e2ae-488a-428d-a606-ae8354102349
2025-10-16 03:16:34,901 - INFO - Verified VN network id 12 for VN 9f1eb437-fc36-490b-b3dc-59c2942c22dc
2025-10-16 03:16:34,903 - INFO - Verifications in API Server for VN service-left-vn-42160532 passed
2025-10-16 03:16:34,903 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/9f1eb437-fc36-490b-b3dc-59c2942c22dc
2025-10-16 03:16:34,917 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/1f28e2ae-488a-428d-a606-ae8354102349
2025-10-16 03:16:34,927 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/1f28e2ae-488a-428d-a606-ae8354102349
2025-10-16 03:16:34,938 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/9978eddd-f1b1-4492-838c-a12a874cba40
2025-10-16 03:16:34,954 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09553435:service-left-vn-42160532', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09553435', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11465799853879478539', 'uuid-lslong': '12960332519909892828'}, 'enable': 'true', 'created': '2025-10-16T03:16:34', 'last-modified': '2025-10-16T03:16:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.445864'}
2025-10-16 03:16:34,962 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-16 03:16:34,967 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09553435:service-left-vn-42160532', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09553435', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11465799853879478539', 'uuid-lslong': '12960332519909892828'}, 'enable': 'true', 'created': '2025-10-16T03:16:34', 'last-modified': '2025-10-16T03:16:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.461305'}
2025-10-16 03:16:34,974 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-16 03:16:34,979 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09553435:service-left-vn-42160532', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09553435', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11465799853879478539', 'uuid-lslong': '12960332519909892828'}, 'enable': 'true', 'created': '2025-10-16T03:16:34', 'last-modified': '2025-10-16T03:16:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.473445'}
2025-10-16 03:16:34,985 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-16 03:16:34,985 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-42160532 passed
2025-10-16 03:16:34,985 - DEBUG - ====Verifying policy data for service-left-vn-42160532 in API_Server ======
2025-10-16 03:16:34,985 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:34,991 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:35,003 - DEBUG - Requesting: http://10.0.0.19:8082/project/b6d662e6-560e-455b-8d6d-79be24b12b1b
2025-10-16 03:16:35,097 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/9f1eb437-fc36-490b-b3dc-59c2942c22dc
2025-10-16 03:16:35,109 - DEBUG - =>VN service-left-vn-42160532 has no policy to be verified
2025-10-16 03:16:35,109 - DEBUG - Verifying the vn in opserver
2025-10-16 03:16:35,109 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09553435:service-left-vn-42160532 virtual network link through opserver 10.0.0.19
2025-10-16 03:16:35,109 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-10-16 03:16:35,169 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09553435:service-left-vn-42160532', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09553435:service-left-vn-42160532?flat'}
2025-10-16 03:16:35,169 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09553435:service-left-vn-42160532 virtual network link through opserver 10.0.0.57
2025-10-16 03:16:35,169 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-10-16 03:16:35,223 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09553435:service-left-vn-42160532', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09553435:service-left-vn-42160532?flat'}
2025-10-16 03:16:35,223 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09553435:service-left-vn-42160532 virtual network link through opserver 10.0.0.23
2025-10-16 03:16:35,223 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-10-16 03:16:35,283 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09553435:service-left-vn-42160532', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09553435:service-left-vn-42160532?flat'}
2025-10-16 03:16:35,283 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-09553435:service-left-vn-42160532 is found in opserver
2025-10-16 03:16:35,304 - DEBUG - Do not have enough data to verify VN in agent
2025-10-16 03:16:35,315 - DEBUG - VRF ids for VN service-left-vn-42160532: {}
2025-10-16 03:16:35,593 - DEBUG - Response for create_network : {'network': {'id': '588ec5ca-2a1e-4f37-8719-cf498240bb7d', 'name': 'service-right-vn-19748954', 'tenant_id': 'b6d662e6560e455b8d6d79be24b12b1b', 'project_id': 'b6d662e6560e455b8d6d79be24b12b1b', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-09553435', 'service-right-vn-19748954'], 'port_security_enabled': True, 'description': ''}}
2025-10-16 03:16:35,862 - DEBUG - Response for create_subnet : {'subnet': {'id': '3a891eff-f759-405d-a5d5-4d7d5173f0fa', 'name': '', 'tenant_id': 'b6d662e6560e455b8d6d79be24b12b1b', 'network_id': '588ec5ca-2a1e-4f37-8719-cf498240bb7d', 'ip_version': 4, 'cidr': '31.185.222.0/26', 'allocation_pools': [{'start': '31.185.222.2', 'end': '31.185.222.62'}], 'gateway_ip': '31.185.222.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '31.185.222.2', 'tags': [], 'project_id': 'b6d662e6560e455b8d6d79be24b12b1b'}}
2025-10-16 03:16:35,883 - INFO - Created VN service-right-vn-19748954
2025-10-16 03:16:35,893 - DEBUG - VN service-right-vn-19748954 UUID is 588ec5ca-2a1e-4f37-8719-cf498240bb7d
2025-10-16 03:16:35,963 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:35,969 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:35,981 - DEBUG - Requesting: http://10.0.0.19:8082/project/b6d662e6-560e-455b-8d6d-79be24b12b1b
2025-10-16 03:16:36,069 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/588ec5ca-2a1e-4f37-8719-cf498240bb7d
2025-10-16 03:16:36,080 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/588ec5ca-2a1e-4f37-8719-cf498240bb7d
2025-10-16 03:16:36,089 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/c9470dfc-8d8b-48b8-bcc1-d62f75c19e52
2025-10-16 03:16:36,098 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/c9470dfc-8d8b-48b8-bcc1-d62f75c19e52
2025-10-16 03:16:36,105 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/bd6f89cf-c3a0-49d7-ae7c-9b5b0921cfbb
2025-10-16 03:16:36,111 - DEBUG - Route Targets: ['target:64512:8000007']
2025-10-16 03:16:36,111 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/588ec5ca-2a1e-4f37-8719-cf498240bb7d
2025-10-16 03:16:36,119 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/c9470dfc-8d8b-48b8-bcc1-d62f75c19e52
2025-10-16 03:16:36,137 - INFO - Verified VN network id 13 for VN 588ec5ca-2a1e-4f37-8719-cf498240bb7d
2025-10-16 03:16:36,137 - INFO - Verifications in API Server for VN service-right-vn-19748954 passed
2025-10-16 03:16:36,137 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/588ec5ca-2a1e-4f37-8719-cf498240bb7d
2025-10-16 03:16:36,149 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/c9470dfc-8d8b-48b8-bcc1-d62f75c19e52
2025-10-16 03:16:36,157 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/c9470dfc-8d8b-48b8-bcc1-d62f75c19e52
2025-10-16 03:16:36,164 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/bd6f89cf-c3a0-49d7-ae7c-9b5b0921cfbb
2025-10-16 03:16:36,178 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09553435:service-right-vn-19748954', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09553435', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6381255194111266615', 'uuid-lslong': '9735039984162880381'}, 'enable': 'true', 'created': '2025-10-16T03:16:35', 'last-modified': '2025-10-16T03:16:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.363328'}
2025-10-16 03:16:36,184 - DEBUG - Route Targets: ['target:64512:8000007']
2025-10-16 03:16:36,189 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09553435:service-right-vn-19748954', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09553435', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6381255194111266615', 'uuid-lslong': '9735039984162880381'}, 'enable': 'true', 'created': '2025-10-16T03:16:35', 'last-modified': '2025-10-16T03:16:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.370577'}
2025-10-16 03:16:36,195 - DEBUG - Route Targets: ['target:64512:8000007']
2025-10-16 03:16:36,201 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09553435:service-right-vn-19748954', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09553435', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6381255194111266615', 'uuid-lslong': '9735039984162880381'}, 'enable': 'true', 'created': '2025-10-16T03:16:35', 'last-modified': '2025-10-16T03:16:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.384693'}
2025-10-16 03:16:36,206 - DEBUG - Route Targets: ['target:64512:8000007']
2025-10-16 03:16:36,206 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-19748954 passed
2025-10-16 03:16:36,206 - DEBUG - ====Verifying policy data for service-right-vn-19748954 in API_Server ======
2025-10-16 03:16:36,206 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:36,213 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:36,224 - DEBUG - Requesting: http://10.0.0.19:8082/project/b6d662e6-560e-455b-8d6d-79be24b12b1b
2025-10-16 03:16:36,320 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/588ec5ca-2a1e-4f37-8719-cf498240bb7d
2025-10-16 03:16:36,337 - DEBUG - =>VN service-right-vn-19748954 has no policy to be verified
2025-10-16 03:16:36,338 - DEBUG - Verifying the vn in opserver
2025-10-16 03:16:36,338 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09553435:service-right-vn-19748954 virtual network link through opserver 10.0.0.19
2025-10-16 03:16:36,338 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-10-16 03:16:36,392 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09553435:service-right-vn-19748954', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09553435:service-right-vn-19748954?flat'}
2025-10-16 03:16:36,392 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09553435:service-right-vn-19748954 virtual network link through opserver 10.0.0.57
2025-10-16 03:16:36,392 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-10-16 03:16:36,448 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09553435:service-right-vn-19748954', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09553435:service-right-vn-19748954?flat'}
2025-10-16 03:16:36,448 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09553435:service-right-vn-19748954 virtual network link through opserver 10.0.0.23
2025-10-16 03:16:36,448 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-10-16 03:16:36,497 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09553435:service-right-vn-19748954', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09553435:service-right-vn-19748954?flat'}
2025-10-16 03:16:36,498 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-09553435:service-right-vn-19748954 is found in opserver
2025-10-16 03:16:36,518 - DEBUG - Do not have enough data to verify VN in agent
2025-10-16 03:16:36,529 - DEBUG - VRF ids for VN service-right-vn-19748954: {}
2025-10-16 03:16:36,594 - DEBUG - Services list from nova: [, , , ]
2025-10-16 03:16:37,680 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4339-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4339-1)
2025-10-16 03:16:38,973 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4339-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4339-2)
2025-10-16 03:16:38,974 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-23910178']
2025-10-16 03:16:39,277 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-23910178'] created succesfully
2025-10-16 03:16:39,634 - DEBUG - Image by name tiny_nat_fw not found
2025-10-16 03:16:39,634 - DEBUG - Installing image tiny_nat_fw
2025-10-16 03:16:39,634 - 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'"}
2025-10-16 03:16:39,634 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-10-16 03:16:39,635 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-10-16 03:16:39,635 - DEBUG - Unzip image
2025-10-16 03:16:39,635 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-10-16 03:16:39,666 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2025-10-16 03:16:39,666 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-23910178']
2025-10-16 03:16:39,754 - INFO - Service template: ['default-domain', 'ctest-service_template_1-23910178'] deleted successfully.
2025-10-16 03:16:39,754 - INFO - Skip interface_detach for VM ctest-right_vm-14010007 in state BUILD
2025-10-16 03:16:39,754 - INFO - Deleting VM ctest-right_vm-14010007
2025-10-16 03:16:39,787 - ERROR - VM ctest-right_vm-14010007 has failed to come up
2025-10-16 03:16:39,788 - ERROR - Nova failed to get host of the VM
2025-10-16 03:16:39,788 - ERROR - VM ctest-right_vm-14010007 has failed to come up
2025-10-16 03:16:39,788 - ERROR - Nova failed to get host of the VM
2025-10-16 03:16:39,863 - INFO - Skip interface_detach for VM ctest-left_vm-75017428 in state BUILD
2025-10-16 03:16:39,863 - INFO - Deleting VM ctest-left_vm-75017428
2025-10-16 03:16:39,863 - ERROR - VM ctest-left_vm-75017428 has failed to come up
2025-10-16 03:16:39,863 - ERROR - Nova failed to get host of the VM
2025-10-16 03:16:39,863 - ERROR - VM ctest-left_vm-75017428 has failed to come up
2025-10-16 03:16:39,864 - ERROR - Nova failed to get host of the VM
2025-10-16 03:16:39,965 - INFO - Deleting VN service-right-vn-19748954
2025-10-16 03:16:40,026 - DEBUG - VN 588ec5ca-2a1e-4f37-8719-cf498240bb7d still in use: Unable to complete operation on network 588ec5ca-2a1e-4f37-8719-cf498240bb7d. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-1271bfe3-af26-4053-a25c-d5ba9d2f875c']
2025-10-16 03:16:40,026 - WARNING - Deleting VN service-right-vn-19748954 failed..Will retry
2025-10-16 03:16:42,178 - DEBUG - Response for deleting network ()
2025-10-16 03:16:42,178 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/c9470dfc-8d8b-48b8-bcc1-d62f75c19e52
2025-10-16 03:16:42,187 - DEBUG - Response Code: 404
2025-10-16 03:16:42,187 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:42,195 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:42,209 - DEBUG - Requesting: http://10.0.0.19:8082/project/b6d662e6-560e-455b-8d6d-79be24b12b1b
2025-10-16 03:16:42,312 - INFO - Validated that VN service-right-vn-19748954 is not found in API Server
2025-10-16 03:16:42,324 - DEBUG - VN service-right-vn-19748954 is not present in Agent 10.0.0.38
2025-10-16 03:16:42,333 - DEBUG - VN service-right-vn-19748954 is not present in Agent 10.0.0.129
2025-10-16 03:16:42,333 - INFO - Validated that VN service-right-vn-19748954 is not in any agent
2025-10-16 03:16:42,367 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-19748954 info
2025-10-16 03:16:42,368 - INFO - Deleting VN service-left-vn-42160532
2025-10-16 03:16:42,559 - DEBUG - Response for deleting network ()
2025-10-16 03:16:42,559 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/1f28e2ae-488a-428d-a606-ae8354102349
2025-10-16 03:16:42,566 - DEBUG - Response Code: 404
2025-10-16 03:16:42,566 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:42,572 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:42,607 - DEBUG - Requesting: http://10.0.0.19:8082/project/b6d662e6-560e-455b-8d6d-79be24b12b1b
2025-10-16 03:16:42,700 - INFO - Validated that VN service-left-vn-42160532 is not found in API Server
2025-10-16 03:16:42,712 - DEBUG - VN service-left-vn-42160532 is not present in Agent 10.0.0.38
2025-10-16 03:16:42,724 - DEBUG - VN service-left-vn-42160532 is not present in Agent 10.0.0.129
2025-10-16 03:16:42,724 - INFO - Validated that VN service-left-vn-42160532 is not in any agent
2025-10-16 03:16:42,756 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-42160532 info
2025-10-16 03:16:42,756 - INFO - Deleting VN ctest-mgmt_vn-60473414
2025-10-16 03:16:42,924 - DEBUG - Response for deleting network ()
2025-10-16 03:16:42,924 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/bf85d354-821a-494c-9ae1-6f3f76fdd6db
2025-10-16 03:16:42,930 - DEBUG - Response Code: 404
2025-10-16 03:16:42,930 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:42,937 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:42,961 - DEBUG - Requesting: http://10.0.0.19:8082/project/b6d662e6-560e-455b-8d6d-79be24b12b1b
2025-10-16 03:16:43,060 - INFO - Validated that VN ctest-mgmt_vn-60473414 is not found in API Server
2025-10-16 03:16:43,072 - DEBUG - VN ctest-mgmt_vn-60473414 is not present in Agent 10.0.0.38
2025-10-16 03:16:43,081 - DEBUG - VN ctest-mgmt_vn-60473414 is not present in Agent 10.0.0.129
2025-10-16 03:16:43,081 - INFO - Validated that VN ctest-mgmt_vn-60473414 is not in any agent
2025-10-16 03:16:43,111 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-60473414 info
2025-10-16 03:16:44,384 - DEBUG - No XMPP flaps were noticed during the test
2025-10-16 03:16:44,384 - INFO -
2025-10-16 03:16:44,384 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:15]
2025-10-16 03:16:44,384 - INFO - --------------------------------------------------------------------------------
2025-10-16 03:16:44,386 - INFO - ================================================================================
2025-10-16 03:16:44,386 - INFO - STARTING TEST : test_svc_in_network_datapath
2025-10-16 03:16:45,668 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.252': '0', '10.20.0.5': '0'}, '10.0.0.129': {'10.20.0.5': '0', '10.20.0.252': '0'}} with
2025-10-16 03:16:45,668 - INFO - Initial checks done. Running the testcase now
2025-10-16 03:16:45,668 - INFO -
2025-10-16 03:16:45,931 - DEBUG - Response for create_network : {'network': {'id': '113c8e2e-3066-4523-9395-e3e84a74a60d', 'name': 'ctest-mgmt_vn-79976616', 'tenant_id': 'b6d662e6560e455b8d6d79be24b12b1b', 'project_id': 'b6d662e6560e455b8d6d79be24b12b1b', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-09553435', 'ctest-mgmt_vn-79976616'], 'port_security_enabled': True, 'description': ''}}
2025-10-16 03:16:46,141 - DEBUG - Response for create_subnet : {'subnet': {'id': '236a1c34-25cb-464a-b252-75ee416903b9', 'name': '', 'tenant_id': 'b6d662e6560e455b8d6d79be24b12b1b', 'network_id': '113c8e2e-3066-4523-9395-e3e84a74a60d', 'ip_version': 4, 'cidr': '25.222.189.64/26', 'allocation_pools': [{'start': '25.222.189.66', 'end': '25.222.189.126'}], 'gateway_ip': '25.222.189.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '25.222.189.66', 'tags': [], 'project_id': 'b6d662e6560e455b8d6d79be24b12b1b'}}
2025-10-16 03:16:46,161 - INFO - Created VN ctest-mgmt_vn-79976616
2025-10-16 03:16:46,172 - DEBUG - VN ctest-mgmt_vn-79976616 UUID is 113c8e2e-3066-4523-9395-e3e84a74a60d
2025-10-16 03:16:46,260 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:46,268 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:46,281 - DEBUG - Requesting: http://10.0.0.19:8082/project/b6d662e6-560e-455b-8d6d-79be24b12b1b
2025-10-16 03:16:46,370 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/113c8e2e-3066-4523-9395-e3e84a74a60d
2025-10-16 03:16:46,381 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/113c8e2e-3066-4523-9395-e3e84a74a60d
2025-10-16 03:16:46,392 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/22499d04-de62-4f8e-96cf-43869ef8b466
2025-10-16 03:16:46,403 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/22499d04-de62-4f8e-96cf-43869ef8b466
2025-10-16 03:16:46,410 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/f919d25f-93f3-46c3-bd2d-aee1d6db1669
2025-10-16 03:16:46,416 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-16 03:16:46,416 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/113c8e2e-3066-4523-9395-e3e84a74a60d
2025-10-16 03:16:46,427 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/22499d04-de62-4f8e-96cf-43869ef8b466
2025-10-16 03:16:46,445 - INFO - Verified VN network id 11 for VN 113c8e2e-3066-4523-9395-e3e84a74a60d
2025-10-16 03:16:46,445 - INFO - Verifications in API Server for VN ctest-mgmt_vn-79976616 passed
2025-10-16 03:16:46,445 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/113c8e2e-3066-4523-9395-e3e84a74a60d
2025-10-16 03:16:46,456 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/22499d04-de62-4f8e-96cf-43869ef8b466
2025-10-16 03:16:46,465 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/22499d04-de62-4f8e-96cf-43869ef8b466
2025-10-16 03:16:46,472 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/f919d25f-93f3-46c3-bd2d-aee1d6db1669
2025-10-16 03:16:46,484 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-79976616', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09553435', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1242023926279062819', 'uuid-lslong': '10634656681926370829'}, 'enable': 'true', 'created': '2025-10-16T03:16:45', 'last-modified': '2025-10-16T03:16:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.380801'}
2025-10-16 03:16:46,490 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-16 03:16:46,496 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-79976616', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09553435', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1242023926279062819', 'uuid-lslong': '10634656681926370829'}, 'enable': 'true', 'created': '2025-10-16T03:16:45', 'last-modified': '2025-10-16T03:16:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.401868'}
2025-10-16 03:16:46,502 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-16 03:16:46,514 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-79976616', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09553435', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1242023926279062819', 'uuid-lslong': '10634656681926370829'}, 'enable': 'true', 'created': '2025-10-16T03:16:45', 'last-modified': '2025-10-16T03:16:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.421179'}
2025-10-16 03:16:46,520 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-16 03:16:46,520 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-79976616 passed
2025-10-16 03:16:46,521 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-79976616 in API_Server ======
2025-10-16 03:16:46,521 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:46,531 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:46,542 - DEBUG - Requesting: http://10.0.0.19:8082/project/b6d662e6-560e-455b-8d6d-79be24b12b1b
2025-10-16 03:16:46,635 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/113c8e2e-3066-4523-9395-e3e84a74a60d
2025-10-16 03:16:46,644 - DEBUG - =>VN ctest-mgmt_vn-79976616 has no policy to be verified
2025-10-16 03:16:46,644 - DEBUG - Verifying the vn in opserver
2025-10-16 03:16:46,644 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-79976616 virtual network link through opserver 10.0.0.19
2025-10-16 03:16:46,644 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-10-16 03:16:46,656 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-79976616', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-79976616?flat'}
2025-10-16 03:16:46,656 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-79976616 virtual network link through opserver 10.0.0.57
2025-10-16 03:16:46,656 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-10-16 03:16:46,670 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-79976616', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-79976616?flat'}
2025-10-16 03:16:46,670 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-79976616 virtual network link through opserver 10.0.0.23
2025-10-16 03:16:46,670 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-10-16 03:16:46,685 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-79976616', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-79976616?flat'}
2025-10-16 03:16:46,685 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-09553435:ctest-mgmt_vn-79976616 is found in opserver
2025-10-16 03:16:46,709 - DEBUG - Do not have enough data to verify VN in agent
2025-10-16 03:16:46,721 - DEBUG - VRF ids for VN ctest-mgmt_vn-79976616: {}
2025-10-16 03:16:47,008 - DEBUG - Response for create_network : {'network': {'id': '02a02788-b357-483d-96ac-f43d5ffc09c4', 'name': 'ctest-left_vn-50824180', 'tenant_id': 'b6d662e6560e455b8d6d79be24b12b1b', 'project_id': 'b6d662e6560e455b8d6d79be24b12b1b', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-09553435', 'ctest-left_vn-50824180'], 'port_security_enabled': True, 'description': ''}}
2025-10-16 03:16:47,213 - DEBUG - Response for create_subnet : {'subnet': {'id': '29cb6c2a-cdfa-4c67-913c-18b6c60db96b', 'name': '', 'tenant_id': 'b6d662e6560e455b8d6d79be24b12b1b', 'network_id': '02a02788-b357-483d-96ac-f43d5ffc09c4', 'ip_version': 4, 'cidr': '63.3.98.192/26', 'allocation_pools': [{'start': '63.3.98.194', 'end': '63.3.98.254'}], 'gateway_ip': '63.3.98.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '63.3.98.194', 'tags': [], 'project_id': 'b6d662e6560e455b8d6d79be24b12b1b'}}
2025-10-16 03:16:47,240 - INFO - Created VN ctest-left_vn-50824180
2025-10-16 03:16:47,250 - DEBUG - VN ctest-left_vn-50824180 UUID is 02a02788-b357-483d-96ac-f43d5ffc09c4
2025-10-16 03:16:47,318 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:47,324 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:47,336 - DEBUG - Requesting: http://10.0.0.19:8082/project/b6d662e6-560e-455b-8d6d-79be24b12b1b
2025-10-16 03:16:47,428 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/02a02788-b357-483d-96ac-f43d5ffc09c4
2025-10-16 03:16:47,445 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/02a02788-b357-483d-96ac-f43d5ffc09c4
2025-10-16 03:16:47,457 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/b0ecec92-3411-4c48-80ca-31334d8a4e3b
2025-10-16 03:16:47,464 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/b0ecec92-3411-4c48-80ca-31334d8a4e3b
2025-10-16 03:16:47,473 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/db834d40-cd06-4399-96b8-d3da8bb8f0aa
2025-10-16 03:16:47,480 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-16 03:16:47,480 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/02a02788-b357-483d-96ac-f43d5ffc09c4
2025-10-16 03:16:47,491 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/b0ecec92-3411-4c48-80ca-31334d8a4e3b
2025-10-16 03:16:47,512 - INFO - Verified VN network id 12 for VN 02a02788-b357-483d-96ac-f43d5ffc09c4
2025-10-16 03:16:47,512 - INFO - Verifications in API Server for VN ctest-left_vn-50824180 passed
2025-10-16 03:16:47,512 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/02a02788-b357-483d-96ac-f43d5ffc09c4
2025-10-16 03:16:47,554 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/b0ecec92-3411-4c48-80ca-31334d8a4e3b
2025-10-16 03:16:47,571 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/b0ecec92-3411-4c48-80ca-31334d8a4e3b
2025-10-16 03:16:47,579 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/db834d40-cd06-4399-96b8-d3da8bb8f0aa
2025-10-16 03:16:47,593 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09553435:ctest-left_vn-50824180', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09553435', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '189194652427438141', 'uuid-lslong': '10857321346123958724'}, 'enable': 'true', 'created': '2025-10-16T03:16:46', 'last-modified': '2025-10-16T03:16:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.423538'}
2025-10-16 03:16:47,599 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-16 03:16:47,605 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09553435:ctest-left_vn-50824180', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09553435', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '189194652427438141', 'uuid-lslong': '10857321346123958724'}, 'enable': 'true', 'created': '2025-10-16T03:16:46', 'last-modified': '2025-10-16T03:16:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.436127'}
2025-10-16 03:16:47,611 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-16 03:16:47,618 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09553435:ctest-left_vn-50824180', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09553435', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '189194652427438141', 'uuid-lslong': '10857321346123958724'}, 'enable': 'true', 'created': '2025-10-16T03:16:46', 'last-modified': '2025-10-16T03:16:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.445701'}
2025-10-16 03:16:47,623 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-16 03:16:47,623 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-50824180 passed
2025-10-16 03:16:47,623 - DEBUG - ====Verifying policy data for ctest-left_vn-50824180 in API_Server ======
2025-10-16 03:16:47,623 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:47,630 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:47,640 - DEBUG - Requesting: http://10.0.0.19:8082/project/b6d662e6-560e-455b-8d6d-79be24b12b1b
2025-10-16 03:16:47,756 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/02a02788-b357-483d-96ac-f43d5ffc09c4
2025-10-16 03:16:47,764 - DEBUG - =>VN ctest-left_vn-50824180 has no policy to be verified
2025-10-16 03:16:47,764 - DEBUG - Verifying the vn in opserver
2025-10-16 03:16:47,765 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09553435:ctest-left_vn-50824180 virtual network link through opserver 10.0.0.19
2025-10-16 03:16:47,765 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-10-16 03:16:47,778 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09553435:ctest-left_vn-50824180', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09553435:ctest-left_vn-50824180?flat'}
2025-10-16 03:16:47,778 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09553435:ctest-left_vn-50824180 virtual network link through opserver 10.0.0.57
2025-10-16 03:16:47,778 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-10-16 03:16:47,795 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09553435:ctest-left_vn-50824180', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09553435:ctest-left_vn-50824180?flat'}
2025-10-16 03:16:47,795 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09553435:ctest-left_vn-50824180 virtual network link through opserver 10.0.0.23
2025-10-16 03:16:47,796 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-10-16 03:16:47,810 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09553435:ctest-left_vn-50824180', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09553435:ctest-left_vn-50824180?flat'}
2025-10-16 03:16:47,810 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-09553435:ctest-left_vn-50824180 is found in opserver
2025-10-16 03:16:47,837 - DEBUG - Do not have enough data to verify VN in agent
2025-10-16 03:16:47,848 - DEBUG - VRF ids for VN ctest-left_vn-50824180: {}
2025-10-16 03:16:48,102 - DEBUG - Response for create_network : {'network': {'id': '66482851-b3bd-4112-80d6-edcac4dd0e8c', 'name': 'ctest-right_vn-50128430', 'tenant_id': 'b6d662e6560e455b8d6d79be24b12b1b', 'project_id': 'b6d662e6560e455b8d6d79be24b12b1b', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-09553435', 'ctest-right_vn-50128430'], 'port_security_enabled': True, 'description': ''}}
2025-10-16 03:16:48,312 - DEBUG - Response for create_subnet : {'subnet': {'id': 'b9ab6575-d2ae-4f24-92b1-2757dcf99456', 'name': '', 'tenant_id': 'b6d662e6560e455b8d6d79be24b12b1b', 'network_id': '66482851-b3bd-4112-80d6-edcac4dd0e8c', 'ip_version': 4, 'cidr': '173.5.3.0/26', 'allocation_pools': [{'start': '173.5.3.2', 'end': '173.5.3.62'}], 'gateway_ip': '173.5.3.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '173.5.3.2', 'tags': [], 'project_id': 'b6d662e6560e455b8d6d79be24b12b1b'}}
2025-10-16 03:16:48,332 - INFO - Created VN ctest-right_vn-50128430
2025-10-16 03:16:48,344 - DEBUG - VN ctest-right_vn-50128430 UUID is 66482851-b3bd-4112-80d6-edcac4dd0e8c
2025-10-16 03:16:48,417 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:48,426 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:48,442 - DEBUG - Requesting: http://10.0.0.19:8082/project/b6d662e6-560e-455b-8d6d-79be24b12b1b
2025-10-16 03:16:48,557 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/66482851-b3bd-4112-80d6-edcac4dd0e8c
2025-10-16 03:16:48,573 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/66482851-b3bd-4112-80d6-edcac4dd0e8c
2025-10-16 03:16:48,583 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/541251be-d8f2-4804-a513-5a5a66b4c9ce
2025-10-16 03:16:48,591 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/541251be-d8f2-4804-a513-5a5a66b4c9ce
2025-10-16 03:16:48,598 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/8dc9e8e5-d134-4dd9-ba11-5fc722119c4a
2025-10-16 03:16:48,605 - DEBUG - Route Targets: ['target:64512:8000007']
2025-10-16 03:16:48,605 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/66482851-b3bd-4112-80d6-edcac4dd0e8c
2025-10-16 03:16:48,613 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/541251be-d8f2-4804-a513-5a5a66b4c9ce
2025-10-16 03:16:48,628 - INFO - Verified VN network id 13 for VN 66482851-b3bd-4112-80d6-edcac4dd0e8c
2025-10-16 03:16:48,628 - INFO - Verifications in API Server for VN ctest-right_vn-50128430 passed
2025-10-16 03:16:48,628 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/66482851-b3bd-4112-80d6-edcac4dd0e8c
2025-10-16 03:16:48,641 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/541251be-d8f2-4804-a513-5a5a66b4c9ce
2025-10-16 03:16:48,649 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/541251be-d8f2-4804-a513-5a5a66b4c9ce
2025-10-16 03:16:48,657 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/8dc9e8e5-d134-4dd9-ba11-5fc722119c4a
2025-10-16 03:16:48,670 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09553435:ctest-right_vn-50128430', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09553435', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7370185121564803346', 'uuid-lslong': '9283869137012854412'}, 'enable': 'true', 'created': '2025-10-16T03:16:48', 'last-modified': '2025-10-16T03:16:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.416104'}
2025-10-16 03:16:48,676 - DEBUG - Route Targets: ['target:64512:8000007']
2025-10-16 03:16:48,681 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09553435:ctest-right_vn-50128430', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09553435', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7370185121564803346', 'uuid-lslong': '9283869137012854412'}, 'enable': 'true', 'created': '2025-10-16T03:16:48', 'last-modified': '2025-10-16T03:16:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.429407'}
2025-10-16 03:16:48,687 - DEBUG - Route Targets: ['target:64512:8000007']
2025-10-16 03:16:48,692 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09553435:ctest-right_vn-50128430', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09553435', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7370185121564803346', 'uuid-lslong': '9283869137012854412'}, 'enable': 'true', 'created': '2025-10-16T03:16:48', 'last-modified': '2025-10-16T03:16:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.439657'}
2025-10-16 03:16:48,697 - DEBUG - Route Targets: ['target:64512:8000007']
2025-10-16 03:16:48,697 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-50128430 passed
2025-10-16 03:16:48,698 - DEBUG - ====Verifying policy data for ctest-right_vn-50128430 in API_Server ======
2025-10-16 03:16:48,698 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:48,704 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:48,715 - DEBUG - Requesting: http://10.0.0.19:8082/project/b6d662e6-560e-455b-8d6d-79be24b12b1b
2025-10-16 03:16:48,825 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/66482851-b3bd-4112-80d6-edcac4dd0e8c
2025-10-16 03:16:48,838 - DEBUG - =>VN ctest-right_vn-50128430 has no policy to be verified
2025-10-16 03:16:48,838 - DEBUG - Verifying the vn in opserver
2025-10-16 03:16:48,838 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09553435:ctest-right_vn-50128430 virtual network link through opserver 10.0.0.19
2025-10-16 03:16:48,838 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-10-16 03:16:48,850 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09553435:ctest-right_vn-50128430', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09553435:ctest-right_vn-50128430?flat'}
2025-10-16 03:16:48,850 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09553435:ctest-right_vn-50128430 virtual network link through opserver 10.0.0.57
2025-10-16 03:16:48,851 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-10-16 03:16:48,865 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09553435:ctest-right_vn-50128430', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09553435:ctest-right_vn-50128430?flat'}
2025-10-16 03:16:48,865 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09553435:ctest-right_vn-50128430 virtual network link through opserver 10.0.0.23
2025-10-16 03:16:48,865 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-10-16 03:16:48,880 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09553435:ctest-right_vn-50128430', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09553435:ctest-right_vn-50128430?flat'}
2025-10-16 03:16:48,880 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-09553435:ctest-right_vn-50128430 is found in opserver
2025-10-16 03:16:48,903 - DEBUG - Do not have enough data to verify VN in agent
2025-10-16 03:16:48,914 - DEBUG - VRF ids for VN ctest-right_vn-50128430: {}
2025-10-16 03:16:49,975 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4339-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4339-2)
2025-10-16 03:16:51,261 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4339-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4339-1)
2025-10-16 03:16:51,261 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-28009948']
2025-10-16 03:16:51,553 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-28009948'] created succesfully
2025-10-16 03:16:51,916 - DEBUG - Image by name tiny_nat_fw not found
2025-10-16 03:16:51,916 - DEBUG - Installing image tiny_nat_fw
2025-10-16 03:16:51,916 - 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'"}
2025-10-16 03:16:51,916 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-10-16 03:16:51,916 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-10-16 03:16:51,916 - DEBUG - Unzip image
2025-10-16 03:16:51,916 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-10-16 03:16:51,935 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2025-10-16 03:16:51,935 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-28009948']
2025-10-16 03:16:52,035 - INFO - Service template: ['default-domain', 'ctest-service_template_1-28009948'] deleted successfully.
2025-10-16 03:16:52,035 - INFO - Skip interface_detach for VM ctest-right_vm-29270576 in state BUILD
2025-10-16 03:16:52,035 - INFO - Deleting VM ctest-right_vm-29270576
2025-10-16 03:16:52,035 - ERROR - VM ctest-right_vm-29270576 has failed to come up
2025-10-16 03:16:52,035 - ERROR - Nova failed to get host of the VM
2025-10-16 03:16:52,035 - ERROR - VM ctest-right_vm-29270576 has failed to come up
2025-10-16 03:16:52,035 - ERROR - Nova failed to get host of the VM
2025-10-16 03:16:52,155 - INFO - Skip interface_detach for VM ctest-left_vm-80673080 in state BUILD
2025-10-16 03:16:52,156 - INFO - Deleting VM ctest-left_vm-80673080
2025-10-16 03:16:52,156 - ERROR - VM ctest-left_vm-80673080 has failed to come up
2025-10-16 03:16:52,156 - ERROR - Nova failed to get host of the VM
2025-10-16 03:16:52,156 - ERROR - VM ctest-left_vm-80673080 has failed to come up
2025-10-16 03:16:52,156 - ERROR - Nova failed to get host of the VM
2025-10-16 03:16:52,228 - INFO - Deleting VN ctest-right_vn-50128430
2025-10-16 03:16:52,276 - DEBUG - VN 66482851-b3bd-4112-80d6-edcac4dd0e8c still in use: Unable to complete operation on network 66482851-b3bd-4112-80d6-edcac4dd0e8c. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-3b72d123-ce64-4f5d-9d52-4617d44dec24']
2025-10-16 03:16:52,276 - WARNING - Deleting VN ctest-right_vn-50128430 failed..Will retry
2025-10-16 03:16:54,423 - DEBUG - Response for deleting network ()
2025-10-16 03:16:54,423 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/541251be-d8f2-4804-a513-5a5a66b4c9ce
2025-10-16 03:16:54,430 - DEBUG - Response Code: 404
2025-10-16 03:16:54,430 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:54,436 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:54,469 - DEBUG - Requesting: http://10.0.0.19:8082/project/b6d662e6-560e-455b-8d6d-79be24b12b1b
2025-10-16 03:16:54,566 - INFO - Validated that VN ctest-right_vn-50128430 is not found in API Server
2025-10-16 03:16:54,579 - DEBUG - VN ctest-right_vn-50128430 is not present in Agent 10.0.0.38
2025-10-16 03:16:54,590 - DEBUG - VN ctest-right_vn-50128430 is not present in Agent 10.0.0.129
2025-10-16 03:16:54,590 - INFO - Validated that VN ctest-right_vn-50128430 is not in any agent
2025-10-16 03:16:54,619 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-50128430 info
2025-10-16 03:16:54,619 - INFO - Deleting VN ctest-left_vn-50824180
2025-10-16 03:16:54,769 - DEBUG - Response for deleting network ()
2025-10-16 03:16:54,769 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/b0ecec92-3411-4c48-80ca-31334d8a4e3b
2025-10-16 03:16:54,780 - DEBUG - Response Code: 404
2025-10-16 03:16:54,780 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:54,790 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:54,800 - DEBUG - Requesting: http://10.0.0.19:8082/project/b6d662e6-560e-455b-8d6d-79be24b12b1b
2025-10-16 03:16:54,890 - INFO - Validated that VN ctest-left_vn-50824180 is not found in API Server
2025-10-16 03:16:54,899 - DEBUG - VN ctest-left_vn-50824180 is not present in Agent 10.0.0.38
2025-10-16 03:16:54,909 - DEBUG - VN ctest-left_vn-50824180 is not present in Agent 10.0.0.129
2025-10-16 03:16:54,909 - INFO - Validated that VN ctest-left_vn-50824180 is not in any agent
2025-10-16 03:16:54,937 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-50824180 info
2025-10-16 03:16:54,937 - INFO - Deleting VN ctest-mgmt_vn-79976616
2025-10-16 03:16:55,085 - DEBUG - Response for deleting network ()
2025-10-16 03:16:55,085 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/22499d04-de62-4f8e-96cf-43869ef8b466
2025-10-16 03:16:55,097 - DEBUG - Response Code: 404
2025-10-16 03:16:55,098 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-10-16 03:16:55,103 - DEBUG - Requesting: http://10.0.0.19:8082/domain/446ea2e6-9d96-4973-a55a-3f633ea4d0f9
2025-10-16 03:16:55,160 - DEBUG - Requesting: http://10.0.0.19:8082/project/b6d662e6-560e-455b-8d6d-79be24b12b1b
2025-10-16 03:16:55,255 - INFO - Validated that VN ctest-mgmt_vn-79976616 is not found in API Server
2025-10-16 03:16:55,266 - DEBUG - VN ctest-mgmt_vn-79976616 is not present in Agent 10.0.0.38
2025-10-16 03:16:55,276 - DEBUG - VN ctest-mgmt_vn-79976616 is not present in Agent 10.0.0.129
2025-10-16 03:16:55,276 - INFO - Validated that VN ctest-mgmt_vn-79976616 is not in any agent
2025-10-16 03:16:55,307 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-79976616 info
2025-10-16 03:16:56,592 - DEBUG - No XMPP flaps were noticed during the test
2025-10-16 03:16:56,592 - INFO -
2025-10-16 03:16:56,592 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:12]
2025-10-16 03:16:56,592 - INFO - --------------------------------------------------------------------------------
2025-10-16 03:16:57,313 - INFO - Deleted project: ctest-TestSvcRegr-09553435, ID : b6d662e6-560e-455b-8d6d-79be24b12b1b