]) created on node: (an-jenkins-deploy-platform-ansible-os-5167-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5167-1)
2026-02-02 03:09:26,224 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-15669623']
2026-02-02 03:09:26,507 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-15669623'] created succesfully
2026-02-02 03:09:26,882 - DEBUG - Image by name tiny_nat_fw not found
2026-02-02 03:09:26,882 - DEBUG - Installing image tiny_nat_fw
2026-02-02 03:09:26,882 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-02-02 03:09:26,882 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-02-02 03:09:26,882 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-02-02 03:09:26,908 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz -O /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-02 03:09:26,974 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-02 03:09:26,974 - DEBUG - Unzip image
2026-02-02 03:09:26,974 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-02 03:09:27,007 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-02-02 03:09:27,009 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-15669623']
2026-02-02 03:09:27,109 - INFO - Service template: ['default-domain', 'ctest-service_template_1-15669623'] deleted successfully.
2026-02-02 03:09:27,109 - INFO - Skip interface_detach for VM ctest-right_vm-68645175 in state BUILD
2026-02-02 03:09:27,109 - INFO - Deleting VM ctest-right_vm-68645175
2026-02-02 03:09:27,140 - ERROR - VM ctest-right_vm-68645175 has failed to come up
2026-02-02 03:09:27,140 - ERROR - Nova failed to get host of the VM
2026-02-02 03:09:27,140 - ERROR - VM ctest-right_vm-68645175 has failed to come up
2026-02-02 03:09:27,140 - ERROR - Nova failed to get host of the VM
2026-02-02 03:09:27,217 - INFO - Skip interface_detach for VM ctest-left_vm-15816232 in state BUILD
2026-02-02 03:09:27,217 - INFO - Deleting VM ctest-left_vm-15816232
2026-02-02 03:09:27,217 - ERROR - VM ctest-left_vm-15816232 has failed to come up
2026-02-02 03:09:27,217 - ERROR - Nova failed to get host of the VM
2026-02-02 03:09:27,217 - ERROR - VM ctest-left_vm-15816232 has failed to come up
2026-02-02 03:09:27,218 - ERROR - Nova failed to get host of the VM
2026-02-02 03:09:27,287 - INFO - Deleting VN ctest-right_vn-24415336
2026-02-02 03:09:27,338 - DEBUG - VN b9b50e21-7358-44be-9e6e-796a308d2a41 still in use: Unable to complete operation on network b9b50e21-7358-44be-9e6e-796a308d2a41. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-53c0aec7-7a4e-4766-a97f-1eb3190d0d4c']
2026-02-02 03:09:27,339 - WARNING - Deleting VN ctest-right_vn-24415336 failed..Will retry
2026-02-02 03:09:29,511 - DEBUG - Response for deleting network ()
2026-02-02 03:09:29,511 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/c5e457ad-11aa-4c7c-993a-4780e0cc7468
2026-02-02 03:09:29,519 - DEBUG - Response Code: 404
2026-02-02 03:09:29,519 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:09:29,532 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:09:29,593 - DEBUG - Requesting: http://10.0.0.141:8082/project/e8608734-68da-4861-815a-77514dac48ce
2026-02-02 03:09:29,685 - INFO - Validated that VN ctest-right_vn-24415336 is not found in API Server
2026-02-02 03:09:29,695 - DEBUG - VN ctest-right_vn-24415336 is not present in Agent 10.0.0.50
2026-02-02 03:09:29,705 - DEBUG - VN ctest-right_vn-24415336 is not present in Agent 10.0.0.65
2026-02-02 03:09:29,705 - INFO - Validated that VN ctest-right_vn-24415336 is not in any agent
2026-02-02 03:09:29,734 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-24415336 info
2026-02-02 03:09:29,734 - INFO - Deleting VN ctest-left_vn-38196593
2026-02-02 03:09:29,890 - DEBUG - Response for deleting network ()
2026-02-02 03:09:29,890 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/a54c9081-ebd4-4995-bf1d-a7b0087a636d
2026-02-02 03:09:29,895 - DEBUG - Response Code: 404
2026-02-02 03:09:29,896 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:09:29,915 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:09:29,971 - DEBUG - Requesting: http://10.0.0.141:8082/project/e8608734-68da-4861-815a-77514dac48ce
2026-02-02 03:09:30,066 - INFO - Validated that VN ctest-left_vn-38196593 is not found in API Server
2026-02-02 03:09:30,077 - DEBUG - VN ctest-left_vn-38196593 is not present in Agent 10.0.0.50
2026-02-02 03:09:30,087 - DEBUG - VN ctest-left_vn-38196593 is not present in Agent 10.0.0.65
2026-02-02 03:09:30,087 - INFO - Validated that VN ctest-left_vn-38196593 is not in any agent
2026-02-02 03:09:30,120 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-38196593 info
2026-02-02 03:09:30,120 - INFO - Deleting VN ctest-mgmt_vn-49307244
2026-02-02 03:09:30,289 - DEBUG - Response for deleting network ()
2026-02-02 03:09:30,289 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/3a3b7211-0fd3-48d9-b22b-498534ac2c91
2026-02-02 03:09:30,295 - DEBUG - Response Code: 404
2026-02-02 03:09:30,295 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:09:30,306 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:09:30,328 - DEBUG - Requesting: http://10.0.0.141:8082/project/e8608734-68da-4861-815a-77514dac48ce
2026-02-02 03:09:30,421 - INFO - Validated that VN ctest-mgmt_vn-49307244 is not found in API Server
2026-02-02 03:09:30,434 - DEBUG - VN ctest-mgmt_vn-49307244 is not present in Agent 10.0.0.50
2026-02-02 03:09:30,444 - DEBUG - VN ctest-mgmt_vn-49307244 is not present in Agent 10.0.0.65
2026-02-02 03:09:30,444 - INFO - Validated that VN ctest-mgmt_vn-49307244 is not in any agent
2026-02-02 03:09:30,480 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-49307244 info
2026-02-02 03:09:30,481 - INFO - Deleting VM ctest-vm-in-third-vn-20448439
2026-02-02 03:09:30,556 - INFO - Deleting VN ctest-third-vn-74659765
2026-02-02 03:09:30,601 - DEBUG - VN d603b3bb-5a1c-47e5-aca0-47fe62f24950 still in use: Unable to complete operation on network d603b3bb-5a1c-47e5-aca0-47fe62f24950. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-d2b4dea4-2f0c-4b90-87b2-6a047699658a']
2026-02-02 03:09:30,601 - WARNING - Deleting VN ctest-third-vn-74659765 failed..Will retry
2026-02-02 03:09:32,754 - DEBUG - Response for deleting network ()
2026-02-02 03:09:34,050 - DEBUG - No XMPP flaps were noticed during the test
2026-02-02 03:09:34,050 - INFO -
2026-02-02 03:09:34,050 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:24]
2026-02-02 03:09:34,050 - INFO - --------------------------------------------------------------------------------
2026-02-02 03:09:34,053 - INFO - ================================================================================
2026-02-02 03:09:34,053 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2026-02-02 03:09:35,324 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.17': '0', '10.20.0.193': '0'}, '10.0.0.65': {'10.20.0.193': '0', '10.20.0.129': '0'}} with
2026-02-02 03:09:35,324 - INFO - Initial checks done. Running the testcase now
2026-02-02 03:09:35,324 - INFO -
2026-02-02 03:09:35,556 - DEBUG - Response for create_network : {'network': {'id': '7764799d-6245-4992-9420-f28d7956bdaa', 'name': 'ctest-mgmt_vn-56389614', 'tenant_id': 'e860873468da4861815a77514dac48ce', 'project_id': 'e860873468da4861815a77514dac48ce', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-57680494', 'ctest-mgmt_vn-56389614'], 'port_security_enabled': True, 'description': ''}}
2026-02-02 03:09:35,814 - DEBUG - Response for create_subnet : {'subnet': {'id': '90e7a8af-3c73-4818-8030-3824f40c71b9', 'name': '', 'tenant_id': 'e860873468da4861815a77514dac48ce', 'network_id': '7764799d-6245-4992-9420-f28d7956bdaa', 'ip_version': 4, 'cidr': '183.33.0.0/26', 'allocation_pools': [{'start': '183.33.0.2', 'end': '183.33.0.62'}], 'gateway_ip': '183.33.0.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '183.33.0.2', 'tags': [], 'project_id': 'e860873468da4861815a77514dac48ce'}}
2026-02-02 03:09:35,835 - INFO - Created VN ctest-mgmt_vn-56389614
2026-02-02 03:09:35,852 - DEBUG - VN ctest-mgmt_vn-56389614 UUID is 7764799d-6245-4992-9420-f28d7956bdaa
2026-02-02 03:09:35,937 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:09:35,942 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:09:35,953 - DEBUG - Requesting: http://10.0.0.141:8082/project/e8608734-68da-4861-815a-77514dac48ce
2026-02-02 03:09:36,035 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/7764799d-6245-4992-9420-f28d7956bdaa
2026-02-02 03:09:36,051 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/7764799d-6245-4992-9420-f28d7956bdaa
2026-02-02 03:09:36,064 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/043927ab-82cf-4a9e-b5fe-48e4f624e60c
2026-02-02 03:09:36,080 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/043927ab-82cf-4a9e-b5fe-48e4f624e60c
2026-02-02 03:09:36,096 - DEBUG - Route Targets: []
2026-02-02 03:09:36,096 - DEBUG - RT names not yet present for VN ctest-mgmt_vn-56389614
2026-02-02 03:09:41,097 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:09:41,104 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:09:41,116 - DEBUG - Requesting: http://10.0.0.141:8082/project/e8608734-68da-4861-815a-77514dac48ce
2026-02-02 03:09:41,209 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/7764799d-6245-4992-9420-f28d7956bdaa
2026-02-02 03:09:41,218 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/7764799d-6245-4992-9420-f28d7956bdaa
2026-02-02 03:09:41,228 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/043927ab-82cf-4a9e-b5fe-48e4f624e60c
2026-02-02 03:09:41,237 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/043927ab-82cf-4a9e-b5fe-48e4f624e60c
2026-02-02 03:09:41,244 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/3c1d7c71-8290-4d82-9fae-63ee3d02f962
2026-02-02 03:09:41,251 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-02 03:09:41,251 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/7764799d-6245-4992-9420-f28d7956bdaa
2026-02-02 03:09:41,260 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/043927ab-82cf-4a9e-b5fe-48e4f624e60c
2026-02-02 03:09:41,274 - INFO - Verified VN network id 10 for VN 7764799d-6245-4992-9420-f28d7956bdaa
2026-02-02 03:09:41,275 - INFO - Verifications in API Server for VN ctest-mgmt_vn-56389614 passed
2026-02-02 03:09:41,275 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/7764799d-6245-4992-9420-f28d7956bdaa
2026-02-02 03:09:41,286 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/043927ab-82cf-4a9e-b5fe-48e4f624e60c
2026-02-02 03:09:41,294 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/043927ab-82cf-4a9e-b5fe-48e4f624e60c
2026-02-02 03:09:41,303 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/3c1d7c71-8290-4d82-9fae-63ee3d02f962
2026-02-02 03:09:41,316 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57680494:ctest-mgmt_vn-56389614', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57680494', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8603134905050024338', 'uuid-lslong': '10673797806308113834'}, 'enable': 'true', 'created': '2026-02-02T03:09:35', 'last-modified': '2026-02-02T03:09:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.567213'}
2026-02-02 03:09:41,321 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-02 03:09:41,326 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57680494:ctest-mgmt_vn-56389614', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57680494', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8603134905050024338', 'uuid-lslong': '10673797806308113834'}, 'enable': 'true', 'created': '2026-02-02T03:09:35', 'last-modified': '2026-02-02T03:09:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.578206'}
2026-02-02 03:09:41,332 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-02 03:09:41,337 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57680494:ctest-mgmt_vn-56389614', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57680494', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8603134905050024338', 'uuid-lslong': '10673797806308113834'}, 'enable': 'true', 'created': '2026-02-02T03:09:35', 'last-modified': '2026-02-02T03:09:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.592969'}
2026-02-02 03:09:41,343 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-02 03:09:41,343 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-56389614 passed
2026-02-02 03:09:41,343 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-56389614 in API_Server ======
2026-02-02 03:09:41,343 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:09:41,349 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:09:41,360 - DEBUG - Requesting: http://10.0.0.141:8082/project/e8608734-68da-4861-815a-77514dac48ce
2026-02-02 03:09:41,448 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/7764799d-6245-4992-9420-f28d7956bdaa
2026-02-02 03:09:41,457 - DEBUG - =>VN ctest-mgmt_vn-56389614 has no policy to be verified
2026-02-02 03:09:41,457 - DEBUG - Verifying the vn in opserver
2026-02-02 03:09:41,457 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57680494:ctest-mgmt_vn-56389614 virtual network link through opserver 10.0.0.141
2026-02-02 03:09:41,457 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-02-02 03:09:41,469 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57680494:ctest-mgmt_vn-56389614', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57680494:ctest-mgmt_vn-56389614?flat'}
2026-02-02 03:09:41,469 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57680494:ctest-mgmt_vn-56389614 virtual network link through opserver 10.0.0.22
2026-02-02 03:09:41,469 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-02 03:09:41,480 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57680494:ctest-mgmt_vn-56389614', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57680494:ctest-mgmt_vn-56389614?flat'}
2026-02-02 03:09:41,480 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57680494:ctest-mgmt_vn-56389614 virtual network link through opserver 10.0.0.23
2026-02-02 03:09:41,480 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-02 03:09:41,492 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57680494:ctest-mgmt_vn-56389614', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57680494:ctest-mgmt_vn-56389614?flat'}
2026-02-02 03:09:41,492 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-57680494:ctest-mgmt_vn-56389614 is found in opserver
2026-02-02 03:09:41,513 - DEBUG - Do not have enough data to verify VN in agent
2026-02-02 03:09:41,521 - DEBUG - VRF ids for VN ctest-mgmt_vn-56389614: {}
2026-02-02 03:09:41,777 - DEBUG - Response for create_network : {'network': {'id': '376e571d-0746-4727-b4d8-6f3bcf6dc6d4', 'name': 'ctest-left_vn-50850852', 'tenant_id': 'e860873468da4861815a77514dac48ce', 'project_id': 'e860873468da4861815a77514dac48ce', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-57680494', 'ctest-left_vn-50850852'], 'port_security_enabled': True, 'description': ''}}
2026-02-02 03:09:42,018 - DEBUG - Response for create_subnet : {'subnet': {'id': '67238ccd-f6de-47c0-81c7-997f0f9c86d0', 'name': '', 'tenant_id': 'e860873468da4861815a77514dac48ce', 'network_id': '376e571d-0746-4727-b4d8-6f3bcf6dc6d4', 'ip_version': 4, 'cidr': '41.251.32.128/26', 'allocation_pools': [{'start': '41.251.32.130', 'end': '41.251.32.190'}], 'gateway_ip': '41.251.32.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '41.251.32.130', 'tags': [], 'project_id': 'e860873468da4861815a77514dac48ce'}}
2026-02-02 03:09:42,039 - INFO - Created VN ctest-left_vn-50850852
2026-02-02 03:09:42,049 - DEBUG - VN ctest-left_vn-50850852 UUID is 376e571d-0746-4727-b4d8-6f3bcf6dc6d4
2026-02-02 03:09:42,125 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:09:42,131 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:09:42,145 - DEBUG - Requesting: http://10.0.0.141:8082/project/e8608734-68da-4861-815a-77514dac48ce
2026-02-02 03:09:42,241 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/376e571d-0746-4727-b4d8-6f3bcf6dc6d4
2026-02-02 03:09:42,254 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/376e571d-0746-4727-b4d8-6f3bcf6dc6d4
2026-02-02 03:09:42,266 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/5b5426b4-dd38-42a9-b31b-fd76032fffeb
2026-02-02 03:09:42,277 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/5b5426b4-dd38-42a9-b31b-fd76032fffeb
2026-02-02 03:09:42,287 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/adc8af3d-7890-409c-9c6d-fbb66f29f1b6
2026-02-02 03:09:42,294 - DEBUG - Route Targets: ['target:64512:8000005']
2026-02-02 03:09:42,294 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/376e571d-0746-4727-b4d8-6f3bcf6dc6d4
2026-02-02 03:09:42,306 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/5b5426b4-dd38-42a9-b31b-fd76032fffeb
2026-02-02 03:09:42,323 - INFO - Verified VN network id 11 for VN 376e571d-0746-4727-b4d8-6f3bcf6dc6d4
2026-02-02 03:09:42,323 - INFO - Verifications in API Server for VN ctest-left_vn-50850852 passed
2026-02-02 03:09:42,323 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/376e571d-0746-4727-b4d8-6f3bcf6dc6d4
2026-02-02 03:09:42,336 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/5b5426b4-dd38-42a9-b31b-fd76032fffeb
2026-02-02 03:09:42,344 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/5b5426b4-dd38-42a9-b31b-fd76032fffeb
2026-02-02 03:09:42,353 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/adc8af3d-7890-409c-9c6d-fbb66f29f1b6
2026-02-02 03:09:42,367 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57680494:ctest-left_vn-50850852', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57680494', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3994225701711922983', 'uuid-lslong': '13031287824470361812'}, 'enable': 'true', 'created': '2026-02-02T03:09:41', 'last-modified': '2026-02-02T03:09:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.398697'}
2026-02-02 03:09:42,374 - DEBUG - Route Targets: ['target:64512:8000005']
2026-02-02 03:09:42,380 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57680494:ctest-left_vn-50850852', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57680494', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3994225701711922983', 'uuid-lslong': '13031287824470361812'}, 'enable': 'true', 'created': '2026-02-02T03:09:41', 'last-modified': '2026-02-02T03:09:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.417312'}
2026-02-02 03:09:42,385 - DEBUG - Route Targets: ['target:64512:8000005']
2026-02-02 03:09:42,391 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57680494:ctest-left_vn-50850852', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57680494', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3994225701711922983', 'uuid-lslong': '13031287824470361812'}, 'enable': 'true', 'created': '2026-02-02T03:09:41', 'last-modified': '2026-02-02T03:09:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.426467'}
2026-02-02 03:09:42,397 - DEBUG - Route Targets: ['target:64512:8000005']
2026-02-02 03:09:42,397 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-50850852 passed
2026-02-02 03:09:42,398 - DEBUG - ====Verifying policy data for ctest-left_vn-50850852 in API_Server ======
2026-02-02 03:09:42,398 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:09:42,405 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:09:42,417 - DEBUG - Requesting: http://10.0.0.141:8082/project/e8608734-68da-4861-815a-77514dac48ce
2026-02-02 03:09:42,516 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/376e571d-0746-4727-b4d8-6f3bcf6dc6d4
2026-02-02 03:09:42,529 - DEBUG - =>VN ctest-left_vn-50850852 has no policy to be verified
2026-02-02 03:09:42,529 - DEBUG - Verifying the vn in opserver
2026-02-02 03:09:42,529 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57680494:ctest-left_vn-50850852 virtual network link through opserver 10.0.0.141
2026-02-02 03:09:42,529 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-02-02 03:09:42,550 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57680494:ctest-left_vn-50850852', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57680494:ctest-left_vn-50850852?flat'}
2026-02-02 03:09:42,550 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57680494:ctest-left_vn-50850852 virtual network link through opserver 10.0.0.22
2026-02-02 03:09:42,550 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-02 03:09:42,562 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57680494:ctest-left_vn-50850852', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57680494:ctest-left_vn-50850852?flat'}
2026-02-02 03:09:42,562 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57680494:ctest-left_vn-50850852 virtual network link through opserver 10.0.0.23
2026-02-02 03:09:42,562 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-02 03:09:42,573 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57680494:ctest-left_vn-50850852', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57680494:ctest-left_vn-50850852?flat'}
2026-02-02 03:09:42,573 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-57680494:ctest-left_vn-50850852 is found in opserver
2026-02-02 03:09:42,594 - DEBUG - Do not have enough data to verify VN in agent
2026-02-02 03:09:42,604 - DEBUG - VRF ids for VN ctest-left_vn-50850852: {}
2026-02-02 03:09:42,862 - DEBUG - Response for create_network : {'network': {'id': '02844e70-9b97-46be-9e5c-4a9e47782481', 'name': 'ctest-right_vn-66541531', 'tenant_id': 'e860873468da4861815a77514dac48ce', 'project_id': 'e860873468da4861815a77514dac48ce', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-57680494', 'ctest-right_vn-66541531'], 'port_security_enabled': True, 'description': ''}}
2026-02-02 03:09:43,037 - DEBUG - Response for create_subnet : {'subnet': {'id': '6d6c78fb-6f0a-47d1-90bc-4b7a0dc83da0', 'name': '', 'tenant_id': 'e860873468da4861815a77514dac48ce', 'network_id': '02844e70-9b97-46be-9e5c-4a9e47782481', 'ip_version': 4, 'cidr': '187.41.203.0/26', 'allocation_pools': [{'start': '187.41.203.2', 'end': '187.41.203.62'}], 'gateway_ip': '187.41.203.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '187.41.203.2', 'tags': [], 'project_id': 'e860873468da4861815a77514dac48ce'}}
2026-02-02 03:09:43,066 - INFO - Created VN ctest-right_vn-66541531
2026-02-02 03:09:43,078 - DEBUG - VN ctest-right_vn-66541531 UUID is 02844e70-9b97-46be-9e5c-4a9e47782481
2026-02-02 03:09:43,163 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:09:43,170 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:09:43,182 - DEBUG - Requesting: http://10.0.0.141:8082/project/e8608734-68da-4861-815a-77514dac48ce
2026-02-02 03:09:43,317 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/02844e70-9b97-46be-9e5c-4a9e47782481
2026-02-02 03:09:43,329 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/02844e70-9b97-46be-9e5c-4a9e47782481
2026-02-02 03:09:43,338 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/c512bd2a-19bf-4dc1-95cb-1f76ca4d3e11
2026-02-02 03:09:43,350 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/c512bd2a-19bf-4dc1-95cb-1f76ca4d3e11
2026-02-02 03:09:43,358 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/ac5727c3-14c4-42a6-b015-8252c5a9d5d9
2026-02-02 03:09:43,371 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-02 03:09:43,371 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/02844e70-9b97-46be-9e5c-4a9e47782481
2026-02-02 03:09:43,389 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/c512bd2a-19bf-4dc1-95cb-1f76ca4d3e11
2026-02-02 03:09:43,409 - INFO - Verified VN network id 12 for VN 02844e70-9b97-46be-9e5c-4a9e47782481
2026-02-02 03:09:43,410 - INFO - Verifications in API Server for VN ctest-right_vn-66541531 passed
2026-02-02 03:09:43,410 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/02844e70-9b97-46be-9e5c-4a9e47782481
2026-02-02 03:09:43,422 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/c512bd2a-19bf-4dc1-95cb-1f76ca4d3e11
2026-02-02 03:09:43,431 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/c512bd2a-19bf-4dc1-95cb-1f76ca4d3e11
2026-02-02 03:09:43,438 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/ac5727c3-14c4-42a6-b015-8252c5a9d5d9
2026-02-02 03:09:43,451 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57680494:ctest-right_vn-66541531', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57680494', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '181356130555348670', 'uuid-lslong': '11411077599514338433'}, 'enable': 'true', 'created': '2026-02-02T03:09:42', 'last-modified': '2026-02-02T03:09:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.463540'}
2026-02-02 03:09:43,458 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-02 03:09:43,464 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57680494:ctest-right_vn-66541531', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57680494', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '181356130555348670', 'uuid-lslong': '11411077599514338433'}, 'enable': 'true', 'created': '2026-02-02T03:09:42', 'last-modified': '2026-02-02T03:09:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.476800'}
2026-02-02 03:09:43,470 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-02 03:09:43,477 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57680494:ctest-right_vn-66541531', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57680494', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '181356130555348670', 'uuid-lslong': '11411077599514338433'}, 'enable': 'true', 'created': '2026-02-02T03:09:42', 'last-modified': '2026-02-02T03:09:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.489871'}
2026-02-02 03:09:43,483 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-02 03:09:43,483 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-66541531 passed
2026-02-02 03:09:43,483 - DEBUG - ====Verifying policy data for ctest-right_vn-66541531 in API_Server ======
2026-02-02 03:09:43,483 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:09:43,489 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:09:43,500 - DEBUG - Requesting: http://10.0.0.141:8082/project/e8608734-68da-4861-815a-77514dac48ce
2026-02-02 03:09:43,591 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/02844e70-9b97-46be-9e5c-4a9e47782481
2026-02-02 03:09:43,599 - DEBUG - =>VN ctest-right_vn-66541531 has no policy to be verified
2026-02-02 03:09:43,599 - DEBUG - Verifying the vn in opserver
2026-02-02 03:09:43,599 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57680494:ctest-right_vn-66541531 virtual network link through opserver 10.0.0.141
2026-02-02 03:09:43,599 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-02-02 03:09:43,611 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57680494:ctest-right_vn-66541531', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57680494:ctest-right_vn-66541531?flat'}
2026-02-02 03:09:43,611 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57680494:ctest-right_vn-66541531 virtual network link through opserver 10.0.0.22
2026-02-02 03:09:43,611 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-02 03:09:43,623 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57680494:ctest-right_vn-66541531', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57680494:ctest-right_vn-66541531?flat'}
2026-02-02 03:09:43,623 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57680494:ctest-right_vn-66541531 virtual network link through opserver 10.0.0.23
2026-02-02 03:09:43,623 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-02 03:09:43,634 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57680494:ctest-right_vn-66541531', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57680494:ctest-right_vn-66541531?flat'}
2026-02-02 03:09:43,634 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-57680494:ctest-right_vn-66541531 is found in opserver
2026-02-02 03:09:43,655 - DEBUG - Do not have enough data to verify VN in agent
2026-02-02 03:09:43,665 - DEBUG - VRF ids for VN ctest-right_vn-66541531: {}
2026-02-02 03:09:43,915 - DEBUG - Response for create_network : {'network': {'id': '7eadc35a-7194-4230-a3ed-da9df2871d5d', 'name': 'ctest-trans_left_vn-97888229', 'tenant_id': 'e860873468da4861815a77514dac48ce', 'project_id': 'e860873468da4861815a77514dac48ce', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-57680494', 'ctest-trans_left_vn-97888229'], 'port_security_enabled': True, 'description': ''}}
2026-02-02 03:09:44,134 - DEBUG - Response for create_subnet : {'subnet': {'id': '8cb40887-77fd-49c7-b2f1-a9d5fe389deb', 'name': '', 'tenant_id': 'e860873468da4861815a77514dac48ce', 'network_id': '7eadc35a-7194-4230-a3ed-da9df2871d5d', 'ip_version': 4, 'cidr': '55.233.32.0/26', 'allocation_pools': [{'start': '55.233.32.2', 'end': '55.233.32.62'}], 'gateway_ip': '55.233.32.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '55.233.32.2', 'tags': [], 'project_id': 'e860873468da4861815a77514dac48ce'}}
2026-02-02 03:09:44,153 - INFO - Created VN ctest-trans_left_vn-97888229
2026-02-02 03:09:44,166 - DEBUG - VN ctest-trans_left_vn-97888229 UUID is 7eadc35a-7194-4230-a3ed-da9df2871d5d
2026-02-02 03:09:44,233 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:09:44,239 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:09:44,249 - DEBUG - Requesting: http://10.0.0.141:8082/project/e8608734-68da-4861-815a-77514dac48ce
2026-02-02 03:09:44,338 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/7eadc35a-7194-4230-a3ed-da9df2871d5d
2026-02-02 03:09:44,357 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/7eadc35a-7194-4230-a3ed-da9df2871d5d
2026-02-02 03:09:44,367 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/52f3d765-6fe5-41db-b882-db734f122022
2026-02-02 03:09:44,375 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/52f3d765-6fe5-41db-b882-db734f122022
2026-02-02 03:09:44,383 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/5f821680-044a-491d-aae5-37b65e6020a4
2026-02-02 03:09:44,392 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-02 03:09:44,392 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/7eadc35a-7194-4230-a3ed-da9df2871d5d
2026-02-02 03:09:44,401 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/52f3d765-6fe5-41db-b882-db734f122022
2026-02-02 03:09:44,416 - INFO - Verified VN network id 13 for VN 7eadc35a-7194-4230-a3ed-da9df2871d5d
2026-02-02 03:09:44,416 - INFO - Verifications in API Server for VN ctest-trans_left_vn-97888229 passed
2026-02-02 03:09:44,416 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/7eadc35a-7194-4230-a3ed-da9df2871d5d
2026-02-02 03:09:44,427 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/52f3d765-6fe5-41db-b882-db734f122022
2026-02-02 03:09:44,437 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/52f3d765-6fe5-41db-b882-db734f122022
2026-02-02 03:09:44,446 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/5f821680-044a-491d-aae5-37b65e6020a4
2026-02-02 03:09:44,457 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57680494:ctest-trans_left_vn-97888229', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57680494', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9128166812969878064', 'uuid-lslong': '11812337769576340829'}, 'enable': 'true', 'created': '2026-02-02T03:09:43', 'last-modified': '2026-02-02T03:09:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.369655'}
2026-02-02 03:09:44,464 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-02 03:09:44,470 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57680494:ctest-trans_left_vn-97888229', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57680494', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9128166812969878064', 'uuid-lslong': '11812337769576340829'}, 'enable': 'true', 'created': '2026-02-02T03:09:43', 'last-modified': '2026-02-02T03:09:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.392804'}
2026-02-02 03:09:44,475 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-02 03:09:44,480 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57680494:ctest-trans_left_vn-97888229', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57680494', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9128166812969878064', 'uuid-lslong': '11812337769576340829'}, 'enable': 'true', 'created': '2026-02-02T03:09:43', 'last-modified': '2026-02-02T03:09:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.403790'}
2026-02-02 03:09:44,487 - DEBUG - Route Targets: ['target:64512:8000007']
2026-02-02 03:09:44,487 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-97888229 passed
2026-02-02 03:09:44,487 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-97888229 in API_Server ======
2026-02-02 03:09:44,487 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:09:44,494 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:09:44,504 - DEBUG - Requesting: http://10.0.0.141:8082/project/e8608734-68da-4861-815a-77514dac48ce
2026-02-02 03:09:44,598 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/7eadc35a-7194-4230-a3ed-da9df2871d5d
2026-02-02 03:09:44,609 - DEBUG - =>VN ctest-trans_left_vn-97888229 has no policy to be verified
2026-02-02 03:09:44,609 - DEBUG - Verifying the vn in opserver
2026-02-02 03:09:44,609 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57680494:ctest-trans_left_vn-97888229 virtual network link through opserver 10.0.0.141
2026-02-02 03:09:44,609 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-02-02 03:09:44,622 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57680494:ctest-trans_left_vn-97888229', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57680494:ctest-trans_left_vn-97888229?flat'}
2026-02-02 03:09:44,622 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57680494:ctest-trans_left_vn-97888229 virtual network link through opserver 10.0.0.22
2026-02-02 03:09:44,622 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-02 03:09:44,634 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57680494:ctest-trans_left_vn-97888229', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57680494:ctest-trans_left_vn-97888229?flat'}
2026-02-02 03:09:44,634 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57680494:ctest-trans_left_vn-97888229 virtual network link through opserver 10.0.0.23
2026-02-02 03:09:44,634 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-02 03:09:44,646 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57680494:ctest-trans_left_vn-97888229', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57680494:ctest-trans_left_vn-97888229?flat'}
2026-02-02 03:09:44,646 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-57680494:ctest-trans_left_vn-97888229 is found in opserver
2026-02-02 03:09:44,667 - DEBUG - Do not have enough data to verify VN in agent
2026-02-02 03:09:44,679 - DEBUG - VRF ids for VN ctest-trans_left_vn-97888229: {}
2026-02-02 03:09:44,931 - DEBUG - Response for create_network : {'network': {'id': 'a59af1b2-df10-41f9-b1c4-b6a3d0ab7725', 'name': 'ctest-trans_right_vn-85113773', 'tenant_id': 'e860873468da4861815a77514dac48ce', 'project_id': 'e860873468da4861815a77514dac48ce', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-57680494', 'ctest-trans_right_vn-85113773'], 'port_security_enabled': True, 'description': ''}}
2026-02-02 03:09:45,136 - DEBUG - Response for create_subnet : {'subnet': {'id': '75ee40d5-7c80-42ed-8ed8-d40d23d698d2', 'name': '', 'tenant_id': 'e860873468da4861815a77514dac48ce', 'network_id': 'a59af1b2-df10-41f9-b1c4-b6a3d0ab7725', 'ip_version': 4, 'cidr': '30.122.153.64/26', 'allocation_pools': [{'start': '30.122.153.66', 'end': '30.122.153.126'}], 'gateway_ip': '30.122.153.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '30.122.153.66', 'tags': [], 'project_id': 'e860873468da4861815a77514dac48ce'}}
2026-02-02 03:09:45,159 - INFO - Created VN ctest-trans_right_vn-85113773
2026-02-02 03:09:45,169 - DEBUG - VN ctest-trans_right_vn-85113773 UUID is a59af1b2-df10-41f9-b1c4-b6a3d0ab7725
2026-02-02 03:09:45,236 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:09:45,242 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:09:45,253 - DEBUG - Requesting: http://10.0.0.141:8082/project/e8608734-68da-4861-815a-77514dac48ce
2026-02-02 03:09:45,344 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/a59af1b2-df10-41f9-b1c4-b6a3d0ab7725
2026-02-02 03:09:45,357 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/a59af1b2-df10-41f9-b1c4-b6a3d0ab7725
2026-02-02 03:09:45,366 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/1ef80ad7-dd8d-4ed1-bb7c-af63e5bca75b
2026-02-02 03:09:45,374 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/1ef80ad7-dd8d-4ed1-bb7c-af63e5bca75b
2026-02-02 03:09:45,380 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/4b8d9195-9332-43d6-a6b8-28d55afe1c70
2026-02-02 03:09:45,387 - DEBUG - Route Targets: ['target:64512:8000008']
2026-02-02 03:09:45,387 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/a59af1b2-df10-41f9-b1c4-b6a3d0ab7725
2026-02-02 03:09:45,396 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/1ef80ad7-dd8d-4ed1-bb7c-af63e5bca75b
2026-02-02 03:09:45,414 - INFO - Verified VN network id 14 for VN a59af1b2-df10-41f9-b1c4-b6a3d0ab7725
2026-02-02 03:09:45,414 - INFO - Verifications in API Server for VN ctest-trans_right_vn-85113773 passed
2026-02-02 03:09:45,414 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/a59af1b2-df10-41f9-b1c4-b6a3d0ab7725
2026-02-02 03:09:45,424 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/1ef80ad7-dd8d-4ed1-bb7c-af63e5bca75b
2026-02-02 03:09:45,432 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/1ef80ad7-dd8d-4ed1-bb7c-af63e5bca75b
2026-02-02 03:09:45,439 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/4b8d9195-9332-43d6-a6b8-28d55afe1c70
2026-02-02 03:09:45,451 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57680494:ctest-trans_right_vn-85113773', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57680494', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11933115913220407801', 'uuid-lslong': '12809564054845355813'}, 'enable': 'true', 'created': '2026-02-02T03:09:44', 'last-modified': '2026-02-02T03:09:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.356042'}
2026-02-02 03:09:45,456 - DEBUG - Route Targets: ['target:64512:8000008']
2026-02-02 03:09:45,461 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57680494:ctest-trans_right_vn-85113773', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57680494', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11933115913220407801', 'uuid-lslong': '12809564054845355813'}, 'enable': 'true', 'created': '2026-02-02T03:09:44', 'last-modified': '2026-02-02T03:09:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.367138'}
2026-02-02 03:09:45,466 - DEBUG - Route Targets: ['target:64512:8000008']
2026-02-02 03:09:45,472 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-57680494:ctest-trans_right_vn-85113773', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-57680494', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11933115913220407801', 'uuid-lslong': '12809564054845355813'}, 'enable': 'true', 'created': '2026-02-02T03:09:44', 'last-modified': '2026-02-02T03:09:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.379240'}
2026-02-02 03:09:45,477 - DEBUG - Route Targets: ['target:64512:8000008']
2026-02-02 03:09:45,477 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-85113773 passed
2026-02-02 03:09:45,477 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-85113773 in API_Server ======
2026-02-02 03:09:45,477 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:09:45,483 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:09:45,493 - DEBUG - Requesting: http://10.0.0.141:8082/project/e8608734-68da-4861-815a-77514dac48ce
2026-02-02 03:09:45,585 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/a59af1b2-df10-41f9-b1c4-b6a3d0ab7725
2026-02-02 03:09:45,595 - DEBUG - =>VN ctest-trans_right_vn-85113773 has no policy to be verified
2026-02-02 03:09:45,595 - DEBUG - Verifying the vn in opserver
2026-02-02 03:09:45,595 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57680494:ctest-trans_right_vn-85113773 virtual network link through opserver 10.0.0.141
2026-02-02 03:09:45,595 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-02-02 03:09:45,609 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57680494:ctest-trans_right_vn-85113773', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57680494:ctest-trans_right_vn-85113773?flat'}
2026-02-02 03:09:45,609 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57680494:ctest-trans_right_vn-85113773 virtual network link through opserver 10.0.0.22
2026-02-02 03:09:45,609 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-02 03:09:45,621 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57680494:ctest-trans_right_vn-85113773', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57680494:ctest-trans_right_vn-85113773?flat'}
2026-02-02 03:09:45,621 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-57680494:ctest-trans_right_vn-85113773 virtual network link through opserver 10.0.0.23
2026-02-02 03:09:45,621 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-02 03:09:45,633 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-57680494:ctest-trans_right_vn-85113773', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-57680494:ctest-trans_right_vn-85113773?flat'}
2026-02-02 03:09:45,633 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-57680494:ctest-trans_right_vn-85113773 is found in opserver
2026-02-02 03:09:45,654 - DEBUG - Do not have enough data to verify VN in agent
2026-02-02 03:09:45,665 - DEBUG - VRF ids for VN ctest-trans_right_vn-85113773: {}
2026-02-02 03:09:46,715 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5167-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5167-1)
2026-02-02 03:09:48,039 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5167-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5167-2)
2026-02-02 03:09:48,039 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-33343943']
2026-02-02 03:09:48,336 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-33343943'] created succesfully
2026-02-02 03:09:48,723 - DEBUG - Image by name tiny_trans_fw not found
2026-02-02 03:09:48,723 - DEBUG - Installing image tiny_trans_fw
2026-02-02 03:09:48,723 - DEBUG - Image info {'name': 'tinycore-net-transparent-fw.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd'}
2026-02-02 03:09:48,724 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-02-02 03:09:48,724 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-02-02 03:09:48,741 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz -O /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-02-02 03:09:48,772 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-02-02 03:09:48,772 - DEBUG - Unzip image
2026-02-02 03:09:48,772 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-02-02 03:09:48,791 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-02-02 03:09:48,792 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-33343943']
2026-02-02 03:09:48,905 - INFO - Service template: ['default-domain', 'ctest-service_template_1-33343943'] deleted successfully.
2026-02-02 03:09:48,905 - INFO - Skip interface_detach for VM ctest-right_vm-70808773 in state BUILD
2026-02-02 03:09:48,905 - INFO - Deleting VM ctest-right_vm-70808773
2026-02-02 03:09:48,905 - ERROR - VM ctest-right_vm-70808773 has failed to come up
2026-02-02 03:09:48,905 - ERROR - Nova failed to get host of the VM
2026-02-02 03:09:48,905 - ERROR - VM ctest-right_vm-70808773 has failed to come up
2026-02-02 03:09:48,905 - ERROR - Nova failed to get host of the VM
2026-02-02 03:09:48,980 - INFO - Skip interface_detach for VM ctest-left_vm-70569292 in state BUILD
2026-02-02 03:09:48,981 - INFO - Deleting VM ctest-left_vm-70569292
2026-02-02 03:09:48,981 - ERROR - VM ctest-left_vm-70569292 has failed to come up
2026-02-02 03:09:48,981 - ERROR - Nova failed to get host of the VM
2026-02-02 03:09:48,981 - ERROR - VM ctest-left_vm-70569292 has failed to come up
2026-02-02 03:09:48,982 - ERROR - Nova failed to get host of the VM
2026-02-02 03:09:49,068 - INFO - Deleting VN ctest-trans_right_vn-85113773
2026-02-02 03:09:49,213 - DEBUG - Response for deleting network ()
2026-02-02 03:09:49,213 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/1ef80ad7-dd8d-4ed1-bb7c-af63e5bca75b
2026-02-02 03:09:49,226 - DEBUG - Response Code: 404
2026-02-02 03:09:49,226 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:09:49,233 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:09:49,290 - DEBUG - Requesting: http://10.0.0.141:8082/project/e8608734-68da-4861-815a-77514dac48ce
2026-02-02 03:09:49,389 - INFO - Validated that VN ctest-trans_right_vn-85113773 is not found in API Server
2026-02-02 03:09:49,400 - DEBUG - VN ctest-trans_right_vn-85113773 is not present in Agent 10.0.0.50
2026-02-02 03:09:49,418 - DEBUG - VN ctest-trans_right_vn-85113773 is not present in Agent 10.0.0.65
2026-02-02 03:09:49,418 - INFO - Validated that VN ctest-trans_right_vn-85113773 is not in any agent
2026-02-02 03:09:49,450 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-85113773 info
2026-02-02 03:09:49,450 - INFO - Deleting VN ctest-trans_left_vn-97888229
2026-02-02 03:09:49,582 - DEBUG - Response for deleting network ()
2026-02-02 03:09:49,582 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/52f3d765-6fe5-41db-b882-db734f122022
2026-02-02 03:09:49,587 - DEBUG - Response Code: 404
2026-02-02 03:09:49,587 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:09:49,595 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:09:49,621 - DEBUG - Requesting: http://10.0.0.141:8082/project/e8608734-68da-4861-815a-77514dac48ce
2026-02-02 03:09:49,738 - INFO - Validated that VN ctest-trans_left_vn-97888229 is not found in API Server
2026-02-02 03:09:49,752 - DEBUG - VN ctest-trans_left_vn-97888229 is not present in Agent 10.0.0.50
2026-02-02 03:09:49,776 - DEBUG - VN ctest-trans_left_vn-97888229 is not present in Agent 10.0.0.65
2026-02-02 03:09:49,776 - INFO - Validated that VN ctest-trans_left_vn-97888229 is not in any agent
2026-02-02 03:09:49,822 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-97888229 info
2026-02-02 03:09:49,822 - INFO - Deleting VN ctest-right_vn-66541531
2026-02-02 03:09:49,870 - DEBUG - VN 02844e70-9b97-46be-9e5c-4a9e47782481 still in use: Unable to complete operation on network 02844e70-9b97-46be-9e5c-4a9e47782481. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-cfa2bf6e-6e01-4a9a-b7ef-1a694277ef6c']
2026-02-02 03:09:49,870 - WARNING - Deleting VN ctest-right_vn-66541531 failed..Will retry
2026-02-02 03:09:52,003 - DEBUG - Response for deleting network ()
2026-02-02 03:09:52,003 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/c512bd2a-19bf-4dc1-95cb-1f76ca4d3e11
2026-02-02 03:09:52,008 - DEBUG - Response Code: 404
2026-02-02 03:09:52,008 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:09:52,019 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:09:52,029 - DEBUG - Requesting: http://10.0.0.141:8082/project/e8608734-68da-4861-815a-77514dac48ce
2026-02-02 03:09:52,118 - INFO - Validated that VN ctest-right_vn-66541531 is not found in API Server
2026-02-02 03:09:52,128 - DEBUG - VN ctest-right_vn-66541531 is not present in Agent 10.0.0.50
2026-02-02 03:09:52,139 - DEBUG - VN ctest-right_vn-66541531 is not present in Agent 10.0.0.65
2026-02-02 03:09:52,139 - INFO - Validated that VN ctest-right_vn-66541531 is not in any agent
2026-02-02 03:09:52,169 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-66541531 info
2026-02-02 03:09:52,170 - INFO - Deleting VN ctest-left_vn-50850852
2026-02-02 03:09:52,312 - DEBUG - Response for deleting network ()
2026-02-02 03:09:52,312 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/5b5426b4-dd38-42a9-b31b-fd76032fffeb
2026-02-02 03:09:52,330 - DEBUG - Response Code: 404
2026-02-02 03:09:52,330 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:09:52,337 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:09:52,390 - DEBUG - Requesting: http://10.0.0.141:8082/project/e8608734-68da-4861-815a-77514dac48ce
2026-02-02 03:09:52,480 - INFO - Validated that VN ctest-left_vn-50850852 is not found in API Server
2026-02-02 03:09:52,490 - DEBUG - VN ctest-left_vn-50850852 is not present in Agent 10.0.0.50
2026-02-02 03:09:52,499 - DEBUG - VN ctest-left_vn-50850852 is not present in Agent 10.0.0.65
2026-02-02 03:09:52,499 - INFO - Validated that VN ctest-left_vn-50850852 is not in any agent
2026-02-02 03:09:52,530 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-50850852 info
2026-02-02 03:09:52,531 - INFO - Deleting VN ctest-mgmt_vn-56389614
2026-02-02 03:09:52,655 - DEBUG - Response for deleting network ()
2026-02-02 03:09:52,655 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/043927ab-82cf-4a9e-b5fe-48e4f624e60c
2026-02-02 03:09:52,662 - DEBUG - Response Code: 404
2026-02-02 03:09:52,662 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:09:52,667 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:09:52,684 - DEBUG - Requesting: http://10.0.0.141:8082/project/e8608734-68da-4861-815a-77514dac48ce
2026-02-02 03:09:52,791 - INFO - Validated that VN ctest-mgmt_vn-56389614 is not found in API Server
2026-02-02 03:09:52,802 - DEBUG - VN ctest-mgmt_vn-56389614 is not present in Agent 10.0.0.50
2026-02-02 03:09:52,812 - DEBUG - VN ctest-mgmt_vn-56389614 is not present in Agent 10.0.0.65
2026-02-02 03:09:52,812 - INFO - Validated that VN ctest-mgmt_vn-56389614 is not in any agent
2026-02-02 03:09:52,841 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-56389614 info
2026-02-02 03:09:54,098 - DEBUG - No XMPP flaps were noticed during the test
2026-02-02 03:09:54,098 - INFO -
2026-02-02 03:09:54,099 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:20]
2026-02-02 03:09:54,099 - INFO - --------------------------------------------------------------------------------
2026-02-02 03:09:54,853 - INFO - Deleted project: ctest-TestSvcRegr-57680494, ID : e8608734-68da-4861-815a-77514dac48ce
2026-02-02 03:09:55,040 - INFO - Domain Default found not creating
2026-02-02 03:09:55,235 - INFO - Project ctest-TestSvcRegr-80669226 not found, creating it
2026-02-02 03:09:55,820 - INFO - Created Project:ctest-TestSvcRegr-80669226, ID : d38d074e-b893-4da5-9175-8c1691f42995
2026-02-02 03:09:57,479 - INFO - ================================================================================
2026-02-02 03:09:57,479 - INFO - STARTING TEST : test_svc_CEM_22032
2026-02-02 03:09:58,763 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.17': '0', '10.20.0.193': '0'}, '10.0.0.65': {'10.20.0.193': '0', '10.20.0.129': '0'}} with
2026-02-02 03:09:58,763 - INFO - Initial checks done. Running the testcase now
2026-02-02 03:09:58,763 - INFO -
2026-02-02 03:09:59,452 - DEBUG - Response for create_network : {'network': {'id': '89e1d90b-fea3-493c-8a3d-b0d83116f70a', 'name': 'ctest-mgmt_vn-97411112', 'tenant_id': 'd38d074eb8934da591758c1691f42995', 'project_id': 'd38d074eb8934da591758c1691f42995', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-80669226', 'ctest-mgmt_vn-97411112'], 'port_security_enabled': True, 'description': ''}}
2026-02-02 03:09:59,725 - DEBUG - Response for create_subnet : {'subnet': {'id': '048685c1-509c-4316-9a24-25a25c42208b', 'name': '', 'tenant_id': 'd38d074eb8934da591758c1691f42995', 'network_id': '89e1d90b-fea3-493c-8a3d-b0d83116f70a', 'ip_version': 4, 'cidr': '76.199.142.0/26', 'allocation_pools': [{'start': '76.199.142.2', 'end': '76.199.142.62'}], 'gateway_ip': '76.199.142.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '76.199.142.2', 'tags': [], 'project_id': 'd38d074eb8934da591758c1691f42995'}}
2026-02-02 03:09:59,746 - INFO - Created VN ctest-mgmt_vn-97411112
2026-02-02 03:09:59,757 - DEBUG - VN ctest-mgmt_vn-97411112 UUID is 89e1d90b-fea3-493c-8a3d-b0d83116f70a
2026-02-02 03:09:59,827 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:10:00,131 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:10:00,163 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:10:00,179 - DEBUG - Requesting: http://10.0.0.141:8082/project/d38d074e-b893-4da5-9175-8c1691f42995
2026-02-02 03:10:00,264 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/89e1d90b-fea3-493c-8a3d-b0d83116f70a
2026-02-02 03:10:00,280 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/89e1d90b-fea3-493c-8a3d-b0d83116f70a
2026-02-02 03:10:00,289 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/3bcdb78d-a557-4d9f-bb77-e4f130d9bcd9
2026-02-02 03:10:00,297 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/3bcdb78d-a557-4d9f-bb77-e4f130d9bcd9
2026-02-02 03:10:00,304 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/ddbe6286-8f32-493e-a878-9516d6a8d819
2026-02-02 03:10:00,311 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-02 03:10:00,311 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/89e1d90b-fea3-493c-8a3d-b0d83116f70a
2026-02-02 03:10:00,321 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/3bcdb78d-a557-4d9f-bb77-e4f130d9bcd9
2026-02-02 03:10:00,337 - INFO - Verified VN network id 10 for VN 89e1d90b-fea3-493c-8a3d-b0d83116f70a
2026-02-02 03:10:00,337 - INFO - Verifications in API Server for VN ctest-mgmt_vn-97411112 passed
2026-02-02 03:10:00,337 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/89e1d90b-fea3-493c-8a3d-b0d83116f70a
2026-02-02 03:10:00,348 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/3bcdb78d-a557-4d9f-bb77-e4f130d9bcd9
2026-02-02 03:10:00,357 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/3bcdb78d-a557-4d9f-bb77-e4f130d9bcd9
2026-02-02 03:10:00,364 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/ddbe6286-8f32-493e-a878-9516d6a8d819
2026-02-02 03:10:00,378 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-97411112', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80669226', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9935460898496006460', 'uuid-lslong': '9961312393396418314'}, 'enable': 'true', 'created': '2026-02-02T03:09:59', 'last-modified': '2026-02-02T03:09:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.701762'}
2026-02-02 03:10:00,384 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-02 03:10:00,390 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-97411112', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80669226', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9935460898496006460', 'uuid-lslong': '9961312393396418314'}, 'enable': 'true', 'created': '2026-02-02T03:09:59', 'last-modified': '2026-02-02T03:09:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.712105'}
2026-02-02 03:10:00,397 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-02 03:10:00,402 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-97411112', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80669226', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9935460898496006460', 'uuid-lslong': '9961312393396418314'}, 'enable': 'true', 'created': '2026-02-02T03:09:59', 'last-modified': '2026-02-02T03:09:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.728257'}
2026-02-02 03:10:00,409 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-02 03:10:00,409 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-97411112 passed
2026-02-02 03:10:00,409 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-97411112 in API_Server ======
2026-02-02 03:10:00,409 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:10:00,415 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:10:00,425 - DEBUG - Requesting: http://10.0.0.141:8082/project/d38d074e-b893-4da5-9175-8c1691f42995
2026-02-02 03:10:00,517 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/89e1d90b-fea3-493c-8a3d-b0d83116f70a
2026-02-02 03:10:00,527 - DEBUG - =>VN ctest-mgmt_vn-97411112 has no policy to be verified
2026-02-02 03:10:00,527 - DEBUG - Verifying the vn in opserver
2026-02-02 03:10:00,527 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-97411112 virtual network link through opserver 10.0.0.141
2026-02-02 03:10:00,527 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-02-02 03:10:00,823 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-02-02 03:10:00,892 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-97411112', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-97411112?flat'}
2026-02-02 03:10:00,892 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-97411112 virtual network link through opserver 10.0.0.22
2026-02-02 03:10:00,892 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-02 03:10:01,199 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-02 03:10:01,264 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-97411112', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-97411112?flat'}
2026-02-02 03:10:01,264 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-97411112 virtual network link through opserver 10.0.0.23
2026-02-02 03:10:01,265 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-02 03:10:01,566 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-02 03:10:01,630 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-97411112', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-97411112?flat'}
2026-02-02 03:10:01,630 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-97411112 is found in opserver
2026-02-02 03:10:01,654 - DEBUG - Do not have enough data to verify VN in agent
2026-02-02 03:10:01,665 - DEBUG - VRF ids for VN ctest-mgmt_vn-97411112: {}
2026-02-02 03:10:01,951 - DEBUG - Response for create_network : {'network': {'id': 'f2081e12-1591-4b19-bf26-a782c9dc4de2', 'name': 'service-left-vn-31493707', 'tenant_id': 'd38d074eb8934da591758c1691f42995', 'project_id': 'd38d074eb8934da591758c1691f42995', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-80669226', 'service-left-vn-31493707'], 'port_security_enabled': True, 'description': ''}}
2026-02-02 03:10:02,220 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f6e59e40-16f0-4585-a133-95dc0fdba3ec', 'name': '', 'tenant_id': 'd38d074eb8934da591758c1691f42995', 'network_id': 'f2081e12-1591-4b19-bf26-a782c9dc4de2', 'ip_version': 4, 'cidr': '20.0.252.192/26', 'allocation_pools': [{'start': '20.0.252.194', 'end': '20.0.252.254'}], 'gateway_ip': '20.0.252.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '20.0.252.194', 'tags': [], 'project_id': 'd38d074eb8934da591758c1691f42995'}}
2026-02-02 03:10:02,244 - INFO - Created VN service-left-vn-31493707
2026-02-02 03:10:02,258 - DEBUG - VN service-left-vn-31493707 UUID is f2081e12-1591-4b19-bf26-a782c9dc4de2
2026-02-02 03:10:02,335 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:10:02,342 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:10:02,356 - DEBUG - Requesting: http://10.0.0.141:8082/project/d38d074e-b893-4da5-9175-8c1691f42995
2026-02-02 03:10:02,441 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/f2081e12-1591-4b19-bf26-a782c9dc4de2
2026-02-02 03:10:02,460 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/f2081e12-1591-4b19-bf26-a782c9dc4de2
2026-02-02 03:10:02,470 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/59a8aa6e-1e80-45ab-aa2a-a9e4825454fc
2026-02-02 03:10:02,479 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/59a8aa6e-1e80-45ab-aa2a-a9e4825454fc
2026-02-02 03:10:02,487 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/41e2476e-e5c3-4a4c-a72b-f94135b9c93a
2026-02-02 03:10:02,571 - DEBUG - Route Targets: ['target:64512:8000005']
2026-02-02 03:10:02,571 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/f2081e12-1591-4b19-bf26-a782c9dc4de2
2026-02-02 03:10:02,580 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/59a8aa6e-1e80-45ab-aa2a-a9e4825454fc
2026-02-02 03:10:02,597 - INFO - Verified VN network id 11 for VN f2081e12-1591-4b19-bf26-a782c9dc4de2
2026-02-02 03:10:02,597 - INFO - Verifications in API Server for VN service-left-vn-31493707 passed
2026-02-02 03:10:02,597 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/f2081e12-1591-4b19-bf26-a782c9dc4de2
2026-02-02 03:10:02,607 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/59a8aa6e-1e80-45ab-aa2a-a9e4825454fc
2026-02-02 03:10:02,614 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/59a8aa6e-1e80-45ab-aa2a-a9e4825454fc
2026-02-02 03:10:02,620 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/41e2476e-e5c3-4a4c-a72b-f94135b9c93a
2026-02-02 03:10:02,634 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80669226:service-left-vn-31493707', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80669226', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17440222620012333849', 'uuid-lslong': '13773880690533486050'}, 'enable': 'true', 'created': '2026-02-02T03:10:01', 'last-modified': '2026-02-02T03:10:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.458405'}
2026-02-02 03:10:02,641 - DEBUG - Route Targets: ['target:64512:8000005']
2026-02-02 03:10:02,646 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80669226:service-left-vn-31493707', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80669226', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17440222620012333849', 'uuid-lslong': '13773880690533486050'}, 'enable': 'true', 'created': '2026-02-02T03:10:01', 'last-modified': '2026-02-02T03:10:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.484894'}
2026-02-02 03:10:02,652 - DEBUG - Route Targets: ['target:64512:8000005']
2026-02-02 03:10:02,659 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80669226:service-left-vn-31493707', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80669226', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17440222620012333849', 'uuid-lslong': '13773880690533486050'}, 'enable': 'true', 'created': '2026-02-02T03:10:01', 'last-modified': '2026-02-02T03:10:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.490355'}
2026-02-02 03:10:02,667 - DEBUG - Route Targets: ['target:64512:8000005']
2026-02-02 03:10:02,667 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-31493707 passed
2026-02-02 03:10:02,668 - DEBUG - ====Verifying policy data for service-left-vn-31493707 in API_Server ======
2026-02-02 03:10:02,668 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:10:02,674 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:10:02,687 - DEBUG - Requesting: http://10.0.0.141:8082/project/d38d074e-b893-4da5-9175-8c1691f42995
2026-02-02 03:10:02,781 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/f2081e12-1591-4b19-bf26-a782c9dc4de2
2026-02-02 03:10:02,789 - DEBUG - =>VN service-left-vn-31493707 has no policy to be verified
2026-02-02 03:10:02,789 - DEBUG - Verifying the vn in opserver
2026-02-02 03:10:02,789 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80669226:service-left-vn-31493707 virtual network link through opserver 10.0.0.141
2026-02-02 03:10:02,789 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-02-02 03:10:02,856 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80669226:service-left-vn-31493707', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80669226:service-left-vn-31493707?flat'}
2026-02-02 03:10:02,856 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80669226:service-left-vn-31493707 virtual network link through opserver 10.0.0.22
2026-02-02 03:10:02,856 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-02 03:10:02,927 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80669226:service-left-vn-31493707', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80669226:service-left-vn-31493707?flat'}
2026-02-02 03:10:02,927 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80669226:service-left-vn-31493707 virtual network link through opserver 10.0.0.23
2026-02-02 03:10:02,927 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-02 03:10:02,986 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80669226:service-left-vn-31493707', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80669226:service-left-vn-31493707?flat'}
2026-02-02 03:10:02,986 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-80669226:service-left-vn-31493707 is found in opserver
2026-02-02 03:10:03,007 - DEBUG - Do not have enough data to verify VN in agent
2026-02-02 03:10:03,018 - DEBUG - VRF ids for VN service-left-vn-31493707: {}
2026-02-02 03:10:03,309 - DEBUG - Response for create_network : {'network': {'id': '44f0f4cc-2b20-42cb-98eb-fca34e902d6c', 'name': 'service-right-vn-38772393', 'tenant_id': 'd38d074eb8934da591758c1691f42995', 'project_id': 'd38d074eb8934da591758c1691f42995', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-80669226', 'service-right-vn-38772393'], 'port_security_enabled': True, 'description': ''}}
2026-02-02 03:10:03,509 - DEBUG - Response for create_subnet : {'subnet': {'id': '27038f54-a93d-4df7-9df4-6d080af02598', 'name': '', 'tenant_id': 'd38d074eb8934da591758c1691f42995', 'network_id': '44f0f4cc-2b20-42cb-98eb-fca34e902d6c', 'ip_version': 4, 'cidr': '215.107.124.128/26', 'allocation_pools': [{'start': '215.107.124.130', 'end': '215.107.124.190'}], 'gateway_ip': '215.107.124.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '215.107.124.130', 'tags': [], 'project_id': 'd38d074eb8934da591758c1691f42995'}}
2026-02-02 03:10:03,531 - INFO - Created VN service-right-vn-38772393
2026-02-02 03:10:03,541 - DEBUG - VN service-right-vn-38772393 UUID is 44f0f4cc-2b20-42cb-98eb-fca34e902d6c
2026-02-02 03:10:03,621 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:10:03,628 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:10:03,638 - DEBUG - Requesting: http://10.0.0.141:8082/project/d38d074e-b893-4da5-9175-8c1691f42995
2026-02-02 03:10:03,721 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/44f0f4cc-2b20-42cb-98eb-fca34e902d6c
2026-02-02 03:10:03,734 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/44f0f4cc-2b20-42cb-98eb-fca34e902d6c
2026-02-02 03:10:03,743 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/94d231d3-5c77-48e5-818f-6b5a9af7bf8e
2026-02-02 03:10:03,750 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/94d231d3-5c77-48e5-818f-6b5a9af7bf8e
2026-02-02 03:10:03,757 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/d2672dc8-1d6f-4149-bde4-cbf98b3b1b5a
2026-02-02 03:10:03,765 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-02 03:10:03,765 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/44f0f4cc-2b20-42cb-98eb-fca34e902d6c
2026-02-02 03:10:03,774 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/94d231d3-5c77-48e5-818f-6b5a9af7bf8e
2026-02-02 03:10:03,790 - INFO - Verified VN network id 12 for VN 44f0f4cc-2b20-42cb-98eb-fca34e902d6c
2026-02-02 03:10:03,790 - INFO - Verifications in API Server for VN service-right-vn-38772393 passed
2026-02-02 03:10:03,790 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/44f0f4cc-2b20-42cb-98eb-fca34e902d6c
2026-02-02 03:10:03,801 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/94d231d3-5c77-48e5-818f-6b5a9af7bf8e
2026-02-02 03:10:03,808 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/94d231d3-5c77-48e5-818f-6b5a9af7bf8e
2026-02-02 03:10:03,816 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/d2672dc8-1d6f-4149-bde4-cbf98b3b1b5a
2026-02-02 03:10:03,832 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80669226:service-right-vn-38772393', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80669226', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4967739546723697355', 'uuid-lslong': '11019178691619990892'}, 'enable': 'true', 'created': '2026-02-02T03:10:03', 'last-modified': '2026-02-02T03:10:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.366120'}
2026-02-02 03:10:03,839 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-02 03:10:03,845 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80669226:service-right-vn-38772393', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80669226', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4967739546723697355', 'uuid-lslong': '11019178691619990892'}, 'enable': 'true', 'created': '2026-02-02T03:10:03', 'last-modified': '2026-02-02T03:10:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.384948'}
2026-02-02 03:10:03,851 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-02 03:10:03,858 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80669226:service-right-vn-38772393', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80669226', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4967739546723697355', 'uuid-lslong': '11019178691619990892'}, 'enable': 'true', 'created': '2026-02-02T03:10:03', 'last-modified': '2026-02-02T03:10:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.389942'}
2026-02-02 03:10:03,865 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-02 03:10:03,865 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-38772393 passed
2026-02-02 03:10:03,866 - DEBUG - ====Verifying policy data for service-right-vn-38772393 in API_Server ======
2026-02-02 03:10:03,866 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:10:03,872 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:10:03,883 - DEBUG - Requesting: http://10.0.0.141:8082/project/d38d074e-b893-4da5-9175-8c1691f42995
2026-02-02 03:10:03,978 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/44f0f4cc-2b20-42cb-98eb-fca34e902d6c
2026-02-02 03:10:03,989 - DEBUG - =>VN service-right-vn-38772393 has no policy to be verified
2026-02-02 03:10:03,989 - DEBUG - Verifying the vn in opserver
2026-02-02 03:10:03,989 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80669226:service-right-vn-38772393 virtual network link through opserver 10.0.0.141
2026-02-02 03:10:03,989 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-02-02 03:10:04,052 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80669226:service-right-vn-38772393', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80669226:service-right-vn-38772393?flat'}
2026-02-02 03:10:04,052 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80669226:service-right-vn-38772393 virtual network link through opserver 10.0.0.22
2026-02-02 03:10:04,052 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-02 03:10:04,116 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80669226:service-right-vn-38772393', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80669226:service-right-vn-38772393?flat'}
2026-02-02 03:10:04,116 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80669226:service-right-vn-38772393 virtual network link through opserver 10.0.0.23
2026-02-02 03:10:04,116 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-02 03:10:04,177 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80669226:service-right-vn-38772393', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80669226:service-right-vn-38772393?flat'}
2026-02-02 03:10:04,177 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-80669226:service-right-vn-38772393 is found in opserver
2026-02-02 03:10:04,202 - DEBUG - Do not have enough data to verify VN in agent
2026-02-02 03:10:04,213 - DEBUG - VRF ids for VN service-right-vn-38772393: {}
2026-02-02 03:10:04,274 - DEBUG - Services list from nova: [, , , ]
2026-02-02 03:10:05,437 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5167-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5167-1)
2026-02-02 03:10:06,820 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5167-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5167-2)
2026-02-02 03:10:06,820 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-36421434']
2026-02-02 03:10:07,214 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-36421434'] created succesfully
2026-02-02 03:10:07,705 - DEBUG - Image by name tiny_nat_fw not found
2026-02-02 03:10:07,705 - DEBUG - Installing image tiny_nat_fw
2026-02-02 03:10:07,705 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-02-02 03:10:07,706 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-02 03:10:07,706 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-02 03:10:07,706 - DEBUG - Unzip image
2026-02-02 03:10:07,706 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-02 03:10:07,731 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-02-02 03:10:07,732 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-36421434']
2026-02-02 03:10:07,837 - INFO - Service template: ['default-domain', 'ctest-service_template_1-36421434'] deleted successfully.
2026-02-02 03:10:07,837 - INFO - Skip interface_detach for VM ctest-right_vm-43114593 in state BUILD
2026-02-02 03:10:07,837 - INFO - Deleting VM ctest-right_vm-43114593
2026-02-02 03:10:07,870 - ERROR - VM ctest-right_vm-43114593 has failed to come up
2026-02-02 03:10:07,871 - ERROR - Nova failed to get host of the VM
2026-02-02 03:10:07,871 - ERROR - VM ctest-right_vm-43114593 has failed to come up
2026-02-02 03:10:07,871 - ERROR - Nova failed to get host of the VM
2026-02-02 03:10:08,021 - INFO - Skip interface_detach for VM ctest-left_vm-26503321 in state BUILD
2026-02-02 03:10:08,022 - INFO - Deleting VM ctest-left_vm-26503321
2026-02-02 03:10:08,022 - ERROR - VM ctest-left_vm-26503321 has failed to come up
2026-02-02 03:10:08,022 - ERROR - Nova failed to get host of the VM
2026-02-02 03:10:08,022 - ERROR - VM ctest-left_vm-26503321 has failed to come up
2026-02-02 03:10:08,022 - ERROR - Nova failed to get host of the VM
2026-02-02 03:10:08,107 - INFO - Deleting VN service-right-vn-38772393
2026-02-02 03:10:08,155 - DEBUG - VN 44f0f4cc-2b20-42cb-98eb-fca34e902d6c still in use: Unable to complete operation on network 44f0f4cc-2b20-42cb-98eb-fca34e902d6c. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-132ca35a-3c72-4563-9193-02b3056e43e9']
2026-02-02 03:10:08,155 - WARNING - Deleting VN service-right-vn-38772393 failed..Will retry
2026-02-02 03:10:10,303 - DEBUG - Response for deleting network ()
2026-02-02 03:10:10,303 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/94d231d3-5c77-48e5-818f-6b5a9af7bf8e
2026-02-02 03:10:10,311 - DEBUG - Response Code: 404
2026-02-02 03:10:10,311 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:10:10,319 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:10:10,350 - DEBUG - Requesting: http://10.0.0.141:8082/project/d38d074e-b893-4da5-9175-8c1691f42995
2026-02-02 03:10:10,472 - INFO - Validated that VN service-right-vn-38772393 is not found in API Server
2026-02-02 03:10:10,484 - DEBUG - VN service-right-vn-38772393 is not present in Agent 10.0.0.50
2026-02-02 03:10:10,495 - DEBUG - VN service-right-vn-38772393 is not present in Agent 10.0.0.65
2026-02-02 03:10:10,495 - INFO - Validated that VN service-right-vn-38772393 is not in any agent
2026-02-02 03:10:10,532 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-38772393 info
2026-02-02 03:10:10,532 - INFO - Deleting VN service-left-vn-31493707
2026-02-02 03:10:10,683 - DEBUG - Response for deleting network ()
2026-02-02 03:10:10,683 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/59a8aa6e-1e80-45ab-aa2a-a9e4825454fc
2026-02-02 03:10:10,690 - DEBUG - Response Code: 404
2026-02-02 03:10:10,690 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:10:10,696 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:10:10,724 - DEBUG - Requesting: http://10.0.0.141:8082/project/d38d074e-b893-4da5-9175-8c1691f42995
2026-02-02 03:10:10,821 - INFO - Validated that VN service-left-vn-31493707 is not found in API Server
2026-02-02 03:10:10,833 - DEBUG - VN service-left-vn-31493707 is not present in Agent 10.0.0.50
2026-02-02 03:10:10,844 - DEBUG - VN service-left-vn-31493707 is not present in Agent 10.0.0.65
2026-02-02 03:10:10,844 - INFO - Validated that VN service-left-vn-31493707 is not in any agent
2026-02-02 03:10:10,877 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-31493707 info
2026-02-02 03:10:10,877 - INFO - Deleting VN ctest-mgmt_vn-97411112
2026-02-02 03:10:11,022 - DEBUG - Response for deleting network ()
2026-02-02 03:10:11,022 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/3bcdb78d-a557-4d9f-bb77-e4f130d9bcd9
2026-02-02 03:10:11,030 - DEBUG - Response Code: 404
2026-02-02 03:10:11,030 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:10:11,040 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:10:11,059 - DEBUG - Requesting: http://10.0.0.141:8082/project/d38d074e-b893-4da5-9175-8c1691f42995
2026-02-02 03:10:11,182 - INFO - Validated that VN ctest-mgmt_vn-97411112 is not found in API Server
2026-02-02 03:10:11,199 - DEBUG - VN ctest-mgmt_vn-97411112 is not present in Agent 10.0.0.50
2026-02-02 03:10:11,212 - DEBUG - VN ctest-mgmt_vn-97411112 is not present in Agent 10.0.0.65
2026-02-02 03:10:11,212 - INFO - Validated that VN ctest-mgmt_vn-97411112 is not in any agent
2026-02-02 03:10:11,246 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-97411112 info
2026-02-02 03:10:12,526 - DEBUG - No XMPP flaps were noticed during the test
2026-02-02 03:10:12,526 - INFO -
2026-02-02 03:10:12,526 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:15]
2026-02-02 03:10:12,526 - INFO - --------------------------------------------------------------------------------
2026-02-02 03:10:12,530 - INFO - ================================================================================
2026-02-02 03:10:12,530 - INFO - STARTING TEST : test_svc_in_network_datapath
2026-02-02 03:10:13,811 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.17': '0', '10.20.0.193': '0'}, '10.0.0.65': {'10.20.0.193': '0', '10.20.0.129': '0'}} with
2026-02-02 03:10:13,811 - INFO - Initial checks done. Running the testcase now
2026-02-02 03:10:13,812 - INFO -
2026-02-02 03:10:14,092 - DEBUG - Response for create_network : {'network': {'id': 'b68164a0-8434-46db-ba67-5eca40538bca', 'name': 'ctest-mgmt_vn-47295312', 'tenant_id': 'd38d074eb8934da591758c1691f42995', 'project_id': 'd38d074eb8934da591758c1691f42995', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-80669226', 'ctest-mgmt_vn-47295312'], 'port_security_enabled': True, 'description': ''}}
2026-02-02 03:10:14,286 - DEBUG - Response for create_subnet : {'subnet': {'id': '1b1e81d8-e37a-4830-82b1-8e52fa4c657c', 'name': '', 'tenant_id': 'd38d074eb8934da591758c1691f42995', 'network_id': 'b68164a0-8434-46db-ba67-5eca40538bca', 'ip_version': 4, 'cidr': '42.149.95.64/26', 'allocation_pools': [{'start': '42.149.95.66', 'end': '42.149.95.126'}], 'gateway_ip': '42.149.95.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '42.149.95.66', 'tags': [], 'project_id': 'd38d074eb8934da591758c1691f42995'}}
2026-02-02 03:10:14,310 - INFO - Created VN ctest-mgmt_vn-47295312
2026-02-02 03:10:14,327 - DEBUG - VN ctest-mgmt_vn-47295312 UUID is b68164a0-8434-46db-ba67-5eca40538bca
2026-02-02 03:10:14,409 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:10:14,419 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:10:14,431 - DEBUG - Requesting: http://10.0.0.141:8082/project/d38d074e-b893-4da5-9175-8c1691f42995
2026-02-02 03:10:14,517 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/b68164a0-8434-46db-ba67-5eca40538bca
2026-02-02 03:10:14,530 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/b68164a0-8434-46db-ba67-5eca40538bca
2026-02-02 03:10:14,541 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/b5ea4c69-5412-4c96-83b9-f81f2e6ecde9
2026-02-02 03:10:14,549 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/b5ea4c69-5412-4c96-83b9-f81f2e6ecde9
2026-02-02 03:10:14,555 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/e8cc7912-d6ca-4e40-9452-06164ad6598c
2026-02-02 03:10:14,560 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-02 03:10:14,560 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/b68164a0-8434-46db-ba67-5eca40538bca
2026-02-02 03:10:14,569 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/b5ea4c69-5412-4c96-83b9-f81f2e6ecde9
2026-02-02 03:10:14,594 - INFO - Verified VN network id 10 for VN b68164a0-8434-46db-ba67-5eca40538bca
2026-02-02 03:10:14,595 - INFO - Verifications in API Server for VN ctest-mgmt_vn-47295312 passed
2026-02-02 03:10:14,595 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/b68164a0-8434-46db-ba67-5eca40538bca
2026-02-02 03:10:14,605 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/b5ea4c69-5412-4c96-83b9-f81f2e6ecde9
2026-02-02 03:10:14,612 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/b5ea4c69-5412-4c96-83b9-f81f2e6ecde9
2026-02-02 03:10:14,619 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/e8cc7912-d6ca-4e40-9452-06164ad6598c
2026-02-02 03:10:14,634 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-47295312', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80669226', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13150903027474122459', 'uuid-lslong': '13431808636411415498'}, 'enable': 'true', 'created': '2026-02-02T03:10:14', 'last-modified': '2026-02-02T03:10:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.397349'}
2026-02-02 03:10:14,641 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-02 03:10:14,646 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-47295312', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80669226', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13150903027474122459', 'uuid-lslong': '13431808636411415498'}, 'enable': 'true', 'created': '2026-02-02T03:10:14', 'last-modified': '2026-02-02T03:10:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.417533'}
2026-02-02 03:10:14,652 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-02 03:10:14,668 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-47295312', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80669226', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13150903027474122459', 'uuid-lslong': '13431808636411415498'}, 'enable': 'true', 'created': '2026-02-02T03:10:14', 'last-modified': '2026-02-02T03:10:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.438825'}
2026-02-02 03:10:14,674 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-02 03:10:14,674 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-47295312 passed
2026-02-02 03:10:14,674 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-47295312 in API_Server ======
2026-02-02 03:10:14,674 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:10:14,681 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:10:14,692 - DEBUG - Requesting: http://10.0.0.141:8082/project/d38d074e-b893-4da5-9175-8c1691f42995
2026-02-02 03:10:14,820 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/b68164a0-8434-46db-ba67-5eca40538bca
2026-02-02 03:10:14,831 - DEBUG - =>VN ctest-mgmt_vn-47295312 has no policy to be verified
2026-02-02 03:10:14,831 - DEBUG - Verifying the vn in opserver
2026-02-02 03:10:14,831 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-47295312 virtual network link through opserver 10.0.0.141
2026-02-02 03:10:14,832 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-02-02 03:10:14,845 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-47295312', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-47295312?flat'}
2026-02-02 03:10:14,845 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-47295312 virtual network link through opserver 10.0.0.22
2026-02-02 03:10:14,845 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-02 03:10:14,857 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-47295312', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-47295312?flat'}
2026-02-02 03:10:14,857 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-47295312 virtual network link through opserver 10.0.0.23
2026-02-02 03:10:14,857 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-02 03:10:14,868 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-47295312', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-47295312?flat'}
2026-02-02 03:10:14,868 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-80669226:ctest-mgmt_vn-47295312 is found in opserver
2026-02-02 03:10:14,892 - DEBUG - Do not have enough data to verify VN in agent
2026-02-02 03:10:14,902 - DEBUG - VRF ids for VN ctest-mgmt_vn-47295312: {}
2026-02-02 03:10:15,193 - DEBUG - Response for create_network : {'network': {'id': '2e61dad1-f714-47a4-93f5-c0a1032a91d9', 'name': 'ctest-left_vn-03999201', 'tenant_id': 'd38d074eb8934da591758c1691f42995', 'project_id': 'd38d074eb8934da591758c1691f42995', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-80669226', 'ctest-left_vn-03999201'], 'port_security_enabled': True, 'description': ''}}
2026-02-02 03:10:15,404 - DEBUG - Response for create_subnet : {'subnet': {'id': '4342ec88-448b-4204-bf21-b6f9fe5238d1', 'name': '', 'tenant_id': 'd38d074eb8934da591758c1691f42995', 'network_id': '2e61dad1-f714-47a4-93f5-c0a1032a91d9', 'ip_version': 4, 'cidr': '132.233.208.64/26', 'allocation_pools': [{'start': '132.233.208.66', 'end': '132.233.208.126'}], 'gateway_ip': '132.233.208.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '132.233.208.66', 'tags': [], 'project_id': 'd38d074eb8934da591758c1691f42995'}}
2026-02-02 03:10:15,431 - INFO - Created VN ctest-left_vn-03999201
2026-02-02 03:10:15,443 - DEBUG - VN ctest-left_vn-03999201 UUID is 2e61dad1-f714-47a4-93f5-c0a1032a91d9
2026-02-02 03:10:15,521 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:10:15,530 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:10:15,546 - DEBUG - Requesting: http://10.0.0.141:8082/project/d38d074e-b893-4da5-9175-8c1691f42995
2026-02-02 03:10:15,650 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/2e61dad1-f714-47a4-93f5-c0a1032a91d9
2026-02-02 03:10:15,671 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/2e61dad1-f714-47a4-93f5-c0a1032a91d9
2026-02-02 03:10:15,682 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7b41a4d5-0272-4d99-a383-b604e65a466d
2026-02-02 03:10:15,690 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7b41a4d5-0272-4d99-a383-b604e65a466d
2026-02-02 03:10:15,698 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/3373d78c-7ec2-4d3e-a9df-ad100873e825
2026-02-02 03:10:15,704 - DEBUG - Route Targets: ['target:64512:8000005']
2026-02-02 03:10:15,704 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/2e61dad1-f714-47a4-93f5-c0a1032a91d9
2026-02-02 03:10:15,712 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7b41a4d5-0272-4d99-a383-b604e65a466d
2026-02-02 03:10:15,727 - INFO - Verified VN network id 11 for VN 2e61dad1-f714-47a4-93f5-c0a1032a91d9
2026-02-02 03:10:15,727 - INFO - Verifications in API Server for VN ctest-left_vn-03999201 passed
2026-02-02 03:10:15,727 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/2e61dad1-f714-47a4-93f5-c0a1032a91d9
2026-02-02 03:10:15,736 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7b41a4d5-0272-4d99-a383-b604e65a466d
2026-02-02 03:10:15,744 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7b41a4d5-0272-4d99-a383-b604e65a466d
2026-02-02 03:10:15,752 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/3373d78c-7ec2-4d3e-a9df-ad100873e825
2026-02-02 03:10:15,765 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80669226:ctest-left_vn-03999201', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80669226', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3342192993813940132', 'uuid-lslong': '10661639490644906457'}, 'enable': 'true', 'created': '2026-02-02T03:10:15', 'last-modified': '2026-02-02T03:10:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.406989'}
2026-02-02 03:10:15,771 - DEBUG - Route Targets: ['target:64512:8000005']
2026-02-02 03:10:15,777 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80669226:ctest-left_vn-03999201', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80669226', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3342192993813940132', 'uuid-lslong': '10661639490644906457'}, 'enable': 'true', 'created': '2026-02-02T03:10:15', 'last-modified': '2026-02-02T03:10:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.420627'}
2026-02-02 03:10:15,787 - DEBUG - Route Targets: ['target:64512:8000005']
2026-02-02 03:10:15,793 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80669226:ctest-left_vn-03999201', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80669226', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3342192993813940132', 'uuid-lslong': '10661639490644906457'}, 'enable': 'true', 'created': '2026-02-02T03:10:15', 'last-modified': '2026-02-02T03:10:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.434831'}
2026-02-02 03:10:15,804 - DEBUG - Route Targets: ['target:64512:8000005']
2026-02-02 03:10:15,804 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-03999201 passed
2026-02-02 03:10:15,804 - DEBUG - ====Verifying policy data for ctest-left_vn-03999201 in API_Server ======
2026-02-02 03:10:15,804 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:10:15,811 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:10:15,824 - DEBUG - Requesting: http://10.0.0.141:8082/project/d38d074e-b893-4da5-9175-8c1691f42995
2026-02-02 03:10:15,923 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/2e61dad1-f714-47a4-93f5-c0a1032a91d9
2026-02-02 03:10:15,938 - DEBUG - =>VN ctest-left_vn-03999201 has no policy to be verified
2026-02-02 03:10:15,938 - DEBUG - Verifying the vn in opserver
2026-02-02 03:10:15,938 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80669226:ctest-left_vn-03999201 virtual network link through opserver 10.0.0.141
2026-02-02 03:10:15,938 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-02-02 03:10:15,952 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80669226:ctest-left_vn-03999201', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80669226:ctest-left_vn-03999201?flat'}
2026-02-02 03:10:15,952 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80669226:ctest-left_vn-03999201 virtual network link through opserver 10.0.0.22
2026-02-02 03:10:15,952 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-02 03:10:15,969 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80669226:ctest-left_vn-03999201', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80669226:ctest-left_vn-03999201?flat'}
2026-02-02 03:10:15,969 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80669226:ctest-left_vn-03999201 virtual network link through opserver 10.0.0.23
2026-02-02 03:10:15,969 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-02 03:10:15,982 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80669226:ctest-left_vn-03999201', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80669226:ctest-left_vn-03999201?flat'}
2026-02-02 03:10:15,982 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-80669226:ctest-left_vn-03999201 is found in opserver
2026-02-02 03:10:16,004 - DEBUG - Do not have enough data to verify VN in agent
2026-02-02 03:10:16,015 - DEBUG - VRF ids for VN ctest-left_vn-03999201: {}
2026-02-02 03:10:16,281 - DEBUG - Response for create_network : {'network': {'id': '4583f7a6-2155-4015-b27f-c30d16598482', 'name': 'ctest-right_vn-90431145', 'tenant_id': 'd38d074eb8934da591758c1691f42995', 'project_id': 'd38d074eb8934da591758c1691f42995', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-80669226', 'ctest-right_vn-90431145'], 'port_security_enabled': True, 'description': ''}}
2026-02-02 03:10:16,491 - DEBUG - Response for create_subnet : {'subnet': {'id': '1a9c004e-a778-4963-87da-17fdee82f9e9', 'name': '', 'tenant_id': 'd38d074eb8934da591758c1691f42995', 'network_id': '4583f7a6-2155-4015-b27f-c30d16598482', 'ip_version': 4, 'cidr': '50.184.142.0/26', 'allocation_pools': [{'start': '50.184.142.2', 'end': '50.184.142.62'}], 'gateway_ip': '50.184.142.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '50.184.142.2', 'tags': [], 'project_id': 'd38d074eb8934da591758c1691f42995'}}
2026-02-02 03:10:16,514 - INFO - Created VN ctest-right_vn-90431145
2026-02-02 03:10:16,528 - DEBUG - VN ctest-right_vn-90431145 UUID is 4583f7a6-2155-4015-b27f-c30d16598482
2026-02-02 03:10:16,603 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:10:16,609 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:10:16,620 - DEBUG - Requesting: http://10.0.0.141:8082/project/d38d074e-b893-4da5-9175-8c1691f42995
2026-02-02 03:10:16,715 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/4583f7a6-2155-4015-b27f-c30d16598482
2026-02-02 03:10:16,730 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/4583f7a6-2155-4015-b27f-c30d16598482
2026-02-02 03:10:16,747 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/85d6d467-976e-4ff3-9f09-870322e8b745
2026-02-02 03:10:16,756 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/85d6d467-976e-4ff3-9f09-870322e8b745
2026-02-02 03:10:16,764 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/c87cb503-246c-45a3-8047-add83db5932d
2026-02-02 03:10:16,775 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-02 03:10:16,776 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/4583f7a6-2155-4015-b27f-c30d16598482
2026-02-02 03:10:16,786 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/85d6d467-976e-4ff3-9f09-870322e8b745
2026-02-02 03:10:16,802 - INFO - Verified VN network id 12 for VN 4583f7a6-2155-4015-b27f-c30d16598482
2026-02-02 03:10:16,802 - INFO - Verifications in API Server for VN ctest-right_vn-90431145 passed
2026-02-02 03:10:16,802 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/4583f7a6-2155-4015-b27f-c30d16598482
2026-02-02 03:10:16,813 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/85d6d467-976e-4ff3-9f09-870322e8b745
2026-02-02 03:10:16,821 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/85d6d467-976e-4ff3-9f09-870322e8b745
2026-02-02 03:10:16,836 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/c87cb503-246c-45a3-8047-add83db5932d
2026-02-02 03:10:16,863 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80669226:ctest-right_vn-90431145', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80669226', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5009119503461990421', 'uuid-lslong': '12862213521770382466'}, 'enable': 'true', 'created': '2026-02-02T03:10:16', 'last-modified': '2026-02-02T03:10:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.425427'}
2026-02-02 03:10:16,873 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-02 03:10:16,880 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80669226:ctest-right_vn-90431145', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80669226', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5009119503461990421', 'uuid-lslong': '12862213521770382466'}, 'enable': 'true', 'created': '2026-02-02T03:10:16', 'last-modified': '2026-02-02T03:10:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.447922'}
2026-02-02 03:10:16,887 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-02 03:10:16,894 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80669226:ctest-right_vn-90431145', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80669226', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5009119503461990421', 'uuid-lslong': '12862213521770382466'}, 'enable': 'true', 'created': '2026-02-02T03:10:16', 'last-modified': '2026-02-02T03:10:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.464427'}
2026-02-02 03:10:16,902 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-02 03:10:16,902 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-90431145 passed
2026-02-02 03:10:16,902 - DEBUG - ====Verifying policy data for ctest-right_vn-90431145 in API_Server ======
2026-02-02 03:10:16,902 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:10:16,908 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:10:16,919 - DEBUG - Requesting: http://10.0.0.141:8082/project/d38d074e-b893-4da5-9175-8c1691f42995
2026-02-02 03:10:17,004 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/4583f7a6-2155-4015-b27f-c30d16598482
2026-02-02 03:10:17,016 - DEBUG - =>VN ctest-right_vn-90431145 has no policy to be verified
2026-02-02 03:10:17,016 - DEBUG - Verifying the vn in opserver
2026-02-02 03:10:17,016 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80669226:ctest-right_vn-90431145 virtual network link through opserver 10.0.0.141
2026-02-02 03:10:17,016 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2026-02-02 03:10:17,027 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80669226:ctest-right_vn-90431145', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80669226:ctest-right_vn-90431145?flat'}
2026-02-02 03:10:17,028 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80669226:ctest-right_vn-90431145 virtual network link through opserver 10.0.0.22
2026-02-02 03:10:17,028 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-02-02 03:10:17,041 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80669226:ctest-right_vn-90431145', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80669226:ctest-right_vn-90431145?flat'}
2026-02-02 03:10:17,041 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80669226:ctest-right_vn-90431145 virtual network link through opserver 10.0.0.23
2026-02-02 03:10:17,041 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-02-02 03:10:17,054 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80669226:ctest-right_vn-90431145', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80669226:ctest-right_vn-90431145?flat'}
2026-02-02 03:10:17,054 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-80669226:ctest-right_vn-90431145 is found in opserver
2026-02-02 03:10:17,076 - DEBUG - Do not have enough data to verify VN in agent
2026-02-02 03:10:17,087 - DEBUG - VRF ids for VN ctest-right_vn-90431145: {}
2026-02-02 03:10:18,161 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5167-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5167-2)
2026-02-02 03:10:19,467 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5167-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5167-1)
2026-02-02 03:10:19,467 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-99922840']
2026-02-02 03:10:19,762 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-99922840'] created succesfully
2026-02-02 03:10:20,068 - DEBUG - Image by name tiny_nat_fw not found
2026-02-02 03:10:20,068 - DEBUG - Installing image tiny_nat_fw
2026-02-02 03:10:20,068 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-02-02 03:10:20,069 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-02 03:10:20,069 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-02 03:10:20,069 - DEBUG - Unzip image
2026-02-02 03:10:20,069 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-02-02 03:10:20,091 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-02-02 03:10:20,091 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-99922840']
2026-02-02 03:10:20,197 - INFO - Service template: ['default-domain', 'ctest-service_template_1-99922840'] deleted successfully.
2026-02-02 03:10:20,197 - INFO - Skip interface_detach for VM ctest-right_vm-23308834 in state BUILD
2026-02-02 03:10:20,197 - INFO - Deleting VM ctest-right_vm-23308834
2026-02-02 03:10:20,198 - ERROR - VM ctest-right_vm-23308834 has failed to come up
2026-02-02 03:10:20,198 - ERROR - Nova failed to get host of the VM
2026-02-02 03:10:20,198 - ERROR - VM ctest-right_vm-23308834 has failed to come up
2026-02-02 03:10:20,198 - ERROR - Nova failed to get host of the VM
2026-02-02 03:10:20,283 - INFO - Skip interface_detach for VM ctest-left_vm-16289662 in state BUILD
2026-02-02 03:10:20,283 - INFO - Deleting VM ctest-left_vm-16289662
2026-02-02 03:10:20,283 - ERROR - VM ctest-left_vm-16289662 has failed to come up
2026-02-02 03:10:20,283 - ERROR - Nova failed to get host of the VM
2026-02-02 03:10:20,283 - ERROR - VM ctest-left_vm-16289662 has failed to come up
2026-02-02 03:10:20,283 - ERROR - Nova failed to get host of the VM
2026-02-02 03:10:20,369 - INFO - Deleting VN ctest-right_vn-90431145
2026-02-02 03:10:20,409 - DEBUG - VN 4583f7a6-2155-4015-b27f-c30d16598482 still in use: Unable to complete operation on network 4583f7a6-2155-4015-b27f-c30d16598482. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-680dc326-b7f2-4c5f-968c-13212f2d4ec4']
2026-02-02 03:10:20,409 - WARNING - Deleting VN ctest-right_vn-90431145 failed..Will retry
2026-02-02 03:10:22,546 - DEBUG - Response for deleting network ()
2026-02-02 03:10:22,546 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/85d6d467-976e-4ff3-9f09-870322e8b745
2026-02-02 03:10:22,553 - DEBUG - Response Code: 404
2026-02-02 03:10:22,554 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:10:22,559 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:10:22,572 - DEBUG - Requesting: http://10.0.0.141:8082/project/d38d074e-b893-4da5-9175-8c1691f42995
2026-02-02 03:10:22,669 - INFO - Validated that VN ctest-right_vn-90431145 is not found in API Server
2026-02-02 03:10:22,679 - DEBUG - VN ctest-right_vn-90431145 is not present in Agent 10.0.0.50
2026-02-02 03:10:22,691 - DEBUG - VN ctest-right_vn-90431145 is not present in Agent 10.0.0.65
2026-02-02 03:10:22,691 - INFO - Validated that VN ctest-right_vn-90431145 is not in any agent
2026-02-02 03:10:22,720 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-90431145 info
2026-02-02 03:10:22,720 - INFO - Deleting VN ctest-left_vn-03999201
2026-02-02 03:10:22,850 - DEBUG - Response for deleting network ()
2026-02-02 03:10:22,850 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7b41a4d5-0272-4d99-a383-b604e65a466d
2026-02-02 03:10:22,855 - DEBUG - Response Code: 404
2026-02-02 03:10:22,856 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:10:22,862 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:10:22,872 - DEBUG - Requesting: http://10.0.0.141:8082/project/d38d074e-b893-4da5-9175-8c1691f42995
2026-02-02 03:10:22,973 - INFO - Validated that VN ctest-left_vn-03999201 is not found in API Server
2026-02-02 03:10:22,990 - DEBUG - VN ctest-left_vn-03999201 is not present in Agent 10.0.0.50
2026-02-02 03:10:23,004 - DEBUG - VN ctest-left_vn-03999201 is not present in Agent 10.0.0.65
2026-02-02 03:10:23,004 - INFO - Validated that VN ctest-left_vn-03999201 is not in any agent
2026-02-02 03:10:23,034 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-03999201 info
2026-02-02 03:10:23,034 - INFO - Deleting VN ctest-mgmt_vn-47295312
2026-02-02 03:10:23,170 - DEBUG - Response for deleting network ()
2026-02-02 03:10:23,170 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/b5ea4c69-5412-4c96-83b9-f81f2e6ecde9
2026-02-02 03:10:23,176 - DEBUG - Response Code: 404
2026-02-02 03:10:23,176 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2026-02-02 03:10:23,182 - DEBUG - Requesting: http://10.0.0.141:8082/domain/4480bafd-5776-4d34-b387-df5887123349
2026-02-02 03:10:23,242 - DEBUG - Requesting: http://10.0.0.141:8082/project/d38d074e-b893-4da5-9175-8c1691f42995
2026-02-02 03:10:23,322 - INFO - Validated that VN ctest-mgmt_vn-47295312 is not found in API Server
2026-02-02 03:10:23,334 - DEBUG - VN ctest-mgmt_vn-47295312 is not present in Agent 10.0.0.50
2026-02-02 03:10:23,345 - DEBUG - VN ctest-mgmt_vn-47295312 is not present in Agent 10.0.0.65
2026-02-02 03:10:23,345 - INFO - Validated that VN ctest-mgmt_vn-47295312 is not in any agent
2026-02-02 03:10:23,374 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-47295312 info
2026-02-02 03:10:24,673 - DEBUG - No XMPP flaps were noticed during the test
2026-02-02 03:10:24,673 - INFO -
2026-02-02 03:10:24,673 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:12]
2026-02-02 03:10:24,673 - INFO - --------------------------------------------------------------------------------
2026-02-02 03:10:25,394 - INFO - Deleted project: ctest-TestSvcRegr-80669226, ID : d38d074e-b893-4da5-9175-8c1691f42995