]) created on node: (an-jenkins-deploy-platform-ansible-os-5589-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5589-2)
2026-04-03 17:48:52,092 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-51207587']
2026-04-03 17:48:52,386 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-51207587'] created succesfully
2026-04-03 17:48:52,823 - DEBUG - Image by name tiny_nat_fw not found
2026-04-03 17:48:52,823 - DEBUG - Installing image tiny_nat_fw
2026-04-03 17:48:52,824 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-04-03 17:48:52,824 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-04-03 17:48:52,824 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-04-03 17:48:52,841 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz -O /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-04-03 17:48:53,001 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-04-03 17:48:53,001 - DEBUG - Unzip image
2026-04-03 17:48:53,001 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-04-03 17:48:53,027 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-04-03 17:48:53,027 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-51207587']
2026-04-03 17:48:53,132 - INFO - Service template: ['default-domain', 'ctest-service_template_1-51207587'] deleted successfully.
2026-04-03 17:48:53,132 - INFO - Skip interface_detach for VM ctest-right_vm-87270326 in state BUILD
2026-04-03 17:48:53,132 - INFO - Deleting VM ctest-right_vm-87270326
2026-04-03 17:48:53,174 - ERROR - VM ctest-right_vm-87270326 has failed to come up
2026-04-03 17:48:53,174 - ERROR - Nova failed to get host of the VM
2026-04-03 17:48:53,174 - ERROR - VM ctest-right_vm-87270326 has failed to come up
2026-04-03 17:48:53,174 - ERROR - Nova failed to get host of the VM
2026-04-03 17:48:53,249 - INFO - Skip interface_detach for VM ctest-left_vm-61836866 in state BUILD
2026-04-03 17:48:53,249 - INFO - Deleting VM ctest-left_vm-61836866
2026-04-03 17:48:53,250 - ERROR - VM ctest-left_vm-61836866 has failed to come up
2026-04-03 17:48:53,250 - ERROR - Nova failed to get host of the VM
2026-04-03 17:48:53,250 - ERROR - VM ctest-left_vm-61836866 has failed to come up
2026-04-03 17:48:53,250 - ERROR - Nova failed to get host of the VM
2026-04-03 17:48:53,342 - INFO - Deleting VN ctest-right_vn-71227033
2026-04-03 17:48:53,379 - DEBUG - VN 8dcb7e6f-3900-4e5d-94d5-a5a1a7e7087b still in use: Unable to complete operation on network 8dcb7e6f-3900-4e5d-94d5-a5a1a7e7087b. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-2b271546-59be-4256-bd95-9f08ec065552']
2026-04-03 17:48:53,380 - WARNING - Deleting VN ctest-right_vn-71227033 failed..Will retry
2026-04-03 17:48:55,532 - DEBUG - Response for deleting network ()
2026-04-03 17:48:55,532 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/476d6742-bc48-46ec-8043-3bf4ad7cd5b8
2026-04-03 17:48:55,538 - DEBUG - Response Code: 404
2026-04-03 17:48:55,538 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:48:55,554 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:48:55,569 - DEBUG - Requesting: http://10.0.0.22:8082/project/a793e212-cdc4-424c-901c-711d9be0e9e7
2026-04-03 17:48:55,659 - INFO - Validated that VN ctest-right_vn-71227033 is not found in API Server
2026-04-03 17:48:55,684 - DEBUG - VN ctest-right_vn-71227033 is not present in Agent 10.0.0.19
2026-04-03 17:48:55,694 - DEBUG - VN ctest-right_vn-71227033 is not present in Agent 10.0.0.240
2026-04-03 17:48:55,694 - INFO - Validated that VN ctest-right_vn-71227033 is not in any agent
2026-04-03 17:48:55,724 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-71227033 info
2026-04-03 17:48:55,724 - INFO - Deleting VN ctest-left_vn-10557765
2026-04-03 17:48:55,867 - DEBUG - Response for deleting network ()
2026-04-03 17:48:55,868 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/a4329ac6-e87b-47e1-9f11-7da8c23f0835
2026-04-03 17:48:55,878 - DEBUG - Response Code: 404
2026-04-03 17:48:55,878 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:48:55,888 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:48:55,901 - DEBUG - Requesting: http://10.0.0.22:8082/project/a793e212-cdc4-424c-901c-711d9be0e9e7
2026-04-03 17:48:55,985 - INFO - Validated that VN ctest-left_vn-10557765 is not found in API Server
2026-04-03 17:48:55,996 - DEBUG - VN ctest-left_vn-10557765 is not present in Agent 10.0.0.19
2026-04-03 17:48:56,006 - DEBUG - VN ctest-left_vn-10557765 is not present in Agent 10.0.0.240
2026-04-03 17:48:56,006 - INFO - Validated that VN ctest-left_vn-10557765 is not in any agent
2026-04-03 17:48:56,039 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-10557765 info
2026-04-03 17:48:56,039 - INFO - Deleting VN ctest-mgmt_vn-12018501
2026-04-03 17:48:56,179 - DEBUG - Response for deleting network ()
2026-04-03 17:48:56,179 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/8dec1117-dabf-4e6f-ab6b-855d6d610b40
2026-04-03 17:48:56,185 - DEBUG - Response Code: 404
2026-04-03 17:48:56,186 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:48:56,201 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:48:56,229 - DEBUG - Requesting: http://10.0.0.22:8082/project/a793e212-cdc4-424c-901c-711d9be0e9e7
2026-04-03 17:48:56,322 - INFO - Validated that VN ctest-mgmt_vn-12018501 is not found in API Server
2026-04-03 17:48:56,336 - DEBUG - VN ctest-mgmt_vn-12018501 is not present in Agent 10.0.0.19
2026-04-03 17:48:56,347 - DEBUG - VN ctest-mgmt_vn-12018501 is not present in Agent 10.0.0.240
2026-04-03 17:48:56,347 - INFO - Validated that VN ctest-mgmt_vn-12018501 is not in any agent
2026-04-03 17:48:56,380 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-12018501 info
2026-04-03 17:48:56,380 - INFO - Deleting VM ctest-vm-in-third-vn-91986450
2026-04-03 17:48:56,459 - INFO - Deleting VN ctest-third-vn-06475487
2026-04-03 17:48:56,510 - DEBUG - VN f4d384cd-41ef-4f08-b4e8-9b52070e3340 still in use: Unable to complete operation on network f4d384cd-41ef-4f08-b4e8-9b52070e3340. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-3567f877-5c9f-416e-92e9-bbd01348b19f']
2026-04-03 17:48:56,510 - WARNING - Deleting VN ctest-third-vn-06475487 failed..Will retry
2026-04-03 17:48:58,658 - DEBUG - Response for deleting network ()
2026-04-03 17:48:59,953 - DEBUG - No XMPP flaps were noticed during the test
2026-04-03 17:48:59,953 - INFO -
2026-04-03 17:48:59,953 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:24]
2026-04-03 17:48:59,953 - INFO - --------------------------------------------------------------------------------
2026-04-03 17:48:59,956 - INFO - ================================================================================
2026-04-03 17:48:59,956 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2026-04-03 17:49:01,241 - DEBUG - Nothing to compare xmpp stats {'10.0.0.19': {'10.20.0.254': '0', '10.20.0.17': '0'}, '10.0.0.240': {'10.20.0.14': '0', '10.20.0.254': '0'}} with
2026-04-03 17:49:01,241 - INFO - Initial checks done. Running the testcase now
2026-04-03 17:49:01,241 - INFO -
2026-04-03 17:49:01,494 - DEBUG - Response for create_network : {'network': {'id': '1d58993f-683a-448e-9569-74b6a67251f6', 'name': 'ctest-mgmt_vn-78656351', 'tenant_id': 'a793e212cdc4424c901c711d9be0e9e7', 'project_id': 'a793e212cdc4424c901c711d9be0e9e7', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-72895007', 'ctest-mgmt_vn-78656351'], 'port_security_enabled': True, 'description': ''}}
2026-04-03 17:49:01,742 - DEBUG - Response for create_subnet : {'subnet': {'id': '6f306f17-1db8-4666-813e-802c04295b9b', 'name': '', 'tenant_id': 'a793e212cdc4424c901c711d9be0e9e7', 'network_id': '1d58993f-683a-448e-9569-74b6a67251f6', 'ip_version': 4, 'cidr': '185.122.99.0/26', 'allocation_pools': [{'start': '185.122.99.2', 'end': '185.122.99.62'}], 'gateway_ip': '185.122.99.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '185.122.99.2', 'tags': [], 'project_id': 'a793e212cdc4424c901c711d9be0e9e7'}}
2026-04-03 17:49:01,762 - INFO - Created VN ctest-mgmt_vn-78656351
2026-04-03 17:49:01,774 - DEBUG - VN ctest-mgmt_vn-78656351 UUID is 1d58993f-683a-448e-9569-74b6a67251f6
2026-04-03 17:49:01,844 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:01,849 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:01,861 - DEBUG - Requesting: http://10.0.0.22:8082/project/a793e212-cdc4-424c-901c-711d9be0e9e7
2026-04-03 17:49:01,961 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/1d58993f-683a-448e-9569-74b6a67251f6
2026-04-03 17:49:01,972 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/1d58993f-683a-448e-9569-74b6a67251f6
2026-04-03 17:49:01,987 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c47564da-8486-429c-afd2-f2f1d01c483f
2026-04-03 17:49:01,996 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c47564da-8486-429c-afd2-f2f1d01c483f
2026-04-03 17:49:02,006 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/1b6a74cd-40aa-4705-9cee-820745c366fa
2026-04-03 17:49:02,017 - DEBUG - Route Targets: ['target:64512:8000006']
2026-04-03 17:49:02,017 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/1d58993f-683a-448e-9569-74b6a67251f6
2026-04-03 17:49:02,032 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c47564da-8486-429c-afd2-f2f1d01c483f
2026-04-03 17:49:02,052 - INFO - Verified VN network id 14 for VN 1d58993f-683a-448e-9569-74b6a67251f6
2026-04-03 17:49:02,052 - INFO - Verifications in API Server for VN ctest-mgmt_vn-78656351 passed
2026-04-03 17:49:02,052 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/1d58993f-683a-448e-9569-74b6a67251f6
2026-04-03 17:49:02,063 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c47564da-8486-429c-afd2-f2f1d01c483f
2026-04-03 17:49:02,071 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c47564da-8486-429c-afd2-f2f1d01c483f
2026-04-03 17:49:02,079 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/1b6a74cd-40aa-4705-9cee-820745c366fa
2026-04-03 17:49:02,093 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72895007:ctest-mgmt_vn-78656351', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72895007', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2114608522661086350', 'uuid-lslong': '10766264712031261174'}, 'enable': 'true', 'created': '2026-04-03T17:49:01', 'last-modified': '2026-04-03T17:49:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.431002'}
2026-04-03 17:49:02,100 - DEBUG - Route Targets: ['target:64512:8000006']
2026-04-03 17:49:02,106 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72895007:ctest-mgmt_vn-78656351', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72895007', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2114608522661086350', 'uuid-lslong': '10766264712031261174'}, 'enable': 'true', 'created': '2026-04-03T17:49:01', 'last-modified': '2026-04-03T17:49:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.445812'}
2026-04-03 17:49:02,112 - DEBUG - Route Targets: ['target:64512:8000006']
2026-04-03 17:49:02,118 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72895007:ctest-mgmt_vn-78656351', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72895007', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2114608522661086350', 'uuid-lslong': '10766264712031261174'}, 'enable': 'true', 'created': '2026-04-03T17:49:01', 'last-modified': '2026-04-03T17:49:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.455013'}
2026-04-03 17:49:02,123 - DEBUG - Route Targets: ['target:64512:8000006']
2026-04-03 17:49:02,123 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-78656351 passed
2026-04-03 17:49:02,123 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-78656351 in API_Server ======
2026-04-03 17:49:02,124 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:02,129 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:02,141 - DEBUG - Requesting: http://10.0.0.22:8082/project/a793e212-cdc4-424c-901c-711d9be0e9e7
2026-04-03 17:49:02,237 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/1d58993f-683a-448e-9569-74b6a67251f6
2026-04-03 17:49:02,248 - DEBUG - =>VN ctest-mgmt_vn-78656351 has no policy to be verified
2026-04-03 17:49:02,248 - DEBUG - Verifying the vn in opserver
2026-04-03 17:49:02,249 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72895007:ctest-mgmt_vn-78656351 virtual network link through opserver 10.0.0.22
2026-04-03 17:49:02,249 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-04-03 17:49:02,263 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72895007:ctest-mgmt_vn-78656351', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72895007:ctest-mgmt_vn-78656351?flat'}
2026-04-03 17:49:02,263 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72895007:ctest-mgmt_vn-78656351 virtual network link through opserver 10.0.0.38
2026-04-03 17:49:02,263 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-03 17:49:02,275 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72895007:ctest-mgmt_vn-78656351', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72895007:ctest-mgmt_vn-78656351?flat'}
2026-04-03 17:49:02,275 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72895007:ctest-mgmt_vn-78656351 virtual network link through opserver 10.0.0.141
2026-04-03 17:49:02,275 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-04-03 17:49:02,289 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72895007:ctest-mgmt_vn-78656351', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72895007:ctest-mgmt_vn-78656351?flat'}
2026-04-03 17:49:02,289 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-72895007:ctest-mgmt_vn-78656351 is found in opserver
2026-04-03 17:49:02,309 - DEBUG - Do not have enough data to verify VN in agent
2026-04-03 17:49:02,323 - DEBUG - VRF ids for VN ctest-mgmt_vn-78656351: {}
2026-04-03 17:49:02,621 - DEBUG - Response for create_network : {'network': {'id': '14c7b713-c813-483c-b79c-da272bc2788f', 'name': 'ctest-left_vn-61215386', 'tenant_id': 'a793e212cdc4424c901c711d9be0e9e7', 'project_id': 'a793e212cdc4424c901c711d9be0e9e7', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-72895007', 'ctest-left_vn-61215386'], 'port_security_enabled': True, 'description': ''}}
2026-04-03 17:49:02,841 - DEBUG - Response for create_subnet : {'subnet': {'id': '76210d20-d355-489a-a8cd-59616ff8b695', 'name': '', 'tenant_id': 'a793e212cdc4424c901c711d9be0e9e7', 'network_id': '14c7b713-c813-483c-b79c-da272bc2788f', 'ip_version': 4, 'cidr': '201.101.185.192/26', 'allocation_pools': [{'start': '201.101.185.194', 'end': '201.101.185.254'}], 'gateway_ip': '201.101.185.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '201.101.185.194', 'tags': [], 'project_id': 'a793e212cdc4424c901c711d9be0e9e7'}}
2026-04-03 17:49:02,862 - INFO - Created VN ctest-left_vn-61215386
2026-04-03 17:49:02,876 - DEBUG - VN ctest-left_vn-61215386 UUID is 14c7b713-c813-483c-b79c-da272bc2788f
2026-04-03 17:49:02,941 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:02,951 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:02,962 - DEBUG - Requesting: http://10.0.0.22:8082/project/a793e212-cdc4-424c-901c-711d9be0e9e7
2026-04-03 17:49:03,065 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/14c7b713-c813-483c-b79c-da272bc2788f
2026-04-03 17:49:03,079 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/14c7b713-c813-483c-b79c-da272bc2788f
2026-04-03 17:49:03,087 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/308d27d8-d8f6-4037-ae25-d094cdad5981
2026-04-03 17:49:03,096 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/308d27d8-d8f6-4037-ae25-d094cdad5981
2026-04-03 17:49:03,103 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/3eff93f2-c01a-4a79-b6ae-d324fe881305
2026-04-03 17:49:03,109 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-03 17:49:03,109 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/14c7b713-c813-483c-b79c-da272bc2788f
2026-04-03 17:49:03,118 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/308d27d8-d8f6-4037-ae25-d094cdad5981
2026-04-03 17:49:03,133 - INFO - Verified VN network id 15 for VN 14c7b713-c813-483c-b79c-da272bc2788f
2026-04-03 17:49:03,133 - INFO - Verifications in API Server for VN ctest-left_vn-61215386 passed
2026-04-03 17:49:03,133 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/14c7b713-c813-483c-b79c-da272bc2788f
2026-04-03 17:49:03,142 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/308d27d8-d8f6-4037-ae25-d094cdad5981
2026-04-03 17:49:03,151 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/308d27d8-d8f6-4037-ae25-d094cdad5981
2026-04-03 17:49:03,159 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/3eff93f2-c01a-4a79-b6ae-d324fe881305
2026-04-03 17:49:03,174 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72895007:ctest-left_vn-61215386', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72895007', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1497366696712947772', 'uuid-lslong': '13230689667080419471'}, 'enable': 'true', 'created': '2026-04-03T17:49:02', 'last-modified': '2026-04-03T17:49:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.377730'}
2026-04-03 17:49:03,181 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-03 17:49:03,187 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72895007:ctest-left_vn-61215386', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72895007', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1497366696712947772', 'uuid-lslong': '13230689667080419471'}, 'enable': 'true', 'created': '2026-04-03T17:49:02', 'last-modified': '2026-04-03T17:49:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.393395'}
2026-04-03 17:49:03,193 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-03 17:49:03,201 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72895007:ctest-left_vn-61215386', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72895007', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1497366696712947772', 'uuid-lslong': '13230689667080419471'}, 'enable': 'true', 'created': '2026-04-03T17:49:02', 'last-modified': '2026-04-03T17:49:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.406449'}
2026-04-03 17:49:03,209 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-03 17:49:03,209 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-61215386 passed
2026-04-03 17:49:03,209 - DEBUG - ====Verifying policy data for ctest-left_vn-61215386 in API_Server ======
2026-04-03 17:49:03,209 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:03,217 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:03,228 - DEBUG - Requesting: http://10.0.0.22:8082/project/a793e212-cdc4-424c-901c-711d9be0e9e7
2026-04-03 17:49:03,326 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/14c7b713-c813-483c-b79c-da272bc2788f
2026-04-03 17:49:03,336 - DEBUG - =>VN ctest-left_vn-61215386 has no policy to be verified
2026-04-03 17:49:03,336 - DEBUG - Verifying the vn in opserver
2026-04-03 17:49:03,336 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72895007:ctest-left_vn-61215386 virtual network link through opserver 10.0.0.22
2026-04-03 17:49:03,336 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-04-03 17:49:03,348 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72895007:ctest-left_vn-61215386', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72895007:ctest-left_vn-61215386?flat'}
2026-04-03 17:49:03,348 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72895007:ctest-left_vn-61215386 virtual network link through opserver 10.0.0.38
2026-04-03 17:49:03,348 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-03 17:49:03,361 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72895007:ctest-left_vn-61215386', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72895007:ctest-left_vn-61215386?flat'}
2026-04-03 17:49:03,361 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72895007:ctest-left_vn-61215386 virtual network link through opserver 10.0.0.141
2026-04-03 17:49:03,361 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-04-03 17:49:03,374 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72895007:ctest-left_vn-61215386', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72895007:ctest-left_vn-61215386?flat'}
2026-04-03 17:49:03,374 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-72895007:ctest-left_vn-61215386 is found in opserver
2026-04-03 17:49:03,398 - DEBUG - Do not have enough data to verify VN in agent
2026-04-03 17:49:03,408 - DEBUG - VRF ids for VN ctest-left_vn-61215386: {}
2026-04-03 17:49:03,712 - DEBUG - Response for create_network : {'network': {'id': '2d23b7d2-90c7-40ef-92eb-57b8e230e498', 'name': 'ctest-right_vn-76200171', 'tenant_id': 'a793e212cdc4424c901c711d9be0e9e7', 'project_id': 'a793e212cdc4424c901c711d9be0e9e7', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-72895007', 'ctest-right_vn-76200171'], 'port_security_enabled': True, 'description': ''}}
2026-04-03 17:49:03,998 - DEBUG - Response for create_subnet : {'subnet': {'id': '21b80bd7-fa12-46f1-9bc6-891e00ef6aba', 'name': '', 'tenant_id': 'a793e212cdc4424c901c711d9be0e9e7', 'network_id': '2d23b7d2-90c7-40ef-92eb-57b8e230e498', 'ip_version': 4, 'cidr': '33.147.82.128/26', 'allocation_pools': [{'start': '33.147.82.130', 'end': '33.147.82.190'}], 'gateway_ip': '33.147.82.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '33.147.82.130', 'tags': [], 'project_id': 'a793e212cdc4424c901c711d9be0e9e7'}}
2026-04-03 17:49:04,019 - INFO - Created VN ctest-right_vn-76200171
2026-04-03 17:49:04,030 - DEBUG - VN ctest-right_vn-76200171 UUID is 2d23b7d2-90c7-40ef-92eb-57b8e230e498
2026-04-03 17:49:04,105 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:04,111 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:04,121 - DEBUG - Requesting: http://10.0.0.22:8082/project/a793e212-cdc4-424c-901c-711d9be0e9e7
2026-04-03 17:49:04,219 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/2d23b7d2-90c7-40ef-92eb-57b8e230e498
2026-04-03 17:49:04,234 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/2d23b7d2-90c7-40ef-92eb-57b8e230e498
2026-04-03 17:49:04,245 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c68f4902-ae52-4139-9370-a736575b2f60
2026-04-03 17:49:04,253 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c68f4902-ae52-4139-9370-a736575b2f60
2026-04-03 17:49:04,259 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/9ee83f5d-bea3-49c0-bb83-d4cb22da1840
2026-04-03 17:49:04,265 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-03 17:49:04,265 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/2d23b7d2-90c7-40ef-92eb-57b8e230e498
2026-04-03 17:49:04,274 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c68f4902-ae52-4139-9370-a736575b2f60
2026-04-03 17:49:04,289 - INFO - Verified VN network id 16 for VN 2d23b7d2-90c7-40ef-92eb-57b8e230e498
2026-04-03 17:49:04,289 - INFO - Verifications in API Server for VN ctest-right_vn-76200171 passed
2026-04-03 17:49:04,289 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/2d23b7d2-90c7-40ef-92eb-57b8e230e498
2026-04-03 17:49:04,298 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c68f4902-ae52-4139-9370-a736575b2f60
2026-04-03 17:49:04,306 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c68f4902-ae52-4139-9370-a736575b2f60
2026-04-03 17:49:04,314 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/9ee83f5d-bea3-49c0-bb83-d4cb22da1840
2026-04-03 17:49:04,326 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72895007:ctest-right_vn-76200171', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72895007', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3252645470891622639', 'uuid-lslong': '10586651800644936856'}, 'enable': 'true', 'created': '2026-04-03T17:49:03', 'last-modified': '2026-04-03T17:49:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.383902'}
2026-04-03 17:49:04,332 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-03 17:49:04,337 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72895007:ctest-right_vn-76200171', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72895007', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3252645470891622639', 'uuid-lslong': '10586651800644936856'}, 'enable': 'true', 'created': '2026-04-03T17:49:03', 'last-modified': '2026-04-03T17:49:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.410302'}
2026-04-03 17:49:04,342 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-03 17:49:04,347 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72895007:ctest-right_vn-76200171', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72895007', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3252645470891622639', 'uuid-lslong': '10586651800644936856'}, 'enable': 'true', 'created': '2026-04-03T17:49:03', 'last-modified': '2026-04-03T17:49:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.405672'}
2026-04-03 17:49:04,352 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-03 17:49:04,352 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-76200171 passed
2026-04-03 17:49:04,353 - DEBUG - ====Verifying policy data for ctest-right_vn-76200171 in API_Server ======
2026-04-03 17:49:04,353 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:04,358 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:04,368 - DEBUG - Requesting: http://10.0.0.22:8082/project/a793e212-cdc4-424c-901c-711d9be0e9e7
2026-04-03 17:49:04,457 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/2d23b7d2-90c7-40ef-92eb-57b8e230e498
2026-04-03 17:49:04,465 - DEBUG - =>VN ctest-right_vn-76200171 has no policy to be verified
2026-04-03 17:49:04,465 - DEBUG - Verifying the vn in opserver
2026-04-03 17:49:04,465 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72895007:ctest-right_vn-76200171 virtual network link through opserver 10.0.0.22
2026-04-03 17:49:04,465 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-04-03 17:49:04,477 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72895007:ctest-right_vn-76200171', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72895007:ctest-right_vn-76200171?flat'}
2026-04-03 17:49:04,477 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72895007:ctest-right_vn-76200171 virtual network link through opserver 10.0.0.38
2026-04-03 17:49:04,477 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-03 17:49:04,489 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72895007:ctest-right_vn-76200171', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72895007:ctest-right_vn-76200171?flat'}
2026-04-03 17:49:04,489 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72895007:ctest-right_vn-76200171 virtual network link through opserver 10.0.0.141
2026-04-03 17:49:04,489 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-04-03 17:49:04,502 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72895007:ctest-right_vn-76200171', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72895007:ctest-right_vn-76200171?flat'}
2026-04-03 17:49:04,502 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-72895007:ctest-right_vn-76200171 is found in opserver
2026-04-03 17:49:04,524 - DEBUG - Do not have enough data to verify VN in agent
2026-04-03 17:49:04,535 - DEBUG - VRF ids for VN ctest-right_vn-76200171: {}
2026-04-03 17:49:04,807 - DEBUG - Response for create_network : {'network': {'id': 'dd2e74c2-eb6c-469d-b405-71d9697347d3', 'name': 'ctest-trans_left_vn-22802461', 'tenant_id': 'a793e212cdc4424c901c711d9be0e9e7', 'project_id': 'a793e212cdc4424c901c711d9be0e9e7', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-72895007', 'ctest-trans_left_vn-22802461'], 'port_security_enabled': True, 'description': ''}}
2026-04-03 17:49:05,081 - DEBUG - Response for create_subnet : {'subnet': {'id': '49dda1b0-be1a-4e49-a831-c816758c0cf6', 'name': '', 'tenant_id': 'a793e212cdc4424c901c711d9be0e9e7', 'network_id': 'dd2e74c2-eb6c-469d-b405-71d9697347d3', 'ip_version': 4, 'cidr': '192.77.198.192/26', 'allocation_pools': [{'start': '192.77.198.194', 'end': '192.77.198.254'}], 'gateway_ip': '192.77.198.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '192.77.198.194', 'tags': [], 'project_id': 'a793e212cdc4424c901c711d9be0e9e7'}}
2026-04-03 17:49:05,101 - INFO - Created VN ctest-trans_left_vn-22802461
2026-04-03 17:49:05,112 - DEBUG - VN ctest-trans_left_vn-22802461 UUID is dd2e74c2-eb6c-469d-b405-71d9697347d3
2026-04-03 17:49:05,177 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:05,182 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:05,192 - DEBUG - Requesting: http://10.0.0.22:8082/project/a793e212-cdc4-424c-901c-711d9be0e9e7
2026-04-03 17:49:05,283 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/dd2e74c2-eb6c-469d-b405-71d9697347d3
2026-04-03 17:49:05,294 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/dd2e74c2-eb6c-469d-b405-71d9697347d3
2026-04-03 17:49:05,303 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/72035236-6d38-408b-b8c5-da96d4c0079b
2026-04-03 17:49:05,310 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/72035236-6d38-408b-b8c5-da96d4c0079b
2026-04-03 17:49:05,317 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/5e8c906e-a6bb-4e74-ac3e-e9f6dd1a5a82
2026-04-03 17:49:05,323 - DEBUG - Route Targets: ['target:64512:8000009']
2026-04-03 17:49:05,323 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/dd2e74c2-eb6c-469d-b405-71d9697347d3
2026-04-03 17:49:05,331 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/72035236-6d38-408b-b8c5-da96d4c0079b
2026-04-03 17:49:05,346 - INFO - Verified VN network id 17 for VN dd2e74c2-eb6c-469d-b405-71d9697347d3
2026-04-03 17:49:05,346 - INFO - Verifications in API Server for VN ctest-trans_left_vn-22802461 passed
2026-04-03 17:49:05,346 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/dd2e74c2-eb6c-469d-b405-71d9697347d3
2026-04-03 17:49:05,355 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/72035236-6d38-408b-b8c5-da96d4c0079b
2026-04-03 17:49:05,361 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/72035236-6d38-408b-b8c5-da96d4c0079b
2026-04-03 17:49:05,369 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/5e8c906e-a6bb-4e74-ac3e-e9f6dd1a5a82
2026-04-03 17:49:05,380 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72895007:ctest-trans_left_vn-22802461', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72895007', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15937804511832983197', 'uuid-lslong': '12971899480301586387'}, 'enable': 'true', 'created': '2026-04-03T17:49:04', 'last-modified': '2026-04-03T17:49:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.387967'}
2026-04-03 17:49:05,386 - DEBUG - Route Targets: ['target:64512:8000009']
2026-04-03 17:49:05,391 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72895007:ctest-trans_left_vn-22802461', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72895007', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15937804511832983197', 'uuid-lslong': '12971899480301586387'}, 'enable': 'true', 'created': '2026-04-03T17:49:04', 'last-modified': '2026-04-03T17:49:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.397753'}
2026-04-03 17:49:05,397 - DEBUG - Route Targets: ['target:64512:8000009']
2026-04-03 17:49:05,403 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72895007:ctest-trans_left_vn-22802461', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72895007', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15937804511832983197', 'uuid-lslong': '12971899480301586387'}, 'enable': 'true', 'created': '2026-04-03T17:49:04', 'last-modified': '2026-04-03T17:49:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.409904'}
2026-04-03 17:49:05,410 - DEBUG - Route Targets: ['target:64512:8000009']
2026-04-03 17:49:05,410 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-22802461 passed
2026-04-03 17:49:05,410 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-22802461 in API_Server ======
2026-04-03 17:49:05,410 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:05,416 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:05,426 - DEBUG - Requesting: http://10.0.0.22:8082/project/a793e212-cdc4-424c-901c-711d9be0e9e7
2026-04-03 17:49:05,523 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/dd2e74c2-eb6c-469d-b405-71d9697347d3
2026-04-03 17:49:05,534 - DEBUG - =>VN ctest-trans_left_vn-22802461 has no policy to be verified
2026-04-03 17:49:05,534 - DEBUG - Verifying the vn in opserver
2026-04-03 17:49:05,534 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72895007:ctest-trans_left_vn-22802461 virtual network link through opserver 10.0.0.22
2026-04-03 17:49:05,534 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-04-03 17:49:05,549 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72895007:ctest-trans_left_vn-22802461', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72895007:ctest-trans_left_vn-22802461?flat'}
2026-04-03 17:49:05,549 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72895007:ctest-trans_left_vn-22802461 virtual network link through opserver 10.0.0.38
2026-04-03 17:49:05,550 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-03 17:49:05,562 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72895007:ctest-trans_left_vn-22802461', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72895007:ctest-trans_left_vn-22802461?flat'}
2026-04-03 17:49:05,563 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72895007:ctest-trans_left_vn-22802461 virtual network link through opserver 10.0.0.141
2026-04-03 17:49:05,563 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-04-03 17:49:05,575 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72895007:ctest-trans_left_vn-22802461', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72895007:ctest-trans_left_vn-22802461?flat'}
2026-04-03 17:49:05,575 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-72895007:ctest-trans_left_vn-22802461 is found in opserver
2026-04-03 17:49:05,596 - DEBUG - Do not have enough data to verify VN in agent
2026-04-03 17:49:05,606 - DEBUG - VRF ids for VN ctest-trans_left_vn-22802461: {}
2026-04-03 17:49:05,887 - DEBUG - Response for create_network : {'network': {'id': '69e4091b-5319-4500-8305-e9b054289152', 'name': 'ctest-trans_right_vn-55927467', 'tenant_id': 'a793e212cdc4424c901c711d9be0e9e7', 'project_id': 'a793e212cdc4424c901c711d9be0e9e7', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-72895007', 'ctest-trans_right_vn-55927467'], 'port_security_enabled': True, 'description': ''}}
2026-04-03 17:49:06,120 - DEBUG - Response for create_subnet : {'subnet': {'id': '0dab92d8-ea93-44cd-8638-7dfcc135c519', 'name': '', 'tenant_id': 'a793e212cdc4424c901c711d9be0e9e7', 'network_id': '69e4091b-5319-4500-8305-e9b054289152', 'ip_version': 4, 'cidr': '174.196.178.64/26', 'allocation_pools': [{'start': '174.196.178.66', 'end': '174.196.178.126'}], 'gateway_ip': '174.196.178.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '174.196.178.66', 'tags': [], 'project_id': 'a793e212cdc4424c901c711d9be0e9e7'}}
2026-04-03 17:49:06,139 - INFO - Created VN ctest-trans_right_vn-55927467
2026-04-03 17:49:06,152 - DEBUG - VN ctest-trans_right_vn-55927467 UUID is 69e4091b-5319-4500-8305-e9b054289152
2026-04-03 17:49:06,218 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:06,224 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:06,234 - DEBUG - Requesting: http://10.0.0.22:8082/project/a793e212-cdc4-424c-901c-711d9be0e9e7
2026-04-03 17:49:06,339 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/69e4091b-5319-4500-8305-e9b054289152
2026-04-03 17:49:06,350 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/69e4091b-5319-4500-8305-e9b054289152
2026-04-03 17:49:06,358 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/2ff0761c-de95-482d-adeb-4acf3a974950
2026-04-03 17:49:06,365 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/2ff0761c-de95-482d-adeb-4acf3a974950
2026-04-03 17:49:06,372 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/c0481fa8-b58c-44a8-9718-7d67526070dc
2026-04-03 17:49:06,378 - DEBUG - Route Targets: ['target:64512:8000010']
2026-04-03 17:49:06,378 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/69e4091b-5319-4500-8305-e9b054289152
2026-04-03 17:49:06,386 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/2ff0761c-de95-482d-adeb-4acf3a974950
2026-04-03 17:49:06,403 - INFO - Verified VN network id 18 for VN 69e4091b-5319-4500-8305-e9b054289152
2026-04-03 17:49:06,403 - INFO - Verifications in API Server for VN ctest-trans_right_vn-55927467 passed
2026-04-03 17:49:06,403 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/69e4091b-5319-4500-8305-e9b054289152
2026-04-03 17:49:06,412 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/2ff0761c-de95-482d-adeb-4acf3a974950
2026-04-03 17:49:06,419 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/2ff0761c-de95-482d-adeb-4acf3a974950
2026-04-03 17:49:06,426 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/c0481fa8-b58c-44a8-9718-7d67526070dc
2026-04-03 17:49:06,438 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72895007:ctest-trans_right_vn-55927467', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72895007', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7630233681635394816', 'uuid-lslong': '9441209137387573586'}, 'enable': 'true', 'created': '2026-04-03T17:49:05', 'last-modified': '2026-04-03T17:49:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.367174'}
2026-04-03 17:49:06,443 - DEBUG - Route Targets: ['target:64512:8000010']
2026-04-03 17:49:06,448 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72895007:ctest-trans_right_vn-55927467', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72895007', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7630233681635394816', 'uuid-lslong': '9441209137387573586'}, 'enable': 'true', 'created': '2026-04-03T17:49:05', 'last-modified': '2026-04-03T17:49:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.372513'}
2026-04-03 17:49:06,453 - DEBUG - Route Targets: ['target:64512:8000010']
2026-04-03 17:49:06,458 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72895007:ctest-trans_right_vn-55927467', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72895007', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7630233681635394816', 'uuid-lslong': '9441209137387573586'}, 'enable': 'true', 'created': '2026-04-03T17:49:05', 'last-modified': '2026-04-03T17:49:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.387350'}
2026-04-03 17:49:06,464 - DEBUG - Route Targets: ['target:64512:8000010']
2026-04-03 17:49:06,464 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-55927467 passed
2026-04-03 17:49:06,464 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-55927467 in API_Server ======
2026-04-03 17:49:06,464 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:06,469 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:06,480 - DEBUG - Requesting: http://10.0.0.22:8082/project/a793e212-cdc4-424c-901c-711d9be0e9e7
2026-04-03 17:49:06,572 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/69e4091b-5319-4500-8305-e9b054289152
2026-04-03 17:49:06,584 - DEBUG - =>VN ctest-trans_right_vn-55927467 has no policy to be verified
2026-04-03 17:49:06,584 - DEBUG - Verifying the vn in opserver
2026-04-03 17:49:06,584 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72895007:ctest-trans_right_vn-55927467 virtual network link through opserver 10.0.0.22
2026-04-03 17:49:06,584 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-04-03 17:49:06,596 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72895007:ctest-trans_right_vn-55927467', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72895007:ctest-trans_right_vn-55927467?flat'}
2026-04-03 17:49:06,596 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72895007:ctest-trans_right_vn-55927467 virtual network link through opserver 10.0.0.38
2026-04-03 17:49:06,596 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-03 17:49:06,608 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72895007:ctest-trans_right_vn-55927467', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72895007:ctest-trans_right_vn-55927467?flat'}
2026-04-03 17:49:06,608 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72895007:ctest-trans_right_vn-55927467 virtual network link through opserver 10.0.0.141
2026-04-03 17:49:06,608 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-04-03 17:49:06,620 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72895007:ctest-trans_right_vn-55927467', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72895007:ctest-trans_right_vn-55927467?flat'}
2026-04-03 17:49:06,620 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-72895007:ctest-trans_right_vn-55927467 is found in opserver
2026-04-03 17:49:06,639 - DEBUG - Do not have enough data to verify VN in agent
2026-04-03 17:49:06,650 - DEBUG - VRF ids for VN ctest-trans_right_vn-55927467: {}
2026-04-03 17:49:07,821 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5589-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5589-2)
2026-04-03 17:49:09,267 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5589-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5589-1)
2026-04-03 17:49:09,267 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-03775811']
2026-04-03 17:49:09,583 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-03775811'] created succesfully
2026-04-03 17:49:10,129 - DEBUG - Image by name tiny_trans_fw not found
2026-04-03 17:49:10,130 - DEBUG - Installing image tiny_trans_fw
2026-04-03 17:49:10,130 - DEBUG - Image info {'name': 'tinycore-net-transparent-fw.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd'}
2026-04-03 17:49:10,130 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-04-03 17:49:10,130 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-04-03 17:49:10,149 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz -O /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-04-03 17:49:10,185 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-04-03 17:49:10,185 - DEBUG - Unzip image
2026-04-03 17:49:10,185 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-04-03 17:49:10,203 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-04-03 17:49:10,203 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-03775811']
2026-04-03 17:49:10,311 - INFO - Service template: ['default-domain', 'ctest-service_template_1-03775811'] deleted successfully.
2026-04-03 17:49:10,312 - INFO - Skip interface_detach for VM ctest-right_vm-37361928 in state BUILD
2026-04-03 17:49:10,312 - INFO - Deleting VM ctest-right_vm-37361928
2026-04-03 17:49:10,312 - ERROR - VM ctest-right_vm-37361928 has failed to come up
2026-04-03 17:49:10,312 - ERROR - Nova failed to get host of the VM
2026-04-03 17:49:10,312 - ERROR - VM ctest-right_vm-37361928 has failed to come up
2026-04-03 17:49:10,313 - ERROR - Nova failed to get host of the VM
2026-04-03 17:49:10,432 - INFO - Skip interface_detach for VM ctest-left_vm-47148417 in state BUILD
2026-04-03 17:49:10,432 - INFO - Deleting VM ctest-left_vm-47148417
2026-04-03 17:49:10,432 - ERROR - VM ctest-left_vm-47148417 has failed to come up
2026-04-03 17:49:10,432 - ERROR - Nova failed to get host of the VM
2026-04-03 17:49:10,432 - ERROR - VM ctest-left_vm-47148417 has failed to come up
2026-04-03 17:49:10,433 - ERROR - Nova failed to get host of the VM
2026-04-03 17:49:10,511 - INFO - Deleting VN ctest-trans_right_vn-55927467
2026-04-03 17:49:10,658 - DEBUG - Response for deleting network ()
2026-04-03 17:49:10,658 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/2ff0761c-de95-482d-adeb-4acf3a974950
2026-04-03 17:49:10,664 - DEBUG - Response Code: 404
2026-04-03 17:49:10,664 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:10,670 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:10,697 - DEBUG - Requesting: http://10.0.0.22:8082/project/a793e212-cdc4-424c-901c-711d9be0e9e7
2026-04-03 17:49:10,797 - INFO - Validated that VN ctest-trans_right_vn-55927467 is not found in API Server
2026-04-03 17:49:10,810 - DEBUG - VN ctest-trans_right_vn-55927467 is not present in Agent 10.0.0.19
2026-04-03 17:49:10,819 - DEBUG - VN ctest-trans_right_vn-55927467 is not present in Agent 10.0.0.240
2026-04-03 17:49:10,819 - INFO - Validated that VN ctest-trans_right_vn-55927467 is not in any agent
2026-04-03 17:49:10,858 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-55927467 info
2026-04-03 17:49:10,859 - INFO - Deleting VN ctest-trans_left_vn-22802461
2026-04-03 17:49:11,022 - DEBUG - Response for deleting network ()
2026-04-03 17:49:11,022 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/72035236-6d38-408b-b8c5-da96d4c0079b
2026-04-03 17:49:11,037 - DEBUG - Response Code: 404
2026-04-03 17:49:11,037 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:11,059 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:11,072 - DEBUG - Requesting: http://10.0.0.22:8082/project/a793e212-cdc4-424c-901c-711d9be0e9e7
2026-04-03 17:49:11,188 - INFO - Validated that VN ctest-trans_left_vn-22802461 is not found in API Server
2026-04-03 17:49:11,204 - DEBUG - VN ctest-trans_left_vn-22802461 is not present in Agent 10.0.0.19
2026-04-03 17:49:11,213 - DEBUG - VN ctest-trans_left_vn-22802461 is not present in Agent 10.0.0.240
2026-04-03 17:49:11,214 - INFO - Validated that VN ctest-trans_left_vn-22802461 is not in any agent
2026-04-03 17:49:11,244 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-22802461 info
2026-04-03 17:49:11,244 - INFO - Deleting VN ctest-right_vn-76200171
2026-04-03 17:49:11,301 - DEBUG - VN 2d23b7d2-90c7-40ef-92eb-57b8e230e498 still in use: Unable to complete operation on network 2d23b7d2-90c7-40ef-92eb-57b8e230e498. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-beeaf84a-9f08-453e-944a-f29512091072']
2026-04-03 17:49:11,301 - WARNING - Deleting VN ctest-right_vn-76200171 failed..Will retry
2026-04-03 17:49:13,456 - DEBUG - Response for deleting network ()
2026-04-03 17:49:13,456 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c68f4902-ae52-4139-9370-a736575b2f60
2026-04-03 17:49:13,461 - DEBUG - Response Code: 404
2026-04-03 17:49:13,461 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:13,468 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:13,495 - DEBUG - Requesting: http://10.0.0.22:8082/project/a793e212-cdc4-424c-901c-711d9be0e9e7
2026-04-03 17:49:13,587 - INFO - Validated that VN ctest-right_vn-76200171 is not found in API Server
2026-04-03 17:49:13,597 - DEBUG - VN ctest-right_vn-76200171 is not present in Agent 10.0.0.19
2026-04-03 17:49:13,605 - DEBUG - VN ctest-right_vn-76200171 is not present in Agent 10.0.0.240
2026-04-03 17:49:13,605 - INFO - Validated that VN ctest-right_vn-76200171 is not in any agent
2026-04-03 17:49:13,634 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-76200171 info
2026-04-03 17:49:13,634 - INFO - Deleting VN ctest-left_vn-61215386
2026-04-03 17:49:13,776 - DEBUG - Response for deleting network ()
2026-04-03 17:49:13,776 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/308d27d8-d8f6-4037-ae25-d094cdad5981
2026-04-03 17:49:13,783 - DEBUG - Response Code: 404
2026-04-03 17:49:13,783 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:13,788 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:13,841 - DEBUG - Requesting: http://10.0.0.22:8082/project/a793e212-cdc4-424c-901c-711d9be0e9e7
2026-04-03 17:49:13,921 - INFO - Validated that VN ctest-left_vn-61215386 is not found in API Server
2026-04-03 17:49:13,933 - DEBUG - VN ctest-left_vn-61215386 is not present in Agent 10.0.0.19
2026-04-03 17:49:13,942 - DEBUG - VN ctest-left_vn-61215386 is not present in Agent 10.0.0.240
2026-04-03 17:49:13,942 - INFO - Validated that VN ctest-left_vn-61215386 is not in any agent
2026-04-03 17:49:13,973 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-61215386 info
2026-04-03 17:49:13,974 - INFO - Deleting VN ctest-mgmt_vn-78656351
2026-04-03 17:49:14,125 - DEBUG - Response for deleting network ()
2026-04-03 17:49:14,125 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c47564da-8486-429c-afd2-f2f1d01c483f
2026-04-03 17:49:14,139 - DEBUG - Response Code: 404
2026-04-03 17:49:14,139 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:14,148 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:14,163 - DEBUG - Requesting: http://10.0.0.22:8082/project/a793e212-cdc4-424c-901c-711d9be0e9e7
2026-04-03 17:49:14,267 - INFO - Validated that VN ctest-mgmt_vn-78656351 is not found in API Server
2026-04-03 17:49:14,284 - DEBUG - VN ctest-mgmt_vn-78656351 is not present in Agent 10.0.0.19
2026-04-03 17:49:14,295 - DEBUG - VN ctest-mgmt_vn-78656351 is not present in Agent 10.0.0.240
2026-04-03 17:49:14,295 - INFO - Validated that VN ctest-mgmt_vn-78656351 is not in any agent
2026-04-03 17:49:14,337 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-78656351 info
2026-04-03 17:49:15,608 - DEBUG - No XMPP flaps were noticed during the test
2026-04-03 17:49:15,608 - INFO -
2026-04-03 17:49:15,608 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:16]
2026-04-03 17:49:15,608 - INFO - --------------------------------------------------------------------------------
2026-04-03 17:49:16,358 - INFO - Deleted project: ctest-TestSvcRegr-72895007, ID : a793e212-cdc4-424c-901c-711d9be0e9e7
2026-04-03 17:49:16,526 - INFO - Domain Default found not creating
2026-04-03 17:49:16,674 - INFO - Project ctest-TestSvcRegr-41831039 not found, creating it
2026-04-03 17:49:17,181 - INFO - Created Project:ctest-TestSvcRegr-41831039, ID : 39500b7a-79fa-42ff-9318-1f567b3b9078
2026-04-03 17:49:18,658 - INFO - ================================================================================
2026-04-03 17:49:18,659 - INFO - STARTING TEST : test_svc_CEM_22032
2026-04-03 17:49:19,921 - DEBUG - Nothing to compare xmpp stats {'10.0.0.19': {'10.20.0.254': '0', '10.20.0.17': '0'}, '10.0.0.240': {'10.20.0.14': '0', '10.20.0.254': '0'}} with
2026-04-03 17:49:19,921 - INFO - Initial checks done. Running the testcase now
2026-04-03 17:49:19,921 - INFO -
2026-04-03 17:49:20,635 - DEBUG - Response for create_network : {'network': {'id': 'c787cc73-f67d-4ce4-8aae-29978f0275ea', 'name': 'ctest-mgmt_vn-08772704', 'tenant_id': '39500b7a79fa42ff93181f567b3b9078', 'project_id': '39500b7a79fa42ff93181f567b3b9078', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-41831039', 'ctest-mgmt_vn-08772704'], 'port_security_enabled': True, 'description': ''}}
2026-04-03 17:49:21,003 - DEBUG - Response for create_subnet : {'subnet': {'id': '8706f6bf-ddbd-4b47-8406-ff7abe4128ab', 'name': '', 'tenant_id': '39500b7a79fa42ff93181f567b3b9078', 'network_id': 'c787cc73-f67d-4ce4-8aae-29978f0275ea', 'ip_version': 4, 'cidr': '107.49.254.128/26', 'allocation_pools': [{'start': '107.49.254.130', 'end': '107.49.254.190'}], 'gateway_ip': '107.49.254.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '107.49.254.130', 'tags': [], 'project_id': '39500b7a79fa42ff93181f567b3b9078'}}
2026-04-03 17:49:21,029 - INFO - Created VN ctest-mgmt_vn-08772704
2026-04-03 17:49:21,041 - DEBUG - VN ctest-mgmt_vn-08772704 UUID is c787cc73-f67d-4ce4-8aae-29978f0275ea
2026-04-03 17:49:21,114 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:21,408 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:21,438 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:21,480 - DEBUG - Requesting: http://10.0.0.22:8082/project/39500b7a-79fa-42ff-9318-1f567b3b9078
2026-04-03 17:49:21,571 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/c787cc73-f67d-4ce4-8aae-29978f0275ea
2026-04-03 17:49:21,585 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/c787cc73-f67d-4ce4-8aae-29978f0275ea
2026-04-03 17:49:21,599 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c52dff68-40e8-4d32-b968-9f2ea950563e
2026-04-03 17:49:21,608 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c52dff68-40e8-4d32-b968-9f2ea950563e
2026-04-03 17:49:21,618 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/31af9939-1d55-479f-b7ff-608287671a0d
2026-04-03 17:49:21,624 - DEBUG - Route Targets: ['target:64512:8000006']
2026-04-03 17:49:21,624 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/c787cc73-f67d-4ce4-8aae-29978f0275ea
2026-04-03 17:49:21,632 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c52dff68-40e8-4d32-b968-9f2ea950563e
2026-04-03 17:49:21,656 - INFO - Verified VN network id 14 for VN c787cc73-f67d-4ce4-8aae-29978f0275ea
2026-04-03 17:49:21,657 - INFO - Verifications in API Server for VN ctest-mgmt_vn-08772704 passed
2026-04-03 17:49:21,657 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/c787cc73-f67d-4ce4-8aae-29978f0275ea
2026-04-03 17:49:21,667 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c52dff68-40e8-4d32-b968-9f2ea950563e
2026-04-03 17:49:21,675 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c52dff68-40e8-4d32-b968-9f2ea950563e
2026-04-03 17:49:21,685 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/31af9939-1d55-479f-b7ff-608287671a0d
2026-04-03 17:49:21,698 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-08772704', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-41831039', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14377685133832309988', 'uuid-lslong': '9992970354097812970'}, 'enable': 'true', 'created': '2026-04-03T17:49:20', 'last-modified': '2026-04-03T17:49:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.768309'}
2026-04-03 17:49:21,704 - DEBUG - Route Targets: ['target:64512:8000006']
2026-04-03 17:49:21,709 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-08772704', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-41831039', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14377685133832309988', 'uuid-lslong': '9992970354097812970'}, 'enable': 'true', 'created': '2026-04-03T17:49:20', 'last-modified': '2026-04-03T17:49:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.779084'}
2026-04-03 17:49:21,716 - DEBUG - Route Targets: ['target:64512:8000006']
2026-04-03 17:49:21,721 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-08772704', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-41831039', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14377685133832309988', 'uuid-lslong': '9992970354097812970'}, 'enable': 'true', 'created': '2026-04-03T17:49:20', 'last-modified': '2026-04-03T17:49:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.790683'}
2026-04-03 17:49:21,728 - DEBUG - Route Targets: ['target:64512:8000006']
2026-04-03 17:49:21,728 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-08772704 passed
2026-04-03 17:49:21,729 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-08772704 in API_Server ======
2026-04-03 17:49:21,729 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:21,735 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:21,750 - DEBUG - Requesting: http://10.0.0.22:8082/project/39500b7a-79fa-42ff-9318-1f567b3b9078
2026-04-03 17:49:21,852 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/c787cc73-f67d-4ce4-8aae-29978f0275ea
2026-04-03 17:49:21,868 - DEBUG - =>VN ctest-mgmt_vn-08772704 has no policy to be verified
2026-04-03 17:49:21,868 - DEBUG - Verifying the vn in opserver
2026-04-03 17:49:21,868 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-08772704 virtual network link through opserver 10.0.0.22
2026-04-03 17:49:21,868 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-04-03 17:49:22,181 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-04-03 17:49:22,250 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-08772704', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-08772704?flat'}
2026-04-03 17:49:22,250 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-08772704 virtual network link through opserver 10.0.0.38
2026-04-03 17:49:22,250 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-03 17:49:22,556 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-03 17:49:22,622 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-08772704', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-08772704?flat'}
2026-04-03 17:49:22,622 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-08772704 virtual network link through opserver 10.0.0.141
2026-04-03 17:49:22,622 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-04-03 17:49:22,917 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-04-03 17:49:22,984 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-08772704', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-08772704?flat'}
2026-04-03 17:49:22,984 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-08772704 is found in opserver
2026-04-03 17:49:23,008 - DEBUG - Do not have enough data to verify VN in agent
2026-04-03 17:49:23,020 - DEBUG - VRF ids for VN ctest-mgmt_vn-08772704: {}
2026-04-03 17:49:23,311 - DEBUG - Response for create_network : {'network': {'id': '35bc4970-c02c-44ee-97b1-06b8768a0430', 'name': 'service-left-vn-38949380', 'tenant_id': '39500b7a79fa42ff93181f567b3b9078', 'project_id': '39500b7a79fa42ff93181f567b3b9078', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-41831039', 'service-left-vn-38949380'], 'port_security_enabled': True, 'description': ''}}
2026-04-03 17:49:23,518 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd79c7247-091c-4658-b53d-be65a03b9dd3', 'name': '', 'tenant_id': '39500b7a79fa42ff93181f567b3b9078', 'network_id': '35bc4970-c02c-44ee-97b1-06b8768a0430', 'ip_version': 4, 'cidr': '161.60.123.192/26', 'allocation_pools': [{'start': '161.60.123.194', 'end': '161.60.123.254'}], 'gateway_ip': '161.60.123.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '161.60.123.194', 'tags': [], 'project_id': '39500b7a79fa42ff93181f567b3b9078'}}
2026-04-03 17:49:23,542 - INFO - Created VN service-left-vn-38949380
2026-04-03 17:49:23,560 - DEBUG - VN service-left-vn-38949380 UUID is 35bc4970-c02c-44ee-97b1-06b8768a0430
2026-04-03 17:49:23,637 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:23,644 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:23,654 - DEBUG - Requesting: http://10.0.0.22:8082/project/39500b7a-79fa-42ff-9318-1f567b3b9078
2026-04-03 17:49:23,741 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/35bc4970-c02c-44ee-97b1-06b8768a0430
2026-04-03 17:49:23,755 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/35bc4970-c02c-44ee-97b1-06b8768a0430
2026-04-03 17:49:23,764 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/fbd3cc86-32b8-476a-9ce0-26f60a443e9a
2026-04-03 17:49:23,771 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/fbd3cc86-32b8-476a-9ce0-26f60a443e9a
2026-04-03 17:49:23,777 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/0e49594b-cc36-40d7-aac4-b18786702fdf
2026-04-03 17:49:23,785 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-03 17:49:23,785 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/35bc4970-c02c-44ee-97b1-06b8768a0430
2026-04-03 17:49:23,794 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/fbd3cc86-32b8-476a-9ce0-26f60a443e9a
2026-04-03 17:49:23,814 - INFO - Verified VN network id 15 for VN 35bc4970-c02c-44ee-97b1-06b8768a0430
2026-04-03 17:49:23,814 - INFO - Verifications in API Server for VN service-left-vn-38949380 passed
2026-04-03 17:49:23,814 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/35bc4970-c02c-44ee-97b1-06b8768a0430
2026-04-03 17:49:23,826 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/fbd3cc86-32b8-476a-9ce0-26f60a443e9a
2026-04-03 17:49:23,833 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/fbd3cc86-32b8-476a-9ce0-26f60a443e9a
2026-04-03 17:49:23,843 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/0e49594b-cc36-40d7-aac4-b18786702fdf
2026-04-03 17:49:23,858 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-41831039:service-left-vn-38949380', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-41831039', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3872050528241075438', 'uuid-lslong': '10930525159937410096'}, 'enable': 'true', 'created': '2026-04-03T17:49:23', 'last-modified': '2026-04-03T17:49:23', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.393957'}
2026-04-03 17:49:23,863 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-03 17:49:23,868 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-41831039:service-left-vn-38949380', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-41831039', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3872050528241075438', 'uuid-lslong': '10930525159937410096'}, 'enable': 'true', 'created': '2026-04-03T17:49:23', 'last-modified': '2026-04-03T17:49:23', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.402852'}
2026-04-03 17:49:23,877 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-03 17:49:23,885 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-41831039:service-left-vn-38949380', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-41831039', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3872050528241075438', 'uuid-lslong': '10930525159937410096'}, 'enable': 'true', 'created': '2026-04-03T17:49:23', 'last-modified': '2026-04-03T17:49:23', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.418613'}
2026-04-03 17:49:23,893 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-03 17:49:23,893 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-38949380 passed
2026-04-03 17:49:23,893 - DEBUG - ====Verifying policy data for service-left-vn-38949380 in API_Server ======
2026-04-03 17:49:23,893 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:23,898 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:23,910 - DEBUG - Requesting: http://10.0.0.22:8082/project/39500b7a-79fa-42ff-9318-1f567b3b9078
2026-04-03 17:49:24,008 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/35bc4970-c02c-44ee-97b1-06b8768a0430
2026-04-03 17:49:24,019 - DEBUG - =>VN service-left-vn-38949380 has no policy to be verified
2026-04-03 17:49:24,019 - DEBUG - Verifying the vn in opserver
2026-04-03 17:49:24,019 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-41831039:service-left-vn-38949380 virtual network link through opserver 10.0.0.22
2026-04-03 17:49:24,019 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-04-03 17:49:24,100 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-41831039:service-left-vn-38949380', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-41831039:service-left-vn-38949380?flat'}
2026-04-03 17:49:24,100 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-41831039:service-left-vn-38949380 virtual network link through opserver 10.0.0.38
2026-04-03 17:49:24,100 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-03 17:49:24,175 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-41831039:service-left-vn-38949380', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-41831039:service-left-vn-38949380?flat'}
2026-04-03 17:49:24,175 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-41831039:service-left-vn-38949380 virtual network link through opserver 10.0.0.141
2026-04-03 17:49:24,175 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-04-03 17:49:24,249 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-41831039:service-left-vn-38949380', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-41831039:service-left-vn-38949380?flat'}
2026-04-03 17:49:24,249 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-41831039:service-left-vn-38949380 is found in opserver
2026-04-03 17:49:24,274 - DEBUG - Do not have enough data to verify VN in agent
2026-04-03 17:49:24,285 - DEBUG - VRF ids for VN service-left-vn-38949380: {}
2026-04-03 17:49:24,589 - DEBUG - Response for create_network : {'network': {'id': '70b17778-6ffd-4ce6-bffe-d358c7c3010d', 'name': 'service-right-vn-78922045', 'tenant_id': '39500b7a79fa42ff93181f567b3b9078', 'project_id': '39500b7a79fa42ff93181f567b3b9078', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-41831039', 'service-right-vn-78922045'], 'port_security_enabled': True, 'description': ''}}
2026-04-03 17:49:24,862 - DEBUG - Response for create_subnet : {'subnet': {'id': '98eb39ed-94c5-435c-840f-0e82ba0e07fd', 'name': '', 'tenant_id': '39500b7a79fa42ff93181f567b3b9078', 'network_id': '70b17778-6ffd-4ce6-bffe-d358c7c3010d', 'ip_version': 4, 'cidr': '169.244.119.0/26', 'allocation_pools': [{'start': '169.244.119.2', 'end': '169.244.119.62'}], 'gateway_ip': '169.244.119.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '169.244.119.2', 'tags': [], 'project_id': '39500b7a79fa42ff93181f567b3b9078'}}
2026-04-03 17:49:24,882 - INFO - Created VN service-right-vn-78922045
2026-04-03 17:49:24,893 - DEBUG - VN service-right-vn-78922045 UUID is 70b17778-6ffd-4ce6-bffe-d358c7c3010d
2026-04-03 17:49:24,971 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:24,981 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:24,992 - DEBUG - Requesting: http://10.0.0.22:8082/project/39500b7a-79fa-42ff-9318-1f567b3b9078
2026-04-03 17:49:25,081 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/70b17778-6ffd-4ce6-bffe-d358c7c3010d
2026-04-03 17:49:25,093 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/70b17778-6ffd-4ce6-bffe-d358c7c3010d
2026-04-03 17:49:25,102 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c452b2dd-7f84-4483-9737-9342a33f8a54
2026-04-03 17:49:25,110 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c452b2dd-7f84-4483-9737-9342a33f8a54
2026-04-03 17:49:25,118 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/0eb8d8ac-0472-4a5a-8018-68a5f35df6f3
2026-04-03 17:49:25,127 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-03 17:49:25,127 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/70b17778-6ffd-4ce6-bffe-d358c7c3010d
2026-04-03 17:49:25,137 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c452b2dd-7f84-4483-9737-9342a33f8a54
2026-04-03 17:49:25,154 - INFO - Verified VN network id 16 for VN 70b17778-6ffd-4ce6-bffe-d358c7c3010d
2026-04-03 17:49:25,155 - INFO - Verifications in API Server for VN service-right-vn-78922045 passed
2026-04-03 17:49:25,155 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/70b17778-6ffd-4ce6-bffe-d358c7c3010d
2026-04-03 17:49:25,169 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c452b2dd-7f84-4483-9737-9342a33f8a54
2026-04-03 17:49:25,178 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c452b2dd-7f84-4483-9737-9342a33f8a54
2026-04-03 17:49:25,184 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/0eb8d8ac-0472-4a5a-8018-68a5f35df6f3
2026-04-03 17:49:25,198 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-41831039:service-right-vn-78922045', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-41831039', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8120402962284367078', 'uuid-lslong': '13834727483590770957'}, 'enable': 'true', 'created': '2026-04-03T17:49:24', 'last-modified': '2026-04-03T17:49:24', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.407839'}
2026-04-03 17:49:25,203 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-03 17:49:25,209 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-41831039:service-right-vn-78922045', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-41831039', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8120402962284367078', 'uuid-lslong': '13834727483590770957'}, 'enable': 'true', 'created': '2026-04-03T17:49:24', 'last-modified': '2026-04-03T17:49:24', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.416525'}
2026-04-03 17:49:25,215 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-03 17:49:25,221 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-41831039:service-right-vn-78922045', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-41831039', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8120402962284367078', 'uuid-lslong': '13834727483590770957'}, 'enable': 'true', 'created': '2026-04-03T17:49:24', 'last-modified': '2026-04-03T17:49:24', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.431182'}
2026-04-03 17:49:25,227 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-03 17:49:25,227 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-78922045 passed
2026-04-03 17:49:25,227 - DEBUG - ====Verifying policy data for service-right-vn-78922045 in API_Server ======
2026-04-03 17:49:25,227 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:25,233 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:25,244 - DEBUG - Requesting: http://10.0.0.22:8082/project/39500b7a-79fa-42ff-9318-1f567b3b9078
2026-04-03 17:49:25,344 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/70b17778-6ffd-4ce6-bffe-d358c7c3010d
2026-04-03 17:49:25,355 - DEBUG - =>VN service-right-vn-78922045 has no policy to be verified
2026-04-03 17:49:25,356 - DEBUG - Verifying the vn in opserver
2026-04-03 17:49:25,356 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-41831039:service-right-vn-78922045 virtual network link through opserver 10.0.0.22
2026-04-03 17:49:25,356 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-04-03 17:49:25,435 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-41831039:service-right-vn-78922045', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-41831039:service-right-vn-78922045?flat'}
2026-04-03 17:49:25,436 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-41831039:service-right-vn-78922045 virtual network link through opserver 10.0.0.38
2026-04-03 17:49:25,436 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-03 17:49:25,505 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-41831039:service-right-vn-78922045', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-41831039:service-right-vn-78922045?flat'}
2026-04-03 17:49:25,505 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-41831039:service-right-vn-78922045 virtual network link through opserver 10.0.0.141
2026-04-03 17:49:25,505 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-04-03 17:49:25,565 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-41831039:service-right-vn-78922045', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-41831039:service-right-vn-78922045?flat'}
2026-04-03 17:49:25,565 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-41831039:service-right-vn-78922045 is found in opserver
2026-04-03 17:49:25,587 - DEBUG - Do not have enough data to verify VN in agent
2026-04-03 17:49:25,597 - DEBUG - VRF ids for VN service-right-vn-78922045: {}
2026-04-03 17:49:25,738 - DEBUG - Services list from nova: [, , , ]
2026-04-03 17:49:26,880 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5589-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5589-2)
2026-04-03 17:49:28,502 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5589-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5589-1)
2026-04-03 17:49:28,502 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-20589029']
2026-04-03 17:49:28,829 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-20589029'] created succesfully
2026-04-03 17:49:29,212 - DEBUG - Image by name tiny_nat_fw not found
2026-04-03 17:49:29,212 - DEBUG - Installing image tiny_nat_fw
2026-04-03 17:49:29,212 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-04-03 17:49:29,212 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-04-03 17:49:29,213 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-04-03 17:49:29,213 - DEBUG - Unzip image
2026-04-03 17:49:29,213 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-04-03 17:49:29,232 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-04-03 17:49:29,232 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-20589029']
2026-04-03 17:49:29,371 - INFO - Service template: ['default-domain', 'ctest-service_template_1-20589029'] deleted successfully.
2026-04-03 17:49:29,372 - INFO - Skip interface_detach for VM ctest-right_vm-05914301 in state BUILD
2026-04-03 17:49:29,372 - INFO - Deleting VM ctest-right_vm-05914301
2026-04-03 17:49:29,398 - ERROR - VM ctest-right_vm-05914301 has failed to come up
2026-04-03 17:49:29,398 - ERROR - Nova failed to get host of the VM
2026-04-03 17:49:29,398 - ERROR - VM ctest-right_vm-05914301 has failed to come up
2026-04-03 17:49:29,398 - ERROR - Nova failed to get host of the VM
2026-04-03 17:49:29,471 - INFO - Skip interface_detach for VM ctest-left_vm-85821928 in state BUILD
2026-04-03 17:49:29,471 - INFO - Deleting VM ctest-left_vm-85821928
2026-04-03 17:49:29,471 - ERROR - VM ctest-left_vm-85821928 has failed to come up
2026-04-03 17:49:29,471 - ERROR - Nova failed to get host of the VM
2026-04-03 17:49:29,471 - ERROR - VM ctest-left_vm-85821928 has failed to come up
2026-04-03 17:49:29,471 - ERROR - Nova failed to get host of the VM
2026-04-03 17:49:29,541 - INFO - Deleting VN service-right-vn-78922045
2026-04-03 17:49:29,585 - DEBUG - VN 70b17778-6ffd-4ce6-bffe-d358c7c3010d still in use: Unable to complete operation on network 70b17778-6ffd-4ce6-bffe-d358c7c3010d. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-86a4c1d1-6025-43f5-a350-491383a5d527']
2026-04-03 17:49:29,585 - WARNING - Deleting VN service-right-vn-78922045 failed..Will retry
2026-04-03 17:49:31,732 - DEBUG - Response for deleting network ()
2026-04-03 17:49:31,733 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c452b2dd-7f84-4483-9737-9342a33f8a54
2026-04-03 17:49:31,739 - DEBUG - Response Code: 404
2026-04-03 17:49:31,739 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:31,750 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:31,807 - DEBUG - Requesting: http://10.0.0.22:8082/project/39500b7a-79fa-42ff-9318-1f567b3b9078
2026-04-03 17:49:31,913 - INFO - Validated that VN service-right-vn-78922045 is not found in API Server
2026-04-03 17:49:31,930 - DEBUG - VN service-right-vn-78922045 is not present in Agent 10.0.0.19
2026-04-03 17:49:31,941 - DEBUG - VN service-right-vn-78922045 is not present in Agent 10.0.0.240
2026-04-03 17:49:31,941 - INFO - Validated that VN service-right-vn-78922045 is not in any agent
2026-04-03 17:49:31,970 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-78922045 info
2026-04-03 17:49:31,970 - INFO - Deleting VN service-left-vn-38949380
2026-04-03 17:49:32,111 - DEBUG - Response for deleting network ()
2026-04-03 17:49:32,111 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/fbd3cc86-32b8-476a-9ce0-26f60a443e9a
2026-04-03 17:49:32,116 - DEBUG - Response Code: 404
2026-04-03 17:49:32,116 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:32,133 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:32,185 - DEBUG - Requesting: http://10.0.0.22:8082/project/39500b7a-79fa-42ff-9318-1f567b3b9078
2026-04-03 17:49:32,264 - INFO - Validated that VN service-left-vn-38949380 is not found in API Server
2026-04-03 17:49:32,276 - DEBUG - VN service-left-vn-38949380 is not present in Agent 10.0.0.19
2026-04-03 17:49:32,287 - DEBUG - VN service-left-vn-38949380 is not present in Agent 10.0.0.240
2026-04-03 17:49:32,287 - INFO - Validated that VN service-left-vn-38949380 is not in any agent
2026-04-03 17:49:32,322 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-38949380 info
2026-04-03 17:49:32,322 - INFO - Deleting VN ctest-mgmt_vn-08772704
2026-04-03 17:49:32,454 - DEBUG - Response for deleting network ()
2026-04-03 17:49:32,454 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/c52dff68-40e8-4d32-b968-9f2ea950563e
2026-04-03 17:49:32,459 - DEBUG - Response Code: 404
2026-04-03 17:49:32,459 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:32,464 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:32,475 - DEBUG - Requesting: http://10.0.0.22:8082/project/39500b7a-79fa-42ff-9318-1f567b3b9078
2026-04-03 17:49:32,567 - INFO - Validated that VN ctest-mgmt_vn-08772704 is not found in API Server
2026-04-03 17:49:32,578 - DEBUG - VN ctest-mgmt_vn-08772704 is not present in Agent 10.0.0.19
2026-04-03 17:49:32,589 - DEBUG - VN ctest-mgmt_vn-08772704 is not present in Agent 10.0.0.240
2026-04-03 17:49:32,589 - INFO - Validated that VN ctest-mgmt_vn-08772704 is not in any agent
2026-04-03 17:49:32,617 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-08772704 info
2026-04-03 17:49:33,877 - DEBUG - No XMPP flaps were noticed during the test
2026-04-03 17:49:33,877 - INFO -
2026-04-03 17:49:33,877 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:15]
2026-04-03 17:49:33,877 - INFO - --------------------------------------------------------------------------------
2026-04-03 17:49:33,879 - INFO - ================================================================================
2026-04-03 17:49:33,879 - INFO - STARTING TEST : test_svc_in_network_datapath
2026-04-03 17:49:35,157 - DEBUG - Nothing to compare xmpp stats {'10.0.0.19': {'10.20.0.254': '0', '10.20.0.17': '0'}, '10.0.0.240': {'10.20.0.14': '0', '10.20.0.254': '0'}} with
2026-04-03 17:49:35,157 - INFO - Initial checks done. Running the testcase now
2026-04-03 17:49:35,157 - INFO -
2026-04-03 17:49:35,397 - DEBUG - Response for create_network : {'network': {'id': 'd4eddbb4-81c8-4ca1-8f6e-da17a52f5b7a', 'name': 'ctest-mgmt_vn-25511224', 'tenant_id': '39500b7a79fa42ff93181f567b3b9078', 'project_id': '39500b7a79fa42ff93181f567b3b9078', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-41831039', 'ctest-mgmt_vn-25511224'], 'port_security_enabled': True, 'description': ''}}
2026-04-03 17:49:35,670 - DEBUG - Response for create_subnet : {'subnet': {'id': '91c3588c-2a1e-4070-b704-4ffed60bdea7', 'name': '', 'tenant_id': '39500b7a79fa42ff93181f567b3b9078', 'network_id': 'd4eddbb4-81c8-4ca1-8f6e-da17a52f5b7a', 'ip_version': 4, 'cidr': '176.160.213.64/26', 'allocation_pools': [{'start': '176.160.213.66', 'end': '176.160.213.126'}], 'gateway_ip': '176.160.213.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '176.160.213.66', 'tags': [], 'project_id': '39500b7a79fa42ff93181f567b3b9078'}}
2026-04-03 17:49:35,691 - INFO - Created VN ctest-mgmt_vn-25511224
2026-04-03 17:49:35,703 - DEBUG - VN ctest-mgmt_vn-25511224 UUID is d4eddbb4-81c8-4ca1-8f6e-da17a52f5b7a
2026-04-03 17:49:35,769 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:35,775 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:35,784 - DEBUG - Requesting: http://10.0.0.22:8082/project/39500b7a-79fa-42ff-9318-1f567b3b9078
2026-04-03 17:49:35,874 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/d4eddbb4-81c8-4ca1-8f6e-da17a52f5b7a
2026-04-03 17:49:35,886 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/d4eddbb4-81c8-4ca1-8f6e-da17a52f5b7a
2026-04-03 17:49:35,897 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/441b87dd-59dc-44ca-9bd7-048b08e85df9
2026-04-03 17:49:35,918 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/441b87dd-59dc-44ca-9bd7-048b08e85df9
2026-04-03 17:49:35,924 - DEBUG - Route Targets: []
2026-04-03 17:49:35,924 - DEBUG - RT names not yet present for VN ctest-mgmt_vn-25511224
2026-04-03 17:49:40,925 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:40,931 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:40,942 - DEBUG - Requesting: http://10.0.0.22:8082/project/39500b7a-79fa-42ff-9318-1f567b3b9078
2026-04-03 17:49:41,029 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/d4eddbb4-81c8-4ca1-8f6e-da17a52f5b7a
2026-04-03 17:49:41,037 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/d4eddbb4-81c8-4ca1-8f6e-da17a52f5b7a
2026-04-03 17:49:41,046 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/441b87dd-59dc-44ca-9bd7-048b08e85df9
2026-04-03 17:49:41,058 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/441b87dd-59dc-44ca-9bd7-048b08e85df9
2026-04-03 17:49:41,066 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/79ffa000-329d-4ece-8cf9-525de88fbc41
2026-04-03 17:49:41,073 - DEBUG - Route Targets: ['target:64512:8000006']
2026-04-03 17:49:41,073 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/d4eddbb4-81c8-4ca1-8f6e-da17a52f5b7a
2026-04-03 17:49:41,085 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/441b87dd-59dc-44ca-9bd7-048b08e85df9
2026-04-03 17:49:41,102 - INFO - Verified VN network id 14 for VN d4eddbb4-81c8-4ca1-8f6e-da17a52f5b7a
2026-04-03 17:49:41,102 - INFO - Verifications in API Server for VN ctest-mgmt_vn-25511224 passed
2026-04-03 17:49:41,102 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/d4eddbb4-81c8-4ca1-8f6e-da17a52f5b7a
2026-04-03 17:49:41,110 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/441b87dd-59dc-44ca-9bd7-048b08e85df9
2026-04-03 17:49:41,118 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/441b87dd-59dc-44ca-9bd7-048b08e85df9
2026-04-03 17:49:41,125 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/79ffa000-329d-4ece-8cf9-525de88fbc41
2026-04-03 17:49:41,138 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-25511224', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-41831039', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15343161073839131809', 'uuid-lslong': '10335437989952314234'}, 'enable': 'true', 'created': '2026-04-03T17:49:35', 'last-modified': '2026-04-03T17:49:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.532556'}
2026-04-03 17:49:41,144 - DEBUG - Route Targets: ['target:64512:8000006']
2026-04-03 17:49:41,149 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-25511224', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-41831039', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15343161073839131809', 'uuid-lslong': '10335437989952314234'}, 'enable': 'true', 'created': '2026-04-03T17:49:35', 'last-modified': '2026-04-03T17:49:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.540544'}
2026-04-03 17:49:41,154 - DEBUG - Route Targets: ['target:64512:8000006']
2026-04-03 17:49:41,159 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-25511224', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-41831039', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15343161073839131809', 'uuid-lslong': '10335437989952314234'}, 'enable': 'true', 'created': '2026-04-03T17:49:35', 'last-modified': '2026-04-03T17:49:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.553493'}
2026-04-03 17:49:41,164 - DEBUG - Route Targets: ['target:64512:8000006']
2026-04-03 17:49:41,165 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-25511224 passed
2026-04-03 17:49:41,165 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-25511224 in API_Server ======
2026-04-03 17:49:41,165 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:41,170 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:41,181 - DEBUG - Requesting: http://10.0.0.22:8082/project/39500b7a-79fa-42ff-9318-1f567b3b9078
2026-04-03 17:49:41,272 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/d4eddbb4-81c8-4ca1-8f6e-da17a52f5b7a
2026-04-03 17:49:41,281 - DEBUG - =>VN ctest-mgmt_vn-25511224 has no policy to be verified
2026-04-03 17:49:41,281 - DEBUG - Verifying the vn in opserver
2026-04-03 17:49:41,281 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-25511224 virtual network link through opserver 10.0.0.22
2026-04-03 17:49:41,281 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-04-03 17:49:41,294 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-25511224', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-25511224?flat'}
2026-04-03 17:49:41,294 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-25511224 virtual network link through opserver 10.0.0.38
2026-04-03 17:49:41,294 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-03 17:49:41,308 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-25511224', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-25511224?flat'}
2026-04-03 17:49:41,308 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-25511224 virtual network link through opserver 10.0.0.141
2026-04-03 17:49:41,308 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-04-03 17:49:41,321 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-25511224', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-25511224?flat'}
2026-04-03 17:49:41,321 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-41831039:ctest-mgmt_vn-25511224 is found in opserver
2026-04-03 17:49:41,343 - DEBUG - Do not have enough data to verify VN in agent
2026-04-03 17:49:41,353 - DEBUG - VRF ids for VN ctest-mgmt_vn-25511224: {}
2026-04-03 17:49:41,648 - DEBUG - Response for create_network : {'network': {'id': '298478d0-d265-437b-a35f-a892a7d69438', 'name': 'ctest-left_vn-65330812', 'tenant_id': '39500b7a79fa42ff93181f567b3b9078', 'project_id': '39500b7a79fa42ff93181f567b3b9078', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-41831039', 'ctest-left_vn-65330812'], 'port_security_enabled': True, 'description': ''}}
2026-04-03 17:49:41,919 - DEBUG - Response for create_subnet : {'subnet': {'id': '01af3d69-4c39-4f4c-9e86-a25c2dce0d24', 'name': '', 'tenant_id': '39500b7a79fa42ff93181f567b3b9078', 'network_id': '298478d0-d265-437b-a35f-a892a7d69438', 'ip_version': 4, 'cidr': '42.128.88.128/26', 'allocation_pools': [{'start': '42.128.88.130', 'end': '42.128.88.190'}], 'gateway_ip': '42.128.88.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '42.128.88.130', 'tags': [], 'project_id': '39500b7a79fa42ff93181f567b3b9078'}}
2026-04-03 17:49:41,941 - INFO - Created VN ctest-left_vn-65330812
2026-04-03 17:49:41,955 - DEBUG - VN ctest-left_vn-65330812 UUID is 298478d0-d265-437b-a35f-a892a7d69438
2026-04-03 17:49:42,031 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:42,039 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:42,050 - DEBUG - Requesting: http://10.0.0.22:8082/project/39500b7a-79fa-42ff-9318-1f567b3b9078
2026-04-03 17:49:42,147 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/298478d0-d265-437b-a35f-a892a7d69438
2026-04-03 17:49:42,164 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/298478d0-d265-437b-a35f-a892a7d69438
2026-04-03 17:49:42,178 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/e7e8809f-dedb-4e7e-9e9d-8b2cd5b453c0
2026-04-03 17:49:42,187 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/e7e8809f-dedb-4e7e-9e9d-8b2cd5b453c0
2026-04-03 17:49:42,195 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/45476bdd-cfb0-4f8a-8be6-904a2ca53e2c
2026-04-03 17:49:42,204 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-03 17:49:42,204 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/298478d0-d265-437b-a35f-a892a7d69438
2026-04-03 17:49:42,215 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/e7e8809f-dedb-4e7e-9e9d-8b2cd5b453c0
2026-04-03 17:49:42,233 - INFO - Verified VN network id 15 for VN 298478d0-d265-437b-a35f-a892a7d69438
2026-04-03 17:49:42,233 - INFO - Verifications in API Server for VN ctest-left_vn-65330812 passed
2026-04-03 17:49:42,233 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/298478d0-d265-437b-a35f-a892a7d69438
2026-04-03 17:49:42,246 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/e7e8809f-dedb-4e7e-9e9d-8b2cd5b453c0
2026-04-03 17:49:42,254 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/e7e8809f-dedb-4e7e-9e9d-8b2cd5b453c0
2026-04-03 17:49:42,261 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/45476bdd-cfb0-4f8a-8be6-904a2ca53e2c
2026-04-03 17:49:42,274 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-41831039:ctest-left_vn-65330812', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-41831039', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2991648890759234427', 'uuid-lslong': '11772313298804315192'}, 'enable': 'true', 'created': '2026-04-03T17:49:41', 'last-modified': '2026-04-03T17:49:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.433731'}
2026-04-03 17:49:42,281 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-03 17:49:42,285 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-41831039:ctest-left_vn-65330812', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-41831039', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2991648890759234427', 'uuid-lslong': '11772313298804315192'}, 'enable': 'true', 'created': '2026-04-03T17:49:41', 'last-modified': '2026-04-03T17:49:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.433106'}
2026-04-03 17:49:42,290 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-03 17:49:42,295 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-41831039:ctest-left_vn-65330812', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-41831039', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2991648890759234427', 'uuid-lslong': '11772313298804315192'}, 'enable': 'true', 'created': '2026-04-03T17:49:41', 'last-modified': '2026-04-03T17:49:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.451105'}
2026-04-03 17:49:42,301 - DEBUG - Route Targets: ['target:64512:8000007']
2026-04-03 17:49:42,301 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-65330812 passed
2026-04-03 17:49:42,301 - DEBUG - ====Verifying policy data for ctest-left_vn-65330812 in API_Server ======
2026-04-03 17:49:42,302 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:42,307 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:42,319 - DEBUG - Requesting: http://10.0.0.22:8082/project/39500b7a-79fa-42ff-9318-1f567b3b9078
2026-04-03 17:49:42,427 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/298478d0-d265-437b-a35f-a892a7d69438
2026-04-03 17:49:42,438 - DEBUG - =>VN ctest-left_vn-65330812 has no policy to be verified
2026-04-03 17:49:42,438 - DEBUG - Verifying the vn in opserver
2026-04-03 17:49:42,438 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-41831039:ctest-left_vn-65330812 virtual network link through opserver 10.0.0.22
2026-04-03 17:49:42,438 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-04-03 17:49:42,450 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-41831039:ctest-left_vn-65330812', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-41831039:ctest-left_vn-65330812?flat'}
2026-04-03 17:49:42,450 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-41831039:ctest-left_vn-65330812 virtual network link through opserver 10.0.0.38
2026-04-03 17:49:42,450 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-03 17:49:42,462 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-41831039:ctest-left_vn-65330812', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-41831039:ctest-left_vn-65330812?flat'}
2026-04-03 17:49:42,462 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-41831039:ctest-left_vn-65330812 virtual network link through opserver 10.0.0.141
2026-04-03 17:49:42,463 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-04-03 17:49:42,476 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-41831039:ctest-left_vn-65330812', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-41831039:ctest-left_vn-65330812?flat'}
2026-04-03 17:49:42,476 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-41831039:ctest-left_vn-65330812 is found in opserver
2026-04-03 17:49:42,498 - DEBUG - Do not have enough data to verify VN in agent
2026-04-03 17:49:42,508 - DEBUG - VRF ids for VN ctest-left_vn-65330812: {}
2026-04-03 17:49:42,825 - DEBUG - Response for create_network : {'network': {'id': '534fcb8f-51d1-4852-af18-2ef7550b584a', 'name': 'ctest-right_vn-88857128', 'tenant_id': '39500b7a79fa42ff93181f567b3b9078', 'project_id': '39500b7a79fa42ff93181f567b3b9078', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-41831039', 'ctest-right_vn-88857128'], 'port_security_enabled': True, 'description': ''}}
2026-04-03 17:49:43,131 - DEBUG - Response for create_subnet : {'subnet': {'id': '67caf006-b501-490e-ae12-f89b0ac1cc05', 'name': '', 'tenant_id': '39500b7a79fa42ff93181f567b3b9078', 'network_id': '534fcb8f-51d1-4852-af18-2ef7550b584a', 'ip_version': 4, 'cidr': '87.114.44.0/26', 'allocation_pools': [{'start': '87.114.44.2', 'end': '87.114.44.62'}], 'gateway_ip': '87.114.44.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '87.114.44.2', 'tags': [], 'project_id': '39500b7a79fa42ff93181f567b3b9078'}}
2026-04-03 17:49:43,165 - INFO - Created VN ctest-right_vn-88857128
2026-04-03 17:49:43,177 - DEBUG - VN ctest-right_vn-88857128 UUID is 534fcb8f-51d1-4852-af18-2ef7550b584a
2026-04-03 17:49:43,259 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:43,265 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:43,277 - DEBUG - Requesting: http://10.0.0.22:8082/project/39500b7a-79fa-42ff-9318-1f567b3b9078
2026-04-03 17:49:43,371 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/534fcb8f-51d1-4852-af18-2ef7550b584a
2026-04-03 17:49:43,389 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/534fcb8f-51d1-4852-af18-2ef7550b584a
2026-04-03 17:49:43,398 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/11058756-14fb-43f5-a3a4-d438676e2ed0
2026-04-03 17:49:43,410 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/11058756-14fb-43f5-a3a4-d438676e2ed0
2026-04-03 17:49:43,420 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/7123258c-298c-4f2b-bb4b-6ebb06e71970
2026-04-03 17:49:43,429 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-03 17:49:43,429 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/534fcb8f-51d1-4852-af18-2ef7550b584a
2026-04-03 17:49:43,439 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/11058756-14fb-43f5-a3a4-d438676e2ed0
2026-04-03 17:49:43,458 - INFO - Verified VN network id 16 for VN 534fcb8f-51d1-4852-af18-2ef7550b584a
2026-04-03 17:49:43,460 - INFO - Verifications in API Server for VN ctest-right_vn-88857128 passed
2026-04-03 17:49:43,460 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/534fcb8f-51d1-4852-af18-2ef7550b584a
2026-04-03 17:49:43,471 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/11058756-14fb-43f5-a3a4-d438676e2ed0
2026-04-03 17:49:43,479 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/11058756-14fb-43f5-a3a4-d438676e2ed0
2026-04-03 17:49:43,488 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/7123258c-298c-4f2b-bb4b-6ebb06e71970
2026-04-03 17:49:43,502 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-41831039:ctest-right_vn-88857128', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-41831039', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6003240644721592402', 'uuid-lslong': '12616885995897051210'}, 'enable': 'true', 'created': '2026-04-03T17:49:42', 'last-modified': '2026-04-03T17:49:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.442412'}
2026-04-03 17:49:43,509 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-03 17:49:43,515 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-41831039:ctest-right_vn-88857128', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-41831039', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6003240644721592402', 'uuid-lslong': '12616885995897051210'}, 'enable': 'true', 'created': '2026-04-03T17:49:42', 'last-modified': '2026-04-03T17:49:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.445063'}
2026-04-03 17:49:43,521 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-03 17:49:43,528 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-41831039:ctest-right_vn-88857128', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-41831039', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6003240644721592402', 'uuid-lslong': '12616885995897051210'}, 'enable': 'true', 'created': '2026-04-03T17:49:42', 'last-modified': '2026-04-03T17:49:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.466508'}
2026-04-03 17:49:43,539 - DEBUG - Route Targets: ['target:64512:8000008']
2026-04-03 17:49:43,539 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-88857128 passed
2026-04-03 17:49:43,539 - DEBUG - ====Verifying policy data for ctest-right_vn-88857128 in API_Server ======
2026-04-03 17:49:43,539 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:43,552 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:43,563 - DEBUG - Requesting: http://10.0.0.22:8082/project/39500b7a-79fa-42ff-9318-1f567b3b9078
2026-04-03 17:49:43,675 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/534fcb8f-51d1-4852-af18-2ef7550b584a
2026-04-03 17:49:43,698 - DEBUG - =>VN ctest-right_vn-88857128 has no policy to be verified
2026-04-03 17:49:43,698 - DEBUG - Verifying the vn in opserver
2026-04-03 17:49:43,699 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-41831039:ctest-right_vn-88857128 virtual network link through opserver 10.0.0.22
2026-04-03 17:49:43,699 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-04-03 17:49:43,710 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-41831039:ctest-right_vn-88857128', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-41831039:ctest-right_vn-88857128?flat'}
2026-04-03 17:49:43,710 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-41831039:ctest-right_vn-88857128 virtual network link through opserver 10.0.0.38
2026-04-03 17:49:43,710 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-04-03 17:49:43,721 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-41831039:ctest-right_vn-88857128', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-41831039:ctest-right_vn-88857128?flat'}
2026-04-03 17:49:43,721 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-41831039:ctest-right_vn-88857128 virtual network link through opserver 10.0.0.141
2026-04-03 17:49:43,721 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-04-03 17:49:43,736 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-41831039:ctest-right_vn-88857128', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-41831039:ctest-right_vn-88857128?flat'}
2026-04-03 17:49:43,736 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-41831039:ctest-right_vn-88857128 is found in opserver
2026-04-03 17:49:43,761 - DEBUG - Do not have enough data to verify VN in agent
2026-04-03 17:49:43,770 - DEBUG - VRF ids for VN ctest-right_vn-88857128: {}
2026-04-03 17:49:45,042 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5589-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5589-1)
2026-04-03 17:49:46,593 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5589-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5589-2)
2026-04-03 17:49:46,593 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-20200801']
2026-04-03 17:49:46,882 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-20200801'] created succesfully
2026-04-03 17:49:47,285 - DEBUG - Image by name tiny_nat_fw not found
2026-04-03 17:49:47,285 - DEBUG - Installing image tiny_nat_fw
2026-04-03 17:49:47,285 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-04-03 17:49:47,285 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-04-03 17:49:47,285 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-04-03 17:49:47,285 - DEBUG - Unzip image
2026-04-03 17:49:47,285 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-04-03 17:49:47,304 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-04-03 17:49:47,305 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-20200801']
2026-04-03 17:49:47,423 - INFO - Service template: ['default-domain', 'ctest-service_template_1-20200801'] deleted successfully.
2026-04-03 17:49:47,424 - INFO - Skip interface_detach for VM ctest-right_vm-75921936 in state BUILD
2026-04-03 17:49:47,424 - INFO - Deleting VM ctest-right_vm-75921936
2026-04-03 17:49:47,424 - ERROR - VM ctest-right_vm-75921936 has failed to come up
2026-04-03 17:49:47,424 - ERROR - Nova failed to get host of the VM
2026-04-03 17:49:47,424 - ERROR - VM ctest-right_vm-75921936 has failed to come up
2026-04-03 17:49:47,424 - ERROR - Nova failed to get host of the VM
2026-04-03 17:49:47,496 - INFO - Skip interface_detach for VM ctest-left_vm-07899654 in state BUILD
2026-04-03 17:49:47,496 - INFO - Deleting VM ctest-left_vm-07899654
2026-04-03 17:49:47,496 - ERROR - VM ctest-left_vm-07899654 has failed to come up
2026-04-03 17:49:47,496 - ERROR - Nova failed to get host of the VM
2026-04-03 17:49:47,496 - ERROR - VM ctest-left_vm-07899654 has failed to come up
2026-04-03 17:49:47,496 - ERROR - Nova failed to get host of the VM
2026-04-03 17:49:47,576 - INFO - Deleting VN ctest-right_vn-88857128
2026-04-03 17:49:47,625 - DEBUG - VN 534fcb8f-51d1-4852-af18-2ef7550b584a still in use: Unable to complete operation on network 534fcb8f-51d1-4852-af18-2ef7550b584a. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-15db07e9-1604-4bfa-80e9-2da3aa4fafb2']
2026-04-03 17:49:47,625 - WARNING - Deleting VN ctest-right_vn-88857128 failed..Will retry
2026-04-03 17:49:49,791 - DEBUG - Response for deleting network ()
2026-04-03 17:49:49,792 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/11058756-14fb-43f5-a3a4-d438676e2ed0
2026-04-03 17:49:49,800 - DEBUG - Response Code: 404
2026-04-03 17:49:49,801 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:49,816 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:49,836 - DEBUG - Requesting: http://10.0.0.22:8082/project/39500b7a-79fa-42ff-9318-1f567b3b9078
2026-04-03 17:49:49,930 - INFO - Validated that VN ctest-right_vn-88857128 is not found in API Server
2026-04-03 17:49:49,942 - DEBUG - VN ctest-right_vn-88857128 is not present in Agent 10.0.0.19
2026-04-03 17:49:49,951 - DEBUG - VN ctest-right_vn-88857128 is not present in Agent 10.0.0.240
2026-04-03 17:49:49,951 - INFO - Validated that VN ctest-right_vn-88857128 is not in any agent
2026-04-03 17:49:49,981 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-88857128 info
2026-04-03 17:49:49,981 - INFO - Deleting VN ctest-left_vn-65330812
2026-04-03 17:49:50,130 - DEBUG - Response for deleting network ()
2026-04-03 17:49:50,130 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/e7e8809f-dedb-4e7e-9e9d-8b2cd5b453c0
2026-04-03 17:49:50,136 - DEBUG - Response Code: 404
2026-04-03 17:49:50,136 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:50,147 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:50,200 - DEBUG - Requesting: http://10.0.0.22:8082/project/39500b7a-79fa-42ff-9318-1f567b3b9078
2026-04-03 17:49:50,283 - INFO - Validated that VN ctest-left_vn-65330812 is not found in API Server
2026-04-03 17:49:50,295 - DEBUG - VN ctest-left_vn-65330812 is not present in Agent 10.0.0.19
2026-04-03 17:49:50,304 - DEBUG - VN ctest-left_vn-65330812 is not present in Agent 10.0.0.240
2026-04-03 17:49:50,304 - INFO - Validated that VN ctest-left_vn-65330812 is not in any agent
2026-04-03 17:49:50,333 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-65330812 info
2026-04-03 17:49:50,333 - INFO - Deleting VN ctest-mgmt_vn-25511224
2026-04-03 17:49:50,477 - DEBUG - Response for deleting network ()
2026-04-03 17:49:50,477 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/441b87dd-59dc-44ca-9bd7-048b08e85df9
2026-04-03 17:49:50,483 - DEBUG - Response Code: 404
2026-04-03 17:49:50,483 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-04-03 17:49:50,492 - DEBUG - Requesting: http://10.0.0.22:8082/domain/3366d1ce-0fb9-4373-a4f2-6bb9715d4849
2026-04-03 17:49:50,504 - DEBUG - Requesting: http://10.0.0.22:8082/project/39500b7a-79fa-42ff-9318-1f567b3b9078
2026-04-03 17:49:50,593 - INFO - Validated that VN ctest-mgmt_vn-25511224 is not found in API Server
2026-04-03 17:49:50,607 - DEBUG - VN ctest-mgmt_vn-25511224 is not present in Agent 10.0.0.19
2026-04-03 17:49:50,616 - DEBUG - VN ctest-mgmt_vn-25511224 is not present in Agent 10.0.0.240
2026-04-03 17:49:50,616 - INFO - Validated that VN ctest-mgmt_vn-25511224 is not in any agent
2026-04-03 17:49:50,649 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-25511224 info
2026-04-03 17:49:51,926 - DEBUG - No XMPP flaps were noticed during the test
2026-04-03 17:49:51,926 - INFO -
2026-04-03 17:49:51,926 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:18]
2026-04-03 17:49:51,926 - INFO - --------------------------------------------------------------------------------
2026-04-03 17:49:52,668 - INFO - Deleted project: ctest-TestSvcRegr-41831039, ID : 39500b7a-79fa-42ff-9318-1f567b3b9078