]) created on node: (an-jenkins-deploy-platform-ansible-os-5402-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5402-2)
2026-02-26 03:12:13,122 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-96227357']
2026-02-26 03:12:13,409 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-96227357'] created succesfully
2026-02-26 03:12:13,776 - DEBUG - Image by name tiny_nat_fw not found
2026-02-26 03:12:13,776 - DEBUG - Installing image tiny_nat_fw
2026-02-26 03:12:13,776 - 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-02-26 03:12:13,776 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-02-26 03:12:13,776 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-02-26 03:12:13,803 - 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-02-26 03:12:13,941 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-26 03:12:13,941 - DEBUG - Unzip image
2026-02-26 03:12:13,941 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-26 03:12:13,970 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-02-26 03:12:13,974 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-96227357']
2026-02-26 03:12:14,094 - INFO - Service template: ['default-domain', 'ctest-service_template_1-96227357'] deleted successfully.
2026-02-26 03:12:14,094 - INFO - Skip interface_detach for VM ctest-right_vm-70671488 in state BUILD
2026-02-26 03:12:14,095 - INFO - Deleting VM ctest-right_vm-70671488
2026-02-26 03:12:14,157 - ERROR - VM ctest-right_vm-70671488 has failed to come up
2026-02-26 03:12:14,157 - ERROR - Nova failed to get host of the VM
2026-02-26 03:12:14,157 - ERROR - VM ctest-right_vm-70671488 has failed to come up
2026-02-26 03:12:14,157 - ERROR - Nova failed to get host of the VM
2026-02-26 03:12:14,299 - INFO - Skip interface_detach for VM ctest-left_vm-21193763 in state BUILD
2026-02-26 03:12:14,299 - INFO - Deleting VM ctest-left_vm-21193763
2026-02-26 03:12:14,299 - ERROR - VM ctest-left_vm-21193763 has failed to come up
2026-02-26 03:12:14,299 - ERROR - Nova failed to get host of the VM
2026-02-26 03:12:14,299 - ERROR - VM ctest-left_vm-21193763 has failed to come up
2026-02-26 03:12:14,299 - ERROR - Nova failed to get host of the VM
2026-02-26 03:12:14,387 - INFO - Deleting VN ctest-right_vn-26065313
2026-02-26 03:12:14,454 - DEBUG - VN 80b77582-10e7-469a-b29e-dc6c4bb96a5c still in use: Unable to complete operation on network 80b77582-10e7-469a-b29e-dc6c4bb96a5c. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-008a192a-126a-4ce9-bacb-62780fd8eb74']
2026-02-26 03:12:14,454 - WARNING - Deleting VN ctest-right_vn-26065313 failed..Will retry
2026-02-26 03:12:16,507 - DEBUG - VN 80b77582-10e7-469a-b29e-dc6c4bb96a5c still in use: Unable to complete operation on network 80b77582-10e7-469a-b29e-dc6c4bb96a5c. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-1f8fa143-b7cb-4071-9d2f-840f868e7611']
2026-02-26 03:12:16,507 - WARNING - Deleting VN ctest-right_vn-26065313 failed..Will retry
2026-02-26 03:12:18,685 - DEBUG - Response for deleting network ()
2026-02-26 03:12:18,686 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/1af7fdd7-0d15-4f86-9f08-d30629b348d2
2026-02-26 03:12:18,699 - DEBUG - Response Code: 404
2026-02-26 03:12:18,699 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:18,710 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:18,732 - DEBUG - Requesting: http://10.0.0.65:8082/project/05aaab3b-81a3-4006-82b6-1f376bd9a60a
2026-02-26 03:12:18,841 - INFO - Validated that VN ctest-right_vn-26065313 is not found in API Server
2026-02-26 03:12:18,858 - DEBUG - VN ctest-right_vn-26065313 is not present in Agent 10.0.0.23
2026-02-26 03:12:18,872 - DEBUG - VN ctest-right_vn-26065313 is not present in Agent 10.0.0.48
2026-02-26 03:12:18,872 - INFO - Validated that VN ctest-right_vn-26065313 is not in any agent
2026-02-26 03:12:18,915 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-26065313 info
2026-02-26 03:12:18,915 - INFO - Deleting VN ctest-left_vn-12248583
2026-02-26 03:12:19,091 - DEBUG - Response for deleting network ()
2026-02-26 03:12:19,091 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/814de012-6340-45f1-bdd9-92a8d4f695f1
2026-02-26 03:12:19,097 - DEBUG - Response Code: 404
2026-02-26 03:12:19,098 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:19,104 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:19,126 - DEBUG - Requesting: http://10.0.0.65:8082/project/05aaab3b-81a3-4006-82b6-1f376bd9a60a
2026-02-26 03:12:19,231 - INFO - Validated that VN ctest-left_vn-12248583 is not found in API Server
2026-02-26 03:12:19,245 - DEBUG - VN ctest-left_vn-12248583 is not present in Agent 10.0.0.23
2026-02-26 03:12:19,257 - DEBUG - VN ctest-left_vn-12248583 is not present in Agent 10.0.0.48
2026-02-26 03:12:19,257 - INFO - Validated that VN ctest-left_vn-12248583 is not in any agent
2026-02-26 03:12:19,292 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-12248583 info
2026-02-26 03:12:19,292 - INFO - Deleting VN ctest-mgmt_vn-28089296
2026-02-26 03:12:19,449 - DEBUG - Response for deleting network ()
2026-02-26 03:12:19,449 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/81cc003f-e357-4012-bb76-48b8feb96a3c
2026-02-26 03:12:19,457 - DEBUG - Response Code: 404
2026-02-26 03:12:19,458 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:19,465 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:19,492 - DEBUG - Requesting: http://10.0.0.65:8082/project/05aaab3b-81a3-4006-82b6-1f376bd9a60a
2026-02-26 03:12:19,616 - INFO - Validated that VN ctest-mgmt_vn-28089296 is not found in API Server
2026-02-26 03:12:19,628 - DEBUG - VN ctest-mgmt_vn-28089296 is not present in Agent 10.0.0.23
2026-02-26 03:12:19,644 - DEBUG - VN ctest-mgmt_vn-28089296 is not present in Agent 10.0.0.48
2026-02-26 03:12:19,644 - INFO - Validated that VN ctest-mgmt_vn-28089296 is not in any agent
2026-02-26 03:12:19,681 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-28089296 info
2026-02-26 03:12:19,682 - INFO - Deleting VM ctest-vm-in-third-vn-70138149
2026-02-26 03:12:19,771 - INFO - Deleting VN ctest-third-vn-89921143
2026-02-26 03:12:19,825 - DEBUG - VN cfde1eb5-b6d3-4c0a-b241-4a5bdf31876a still in use: Unable to complete operation on network cfde1eb5-b6d3-4c0a-b241-4a5bdf31876a. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-cf078fe8-1a1d-4c17-99cd-9d69d3bb002c']
2026-02-26 03:12:19,825 - WARNING - Deleting VN ctest-third-vn-89921143 failed..Will retry
2026-02-26 03:12:21,963 - DEBUG - Response for deleting network ()
2026-02-26 03:12:23,262 - DEBUG - No XMPP flaps were noticed during the test
2026-02-26 03:12:23,262 - INFO -
2026-02-26 03:12:23,263 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:29]
2026-02-26 03:12:23,263 - INFO - --------------------------------------------------------------------------------
2026-02-26 03:12:23,266 - INFO - ================================================================================
2026-02-26 03:12:23,266 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2026-02-26 03:12:24,579 - DEBUG - Nothing to compare xmpp stats {'10.0.0.23': {'10.20.0.129': '0', '10.20.0.254': '0'}, '10.0.0.48': {'10.20.0.129': '0', '10.20.0.25': '0'}} with
2026-02-26 03:12:24,579 - INFO - Initial checks done. Running the testcase now
2026-02-26 03:12:24,579 - INFO -
2026-02-26 03:12:24,859 - DEBUG - Response for create_network : {'network': {'id': 'af128b54-e118-4b8e-bf83-f81be99e6589', 'name': 'ctest-mgmt_vn-84321080', 'tenant_id': '05aaab3b81a3400682b61f376bd9a60a', 'project_id': '05aaab3b81a3400682b61f376bd9a60a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-62003112', 'ctest-mgmt_vn-84321080'], 'port_security_enabled': True, 'description': ''}}
2026-02-26 03:12:25,101 - DEBUG - Response for create_subnet : {'subnet': {'id': '7455f070-1ce5-497d-82d0-37ca6ac4f4cf', 'name': '', 'tenant_id': '05aaab3b81a3400682b61f376bd9a60a', 'network_id': 'af128b54-e118-4b8e-bf83-f81be99e6589', 'ip_version': 4, 'cidr': '1.82.21.192/26', 'allocation_pools': [{'start': '1.82.21.194', 'end': '1.82.21.254'}], 'gateway_ip': '1.82.21.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '1.82.21.194', 'tags': [], 'project_id': '05aaab3b81a3400682b61f376bd9a60a'}}
2026-02-26 03:12:25,128 - INFO - Created VN ctest-mgmt_vn-84321080
2026-02-26 03:12:25,142 - DEBUG - VN ctest-mgmt_vn-84321080 UUID is af128b54-e118-4b8e-bf83-f81be99e6589
2026-02-26 03:12:25,234 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:25,242 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:25,254 - DEBUG - Requesting: http://10.0.0.65:8082/project/05aaab3b-81a3-4006-82b6-1f376bd9a60a
2026-02-26 03:12:25,360 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/af128b54-e118-4b8e-bf83-f81be99e6589
2026-02-26 03:12:25,382 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/af128b54-e118-4b8e-bf83-f81be99e6589
2026-02-26 03:12:25,395 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/6d23e8f4-c109-40ab-ae32-6a91b5b0e537
2026-02-26 03:12:25,406 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/6d23e8f4-c109-40ab-ae32-6a91b5b0e537
2026-02-26 03:12:25,416 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/c7dcbfa7-4c02-44b6-972d-4644c1d3d693
2026-02-26 03:12:25,424 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-26 03:12:25,424 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/af128b54-e118-4b8e-bf83-f81be99e6589
2026-02-26 03:12:25,435 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/6d23e8f4-c109-40ab-ae32-6a91b5b0e537
2026-02-26 03:12:25,452 - INFO - Verified VN network id 13 for VN af128b54-e118-4b8e-bf83-f81be99e6589
2026-02-26 03:12:25,452 - INFO - Verifications in API Server for VN ctest-mgmt_vn-84321080 passed
2026-02-26 03:12:25,452 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/af128b54-e118-4b8e-bf83-f81be99e6589
2026-02-26 03:12:25,464 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/6d23e8f4-c109-40ab-ae32-6a91b5b0e537
2026-02-26 03:12:25,472 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/6d23e8f4-c109-40ab-ae32-6a91b5b0e537
2026-02-26 03:12:25,481 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/c7dcbfa7-4c02-44b6-972d-4644c1d3d693
2026-02-26 03:12:25,499 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-62003112:ctest-mgmt_vn-84321080', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-62003112', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12615298702888160142', 'uuid-lslong': '13800146481960609161'}, 'enable': 'true', 'created': '2026-02-26T03:12:24', 'last-modified': '2026-02-26T03:12:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.450888'}
2026-02-26 03:12:25,506 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-26 03:12:25,511 - DEBUG - Control-node 10.0.0.73 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-62003112:ctest-mgmt_vn-84321080', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-62003112', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12615298702888160142', 'uuid-lslong': '13800146481960609161'}, 'enable': 'true', 'created': '2026-02-26T03:12:24', 'last-modified': '2026-02-26T03:12:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.457026'}
2026-02-26 03:12:25,518 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-26 03:12:25,524 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-62003112:ctest-mgmt_vn-84321080', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-62003112', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12615298702888160142', 'uuid-lslong': '13800146481960609161'}, 'enable': 'true', 'created': '2026-02-26T03:12:24', 'last-modified': '2026-02-26T03:12:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.474295'}
2026-02-26 03:12:25,532 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-26 03:12:25,532 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-84321080 passed
2026-02-26 03:12:25,532 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-84321080 in API_Server ======
2026-02-26 03:12:25,532 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:25,540 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:25,553 - DEBUG - Requesting: http://10.0.0.65:8082/project/05aaab3b-81a3-4006-82b6-1f376bd9a60a
2026-02-26 03:12:25,660 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/af128b54-e118-4b8e-bf83-f81be99e6589
2026-02-26 03:12:25,671 - DEBUG - =>VN ctest-mgmt_vn-84321080 has no policy to be verified
2026-02-26 03:12:25,671 - DEBUG - Verifying the vn in opserver
2026-02-26 03:12:25,671 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-62003112:ctest-mgmt_vn-84321080 virtual network link through opserver 10.0.0.65
2026-02-26 03:12:25,671 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-02-26 03:12:25,683 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-62003112:ctest-mgmt_vn-84321080', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-62003112:ctest-mgmt_vn-84321080?flat'}
2026-02-26 03:12:25,683 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-62003112:ctest-mgmt_vn-84321080 virtual network link through opserver 10.0.0.73
2026-02-26 03:12:25,683 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2026-02-26 03:12:25,696 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-62003112:ctest-mgmt_vn-84321080', 'href': 'http://10.0.0.73:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-62003112:ctest-mgmt_vn-84321080?flat'}
2026-02-26 03:12:25,697 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-62003112:ctest-mgmt_vn-84321080 virtual network link through opserver 10.0.0.131
2026-02-26 03:12:25,697 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-02-26 03:12:25,711 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-62003112:ctest-mgmt_vn-84321080', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-62003112:ctest-mgmt_vn-84321080?flat'}
2026-02-26 03:12:25,711 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-62003112:ctest-mgmt_vn-84321080 is found in opserver
2026-02-26 03:12:25,738 - DEBUG - Do not have enough data to verify VN in agent
2026-02-26 03:12:25,749 - DEBUG - VRF ids for VN ctest-mgmt_vn-84321080: {}
2026-02-26 03:12:26,045 - DEBUG - Response for create_network : {'network': {'id': '4fe0b679-89d0-4924-ad80-ea918a20ea10', 'name': 'ctest-left_vn-93274922', 'tenant_id': '05aaab3b81a3400682b61f376bd9a60a', 'project_id': '05aaab3b81a3400682b61f376bd9a60a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-62003112', 'ctest-left_vn-93274922'], 'port_security_enabled': True, 'description': ''}}
2026-02-26 03:12:26,280 - DEBUG - Response for create_subnet : {'subnet': {'id': '50aa4441-76bd-4406-b5ba-16e4005a39a6', 'name': '', 'tenant_id': '05aaab3b81a3400682b61f376bd9a60a', 'network_id': '4fe0b679-89d0-4924-ad80-ea918a20ea10', 'ip_version': 4, 'cidr': '199.230.53.0/26', 'allocation_pools': [{'start': '199.230.53.2', 'end': '199.230.53.62'}], 'gateway_ip': '199.230.53.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '199.230.53.2', 'tags': [], 'project_id': '05aaab3b81a3400682b61f376bd9a60a'}}
2026-02-26 03:12:26,306 - INFO - Created VN ctest-left_vn-93274922
2026-02-26 03:12:26,323 - DEBUG - VN ctest-left_vn-93274922 UUID is 4fe0b679-89d0-4924-ad80-ea918a20ea10
2026-02-26 03:12:26,408 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:26,418 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:26,436 - DEBUG - Requesting: http://10.0.0.65:8082/project/05aaab3b-81a3-4006-82b6-1f376bd9a60a
2026-02-26 03:12:26,547 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/4fe0b679-89d0-4924-ad80-ea918a20ea10
2026-02-26 03:12:26,563 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/4fe0b679-89d0-4924-ad80-ea918a20ea10
2026-02-26 03:12:26,575 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/31cb818e-4576-4604-a748-697adb4977cb
2026-02-26 03:12:26,582 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/31cb818e-4576-4604-a748-697adb4977cb
2026-02-26 03:12:26,590 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/15d037f1-0a1e-4333-8681-4df4c4968475
2026-02-26 03:12:26,598 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-26 03:12:26,598 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/4fe0b679-89d0-4924-ad80-ea918a20ea10
2026-02-26 03:12:26,609 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/31cb818e-4576-4604-a748-697adb4977cb
2026-02-26 03:12:26,629 - INFO - Verified VN network id 14 for VN 4fe0b679-89d0-4924-ad80-ea918a20ea10
2026-02-26 03:12:26,630 - INFO - Verifications in API Server for VN ctest-left_vn-93274922 passed
2026-02-26 03:12:26,630 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/4fe0b679-89d0-4924-ad80-ea918a20ea10
2026-02-26 03:12:26,642 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/31cb818e-4576-4604-a748-697adb4977cb
2026-02-26 03:12:26,650 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/31cb818e-4576-4604-a748-697adb4977cb
2026-02-26 03:12:26,658 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/15d037f1-0a1e-4333-8681-4df4c4968475
2026-02-26 03:12:26,673 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-62003112:ctest-left_vn-93274922', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-62003112', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5755800956898920740', 'uuid-lslong': '12502250476389067280'}, 'enable': 'true', 'created': '2026-02-26T03:12:25', 'last-modified': '2026-02-26T03:12:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.466637'}
2026-02-26 03:12:26,680 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-26 03:12:26,686 - DEBUG - Control-node 10.0.0.73 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-62003112:ctest-left_vn-93274922', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-62003112', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5755800956898920740', 'uuid-lslong': '12502250476389067280'}, 'enable': 'true', 'created': '2026-02-26T03:12:25', 'last-modified': '2026-02-26T03:12:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.476275'}
2026-02-26 03:12:26,692 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-26 03:12:26,698 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-62003112:ctest-left_vn-93274922', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-62003112', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5755800956898920740', 'uuid-lslong': '12502250476389067280'}, 'enable': 'true', 'created': '2026-02-26T03:12:25', 'last-modified': '2026-02-26T03:12:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.489712'}
2026-02-26 03:12:26,705 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-26 03:12:26,705 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-93274922 passed
2026-02-26 03:12:26,706 - DEBUG - ====Verifying policy data for ctest-left_vn-93274922 in API_Server ======
2026-02-26 03:12:26,706 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:26,713 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:26,726 - DEBUG - Requesting: http://10.0.0.65:8082/project/05aaab3b-81a3-4006-82b6-1f376bd9a60a
2026-02-26 03:12:26,830 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/4fe0b679-89d0-4924-ad80-ea918a20ea10
2026-02-26 03:12:26,845 - DEBUG - =>VN ctest-left_vn-93274922 has no policy to be verified
2026-02-26 03:12:26,845 - DEBUG - Verifying the vn in opserver
2026-02-26 03:12:26,845 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-62003112:ctest-left_vn-93274922 virtual network link through opserver 10.0.0.65
2026-02-26 03:12:26,845 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-02-26 03:12:26,859 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-62003112:ctest-left_vn-93274922', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-62003112:ctest-left_vn-93274922?flat'}
2026-02-26 03:12:26,860 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-62003112:ctest-left_vn-93274922 virtual network link through opserver 10.0.0.73
2026-02-26 03:12:26,860 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2026-02-26 03:12:26,873 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-62003112:ctest-left_vn-93274922', 'href': 'http://10.0.0.73:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-62003112:ctest-left_vn-93274922?flat'}
2026-02-26 03:12:26,873 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-62003112:ctest-left_vn-93274922 virtual network link through opserver 10.0.0.131
2026-02-26 03:12:26,873 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-02-26 03:12:26,887 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-62003112:ctest-left_vn-93274922', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-62003112:ctest-left_vn-93274922?flat'}
2026-02-26 03:12:26,887 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-62003112:ctest-left_vn-93274922 is found in opserver
2026-02-26 03:12:26,912 - DEBUG - Do not have enough data to verify VN in agent
2026-02-26 03:12:26,926 - DEBUG - VRF ids for VN ctest-left_vn-93274922: {}
2026-02-26 03:12:27,231 - DEBUG - Response for create_network : {'network': {'id': '61b28758-04b2-49c6-b9bd-933b6f7ad02f', 'name': 'ctest-right_vn-77803458', 'tenant_id': '05aaab3b81a3400682b61f376bd9a60a', 'project_id': '05aaab3b81a3400682b61f376bd9a60a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-62003112', 'ctest-right_vn-77803458'], 'port_security_enabled': True, 'description': ''}}
2026-02-26 03:12:27,486 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f5ec4262-2287-4bf0-842b-d2c8413461d9', 'name': '', 'tenant_id': '05aaab3b81a3400682b61f376bd9a60a', 'network_id': '61b28758-04b2-49c6-b9bd-933b6f7ad02f', 'ip_version': 4, 'cidr': '87.86.64.64/26', 'allocation_pools': [{'start': '87.86.64.66', 'end': '87.86.64.126'}], 'gateway_ip': '87.86.64.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '87.86.64.66', 'tags': [], 'project_id': '05aaab3b81a3400682b61f376bd9a60a'}}
2026-02-26 03:12:27,515 - INFO - Created VN ctest-right_vn-77803458
2026-02-26 03:12:27,529 - DEBUG - VN ctest-right_vn-77803458 UUID is 61b28758-04b2-49c6-b9bd-933b6f7ad02f
2026-02-26 03:12:27,617 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:27,625 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:27,638 - DEBUG - Requesting: http://10.0.0.65:8082/project/05aaab3b-81a3-4006-82b6-1f376bd9a60a
2026-02-26 03:12:27,754 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/61b28758-04b2-49c6-b9bd-933b6f7ad02f
2026-02-26 03:12:27,767 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/61b28758-04b2-49c6-b9bd-933b6f7ad02f
2026-02-26 03:12:27,779 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/430632f2-a5ba-4b6d-8337-d1b344001e24
2026-02-26 03:12:27,792 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/430632f2-a5ba-4b6d-8337-d1b344001e24
2026-02-26 03:12:27,803 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/3c7e8ae1-8603-45a1-9723-c65b13680983
2026-02-26 03:12:27,812 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-26 03:12:27,812 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/61b28758-04b2-49c6-b9bd-933b6f7ad02f
2026-02-26 03:12:27,827 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/430632f2-a5ba-4b6d-8337-d1b344001e24
2026-02-26 03:12:27,842 - INFO - Verified VN network id 15 for VN 61b28758-04b2-49c6-b9bd-933b6f7ad02f
2026-02-26 03:12:27,842 - INFO - Verifications in API Server for VN ctest-right_vn-77803458 passed
2026-02-26 03:12:27,842 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/61b28758-04b2-49c6-b9bd-933b6f7ad02f
2026-02-26 03:12:27,857 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/430632f2-a5ba-4b6d-8337-d1b344001e24
2026-02-26 03:12:27,867 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/430632f2-a5ba-4b6d-8337-d1b344001e24
2026-02-26 03:12:27,875 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/3c7e8ae1-8603-45a1-9723-c65b13680983
2026-02-26 03:12:27,887 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-62003112:ctest-right_vn-77803458', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-62003112', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7039837979639171526', 'uuid-lslong': '13384015551097655343'}, 'enable': 'true', 'created': '2026-02-26T03:12:27', 'last-modified': '2026-02-26T03:12:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.471271'}
2026-02-26 03:12:27,893 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-26 03:12:27,899 - DEBUG - Control-node 10.0.0.73 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-62003112:ctest-right_vn-77803458', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-62003112', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7039837979639171526', 'uuid-lslong': '13384015551097655343'}, 'enable': 'true', 'created': '2026-02-26T03:12:27', 'last-modified': '2026-02-26T03:12:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.487183'}
2026-02-26 03:12:27,906 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-26 03:12:27,911 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-62003112:ctest-right_vn-77803458', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-62003112', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7039837979639171526', 'uuid-lslong': '13384015551097655343'}, 'enable': 'true', 'created': '2026-02-26T03:12:27', 'last-modified': '2026-02-26T03:12:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.499332'}
2026-02-26 03:12:27,919 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-26 03:12:27,919 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-77803458 passed
2026-02-26 03:12:27,919 - DEBUG - ====Verifying policy data for ctest-right_vn-77803458 in API_Server ======
2026-02-26 03:12:27,919 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:27,928 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:27,943 - DEBUG - Requesting: http://10.0.0.65:8082/project/05aaab3b-81a3-4006-82b6-1f376bd9a60a
2026-02-26 03:12:28,038 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/61b28758-04b2-49c6-b9bd-933b6f7ad02f
2026-02-26 03:12:28,056 - DEBUG - =>VN ctest-right_vn-77803458 has no policy to be verified
2026-02-26 03:12:28,056 - DEBUG - Verifying the vn in opserver
2026-02-26 03:12:28,056 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-62003112:ctest-right_vn-77803458 virtual network link through opserver 10.0.0.65
2026-02-26 03:12:28,056 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-02-26 03:12:28,071 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-62003112:ctest-right_vn-77803458', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-62003112:ctest-right_vn-77803458?flat'}
2026-02-26 03:12:28,071 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-62003112:ctest-right_vn-77803458 virtual network link through opserver 10.0.0.73
2026-02-26 03:12:28,071 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2026-02-26 03:12:28,083 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-62003112:ctest-right_vn-77803458', 'href': 'http://10.0.0.73:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-62003112:ctest-right_vn-77803458?flat'}
2026-02-26 03:12:28,083 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-62003112:ctest-right_vn-77803458 virtual network link through opserver 10.0.0.131
2026-02-26 03:12:28,083 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-02-26 03:12:28,095 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-62003112:ctest-right_vn-77803458', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-62003112:ctest-right_vn-77803458?flat'}
2026-02-26 03:12:28,095 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-62003112:ctest-right_vn-77803458 is found in opserver
2026-02-26 03:12:28,118 - DEBUG - Do not have enough data to verify VN in agent
2026-02-26 03:12:28,129 - DEBUG - VRF ids for VN ctest-right_vn-77803458: {}
2026-02-26 03:12:28,502 - DEBUG - Response for create_network : {'network': {'id': 'b446b056-413e-4c73-a5c2-8d354275c607', 'name': 'ctest-trans_left_vn-28686411', 'tenant_id': '05aaab3b81a3400682b61f376bd9a60a', 'project_id': '05aaab3b81a3400682b61f376bd9a60a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-62003112', 'ctest-trans_left_vn-28686411'], 'port_security_enabled': True, 'description': ''}}
2026-02-26 03:12:28,709 - DEBUG - Response for create_subnet : {'subnet': {'id': 'bdbf1609-5713-4eac-8e4f-6074424e9866', 'name': '', 'tenant_id': '05aaab3b81a3400682b61f376bd9a60a', 'network_id': 'b446b056-413e-4c73-a5c2-8d354275c607', 'ip_version': 4, 'cidr': '48.26.177.0/26', 'allocation_pools': [{'start': '48.26.177.2', 'end': '48.26.177.62'}], 'gateway_ip': '48.26.177.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '48.26.177.2', 'tags': [], 'project_id': '05aaab3b81a3400682b61f376bd9a60a'}}
2026-02-26 03:12:28,744 - INFO - Created VN ctest-trans_left_vn-28686411
2026-02-26 03:12:28,759 - DEBUG - VN ctest-trans_left_vn-28686411 UUID is b446b056-413e-4c73-a5c2-8d354275c607
2026-02-26 03:12:28,841 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:28,849 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:28,865 - DEBUG - Requesting: http://10.0.0.65:8082/project/05aaab3b-81a3-4006-82b6-1f376bd9a60a
2026-02-26 03:12:28,977 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/b446b056-413e-4c73-a5c2-8d354275c607
2026-02-26 03:12:28,997 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/b446b056-413e-4c73-a5c2-8d354275c607
2026-02-26 03:12:29,012 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/be29e541-a835-4bdb-8866-98b7a64ba650
2026-02-26 03:12:29,022 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/be29e541-a835-4bdb-8866-98b7a64ba650
2026-02-26 03:12:29,032 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/88d7ff56-e624-43e4-b99d-67d718cb60ac
2026-02-26 03:12:29,039 - DEBUG - Route Targets: ['target:64512:8000008']
2026-02-26 03:12:29,039 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/b446b056-413e-4c73-a5c2-8d354275c607
2026-02-26 03:12:29,050 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/be29e541-a835-4bdb-8866-98b7a64ba650
2026-02-26 03:12:29,067 - INFO - Verified VN network id 16 for VN b446b056-413e-4c73-a5c2-8d354275c607
2026-02-26 03:12:29,067 - INFO - Verifications in API Server for VN ctest-trans_left_vn-28686411 passed
2026-02-26 03:12:29,067 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/b446b056-413e-4c73-a5c2-8d354275c607
2026-02-26 03:12:29,078 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/be29e541-a835-4bdb-8866-98b7a64ba650
2026-02-26 03:12:29,086 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/be29e541-a835-4bdb-8866-98b7a64ba650
2026-02-26 03:12:29,093 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/88d7ff56-e624-43e4-b99d-67d718cb60ac
2026-02-26 03:12:29,106 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-62003112:ctest-trans_left_vn-28686411', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-62003112', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12990264059705052275', 'uuid-lslong': '11944264421627774471'}, 'enable': 'true', 'created': '2026-02-26T03:12:28', 'last-modified': '2026-02-26T03:12:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.451350'}
2026-02-26 03:12:29,112 - DEBUG - Route Targets: ['target:64512:8000008']
2026-02-26 03:12:29,117 - DEBUG - Control-node 10.0.0.73 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-62003112:ctest-trans_left_vn-28686411', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-62003112', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12990264059705052275', 'uuid-lslong': '11944264421627774471'}, 'enable': 'true', 'created': '2026-02-26T03:12:28', 'last-modified': '2026-02-26T03:12:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.460175'}
2026-02-26 03:12:29,124 - DEBUG - Route Targets: ['target:64512:8000008']
2026-02-26 03:12:29,129 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-62003112:ctest-trans_left_vn-28686411', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-62003112', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12990264059705052275', 'uuid-lslong': '11944264421627774471'}, 'enable': 'true', 'created': '2026-02-26T03:12:28', 'last-modified': '2026-02-26T03:12:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.474765'}
2026-02-26 03:12:29,136 - DEBUG - Route Targets: ['target:64512:8000008']
2026-02-26 03:12:29,136 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-28686411 passed
2026-02-26 03:12:29,136 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-28686411 in API_Server ======
2026-02-26 03:12:29,136 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:29,143 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:29,156 - DEBUG - Requesting: http://10.0.0.65:8082/project/05aaab3b-81a3-4006-82b6-1f376bd9a60a
2026-02-26 03:12:29,260 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/b446b056-413e-4c73-a5c2-8d354275c607
2026-02-26 03:12:29,274 - DEBUG - =>VN ctest-trans_left_vn-28686411 has no policy to be verified
2026-02-26 03:12:29,274 - DEBUG - Verifying the vn in opserver
2026-02-26 03:12:29,274 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-62003112:ctest-trans_left_vn-28686411 virtual network link through opserver 10.0.0.65
2026-02-26 03:12:29,274 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-02-26 03:12:29,289 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-62003112:ctest-trans_left_vn-28686411', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-62003112:ctest-trans_left_vn-28686411?flat'}
2026-02-26 03:12:29,289 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-62003112:ctest-trans_left_vn-28686411 virtual network link through opserver 10.0.0.73
2026-02-26 03:12:29,289 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2026-02-26 03:12:29,300 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-62003112:ctest-trans_left_vn-28686411', 'href': 'http://10.0.0.73:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-62003112:ctest-trans_left_vn-28686411?flat'}
2026-02-26 03:12:29,301 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-62003112:ctest-trans_left_vn-28686411 virtual network link through opserver 10.0.0.131
2026-02-26 03:12:29,301 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-02-26 03:12:29,315 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-62003112:ctest-trans_left_vn-28686411', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-62003112:ctest-trans_left_vn-28686411?flat'}
2026-02-26 03:12:29,315 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-62003112:ctest-trans_left_vn-28686411 is found in opserver
2026-02-26 03:12:29,340 - DEBUG - Do not have enough data to verify VN in agent
2026-02-26 03:12:29,352 - DEBUG - VRF ids for VN ctest-trans_left_vn-28686411: {}
2026-02-26 03:12:29,633 - DEBUG - Response for create_network : {'network': {'id': 'f1c6bdfc-1815-4631-bb96-9cb38abbdb6c', 'name': 'ctest-trans_right_vn-37446151', 'tenant_id': '05aaab3b81a3400682b61f376bd9a60a', 'project_id': '05aaab3b81a3400682b61f376bd9a60a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-62003112', 'ctest-trans_right_vn-37446151'], 'port_security_enabled': True, 'description': ''}}
2026-02-26 03:12:30,035 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ff8884f2-34b9-4a79-986e-3852a141e985', 'name': '', 'tenant_id': '05aaab3b81a3400682b61f376bd9a60a', 'network_id': 'f1c6bdfc-1815-4631-bb96-9cb38abbdb6c', 'ip_version': 4, 'cidr': '74.205.197.192/26', 'allocation_pools': [{'start': '74.205.197.194', 'end': '74.205.197.254'}], 'gateway_ip': '74.205.197.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '74.205.197.194', 'tags': [], 'project_id': '05aaab3b81a3400682b61f376bd9a60a'}}
2026-02-26 03:12:30,060 - INFO - Created VN ctest-trans_right_vn-37446151
2026-02-26 03:12:30,075 - DEBUG - VN ctest-trans_right_vn-37446151 UUID is f1c6bdfc-1815-4631-bb96-9cb38abbdb6c
2026-02-26 03:12:30,164 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:30,172 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:30,186 - DEBUG - Requesting: http://10.0.0.65:8082/project/05aaab3b-81a3-4006-82b6-1f376bd9a60a
2026-02-26 03:12:30,296 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/f1c6bdfc-1815-4631-bb96-9cb38abbdb6c
2026-02-26 03:12:30,324 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/f1c6bdfc-1815-4631-bb96-9cb38abbdb6c
2026-02-26 03:12:30,338 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f6dbd009-0eb7-4a2c-bd75-8e4c3ffddef4
2026-02-26 03:12:30,347 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f6dbd009-0eb7-4a2c-bd75-8e4c3ffddef4
2026-02-26 03:12:30,355 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/88e88790-0a4a-4d16-af6e-3f8df23c7a1f
2026-02-26 03:12:30,365 - DEBUG - Route Targets: ['target:64512:8000009']
2026-02-26 03:12:30,365 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/f1c6bdfc-1815-4631-bb96-9cb38abbdb6c
2026-02-26 03:12:30,380 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f6dbd009-0eb7-4a2c-bd75-8e4c3ffddef4
2026-02-26 03:12:30,399 - INFO - Verified VN network id 17 for VN f1c6bdfc-1815-4631-bb96-9cb38abbdb6c
2026-02-26 03:12:30,399 - INFO - Verifications in API Server for VN ctest-trans_right_vn-37446151 passed
2026-02-26 03:12:30,399 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/f1c6bdfc-1815-4631-bb96-9cb38abbdb6c
2026-02-26 03:12:30,414 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f6dbd009-0eb7-4a2c-bd75-8e4c3ffddef4
2026-02-26 03:12:30,424 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f6dbd009-0eb7-4a2c-bd75-8e4c3ffddef4
2026-02-26 03:12:30,435 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/88e88790-0a4a-4d16-af6e-3f8df23c7a1f
2026-02-26 03:12:30,451 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-62003112:ctest-trans_right_vn-37446151', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-62003112', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17421821098962798129', 'uuid-lslong': '13517163626539768684'}, 'enable': 'true', 'created': '2026-02-26T03:12:29', 'last-modified': '2026-02-26T03:12:29', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.607260'}
2026-02-26 03:12:30,460 - DEBUG - Route Targets: ['target:64512:8000009']
2026-02-26 03:12:30,466 - DEBUG - Control-node 10.0.0.73 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-62003112:ctest-trans_right_vn-37446151', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-62003112', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17421821098962798129', 'uuid-lslong': '13517163626539768684'}, 'enable': 'true', 'created': '2026-02-26T03:12:29', 'last-modified': '2026-02-26T03:12:29', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.619704'}
2026-02-26 03:12:30,475 - DEBUG - Route Targets: ['target:64512:8000009']
2026-02-26 03:12:30,481 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-62003112:ctest-trans_right_vn-37446151', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-62003112', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17421821098962798129', 'uuid-lslong': '13517163626539768684'}, 'enable': 'true', 'created': '2026-02-26T03:12:29', 'last-modified': '2026-02-26T03:12:29', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.635475'}
2026-02-26 03:12:30,488 - DEBUG - Route Targets: ['target:64512:8000009']
2026-02-26 03:12:30,488 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-37446151 passed
2026-02-26 03:12:30,488 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-37446151 in API_Server ======
2026-02-26 03:12:30,488 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:30,496 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:30,509 - DEBUG - Requesting: http://10.0.0.65:8082/project/05aaab3b-81a3-4006-82b6-1f376bd9a60a
2026-02-26 03:12:30,605 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/f1c6bdfc-1815-4631-bb96-9cb38abbdb6c
2026-02-26 03:12:30,623 - DEBUG - =>VN ctest-trans_right_vn-37446151 has no policy to be verified
2026-02-26 03:12:30,623 - DEBUG - Verifying the vn in opserver
2026-02-26 03:12:30,623 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-62003112:ctest-trans_right_vn-37446151 virtual network link through opserver 10.0.0.65
2026-02-26 03:12:30,623 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-02-26 03:12:30,638 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-62003112:ctest-trans_right_vn-37446151', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-62003112:ctest-trans_right_vn-37446151?flat'}
2026-02-26 03:12:30,638 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-62003112:ctest-trans_right_vn-37446151 virtual network link through opserver 10.0.0.73
2026-02-26 03:12:30,638 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2026-02-26 03:12:30,651 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-62003112:ctest-trans_right_vn-37446151', 'href': 'http://10.0.0.73:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-62003112:ctest-trans_right_vn-37446151?flat'}
2026-02-26 03:12:30,651 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-62003112:ctest-trans_right_vn-37446151 virtual network link through opserver 10.0.0.131
2026-02-26 03:12:30,651 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-02-26 03:12:30,665 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-62003112:ctest-trans_right_vn-37446151', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-62003112:ctest-trans_right_vn-37446151?flat'}
2026-02-26 03:12:30,665 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-62003112:ctest-trans_right_vn-37446151 is found in opserver
2026-02-26 03:12:30,687 - DEBUG - Do not have enough data to verify VN in agent
2026-02-26 03:12:30,698 - DEBUG - VRF ids for VN ctest-trans_right_vn-37446151: {}
2026-02-26 03:12:31,956 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5402-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5402-2)
2026-02-26 03:12:33,583 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5402-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5402-1)
2026-02-26 03:12:33,584 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-61185409']
2026-02-26 03:12:33,878 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-61185409'] created succesfully
2026-02-26 03:12:34,301 - DEBUG - Image by name tiny_trans_fw not found
2026-02-26 03:12:34,301 - DEBUG - Installing image tiny_trans_fw
2026-02-26 03:12:34,302 - 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-02-26 03:12:34,302 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-02-26 03:12:34,302 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-02-26 03:12:34,327 - 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-02-26 03:12:34,385 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-02-26 03:12:34,386 - DEBUG - Unzip image
2026-02-26 03:12:34,386 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-02-26 03:12:34,417 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-02-26 03:12:34,418 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-61185409']
2026-02-26 03:12:34,514 - INFO - Service template: ['default-domain', 'ctest-service_template_1-61185409'] deleted successfully.
2026-02-26 03:12:34,514 - INFO - Skip interface_detach for VM ctest-right_vm-34512268 in state BUILD
2026-02-26 03:12:34,514 - INFO - Deleting VM ctest-right_vm-34512268
2026-02-26 03:12:34,515 - ERROR - VM ctest-right_vm-34512268 has failed to come up
2026-02-26 03:12:34,515 - ERROR - Nova failed to get host of the VM
2026-02-26 03:12:34,515 - ERROR - VM ctest-right_vm-34512268 has failed to come up
2026-02-26 03:12:34,515 - ERROR - Nova failed to get host of the VM
2026-02-26 03:12:34,705 - INFO - Skip interface_detach for VM ctest-left_vm-79708597 in state BUILD
2026-02-26 03:12:34,706 - INFO - Deleting VM ctest-left_vm-79708597
2026-02-26 03:12:34,706 - ERROR - VM ctest-left_vm-79708597 has failed to come up
2026-02-26 03:12:34,706 - ERROR - Nova failed to get host of the VM
2026-02-26 03:12:34,707 - ERROR - VM ctest-left_vm-79708597 has failed to come up
2026-02-26 03:12:34,707 - ERROR - Nova failed to get host of the VM
2026-02-26 03:12:34,815 - INFO - Deleting VN ctest-trans_right_vn-37446151
2026-02-26 03:12:34,980 - DEBUG - Response for deleting network ()
2026-02-26 03:12:34,980 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f6dbd009-0eb7-4a2c-bd75-8e4c3ffddef4
2026-02-26 03:12:34,988 - DEBUG - Response Code: 404
2026-02-26 03:12:34,989 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:34,998 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:35,034 - DEBUG - Requesting: http://10.0.0.65:8082/project/05aaab3b-81a3-4006-82b6-1f376bd9a60a
2026-02-26 03:12:35,131 - INFO - Validated that VN ctest-trans_right_vn-37446151 is not found in API Server
2026-02-26 03:12:35,159 - DEBUG - VN ctest-trans_right_vn-37446151 is not present in Agent 10.0.0.23
2026-02-26 03:12:35,171 - DEBUG - VN ctest-trans_right_vn-37446151 is not present in Agent 10.0.0.48
2026-02-26 03:12:35,171 - INFO - Validated that VN ctest-trans_right_vn-37446151 is not in any agent
2026-02-26 03:12:35,211 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-37446151 info
2026-02-26 03:12:35,211 - INFO - Deleting VN ctest-trans_left_vn-28686411
2026-02-26 03:12:35,373 - DEBUG - Response for deleting network ()
2026-02-26 03:12:35,373 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/be29e541-a835-4bdb-8866-98b7a64ba650
2026-02-26 03:12:35,380 - DEBUG - Response Code: 404
2026-02-26 03:12:35,380 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:35,396 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:35,425 - DEBUG - Requesting: http://10.0.0.65:8082/project/05aaab3b-81a3-4006-82b6-1f376bd9a60a
2026-02-26 03:12:35,544 - INFO - Validated that VN ctest-trans_left_vn-28686411 is not found in API Server
2026-02-26 03:12:35,574 - DEBUG - VN ctest-trans_left_vn-28686411 is not present in Agent 10.0.0.23
2026-02-26 03:12:35,590 - DEBUG - VN ctest-trans_left_vn-28686411 is not present in Agent 10.0.0.48
2026-02-26 03:12:35,590 - INFO - Validated that VN ctest-trans_left_vn-28686411 is not in any agent
2026-02-26 03:12:35,661 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-28686411 info
2026-02-26 03:12:35,661 - INFO - Deleting VN ctest-right_vn-77803458
2026-02-26 03:12:35,731 - DEBUG - VN 61b28758-04b2-49c6-b9bd-933b6f7ad02f still in use: Unable to complete operation on network 61b28758-04b2-49c6-b9bd-933b6f7ad02f. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-18f20fc0-341d-445e-a0ed-a7d78f46f463']
2026-02-26 03:12:35,731 - WARNING - Deleting VN ctest-right_vn-77803458 failed..Will retry
2026-02-26 03:12:37,902 - DEBUG - Response for deleting network ()
2026-02-26 03:12:37,902 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/430632f2-a5ba-4b6d-8337-d1b344001e24
2026-02-26 03:12:37,911 - DEBUG - Response Code: 404
2026-02-26 03:12:37,911 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:37,918 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:37,980 - DEBUG - Requesting: http://10.0.0.65:8082/project/05aaab3b-81a3-4006-82b6-1f376bd9a60a
2026-02-26 03:12:38,086 - INFO - Validated that VN ctest-right_vn-77803458 is not found in API Server
2026-02-26 03:12:38,099 - DEBUG - VN ctest-right_vn-77803458 is not present in Agent 10.0.0.23
2026-02-26 03:12:38,109 - DEBUG - VN ctest-right_vn-77803458 is not present in Agent 10.0.0.48
2026-02-26 03:12:38,109 - INFO - Validated that VN ctest-right_vn-77803458 is not in any agent
2026-02-26 03:12:38,142 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-77803458 info
2026-02-26 03:12:38,143 - INFO - Deleting VN ctest-left_vn-93274922
2026-02-26 03:12:38,287 - DEBUG - Response for deleting network ()
2026-02-26 03:12:38,287 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/31cb818e-4576-4604-a748-697adb4977cb
2026-02-26 03:12:38,296 - DEBUG - Response Code: 404
2026-02-26 03:12:38,296 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:38,307 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:38,327 - DEBUG - Requesting: http://10.0.0.65:8082/project/05aaab3b-81a3-4006-82b6-1f376bd9a60a
2026-02-26 03:12:38,461 - INFO - Validated that VN ctest-left_vn-93274922 is not found in API Server
2026-02-26 03:12:38,475 - DEBUG - VN ctest-left_vn-93274922 is not present in Agent 10.0.0.23
2026-02-26 03:12:38,489 - DEBUG - VN ctest-left_vn-93274922 is not present in Agent 10.0.0.48
2026-02-26 03:12:38,490 - INFO - Validated that VN ctest-left_vn-93274922 is not in any agent
2026-02-26 03:12:38,545 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-93274922 info
2026-02-26 03:12:38,545 - INFO - Deleting VN ctest-mgmt_vn-84321080
2026-02-26 03:12:38,761 - DEBUG - Response for deleting network ()
2026-02-26 03:12:38,761 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/6d23e8f4-c109-40ab-ae32-6a91b5b0e537
2026-02-26 03:12:38,775 - DEBUG - Response Code: 404
2026-02-26 03:12:38,775 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:38,792 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:38,876 - DEBUG - Requesting: http://10.0.0.65:8082/project/05aaab3b-81a3-4006-82b6-1f376bd9a60a
2026-02-26 03:12:38,996 - INFO - Validated that VN ctest-mgmt_vn-84321080 is not found in API Server
2026-02-26 03:12:39,015 - DEBUG - VN ctest-mgmt_vn-84321080 is not present in Agent 10.0.0.23
2026-02-26 03:12:39,029 - DEBUG - VN ctest-mgmt_vn-84321080 is not present in Agent 10.0.0.48
2026-02-26 03:12:39,031 - INFO - Validated that VN ctest-mgmt_vn-84321080 is not in any agent
2026-02-26 03:12:39,088 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-84321080 info
2026-02-26 03:12:40,403 - DEBUG - No XMPP flaps were noticed during the test
2026-02-26 03:12:40,404 - INFO -
2026-02-26 03:12:40,404 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:17]
2026-02-26 03:12:40,404 - INFO - --------------------------------------------------------------------------------
2026-02-26 03:12:41,185 - INFO - Deleted project: ctest-TestSvcRegr-62003112, ID : 05aaab3b-81a3-4006-82b6-1f376bd9a60a
2026-02-26 03:12:41,410 - INFO - Domain Default found not creating
2026-02-26 03:12:41,646 - INFO - Project ctest-TestSvcRegr-83075497 not found, creating it
2026-02-26 03:12:42,188 - INFO - Created Project:ctest-TestSvcRegr-83075497, ID : 3705f1ce-c5c8-4ce9-8446-6e6bcdfe3cae
2026-02-26 03:12:44,112 - INFO - ================================================================================
2026-02-26 03:12:44,112 - INFO - STARTING TEST : test_svc_CEM_22032
2026-02-26 03:12:45,406 - DEBUG - Nothing to compare xmpp stats {'10.0.0.23': {'10.20.0.129': '0', '10.20.0.254': '0'}, '10.0.0.48': {'10.20.0.129': '0', '10.20.0.25': '0'}} with
2026-02-26 03:12:45,406 - INFO - Initial checks done. Running the testcase now
2026-02-26 03:12:45,406 - INFO -
2026-02-26 03:12:46,190 - DEBUG - Response for create_network : {'network': {'id': 'f8a7e58d-e15d-4b12-a83c-b72155cc347c', 'name': 'ctest-mgmt_vn-27295308', 'tenant_id': '3705f1cec5c84ce984466e6bcdfe3cae', 'project_id': '3705f1cec5c84ce984466e6bcdfe3cae', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-83075497', 'ctest-mgmt_vn-27295308'], 'port_security_enabled': True, 'description': ''}}
2026-02-26 03:12:46,511 - DEBUG - Response for create_subnet : {'subnet': {'id': '3cb205c7-91f3-4f8d-b6e4-8482c513000e', 'name': '', 'tenant_id': '3705f1cec5c84ce984466e6bcdfe3cae', 'network_id': 'f8a7e58d-e15d-4b12-a83c-b72155cc347c', 'ip_version': 4, 'cidr': '34.83.9.128/26', 'allocation_pools': [{'start': '34.83.9.130', 'end': '34.83.9.190'}], 'gateway_ip': '34.83.9.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '34.83.9.130', 'tags': [], 'project_id': '3705f1cec5c84ce984466e6bcdfe3cae'}}
2026-02-26 03:12:46,554 - INFO - Created VN ctest-mgmt_vn-27295308
2026-02-26 03:12:46,566 - DEBUG - VN ctest-mgmt_vn-27295308 UUID is f8a7e58d-e15d-4b12-a83c-b72155cc347c
2026-02-26 03:12:46,646 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:47,018 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:47,054 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:47,071 - DEBUG - Requesting: http://10.0.0.65:8082/project/3705f1ce-c5c8-4ce9-8446-6e6bcdfe3cae
2026-02-26 03:12:47,190 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/f8a7e58d-e15d-4b12-a83c-b72155cc347c
2026-02-26 03:12:47,207 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/f8a7e58d-e15d-4b12-a83c-b72155cc347c
2026-02-26 03:12:47,219 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/7573b49e-f695-4095-ae52-8c6fe37c8c6b
2026-02-26 03:12:47,231 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/7573b49e-f695-4095-ae52-8c6fe37c8c6b
2026-02-26 03:12:47,239 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/55189819-0431-4ddb-b0f3-0cd16c8bdb1b
2026-02-26 03:12:47,248 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-26 03:12:47,248 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/f8a7e58d-e15d-4b12-a83c-b72155cc347c
2026-02-26 03:12:47,260 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/7573b49e-f695-4095-ae52-8c6fe37c8c6b
2026-02-26 03:12:47,277 - INFO - Verified VN network id 13 for VN f8a7e58d-e15d-4b12-a83c-b72155cc347c
2026-02-26 03:12:47,278 - INFO - Verifications in API Server for VN ctest-mgmt_vn-27295308 passed
2026-02-26 03:12:47,278 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/f8a7e58d-e15d-4b12-a83c-b72155cc347c
2026-02-26 03:12:47,288 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/7573b49e-f695-4095-ae52-8c6fe37c8c6b
2026-02-26 03:12:47,297 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/7573b49e-f695-4095-ae52-8c6fe37c8c6b
2026-02-26 03:12:47,306 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/55189819-0431-4ddb-b0f3-0cd16c8bdb1b
2026-02-26 03:12:47,322 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-27295308', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-83075497', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17917542040050944786', 'uuid-lslong': '12122765650775782524'}, 'enable': 'true', 'created': '2026-02-26T03:12:46', 'last-modified': '2026-02-26T03:12:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.851411'}
2026-02-26 03:12:47,330 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-26 03:12:47,336 - DEBUG - Control-node 10.0.0.73 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-27295308', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-83075497', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17917542040050944786', 'uuid-lslong': '12122765650775782524'}, 'enable': 'true', 'created': '2026-02-26T03:12:46', 'last-modified': '2026-02-26T03:12:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.871033'}
2026-02-26 03:12:47,343 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-26 03:12:47,349 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-27295308', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-83075497', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17917542040050944786', 'uuid-lslong': '12122765650775782524'}, 'enable': 'true', 'created': '2026-02-26T03:12:46', 'last-modified': '2026-02-26T03:12:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.884126'}
2026-02-26 03:12:47,356 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-26 03:12:47,356 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-27295308 passed
2026-02-26 03:12:47,356 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-27295308 in API_Server ======
2026-02-26 03:12:47,356 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:47,363 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:47,378 - DEBUG - Requesting: http://10.0.0.65:8082/project/3705f1ce-c5c8-4ce9-8446-6e6bcdfe3cae
2026-02-26 03:12:47,471 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/f8a7e58d-e15d-4b12-a83c-b72155cc347c
2026-02-26 03:12:47,483 - DEBUG - =>VN ctest-mgmt_vn-27295308 has no policy to be verified
2026-02-26 03:12:47,483 - DEBUG - Verifying the vn in opserver
2026-02-26 03:12:47,484 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-27295308 virtual network link through opserver 10.0.0.65
2026-02-26 03:12:47,484 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-02-26 03:12:47,854 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-02-26 03:12:47,927 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-27295308', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-27295308?flat'}
2026-02-26 03:12:47,927 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-27295308 virtual network link through opserver 10.0.0.73
2026-02-26 03:12:47,927 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2026-02-26 03:12:48,291 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2026-02-26 03:12:48,431 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-27295308', 'href': 'http://10.0.0.73:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-27295308?flat'}
2026-02-26 03:12:48,432 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-27295308 virtual network link through opserver 10.0.0.131
2026-02-26 03:12:48,432 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-02-26 03:12:48,958 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-02-26 03:12:49,068 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-27295308', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-27295308?flat'}
2026-02-26 03:12:49,068 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-27295308 is found in opserver
2026-02-26 03:12:49,101 - DEBUG - Do not have enough data to verify VN in agent
2026-02-26 03:12:49,111 - DEBUG - VRF ids for VN ctest-mgmt_vn-27295308: {}
2026-02-26 03:12:49,391 - DEBUG - Response for create_network : {'network': {'id': '80177edd-d492-462b-9a80-259e39c39b72', 'name': 'service-left-vn-24349768', 'tenant_id': '3705f1cec5c84ce984466e6bcdfe3cae', 'project_id': '3705f1cec5c84ce984466e6bcdfe3cae', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-83075497', 'service-left-vn-24349768'], 'port_security_enabled': True, 'description': ''}}
2026-02-26 03:12:49,582 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ec1c62e4-9768-4712-b45d-928fe9f09f85', 'name': '', 'tenant_id': '3705f1cec5c84ce984466e6bcdfe3cae', 'network_id': '80177edd-d492-462b-9a80-259e39c39b72', 'ip_version': 4, 'cidr': '11.161.87.64/26', 'allocation_pools': [{'start': '11.161.87.66', 'end': '11.161.87.126'}], 'gateway_ip': '11.161.87.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '11.161.87.66', 'tags': [], 'project_id': '3705f1cec5c84ce984466e6bcdfe3cae'}}
2026-02-26 03:12:49,620 - INFO - Created VN service-left-vn-24349768
2026-02-26 03:12:49,632 - DEBUG - VN service-left-vn-24349768 UUID is 80177edd-d492-462b-9a80-259e39c39b72
2026-02-26 03:12:49,716 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:49,724 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:49,775 - DEBUG - Requesting: http://10.0.0.65:8082/project/3705f1ce-c5c8-4ce9-8446-6e6bcdfe3cae
2026-02-26 03:12:49,904 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/80177edd-d492-462b-9a80-259e39c39b72
2026-02-26 03:12:49,917 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/80177edd-d492-462b-9a80-259e39c39b72
2026-02-26 03:12:49,928 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f0dd3b3a-2971-43d9-90f5-a4eb7d517d28
2026-02-26 03:12:49,939 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f0dd3b3a-2971-43d9-90f5-a4eb7d517d28
2026-02-26 03:12:49,968 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/200823a2-5c14-4b5d-9d31-68b4b163f005
2026-02-26 03:12:49,978 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-26 03:12:49,978 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/80177edd-d492-462b-9a80-259e39c39b72
2026-02-26 03:12:49,991 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f0dd3b3a-2971-43d9-90f5-a4eb7d517d28
2026-02-26 03:12:50,020 - INFO - Verified VN network id 14 for VN 80177edd-d492-462b-9a80-259e39c39b72
2026-02-26 03:12:50,020 - INFO - Verifications in API Server for VN service-left-vn-24349768 passed
2026-02-26 03:12:50,021 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/80177edd-d492-462b-9a80-259e39c39b72
2026-02-26 03:12:50,032 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f0dd3b3a-2971-43d9-90f5-a4eb7d517d28
2026-02-26 03:12:50,043 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f0dd3b3a-2971-43d9-90f5-a4eb7d517d28
2026-02-26 03:12:50,052 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/200823a2-5c14-4b5d-9d31-68b4b163f005
2026-02-26 03:12:50,067 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-83075497:service-left-vn-24349768', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-83075497', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9229985452538349099', 'uuid-lslong': '11132939640364047218'}, 'enable': 'true', 'created': '2026-02-26T03:12:49', 'last-modified': '2026-02-26T03:12:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.528559'}
2026-02-26 03:12:50,074 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-26 03:12:50,082 - DEBUG - Control-node 10.0.0.73 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-83075497:service-left-vn-24349768', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-83075497', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9229985452538349099', 'uuid-lslong': '11132939640364047218'}, 'enable': 'true', 'created': '2026-02-26T03:12:49', 'last-modified': '2026-02-26T03:12:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.544638'}
2026-02-26 03:12:50,088 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-26 03:12:50,094 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-83075497:service-left-vn-24349768', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-83075497', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9229985452538349099', 'uuid-lslong': '11132939640364047218'}, 'enable': 'true', 'created': '2026-02-26T03:12:49', 'last-modified': '2026-02-26T03:12:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.558143'}
2026-02-26 03:12:50,100 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-26 03:12:50,100 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-24349768 passed
2026-02-26 03:12:50,101 - DEBUG - ====Verifying policy data for service-left-vn-24349768 in API_Server ======
2026-02-26 03:12:50,101 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:50,108 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:50,119 - DEBUG - Requesting: http://10.0.0.65:8082/project/3705f1ce-c5c8-4ce9-8446-6e6bcdfe3cae
2026-02-26 03:12:50,214 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/80177edd-d492-462b-9a80-259e39c39b72
2026-02-26 03:12:50,231 - DEBUG - =>VN service-left-vn-24349768 has no policy to be verified
2026-02-26 03:12:50,231 - DEBUG - Verifying the vn in opserver
2026-02-26 03:12:50,231 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-83075497:service-left-vn-24349768 virtual network link through opserver 10.0.0.65
2026-02-26 03:12:50,231 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-02-26 03:12:50,325 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-83075497:service-left-vn-24349768', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-83075497:service-left-vn-24349768?flat'}
2026-02-26 03:12:50,325 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-83075497:service-left-vn-24349768 virtual network link through opserver 10.0.0.73
2026-02-26 03:12:50,325 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2026-02-26 03:12:50,409 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-83075497:service-left-vn-24349768', 'href': 'http://10.0.0.73:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-83075497:service-left-vn-24349768?flat'}
2026-02-26 03:12:50,410 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-83075497:service-left-vn-24349768 virtual network link through opserver 10.0.0.131
2026-02-26 03:12:50,410 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-02-26 03:12:50,482 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-83075497:service-left-vn-24349768', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-83075497:service-left-vn-24349768?flat'}
2026-02-26 03:12:50,482 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-83075497:service-left-vn-24349768 is found in opserver
2026-02-26 03:12:50,506 - DEBUG - Do not have enough data to verify VN in agent
2026-02-26 03:12:50,517 - DEBUG - VRF ids for VN service-left-vn-24349768: {}
2026-02-26 03:12:50,788 - DEBUG - Response for create_network : {'network': {'id': 'df8824cf-63b9-4a08-9b14-0a928a12cc11', 'name': 'service-right-vn-96645428', 'tenant_id': '3705f1cec5c84ce984466e6bcdfe3cae', 'project_id': '3705f1cec5c84ce984466e6bcdfe3cae', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-83075497', 'service-right-vn-96645428'], 'port_security_enabled': True, 'description': ''}}
2026-02-26 03:12:51,107 - DEBUG - Response for create_subnet : {'subnet': {'id': '08e07a9b-d623-42f5-acf4-a122333bc1d1', 'name': '', 'tenant_id': '3705f1cec5c84ce984466e6bcdfe3cae', 'network_id': 'df8824cf-63b9-4a08-9b14-0a928a12cc11', 'ip_version': 4, 'cidr': '194.4.198.192/26', 'allocation_pools': [{'start': '194.4.198.194', 'end': '194.4.198.254'}], 'gateway_ip': '194.4.198.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '194.4.198.194', 'tags': [], 'project_id': '3705f1cec5c84ce984466e6bcdfe3cae'}}
2026-02-26 03:12:51,131 - INFO - Created VN service-right-vn-96645428
2026-02-26 03:12:51,147 - DEBUG - VN service-right-vn-96645428 UUID is df8824cf-63b9-4a08-9b14-0a928a12cc11
2026-02-26 03:12:51,235 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:51,243 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:51,257 - DEBUG - Requesting: http://10.0.0.65:8082/project/3705f1ce-c5c8-4ce9-8446-6e6bcdfe3cae
2026-02-26 03:12:51,389 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/df8824cf-63b9-4a08-9b14-0a928a12cc11
2026-02-26 03:12:51,404 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/df8824cf-63b9-4a08-9b14-0a928a12cc11
2026-02-26 03:12:51,416 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/3ea75b12-f244-458c-88ea-4ced628c094e
2026-02-26 03:12:51,424 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/3ea75b12-f244-458c-88ea-4ced628c094e
2026-02-26 03:12:51,432 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/8c3d221d-a3ee-41d8-beb9-18e8df3f99c1
2026-02-26 03:12:51,440 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-26 03:12:51,440 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/df8824cf-63b9-4a08-9b14-0a928a12cc11
2026-02-26 03:12:51,451 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/3ea75b12-f244-458c-88ea-4ced628c094e
2026-02-26 03:12:51,467 - INFO - Verified VN network id 15 for VN df8824cf-63b9-4a08-9b14-0a928a12cc11
2026-02-26 03:12:51,467 - INFO - Verifications in API Server for VN service-right-vn-96645428 passed
2026-02-26 03:12:51,467 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/df8824cf-63b9-4a08-9b14-0a928a12cc11
2026-02-26 03:12:51,479 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/3ea75b12-f244-458c-88ea-4ced628c094e
2026-02-26 03:12:51,487 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/3ea75b12-f244-458c-88ea-4ced628c094e
2026-02-26 03:12:51,495 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/8c3d221d-a3ee-41d8-beb9-18e8df3f99c1
2026-02-26 03:12:51,509 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-83075497:service-right-vn-96645428', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-83075497', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16107164540440496648', 'uuid-lslong': '11174568199911033873'}, 'enable': 'true', 'created': '2026-02-26T03:12:50', 'last-modified': '2026-02-26T03:12:50', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.498945'}
2026-02-26 03:12:51,514 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-26 03:12:51,520 - DEBUG - Control-node 10.0.0.73 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-83075497:service-right-vn-96645428', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-83075497', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16107164540440496648', 'uuid-lslong': '11174568199911033873'}, 'enable': 'true', 'created': '2026-02-26T03:12:50', 'last-modified': '2026-02-26T03:12:50', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.519359'}
2026-02-26 03:12:51,528 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-26 03:12:51,535 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-83075497:service-right-vn-96645428', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-83075497', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16107164540440496648', 'uuid-lslong': '11174568199911033873'}, 'enable': 'true', 'created': '2026-02-26T03:12:50', 'last-modified': '2026-02-26T03:12:50', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.533273'}
2026-02-26 03:12:51,541 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-26 03:12:51,541 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-96645428 passed
2026-02-26 03:12:51,542 - DEBUG - ====Verifying policy data for service-right-vn-96645428 in API_Server ======
2026-02-26 03:12:51,542 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:51,550 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:51,562 - DEBUG - Requesting: http://10.0.0.65:8082/project/3705f1ce-c5c8-4ce9-8446-6e6bcdfe3cae
2026-02-26 03:12:51,652 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/df8824cf-63b9-4a08-9b14-0a928a12cc11
2026-02-26 03:12:51,664 - DEBUG - =>VN service-right-vn-96645428 has no policy to be verified
2026-02-26 03:12:51,664 - DEBUG - Verifying the vn in opserver
2026-02-26 03:12:51,664 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-83075497:service-right-vn-96645428 virtual network link through opserver 10.0.0.65
2026-02-26 03:12:51,664 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-02-26 03:12:51,736 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-83075497:service-right-vn-96645428', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-83075497:service-right-vn-96645428?flat'}
2026-02-26 03:12:51,736 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-83075497:service-right-vn-96645428 virtual network link through opserver 10.0.0.73
2026-02-26 03:12:51,737 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2026-02-26 03:12:51,814 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-83075497:service-right-vn-96645428', 'href': 'http://10.0.0.73:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-83075497:service-right-vn-96645428?flat'}
2026-02-26 03:12:51,814 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-83075497:service-right-vn-96645428 virtual network link through opserver 10.0.0.131
2026-02-26 03:12:51,814 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-02-26 03:12:51,896 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-83075497:service-right-vn-96645428', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-83075497:service-right-vn-96645428?flat'}
2026-02-26 03:12:51,896 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-83075497:service-right-vn-96645428 is found in opserver
2026-02-26 03:12:51,920 - DEBUG - Do not have enough data to verify VN in agent
2026-02-26 03:12:51,931 - DEBUG - VRF ids for VN service-right-vn-96645428: {}
2026-02-26 03:12:52,009 - DEBUG - Services list from nova: [, , , ]
2026-02-26 03:12:53,281 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5402-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5402-2)
2026-02-26 03:12:54,892 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5402-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5402-1)
2026-02-26 03:12:54,892 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-15906587']
2026-02-26 03:12:55,193 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-15906587'] created succesfully
2026-02-26 03:12:55,663 - DEBUG - Image by name tiny_nat_fw not found
2026-02-26 03:12:55,663 - DEBUG - Installing image tiny_nat_fw
2026-02-26 03:12:55,663 - 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-02-26 03:12:55,663 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-26 03:12:55,663 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-26 03:12:55,663 - DEBUG - Unzip image
2026-02-26 03:12:55,663 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-26 03:12:55,688 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-02-26 03:12:55,689 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-15906587']
2026-02-26 03:12:55,854 - INFO - Service template: ['default-domain', 'ctest-service_template_1-15906587'] deleted successfully.
2026-02-26 03:12:55,854 - INFO - Skip interface_detach for VM ctest-right_vm-48713116 in state BUILD
2026-02-26 03:12:55,855 - INFO - Deleting VM ctest-right_vm-48713116
2026-02-26 03:12:55,905 - ERROR - VM ctest-right_vm-48713116 has failed to come up
2026-02-26 03:12:55,905 - ERROR - Nova failed to get host of the VM
2026-02-26 03:12:55,905 - ERROR - VM ctest-right_vm-48713116 has failed to come up
2026-02-26 03:12:55,905 - ERROR - Nova failed to get host of the VM
2026-02-26 03:12:55,984 - INFO - Skip interface_detach for VM ctest-left_vm-35727838 in state BUILD
2026-02-26 03:12:55,984 - INFO - Deleting VM ctest-left_vm-35727838
2026-02-26 03:12:55,984 - ERROR - VM ctest-left_vm-35727838 has failed to come up
2026-02-26 03:12:55,984 - ERROR - Nova failed to get host of the VM
2026-02-26 03:12:55,984 - ERROR - VM ctest-left_vm-35727838 has failed to come up
2026-02-26 03:12:55,984 - ERROR - Nova failed to get host of the VM
2026-02-26 03:12:56,072 - INFO - Deleting VN service-right-vn-96645428
2026-02-26 03:12:56,115 - DEBUG - VN df8824cf-63b9-4a08-9b14-0a928a12cc11 still in use: Unable to complete operation on network df8824cf-63b9-4a08-9b14-0a928a12cc11. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-d79743e3-6bbc-43e8-9a1e-35795a6b7b49']
2026-02-26 03:12:56,115 - WARNING - Deleting VN service-right-vn-96645428 failed..Will retry
2026-02-26 03:12:58,278 - DEBUG - Response for deleting network ()
2026-02-26 03:12:58,278 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/3ea75b12-f244-458c-88ea-4ced628c094e
2026-02-26 03:12:58,288 - DEBUG - Response Code: 404
2026-02-26 03:12:58,288 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:58,296 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:58,335 - DEBUG - Requesting: http://10.0.0.65:8082/project/3705f1ce-c5c8-4ce9-8446-6e6bcdfe3cae
2026-02-26 03:12:58,454 - INFO - Validated that VN service-right-vn-96645428 is not found in API Server
2026-02-26 03:12:58,466 - DEBUG - VN service-right-vn-96645428 is not present in Agent 10.0.0.23
2026-02-26 03:12:58,479 - DEBUG - VN service-right-vn-96645428 is not present in Agent 10.0.0.48
2026-02-26 03:12:58,479 - INFO - Validated that VN service-right-vn-96645428 is not in any agent
2026-02-26 03:12:58,515 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-96645428 info
2026-02-26 03:12:58,515 - INFO - Deleting VN service-left-vn-24349768
2026-02-26 03:12:58,681 - DEBUG - Response for deleting network ()
2026-02-26 03:12:58,681 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/f0dd3b3a-2971-43d9-90f5-a4eb7d517d28
2026-02-26 03:12:58,689 - DEBUG - Response Code: 404
2026-02-26 03:12:58,689 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:58,701 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:58,719 - DEBUG - Requesting: http://10.0.0.65:8082/project/3705f1ce-c5c8-4ce9-8446-6e6bcdfe3cae
2026-02-26 03:12:58,825 - INFO - Validated that VN service-left-vn-24349768 is not found in API Server
2026-02-26 03:12:58,838 - DEBUG - VN service-left-vn-24349768 is not present in Agent 10.0.0.23
2026-02-26 03:12:58,852 - DEBUG - VN service-left-vn-24349768 is not present in Agent 10.0.0.48
2026-02-26 03:12:58,853 - INFO - Validated that VN service-left-vn-24349768 is not in any agent
2026-02-26 03:12:58,888 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-24349768 info
2026-02-26 03:12:58,888 - INFO - Deleting VN ctest-mgmt_vn-27295308
2026-02-26 03:12:59,068 - DEBUG - Response for deleting network ()
2026-02-26 03:12:59,068 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/7573b49e-f695-4095-ae52-8c6fe37c8c6b
2026-02-26 03:12:59,086 - DEBUG - Response Code: 404
2026-02-26 03:12:59,086 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:12:59,097 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:12:59,111 - DEBUG - Requesting: http://10.0.0.65:8082/project/3705f1ce-c5c8-4ce9-8446-6e6bcdfe3cae
2026-02-26 03:12:59,216 - INFO - Validated that VN ctest-mgmt_vn-27295308 is not found in API Server
2026-02-26 03:12:59,237 - DEBUG - VN ctest-mgmt_vn-27295308 is not present in Agent 10.0.0.23
2026-02-26 03:12:59,250 - DEBUG - VN ctest-mgmt_vn-27295308 is not present in Agent 10.0.0.48
2026-02-26 03:12:59,250 - INFO - Validated that VN ctest-mgmt_vn-27295308 is not in any agent
2026-02-26 03:12:59,285 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-27295308 info
2026-02-26 03:13:00,597 - DEBUG - No XMPP flaps were noticed during the test
2026-02-26 03:13:00,597 - INFO -
2026-02-26 03:13:00,598 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:16]
2026-02-26 03:13:00,598 - INFO - --------------------------------------------------------------------------------
2026-02-26 03:13:00,601 - INFO - ================================================================================
2026-02-26 03:13:00,601 - INFO - STARTING TEST : test_svc_in_network_datapath
2026-02-26 03:13:01,914 - DEBUG - Nothing to compare xmpp stats {'10.0.0.23': {'10.20.0.129': '0', '10.20.0.254': '0'}, '10.0.0.48': {'10.20.0.129': '0', '10.20.0.25': '0'}} with
2026-02-26 03:13:01,914 - INFO - Initial checks done. Running the testcase now
2026-02-26 03:13:01,914 - INFO -
2026-02-26 03:13:02,217 - DEBUG - Response for create_network : {'network': {'id': 'd49429fa-286d-4888-a2ba-d83adc748ad6', 'name': 'ctest-mgmt_vn-78311737', 'tenant_id': '3705f1cec5c84ce984466e6bcdfe3cae', 'project_id': '3705f1cec5c84ce984466e6bcdfe3cae', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-83075497', 'ctest-mgmt_vn-78311737'], 'port_security_enabled': True, 'description': ''}}
2026-02-26 03:13:02,481 - DEBUG - Response for create_subnet : {'subnet': {'id': '8dab0f67-74c2-41db-9d1a-45224d2f3b25', 'name': '', 'tenant_id': '3705f1cec5c84ce984466e6bcdfe3cae', 'network_id': 'd49429fa-286d-4888-a2ba-d83adc748ad6', 'ip_version': 4, 'cidr': '119.54.118.0/26', 'allocation_pools': [{'start': '119.54.118.2', 'end': '119.54.118.62'}], 'gateway_ip': '119.54.118.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '119.54.118.2', 'tags': [], 'project_id': '3705f1cec5c84ce984466e6bcdfe3cae'}}
2026-02-26 03:13:02,505 - INFO - Created VN ctest-mgmt_vn-78311737
2026-02-26 03:13:02,541 - DEBUG - VN ctest-mgmt_vn-78311737 UUID is d49429fa-286d-4888-a2ba-d83adc748ad6
2026-02-26 03:13:02,651 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:13:02,664 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:13:02,678 - DEBUG - Requesting: http://10.0.0.65:8082/project/3705f1ce-c5c8-4ce9-8446-6e6bcdfe3cae
2026-02-26 03:13:02,836 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/d49429fa-286d-4888-a2ba-d83adc748ad6
2026-02-26 03:13:02,852 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/d49429fa-286d-4888-a2ba-d83adc748ad6
2026-02-26 03:13:02,868 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/2629e4b6-083d-4f7c-8317-65c148ea165a
2026-02-26 03:13:02,882 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/2629e4b6-083d-4f7c-8317-65c148ea165a
2026-02-26 03:13:02,896 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/10e2a253-d581-4e8c-a7a7-eb7f56345655
2026-02-26 03:13:02,906 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-26 03:13:02,907 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/d49429fa-286d-4888-a2ba-d83adc748ad6
2026-02-26 03:13:02,924 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/2629e4b6-083d-4f7c-8317-65c148ea165a
2026-02-26 03:13:02,944 - INFO - Verified VN network id 13 for VN d49429fa-286d-4888-a2ba-d83adc748ad6
2026-02-26 03:13:02,944 - INFO - Verifications in API Server for VN ctest-mgmt_vn-78311737 passed
2026-02-26 03:13:02,944 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/d49429fa-286d-4888-a2ba-d83adc748ad6
2026-02-26 03:13:02,960 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/2629e4b6-083d-4f7c-8317-65c148ea165a
2026-02-26 03:13:02,973 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/2629e4b6-083d-4f7c-8317-65c148ea165a
2026-02-26 03:13:02,984 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/10e2a253-d581-4e8c-a7a7-eb7f56345655
2026-02-26 03:13:03,001 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-78311737', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-83075497', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15317914386990712968', 'uuid-lslong': '11725922327130835670'}, 'enable': 'true', 'created': '2026-02-26T03:13:02', 'last-modified': '2026-02-26T03:13:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.611401'}
2026-02-26 03:13:03,011 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-26 03:13:03,020 - DEBUG - Control-node 10.0.0.73 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-78311737', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-83075497', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15317914386990712968', 'uuid-lslong': '11725922327130835670'}, 'enable': 'true', 'created': '2026-02-26T03:13:02', 'last-modified': '2026-02-26T03:13:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.630852'}
2026-02-26 03:13:03,026 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-26 03:13:03,032 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-78311737', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-83075497', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15317914386990712968', 'uuid-lslong': '11725922327130835670'}, 'enable': 'true', 'created': '2026-02-26T03:13:02', 'last-modified': '2026-02-26T03:13:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.645422'}
2026-02-26 03:13:03,038 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-26 03:13:03,038 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-78311737 passed
2026-02-26 03:13:03,039 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-78311737 in API_Server ======
2026-02-26 03:13:03,039 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:13:03,047 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:13:03,059 - DEBUG - Requesting: http://10.0.0.65:8082/project/3705f1ce-c5c8-4ce9-8446-6e6bcdfe3cae
2026-02-26 03:13:03,193 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/d49429fa-286d-4888-a2ba-d83adc748ad6
2026-02-26 03:13:03,207 - DEBUG - =>VN ctest-mgmt_vn-78311737 has no policy to be verified
2026-02-26 03:13:03,207 - DEBUG - Verifying the vn in opserver
2026-02-26 03:13:03,207 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-78311737 virtual network link through opserver 10.0.0.65
2026-02-26 03:13:03,207 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-02-26 03:13:03,224 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-78311737', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-78311737?flat'}
2026-02-26 03:13:03,224 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-78311737 virtual network link through opserver 10.0.0.73
2026-02-26 03:13:03,224 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2026-02-26 03:13:03,244 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-78311737', 'href': 'http://10.0.0.73:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-78311737?flat'}
2026-02-26 03:13:03,244 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-78311737 virtual network link through opserver 10.0.0.131
2026-02-26 03:13:03,244 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-02-26 03:13:03,258 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-78311737', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-78311737?flat'}
2026-02-26 03:13:03,258 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-83075497:ctest-mgmt_vn-78311737 is found in opserver
2026-02-26 03:13:03,287 - DEBUG - Do not have enough data to verify VN in agent
2026-02-26 03:13:03,297 - DEBUG - VRF ids for VN ctest-mgmt_vn-78311737: {}
2026-02-26 03:13:03,671 - DEBUG - Response for create_network : {'network': {'id': 'd959b50e-7c3e-4fd8-87c7-b05166948063', 'name': 'ctest-left_vn-46231530', 'tenant_id': '3705f1cec5c84ce984466e6bcdfe3cae', 'project_id': '3705f1cec5c84ce984466e6bcdfe3cae', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-83075497', 'ctest-left_vn-46231530'], 'port_security_enabled': True, 'description': ''}}
2026-02-26 03:13:03,978 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f55af4cd-ba28-4fa3-b30c-6bc9975d38e7', 'name': '', 'tenant_id': '3705f1cec5c84ce984466e6bcdfe3cae', 'network_id': 'd959b50e-7c3e-4fd8-87c7-b05166948063', 'ip_version': 4, 'cidr': '63.35.199.0/26', 'allocation_pools': [{'start': '63.35.199.2', 'end': '63.35.199.62'}], 'gateway_ip': '63.35.199.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '63.35.199.2', 'tags': [], 'project_id': '3705f1cec5c84ce984466e6bcdfe3cae'}}
2026-02-26 03:13:04,015 - INFO - Created VN ctest-left_vn-46231530
2026-02-26 03:13:04,029 - DEBUG - VN ctest-left_vn-46231530 UUID is d959b50e-7c3e-4fd8-87c7-b05166948063
2026-02-26 03:13:04,125 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:13:04,133 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:13:04,150 - DEBUG - Requesting: http://10.0.0.65:8082/project/3705f1ce-c5c8-4ce9-8446-6e6bcdfe3cae
2026-02-26 03:13:04,255 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/d959b50e-7c3e-4fd8-87c7-b05166948063
2026-02-26 03:13:04,274 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/d959b50e-7c3e-4fd8-87c7-b05166948063
2026-02-26 03:13:04,286 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/e7179719-2617-4957-8a11-03b93652bf1c
2026-02-26 03:13:04,297 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/e7179719-2617-4957-8a11-03b93652bf1c
2026-02-26 03:13:04,309 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/8f7ac5a4-3bb0-4320-a993-7bd1de706064
2026-02-26 03:13:04,322 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-26 03:13:04,322 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/d959b50e-7c3e-4fd8-87c7-b05166948063
2026-02-26 03:13:04,336 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/e7179719-2617-4957-8a11-03b93652bf1c
2026-02-26 03:13:04,353 - INFO - Verified VN network id 14 for VN d959b50e-7c3e-4fd8-87c7-b05166948063
2026-02-26 03:13:04,355 - INFO - Verifications in API Server for VN ctest-left_vn-46231530 passed
2026-02-26 03:13:04,356 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/d959b50e-7c3e-4fd8-87c7-b05166948063
2026-02-26 03:13:04,370 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/e7179719-2617-4957-8a11-03b93652bf1c
2026-02-26 03:13:04,378 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/e7179719-2617-4957-8a11-03b93652bf1c
2026-02-26 03:13:04,386 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/8f7ac5a4-3bb0-4320-a993-7bd1de706064
2026-02-26 03:13:04,403 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-83075497:ctest-left_vn-46231530', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-83075497', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15661748252976238552', 'uuid-lslong': '9783982579145539683'}, 'enable': 'true', 'created': '2026-02-26T03:13:03', 'last-modified': '2026-02-26T03:13:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.489015'}
2026-02-26 03:13:04,414 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-26 03:13:04,420 - DEBUG - Control-node 10.0.0.73 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-83075497:ctest-left_vn-46231530', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-83075497', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15661748252976238552', 'uuid-lslong': '9783982579145539683'}, 'enable': 'true', 'created': '2026-02-26T03:13:03', 'last-modified': '2026-02-26T03:13:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.509105'}
2026-02-26 03:13:04,429 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-26 03:13:04,434 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-83075497:ctest-left_vn-46231530', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-83075497', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15661748252976238552', 'uuid-lslong': '9783982579145539683'}, 'enable': 'true', 'created': '2026-02-26T03:13:03', 'last-modified': '2026-02-26T03:13:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.520817'}
2026-02-26 03:13:04,443 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-26 03:13:04,443 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-46231530 passed
2026-02-26 03:13:04,444 - DEBUG - ====Verifying policy data for ctest-left_vn-46231530 in API_Server ======
2026-02-26 03:13:04,444 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:13:04,452 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:13:04,465 - DEBUG - Requesting: http://10.0.0.65:8082/project/3705f1ce-c5c8-4ce9-8446-6e6bcdfe3cae
2026-02-26 03:13:04,593 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/d959b50e-7c3e-4fd8-87c7-b05166948063
2026-02-26 03:13:04,605 - DEBUG - =>VN ctest-left_vn-46231530 has no policy to be verified
2026-02-26 03:13:04,605 - DEBUG - Verifying the vn in opserver
2026-02-26 03:13:04,605 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-83075497:ctest-left_vn-46231530 virtual network link through opserver 10.0.0.65
2026-02-26 03:13:04,605 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-02-26 03:13:04,617 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-83075497:ctest-left_vn-46231530', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-83075497:ctest-left_vn-46231530?flat'}
2026-02-26 03:13:04,617 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-83075497:ctest-left_vn-46231530 virtual network link through opserver 10.0.0.73
2026-02-26 03:13:04,618 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2026-02-26 03:13:04,630 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-83075497:ctest-left_vn-46231530', 'href': 'http://10.0.0.73:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-83075497:ctest-left_vn-46231530?flat'}
2026-02-26 03:13:04,630 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-83075497:ctest-left_vn-46231530 virtual network link through opserver 10.0.0.131
2026-02-26 03:13:04,630 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-02-26 03:13:04,644 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-83075497:ctest-left_vn-46231530', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-83075497:ctest-left_vn-46231530?flat'}
2026-02-26 03:13:04,644 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-83075497:ctest-left_vn-46231530 is found in opserver
2026-02-26 03:13:04,674 - DEBUG - Do not have enough data to verify VN in agent
2026-02-26 03:13:04,688 - DEBUG - VRF ids for VN ctest-left_vn-46231530: {}
2026-02-26 03:13:04,970 - DEBUG - Response for create_network : {'network': {'id': '79249819-741b-46f4-a667-280e8a861a24', 'name': 'ctest-right_vn-44065766', 'tenant_id': '3705f1cec5c84ce984466e6bcdfe3cae', 'project_id': '3705f1cec5c84ce984466e6bcdfe3cae', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-83075497', 'ctest-right_vn-44065766'], 'port_security_enabled': True, 'description': ''}}
2026-02-26 03:13:05,237 - DEBUG - Response for create_subnet : {'subnet': {'id': '0f7ce7a7-b329-4644-a979-5ec51e8f5150', 'name': '', 'tenant_id': '3705f1cec5c84ce984466e6bcdfe3cae', 'network_id': '79249819-741b-46f4-a667-280e8a861a24', 'ip_version': 4, 'cidr': '138.66.60.192/26', 'allocation_pools': [{'start': '138.66.60.194', 'end': '138.66.60.254'}], 'gateway_ip': '138.66.60.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '138.66.60.194', 'tags': [], 'project_id': '3705f1cec5c84ce984466e6bcdfe3cae'}}
2026-02-26 03:13:05,278 - INFO - Created VN ctest-right_vn-44065766
2026-02-26 03:13:05,291 - DEBUG - VN ctest-right_vn-44065766 UUID is 79249819-741b-46f4-a667-280e8a861a24
2026-02-26 03:13:05,384 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:13:05,393 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:13:05,406 - DEBUG - Requesting: http://10.0.0.65:8082/project/3705f1ce-c5c8-4ce9-8446-6e6bcdfe3cae
2026-02-26 03:13:05,508 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/79249819-741b-46f4-a667-280e8a861a24
2026-02-26 03:13:05,544 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/79249819-741b-46f4-a667-280e8a861a24
2026-02-26 03:13:05,559 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/635576d0-3a18-4f85-9b9b-758713ddbd2a
2026-02-26 03:13:05,569 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/635576d0-3a18-4f85-9b9b-758713ddbd2a
2026-02-26 03:13:05,580 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/8b7f4c76-14c7-430b-852e-8cbfda3e3c3e
2026-02-26 03:13:05,591 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-26 03:13:05,591 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/79249819-741b-46f4-a667-280e8a861a24
2026-02-26 03:13:05,604 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/635576d0-3a18-4f85-9b9b-758713ddbd2a
2026-02-26 03:13:05,625 - INFO - Verified VN network id 15 for VN 79249819-741b-46f4-a667-280e8a861a24
2026-02-26 03:13:05,625 - INFO - Verifications in API Server for VN ctest-right_vn-44065766 passed
2026-02-26 03:13:05,625 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/79249819-741b-46f4-a667-280e8a861a24
2026-02-26 03:13:05,637 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/635576d0-3a18-4f85-9b9b-758713ddbd2a
2026-02-26 03:13:05,654 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/635576d0-3a18-4f85-9b9b-758713ddbd2a
2026-02-26 03:13:05,665 - DEBUG - Requesting: http://10.0.0.65:8082/route-target/8b7f4c76-14c7-430b-852e-8cbfda3e3c3e
2026-02-26 03:13:05,691 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-83075497:ctest-right_vn-44065766', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-83075497', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8729269212840412916', 'uuid-lslong': '11990596575815932452'}, 'enable': 'true', 'created': '2026-02-26T03:13:04', 'last-modified': '2026-02-26T03:13:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.491692'}
2026-02-26 03:13:05,704 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-26 03:13:05,712 - DEBUG - Control-node 10.0.0.73 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-83075497:ctest-right_vn-44065766', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-83075497', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8729269212840412916', 'uuid-lslong': '11990596575815932452'}, 'enable': 'true', 'created': '2026-02-26T03:13:04', 'last-modified': '2026-02-26T03:13:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.519473'}
2026-02-26 03:13:05,720 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-26 03:13:05,726 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-83075497:ctest-right_vn-44065766', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-83075497', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8729269212840412916', 'uuid-lslong': '11990596575815932452'}, 'enable': 'true', 'created': '2026-02-26T03:13:04', 'last-modified': '2026-02-26T03:13:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.532507'}
2026-02-26 03:13:05,732 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-26 03:13:05,732 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-44065766 passed
2026-02-26 03:13:05,732 - DEBUG - ====Verifying policy data for ctest-right_vn-44065766 in API_Server ======
2026-02-26 03:13:05,732 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:13:05,740 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:13:05,762 - DEBUG - Requesting: http://10.0.0.65:8082/project/3705f1ce-c5c8-4ce9-8446-6e6bcdfe3cae
2026-02-26 03:13:05,887 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-network/79249819-741b-46f4-a667-280e8a861a24
2026-02-26 03:13:05,904 - DEBUG - =>VN ctest-right_vn-44065766 has no policy to be verified
2026-02-26 03:13:05,904 - DEBUG - Verifying the vn in opserver
2026-02-26 03:13:05,904 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-83075497:ctest-right_vn-44065766 virtual network link through opserver 10.0.0.65
2026-02-26 03:13:05,904 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-02-26 03:13:05,923 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-83075497:ctest-right_vn-44065766', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-83075497:ctest-right_vn-44065766?flat'}
2026-02-26 03:13:05,923 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-83075497:ctest-right_vn-44065766 virtual network link through opserver 10.0.0.73
2026-02-26 03:13:05,923 - DEBUG - Requesting: http://10.0.0.73:8081/analytics/uves/virtual-networks
2026-02-26 03:13:05,938 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-83075497:ctest-right_vn-44065766', 'href': 'http://10.0.0.73:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-83075497:ctest-right_vn-44065766?flat'}
2026-02-26 03:13:05,938 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-83075497:ctest-right_vn-44065766 virtual network link through opserver 10.0.0.131
2026-02-26 03:13:05,938 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-02-26 03:13:05,954 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-83075497:ctest-right_vn-44065766', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-83075497:ctest-right_vn-44065766?flat'}
2026-02-26 03:13:05,954 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-83075497:ctest-right_vn-44065766 is found in opserver
2026-02-26 03:13:05,982 - DEBUG - Do not have enough data to verify VN in agent
2026-02-26 03:13:05,996 - DEBUG - VRF ids for VN ctest-right_vn-44065766: {}
2026-02-26 03:13:07,420 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5402-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5402-1)
2026-02-26 03:13:09,154 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5402-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5402-2)
2026-02-26 03:13:09,155 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-05625240']
2026-02-26 03:13:09,473 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-05625240'] created succesfully
2026-02-26 03:13:09,935 - DEBUG - Image by name tiny_nat_fw not found
2026-02-26 03:13:09,935 - DEBUG - Installing image tiny_nat_fw
2026-02-26 03:13:09,935 - 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-02-26 03:13:09,935 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-26 03:13:09,935 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-26 03:13:09,935 - DEBUG - Unzip image
2026-02-26 03:13:09,935 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-26 03:13:09,957 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-02-26 03:13:09,958 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-05625240']
2026-02-26 03:13:10,044 - INFO - Service template: ['default-domain', 'ctest-service_template_1-05625240'] deleted successfully.
2026-02-26 03:13:10,044 - INFO - Skip interface_detach for VM ctest-right_vm-13670449 in state BUILD
2026-02-26 03:13:10,044 - INFO - Deleting VM ctest-right_vm-13670449
2026-02-26 03:13:10,044 - ERROR - VM ctest-right_vm-13670449 has failed to come up
2026-02-26 03:13:10,045 - ERROR - Nova failed to get host of the VM
2026-02-26 03:13:10,045 - ERROR - VM ctest-right_vm-13670449 has failed to come up
2026-02-26 03:13:10,045 - ERROR - Nova failed to get host of the VM
2026-02-26 03:13:10,174 - INFO - Skip interface_detach for VM ctest-left_vm-87325526 in state BUILD
2026-02-26 03:13:10,174 - INFO - Deleting VM ctest-left_vm-87325526
2026-02-26 03:13:10,174 - ERROR - VM ctest-left_vm-87325526 has failed to come up
2026-02-26 03:13:10,174 - ERROR - Nova failed to get host of the VM
2026-02-26 03:13:10,174 - ERROR - VM ctest-left_vm-87325526 has failed to come up
2026-02-26 03:13:10,174 - ERROR - Nova failed to get host of the VM
2026-02-26 03:13:10,273 - INFO - Deleting VN ctest-right_vn-44065766
2026-02-26 03:13:10,343 - DEBUG - VN 79249819-741b-46f4-a667-280e8a861a24 still in use: Unable to complete operation on network 79249819-741b-46f4-a667-280e8a861a24. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-d7bb2033-f45f-4ad4-ab10-3e127405910e']
2026-02-26 03:13:10,344 - WARNING - Deleting VN ctest-right_vn-44065766 failed..Will retry
2026-02-26 03:13:12,501 - DEBUG - Response for deleting network ()
2026-02-26 03:13:12,501 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/635576d0-3a18-4f85-9b9b-758713ddbd2a
2026-02-26 03:13:12,508 - DEBUG - Response Code: 404
2026-02-26 03:13:12,509 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:13:12,532 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:13:12,575 - DEBUG - Requesting: http://10.0.0.65:8082/project/3705f1ce-c5c8-4ce9-8446-6e6bcdfe3cae
2026-02-26 03:13:12,695 - INFO - Validated that VN ctest-right_vn-44065766 is not found in API Server
2026-02-26 03:13:12,708 - DEBUG - VN ctest-right_vn-44065766 is not present in Agent 10.0.0.23
2026-02-26 03:13:12,721 - DEBUG - VN ctest-right_vn-44065766 is not present in Agent 10.0.0.48
2026-02-26 03:13:12,722 - INFO - Validated that VN ctest-right_vn-44065766 is not in any agent
2026-02-26 03:13:12,761 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-44065766 info
2026-02-26 03:13:12,762 - INFO - Deleting VN ctest-left_vn-46231530
2026-02-26 03:13:12,931 - DEBUG - Response for deleting network ()
2026-02-26 03:13:12,931 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/e7179719-2617-4957-8a11-03b93652bf1c
2026-02-26 03:13:12,939 - DEBUG - Response Code: 404
2026-02-26 03:13:12,939 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:13:12,952 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:13:12,968 - DEBUG - Requesting: http://10.0.0.65:8082/project/3705f1ce-c5c8-4ce9-8446-6e6bcdfe3cae
2026-02-26 03:13:13,075 - INFO - Validated that VN ctest-left_vn-46231530 is not found in API Server
2026-02-26 03:13:13,088 - DEBUG - VN ctest-left_vn-46231530 is not present in Agent 10.0.0.23
2026-02-26 03:13:13,103 - DEBUG - VN ctest-left_vn-46231530 is not present in Agent 10.0.0.48
2026-02-26 03:13:13,103 - INFO - Validated that VN ctest-left_vn-46231530 is not in any agent
2026-02-26 03:13:13,138 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-46231530 info
2026-02-26 03:13:13,138 - INFO - Deleting VN ctest-mgmt_vn-78311737
2026-02-26 03:13:13,318 - DEBUG - Response for deleting network ()
2026-02-26 03:13:13,318 - DEBUG - Requesting: http://10.0.0.65:8082/routing-instance/2629e4b6-083d-4f7c-8317-65c148ea165a
2026-02-26 03:13:13,329 - DEBUG - Response Code: 404
2026-02-26 03:13:13,329 - DEBUG - Requesting: http://10.0.0.65:8082/domains
2026-02-26 03:13:13,336 - DEBUG - Requesting: http://10.0.0.65:8082/domain/ca8c29a2-0264-4f8f-adb5-14cf22895ebe
2026-02-26 03:13:13,392 - DEBUG - Requesting: http://10.0.0.65:8082/project/3705f1ce-c5c8-4ce9-8446-6e6bcdfe3cae
2026-02-26 03:13:13,494 - INFO - Validated that VN ctest-mgmt_vn-78311737 is not found in API Server
2026-02-26 03:13:13,506 - DEBUG - VN ctest-mgmt_vn-78311737 is not present in Agent 10.0.0.23
2026-02-26 03:13:13,517 - DEBUG - VN ctest-mgmt_vn-78311737 is not present in Agent 10.0.0.48
2026-02-26 03:13:13,517 - INFO - Validated that VN ctest-mgmt_vn-78311737 is not in any agent
2026-02-26 03:13:13,549 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-78311737 info
2026-02-26 03:13:14,818 - DEBUG - No XMPP flaps were noticed during the test
2026-02-26 03:13:14,819 - INFO -
2026-02-26 03:13:14,819 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:14]
2026-02-26 03:13:14,819 - INFO - --------------------------------------------------------------------------------
2026-02-26 03:13:15,706 - INFO - Deleted project: ctest-TestSvcRegr-83075497, ID : 3705f1ce-c5c8-4ce9-8446-6e6bcdfe3cae