]) created on node: (an-jenkins-deploy-platform-ansible-os-3775-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3775-2)
2025-08-07 19:17:24,491 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-30415199']
2025-08-07 19:17:24,823 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-30415199'] created succesfully
2025-08-07 19:17:25,300 - DEBUG - Image by name tiny_nat_fw not found
2025-08-07 19:17:25,300 - DEBUG - Installing image tiny_nat_fw
2025-08-07 19:17:25,300 - 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'"}
2025-08-07 19:17:25,302 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2025-08-07 19:17:25,303 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2025-08-07 19:17:25,322 - 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
2025-08-07 19:17:25,402 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-08-07 19:17:25,403 - DEBUG - Unzip image
2025-08-07 19:17:25,403 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-08-07 19:17:25,423 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2025-08-07 19:17:25,424 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-30415199']
2025-08-07 19:17:25,523 - INFO - Service template: ['default-domain', 'ctest-service_template_1-30415199'] deleted successfully.
2025-08-07 19:17:25,523 - INFO - Skip interface_detach for VM ctest-right_vm-30105764 in state BUILD
2025-08-07 19:17:25,523 - INFO - Deleting VM ctest-right_vm-30105764
2025-08-07 19:17:25,561 - ERROR - VM ctest-right_vm-30105764 has failed to come up
2025-08-07 19:17:25,561 - ERROR - Nova failed to get host of the VM
2025-08-07 19:17:25,562 - ERROR - VM ctest-right_vm-30105764 has failed to come up
2025-08-07 19:17:25,562 - ERROR - Nova failed to get host of the VM
2025-08-07 19:17:25,635 - INFO - Skip interface_detach for VM ctest-left_vm-54450627 in state BUILD
2025-08-07 19:17:25,635 - INFO - Deleting VM ctest-left_vm-54450627
2025-08-07 19:17:25,636 - ERROR - VM ctest-left_vm-54450627 has failed to come up
2025-08-07 19:17:25,636 - ERROR - Nova failed to get host of the VM
2025-08-07 19:17:25,636 - ERROR - VM ctest-left_vm-54450627 has failed to come up
2025-08-07 19:17:25,636 - ERROR - Nova failed to get host of the VM
2025-08-07 19:17:25,716 - INFO - Deleting VN ctest-right_vn-88217964
2025-08-07 19:17:25,759 - DEBUG - VN b354482f-d9db-4a42-ba82-f14dc483ed42 still in use: Unable to complete operation on network b354482f-d9db-4a42-ba82-f14dc483ed42. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-fdc50f2c-c396-4bde-8181-4527afb7dc15']
2025-08-07 19:17:25,760 - WARNING - Deleting VN ctest-right_vn-88217964 failed..Will retry
2025-08-07 19:17:27,946 - DEBUG - Response for deleting network ()
2025-08-07 19:17:27,946 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/5120ca7d-55fd-4c37-8415-7a8a66721c0e
2025-08-07 19:17:27,954 - DEBUG - Response Code: 404
2025-08-07 19:17:27,954 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:27,961 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:27,991 - DEBUG - Requesting: http://10.0.0.19:8082/project/40f7ace0-38f2-438d-ae89-3ed206c0746c
2025-08-07 19:17:28,109 - INFO - Validated that VN ctest-right_vn-88217964 is not found in API Server
2025-08-07 19:17:28,128 - DEBUG - VN ctest-right_vn-88217964 is not present in Agent 10.0.0.65
2025-08-07 19:17:28,144 - DEBUG - VN ctest-right_vn-88217964 is not present in Agent 10.0.0.242
2025-08-07 19:17:28,144 - INFO - Validated that VN ctest-right_vn-88217964 is not in any agent
2025-08-07 19:17:28,191 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-88217964 info
2025-08-07 19:17:28,192 - INFO - Deleting VN ctest-left_vn-92979383
2025-08-07 19:17:28,420 - DEBUG - Response for deleting network ()
2025-08-07 19:17:28,420 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/6c87b1d2-54eb-4bfa-af2c-23088b0663e9
2025-08-07 19:17:28,430 - DEBUG - Response Code: 404
2025-08-07 19:17:28,431 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:28,440 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:28,464 - DEBUG - Requesting: http://10.0.0.19:8082/project/40f7ace0-38f2-438d-ae89-3ed206c0746c
2025-08-07 19:17:28,582 - INFO - Validated that VN ctest-left_vn-92979383 is not found in API Server
2025-08-07 19:17:28,616 - DEBUG - VN ctest-left_vn-92979383 is not present in Agent 10.0.0.65
2025-08-07 19:17:28,631 - DEBUG - VN ctest-left_vn-92979383 is not present in Agent 10.0.0.242
2025-08-07 19:17:28,631 - INFO - Validated that VN ctest-left_vn-92979383 is not in any agent
2025-08-07 19:17:28,687 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-92979383 info
2025-08-07 19:17:28,687 - INFO - Deleting VN ctest-mgmt_vn-48875728
2025-08-07 19:17:28,868 - DEBUG - Response for deleting network ()
2025-08-07 19:17:28,868 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/0032bfc7-1049-4117-a53a-33b2265fa591
2025-08-07 19:17:28,877 - DEBUG - Response Code: 404
2025-08-07 19:17:28,878 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:28,885 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:28,946 - DEBUG - Requesting: http://10.0.0.19:8082/project/40f7ace0-38f2-438d-ae89-3ed206c0746c
2025-08-07 19:17:29,053 - INFO - Validated that VN ctest-mgmt_vn-48875728 is not found in API Server
2025-08-07 19:17:29,083 - DEBUG - VN ctest-mgmt_vn-48875728 is not present in Agent 10.0.0.65
2025-08-07 19:17:29,102 - DEBUG - VN ctest-mgmt_vn-48875728 is not present in Agent 10.0.0.242
2025-08-07 19:17:29,102 - INFO - Validated that VN ctest-mgmt_vn-48875728 is not in any agent
2025-08-07 19:17:29,154 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-48875728 info
2025-08-07 19:17:29,154 - INFO - Deleting VM ctest-vm-in-third-vn-37080161
2025-08-07 19:17:29,253 - INFO - Deleting VN ctest-third-vn-39161220
2025-08-07 19:17:29,306 - DEBUG - VN 9ea34adf-39d9-4c11-9833-dd048b8c4156 still in use: Unable to complete operation on network 9ea34adf-39d9-4c11-9833-dd048b8c4156. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-999a16f6-69de-4623-80c6-7e541e20712f']
2025-08-07 19:17:29,306 - WARNING - Deleting VN ctest-third-vn-39161220 failed..Will retry
2025-08-07 19:17:31,578 - DEBUG - Response for deleting network ()
2025-08-07 19:17:32,947 - DEBUG - No XMPP flaps were noticed during the test
2025-08-07 19:17:32,947 - INFO -
2025-08-07 19:17:32,947 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:26]
2025-08-07 19:17:32,947 - INFO - --------------------------------------------------------------------------------
2025-08-07 19:17:32,951 - INFO - ================================================================================
2025-08-07 19:17:32,951 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2025-08-07 19:17:34,281 - DEBUG - Nothing to compare xmpp stats {'10.0.0.65': {'10.20.0.14': '0', '10.20.0.193': '0'}, '10.0.0.242': {'10.20.0.14': '0', '10.20.0.193': '0'}} with
2025-08-07 19:17:34,281 - INFO - Initial checks done. Running the testcase now
2025-08-07 19:17:34,281 - INFO -
2025-08-07 19:17:34,593 - DEBUG - Response for create_network : {'network': {'id': '1b01889b-f344-47d7-ace4-7b91f35ec04d', 'name': 'ctest-mgmt_vn-01431940', 'tenant_id': '40f7ace038f2438dae893ed206c0746c', 'project_id': '40f7ace038f2438dae893ed206c0746c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-82255929', 'ctest-mgmt_vn-01431940'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 19:17:34,846 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a30f6807-3508-4539-b64f-a70d2bf12d81', 'name': '', 'tenant_id': '40f7ace038f2438dae893ed206c0746c', 'network_id': '1b01889b-f344-47d7-ace4-7b91f35ec04d', 'ip_version': 4, 'cidr': '183.73.105.128/26', 'allocation_pools': [{'start': '183.73.105.130', 'end': '183.73.105.190'}], 'gateway_ip': '183.73.105.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '183.73.105.130', 'tags': [], 'project_id': '40f7ace038f2438dae893ed206c0746c'}}
2025-08-07 19:17:34,876 - INFO - Created VN ctest-mgmt_vn-01431940
2025-08-07 19:17:34,895 - DEBUG - VN ctest-mgmt_vn-01431940 UUID is 1b01889b-f344-47d7-ace4-7b91f35ec04d
2025-08-07 19:17:34,986 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:34,997 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:35,014 - DEBUG - Requesting: http://10.0.0.19:8082/project/40f7ace0-38f2-438d-ae89-3ed206c0746c
2025-08-07 19:17:35,111 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/1b01889b-f344-47d7-ace4-7b91f35ec04d
2025-08-07 19:17:35,127 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/1b01889b-f344-47d7-ace4-7b91f35ec04d
2025-08-07 19:17:35,143 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/be552464-e44c-4e08-913b-661496317690
2025-08-07 19:17:35,153 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/be552464-e44c-4e08-913b-661496317690
2025-08-07 19:17:35,164 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/ad5f8b4a-df0e-483a-88b5-c0454565540f
2025-08-07 19:17:35,173 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-07 19:17:35,173 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/1b01889b-f344-47d7-ace4-7b91f35ec04d
2025-08-07 19:17:35,185 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/be552464-e44c-4e08-913b-661496317690
2025-08-07 19:17:35,204 - INFO - Verified VN network id 15 for VN 1b01889b-f344-47d7-ace4-7b91f35ec04d
2025-08-07 19:17:35,205 - INFO - Verifications in API Server for VN ctest-mgmt_vn-01431940 passed
2025-08-07 19:17:35,205 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/1b01889b-f344-47d7-ace4-7b91f35ec04d
2025-08-07 19:17:35,218 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/be552464-e44c-4e08-913b-661496317690
2025-08-07 19:17:35,229 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/be552464-e44c-4e08-913b-661496317690
2025-08-07 19:17:35,238 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/ad5f8b4a-df0e-483a-88b5-c0454565540f
2025-08-07 19:17:35,255 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-82255929:ctest-mgmt_vn-01431940', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-82255929', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1945986717383411671', 'uuid-lslong': '12458218335997182029'}, 'enable': 'true', 'created': '2025-08-07T19:17:34', 'last-modified': '2025-08-07T19:17:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.481031'}
2025-08-07 19:17:35,262 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-07 19:17:35,270 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-82255929:ctest-mgmt_vn-01431940', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-82255929', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1945986717383411671', 'uuid-lslong': '12458218335997182029'}, 'enable': 'true', 'created': '2025-08-07T19:17:34', 'last-modified': '2025-08-07T19:17:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.495992'}
2025-08-07 19:17:35,279 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-07 19:17:35,286 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-82255929:ctest-mgmt_vn-01431940', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-82255929', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1945986717383411671', 'uuid-lslong': '12458218335997182029'}, 'enable': 'true', 'created': '2025-08-07T19:17:34', 'last-modified': '2025-08-07T19:17:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.512951'}
2025-08-07 19:17:35,294 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-07 19:17:35,294 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-01431940 passed
2025-08-07 19:17:35,294 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-01431940 in API_Server ======
2025-08-07 19:17:35,294 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:35,302 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:35,320 - DEBUG - Requesting: http://10.0.0.19:8082/project/40f7ace0-38f2-438d-ae89-3ed206c0746c
2025-08-07 19:17:35,422 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/1b01889b-f344-47d7-ace4-7b91f35ec04d
2025-08-07 19:17:35,434 - DEBUG - =>VN ctest-mgmt_vn-01431940 has no policy to be verified
2025-08-07 19:17:35,434 - DEBUG - Verifying the vn in opserver
2025-08-07 19:17:35,434 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-82255929:ctest-mgmt_vn-01431940 virtual network link through opserver 10.0.0.19
2025-08-07 19:17:35,434 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-07 19:17:35,457 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-82255929:ctest-mgmt_vn-01431940', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-82255929:ctest-mgmt_vn-01431940?flat'}
2025-08-07 19:17:35,457 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-82255929:ctest-mgmt_vn-01431940 virtual network link through opserver 10.0.0.50
2025-08-07 19:17:35,457 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-08-07 19:17:35,473 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-82255929:ctest-mgmt_vn-01431940', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-82255929:ctest-mgmt_vn-01431940?flat'}
2025-08-07 19:17:35,473 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-82255929:ctest-mgmt_vn-01431940 virtual network link through opserver 10.0.0.241
2025-08-07 19:17:35,473 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2025-08-07 19:17:35,489 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-82255929:ctest-mgmt_vn-01431940', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-82255929:ctest-mgmt_vn-01431940?flat'}
2025-08-07 19:17:35,489 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-82255929:ctest-mgmt_vn-01431940 is found in opserver
2025-08-07 19:17:35,543 - DEBUG - Do not have enough data to verify VN in agent
2025-08-07 19:17:35,569 - DEBUG - VRF ids for VN ctest-mgmt_vn-01431940: {}
2025-08-07 19:17:35,880 - DEBUG - Response for create_network : {'network': {'id': '6f6c7b00-6006-44d8-8518-da6e5bef0788', 'name': 'ctest-left_vn-73042560', 'tenant_id': '40f7ace038f2438dae893ed206c0746c', 'project_id': '40f7ace038f2438dae893ed206c0746c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-82255929', 'ctest-left_vn-73042560'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 19:17:36,125 - DEBUG - Response for create_subnet : {'subnet': {'id': '1566fc91-b715-4127-883c-7735f91d9d8d', 'name': '', 'tenant_id': '40f7ace038f2438dae893ed206c0746c', 'network_id': '6f6c7b00-6006-44d8-8518-da6e5bef0788', 'ip_version': 4, 'cidr': '204.126.23.0/26', 'allocation_pools': [{'start': '204.126.23.2', 'end': '204.126.23.62'}], 'gateway_ip': '204.126.23.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '204.126.23.2', 'tags': [], 'project_id': '40f7ace038f2438dae893ed206c0746c'}}
2025-08-07 19:17:36,152 - INFO - Created VN ctest-left_vn-73042560
2025-08-07 19:17:36,171 - DEBUG - VN ctest-left_vn-73042560 UUID is 6f6c7b00-6006-44d8-8518-da6e5bef0788
2025-08-07 19:17:36,267 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:36,275 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:36,290 - DEBUG - Requesting: http://10.0.0.19:8082/project/40f7ace0-38f2-438d-ae89-3ed206c0746c
2025-08-07 19:17:36,389 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/6f6c7b00-6006-44d8-8518-da6e5bef0788
2025-08-07 19:17:36,408 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/6f6c7b00-6006-44d8-8518-da6e5bef0788
2025-08-07 19:17:36,421 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/00a1874d-2a3f-483d-8132-408ad1db85f7
2025-08-07 19:17:36,432 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/00a1874d-2a3f-483d-8132-408ad1db85f7
2025-08-07 19:17:36,441 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/9a0ed29e-0258-4a8e-93c9-d8f354caf664
2025-08-07 19:17:36,450 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-07 19:17:36,450 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/6f6c7b00-6006-44d8-8518-da6e5bef0788
2025-08-07 19:17:36,462 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/00a1874d-2a3f-483d-8132-408ad1db85f7
2025-08-07 19:17:36,486 - INFO - Verified VN network id 16 for VN 6f6c7b00-6006-44d8-8518-da6e5bef0788
2025-08-07 19:17:36,486 - INFO - Verifications in API Server for VN ctest-left_vn-73042560 passed
2025-08-07 19:17:36,486 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/6f6c7b00-6006-44d8-8518-da6e5bef0788
2025-08-07 19:17:36,500 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/00a1874d-2a3f-483d-8132-408ad1db85f7
2025-08-07 19:17:36,510 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/00a1874d-2a3f-483d-8132-408ad1db85f7
2025-08-07 19:17:36,522 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/9a0ed29e-0258-4a8e-93c9-d8f354caf664
2025-08-07 19:17:36,541 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-82255929:ctest-left_vn-73042560', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-82255929', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8028927477235991768', 'uuid-lslong': '9590655574009120648'}, 'enable': 'true', 'created': '2025-08-07T19:17:35', 'last-modified': '2025-08-07T19:17:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.482255'}
2025-08-07 19:17:36,550 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-07 19:17:36,557 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-82255929:ctest-left_vn-73042560', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-82255929', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8028927477235991768', 'uuid-lslong': '9590655574009120648'}, 'enable': 'true', 'created': '2025-08-07T19:17:35', 'last-modified': '2025-08-07T19:17:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.498531'}
2025-08-07 19:17:36,564 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-07 19:17:36,572 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-82255929:ctest-left_vn-73042560', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-82255929', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8028927477235991768', 'uuid-lslong': '9590655574009120648'}, 'enable': 'true', 'created': '2025-08-07T19:17:35', 'last-modified': '2025-08-07T19:17:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.509745'}
2025-08-07 19:17:36,582 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-07 19:17:36,582 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-73042560 passed
2025-08-07 19:17:36,583 - DEBUG - ====Verifying policy data for ctest-left_vn-73042560 in API_Server ======
2025-08-07 19:17:36,583 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:36,594 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:36,611 - DEBUG - Requesting: http://10.0.0.19:8082/project/40f7ace0-38f2-438d-ae89-3ed206c0746c
2025-08-07 19:17:36,728 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/6f6c7b00-6006-44d8-8518-da6e5bef0788
2025-08-07 19:17:36,745 - DEBUG - =>VN ctest-left_vn-73042560 has no policy to be verified
2025-08-07 19:17:36,745 - DEBUG - Verifying the vn in opserver
2025-08-07 19:17:36,745 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-82255929:ctest-left_vn-73042560 virtual network link through opserver 10.0.0.19
2025-08-07 19:17:36,746 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-07 19:17:36,760 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-82255929:ctest-left_vn-73042560', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-82255929:ctest-left_vn-73042560?flat'}
2025-08-07 19:17:36,760 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-82255929:ctest-left_vn-73042560 virtual network link through opserver 10.0.0.50
2025-08-07 19:17:36,760 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-08-07 19:17:36,774 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-82255929:ctest-left_vn-73042560', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-82255929:ctest-left_vn-73042560?flat'}
2025-08-07 19:17:36,774 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-82255929:ctest-left_vn-73042560 virtual network link through opserver 10.0.0.241
2025-08-07 19:17:36,774 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2025-08-07 19:17:36,790 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-82255929:ctest-left_vn-73042560', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-82255929:ctest-left_vn-73042560?flat'}
2025-08-07 19:17:36,790 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-82255929:ctest-left_vn-73042560 is found in opserver
2025-08-07 19:17:36,821 - DEBUG - Do not have enough data to verify VN in agent
2025-08-07 19:17:36,844 - DEBUG - VRF ids for VN ctest-left_vn-73042560: {}
2025-08-07 19:17:37,222 - DEBUG - Response for create_network : {'network': {'id': '417861ff-ad67-489d-8311-315afc6550e7', 'name': 'ctest-right_vn-99076620', 'tenant_id': '40f7ace038f2438dae893ed206c0746c', 'project_id': '40f7ace038f2438dae893ed206c0746c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-82255929', 'ctest-right_vn-99076620'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 19:17:37,510 - DEBUG - Response for create_subnet : {'subnet': {'id': '28cbbc5b-5d15-4de3-8fba-7181f1ceb6ed', 'name': '', 'tenant_id': '40f7ace038f2438dae893ed206c0746c', 'network_id': '417861ff-ad67-489d-8311-315afc6550e7', 'ip_version': 4, 'cidr': '1.104.85.0/26', 'allocation_pools': [{'start': '1.104.85.2', 'end': '1.104.85.62'}], 'gateway_ip': '1.104.85.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '1.104.85.2', 'tags': [], 'project_id': '40f7ace038f2438dae893ed206c0746c'}}
2025-08-07 19:17:37,535 - INFO - Created VN ctest-right_vn-99076620
2025-08-07 19:17:37,550 - DEBUG - VN ctest-right_vn-99076620 UUID is 417861ff-ad67-489d-8311-315afc6550e7
2025-08-07 19:17:37,641 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:37,651 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:37,672 - DEBUG - Requesting: http://10.0.0.19:8082/project/40f7ace0-38f2-438d-ae89-3ed206c0746c
2025-08-07 19:17:37,782 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/417861ff-ad67-489d-8311-315afc6550e7
2025-08-07 19:17:37,822 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/417861ff-ad67-489d-8311-315afc6550e7
2025-08-07 19:17:37,839 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/fc0b708d-9376-4aa1-8536-5adf30c58800
2025-08-07 19:17:37,849 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/fc0b708d-9376-4aa1-8536-5adf30c58800
2025-08-07 19:17:37,859 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/eaf0954b-8f73-483c-b3eb-77e7ddaccbd8
2025-08-07 19:17:37,871 - DEBUG - Route Targets: ['target:64512:8000008']
2025-08-07 19:17:37,871 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/417861ff-ad67-489d-8311-315afc6550e7
2025-08-07 19:17:37,886 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/fc0b708d-9376-4aa1-8536-5adf30c58800
2025-08-07 19:17:37,908 - INFO - Verified VN network id 17 for VN 417861ff-ad67-489d-8311-315afc6550e7
2025-08-07 19:17:37,909 - INFO - Verifications in API Server for VN ctest-right_vn-99076620 passed
2025-08-07 19:17:37,909 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/417861ff-ad67-489d-8311-315afc6550e7
2025-08-07 19:17:37,929 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/fc0b708d-9376-4aa1-8536-5adf30c58800
2025-08-07 19:17:37,946 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/fc0b708d-9376-4aa1-8536-5adf30c58800
2025-08-07 19:17:37,958 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/eaf0954b-8f73-483c-b3eb-77e7ddaccbd8
2025-08-07 19:17:37,982 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-82255929:ctest-right_vn-99076620', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-82255929', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4717628360424376477', 'uuid-lslong': '9444384160423956711'}, 'enable': 'true', 'created': '2025-08-07T19:17:37', 'last-modified': '2025-08-07T19:17:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.531441'}
2025-08-07 19:17:37,996 - DEBUG - Route Targets: ['target:64512:8000008']
2025-08-07 19:17:38,004 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-82255929:ctest-right_vn-99076620', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-82255929', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4717628360424376477', 'uuid-lslong': '9444384160423956711'}, 'enable': 'true', 'created': '2025-08-07T19:17:37', 'last-modified': '2025-08-07T19:17:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.556447'}
2025-08-07 19:17:38,014 - DEBUG - Route Targets: ['target:64512:8000008']
2025-08-07 19:17:38,029 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-82255929:ctest-right_vn-99076620', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-82255929', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4717628360424376477', 'uuid-lslong': '9444384160423956711'}, 'enable': 'true', 'created': '2025-08-07T19:17:37', 'last-modified': '2025-08-07T19:17:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.574570'}
2025-08-07 19:17:38,043 - DEBUG - Route Targets: ['target:64512:8000008']
2025-08-07 19:17:38,043 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-99076620 passed
2025-08-07 19:17:38,044 - DEBUG - ====Verifying policy data for ctest-right_vn-99076620 in API_Server ======
2025-08-07 19:17:38,044 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:38,054 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:38,071 - DEBUG - Requesting: http://10.0.0.19:8082/project/40f7ace0-38f2-438d-ae89-3ed206c0746c
2025-08-07 19:17:38,176 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/417861ff-ad67-489d-8311-315afc6550e7
2025-08-07 19:17:38,190 - DEBUG - =>VN ctest-right_vn-99076620 has no policy to be verified
2025-08-07 19:17:38,190 - DEBUG - Verifying the vn in opserver
2025-08-07 19:17:38,190 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-82255929:ctest-right_vn-99076620 virtual network link through opserver 10.0.0.19
2025-08-07 19:17:38,190 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-07 19:17:38,209 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-82255929:ctest-right_vn-99076620', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-82255929:ctest-right_vn-99076620?flat'}
2025-08-07 19:17:38,209 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-82255929:ctest-right_vn-99076620 virtual network link through opserver 10.0.0.50
2025-08-07 19:17:38,209 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-08-07 19:17:38,225 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-82255929:ctest-right_vn-99076620', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-82255929:ctest-right_vn-99076620?flat'}
2025-08-07 19:17:38,225 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-82255929:ctest-right_vn-99076620 virtual network link through opserver 10.0.0.241
2025-08-07 19:17:38,225 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2025-08-07 19:17:38,244 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-82255929:ctest-right_vn-99076620', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-82255929:ctest-right_vn-99076620?flat'}
2025-08-07 19:17:38,244 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-82255929:ctest-right_vn-99076620 is found in opserver
2025-08-07 19:17:38,289 - DEBUG - Do not have enough data to verify VN in agent
2025-08-07 19:17:38,305 - DEBUG - VRF ids for VN ctest-right_vn-99076620: {}
2025-08-07 19:17:38,642 - DEBUG - Response for create_network : {'network': {'id': '26db9013-50bd-4b77-8c62-2aea8140f044', 'name': 'ctest-trans_left_vn-35819622', 'tenant_id': '40f7ace038f2438dae893ed206c0746c', 'project_id': '40f7ace038f2438dae893ed206c0746c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-82255929', 'ctest-trans_left_vn-35819622'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 19:17:38,886 - DEBUG - Response for create_subnet : {'subnet': {'id': 'bb3ab0da-70b0-424b-9a13-35fc109010ef', 'name': '', 'tenant_id': '40f7ace038f2438dae893ed206c0746c', 'network_id': '26db9013-50bd-4b77-8c62-2aea8140f044', 'ip_version': 4, 'cidr': '93.78.80.192/26', 'allocation_pools': [{'start': '93.78.80.194', 'end': '93.78.80.254'}], 'gateway_ip': '93.78.80.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '93.78.80.194', 'tags': [], 'project_id': '40f7ace038f2438dae893ed206c0746c'}}
2025-08-07 19:17:38,910 - INFO - Created VN ctest-trans_left_vn-35819622
2025-08-07 19:17:38,922 - DEBUG - VN ctest-trans_left_vn-35819622 UUID is 26db9013-50bd-4b77-8c62-2aea8140f044
2025-08-07 19:17:39,006 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:39,014 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:39,029 - DEBUG - Requesting: http://10.0.0.19:8082/project/40f7ace0-38f2-438d-ae89-3ed206c0746c
2025-08-07 19:17:39,152 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/26db9013-50bd-4b77-8c62-2aea8140f044
2025-08-07 19:17:39,171 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/26db9013-50bd-4b77-8c62-2aea8140f044
2025-08-07 19:17:39,183 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/2702cb24-55ba-467d-bcb0-ef5108f44cbd
2025-08-07 19:17:39,195 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/2702cb24-55ba-467d-bcb0-ef5108f44cbd
2025-08-07 19:17:39,206 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/4fceb076-3f20-4f53-8f3b-069244fda082
2025-08-07 19:17:39,216 - DEBUG - Route Targets: ['target:64512:8000009']
2025-08-07 19:17:39,217 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/26db9013-50bd-4b77-8c62-2aea8140f044
2025-08-07 19:17:39,232 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/2702cb24-55ba-467d-bcb0-ef5108f44cbd
2025-08-07 19:17:39,252 - INFO - Verified VN network id 18 for VN 26db9013-50bd-4b77-8c62-2aea8140f044
2025-08-07 19:17:39,252 - INFO - Verifications in API Server for VN ctest-trans_left_vn-35819622 passed
2025-08-07 19:17:39,252 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/26db9013-50bd-4b77-8c62-2aea8140f044
2025-08-07 19:17:39,266 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/2702cb24-55ba-467d-bcb0-ef5108f44cbd
2025-08-07 19:17:39,276 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/2702cb24-55ba-467d-bcb0-ef5108f44cbd
2025-08-07 19:17:39,285 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/4fceb076-3f20-4f53-8f3b-069244fda082
2025-08-07 19:17:39,301 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-82255929:ctest-trans_left_vn-35819622', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-82255929', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2799990005974256503', 'uuid-lslong': '10115694899706785860'}, 'enable': 'true', 'created': '2025-08-07T19:17:38', 'last-modified': '2025-08-07T19:17:38', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.456538'}
2025-08-07 19:17:39,312 - DEBUG - Route Targets: ['target:64512:8000009']
2025-08-07 19:17:39,320 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-82255929:ctest-trans_left_vn-35819622', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-82255929', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2799990005974256503', 'uuid-lslong': '10115694899706785860'}, 'enable': 'true', 'created': '2025-08-07T19:17:38', 'last-modified': '2025-08-07T19:17:38', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.476823'}
2025-08-07 19:17:39,328 - DEBUG - Route Targets: ['target:64512:8000009']
2025-08-07 19:17:39,335 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-82255929:ctest-trans_left_vn-35819622', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-82255929', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2799990005974256503', 'uuid-lslong': '10115694899706785860'}, 'enable': 'true', 'created': '2025-08-07T19:17:38', 'last-modified': '2025-08-07T19:17:38', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.496104'}
2025-08-07 19:17:39,343 - DEBUG - Route Targets: ['target:64512:8000009']
2025-08-07 19:17:39,343 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-35819622 passed
2025-08-07 19:17:39,343 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-35819622 in API_Server ======
2025-08-07 19:17:39,343 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:39,351 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:39,366 - DEBUG - Requesting: http://10.0.0.19:8082/project/40f7ace0-38f2-438d-ae89-3ed206c0746c
2025-08-07 19:17:39,469 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/26db9013-50bd-4b77-8c62-2aea8140f044
2025-08-07 19:17:39,481 - DEBUG - =>VN ctest-trans_left_vn-35819622 has no policy to be verified
2025-08-07 19:17:39,481 - DEBUG - Verifying the vn in opserver
2025-08-07 19:17:39,481 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-82255929:ctest-trans_left_vn-35819622 virtual network link through opserver 10.0.0.19
2025-08-07 19:17:39,481 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-07 19:17:39,497 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-82255929:ctest-trans_left_vn-35819622', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-82255929:ctest-trans_left_vn-35819622?flat'}
2025-08-07 19:17:39,497 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-82255929:ctest-trans_left_vn-35819622 virtual network link through opserver 10.0.0.50
2025-08-07 19:17:39,497 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-08-07 19:17:39,513 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-82255929:ctest-trans_left_vn-35819622', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-82255929:ctest-trans_left_vn-35819622?flat'}
2025-08-07 19:17:39,513 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-82255929:ctest-trans_left_vn-35819622 virtual network link through opserver 10.0.0.241
2025-08-07 19:17:39,513 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2025-08-07 19:17:39,529 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-82255929:ctest-trans_left_vn-35819622', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-82255929:ctest-trans_left_vn-35819622?flat'}
2025-08-07 19:17:39,529 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-82255929:ctest-trans_left_vn-35819622 is found in opserver
2025-08-07 19:17:39,574 - DEBUG - Do not have enough data to verify VN in agent
2025-08-07 19:17:39,598 - DEBUG - VRF ids for VN ctest-trans_left_vn-35819622: {}
2025-08-07 19:17:39,879 - DEBUG - Response for create_network : {'network': {'id': '5eda6551-60cc-4726-ac6b-5fa3dde863a6', 'name': 'ctest-trans_right_vn-25868693', 'tenant_id': '40f7ace038f2438dae893ed206c0746c', 'project_id': '40f7ace038f2438dae893ed206c0746c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-82255929', 'ctest-trans_right_vn-25868693'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 19:17:40,132 - DEBUG - Response for create_subnet : {'subnet': {'id': '51e10363-47f4-41fc-bade-5364e678de25', 'name': '', 'tenant_id': '40f7ace038f2438dae893ed206c0746c', 'network_id': '5eda6551-60cc-4726-ac6b-5fa3dde863a6', 'ip_version': 4, 'cidr': '164.11.149.128/26', 'allocation_pools': [{'start': '164.11.149.130', 'end': '164.11.149.190'}], 'gateway_ip': '164.11.149.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '164.11.149.130', 'tags': [], 'project_id': '40f7ace038f2438dae893ed206c0746c'}}
2025-08-07 19:17:40,161 - INFO - Created VN ctest-trans_right_vn-25868693
2025-08-07 19:17:40,179 - DEBUG - VN ctest-trans_right_vn-25868693 UUID is 5eda6551-60cc-4726-ac6b-5fa3dde863a6
2025-08-07 19:17:40,274 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:40,282 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:40,299 - DEBUG - Requesting: http://10.0.0.19:8082/project/40f7ace0-38f2-438d-ae89-3ed206c0746c
2025-08-07 19:17:40,415 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/5eda6551-60cc-4726-ac6b-5fa3dde863a6
2025-08-07 19:17:40,431 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/5eda6551-60cc-4726-ac6b-5fa3dde863a6
2025-08-07 19:17:40,443 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7c6ed9b1-ccc0-4a9b-acf8-c9180baeb1b3
2025-08-07 19:17:40,456 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7c6ed9b1-ccc0-4a9b-acf8-c9180baeb1b3
2025-08-07 19:17:40,467 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/f81aee20-c9bf-4b5b-8d8b-91731aad8bf5
2025-08-07 19:17:40,478 - DEBUG - Route Targets: ['target:64512:8000010']
2025-08-07 19:17:40,479 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/5eda6551-60cc-4726-ac6b-5fa3dde863a6
2025-08-07 19:17:40,492 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7c6ed9b1-ccc0-4a9b-acf8-c9180baeb1b3
2025-08-07 19:17:40,516 - INFO - Verified VN network id 19 for VN 5eda6551-60cc-4726-ac6b-5fa3dde863a6
2025-08-07 19:17:40,516 - INFO - Verifications in API Server for VN ctest-trans_right_vn-25868693 passed
2025-08-07 19:17:40,516 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/5eda6551-60cc-4726-ac6b-5fa3dde863a6
2025-08-07 19:17:40,529 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7c6ed9b1-ccc0-4a9b-acf8-c9180baeb1b3
2025-08-07 19:17:40,539 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7c6ed9b1-ccc0-4a9b-acf8-c9180baeb1b3
2025-08-07 19:17:40,550 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/f81aee20-c9bf-4b5b-8d8b-91731aad8bf5
2025-08-07 19:17:40,567 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-82255929:ctest-trans_right_vn-25868693', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-82255929', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6834886784678905638', 'uuid-lslong': '12424129154438947750'}, 'enable': 'true', 'created': '2025-08-07T19:17:39', 'last-modified': '2025-08-07T19:17:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.478451'}
2025-08-07 19:17:40,575 - DEBUG - Route Targets: ['target:64512:8000010']
2025-08-07 19:17:40,582 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-82255929:ctest-trans_right_vn-25868693', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-82255929', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6834886784678905638', 'uuid-lslong': '12424129154438947750'}, 'enable': 'true', 'created': '2025-08-07T19:17:39', 'last-modified': '2025-08-07T19:17:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.498111'}
2025-08-07 19:17:40,589 - DEBUG - Route Targets: ['target:64512:8000010']
2025-08-07 19:17:40,595 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-82255929:ctest-trans_right_vn-25868693', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-82255929', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6834886784678905638', 'uuid-lslong': '12424129154438947750'}, 'enable': 'true', 'created': '2025-08-07T19:17:39', 'last-modified': '2025-08-07T19:17:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.517324'}
2025-08-07 19:17:40,602 - DEBUG - Route Targets: ['target:64512:8000010']
2025-08-07 19:17:40,602 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-25868693 passed
2025-08-07 19:17:40,603 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-25868693 in API_Server ======
2025-08-07 19:17:40,603 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:40,625 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:40,641 - DEBUG - Requesting: http://10.0.0.19:8082/project/40f7ace0-38f2-438d-ae89-3ed206c0746c
2025-08-07 19:17:40,761 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/5eda6551-60cc-4726-ac6b-5fa3dde863a6
2025-08-07 19:17:40,774 - DEBUG - =>VN ctest-trans_right_vn-25868693 has no policy to be verified
2025-08-07 19:17:40,774 - DEBUG - Verifying the vn in opserver
2025-08-07 19:17:40,774 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-82255929:ctest-trans_right_vn-25868693 virtual network link through opserver 10.0.0.19
2025-08-07 19:17:40,774 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-07 19:17:40,790 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-82255929:ctest-trans_right_vn-25868693', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-82255929:ctest-trans_right_vn-25868693?flat'}
2025-08-07 19:17:40,790 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-82255929:ctest-trans_right_vn-25868693 virtual network link through opserver 10.0.0.50
2025-08-07 19:17:40,790 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-08-07 19:17:40,808 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-82255929:ctest-trans_right_vn-25868693', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-82255929:ctest-trans_right_vn-25868693?flat'}
2025-08-07 19:17:40,808 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-82255929:ctest-trans_right_vn-25868693 virtual network link through opserver 10.0.0.241
2025-08-07 19:17:40,809 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2025-08-07 19:17:40,823 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-82255929:ctest-trans_right_vn-25868693', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-82255929:ctest-trans_right_vn-25868693?flat'}
2025-08-07 19:17:40,823 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-82255929:ctest-trans_right_vn-25868693 is found in opserver
2025-08-07 19:17:40,875 - DEBUG - Do not have enough data to verify VN in agent
2025-08-07 19:17:40,898 - DEBUG - VRF ids for VN ctest-trans_right_vn-25868693: {}
2025-08-07 19:17:42,112 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3775-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3775-2)
2025-08-07 19:17:43,876 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3775-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3775-1)
2025-08-07 19:17:43,876 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-98789775']
2025-08-07 19:17:44,199 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-98789775'] created succesfully
2025-08-07 19:17:44,744 - DEBUG - Image by name tiny_trans_fw not found
2025-08-07 19:17:44,744 - DEBUG - Installing image tiny_trans_fw
2025-08-07 19:17:44,744 - 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'}
2025-08-07 19:17:44,744 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2025-08-07 19:17:44,744 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2025-08-07 19:17:44,762 - 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
2025-08-07 19:17:44,805 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-08-07 19:17:44,805 - DEBUG - Unzip image
2025-08-07 19:17:44,805 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-08-07 19:17:44,828 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2025-08-07 19:17:44,829 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-98789775']
2025-08-07 19:17:44,944 - INFO - Service template: ['default-domain', 'ctest-service_template_1-98789775'] deleted successfully.
2025-08-07 19:17:44,944 - INFO - Skip interface_detach for VM ctest-right_vm-60957718 in state BUILD
2025-08-07 19:17:44,944 - INFO - Deleting VM ctest-right_vm-60957718
2025-08-07 19:17:44,944 - ERROR - VM ctest-right_vm-60957718 has failed to come up
2025-08-07 19:17:44,944 - ERROR - Nova failed to get host of the VM
2025-08-07 19:17:44,944 - ERROR - VM ctest-right_vm-60957718 has failed to come up
2025-08-07 19:17:44,944 - ERROR - Nova failed to get host of the VM
2025-08-07 19:17:45,051 - INFO - Skip interface_detach for VM ctest-left_vm-42285585 in state BUILD
2025-08-07 19:17:45,052 - INFO - Deleting VM ctest-left_vm-42285585
2025-08-07 19:17:45,052 - ERROR - VM ctest-left_vm-42285585 has failed to come up
2025-08-07 19:17:45,052 - ERROR - Nova failed to get host of the VM
2025-08-07 19:17:45,052 - ERROR - VM ctest-left_vm-42285585 has failed to come up
2025-08-07 19:17:45,052 - ERROR - Nova failed to get host of the VM
2025-08-07 19:17:45,155 - INFO - Deleting VN ctest-trans_right_vn-25868693
2025-08-07 19:17:45,357 - DEBUG - Response for deleting network ()
2025-08-07 19:17:45,358 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7c6ed9b1-ccc0-4a9b-acf8-c9180baeb1b3
2025-08-07 19:17:45,382 - DEBUG - Response Code: 404
2025-08-07 19:17:45,382 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:45,396 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:45,424 - DEBUG - Requesting: http://10.0.0.19:8082/project/40f7ace0-38f2-438d-ae89-3ed206c0746c
2025-08-07 19:17:45,548 - INFO - Validated that VN ctest-trans_right_vn-25868693 is not found in API Server
2025-08-07 19:17:45,572 - DEBUG - VN ctest-trans_right_vn-25868693 is not present in Agent 10.0.0.65
2025-08-07 19:17:45,592 - DEBUG - VN ctest-trans_right_vn-25868693 is not present in Agent 10.0.0.242
2025-08-07 19:17:45,592 - INFO - Validated that VN ctest-trans_right_vn-25868693 is not in any agent
2025-08-07 19:17:45,695 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-25868693 info
2025-08-07 19:17:45,695 - INFO - Deleting VN ctest-trans_left_vn-35819622
2025-08-07 19:17:45,929 - DEBUG - Response for deleting network ()
2025-08-07 19:17:45,929 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/2702cb24-55ba-467d-bcb0-ef5108f44cbd
2025-08-07 19:17:45,946 - DEBUG - Response Code: 404
2025-08-07 19:17:45,946 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:45,956 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:45,981 - DEBUG - Requesting: http://10.0.0.19:8082/project/40f7ace0-38f2-438d-ae89-3ed206c0746c
2025-08-07 19:17:46,134 - INFO - Validated that VN ctest-trans_left_vn-35819622 is not found in API Server
2025-08-07 19:17:46,158 - DEBUG - VN ctest-trans_left_vn-35819622 is not present in Agent 10.0.0.65
2025-08-07 19:17:46,204 - DEBUG - VN ctest-trans_left_vn-35819622 is not present in Agent 10.0.0.242
2025-08-07 19:17:46,204 - INFO - Validated that VN ctest-trans_left_vn-35819622 is not in any agent
2025-08-07 19:17:46,268 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-35819622 info
2025-08-07 19:17:46,268 - INFO - Deleting VN ctest-right_vn-99076620
2025-08-07 19:17:46,320 - DEBUG - VN 417861ff-ad67-489d-8311-315afc6550e7 still in use: Unable to complete operation on network 417861ff-ad67-489d-8311-315afc6550e7. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-9107084c-87fd-449b-b097-c2fad0dfffa9']
2025-08-07 19:17:46,320 - WARNING - Deleting VN ctest-right_vn-99076620 failed..Will retry
2025-08-07 19:17:48,494 - DEBUG - Response for deleting network ()
2025-08-07 19:17:48,494 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/fc0b708d-9376-4aa1-8536-5adf30c58800
2025-08-07 19:17:48,503 - DEBUG - Response Code: 404
2025-08-07 19:17:48,503 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:48,511 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:48,569 - DEBUG - Requesting: http://10.0.0.19:8082/project/40f7ace0-38f2-438d-ae89-3ed206c0746c
2025-08-07 19:17:48,674 - INFO - Validated that VN ctest-right_vn-99076620 is not found in API Server
2025-08-07 19:17:48,702 - DEBUG - VN ctest-right_vn-99076620 is not present in Agent 10.0.0.65
2025-08-07 19:17:48,717 - DEBUG - VN ctest-right_vn-99076620 is not present in Agent 10.0.0.242
2025-08-07 19:17:48,717 - INFO - Validated that VN ctest-right_vn-99076620 is not in any agent
2025-08-07 19:17:48,769 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-99076620 info
2025-08-07 19:17:48,769 - INFO - Deleting VN ctest-left_vn-73042560
2025-08-07 19:17:48,987 - DEBUG - Response for deleting network ()
2025-08-07 19:17:48,988 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/00a1874d-2a3f-483d-8132-408ad1db85f7
2025-08-07 19:17:48,997 - DEBUG - Response Code: 404
2025-08-07 19:17:48,997 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:49,008 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:49,023 - DEBUG - Requesting: http://10.0.0.19:8082/project/40f7ace0-38f2-438d-ae89-3ed206c0746c
2025-08-07 19:17:49,125 - INFO - Validated that VN ctest-left_vn-73042560 is not found in API Server
2025-08-07 19:17:49,155 - DEBUG - VN ctest-left_vn-73042560 is not present in Agent 10.0.0.65
2025-08-07 19:17:49,170 - DEBUG - VN ctest-left_vn-73042560 is not present in Agent 10.0.0.242
2025-08-07 19:17:49,170 - INFO - Validated that VN ctest-left_vn-73042560 is not in any agent
2025-08-07 19:17:49,216 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-73042560 info
2025-08-07 19:17:49,216 - INFO - Deleting VN ctest-mgmt_vn-01431940
2025-08-07 19:17:49,356 - DEBUG - Response for deleting network ()
2025-08-07 19:17:49,357 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/be552464-e44c-4e08-913b-661496317690
2025-08-07 19:17:49,364 - DEBUG - Response Code: 404
2025-08-07 19:17:49,364 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:49,372 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:49,404 - DEBUG - Requesting: http://10.0.0.19:8082/project/40f7ace0-38f2-438d-ae89-3ed206c0746c
2025-08-07 19:17:49,506 - INFO - Validated that VN ctest-mgmt_vn-01431940 is not found in API Server
2025-08-07 19:17:49,539 - DEBUG - VN ctest-mgmt_vn-01431940 is not present in Agent 10.0.0.65
2025-08-07 19:17:49,554 - DEBUG - VN ctest-mgmt_vn-01431940 is not present in Agent 10.0.0.242
2025-08-07 19:17:49,554 - INFO - Validated that VN ctest-mgmt_vn-01431940 is not in any agent
2025-08-07 19:17:49,604 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-01431940 info
2025-08-07 19:17:50,962 - DEBUG - No XMPP flaps were noticed during the test
2025-08-07 19:17:50,962 - INFO -
2025-08-07 19:17:50,962 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:18]
2025-08-07 19:17:50,962 - INFO - --------------------------------------------------------------------------------
2025-08-07 19:17:51,713 - INFO - Deleted project: ctest-TestSvcRegr-82255929, ID : 40f7ace0-38f2-438d-ae89-3ed206c0746c
2025-08-07 19:17:51,907 - INFO - Domain Default found not creating
2025-08-07 19:17:52,088 - INFO - Project ctest-TestSvcRegr-78941139 not found, creating it
2025-08-07 19:17:52,636 - INFO - Created Project:ctest-TestSvcRegr-78941139, ID : fdaea7a7-67b2-42ee-8087-12a8e1585be3
2025-08-07 19:17:54,237 - INFO - ================================================================================
2025-08-07 19:17:54,237 - INFO - STARTING TEST : test_svc_CEM_22032
2025-08-07 19:17:55,616 - DEBUG - Nothing to compare xmpp stats {'10.0.0.65': {'10.20.0.14': '0', '10.20.0.193': '0'}, '10.0.0.242': {'10.20.0.14': '0', '10.20.0.193': '0'}} with
2025-08-07 19:17:55,616 - INFO - Initial checks done. Running the testcase now
2025-08-07 19:17:55,617 - INFO -
2025-08-07 19:17:56,340 - DEBUG - Response for create_network : {'network': {'id': 'd3feb1de-735e-4f1c-bbb8-9735a8ed0616', 'name': 'ctest-mgmt_vn-77810872', 'tenant_id': 'fdaea7a767b242ee808712a8e1585be3', 'project_id': 'fdaea7a767b242ee808712a8e1585be3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-78941139', 'ctest-mgmt_vn-77810872'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 19:17:56,658 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a69b3e93-b81d-418a-a473-383f6f209917', 'name': '', 'tenant_id': 'fdaea7a767b242ee808712a8e1585be3', 'network_id': 'd3feb1de-735e-4f1c-bbb8-9735a8ed0616', 'ip_version': 4, 'cidr': '202.132.86.128/26', 'allocation_pools': [{'start': '202.132.86.130', 'end': '202.132.86.190'}], 'gateway_ip': '202.132.86.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '202.132.86.130', 'tags': [], 'project_id': 'fdaea7a767b242ee808712a8e1585be3'}}
2025-08-07 19:17:56,688 - INFO - Created VN ctest-mgmt_vn-77810872
2025-08-07 19:17:56,705 - DEBUG - VN ctest-mgmt_vn-77810872 UUID is d3feb1de-735e-4f1c-bbb8-9735a8ed0616
2025-08-07 19:17:56,792 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:57,094 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:57,127 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:57,146 - DEBUG - Requesting: http://10.0.0.19:8082/project/fdaea7a7-67b2-42ee-8087-12a8e1585be3
2025-08-07 19:17:57,261 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/d3feb1de-735e-4f1c-bbb8-9735a8ed0616
2025-08-07 19:17:57,276 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/d3feb1de-735e-4f1c-bbb8-9735a8ed0616
2025-08-07 19:17:57,287 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/4f016256-2d81-4019-865f-60a63d544ba5
2025-08-07 19:17:57,297 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/4f016256-2d81-4019-865f-60a63d544ba5
2025-08-07 19:17:57,306 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/7fbe8837-f8a1-45d8-ad0e-40b156833bdb
2025-08-07 19:17:57,314 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-07 19:17:57,314 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/d3feb1de-735e-4f1c-bbb8-9735a8ed0616
2025-08-07 19:17:57,326 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/4f016256-2d81-4019-865f-60a63d544ba5
2025-08-07 19:17:57,346 - INFO - Verified VN network id 15 for VN d3feb1de-735e-4f1c-bbb8-9735a8ed0616
2025-08-07 19:17:57,346 - INFO - Verifications in API Server for VN ctest-mgmt_vn-77810872 passed
2025-08-07 19:17:57,346 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/d3feb1de-735e-4f1c-bbb8-9735a8ed0616
2025-08-07 19:17:57,358 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/4f016256-2d81-4019-865f-60a63d544ba5
2025-08-07 19:17:57,369 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/4f016256-2d81-4019-865f-60a63d544ba5
2025-08-07 19:17:57,378 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/7fbe8837-f8a1-45d8-ad0e-40b156833bdb
2025-08-07 19:17:57,392 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-77810872', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-78941139', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15275842555063717660', 'uuid-lslong': '13526727737530451478'}, 'enable': 'true', 'created': '2025-08-07T19:17:56', 'last-modified': '2025-08-07T19:17:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.807003'}
2025-08-07 19:17:57,399 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-07 19:17:57,406 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-77810872', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-78941139', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15275842555063717660', 'uuid-lslong': '13526727737530451478'}, 'enable': 'true', 'created': '2025-08-07T19:17:56', 'last-modified': '2025-08-07T19:17:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.818854'}
2025-08-07 19:17:57,414 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-07 19:17:57,421 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-77810872', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-78941139', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15275842555063717660', 'uuid-lslong': '13526727737530451478'}, 'enable': 'true', 'created': '2025-08-07T19:17:56', 'last-modified': '2025-08-07T19:17:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.832865'}
2025-08-07 19:17:57,429 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-07 19:17:57,429 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-77810872 passed
2025-08-07 19:17:57,429 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-77810872 in API_Server ======
2025-08-07 19:17:57,429 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:57,439 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:57,453 - DEBUG - Requesting: http://10.0.0.19:8082/project/fdaea7a7-67b2-42ee-8087-12a8e1585be3
2025-08-07 19:17:57,560 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/d3feb1de-735e-4f1c-bbb8-9735a8ed0616
2025-08-07 19:17:57,575 - DEBUG - =>VN ctest-mgmt_vn-77810872 has no policy to be verified
2025-08-07 19:17:57,575 - DEBUG - Verifying the vn in opserver
2025-08-07 19:17:57,575 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-77810872 virtual network link through opserver 10.0.0.19
2025-08-07 19:17:57,575 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-07 19:17:57,875 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-07 19:17:57,946 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-77810872', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-77810872?flat'}
2025-08-07 19:17:57,947 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-77810872 virtual network link through opserver 10.0.0.50
2025-08-07 19:17:57,947 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-08-07 19:17:58,248 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-08-07 19:17:58,319 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-77810872', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-77810872?flat'}
2025-08-07 19:17:58,319 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-77810872 virtual network link through opserver 10.0.0.241
2025-08-07 19:17:58,319 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2025-08-07 19:17:58,644 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2025-08-07 19:17:58,705 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-77810872', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-77810872?flat'}
2025-08-07 19:17:58,705 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-77810872 is found in opserver
2025-08-07 19:17:58,748 - DEBUG - Do not have enough data to verify VN in agent
2025-08-07 19:17:58,774 - DEBUG - VRF ids for VN ctest-mgmt_vn-77810872: {}
2025-08-07 19:17:59,106 - DEBUG - Response for create_network : {'network': {'id': '7204fa1c-1692-4a5a-9a80-814d29864e61', 'name': 'service-left-vn-64755115', 'tenant_id': 'fdaea7a767b242ee808712a8e1585be3', 'project_id': 'fdaea7a767b242ee808712a8e1585be3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-78941139', 'service-left-vn-64755115'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 19:17:59,388 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e98ee573-d3a5-4c70-a21d-09bb107c50af', 'name': '', 'tenant_id': 'fdaea7a767b242ee808712a8e1585be3', 'network_id': '7204fa1c-1692-4a5a-9a80-814d29864e61', 'ip_version': 4, 'cidr': '5.149.228.192/26', 'allocation_pools': [{'start': '5.149.228.194', 'end': '5.149.228.254'}], 'gateway_ip': '5.149.228.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '5.149.228.194', 'tags': [], 'project_id': 'fdaea7a767b242ee808712a8e1585be3'}}
2025-08-07 19:17:59,414 - INFO - Created VN service-left-vn-64755115
2025-08-07 19:17:59,427 - DEBUG - VN service-left-vn-64755115 UUID is 7204fa1c-1692-4a5a-9a80-814d29864e61
2025-08-07 19:17:59,512 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:59,521 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:59,542 - DEBUG - Requesting: http://10.0.0.19:8082/project/fdaea7a7-67b2-42ee-8087-12a8e1585be3
2025-08-07 19:17:59,640 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/7204fa1c-1692-4a5a-9a80-814d29864e61
2025-08-07 19:17:59,656 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/7204fa1c-1692-4a5a-9a80-814d29864e61
2025-08-07 19:17:59,669 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/bf2c7acd-22e9-4d98-825d-6f2509185c39
2025-08-07 19:17:59,681 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/bf2c7acd-22e9-4d98-825d-6f2509185c39
2025-08-07 19:17:59,689 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/f310eda1-2d27-475a-8fe4-7cc64deaca25
2025-08-07 19:17:59,701 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-07 19:17:59,701 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/7204fa1c-1692-4a5a-9a80-814d29864e61
2025-08-07 19:17:59,715 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/bf2c7acd-22e9-4d98-825d-6f2509185c39
2025-08-07 19:17:59,734 - INFO - Verified VN network id 16 for VN 7204fa1c-1692-4a5a-9a80-814d29864e61
2025-08-07 19:17:59,734 - INFO - Verifications in API Server for VN service-left-vn-64755115 passed
2025-08-07 19:17:59,734 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/7204fa1c-1692-4a5a-9a80-814d29864e61
2025-08-07 19:17:59,748 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/bf2c7acd-22e9-4d98-825d-6f2509185c39
2025-08-07 19:17:59,757 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/bf2c7acd-22e9-4d98-825d-6f2509185c39
2025-08-07 19:17:59,766 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/f310eda1-2d27-475a-8fe4-7cc64deaca25
2025-08-07 19:17:59,782 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-78941139:service-left-vn-64755115', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-78941139', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8215966618775341658', 'uuid-lslong': '11133040447268998753'}, 'enable': 'true', 'created': '2025-08-07T19:17:59', 'last-modified': '2025-08-07T19:17:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.453796'}
2025-08-07 19:17:59,792 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-07 19:17:59,798 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-78941139:service-left-vn-64755115', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-78941139', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8215966618775341658', 'uuid-lslong': '11133040447268998753'}, 'enable': 'true', 'created': '2025-08-07T19:17:59', 'last-modified': '2025-08-07T19:17:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.471736'}
2025-08-07 19:17:59,805 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-07 19:17:59,813 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-78941139:service-left-vn-64755115', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-78941139', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8215966618775341658', 'uuid-lslong': '11133040447268998753'}, 'enable': 'true', 'created': '2025-08-07T19:17:59', 'last-modified': '2025-08-07T19:17:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.483723'}
2025-08-07 19:17:59,823 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-07 19:17:59,823 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-64755115 passed
2025-08-07 19:17:59,823 - DEBUG - ====Verifying policy data for service-left-vn-64755115 in API_Server ======
2025-08-07 19:17:59,823 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:17:59,832 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:17:59,848 - DEBUG - Requesting: http://10.0.0.19:8082/project/fdaea7a7-67b2-42ee-8087-12a8e1585be3
2025-08-07 19:17:59,938 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/7204fa1c-1692-4a5a-9a80-814d29864e61
2025-08-07 19:17:59,954 - DEBUG - =>VN service-left-vn-64755115 has no policy to be verified
2025-08-07 19:17:59,954 - DEBUG - Verifying the vn in opserver
2025-08-07 19:17:59,954 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-78941139:service-left-vn-64755115 virtual network link through opserver 10.0.0.19
2025-08-07 19:17:59,954 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-07 19:18:00,031 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-78941139:service-left-vn-64755115', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-78941139:service-left-vn-64755115?flat'}
2025-08-07 19:18:00,031 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-78941139:service-left-vn-64755115 virtual network link through opserver 10.0.0.50
2025-08-07 19:18:00,031 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-08-07 19:18:00,108 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-78941139:service-left-vn-64755115', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-78941139:service-left-vn-64755115?flat'}
2025-08-07 19:18:00,108 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-78941139:service-left-vn-64755115 virtual network link through opserver 10.0.0.241
2025-08-07 19:18:00,108 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2025-08-07 19:18:00,184 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-78941139:service-left-vn-64755115', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-78941139:service-left-vn-64755115?flat'}
2025-08-07 19:18:00,184 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-78941139:service-left-vn-64755115 is found in opserver
2025-08-07 19:18:00,235 - DEBUG - Do not have enough data to verify VN in agent
2025-08-07 19:18:00,251 - DEBUG - VRF ids for VN service-left-vn-64755115: {}
2025-08-07 19:18:00,590 - DEBUG - Response for create_network : {'network': {'id': 'bc3cf95d-5ca5-4e9c-a684-40ab2505d7bd', 'name': 'service-right-vn-54163371', 'tenant_id': 'fdaea7a767b242ee808712a8e1585be3', 'project_id': 'fdaea7a767b242ee808712a8e1585be3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-78941139', 'service-right-vn-54163371'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 19:18:00,851 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd29891de-d7e9-4c7d-a5c3-e3f628096a7e', 'name': '', 'tenant_id': 'fdaea7a767b242ee808712a8e1585be3', 'network_id': 'bc3cf95d-5ca5-4e9c-a684-40ab2505d7bd', 'ip_version': 4, 'cidr': '211.118.222.192/26', 'allocation_pools': [{'start': '211.118.222.194', 'end': '211.118.222.254'}], 'gateway_ip': '211.118.222.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '211.118.222.194', 'tags': [], 'project_id': 'fdaea7a767b242ee808712a8e1585be3'}}
2025-08-07 19:18:00,884 - INFO - Created VN service-right-vn-54163371
2025-08-07 19:18:00,909 - DEBUG - VN service-right-vn-54163371 UUID is bc3cf95d-5ca5-4e9c-a684-40ab2505d7bd
2025-08-07 19:18:01,024 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:18:01,040 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:18:01,065 - DEBUG - Requesting: http://10.0.0.19:8082/project/fdaea7a7-67b2-42ee-8087-12a8e1585be3
2025-08-07 19:18:01,182 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/bc3cf95d-5ca5-4e9c-a684-40ab2505d7bd
2025-08-07 19:18:01,203 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/bc3cf95d-5ca5-4e9c-a684-40ab2505d7bd
2025-08-07 19:18:01,219 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/780857c1-9d26-4ae5-9a8e-009f5936f1e8
2025-08-07 19:18:01,232 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/780857c1-9d26-4ae5-9a8e-009f5936f1e8
2025-08-07 19:18:01,247 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/ada4ff61-84ea-441a-9249-1d505962fb8f
2025-08-07 19:18:01,260 - DEBUG - Route Targets: ['target:64512:8000008']
2025-08-07 19:18:01,260 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/bc3cf95d-5ca5-4e9c-a684-40ab2505d7bd
2025-08-07 19:18:01,277 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/780857c1-9d26-4ae5-9a8e-009f5936f1e8
2025-08-07 19:18:01,302 - INFO - Verified VN network id 17 for VN bc3cf95d-5ca5-4e9c-a684-40ab2505d7bd
2025-08-07 19:18:01,302 - INFO - Verifications in API Server for VN service-right-vn-54163371 passed
2025-08-07 19:18:01,302 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/bc3cf95d-5ca5-4e9c-a684-40ab2505d7bd
2025-08-07 19:18:01,318 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/780857c1-9d26-4ae5-9a8e-009f5936f1e8
2025-08-07 19:18:01,336 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/780857c1-9d26-4ae5-9a8e-009f5936f1e8
2025-08-07 19:18:01,348 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/ada4ff61-84ea-441a-9249-1d505962fb8f
2025-08-07 19:18:01,369 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-78941139:service-right-vn-54163371', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-78941139', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13563990357114703516', 'uuid-lslong': '11998786411026569149'}, 'enable': 'true', 'created': '2025-08-07T19:18:00', 'last-modified': '2025-08-07T19:18:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.598388'}
2025-08-07 19:18:01,379 - DEBUG - Route Targets: ['target:64512:8000008']
2025-08-07 19:18:01,396 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-78941139:service-right-vn-54163371', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-78941139', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13563990357114703516', 'uuid-lslong': '11998786411026569149'}, 'enable': 'true', 'created': '2025-08-07T19:18:00', 'last-modified': '2025-08-07T19:18:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.624445'}
2025-08-07 19:18:01,409 - DEBUG - Route Targets: ['target:64512:8000008']
2025-08-07 19:18:01,419 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-78941139:service-right-vn-54163371', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-78941139', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13563990357114703516', 'uuid-lslong': '11998786411026569149'}, 'enable': 'true', 'created': '2025-08-07T19:18:00', 'last-modified': '2025-08-07T19:18:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.649341'}
2025-08-07 19:18:01,440 - DEBUG - Route Targets: ['target:64512:8000008']
2025-08-07 19:18:01,441 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-54163371 passed
2025-08-07 19:18:01,441 - DEBUG - ====Verifying policy data for service-right-vn-54163371 in API_Server ======
2025-08-07 19:18:01,441 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:18:01,453 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:18:01,481 - DEBUG - Requesting: http://10.0.0.19:8082/project/fdaea7a7-67b2-42ee-8087-12a8e1585be3
2025-08-07 19:18:01,628 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/bc3cf95d-5ca5-4e9c-a684-40ab2505d7bd
2025-08-07 19:18:01,644 - DEBUG - =>VN service-right-vn-54163371 has no policy to be verified
2025-08-07 19:18:01,644 - DEBUG - Verifying the vn in opserver
2025-08-07 19:18:01,644 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-78941139:service-right-vn-54163371 virtual network link through opserver 10.0.0.19
2025-08-07 19:18:01,644 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-07 19:18:01,717 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-78941139:service-right-vn-54163371', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-78941139:service-right-vn-54163371?flat'}
2025-08-07 19:18:01,717 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-78941139:service-right-vn-54163371 virtual network link through opserver 10.0.0.50
2025-08-07 19:18:01,717 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-08-07 19:18:01,788 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-78941139:service-right-vn-54163371', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-78941139:service-right-vn-54163371?flat'}
2025-08-07 19:18:01,788 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-78941139:service-right-vn-54163371 virtual network link through opserver 10.0.0.241
2025-08-07 19:18:01,788 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2025-08-07 19:18:01,851 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-78941139:service-right-vn-54163371', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-78941139:service-right-vn-54163371?flat'}
2025-08-07 19:18:01,851 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-78941139:service-right-vn-54163371 is found in opserver
2025-08-07 19:18:01,894 - DEBUG - Do not have enough data to verify VN in agent
2025-08-07 19:18:01,909 - DEBUG - VRF ids for VN service-right-vn-54163371: {}
2025-08-07 19:18:02,027 - DEBUG - Services list from nova: [, , , ]
2025-08-07 19:18:03,315 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3775-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3775-2)
2025-08-07 19:18:05,268 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3775-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3775-1)
2025-08-07 19:18:05,268 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-46269128']
2025-08-07 19:18:05,592 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-46269128'] created succesfully
2025-08-07 19:18:06,028 - DEBUG - Image by name tiny_nat_fw not found
2025-08-07 19:18:06,028 - DEBUG - Installing image tiny_nat_fw
2025-08-07 19:18:06,028 - 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'"}
2025-08-07 19:18:06,028 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-08-07 19:18:06,028 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-08-07 19:18:06,028 - DEBUG - Unzip image
2025-08-07 19:18:06,028 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-08-07 19:18:06,078 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2025-08-07 19:18:06,079 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-46269128']
2025-08-07 19:18:06,215 - INFO - Service template: ['default-domain', 'ctest-service_template_1-46269128'] deleted successfully.
2025-08-07 19:18:06,215 - INFO - Skip interface_detach for VM ctest-right_vm-88786360 in state BUILD
2025-08-07 19:18:06,215 - INFO - Deleting VM ctest-right_vm-88786360
2025-08-07 19:18:06,264 - ERROR - VM ctest-right_vm-88786360 has failed to come up
2025-08-07 19:18:06,264 - ERROR - Nova failed to get host of the VM
2025-08-07 19:18:06,264 - ERROR - VM ctest-right_vm-88786360 has failed to come up
2025-08-07 19:18:06,264 - ERROR - Nova failed to get host of the VM
2025-08-07 19:18:06,446 - INFO - Skip interface_detach for VM ctest-left_vm-28367501 in state BUILD
2025-08-07 19:18:06,446 - INFO - Deleting VM ctest-left_vm-28367501
2025-08-07 19:18:06,446 - ERROR - VM ctest-left_vm-28367501 has failed to come up
2025-08-07 19:18:06,446 - ERROR - Nova failed to get host of the VM
2025-08-07 19:18:06,446 - ERROR - VM ctest-left_vm-28367501 has failed to come up
2025-08-07 19:18:06,446 - ERROR - Nova failed to get host of the VM
2025-08-07 19:18:06,614 - INFO - Deleting VN service-right-vn-54163371
2025-08-07 19:18:06,716 - DEBUG - VN bc3cf95d-5ca5-4e9c-a684-40ab2505d7bd still in use: Unable to complete operation on network bc3cf95d-5ca5-4e9c-a684-40ab2505d7bd. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-22e8106a-d194-43b9-86df-ab8700794129']
2025-08-07 19:18:06,716 - WARNING - Deleting VN service-right-vn-54163371 failed..Will retry
2025-08-07 19:18:08,922 - DEBUG - Response for deleting network ()
2025-08-07 19:18:08,922 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/780857c1-9d26-4ae5-9a8e-009f5936f1e8
2025-08-07 19:18:08,931 - DEBUG - Response Code: 404
2025-08-07 19:18:08,931 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:18:08,952 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:18:08,979 - DEBUG - Requesting: http://10.0.0.19:8082/project/fdaea7a7-67b2-42ee-8087-12a8e1585be3
2025-08-07 19:18:09,101 - INFO - Validated that VN service-right-vn-54163371 is not found in API Server
2025-08-07 19:18:09,125 - DEBUG - VN service-right-vn-54163371 is not present in Agent 10.0.0.65
2025-08-07 19:18:09,147 - DEBUG - VN service-right-vn-54163371 is not present in Agent 10.0.0.242
2025-08-07 19:18:09,147 - INFO - Validated that VN service-right-vn-54163371 is not in any agent
2025-08-07 19:18:09,198 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-54163371 info
2025-08-07 19:18:09,198 - INFO - Deleting VN service-left-vn-64755115
2025-08-07 19:18:09,403 - DEBUG - Response for deleting network ()
2025-08-07 19:18:09,404 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/bf2c7acd-22e9-4d98-825d-6f2509185c39
2025-08-07 19:18:09,421 - DEBUG - Response Code: 404
2025-08-07 19:18:09,421 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:18:09,437 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:18:09,454 - DEBUG - Requesting: http://10.0.0.19:8082/project/fdaea7a7-67b2-42ee-8087-12a8e1585be3
2025-08-07 19:18:09,581 - INFO - Validated that VN service-left-vn-64755115 is not found in API Server
2025-08-07 19:18:09,607 - DEBUG - VN service-left-vn-64755115 is not present in Agent 10.0.0.65
2025-08-07 19:18:09,624 - DEBUG - VN service-left-vn-64755115 is not present in Agent 10.0.0.242
2025-08-07 19:18:09,624 - INFO - Validated that VN service-left-vn-64755115 is not in any agent
2025-08-07 19:18:09,682 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-64755115 info
2025-08-07 19:18:09,682 - INFO - Deleting VN ctest-mgmt_vn-77810872
2025-08-07 19:18:09,851 - DEBUG - Response for deleting network ()
2025-08-07 19:18:09,851 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/4f016256-2d81-4019-865f-60a63d544ba5
2025-08-07 19:18:09,867 - DEBUG - Response Code: 404
2025-08-07 19:18:09,868 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:18:09,875 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:18:09,891 - DEBUG - Requesting: http://10.0.0.19:8082/project/fdaea7a7-67b2-42ee-8087-12a8e1585be3
2025-08-07 19:18:09,987 - INFO - Validated that VN ctest-mgmt_vn-77810872 is not found in API Server
2025-08-07 19:18:10,019 - DEBUG - VN ctest-mgmt_vn-77810872 is not present in Agent 10.0.0.65
2025-08-07 19:18:10,033 - DEBUG - VN ctest-mgmt_vn-77810872 is not present in Agent 10.0.0.242
2025-08-07 19:18:10,033 - INFO - Validated that VN ctest-mgmt_vn-77810872 is not in any agent
2025-08-07 19:18:10,074 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-77810872 info
2025-08-07 19:18:11,390 - DEBUG - No XMPP flaps were noticed during the test
2025-08-07 19:18:11,390 - INFO -
2025-08-07 19:18:11,390 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:17]
2025-08-07 19:18:11,390 - INFO - --------------------------------------------------------------------------------
2025-08-07 19:18:11,394 - INFO - ================================================================================
2025-08-07 19:18:11,394 - INFO - STARTING TEST : test_svc_in_network_datapath
2025-08-07 19:18:12,749 - DEBUG - Nothing to compare xmpp stats {'10.0.0.65': {'10.20.0.14': '0', '10.20.0.193': '0'}, '10.0.0.242': {'10.20.0.14': '0', '10.20.0.193': '0'}} with
2025-08-07 19:18:12,749 - INFO - Initial checks done. Running the testcase now
2025-08-07 19:18:12,749 - INFO -
2025-08-07 19:18:13,085 - DEBUG - Response for create_network : {'network': {'id': 'b62b2fd5-7e1f-4eed-b0b5-a3729690b41e', 'name': 'ctest-mgmt_vn-81528164', 'tenant_id': 'fdaea7a767b242ee808712a8e1585be3', 'project_id': 'fdaea7a767b242ee808712a8e1585be3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-78941139', 'ctest-mgmt_vn-81528164'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 19:18:13,354 - DEBUG - Response for create_subnet : {'subnet': {'id': '2dc369d8-dbdd-4ca8-a3e5-23533e55cdac', 'name': '', 'tenant_id': 'fdaea7a767b242ee808712a8e1585be3', 'network_id': 'b62b2fd5-7e1f-4eed-b0b5-a3729690b41e', 'ip_version': 4, 'cidr': '205.25.160.64/26', 'allocation_pools': [{'start': '205.25.160.66', 'end': '205.25.160.126'}], 'gateway_ip': '205.25.160.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '205.25.160.66', 'tags': [], 'project_id': 'fdaea7a767b242ee808712a8e1585be3'}}
2025-08-07 19:18:13,379 - INFO - Created VN ctest-mgmt_vn-81528164
2025-08-07 19:18:13,392 - DEBUG - VN ctest-mgmt_vn-81528164 UUID is b62b2fd5-7e1f-4eed-b0b5-a3729690b41e
2025-08-07 19:18:13,486 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:18:13,496 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:18:13,515 - DEBUG - Requesting: http://10.0.0.19:8082/project/fdaea7a7-67b2-42ee-8087-12a8e1585be3
2025-08-07 19:18:13,649 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/b62b2fd5-7e1f-4eed-b0b5-a3729690b41e
2025-08-07 19:18:13,679 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/b62b2fd5-7e1f-4eed-b0b5-a3729690b41e
2025-08-07 19:18:13,692 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/8d93bf2b-050e-4222-b24a-5d7633deb64c
2025-08-07 19:18:13,702 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/8d93bf2b-050e-4222-b24a-5d7633deb64c
2025-08-07 19:18:13,712 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/be07fae2-efad-49be-9b75-7ad62db97b38
2025-08-07 19:18:13,721 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-07 19:18:13,721 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/b62b2fd5-7e1f-4eed-b0b5-a3729690b41e
2025-08-07 19:18:13,734 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/8d93bf2b-050e-4222-b24a-5d7633deb64c
2025-08-07 19:18:13,754 - INFO - Verified VN network id 15 for VN b62b2fd5-7e1f-4eed-b0b5-a3729690b41e
2025-08-07 19:18:13,754 - INFO - Verifications in API Server for VN ctest-mgmt_vn-81528164 passed
2025-08-07 19:18:13,754 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/b62b2fd5-7e1f-4eed-b0b5-a3729690b41e
2025-08-07 19:18:13,766 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/8d93bf2b-050e-4222-b24a-5d7633deb64c
2025-08-07 19:18:13,778 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/8d93bf2b-050e-4222-b24a-5d7633deb64c
2025-08-07 19:18:13,789 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/be07fae2-efad-49be-9b75-7ad62db97b38
2025-08-07 19:18:13,807 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-81528164', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-78941139', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13126638132891963117', 'uuid-lslong': '12733263234007610398'}, 'enable': 'true', 'created': '2025-08-07T19:18:12', 'last-modified': '2025-08-07T19:18:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.494974'}
2025-08-07 19:18:13,814 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-07 19:18:13,821 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-81528164', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-78941139', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13126638132891963117', 'uuid-lslong': '12733263234007610398'}, 'enable': 'true', 'created': '2025-08-07T19:18:12', 'last-modified': '2025-08-07T19:18:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.510911'}
2025-08-07 19:18:13,828 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-07 19:18:13,836 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-81528164', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-78941139', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13126638132891963117', 'uuid-lslong': '12733263234007610398'}, 'enable': 'true', 'created': '2025-08-07T19:18:12', 'last-modified': '2025-08-07T19:18:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.532143'}
2025-08-07 19:18:13,844 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-07 19:18:13,844 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-81528164 passed
2025-08-07 19:18:13,844 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-81528164 in API_Server ======
2025-08-07 19:18:13,844 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:18:13,851 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:18:13,866 - DEBUG - Requesting: http://10.0.0.19:8082/project/fdaea7a7-67b2-42ee-8087-12a8e1585be3
2025-08-07 19:18:13,962 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/b62b2fd5-7e1f-4eed-b0b5-a3729690b41e
2025-08-07 19:18:13,975 - DEBUG - =>VN ctest-mgmt_vn-81528164 has no policy to be verified
2025-08-07 19:18:13,976 - DEBUG - Verifying the vn in opserver
2025-08-07 19:18:13,976 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-81528164 virtual network link through opserver 10.0.0.19
2025-08-07 19:18:13,976 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-07 19:18:13,992 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-81528164', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-81528164?flat'}
2025-08-07 19:18:13,992 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-81528164 virtual network link through opserver 10.0.0.50
2025-08-07 19:18:13,992 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-08-07 19:18:14,007 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-81528164', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-81528164?flat'}
2025-08-07 19:18:14,007 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-81528164 virtual network link through opserver 10.0.0.241
2025-08-07 19:18:14,007 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2025-08-07 19:18:14,022 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-81528164', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-81528164?flat'}
2025-08-07 19:18:14,022 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-78941139:ctest-mgmt_vn-81528164 is found in opserver
2025-08-07 19:18:14,060 - DEBUG - Do not have enough data to verify VN in agent
2025-08-07 19:18:14,084 - DEBUG - VRF ids for VN ctest-mgmt_vn-81528164: {}
2025-08-07 19:18:14,406 - DEBUG - Response for create_network : {'network': {'id': 'd3e30be4-d0e5-4dc2-9848-2aff8d0546c3', 'name': 'ctest-left_vn-88775601', 'tenant_id': 'fdaea7a767b242ee808712a8e1585be3', 'project_id': 'fdaea7a767b242ee808712a8e1585be3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-78941139', 'ctest-left_vn-88775601'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 19:18:14,697 - DEBUG - Response for create_subnet : {'subnet': {'id': 'fe54e6a7-a17e-4932-bd9f-9ba7176a72d9', 'name': '', 'tenant_id': 'fdaea7a767b242ee808712a8e1585be3', 'network_id': 'd3e30be4-d0e5-4dc2-9848-2aff8d0546c3', 'ip_version': 4, 'cidr': '95.121.187.128/26', 'allocation_pools': [{'start': '95.121.187.130', 'end': '95.121.187.190'}], 'gateway_ip': '95.121.187.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '95.121.187.130', 'tags': [], 'project_id': 'fdaea7a767b242ee808712a8e1585be3'}}
2025-08-07 19:18:14,725 - INFO - Created VN ctest-left_vn-88775601
2025-08-07 19:18:14,743 - DEBUG - VN ctest-left_vn-88775601 UUID is d3e30be4-d0e5-4dc2-9848-2aff8d0546c3
2025-08-07 19:18:14,829 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:18:14,838 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:18:14,857 - DEBUG - Requesting: http://10.0.0.19:8082/project/fdaea7a7-67b2-42ee-8087-12a8e1585be3
2025-08-07 19:18:14,956 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/d3e30be4-d0e5-4dc2-9848-2aff8d0546c3
2025-08-07 19:18:14,984 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/d3e30be4-d0e5-4dc2-9848-2aff8d0546c3
2025-08-07 19:18:14,999 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/28257c5d-1149-4ae9-a875-a9847da341fb
2025-08-07 19:18:15,013 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/28257c5d-1149-4ae9-a875-a9847da341fb
2025-08-07 19:18:15,025 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/7d349d17-9d26-4372-96a9-f4fb11c88ed5
2025-08-07 19:18:15,034 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-07 19:18:15,034 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/d3e30be4-d0e5-4dc2-9848-2aff8d0546c3
2025-08-07 19:18:15,047 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/28257c5d-1149-4ae9-a875-a9847da341fb
2025-08-07 19:18:15,068 - INFO - Verified VN network id 16 for VN d3e30be4-d0e5-4dc2-9848-2aff8d0546c3
2025-08-07 19:18:15,069 - INFO - Verifications in API Server for VN ctest-left_vn-88775601 passed
2025-08-07 19:18:15,069 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/d3e30be4-d0e5-4dc2-9848-2aff8d0546c3
2025-08-07 19:18:15,084 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/28257c5d-1149-4ae9-a875-a9847da341fb
2025-08-07 19:18:15,093 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/28257c5d-1149-4ae9-a875-a9847da341fb
2025-08-07 19:18:15,105 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/7d349d17-9d26-4372-96a9-f4fb11c88ed5
2025-08-07 19:18:15,121 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-78941139:ctest-left_vn-88775601', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-78941139', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15268060239101251010', 'uuid-lslong': '10973067769159173827'}, 'enable': 'true', 'created': '2025-08-07T19:18:14', 'last-modified': '2025-08-07T19:18:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.489172'}
2025-08-07 19:18:15,131 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-07 19:18:15,138 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-78941139:ctest-left_vn-88775601', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-78941139', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15268060239101251010', 'uuid-lslong': '10973067769159173827'}, 'enable': 'true', 'created': '2025-08-07T19:18:14', 'last-modified': '2025-08-07T19:18:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.508783'}
2025-08-07 19:18:15,146 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-07 19:18:15,152 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-78941139:ctest-left_vn-88775601', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-78941139', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15268060239101251010', 'uuid-lslong': '10973067769159173827'}, 'enable': 'true', 'created': '2025-08-07T19:18:14', 'last-modified': '2025-08-07T19:18:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.523873'}
2025-08-07 19:18:15,162 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-07 19:18:15,162 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-88775601 passed
2025-08-07 19:18:15,162 - DEBUG - ====Verifying policy data for ctest-left_vn-88775601 in API_Server ======
2025-08-07 19:18:15,162 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:18:15,171 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:18:15,191 - DEBUG - Requesting: http://10.0.0.19:8082/project/fdaea7a7-67b2-42ee-8087-12a8e1585be3
2025-08-07 19:18:15,295 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/d3e30be4-d0e5-4dc2-9848-2aff8d0546c3
2025-08-07 19:18:15,315 - DEBUG - =>VN ctest-left_vn-88775601 has no policy to be verified
2025-08-07 19:18:15,315 - DEBUG - Verifying the vn in opserver
2025-08-07 19:18:15,315 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-78941139:ctest-left_vn-88775601 virtual network link through opserver 10.0.0.19
2025-08-07 19:18:15,315 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-07 19:18:15,339 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-78941139:ctest-left_vn-88775601', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-78941139:ctest-left_vn-88775601?flat'}
2025-08-07 19:18:15,339 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-78941139:ctest-left_vn-88775601 virtual network link through opserver 10.0.0.50
2025-08-07 19:18:15,339 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-08-07 19:18:15,356 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-78941139:ctest-left_vn-88775601', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-78941139:ctest-left_vn-88775601?flat'}
2025-08-07 19:18:15,356 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-78941139:ctest-left_vn-88775601 virtual network link through opserver 10.0.0.241
2025-08-07 19:18:15,357 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2025-08-07 19:18:15,373 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-78941139:ctest-left_vn-88775601', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-78941139:ctest-left_vn-88775601?flat'}
2025-08-07 19:18:15,373 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-78941139:ctest-left_vn-88775601 is found in opserver
2025-08-07 19:18:15,422 - DEBUG - Do not have enough data to verify VN in agent
2025-08-07 19:18:15,445 - DEBUG - VRF ids for VN ctest-left_vn-88775601: {}
2025-08-07 19:18:15,758 - DEBUG - Response for create_network : {'network': {'id': 'fd1d4806-63f9-4416-ac20-da46406bea24', 'name': 'ctest-right_vn-21742861', 'tenant_id': 'fdaea7a767b242ee808712a8e1585be3', 'project_id': 'fdaea7a767b242ee808712a8e1585be3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-78941139', 'ctest-right_vn-21742861'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 19:18:16,014 - DEBUG - Response for create_subnet : {'subnet': {'id': '2e833c1c-7331-484d-a951-c87835cbdac4', 'name': '', 'tenant_id': 'fdaea7a767b242ee808712a8e1585be3', 'network_id': 'fd1d4806-63f9-4416-ac20-da46406bea24', 'ip_version': 4, 'cidr': '144.79.13.192/26', 'allocation_pools': [{'start': '144.79.13.194', 'end': '144.79.13.254'}], 'gateway_ip': '144.79.13.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '144.79.13.194', 'tags': [], 'project_id': 'fdaea7a767b242ee808712a8e1585be3'}}
2025-08-07 19:18:16,042 - INFO - Created VN ctest-right_vn-21742861
2025-08-07 19:18:16,060 - DEBUG - VN ctest-right_vn-21742861 UUID is fd1d4806-63f9-4416-ac20-da46406bea24
2025-08-07 19:18:16,142 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:18:16,150 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:18:16,165 - DEBUG - Requesting: http://10.0.0.19:8082/project/fdaea7a7-67b2-42ee-8087-12a8e1585be3
2025-08-07 19:18:16,267 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/fd1d4806-63f9-4416-ac20-da46406bea24
2025-08-07 19:18:16,286 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/fd1d4806-63f9-4416-ac20-da46406bea24
2025-08-07 19:18:16,298 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/1b3bf9c2-ed5e-4a17-a3ac-8eb8327cc8ec
2025-08-07 19:18:16,307 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/1b3bf9c2-ed5e-4a17-a3ac-8eb8327cc8ec
2025-08-07 19:18:16,316 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/57f549f5-1a05-4785-8eaa-2eb1b0eb8ade
2025-08-07 19:18:16,326 - DEBUG - Route Targets: ['target:64512:8000008']
2025-08-07 19:18:16,326 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/fd1d4806-63f9-4416-ac20-da46406bea24
2025-08-07 19:18:16,341 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/1b3bf9c2-ed5e-4a17-a3ac-8eb8327cc8ec
2025-08-07 19:18:16,363 - INFO - Verified VN network id 17 for VN fd1d4806-63f9-4416-ac20-da46406bea24
2025-08-07 19:18:16,363 - INFO - Verifications in API Server for VN ctest-right_vn-21742861 passed
2025-08-07 19:18:16,363 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/fd1d4806-63f9-4416-ac20-da46406bea24
2025-08-07 19:18:16,383 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/1b3bf9c2-ed5e-4a17-a3ac-8eb8327cc8ec
2025-08-07 19:18:16,398 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/1b3bf9c2-ed5e-4a17-a3ac-8eb8327cc8ec
2025-08-07 19:18:16,414 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/57f549f5-1a05-4785-8eaa-2eb1b0eb8ade
2025-08-07 19:18:16,432 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-78941139:ctest-right_vn-21742861', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-78941139', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18238813258204660758', 'uuid-lslong': '12403153369041725988'}, 'enable': 'true', 'created': '2025-08-07T19:18:15', 'last-modified': '2025-08-07T19:18:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.491608'}
2025-08-07 19:18:16,442 - DEBUG - Route Targets: ['target:64512:8000008']
2025-08-07 19:18:16,449 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-78941139:ctest-right_vn-21742861', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-78941139', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18238813258204660758', 'uuid-lslong': '12403153369041725988'}, 'enable': 'true', 'created': '2025-08-07T19:18:15', 'last-modified': '2025-08-07T19:18:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.510354'}
2025-08-07 19:18:16,456 - DEBUG - Route Targets: ['target:64512:8000008']
2025-08-07 19:18:16,463 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-78941139:ctest-right_vn-21742861', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-78941139', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18238813258204660758', 'uuid-lslong': '12403153369041725988'}, 'enable': 'true', 'created': '2025-08-07T19:18:15', 'last-modified': '2025-08-07T19:18:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.519821'}
2025-08-07 19:18:16,470 - DEBUG - Route Targets: ['target:64512:8000008']
2025-08-07 19:18:16,470 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-21742861 passed
2025-08-07 19:18:16,470 - DEBUG - ====Verifying policy data for ctest-right_vn-21742861 in API_Server ======
2025-08-07 19:18:16,470 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:18:16,479 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:18:16,496 - DEBUG - Requesting: http://10.0.0.19:8082/project/fdaea7a7-67b2-42ee-8087-12a8e1585be3
2025-08-07 19:18:16,610 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/fd1d4806-63f9-4416-ac20-da46406bea24
2025-08-07 19:18:16,625 - DEBUG - =>VN ctest-right_vn-21742861 has no policy to be verified
2025-08-07 19:18:16,625 - DEBUG - Verifying the vn in opserver
2025-08-07 19:18:16,625 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-78941139:ctest-right_vn-21742861 virtual network link through opserver 10.0.0.19
2025-08-07 19:18:16,625 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-07 19:18:16,640 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-78941139:ctest-right_vn-21742861', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-78941139:ctest-right_vn-21742861?flat'}
2025-08-07 19:18:16,640 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-78941139:ctest-right_vn-21742861 virtual network link through opserver 10.0.0.50
2025-08-07 19:18:16,640 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-08-07 19:18:16,655 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-78941139:ctest-right_vn-21742861', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-78941139:ctest-right_vn-21742861?flat'}
2025-08-07 19:18:16,655 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-78941139:ctest-right_vn-21742861 virtual network link through opserver 10.0.0.241
2025-08-07 19:18:16,655 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks
2025-08-07 19:18:16,672 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-78941139:ctest-right_vn-21742861', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-78941139:ctest-right_vn-21742861?flat'}
2025-08-07 19:18:16,672 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-78941139:ctest-right_vn-21742861 is found in opserver
2025-08-07 19:18:16,717 - DEBUG - Do not have enough data to verify VN in agent
2025-08-07 19:18:16,738 - DEBUG - VRF ids for VN ctest-right_vn-21742861: {}
2025-08-07 19:18:17,971 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3775-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3775-1)
2025-08-07 19:18:19,655 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3775-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3775-2)
2025-08-07 19:18:19,655 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-15824099']
2025-08-07 19:18:19,999 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-15824099'] created succesfully
2025-08-07 19:18:20,397 - DEBUG - Image by name tiny_nat_fw not found
2025-08-07 19:18:20,397 - DEBUG - Installing image tiny_nat_fw
2025-08-07 19:18:20,397 - 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'"}
2025-08-07 19:18:20,397 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-08-07 19:18:20,398 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-08-07 19:18:20,398 - DEBUG - Unzip image
2025-08-07 19:18:20,398 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-08-07 19:18:20,417 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2025-08-07 19:18:20,418 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-15824099']
2025-08-07 19:18:20,522 - INFO - Service template: ['default-domain', 'ctest-service_template_1-15824099'] deleted successfully.
2025-08-07 19:18:20,523 - INFO - Skip interface_detach for VM ctest-right_vm-54867118 in state BUILD
2025-08-07 19:18:20,523 - INFO - Deleting VM ctest-right_vm-54867118
2025-08-07 19:18:20,523 - ERROR - VM ctest-right_vm-54867118 has failed to come up
2025-08-07 19:18:20,523 - ERROR - Nova failed to get host of the VM
2025-08-07 19:18:20,523 - ERROR - VM ctest-right_vm-54867118 has failed to come up
2025-08-07 19:18:20,524 - ERROR - Nova failed to get host of the VM
2025-08-07 19:18:20,662 - INFO - Skip interface_detach for VM ctest-left_vm-61348736 in state BUILD
2025-08-07 19:18:20,663 - INFO - Deleting VM ctest-left_vm-61348736
2025-08-07 19:18:20,663 - ERROR - VM ctest-left_vm-61348736 has failed to come up
2025-08-07 19:18:20,663 - ERROR - Nova failed to get host of the VM
2025-08-07 19:18:20,663 - ERROR - VM ctest-left_vm-61348736 has failed to come up
2025-08-07 19:18:20,663 - ERROR - Nova failed to get host of the VM
2025-08-07 19:18:20,750 - INFO - Deleting VN ctest-right_vn-21742861
2025-08-07 19:18:20,797 - DEBUG - VN fd1d4806-63f9-4416-ac20-da46406bea24 still in use: Unable to complete operation on network fd1d4806-63f9-4416-ac20-da46406bea24. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-b57d7bc4-861e-4c65-b55c-bb591ab3a129']
2025-08-07 19:18:20,797 - WARNING - Deleting VN ctest-right_vn-21742861 failed..Will retry
2025-08-07 19:18:22,994 - DEBUG - Response for deleting network ()
2025-08-07 19:18:22,994 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/1b3bf9c2-ed5e-4a17-a3ac-8eb8327cc8ec
2025-08-07 19:18:23,003 - DEBUG - Response Code: 404
2025-08-07 19:18:23,004 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:18:23,015 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:18:23,045 - DEBUG - Requesting: http://10.0.0.19:8082/project/fdaea7a7-67b2-42ee-8087-12a8e1585be3
2025-08-07 19:18:23,169 - INFO - Validated that VN ctest-right_vn-21742861 is not found in API Server
2025-08-07 19:18:23,200 - DEBUG - VN ctest-right_vn-21742861 is not present in Agent 10.0.0.65
2025-08-07 19:18:23,215 - DEBUG - VN ctest-right_vn-21742861 is not present in Agent 10.0.0.242
2025-08-07 19:18:23,216 - INFO - Validated that VN ctest-right_vn-21742861 is not in any agent
2025-08-07 19:18:23,269 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-21742861 info
2025-08-07 19:18:23,269 - INFO - Deleting VN ctest-left_vn-88775601
2025-08-07 19:18:23,452 - DEBUG - Response for deleting network ()
2025-08-07 19:18:23,453 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/28257c5d-1149-4ae9-a875-a9847da341fb
2025-08-07 19:18:23,460 - DEBUG - Response Code: 404
2025-08-07 19:18:23,460 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:18:23,466 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:18:23,499 - DEBUG - Requesting: http://10.0.0.19:8082/project/fdaea7a7-67b2-42ee-8087-12a8e1585be3
2025-08-07 19:18:23,601 - INFO - Validated that VN ctest-left_vn-88775601 is not found in API Server
2025-08-07 19:18:23,632 - DEBUG - VN ctest-left_vn-88775601 is not present in Agent 10.0.0.65
2025-08-07 19:18:23,647 - DEBUG - VN ctest-left_vn-88775601 is not present in Agent 10.0.0.242
2025-08-07 19:18:23,647 - INFO - Validated that VN ctest-left_vn-88775601 is not in any agent
2025-08-07 19:18:23,698 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-88775601 info
2025-08-07 19:18:23,698 - INFO - Deleting VN ctest-mgmt_vn-81528164
2025-08-07 19:18:23,877 - DEBUG - Response for deleting network ()
2025-08-07 19:18:23,877 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/8d93bf2b-050e-4222-b24a-5d7633deb64c
2025-08-07 19:18:23,885 - DEBUG - Response Code: 404
2025-08-07 19:18:23,885 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-07 19:18:23,893 - DEBUG - Requesting: http://10.0.0.19:8082/domain/e058ca0e-02ca-4506-8888-1a040ca13521
2025-08-07 19:18:23,926 - DEBUG - Requesting: http://10.0.0.19:8082/project/fdaea7a7-67b2-42ee-8087-12a8e1585be3
2025-08-07 19:18:24,050 - INFO - Validated that VN ctest-mgmt_vn-81528164 is not found in API Server
2025-08-07 19:18:24,073 - DEBUG - VN ctest-mgmt_vn-81528164 is not present in Agent 10.0.0.65
2025-08-07 19:18:24,089 - DEBUG - VN ctest-mgmt_vn-81528164 is not present in Agent 10.0.0.242
2025-08-07 19:18:24,089 - INFO - Validated that VN ctest-mgmt_vn-81528164 is not in any agent
2025-08-07 19:18:24,132 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-81528164 info
2025-08-07 19:18:25,459 - DEBUG - No XMPP flaps were noticed during the test
2025-08-07 19:18:25,459 - INFO -
2025-08-07 19:18:25,459 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:14]
2025-08-07 19:18:25,459 - INFO - --------------------------------------------------------------------------------
2025-08-07 19:18:26,222 - INFO - Deleted project: ctest-TestSvcRegr-78941139, ID : fdaea7a7-67b2-42ee-8087-12a8e1585be3