]) created on node: (an-jenkins-deploy-platform-ansible-os-6343-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6343-1)
2026-10-05 04:08:59,612 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-87892420']
2026-10-05 04:08:59,918 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-87892420'] created succesfully
2026-10-05 04:09:00,258 - DEBUG - Image by name tiny_nat_fw not found
2026-10-05 04:09:00,258 - DEBUG - Installing image tiny_nat_fw
2026-10-05 04:09:00,258 - 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-10-05 04:09:00,259 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-10-05 04:09:00,259 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-10-05 04:09:00,280 - 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-10-05 04:09:00,430 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-10-05 04:09:00,431 - DEBUG - Unzip image
2026-10-05 04:09:00,431 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-10-05 04:09:00,454 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-10-05 04:09:00,454 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-87892420']
2026-10-05 04:09:00,558 - INFO - Service template: ['default-domain', 'ctest-service_template_1-87892420'] deleted successfully.
2026-10-05 04:09:00,558 - INFO - Skip interface_detach for VM ctest-right_vm-97233613 in state BUILD
2026-10-05 04:09:00,558 - INFO - Deleting VM ctest-right_vm-97233613
2026-10-05 04:09:00,600 - ERROR - VM ctest-right_vm-97233613 has failed to come up
2026-10-05 04:09:00,600 - ERROR - Nova failed to get host of the VM
2026-10-05 04:09:00,600 - ERROR - VM ctest-right_vm-97233613 has failed to come up
2026-10-05 04:09:00,600 - ERROR - Nova failed to get host of the VM
2026-10-05 04:09:00,767 - INFO - Skip interface_detach for VM ctest-left_vm-05084350 in state BUILD
2026-10-05 04:09:00,768 - INFO - Deleting VM ctest-left_vm-05084350
2026-10-05 04:09:00,768 - ERROR - VM ctest-left_vm-05084350 has failed to come up
2026-10-05 04:09:00,768 - ERROR - Nova failed to get host of the VM
2026-10-05 04:09:00,768 - ERROR - VM ctest-left_vm-05084350 has failed to come up
2026-10-05 04:09:00,768 - ERROR - Nova failed to get host of the VM
2026-10-05 04:09:00,972 - INFO - Deleting VN ctest-right_vn-60325046
2026-10-05 04:09:01,133 - DEBUG - Response for deleting network ()
2026-10-05 04:09:01,133 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/35d93217-2051-4767-ad39-bd27638b0bd5
2026-10-05 04:09:01,141 - DEBUG - Response Code: 404
2026-10-05 04:09:01,141 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:01,152 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:01,176 - DEBUG - Requesting: http://10.0.0.177:8082/project/cb51484c-c379-4d8d-adb0-2cf8111772f5
2026-10-05 04:09:01,290 - INFO - Validated that VN ctest-right_vn-60325046 is not found in API Server
2026-10-05 04:09:01,303 - DEBUG - VN ctest-right_vn-60325046 is not present in Agent 10.0.0.50
2026-10-05 04:09:01,316 - DEBUG - VN ctest-right_vn-60325046 is not present in Agent 10.0.0.191
2026-10-05 04:09:01,316 - INFO - Validated that VN ctest-right_vn-60325046 is not in any agent
2026-10-05 04:09:01,362 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-60325046 info
2026-10-05 04:09:01,362 - INFO - Deleting VN ctest-left_vn-12759771
2026-10-05 04:09:01,573 - DEBUG - Response for deleting network ()
2026-10-05 04:09:01,573 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/2e9d5ad7-2279-4a4e-9e24-fb6ec214d38e
2026-10-05 04:09:01,580 - DEBUG - Response Code: 404
2026-10-05 04:09:01,581 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:01,587 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:01,656 - DEBUG - Requesting: http://10.0.0.177:8082/project/cb51484c-c379-4d8d-adb0-2cf8111772f5
2026-10-05 04:09:01,753 - INFO - Validated that VN ctest-left_vn-12759771 is not found in API Server
2026-10-05 04:09:01,810 - DEBUG - VN ctest-left_vn-12759771 is not present in Agent 10.0.0.50
2026-10-05 04:09:01,824 - DEBUG - VN ctest-left_vn-12759771 is not present in Agent 10.0.0.191
2026-10-05 04:09:01,824 - INFO - Validated that VN ctest-left_vn-12759771 is not in any agent
2026-10-05 04:09:01,877 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-12759771 info
2026-10-05 04:09:01,878 - INFO - Deleting VN ctest-mgmt_vn-56255384
2026-10-05 04:09:02,089 - DEBUG - Response for deleting network ()
2026-10-05 04:09:02,089 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/31bf8a12-1fa2-4b4d-b143-74dd9a1196d6
2026-10-05 04:09:02,099 - DEBUG - Response Code: 404
2026-10-05 04:09:02,099 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:02,106 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:02,123 - DEBUG - Requesting: http://10.0.0.177:8082/project/cb51484c-c379-4d8d-adb0-2cf8111772f5
2026-10-05 04:09:02,256 - INFO - Validated that VN ctest-mgmt_vn-56255384 is not found in API Server
2026-10-05 04:09:02,278 - DEBUG - VN ctest-mgmt_vn-56255384 is not present in Agent 10.0.0.50
2026-10-05 04:09:02,291 - DEBUG - VN ctest-mgmt_vn-56255384 is not present in Agent 10.0.0.191
2026-10-05 04:09:02,291 - INFO - Validated that VN ctest-mgmt_vn-56255384 is not in any agent
2026-10-05 04:09:02,349 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-56255384 info
2026-10-05 04:09:02,349 - INFO - Deleting VM ctest-vm-in-third-vn-72674774
2026-10-05 04:09:02,443 - INFO - Deleting VN ctest-third-vn-78711671
2026-10-05 04:09:02,501 - DEBUG - VN 3513d6ac-f23e-4c06-8d36-df5ec6ae69d7 still in use: Unable to complete operation on network 3513d6ac-f23e-4c06-8d36-df5ec6ae69d7. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-bbad743e-8e42-471a-9e91-2eb109b5aeb0']
2026-10-05 04:09:02,501 - WARNING - Deleting VN ctest-third-vn-78711671 failed..Will retry
2026-10-05 04:09:04,552 - DEBUG - VN 3513d6ac-f23e-4c06-8d36-df5ec6ae69d7 still in use: Unable to complete operation on network 3513d6ac-f23e-4c06-8d36-df5ec6ae69d7. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-2b5c3142-20e7-4fd9-af4a-0c4728dd20e6']
2026-10-05 04:09:04,552 - WARNING - Deleting VN ctest-third-vn-78711671 failed..Will retry
2026-10-05 04:09:06,746 - DEBUG - Response for deleting network ()
2026-10-05 04:09:08,079 - DEBUG - No XMPP flaps were noticed during the test
2026-10-05 04:09:08,079 - INFO -
2026-10-05 04:09:08,079 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:51]
2026-10-05 04:09:08,079 - INFO - --------------------------------------------------------------------------------
2026-10-05 04:09:08,082 - INFO - ================================================================================
2026-10-05 04:09:08,083 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2026-10-05 04:09:09,409 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.14': '0', '10.20.0.25': '0'}, '10.0.0.191': {'10.20.0.254': '0', '10.20.0.25': '0'}} with
2026-10-05 04:09:09,409 - INFO - Initial checks done. Running the testcase now
2026-10-05 04:09:09,409 - INFO -
2026-10-05 04:09:09,793 - DEBUG - Response for create_network : {'network': {'id': '73e03064-7bcd-4b55-9879-b0558a680891', 'name': 'ctest-mgmt_vn-36461573', 'tenant_id': 'cb51484cc3794d8dadb02cf8111772f5', 'project_id': 'cb51484cc3794d8dadb02cf8111772f5', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-60268001', 'ctest-mgmt_vn-36461573'], 'port_security_enabled': True, 'description': ''}}
2026-10-05 04:09:10,058 - DEBUG - Response for create_subnet : {'subnet': {'id': 'b0584972-e23d-4322-b3d4-f18520609e39', 'name': '', 'tenant_id': 'cb51484cc3794d8dadb02cf8111772f5', 'network_id': '73e03064-7bcd-4b55-9879-b0558a680891', 'ip_version': 4, 'cidr': '221.84.77.64/26', 'allocation_pools': [{'start': '221.84.77.66', 'end': '221.84.77.126'}], 'gateway_ip': '221.84.77.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '221.84.77.66', 'tags': [], 'project_id': 'cb51484cc3794d8dadb02cf8111772f5'}}
2026-10-05 04:09:10,093 - INFO - Created VN ctest-mgmt_vn-36461573
2026-10-05 04:09:10,114 - DEBUG - VN ctest-mgmt_vn-36461573 UUID is 73e03064-7bcd-4b55-9879-b0558a680891
2026-10-05 04:09:10,215 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:10,229 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:10,244 - DEBUG - Requesting: http://10.0.0.177:8082/project/cb51484c-c379-4d8d-adb0-2cf8111772f5
2026-10-05 04:09:10,379 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/73e03064-7bcd-4b55-9879-b0558a680891
2026-10-05 04:09:10,394 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/73e03064-7bcd-4b55-9879-b0558a680891
2026-10-05 04:09:10,410 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/9bdad1c5-6af5-4f2e-8a38-894f8d7c0c86
2026-10-05 04:09:10,421 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/9bdad1c5-6af5-4f2e-8a38-894f8d7c0c86
2026-10-05 04:09:10,432 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/9308ac24-c275-468f-8cb1-bcd2c52fd3ba
2026-10-05 04:09:10,442 - DEBUG - Route Targets: ['target:64512:8000010']
2026-10-05 04:09:10,442 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/73e03064-7bcd-4b55-9879-b0558a680891
2026-10-05 04:09:10,455 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/9bdad1c5-6af5-4f2e-8a38-894f8d7c0c86
2026-10-05 04:09:10,476 - INFO - Verified VN network id 19 for VN 73e03064-7bcd-4b55-9879-b0558a680891
2026-10-05 04:09:10,476 - INFO - Verifications in API Server for VN ctest-mgmt_vn-36461573 passed
2026-10-05 04:09:10,476 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/73e03064-7bcd-4b55-9879-b0558a680891
2026-10-05 04:09:10,492 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/9bdad1c5-6af5-4f2e-8a38-894f8d7c0c86
2026-10-05 04:09:10,503 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/9bdad1c5-6af5-4f2e-8a38-894f8d7c0c86
2026-10-05 04:09:10,513 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/9308ac24-c275-468f-8cb1-bcd2c52fd3ba
2026-10-05 04:09:10,533 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-60268001:ctest-mgmt_vn-36461573', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-60268001', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8349726917276814165', 'uuid-lslong': '10987006647387818129'}, 'enable': 'true', 'created': '2026-10-05T04:09:09', 'last-modified': '2026-10-05T04:09:09', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.557056'}
2026-10-05 04:09:10,544 - DEBUG - Route Targets: ['target:64512:8000010']
2026-10-05 04:09:10,552 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-60268001:ctest-mgmt_vn-36461573', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-60268001', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8349726917276814165', 'uuid-lslong': '10987006647387818129'}, 'enable': 'true', 'created': '2026-10-05T04:09:09', 'last-modified': '2026-10-05T04:09:09', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.572600'}
2026-10-05 04:09:10,561 - DEBUG - Route Targets: ['target:64512:8000010']
2026-10-05 04:09:10,568 - DEBUG - Control-node 10.0.0.190 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-60268001:ctest-mgmt_vn-36461573', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-60268001', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8349726917276814165', 'uuid-lslong': '10987006647387818129'}, 'enable': 'true', 'created': '2026-10-05T04:09:09', 'last-modified': '2026-10-05T04:09:09', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.595963'}
2026-10-05 04:09:10,576 - DEBUG - Route Targets: ['target:64512:8000010']
2026-10-05 04:09:10,576 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-36461573 passed
2026-10-05 04:09:10,577 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-36461573 in API_Server ======
2026-10-05 04:09:10,577 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:10,591 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:10,610 - DEBUG - Requesting: http://10.0.0.177:8082/project/cb51484c-c379-4d8d-adb0-2cf8111772f5
2026-10-05 04:09:10,731 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/73e03064-7bcd-4b55-9879-b0558a680891
2026-10-05 04:09:10,744 - DEBUG - =>VN ctest-mgmt_vn-36461573 has no policy to be verified
2026-10-05 04:09:10,744 - DEBUG - Verifying the vn in opserver
2026-10-05 04:09:10,744 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-60268001:ctest-mgmt_vn-36461573 virtual network link through opserver 10.0.0.177
2026-10-05 04:09:10,744 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-10-05 04:09:10,758 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-60268001:ctest-mgmt_vn-36461573', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-60268001:ctest-mgmt_vn-36461573?flat'}
2026-10-05 04:09:10,758 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-60268001:ctest-mgmt_vn-36461573 virtual network link through opserver 10.0.0.38
2026-10-05 04:09:10,758 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-10-05 04:09:10,774 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-60268001:ctest-mgmt_vn-36461573', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-60268001:ctest-mgmt_vn-36461573?flat'}
2026-10-05 04:09:10,774 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-60268001:ctest-mgmt_vn-36461573 virtual network link through opserver 10.0.0.190
2026-10-05 04:09:10,774 - DEBUG - Requesting: http://10.0.0.190:8081/analytics/uves/virtual-networks
2026-10-05 04:09:10,842 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-60268001:ctest-mgmt_vn-36461573', 'href': 'http://10.0.0.190:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-60268001:ctest-mgmt_vn-36461573?flat'}
2026-10-05 04:09:10,842 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-60268001:ctest-mgmt_vn-36461573 is found in opserver
2026-10-05 04:09:10,876 - DEBUG - Do not have enough data to verify VN in agent
2026-10-05 04:09:10,889 - DEBUG - VRF ids for VN ctest-mgmt_vn-36461573: {}
2026-10-05 04:09:11,285 - DEBUG - Response for create_network : {'network': {'id': '6962570d-e993-489d-bac4-617c50c5c952', 'name': 'ctest-left_vn-12963617', 'tenant_id': 'cb51484cc3794d8dadb02cf8111772f5', 'project_id': 'cb51484cc3794d8dadb02cf8111772f5', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-60268001', 'ctest-left_vn-12963617'], 'port_security_enabled': True, 'description': ''}}
2026-10-05 04:09:11,542 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a718b252-e0f8-4d89-b4c9-445156d8cf96', 'name': '', 'tenant_id': 'cb51484cc3794d8dadb02cf8111772f5', 'network_id': '6962570d-e993-489d-bac4-617c50c5c952', 'ip_version': 4, 'cidr': '129.52.69.0/26', 'allocation_pools': [{'start': '129.52.69.2', 'end': '129.52.69.62'}], 'gateway_ip': '129.52.69.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '129.52.69.2', 'tags': [], 'project_id': 'cb51484cc3794d8dadb02cf8111772f5'}}
2026-10-05 04:09:11,571 - INFO - Created VN ctest-left_vn-12963617
2026-10-05 04:09:11,586 - DEBUG - VN ctest-left_vn-12963617 UUID is 6962570d-e993-489d-bac4-617c50c5c952
2026-10-05 04:09:11,680 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:11,692 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:11,708 - DEBUG - Requesting: http://10.0.0.177:8082/project/cb51484c-c379-4d8d-adb0-2cf8111772f5
2026-10-05 04:09:11,803 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/6962570d-e993-489d-bac4-617c50c5c952
2026-10-05 04:09:11,823 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/6962570d-e993-489d-bac4-617c50c5c952
2026-10-05 04:09:11,838 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/a20466f7-4865-445e-a2cb-4bf9bdd6c6a2
2026-10-05 04:09:11,849 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/a20466f7-4865-445e-a2cb-4bf9bdd6c6a2
2026-10-05 04:09:11,858 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/b5f83b58-7ad8-45f7-8f8d-6c1caed4eff2
2026-10-05 04:09:11,871 - DEBUG - Route Targets: ['target:64512:8000011']
2026-10-05 04:09:11,871 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/6962570d-e993-489d-bac4-617c50c5c952
2026-10-05 04:09:11,884 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/a20466f7-4865-445e-a2cb-4bf9bdd6c6a2
2026-10-05 04:09:11,907 - INFO - Verified VN network id 20 for VN 6962570d-e993-489d-bac4-617c50c5c952
2026-10-05 04:09:11,908 - INFO - Verifications in API Server for VN ctest-left_vn-12963617 passed
2026-10-05 04:09:11,908 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/6962570d-e993-489d-bac4-617c50c5c952
2026-10-05 04:09:11,923 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/a20466f7-4865-445e-a2cb-4bf9bdd6c6a2
2026-10-05 04:09:11,933 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/a20466f7-4865-445e-a2cb-4bf9bdd6c6a2
2026-10-05 04:09:11,954 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/b5f83b58-7ad8-45f7-8f8d-6c1caed4eff2
2026-10-05 04:09:11,980 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-60268001:ctest-left_vn-12963617', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-60268001', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7593727638965012637', 'uuid-lslong': '13457988773048863058'}, 'enable': 'true', 'created': '2026-10-05T04:09:11', 'last-modified': '2026-10-05T04:09:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.498828'}
2026-10-05 04:09:11,989 - DEBUG - Route Targets: ['target:64512:8000011']
2026-10-05 04:09:12,002 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-60268001:ctest-left_vn-12963617', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-60268001', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7593727638965012637', 'uuid-lslong': '13457988773048863058'}, 'enable': 'true', 'created': '2026-10-05T04:09:11', 'last-modified': '2026-10-05T04:09:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.516248'}
2026-10-05 04:09:12,010 - DEBUG - Route Targets: ['target:64512:8000011']
2026-10-05 04:09:12,019 - DEBUG - Control-node 10.0.0.190 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-60268001:ctest-left_vn-12963617', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-60268001', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7593727638965012637', 'uuid-lslong': '13457988773048863058'}, 'enable': 'true', 'created': '2026-10-05T04:09:11', 'last-modified': '2026-10-05T04:09:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.538951'}
2026-10-05 04:09:12,028 - DEBUG - Route Targets: ['target:64512:8000011']
2026-10-05 04:09:12,028 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-12963617 passed
2026-10-05 04:09:12,028 - DEBUG - ====Verifying policy data for ctest-left_vn-12963617 in API_Server ======
2026-10-05 04:09:12,028 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:12,035 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:12,049 - DEBUG - Requesting: http://10.0.0.177:8082/project/cb51484c-c379-4d8d-adb0-2cf8111772f5
2026-10-05 04:09:12,160 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/6962570d-e993-489d-bac4-617c50c5c952
2026-10-05 04:09:12,174 - DEBUG - =>VN ctest-left_vn-12963617 has no policy to be verified
2026-10-05 04:09:12,174 - DEBUG - Verifying the vn in opserver
2026-10-05 04:09:12,174 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-60268001:ctest-left_vn-12963617 virtual network link through opserver 10.0.0.177
2026-10-05 04:09:12,174 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-10-05 04:09:12,232 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-60268001:ctest-left_vn-12963617', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-60268001:ctest-left_vn-12963617?flat'}
2026-10-05 04:09:12,232 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-60268001:ctest-left_vn-12963617 virtual network link through opserver 10.0.0.38
2026-10-05 04:09:12,232 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-10-05 04:09:12,251 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-60268001:ctest-left_vn-12963617', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-60268001:ctest-left_vn-12963617?flat'}
2026-10-05 04:09:12,251 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-60268001:ctest-left_vn-12963617 virtual network link through opserver 10.0.0.190
2026-10-05 04:09:12,252 - DEBUG - Requesting: http://10.0.0.190:8081/analytics/uves/virtual-networks
2026-10-05 04:09:12,269 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-60268001:ctest-left_vn-12963617', 'href': 'http://10.0.0.190:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-60268001:ctest-left_vn-12963617?flat'}
2026-10-05 04:09:12,269 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-60268001:ctest-left_vn-12963617 is found in opserver
2026-10-05 04:09:12,297 - DEBUG - Do not have enough data to verify VN in agent
2026-10-05 04:09:12,310 - DEBUG - VRF ids for VN ctest-left_vn-12963617: {}
2026-10-05 04:09:12,644 - DEBUG - Response for create_network : {'network': {'id': '4c94c0b5-fe62-490e-ad59-0a9b376b143c', 'name': 'ctest-right_vn-65873396', 'tenant_id': 'cb51484cc3794d8dadb02cf8111772f5', 'project_id': 'cb51484cc3794d8dadb02cf8111772f5', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-60268001', 'ctest-right_vn-65873396'], 'port_security_enabled': True, 'description': ''}}
2026-10-05 04:09:12,947 - DEBUG - Response for create_subnet : {'subnet': {'id': '9451bfcb-ab66-4c33-b4d3-204c9ad7e153', 'name': '', 'tenant_id': 'cb51484cc3794d8dadb02cf8111772f5', 'network_id': '4c94c0b5-fe62-490e-ad59-0a9b376b143c', 'ip_version': 4, 'cidr': '219.25.232.192/26', 'allocation_pools': [{'start': '219.25.232.194', 'end': '219.25.232.254'}], 'gateway_ip': '219.25.232.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '219.25.232.194', 'tags': [], 'project_id': 'cb51484cc3794d8dadb02cf8111772f5'}}
2026-10-05 04:09:12,969 - INFO - Created VN ctest-right_vn-65873396
2026-10-05 04:09:12,983 - DEBUG - VN ctest-right_vn-65873396 UUID is 4c94c0b5-fe62-490e-ad59-0a9b376b143c
2026-10-05 04:09:13,066 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:13,074 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:13,088 - DEBUG - Requesting: http://10.0.0.177:8082/project/cb51484c-c379-4d8d-adb0-2cf8111772f5
2026-10-05 04:09:13,189 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/4c94c0b5-fe62-490e-ad59-0a9b376b143c
2026-10-05 04:09:13,204 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/4c94c0b5-fe62-490e-ad59-0a9b376b143c
2026-10-05 04:09:13,216 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/4eb64778-806a-4476-bd87-53b7c186db74
2026-10-05 04:09:13,234 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/4eb64778-806a-4476-bd87-53b7c186db74
2026-10-05 04:09:13,244 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/47d82fb3-5d84-4a93-a55d-c536796da948
2026-10-05 04:09:13,255 - DEBUG - Route Targets: ['target:64512:8000012']
2026-10-05 04:09:13,255 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/4c94c0b5-fe62-490e-ad59-0a9b376b143c
2026-10-05 04:09:13,267 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/4eb64778-806a-4476-bd87-53b7c186db74
2026-10-05 04:09:13,287 - INFO - Verified VN network id 21 for VN 4c94c0b5-fe62-490e-ad59-0a9b376b143c
2026-10-05 04:09:13,287 - INFO - Verifications in API Server for VN ctest-right_vn-65873396 passed
2026-10-05 04:09:13,287 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/4c94c0b5-fe62-490e-ad59-0a9b376b143c
2026-10-05 04:09:13,300 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/4eb64778-806a-4476-bd87-53b7c186db74
2026-10-05 04:09:13,309 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/4eb64778-806a-4476-bd87-53b7c186db74
2026-10-05 04:09:13,317 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/47d82fb3-5d84-4a93-a55d-c536796da948
2026-10-05 04:09:13,335 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-60268001:ctest-right_vn-65873396', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-60268001', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5518247331325167886', 'uuid-lslong': '12491026703254754364'}, 'enable': 'true', 'created': '2026-10-05T04:09:12', 'last-modified': '2026-10-05T04:09:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.443785'}
2026-10-05 04:09:13,343 - DEBUG - Route Targets: ['target:64512:8000012']
2026-10-05 04:09:13,350 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-60268001:ctest-right_vn-65873396', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-60268001', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5518247331325167886', 'uuid-lslong': '12491026703254754364'}, 'enable': 'true', 'created': '2026-10-05T04:09:12', 'last-modified': '2026-10-05T04:09:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.467923'}
2026-10-05 04:09:13,359 - DEBUG - Route Targets: ['target:64512:8000012']
2026-10-05 04:09:13,366 - DEBUG - Control-node 10.0.0.190 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-60268001:ctest-right_vn-65873396', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-60268001', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5518247331325167886', 'uuid-lslong': '12491026703254754364'}, 'enable': 'true', 'created': '2026-10-05T04:09:12', 'last-modified': '2026-10-05T04:09:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.486520'}
2026-10-05 04:09:13,377 - DEBUG - Route Targets: ['target:64512:8000012']
2026-10-05 04:09:13,377 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-65873396 passed
2026-10-05 04:09:13,377 - DEBUG - ====Verifying policy data for ctest-right_vn-65873396 in API_Server ======
2026-10-05 04:09:13,377 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:13,384 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:13,398 - DEBUG - Requesting: http://10.0.0.177:8082/project/cb51484c-c379-4d8d-adb0-2cf8111772f5
2026-10-05 04:09:13,503 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/4c94c0b5-fe62-490e-ad59-0a9b376b143c
2026-10-05 04:09:13,519 - DEBUG - =>VN ctest-right_vn-65873396 has no policy to be verified
2026-10-05 04:09:13,519 - DEBUG - Verifying the vn in opserver
2026-10-05 04:09:13,519 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-60268001:ctest-right_vn-65873396 virtual network link through opserver 10.0.0.177
2026-10-05 04:09:13,519 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-10-05 04:09:13,534 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-60268001:ctest-right_vn-65873396', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-60268001:ctest-right_vn-65873396?flat'}
2026-10-05 04:09:13,534 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-60268001:ctest-right_vn-65873396 virtual network link through opserver 10.0.0.38
2026-10-05 04:09:13,534 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-10-05 04:09:13,549 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-60268001:ctest-right_vn-65873396', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-60268001:ctest-right_vn-65873396?flat'}
2026-10-05 04:09:13,549 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-60268001:ctest-right_vn-65873396 virtual network link through opserver 10.0.0.190
2026-10-05 04:09:13,549 - DEBUG - Requesting: http://10.0.0.190:8081/analytics/uves/virtual-networks
2026-10-05 04:09:13,564 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-60268001:ctest-right_vn-65873396', 'href': 'http://10.0.0.190:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-60268001:ctest-right_vn-65873396?flat'}
2026-10-05 04:09:13,564 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-60268001:ctest-right_vn-65873396 is found in opserver
2026-10-05 04:09:13,588 - DEBUG - Do not have enough data to verify VN in agent
2026-10-05 04:09:13,600 - DEBUG - VRF ids for VN ctest-right_vn-65873396: {}
2026-10-05 04:09:13,942 - DEBUG - Response for create_network : {'network': {'id': '84a3f78b-6cb0-4912-afae-419b1c439909', 'name': 'ctest-trans_left_vn-38726293', 'tenant_id': 'cb51484cc3794d8dadb02cf8111772f5', 'project_id': 'cb51484cc3794d8dadb02cf8111772f5', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-60268001', 'ctest-trans_left_vn-38726293'], 'port_security_enabled': True, 'description': ''}}
2026-10-05 04:09:14,200 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f40e5cc8-fc6b-4a35-8851-e522c6e3ee74', 'name': '', 'tenant_id': 'cb51484cc3794d8dadb02cf8111772f5', 'network_id': '84a3f78b-6cb0-4912-afae-419b1c439909', 'ip_version': 4, 'cidr': '150.120.23.0/26', 'allocation_pools': [{'start': '150.120.23.2', 'end': '150.120.23.62'}], 'gateway_ip': '150.120.23.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '150.120.23.2', 'tags': [], 'project_id': 'cb51484cc3794d8dadb02cf8111772f5'}}
2026-10-05 04:09:14,225 - INFO - Created VN ctest-trans_left_vn-38726293
2026-10-05 04:09:14,243 - DEBUG - VN ctest-trans_left_vn-38726293 UUID is 84a3f78b-6cb0-4912-afae-419b1c439909
2026-10-05 04:09:14,321 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:14,329 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:14,343 - DEBUG - Requesting: http://10.0.0.177:8082/project/cb51484c-c379-4d8d-adb0-2cf8111772f5
2026-10-05 04:09:14,446 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/84a3f78b-6cb0-4912-afae-419b1c439909
2026-10-05 04:09:14,461 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/84a3f78b-6cb0-4912-afae-419b1c439909
2026-10-05 04:09:14,474 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/3e04531d-6650-48fe-a50b-ddcf7b778985
2026-10-05 04:09:14,485 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/3e04531d-6650-48fe-a50b-ddcf7b778985
2026-10-05 04:09:14,494 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/b6d57f92-ea8e-4d29-a6ee-81ce7a22ad69
2026-10-05 04:09:14,502 - DEBUG - Route Targets: ['target:64512:8000013']
2026-10-05 04:09:14,502 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/84a3f78b-6cb0-4912-afae-419b1c439909
2026-10-05 04:09:14,513 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/3e04531d-6650-48fe-a50b-ddcf7b778985
2026-10-05 04:09:14,536 - INFO - Verified VN network id 22 for VN 84a3f78b-6cb0-4912-afae-419b1c439909
2026-10-05 04:09:14,536 - INFO - Verifications in API Server for VN ctest-trans_left_vn-38726293 passed
2026-10-05 04:09:14,536 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/84a3f78b-6cb0-4912-afae-419b1c439909
2026-10-05 04:09:14,550 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/3e04531d-6650-48fe-a50b-ddcf7b778985
2026-10-05 04:09:14,559 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/3e04531d-6650-48fe-a50b-ddcf7b778985
2026-10-05 04:09:14,568 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/b6d57f92-ea8e-4d29-a6ee-81ce7a22ad69
2026-10-05 04:09:14,587 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-60268001:ctest-trans_left_vn-38726293', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-60268001', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9557755012406331666', 'uuid-lslong': '12659127737034971401'}, 'enable': 'true', 'created': '2026-10-05T04:09:13', 'last-modified': '2026-10-05T04:09:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.451356'}
2026-10-05 04:09:14,595 - DEBUG - Route Targets: ['target:64512:8000013']
2026-10-05 04:09:14,604 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-60268001:ctest-trans_left_vn-38726293', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-60268001', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9557755012406331666', 'uuid-lslong': '12659127737034971401'}, 'enable': 'true', 'created': '2026-10-05T04:09:13', 'last-modified': '2026-10-05T04:09:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.467306'}
2026-10-05 04:09:14,611 - DEBUG - Route Targets: ['target:64512:8000013']
2026-10-05 04:09:14,617 - DEBUG - Control-node 10.0.0.190 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-60268001:ctest-trans_left_vn-38726293', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-60268001', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9557755012406331666', 'uuid-lslong': '12659127737034971401'}, 'enable': 'true', 'created': '2026-10-05T04:09:13', 'last-modified': '2026-10-05T04:09:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.483953'}
2026-10-05 04:09:14,625 - DEBUG - Route Targets: ['target:64512:8000013']
2026-10-05 04:09:14,625 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-38726293 passed
2026-10-05 04:09:14,625 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-38726293 in API_Server ======
2026-10-05 04:09:14,625 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:14,633 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:14,648 - DEBUG - Requesting: http://10.0.0.177:8082/project/cb51484c-c379-4d8d-adb0-2cf8111772f5
2026-10-05 04:09:14,766 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/84a3f78b-6cb0-4912-afae-419b1c439909
2026-10-05 04:09:14,778 - DEBUG - =>VN ctest-trans_left_vn-38726293 has no policy to be verified
2026-10-05 04:09:14,778 - DEBUG - Verifying the vn in opserver
2026-10-05 04:09:14,779 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-60268001:ctest-trans_left_vn-38726293 virtual network link through opserver 10.0.0.177
2026-10-05 04:09:14,779 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-10-05 04:09:14,793 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-60268001:ctest-trans_left_vn-38726293', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-60268001:ctest-trans_left_vn-38726293?flat'}
2026-10-05 04:09:14,793 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-60268001:ctest-trans_left_vn-38726293 virtual network link through opserver 10.0.0.38
2026-10-05 04:09:14,794 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-10-05 04:09:14,808 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-60268001:ctest-trans_left_vn-38726293', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-60268001:ctest-trans_left_vn-38726293?flat'}
2026-10-05 04:09:14,808 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-60268001:ctest-trans_left_vn-38726293 virtual network link through opserver 10.0.0.190
2026-10-05 04:09:14,808 - DEBUG - Requesting: http://10.0.0.190:8081/analytics/uves/virtual-networks
2026-10-05 04:09:14,824 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-60268001:ctest-trans_left_vn-38726293', 'href': 'http://10.0.0.190:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-60268001:ctest-trans_left_vn-38726293?flat'}
2026-10-05 04:09:14,824 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-60268001:ctest-trans_left_vn-38726293 is found in opserver
2026-10-05 04:09:14,853 - DEBUG - Do not have enough data to verify VN in agent
2026-10-05 04:09:14,869 - DEBUG - VRF ids for VN ctest-trans_left_vn-38726293: {}
2026-10-05 04:09:15,210 - DEBUG - Response for create_network : {'network': {'id': 'c6cf70dc-f150-4f72-9c4c-a7fc0c392b6f', 'name': 'ctest-trans_right_vn-82277307', 'tenant_id': 'cb51484cc3794d8dadb02cf8111772f5', 'project_id': 'cb51484cc3794d8dadb02cf8111772f5', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-60268001', 'ctest-trans_right_vn-82277307'], 'port_security_enabled': True, 'description': ''}}
2026-10-05 04:09:15,433 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c0aed6f0-c58f-4179-9222-380b02147212', 'name': '', 'tenant_id': 'cb51484cc3794d8dadb02cf8111772f5', 'network_id': 'c6cf70dc-f150-4f72-9c4c-a7fc0c392b6f', 'ip_version': 4, 'cidr': '47.240.242.0/26', 'allocation_pools': [{'start': '47.240.242.2', 'end': '47.240.242.62'}], 'gateway_ip': '47.240.242.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '47.240.242.2', 'tags': [], 'project_id': 'cb51484cc3794d8dadb02cf8111772f5'}}
2026-10-05 04:09:15,455 - INFO - Created VN ctest-trans_right_vn-82277307
2026-10-05 04:09:15,470 - DEBUG - VN ctest-trans_right_vn-82277307 UUID is c6cf70dc-f150-4f72-9c4c-a7fc0c392b6f
2026-10-05 04:09:15,546 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:15,553 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:15,567 - DEBUG - Requesting: http://10.0.0.177:8082/project/cb51484c-c379-4d8d-adb0-2cf8111772f5
2026-10-05 04:09:15,664 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/c6cf70dc-f150-4f72-9c4c-a7fc0c392b6f
2026-10-05 04:09:15,679 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/c6cf70dc-f150-4f72-9c4c-a7fc0c392b6f
2026-10-05 04:09:15,689 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/150de567-0317-47ae-99f4-8a8afbea16c3
2026-10-05 04:09:15,703 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/150de567-0317-47ae-99f4-8a8afbea16c3
2026-10-05 04:09:15,711 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/f4e56c97-1427-44fd-8f51-02064869c8c4
2026-10-05 04:09:15,720 - DEBUG - Route Targets: ['target:64512:8000014']
2026-10-05 04:09:15,721 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/c6cf70dc-f150-4f72-9c4c-a7fc0c392b6f
2026-10-05 04:09:15,731 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/150de567-0317-47ae-99f4-8a8afbea16c3
2026-10-05 04:09:15,757 - INFO - Verified VN network id 23 for VN c6cf70dc-f150-4f72-9c4c-a7fc0c392b6f
2026-10-05 04:09:15,757 - INFO - Verifications in API Server for VN ctest-trans_right_vn-82277307 passed
2026-10-05 04:09:15,757 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/c6cf70dc-f150-4f72-9c4c-a7fc0c392b6f
2026-10-05 04:09:15,770 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/150de567-0317-47ae-99f4-8a8afbea16c3
2026-10-05 04:09:15,779 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/150de567-0317-47ae-99f4-8a8afbea16c3
2026-10-05 04:09:15,788 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/f4e56c97-1427-44fd-8f51-02064869c8c4
2026-10-05 04:09:15,802 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-60268001:ctest-trans_right_vn-82277307', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-60268001', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14325793033932525426', 'uuid-lslong': '11262561469125438319'}, 'enable': 'true', 'created': '2026-10-05T04:09:15', 'last-modified': '2026-10-05T04:09:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.424437'}
2026-10-05 04:09:15,810 - DEBUG - Route Targets: ['target:64512:8000014']
2026-10-05 04:09:15,818 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-60268001:ctest-trans_right_vn-82277307', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-60268001', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14325793033932525426', 'uuid-lslong': '11262561469125438319'}, 'enable': 'true', 'created': '2026-10-05T04:09:15', 'last-modified': '2026-10-05T04:09:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.448431'}
2026-10-05 04:09:15,827 - DEBUG - Route Targets: ['target:64512:8000014']
2026-10-05 04:09:15,836 - DEBUG - Control-node 10.0.0.190 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-60268001:ctest-trans_right_vn-82277307', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-60268001', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14325793033932525426', 'uuid-lslong': '11262561469125438319'}, 'enable': 'true', 'created': '2026-10-05T04:09:15', 'last-modified': '2026-10-05T04:09:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.459558'}
2026-10-05 04:09:15,845 - DEBUG - Route Targets: ['target:64512:8000014']
2026-10-05 04:09:15,845 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-82277307 passed
2026-10-05 04:09:15,846 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-82277307 in API_Server ======
2026-10-05 04:09:15,846 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:15,854 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:15,870 - DEBUG - Requesting: http://10.0.0.177:8082/project/cb51484c-c379-4d8d-adb0-2cf8111772f5
2026-10-05 04:09:15,974 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/c6cf70dc-f150-4f72-9c4c-a7fc0c392b6f
2026-10-05 04:09:15,990 - DEBUG - =>VN ctest-trans_right_vn-82277307 has no policy to be verified
2026-10-05 04:09:15,991 - DEBUG - Verifying the vn in opserver
2026-10-05 04:09:15,991 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-60268001:ctest-trans_right_vn-82277307 virtual network link through opserver 10.0.0.177
2026-10-05 04:09:15,991 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-10-05 04:09:16,006 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-60268001:ctest-trans_right_vn-82277307', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-60268001:ctest-trans_right_vn-82277307?flat'}
2026-10-05 04:09:16,006 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-60268001:ctest-trans_right_vn-82277307 virtual network link through opserver 10.0.0.38
2026-10-05 04:09:16,006 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-10-05 04:09:16,023 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-60268001:ctest-trans_right_vn-82277307', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-60268001:ctest-trans_right_vn-82277307?flat'}
2026-10-05 04:09:16,023 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-60268001:ctest-trans_right_vn-82277307 virtual network link through opserver 10.0.0.190
2026-10-05 04:09:16,023 - DEBUG - Requesting: http://10.0.0.190:8081/analytics/uves/virtual-networks
2026-10-05 04:09:16,040 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-60268001:ctest-trans_right_vn-82277307', 'href': 'http://10.0.0.190:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-60268001:ctest-trans_right_vn-82277307?flat'}
2026-10-05 04:09:16,040 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-60268001:ctest-trans_right_vn-82277307 is found in opserver
2026-10-05 04:09:16,067 - DEBUG - Do not have enough data to verify VN in agent
2026-10-05 04:09:16,078 - DEBUG - VRF ids for VN ctest-trans_right_vn-82277307: {}
2026-10-05 04:09:16,703 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6343-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6343-1)
2026-10-05 04:09:17,441 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6343-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6343-2)
2026-10-05 04:09:17,441 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-66243137']
2026-10-05 04:09:17,769 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-66243137'] created succesfully
2026-10-05 04:09:18,070 - DEBUG - Image by name tiny_trans_fw not found
2026-10-05 04:09:18,070 - DEBUG - Installing image tiny_trans_fw
2026-10-05 04:09:18,070 - 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-10-05 04:09:18,071 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-10-05 04:09:18,071 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-10-05 04:09:18,089 - 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-10-05 04:09:18,127 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-10-05 04:09:18,128 - DEBUG - Unzip image
2026-10-05 04:09:18,128 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-10-05 04:09:18,148 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-10-05 04:09:18,148 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-66243137']
2026-10-05 04:09:18,246 - INFO - Service template: ['default-domain', 'ctest-service_template_1-66243137'] deleted successfully.
2026-10-05 04:09:18,246 - INFO - Skip interface_detach for VM ctest-right_vm-22513476 in state BUILD
2026-10-05 04:09:18,246 - INFO - Deleting VM ctest-right_vm-22513476
2026-10-05 04:09:18,247 - ERROR - VM ctest-right_vm-22513476 has failed to come up
2026-10-05 04:09:18,247 - ERROR - Nova failed to get host of the VM
2026-10-05 04:09:18,247 - ERROR - VM ctest-right_vm-22513476 has failed to come up
2026-10-05 04:09:18,247 - ERROR - Nova failed to get host of the VM
2026-10-05 04:09:18,409 - INFO - Skip interface_detach for VM ctest-left_vm-39401402 in state BUILD
2026-10-05 04:09:18,409 - INFO - Deleting VM ctest-left_vm-39401402
2026-10-05 04:09:18,409 - ERROR - VM ctest-left_vm-39401402 has failed to come up
2026-10-05 04:09:18,409 - ERROR - Nova failed to get host of the VM
2026-10-05 04:09:18,409 - ERROR - VM ctest-left_vm-39401402 has failed to come up
2026-10-05 04:09:18,410 - ERROR - Nova failed to get host of the VM
2026-10-05 04:09:18,496 - INFO - Deleting VN ctest-trans_right_vn-82277307
2026-10-05 04:09:18,654 - DEBUG - Response for deleting network ()
2026-10-05 04:09:18,654 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/150de567-0317-47ae-99f4-8a8afbea16c3
2026-10-05 04:09:18,662 - DEBUG - Response Code: 404
2026-10-05 04:09:18,663 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:18,677 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:18,694 - DEBUG - Requesting: http://10.0.0.177:8082/project/cb51484c-c379-4d8d-adb0-2cf8111772f5
2026-10-05 04:09:18,806 - INFO - Validated that VN ctest-trans_right_vn-82277307 is not found in API Server
2026-10-05 04:09:18,819 - DEBUG - VN ctest-trans_right_vn-82277307 is not present in Agent 10.0.0.50
2026-10-05 04:09:18,837 - DEBUG - VN ctest-trans_right_vn-82277307 is not present in Agent 10.0.0.191
2026-10-05 04:09:18,837 - INFO - Validated that VN ctest-trans_right_vn-82277307 is not in any agent
2026-10-05 04:09:18,887 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-82277307 info
2026-10-05 04:09:18,888 - INFO - Deleting VN ctest-trans_left_vn-38726293
2026-10-05 04:09:19,061 - DEBUG - Response for deleting network ()
2026-10-05 04:09:19,061 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/3e04531d-6650-48fe-a50b-ddcf7b778985
2026-10-05 04:09:19,067 - DEBUG - Response Code: 404
2026-10-05 04:09:19,067 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:19,085 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:19,099 - DEBUG - Requesting: http://10.0.0.177:8082/project/cb51484c-c379-4d8d-adb0-2cf8111772f5
2026-10-05 04:09:19,219 - INFO - Validated that VN ctest-trans_left_vn-38726293 is not found in API Server
2026-10-05 04:09:19,238 - DEBUG - VN ctest-trans_left_vn-38726293 is not present in Agent 10.0.0.50
2026-10-05 04:09:19,255 - DEBUG - VN ctest-trans_left_vn-38726293 is not present in Agent 10.0.0.191
2026-10-05 04:09:19,255 - INFO - Validated that VN ctest-trans_left_vn-38726293 is not in any agent
2026-10-05 04:09:19,312 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-38726293 info
2026-10-05 04:09:19,313 - INFO - Deleting VN ctest-right_vn-65873396
2026-10-05 04:09:19,597 - DEBUG - Response for deleting network ()
2026-10-05 04:09:19,598 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/4eb64778-806a-4476-bd87-53b7c186db74
2026-10-05 04:09:19,605 - DEBUG - Response Code: 404
2026-10-05 04:09:19,605 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:19,612 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:19,669 - DEBUG - Requesting: http://10.0.0.177:8082/project/cb51484c-c379-4d8d-adb0-2cf8111772f5
2026-10-05 04:09:19,776 - INFO - Validated that VN ctest-right_vn-65873396 is not found in API Server
2026-10-05 04:09:19,791 - DEBUG - VN ctest-right_vn-65873396 is not present in Agent 10.0.0.50
2026-10-05 04:09:19,806 - DEBUG - VN ctest-right_vn-65873396 is not present in Agent 10.0.0.191
2026-10-05 04:09:19,806 - INFO - Validated that VN ctest-right_vn-65873396 is not in any agent
2026-10-05 04:09:19,859 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-65873396 info
2026-10-05 04:09:19,859 - INFO - Deleting VN ctest-left_vn-12963617
2026-10-05 04:09:20,052 - DEBUG - Response for deleting network ()
2026-10-05 04:09:20,052 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/a20466f7-4865-445e-a2cb-4bf9bdd6c6a2
2026-10-05 04:09:20,059 - DEBUG - Response Code: 404
2026-10-05 04:09:20,059 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:20,076 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:20,090 - DEBUG - Requesting: http://10.0.0.177:8082/project/cb51484c-c379-4d8d-adb0-2cf8111772f5
2026-10-05 04:09:20,206 - INFO - Validated that VN ctest-left_vn-12963617 is not found in API Server
2026-10-05 04:09:20,219 - DEBUG - VN ctest-left_vn-12963617 is not present in Agent 10.0.0.50
2026-10-05 04:09:20,232 - DEBUG - VN ctest-left_vn-12963617 is not present in Agent 10.0.0.191
2026-10-05 04:09:20,233 - INFO - Validated that VN ctest-left_vn-12963617 is not in any agent
2026-10-05 04:09:20,278 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-12963617 info
2026-10-05 04:09:20,279 - INFO - Deleting VN ctest-mgmt_vn-36461573
2026-10-05 04:09:20,458 - DEBUG - Response for deleting network ()
2026-10-05 04:09:20,458 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/9bdad1c5-6af5-4f2e-8a38-894f8d7c0c86
2026-10-05 04:09:20,466 - DEBUG - Response Code: 404
2026-10-05 04:09:20,466 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:20,475 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:20,498 - DEBUG - Requesting: http://10.0.0.177:8082/project/cb51484c-c379-4d8d-adb0-2cf8111772f5
2026-10-05 04:09:20,626 - INFO - Validated that VN ctest-mgmt_vn-36461573 is not found in API Server
2026-10-05 04:09:20,639 - DEBUG - VN ctest-mgmt_vn-36461573 is not present in Agent 10.0.0.50
2026-10-05 04:09:20,653 - DEBUG - VN ctest-mgmt_vn-36461573 is not present in Agent 10.0.0.191
2026-10-05 04:09:20,653 - INFO - Validated that VN ctest-mgmt_vn-36461573 is not in any agent
2026-10-05 04:09:20,696 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-36461573 info
2026-10-05 04:09:22,013 - DEBUG - No XMPP flaps were noticed during the test
2026-10-05 04:09:22,013 - INFO -
2026-10-05 04:09:22,013 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:14]
2026-10-05 04:09:22,014 - INFO - --------------------------------------------------------------------------------
2026-10-05 04:09:22,910 - INFO - Deleted project: ctest-TestSvcRegr-60268001, ID : cb51484c-c379-4d8d-adb0-2cf8111772f5
2026-10-05 04:09:23,133 - INFO - Domain Default found not creating
2026-10-05 04:09:23,330 - INFO - Project ctest-TestSvcRegr-10191597 not found, creating it
2026-10-05 04:09:23,982 - INFO - Created Project:ctest-TestSvcRegr-10191597, ID : e463d329-8ba4-4796-8165-091e7445c4a1
2026-10-05 04:09:26,020 - INFO - ================================================================================
2026-10-05 04:09:26,020 - INFO - STARTING TEST : test_svc_CEM_22032
2026-10-05 04:09:27,359 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.14': '0', '10.20.0.25': '0'}, '10.0.0.191': {'10.20.0.254': '0', '10.20.0.25': '0'}} with
2026-10-05 04:09:27,359 - INFO - Initial checks done. Running the testcase now
2026-10-05 04:09:27,360 - INFO -
2026-10-05 04:09:28,180 - DEBUG - Response for create_network : {'network': {'id': '02048854-2271-4d00-8194-0f4f754a7b19', 'name': 'ctest-mgmt_vn-20735175', 'tenant_id': 'e463d3298ba447968165091e7445c4a1', 'project_id': 'e463d3298ba447968165091e7445c4a1', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-10191597', 'ctest-mgmt_vn-20735175'], 'port_security_enabled': True, 'description': ''}}
2026-10-05 04:09:28,611 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a79a9753-ec48-47a8-bb0c-4ca50eb23681', 'name': '', 'tenant_id': 'e463d3298ba447968165091e7445c4a1', 'network_id': '02048854-2271-4d00-8194-0f4f754a7b19', 'ip_version': 4, 'cidr': '64.23.68.128/26', 'allocation_pools': [{'start': '64.23.68.130', 'end': '64.23.68.190'}], 'gateway_ip': '64.23.68.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '64.23.68.130', 'tags': [], 'project_id': 'e463d3298ba447968165091e7445c4a1'}}
2026-10-05 04:09:28,654 - INFO - Created VN ctest-mgmt_vn-20735175
2026-10-05 04:09:28,675 - DEBUG - VN ctest-mgmt_vn-20735175 UUID is 02048854-2271-4d00-8194-0f4f754a7b19
2026-10-05 04:09:28,765 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:29,162 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:29,213 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:29,235 - DEBUG - Requesting: http://10.0.0.177:8082/project/e463d329-8ba4-4796-8165-091e7445c4a1
2026-10-05 04:09:29,347 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/02048854-2271-4d00-8194-0f4f754a7b19
2026-10-05 04:09:29,363 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/02048854-2271-4d00-8194-0f4f754a7b19
2026-10-05 04:09:29,378 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/6dfac590-4ee2-4621-95cb-bd83b2ca0d9a
2026-10-05 04:09:29,387 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/6dfac590-4ee2-4621-95cb-bd83b2ca0d9a
2026-10-05 04:09:29,397 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/ee4c4f4d-9739-43c5-96a3-acba436f9787
2026-10-05 04:09:29,408 - DEBUG - Route Targets: ['target:64512:8000010']
2026-10-05 04:09:29,408 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/02048854-2271-4d00-8194-0f4f754a7b19
2026-10-05 04:09:29,422 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/6dfac590-4ee2-4621-95cb-bd83b2ca0d9a
2026-10-05 04:09:29,446 - INFO - Verified VN network id 19 for VN 02048854-2271-4d00-8194-0f4f754a7b19
2026-10-05 04:09:29,446 - INFO - Verifications in API Server for VN ctest-mgmt_vn-20735175 passed
2026-10-05 04:09:29,446 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/02048854-2271-4d00-8194-0f4f754a7b19
2026-10-05 04:09:29,463 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/6dfac590-4ee2-4621-95cb-bd83b2ca0d9a
2026-10-05 04:09:29,474 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/6dfac590-4ee2-4621-95cb-bd83b2ca0d9a
2026-10-05 04:09:29,487 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/ee4c4f4d-9739-43c5-96a3-acba436f9787
2026-10-05 04:09:29,506 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-20735175', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10191597', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '145390982919179520', 'uuid-lslong': '9337104761390529305'}, 'enable': 'true', 'created': '2026-10-05T04:09:28', 'last-modified': '2026-10-05T04:09:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.007414'}
2026-10-05 04:09:29,512 - DEBUG - Route Targets: ['target:64512:8000010']
2026-10-05 04:09:29,520 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-20735175', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10191597', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '145390982919179520', 'uuid-lslong': '9337104761390529305'}, 'enable': 'true', 'created': '2026-10-05T04:09:28', 'last-modified': '2026-10-05T04:09:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.023650'}
2026-10-05 04:09:29,527 - DEBUG - Route Targets: ['target:64512:8000010']
2026-10-05 04:09:29,534 - DEBUG - Control-node 10.0.0.190 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-20735175', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10191597', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '145390982919179520', 'uuid-lslong': '9337104761390529305'}, 'enable': 'true', 'created': '2026-10-05T04:09:28', 'last-modified': '2026-10-05T04:09:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.026479'}
2026-10-05 04:09:29,542 - DEBUG - Route Targets: ['target:64512:8000010']
2026-10-05 04:09:29,542 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-20735175 passed
2026-10-05 04:09:29,542 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-20735175 in API_Server ======
2026-10-05 04:09:29,543 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:29,553 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:29,586 - DEBUG - Requesting: http://10.0.0.177:8082/project/e463d329-8ba4-4796-8165-091e7445c4a1
2026-10-05 04:09:29,697 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/02048854-2271-4d00-8194-0f4f754a7b19
2026-10-05 04:09:29,710 - DEBUG - =>VN ctest-mgmt_vn-20735175 has no policy to be verified
2026-10-05 04:09:29,710 - DEBUG - Verifying the vn in opserver
2026-10-05 04:09:29,710 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-20735175 virtual network link through opserver 10.0.0.177
2026-10-05 04:09:29,710 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-10-05 04:09:30,106 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-10-05 04:09:30,191 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-20735175', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-20735175?flat'}
2026-10-05 04:09:30,191 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-20735175 virtual network link through opserver 10.0.0.38
2026-10-05 04:09:30,191 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-10-05 04:09:30,577 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-10-05 04:09:30,647 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-20735175', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-20735175?flat'}
2026-10-05 04:09:30,647 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-20735175 virtual network link through opserver 10.0.0.190
2026-10-05 04:09:30,647 - DEBUG - Requesting: http://10.0.0.190:8081/analytics/uves/virtual-networks
2026-10-05 04:09:31,020 - DEBUG - Requesting: http://10.0.0.190:8081/analytics/uves/virtual-networks
2026-10-05 04:09:31,087 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-20735175', 'href': 'http://10.0.0.190:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-20735175?flat'}
2026-10-05 04:09:31,087 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-20735175 is found in opserver
2026-10-05 04:09:31,155 - DEBUG - Do not have enough data to verify VN in agent
2026-10-05 04:09:31,180 - DEBUG - VRF ids for VN ctest-mgmt_vn-20735175: {}
2026-10-05 04:09:31,515 - DEBUG - Response for create_network : {'network': {'id': '6c69739e-2741-4d47-ba0f-30cf23a7ef34', 'name': 'service-left-vn-39387434', 'tenant_id': 'e463d3298ba447968165091e7445c4a1', 'project_id': 'e463d3298ba447968165091e7445c4a1', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-10191597', 'service-left-vn-39387434'], 'port_security_enabled': True, 'description': ''}}
2026-10-05 04:09:31,753 - DEBUG - Response for create_subnet : {'subnet': {'id': '3f965e8b-6845-47f3-999b-eeeaf055ae0e', 'name': '', 'tenant_id': 'e463d3298ba447968165091e7445c4a1', 'network_id': '6c69739e-2741-4d47-ba0f-30cf23a7ef34', 'ip_version': 4, 'cidr': '49.195.225.128/26', 'allocation_pools': [{'start': '49.195.225.130', 'end': '49.195.225.190'}], 'gateway_ip': '49.195.225.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '49.195.225.130', 'tags': [], 'project_id': 'e463d3298ba447968165091e7445c4a1'}}
2026-10-05 04:09:31,777 - INFO - Created VN service-left-vn-39387434
2026-10-05 04:09:31,791 - DEBUG - VN service-left-vn-39387434 UUID is 6c69739e-2741-4d47-ba0f-30cf23a7ef34
2026-10-05 04:09:31,871 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:31,880 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:31,895 - DEBUG - Requesting: http://10.0.0.177:8082/project/e463d329-8ba4-4796-8165-091e7445c4a1
2026-10-05 04:09:31,997 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/6c69739e-2741-4d47-ba0f-30cf23a7ef34
2026-10-05 04:09:32,014 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/6c69739e-2741-4d47-ba0f-30cf23a7ef34
2026-10-05 04:09:32,026 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/0d2e960b-b500-46c7-955d-1153987cb0a6
2026-10-05 04:09:32,041 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/0d2e960b-b500-46c7-955d-1153987cb0a6
2026-10-05 04:09:32,050 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/d3713c47-b28c-41aa-be3a-99ad522cd45f
2026-10-05 04:09:32,059 - DEBUG - Route Targets: ['target:64512:8000011']
2026-10-05 04:09:32,059 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/6c69739e-2741-4d47-ba0f-30cf23a7ef34
2026-10-05 04:09:32,070 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/0d2e960b-b500-46c7-955d-1153987cb0a6
2026-10-05 04:09:32,090 - INFO - Verified VN network id 20 for VN 6c69739e-2741-4d47-ba0f-30cf23a7ef34
2026-10-05 04:09:32,090 - INFO - Verifications in API Server for VN service-left-vn-39387434 passed
2026-10-05 04:09:32,090 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/6c69739e-2741-4d47-ba0f-30cf23a7ef34
2026-10-05 04:09:32,104 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/0d2e960b-b500-46c7-955d-1153987cb0a6
2026-10-05 04:09:32,114 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/0d2e960b-b500-46c7-955d-1153987cb0a6
2026-10-05 04:09:32,122 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/d3713c47-b28c-41aa-be3a-99ad522cd45f
2026-10-05 04:09:32,139 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10191597:service-left-vn-39387434', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10191597', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7811902151751454023', 'uuid-lslong': '13406988281919827764'}, 'enable': 'true', 'created': '2026-10-05T04:09:31', 'last-modified': '2026-10-05T04:09:31', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.446184'}
2026-10-05 04:09:32,149 - DEBUG - Route Targets: ['target:64512:8000011']
2026-10-05 04:09:32,156 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10191597:service-left-vn-39387434', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10191597', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7811902151751454023', 'uuid-lslong': '13406988281919827764'}, 'enable': 'true', 'created': '2026-10-05T04:09:31', 'last-modified': '2026-10-05T04:09:31', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.469591'}
2026-10-05 04:09:32,163 - DEBUG - Route Targets: ['target:64512:8000011']
2026-10-05 04:09:32,170 - DEBUG - Control-node 10.0.0.190 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10191597:service-left-vn-39387434', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10191597', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7811902151751454023', 'uuid-lslong': '13406988281919827764'}, 'enable': 'true', 'created': '2026-10-05T04:09:31', 'last-modified': '2026-10-05T04:09:31', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.474520'}
2026-10-05 04:09:32,177 - DEBUG - Route Targets: ['target:64512:8000011']
2026-10-05 04:09:32,177 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-39387434 passed
2026-10-05 04:09:32,177 - DEBUG - ====Verifying policy data for service-left-vn-39387434 in API_Server ======
2026-10-05 04:09:32,177 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:32,184 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:32,199 - DEBUG - Requesting: http://10.0.0.177:8082/project/e463d329-8ba4-4796-8165-091e7445c4a1
2026-10-05 04:09:32,324 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/6c69739e-2741-4d47-ba0f-30cf23a7ef34
2026-10-05 04:09:32,337 - DEBUG - =>VN service-left-vn-39387434 has no policy to be verified
2026-10-05 04:09:32,337 - DEBUG - Verifying the vn in opserver
2026-10-05 04:09:32,337 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10191597:service-left-vn-39387434 virtual network link through opserver 10.0.0.177
2026-10-05 04:09:32,337 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-10-05 04:09:32,416 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10191597:service-left-vn-39387434', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10191597:service-left-vn-39387434?flat'}
2026-10-05 04:09:32,416 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10191597:service-left-vn-39387434 virtual network link through opserver 10.0.0.38
2026-10-05 04:09:32,416 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-10-05 04:09:32,475 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10191597:service-left-vn-39387434', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10191597:service-left-vn-39387434?flat'}
2026-10-05 04:09:32,475 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10191597:service-left-vn-39387434 virtual network link through opserver 10.0.0.190
2026-10-05 04:09:32,475 - DEBUG - Requesting: http://10.0.0.190:8081/analytics/uves/virtual-networks
2026-10-05 04:09:32,531 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10191597:service-left-vn-39387434', 'href': 'http://10.0.0.190:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10191597:service-left-vn-39387434?flat'}
2026-10-05 04:09:32,531 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-10191597:service-left-vn-39387434 is found in opserver
2026-10-05 04:09:32,555 - DEBUG - Do not have enough data to verify VN in agent
2026-10-05 04:09:32,567 - DEBUG - VRF ids for VN service-left-vn-39387434: {}
2026-10-05 04:09:32,872 - DEBUG - Response for create_network : {'network': {'id': '532f57f6-38a0-49f8-81b7-1b2f09dc6a07', 'name': 'service-right-vn-75342732', 'tenant_id': 'e463d3298ba447968165091e7445c4a1', 'project_id': 'e463d3298ba447968165091e7445c4a1', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-10191597', 'service-right-vn-75342732'], 'port_security_enabled': True, 'description': ''}}
2026-10-05 04:09:33,121 - DEBUG - Response for create_subnet : {'subnet': {'id': '50310a4e-13a4-473b-af1b-24602e87ae4c', 'name': '', 'tenant_id': 'e463d3298ba447968165091e7445c4a1', 'network_id': '532f57f6-38a0-49f8-81b7-1b2f09dc6a07', 'ip_version': 4, 'cidr': '45.239.88.0/26', 'allocation_pools': [{'start': '45.239.88.2', 'end': '45.239.88.62'}], 'gateway_ip': '45.239.88.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '45.239.88.2', 'tags': [], 'project_id': 'e463d3298ba447968165091e7445c4a1'}}
2026-10-05 04:09:33,146 - INFO - Created VN service-right-vn-75342732
2026-10-05 04:09:33,161 - DEBUG - VN service-right-vn-75342732 UUID is 532f57f6-38a0-49f8-81b7-1b2f09dc6a07
2026-10-05 04:09:33,244 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:33,252 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:33,266 - DEBUG - Requesting: http://10.0.0.177:8082/project/e463d329-8ba4-4796-8165-091e7445c4a1
2026-10-05 04:09:33,361 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/532f57f6-38a0-49f8-81b7-1b2f09dc6a07
2026-10-05 04:09:33,383 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/532f57f6-38a0-49f8-81b7-1b2f09dc6a07
2026-10-05 04:09:33,396 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/244db9b3-e7d8-4b12-9c6f-b62a99beabc0
2026-10-05 04:09:33,407 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/244db9b3-e7d8-4b12-9c6f-b62a99beabc0
2026-10-05 04:09:33,417 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/cb9af7ef-abed-4f39-9c3a-9b94d41a3378
2026-10-05 04:09:33,426 - DEBUG - Route Targets: ['target:64512:8000012']
2026-10-05 04:09:33,426 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/532f57f6-38a0-49f8-81b7-1b2f09dc6a07
2026-10-05 04:09:33,439 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/244db9b3-e7d8-4b12-9c6f-b62a99beabc0
2026-10-05 04:09:33,460 - INFO - Verified VN network id 21 for VN 532f57f6-38a0-49f8-81b7-1b2f09dc6a07
2026-10-05 04:09:33,461 - INFO - Verifications in API Server for VN service-right-vn-75342732 passed
2026-10-05 04:09:33,461 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/532f57f6-38a0-49f8-81b7-1b2f09dc6a07
2026-10-05 04:09:33,473 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/244db9b3-e7d8-4b12-9c6f-b62a99beabc0
2026-10-05 04:09:33,484 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/244db9b3-e7d8-4b12-9c6f-b62a99beabc0
2026-10-05 04:09:33,494 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/cb9af7ef-abed-4f39-9c3a-9b94d41a3378
2026-10-05 04:09:33,513 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10191597:service-right-vn-75342732', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10191597', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5994106344077019640', 'uuid-lslong': '9346969440473606663'}, 'enable': 'true', 'created': '2026-10-05T04:09:32', 'last-modified': '2026-10-05T04:09:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.456272'}
2026-10-05 04:09:33,521 - DEBUG - Route Targets: ['target:64512:8000012']
2026-10-05 04:09:33,529 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10191597:service-right-vn-75342732', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10191597', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5994106344077019640', 'uuid-lslong': '9346969440473606663'}, 'enable': 'true', 'created': '2026-10-05T04:09:32', 'last-modified': '2026-10-05T04:09:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.479511'}
2026-10-05 04:09:33,537 - DEBUG - Route Targets: ['target:64512:8000012']
2026-10-05 04:09:33,544 - DEBUG - Control-node 10.0.0.190 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10191597:service-right-vn-75342732', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10191597', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5994106344077019640', 'uuid-lslong': '9346969440473606663'}, 'enable': 'true', 'created': '2026-10-05T04:09:32', 'last-modified': '2026-10-05T04:09:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.494394'}
2026-10-05 04:09:33,552 - DEBUG - Route Targets: ['target:64512:8000012']
2026-10-05 04:09:33,552 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-75342732 passed
2026-10-05 04:09:33,552 - DEBUG - ====Verifying policy data for service-right-vn-75342732 in API_Server ======
2026-10-05 04:09:33,552 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:33,560 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:33,573 - DEBUG - Requesting: http://10.0.0.177:8082/project/e463d329-8ba4-4796-8165-091e7445c4a1
2026-10-05 04:09:33,671 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/532f57f6-38a0-49f8-81b7-1b2f09dc6a07
2026-10-05 04:09:33,683 - DEBUG - =>VN service-right-vn-75342732 has no policy to be verified
2026-10-05 04:09:33,683 - DEBUG - Verifying the vn in opserver
2026-10-05 04:09:33,683 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10191597:service-right-vn-75342732 virtual network link through opserver 10.0.0.177
2026-10-05 04:09:33,683 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-10-05 04:09:33,742 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10191597:service-right-vn-75342732', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10191597:service-right-vn-75342732?flat'}
2026-10-05 04:09:33,742 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10191597:service-right-vn-75342732 virtual network link through opserver 10.0.0.38
2026-10-05 04:09:33,742 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-10-05 04:09:33,799 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10191597:service-right-vn-75342732', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10191597:service-right-vn-75342732?flat'}
2026-10-05 04:09:33,799 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10191597:service-right-vn-75342732 virtual network link through opserver 10.0.0.190
2026-10-05 04:09:33,799 - DEBUG - Requesting: http://10.0.0.190:8081/analytics/uves/virtual-networks
2026-10-05 04:09:33,858 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10191597:service-right-vn-75342732', 'href': 'http://10.0.0.190:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10191597:service-right-vn-75342732?flat'}
2026-10-05 04:09:33,858 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-10191597:service-right-vn-75342732 is found in opserver
2026-10-05 04:09:33,885 - DEBUG - Do not have enough data to verify VN in agent
2026-10-05 04:09:33,897 - DEBUG - VRF ids for VN service-right-vn-75342732: {}
2026-10-05 04:09:34,055 - DEBUG - Services list from nova: [, , , ]
2026-10-05 04:09:34,559 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6343-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6343-1)
2026-10-05 04:09:35,255 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6343-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6343-2)
2026-10-05 04:09:35,256 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-53224034']
2026-10-05 04:09:35,582 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-53224034'] created succesfully
2026-10-05 04:09:35,907 - DEBUG - Image by name tiny_nat_fw not found
2026-10-05 04:09:35,907 - DEBUG - Installing image tiny_nat_fw
2026-10-05 04:09:35,907 - 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-10-05 04:09:35,907 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-10-05 04:09:35,907 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-10-05 04:09:35,907 - DEBUG - Unzip image
2026-10-05 04:09:35,907 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-10-05 04:09:35,928 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-10-05 04:09:35,928 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-53224034']
2026-10-05 04:09:36,026 - INFO - Service template: ['default-domain', 'ctest-service_template_1-53224034'] deleted successfully.
2026-10-05 04:09:36,027 - INFO - Skip interface_detach for VM ctest-right_vm-30697963 in state BUILD
2026-10-05 04:09:36,030 - INFO - Deleting VM ctest-right_vm-30697963
2026-10-05 04:09:36,064 - ERROR - VM ctest-right_vm-30697963 has failed to come up
2026-10-05 04:09:36,064 - ERROR - Nova failed to get host of the VM
2026-10-05 04:09:36,065 - ERROR - VM ctest-right_vm-30697963 has failed to come up
2026-10-05 04:09:36,065 - ERROR - Nova failed to get host of the VM
2026-10-05 04:09:36,207 - INFO - Skip interface_detach for VM ctest-left_vm-47568164 in state BUILD
2026-10-05 04:09:36,207 - INFO - Deleting VM ctest-left_vm-47568164
2026-10-05 04:09:36,207 - ERROR - VM ctest-left_vm-47568164 has failed to come up
2026-10-05 04:09:36,207 - ERROR - Nova failed to get host of the VM
2026-10-05 04:09:36,207 - ERROR - VM ctest-left_vm-47568164 has failed to come up
2026-10-05 04:09:36,208 - ERROR - Nova failed to get host of the VM
2026-10-05 04:09:36,285 - INFO - Deleting VN service-right-vn-75342732
2026-10-05 04:09:36,466 - DEBUG - Response for deleting network ()
2026-10-05 04:09:36,466 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/244db9b3-e7d8-4b12-9c6f-b62a99beabc0
2026-10-05 04:09:36,475 - DEBUG - Response Code: 404
2026-10-05 04:09:36,476 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:36,485 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:36,544 - DEBUG - Requesting: http://10.0.0.177:8082/project/e463d329-8ba4-4796-8165-091e7445c4a1
2026-10-05 04:09:36,652 - INFO - Validated that VN service-right-vn-75342732 is not found in API Server
2026-10-05 04:09:36,665 - DEBUG - VN service-right-vn-75342732 is not present in Agent 10.0.0.50
2026-10-05 04:09:36,678 - DEBUG - VN service-right-vn-75342732 is not present in Agent 10.0.0.191
2026-10-05 04:09:36,678 - INFO - Validated that VN service-right-vn-75342732 is not in any agent
2026-10-05 04:09:36,721 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-75342732 info
2026-10-05 04:09:36,722 - INFO - Deleting VN service-left-vn-39387434
2026-10-05 04:09:36,909 - DEBUG - Response for deleting network ()
2026-10-05 04:09:36,909 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/0d2e960b-b500-46c7-955d-1153987cb0a6
2026-10-05 04:09:36,915 - DEBUG - Response Code: 404
2026-10-05 04:09:36,915 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:36,932 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:36,949 - DEBUG - Requesting: http://10.0.0.177:8082/project/e463d329-8ba4-4796-8165-091e7445c4a1
2026-10-05 04:09:37,057 - INFO - Validated that VN service-left-vn-39387434 is not found in API Server
2026-10-05 04:09:37,071 - DEBUG - VN service-left-vn-39387434 is not present in Agent 10.0.0.50
2026-10-05 04:09:37,084 - DEBUG - VN service-left-vn-39387434 is not present in Agent 10.0.0.191
2026-10-05 04:09:37,084 - INFO - Validated that VN service-left-vn-39387434 is not in any agent
2026-10-05 04:09:37,130 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-39387434 info
2026-10-05 04:09:37,131 - INFO - Deleting VN ctest-mgmt_vn-20735175
2026-10-05 04:09:37,297 - DEBUG - Response for deleting network ()
2026-10-05 04:09:37,297 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/6dfac590-4ee2-4621-95cb-bd83b2ca0d9a
2026-10-05 04:09:37,305 - DEBUG - Response Code: 404
2026-10-05 04:09:37,305 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:37,316 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:37,341 - DEBUG - Requesting: http://10.0.0.177:8082/project/e463d329-8ba4-4796-8165-091e7445c4a1
2026-10-05 04:09:37,457 - INFO - Validated that VN ctest-mgmt_vn-20735175 is not found in API Server
2026-10-05 04:09:37,471 - DEBUG - VN ctest-mgmt_vn-20735175 is not present in Agent 10.0.0.50
2026-10-05 04:09:37,484 - DEBUG - VN ctest-mgmt_vn-20735175 is not present in Agent 10.0.0.191
2026-10-05 04:09:37,484 - INFO - Validated that VN ctest-mgmt_vn-20735175 is not in any agent
2026-10-05 04:09:37,530 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-20735175 info
2026-10-05 04:09:38,863 - DEBUG - No XMPP flaps were noticed during the test
2026-10-05 04:09:38,864 - INFO -
2026-10-05 04:09:38,864 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:12]
2026-10-05 04:09:38,864 - INFO - --------------------------------------------------------------------------------
2026-10-05 04:09:38,870 - INFO - ================================================================================
2026-10-05 04:09:38,870 - INFO - STARTING TEST : test_svc_in_network_datapath
2026-10-05 04:09:40,196 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.14': '0', '10.20.0.25': '0'}, '10.0.0.191': {'10.20.0.254': '0', '10.20.0.25': '0'}} with
2026-10-05 04:09:40,196 - INFO - Initial checks done. Running the testcase now
2026-10-05 04:09:40,196 - INFO -
2026-10-05 04:09:40,526 - DEBUG - Response for create_network : {'network': {'id': 'be7fea18-2b58-4910-b0b3-d1d9e572de36', 'name': 'ctest-mgmt_vn-67634232', 'tenant_id': 'e463d3298ba447968165091e7445c4a1', 'project_id': 'e463d3298ba447968165091e7445c4a1', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-10191597', 'ctest-mgmt_vn-67634232'], 'port_security_enabled': True, 'description': ''}}
2026-10-05 04:09:40,823 - DEBUG - Response for create_subnet : {'subnet': {'id': '76a85048-ea75-4579-a3bc-02c3376352ad', 'name': '', 'tenant_id': 'e463d3298ba447968165091e7445c4a1', 'network_id': 'be7fea18-2b58-4910-b0b3-d1d9e572de36', 'ip_version': 4, 'cidr': '2.6.48.0/26', 'allocation_pools': [{'start': '2.6.48.2', 'end': '2.6.48.62'}], 'gateway_ip': '2.6.48.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '2.6.48.2', 'tags': [], 'project_id': 'e463d3298ba447968165091e7445c4a1'}}
2026-10-05 04:09:40,848 - INFO - Created VN ctest-mgmt_vn-67634232
2026-10-05 04:09:40,868 - DEBUG - VN ctest-mgmt_vn-67634232 UUID is be7fea18-2b58-4910-b0b3-d1d9e572de36
2026-10-05 04:09:40,960 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:40,967 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:40,986 - DEBUG - Requesting: http://10.0.0.177:8082/project/e463d329-8ba4-4796-8165-091e7445c4a1
2026-10-05 04:09:41,092 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/be7fea18-2b58-4910-b0b3-d1d9e572de36
2026-10-05 04:09:41,113 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/be7fea18-2b58-4910-b0b3-d1d9e572de36
2026-10-05 04:09:41,129 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/07bad37d-1e41-4e06-9455-3f19c0c505f3
2026-10-05 04:09:41,142 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/07bad37d-1e41-4e06-9455-3f19c0c505f3
2026-10-05 04:09:41,151 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/3f972192-e452-443e-bd8e-69243f1c9591
2026-10-05 04:09:41,160 - DEBUG - Route Targets: ['target:64512:8000010']
2026-10-05 04:09:41,161 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/be7fea18-2b58-4910-b0b3-d1d9e572de36
2026-10-05 04:09:41,172 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/07bad37d-1e41-4e06-9455-3f19c0c505f3
2026-10-05 04:09:41,191 - INFO - Verified VN network id 19 for VN be7fea18-2b58-4910-b0b3-d1d9e572de36
2026-10-05 04:09:41,191 - INFO - Verifications in API Server for VN ctest-mgmt_vn-67634232 passed
2026-10-05 04:09:41,191 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/be7fea18-2b58-4910-b0b3-d1d9e572de36
2026-10-05 04:09:41,204 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/07bad37d-1e41-4e06-9455-3f19c0c505f3
2026-10-05 04:09:41,215 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/07bad37d-1e41-4e06-9455-3f19c0c505f3
2026-10-05 04:09:41,224 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/3f972192-e452-443e-bd8e-69243f1c9591
2026-10-05 04:09:41,241 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-67634232', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10191597', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13726947578775882000', 'uuid-lslong': '12732751305294143030'}, 'enable': 'true', 'created': '2026-10-05T04:09:40', 'last-modified': '2026-10-05T04:09:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.475490'}
2026-10-05 04:09:41,251 - DEBUG - Route Targets: ['target:64512:8000010']
2026-10-05 04:09:41,260 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-67634232', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10191597', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13726947578775882000', 'uuid-lslong': '12732751305294143030'}, 'enable': 'true', 'created': '2026-10-05T04:09:40', 'last-modified': '2026-10-05T04:09:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.494425'}
2026-10-05 04:09:41,268 - DEBUG - Route Targets: ['target:64512:8000010']
2026-10-05 04:09:41,276 - DEBUG - Control-node 10.0.0.190 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-67634232', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10191597', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13726947578775882000', 'uuid-lslong': '12732751305294143030'}, 'enable': 'true', 'created': '2026-10-05T04:09:40', 'last-modified': '2026-10-05T04:09:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.520023'}
2026-10-05 04:09:41,287 - DEBUG - Route Targets: ['target:64512:8000010']
2026-10-05 04:09:41,288 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-67634232 passed
2026-10-05 04:09:41,288 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-67634232 in API_Server ======
2026-10-05 04:09:41,288 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:41,296 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:41,315 - DEBUG - Requesting: http://10.0.0.177:8082/project/e463d329-8ba4-4796-8165-091e7445c4a1
2026-10-05 04:09:41,412 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/be7fea18-2b58-4910-b0b3-d1d9e572de36
2026-10-05 04:09:41,431 - DEBUG - =>VN ctest-mgmt_vn-67634232 has no policy to be verified
2026-10-05 04:09:41,431 - DEBUG - Verifying the vn in opserver
2026-10-05 04:09:41,431 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-67634232 virtual network link through opserver 10.0.0.177
2026-10-05 04:09:41,431 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-10-05 04:09:41,446 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-67634232', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-67634232?flat'}
2026-10-05 04:09:41,446 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-67634232 virtual network link through opserver 10.0.0.38
2026-10-05 04:09:41,446 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-10-05 04:09:41,466 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-67634232', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-67634232?flat'}
2026-10-05 04:09:41,467 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-67634232 virtual network link through opserver 10.0.0.190
2026-10-05 04:09:41,467 - DEBUG - Requesting: http://10.0.0.190:8081/analytics/uves/virtual-networks
2026-10-05 04:09:41,481 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-67634232', 'href': 'http://10.0.0.190:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-67634232?flat'}
2026-10-05 04:09:41,481 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-10191597:ctest-mgmt_vn-67634232 is found in opserver
2026-10-05 04:09:41,511 - DEBUG - Do not have enough data to verify VN in agent
2026-10-05 04:09:41,522 - DEBUG - VRF ids for VN ctest-mgmt_vn-67634232: {}
2026-10-05 04:09:41,842 - DEBUG - Response for create_network : {'network': {'id': 'e0354b37-1ebd-4ae7-9434-52265635dc0d', 'name': 'ctest-left_vn-25423251', 'tenant_id': 'e463d3298ba447968165091e7445c4a1', 'project_id': 'e463d3298ba447968165091e7445c4a1', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-10191597', 'ctest-left_vn-25423251'], 'port_security_enabled': True, 'description': ''}}
2026-10-05 04:09:42,110 - DEBUG - Response for create_subnet : {'subnet': {'id': '38365886-c886-4047-aab8-05a30fff0bce', 'name': '', 'tenant_id': 'e463d3298ba447968165091e7445c4a1', 'network_id': 'e0354b37-1ebd-4ae7-9434-52265635dc0d', 'ip_version': 4, 'cidr': '149.73.85.192/26', 'allocation_pools': [{'start': '149.73.85.194', 'end': '149.73.85.254'}], 'gateway_ip': '149.73.85.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '149.73.85.194', 'tags': [], 'project_id': 'e463d3298ba447968165091e7445c4a1'}}
2026-10-05 04:09:42,133 - INFO - Created VN ctest-left_vn-25423251
2026-10-05 04:09:42,151 - DEBUG - VN ctest-left_vn-25423251 UUID is e0354b37-1ebd-4ae7-9434-52265635dc0d
2026-10-05 04:09:42,225 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:42,233 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:42,248 - DEBUG - Requesting: http://10.0.0.177:8082/project/e463d329-8ba4-4796-8165-091e7445c4a1
2026-10-05 04:09:42,348 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/e0354b37-1ebd-4ae7-9434-52265635dc0d
2026-10-05 04:09:42,369 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/e0354b37-1ebd-4ae7-9434-52265635dc0d
2026-10-05 04:09:42,381 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/b8faf877-ebe6-483b-addb-4dceb661db07
2026-10-05 04:09:42,391 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/b8faf877-ebe6-483b-addb-4dceb661db07
2026-10-05 04:09:42,404 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/ba6a9f2b-7966-4fb6-9a71-141b660a6d38
2026-10-05 04:09:42,415 - DEBUG - Route Targets: ['target:64512:8000011']
2026-10-05 04:09:42,415 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/e0354b37-1ebd-4ae7-9434-52265635dc0d
2026-10-05 04:09:42,429 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/b8faf877-ebe6-483b-addb-4dceb661db07
2026-10-05 04:09:42,452 - INFO - Verified VN network id 20 for VN e0354b37-1ebd-4ae7-9434-52265635dc0d
2026-10-05 04:09:42,452 - INFO - Verifications in API Server for VN ctest-left_vn-25423251 passed
2026-10-05 04:09:42,452 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/e0354b37-1ebd-4ae7-9434-52265635dc0d
2026-10-05 04:09:42,464 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/b8faf877-ebe6-483b-addb-4dceb661db07
2026-10-05 04:09:42,476 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/b8faf877-ebe6-483b-addb-4dceb661db07
2026-10-05 04:09:42,488 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/ba6a9f2b-7966-4fb6-9a71-141b660a6d38
2026-10-05 04:09:42,507 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10191597:ctest-left_vn-25423251', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10191597', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16155901938372528871', 'uuid-lslong': '10679250941010893837'}, 'enable': 'true', 'created': '2026-10-05T04:09:41', 'last-modified': '2026-10-05T04:09:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.467640'}
2026-10-05 04:09:42,514 - DEBUG - Route Targets: ['target:64512:8000011']
2026-10-05 04:09:42,521 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10191597:ctest-left_vn-25423251', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10191597', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16155901938372528871', 'uuid-lslong': '10679250941010893837'}, 'enable': 'true', 'created': '2026-10-05T04:09:41', 'last-modified': '2026-10-05T04:09:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.487616'}
2026-10-05 04:09:42,529 - DEBUG - Route Targets: ['target:64512:8000011']
2026-10-05 04:09:42,543 - DEBUG - Control-node 10.0.0.190 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10191597:ctest-left_vn-25423251', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10191597', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16155901938372528871', 'uuid-lslong': '10679250941010893837'}, 'enable': 'true', 'created': '2026-10-05T04:09:41', 'last-modified': '2026-10-05T04:09:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.513522'}
2026-10-05 04:09:42,550 - DEBUG - Route Targets: ['target:64512:8000011']
2026-10-05 04:09:42,551 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-25423251 passed
2026-10-05 04:09:42,551 - DEBUG - ====Verifying policy data for ctest-left_vn-25423251 in API_Server ======
2026-10-05 04:09:42,551 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:42,559 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:42,580 - DEBUG - Requesting: http://10.0.0.177:8082/project/e463d329-8ba4-4796-8165-091e7445c4a1
2026-10-05 04:09:42,685 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/e0354b37-1ebd-4ae7-9434-52265635dc0d
2026-10-05 04:09:42,696 - DEBUG - =>VN ctest-left_vn-25423251 has no policy to be verified
2026-10-05 04:09:42,696 - DEBUG - Verifying the vn in opserver
2026-10-05 04:09:42,696 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10191597:ctest-left_vn-25423251 virtual network link through opserver 10.0.0.177
2026-10-05 04:09:42,696 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-10-05 04:09:42,711 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10191597:ctest-left_vn-25423251', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10191597:ctest-left_vn-25423251?flat'}
2026-10-05 04:09:42,711 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10191597:ctest-left_vn-25423251 virtual network link through opserver 10.0.0.38
2026-10-05 04:09:42,711 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-10-05 04:09:42,726 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10191597:ctest-left_vn-25423251', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10191597:ctest-left_vn-25423251?flat'}
2026-10-05 04:09:42,726 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10191597:ctest-left_vn-25423251 virtual network link through opserver 10.0.0.190
2026-10-05 04:09:42,727 - DEBUG - Requesting: http://10.0.0.190:8081/analytics/uves/virtual-networks
2026-10-05 04:09:42,741 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10191597:ctest-left_vn-25423251', 'href': 'http://10.0.0.190:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10191597:ctest-left_vn-25423251?flat'}
2026-10-05 04:09:42,741 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-10191597:ctest-left_vn-25423251 is found in opserver
2026-10-05 04:09:42,766 - DEBUG - Do not have enough data to verify VN in agent
2026-10-05 04:09:42,778 - DEBUG - VRF ids for VN ctest-left_vn-25423251: {}
2026-10-05 04:09:43,095 - DEBUG - Response for create_network : {'network': {'id': 'fe855a77-4369-4fa2-93c8-47f754618f44', 'name': 'ctest-right_vn-25525109', 'tenant_id': 'e463d3298ba447968165091e7445c4a1', 'project_id': 'e463d3298ba447968165091e7445c4a1', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-10191597', 'ctest-right_vn-25525109'], 'port_security_enabled': True, 'description': ''}}
2026-10-05 04:09:43,366 - DEBUG - Response for create_subnet : {'subnet': {'id': '2ea0e530-8a2f-4e2a-ba54-9e7f717dbbd9', 'name': '', 'tenant_id': 'e463d3298ba447968165091e7445c4a1', 'network_id': 'fe855a77-4369-4fa2-93c8-47f754618f44', 'ip_version': 4, 'cidr': '185.230.221.64/26', 'allocation_pools': [{'start': '185.230.221.66', 'end': '185.230.221.126'}], 'gateway_ip': '185.230.221.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '185.230.221.66', 'tags': [], 'project_id': 'e463d3298ba447968165091e7445c4a1'}}
2026-10-05 04:09:43,394 - INFO - Created VN ctest-right_vn-25525109
2026-10-05 04:09:43,409 - DEBUG - VN ctest-right_vn-25525109 UUID is fe855a77-4369-4fa2-93c8-47f754618f44
2026-10-05 04:09:43,484 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:43,496 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:43,514 - DEBUG - Requesting: http://10.0.0.177:8082/project/e463d329-8ba4-4796-8165-091e7445c4a1
2026-10-05 04:09:43,625 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/fe855a77-4369-4fa2-93c8-47f754618f44
2026-10-05 04:09:43,640 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/fe855a77-4369-4fa2-93c8-47f754618f44
2026-10-05 04:09:43,652 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/4a6d469d-f0cb-4a05-b48f-fbaff584af68
2026-10-05 04:09:43,660 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/4a6d469d-f0cb-4a05-b48f-fbaff584af68
2026-10-05 04:09:43,670 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/d83d65cf-6de2-4677-88f8-b4512bbd0852
2026-10-05 04:09:43,679 - DEBUG - Route Targets: ['target:64512:8000012']
2026-10-05 04:09:43,679 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/fe855a77-4369-4fa2-93c8-47f754618f44
2026-10-05 04:09:43,691 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/4a6d469d-f0cb-4a05-b48f-fbaff584af68
2026-10-05 04:09:43,712 - INFO - Verified VN network id 21 for VN fe855a77-4369-4fa2-93c8-47f754618f44
2026-10-05 04:09:43,712 - INFO - Verifications in API Server for VN ctest-right_vn-25525109 passed
2026-10-05 04:09:43,712 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/fe855a77-4369-4fa2-93c8-47f754618f44
2026-10-05 04:09:43,724 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/4a6d469d-f0cb-4a05-b48f-fbaff584af68
2026-10-05 04:09:43,734 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/4a6d469d-f0cb-4a05-b48f-fbaff584af68
2026-10-05 04:09:43,754 - DEBUG - Requesting: http://10.0.0.177:8082/route-target/d83d65cf-6de2-4677-88f8-b4512bbd0852
2026-10-05 04:09:43,771 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10191597:ctest-right_vn-25525109', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10191597', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18340164525814796194', 'uuid-lslong': '10648840446515711812'}, 'enable': 'true', 'created': '2026-10-05T04:09:43', 'last-modified': '2026-10-05T04:09:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.474071'}
2026-10-05 04:09:43,778 - DEBUG - Route Targets: ['target:64512:8000012']
2026-10-05 04:09:43,786 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10191597:ctest-right_vn-25525109', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10191597', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18340164525814796194', 'uuid-lslong': '10648840446515711812'}, 'enable': 'true', 'created': '2026-10-05T04:09:43', 'last-modified': '2026-10-05T04:09:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.493891'}
2026-10-05 04:09:43,793 - DEBUG - Route Targets: ['target:64512:8000012']
2026-10-05 04:09:43,801 - DEBUG - Control-node 10.0.0.190 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10191597:ctest-right_vn-25525109', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10191597', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18340164525814796194', 'uuid-lslong': '10648840446515711812'}, 'enable': 'true', 'created': '2026-10-05T04:09:43', 'last-modified': '2026-10-05T04:09:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.516044'}
2026-10-05 04:09:43,809 - DEBUG - Route Targets: ['target:64512:8000012']
2026-10-05 04:09:43,809 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-25525109 passed
2026-10-05 04:09:43,809 - DEBUG - ====Verifying policy data for ctest-right_vn-25525109 in API_Server ======
2026-10-05 04:09:43,810 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:43,817 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:43,834 - DEBUG - Requesting: http://10.0.0.177:8082/project/e463d329-8ba4-4796-8165-091e7445c4a1
2026-10-05 04:09:43,934 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-network/fe855a77-4369-4fa2-93c8-47f754618f44
2026-10-05 04:09:43,947 - DEBUG - =>VN ctest-right_vn-25525109 has no policy to be verified
2026-10-05 04:09:43,947 - DEBUG - Verifying the vn in opserver
2026-10-05 04:09:43,947 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10191597:ctest-right_vn-25525109 virtual network link through opserver 10.0.0.177
2026-10-05 04:09:43,947 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-10-05 04:09:43,962 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10191597:ctest-right_vn-25525109', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10191597:ctest-right_vn-25525109?flat'}
2026-10-05 04:09:43,962 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10191597:ctest-right_vn-25525109 virtual network link through opserver 10.0.0.38
2026-10-05 04:09:43,962 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-10-05 04:09:43,976 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10191597:ctest-right_vn-25525109', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10191597:ctest-right_vn-25525109?flat'}
2026-10-05 04:09:43,976 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10191597:ctest-right_vn-25525109 virtual network link through opserver 10.0.0.190
2026-10-05 04:09:43,976 - DEBUG - Requesting: http://10.0.0.190:8081/analytics/uves/virtual-networks
2026-10-05 04:09:43,992 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10191597:ctest-right_vn-25525109', 'href': 'http://10.0.0.190:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10191597:ctest-right_vn-25525109?flat'}
2026-10-05 04:09:43,992 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-10191597:ctest-right_vn-25525109 is found in opserver
2026-10-05 04:09:44,018 - DEBUG - Do not have enough data to verify VN in agent
2026-10-05 04:09:44,030 - DEBUG - VRF ids for VN ctest-right_vn-25525109: {}
2026-10-05 04:09:44,692 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6343-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6343-2)
2026-10-05 04:09:45,428 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6343-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6343-1)
2026-10-05 04:09:45,429 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-77518983']
2026-10-05 04:09:45,738 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-77518983'] created succesfully
2026-10-05 04:09:46,038 - DEBUG - Image by name tiny_nat_fw not found
2026-10-05 04:09:46,038 - DEBUG - Installing image tiny_nat_fw
2026-10-05 04:09:46,038 - 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-10-05 04:09:46,039 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-10-05 04:09:46,039 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-10-05 04:09:46,039 - DEBUG - Unzip image
2026-10-05 04:09:46,039 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-10-05 04:09:46,058 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-10-05 04:09:46,059 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-77518983']
2026-10-05 04:09:46,154 - INFO - Service template: ['default-domain', 'ctest-service_template_1-77518983'] deleted successfully.
2026-10-05 04:09:46,155 - INFO - Skip interface_detach for VM ctest-right_vm-04456854 in state BUILD
2026-10-05 04:09:46,155 - INFO - Deleting VM ctest-right_vm-04456854
2026-10-05 04:09:46,155 - ERROR - VM ctest-right_vm-04456854 has failed to come up
2026-10-05 04:09:46,155 - ERROR - Nova failed to get host of the VM
2026-10-05 04:09:46,155 - ERROR - VM ctest-right_vm-04456854 has failed to come up
2026-10-05 04:09:46,155 - ERROR - Nova failed to get host of the VM
2026-10-05 04:09:46,309 - INFO - Skip interface_detach for VM ctest-left_vm-19381566 in state BUILD
2026-10-05 04:09:46,309 - INFO - Deleting VM ctest-left_vm-19381566
2026-10-05 04:09:46,309 - ERROR - VM ctest-left_vm-19381566 has failed to come up
2026-10-05 04:09:46,309 - ERROR - Nova failed to get host of the VM
2026-10-05 04:09:46,309 - ERROR - VM ctest-left_vm-19381566 has failed to come up
2026-10-05 04:09:46,309 - ERROR - Nova failed to get host of the VM
2026-10-05 04:09:46,469 - INFO - Deleting VN ctest-right_vn-25525109
2026-10-05 04:09:46,663 - DEBUG - Response for deleting network ()
2026-10-05 04:09:46,663 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/4a6d469d-f0cb-4a05-b48f-fbaff584af68
2026-10-05 04:09:46,671 - DEBUG - Response Code: 404
2026-10-05 04:09:46,671 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:46,690 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:46,748 - DEBUG - Requesting: http://10.0.0.177:8082/project/e463d329-8ba4-4796-8165-091e7445c4a1
2026-10-05 04:09:46,849 - INFO - Validated that VN ctest-right_vn-25525109 is not found in API Server
2026-10-05 04:09:46,863 - DEBUG - VN ctest-right_vn-25525109 is not present in Agent 10.0.0.50
2026-10-05 04:09:46,878 - DEBUG - VN ctest-right_vn-25525109 is not present in Agent 10.0.0.191
2026-10-05 04:09:46,879 - INFO - Validated that VN ctest-right_vn-25525109 is not in any agent
2026-10-05 04:09:46,922 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-25525109 info
2026-10-05 04:09:46,923 - INFO - Deleting VN ctest-left_vn-25423251
2026-10-05 04:09:47,097 - DEBUG - Response for deleting network ()
2026-10-05 04:09:47,097 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/b8faf877-ebe6-483b-addb-4dceb661db07
2026-10-05 04:09:47,103 - DEBUG - Response Code: 404
2026-10-05 04:09:47,104 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:47,117 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:47,134 - DEBUG - Requesting: http://10.0.0.177:8082/project/e463d329-8ba4-4796-8165-091e7445c4a1
2026-10-05 04:09:47,256 - INFO - Validated that VN ctest-left_vn-25423251 is not found in API Server
2026-10-05 04:09:47,269 - DEBUG - VN ctest-left_vn-25423251 is not present in Agent 10.0.0.50
2026-10-05 04:09:47,282 - DEBUG - VN ctest-left_vn-25423251 is not present in Agent 10.0.0.191
2026-10-05 04:09:47,282 - INFO - Validated that VN ctest-left_vn-25423251 is not in any agent
2026-10-05 04:09:47,322 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-25423251 info
2026-10-05 04:09:47,322 - INFO - Deleting VN ctest-mgmt_vn-67634232
2026-10-05 04:09:47,477 - DEBUG - Response for deleting network ()
2026-10-05 04:09:47,477 - DEBUG - Requesting: http://10.0.0.177:8082/routing-instance/07bad37d-1e41-4e06-9455-3f19c0c505f3
2026-10-05 04:09:47,483 - DEBUG - Response Code: 404
2026-10-05 04:09:47,484 - DEBUG - Requesting: http://10.0.0.177:8082/domains
2026-10-05 04:09:47,490 - DEBUG - Requesting: http://10.0.0.177:8082/domain/6850e378-7089-4036-8f54-55c0ed1b9054
2026-10-05 04:09:47,512 - DEBUG - Requesting: http://10.0.0.177:8082/project/e463d329-8ba4-4796-8165-091e7445c4a1
2026-10-05 04:09:47,622 - INFO - Validated that VN ctest-mgmt_vn-67634232 is not found in API Server
2026-10-05 04:09:47,636 - DEBUG - VN ctest-mgmt_vn-67634232 is not present in Agent 10.0.0.50
2026-10-05 04:09:47,650 - DEBUG - VN ctest-mgmt_vn-67634232 is not present in Agent 10.0.0.191
2026-10-05 04:09:47,650 - INFO - Validated that VN ctest-mgmt_vn-67634232 is not in any agent
2026-10-05 04:09:47,699 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-67634232 info
2026-10-05 04:09:49,023 - DEBUG - No XMPP flaps were noticed during the test
2026-10-05 04:09:49,023 - INFO -
2026-10-05 04:09:49,023 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:11]
2026-10-05 04:09:49,023 - INFO - --------------------------------------------------------------------------------
2026-10-05 04:09:49,936 - INFO - Deleted project: ctest-TestSvcRegr-10191597, ID : e463d329-8ba4-4796-8165-091e7445c4a1