]) created on node: (an-jenkins-deploy-platform-ansible-os-5493-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5493-2)
2026-03-19 03:25:36,563 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-38712830']
2026-03-19 03:25:36,851 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-38712830'] created succesfully
2026-03-19 03:25:37,325 - DEBUG - Image by name tiny_nat_fw not found
2026-03-19 03:25:37,325 - DEBUG - Installing image tiny_nat_fw
2026-03-19 03:25:37,325 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-03-19 03:25:37,326 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-03-19 03:25:37,326 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-03-19 03:25:37,347 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz -O /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-19 03:25:37,463 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-19 03:25:37,463 - DEBUG - Unzip image
2026-03-19 03:25:37,463 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-19 03:25:37,488 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-03-19 03:25:37,489 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-38712830']
2026-03-19 03:25:37,594 - INFO - Service template: ['default-domain', 'ctest-service_template_1-38712830'] deleted successfully.
2026-03-19 03:25:37,594 - INFO - Skip interface_detach for VM ctest-right_vm-34709633 in state BUILD
2026-03-19 03:25:37,595 - INFO - Deleting VM ctest-right_vm-34709633
2026-03-19 03:25:37,629 - ERROR - VM ctest-right_vm-34709633 has failed to come up
2026-03-19 03:25:37,630 - ERROR - Nova failed to get host of the VM
2026-03-19 03:25:37,630 - ERROR - VM ctest-right_vm-34709633 has failed to come up
2026-03-19 03:25:37,630 - ERROR - Nova failed to get host of the VM
2026-03-19 03:25:37,709 - INFO - Skip interface_detach for VM ctest-left_vm-83361251 in state BUILD
2026-03-19 03:25:37,709 - INFO - Deleting VM ctest-left_vm-83361251
2026-03-19 03:25:37,709 - ERROR - VM ctest-left_vm-83361251 has failed to come up
2026-03-19 03:25:37,709 - ERROR - Nova failed to get host of the VM
2026-03-19 03:25:37,709 - ERROR - VM ctest-left_vm-83361251 has failed to come up
2026-03-19 03:25:37,709 - ERROR - Nova failed to get host of the VM
2026-03-19 03:25:37,781 - INFO - Deleting VN ctest-right_vn-96844476
2026-03-19 03:25:37,827 - DEBUG - VN 911cfcf3-38b3-4e61-98b5-aef5d8ae3e9a still in use: Unable to complete operation on network 911cfcf3-38b3-4e61-98b5-aef5d8ae3e9a. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-4d7d6fb0-0d59-49ba-90a9-898501116479']
2026-03-19 03:25:37,827 - WARNING - Deleting VN ctest-right_vn-96844476 failed..Will retry
2026-03-19 03:25:40,072 - DEBUG - Response for deleting network ()
2026-03-19 03:25:40,072 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/edfc86f5-5ffd-4447-92cb-5d64abe5c85f
2026-03-19 03:25:40,078 - DEBUG - Response Code: 404
2026-03-19 03:25:40,078 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:25:40,086 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:25:40,148 - DEBUG - Requesting: http://10.0.0.41:8082/project/e10640a3-d29b-41b2-97fc-629ff0d52ae9
2026-03-19 03:25:40,240 - INFO - Validated that VN ctest-right_vn-96844476 is not found in API Server
2026-03-19 03:25:40,251 - DEBUG - VN ctest-right_vn-96844476 is not present in Agent 10.0.0.23
2026-03-19 03:25:40,261 - DEBUG - VN ctest-right_vn-96844476 is not present in Agent 10.0.0.240
2026-03-19 03:25:40,261 - INFO - Validated that VN ctest-right_vn-96844476 is not in any agent
2026-03-19 03:25:40,300 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-96844476 info
2026-03-19 03:25:40,300 - INFO - Deleting VN ctest-left_vn-03237551
2026-03-19 03:25:40,482 - DEBUG - Response for deleting network ()
2026-03-19 03:25:40,483 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/d37fe4ff-7055-4d7a-86b2-a1028fad0e75
2026-03-19 03:25:40,501 - DEBUG - Response Code: 404
2026-03-19 03:25:40,501 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:25:40,507 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:25:40,560 - DEBUG - Requesting: http://10.0.0.41:8082/project/e10640a3-d29b-41b2-97fc-629ff0d52ae9
2026-03-19 03:25:40,660 - INFO - Validated that VN ctest-left_vn-03237551 is not found in API Server
2026-03-19 03:25:40,672 - DEBUG - VN ctest-left_vn-03237551 is not present in Agent 10.0.0.23
2026-03-19 03:25:40,684 - DEBUG - VN ctest-left_vn-03237551 is not present in Agent 10.0.0.240
2026-03-19 03:25:40,684 - INFO - Validated that VN ctest-left_vn-03237551 is not in any agent
2026-03-19 03:25:40,722 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-03237551 info
2026-03-19 03:25:40,723 - INFO - Deleting VN ctest-mgmt_vn-52041910
2026-03-19 03:25:40,877 - DEBUG - Response for deleting network ()
2026-03-19 03:25:40,878 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/cbcd56a0-d8c5-44df-a754-c6ccccaa81b5
2026-03-19 03:25:40,884 - DEBUG - Response Code: 404
2026-03-19 03:25:40,884 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:25:40,890 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:25:40,924 - DEBUG - Requesting: http://10.0.0.41:8082/project/e10640a3-d29b-41b2-97fc-629ff0d52ae9
2026-03-19 03:25:41,045 - INFO - Validated that VN ctest-mgmt_vn-52041910 is not found in API Server
2026-03-19 03:25:41,071 - DEBUG - VN ctest-mgmt_vn-52041910 is not present in Agent 10.0.0.23
2026-03-19 03:25:41,090 - DEBUG - VN ctest-mgmt_vn-52041910 is not present in Agent 10.0.0.240
2026-03-19 03:25:41,090 - INFO - Validated that VN ctest-mgmt_vn-52041910 is not in any agent
2026-03-19 03:25:41,161 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-52041910 info
2026-03-19 03:25:41,161 - INFO - Deleting VM ctest-vm-in-third-vn-00203487
2026-03-19 03:25:41,258 - INFO - Deleting VN ctest-third-vn-38046077
2026-03-19 03:25:41,310 - DEBUG - VN 28072b89-c854-42ab-be2c-b09b7bf4d34f still in use: Unable to complete operation on network 28072b89-c854-42ab-be2c-b09b7bf4d34f. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-8ac7d42c-3efb-4412-9cfd-9b38ffc855ef']
2026-03-19 03:25:41,310 - WARNING - Deleting VN ctest-third-vn-38046077 failed..Will retry
2026-03-19 03:25:43,513 - DEBUG - Response for deleting network ()
2026-03-19 03:25:44,789 - DEBUG - No XMPP flaps were noticed during the test
2026-03-19 03:25:44,789 - INFO -
2026-03-19 03:25:44,789 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:25]
2026-03-19 03:25:44,789 - INFO - --------------------------------------------------------------------------------
2026-03-19 03:25:44,792 - INFO - ================================================================================
2026-03-19 03:25:44,792 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2026-03-19 03:25:46,088 - DEBUG - Nothing to compare xmpp stats {'10.0.0.23': {'10.20.0.129': '0', '10.20.0.18': '0'}, '10.0.0.240': {'10.20.0.18': '0', '10.20.0.193': '0'}} with
2026-03-19 03:25:46,088 - INFO - Initial checks done. Running the testcase now
2026-03-19 03:25:46,088 - INFO -
2026-03-19 03:25:46,338 - DEBUG - Response for create_network : {'network': {'id': 'b0ac3793-6c29-42b7-b328-ed563dfd07cf', 'name': 'ctest-mgmt_vn-15504424', 'tenant_id': 'e10640a3d29b41b297fc629ff0d52ae9', 'project_id': 'e10640a3d29b41b297fc629ff0d52ae9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-10574396', 'ctest-mgmt_vn-15504424'], 'port_security_enabled': True, 'description': ''}}
2026-03-19 03:25:46,591 - DEBUG - Response for create_subnet : {'subnet': {'id': '5e77ae51-2649-435c-82ab-b0e55f6cfd11', 'name': '', 'tenant_id': 'e10640a3d29b41b297fc629ff0d52ae9', 'network_id': 'b0ac3793-6c29-42b7-b328-ed563dfd07cf', 'ip_version': 4, 'cidr': '93.142.53.192/26', 'allocation_pools': [{'start': '93.142.53.194', 'end': '93.142.53.254'}], 'gateway_ip': '93.142.53.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '93.142.53.194', 'tags': [], 'project_id': 'e10640a3d29b41b297fc629ff0d52ae9'}}
2026-03-19 03:25:46,615 - INFO - Created VN ctest-mgmt_vn-15504424
2026-03-19 03:25:46,628 - DEBUG - VN ctest-mgmt_vn-15504424 UUID is b0ac3793-6c29-42b7-b328-ed563dfd07cf
2026-03-19 03:25:46,701 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:25:46,710 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:25:46,724 - DEBUG - Requesting: http://10.0.0.41:8082/project/e10640a3-d29b-41b2-97fc-629ff0d52ae9
2026-03-19 03:25:46,819 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/b0ac3793-6c29-42b7-b328-ed563dfd07cf
2026-03-19 03:25:46,834 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/b0ac3793-6c29-42b7-b328-ed563dfd07cf
2026-03-19 03:25:46,845 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/25b8b38f-0a62-4d76-afe3-2e63e0effe01
2026-03-19 03:25:46,853 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/25b8b38f-0a62-4d76-afe3-2e63e0effe01
2026-03-19 03:25:46,860 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/d81f9a12-0c5d-4d3e-b42e-34321fb62cbc
2026-03-19 03:25:46,868 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-19 03:25:46,868 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/b0ac3793-6c29-42b7-b328-ed563dfd07cf
2026-03-19 03:25:46,880 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/25b8b38f-0a62-4d76-afe3-2e63e0effe01
2026-03-19 03:25:46,899 - INFO - Verified VN network id 14 for VN b0ac3793-6c29-42b7-b328-ed563dfd07cf
2026-03-19 03:25:46,899 - INFO - Verifications in API Server for VN ctest-mgmt_vn-15504424 passed
2026-03-19 03:25:46,899 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/b0ac3793-6c29-42b7-b328-ed563dfd07cf
2026-03-19 03:25:46,911 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/25b8b38f-0a62-4d76-afe3-2e63e0effe01
2026-03-19 03:25:46,919 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/25b8b38f-0a62-4d76-afe3-2e63e0effe01
2026-03-19 03:25:46,927 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/d81f9a12-0c5d-4d3e-b42e-34321fb62cbc
2026-03-19 03:25:46,944 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10574396:ctest-mgmt_vn-15504424', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10574396', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12730611352983913143', 'uuid-lslong': '12909829286520489935'}, 'enable': 'true', 'created': '2026-03-19T03:25:46', 'last-modified': '2026-03-19T03:25:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.404790'}
2026-03-19 03:25:46,951 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-19 03:25:46,957 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10574396:ctest-mgmt_vn-15504424', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10574396', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12730611352983913143', 'uuid-lslong': '12909829286520489935'}, 'enable': 'true', 'created': '2026-03-19T03:25:46', 'last-modified': '2026-03-19T03:25:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.422670'}
2026-03-19 03:25:46,963 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-19 03:25:46,967 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10574396:ctest-mgmt_vn-15504424', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10574396', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12730611352983913143', 'uuid-lslong': '12909829286520489935'}, 'enable': 'true', 'created': '2026-03-19T03:25:46', 'last-modified': '2026-03-19T03:25:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.431398'}
2026-03-19 03:25:46,973 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-19 03:25:46,973 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-15504424 passed
2026-03-19 03:25:46,973 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-15504424 in API_Server ======
2026-03-19 03:25:46,973 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:25:46,981 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:25:46,993 - DEBUG - Requesting: http://10.0.0.41:8082/project/e10640a3-d29b-41b2-97fc-629ff0d52ae9
2026-03-19 03:25:47,087 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/b0ac3793-6c29-42b7-b328-ed563dfd07cf
2026-03-19 03:25:47,097 - DEBUG - =>VN ctest-mgmt_vn-15504424 has no policy to be verified
2026-03-19 03:25:47,097 - DEBUG - Verifying the vn in opserver
2026-03-19 03:25:47,097 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10574396:ctest-mgmt_vn-15504424 virtual network link through opserver 10.0.0.41
2026-03-19 03:25:47,097 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-03-19 03:25:47,111 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10574396:ctest-mgmt_vn-15504424', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10574396:ctest-mgmt_vn-15504424?flat'}
2026-03-19 03:25:47,111 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10574396:ctest-mgmt_vn-15504424 virtual network link through opserver 10.0.0.242
2026-03-19 03:25:47,111 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-03-19 03:25:47,123 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10574396:ctest-mgmt_vn-15504424', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10574396:ctest-mgmt_vn-15504424?flat'}
2026-03-19 03:25:47,123 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10574396:ctest-mgmt_vn-15504424 virtual network link through opserver 10.0.0.27
2026-03-19 03:25:47,123 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-19 03:25:47,136 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10574396:ctest-mgmt_vn-15504424', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10574396:ctest-mgmt_vn-15504424?flat'}
2026-03-19 03:25:47,136 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-10574396:ctest-mgmt_vn-15504424 is found in opserver
2026-03-19 03:25:47,156 - DEBUG - Do not have enough data to verify VN in agent
2026-03-19 03:25:47,167 - DEBUG - VRF ids for VN ctest-mgmt_vn-15504424: {}
2026-03-19 03:25:47,457 - DEBUG - Response for create_network : {'network': {'id': '6348fd62-2fa5-4cd2-b61a-c4cf00ee1f0f', 'name': 'ctest-left_vn-84826708', 'tenant_id': 'e10640a3d29b41b297fc629ff0d52ae9', 'project_id': 'e10640a3d29b41b297fc629ff0d52ae9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-10574396', 'ctest-left_vn-84826708'], 'port_security_enabled': True, 'description': ''}}
2026-03-19 03:25:47,729 - DEBUG - Response for create_subnet : {'subnet': {'id': '71a28386-e97a-44d2-b3fa-d90d4d6ef88d', 'name': '', 'tenant_id': 'e10640a3d29b41b297fc629ff0d52ae9', 'network_id': '6348fd62-2fa5-4cd2-b61a-c4cf00ee1f0f', 'ip_version': 4, 'cidr': '131.214.250.64/26', 'allocation_pools': [{'start': '131.214.250.66', 'end': '131.214.250.126'}], 'gateway_ip': '131.214.250.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '131.214.250.66', 'tags': [], 'project_id': 'e10640a3d29b41b297fc629ff0d52ae9'}}
2026-03-19 03:25:47,750 - INFO - Created VN ctest-left_vn-84826708
2026-03-19 03:25:47,760 - DEBUG - VN ctest-left_vn-84826708 UUID is 6348fd62-2fa5-4cd2-b61a-c4cf00ee1f0f
2026-03-19 03:25:47,839 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:25:47,847 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:25:47,860 - DEBUG - Requesting: http://10.0.0.41:8082/project/e10640a3-d29b-41b2-97fc-629ff0d52ae9
2026-03-19 03:25:47,963 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/6348fd62-2fa5-4cd2-b61a-c4cf00ee1f0f
2026-03-19 03:25:47,984 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/6348fd62-2fa5-4cd2-b61a-c4cf00ee1f0f
2026-03-19 03:25:47,995 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/49c00f85-30d8-4c92-b1c9-5a4ea43aa902
2026-03-19 03:25:48,003 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/49c00f85-30d8-4c92-b1c9-5a4ea43aa902
2026-03-19 03:25:48,013 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/d3ff6170-03a9-4734-b0a0-aa1dc6152ae8
2026-03-19 03:25:48,024 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-19 03:25:48,024 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/6348fd62-2fa5-4cd2-b61a-c4cf00ee1f0f
2026-03-19 03:25:48,038 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/49c00f85-30d8-4c92-b1c9-5a4ea43aa902
2026-03-19 03:25:48,054 - INFO - Verified VN network id 15 for VN 6348fd62-2fa5-4cd2-b61a-c4cf00ee1f0f
2026-03-19 03:25:48,054 - INFO - Verifications in API Server for VN ctest-left_vn-84826708 passed
2026-03-19 03:25:48,054 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/6348fd62-2fa5-4cd2-b61a-c4cf00ee1f0f
2026-03-19 03:25:48,065 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/49c00f85-30d8-4c92-b1c9-5a4ea43aa902
2026-03-19 03:25:48,072 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/49c00f85-30d8-4c92-b1c9-5a4ea43aa902
2026-03-19 03:25:48,080 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/d3ff6170-03a9-4734-b0a0-aa1dc6152ae8
2026-03-19 03:25:48,094 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10574396:ctest-left_vn-84826708', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10574396', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7154246606226017490', 'uuid-lslong': '13122016857650241295'}, 'enable': 'true', 'created': '2026-03-19T03:25:47', 'last-modified': '2026-03-19T03:25:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.417306'}
2026-03-19 03:25:48,100 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-19 03:25:48,106 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10574396:ctest-left_vn-84826708', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10574396', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7154246606226017490', 'uuid-lslong': '13122016857650241295'}, 'enable': 'true', 'created': '2026-03-19T03:25:47', 'last-modified': '2026-03-19T03:25:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.431395'}
2026-03-19 03:25:48,112 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-19 03:25:48,118 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10574396:ctest-left_vn-84826708', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10574396', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7154246606226017490', 'uuid-lslong': '13122016857650241295'}, 'enable': 'true', 'created': '2026-03-19T03:25:47', 'last-modified': '2026-03-19T03:25:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.437526'}
2026-03-19 03:25:48,124 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-19 03:25:48,124 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-84826708 passed
2026-03-19 03:25:48,125 - DEBUG - ====Verifying policy data for ctest-left_vn-84826708 in API_Server ======
2026-03-19 03:25:48,125 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:25:48,132 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:25:48,143 - DEBUG - Requesting: http://10.0.0.41:8082/project/e10640a3-d29b-41b2-97fc-629ff0d52ae9
2026-03-19 03:25:48,244 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/6348fd62-2fa5-4cd2-b61a-c4cf00ee1f0f
2026-03-19 03:25:48,257 - DEBUG - =>VN ctest-left_vn-84826708 has no policy to be verified
2026-03-19 03:25:48,257 - DEBUG - Verifying the vn in opserver
2026-03-19 03:25:48,257 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10574396:ctest-left_vn-84826708 virtual network link through opserver 10.0.0.41
2026-03-19 03:25:48,257 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-03-19 03:25:48,271 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10574396:ctest-left_vn-84826708', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10574396:ctest-left_vn-84826708?flat'}
2026-03-19 03:25:48,271 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10574396:ctest-left_vn-84826708 virtual network link through opserver 10.0.0.242
2026-03-19 03:25:48,271 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-03-19 03:25:48,284 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10574396:ctest-left_vn-84826708', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10574396:ctest-left_vn-84826708?flat'}
2026-03-19 03:25:48,284 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10574396:ctest-left_vn-84826708 virtual network link through opserver 10.0.0.27
2026-03-19 03:25:48,285 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-19 03:25:48,297 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10574396:ctest-left_vn-84826708', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10574396:ctest-left_vn-84826708?flat'}
2026-03-19 03:25:48,297 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-10574396:ctest-left_vn-84826708 is found in opserver
2026-03-19 03:25:48,320 - DEBUG - Do not have enough data to verify VN in agent
2026-03-19 03:25:48,332 - DEBUG - VRF ids for VN ctest-left_vn-84826708: {}
2026-03-19 03:25:48,623 - DEBUG - Response for create_network : {'network': {'id': '719c4d37-4c51-4fee-8c8d-4b1f17293f99', 'name': 'ctest-right_vn-72533481', 'tenant_id': 'e10640a3d29b41b297fc629ff0d52ae9', 'project_id': 'e10640a3d29b41b297fc629ff0d52ae9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-10574396', 'ctest-right_vn-72533481'], 'port_security_enabled': True, 'description': ''}}
2026-03-19 03:25:48,846 - DEBUG - Response for create_subnet : {'subnet': {'id': '799fe7d0-6edb-4ecf-9224-43934efc295b', 'name': '', 'tenant_id': 'e10640a3d29b41b297fc629ff0d52ae9', 'network_id': '719c4d37-4c51-4fee-8c8d-4b1f17293f99', 'ip_version': 4, 'cidr': '164.69.21.128/26', 'allocation_pools': [{'start': '164.69.21.130', 'end': '164.69.21.190'}], 'gateway_ip': '164.69.21.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '164.69.21.130', 'tags': [], 'project_id': 'e10640a3d29b41b297fc629ff0d52ae9'}}
2026-03-19 03:25:48,879 - INFO - Created VN ctest-right_vn-72533481
2026-03-19 03:25:48,890 - DEBUG - VN ctest-right_vn-72533481 UUID is 719c4d37-4c51-4fee-8c8d-4b1f17293f99
2026-03-19 03:25:48,970 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:25:48,979 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:25:48,992 - DEBUG - Requesting: http://10.0.0.41:8082/project/e10640a3-d29b-41b2-97fc-629ff0d52ae9
2026-03-19 03:25:49,085 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/719c4d37-4c51-4fee-8c8d-4b1f17293f99
2026-03-19 03:25:49,099 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/719c4d37-4c51-4fee-8c8d-4b1f17293f99
2026-03-19 03:25:49,110 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/c216a1c8-a682-4d28-b764-356a985e4db1
2026-03-19 03:25:49,119 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/c216a1c8-a682-4d28-b764-356a985e4db1
2026-03-19 03:25:49,125 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/50244f28-c9b3-4035-a468-e8610597aea9
2026-03-19 03:25:49,134 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-19 03:25:49,134 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/719c4d37-4c51-4fee-8c8d-4b1f17293f99
2026-03-19 03:25:49,145 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/c216a1c8-a682-4d28-b764-356a985e4db1
2026-03-19 03:25:49,159 - INFO - Verified VN network id 16 for VN 719c4d37-4c51-4fee-8c8d-4b1f17293f99
2026-03-19 03:25:49,159 - INFO - Verifications in API Server for VN ctest-right_vn-72533481 passed
2026-03-19 03:25:49,159 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/719c4d37-4c51-4fee-8c8d-4b1f17293f99
2026-03-19 03:25:49,168 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/c216a1c8-a682-4d28-b764-356a985e4db1
2026-03-19 03:25:49,176 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/c216a1c8-a682-4d28-b764-356a985e4db1
2026-03-19 03:25:49,184 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/50244f28-c9b3-4035-a468-e8610597aea9
2026-03-19 03:25:49,197 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10574396:ctest-right_vn-72533481', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10574396', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8186503122551656430', 'uuid-lslong': '10127833733930762137'}, 'enable': 'true', 'created': '2026-03-19T03:25:48', 'last-modified': '2026-03-19T03:25:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.406368'}
2026-03-19 03:25:49,205 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-19 03:25:49,211 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10574396:ctest-right_vn-72533481', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10574396', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8186503122551656430', 'uuid-lslong': '10127833733930762137'}, 'enable': 'true', 'created': '2026-03-19T03:25:48', 'last-modified': '2026-03-19T03:25:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.419094'}
2026-03-19 03:25:49,218 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-19 03:25:49,224 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10574396:ctest-right_vn-72533481', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10574396', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8186503122551656430', 'uuid-lslong': '10127833733930762137'}, 'enable': 'true', 'created': '2026-03-19T03:25:48', 'last-modified': '2026-03-19T03:25:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.431673'}
2026-03-19 03:25:49,230 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-19 03:25:49,230 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-72533481 passed
2026-03-19 03:25:49,230 - DEBUG - ====Verifying policy data for ctest-right_vn-72533481 in API_Server ======
2026-03-19 03:25:49,231 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:25:49,237 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:25:49,256 - DEBUG - Requesting: http://10.0.0.41:8082/project/e10640a3-d29b-41b2-97fc-629ff0d52ae9
2026-03-19 03:25:49,369 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/719c4d37-4c51-4fee-8c8d-4b1f17293f99
2026-03-19 03:25:49,378 - DEBUG - =>VN ctest-right_vn-72533481 has no policy to be verified
2026-03-19 03:25:49,379 - DEBUG - Verifying the vn in opserver
2026-03-19 03:25:49,379 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10574396:ctest-right_vn-72533481 virtual network link through opserver 10.0.0.41
2026-03-19 03:25:49,379 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-03-19 03:25:49,394 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10574396:ctest-right_vn-72533481', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10574396:ctest-right_vn-72533481?flat'}
2026-03-19 03:25:49,394 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10574396:ctest-right_vn-72533481 virtual network link through opserver 10.0.0.242
2026-03-19 03:25:49,394 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-03-19 03:25:49,408 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10574396:ctest-right_vn-72533481', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10574396:ctest-right_vn-72533481?flat'}
2026-03-19 03:25:49,408 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10574396:ctest-right_vn-72533481 virtual network link through opserver 10.0.0.27
2026-03-19 03:25:49,408 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-19 03:25:49,421 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10574396:ctest-right_vn-72533481', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10574396:ctest-right_vn-72533481?flat'}
2026-03-19 03:25:49,421 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-10574396:ctest-right_vn-72533481 is found in opserver
2026-03-19 03:25:49,444 - DEBUG - Do not have enough data to verify VN in agent
2026-03-19 03:25:49,457 - DEBUG - VRF ids for VN ctest-right_vn-72533481: {}
2026-03-19 03:25:49,709 - DEBUG - Response for create_network : {'network': {'id': '5e0a8fe8-a46e-47a1-9036-d33d3ab6555f', 'name': 'ctest-trans_left_vn-13247455', 'tenant_id': 'e10640a3d29b41b297fc629ff0d52ae9', 'project_id': 'e10640a3d29b41b297fc629ff0d52ae9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-10574396', 'ctest-trans_left_vn-13247455'], 'port_security_enabled': True, 'description': ''}}
2026-03-19 03:25:49,939 - DEBUG - Response for create_subnet : {'subnet': {'id': '2ceacafa-4bc4-49ee-946e-04cddc13fb17', 'name': '', 'tenant_id': 'e10640a3d29b41b297fc629ff0d52ae9', 'network_id': '5e0a8fe8-a46e-47a1-9036-d33d3ab6555f', 'ip_version': 4, 'cidr': '83.141.176.192/26', 'allocation_pools': [{'start': '83.141.176.194', 'end': '83.141.176.254'}], 'gateway_ip': '83.141.176.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '83.141.176.194', 'tags': [], 'project_id': 'e10640a3d29b41b297fc629ff0d52ae9'}}
2026-03-19 03:25:49,962 - INFO - Created VN ctest-trans_left_vn-13247455
2026-03-19 03:25:49,974 - DEBUG - VN ctest-trans_left_vn-13247455 UUID is 5e0a8fe8-a46e-47a1-9036-d33d3ab6555f
2026-03-19 03:25:50,054 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:25:50,060 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:25:50,071 - DEBUG - Requesting: http://10.0.0.41:8082/project/e10640a3-d29b-41b2-97fc-629ff0d52ae9
2026-03-19 03:25:50,167 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/5e0a8fe8-a46e-47a1-9036-d33d3ab6555f
2026-03-19 03:25:50,183 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/5e0a8fe8-a46e-47a1-9036-d33d3ab6555f
2026-03-19 03:25:50,192 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/ccc85045-446a-41f3-a02b-6b3be8e13662
2026-03-19 03:25:50,200 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/ccc85045-446a-41f3-a02b-6b3be8e13662
2026-03-19 03:25:50,216 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/61ad75a1-61ef-471a-a590-ed87aa9904ed
2026-03-19 03:25:50,225 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-19 03:25:50,225 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/5e0a8fe8-a46e-47a1-9036-d33d3ab6555f
2026-03-19 03:25:50,235 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/ccc85045-446a-41f3-a02b-6b3be8e13662
2026-03-19 03:25:50,252 - INFO - Verified VN network id 17 for VN 5e0a8fe8-a46e-47a1-9036-d33d3ab6555f
2026-03-19 03:25:50,253 - INFO - Verifications in API Server for VN ctest-trans_left_vn-13247455 passed
2026-03-19 03:25:50,255 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/5e0a8fe8-a46e-47a1-9036-d33d3ab6555f
2026-03-19 03:25:50,267 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/ccc85045-446a-41f3-a02b-6b3be8e13662
2026-03-19 03:25:50,275 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/ccc85045-446a-41f3-a02b-6b3be8e13662
2026-03-19 03:25:50,282 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/61ad75a1-61ef-471a-a590-ed87aa9904ed
2026-03-19 03:25:50,292 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10574396:ctest-trans_left_vn-13247455', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10574396', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6776386818686207905', 'uuid-lslong': '10391725450135491935'}, 'enable': 'true', 'created': '2026-03-19T03:25:49', 'last-modified': '2026-03-19T03:25:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.406694'}
2026-03-19 03:25:50,297 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-19 03:25:50,303 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10574396:ctest-trans_left_vn-13247455', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10574396', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6776386818686207905', 'uuid-lslong': '10391725450135491935'}, 'enable': 'true', 'created': '2026-03-19T03:25:49', 'last-modified': '2026-03-19T03:25:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.415047'}
2026-03-19 03:25:50,309 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-19 03:25:50,314 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10574396:ctest-trans_left_vn-13247455', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10574396', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6776386818686207905', 'uuid-lslong': '10391725450135491935'}, 'enable': 'true', 'created': '2026-03-19T03:25:49', 'last-modified': '2026-03-19T03:25:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.426223'}
2026-03-19 03:25:50,320 - DEBUG - Route Targets: ['target:64512:8000007']
2026-03-19 03:25:50,320 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-13247455 passed
2026-03-19 03:25:50,320 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-13247455 in API_Server ======
2026-03-19 03:25:50,320 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:25:50,326 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:25:50,339 - DEBUG - Requesting: http://10.0.0.41:8082/project/e10640a3-d29b-41b2-97fc-629ff0d52ae9
2026-03-19 03:25:50,444 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/5e0a8fe8-a46e-47a1-9036-d33d3ab6555f
2026-03-19 03:25:50,456 - DEBUG - =>VN ctest-trans_left_vn-13247455 has no policy to be verified
2026-03-19 03:25:50,456 - DEBUG - Verifying the vn in opserver
2026-03-19 03:25:50,456 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10574396:ctest-trans_left_vn-13247455 virtual network link through opserver 10.0.0.41
2026-03-19 03:25:50,457 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-03-19 03:25:50,472 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10574396:ctest-trans_left_vn-13247455', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10574396:ctest-trans_left_vn-13247455?flat'}
2026-03-19 03:25:50,472 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10574396:ctest-trans_left_vn-13247455 virtual network link through opserver 10.0.0.242
2026-03-19 03:25:50,472 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-03-19 03:25:50,485 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10574396:ctest-trans_left_vn-13247455', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10574396:ctest-trans_left_vn-13247455?flat'}
2026-03-19 03:25:50,485 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10574396:ctest-trans_left_vn-13247455 virtual network link through opserver 10.0.0.27
2026-03-19 03:25:50,485 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-19 03:25:50,499 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10574396:ctest-trans_left_vn-13247455', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10574396:ctest-trans_left_vn-13247455?flat'}
2026-03-19 03:25:50,499 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-10574396:ctest-trans_left_vn-13247455 is found in opserver
2026-03-19 03:25:50,521 - DEBUG - Do not have enough data to verify VN in agent
2026-03-19 03:25:50,533 - DEBUG - VRF ids for VN ctest-trans_left_vn-13247455: {}
2026-03-19 03:25:50,808 - DEBUG - Response for create_network : {'network': {'id': '706f785b-f153-4193-9705-d04e0810b9ae', 'name': 'ctest-trans_right_vn-77871144', 'tenant_id': 'e10640a3d29b41b297fc629ff0d52ae9', 'project_id': 'e10640a3d29b41b297fc629ff0d52ae9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-10574396', 'ctest-trans_right_vn-77871144'], 'port_security_enabled': True, 'description': ''}}
2026-03-19 03:25:51,082 - DEBUG - Response for create_subnet : {'subnet': {'id': '7a479011-25ab-48e5-94cd-69f4db980772', 'name': '', 'tenant_id': 'e10640a3d29b41b297fc629ff0d52ae9', 'network_id': '706f785b-f153-4193-9705-d04e0810b9ae', 'ip_version': 4, 'cidr': '155.133.230.192/26', 'allocation_pools': [{'start': '155.133.230.194', 'end': '155.133.230.254'}], 'gateway_ip': '155.133.230.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '155.133.230.194', 'tags': [], 'project_id': 'e10640a3d29b41b297fc629ff0d52ae9'}}
2026-03-19 03:25:51,104 - INFO - Created VN ctest-trans_right_vn-77871144
2026-03-19 03:25:51,114 - DEBUG - VN ctest-trans_right_vn-77871144 UUID is 706f785b-f153-4193-9705-d04e0810b9ae
2026-03-19 03:25:51,189 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:25:51,195 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:25:51,207 - DEBUG - Requesting: http://10.0.0.41:8082/project/e10640a3-d29b-41b2-97fc-629ff0d52ae9
2026-03-19 03:25:51,302 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/706f785b-f153-4193-9705-d04e0810b9ae
2026-03-19 03:25:51,319 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/706f785b-f153-4193-9705-d04e0810b9ae
2026-03-19 03:25:51,330 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/b99cfbfd-429f-4067-9abc-b6e5f6e184df
2026-03-19 03:25:51,339 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/b99cfbfd-429f-4067-9abc-b6e5f6e184df
2026-03-19 03:25:51,346 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/e9ac041e-893c-430d-a831-61e96206a924
2026-03-19 03:25:51,353 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-19 03:25:51,353 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/706f785b-f153-4193-9705-d04e0810b9ae
2026-03-19 03:25:51,364 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/b99cfbfd-429f-4067-9abc-b6e5f6e184df
2026-03-19 03:25:51,380 - INFO - Verified VN network id 18 for VN 706f785b-f153-4193-9705-d04e0810b9ae
2026-03-19 03:25:51,380 - INFO - Verifications in API Server for VN ctest-trans_right_vn-77871144 passed
2026-03-19 03:25:51,380 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/706f785b-f153-4193-9705-d04e0810b9ae
2026-03-19 03:25:51,392 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/b99cfbfd-429f-4067-9abc-b6e5f6e184df
2026-03-19 03:25:51,404 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/b99cfbfd-429f-4067-9abc-b6e5f6e184df
2026-03-19 03:25:51,412 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/e9ac041e-893c-430d-a831-61e96206a924
2026-03-19 03:25:51,424 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10574396:ctest-trans_right_vn-77871144', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10574396', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8101826590948934035', 'uuid-lslong': '10882333108172011950'}, 'enable': 'true', 'created': '2026-03-19T03:25:50', 'last-modified': '2026-03-19T03:25:51', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.393400'}
2026-03-19 03:25:51,430 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-19 03:25:51,436 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10574396:ctest-trans_right_vn-77871144', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10574396', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8101826590948934035', 'uuid-lslong': '10882333108172011950'}, 'enable': 'true', 'created': '2026-03-19T03:25:50', 'last-modified': '2026-03-19T03:25:51', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.413130'}
2026-03-19 03:25:51,443 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-19 03:25:51,448 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-10574396:ctest-trans_right_vn-77871144', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-10574396', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8101826590948934035', 'uuid-lslong': '10882333108172011950'}, 'enable': 'true', 'created': '2026-03-19T03:25:50', 'last-modified': '2026-03-19T03:25:51', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.419891'}
2026-03-19 03:25:51,455 - DEBUG - Route Targets: ['target:64512:8000008']
2026-03-19 03:25:51,455 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-77871144 passed
2026-03-19 03:25:51,455 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-77871144 in API_Server ======
2026-03-19 03:25:51,455 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:25:51,462 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:25:51,474 - DEBUG - Requesting: http://10.0.0.41:8082/project/e10640a3-d29b-41b2-97fc-629ff0d52ae9
2026-03-19 03:25:51,567 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/706f785b-f153-4193-9705-d04e0810b9ae
2026-03-19 03:25:51,577 - DEBUG - =>VN ctest-trans_right_vn-77871144 has no policy to be verified
2026-03-19 03:25:51,577 - DEBUG - Verifying the vn in opserver
2026-03-19 03:25:51,577 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10574396:ctest-trans_right_vn-77871144 virtual network link through opserver 10.0.0.41
2026-03-19 03:25:51,577 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-03-19 03:25:51,589 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10574396:ctest-trans_right_vn-77871144', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10574396:ctest-trans_right_vn-77871144?flat'}
2026-03-19 03:25:51,590 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10574396:ctest-trans_right_vn-77871144 virtual network link through opserver 10.0.0.242
2026-03-19 03:25:51,590 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-03-19 03:25:51,603 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10574396:ctest-trans_right_vn-77871144', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10574396:ctest-trans_right_vn-77871144?flat'}
2026-03-19 03:25:51,603 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-10574396:ctest-trans_right_vn-77871144 virtual network link through opserver 10.0.0.27
2026-03-19 03:25:51,604 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-19 03:25:51,616 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-10574396:ctest-trans_right_vn-77871144', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-10574396:ctest-trans_right_vn-77871144?flat'}
2026-03-19 03:25:51,616 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-10574396:ctest-trans_right_vn-77871144 is found in opserver
2026-03-19 03:25:51,638 - DEBUG - Do not have enough data to verify VN in agent
2026-03-19 03:25:51,656 - DEBUG - VRF ids for VN ctest-trans_right_vn-77871144: {}
2026-03-19 03:25:52,843 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5493-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5493-2)
2026-03-19 03:25:54,178 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5493-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5493-1)
2026-03-19 03:25:54,179 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-13596740']
2026-03-19 03:25:54,473 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-13596740'] created succesfully
2026-03-19 03:25:54,831 - DEBUG - Image by name tiny_trans_fw not found
2026-03-19 03:25:54,831 - DEBUG - Installing image tiny_trans_fw
2026-03-19 03:25:54,831 - DEBUG - Image info {'name': 'tinycore-net-transparent-fw.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd'}
2026-03-19 03:25:54,832 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-03-19 03:25:54,832 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-03-19 03:25:54,854 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz -O /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-03-19 03:25:54,917 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-03-19 03:25:54,917 - DEBUG - Unzip image
2026-03-19 03:25:54,918 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-03-19 03:25:54,945 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-03-19 03:25:54,946 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-13596740']
2026-03-19 03:25:55,050 - INFO - Service template: ['default-domain', 'ctest-service_template_1-13596740'] deleted successfully.
2026-03-19 03:25:55,050 - INFO - Skip interface_detach for VM ctest-right_vm-61057983 in state BUILD
2026-03-19 03:25:55,050 - INFO - Deleting VM ctest-right_vm-61057983
2026-03-19 03:25:55,050 - ERROR - VM ctest-right_vm-61057983 has failed to come up
2026-03-19 03:25:55,051 - ERROR - Nova failed to get host of the VM
2026-03-19 03:25:55,051 - ERROR - VM ctest-right_vm-61057983 has failed to come up
2026-03-19 03:25:55,051 - ERROR - Nova failed to get host of the VM
2026-03-19 03:25:55,186 - INFO - Skip interface_detach for VM ctest-left_vm-56024479 in state BUILD
2026-03-19 03:25:55,186 - INFO - Deleting VM ctest-left_vm-56024479
2026-03-19 03:25:55,186 - ERROR - VM ctest-left_vm-56024479 has failed to come up
2026-03-19 03:25:55,186 - ERROR - Nova failed to get host of the VM
2026-03-19 03:25:55,187 - ERROR - VM ctest-left_vm-56024479 has failed to come up
2026-03-19 03:25:55,187 - ERROR - Nova failed to get host of the VM
2026-03-19 03:25:55,264 - INFO - Deleting VN ctest-trans_right_vn-77871144
2026-03-19 03:25:55,451 - DEBUG - Response for deleting network ()
2026-03-19 03:25:55,451 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/b99cfbfd-429f-4067-9abc-b6e5f6e184df
2026-03-19 03:25:55,458 - DEBUG - Response Code: 404
2026-03-19 03:25:55,458 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:25:55,471 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:25:55,488 - DEBUG - Requesting: http://10.0.0.41:8082/project/e10640a3-d29b-41b2-97fc-629ff0d52ae9
2026-03-19 03:25:55,588 - INFO - Validated that VN ctest-trans_right_vn-77871144 is not found in API Server
2026-03-19 03:25:55,618 - DEBUG - VN ctest-trans_right_vn-77871144 is not present in Agent 10.0.0.23
2026-03-19 03:25:55,631 - DEBUG - VN ctest-trans_right_vn-77871144 is not present in Agent 10.0.0.240
2026-03-19 03:25:55,631 - INFO - Validated that VN ctest-trans_right_vn-77871144 is not in any agent
2026-03-19 03:25:55,677 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-77871144 info
2026-03-19 03:25:55,677 - INFO - Deleting VN ctest-trans_left_vn-13247455
2026-03-19 03:25:55,827 - DEBUG - Response for deleting network ()
2026-03-19 03:25:55,827 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/ccc85045-446a-41f3-a02b-6b3be8e13662
2026-03-19 03:25:55,833 - DEBUG - Response Code: 404
2026-03-19 03:25:55,834 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:25:55,844 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:25:55,864 - DEBUG - Requesting: http://10.0.0.41:8082/project/e10640a3-d29b-41b2-97fc-629ff0d52ae9
2026-03-19 03:25:55,966 - INFO - Validated that VN ctest-trans_left_vn-13247455 is not found in API Server
2026-03-19 03:25:55,987 - DEBUG - VN ctest-trans_left_vn-13247455 is not present in Agent 10.0.0.23
2026-03-19 03:25:56,010 - DEBUG - VN ctest-trans_left_vn-13247455 is not present in Agent 10.0.0.240
2026-03-19 03:25:56,010 - INFO - Validated that VN ctest-trans_left_vn-13247455 is not in any agent
2026-03-19 03:25:56,078 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-13247455 info
2026-03-19 03:25:56,078 - INFO - Deleting VN ctest-right_vn-72533481
2026-03-19 03:25:56,142 - DEBUG - VN 719c4d37-4c51-4fee-8c8d-4b1f17293f99 still in use: Unable to complete operation on network 719c4d37-4c51-4fee-8c8d-4b1f17293f99. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-d4af6323-6f53-4718-aa91-0c366899f3b6']
2026-03-19 03:25:56,142 - WARNING - Deleting VN ctest-right_vn-72533481 failed..Will retry
2026-03-19 03:25:58,385 - DEBUG - Response for deleting network ()
2026-03-19 03:25:58,385 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/c216a1c8-a682-4d28-b764-356a985e4db1
2026-03-19 03:25:58,397 - DEBUG - Response Code: 404
2026-03-19 03:25:58,397 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:25:58,411 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:25:58,426 - DEBUG - Requesting: http://10.0.0.41:8082/project/e10640a3-d29b-41b2-97fc-629ff0d52ae9
2026-03-19 03:25:58,550 - INFO - Validated that VN ctest-right_vn-72533481 is not found in API Server
2026-03-19 03:25:58,562 - DEBUG - VN ctest-right_vn-72533481 is not present in Agent 10.0.0.23
2026-03-19 03:25:58,578 - DEBUG - VN ctest-right_vn-72533481 is not present in Agent 10.0.0.240
2026-03-19 03:25:58,578 - INFO - Validated that VN ctest-right_vn-72533481 is not in any agent
2026-03-19 03:25:58,615 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-72533481 info
2026-03-19 03:25:58,616 - INFO - Deleting VN ctest-left_vn-84826708
2026-03-19 03:25:58,806 - DEBUG - Response for deleting network ()
2026-03-19 03:25:58,806 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/49c00f85-30d8-4c92-b1c9-5a4ea43aa902
2026-03-19 03:25:58,814 - DEBUG - Response Code: 404
2026-03-19 03:25:58,814 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:25:58,833 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:25:58,896 - DEBUG - Requesting: http://10.0.0.41:8082/project/e10640a3-d29b-41b2-97fc-629ff0d52ae9
2026-03-19 03:25:58,991 - INFO - Validated that VN ctest-left_vn-84826708 is not found in API Server
2026-03-19 03:25:59,004 - DEBUG - VN ctest-left_vn-84826708 is not present in Agent 10.0.0.23
2026-03-19 03:25:59,020 - DEBUG - VN ctest-left_vn-84826708 is not present in Agent 10.0.0.240
2026-03-19 03:25:59,020 - INFO - Validated that VN ctest-left_vn-84826708 is not in any agent
2026-03-19 03:25:59,054 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-84826708 info
2026-03-19 03:25:59,054 - INFO - Deleting VN ctest-mgmt_vn-15504424
2026-03-19 03:25:59,222 - DEBUG - Response for deleting network ()
2026-03-19 03:25:59,222 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/25b8b38f-0a62-4d76-afe3-2e63e0effe01
2026-03-19 03:25:59,228 - DEBUG - Response Code: 404
2026-03-19 03:25:59,228 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:25:59,237 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:25:59,258 - DEBUG - Requesting: http://10.0.0.41:8082/project/e10640a3-d29b-41b2-97fc-629ff0d52ae9
2026-03-19 03:25:59,373 - INFO - Validated that VN ctest-mgmt_vn-15504424 is not found in API Server
2026-03-19 03:25:59,385 - DEBUG - VN ctest-mgmt_vn-15504424 is not present in Agent 10.0.0.23
2026-03-19 03:25:59,401 - DEBUG - VN ctest-mgmt_vn-15504424 is not present in Agent 10.0.0.240
2026-03-19 03:25:59,402 - INFO - Validated that VN ctest-mgmt_vn-15504424 is not in any agent
2026-03-19 03:25:59,439 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-15504424 info
2026-03-19 03:26:00,739 - DEBUG - No XMPP flaps were noticed during the test
2026-03-19 03:26:00,739 - INFO -
2026-03-19 03:26:00,739 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:16]
2026-03-19 03:26:00,739 - INFO - --------------------------------------------------------------------------------
2026-03-19 03:26:01,654 - INFO - Deleted project: ctest-TestSvcRegr-10574396, ID : e10640a3-d29b-41b2-97fc-629ff0d52ae9
2026-03-19 03:26:01,948 - INFO - Domain Default found not creating
2026-03-19 03:26:02,152 - INFO - Project ctest-TestSvcRegr-44202795 not found, creating it
2026-03-19 03:26:02,674 - INFO - Created Project:ctest-TestSvcRegr-44202795, ID : 4cbda1fe-728a-41e6-a215-b7d1565728d9
2026-03-19 03:26:04,343 - INFO - ================================================================================
2026-03-19 03:26:04,343 - INFO - STARTING TEST : test_svc_CEM_22032
2026-03-19 03:26:05,637 - DEBUG - Nothing to compare xmpp stats {'10.0.0.23': {'10.20.0.129': '0', '10.20.0.18': '0'}, '10.0.0.240': {'10.20.0.18': '0', '10.20.0.193': '0'}} with
2026-03-19 03:26:05,638 - INFO - Initial checks done. Running the testcase now
2026-03-19 03:26:05,638 - INFO -
2026-03-19 03:26:06,320 - DEBUG - Response for create_network : {'network': {'id': '4c365e0f-5d54-4173-a3d8-018c49ab6dee', 'name': 'ctest-mgmt_vn-05764318', 'tenant_id': '4cbda1fe728a41e6a215b7d1565728d9', 'project_id': '4cbda1fe728a41e6a215b7d1565728d9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-44202795', 'ctest-mgmt_vn-05764318'], 'port_security_enabled': True, 'description': ''}}
2026-03-19 03:26:06,628 - DEBUG - Response for create_subnet : {'subnet': {'id': '923dd258-d2e8-4462-8a57-856bc18f7aef', 'name': '', 'tenant_id': '4cbda1fe728a41e6a215b7d1565728d9', 'network_id': '4c365e0f-5d54-4173-a3d8-018c49ab6dee', 'ip_version': 4, 'cidr': '42.97.188.64/26', 'allocation_pools': [{'start': '42.97.188.66', 'end': '42.97.188.126'}], 'gateway_ip': '42.97.188.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '42.97.188.66', 'tags': [], 'project_id': '4cbda1fe728a41e6a215b7d1565728d9'}}
2026-03-19 03:26:06,649 - INFO - Created VN ctest-mgmt_vn-05764318
2026-03-19 03:26:06,661 - DEBUG - VN ctest-mgmt_vn-05764318 UUID is 4c365e0f-5d54-4173-a3d8-018c49ab6dee
2026-03-19 03:26:06,737 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:26:07,050 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:26:07,085 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:26:07,102 - DEBUG - Requesting: http://10.0.0.41:8082/project/4cbda1fe-728a-41e6-a215-b7d1565728d9
2026-03-19 03:26:07,203 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/4c365e0f-5d54-4173-a3d8-018c49ab6dee
2026-03-19 03:26:07,217 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/4c365e0f-5d54-4173-a3d8-018c49ab6dee
2026-03-19 03:26:07,227 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/9a961afc-1c2d-423d-bae7-bca18926736c
2026-03-19 03:26:07,238 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/9a961afc-1c2d-423d-bae7-bca18926736c
2026-03-19 03:26:07,248 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/9be759ef-956d-4e6a-93e7-5dbb8c803884
2026-03-19 03:26:07,256 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-19 03:26:07,256 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/4c365e0f-5d54-4173-a3d8-018c49ab6dee
2026-03-19 03:26:07,267 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/9a961afc-1c2d-423d-bae7-bca18926736c
2026-03-19 03:26:07,286 - INFO - Verified VN network id 14 for VN 4c365e0f-5d54-4173-a3d8-018c49ab6dee
2026-03-19 03:26:07,286 - INFO - Verifications in API Server for VN ctest-mgmt_vn-05764318 passed
2026-03-19 03:26:07,286 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/4c365e0f-5d54-4173-a3d8-018c49ab6dee
2026-03-19 03:26:07,298 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/9a961afc-1c2d-423d-bae7-bca18926736c
2026-03-19 03:26:07,308 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/9a961afc-1c2d-423d-bae7-bca18926736c
2026-03-19 03:26:07,315 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/9be759ef-956d-4e6a-93e7-5dbb8c803884
2026-03-19 03:26:07,329 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-05764318', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-44202795', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5491680215708221811', 'uuid-lslong': '11806188125194776046'}, 'enable': 'true', 'created': '2026-03-19T03:26:06', 'last-modified': '2026-03-19T03:26:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.747834'}
2026-03-19 03:26:07,334 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-19 03:26:07,340 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-05764318', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-44202795', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5491680215708221811', 'uuid-lslong': '11806188125194776046'}, 'enable': 'true', 'created': '2026-03-19T03:26:06', 'last-modified': '2026-03-19T03:26:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.758161'}
2026-03-19 03:26:07,347 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-19 03:26:07,353 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-05764318', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-44202795', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5491680215708221811', 'uuid-lslong': '11806188125194776046'}, 'enable': 'true', 'created': '2026-03-19T03:26:06', 'last-modified': '2026-03-19T03:26:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.782535'}
2026-03-19 03:26:07,358 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-19 03:26:07,359 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-05764318 passed
2026-03-19 03:26:07,359 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-05764318 in API_Server ======
2026-03-19 03:26:07,359 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:26:07,365 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:26:07,379 - DEBUG - Requesting: http://10.0.0.41:8082/project/4cbda1fe-728a-41e6-a215-b7d1565728d9
2026-03-19 03:26:07,471 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/4c365e0f-5d54-4173-a3d8-018c49ab6dee
2026-03-19 03:26:07,483 - DEBUG - =>VN ctest-mgmt_vn-05764318 has no policy to be verified
2026-03-19 03:26:07,483 - DEBUG - Verifying the vn in opserver
2026-03-19 03:26:07,483 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-05764318 virtual network link through opserver 10.0.0.41
2026-03-19 03:26:07,483 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-03-19 03:26:07,814 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-03-19 03:26:07,898 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-05764318', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-05764318?flat'}
2026-03-19 03:26:07,898 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-05764318 virtual network link through opserver 10.0.0.242
2026-03-19 03:26:07,898 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-03-19 03:26:08,205 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-03-19 03:26:08,290 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-05764318', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-05764318?flat'}
2026-03-19 03:26:08,290 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-05764318 virtual network link through opserver 10.0.0.27
2026-03-19 03:26:08,290 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-19 03:26:08,610 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-19 03:26:08,684 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-05764318', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-05764318?flat'}
2026-03-19 03:26:08,684 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-05764318 is found in opserver
2026-03-19 03:26:08,707 - DEBUG - Do not have enough data to verify VN in agent
2026-03-19 03:26:08,718 - DEBUG - VRF ids for VN ctest-mgmt_vn-05764318: {}
2026-03-19 03:26:08,968 - DEBUG - Response for create_network : {'network': {'id': 'cda142be-47a5-49c1-b7ef-3bd2c65b7d00', 'name': 'service-left-vn-51538273', 'tenant_id': '4cbda1fe728a41e6a215b7d1565728d9', 'project_id': '4cbda1fe728a41e6a215b7d1565728d9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-44202795', 'service-left-vn-51538273'], 'port_security_enabled': True, 'description': ''}}
2026-03-19 03:26:09,245 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ed647fd3-e7c6-4d18-9daa-f966a087fa6f', 'name': '', 'tenant_id': '4cbda1fe728a41e6a215b7d1565728d9', 'network_id': 'cda142be-47a5-49c1-b7ef-3bd2c65b7d00', 'ip_version': 4, 'cidr': '134.130.207.128/26', 'allocation_pools': [{'start': '134.130.207.130', 'end': '134.130.207.190'}], 'gateway_ip': '134.130.207.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '134.130.207.130', 'tags': [], 'project_id': '4cbda1fe728a41e6a215b7d1565728d9'}}
2026-03-19 03:26:09,273 - INFO - Created VN service-left-vn-51538273
2026-03-19 03:26:09,287 - DEBUG - VN service-left-vn-51538273 UUID is cda142be-47a5-49c1-b7ef-3bd2c65b7d00
2026-03-19 03:26:09,363 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:26:09,369 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:26:09,382 - DEBUG - Requesting: http://10.0.0.41:8082/project/4cbda1fe-728a-41e6-a215-b7d1565728d9
2026-03-19 03:26:09,478 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/cda142be-47a5-49c1-b7ef-3bd2c65b7d00
2026-03-19 03:26:09,492 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/cda142be-47a5-49c1-b7ef-3bd2c65b7d00
2026-03-19 03:26:09,506 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/8ada545e-e605-4b64-9042-87d44ae608c3
2026-03-19 03:26:09,516 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/8ada545e-e605-4b64-9042-87d44ae608c3
2026-03-19 03:26:09,524 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/54da4a78-932a-4a93-bb07-aac5bd636f49
2026-03-19 03:26:09,532 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-19 03:26:09,532 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/cda142be-47a5-49c1-b7ef-3bd2c65b7d00
2026-03-19 03:26:09,543 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/8ada545e-e605-4b64-9042-87d44ae608c3
2026-03-19 03:26:09,561 - INFO - Verified VN network id 15 for VN cda142be-47a5-49c1-b7ef-3bd2c65b7d00
2026-03-19 03:26:09,561 - INFO - Verifications in API Server for VN service-left-vn-51538273 passed
2026-03-19 03:26:09,561 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/cda142be-47a5-49c1-b7ef-3bd2c65b7d00
2026-03-19 03:26:09,573 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/8ada545e-e605-4b64-9042-87d44ae608c3
2026-03-19 03:26:09,583 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/8ada545e-e605-4b64-9042-87d44ae608c3
2026-03-19 03:26:09,593 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/54da4a78-932a-4a93-bb07-aac5bd636f49
2026-03-19 03:26:09,608 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-44202795:service-left-vn-51538273', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-44202795', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14817197634038876609', 'uuid-lslong': '13253878004831714560'}, 'enable': 'true', 'created': '2026-03-19T03:26:08', 'last-modified': '2026-03-19T03:26:09', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.430839'}
2026-03-19 03:26:09,615 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-19 03:26:09,621 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-44202795:service-left-vn-51538273', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-44202795', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14817197634038876609', 'uuid-lslong': '13253878004831714560'}, 'enable': 'true', 'created': '2026-03-19T03:26:08', 'last-modified': '2026-03-19T03:26:09', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.446944'}
2026-03-19 03:26:09,628 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-19 03:26:09,634 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-44202795:service-left-vn-51538273', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-44202795', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14817197634038876609', 'uuid-lslong': '13253878004831714560'}, 'enable': 'true', 'created': '2026-03-19T03:26:08', 'last-modified': '2026-03-19T03:26:09', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.448117'}
2026-03-19 03:26:09,640 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-19 03:26:09,641 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-51538273 passed
2026-03-19 03:26:09,641 - DEBUG - ====Verifying policy data for service-left-vn-51538273 in API_Server ======
2026-03-19 03:26:09,641 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:26:09,649 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:26:09,662 - DEBUG - Requesting: http://10.0.0.41:8082/project/4cbda1fe-728a-41e6-a215-b7d1565728d9
2026-03-19 03:26:09,758 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/cda142be-47a5-49c1-b7ef-3bd2c65b7d00
2026-03-19 03:26:09,771 - DEBUG - =>VN service-left-vn-51538273 has no policy to be verified
2026-03-19 03:26:09,771 - DEBUG - Verifying the vn in opserver
2026-03-19 03:26:09,771 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-44202795:service-left-vn-51538273 virtual network link through opserver 10.0.0.41
2026-03-19 03:26:09,771 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-03-19 03:26:09,838 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-44202795:service-left-vn-51538273', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-44202795:service-left-vn-51538273?flat'}
2026-03-19 03:26:09,838 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-44202795:service-left-vn-51538273 virtual network link through opserver 10.0.0.242
2026-03-19 03:26:09,839 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-03-19 03:26:09,920 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-44202795:service-left-vn-51538273', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-44202795:service-left-vn-51538273?flat'}
2026-03-19 03:26:09,920 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-44202795:service-left-vn-51538273 virtual network link through opserver 10.0.0.27
2026-03-19 03:26:09,920 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-19 03:26:09,990 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-44202795:service-left-vn-51538273', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-44202795:service-left-vn-51538273?flat'}
2026-03-19 03:26:09,990 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-44202795:service-left-vn-51538273 is found in opserver
2026-03-19 03:26:10,015 - DEBUG - Do not have enough data to verify VN in agent
2026-03-19 03:26:10,029 - DEBUG - VRF ids for VN service-left-vn-51538273: {}
2026-03-19 03:26:10,310 - DEBUG - Response for create_network : {'network': {'id': '77c60b77-97f3-465c-ba3b-9aec3837dc37', 'name': 'service-right-vn-84555501', 'tenant_id': '4cbda1fe728a41e6a215b7d1565728d9', 'project_id': '4cbda1fe728a41e6a215b7d1565728d9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-44202795', 'service-right-vn-84555501'], 'port_security_enabled': True, 'description': ''}}
2026-03-19 03:26:10,606 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c3064567-58d4-4338-9ec0-db45b497c596', 'name': '', 'tenant_id': '4cbda1fe728a41e6a215b7d1565728d9', 'network_id': '77c60b77-97f3-465c-ba3b-9aec3837dc37', 'ip_version': 4, 'cidr': '53.159.60.64/26', 'allocation_pools': [{'start': '53.159.60.66', 'end': '53.159.60.126'}], 'gateway_ip': '53.159.60.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '53.159.60.66', 'tags': [], 'project_id': '4cbda1fe728a41e6a215b7d1565728d9'}}
2026-03-19 03:26:10,631 - INFO - Created VN service-right-vn-84555501
2026-03-19 03:26:10,644 - DEBUG - VN service-right-vn-84555501 UUID is 77c60b77-97f3-465c-ba3b-9aec3837dc37
2026-03-19 03:26:10,738 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:26:10,747 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:26:10,759 - DEBUG - Requesting: http://10.0.0.41:8082/project/4cbda1fe-728a-41e6-a215-b7d1565728d9
2026-03-19 03:26:10,858 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/77c60b77-97f3-465c-ba3b-9aec3837dc37
2026-03-19 03:26:10,875 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/77c60b77-97f3-465c-ba3b-9aec3837dc37
2026-03-19 03:26:10,886 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/1b313361-9e5c-4498-ba3f-875502ae9815
2026-03-19 03:26:10,896 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/1b313361-9e5c-4498-ba3f-875502ae9815
2026-03-19 03:26:10,903 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/cc1331a8-d9b3-429b-80db-f772b9644ae5
2026-03-19 03:26:10,911 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-19 03:26:10,911 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/77c60b77-97f3-465c-ba3b-9aec3837dc37
2026-03-19 03:26:10,919 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/1b313361-9e5c-4498-ba3f-875502ae9815
2026-03-19 03:26:10,934 - INFO - Verified VN network id 16 for VN 77c60b77-97f3-465c-ba3b-9aec3837dc37
2026-03-19 03:26:10,934 - INFO - Verifications in API Server for VN service-right-vn-84555501 passed
2026-03-19 03:26:10,934 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/77c60b77-97f3-465c-ba3b-9aec3837dc37
2026-03-19 03:26:10,944 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/1b313361-9e5c-4498-ba3f-875502ae9815
2026-03-19 03:26:10,953 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/1b313361-9e5c-4498-ba3f-875502ae9815
2026-03-19 03:26:10,961 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/cc1331a8-d9b3-429b-80db-f772b9644ae5
2026-03-19 03:26:10,973 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-44202795:service-right-vn-84555501', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-44202795', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8630598344180450908', 'uuid-lslong': '13419489854026669111'}, 'enable': 'true', 'created': '2026-03-19T03:26:10', 'last-modified': '2026-03-19T03:26:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.430769'}
2026-03-19 03:26:10,979 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-19 03:26:10,986 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-44202795:service-right-vn-84555501', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-44202795', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8630598344180450908', 'uuid-lslong': '13419489854026669111'}, 'enable': 'true', 'created': '2026-03-19T03:26:10', 'last-modified': '2026-03-19T03:26:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.442018'}
2026-03-19 03:26:10,993 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-19 03:26:10,998 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-44202795:service-right-vn-84555501', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-44202795', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8630598344180450908', 'uuid-lslong': '13419489854026669111'}, 'enable': 'true', 'created': '2026-03-19T03:26:10', 'last-modified': '2026-03-19T03:26:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.456476'}
2026-03-19 03:26:11,004 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-19 03:26:11,004 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-84555501 passed
2026-03-19 03:26:11,004 - DEBUG - ====Verifying policy data for service-right-vn-84555501 in API_Server ======
2026-03-19 03:26:11,004 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:26:11,011 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:26:11,023 - DEBUG - Requesting: http://10.0.0.41:8082/project/4cbda1fe-728a-41e6-a215-b7d1565728d9
2026-03-19 03:26:11,118 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/77c60b77-97f3-465c-ba3b-9aec3837dc37
2026-03-19 03:26:11,130 - DEBUG - =>VN service-right-vn-84555501 has no policy to be verified
2026-03-19 03:26:11,130 - DEBUG - Verifying the vn in opserver
2026-03-19 03:26:11,130 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-44202795:service-right-vn-84555501 virtual network link through opserver 10.0.0.41
2026-03-19 03:26:11,130 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-03-19 03:26:11,212 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-44202795:service-right-vn-84555501', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-44202795:service-right-vn-84555501?flat'}
2026-03-19 03:26:11,212 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-44202795:service-right-vn-84555501 virtual network link through opserver 10.0.0.242
2026-03-19 03:26:11,213 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-03-19 03:26:11,287 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-44202795:service-right-vn-84555501', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-44202795:service-right-vn-84555501?flat'}
2026-03-19 03:26:11,287 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-44202795:service-right-vn-84555501 virtual network link through opserver 10.0.0.27
2026-03-19 03:26:11,287 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-19 03:26:11,379 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-44202795:service-right-vn-84555501', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-44202795:service-right-vn-84555501?flat'}
2026-03-19 03:26:11,379 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-44202795:service-right-vn-84555501 is found in opserver
2026-03-19 03:26:11,404 - DEBUG - Do not have enough data to verify VN in agent
2026-03-19 03:26:11,415 - DEBUG - VRF ids for VN service-right-vn-84555501: {}
2026-03-19 03:26:11,498 - DEBUG - Services list from nova: [, , , ]
2026-03-19 03:26:12,716 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5493-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5493-2)
2026-03-19 03:26:14,037 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5493-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5493-1)
2026-03-19 03:26:14,037 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-57895509']
2026-03-19 03:26:14,321 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-57895509'] created succesfully
2026-03-19 03:26:14,723 - DEBUG - Image by name tiny_nat_fw not found
2026-03-19 03:26:14,723 - DEBUG - Installing image tiny_nat_fw
2026-03-19 03:26:14,723 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-03-19 03:26:14,723 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-19 03:26:14,723 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-19 03:26:14,723 - DEBUG - Unzip image
2026-03-19 03:26:14,723 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-19 03:26:14,767 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-03-19 03:26:14,768 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-57895509']
2026-03-19 03:26:14,862 - INFO - Service template: ['default-domain', 'ctest-service_template_1-57895509'] deleted successfully.
2026-03-19 03:26:14,862 - INFO - Skip interface_detach for VM ctest-right_vm-56625994 in state BUILD
2026-03-19 03:26:14,863 - INFO - Deleting VM ctest-right_vm-56625994
2026-03-19 03:26:14,914 - ERROR - VM ctest-right_vm-56625994 has failed to come up
2026-03-19 03:26:14,914 - ERROR - Nova failed to get host of the VM
2026-03-19 03:26:14,914 - ERROR - VM ctest-right_vm-56625994 has failed to come up
2026-03-19 03:26:14,914 - ERROR - Nova failed to get host of the VM
2026-03-19 03:26:15,038 - INFO - Skip interface_detach for VM ctest-left_vm-86026318 in state BUILD
2026-03-19 03:26:15,038 - INFO - Deleting VM ctest-left_vm-86026318
2026-03-19 03:26:15,038 - ERROR - VM ctest-left_vm-86026318 has failed to come up
2026-03-19 03:26:15,038 - ERROR - Nova failed to get host of the VM
2026-03-19 03:26:15,038 - ERROR - VM ctest-left_vm-86026318 has failed to come up
2026-03-19 03:26:15,038 - ERROR - Nova failed to get host of the VM
2026-03-19 03:26:15,139 - INFO - Deleting VN service-right-vn-84555501
2026-03-19 03:26:15,191 - DEBUG - VN 77c60b77-97f3-465c-ba3b-9aec3837dc37 still in use: Unable to complete operation on network 77c60b77-97f3-465c-ba3b-9aec3837dc37. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-b69007d6-c4c5-42e5-a976-67c4acb1aef3']
2026-03-19 03:26:15,192 - WARNING - Deleting VN service-right-vn-84555501 failed..Will retry
2026-03-19 03:26:17,349 - DEBUG - Response for deleting network ()
2026-03-19 03:26:17,349 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/1b313361-9e5c-4498-ba3f-875502ae9815
2026-03-19 03:26:17,356 - DEBUG - Response Code: 404
2026-03-19 03:26:17,357 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:26:17,402 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:26:17,440 - DEBUG - Requesting: http://10.0.0.41:8082/project/4cbda1fe-728a-41e6-a215-b7d1565728d9
2026-03-19 03:26:17,545 - INFO - Validated that VN service-right-vn-84555501 is not found in API Server
2026-03-19 03:26:17,557 - DEBUG - VN service-right-vn-84555501 is not present in Agent 10.0.0.23
2026-03-19 03:26:17,569 - DEBUG - VN service-right-vn-84555501 is not present in Agent 10.0.0.240
2026-03-19 03:26:17,569 - INFO - Validated that VN service-right-vn-84555501 is not in any agent
2026-03-19 03:26:17,608 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-84555501 info
2026-03-19 03:26:17,608 - INFO - Deleting VN service-left-vn-51538273
2026-03-19 03:26:17,803 - DEBUG - Response for deleting network ()
2026-03-19 03:26:17,804 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/8ada545e-e605-4b64-9042-87d44ae608c3
2026-03-19 03:26:17,810 - DEBUG - Response Code: 404
2026-03-19 03:26:17,810 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:26:17,817 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:26:17,841 - DEBUG - Requesting: http://10.0.0.41:8082/project/4cbda1fe-728a-41e6-a215-b7d1565728d9
2026-03-19 03:26:17,947 - INFO - Validated that VN service-left-vn-51538273 is not found in API Server
2026-03-19 03:26:17,960 - DEBUG - VN service-left-vn-51538273 is not present in Agent 10.0.0.23
2026-03-19 03:26:17,971 - DEBUG - VN service-left-vn-51538273 is not present in Agent 10.0.0.240
2026-03-19 03:26:17,971 - INFO - Validated that VN service-left-vn-51538273 is not in any agent
2026-03-19 03:26:18,006 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-51538273 info
2026-03-19 03:26:18,007 - INFO - Deleting VN ctest-mgmt_vn-05764318
2026-03-19 03:26:18,196 - DEBUG - Response for deleting network ()
2026-03-19 03:26:18,196 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/9a961afc-1c2d-423d-bae7-bca18926736c
2026-03-19 03:26:18,203 - DEBUG - Response Code: 404
2026-03-19 03:26:18,203 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:26:18,218 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:26:18,239 - DEBUG - Requesting: http://10.0.0.41:8082/project/4cbda1fe-728a-41e6-a215-b7d1565728d9
2026-03-19 03:26:18,329 - INFO - Validated that VN ctest-mgmt_vn-05764318 is not found in API Server
2026-03-19 03:26:18,348 - DEBUG - VN ctest-mgmt_vn-05764318 is not present in Agent 10.0.0.23
2026-03-19 03:26:18,358 - DEBUG - VN ctest-mgmt_vn-05764318 is not present in Agent 10.0.0.240
2026-03-19 03:26:18,358 - INFO - Validated that VN ctest-mgmt_vn-05764318 is not in any agent
2026-03-19 03:26:18,390 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-05764318 info
2026-03-19 03:26:19,692 - DEBUG - No XMPP flaps were noticed during the test
2026-03-19 03:26:19,693 - INFO -
2026-03-19 03:26:19,693 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:15]
2026-03-19 03:26:19,693 - INFO - --------------------------------------------------------------------------------
2026-03-19 03:26:19,696 - INFO - ================================================================================
2026-03-19 03:26:19,696 - INFO - STARTING TEST : test_svc_in_network_datapath
2026-03-19 03:26:20,989 - DEBUG - Nothing to compare xmpp stats {'10.0.0.23': {'10.20.0.129': '0', '10.20.0.18': '0'}, '10.0.0.240': {'10.20.0.18': '0', '10.20.0.193': '0'}} with
2026-03-19 03:26:20,989 - INFO - Initial checks done. Running the testcase now
2026-03-19 03:26:20,989 - INFO -
2026-03-19 03:26:21,284 - DEBUG - Response for create_network : {'network': {'id': '1e32e5b6-a7aa-4f64-908a-818713079fad', 'name': 'ctest-mgmt_vn-07426048', 'tenant_id': '4cbda1fe728a41e6a215b7d1565728d9', 'project_id': '4cbda1fe728a41e6a215b7d1565728d9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-44202795', 'ctest-mgmt_vn-07426048'], 'port_security_enabled': True, 'description': ''}}
2026-03-19 03:26:21,511 - DEBUG - Response for create_subnet : {'subnet': {'id': '9d78b458-24f7-4ee3-b008-3a492de97afb', 'name': '', 'tenant_id': '4cbda1fe728a41e6a215b7d1565728d9', 'network_id': '1e32e5b6-a7aa-4f64-908a-818713079fad', 'ip_version': 4, 'cidr': '61.145.113.128/26', 'allocation_pools': [{'start': '61.145.113.130', 'end': '61.145.113.190'}], 'gateway_ip': '61.145.113.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '61.145.113.130', 'tags': [], 'project_id': '4cbda1fe728a41e6a215b7d1565728d9'}}
2026-03-19 03:26:21,534 - INFO - Created VN ctest-mgmt_vn-07426048
2026-03-19 03:26:21,547 - DEBUG - VN ctest-mgmt_vn-07426048 UUID is 1e32e5b6-a7aa-4f64-908a-818713079fad
2026-03-19 03:26:21,625 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:26:21,632 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:26:21,647 - DEBUG - Requesting: http://10.0.0.41:8082/project/4cbda1fe-728a-41e6-a215-b7d1565728d9
2026-03-19 03:26:21,747 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/1e32e5b6-a7aa-4f64-908a-818713079fad
2026-03-19 03:26:21,768 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/1e32e5b6-a7aa-4f64-908a-818713079fad
2026-03-19 03:26:21,784 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/a368cf32-4ba1-4127-89d2-25e35d10fa02
2026-03-19 03:26:21,797 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/a368cf32-4ba1-4127-89d2-25e35d10fa02
2026-03-19 03:26:21,807 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/06c2348b-cfd9-4ed0-9e29-bc7baf494192
2026-03-19 03:26:21,815 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-19 03:26:21,815 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/1e32e5b6-a7aa-4f64-908a-818713079fad
2026-03-19 03:26:21,830 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/a368cf32-4ba1-4127-89d2-25e35d10fa02
2026-03-19 03:26:21,848 - INFO - Verified VN network id 14 for VN 1e32e5b6-a7aa-4f64-908a-818713079fad
2026-03-19 03:26:21,848 - INFO - Verifications in API Server for VN ctest-mgmt_vn-07426048 passed
2026-03-19 03:26:21,848 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/1e32e5b6-a7aa-4f64-908a-818713079fad
2026-03-19 03:26:21,863 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/a368cf32-4ba1-4127-89d2-25e35d10fa02
2026-03-19 03:26:21,873 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/a368cf32-4ba1-4127-89d2-25e35d10fa02
2026-03-19 03:26:21,885 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/06c2348b-cfd9-4ed0-9e29-bc7baf494192
2026-03-19 03:26:21,900 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-07426048', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-44202795', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2176054142633135972', 'uuid-lslong': '10415279505387528109'}, 'enable': 'true', 'created': '2026-03-19T03:26:21', 'last-modified': '2026-03-19T03:26:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.460898'}
2026-03-19 03:26:21,906 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-19 03:26:21,912 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-07426048', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-44202795', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2176054142633135972', 'uuid-lslong': '10415279505387528109'}, 'enable': 'true', 'created': '2026-03-19T03:26:21', 'last-modified': '2026-03-19T03:26:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.472267'}
2026-03-19 03:26:21,919 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-19 03:26:21,924 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-07426048', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-44202795', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2176054142633135972', 'uuid-lslong': '10415279505387528109'}, 'enable': 'true', 'created': '2026-03-19T03:26:21', 'last-modified': '2026-03-19T03:26:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.484594'}
2026-03-19 03:26:21,930 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-19 03:26:21,930 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-07426048 passed
2026-03-19 03:26:21,931 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-07426048 in API_Server ======
2026-03-19 03:26:21,931 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:26:21,938 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:26:21,952 - DEBUG - Requesting: http://10.0.0.41:8082/project/4cbda1fe-728a-41e6-a215-b7d1565728d9
2026-03-19 03:26:22,056 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/1e32e5b6-a7aa-4f64-908a-818713079fad
2026-03-19 03:26:22,070 - DEBUG - =>VN ctest-mgmt_vn-07426048 has no policy to be verified
2026-03-19 03:26:22,070 - DEBUG - Verifying the vn in opserver
2026-03-19 03:26:22,070 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-07426048 virtual network link through opserver 10.0.0.41
2026-03-19 03:26:22,070 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-03-19 03:26:22,088 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-07426048', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-07426048?flat'}
2026-03-19 03:26:22,088 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-07426048 virtual network link through opserver 10.0.0.242
2026-03-19 03:26:22,088 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-03-19 03:26:22,103 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-07426048', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-07426048?flat'}
2026-03-19 03:26:22,103 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-07426048 virtual network link through opserver 10.0.0.27
2026-03-19 03:26:22,103 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-19 03:26:22,115 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-07426048', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-07426048?flat'}
2026-03-19 03:26:22,115 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-44202795:ctest-mgmt_vn-07426048 is found in opserver
2026-03-19 03:26:22,138 - DEBUG - Do not have enough data to verify VN in agent
2026-03-19 03:26:22,149 - DEBUG - VRF ids for VN ctest-mgmt_vn-07426048: {}
2026-03-19 03:26:22,423 - DEBUG - Response for create_network : {'network': {'id': 'eb1df059-729b-4887-865c-69a7e7d897ac', 'name': 'ctest-left_vn-21797002', 'tenant_id': '4cbda1fe728a41e6a215b7d1565728d9', 'project_id': '4cbda1fe728a41e6a215b7d1565728d9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-44202795', 'ctest-left_vn-21797002'], 'port_security_enabled': True, 'description': ''}}
2026-03-19 03:26:22,681 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a01fb772-4205-47d1-99fa-763484f8a719', 'name': '', 'tenant_id': '4cbda1fe728a41e6a215b7d1565728d9', 'network_id': 'eb1df059-729b-4887-865c-69a7e7d897ac', 'ip_version': 4, 'cidr': '3.106.66.128/26', 'allocation_pools': [{'start': '3.106.66.130', 'end': '3.106.66.190'}], 'gateway_ip': '3.106.66.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '3.106.66.130', 'tags': [], 'project_id': '4cbda1fe728a41e6a215b7d1565728d9'}}
2026-03-19 03:26:22,705 - INFO - Created VN ctest-left_vn-21797002
2026-03-19 03:26:22,716 - DEBUG - VN ctest-left_vn-21797002 UUID is eb1df059-729b-4887-865c-69a7e7d897ac
2026-03-19 03:26:22,801 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:26:22,808 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:26:22,823 - DEBUG - Requesting: http://10.0.0.41:8082/project/4cbda1fe-728a-41e6-a215-b7d1565728d9
2026-03-19 03:26:22,930 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/eb1df059-729b-4887-865c-69a7e7d897ac
2026-03-19 03:26:22,946 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/eb1df059-729b-4887-865c-69a7e7d897ac
2026-03-19 03:26:22,957 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/52145253-375b-4b27-b15d-d3242949e2b3
2026-03-19 03:26:22,968 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/52145253-375b-4b27-b15d-d3242949e2b3
2026-03-19 03:26:22,977 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/7c22cddb-fbcb-46ec-826d-d4182cbc2ba2
2026-03-19 03:26:22,986 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-19 03:26:22,986 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/eb1df059-729b-4887-865c-69a7e7d897ac
2026-03-19 03:26:22,998 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/52145253-375b-4b27-b15d-d3242949e2b3
2026-03-19 03:26:23,016 - INFO - Verified VN network id 15 for VN eb1df059-729b-4887-865c-69a7e7d897ac
2026-03-19 03:26:23,017 - INFO - Verifications in API Server for VN ctest-left_vn-21797002 passed
2026-03-19 03:26:23,018 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/eb1df059-729b-4887-865c-69a7e7d897ac
2026-03-19 03:26:23,031 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/52145253-375b-4b27-b15d-d3242949e2b3
2026-03-19 03:26:23,039 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/52145253-375b-4b27-b15d-d3242949e2b3
2026-03-19 03:26:23,047 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/7c22cddb-fbcb-46ec-826d-d4182cbc2ba2
2026-03-19 03:26:23,060 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-44202795:ctest-left_vn-21797002', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-44202795', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16941961640203208839', 'uuid-lslong': '9681729468809910188'}, 'enable': 'true', 'created': '2026-03-19T03:26:22', 'last-modified': '2026-03-19T03:26:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.424015'}
2026-03-19 03:26:23,066 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-19 03:26:23,072 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-44202795:ctest-left_vn-21797002', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-44202795', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16941961640203208839', 'uuid-lslong': '9681729468809910188'}, 'enable': 'true', 'created': '2026-03-19T03:26:22', 'last-modified': '2026-03-19T03:26:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.436020'}
2026-03-19 03:26:23,080 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-19 03:26:23,086 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-44202795:ctest-left_vn-21797002', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-44202795', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16941961640203208839', 'uuid-lslong': '9681729468809910188'}, 'enable': 'true', 'created': '2026-03-19T03:26:22', 'last-modified': '2026-03-19T03:26:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.447351'}
2026-03-19 03:26:23,093 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-19 03:26:23,093 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-21797002 passed
2026-03-19 03:26:23,093 - DEBUG - ====Verifying policy data for ctest-left_vn-21797002 in API_Server ======
2026-03-19 03:26:23,093 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:26:23,100 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:26:23,112 - DEBUG - Requesting: http://10.0.0.41:8082/project/4cbda1fe-728a-41e6-a215-b7d1565728d9
2026-03-19 03:26:23,218 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/eb1df059-729b-4887-865c-69a7e7d897ac
2026-03-19 03:26:23,229 - DEBUG - =>VN ctest-left_vn-21797002 has no policy to be verified
2026-03-19 03:26:23,229 - DEBUG - Verifying the vn in opserver
2026-03-19 03:26:23,229 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-44202795:ctest-left_vn-21797002 virtual network link through opserver 10.0.0.41
2026-03-19 03:26:23,229 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-03-19 03:26:23,245 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-44202795:ctest-left_vn-21797002', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-44202795:ctest-left_vn-21797002?flat'}
2026-03-19 03:26:23,245 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-44202795:ctest-left_vn-21797002 virtual network link through opserver 10.0.0.242
2026-03-19 03:26:23,245 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-03-19 03:26:23,264 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-44202795:ctest-left_vn-21797002', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-44202795:ctest-left_vn-21797002?flat'}
2026-03-19 03:26:23,264 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-44202795:ctest-left_vn-21797002 virtual network link through opserver 10.0.0.27
2026-03-19 03:26:23,265 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-19 03:26:23,280 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-44202795:ctest-left_vn-21797002', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-44202795:ctest-left_vn-21797002?flat'}
2026-03-19 03:26:23,280 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-44202795:ctest-left_vn-21797002 is found in opserver
2026-03-19 03:26:23,305 - DEBUG - Do not have enough data to verify VN in agent
2026-03-19 03:26:23,317 - DEBUG - VRF ids for VN ctest-left_vn-21797002: {}
2026-03-19 03:26:23,598 - DEBUG - Response for create_network : {'network': {'id': 'bb180e82-0053-4e54-8ff2-7c4608f31b89', 'name': 'ctest-right_vn-43938858', 'tenant_id': '4cbda1fe728a41e6a215b7d1565728d9', 'project_id': '4cbda1fe728a41e6a215b7d1565728d9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-44202795', 'ctest-right_vn-43938858'], 'port_security_enabled': True, 'description': ''}}
2026-03-19 03:26:23,828 - DEBUG - Response for create_subnet : {'subnet': {'id': '95fc6b01-29a0-4c24-9577-a36425d08b35', 'name': '', 'tenant_id': '4cbda1fe728a41e6a215b7d1565728d9', 'network_id': 'bb180e82-0053-4e54-8ff2-7c4608f31b89', 'ip_version': 4, 'cidr': '99.86.219.64/26', 'allocation_pools': [{'start': '99.86.219.66', 'end': '99.86.219.126'}], 'gateway_ip': '99.86.219.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '99.86.219.66', 'tags': [], 'project_id': '4cbda1fe728a41e6a215b7d1565728d9'}}
2026-03-19 03:26:23,853 - INFO - Created VN ctest-right_vn-43938858
2026-03-19 03:26:23,868 - DEBUG - VN ctest-right_vn-43938858 UUID is bb180e82-0053-4e54-8ff2-7c4608f31b89
2026-03-19 03:26:23,942 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:26:23,948 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:26:23,960 - DEBUG - Requesting: http://10.0.0.41:8082/project/4cbda1fe-728a-41e6-a215-b7d1565728d9
2026-03-19 03:26:24,056 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/bb180e82-0053-4e54-8ff2-7c4608f31b89
2026-03-19 03:26:24,069 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/bb180e82-0053-4e54-8ff2-7c4608f31b89
2026-03-19 03:26:24,080 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/b4cf4f05-603a-4bfa-a238-a9b37f172f96
2026-03-19 03:26:24,091 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/b4cf4f05-603a-4bfa-a238-a9b37f172f96
2026-03-19 03:26:24,099 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/d1c36b2e-a4aa-4e70-8dc7-2accc4b1f663
2026-03-19 03:26:24,107 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-19 03:26:24,107 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/bb180e82-0053-4e54-8ff2-7c4608f31b89
2026-03-19 03:26:24,118 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/b4cf4f05-603a-4bfa-a238-a9b37f172f96
2026-03-19 03:26:24,136 - INFO - Verified VN network id 16 for VN bb180e82-0053-4e54-8ff2-7c4608f31b89
2026-03-19 03:26:24,136 - INFO - Verifications in API Server for VN ctest-right_vn-43938858 passed
2026-03-19 03:26:24,136 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/bb180e82-0053-4e54-8ff2-7c4608f31b89
2026-03-19 03:26:24,146 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/b4cf4f05-603a-4bfa-a238-a9b37f172f96
2026-03-19 03:26:24,156 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/b4cf4f05-603a-4bfa-a238-a9b37f172f96
2026-03-19 03:26:24,164 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/d1c36b2e-a4aa-4e70-8dc7-2accc4b1f663
2026-03-19 03:26:24,177 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-44202795:ctest-right_vn-43938858', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-44202795', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13481541436047576660', 'uuid-lslong': '10372489532027378569'}, 'enable': 'true', 'created': '2026-03-19T03:26:23', 'last-modified': '2026-03-19T03:26:23', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.410498'}
2026-03-19 03:26:24,183 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-19 03:26:24,189 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-44202795:ctest-right_vn-43938858', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-44202795', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13481541436047576660', 'uuid-lslong': '10372489532027378569'}, 'enable': 'true', 'created': '2026-03-19T03:26:23', 'last-modified': '2026-03-19T03:26:23', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.422871'}
2026-03-19 03:26:24,196 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-19 03:26:24,201 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-44202795:ctest-right_vn-43938858', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-44202795', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13481541436047576660', 'uuid-lslong': '10372489532027378569'}, 'enable': 'true', 'created': '2026-03-19T03:26:23', 'last-modified': '2026-03-19T03:26:23', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.437837'}
2026-03-19 03:26:24,207 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-19 03:26:24,207 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-43938858 passed
2026-03-19 03:26:24,207 - DEBUG - ====Verifying policy data for ctest-right_vn-43938858 in API_Server ======
2026-03-19 03:26:24,208 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:26:24,216 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:26:24,230 - DEBUG - Requesting: http://10.0.0.41:8082/project/4cbda1fe-728a-41e6-a215-b7d1565728d9
2026-03-19 03:26:24,328 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/bb180e82-0053-4e54-8ff2-7c4608f31b89
2026-03-19 03:26:24,342 - DEBUG - =>VN ctest-right_vn-43938858 has no policy to be verified
2026-03-19 03:26:24,342 - DEBUG - Verifying the vn in opserver
2026-03-19 03:26:24,342 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-44202795:ctest-right_vn-43938858 virtual network link through opserver 10.0.0.41
2026-03-19 03:26:24,342 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-03-19 03:26:24,359 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-44202795:ctest-right_vn-43938858', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-44202795:ctest-right_vn-43938858?flat'}
2026-03-19 03:26:24,359 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-44202795:ctest-right_vn-43938858 virtual network link through opserver 10.0.0.242
2026-03-19 03:26:24,360 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-03-19 03:26:24,375 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-44202795:ctest-right_vn-43938858', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-44202795:ctest-right_vn-43938858?flat'}
2026-03-19 03:26:24,375 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-44202795:ctest-right_vn-43938858 virtual network link through opserver 10.0.0.27
2026-03-19 03:26:24,375 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-19 03:26:24,387 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-44202795:ctest-right_vn-43938858', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-44202795:ctest-right_vn-43938858?flat'}
2026-03-19 03:26:24,388 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-44202795:ctest-right_vn-43938858 is found in opserver
2026-03-19 03:26:24,418 - DEBUG - Do not have enough data to verify VN in agent
2026-03-19 03:26:24,430 - DEBUG - VRF ids for VN ctest-right_vn-43938858: {}
2026-03-19 03:26:25,555 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5493-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5493-1)
2026-03-19 03:26:27,095 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5493-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5493-2)
2026-03-19 03:26:27,095 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-70757211']
2026-03-19 03:26:27,405 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-70757211'] created succesfully
2026-03-19 03:26:27,880 - DEBUG - Image by name tiny_nat_fw not found
2026-03-19 03:26:27,880 - DEBUG - Installing image tiny_nat_fw
2026-03-19 03:26:27,880 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-03-19 03:26:27,880 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-19 03:26:27,880 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-19 03:26:27,880 - DEBUG - Unzip image
2026-03-19 03:26:27,880 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-03-19 03:26:27,901 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-03-19 03:26:27,902 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-70757211']
2026-03-19 03:26:28,006 - INFO - Service template: ['default-domain', 'ctest-service_template_1-70757211'] deleted successfully.
2026-03-19 03:26:28,006 - INFO - Skip interface_detach for VM ctest-right_vm-73769030 in state BUILD
2026-03-19 03:26:28,006 - INFO - Deleting VM ctest-right_vm-73769030
2026-03-19 03:26:28,006 - ERROR - VM ctest-right_vm-73769030 has failed to come up
2026-03-19 03:26:28,006 - ERROR - Nova failed to get host of the VM
2026-03-19 03:26:28,007 - ERROR - VM ctest-right_vm-73769030 has failed to come up
2026-03-19 03:26:28,007 - ERROR - Nova failed to get host of the VM
2026-03-19 03:26:28,140 - INFO - Skip interface_detach for VM ctest-left_vm-14486750 in state BUILD
2026-03-19 03:26:28,140 - INFO - Deleting VM ctest-left_vm-14486750
2026-03-19 03:26:28,140 - ERROR - VM ctest-left_vm-14486750 has failed to come up
2026-03-19 03:26:28,140 - ERROR - Nova failed to get host of the VM
2026-03-19 03:26:28,140 - ERROR - VM ctest-left_vm-14486750 has failed to come up
2026-03-19 03:26:28,140 - ERROR - Nova failed to get host of the VM
2026-03-19 03:26:28,237 - INFO - Deleting VN ctest-right_vn-43938858
2026-03-19 03:26:28,332 - DEBUG - VN bb180e82-0053-4e54-8ff2-7c4608f31b89 still in use: Unable to complete operation on network bb180e82-0053-4e54-8ff2-7c4608f31b89. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-6facd435-14bf-4c9b-8574-69bb9220d61a']
2026-03-19 03:26:28,332 - WARNING - Deleting VN ctest-right_vn-43938858 failed..Will retry
2026-03-19 03:26:30,512 - DEBUG - Response for deleting network ()
2026-03-19 03:26:30,512 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/b4cf4f05-603a-4bfa-a238-a9b37f172f96
2026-03-19 03:26:30,519 - DEBUG - Response Code: 404
2026-03-19 03:26:30,519 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:26:30,527 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:26:30,567 - DEBUG - Requesting: http://10.0.0.41:8082/project/4cbda1fe-728a-41e6-a215-b7d1565728d9
2026-03-19 03:26:30,679 - INFO - Validated that VN ctest-right_vn-43938858 is not found in API Server
2026-03-19 03:26:30,690 - DEBUG - VN ctest-right_vn-43938858 is not present in Agent 10.0.0.23
2026-03-19 03:26:30,706 - DEBUG - VN ctest-right_vn-43938858 is not present in Agent 10.0.0.240
2026-03-19 03:26:30,706 - INFO - Validated that VN ctest-right_vn-43938858 is not in any agent
2026-03-19 03:26:30,739 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-43938858 info
2026-03-19 03:26:30,739 - INFO - Deleting VN ctest-left_vn-21797002
2026-03-19 03:26:30,898 - DEBUG - Response for deleting network ()
2026-03-19 03:26:30,899 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/52145253-375b-4b27-b15d-d3242949e2b3
2026-03-19 03:26:30,905 - DEBUG - Response Code: 404
2026-03-19 03:26:30,906 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:26:30,917 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:26:30,929 - DEBUG - Requesting: http://10.0.0.41:8082/project/4cbda1fe-728a-41e6-a215-b7d1565728d9
2026-03-19 03:26:31,026 - INFO - Validated that VN ctest-left_vn-21797002 is not found in API Server
2026-03-19 03:26:31,039 - DEBUG - VN ctest-left_vn-21797002 is not present in Agent 10.0.0.23
2026-03-19 03:26:31,050 - DEBUG - VN ctest-left_vn-21797002 is not present in Agent 10.0.0.240
2026-03-19 03:26:31,050 - INFO - Validated that VN ctest-left_vn-21797002 is not in any agent
2026-03-19 03:26:31,082 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-21797002 info
2026-03-19 03:26:31,082 - INFO - Deleting VN ctest-mgmt_vn-07426048
2026-03-19 03:26:31,228 - DEBUG - Response for deleting network ()
2026-03-19 03:26:31,228 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/a368cf32-4ba1-4127-89d2-25e35d10fa02
2026-03-19 03:26:31,234 - DEBUG - Response Code: 404
2026-03-19 03:26:31,234 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 03:26:31,240 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 03:26:31,300 - DEBUG - Requesting: http://10.0.0.41:8082/project/4cbda1fe-728a-41e6-a215-b7d1565728d9
2026-03-19 03:26:31,404 - INFO - Validated that VN ctest-mgmt_vn-07426048 is not found in API Server
2026-03-19 03:26:31,420 - DEBUG - VN ctest-mgmt_vn-07426048 is not present in Agent 10.0.0.23
2026-03-19 03:26:31,432 - DEBUG - VN ctest-mgmt_vn-07426048 is not present in Agent 10.0.0.240
2026-03-19 03:26:31,432 - INFO - Validated that VN ctest-mgmt_vn-07426048 is not in any agent
2026-03-19 03:26:31,467 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-07426048 info
2026-03-19 03:26:32,754 - DEBUG - No XMPP flaps were noticed during the test
2026-03-19 03:26:32,754 - INFO -
2026-03-19 03:26:32,754 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:13]
2026-03-19 03:26:32,754 - INFO - --------------------------------------------------------------------------------
2026-03-19 03:26:33,477 - INFO - Deleted project: ctest-TestSvcRegr-44202795, ID : 4cbda1fe-728a-41e6-a215-b7d1565728d9