]) created on node: (an-jenkins-deploy-platform-ansible-os-5433-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5433-2)
2026-03-05 03:03:47,253 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-73312076']
2026-03-05 03:03:47,559 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-73312076'] created succesfully
2026-03-05 03:03:47,978 - DEBUG - Image by name tiny_nat_fw not found
2026-03-05 03:03:47,978 - DEBUG - Installing image tiny_nat_fw
2026-03-05 03:03:47,978 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-03-05 03:03:47,978 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-03-05 03:03:47,978 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-03-05 03:03:47,998 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz -O /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-05 03:03:48,076 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-05 03:03:48,076 - DEBUG - Unzip image
2026-03-05 03:03:48,076 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-05 03:03:48,109 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-03-05 03:03:48,110 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-73312076']
2026-03-05 03:03:48,197 - INFO - Service template: ['default-domain', 'ctest-service_template_1-73312076'] deleted successfully.
2026-03-05 03:03:48,197 - INFO - Skip interface_detach for VM ctest-right_vm-51887760 in state BUILD
2026-03-05 03:03:48,197 - INFO - Deleting VM ctest-right_vm-51887760
2026-03-05 03:03:48,230 - ERROR - VM ctest-right_vm-51887760 has failed to come up
2026-03-05 03:03:48,230 - ERROR - Nova failed to get host of the VM
2026-03-05 03:03:48,230 - ERROR - VM ctest-right_vm-51887760 has failed to come up
2026-03-05 03:03:48,230 - ERROR - Nova failed to get host of the VM
2026-03-05 03:03:48,311 - INFO - Skip interface_detach for VM ctest-left_vm-90298284 in state BUILD
2026-03-05 03:03:48,311 - INFO - Deleting VM ctest-left_vm-90298284
2026-03-05 03:03:48,311 - ERROR - VM ctest-left_vm-90298284 has failed to come up
2026-03-05 03:03:48,311 - ERROR - Nova failed to get host of the VM
2026-03-05 03:03:48,311 - ERROR - VM ctest-left_vm-90298284 has failed to come up
2026-03-05 03:03:48,312 - ERROR - Nova failed to get host of the VM
2026-03-05 03:03:48,382 - INFO - Deleting VN ctest-right_vn-09742983
2026-03-05 03:03:48,421 - DEBUG - VN d284c520-10e4-4a90-bb87-118ac8bae547 still in use: Unable to complete operation on network d284c520-10e4-4a90-bb87-118ac8bae547. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-9e9bc497-6f86-43de-9564-dba1cc6161bf']
2026-03-05 03:03:48,421 - WARNING - Deleting VN ctest-right_vn-09742983 failed..Will retry
2026-03-05 03:03:50,555 - DEBUG - Response for deleting network ()
2026-03-05 03:03:50,555 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/98f8b23b-df7a-4a95-92cd-fd665ac9e294
2026-03-05 03:03:50,560 - DEBUG - Response Code: 404
2026-03-05 03:03:50,561 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:03:50,572 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:03:50,589 - DEBUG - Requesting: http://10.0.0.65:8082/project/9a1310fa-4395-4762-91e7-b00ef1dd0ca2
2026-03-05 03:03:50,688 - INFO - Validated that VN ctest-right_vn-09742983 is not found in API Server
2026-03-05 03:03:50,700 - DEBUG - VN ctest-right_vn-09742983 is not present in Agent 10.0.0.141
2026-03-05 03:03:50,710 - DEBUG - VN ctest-right_vn-09742983 is not present in Agent 10.0.0.73
2026-03-05 03:03:50,710 - INFO - Validated that VN ctest-right_vn-09742983 is not in any agent
2026-03-05 03:03:50,741 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-09742983 info
2026-03-05 03:03:50,742 - INFO - Deleting VN ctest-left_vn-18088850
2026-03-05 03:03:50,894 - DEBUG - Response for deleting network ()
2026-03-05 03:03:50,895 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/ba4176c9-ae90-435c-aca5-b4757c4c47dc
2026-03-05 03:03:50,906 - DEBUG - Response Code: 404
2026-03-05 03:03:50,907 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:03:50,925 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:03:50,946 - DEBUG - Requesting: http://10.0.0.65:8082/project/9a1310fa-4395-4762-91e7-b00ef1dd0ca2
2026-03-05 03:03:51,058 - INFO - Validated that VN ctest-left_vn-18088850 is not found in API Server
2026-03-05 03:03:51,069 - DEBUG - VN ctest-left_vn-18088850 is not present in Agent 10.0.0.141
2026-03-05 03:03:51,083 - DEBUG - VN ctest-left_vn-18088850 is not present in Agent 10.0.0.73
2026-03-05 03:03:51,083 - INFO - Validated that VN ctest-left_vn-18088850 is not in any agent
2026-03-05 03:03:51,125 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-18088850 info
2026-03-05 03:03:51,125 - INFO - Deleting VN ctest-mgmt_vn-73855478
2026-03-05 03:03:51,274 - DEBUG - Response for deleting network ()
2026-03-05 03:03:51,274 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/5b08bd12-e05d-486e-8c88-60bc72c2a642
2026-03-05 03:03:51,281 - DEBUG - Response Code: 404
2026-03-05 03:03:51,281 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:03:51,293 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:03:51,351 - DEBUG - Requesting: http://10.0.0.65:8082/project/9a1310fa-4395-4762-91e7-b00ef1dd0ca2
2026-03-05 03:03:51,455 - INFO - Validated that VN ctest-mgmt_vn-73855478 is not found in API Server
2026-03-05 03:03:51,466 - DEBUG - VN ctest-mgmt_vn-73855478 is not present in Agent 10.0.0.141
2026-03-05 03:03:51,483 - DEBUG - VN ctest-mgmt_vn-73855478 is not present in Agent 10.0.0.73
2026-03-05 03:03:51,484 - INFO - Validated that VN ctest-mgmt_vn-73855478 is not in any agent
2026-03-05 03:03:51,522 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-73855478 info
2026-03-05 03:03:51,522 - INFO - Deleting VM ctest-vm-in-third-vn-19546939
2026-03-05 03:03:51,592 - INFO - Deleting VN ctest-third-vn-56691229
2026-03-05 03:03:51,634 - DEBUG - VN a8d527ac-8705-4869-a5bf-a9187426ae6c still in use: Unable to complete operation on network a8d527ac-8705-4869-a5bf-a9187426ae6c. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-c689271d-6fc9-4e94-a716-4aa95957619b']
2026-03-05 03:03:51,634 - WARNING - Deleting VN ctest-third-vn-56691229 failed..Will retry
2026-03-05 03:03:53,768 - DEBUG - Response for deleting network ()
2026-03-05 03:03:55,047 - DEBUG - No XMPP flaps were noticed during the test
2026-03-05 03:03:55,047 - INFO -
2026-03-05 03:03:55,047 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:25]
2026-03-05 03:03:55,047 - INFO - --------------------------------------------------------------------------------
2026-03-05 03:03:55,051 - INFO - ================================================================================
2026-03-05 03:03:55,051 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2026-03-05 03:03:56,329 - DEBUG - Nothing to compare xmpp stats {'10.0.0.141': {'10.20.0.254': '0', '10.20.0.14': '0'}, '10.0.0.73': {'10.20.0.14': '0', '10.20.0.254': '0'}} with
2026-03-05 03:03:56,329 - INFO - Initial checks done. Running the testcase now
2026-03-05 03:03:56,329 - INFO -
2026-03-05 03:03:56,576 - DEBUG - Response for create_network : {'network': {'id': 'faf327e3-df6c-4c0b-b406-7c1f8821e964', 'name': 'ctest-mgmt_vn-78564881', 'tenant_id': '9a1310fa4395476291e7b00ef1dd0ca2', 'project_id': '9a1310fa4395476291e7b00ef1dd0ca2', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-23180742', 'ctest-mgmt_vn-78564881'], 'port_security_enabled': True, 'description': ''}}
2026-03-05 03:03:56,778 - DEBUG - Response for create_subnet : {'subnet': {'id': 'aefabd10-ff0a-4d55-b19f-cf2d53aa7e14', 'name': '', 'tenant_id': '9a1310fa4395476291e7b00ef1dd0ca2', 'network_id': 'faf327e3-df6c-4c0b-b406-7c1f8821e964', 'ip_version': 4, 'cidr': '11.248.83.0/26', 'allocation_pools': [{'start': '11.248.83.2', 'end': '11.248.83.62'}], 'gateway_ip': '11.248.83.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '11.248.83.2', 'tags': [], 'project_id': '9a1310fa4395476291e7b00ef1dd0ca2'}}
2026-03-05 03:03:56,800 - INFO - Created VN ctest-mgmt_vn-78564881
2026-03-05 03:03:56,811 - DEBUG - VN ctest-mgmt_vn-78564881 UUID is faf327e3-df6c-4c0b-b406-7c1f8821e964
2026-03-05 03:03:56,882 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:03:56,888 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:03:56,898 - DEBUG - Requesting: http://10.0.0.65:8082/project/9a1310fa-4395-4762-91e7-b00ef1dd0ca2
2026-03-05 03:03:56,990 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/faf327e3-df6c-4c0b-b406-7c1f8821e964
2026-03-05 03:03:57,005 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/faf327e3-df6c-4c0b-b406-7c1f8821e964
2026-03-05 03:03:57,015 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/a5817249-c009-44ab-bdda-67cdb759358c
2026-03-05 03:03:57,023 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/a5817249-c009-44ab-bdda-67cdb759358c
2026-03-05 03:03:57,031 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/5ce442b7-f92d-48b8-96b4-da84d910a3b4
2026-03-05 03:03:57,038 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-05 03:03:57,038 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/faf327e3-df6c-4c0b-b406-7c1f8821e964
2026-03-05 03:03:57,047 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/a5817249-c009-44ab-bdda-67cdb759358c
2026-03-05 03:03:57,063 - INFO - Verified VN network id 16 for VN faf327e3-df6c-4c0b-b406-7c1f8821e964
2026-03-05 03:03:57,063 - INFO - Verifications in API Server for VN ctest-mgmt_vn-78564881 passed
2026-03-05 03:03:57,063 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/faf327e3-df6c-4c0b-b406-7c1f8821e964
2026-03-05 03:03:57,075 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/a5817249-c009-44ab-bdda-67cdb759358c
2026-03-05 03:03:57,085 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/a5817249-c009-44ab-bdda-67cdb759358c
2026-03-05 03:03:57,093 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/5ce442b7-f92d-48b8-96b4-da84d910a3b4
2026-03-05 03:03:57,111 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23180742:ctest-mgmt_vn-78564881', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23180742', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18082840788482149387', 'uuid-lslong': '12972192251557046628'}, 'enable': 'true', 'created': '2026-03-05T03:03:56', 'last-modified': '2026-03-05T03:03:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.366728'}
2026-03-05 03:03:57,121 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-05 03:03:57,127 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23180742:ctest-mgmt_vn-78564881', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23180742', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18082840788482149387', 'uuid-lslong': '12972192251557046628'}, 'enable': 'true', 'created': '2026-03-05T03:03:56', 'last-modified': '2026-03-05T03:03:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.391605'}
2026-03-05 03:03:57,134 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-05 03:03:57,144 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23180742:ctest-mgmt_vn-78564881', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23180742', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18082840788482149387', 'uuid-lslong': '12972192251557046628'}, 'enable': 'true', 'created': '2026-03-05T03:03:56', 'last-modified': '2026-03-05T03:03:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.403674'}
2026-03-05 03:03:57,153 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-05 03:03:57,153 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-78564881 passed
2026-03-05 03:03:57,153 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-78564881 in API_Server ======
2026-03-05 03:03:57,153 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:03:57,162 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:03:57,176 - DEBUG - Requesting: http://10.0.0.65:8082/project/9a1310fa-4395-4762-91e7-b00ef1dd0ca2
2026-03-05 03:03:57,274 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/faf327e3-df6c-4c0b-b406-7c1f8821e964
2026-03-05 03:03:57,285 - DEBUG - =>VN ctest-mgmt_vn-78564881 has no policy to be verified
2026-03-05 03:03:57,285 - DEBUG - Verifying the vn in opserver
2026-03-05 03:03:57,285 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23180742:ctest-mgmt_vn-78564881 virtual network link through opserver 10.0.0.65
2026-03-05 03:03:57,285 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-05 03:03:57,301 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23180742:ctest-mgmt_vn-78564881', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23180742:ctest-mgmt_vn-78564881?flat'}
2026-03-05 03:03:57,301 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23180742:ctest-mgmt_vn-78564881 virtual network link through opserver 10.0.0.33
2026-03-05 03:03:57,301 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-03-05 03:03:57,320 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23180742:ctest-mgmt_vn-78564881', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23180742:ctest-mgmt_vn-78564881?flat'}
2026-03-05 03:03:57,320 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23180742:ctest-mgmt_vn-78564881 virtual network link through opserver 10.0.0.133
2026-03-05 03:03:57,320 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-03-05 03:03:57,335 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23180742:ctest-mgmt_vn-78564881', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23180742:ctest-mgmt_vn-78564881?flat'}
2026-03-05 03:03:57,335 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-23180742:ctest-mgmt_vn-78564881 is found in opserver
2026-03-05 03:03:57,357 - DEBUG - Do not have enough data to verify VN in agent
2026-03-05 03:03:57,367 - DEBUG - VRF ids for VN ctest-mgmt_vn-78564881: {}
2026-03-05 03:03:57,617 - DEBUG - Response for create_network : {'network': {'id': '8c5438b3-6ee7-46e3-a950-25b66ce166ea', 'name': 'ctest-left_vn-89360980', 'tenant_id': '9a1310fa4395476291e7b00ef1dd0ca2', 'project_id': '9a1310fa4395476291e7b00ef1dd0ca2', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-23180742', 'ctest-left_vn-89360980'], 'port_security_enabled': True, 'description': ''}}
2026-03-05 03:03:57,809 - DEBUG - Response for create_subnet : {'subnet': {'id': '43d9fab5-4b76-4140-b50d-60ecb788acb4', 'name': '', 'tenant_id': '9a1310fa4395476291e7b00ef1dd0ca2', 'network_id': '8c5438b3-6ee7-46e3-a950-25b66ce166ea', 'ip_version': 4, 'cidr': '178.64.143.64/26', 'allocation_pools': [{'start': '178.64.143.66', 'end': '178.64.143.126'}], 'gateway_ip': '178.64.143.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '178.64.143.66', 'tags': [], 'project_id': '9a1310fa4395476291e7b00ef1dd0ca2'}}
2026-03-05 03:03:57,832 - INFO - Created VN ctest-left_vn-89360980
2026-03-05 03:03:57,843 - DEBUG - VN ctest-left_vn-89360980 UUID is 8c5438b3-6ee7-46e3-a950-25b66ce166ea
2026-03-05 03:03:57,918 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:03:57,926 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:03:57,942 - DEBUG - Requesting: http://10.0.0.65:8082/project/9a1310fa-4395-4762-91e7-b00ef1dd0ca2
2026-03-05 03:03:58,036 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/8c5438b3-6ee7-46e3-a950-25b66ce166ea
2026-03-05 03:03:58,051 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/8c5438b3-6ee7-46e3-a950-25b66ce166ea
2026-03-05 03:03:58,061 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/7964b22f-c89d-4062-9594-8e063a1c006d
2026-03-05 03:03:58,071 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/7964b22f-c89d-4062-9594-8e063a1c006d
2026-03-05 03:03:58,079 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/3a385862-b03e-4d26-bf4e-76e90d80e29b
2026-03-05 03:03:58,087 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-05 03:03:58,087 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/8c5438b3-6ee7-46e3-a950-25b66ce166ea
2026-03-05 03:03:58,096 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/7964b22f-c89d-4062-9594-8e063a1c006d
2026-03-05 03:03:58,113 - INFO - Verified VN network id 17 for VN 8c5438b3-6ee7-46e3-a950-25b66ce166ea
2026-03-05 03:03:58,113 - INFO - Verifications in API Server for VN ctest-left_vn-89360980 passed
2026-03-05 03:03:58,113 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/8c5438b3-6ee7-46e3-a950-25b66ce166ea
2026-03-05 03:03:58,124 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/7964b22f-c89d-4062-9594-8e063a1c006d
2026-03-05 03:03:58,133 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/7964b22f-c89d-4062-9594-8e063a1c006d
2026-03-05 03:03:58,142 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/3a385862-b03e-4d26-bf4e-76e90d80e29b
2026-03-05 03:03:58,154 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23180742:ctest-left_vn-89360980', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23180742', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10111769406664558307', 'uuid-lslong': '12200292855987660522'}, 'enable': 'true', 'created': '2026-03-05T03:03:57', 'last-modified': '2026-03-05T03:03:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.405172'}
2026-03-05 03:03:58,160 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-05 03:03:58,165 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23180742:ctest-left_vn-89360980', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23180742', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10111769406664558307', 'uuid-lslong': '12200292855987660522'}, 'enable': 'true', 'created': '2026-03-05T03:03:57', 'last-modified': '2026-03-05T03:03:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.418224'}
2026-03-05 03:03:58,172 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-05 03:03:58,177 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23180742:ctest-left_vn-89360980', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23180742', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10111769406664558307', 'uuid-lslong': '12200292855987660522'}, 'enable': 'true', 'created': '2026-03-05T03:03:57', 'last-modified': '2026-03-05T03:03:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.428390'}
2026-03-05 03:03:58,182 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-05 03:03:58,182 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-89360980 passed
2026-03-05 03:03:58,182 - DEBUG - ====Verifying policy data for ctest-left_vn-89360980 in API_Server ======
2026-03-05 03:03:58,183 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:03:58,188 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:03:58,201 - DEBUG - Requesting: http://10.0.0.65:8082/project/9a1310fa-4395-4762-91e7-b00ef1dd0ca2
2026-03-05 03:03:58,315 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/8c5438b3-6ee7-46e3-a950-25b66ce166ea
2026-03-05 03:03:58,331 - DEBUG - =>VN ctest-left_vn-89360980 has no policy to be verified
2026-03-05 03:03:58,331 - DEBUG - Verifying the vn in opserver
2026-03-05 03:03:58,331 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23180742:ctest-left_vn-89360980 virtual network link through opserver 10.0.0.65
2026-03-05 03:03:58,331 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-05 03:03:58,346 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23180742:ctest-left_vn-89360980', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23180742:ctest-left_vn-89360980?flat'}
2026-03-05 03:03:58,346 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23180742:ctest-left_vn-89360980 virtual network link through opserver 10.0.0.33
2026-03-05 03:03:58,346 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-03-05 03:03:58,359 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23180742:ctest-left_vn-89360980', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23180742:ctest-left_vn-89360980?flat'}
2026-03-05 03:03:58,360 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23180742:ctest-left_vn-89360980 virtual network link through opserver 10.0.0.133
2026-03-05 03:03:58,360 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-03-05 03:03:58,374 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23180742:ctest-left_vn-89360980', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23180742:ctest-left_vn-89360980?flat'}
2026-03-05 03:03:58,374 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-23180742:ctest-left_vn-89360980 is found in opserver
2026-03-05 03:03:58,414 - DEBUG - Do not have enough data to verify VN in agent
2026-03-05 03:03:58,426 - DEBUG - VRF ids for VN ctest-left_vn-89360980: {}
2026-03-05 03:03:58,678 - DEBUG - Response for create_network : {'network': {'id': '2c039159-0c5a-414e-ae36-df288392207b', 'name': 'ctest-right_vn-79002301', 'tenant_id': '9a1310fa4395476291e7b00ef1dd0ca2', 'project_id': '9a1310fa4395476291e7b00ef1dd0ca2', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-23180742', 'ctest-right_vn-79002301'], 'port_security_enabled': True, 'description': ''}}
2026-03-05 03:03:58,939 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f13ceb48-2b92-420a-8104-42c23ec636a8', 'name': '', 'tenant_id': '9a1310fa4395476291e7b00ef1dd0ca2', 'network_id': '2c039159-0c5a-414e-ae36-df288392207b', 'ip_version': 4, 'cidr': '217.255.36.64/26', 'allocation_pools': [{'start': '217.255.36.66', 'end': '217.255.36.126'}], 'gateway_ip': '217.255.36.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '217.255.36.66', 'tags': [], 'project_id': '9a1310fa4395476291e7b00ef1dd0ca2'}}
2026-03-05 03:03:58,961 - INFO - Created VN ctest-right_vn-79002301
2026-03-05 03:03:58,973 - DEBUG - VN ctest-right_vn-79002301 UUID is 2c039159-0c5a-414e-ae36-df288392207b
2026-03-05 03:03:59,046 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:03:59,054 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:03:59,068 - DEBUG - Requesting: http://10.0.0.65:8082/project/9a1310fa-4395-4762-91e7-b00ef1dd0ca2
2026-03-05 03:03:59,157 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/2c039159-0c5a-414e-ae36-df288392207b
2026-03-05 03:03:59,169 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/2c039159-0c5a-414e-ae36-df288392207b
2026-03-05 03:03:59,178 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/d32ef962-58a8-4997-b547-945d33e50098
2026-03-05 03:03:59,186 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/d32ef962-58a8-4997-b547-945d33e50098
2026-03-05 03:03:59,192 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/3903c32c-2fdf-4867-91a6-d1b0d0d88bda
2026-03-05 03:03:59,199 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-05 03:03:59,199 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/2c039159-0c5a-414e-ae36-df288392207b
2026-03-05 03:03:59,208 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/d32ef962-58a8-4997-b547-945d33e50098
2026-03-05 03:03:59,223 - INFO - Verified VN network id 18 for VN 2c039159-0c5a-414e-ae36-df288392207b
2026-03-05 03:03:59,223 - INFO - Verifications in API Server for VN ctest-right_vn-79002301 passed
2026-03-05 03:03:59,223 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/2c039159-0c5a-414e-ae36-df288392207b
2026-03-05 03:03:59,233 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/d32ef962-58a8-4997-b547-945d33e50098
2026-03-05 03:03:59,241 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/d32ef962-58a8-4997-b547-945d33e50098
2026-03-05 03:03:59,251 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/3903c32c-2fdf-4867-91a6-d1b0d0d88bda
2026-03-05 03:03:59,265 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23180742:ctest-right_vn-79002301', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23180742', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3171538374244319566', 'uuid-lslong': '12553466376440914043'}, 'enable': 'true', 'created': '2026-03-05T03:03:58', 'last-modified': '2026-03-05T03:03:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.370378'}
2026-03-05 03:03:59,273 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-05 03:03:59,278 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23180742:ctest-right_vn-79002301', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23180742', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3171538374244319566', 'uuid-lslong': '12553466376440914043'}, 'enable': 'true', 'created': '2026-03-05T03:03:58', 'last-modified': '2026-03-05T03:03:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.384641'}
2026-03-05 03:03:59,284 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-05 03:03:59,290 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23180742:ctest-right_vn-79002301', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23180742', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3171538374244319566', 'uuid-lslong': '12553466376440914043'}, 'enable': 'true', 'created': '2026-03-05T03:03:58', 'last-modified': '2026-03-05T03:03:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.399336'}
2026-03-05 03:03:59,296 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-05 03:03:59,297 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-79002301 passed
2026-03-05 03:03:59,297 - DEBUG - ====Verifying policy data for ctest-right_vn-79002301 in API_Server ======
2026-03-05 03:03:59,297 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:03:59,304 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:03:59,317 - DEBUG - Requesting: http://10.0.0.65:8082/project/9a1310fa-4395-4762-91e7-b00ef1dd0ca2
2026-03-05 03:03:59,409 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/2c039159-0c5a-414e-ae36-df288392207b
2026-03-05 03:03:59,420 - DEBUG - =>VN ctest-right_vn-79002301 has no policy to be verified
2026-03-05 03:03:59,420 - DEBUG - Verifying the vn in opserver
2026-03-05 03:03:59,420 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23180742:ctest-right_vn-79002301 virtual network link through opserver 10.0.0.65
2026-03-05 03:03:59,420 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-05 03:03:59,435 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23180742:ctest-right_vn-79002301', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23180742:ctest-right_vn-79002301?flat'}
2026-03-05 03:03:59,435 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23180742:ctest-right_vn-79002301 virtual network link through opserver 10.0.0.33
2026-03-05 03:03:59,435 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-03-05 03:03:59,446 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23180742:ctest-right_vn-79002301', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23180742:ctest-right_vn-79002301?flat'}
2026-03-05 03:03:59,446 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23180742:ctest-right_vn-79002301 virtual network link through opserver 10.0.0.133
2026-03-05 03:03:59,446 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-03-05 03:03:59,461 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23180742:ctest-right_vn-79002301', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23180742:ctest-right_vn-79002301?flat'}
2026-03-05 03:03:59,461 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-23180742:ctest-right_vn-79002301 is found in opserver
2026-03-05 03:03:59,485 - DEBUG - Do not have enough data to verify VN in agent
2026-03-05 03:03:59,495 - DEBUG - VRF ids for VN ctest-right_vn-79002301: {}
2026-03-05 03:03:59,732 - DEBUG - Response for create_network : {'network': {'id': '73b19e2a-a40e-4dac-869b-b07de7ef5e21', 'name': 'ctest-trans_left_vn-40832349', 'tenant_id': '9a1310fa4395476291e7b00ef1dd0ca2', 'project_id': '9a1310fa4395476291e7b00ef1dd0ca2', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-23180742', 'ctest-trans_left_vn-40832349'], 'port_security_enabled': True, 'description': ''}}
2026-03-05 03:03:59,914 - DEBUG - Response for create_subnet : {'subnet': {'id': '32e188d2-714c-441b-8f57-0266ebca5ec5', 'name': '', 'tenant_id': '9a1310fa4395476291e7b00ef1dd0ca2', 'network_id': '73b19e2a-a40e-4dac-869b-b07de7ef5e21', 'ip_version': 4, 'cidr': '79.106.202.192/26', 'allocation_pools': [{'start': '79.106.202.194', 'end': '79.106.202.254'}], 'gateway_ip': '79.106.202.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '79.106.202.194', 'tags': [], 'project_id': '9a1310fa4395476291e7b00ef1dd0ca2'}}
2026-03-05 03:03:59,934 - INFO - Created VN ctest-trans_left_vn-40832349
2026-03-05 03:03:59,945 - DEBUG - VN ctest-trans_left_vn-40832349 UUID is 73b19e2a-a40e-4dac-869b-b07de7ef5e21
2026-03-05 03:04:00,011 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:00,018 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:00,034 - DEBUG - Requesting: http://10.0.0.65:8082/project/9a1310fa-4395-4762-91e7-b00ef1dd0ca2
2026-03-05 03:04:00,118 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/73b19e2a-a40e-4dac-869b-b07de7ef5e21
2026-03-05 03:04:00,132 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/73b19e2a-a40e-4dac-869b-b07de7ef5e21
2026-03-05 03:04:00,141 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/42e9ec50-4000-4194-81b6-668619bcaf29
2026-03-05 03:04:00,148 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/42e9ec50-4000-4194-81b6-668619bcaf29
2026-03-05 03:04:00,155 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/da821a8b-782c-4bf4-bb68-0669bcfdb908
2026-03-05 03:04:00,162 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-05 03:04:00,162 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/73b19e2a-a40e-4dac-869b-b07de7ef5e21
2026-03-05 03:04:00,170 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/42e9ec50-4000-4194-81b6-668619bcaf29
2026-03-05 03:04:00,186 - INFO - Verified VN network id 19 for VN 73b19e2a-a40e-4dac-869b-b07de7ef5e21
2026-03-05 03:04:00,186 - INFO - Verifications in API Server for VN ctest-trans_left_vn-40832349 passed
2026-03-05 03:04:00,186 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/73b19e2a-a40e-4dac-869b-b07de7ef5e21
2026-03-05 03:04:00,196 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/42e9ec50-4000-4194-81b6-668619bcaf29
2026-03-05 03:04:00,207 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/42e9ec50-4000-4194-81b6-668619bcaf29
2026-03-05 03:04:00,218 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/da821a8b-782c-4bf4-bb68-0669bcfdb908
2026-03-05 03:04:00,234 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23180742:ctest-trans_left_vn-40832349', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23180742', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8336618291217714604', 'uuid-lslong': '9699540277281119777'}, 'enable': 'true', 'created': '2026-03-05T03:03:59', 'last-modified': '2026-03-05T03:03:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.364233'}
2026-03-05 03:04:00,241 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-05 03:04:00,248 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23180742:ctest-trans_left_vn-40832349', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23180742', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8336618291217714604', 'uuid-lslong': '9699540277281119777'}, 'enable': 'true', 'created': '2026-03-05T03:03:59', 'last-modified': '2026-03-05T03:03:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.382467'}
2026-03-05 03:04:00,256 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-05 03:04:00,262 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23180742:ctest-trans_left_vn-40832349', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23180742', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8336618291217714604', 'uuid-lslong': '9699540277281119777'}, 'enable': 'true', 'created': '2026-03-05T03:03:59', 'last-modified': '2026-03-05T03:03:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.395615'}
2026-03-05 03:04:00,267 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-05 03:04:00,268 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-40832349 passed
2026-03-05 03:04:00,268 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-40832349 in API_Server ======
2026-03-05 03:04:00,268 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:00,275 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:00,291 - DEBUG - Requesting: http://10.0.0.65:8082/project/9a1310fa-4395-4762-91e7-b00ef1dd0ca2
2026-03-05 03:04:00,384 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/73b19e2a-a40e-4dac-869b-b07de7ef5e21
2026-03-05 03:04:00,398 - DEBUG - =>VN ctest-trans_left_vn-40832349 has no policy to be verified
2026-03-05 03:04:00,398 - DEBUG - Verifying the vn in opserver
2026-03-05 03:04:00,398 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23180742:ctest-trans_left_vn-40832349 virtual network link through opserver 10.0.0.65
2026-03-05 03:04:00,398 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-05 03:04:00,411 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23180742:ctest-trans_left_vn-40832349', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23180742:ctest-trans_left_vn-40832349?flat'}
2026-03-05 03:04:00,412 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23180742:ctest-trans_left_vn-40832349 virtual network link through opserver 10.0.0.33
2026-03-05 03:04:00,412 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-03-05 03:04:00,423 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23180742:ctest-trans_left_vn-40832349', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23180742:ctest-trans_left_vn-40832349?flat'}
2026-03-05 03:04:00,423 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23180742:ctest-trans_left_vn-40832349 virtual network link through opserver 10.0.0.133
2026-03-05 03:04:00,424 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-03-05 03:04:00,435 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23180742:ctest-trans_left_vn-40832349', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23180742:ctest-trans_left_vn-40832349?flat'}
2026-03-05 03:04:00,435 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-23180742:ctest-trans_left_vn-40832349 is found in opserver
2026-03-05 03:04:00,458 - DEBUG - Do not have enough data to verify VN in agent
2026-03-05 03:04:00,469 - DEBUG - VRF ids for VN ctest-trans_left_vn-40832349: {}
2026-03-05 03:04:00,729 - DEBUG - Response for create_network : {'network': {'id': '8a950edf-cb26-4e85-a5d0-a3783975447b', 'name': 'ctest-trans_right_vn-60552810', 'tenant_id': '9a1310fa4395476291e7b00ef1dd0ca2', 'project_id': '9a1310fa4395476291e7b00ef1dd0ca2', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-23180742', 'ctest-trans_right_vn-60552810'], 'port_security_enabled': True, 'description': ''}}
2026-03-05 03:04:00,974 - DEBUG - Response for create_subnet : {'subnet': {'id': '51b429ec-7aca-4bf6-8478-87fcf71df7db', 'name': '', 'tenant_id': '9a1310fa4395476291e7b00ef1dd0ca2', 'network_id': '8a950edf-cb26-4e85-a5d0-a3783975447b', 'ip_version': 4, 'cidr': '217.88.68.64/26', 'allocation_pools': [{'start': '217.88.68.66', 'end': '217.88.68.126'}], 'gateway_ip': '217.88.68.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '217.88.68.66', 'tags': [], 'project_id': '9a1310fa4395476291e7b00ef1dd0ca2'}}
2026-03-05 03:04:00,996 - INFO - Created VN ctest-trans_right_vn-60552810
2026-03-05 03:04:01,008 - DEBUG - VN ctest-trans_right_vn-60552810 UUID is 8a950edf-cb26-4e85-a5d0-a3783975447b
2026-03-05 03:04:01,082 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:01,089 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:01,101 - DEBUG - Requesting: http://10.0.0.65:8082/project/9a1310fa-4395-4762-91e7-b00ef1dd0ca2
2026-03-05 03:04:01,192 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/8a950edf-cb26-4e85-a5d0-a3783975447b
2026-03-05 03:04:01,205 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/8a950edf-cb26-4e85-a5d0-a3783975447b
2026-03-05 03:04:01,218 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/764b7126-657b-4168-90c2-4a2f3bf7c945
2026-03-05 03:04:01,229 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/764b7126-657b-4168-90c2-4a2f3bf7c945
2026-03-05 03:04:01,237 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/dc7338c8-b79d-4753-b241-226fe2f7a044
2026-03-05 03:04:01,245 - DEBUG - Route Targets: ['target:64512:8000009']
2026-03-05 03:04:01,245 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/8a950edf-cb26-4e85-a5d0-a3783975447b
2026-03-05 03:04:01,254 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/764b7126-657b-4168-90c2-4a2f3bf7c945
2026-03-05 03:04:01,268 - INFO - Verified VN network id 20 for VN 8a950edf-cb26-4e85-a5d0-a3783975447b
2026-03-05 03:04:01,268 - INFO - Verifications in API Server for VN ctest-trans_right_vn-60552810 passed
2026-03-05 03:04:01,268 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/8a950edf-cb26-4e85-a5d0-a3783975447b
2026-03-05 03:04:01,278 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/764b7126-657b-4168-90c2-4a2f3bf7c945
2026-03-05 03:04:01,286 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/764b7126-657b-4168-90c2-4a2f3bf7c945
2026-03-05 03:04:01,293 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/dc7338c8-b79d-4753-b241-226fe2f7a044
2026-03-05 03:04:01,307 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23180742:ctest-trans_right_vn-60552810', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23180742', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9985904103112724101', 'uuid-lslong': '11948229548169315451'}, 'enable': 'true', 'created': '2026-03-05T03:04:00', 'last-modified': '2026-03-05T03:04:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.379963'}
2026-03-05 03:04:01,314 - DEBUG - Route Targets: ['target:64512:8000009']
2026-03-05 03:04:01,320 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23180742:ctest-trans_right_vn-60552810', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23180742', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9985904103112724101', 'uuid-lslong': '11948229548169315451'}, 'enable': 'true', 'created': '2026-03-05T03:04:00', 'last-modified': '2026-03-05T03:04:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.392881'}
2026-03-05 03:04:01,327 - DEBUG - Route Targets: ['target:64512:8000009']
2026-03-05 03:04:01,333 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23180742:ctest-trans_right_vn-60552810', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23180742', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9985904103112724101', 'uuid-lslong': '11948229548169315451'}, 'enable': 'true', 'created': '2026-03-05T03:04:00', 'last-modified': '2026-03-05T03:04:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.407974'}
2026-03-05 03:04:01,339 - DEBUG - Route Targets: ['target:64512:8000009']
2026-03-05 03:04:01,340 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-60552810 passed
2026-03-05 03:04:01,340 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-60552810 in API_Server ======
2026-03-05 03:04:01,340 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:01,347 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:01,365 - DEBUG - Requesting: http://10.0.0.65:8082/project/9a1310fa-4395-4762-91e7-b00ef1dd0ca2
2026-03-05 03:04:01,482 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/8a950edf-cb26-4e85-a5d0-a3783975447b
2026-03-05 03:04:01,494 - DEBUG - =>VN ctest-trans_right_vn-60552810 has no policy to be verified
2026-03-05 03:04:01,494 - DEBUG - Verifying the vn in opserver
2026-03-05 03:04:01,494 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23180742:ctest-trans_right_vn-60552810 virtual network link through opserver 10.0.0.65
2026-03-05 03:04:01,494 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-05 03:04:01,508 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23180742:ctest-trans_right_vn-60552810', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23180742:ctest-trans_right_vn-60552810?flat'}
2026-03-05 03:04:01,508 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23180742:ctest-trans_right_vn-60552810 virtual network link through opserver 10.0.0.33
2026-03-05 03:04:01,508 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-03-05 03:04:01,520 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23180742:ctest-trans_right_vn-60552810', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23180742:ctest-trans_right_vn-60552810?flat'}
2026-03-05 03:04:01,520 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23180742:ctest-trans_right_vn-60552810 virtual network link through opserver 10.0.0.133
2026-03-05 03:04:01,520 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-03-05 03:04:01,533 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23180742:ctest-trans_right_vn-60552810', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23180742:ctest-trans_right_vn-60552810?flat'}
2026-03-05 03:04:01,533 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-23180742:ctest-trans_right_vn-60552810 is found in opserver
2026-03-05 03:04:01,557 - DEBUG - Do not have enough data to verify VN in agent
2026-03-05 03:04:01,569 - DEBUG - VRF ids for VN ctest-trans_right_vn-60552810: {}
2026-03-05 03:04:02,946 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5433-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5433-2)
2026-03-05 03:04:04,339 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5433-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5433-1)
2026-03-05 03:04:04,339 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-57095893']
2026-03-05 03:04:04,624 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-57095893'] created succesfully
2026-03-05 03:04:04,966 - DEBUG - Image by name tiny_trans_fw not found
2026-03-05 03:04:04,966 - DEBUG - Installing image tiny_trans_fw
2026-03-05 03:04:04,966 - DEBUG - Image info {'name': 'tinycore-net-transparent-fw.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd'}
2026-03-05 03:04:04,966 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-03-05 03:04:04,966 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-03-05 03:04:04,984 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz -O /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-03-05 03:04:05,014 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-03-05 03:04:05,015 - DEBUG - Unzip image
2026-03-05 03:04:05,015 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-03-05 03:04:05,037 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-03-05 03:04:05,038 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-57095893']
2026-03-05 03:04:05,149 - INFO - Service template: ['default-domain', 'ctest-service_template_1-57095893'] deleted successfully.
2026-03-05 03:04:05,149 - INFO - Skip interface_detach for VM ctest-right_vm-13883033 in state BUILD
2026-03-05 03:04:05,149 - INFO - Deleting VM ctest-right_vm-13883033
2026-03-05 03:04:05,149 - ERROR - VM ctest-right_vm-13883033 has failed to come up
2026-03-05 03:04:05,149 - ERROR - Nova failed to get host of the VM
2026-03-05 03:04:05,149 - ERROR - VM ctest-right_vm-13883033 has failed to come up
2026-03-05 03:04:05,150 - ERROR - Nova failed to get host of the VM
2026-03-05 03:04:05,225 - INFO - Skip interface_detach for VM ctest-left_vm-57151308 in state BUILD
2026-03-05 03:04:05,225 - INFO - Deleting VM ctest-left_vm-57151308
2026-03-05 03:04:05,225 - ERROR - VM ctest-left_vm-57151308 has failed to come up
2026-03-05 03:04:05,225 - ERROR - Nova failed to get host of the VM
2026-03-05 03:04:05,226 - ERROR - VM ctest-left_vm-57151308 has failed to come up
2026-03-05 03:04:05,226 - ERROR - Nova failed to get host of the VM
2026-03-05 03:04:05,296 - INFO - Deleting VN ctest-trans_right_vn-60552810
2026-03-05 03:04:05,441 - DEBUG - Response for deleting network ()
2026-03-05 03:04:05,441 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/764b7126-657b-4168-90c2-4a2f3bf7c945
2026-03-05 03:04:05,454 - DEBUG - Response Code: 404
2026-03-05 03:04:05,455 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:05,466 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:05,492 - DEBUG - Requesting: http://10.0.0.65:8082/project/9a1310fa-4395-4762-91e7-b00ef1dd0ca2
2026-03-05 03:04:05,587 - INFO - Validated that VN ctest-trans_right_vn-60552810 is not found in API Server
2026-03-05 03:04:05,603 - DEBUG - VN ctest-trans_right_vn-60552810 is not present in Agent 10.0.0.141
2026-03-05 03:04:05,642 - DEBUG - VN ctest-trans_right_vn-60552810 is not present in Agent 10.0.0.73
2026-03-05 03:04:05,642 - INFO - Validated that VN ctest-trans_right_vn-60552810 is not in any agent
2026-03-05 03:04:05,677 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-60552810 info
2026-03-05 03:04:05,677 - INFO - Deleting VN ctest-trans_left_vn-40832349
2026-03-05 03:04:05,859 - DEBUG - Response for deleting network ()
2026-03-05 03:04:05,859 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/42e9ec50-4000-4194-81b6-668619bcaf29
2026-03-05 03:04:05,867 - DEBUG - Response Code: 404
2026-03-05 03:04:05,867 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:05,878 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:05,941 - DEBUG - Requesting: http://10.0.0.65:8082/project/9a1310fa-4395-4762-91e7-b00ef1dd0ca2
2026-03-05 03:04:06,026 - INFO - Validated that VN ctest-trans_left_vn-40832349 is not found in API Server
2026-03-05 03:04:06,046 - DEBUG - VN ctest-trans_left_vn-40832349 is not present in Agent 10.0.0.141
2026-03-05 03:04:06,055 - DEBUG - VN ctest-trans_left_vn-40832349 is not present in Agent 10.0.0.73
2026-03-05 03:04:06,055 - INFO - Validated that VN ctest-trans_left_vn-40832349 is not in any agent
2026-03-05 03:04:06,107 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-40832349 info
2026-03-05 03:04:06,107 - INFO - Deleting VN ctest-right_vn-79002301
2026-03-05 03:04:06,146 - DEBUG - VN 2c039159-0c5a-414e-ae36-df288392207b still in use: Unable to complete operation on network 2c039159-0c5a-414e-ae36-df288392207b. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-2ac731ff-76bd-4134-84d5-fc3ce7117007']
2026-03-05 03:04:06,146 - WARNING - Deleting VN ctest-right_vn-79002301 failed..Will retry
2026-03-05 03:04:08,288 - DEBUG - Response for deleting network ()
2026-03-05 03:04:08,288 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/d32ef962-58a8-4997-b547-945d33e50098
2026-03-05 03:04:08,294 - DEBUG - Response Code: 404
2026-03-05 03:04:08,294 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:08,308 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:08,362 - DEBUG - Requesting: http://10.0.0.65:8082/project/9a1310fa-4395-4762-91e7-b00ef1dd0ca2
2026-03-05 03:04:08,454 - INFO - Validated that VN ctest-right_vn-79002301 is not found in API Server
2026-03-05 03:04:08,464 - DEBUG - VN ctest-right_vn-79002301 is not present in Agent 10.0.0.141
2026-03-05 03:04:08,476 - DEBUG - VN ctest-right_vn-79002301 is not present in Agent 10.0.0.73
2026-03-05 03:04:08,476 - INFO - Validated that VN ctest-right_vn-79002301 is not in any agent
2026-03-05 03:04:08,514 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-79002301 info
2026-03-05 03:04:08,514 - INFO - Deleting VN ctest-left_vn-89360980
2026-03-05 03:04:08,658 - DEBUG - Response for deleting network ()
2026-03-05 03:04:08,658 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/7964b22f-c89d-4062-9594-8e063a1c006d
2026-03-05 03:04:08,664 - DEBUG - Response Code: 404
2026-03-05 03:04:08,664 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:08,670 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:08,693 - DEBUG - Requesting: http://10.0.0.65:8082/project/9a1310fa-4395-4762-91e7-b00ef1dd0ca2
2026-03-05 03:04:08,781 - INFO - Validated that VN ctest-left_vn-89360980 is not found in API Server
2026-03-05 03:04:08,793 - DEBUG - VN ctest-left_vn-89360980 is not present in Agent 10.0.0.141
2026-03-05 03:04:08,803 - DEBUG - VN ctest-left_vn-89360980 is not present in Agent 10.0.0.73
2026-03-05 03:04:08,803 - INFO - Validated that VN ctest-left_vn-89360980 is not in any agent
2026-03-05 03:04:08,836 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-89360980 info
2026-03-05 03:04:08,836 - INFO - Deleting VN ctest-mgmt_vn-78564881
2026-03-05 03:04:08,959 - DEBUG - Response for deleting network ()
2026-03-05 03:04:08,959 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/a5817249-c009-44ab-bdda-67cdb759358c
2026-03-05 03:04:08,967 - DEBUG - Response Code: 404
2026-03-05 03:04:08,967 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:08,976 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:08,995 - DEBUG - Requesting: http://10.0.0.65:8082/project/9a1310fa-4395-4762-91e7-b00ef1dd0ca2
2026-03-05 03:04:09,081 - INFO - Validated that VN ctest-mgmt_vn-78564881 is not found in API Server
2026-03-05 03:04:09,093 - DEBUG - VN ctest-mgmt_vn-78564881 is not present in Agent 10.0.0.141
2026-03-05 03:04:09,104 - DEBUG - VN ctest-mgmt_vn-78564881 is not present in Agent 10.0.0.73
2026-03-05 03:04:09,104 - INFO - Validated that VN ctest-mgmt_vn-78564881 is not in any agent
2026-03-05 03:04:09,137 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-78564881 info
2026-03-05 03:04:10,420 - DEBUG - No XMPP flaps were noticed during the test
2026-03-05 03:04:10,421 - INFO -
2026-03-05 03:04:10,421 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:15]
2026-03-05 03:04:10,421 - INFO - --------------------------------------------------------------------------------
2026-03-05 03:04:11,139 - INFO - Deleted project: ctest-TestSvcRegr-23180742, ID : 9a1310fa-4395-4762-91e7-b00ef1dd0ca2
2026-03-05 03:04:11,333 - INFO - Domain Default found not creating
2026-03-05 03:04:11,546 - INFO - Project ctest-TestSvcRegr-24806731 not found, creating it
2026-03-05 03:04:12,062 - INFO - Created Project:ctest-TestSvcRegr-24806731, ID : 8b0536d8-98a8-46fb-8f01-bb33b9a98100
2026-03-05 03:04:13,634 - INFO - ================================================================================
2026-03-05 03:04:13,635 - INFO - STARTING TEST : test_svc_CEM_22032
2026-03-05 03:04:14,922 - DEBUG - Nothing to compare xmpp stats {'10.0.0.141': {'10.20.0.254': '0', '10.20.0.14': '0'}, '10.0.0.73': {'10.20.0.14': '0', '10.20.0.254': '0'}} with
2026-03-05 03:04:14,922 - INFO - Initial checks done. Running the testcase now
2026-03-05 03:04:14,922 - INFO -
2026-03-05 03:04:15,594 - DEBUG - Response for create_network : {'network': {'id': '56610b34-d046-4220-a493-6c809cb6295b', 'name': 'ctest-mgmt_vn-21097673', 'tenant_id': '8b0536d898a846fb8f01bb33b9a98100', 'project_id': '8b0536d898a846fb8f01bb33b9a98100', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-24806731', 'ctest-mgmt_vn-21097673'], 'port_security_enabled': True, 'description': ''}}
2026-03-05 03:04:15,843 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f3e9bafd-f0d9-41b7-99f5-977ff05dcc21', 'name': '', 'tenant_id': '8b0536d898a846fb8f01bb33b9a98100', 'network_id': '56610b34-d046-4220-a493-6c809cb6295b', 'ip_version': 4, 'cidr': '44.150.24.64/26', 'allocation_pools': [{'start': '44.150.24.66', 'end': '44.150.24.126'}], 'gateway_ip': '44.150.24.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '44.150.24.66', 'tags': [], 'project_id': '8b0536d898a846fb8f01bb33b9a98100'}}
2026-03-05 03:04:15,864 - INFO - Created VN ctest-mgmt_vn-21097673
2026-03-05 03:04:15,875 - DEBUG - VN ctest-mgmt_vn-21097673 UUID is 56610b34-d046-4220-a493-6c809cb6295b
2026-03-05 03:04:15,948 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:16,264 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:16,297 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:16,314 - DEBUG - Requesting: http://10.0.0.65:8082/project/8b0536d8-98a8-46fb-8f01-bb33b9a98100
2026-03-05 03:04:16,404 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/56610b34-d046-4220-a493-6c809cb6295b
2026-03-05 03:04:16,421 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/56610b34-d046-4220-a493-6c809cb6295b
2026-03-05 03:04:16,433 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/6f99eb96-c8bc-4950-a55d-f08f8f42e0cc
2026-03-05 03:04:16,442 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/6f99eb96-c8bc-4950-a55d-f08f8f42e0cc
2026-03-05 03:04:16,449 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/e304b333-d43e-472a-8be0-67e04bbc1aa6
2026-03-05 03:04:16,456 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-05 03:04:16,456 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/56610b34-d046-4220-a493-6c809cb6295b
2026-03-05 03:04:16,465 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/6f99eb96-c8bc-4950-a55d-f08f8f42e0cc
2026-03-05 03:04:16,481 - INFO - Verified VN network id 16 for VN 56610b34-d046-4220-a493-6c809cb6295b
2026-03-05 03:04:16,481 - INFO - Verifications in API Server for VN ctest-mgmt_vn-21097673 passed
2026-03-05 03:04:16,481 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/56610b34-d046-4220-a493-6c809cb6295b
2026-03-05 03:04:16,490 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/6f99eb96-c8bc-4950-a55d-f08f8f42e0cc
2026-03-05 03:04:16,498 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/6f99eb96-c8bc-4950-a55d-f08f8f42e0cc
2026-03-05 03:04:16,518 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/e304b333-d43e-472a-8be0-67e04bbc1aa6
2026-03-05 03:04:16,529 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-21097673', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24806731', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6224268481463206432', 'uuid-lslong': '11858941543437445467'}, 'enable': 'true', 'created': '2026-03-05T03:04:15', 'last-modified': '2026-03-05T03:04:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.742587'}
2026-03-05 03:04:16,534 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-05 03:04:16,540 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-21097673', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24806731', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6224268481463206432', 'uuid-lslong': '11858941543437445467'}, 'enable': 'true', 'created': '2026-03-05T03:04:15', 'last-modified': '2026-03-05T03:04:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.754913'}
2026-03-05 03:04:16,546 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-05 03:04:16,552 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-21097673', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24806731', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6224268481463206432', 'uuid-lslong': '11858941543437445467'}, 'enable': 'true', 'created': '2026-03-05T03:04:15', 'last-modified': '2026-03-05T03:04:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.766791'}
2026-03-05 03:04:16,558 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-05 03:04:16,558 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-21097673 passed
2026-03-05 03:04:16,558 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-21097673 in API_Server ======
2026-03-05 03:04:16,559 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:16,565 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:16,578 - DEBUG - Requesting: http://10.0.0.65:8082/project/8b0536d8-98a8-46fb-8f01-bb33b9a98100
2026-03-05 03:04:16,664 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/56610b34-d046-4220-a493-6c809cb6295b
2026-03-05 03:04:16,673 - DEBUG - =>VN ctest-mgmt_vn-21097673 has no policy to be verified
2026-03-05 03:04:16,673 - DEBUG - Verifying the vn in opserver
2026-03-05 03:04:16,673 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-21097673 virtual network link through opserver 10.0.0.65
2026-03-05 03:04:16,673 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-05 03:04:16,968 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-05 03:04:17,027 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-21097673', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-21097673?flat'}
2026-03-05 03:04:17,027 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-21097673 virtual network link through opserver 10.0.0.33
2026-03-05 03:04:17,027 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-03-05 03:04:17,326 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-03-05 03:04:17,395 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-21097673', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-21097673?flat'}
2026-03-05 03:04:17,395 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-21097673 virtual network link through opserver 10.0.0.133
2026-03-05 03:04:17,395 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-03-05 03:04:17,706 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-03-05 03:04:17,774 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-21097673', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-21097673?flat'}
2026-03-05 03:04:17,774 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-21097673 is found in opserver
2026-03-05 03:04:17,795 - DEBUG - Do not have enough data to verify VN in agent
2026-03-05 03:04:17,805 - DEBUG - VRF ids for VN ctest-mgmt_vn-21097673: {}
2026-03-05 03:04:18,029 - DEBUG - Response for create_network : {'network': {'id': '17e65439-7c1a-49a6-9ca0-e57a49f1ec16', 'name': 'service-left-vn-39128215', 'tenant_id': '8b0536d898a846fb8f01bb33b9a98100', 'project_id': '8b0536d898a846fb8f01bb33b9a98100', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-24806731', 'service-left-vn-39128215'], 'port_security_enabled': True, 'description': ''}}
2026-03-05 03:04:18,272 - DEBUG - Response for create_subnet : {'subnet': {'id': '3562aa9d-afdd-4312-b944-7c73227e1f02', 'name': '', 'tenant_id': '8b0536d898a846fb8f01bb33b9a98100', 'network_id': '17e65439-7c1a-49a6-9ca0-e57a49f1ec16', 'ip_version': 4, 'cidr': '120.47.196.128/26', 'allocation_pools': [{'start': '120.47.196.130', 'end': '120.47.196.190'}], 'gateway_ip': '120.47.196.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '120.47.196.130', 'tags': [], 'project_id': '8b0536d898a846fb8f01bb33b9a98100'}}
2026-03-05 03:04:18,299 - INFO - Created VN service-left-vn-39128215
2026-03-05 03:04:18,309 - DEBUG - VN service-left-vn-39128215 UUID is 17e65439-7c1a-49a6-9ca0-e57a49f1ec16
2026-03-05 03:04:18,375 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:18,380 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:18,390 - DEBUG - Requesting: http://10.0.0.65:8082/project/8b0536d8-98a8-46fb-8f01-bb33b9a98100
2026-03-05 03:04:18,486 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/17e65439-7c1a-49a6-9ca0-e57a49f1ec16
2026-03-05 03:04:18,499 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/17e65439-7c1a-49a6-9ca0-e57a49f1ec16
2026-03-05 03:04:18,510 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f7982a6b-b63b-4e43-89af-90863944df22
2026-03-05 03:04:18,519 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f7982a6b-b63b-4e43-89af-90863944df22
2026-03-05 03:04:18,525 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/36752ca9-ec6d-4e21-84a2-22cc8a596fb0
2026-03-05 03:04:18,539 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-05 03:04:18,539 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/17e65439-7c1a-49a6-9ca0-e57a49f1ec16
2026-03-05 03:04:18,551 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f7982a6b-b63b-4e43-89af-90863944df22
2026-03-05 03:04:18,570 - INFO - Verified VN network id 17 for VN 17e65439-7c1a-49a6-9ca0-e57a49f1ec16
2026-03-05 03:04:18,570 - INFO - Verifications in API Server for VN service-left-vn-39128215 passed
2026-03-05 03:04:18,570 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/17e65439-7c1a-49a6-9ca0-e57a49f1ec16
2026-03-05 03:04:18,581 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f7982a6b-b63b-4e43-89af-90863944df22
2026-03-05 03:04:18,593 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f7982a6b-b63b-4e43-89af-90863944df22
2026-03-05 03:04:18,601 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/36752ca9-ec6d-4e21-84a2-22cc8a596fb0
2026-03-05 03:04:18,614 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24806731:service-left-vn-39128215', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24806731', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1722156513387760038', 'uuid-lslong': '11286272979579825174'}, 'enable': 'true', 'created': '2026-03-05T03:04:17', 'last-modified': '2026-03-05T03:04:18', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.386465'}
2026-03-05 03:04:18,621 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-05 03:04:18,628 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24806731:service-left-vn-39128215', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24806731', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1722156513387760038', 'uuid-lslong': '11286272979579825174'}, 'enable': 'true', 'created': '2026-03-05T03:04:17', 'last-modified': '2026-03-05T03:04:18', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.401556'}
2026-03-05 03:04:18,633 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-05 03:04:18,639 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24806731:service-left-vn-39128215', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24806731', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1722156513387760038', 'uuid-lslong': '11286272979579825174'}, 'enable': 'true', 'created': '2026-03-05T03:04:17', 'last-modified': '2026-03-05T03:04:18', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.421671'}
2026-03-05 03:04:18,645 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-05 03:04:18,645 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-39128215 passed
2026-03-05 03:04:18,645 - DEBUG - ====Verifying policy data for service-left-vn-39128215 in API_Server ======
2026-03-05 03:04:18,645 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:18,651 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:18,663 - DEBUG - Requesting: http://10.0.0.65:8082/project/8b0536d8-98a8-46fb-8f01-bb33b9a98100
2026-03-05 03:04:18,745 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/17e65439-7c1a-49a6-9ca0-e57a49f1ec16
2026-03-05 03:04:18,764 - DEBUG - =>VN service-left-vn-39128215 has no policy to be verified
2026-03-05 03:04:18,765 - DEBUG - Verifying the vn in opserver
2026-03-05 03:04:18,765 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24806731:service-left-vn-39128215 virtual network link through opserver 10.0.0.65
2026-03-05 03:04:18,765 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-05 03:04:18,824 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24806731:service-left-vn-39128215', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24806731:service-left-vn-39128215?flat'}
2026-03-05 03:04:18,825 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24806731:service-left-vn-39128215 virtual network link through opserver 10.0.0.33
2026-03-05 03:04:18,825 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-03-05 03:04:18,902 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24806731:service-left-vn-39128215', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24806731:service-left-vn-39128215?flat'}
2026-03-05 03:04:18,902 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24806731:service-left-vn-39128215 virtual network link through opserver 10.0.0.133
2026-03-05 03:04:18,902 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-03-05 03:04:18,965 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24806731:service-left-vn-39128215', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24806731:service-left-vn-39128215?flat'}
2026-03-05 03:04:18,965 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-24806731:service-left-vn-39128215 is found in opserver
2026-03-05 03:04:18,998 - DEBUG - Do not have enough data to verify VN in agent
2026-03-05 03:04:19,012 - DEBUG - VRF ids for VN service-left-vn-39128215: {}
2026-03-05 03:04:19,257 - DEBUG - Response for create_network : {'network': {'id': 'ba463ad1-84d7-42b4-9734-14590d434652', 'name': 'service-right-vn-08326059', 'tenant_id': '8b0536d898a846fb8f01bb33b9a98100', 'project_id': '8b0536d898a846fb8f01bb33b9a98100', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-24806731', 'service-right-vn-08326059'], 'port_security_enabled': True, 'description': ''}}
2026-03-05 03:04:19,510 - DEBUG - Response for create_subnet : {'subnet': {'id': '5f2fc2ec-cc7c-4d0a-97d1-8ab61c5a29e1', 'name': '', 'tenant_id': '8b0536d898a846fb8f01bb33b9a98100', 'network_id': 'ba463ad1-84d7-42b4-9734-14590d434652', 'ip_version': 4, 'cidr': '184.163.146.128/26', 'allocation_pools': [{'start': '184.163.146.130', 'end': '184.163.146.190'}], 'gateway_ip': '184.163.146.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '184.163.146.130', 'tags': [], 'project_id': '8b0536d898a846fb8f01bb33b9a98100'}}
2026-03-05 03:04:19,541 - INFO - Created VN service-right-vn-08326059
2026-03-05 03:04:19,554 - DEBUG - VN service-right-vn-08326059 UUID is ba463ad1-84d7-42b4-9734-14590d434652
2026-03-05 03:04:19,625 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:19,632 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:19,643 - DEBUG - Requesting: http://10.0.0.65:8082/project/8b0536d8-98a8-46fb-8f01-bb33b9a98100
2026-03-05 03:04:19,732 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/ba463ad1-84d7-42b4-9734-14590d434652
2026-03-05 03:04:19,749 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/ba463ad1-84d7-42b4-9734-14590d434652
2026-03-05 03:04:19,760 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f6736cbd-3c63-47ae-a121-093cd555bf55
2026-03-05 03:04:19,769 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f6736cbd-3c63-47ae-a121-093cd555bf55
2026-03-05 03:04:19,777 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/9d6af824-a100-42d9-b697-55e5d92a34f7
2026-03-05 03:04:19,784 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-05 03:04:19,784 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/ba463ad1-84d7-42b4-9734-14590d434652
2026-03-05 03:04:19,796 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f6736cbd-3c63-47ae-a121-093cd555bf55
2026-03-05 03:04:19,813 - INFO - Verified VN network id 18 for VN ba463ad1-84d7-42b4-9734-14590d434652
2026-03-05 03:04:19,813 - INFO - Verifications in API Server for VN service-right-vn-08326059 passed
2026-03-05 03:04:19,813 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/ba463ad1-84d7-42b4-9734-14590d434652
2026-03-05 03:04:19,823 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f6736cbd-3c63-47ae-a121-093cd555bf55
2026-03-05 03:04:19,831 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f6736cbd-3c63-47ae-a121-093cd555bf55
2026-03-05 03:04:19,842 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/9d6af824-a100-42d9-b697-55e5d92a34f7
2026-03-05 03:04:19,856 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24806731:service-right-vn-08326059', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24806731', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13422480410975617716', 'uuid-lslong': '10895355771223230034'}, 'enable': 'true', 'created': '2026-03-05T03:04:19', 'last-modified': '2026-03-05T03:04:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.398486'}
2026-03-05 03:04:19,864 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-05 03:04:19,870 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24806731:service-right-vn-08326059', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24806731', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13422480410975617716', 'uuid-lslong': '10895355771223230034'}, 'enable': 'true', 'created': '2026-03-05T03:04:19', 'last-modified': '2026-03-05T03:04:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.410786'}
2026-03-05 03:04:19,878 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-05 03:04:19,884 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24806731:service-right-vn-08326059', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24806731', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13422480410975617716', 'uuid-lslong': '10895355771223230034'}, 'enable': 'true', 'created': '2026-03-05T03:04:19', 'last-modified': '2026-03-05T03:04:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.422245'}
2026-03-05 03:04:19,891 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-05 03:04:19,891 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-08326059 passed
2026-03-05 03:04:19,891 - DEBUG - ====Verifying policy data for service-right-vn-08326059 in API_Server ======
2026-03-05 03:04:19,891 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:19,899 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:19,913 - DEBUG - Requesting: http://10.0.0.65:8082/project/8b0536d8-98a8-46fb-8f01-bb33b9a98100
2026-03-05 03:04:20,006 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/ba463ad1-84d7-42b4-9734-14590d434652
2026-03-05 03:04:20,018 - DEBUG - =>VN service-right-vn-08326059 has no policy to be verified
2026-03-05 03:04:20,018 - DEBUG - Verifying the vn in opserver
2026-03-05 03:04:20,018 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24806731:service-right-vn-08326059 virtual network link through opserver 10.0.0.65
2026-03-05 03:04:20,018 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-05 03:04:20,084 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24806731:service-right-vn-08326059', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24806731:service-right-vn-08326059?flat'}
2026-03-05 03:04:20,084 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24806731:service-right-vn-08326059 virtual network link through opserver 10.0.0.33
2026-03-05 03:04:20,084 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-03-05 03:04:20,152 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24806731:service-right-vn-08326059', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24806731:service-right-vn-08326059?flat'}
2026-03-05 03:04:20,152 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24806731:service-right-vn-08326059 virtual network link through opserver 10.0.0.133
2026-03-05 03:04:20,152 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-03-05 03:04:20,220 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24806731:service-right-vn-08326059', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24806731:service-right-vn-08326059?flat'}
2026-03-05 03:04:20,220 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-24806731:service-right-vn-08326059 is found in opserver
2026-03-05 03:04:20,244 - DEBUG - Do not have enough data to verify VN in agent
2026-03-05 03:04:20,255 - DEBUG - VRF ids for VN service-right-vn-08326059: {}
2026-03-05 03:04:20,315 - DEBUG - Services list from nova: [, , , ]
2026-03-05 03:04:21,414 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5433-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5433-2)
2026-03-05 03:04:23,018 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5433-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5433-1)
2026-03-05 03:04:23,019 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-87519084']
2026-03-05 03:04:23,312 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-87519084'] created succesfully
2026-03-05 03:04:23,750 - DEBUG - Image by name tiny_nat_fw not found
2026-03-05 03:04:23,750 - DEBUG - Installing image tiny_nat_fw
2026-03-05 03:04:23,750 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-03-05 03:04:23,750 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-05 03:04:23,750 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-05 03:04:23,750 - DEBUG - Unzip image
2026-03-05 03:04:23,750 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-05 03:04:23,822 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-03-05 03:04:23,823 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-87519084']
2026-03-05 03:04:23,921 - INFO - Service template: ['default-domain', 'ctest-service_template_1-87519084'] deleted successfully.
2026-03-05 03:04:23,921 - INFO - Skip interface_detach for VM ctest-right_vm-23740054 in state BUILD
2026-03-05 03:04:23,922 - INFO - Deleting VM ctest-right_vm-23740054
2026-03-05 03:04:23,958 - ERROR - VM ctest-right_vm-23740054 has failed to come up
2026-03-05 03:04:23,958 - ERROR - Nova failed to get host of the VM
2026-03-05 03:04:23,958 - ERROR - VM ctest-right_vm-23740054 has failed to come up
2026-03-05 03:04:23,958 - ERROR - Nova failed to get host of the VM
2026-03-05 03:04:24,034 - INFO - Skip interface_detach for VM ctest-left_vm-22030829 in state BUILD
2026-03-05 03:04:24,034 - INFO - Deleting VM ctest-left_vm-22030829
2026-03-05 03:04:24,034 - ERROR - VM ctest-left_vm-22030829 has failed to come up
2026-03-05 03:04:24,034 - ERROR - Nova failed to get host of the VM
2026-03-05 03:04:24,034 - ERROR - VM ctest-left_vm-22030829 has failed to come up
2026-03-05 03:04:24,034 - ERROR - Nova failed to get host of the VM
2026-03-05 03:04:24,135 - INFO - Deleting VN service-right-vn-08326059
2026-03-05 03:04:24,172 - DEBUG - VN ba463ad1-84d7-42b4-9734-14590d434652 still in use: Unable to complete operation on network ba463ad1-84d7-42b4-9734-14590d434652. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-a5af3751-9060-48ff-ba6e-388244492ffe']
2026-03-05 03:04:24,172 - WARNING - Deleting VN service-right-vn-08326059 failed..Will retry
2026-03-05 03:04:26,305 - DEBUG - Response for deleting network ()
2026-03-05 03:04:26,305 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f6736cbd-3c63-47ae-a121-093cd555bf55
2026-03-05 03:04:26,314 - DEBUG - Response Code: 404
2026-03-05 03:04:26,315 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:26,321 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:26,356 - DEBUG - Requesting: http://10.0.0.65:8082/project/8b0536d8-98a8-46fb-8f01-bb33b9a98100
2026-03-05 03:04:26,454 - INFO - Validated that VN service-right-vn-08326059 is not found in API Server
2026-03-05 03:04:26,468 - DEBUG - VN service-right-vn-08326059 is not present in Agent 10.0.0.141
2026-03-05 03:04:26,483 - DEBUG - VN service-right-vn-08326059 is not present in Agent 10.0.0.73
2026-03-05 03:04:26,483 - INFO - Validated that VN service-right-vn-08326059 is not in any agent
2026-03-05 03:04:26,517 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-08326059 info
2026-03-05 03:04:26,517 - INFO - Deleting VN service-left-vn-39128215
2026-03-05 03:04:26,676 - DEBUG - Response for deleting network ()
2026-03-05 03:04:26,677 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f7982a6b-b63b-4e43-89af-90863944df22
2026-03-05 03:04:26,684 - DEBUG - Response Code: 404
2026-03-05 03:04:26,684 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:26,691 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:26,704 - DEBUG - Requesting: http://10.0.0.65:8082/project/8b0536d8-98a8-46fb-8f01-bb33b9a98100
2026-03-05 03:04:26,794 - INFO - Validated that VN service-left-vn-39128215 is not found in API Server
2026-03-05 03:04:26,811 - DEBUG - VN service-left-vn-39128215 is not present in Agent 10.0.0.141
2026-03-05 03:04:26,822 - DEBUG - VN service-left-vn-39128215 is not present in Agent 10.0.0.73
2026-03-05 03:04:26,822 - INFO - Validated that VN service-left-vn-39128215 is not in any agent
2026-03-05 03:04:26,854 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-39128215 info
2026-03-05 03:04:26,854 - INFO - Deleting VN ctest-mgmt_vn-21097673
2026-03-05 03:04:26,987 - DEBUG - Response for deleting network ()
2026-03-05 03:04:26,987 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/6f99eb96-c8bc-4950-a55d-f08f8f42e0cc
2026-03-05 03:04:26,992 - DEBUG - Response Code: 404
2026-03-05 03:04:26,992 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:26,998 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:27,051 - DEBUG - Requesting: http://10.0.0.65:8082/project/8b0536d8-98a8-46fb-8f01-bb33b9a98100
2026-03-05 03:04:27,131 - INFO - Validated that VN ctest-mgmt_vn-21097673 is not found in API Server
2026-03-05 03:04:27,144 - DEBUG - VN ctest-mgmt_vn-21097673 is not present in Agent 10.0.0.141
2026-03-05 03:04:27,153 - DEBUG - VN ctest-mgmt_vn-21097673 is not present in Agent 10.0.0.73
2026-03-05 03:04:27,154 - INFO - Validated that VN ctest-mgmt_vn-21097673 is not in any agent
2026-03-05 03:04:27,187 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-21097673 info
2026-03-05 03:04:28,456 - DEBUG - No XMPP flaps were noticed during the test
2026-03-05 03:04:28,456 - INFO -
2026-03-05 03:04:28,456 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:15]
2026-03-05 03:04:28,456 - INFO - --------------------------------------------------------------------------------
2026-03-05 03:04:28,459 - INFO - ================================================================================
2026-03-05 03:04:28,459 - INFO - STARTING TEST : test_svc_in_network_datapath
2026-03-05 03:04:29,773 - DEBUG - Nothing to compare xmpp stats {'10.0.0.141': {'10.20.0.254': '0', '10.20.0.14': '0'}, '10.0.0.73': {'10.20.0.14': '0', '10.20.0.254': '0'}} with
2026-03-05 03:04:29,773 - INFO - Initial checks done. Running the testcase now
2026-03-05 03:04:29,773 - INFO -
2026-03-05 03:04:30,021 - DEBUG - Response for create_network : {'network': {'id': 'e9914078-0f2f-4403-9e1a-64b4d6841bba', 'name': 'ctest-mgmt_vn-82233193', 'tenant_id': '8b0536d898a846fb8f01bb33b9a98100', 'project_id': '8b0536d898a846fb8f01bb33b9a98100', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-24806731', 'ctest-mgmt_vn-82233193'], 'port_security_enabled': True, 'description': ''}}
2026-03-05 03:04:30,212 - DEBUG - Response for create_subnet : {'subnet': {'id': '0c2628ee-ca14-47f1-8062-c44510f821b4', 'name': '', 'tenant_id': '8b0536d898a846fb8f01bb33b9a98100', 'network_id': 'e9914078-0f2f-4403-9e1a-64b4d6841bba', 'ip_version': 4, 'cidr': '148.231.119.192/26', 'allocation_pools': [{'start': '148.231.119.194', 'end': '148.231.119.254'}], 'gateway_ip': '148.231.119.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '148.231.119.194', 'tags': [], 'project_id': '8b0536d898a846fb8f01bb33b9a98100'}}
2026-03-05 03:04:30,234 - INFO - Created VN ctest-mgmt_vn-82233193
2026-03-05 03:04:30,246 - DEBUG - VN ctest-mgmt_vn-82233193 UUID is e9914078-0f2f-4403-9e1a-64b4d6841bba
2026-03-05 03:04:30,313 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:30,319 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:30,332 - DEBUG - Requesting: http://10.0.0.65:8082/project/8b0536d8-98a8-46fb-8f01-bb33b9a98100
2026-03-05 03:04:30,418 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/e9914078-0f2f-4403-9e1a-64b4d6841bba
2026-03-05 03:04:30,429 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/e9914078-0f2f-4403-9e1a-64b4d6841bba
2026-03-05 03:04:30,438 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/5ec862e4-fb71-4831-9810-a5b4ff7333a0
2026-03-05 03:04:30,445 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/5ec862e4-fb71-4831-9810-a5b4ff7333a0
2026-03-05 03:04:30,452 - DEBUG - Route Targets: []
2026-03-05 03:04:30,452 - DEBUG - RT names not yet present for VN ctest-mgmt_vn-82233193
2026-03-05 03:04:35,453 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:35,541 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:35,552 - DEBUG - Requesting: http://10.0.0.65:8082/project/8b0536d8-98a8-46fb-8f01-bb33b9a98100
2026-03-05 03:04:35,641 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/e9914078-0f2f-4403-9e1a-64b4d6841bba
2026-03-05 03:04:35,650 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/e9914078-0f2f-4403-9e1a-64b4d6841bba
2026-03-05 03:04:35,659 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/5ec862e4-fb71-4831-9810-a5b4ff7333a0
2026-03-05 03:04:35,669 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/5ec862e4-fb71-4831-9810-a5b4ff7333a0
2026-03-05 03:04:35,675 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/4e22357a-264b-46a8-a535-d56ddbf82682
2026-03-05 03:04:35,681 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-05 03:04:35,681 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/e9914078-0f2f-4403-9e1a-64b4d6841bba
2026-03-05 03:04:35,690 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/5ec862e4-fb71-4831-9810-a5b4ff7333a0
2026-03-05 03:04:35,705 - INFO - Verified VN network id 16 for VN e9914078-0f2f-4403-9e1a-64b4d6841bba
2026-03-05 03:04:35,705 - INFO - Verifications in API Server for VN ctest-mgmt_vn-82233193 passed
2026-03-05 03:04:35,705 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/e9914078-0f2f-4403-9e1a-64b4d6841bba
2026-03-05 03:04:35,714 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/5ec862e4-fb71-4831-9810-a5b4ff7333a0
2026-03-05 03:04:35,721 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/5ec862e4-fb71-4831-9810-a5b4ff7333a0
2026-03-05 03:04:35,729 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/4e22357a-264b-46a8-a535-d56ddbf82682
2026-03-05 03:04:35,748 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-82233193', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24806731', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16830304166855263235', 'uuid-lslong': '11392528935242963898'}, 'enable': 'true', 'created': '2026-03-05T03:04:29', 'last-modified': '2026-03-05T03:04:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.591128'}
2026-03-05 03:04:35,754 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-05 03:04:35,759 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-82233193', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24806731', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16830304166855263235', 'uuid-lslong': '11392528935242963898'}, 'enable': 'true', 'created': '2026-03-05T03:04:29', 'last-modified': '2026-03-05T03:04:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.602009'}
2026-03-05 03:04:35,765 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-05 03:04:35,770 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-82233193', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24806731', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16830304166855263235', 'uuid-lslong': '11392528935242963898'}, 'enable': 'true', 'created': '2026-03-05T03:04:29', 'last-modified': '2026-03-05T03:04:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.610575'}
2026-03-05 03:04:35,776 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-05 03:04:35,776 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-82233193 passed
2026-03-05 03:04:35,777 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-82233193 in API_Server ======
2026-03-05 03:04:35,777 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:35,783 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:35,799 - DEBUG - Requesting: http://10.0.0.65:8082/project/8b0536d8-98a8-46fb-8f01-bb33b9a98100
2026-03-05 03:04:35,888 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/e9914078-0f2f-4403-9e1a-64b4d6841bba
2026-03-05 03:04:35,898 - DEBUG - =>VN ctest-mgmt_vn-82233193 has no policy to be verified
2026-03-05 03:04:35,898 - DEBUG - Verifying the vn in opserver
2026-03-05 03:04:35,898 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-82233193 virtual network link through opserver 10.0.0.65
2026-03-05 03:04:35,898 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-05 03:04:35,910 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-82233193', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-82233193?flat'}
2026-03-05 03:04:35,910 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-82233193 virtual network link through opserver 10.0.0.33
2026-03-05 03:04:35,910 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-03-05 03:04:35,921 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-82233193', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-82233193?flat'}
2026-03-05 03:04:35,921 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-82233193 virtual network link through opserver 10.0.0.133
2026-03-05 03:04:35,921 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-03-05 03:04:35,932 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-82233193', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-82233193?flat'}
2026-03-05 03:04:35,932 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-24806731:ctest-mgmt_vn-82233193 is found in opserver
2026-03-05 03:04:35,954 - DEBUG - Do not have enough data to verify VN in agent
2026-03-05 03:04:35,964 - DEBUG - VRF ids for VN ctest-mgmt_vn-82233193: {}
2026-03-05 03:04:36,206 - DEBUG - Response for create_network : {'network': {'id': '439de500-9e3f-4238-bed3-7a3ae5b0b6e6', 'name': 'ctest-left_vn-26017685', 'tenant_id': '8b0536d898a846fb8f01bb33b9a98100', 'project_id': '8b0536d898a846fb8f01bb33b9a98100', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-24806731', 'ctest-left_vn-26017685'], 'port_security_enabled': True, 'description': ''}}
2026-03-05 03:04:36,435 - DEBUG - Response for create_subnet : {'subnet': {'id': '4e11af84-23d3-4f16-bddf-5ed55a250ef4', 'name': '', 'tenant_id': '8b0536d898a846fb8f01bb33b9a98100', 'network_id': '439de500-9e3f-4238-bed3-7a3ae5b0b6e6', 'ip_version': 4, 'cidr': '162.30.66.192/26', 'allocation_pools': [{'start': '162.30.66.194', 'end': '162.30.66.254'}], 'gateway_ip': '162.30.66.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '162.30.66.194', 'tags': [], 'project_id': '8b0536d898a846fb8f01bb33b9a98100'}}
2026-03-05 03:04:36,455 - INFO - Created VN ctest-left_vn-26017685
2026-03-05 03:04:36,465 - DEBUG - VN ctest-left_vn-26017685 UUID is 439de500-9e3f-4238-bed3-7a3ae5b0b6e6
2026-03-05 03:04:36,547 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:36,555 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:36,568 - DEBUG - Requesting: http://10.0.0.65:8082/project/8b0536d8-98a8-46fb-8f01-bb33b9a98100
2026-03-05 03:04:36,664 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/439de500-9e3f-4238-bed3-7a3ae5b0b6e6
2026-03-05 03:04:36,678 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/439de500-9e3f-4238-bed3-7a3ae5b0b6e6
2026-03-05 03:04:36,688 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/e029560a-e6d5-42f7-ad53-5a23e1bc8057
2026-03-05 03:04:36,700 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/e029560a-e6d5-42f7-ad53-5a23e1bc8057
2026-03-05 03:04:36,709 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/d4d99376-56d1-42a8-8165-e8000debfc3c
2026-03-05 03:04:36,717 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-05 03:04:36,717 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/439de500-9e3f-4238-bed3-7a3ae5b0b6e6
2026-03-05 03:04:36,727 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/e029560a-e6d5-42f7-ad53-5a23e1bc8057
2026-03-05 03:04:36,742 - INFO - Verified VN network id 17 for VN 439de500-9e3f-4238-bed3-7a3ae5b0b6e6
2026-03-05 03:04:36,742 - INFO - Verifications in API Server for VN ctest-left_vn-26017685 passed
2026-03-05 03:04:36,742 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/439de500-9e3f-4238-bed3-7a3ae5b0b6e6
2026-03-05 03:04:36,752 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/e029560a-e6d5-42f7-ad53-5a23e1bc8057
2026-03-05 03:04:36,759 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/e029560a-e6d5-42f7-ad53-5a23e1bc8057
2026-03-05 03:04:36,766 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/d4d99376-56d1-42a8-8165-e8000debfc3c
2026-03-05 03:04:36,776 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24806731:ctest-left_vn-26017685', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24806731', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4872302162702451256', 'uuid-lslong': '13750468480672511718'}, 'enable': 'true', 'created': '2026-03-05T03:04:36', 'last-modified': '2026-03-05T03:04:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.380342'}
2026-03-05 03:04:36,781 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-05 03:04:36,786 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24806731:ctest-left_vn-26017685', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24806731', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4872302162702451256', 'uuid-lslong': '13750468480672511718'}, 'enable': 'true', 'created': '2026-03-05T03:04:36', 'last-modified': '2026-03-05T03:04:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.390966'}
2026-03-05 03:04:36,792 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-05 03:04:36,798 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24806731:ctest-left_vn-26017685', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24806731', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4872302162702451256', 'uuid-lslong': '13750468480672511718'}, 'enable': 'true', 'created': '2026-03-05T03:04:36', 'last-modified': '2026-03-05T03:04:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.401404'}
2026-03-05 03:04:36,805 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-05 03:04:36,805 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-26017685 passed
2026-03-05 03:04:36,805 - DEBUG - ====Verifying policy data for ctest-left_vn-26017685 in API_Server ======
2026-03-05 03:04:36,805 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:36,812 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:36,825 - DEBUG - Requesting: http://10.0.0.65:8082/project/8b0536d8-98a8-46fb-8f01-bb33b9a98100
2026-03-05 03:04:36,908 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/439de500-9e3f-4238-bed3-7a3ae5b0b6e6
2026-03-05 03:04:36,922 - DEBUG - =>VN ctest-left_vn-26017685 has no policy to be verified
2026-03-05 03:04:36,922 - DEBUG - Verifying the vn in opserver
2026-03-05 03:04:36,922 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24806731:ctest-left_vn-26017685 virtual network link through opserver 10.0.0.65
2026-03-05 03:04:36,922 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-05 03:04:36,933 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24806731:ctest-left_vn-26017685', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24806731:ctest-left_vn-26017685?flat'}
2026-03-05 03:04:36,933 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24806731:ctest-left_vn-26017685 virtual network link through opserver 10.0.0.33
2026-03-05 03:04:36,933 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-03-05 03:04:36,945 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24806731:ctest-left_vn-26017685', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24806731:ctest-left_vn-26017685?flat'}
2026-03-05 03:04:36,945 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24806731:ctest-left_vn-26017685 virtual network link through opserver 10.0.0.133
2026-03-05 03:04:36,945 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-03-05 03:04:36,958 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24806731:ctest-left_vn-26017685', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24806731:ctest-left_vn-26017685?flat'}
2026-03-05 03:04:36,958 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-24806731:ctest-left_vn-26017685 is found in opserver
2026-03-05 03:04:36,980 - DEBUG - Do not have enough data to verify VN in agent
2026-03-05 03:04:36,989 - DEBUG - VRF ids for VN ctest-left_vn-26017685: {}
2026-03-05 03:04:37,241 - DEBUG - Response for create_network : {'network': {'id': '827889bd-3269-4ca7-bcca-33c286060a72', 'name': 'ctest-right_vn-21243468', 'tenant_id': '8b0536d898a846fb8f01bb33b9a98100', 'project_id': '8b0536d898a846fb8f01bb33b9a98100', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-24806731', 'ctest-right_vn-21243468'], 'port_security_enabled': True, 'description': ''}}
2026-03-05 03:04:37,427 - DEBUG - Response for create_subnet : {'subnet': {'id': 'bc0da68a-fde3-4d1b-9449-2a652f1f725b', 'name': '', 'tenant_id': '8b0536d898a846fb8f01bb33b9a98100', 'network_id': '827889bd-3269-4ca7-bcca-33c286060a72', 'ip_version': 4, 'cidr': '104.52.253.0/26', 'allocation_pools': [{'start': '104.52.253.2', 'end': '104.52.253.62'}], 'gateway_ip': '104.52.253.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '104.52.253.2', 'tags': [], 'project_id': '8b0536d898a846fb8f01bb33b9a98100'}}
2026-03-05 03:04:37,455 - INFO - Created VN ctest-right_vn-21243468
2026-03-05 03:04:37,468 - DEBUG - VN ctest-right_vn-21243468 UUID is 827889bd-3269-4ca7-bcca-33c286060a72
2026-03-05 03:04:37,546 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:37,553 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:37,568 - DEBUG - Requesting: http://10.0.0.65:8082/project/8b0536d8-98a8-46fb-8f01-bb33b9a98100
2026-03-05 03:04:37,656 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/827889bd-3269-4ca7-bcca-33c286060a72
2026-03-05 03:04:37,666 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/827889bd-3269-4ca7-bcca-33c286060a72
2026-03-05 03:04:37,675 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/a655884e-051d-48e1-a8a0-92757c7c55e3
2026-03-05 03:04:37,683 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/a655884e-051d-48e1-a8a0-92757c7c55e3
2026-03-05 03:04:37,689 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/94b1db9b-8ebe-4e71-802a-75f36742901b
2026-03-05 03:04:37,695 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-05 03:04:37,695 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/827889bd-3269-4ca7-bcca-33c286060a72
2026-03-05 03:04:37,705 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/a655884e-051d-48e1-a8a0-92757c7c55e3
2026-03-05 03:04:37,720 - INFO - Verified VN network id 18 for VN 827889bd-3269-4ca7-bcca-33c286060a72
2026-03-05 03:04:37,721 - INFO - Verifications in API Server for VN ctest-right_vn-21243468 passed
2026-03-05 03:04:37,721 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/827889bd-3269-4ca7-bcca-33c286060a72
2026-03-05 03:04:37,730 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/a655884e-051d-48e1-a8a0-92757c7c55e3
2026-03-05 03:04:37,737 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/a655884e-051d-48e1-a8a0-92757c7c55e3
2026-03-05 03:04:37,746 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/94b1db9b-8ebe-4e71-802a-75f36742901b
2026-03-05 03:04:37,760 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24806731:ctest-right_vn-21243468', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24806731', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9401415667823496359', 'uuid-lslong': '13603742534991219314'}, 'enable': 'true', 'created': '2026-03-05T03:04:37', 'last-modified': '2026-03-05T03:04:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.388313'}
2026-03-05 03:04:37,768 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-05 03:04:37,775 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24806731:ctest-right_vn-21243468', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24806731', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9401415667823496359', 'uuid-lslong': '13603742534991219314'}, 'enable': 'true', 'created': '2026-03-05T03:04:37', 'last-modified': '2026-03-05T03:04:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.404346'}
2026-03-05 03:04:37,783 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-05 03:04:37,789 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24806731:ctest-right_vn-21243468', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24806731', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9401415667823496359', 'uuid-lslong': '13603742534991219314'}, 'enable': 'true', 'created': '2026-03-05T03:04:37', 'last-modified': '2026-03-05T03:04:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.417762'}
2026-03-05 03:04:37,794 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-05 03:04:37,794 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-21243468 passed
2026-03-05 03:04:37,794 - DEBUG - ====Verifying policy data for ctest-right_vn-21243468 in API_Server ======
2026-03-05 03:04:37,794 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:37,801 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:37,817 - DEBUG - Requesting: http://10.0.0.65:8082/project/8b0536d8-98a8-46fb-8f01-bb33b9a98100
2026-03-05 03:04:37,911 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/827889bd-3269-4ca7-bcca-33c286060a72
2026-03-05 03:04:37,922 - DEBUG - =>VN ctest-right_vn-21243468 has no policy to be verified
2026-03-05 03:04:37,922 - DEBUG - Verifying the vn in opserver
2026-03-05 03:04:37,922 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24806731:ctest-right_vn-21243468 virtual network link through opserver 10.0.0.65
2026-03-05 03:04:37,922 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-03-05 03:04:37,934 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24806731:ctest-right_vn-21243468', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24806731:ctest-right_vn-21243468?flat'}
2026-03-05 03:04:37,934 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24806731:ctest-right_vn-21243468 virtual network link through opserver 10.0.0.33
2026-03-05 03:04:37,934 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-03-05 03:04:37,946 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24806731:ctest-right_vn-21243468', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24806731:ctest-right_vn-21243468?flat'}
2026-03-05 03:04:37,946 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24806731:ctest-right_vn-21243468 virtual network link through opserver 10.0.0.133
2026-03-05 03:04:37,946 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-03-05 03:04:37,957 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24806731:ctest-right_vn-21243468', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24806731:ctest-right_vn-21243468?flat'}
2026-03-05 03:04:37,957 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-24806731:ctest-right_vn-21243468 is found in opserver
2026-03-05 03:04:37,978 - DEBUG - Do not have enough data to verify VN in agent
2026-03-05 03:04:37,988 - DEBUG - VRF ids for VN ctest-right_vn-21243468: {}
2026-03-05 03:04:39,152 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5433-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5433-1)
2026-03-05 03:04:40,475 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5433-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5433-2)
2026-03-05 03:04:40,475 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-03116126']
2026-03-05 03:04:40,779 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-03116126'] created succesfully
2026-03-05 03:04:41,133 - DEBUG - Image by name tiny_nat_fw not found
2026-03-05 03:04:41,133 - DEBUG - Installing image tiny_nat_fw
2026-03-05 03:04:41,133 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-03-05 03:04:41,134 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-05 03:04:41,134 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-05 03:04:41,134 - DEBUG - Unzip image
2026-03-05 03:04:41,134 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-05 03:04:41,168 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-03-05 03:04:41,168 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-03116126']
2026-03-05 03:04:41,261 - INFO - Service template: ['default-domain', 'ctest-service_template_1-03116126'] deleted successfully.
2026-03-05 03:04:41,261 - INFO - Skip interface_detach for VM ctest-right_vm-86119767 in state BUILD
2026-03-05 03:04:41,261 - INFO - Deleting VM ctest-right_vm-86119767
2026-03-05 03:04:41,262 - ERROR - VM ctest-right_vm-86119767 has failed to come up
2026-03-05 03:04:41,262 - ERROR - Nova failed to get host of the VM
2026-03-05 03:04:41,262 - ERROR - VM ctest-right_vm-86119767 has failed to come up
2026-03-05 03:04:41,262 - ERROR - Nova failed to get host of the VM
2026-03-05 03:04:41,422 - INFO - Skip interface_detach for VM ctest-left_vm-42856419 in state BUILD
2026-03-05 03:04:41,422 - INFO - Deleting VM ctest-left_vm-42856419
2026-03-05 03:04:41,422 - ERROR - VM ctest-left_vm-42856419 has failed to come up
2026-03-05 03:04:41,422 - ERROR - Nova failed to get host of the VM
2026-03-05 03:04:41,422 - ERROR - VM ctest-left_vm-42856419 has failed to come up
2026-03-05 03:04:41,422 - ERROR - Nova failed to get host of the VM
2026-03-05 03:04:41,497 - INFO - Deleting VN ctest-right_vn-21243468
2026-03-05 03:04:41,548 - DEBUG - VN 827889bd-3269-4ca7-bcca-33c286060a72 still in use: Unable to complete operation on network 827889bd-3269-4ca7-bcca-33c286060a72. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-6049fa19-4a0d-42f3-a6d8-157ce5c030a2']
2026-03-05 03:04:41,549 - WARNING - Deleting VN ctest-right_vn-21243468 failed..Will retry
2026-03-05 03:04:43,731 - DEBUG - Response for deleting network ()
2026-03-05 03:04:43,732 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/a655884e-051d-48e1-a8a0-92757c7c55e3
2026-03-05 03:04:43,746 - DEBUG - Response Code: 404
2026-03-05 03:04:43,746 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:43,758 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:43,794 - DEBUG - Requesting: http://10.0.0.65:8082/project/8b0536d8-98a8-46fb-8f01-bb33b9a98100
2026-03-05 03:04:43,902 - INFO - Validated that VN ctest-right_vn-21243468 is not found in API Server
2026-03-05 03:04:43,926 - DEBUG - VN ctest-right_vn-21243468 is not present in Agent 10.0.0.141
2026-03-05 03:04:43,942 - DEBUG - VN ctest-right_vn-21243468 is not present in Agent 10.0.0.73
2026-03-05 03:04:43,942 - INFO - Validated that VN ctest-right_vn-21243468 is not in any agent
2026-03-05 03:04:43,982 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-21243468 info
2026-03-05 03:04:43,982 - INFO - Deleting VN ctest-left_vn-26017685
2026-03-05 03:04:44,163 - DEBUG - Response for deleting network ()
2026-03-05 03:04:44,163 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/e029560a-e6d5-42f7-ad53-5a23e1bc8057
2026-03-05 03:04:44,180 - DEBUG - Response Code: 404
2026-03-05 03:04:44,180 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:44,187 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:44,244 - DEBUG - Requesting: http://10.0.0.65:8082/project/8b0536d8-98a8-46fb-8f01-bb33b9a98100
2026-03-05 03:04:44,338 - INFO - Validated that VN ctest-left_vn-26017685 is not found in API Server
2026-03-05 03:04:44,349 - DEBUG - VN ctest-left_vn-26017685 is not present in Agent 10.0.0.141
2026-03-05 03:04:44,359 - DEBUG - VN ctest-left_vn-26017685 is not present in Agent 10.0.0.73
2026-03-05 03:04:44,359 - INFO - Validated that VN ctest-left_vn-26017685 is not in any agent
2026-03-05 03:04:44,393 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-26017685 info
2026-03-05 03:04:44,394 - INFO - Deleting VN ctest-mgmt_vn-82233193
2026-03-05 03:04:44,523 - DEBUG - Response for deleting network ()
2026-03-05 03:04:44,523 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/5ec862e4-fb71-4831-9810-a5b4ff7333a0
2026-03-05 03:04:44,529 - DEBUG - Response Code: 404
2026-03-05 03:04:44,529 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-03-05 03:04:44,542 - DEBUG - Requesting: http://10.0.0.65:8082/domain/8ec23053-61d3-4e86-b71e-e24c9bc5c983
2026-03-05 03:04:44,552 - DEBUG - Requesting: http://10.0.0.65:8082/project/8b0536d8-98a8-46fb-8f01-bb33b9a98100
2026-03-05 03:04:44,644 - INFO - Validated that VN ctest-mgmt_vn-82233193 is not found in API Server
2026-03-05 03:04:44,656 - DEBUG - VN ctest-mgmt_vn-82233193 is not present in Agent 10.0.0.141
2026-03-05 03:04:44,668 - DEBUG - VN ctest-mgmt_vn-82233193 is not present in Agent 10.0.0.73
2026-03-05 03:04:44,668 - INFO - Validated that VN ctest-mgmt_vn-82233193 is not in any agent
2026-03-05 03:04:44,703 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-82233193 info
2026-03-05 03:04:45,979 - DEBUG - No XMPP flaps were noticed during the test
2026-03-05 03:04:45,979 - INFO -
2026-03-05 03:04:45,979 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:17]
2026-03-05 03:04:45,979 - INFO - --------------------------------------------------------------------------------
2026-03-05 03:04:46,733 - INFO - Deleted project: ctest-TestSvcRegr-24806731, ID : 8b0536d8-98a8-46fb-8f01-bb33b9a98100