]) created on node: (an-jenkins-deploy-platform-ansible-os-5644-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5644-2)
2026-04-20 03:14:34,237 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-52463618']
2026-04-20 03:14:34,561 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-52463618'] created succesfully
2026-04-20 03:14:34,969 - DEBUG - Image by name tiny_nat_fw not found
2026-04-20 03:14:34,969 - DEBUG - Installing image tiny_nat_fw
2026-04-20 03:14:34,969 - 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-04-20 03:14:34,969 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-04-20 03:14:34,970 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-04-20 03:14:34,986 - 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-04-20 03:14:35,097 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-04-20 03:14:35,098 - DEBUG - Unzip image
2026-04-20 03:14:35,098 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-04-20 03:14:35,129 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-04-20 03:14:35,129 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-52463618']
2026-04-20 03:14:35,220 - INFO - Service template: ['default-domain', 'ctest-service_template_1-52463618'] deleted successfully.
2026-04-20 03:14:35,220 - INFO - Skip interface_detach for VM ctest-right_vm-44080953 in state BUILD
2026-04-20 03:14:35,220 - INFO - Deleting VM ctest-right_vm-44080953
2026-04-20 03:14:35,251 - ERROR - VM ctest-right_vm-44080953 has failed to come up
2026-04-20 03:14:35,252 - ERROR - Nova failed to get host of the VM
2026-04-20 03:14:35,252 - ERROR - VM ctest-right_vm-44080953 has failed to come up
2026-04-20 03:14:35,252 - ERROR - Nova failed to get host of the VM
2026-04-20 03:14:35,315 - INFO - Skip interface_detach for VM ctest-left_vm-55521525 in state BUILD
2026-04-20 03:14:35,316 - INFO - Deleting VM ctest-left_vm-55521525
2026-04-20 03:14:35,316 - ERROR - VM ctest-left_vm-55521525 has failed to come up
2026-04-20 03:14:35,316 - ERROR - Nova failed to get host of the VM
2026-04-20 03:14:35,316 - ERROR - VM ctest-left_vm-55521525 has failed to come up
2026-04-20 03:14:35,316 - ERROR - Nova failed to get host of the VM
2026-04-20 03:14:35,380 - INFO - Deleting VN ctest-right_vn-26783064
2026-04-20 03:14:35,419 - DEBUG - VN a619b3c4-2c52-4922-89ab-8143b46b365f still in use: Unable to complete operation on network a619b3c4-2c52-4922-89ab-8143b46b365f. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-3f52ed27-a747-4583-88fc-edac2fa7af43']
2026-04-20 03:14:35,419 - WARNING - Deleting VN ctest-right_vn-26783064 failed..Will retry
2026-04-20 03:14:37,590 - DEBUG - Response for deleting network ()
2026-04-20 03:14:37,590 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/02f91ff7-5665-4190-8e71-37804f23daa7
2026-04-20 03:14:37,602 - DEBUG - Response Code: 404
2026-04-20 03:14:37,602 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:14:37,610 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:14:37,668 - DEBUG - Requesting: http://10.0.0.38:8082/project/d0d30eaa-828a-4670-b08f-dd2a35acb2b2
2026-04-20 03:14:37,778 - INFO - Validated that VN ctest-right_vn-26783064 is not found in API Server
2026-04-20 03:14:37,790 - DEBUG - VN ctest-right_vn-26783064 is not present in Agent 10.0.0.240
2026-04-20 03:14:37,801 - DEBUG - VN ctest-right_vn-26783064 is not present in Agent 10.0.0.65
2026-04-20 03:14:37,802 - INFO - Validated that VN ctest-right_vn-26783064 is not in any agent
2026-04-20 03:14:37,835 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-26783064 info
2026-04-20 03:14:37,835 - INFO - Deleting VN ctest-left_vn-77990772
2026-04-20 03:14:37,994 - DEBUG - Response for deleting network ()
2026-04-20 03:14:37,994 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/49950550-7a91-4ba6-8f06-7ebf9b49530a
2026-04-20 03:14:38,003 - DEBUG - Response Code: 404
2026-04-20 03:14:38,003 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:14:38,011 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:14:38,065 - DEBUG - Requesting: http://10.0.0.38:8082/project/d0d30eaa-828a-4670-b08f-dd2a35acb2b2
2026-04-20 03:14:38,153 - INFO - Validated that VN ctest-left_vn-77990772 is not found in API Server
2026-04-20 03:14:38,164 - DEBUG - VN ctest-left_vn-77990772 is not present in Agent 10.0.0.240
2026-04-20 03:14:38,175 - DEBUG - VN ctest-left_vn-77990772 is not present in Agent 10.0.0.65
2026-04-20 03:14:38,175 - INFO - Validated that VN ctest-left_vn-77990772 is not in any agent
2026-04-20 03:14:38,208 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-77990772 info
2026-04-20 03:14:38,208 - INFO - Deleting VN ctest-mgmt_vn-07089748
2026-04-20 03:14:38,359 - DEBUG - Response for deleting network ()
2026-04-20 03:14:38,359 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/3dba9346-d529-42eb-99cf-00ec9cd5e8f9
2026-04-20 03:14:38,365 - DEBUG - Response Code: 404
2026-04-20 03:14:38,365 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:14:38,373 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:14:38,392 - DEBUG - Requesting: http://10.0.0.38:8082/project/d0d30eaa-828a-4670-b08f-dd2a35acb2b2
2026-04-20 03:14:38,486 - INFO - Validated that VN ctest-mgmt_vn-07089748 is not found in API Server
2026-04-20 03:14:38,498 - DEBUG - VN ctest-mgmt_vn-07089748 is not present in Agent 10.0.0.240
2026-04-20 03:14:38,513 - DEBUG - VN ctest-mgmt_vn-07089748 is not present in Agent 10.0.0.65
2026-04-20 03:14:38,513 - INFO - Validated that VN ctest-mgmt_vn-07089748 is not in any agent
2026-04-20 03:14:38,546 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-07089748 info
2026-04-20 03:14:38,546 - INFO - Deleting VM ctest-vm-in-third-vn-40857163
2026-04-20 03:14:38,639 - INFO - Deleting VN ctest-third-vn-32737449
2026-04-20 03:14:38,682 - DEBUG - VN 62c172e8-6b27-4bab-ac8d-315a687ced6c still in use: Unable to complete operation on network 62c172e8-6b27-4bab-ac8d-315a687ced6c. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-c756133c-a982-4e91-9ada-8d8fb7833059']
2026-04-20 03:14:38,682 - WARNING - Deleting VN ctest-third-vn-32737449 failed..Will retry
2026-04-20 03:14:40,828 - DEBUG - Response for deleting network ()
2026-04-20 03:14:42,087 - DEBUG - No XMPP flaps were noticed during the test
2026-04-20 03:14:42,087 - INFO -
2026-04-20 03:14:42,087 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:25]
2026-04-20 03:14:42,088 - INFO - --------------------------------------------------------------------------------
2026-04-20 03:14:42,090 - INFO - ================================================================================
2026-04-20 03:14:42,090 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2026-04-20 03:14:43,387 - DEBUG - Nothing to compare xmpp stats {'10.0.0.240': {'10.20.0.129': '0', '10.20.0.25': '0'}, '10.0.0.65': {'10.20.0.25': '0', '10.20.0.129': '1'}} with
2026-04-20 03:14:43,388 - INFO - Initial checks done. Running the testcase now
2026-04-20 03:14:43,388 - INFO -
2026-04-20 03:14:43,700 - DEBUG - Response for create_network : {'network': {'id': '01d2b4b8-0297-4a3a-afba-edce5fff5eac', 'name': 'ctest-mgmt_vn-31088329', 'tenant_id': 'd0d30eaa828a4670b08fdd2a35acb2b2', 'project_id': 'd0d30eaa828a4670b08fdd2a35acb2b2', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-24991478', 'ctest-mgmt_vn-31088329'], 'port_security_enabled': True, 'description': ''}}
2026-04-20 03:14:43,953 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ca6321a7-deae-42da-9460-d551cebc0339', 'name': '', 'tenant_id': 'd0d30eaa828a4670b08fdd2a35acb2b2', 'network_id': '01d2b4b8-0297-4a3a-afba-edce5fff5eac', 'ip_version': 4, 'cidr': '89.114.147.128/26', 'allocation_pools': [{'start': '89.114.147.130', 'end': '89.114.147.190'}], 'gateway_ip': '89.114.147.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '89.114.147.130', 'tags': [], 'project_id': 'd0d30eaa828a4670b08fdd2a35acb2b2'}}
2026-04-20 03:14:43,990 - INFO - Created VN ctest-mgmt_vn-31088329
2026-04-20 03:14:44,005 - DEBUG - VN ctest-mgmt_vn-31088329 UUID is 01d2b4b8-0297-4a3a-afba-edce5fff5eac
2026-04-20 03:14:44,085 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:14:44,093 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:14:44,104 - DEBUG - Requesting: http://10.0.0.38:8082/project/d0d30eaa-828a-4670-b08f-dd2a35acb2b2
2026-04-20 03:14:44,204 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/01d2b4b8-0297-4a3a-afba-edce5fff5eac
2026-04-20 03:14:44,218 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/01d2b4b8-0297-4a3a-afba-edce5fff5eac
2026-04-20 03:14:44,227 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/7d862eef-6d4a-4d09-bf9c-8d18ccfb680d
2026-04-20 03:14:44,240 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/7d862eef-6d4a-4d09-bf9c-8d18ccfb680d
2026-04-20 03:14:44,248 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/5fab7c1b-21b0-4bd3-a918-7747fd8781e1
2026-04-20 03:14:44,256 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-20 03:14:44,256 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/01d2b4b8-0297-4a3a-afba-edce5fff5eac
2026-04-20 03:14:44,264 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/7d862eef-6d4a-4d09-bf9c-8d18ccfb680d
2026-04-20 03:14:44,284 - INFO - Verified VN network id 17 for VN 01d2b4b8-0297-4a3a-afba-edce5fff5eac
2026-04-20 03:14:44,284 - INFO - Verifications in API Server for VN ctest-mgmt_vn-31088329 passed
2026-04-20 03:14:44,284 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/01d2b4b8-0297-4a3a-afba-edce5fff5eac
2026-04-20 03:14:44,296 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/7d862eef-6d4a-4d09-bf9c-8d18ccfb680d
2026-04-20 03:14:44,304 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/7d862eef-6d4a-4d09-bf9c-8d18ccfb680d
2026-04-20 03:14:44,311 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/5fab7c1b-21b0-4bd3-a918-7747fd8781e1
2026-04-20 03:14:44,324 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24991478:ctest-mgmt_vn-31088329', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24991478', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '131366041557617210', 'uuid-lslong': '12662694772935188140'}, 'enable': 'true', 'created': '2026-04-20T03:14:43', 'last-modified': '2026-04-20T03:14:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.433910'}
2026-04-20 03:14:44,332 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-20 03:14:44,340 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24991478:ctest-mgmt_vn-31088329', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24991478', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '131366041557617210', 'uuid-lslong': '12662694772935188140'}, 'enable': 'true', 'created': '2026-04-20T03:14:43', 'last-modified': '2026-04-20T03:14:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.450629'}
2026-04-20 03:14:44,349 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-20 03:14:44,355 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24991478:ctest-mgmt_vn-31088329', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24991478', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '131366041557617210', 'uuid-lslong': '12662694772935188140'}, 'enable': 'true', 'created': '2026-04-20T03:14:43', 'last-modified': '2026-04-20T03:14:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.468903'}
2026-04-20 03:14:44,361 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-20 03:14:44,361 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-31088329 passed
2026-04-20 03:14:44,361 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-31088329 in API_Server ======
2026-04-20 03:14:44,361 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:14:44,368 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:14:44,384 - DEBUG - Requesting: http://10.0.0.38:8082/project/d0d30eaa-828a-4670-b08f-dd2a35acb2b2
2026-04-20 03:14:44,479 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/01d2b4b8-0297-4a3a-afba-edce5fff5eac
2026-04-20 03:14:44,491 - DEBUG - =>VN ctest-mgmt_vn-31088329 has no policy to be verified
2026-04-20 03:14:44,492 - DEBUG - Verifying the vn in opserver
2026-04-20 03:14:44,492 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24991478:ctest-mgmt_vn-31088329 virtual network link through opserver 10.0.0.38
2026-04-20 03:14:44,492 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-20 03:14:44,503 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24991478:ctest-mgmt_vn-31088329', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24991478:ctest-mgmt_vn-31088329?flat'}
2026-04-20 03:14:44,504 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24991478:ctest-mgmt_vn-31088329 virtual network link through opserver 10.0.0.27
2026-04-20 03:14:44,504 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-04-20 03:14:44,518 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24991478:ctest-mgmt_vn-31088329', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24991478:ctest-mgmt_vn-31088329?flat'}
2026-04-20 03:14:44,518 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24991478:ctest-mgmt_vn-31088329 virtual network link through opserver 10.0.0.23
2026-04-20 03:14:44,518 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-04-20 03:14:44,529 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24991478:ctest-mgmt_vn-31088329', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24991478:ctest-mgmt_vn-31088329?flat'}
2026-04-20 03:14:44,529 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-24991478:ctest-mgmt_vn-31088329 is found in opserver
2026-04-20 03:14:44,554 - DEBUG - Do not have enough data to verify VN in agent
2026-04-20 03:14:44,565 - DEBUG - VRF ids for VN ctest-mgmt_vn-31088329: {}
2026-04-20 03:14:44,851 - DEBUG - Response for create_network : {'network': {'id': '95e63235-df80-4be9-bd20-65b58e91efbb', 'name': 'ctest-left_vn-34305014', 'tenant_id': 'd0d30eaa828a4670b08fdd2a35acb2b2', 'project_id': 'd0d30eaa828a4670b08fdd2a35acb2b2', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-24991478', 'ctest-left_vn-34305014'], 'port_security_enabled': True, 'description': ''}}
2026-04-20 03:14:45,058 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ffe91492-4abf-411d-ad76-6bb2d2b77233', 'name': '', 'tenant_id': 'd0d30eaa828a4670b08fdd2a35acb2b2', 'network_id': '95e63235-df80-4be9-bd20-65b58e91efbb', 'ip_version': 4, 'cidr': '182.63.145.128/26', 'allocation_pools': [{'start': '182.63.145.130', 'end': '182.63.145.190'}], 'gateway_ip': '182.63.145.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '182.63.145.130', 'tags': [], 'project_id': 'd0d30eaa828a4670b08fdd2a35acb2b2'}}
2026-04-20 03:14:45,077 - INFO - Created VN ctest-left_vn-34305014
2026-04-20 03:14:45,087 - DEBUG - VN ctest-left_vn-34305014 UUID is 95e63235-df80-4be9-bd20-65b58e91efbb
2026-04-20 03:14:45,152 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:14:45,163 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:14:45,174 - DEBUG - Requesting: http://10.0.0.38:8082/project/d0d30eaa-828a-4670-b08f-dd2a35acb2b2
2026-04-20 03:14:45,276 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/95e63235-df80-4be9-bd20-65b58e91efbb
2026-04-20 03:14:45,293 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/95e63235-df80-4be9-bd20-65b58e91efbb
2026-04-20 03:14:45,304 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/f0379288-07d7-4ec3-a243-32b25bcb6d06
2026-04-20 03:14:45,311 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/f0379288-07d7-4ec3-a243-32b25bcb6d06
2026-04-20 03:14:45,318 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/424ec9c6-7a3e-470a-a119-9883972ec387
2026-04-20 03:14:45,324 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-20 03:14:45,324 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/95e63235-df80-4be9-bd20-65b58e91efbb
2026-04-20 03:14:45,332 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/f0379288-07d7-4ec3-a243-32b25bcb6d06
2026-04-20 03:14:45,345 - INFO - Verified VN network id 18 for VN 95e63235-df80-4be9-bd20-65b58e91efbb
2026-04-20 03:14:45,345 - INFO - Verifications in API Server for VN ctest-left_vn-34305014 passed
2026-04-20 03:14:45,345 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/95e63235-df80-4be9-bd20-65b58e91efbb
2026-04-20 03:14:45,354 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/f0379288-07d7-4ec3-a243-32b25bcb6d06
2026-04-20 03:14:45,361 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/f0379288-07d7-4ec3-a243-32b25bcb6d06
2026-04-20 03:14:45,367 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/424ec9c6-7a3e-470a-a119-9883972ec387
2026-04-20 03:14:45,378 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24991478:ctest-left_vn-34305014', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24991478', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10801375963259096041', 'uuid-lslong': '13628004302878535611'}, 'enable': 'true', 'created': '2026-04-20T03:14:44', 'last-modified': '2026-04-20T03:14:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.380775'}
2026-04-20 03:14:45,383 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-20 03:14:45,389 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24991478:ctest-left_vn-34305014', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24991478', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10801375963259096041', 'uuid-lslong': '13628004302878535611'}, 'enable': 'true', 'created': '2026-04-20T03:14:44', 'last-modified': '2026-04-20T03:14:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.392089'}
2026-04-20 03:14:45,394 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-20 03:14:45,399 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24991478:ctest-left_vn-34305014', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24991478', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10801375963259096041', 'uuid-lslong': '13628004302878535611'}, 'enable': 'true', 'created': '2026-04-20T03:14:44', 'last-modified': '2026-04-20T03:14:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.394886'}
2026-04-20 03:14:45,404 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-20 03:14:45,404 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-34305014 passed
2026-04-20 03:14:45,405 - DEBUG - ====Verifying policy data for ctest-left_vn-34305014 in API_Server ======
2026-04-20 03:14:45,405 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:14:45,411 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:14:45,421 - DEBUG - Requesting: http://10.0.0.38:8082/project/d0d30eaa-828a-4670-b08f-dd2a35acb2b2
2026-04-20 03:14:45,527 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/95e63235-df80-4be9-bd20-65b58e91efbb
2026-04-20 03:14:45,537 - DEBUG - =>VN ctest-left_vn-34305014 has no policy to be verified
2026-04-20 03:14:45,537 - DEBUG - Verifying the vn in opserver
2026-04-20 03:14:45,537 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24991478:ctest-left_vn-34305014 virtual network link through opserver 10.0.0.38
2026-04-20 03:14:45,537 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-20 03:14:45,548 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24991478:ctest-left_vn-34305014', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24991478:ctest-left_vn-34305014?flat'}
2026-04-20 03:14:45,548 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24991478:ctest-left_vn-34305014 virtual network link through opserver 10.0.0.27
2026-04-20 03:14:45,548 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-04-20 03:14:45,562 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24991478:ctest-left_vn-34305014', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24991478:ctest-left_vn-34305014?flat'}
2026-04-20 03:14:45,562 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24991478:ctest-left_vn-34305014 virtual network link through opserver 10.0.0.23
2026-04-20 03:14:45,562 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-04-20 03:14:45,573 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24991478:ctest-left_vn-34305014', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24991478:ctest-left_vn-34305014?flat'}
2026-04-20 03:14:45,573 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-24991478:ctest-left_vn-34305014 is found in opserver
2026-04-20 03:14:45,594 - DEBUG - Do not have enough data to verify VN in agent
2026-04-20 03:14:45,605 - DEBUG - VRF ids for VN ctest-left_vn-34305014: {}
2026-04-20 03:14:45,880 - DEBUG - Response for create_network : {'network': {'id': '43902400-c674-44f0-ad7b-a13162a45ec7', 'name': 'ctest-right_vn-15249159', 'tenant_id': 'd0d30eaa828a4670b08fdd2a35acb2b2', 'project_id': 'd0d30eaa828a4670b08fdd2a35acb2b2', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-24991478', 'ctest-right_vn-15249159'], 'port_security_enabled': True, 'description': ''}}
2026-04-20 03:14:46,142 - DEBUG - Response for create_subnet : {'subnet': {'id': 'bcf24b1f-4640-45c3-8a3e-b01f3cf55c54', 'name': '', 'tenant_id': 'd0d30eaa828a4670b08fdd2a35acb2b2', 'network_id': '43902400-c674-44f0-ad7b-a13162a45ec7', 'ip_version': 4, 'cidr': '66.92.109.192/26', 'allocation_pools': [{'start': '66.92.109.194', 'end': '66.92.109.254'}], 'gateway_ip': '66.92.109.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '66.92.109.194', 'tags': [], 'project_id': 'd0d30eaa828a4670b08fdd2a35acb2b2'}}
2026-04-20 03:14:46,161 - INFO - Created VN ctest-right_vn-15249159
2026-04-20 03:14:46,175 - DEBUG - VN ctest-right_vn-15249159 UUID is 43902400-c674-44f0-ad7b-a13162a45ec7
2026-04-20 03:14:46,248 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:14:46,254 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:14:46,264 - DEBUG - Requesting: http://10.0.0.38:8082/project/d0d30eaa-828a-4670-b08f-dd2a35acb2b2
2026-04-20 03:14:46,357 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/43902400-c674-44f0-ad7b-a13162a45ec7
2026-04-20 03:14:46,368 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/43902400-c674-44f0-ad7b-a13162a45ec7
2026-04-20 03:14:46,376 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/fb45e1bc-6803-4d9a-936d-28b497559122
2026-04-20 03:14:46,385 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/fb45e1bc-6803-4d9a-936d-28b497559122
2026-04-20 03:14:46,392 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/c34f52ec-79af-4f44-8d62-88d15ab7f26a
2026-04-20 03:14:46,399 - DEBUG - Route Targets: ['target:64512:8000009']
2026-04-20 03:14:46,399 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/43902400-c674-44f0-ad7b-a13162a45ec7
2026-04-20 03:14:46,412 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/fb45e1bc-6803-4d9a-936d-28b497559122
2026-04-20 03:14:46,427 - INFO - Verified VN network id 19 for VN 43902400-c674-44f0-ad7b-a13162a45ec7
2026-04-20 03:14:46,427 - INFO - Verifications in API Server for VN ctest-right_vn-15249159 passed
2026-04-20 03:14:46,428 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/43902400-c674-44f0-ad7b-a13162a45ec7
2026-04-20 03:14:46,438 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/fb45e1bc-6803-4d9a-936d-28b497559122
2026-04-20 03:14:46,447 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/fb45e1bc-6803-4d9a-936d-28b497559122
2026-04-20 03:14:46,456 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/c34f52ec-79af-4f44-8d62-88d15ab7f26a
2026-04-20 03:14:46,472 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24991478:ctest-right_vn-15249159', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24991478', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4868430782935614704', 'uuid-lslong': '12500762424177352391'}, 'enable': 'true', 'created': '2026-04-20T03:14:45', 'last-modified': '2026-04-20T03:14:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.385375'}
2026-04-20 03:14:46,479 - DEBUG - Route Targets: ['target:64512:8000009']
2026-04-20 03:14:46,489 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24991478:ctest-right_vn-15249159', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24991478', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4868430782935614704', 'uuid-lslong': '12500762424177352391'}, 'enable': 'true', 'created': '2026-04-20T03:14:45', 'last-modified': '2026-04-20T03:14:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.399606'}
2026-04-20 03:14:46,502 - DEBUG - Route Targets: ['target:64512:8000009']
2026-04-20 03:14:46,507 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24991478:ctest-right_vn-15249159', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24991478', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4868430782935614704', 'uuid-lslong': '12500762424177352391'}, 'enable': 'true', 'created': '2026-04-20T03:14:45', 'last-modified': '2026-04-20T03:14:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.418099'}
2026-04-20 03:14:46,512 - DEBUG - Route Targets: ['target:64512:8000009']
2026-04-20 03:14:46,512 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-15249159 passed
2026-04-20 03:14:46,512 - DEBUG - ====Verifying policy data for ctest-right_vn-15249159 in API_Server ======
2026-04-20 03:14:46,513 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:14:46,531 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:14:46,546 - DEBUG - Requesting: http://10.0.0.38:8082/project/d0d30eaa-828a-4670-b08f-dd2a35acb2b2
2026-04-20 03:14:46,646 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/43902400-c674-44f0-ad7b-a13162a45ec7
2026-04-20 03:14:46,656 - DEBUG - =>VN ctest-right_vn-15249159 has no policy to be verified
2026-04-20 03:14:46,656 - DEBUG - Verifying the vn in opserver
2026-04-20 03:14:46,656 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24991478:ctest-right_vn-15249159 virtual network link through opserver 10.0.0.38
2026-04-20 03:14:46,656 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-20 03:14:46,668 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24991478:ctest-right_vn-15249159', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24991478:ctest-right_vn-15249159?flat'}
2026-04-20 03:14:46,668 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24991478:ctest-right_vn-15249159 virtual network link through opserver 10.0.0.27
2026-04-20 03:14:46,668 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-04-20 03:14:46,685 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24991478:ctest-right_vn-15249159', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24991478:ctest-right_vn-15249159?flat'}
2026-04-20 03:14:46,685 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24991478:ctest-right_vn-15249159 virtual network link through opserver 10.0.0.23
2026-04-20 03:14:46,685 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-04-20 03:14:46,698 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24991478:ctest-right_vn-15249159', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24991478:ctest-right_vn-15249159?flat'}
2026-04-20 03:14:46,698 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-24991478:ctest-right_vn-15249159 is found in opserver
2026-04-20 03:14:46,720 - DEBUG - Do not have enough data to verify VN in agent
2026-04-20 03:14:46,729 - DEBUG - VRF ids for VN ctest-right_vn-15249159: {}
2026-04-20 03:14:46,991 - DEBUG - Response for create_network : {'network': {'id': '449b351b-cd47-4332-8d79-005eee43bebd', 'name': 'ctest-trans_left_vn-98250824', 'tenant_id': 'd0d30eaa828a4670b08fdd2a35acb2b2', 'project_id': 'd0d30eaa828a4670b08fdd2a35acb2b2', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-24991478', 'ctest-trans_left_vn-98250824'], 'port_security_enabled': True, 'description': ''}}
2026-04-20 03:14:47,230 - DEBUG - Response for create_subnet : {'subnet': {'id': '0aa10d21-4475-45e6-a7e3-118bd323908f', 'name': '', 'tenant_id': 'd0d30eaa828a4670b08fdd2a35acb2b2', 'network_id': '449b351b-cd47-4332-8d79-005eee43bebd', 'ip_version': 4, 'cidr': '111.61.155.0/26', 'allocation_pools': [{'start': '111.61.155.2', 'end': '111.61.155.62'}], 'gateway_ip': '111.61.155.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '111.61.155.2', 'tags': [], 'project_id': 'd0d30eaa828a4670b08fdd2a35acb2b2'}}
2026-04-20 03:14:47,254 - INFO - Created VN ctest-trans_left_vn-98250824
2026-04-20 03:14:47,267 - DEBUG - VN ctest-trans_left_vn-98250824 UUID is 449b351b-cd47-4332-8d79-005eee43bebd
2026-04-20 03:14:47,344 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:14:47,350 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:14:47,359 - DEBUG - Requesting: http://10.0.0.38:8082/project/d0d30eaa-828a-4670-b08f-dd2a35acb2b2
2026-04-20 03:14:47,457 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/449b351b-cd47-4332-8d79-005eee43bebd
2026-04-20 03:14:47,471 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/449b351b-cd47-4332-8d79-005eee43bebd
2026-04-20 03:14:47,486 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/9415a0d6-545f-4999-9a25-50d40ada2bb9
2026-04-20 03:14:47,493 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/9415a0d6-545f-4999-9a25-50d40ada2bb9
2026-04-20 03:14:47,500 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/6580cd4a-27ba-48e5-957a-01f93dc99871
2026-04-20 03:14:47,507 - DEBUG - Route Targets: ['target:64512:8000010']
2026-04-20 03:14:47,507 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/449b351b-cd47-4332-8d79-005eee43bebd
2026-04-20 03:14:47,517 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/9415a0d6-545f-4999-9a25-50d40ada2bb9
2026-04-20 03:14:47,539 - INFO - Verified VN network id 20 for VN 449b351b-cd47-4332-8d79-005eee43bebd
2026-04-20 03:14:47,539 - INFO - Verifications in API Server for VN ctest-trans_left_vn-98250824 passed
2026-04-20 03:14:47,539 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/449b351b-cd47-4332-8d79-005eee43bebd
2026-04-20 03:14:47,552 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/9415a0d6-545f-4999-9a25-50d40ada2bb9
2026-04-20 03:14:47,561 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/9415a0d6-545f-4999-9a25-50d40ada2bb9
2026-04-20 03:14:47,568 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/6580cd4a-27ba-48e5-957a-01f93dc99871
2026-04-20 03:14:47,583 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24991478:ctest-trans_left_vn-98250824', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24991478', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4943603409493639986', 'uuid-lslong': '10194179639254171325'}, 'enable': 'true', 'created': '2026-04-20T03:14:46', 'last-modified': '2026-04-20T03:14:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.401478'}
2026-04-20 03:14:47,589 - DEBUG - Route Targets: ['target:64512:8000010']
2026-04-20 03:14:47,594 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24991478:ctest-trans_left_vn-98250824', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24991478', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4943603409493639986', 'uuid-lslong': '10194179639254171325'}, 'enable': 'true', 'created': '2026-04-20T03:14:46', 'last-modified': '2026-04-20T03:14:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.411760'}
2026-04-20 03:14:47,600 - DEBUG - Route Targets: ['target:64512:8000010']
2026-04-20 03:14:47,604 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24991478:ctest-trans_left_vn-98250824', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24991478', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4943603409493639986', 'uuid-lslong': '10194179639254171325'}, 'enable': 'true', 'created': '2026-04-20T03:14:46', 'last-modified': '2026-04-20T03:14:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.417509'}
2026-04-20 03:14:47,610 - DEBUG - Route Targets: ['target:64512:8000010']
2026-04-20 03:14:47,610 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-98250824 passed
2026-04-20 03:14:47,610 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-98250824 in API_Server ======
2026-04-20 03:14:47,610 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:14:47,617 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:14:47,632 - DEBUG - Requesting: http://10.0.0.38:8082/project/d0d30eaa-828a-4670-b08f-dd2a35acb2b2
2026-04-20 03:14:47,727 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/449b351b-cd47-4332-8d79-005eee43bebd
2026-04-20 03:14:47,738 - DEBUG - =>VN ctest-trans_left_vn-98250824 has no policy to be verified
2026-04-20 03:14:47,738 - DEBUG - Verifying the vn in opserver
2026-04-20 03:14:47,738 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24991478:ctest-trans_left_vn-98250824 virtual network link through opserver 10.0.0.38
2026-04-20 03:14:47,738 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-20 03:14:47,750 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24991478:ctest-trans_left_vn-98250824', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24991478:ctest-trans_left_vn-98250824?flat'}
2026-04-20 03:14:47,751 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24991478:ctest-trans_left_vn-98250824 virtual network link through opserver 10.0.0.27
2026-04-20 03:14:47,751 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-04-20 03:14:47,766 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24991478:ctest-trans_left_vn-98250824', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24991478:ctest-trans_left_vn-98250824?flat'}
2026-04-20 03:14:47,766 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24991478:ctest-trans_left_vn-98250824 virtual network link through opserver 10.0.0.23
2026-04-20 03:14:47,766 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-04-20 03:14:47,779 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24991478:ctest-trans_left_vn-98250824', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24991478:ctest-trans_left_vn-98250824?flat'}
2026-04-20 03:14:47,779 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-24991478:ctest-trans_left_vn-98250824 is found in opserver
2026-04-20 03:14:47,816 - DEBUG - Do not have enough data to verify VN in agent
2026-04-20 03:14:47,828 - DEBUG - VRF ids for VN ctest-trans_left_vn-98250824: {}
2026-04-20 03:14:48,120 - DEBUG - Response for create_network : {'network': {'id': '13fca4b1-b91a-4437-9d3c-ad7976341956', 'name': 'ctest-trans_right_vn-24532660', 'tenant_id': 'd0d30eaa828a4670b08fdd2a35acb2b2', 'project_id': 'd0d30eaa828a4670b08fdd2a35acb2b2', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-24991478', 'ctest-trans_right_vn-24532660'], 'port_security_enabled': True, 'description': ''}}
2026-04-20 03:14:48,373 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a730aa95-fd89-45cb-9eb0-c9d289b93f83', 'name': '', 'tenant_id': 'd0d30eaa828a4670b08fdd2a35acb2b2', 'network_id': '13fca4b1-b91a-4437-9d3c-ad7976341956', 'ip_version': 4, 'cidr': '119.122.212.128/26', 'allocation_pools': [{'start': '119.122.212.130', 'end': '119.122.212.190'}], 'gateway_ip': '119.122.212.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '119.122.212.130', 'tags': [], 'project_id': 'd0d30eaa828a4670b08fdd2a35acb2b2'}}
2026-04-20 03:14:48,397 - INFO - Created VN ctest-trans_right_vn-24532660
2026-04-20 03:14:48,408 - DEBUG - VN ctest-trans_right_vn-24532660 UUID is 13fca4b1-b91a-4437-9d3c-ad7976341956
2026-04-20 03:14:48,485 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:14:48,493 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:14:48,503 - DEBUG - Requesting: http://10.0.0.38:8082/project/d0d30eaa-828a-4670-b08f-dd2a35acb2b2
2026-04-20 03:14:48,601 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/13fca4b1-b91a-4437-9d3c-ad7976341956
2026-04-20 03:14:48,616 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/13fca4b1-b91a-4437-9d3c-ad7976341956
2026-04-20 03:14:48,625 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/c5c8e820-be55-4855-8a61-5960ce92ed8b
2026-04-20 03:14:48,632 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/c5c8e820-be55-4855-8a61-5960ce92ed8b
2026-04-20 03:14:48,639 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/c5a50438-34cd-4d9b-bffa-159044a2d31c
2026-04-20 03:14:48,646 - DEBUG - Route Targets: ['target:64512:8000011']
2026-04-20 03:14:48,646 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/13fca4b1-b91a-4437-9d3c-ad7976341956
2026-04-20 03:14:48,656 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/c5c8e820-be55-4855-8a61-5960ce92ed8b
2026-04-20 03:14:48,671 - INFO - Verified VN network id 21 for VN 13fca4b1-b91a-4437-9d3c-ad7976341956
2026-04-20 03:14:48,671 - INFO - Verifications in API Server for VN ctest-trans_right_vn-24532660 passed
2026-04-20 03:14:48,671 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/13fca4b1-b91a-4437-9d3c-ad7976341956
2026-04-20 03:14:48,681 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/c5c8e820-be55-4855-8a61-5960ce92ed8b
2026-04-20 03:14:48,689 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/c5c8e820-be55-4855-8a61-5960ce92ed8b
2026-04-20 03:14:48,697 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/c5a50438-34cd-4d9b-bffa-159044a2d31c
2026-04-20 03:14:48,708 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24991478:ctest-trans_right_vn-24532660', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24991478', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1440207064073389111', 'uuid-lslong': '11330121499743099222'}, 'enable': 'true', 'created': '2026-04-20T03:14:48', 'last-modified': '2026-04-20T03:14:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.382539'}
2026-04-20 03:14:48,716 - DEBUG - Route Targets: ['target:64512:8000011']
2026-04-20 03:14:48,721 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24991478:ctest-trans_right_vn-24532660', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24991478', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1440207064073389111', 'uuid-lslong': '11330121499743099222'}, 'enable': 'true', 'created': '2026-04-20T03:14:48', 'last-modified': '2026-04-20T03:14:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.393951'}
2026-04-20 03:14:48,726 - DEBUG - Route Targets: ['target:64512:8000011']
2026-04-20 03:14:48,731 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-24991478:ctest-trans_right_vn-24532660', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-24991478', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1440207064073389111', 'uuid-lslong': '11330121499743099222'}, 'enable': 'true', 'created': '2026-04-20T03:14:48', 'last-modified': '2026-04-20T03:14:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.405059'}
2026-04-20 03:14:48,736 - DEBUG - Route Targets: ['target:64512:8000011']
2026-04-20 03:14:48,736 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-24532660 passed
2026-04-20 03:14:48,737 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-24532660 in API_Server ======
2026-04-20 03:14:48,737 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:14:48,742 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:14:48,752 - DEBUG - Requesting: http://10.0.0.38:8082/project/d0d30eaa-828a-4670-b08f-dd2a35acb2b2
2026-04-20 03:14:48,839 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/13fca4b1-b91a-4437-9d3c-ad7976341956
2026-04-20 03:14:48,850 - DEBUG - =>VN ctest-trans_right_vn-24532660 has no policy to be verified
2026-04-20 03:14:48,850 - DEBUG - Verifying the vn in opserver
2026-04-20 03:14:48,850 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24991478:ctest-trans_right_vn-24532660 virtual network link through opserver 10.0.0.38
2026-04-20 03:14:48,850 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-20 03:14:48,863 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24991478:ctest-trans_right_vn-24532660', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24991478:ctest-trans_right_vn-24532660?flat'}
2026-04-20 03:14:48,863 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24991478:ctest-trans_right_vn-24532660 virtual network link through opserver 10.0.0.27
2026-04-20 03:14:48,863 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-04-20 03:14:48,876 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24991478:ctest-trans_right_vn-24532660', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24991478:ctest-trans_right_vn-24532660?flat'}
2026-04-20 03:14:48,876 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-24991478:ctest-trans_right_vn-24532660 virtual network link through opserver 10.0.0.23
2026-04-20 03:14:48,876 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-04-20 03:14:48,889 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-24991478:ctest-trans_right_vn-24532660', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-24991478:ctest-trans_right_vn-24532660?flat'}
2026-04-20 03:14:48,889 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-24991478:ctest-trans_right_vn-24532660 is found in opserver
2026-04-20 03:14:48,910 - DEBUG - Do not have enough data to verify VN in agent
2026-04-20 03:14:48,920 - DEBUG - VRF ids for VN ctest-trans_right_vn-24532660: {}
2026-04-20 03:14:50,094 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5644-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5644-2)
2026-04-20 03:14:51,504 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5644-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5644-1)
2026-04-20 03:14:51,505 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-50284447']
2026-04-20 03:14:51,817 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-50284447'] created succesfully
2026-04-20 03:14:52,272 - DEBUG - Image by name tiny_trans_fw not found
2026-04-20 03:14:52,272 - DEBUG - Installing image tiny_trans_fw
2026-04-20 03:14:52,272 - 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-04-20 03:14:52,272 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-04-20 03:14:52,273 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-04-20 03:14:52,293 - 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-04-20 03:14:52,340 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-04-20 03:14:52,340 - DEBUG - Unzip image
2026-04-20 03:14:52,340 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-04-20 03:14:52,398 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-04-20 03:14:52,399 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-50284447']
2026-04-20 03:14:52,516 - INFO - Service template: ['default-domain', 'ctest-service_template_1-50284447'] deleted successfully.
2026-04-20 03:14:52,516 - INFO - Skip interface_detach for VM ctest-right_vm-90387583 in state BUILD
2026-04-20 03:14:52,516 - INFO - Deleting VM ctest-right_vm-90387583
2026-04-20 03:14:52,517 - ERROR - VM ctest-right_vm-90387583 has failed to come up
2026-04-20 03:14:52,517 - ERROR - Nova failed to get host of the VM
2026-04-20 03:14:52,517 - ERROR - VM ctest-right_vm-90387583 has failed to come up
2026-04-20 03:14:52,517 - ERROR - Nova failed to get host of the VM
2026-04-20 03:14:52,661 - INFO - Skip interface_detach for VM ctest-left_vm-37101088 in state BUILD
2026-04-20 03:14:52,661 - INFO - Deleting VM ctest-left_vm-37101088
2026-04-20 03:14:52,661 - ERROR - VM ctest-left_vm-37101088 has failed to come up
2026-04-20 03:14:52,661 - ERROR - Nova failed to get host of the VM
2026-04-20 03:14:52,661 - ERROR - VM ctest-left_vm-37101088 has failed to come up
2026-04-20 03:14:52,662 - ERROR - Nova failed to get host of the VM
2026-04-20 03:14:52,753 - INFO - Deleting VN ctest-trans_right_vn-24532660
2026-04-20 03:14:52,918 - DEBUG - Response for deleting network ()
2026-04-20 03:14:52,918 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/c5c8e820-be55-4855-8a61-5960ce92ed8b
2026-04-20 03:14:52,926 - DEBUG - Response Code: 404
2026-04-20 03:14:52,926 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:14:52,947 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:14:52,968 - DEBUG - Requesting: http://10.0.0.38:8082/project/d0d30eaa-828a-4670-b08f-dd2a35acb2b2
2026-04-20 03:14:53,083 - INFO - Validated that VN ctest-trans_right_vn-24532660 is not found in API Server
2026-04-20 03:14:53,099 - DEBUG - VN ctest-trans_right_vn-24532660 is not present in Agent 10.0.0.240
2026-04-20 03:14:53,111 - DEBUG - VN ctest-trans_right_vn-24532660 is not present in Agent 10.0.0.65
2026-04-20 03:14:53,111 - INFO - Validated that VN ctest-trans_right_vn-24532660 is not in any agent
2026-04-20 03:14:53,148 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-24532660 info
2026-04-20 03:14:53,148 - INFO - Deleting VN ctest-trans_left_vn-98250824
2026-04-20 03:14:53,317 - DEBUG - Response for deleting network ()
2026-04-20 03:14:53,318 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/9415a0d6-545f-4999-9a25-50d40ada2bb9
2026-04-20 03:14:53,344 - DEBUG - Response Code: 404
2026-04-20 03:14:53,344 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:14:53,356 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:14:53,370 - DEBUG - Requesting: http://10.0.0.38:8082/project/d0d30eaa-828a-4670-b08f-dd2a35acb2b2
2026-04-20 03:14:53,473 - INFO - Validated that VN ctest-trans_left_vn-98250824 is not found in API Server
2026-04-20 03:14:53,518 - DEBUG - VN ctest-trans_left_vn-98250824 is not present in Agent 10.0.0.240
2026-04-20 03:14:53,532 - DEBUG - VN ctest-trans_left_vn-98250824 is not present in Agent 10.0.0.65
2026-04-20 03:14:53,532 - INFO - Validated that VN ctest-trans_left_vn-98250824 is not in any agent
2026-04-20 03:14:53,626 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-98250824 info
2026-04-20 03:14:53,626 - INFO - Deleting VN ctest-right_vn-15249159
2026-04-20 03:14:53,685 - DEBUG - VN 43902400-c674-44f0-ad7b-a13162a45ec7 still in use: Unable to complete operation on network 43902400-c674-44f0-ad7b-a13162a45ec7. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-621f2034-cca9-46cd-917f-5239cb89a6b2']
2026-04-20 03:14:53,685 - WARNING - Deleting VN ctest-right_vn-15249159 failed..Will retry
2026-04-20 03:14:55,833 - DEBUG - Response for deleting network ()
2026-04-20 03:14:55,833 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/fb45e1bc-6803-4d9a-936d-28b497559122
2026-04-20 03:14:55,839 - DEBUG - Response Code: 404
2026-04-20 03:14:55,839 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:14:55,852 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:14:55,867 - DEBUG - Requesting: http://10.0.0.38:8082/project/d0d30eaa-828a-4670-b08f-dd2a35acb2b2
2026-04-20 03:14:55,955 - INFO - Validated that VN ctest-right_vn-15249159 is not found in API Server
2026-04-20 03:14:55,966 - DEBUG - VN ctest-right_vn-15249159 is not present in Agent 10.0.0.240
2026-04-20 03:14:55,976 - DEBUG - VN ctest-right_vn-15249159 is not present in Agent 10.0.0.65
2026-04-20 03:14:55,976 - INFO - Validated that VN ctest-right_vn-15249159 is not in any agent
2026-04-20 03:14:56,005 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-15249159 info
2026-04-20 03:14:56,005 - INFO - Deleting VN ctest-left_vn-34305014
2026-04-20 03:14:56,172 - DEBUG - Response for deleting network ()
2026-04-20 03:14:56,172 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/f0379288-07d7-4ec3-a243-32b25bcb6d06
2026-04-20 03:14:56,182 - DEBUG - Response Code: 404
2026-04-20 03:14:56,182 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:14:56,191 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:14:56,210 - DEBUG - Requesting: http://10.0.0.38:8082/project/d0d30eaa-828a-4670-b08f-dd2a35acb2b2
2026-04-20 03:14:56,307 - INFO - Validated that VN ctest-left_vn-34305014 is not found in API Server
2026-04-20 03:14:56,320 - DEBUG - VN ctest-left_vn-34305014 is not present in Agent 10.0.0.240
2026-04-20 03:14:56,334 - DEBUG - VN ctest-left_vn-34305014 is not present in Agent 10.0.0.65
2026-04-20 03:14:56,334 - INFO - Validated that VN ctest-left_vn-34305014 is not in any agent
2026-04-20 03:14:56,371 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-34305014 info
2026-04-20 03:14:56,372 - INFO - Deleting VN ctest-mgmt_vn-31088329
2026-04-20 03:14:56,570 - DEBUG - Response for deleting network ()
2026-04-20 03:14:56,570 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/7d862eef-6d4a-4d09-bf9c-8d18ccfb680d
2026-04-20 03:14:56,578 - DEBUG - Response Code: 404
2026-04-20 03:14:56,578 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:14:56,582 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:14:56,637 - DEBUG - Requesting: http://10.0.0.38:8082/project/d0d30eaa-828a-4670-b08f-dd2a35acb2b2
2026-04-20 03:14:56,725 - INFO - Validated that VN ctest-mgmt_vn-31088329 is not found in API Server
2026-04-20 03:14:56,737 - DEBUG - VN ctest-mgmt_vn-31088329 is not present in Agent 10.0.0.240
2026-04-20 03:14:56,749 - DEBUG - VN ctest-mgmt_vn-31088329 is not present in Agent 10.0.0.65
2026-04-20 03:14:56,749 - INFO - Validated that VN ctest-mgmt_vn-31088329 is not in any agent
2026-04-20 03:14:56,780 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-31088329 info
2026-04-20 03:14:58,058 - DEBUG - No XMPP flaps were noticed during the test
2026-04-20 03:14:58,058 - INFO -
2026-04-20 03:14:58,058 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:16]
2026-04-20 03:14:58,058 - INFO - --------------------------------------------------------------------------------
2026-04-20 03:14:58,788 - INFO - Deleted project: ctest-TestSvcRegr-24991478, ID : d0d30eaa-828a-4670-b08f-dd2a35acb2b2
2026-04-20 03:14:58,958 - INFO - Domain Default found not creating
2026-04-20 03:14:59,109 - INFO - Project ctest-TestSvcRegr-27720666 not found, creating it
2026-04-20 03:14:59,594 - INFO - Created Project:ctest-TestSvcRegr-27720666, ID : 2f2dff21-9dba-4dcd-a990-89c6c6e82b6c
2026-04-20 03:15:01,050 - INFO - ================================================================================
2026-04-20 03:15:01,050 - INFO - STARTING TEST : test_svc_CEM_22032
2026-04-20 03:15:02,324 - DEBUG - Nothing to compare xmpp stats {'10.0.0.240': {'10.20.0.129': '0', '10.20.0.25': '0'}, '10.0.0.65': {'10.20.0.25': '0', '10.20.0.129': '1'}} with
2026-04-20 03:15:02,324 - INFO - Initial checks done. Running the testcase now
2026-04-20 03:15:02,324 - INFO -
2026-04-20 03:15:03,001 - DEBUG - Response for create_network : {'network': {'id': '54feeac0-8f6b-4ad5-b5a6-6e6133eddb63', 'name': 'ctest-mgmt_vn-28518055', 'tenant_id': '2f2dff219dba4dcda99089c6c6e82b6c', 'project_id': '2f2dff219dba4dcda99089c6c6e82b6c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-27720666', 'ctest-mgmt_vn-28518055'], 'port_security_enabled': True, 'description': ''}}
2026-04-20 03:15:03,362 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c58362e1-7fcf-4273-b77f-c8a49b2f505b', 'name': '', 'tenant_id': '2f2dff219dba4dcda99089c6c6e82b6c', 'network_id': '54feeac0-8f6b-4ad5-b5a6-6e6133eddb63', 'ip_version': 4, 'cidr': '220.105.247.192/26', 'allocation_pools': [{'start': '220.105.247.194', 'end': '220.105.247.254'}], 'gateway_ip': '220.105.247.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '220.105.247.194', 'tags': [], 'project_id': '2f2dff219dba4dcda99089c6c6e82b6c'}}
2026-04-20 03:15:03,388 - INFO - Created VN ctest-mgmt_vn-28518055
2026-04-20 03:15:03,402 - DEBUG - VN ctest-mgmt_vn-28518055 UUID is 54feeac0-8f6b-4ad5-b5a6-6e6133eddb63
2026-04-20 03:15:03,553 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:15:03,851 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:15:03,884 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:15:03,900 - DEBUG - Requesting: http://10.0.0.38:8082/project/2f2dff21-9dba-4dcd-a990-89c6c6e82b6c
2026-04-20 03:15:03,987 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/54feeac0-8f6b-4ad5-b5a6-6e6133eddb63
2026-04-20 03:15:04,000 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/54feeac0-8f6b-4ad5-b5a6-6e6133eddb63
2026-04-20 03:15:04,009 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/d13b38c0-303e-462d-883d-82248653466f
2026-04-20 03:15:04,027 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/d13b38c0-303e-462d-883d-82248653466f
2026-04-20 03:15:04,037 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/f3bd8e72-c1ef-40ba-b5a0-b82f86f70c35
2026-04-20 03:15:04,046 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-20 03:15:04,047 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/54feeac0-8f6b-4ad5-b5a6-6e6133eddb63
2026-04-20 03:15:04,065 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/d13b38c0-303e-462d-883d-82248653466f
2026-04-20 03:15:04,090 - INFO - Verified VN network id 17 for VN 54feeac0-8f6b-4ad5-b5a6-6e6133eddb63
2026-04-20 03:15:04,090 - INFO - Verifications in API Server for VN ctest-mgmt_vn-28518055 passed
2026-04-20 03:15:04,090 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/54feeac0-8f6b-4ad5-b5a6-6e6133eddb63
2026-04-20 03:15:04,102 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/d13b38c0-303e-462d-883d-82248653466f
2026-04-20 03:15:04,111 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/d13b38c0-303e-462d-883d-82248653466f
2026-04-20 03:15:04,120 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/f3bd8e72-c1ef-40ba-b5a0-b82f86f70c35
2026-04-20 03:15:04,132 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-28518055', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27720666', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6124590656031247061', 'uuid-lslong': '13089270730761034595'}, 'enable': 'true', 'created': '2026-04-20T03:15:02', 'last-modified': '2026-04-20T03:15:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.849364'}
2026-04-20 03:15:04,137 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-20 03:15:04,142 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-28518055', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27720666', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6124590656031247061', 'uuid-lslong': '13089270730761034595'}, 'enable': 'true', 'created': '2026-04-20T03:15:02', 'last-modified': '2026-04-20T03:15:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.860338'}
2026-04-20 03:15:04,148 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-20 03:15:04,153 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-28518055', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27720666', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6124590656031247061', 'uuid-lslong': '13089270730761034595'}, 'enable': 'true', 'created': '2026-04-20T03:15:02', 'last-modified': '2026-04-20T03:15:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.868699'}
2026-04-20 03:15:04,158 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-20 03:15:04,158 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-28518055 passed
2026-04-20 03:15:04,158 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-28518055 in API_Server ======
2026-04-20 03:15:04,158 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:15:04,164 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:15:04,175 - DEBUG - Requesting: http://10.0.0.38:8082/project/2f2dff21-9dba-4dcd-a990-89c6c6e82b6c
2026-04-20 03:15:04,306 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/54feeac0-8f6b-4ad5-b5a6-6e6133eddb63
2026-04-20 03:15:04,319 - DEBUG - =>VN ctest-mgmt_vn-28518055 has no policy to be verified
2026-04-20 03:15:04,319 - DEBUG - Verifying the vn in opserver
2026-04-20 03:15:04,319 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-28518055 virtual network link through opserver 10.0.0.38
2026-04-20 03:15:04,319 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-20 03:15:04,614 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-20 03:15:04,686 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-28518055', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-28518055?flat'}
2026-04-20 03:15:04,686 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-28518055 virtual network link through opserver 10.0.0.27
2026-04-20 03:15:04,686 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-04-20 03:15:04,986 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-04-20 03:15:05,063 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-28518055', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-28518055?flat'}
2026-04-20 03:15:05,063 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-28518055 virtual network link through opserver 10.0.0.23
2026-04-20 03:15:05,063 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-04-20 03:15:05,367 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-04-20 03:15:05,425 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-28518055', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-28518055?flat'}
2026-04-20 03:15:05,425 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-28518055 is found in opserver
2026-04-20 03:15:05,446 - DEBUG - Do not have enough data to verify VN in agent
2026-04-20 03:15:05,457 - DEBUG - VRF ids for VN ctest-mgmt_vn-28518055: {}
2026-04-20 03:15:05,755 - DEBUG - Response for create_network : {'network': {'id': '89710a17-e56c-4738-a43b-1295ae24d84f', 'name': 'service-left-vn-72834022', 'tenant_id': '2f2dff219dba4dcda99089c6c6e82b6c', 'project_id': '2f2dff219dba4dcda99089c6c6e82b6c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-27720666', 'service-left-vn-72834022'], 'port_security_enabled': True, 'description': ''}}
2026-04-20 03:15:05,969 - DEBUG - Response for create_subnet : {'subnet': {'id': 'b13608e0-0dbf-4dde-a08f-4798886c1fd2', 'name': '', 'tenant_id': '2f2dff219dba4dcda99089c6c6e82b6c', 'network_id': '89710a17-e56c-4738-a43b-1295ae24d84f', 'ip_version': 4, 'cidr': '119.24.254.192/26', 'allocation_pools': [{'start': '119.24.254.194', 'end': '119.24.254.254'}], 'gateway_ip': '119.24.254.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '119.24.254.194', 'tags': [], 'project_id': '2f2dff219dba4dcda99089c6c6e82b6c'}}
2026-04-20 03:15:05,991 - INFO - Created VN service-left-vn-72834022
2026-04-20 03:15:06,002 - DEBUG - VN service-left-vn-72834022 UUID is 89710a17-e56c-4738-a43b-1295ae24d84f
2026-04-20 03:15:06,078 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:15:06,085 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:15:06,098 - DEBUG - Requesting: http://10.0.0.38:8082/project/2f2dff21-9dba-4dcd-a990-89c6c6e82b6c
2026-04-20 03:15:06,189 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/89710a17-e56c-4738-a43b-1295ae24d84f
2026-04-20 03:15:06,200 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/89710a17-e56c-4738-a43b-1295ae24d84f
2026-04-20 03:15:06,208 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/8d4091b2-e2e9-4a8c-9cc8-14fc24012bfa
2026-04-20 03:15:06,215 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/8d4091b2-e2e9-4a8c-9cc8-14fc24012bfa
2026-04-20 03:15:06,221 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/c0aa4865-7c32-40dc-a2a2-56b5623e4857
2026-04-20 03:15:06,228 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-20 03:15:06,228 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/89710a17-e56c-4738-a43b-1295ae24d84f
2026-04-20 03:15:06,239 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/8d4091b2-e2e9-4a8c-9cc8-14fc24012bfa
2026-04-20 03:15:06,255 - INFO - Verified VN network id 18 for VN 89710a17-e56c-4738-a43b-1295ae24d84f
2026-04-20 03:15:06,255 - INFO - Verifications in API Server for VN service-left-vn-72834022 passed
2026-04-20 03:15:06,255 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/89710a17-e56c-4738-a43b-1295ae24d84f
2026-04-20 03:15:06,265 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/8d4091b2-e2e9-4a8c-9cc8-14fc24012bfa
2026-04-20 03:15:06,273 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/8d4091b2-e2e9-4a8c-9cc8-14fc24012bfa
2026-04-20 03:15:06,283 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/c0aa4865-7c32-40dc-a2a2-56b5623e4857
2026-04-20 03:15:06,295 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27720666:service-left-vn-72834022', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27720666', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9903708153314035512', 'uuid-lslong': '11834072879927187535'}, 'enable': 'true', 'created': '2026-04-20T03:15:05', 'last-modified': '2026-04-20T03:15:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.383678'}
2026-04-20 03:15:06,301 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-20 03:15:06,307 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27720666:service-left-vn-72834022', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27720666', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9903708153314035512', 'uuid-lslong': '11834072879927187535'}, 'enable': 'true', 'created': '2026-04-20T03:15:05', 'last-modified': '2026-04-20T03:15:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.397589'}
2026-04-20 03:15:06,312 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-20 03:15:06,317 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27720666:service-left-vn-72834022', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27720666', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9903708153314035512', 'uuid-lslong': '11834072879927187535'}, 'enable': 'true', 'created': '2026-04-20T03:15:05', 'last-modified': '2026-04-20T03:15:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.406615'}
2026-04-20 03:15:06,323 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-20 03:15:06,323 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-72834022 passed
2026-04-20 03:15:06,323 - DEBUG - ====Verifying policy data for service-left-vn-72834022 in API_Server ======
2026-04-20 03:15:06,323 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:15:06,329 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:15:06,339 - DEBUG - Requesting: http://10.0.0.38:8082/project/2f2dff21-9dba-4dcd-a990-89c6c6e82b6c
2026-04-20 03:15:06,433 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/89710a17-e56c-4738-a43b-1295ae24d84f
2026-04-20 03:15:06,441 - DEBUG - =>VN service-left-vn-72834022 has no policy to be verified
2026-04-20 03:15:06,442 - DEBUG - Verifying the vn in opserver
2026-04-20 03:15:06,442 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27720666:service-left-vn-72834022 virtual network link through opserver 10.0.0.38
2026-04-20 03:15:06,442 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-20 03:15:06,501 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27720666:service-left-vn-72834022', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27720666:service-left-vn-72834022?flat'}
2026-04-20 03:15:06,501 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27720666:service-left-vn-72834022 virtual network link through opserver 10.0.0.27
2026-04-20 03:15:06,501 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-04-20 03:15:06,555 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27720666:service-left-vn-72834022', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27720666:service-left-vn-72834022?flat'}
2026-04-20 03:15:06,555 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27720666:service-left-vn-72834022 virtual network link through opserver 10.0.0.23
2026-04-20 03:15:06,555 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-04-20 03:15:06,617 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27720666:service-left-vn-72834022', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27720666:service-left-vn-72834022?flat'}
2026-04-20 03:15:06,617 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-27720666:service-left-vn-72834022 is found in opserver
2026-04-20 03:15:06,641 - DEBUG - Do not have enough data to verify VN in agent
2026-04-20 03:15:06,655 - DEBUG - VRF ids for VN service-left-vn-72834022: {}
2026-04-20 03:15:06,940 - DEBUG - Response for create_network : {'network': {'id': '2d5233b3-1b6f-41ca-a561-e7931dc233df', 'name': 'service-right-vn-23183347', 'tenant_id': '2f2dff219dba4dcda99089c6c6e82b6c', 'project_id': '2f2dff219dba4dcda99089c6c6e82b6c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-27720666', 'service-right-vn-23183347'], 'port_security_enabled': True, 'description': ''}}
2026-04-20 03:15:07,176 - DEBUG - Response for create_subnet : {'subnet': {'id': '00acba5c-6c25-4122-b963-6df506ee9ba9', 'name': '', 'tenant_id': '2f2dff219dba4dcda99089c6c6e82b6c', 'network_id': '2d5233b3-1b6f-41ca-a561-e7931dc233df', 'ip_version': 4, 'cidr': '199.42.117.192/26', 'allocation_pools': [{'start': '199.42.117.194', 'end': '199.42.117.254'}], 'gateway_ip': '199.42.117.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '199.42.117.194', 'tags': [], 'project_id': '2f2dff219dba4dcda99089c6c6e82b6c'}}
2026-04-20 03:15:07,201 - INFO - Created VN service-right-vn-23183347
2026-04-20 03:15:07,211 - DEBUG - VN service-right-vn-23183347 UUID is 2d5233b3-1b6f-41ca-a561-e7931dc233df
2026-04-20 03:15:07,294 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:15:07,300 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:15:07,312 - DEBUG - Requesting: http://10.0.0.38:8082/project/2f2dff21-9dba-4dcd-a990-89c6c6e82b6c
2026-04-20 03:15:07,414 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/2d5233b3-1b6f-41ca-a561-e7931dc233df
2026-04-20 03:15:07,428 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/2d5233b3-1b6f-41ca-a561-e7931dc233df
2026-04-20 03:15:07,437 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/da1c5fc1-b291-4ffa-9533-65e0e9191502
2026-04-20 03:15:07,447 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/da1c5fc1-b291-4ffa-9533-65e0e9191502
2026-04-20 03:15:07,456 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/e328cb65-b081-4e16-9ae3-26fea8169835
2026-04-20 03:15:07,472 - DEBUG - Route Targets: ['target:64512:8000009']
2026-04-20 03:15:07,472 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/2d5233b3-1b6f-41ca-a561-e7931dc233df
2026-04-20 03:15:07,483 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/da1c5fc1-b291-4ffa-9533-65e0e9191502
2026-04-20 03:15:07,500 - INFO - Verified VN network id 19 for VN 2d5233b3-1b6f-41ca-a561-e7931dc233df
2026-04-20 03:15:07,500 - INFO - Verifications in API Server for VN service-right-vn-23183347 passed
2026-04-20 03:15:07,500 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/2d5233b3-1b6f-41ca-a561-e7931dc233df
2026-04-20 03:15:07,511 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/da1c5fc1-b291-4ffa-9533-65e0e9191502
2026-04-20 03:15:07,521 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/da1c5fc1-b291-4ffa-9533-65e0e9191502
2026-04-20 03:15:07,531 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/e328cb65-b081-4e16-9ae3-26fea8169835
2026-04-20 03:15:07,550 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27720666:service-right-vn-23183347', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27720666', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3265729524149469642', 'uuid-lslong': '11917060708044518367'}, 'enable': 'true', 'created': '2026-04-20T03:15:06', 'last-modified': '2026-04-20T03:15:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.431249'}
2026-04-20 03:15:07,558 - DEBUG - Route Targets: ['target:64512:8000009']
2026-04-20 03:15:07,563 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27720666:service-right-vn-23183347', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27720666', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3265729524149469642', 'uuid-lslong': '11917060708044518367'}, 'enable': 'true', 'created': '2026-04-20T03:15:06', 'last-modified': '2026-04-20T03:15:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.441058'}
2026-04-20 03:15:07,571 - DEBUG - Route Targets: ['target:64512:8000009']
2026-04-20 03:15:07,576 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27720666:service-right-vn-23183347', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27720666', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3265729524149469642', 'uuid-lslong': '11917060708044518367'}, 'enable': 'true', 'created': '2026-04-20T03:15:06', 'last-modified': '2026-04-20T03:15:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.454147'}
2026-04-20 03:15:07,585 - DEBUG - Route Targets: ['target:64512:8000009']
2026-04-20 03:15:07,585 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-23183347 passed
2026-04-20 03:15:07,586 - DEBUG - ====Verifying policy data for service-right-vn-23183347 in API_Server ======
2026-04-20 03:15:07,586 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:15:07,594 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:15:07,609 - DEBUG - Requesting: http://10.0.0.38:8082/project/2f2dff21-9dba-4dcd-a990-89c6c6e82b6c
2026-04-20 03:15:07,693 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/2d5233b3-1b6f-41ca-a561-e7931dc233df
2026-04-20 03:15:07,710 - DEBUG - =>VN service-right-vn-23183347 has no policy to be verified
2026-04-20 03:15:07,710 - DEBUG - Verifying the vn in opserver
2026-04-20 03:15:07,710 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27720666:service-right-vn-23183347 virtual network link through opserver 10.0.0.38
2026-04-20 03:15:07,710 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-20 03:15:07,801 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27720666:service-right-vn-23183347', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27720666:service-right-vn-23183347?flat'}
2026-04-20 03:15:07,801 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27720666:service-right-vn-23183347 virtual network link through opserver 10.0.0.27
2026-04-20 03:15:07,801 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-04-20 03:15:07,878 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27720666:service-right-vn-23183347', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27720666:service-right-vn-23183347?flat'}
2026-04-20 03:15:07,879 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27720666:service-right-vn-23183347 virtual network link through opserver 10.0.0.23
2026-04-20 03:15:07,879 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-04-20 03:15:07,955 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27720666:service-right-vn-23183347', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27720666:service-right-vn-23183347?flat'}
2026-04-20 03:15:07,955 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-27720666:service-right-vn-23183347 is found in opserver
2026-04-20 03:15:07,982 - DEBUG - Do not have enough data to verify VN in agent
2026-04-20 03:15:07,995 - DEBUG - VRF ids for VN service-right-vn-23183347: {}
2026-04-20 03:15:08,151 - DEBUG - Services list from nova: [, , , ]
2026-04-20 03:15:09,222 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5644-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5644-2)
2026-04-20 03:15:10,694 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5644-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5644-1)
2026-04-20 03:15:10,694 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-01850121']
2026-04-20 03:15:10,982 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-01850121'] created succesfully
2026-04-20 03:15:11,367 - DEBUG - Image by name tiny_nat_fw not found
2026-04-20 03:15:11,367 - DEBUG - Installing image tiny_nat_fw
2026-04-20 03:15:11,367 - 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-04-20 03:15:11,367 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-04-20 03:15:11,368 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-04-20 03:15:11,368 - DEBUG - Unzip image
2026-04-20 03:15:11,368 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-04-20 03:15:11,385 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-04-20 03:15:11,386 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-01850121']
2026-04-20 03:15:11,472 - INFO - Service template: ['default-domain', 'ctest-service_template_1-01850121'] deleted successfully.
2026-04-20 03:15:11,472 - INFO - Skip interface_detach for VM ctest-right_vm-01929544 in state BUILD
2026-04-20 03:15:11,472 - INFO - Deleting VM ctest-right_vm-01929544
2026-04-20 03:15:11,524 - ERROR - VM ctest-right_vm-01929544 has failed to come up
2026-04-20 03:15:11,524 - ERROR - Nova failed to get host of the VM
2026-04-20 03:15:11,524 - ERROR - VM ctest-right_vm-01929544 has failed to come up
2026-04-20 03:15:11,524 - ERROR - Nova failed to get host of the VM
2026-04-20 03:15:11,593 - INFO - Skip interface_detach for VM ctest-left_vm-30181550 in state BUILD
2026-04-20 03:15:11,594 - INFO - Deleting VM ctest-left_vm-30181550
2026-04-20 03:15:11,594 - ERROR - VM ctest-left_vm-30181550 has failed to come up
2026-04-20 03:15:11,594 - ERROR - Nova failed to get host of the VM
2026-04-20 03:15:11,594 - ERROR - VM ctest-left_vm-30181550 has failed to come up
2026-04-20 03:15:11,596 - ERROR - Nova failed to get host of the VM
2026-04-20 03:15:11,676 - INFO - Deleting VN service-right-vn-23183347
2026-04-20 03:15:11,717 - DEBUG - VN 2d5233b3-1b6f-41ca-a561-e7931dc233df still in use: Unable to complete operation on network 2d5233b3-1b6f-41ca-a561-e7931dc233df. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-9e7e00c4-6c69-4d8c-818f-0af5c93e1834']
2026-04-20 03:15:11,717 - WARNING - Deleting VN service-right-vn-23183347 failed..Will retry
2026-04-20 03:15:13,933 - DEBUG - Response for deleting network ()
2026-04-20 03:15:13,934 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/da1c5fc1-b291-4ffa-9533-65e0e9191502
2026-04-20 03:15:13,940 - DEBUG - Response Code: 404
2026-04-20 03:15:13,940 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:15:13,949 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:15:13,962 - DEBUG - Requesting: http://10.0.0.38:8082/project/2f2dff21-9dba-4dcd-a990-89c6c6e82b6c
2026-04-20 03:15:14,058 - INFO - Validated that VN service-right-vn-23183347 is not found in API Server
2026-04-20 03:15:14,074 - DEBUG - VN service-right-vn-23183347 is not present in Agent 10.0.0.240
2026-04-20 03:15:14,084 - DEBUG - VN service-right-vn-23183347 is not present in Agent 10.0.0.65
2026-04-20 03:15:14,084 - INFO - Validated that VN service-right-vn-23183347 is not in any agent
2026-04-20 03:15:14,117 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-23183347 info
2026-04-20 03:15:14,117 - INFO - Deleting VN service-left-vn-72834022
2026-04-20 03:15:14,297 - DEBUG - Response for deleting network ()
2026-04-20 03:15:14,297 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/8d4091b2-e2e9-4a8c-9cc8-14fc24012bfa
2026-04-20 03:15:14,307 - DEBUG - Response Code: 404
2026-04-20 03:15:14,307 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:15:14,317 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:15:14,336 - DEBUG - Requesting: http://10.0.0.38:8082/project/2f2dff21-9dba-4dcd-a990-89c6c6e82b6c
2026-04-20 03:15:14,426 - INFO - Validated that VN service-left-vn-72834022 is not found in API Server
2026-04-20 03:15:14,436 - DEBUG - VN service-left-vn-72834022 is not present in Agent 10.0.0.240
2026-04-20 03:15:14,445 - DEBUG - VN service-left-vn-72834022 is not present in Agent 10.0.0.65
2026-04-20 03:15:14,445 - INFO - Validated that VN service-left-vn-72834022 is not in any agent
2026-04-20 03:15:14,473 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-72834022 info
2026-04-20 03:15:14,474 - INFO - Deleting VN ctest-mgmt_vn-28518055
2026-04-20 03:15:14,635 - DEBUG - Response for deleting network ()
2026-04-20 03:15:14,635 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/d13b38c0-303e-462d-883d-82248653466f
2026-04-20 03:15:14,647 - DEBUG - Response Code: 404
2026-04-20 03:15:14,647 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:15:14,653 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:15:14,705 - DEBUG - Requesting: http://10.0.0.38:8082/project/2f2dff21-9dba-4dcd-a990-89c6c6e82b6c
2026-04-20 03:15:14,790 - INFO - Validated that VN ctest-mgmt_vn-28518055 is not found in API Server
2026-04-20 03:15:14,802 - DEBUG - VN ctest-mgmt_vn-28518055 is not present in Agent 10.0.0.240
2026-04-20 03:15:14,811 - DEBUG - VN ctest-mgmt_vn-28518055 is not present in Agent 10.0.0.65
2026-04-20 03:15:14,811 - INFO - Validated that VN ctest-mgmt_vn-28518055 is not in any agent
2026-04-20 03:15:14,840 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-28518055 info
2026-04-20 03:15:16,120 - DEBUG - No XMPP flaps were noticed during the test
2026-04-20 03:15:16,120 - INFO -
2026-04-20 03:15:16,120 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:15]
2026-04-20 03:15:16,121 - INFO - --------------------------------------------------------------------------------
2026-04-20 03:15:16,124 - INFO - ================================================================================
2026-04-20 03:15:16,124 - INFO - STARTING TEST : test_svc_in_network_datapath
2026-04-20 03:15:17,413 - DEBUG - Nothing to compare xmpp stats {'10.0.0.240': {'10.20.0.129': '0', '10.20.0.25': '0'}, '10.0.0.65': {'10.20.0.25': '0', '10.20.0.129': '1'}} with
2026-04-20 03:15:17,413 - INFO - Initial checks done. Running the testcase now
2026-04-20 03:15:17,413 - INFO -
2026-04-20 03:15:17,668 - DEBUG - Response for create_network : {'network': {'id': '77879c73-cd19-4812-b2de-2c76016ff7ab', 'name': 'ctest-mgmt_vn-05603431', 'tenant_id': '2f2dff219dba4dcda99089c6c6e82b6c', 'project_id': '2f2dff219dba4dcda99089c6c6e82b6c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-27720666', 'ctest-mgmt_vn-05603431'], 'port_security_enabled': True, 'description': ''}}
2026-04-20 03:15:17,929 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f50a3378-89f7-4ebf-be11-9a60091467e2', 'name': '', 'tenant_id': '2f2dff219dba4dcda99089c6c6e82b6c', 'network_id': '77879c73-cd19-4812-b2de-2c76016ff7ab', 'ip_version': 4, 'cidr': '197.160.221.0/26', 'allocation_pools': [{'start': '197.160.221.2', 'end': '197.160.221.62'}], 'gateway_ip': '197.160.221.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '197.160.221.2', 'tags': [], 'project_id': '2f2dff219dba4dcda99089c6c6e82b6c'}}
2026-04-20 03:15:17,953 - INFO - Created VN ctest-mgmt_vn-05603431
2026-04-20 03:15:17,969 - DEBUG - VN ctest-mgmt_vn-05603431 UUID is 77879c73-cd19-4812-b2de-2c76016ff7ab
2026-04-20 03:15:18,060 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:15:18,069 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:15:18,084 - DEBUG - Requesting: http://10.0.0.38:8082/project/2f2dff21-9dba-4dcd-a990-89c6c6e82b6c
2026-04-20 03:15:18,204 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/77879c73-cd19-4812-b2de-2c76016ff7ab
2026-04-20 03:15:18,220 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/77879c73-cd19-4812-b2de-2c76016ff7ab
2026-04-20 03:15:18,232 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/bf0da44b-7985-4ab2-90ae-0b2bf9a7b754
2026-04-20 03:15:18,254 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/bf0da44b-7985-4ab2-90ae-0b2bf9a7b754
2026-04-20 03:15:18,263 - DEBUG - Route Targets: []
2026-04-20 03:15:18,264 - DEBUG - RT names not yet present for VN ctest-mgmt_vn-05603431
2026-04-20 03:15:23,264 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:15:23,272 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:15:23,288 - DEBUG - Requesting: http://10.0.0.38:8082/project/2f2dff21-9dba-4dcd-a990-89c6c6e82b6c
2026-04-20 03:15:23,386 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/77879c73-cd19-4812-b2de-2c76016ff7ab
2026-04-20 03:15:23,397 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/77879c73-cd19-4812-b2de-2c76016ff7ab
2026-04-20 03:15:23,409 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/bf0da44b-7985-4ab2-90ae-0b2bf9a7b754
2026-04-20 03:15:23,422 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/bf0da44b-7985-4ab2-90ae-0b2bf9a7b754
2026-04-20 03:15:23,431 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/f67de67d-917f-4004-aff0-fe485499e010
2026-04-20 03:15:23,439 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-20 03:15:23,439 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/77879c73-cd19-4812-b2de-2c76016ff7ab
2026-04-20 03:15:23,449 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/bf0da44b-7985-4ab2-90ae-0b2bf9a7b754
2026-04-20 03:15:23,464 - INFO - Verified VN network id 17 for VN 77879c73-cd19-4812-b2de-2c76016ff7ab
2026-04-20 03:15:23,465 - INFO - Verifications in API Server for VN ctest-mgmt_vn-05603431 passed
2026-04-20 03:15:23,465 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/77879c73-cd19-4812-b2de-2c76016ff7ab
2026-04-20 03:15:23,475 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/bf0da44b-7985-4ab2-90ae-0b2bf9a7b754
2026-04-20 03:15:23,482 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/bf0da44b-7985-4ab2-90ae-0b2bf9a7b754
2026-04-20 03:15:23,490 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/f67de67d-917f-4004-aff0-fe485499e010
2026-04-20 03:15:23,501 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-05603431', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27720666', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8613024833545521170', 'uuid-lslong': '12888788068922816427'}, 'enable': 'true', 'created': '2026-04-20T03:15:17', 'last-modified': '2026-04-20T03:15:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.622873'}
2026-04-20 03:15:23,506 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-20 03:15:23,511 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-05603431', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27720666', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8613024833545521170', 'uuid-lslong': '12888788068922816427'}, 'enable': 'true', 'created': '2026-04-20T03:15:17', 'last-modified': '2026-04-20T03:15:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.631460'}
2026-04-20 03:15:23,518 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-20 03:15:23,524 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-05603431', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27720666', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8613024833545521170', 'uuid-lslong': '12888788068922816427'}, 'enable': 'true', 'created': '2026-04-20T03:15:17', 'last-modified': '2026-04-20T03:15:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.644232'}
2026-04-20 03:15:23,530 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-20 03:15:23,530 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-05603431 passed
2026-04-20 03:15:23,530 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-05603431 in API_Server ======
2026-04-20 03:15:23,531 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:15:23,537 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:15:23,551 - DEBUG - Requesting: http://10.0.0.38:8082/project/2f2dff21-9dba-4dcd-a990-89c6c6e82b6c
2026-04-20 03:15:23,641 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/77879c73-cd19-4812-b2de-2c76016ff7ab
2026-04-20 03:15:23,650 - DEBUG - =>VN ctest-mgmt_vn-05603431 has no policy to be verified
2026-04-20 03:15:23,650 - DEBUG - Verifying the vn in opserver
2026-04-20 03:15:23,650 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-05603431 virtual network link through opserver 10.0.0.38
2026-04-20 03:15:23,650 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-20 03:15:23,662 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-05603431', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-05603431?flat'}
2026-04-20 03:15:23,662 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-05603431 virtual network link through opserver 10.0.0.27
2026-04-20 03:15:23,662 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-04-20 03:15:23,675 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-05603431', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-05603431?flat'}
2026-04-20 03:15:23,675 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-05603431 virtual network link through opserver 10.0.0.23
2026-04-20 03:15:23,675 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-04-20 03:15:23,686 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-05603431', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-05603431?flat'}
2026-04-20 03:15:23,686 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-27720666:ctest-mgmt_vn-05603431 is found in opserver
2026-04-20 03:15:23,708 - DEBUG - Do not have enough data to verify VN in agent
2026-04-20 03:15:23,719 - DEBUG - VRF ids for VN ctest-mgmt_vn-05603431: {}
2026-04-20 03:15:23,955 - DEBUG - Response for create_network : {'network': {'id': 'e375e09e-d7a5-4d80-8ce2-3407fac5bc84', 'name': 'ctest-left_vn-90025065', 'tenant_id': '2f2dff219dba4dcda99089c6c6e82b6c', 'project_id': '2f2dff219dba4dcda99089c6c6e82b6c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-27720666', 'ctest-left_vn-90025065'], 'port_security_enabled': True, 'description': ''}}
2026-04-20 03:15:24,154 - DEBUG - Response for create_subnet : {'subnet': {'id': '79ee4d2f-fd5e-4bf0-960b-b3c8649e6370', 'name': '', 'tenant_id': '2f2dff219dba4dcda99089c6c6e82b6c', 'network_id': 'e375e09e-d7a5-4d80-8ce2-3407fac5bc84', 'ip_version': 4, 'cidr': '90.228.153.0/26', 'allocation_pools': [{'start': '90.228.153.2', 'end': '90.228.153.62'}], 'gateway_ip': '90.228.153.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '90.228.153.2', 'tags': [], 'project_id': '2f2dff219dba4dcda99089c6c6e82b6c'}}
2026-04-20 03:15:24,176 - INFO - Created VN ctest-left_vn-90025065
2026-04-20 03:15:24,186 - DEBUG - VN ctest-left_vn-90025065 UUID is e375e09e-d7a5-4d80-8ce2-3407fac5bc84
2026-04-20 03:15:24,256 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:15:24,263 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:15:24,283 - DEBUG - Requesting: http://10.0.0.38:8082/project/2f2dff21-9dba-4dcd-a990-89c6c6e82b6c
2026-04-20 03:15:24,367 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/e375e09e-d7a5-4d80-8ce2-3407fac5bc84
2026-04-20 03:15:24,380 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/e375e09e-d7a5-4d80-8ce2-3407fac5bc84
2026-04-20 03:15:24,389 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/7c2061c0-3e02-44e3-aa62-4ae2e4a1f64a
2026-04-20 03:15:24,397 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/7c2061c0-3e02-44e3-aa62-4ae2e4a1f64a
2026-04-20 03:15:24,403 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/b3c4922d-e20d-449d-9f09-2831ff4cdea1
2026-04-20 03:15:24,408 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-20 03:15:24,408 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/e375e09e-d7a5-4d80-8ce2-3407fac5bc84
2026-04-20 03:15:24,416 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/7c2061c0-3e02-44e3-aa62-4ae2e4a1f64a
2026-04-20 03:15:24,430 - INFO - Verified VN network id 18 for VN e375e09e-d7a5-4d80-8ce2-3407fac5bc84
2026-04-20 03:15:24,430 - INFO - Verifications in API Server for VN ctest-left_vn-90025065 passed
2026-04-20 03:15:24,430 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/e375e09e-d7a5-4d80-8ce2-3407fac5bc84
2026-04-20 03:15:24,438 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/7c2061c0-3e02-44e3-aa62-4ae2e4a1f64a
2026-04-20 03:15:24,444 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/7c2061c0-3e02-44e3-aa62-4ae2e4a1f64a
2026-04-20 03:15:24,450 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/b3c4922d-e20d-449d-9f09-2831ff4cdea1
2026-04-20 03:15:24,460 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27720666:ctest-left_vn-90025065', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27720666', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16390253391712177536', 'uuid-lslong': '10151733718923197572'}, 'enable': 'true', 'created': '2026-04-20T03:15:23', 'last-modified': '2026-04-20T03:15:24', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.358456'}
2026-04-20 03:15:24,465 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-20 03:15:24,470 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27720666:ctest-left_vn-90025065', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27720666', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16390253391712177536', 'uuid-lslong': '10151733718923197572'}, 'enable': 'true', 'created': '2026-04-20T03:15:23', 'last-modified': '2026-04-20T03:15:24', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.368210'}
2026-04-20 03:15:24,475 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-20 03:15:24,480 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27720666:ctest-left_vn-90025065', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27720666', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16390253391712177536', 'uuid-lslong': '10151733718923197572'}, 'enable': 'true', 'created': '2026-04-20T03:15:23', 'last-modified': '2026-04-20T03:15:24', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.373507'}
2026-04-20 03:15:24,485 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-20 03:15:24,485 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-90025065 passed
2026-04-20 03:15:24,486 - DEBUG - ====Verifying policy data for ctest-left_vn-90025065 in API_Server ======
2026-04-20 03:15:24,486 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:15:24,492 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:15:24,505 - DEBUG - Requesting: http://10.0.0.38:8082/project/2f2dff21-9dba-4dcd-a990-89c6c6e82b6c
2026-04-20 03:15:24,598 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/e375e09e-d7a5-4d80-8ce2-3407fac5bc84
2026-04-20 03:15:24,610 - DEBUG - =>VN ctest-left_vn-90025065 has no policy to be verified
2026-04-20 03:15:24,611 - DEBUG - Verifying the vn in opserver
2026-04-20 03:15:24,611 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27720666:ctest-left_vn-90025065 virtual network link through opserver 10.0.0.38
2026-04-20 03:15:24,611 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-20 03:15:24,624 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27720666:ctest-left_vn-90025065', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27720666:ctest-left_vn-90025065?flat'}
2026-04-20 03:15:24,625 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27720666:ctest-left_vn-90025065 virtual network link through opserver 10.0.0.27
2026-04-20 03:15:24,625 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-04-20 03:15:24,640 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27720666:ctest-left_vn-90025065', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27720666:ctest-left_vn-90025065?flat'}
2026-04-20 03:15:24,640 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27720666:ctest-left_vn-90025065 virtual network link through opserver 10.0.0.23
2026-04-20 03:15:24,640 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-04-20 03:15:24,651 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27720666:ctest-left_vn-90025065', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27720666:ctest-left_vn-90025065?flat'}
2026-04-20 03:15:24,651 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-27720666:ctest-left_vn-90025065 is found in opserver
2026-04-20 03:15:24,676 - DEBUG - Do not have enough data to verify VN in agent
2026-04-20 03:15:24,688 - DEBUG - VRF ids for VN ctest-left_vn-90025065: {}
2026-04-20 03:15:24,960 - DEBUG - Response for create_network : {'network': {'id': '4db2c9c6-1c97-4a4b-8d1c-7434b1ae4b73', 'name': 'ctest-right_vn-30119572', 'tenant_id': '2f2dff219dba4dcda99089c6c6e82b6c', 'project_id': '2f2dff219dba4dcda99089c6c6e82b6c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-27720666', 'ctest-right_vn-30119572'], 'port_security_enabled': True, 'description': ''}}
2026-04-20 03:15:25,187 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd3fbd37c-cbdb-41c4-9d3c-09749f70c403', 'name': '', 'tenant_id': '2f2dff219dba4dcda99089c6c6e82b6c', 'network_id': '4db2c9c6-1c97-4a4b-8d1c-7434b1ae4b73', 'ip_version': 4, 'cidr': '91.187.127.192/26', 'allocation_pools': [{'start': '91.187.127.194', 'end': '91.187.127.254'}], 'gateway_ip': '91.187.127.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '91.187.127.194', 'tags': [], 'project_id': '2f2dff219dba4dcda99089c6c6e82b6c'}}
2026-04-20 03:15:25,209 - INFO - Created VN ctest-right_vn-30119572
2026-04-20 03:15:25,219 - DEBUG - VN ctest-right_vn-30119572 UUID is 4db2c9c6-1c97-4a4b-8d1c-7434b1ae4b73
2026-04-20 03:15:25,284 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:15:25,290 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:15:25,299 - DEBUG - Requesting: http://10.0.0.38:8082/project/2f2dff21-9dba-4dcd-a990-89c6c6e82b6c
2026-04-20 03:15:25,393 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/4db2c9c6-1c97-4a4b-8d1c-7434b1ae4b73
2026-04-20 03:15:25,405 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/4db2c9c6-1c97-4a4b-8d1c-7434b1ae4b73
2026-04-20 03:15:25,414 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/74cd37fc-7e1d-40ea-9ace-002ad13fa6ea
2026-04-20 03:15:25,423 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/74cd37fc-7e1d-40ea-9ace-002ad13fa6ea
2026-04-20 03:15:25,430 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/d69c0235-7f49-4fbf-acdd-a738cfad5f7f
2026-04-20 03:15:25,437 - DEBUG - Route Targets: ['target:64512:8000009']
2026-04-20 03:15:25,437 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/4db2c9c6-1c97-4a4b-8d1c-7434b1ae4b73
2026-04-20 03:15:25,444 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/74cd37fc-7e1d-40ea-9ace-002ad13fa6ea
2026-04-20 03:15:25,457 - INFO - Verified VN network id 19 for VN 4db2c9c6-1c97-4a4b-8d1c-7434b1ae4b73
2026-04-20 03:15:25,457 - INFO - Verifications in API Server for VN ctest-right_vn-30119572 passed
2026-04-20 03:15:25,457 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/4db2c9c6-1c97-4a4b-8d1c-7434b1ae4b73
2026-04-20 03:15:25,468 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/74cd37fc-7e1d-40ea-9ace-002ad13fa6ea
2026-04-20 03:15:25,476 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/74cd37fc-7e1d-40ea-9ace-002ad13fa6ea
2026-04-20 03:15:25,484 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/d69c0235-7f49-4fbf-acdd-a738cfad5f7f
2026-04-20 03:15:25,495 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27720666:ctest-right_vn-30119572', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27720666', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5598759139495332427', 'uuid-lslong': '10168129828363848563'}, 'enable': 'true', 'created': '2026-04-20T03:15:24', 'last-modified': '2026-04-20T03:15:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.349545'}
2026-04-20 03:15:25,501 - DEBUG - Route Targets: ['target:64512:8000009']
2026-04-20 03:15:25,509 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27720666:ctest-right_vn-30119572', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27720666', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5598759139495332427', 'uuid-lslong': '10168129828363848563'}, 'enable': 'true', 'created': '2026-04-20T03:15:24', 'last-modified': '2026-04-20T03:15:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.365462'}
2026-04-20 03:15:25,516 - DEBUG - Route Targets: ['target:64512:8000009']
2026-04-20 03:15:25,520 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27720666:ctest-right_vn-30119572', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27720666', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5598759139495332427', 'uuid-lslong': '10168129828363848563'}, 'enable': 'true', 'created': '2026-04-20T03:15:24', 'last-modified': '2026-04-20T03:15:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.377099'}
2026-04-20 03:15:25,525 - DEBUG - Route Targets: ['target:64512:8000009']
2026-04-20 03:15:25,525 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-30119572 passed
2026-04-20 03:15:25,525 - DEBUG - ====Verifying policy data for ctest-right_vn-30119572 in API_Server ======
2026-04-20 03:15:25,525 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:15:25,532 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:15:25,543 - DEBUG - Requesting: http://10.0.0.38:8082/project/2f2dff21-9dba-4dcd-a990-89c6c6e82b6c
2026-04-20 03:15:25,638 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/4db2c9c6-1c97-4a4b-8d1c-7434b1ae4b73
2026-04-20 03:15:25,647 - DEBUG - =>VN ctest-right_vn-30119572 has no policy to be verified
2026-04-20 03:15:25,647 - DEBUG - Verifying the vn in opserver
2026-04-20 03:15:25,647 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27720666:ctest-right_vn-30119572 virtual network link through opserver 10.0.0.38
2026-04-20 03:15:25,647 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-20 03:15:25,661 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27720666:ctest-right_vn-30119572', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27720666:ctest-right_vn-30119572?flat'}
2026-04-20 03:15:25,661 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27720666:ctest-right_vn-30119572 virtual network link through opserver 10.0.0.27
2026-04-20 03:15:25,661 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-04-20 03:15:25,675 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27720666:ctest-right_vn-30119572', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27720666:ctest-right_vn-30119572?flat'}
2026-04-20 03:15:25,675 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27720666:ctest-right_vn-30119572 virtual network link through opserver 10.0.0.23
2026-04-20 03:15:25,675 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-04-20 03:15:25,688 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27720666:ctest-right_vn-30119572', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27720666:ctest-right_vn-30119572?flat'}
2026-04-20 03:15:25,688 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-27720666:ctest-right_vn-30119572 is found in opserver
2026-04-20 03:15:25,711 - DEBUG - Do not have enough data to verify VN in agent
2026-04-20 03:15:25,721 - DEBUG - VRF ids for VN ctest-right_vn-30119572: {}
2026-04-20 03:15:26,926 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5644-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5644-1)
2026-04-20 03:15:28,430 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5644-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5644-2)
2026-04-20 03:15:28,430 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-11317240']
2026-04-20 03:15:28,717 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-11317240'] created succesfully
2026-04-20 03:15:29,220 - DEBUG - Image by name tiny_nat_fw not found
2026-04-20 03:15:29,220 - DEBUG - Installing image tiny_nat_fw
2026-04-20 03:15:29,220 - 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-04-20 03:15:29,220 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-04-20 03:15:29,221 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-04-20 03:15:29,221 - DEBUG - Unzip image
2026-04-20 03:15:29,221 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-04-20 03:15:29,245 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-04-20 03:15:29,245 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-11317240']
2026-04-20 03:15:29,360 - INFO - Service template: ['default-domain', 'ctest-service_template_1-11317240'] deleted successfully.
2026-04-20 03:15:29,360 - INFO - Skip interface_detach for VM ctest-right_vm-67157973 in state BUILD
2026-04-20 03:15:29,361 - INFO - Deleting VM ctest-right_vm-67157973
2026-04-20 03:15:29,361 - ERROR - VM ctest-right_vm-67157973 has failed to come up
2026-04-20 03:15:29,361 - ERROR - Nova failed to get host of the VM
2026-04-20 03:15:29,361 - ERROR - VM ctest-right_vm-67157973 has failed to come up
2026-04-20 03:15:29,362 - ERROR - Nova failed to get host of the VM
2026-04-20 03:15:29,434 - INFO - Skip interface_detach for VM ctest-left_vm-56296005 in state BUILD
2026-04-20 03:15:29,434 - INFO - Deleting VM ctest-left_vm-56296005
2026-04-20 03:15:29,434 - ERROR - VM ctest-left_vm-56296005 has failed to come up
2026-04-20 03:15:29,434 - ERROR - Nova failed to get host of the VM
2026-04-20 03:15:29,434 - ERROR - VM ctest-left_vm-56296005 has failed to come up
2026-04-20 03:15:29,435 - ERROR - Nova failed to get host of the VM
2026-04-20 03:15:29,496 - INFO - Deleting VN ctest-right_vn-30119572
2026-04-20 03:15:29,537 - DEBUG - VN 4db2c9c6-1c97-4a4b-8d1c-7434b1ae4b73 still in use: Unable to complete operation on network 4db2c9c6-1c97-4a4b-8d1c-7434b1ae4b73. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-120d567c-3ae2-43e3-8b92-a8853d787ed4']
2026-04-20 03:15:29,538 - WARNING - Deleting VN ctest-right_vn-30119572 failed..Will retry
2026-04-20 03:15:31,706 - DEBUG - Response for deleting network ()
2026-04-20 03:15:31,706 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/74cd37fc-7e1d-40ea-9ace-002ad13fa6ea
2026-04-20 03:15:31,712 - DEBUG - Response Code: 404
2026-04-20 03:15:31,712 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:15:31,718 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:15:31,740 - DEBUG - Requesting: http://10.0.0.38:8082/project/2f2dff21-9dba-4dcd-a990-89c6c6e82b6c
2026-04-20 03:15:31,843 - INFO - Validated that VN ctest-right_vn-30119572 is not found in API Server
2026-04-20 03:15:31,856 - DEBUG - VN ctest-right_vn-30119572 is not present in Agent 10.0.0.240
2026-04-20 03:15:31,867 - DEBUG - VN ctest-right_vn-30119572 is not present in Agent 10.0.0.65
2026-04-20 03:15:31,867 - INFO - Validated that VN ctest-right_vn-30119572 is not in any agent
2026-04-20 03:15:31,898 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-30119572 info
2026-04-20 03:15:31,898 - INFO - Deleting VN ctest-left_vn-90025065
2026-04-20 03:15:32,095 - DEBUG - Response for deleting network ()
2026-04-20 03:15:32,095 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/7c2061c0-3e02-44e3-aa62-4ae2e4a1f64a
2026-04-20 03:15:32,103 - DEBUG - Response Code: 404
2026-04-20 03:15:32,103 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:15:32,111 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:15:32,133 - DEBUG - Requesting: http://10.0.0.38:8082/project/2f2dff21-9dba-4dcd-a990-89c6c6e82b6c
2026-04-20 03:15:32,246 - INFO - Validated that VN ctest-left_vn-90025065 is not found in API Server
2026-04-20 03:15:32,260 - DEBUG - VN ctest-left_vn-90025065 is not present in Agent 10.0.0.240
2026-04-20 03:15:32,274 - DEBUG - VN ctest-left_vn-90025065 is not present in Agent 10.0.0.65
2026-04-20 03:15:32,274 - INFO - Validated that VN ctest-left_vn-90025065 is not in any agent
2026-04-20 03:15:32,303 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-90025065 info
2026-04-20 03:15:32,304 - INFO - Deleting VN ctest-mgmt_vn-05603431
2026-04-20 03:15:32,473 - DEBUG - Response for deleting network ()
2026-04-20 03:15:32,473 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/bf0da44b-7985-4ab2-90ae-0b2bf9a7b754
2026-04-20 03:15:32,480 - DEBUG - Response Code: 404
2026-04-20 03:15:32,480 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-04-20 03:15:32,492 - DEBUG - Requesting: http://10.0.0.38:8082/domain/c2b9cdf0-ff50-48aa-bc48-322f89577022
2026-04-20 03:15:32,546 - DEBUG - Requesting: http://10.0.0.38:8082/project/2f2dff21-9dba-4dcd-a990-89c6c6e82b6c
2026-04-20 03:15:32,647 - INFO - Validated that VN ctest-mgmt_vn-05603431 is not found in API Server
2026-04-20 03:15:32,659 - DEBUG - VN ctest-mgmt_vn-05603431 is not present in Agent 10.0.0.240
2026-04-20 03:15:32,670 - DEBUG - VN ctest-mgmt_vn-05603431 is not present in Agent 10.0.0.65
2026-04-20 03:15:32,670 - INFO - Validated that VN ctest-mgmt_vn-05603431 is not in any agent
2026-04-20 03:15:32,704 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-05603431 info
2026-04-20 03:15:34,000 - DEBUG - No XMPP flaps were noticed during the test
2026-04-20 03:15:34,000 - INFO -
2026-04-20 03:15:34,000 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:18]
2026-04-20 03:15:34,000 - INFO - --------------------------------------------------------------------------------
2026-04-20 03:15:34,783 - INFO - Deleted project: ctest-TestSvcRegr-27720666, ID : 2f2dff21-9dba-4dcd-a990-89c6c6e82b6c