]) created on node: (an-jenkins-deploy-platform-ansible-os-5792-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5792-2)
2026-05-18 03:22:10,426 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-93768663']
2026-05-18 03:22:10,748 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-93768663'] created succesfully
2026-05-18 03:22:11,276 - DEBUG - Image by name tiny_nat_fw not found
2026-05-18 03:22:11,276 - DEBUG - Installing image tiny_nat_fw
2026-05-18 03:22:11,276 - 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-05-18 03:22:11,277 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-05-18 03:22:11,277 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-05-18 03:22:11,299 - 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-05-18 03:22:11,358 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-18 03:22:11,358 - DEBUG - Unzip image
2026-05-18 03:22:11,358 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-18 03:22:11,387 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-05-18 03:22:11,387 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-93768663']
2026-05-18 03:22:11,493 - INFO - Service template: ['default-domain', 'ctest-service_template_1-93768663'] deleted successfully.
2026-05-18 03:22:11,493 - INFO - Skip interface_detach for VM ctest-right_vm-00658369 in state BUILD
2026-05-18 03:22:11,493 - INFO - Deleting VM ctest-right_vm-00658369
2026-05-18 03:22:11,536 - ERROR - VM ctest-right_vm-00658369 has failed to come up
2026-05-18 03:22:11,537 - ERROR - Nova failed to get host of the VM
2026-05-18 03:22:11,537 - ERROR - VM ctest-right_vm-00658369 has failed to come up
2026-05-18 03:22:11,537 - ERROR - Nova failed to get host of the VM
2026-05-18 03:22:11,629 - INFO - Skip interface_detach for VM ctest-left_vm-60060476 in state BUILD
2026-05-18 03:22:11,630 - INFO - Deleting VM ctest-left_vm-60060476
2026-05-18 03:22:11,630 - ERROR - VM ctest-left_vm-60060476 has failed to come up
2026-05-18 03:22:11,630 - ERROR - Nova failed to get host of the VM
2026-05-18 03:22:11,630 - ERROR - VM ctest-left_vm-60060476 has failed to come up
2026-05-18 03:22:11,630 - ERROR - Nova failed to get host of the VM
2026-05-18 03:22:11,707 - INFO - Deleting VN ctest-right_vn-80420676
2026-05-18 03:22:11,764 - DEBUG - VN ba71e382-e4be-4b0d-a155-0b5f235d396f still in use: Unable to complete operation on network ba71e382-e4be-4b0d-a155-0b5f235d396f. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-9bb0681d-ae8a-411a-81de-be314db18da6']
2026-05-18 03:22:11,764 - WARNING - Deleting VN ctest-right_vn-80420676 failed..Will retry
2026-05-18 03:22:13,976 - DEBUG - Response for deleting network ()
2026-05-18 03:22:13,976 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/c4f77a0b-a00a-43cb-81e8-0bc09918c94e
2026-05-18 03:22:13,982 - DEBUG - Response Code: 404
2026-05-18 03:22:13,983 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:13,989 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:14,017 - DEBUG - Requesting: http://10.0.0.23:8082/project/4ba09285-4ceb-403d-a006-195c7c256e49
2026-05-18 03:22:14,108 - INFO - Validated that VN ctest-right_vn-80420676 is not found in API Server
2026-05-18 03:22:14,124 - DEBUG - VN ctest-right_vn-80420676 is not present in Agent 10.0.0.65
2026-05-18 03:22:14,133 - DEBUG - VN ctest-right_vn-80420676 is not present in Agent 10.0.0.130
2026-05-18 03:22:14,134 - INFO - Validated that VN ctest-right_vn-80420676 is not in any agent
2026-05-18 03:22:14,176 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-80420676 info
2026-05-18 03:22:14,176 - INFO - Deleting VN ctest-left_vn-59823150
2026-05-18 03:22:14,340 - DEBUG - Response for deleting network ()
2026-05-18 03:22:14,341 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/96cc6bf6-bbe7-4397-9306-efc981ae885d
2026-05-18 03:22:14,346 - DEBUG - Response Code: 404
2026-05-18 03:22:14,346 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:14,352 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:14,408 - DEBUG - Requesting: http://10.0.0.23:8082/project/4ba09285-4ceb-403d-a006-195c7c256e49
2026-05-18 03:22:14,509 - INFO - Validated that VN ctest-left_vn-59823150 is not found in API Server
2026-05-18 03:22:14,522 - DEBUG - VN ctest-left_vn-59823150 is not present in Agent 10.0.0.65
2026-05-18 03:22:14,553 - DEBUG - VN ctest-left_vn-59823150 is not present in Agent 10.0.0.130
2026-05-18 03:22:14,553 - INFO - Validated that VN ctest-left_vn-59823150 is not in any agent
2026-05-18 03:22:14,602 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-59823150 info
2026-05-18 03:22:14,602 - INFO - Deleting VN ctest-mgmt_vn-61623972
2026-05-18 03:22:14,788 - DEBUG - Response for deleting network ()
2026-05-18 03:22:14,789 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/b763171c-149b-4e7a-b6f1-c04bd25655cd
2026-05-18 03:22:14,795 - DEBUG - Response Code: 404
2026-05-18 03:22:14,795 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:14,814 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:14,834 - DEBUG - Requesting: http://10.0.0.23:8082/project/4ba09285-4ceb-403d-a006-195c7c256e49
2026-05-18 03:22:14,923 - INFO - Validated that VN ctest-mgmt_vn-61623972 is not found in API Server
2026-05-18 03:22:14,936 - DEBUG - VN ctest-mgmt_vn-61623972 is not present in Agent 10.0.0.65
2026-05-18 03:22:14,949 - DEBUG - VN ctest-mgmt_vn-61623972 is not present in Agent 10.0.0.130
2026-05-18 03:22:14,949 - INFO - Validated that VN ctest-mgmt_vn-61623972 is not in any agent
2026-05-18 03:22:14,985 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-61623972 info
2026-05-18 03:22:14,986 - INFO - Deleting VM ctest-vm-in-third-vn-30885379
2026-05-18 03:22:15,059 - INFO - Deleting VN ctest-third-vn-00510716
2026-05-18 03:22:15,108 - DEBUG - VN 043288bb-6a06-485b-a58b-84c1245ba090 still in use: Unable to complete operation on network 043288bb-6a06-485b-a58b-84c1245ba090. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-2f30d8a6-c8ae-4768-b356-60ef01009f37']
2026-05-18 03:22:15,109 - WARNING - Deleting VN ctest-third-vn-00510716 failed..Will retry
2026-05-18 03:22:17,279 - DEBUG - Response for deleting network ()
2026-05-18 03:22:18,579 - DEBUG - No XMPP flaps were noticed during the test
2026-05-18 03:22:18,579 - INFO -
2026-05-18 03:22:18,579 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:26]
2026-05-18 03:22:18,579 - INFO - --------------------------------------------------------------------------------
2026-05-18 03:22:18,582 - INFO - ================================================================================
2026-05-18 03:22:18,582 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2026-05-18 03:22:19,878 - DEBUG - Nothing to compare xmpp stats {'10.0.0.65': {'10.20.0.129': '0', '10.20.0.25': '2'}, '10.0.0.130': {'10.20.0.25': '0', '10.20.0.129': '3'}} with
2026-05-18 03:22:19,878 - INFO - Initial checks done. Running the testcase now
2026-05-18 03:22:19,878 - INFO -
2026-05-18 03:22:20,171 - DEBUG - Response for create_network : {'network': {'id': 'bd0caf8e-0f20-46fe-8ed9-422e14eb6ddf', 'name': 'ctest-mgmt_vn-05421288', 'tenant_id': '4ba092854ceb403da006195c7c256e49', 'project_id': '4ba092854ceb403da006195c7c256e49', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-77270547', 'ctest-mgmt_vn-05421288'], 'port_security_enabled': True, 'description': ''}}
2026-05-18 03:22:20,392 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd4829b21-94ed-4b6c-b177-c3400e58ad34', 'name': '', 'tenant_id': '4ba092854ceb403da006195c7c256e49', 'network_id': 'bd0caf8e-0f20-46fe-8ed9-422e14eb6ddf', 'ip_version': 4, 'cidr': '92.135.182.64/26', 'allocation_pools': [{'start': '92.135.182.66', 'end': '92.135.182.126'}], 'gateway_ip': '92.135.182.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '92.135.182.66', 'tags': [], 'project_id': '4ba092854ceb403da006195c7c256e49'}}
2026-05-18 03:22:20,425 - INFO - Created VN ctest-mgmt_vn-05421288
2026-05-18 03:22:20,440 - DEBUG - VN ctest-mgmt_vn-05421288 UUID is bd0caf8e-0f20-46fe-8ed9-422e14eb6ddf
2026-05-18 03:22:20,525 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:20,533 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:20,546 - DEBUG - Requesting: http://10.0.0.23:8082/project/4ba09285-4ceb-403d-a006-195c7c256e49
2026-05-18 03:22:20,645 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/bd0caf8e-0f20-46fe-8ed9-422e14eb6ddf
2026-05-18 03:22:20,659 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/bd0caf8e-0f20-46fe-8ed9-422e14eb6ddf
2026-05-18 03:22:20,673 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/8e7b8040-bfd0-42ae-b5af-5bf3874ba74a
2026-05-18 03:22:20,684 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/8e7b8040-bfd0-42ae-b5af-5bf3874ba74a
2026-05-18 03:22:20,693 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/96931c3b-92d5-47d9-96ff-1cf547a3e14d
2026-05-18 03:22:20,701 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-18 03:22:20,701 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/bd0caf8e-0f20-46fe-8ed9-422e14eb6ddf
2026-05-18 03:22:20,715 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/8e7b8040-bfd0-42ae-b5af-5bf3874ba74a
2026-05-18 03:22:20,733 - INFO - Verified VN network id 13 for VN bd0caf8e-0f20-46fe-8ed9-422e14eb6ddf
2026-05-18 03:22:20,733 - INFO - Verifications in API Server for VN ctest-mgmt_vn-05421288 passed
2026-05-18 03:22:20,734 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/bd0caf8e-0f20-46fe-8ed9-422e14eb6ddf
2026-05-18 03:22:20,747 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/8e7b8040-bfd0-42ae-b5af-5bf3874ba74a
2026-05-18 03:22:20,758 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/8e7b8040-bfd0-42ae-b5af-5bf3874ba74a
2026-05-18 03:22:20,770 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/96931c3b-92d5-47d9-96ff-1cf547a3e14d
2026-05-18 03:22:20,791 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-77270547:ctest-mgmt_vn-05421288', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-77270547', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13622455997562898174', 'uuid-lslong': '10293331189018881503'}, 'enable': 'true', 'created': '2026-05-18T03:22:20', 'last-modified': '2026-05-18T03:22:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.461819'}
2026-05-18 03:22:20,801 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-18 03:22:20,808 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-77270547:ctest-mgmt_vn-05421288', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-77270547', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13622455997562898174', 'uuid-lslong': '10293331189018881503'}, 'enable': 'true', 'created': '2026-05-18T03:22:20', 'last-modified': '2026-05-18T03:22:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.483850'}
2026-05-18 03:22:20,816 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-18 03:22:20,822 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-77270547:ctest-mgmt_vn-05421288', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-77270547', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13622455997562898174', 'uuid-lslong': '10293331189018881503'}, 'enable': 'true', 'created': '2026-05-18T03:22:20', 'last-modified': '2026-05-18T03:22:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.493812'}
2026-05-18 03:22:20,830 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-18 03:22:20,830 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-05421288 passed
2026-05-18 03:22:20,830 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-05421288 in API_Server ======
2026-05-18 03:22:20,830 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:20,838 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:20,854 - DEBUG - Requesting: http://10.0.0.23:8082/project/4ba09285-4ceb-403d-a006-195c7c256e49
2026-05-18 03:22:20,956 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/bd0caf8e-0f20-46fe-8ed9-422e14eb6ddf
2026-05-18 03:22:20,966 - DEBUG - =>VN ctest-mgmt_vn-05421288 has no policy to be verified
2026-05-18 03:22:20,966 - DEBUG - Verifying the vn in opserver
2026-05-18 03:22:20,966 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-77270547:ctest-mgmt_vn-05421288 virtual network link through opserver 10.0.0.23
2026-05-18 03:22:20,966 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-18 03:22:20,981 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-77270547:ctest-mgmt_vn-05421288', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-77270547:ctest-mgmt_vn-05421288?flat'}
2026-05-18 03:22:20,981 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-77270547:ctest-mgmt_vn-05421288 virtual network link through opserver 10.0.0.22
2026-05-18 03:22:20,981 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-18 03:22:20,997 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-77270547:ctest-mgmt_vn-05421288', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-77270547:ctest-mgmt_vn-05421288?flat'}
2026-05-18 03:22:20,997 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-77270547:ctest-mgmt_vn-05421288 virtual network link through opserver 10.0.0.240
2026-05-18 03:22:20,997 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-05-18 03:22:21,012 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-77270547:ctest-mgmt_vn-05421288', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-77270547:ctest-mgmt_vn-05421288?flat'}
2026-05-18 03:22:21,012 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-77270547:ctest-mgmt_vn-05421288 is found in opserver
2026-05-18 03:22:21,035 - DEBUG - Do not have enough data to verify VN in agent
2026-05-18 03:22:21,046 - DEBUG - VRF ids for VN ctest-mgmt_vn-05421288: {}
2026-05-18 03:22:21,328 - DEBUG - Response for create_network : {'network': {'id': '159025be-2760-4ead-9f87-a12a3fa7c31f', 'name': 'ctest-left_vn-51176033', 'tenant_id': '4ba092854ceb403da006195c7c256e49', 'project_id': '4ba092854ceb403da006195c7c256e49', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-77270547', 'ctest-left_vn-51176033'], 'port_security_enabled': True, 'description': ''}}
2026-05-18 03:22:21,599 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd10ceb05-6eae-4f93-bce4-f71b1aac8734', 'name': '', 'tenant_id': '4ba092854ceb403da006195c7c256e49', 'network_id': '159025be-2760-4ead-9f87-a12a3fa7c31f', 'ip_version': 4, 'cidr': '46.173.13.64/26', 'allocation_pools': [{'start': '46.173.13.66', 'end': '46.173.13.126'}], 'gateway_ip': '46.173.13.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '46.173.13.66', 'tags': [], 'project_id': '4ba092854ceb403da006195c7c256e49'}}
2026-05-18 03:22:21,625 - INFO - Created VN ctest-left_vn-51176033
2026-05-18 03:22:21,637 - DEBUG - VN ctest-left_vn-51176033 UUID is 159025be-2760-4ead-9f87-a12a3fa7c31f
2026-05-18 03:22:21,728 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:21,734 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:21,747 - DEBUG - Requesting: http://10.0.0.23:8082/project/4ba09285-4ceb-403d-a006-195c7c256e49
2026-05-18 03:22:21,854 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/159025be-2760-4ead-9f87-a12a3fa7c31f
2026-05-18 03:22:21,868 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/159025be-2760-4ead-9f87-a12a3fa7c31f
2026-05-18 03:22:21,880 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/2c1b9572-b32a-4c3e-b8b7-465c7af7175e
2026-05-18 03:22:21,889 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/2c1b9572-b32a-4c3e-b8b7-465c7af7175e
2026-05-18 03:22:21,900 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/1ccb92dc-c8ae-4af5-8249-d993a97f4bb3
2026-05-18 03:22:21,910 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-18 03:22:21,910 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/159025be-2760-4ead-9f87-a12a3fa7c31f
2026-05-18 03:22:21,921 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/2c1b9572-b32a-4c3e-b8b7-465c7af7175e
2026-05-18 03:22:21,944 - INFO - Verified VN network id 14 for VN 159025be-2760-4ead-9f87-a12a3fa7c31f
2026-05-18 03:22:21,944 - INFO - Verifications in API Server for VN ctest-left_vn-51176033 passed
2026-05-18 03:22:21,945 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/159025be-2760-4ead-9f87-a12a3fa7c31f
2026-05-18 03:22:21,960 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/2c1b9572-b32a-4c3e-b8b7-465c7af7175e
2026-05-18 03:22:21,969 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/2c1b9572-b32a-4c3e-b8b7-465c7af7175e
2026-05-18 03:22:21,977 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/1ccb92dc-c8ae-4af5-8249-d993a97f4bb3
2026-05-18 03:22:21,994 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-77270547:ctest-left_vn-51176033', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-77270547', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1553783370077458093', 'uuid-lslong': '11495333776715137823'}, 'enable': 'true', 'created': '2026-05-18T03:22:21', 'last-modified': '2026-05-18T03:22:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.463870'}
2026-05-18 03:22:22,001 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-18 03:22:22,007 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-77270547:ctest-left_vn-51176033', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-77270547', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1553783370077458093', 'uuid-lslong': '11495333776715137823'}, 'enable': 'true', 'created': '2026-05-18T03:22:21', 'last-modified': '2026-05-18T03:22:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.470951'}
2026-05-18 03:22:22,014 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-18 03:22:22,020 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-77270547:ctest-left_vn-51176033', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-77270547', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1553783370077458093', 'uuid-lslong': '11495333776715137823'}, 'enable': 'true', 'created': '2026-05-18T03:22:21', 'last-modified': '2026-05-18T03:22:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.481427'}
2026-05-18 03:22:22,027 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-18 03:22:22,027 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-51176033 passed
2026-05-18 03:22:22,028 - DEBUG - ====Verifying policy data for ctest-left_vn-51176033 in API_Server ======
2026-05-18 03:22:22,028 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:22,036 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:22,050 - DEBUG - Requesting: http://10.0.0.23:8082/project/4ba09285-4ceb-403d-a006-195c7c256e49
2026-05-18 03:22:22,156 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/159025be-2760-4ead-9f87-a12a3fa7c31f
2026-05-18 03:22:22,166 - DEBUG - =>VN ctest-left_vn-51176033 has no policy to be verified
2026-05-18 03:22:22,166 - DEBUG - Verifying the vn in opserver
2026-05-18 03:22:22,166 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-77270547:ctest-left_vn-51176033 virtual network link through opserver 10.0.0.23
2026-05-18 03:22:22,166 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-18 03:22:22,180 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-77270547:ctest-left_vn-51176033', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-77270547:ctest-left_vn-51176033?flat'}
2026-05-18 03:22:22,180 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-77270547:ctest-left_vn-51176033 virtual network link through opserver 10.0.0.22
2026-05-18 03:22:22,180 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-18 03:22:22,193 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-77270547:ctest-left_vn-51176033', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-77270547:ctest-left_vn-51176033?flat'}
2026-05-18 03:22:22,193 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-77270547:ctest-left_vn-51176033 virtual network link through opserver 10.0.0.240
2026-05-18 03:22:22,193 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-05-18 03:22:22,208 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-77270547:ctest-left_vn-51176033', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-77270547:ctest-left_vn-51176033?flat'}
2026-05-18 03:22:22,208 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-77270547:ctest-left_vn-51176033 is found in opserver
2026-05-18 03:22:22,230 - DEBUG - Do not have enough data to verify VN in agent
2026-05-18 03:22:22,242 - DEBUG - VRF ids for VN ctest-left_vn-51176033: {}
2026-05-18 03:22:22,521 - DEBUG - Response for create_network : {'network': {'id': '6e56125f-bf3f-4ae8-8366-9dfd3036dd5c', 'name': 'ctest-right_vn-13033341', 'tenant_id': '4ba092854ceb403da006195c7c256e49', 'project_id': '4ba092854ceb403da006195c7c256e49', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-77270547', 'ctest-right_vn-13033341'], 'port_security_enabled': True, 'description': ''}}
2026-05-18 03:22:22,751 - DEBUG - Response for create_subnet : {'subnet': {'id': '4430b8c9-c31d-482f-94bc-d3eb1842273b', 'name': '', 'tenant_id': '4ba092854ceb403da006195c7c256e49', 'network_id': '6e56125f-bf3f-4ae8-8366-9dfd3036dd5c', 'ip_version': 4, 'cidr': '76.29.62.0/26', 'allocation_pools': [{'start': '76.29.62.2', 'end': '76.29.62.62'}], 'gateway_ip': '76.29.62.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '76.29.62.2', 'tags': [], 'project_id': '4ba092854ceb403da006195c7c256e49'}}
2026-05-18 03:22:22,779 - INFO - Created VN ctest-right_vn-13033341
2026-05-18 03:22:22,793 - DEBUG - VN ctest-right_vn-13033341 UUID is 6e56125f-bf3f-4ae8-8366-9dfd3036dd5c
2026-05-18 03:22:22,872 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:22,880 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:22,892 - DEBUG - Requesting: http://10.0.0.23:8082/project/4ba09285-4ceb-403d-a006-195c7c256e49
2026-05-18 03:22:23,005 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/6e56125f-bf3f-4ae8-8366-9dfd3036dd5c
2026-05-18 03:22:23,019 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/6e56125f-bf3f-4ae8-8366-9dfd3036dd5c
2026-05-18 03:22:23,028 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/e166babc-cd09-4bcc-937f-f850815e7655
2026-05-18 03:22:23,036 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/e166babc-cd09-4bcc-937f-f850815e7655
2026-05-18 03:22:23,043 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/da3e38b4-360e-41c5-9875-e0245514bcf5
2026-05-18 03:22:23,053 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-18 03:22:23,053 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/6e56125f-bf3f-4ae8-8366-9dfd3036dd5c
2026-05-18 03:22:23,064 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/e166babc-cd09-4bcc-937f-f850815e7655
2026-05-18 03:22:23,083 - INFO - Verified VN network id 15 for VN 6e56125f-bf3f-4ae8-8366-9dfd3036dd5c
2026-05-18 03:22:23,083 - INFO - Verifications in API Server for VN ctest-right_vn-13033341 passed
2026-05-18 03:22:23,083 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/6e56125f-bf3f-4ae8-8366-9dfd3036dd5c
2026-05-18 03:22:23,096 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/e166babc-cd09-4bcc-937f-f850815e7655
2026-05-18 03:22:23,105 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/e166babc-cd09-4bcc-937f-f850815e7655
2026-05-18 03:22:23,119 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/da3e38b4-360e-41c5-9875-e0245514bcf5
2026-05-18 03:22:23,135 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-77270547:ctest-right_vn-13033341', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-77270547', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7950562394608978664', 'uuid-lslong': '9468428977354235228'}, 'enable': 'true', 'created': '2026-05-18T03:22:22', 'last-modified': '2026-05-18T03:22:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.428526'}
2026-05-18 03:22:23,142 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-18 03:22:23,151 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-77270547:ctest-right_vn-13033341', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-77270547', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7950562394608978664', 'uuid-lslong': '9468428977354235228'}, 'enable': 'true', 'created': '2026-05-18T03:22:22', 'last-modified': '2026-05-18T03:22:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.451771'}
2026-05-18 03:22:23,158 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-18 03:22:23,164 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-77270547:ctest-right_vn-13033341', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-77270547', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7950562394608978664', 'uuid-lslong': '9468428977354235228'}, 'enable': 'true', 'created': '2026-05-18T03:22:22', 'last-modified': '2026-05-18T03:22:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.463142'}
2026-05-18 03:22:23,174 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-18 03:22:23,174 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-13033341 passed
2026-05-18 03:22:23,174 - DEBUG - ====Verifying policy data for ctest-right_vn-13033341 in API_Server ======
2026-05-18 03:22:23,174 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:23,181 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:23,193 - DEBUG - Requesting: http://10.0.0.23:8082/project/4ba09285-4ceb-403d-a006-195c7c256e49
2026-05-18 03:22:23,295 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/6e56125f-bf3f-4ae8-8366-9dfd3036dd5c
2026-05-18 03:22:23,308 - DEBUG - =>VN ctest-right_vn-13033341 has no policy to be verified
2026-05-18 03:22:23,308 - DEBUG - Verifying the vn in opserver
2026-05-18 03:22:23,308 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-77270547:ctest-right_vn-13033341 virtual network link through opserver 10.0.0.23
2026-05-18 03:22:23,308 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-18 03:22:23,322 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-77270547:ctest-right_vn-13033341', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-77270547:ctest-right_vn-13033341?flat'}
2026-05-18 03:22:23,322 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-77270547:ctest-right_vn-13033341 virtual network link through opserver 10.0.0.22
2026-05-18 03:22:23,322 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-18 03:22:23,335 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-77270547:ctest-right_vn-13033341', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-77270547:ctest-right_vn-13033341?flat'}
2026-05-18 03:22:23,335 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-77270547:ctest-right_vn-13033341 virtual network link through opserver 10.0.0.240
2026-05-18 03:22:23,335 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-05-18 03:22:23,350 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-77270547:ctest-right_vn-13033341', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-77270547:ctest-right_vn-13033341?flat'}
2026-05-18 03:22:23,350 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-77270547:ctest-right_vn-13033341 is found in opserver
2026-05-18 03:22:23,378 - DEBUG - Do not have enough data to verify VN in agent
2026-05-18 03:22:23,390 - DEBUG - VRF ids for VN ctest-right_vn-13033341: {}
2026-05-18 03:22:23,705 - DEBUG - Response for create_network : {'network': {'id': '616ce1d9-7cd6-49c7-92a7-4eebc0fba65a', 'name': 'ctest-trans_left_vn-88832097', 'tenant_id': '4ba092854ceb403da006195c7c256e49', 'project_id': '4ba092854ceb403da006195c7c256e49', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-77270547', 'ctest-trans_left_vn-88832097'], 'port_security_enabled': True, 'description': ''}}
2026-05-18 03:22:23,938 - DEBUG - Response for create_subnet : {'subnet': {'id': '0a08d5f9-a833-434f-b3d1-91b460f4d768', 'name': '', 'tenant_id': '4ba092854ceb403da006195c7c256e49', 'network_id': '616ce1d9-7cd6-49c7-92a7-4eebc0fba65a', 'ip_version': 4, 'cidr': '49.103.108.64/26', 'allocation_pools': [{'start': '49.103.108.66', 'end': '49.103.108.126'}], 'gateway_ip': '49.103.108.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '49.103.108.66', 'tags': [], 'project_id': '4ba092854ceb403da006195c7c256e49'}}
2026-05-18 03:22:23,963 - INFO - Created VN ctest-trans_left_vn-88832097
2026-05-18 03:22:23,975 - DEBUG - VN ctest-trans_left_vn-88832097 UUID is 616ce1d9-7cd6-49c7-92a7-4eebc0fba65a
2026-05-18 03:22:24,062 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:24,068 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:24,082 - DEBUG - Requesting: http://10.0.0.23:8082/project/4ba09285-4ceb-403d-a006-195c7c256e49
2026-05-18 03:22:24,184 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/616ce1d9-7cd6-49c7-92a7-4eebc0fba65a
2026-05-18 03:22:24,196 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/616ce1d9-7cd6-49c7-92a7-4eebc0fba65a
2026-05-18 03:22:24,206 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/78c0bcc5-cf85-4419-86a8-b706c29f0f03
2026-05-18 03:22:24,217 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/78c0bcc5-cf85-4419-86a8-b706c29f0f03
2026-05-18 03:22:24,225 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/21d40355-eba4-4487-af74-9f83eb654ecb
2026-05-18 03:22:24,231 - DEBUG - Route Targets: ['target:64512:8000010']
2026-05-18 03:22:24,231 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/616ce1d9-7cd6-49c7-92a7-4eebc0fba65a
2026-05-18 03:22:24,248 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/78c0bcc5-cf85-4419-86a8-b706c29f0f03
2026-05-18 03:22:24,268 - INFO - Verified VN network id 16 for VN 616ce1d9-7cd6-49c7-92a7-4eebc0fba65a
2026-05-18 03:22:24,268 - INFO - Verifications in API Server for VN ctest-trans_left_vn-88832097 passed
2026-05-18 03:22:24,268 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/616ce1d9-7cd6-49c7-92a7-4eebc0fba65a
2026-05-18 03:22:24,279 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/78c0bcc5-cf85-4419-86a8-b706c29f0f03
2026-05-18 03:22:24,289 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/78c0bcc5-cf85-4419-86a8-b706c29f0f03
2026-05-18 03:22:24,297 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/21d40355-eba4-4487-af74-9f83eb654ecb
2026-05-18 03:22:24,309 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-77270547:ctest-trans_left_vn-88832097', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-77270547', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7020234243382331847', 'uuid-lslong': '10567501825110156890'}, 'enable': 'true', 'created': '2026-05-18T03:22:23', 'last-modified': '2026-05-18T03:22:23', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.437538'}
2026-05-18 03:22:24,316 - DEBUG - Route Targets: ['target:64512:8000010']
2026-05-18 03:22:24,321 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-77270547:ctest-trans_left_vn-88832097', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-77270547', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7020234243382331847', 'uuid-lslong': '10567501825110156890'}, 'enable': 'true', 'created': '2026-05-18T03:22:23', 'last-modified': '2026-05-18T03:22:23', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.449562'}
2026-05-18 03:22:24,328 - DEBUG - Route Targets: ['target:64512:8000010']
2026-05-18 03:22:24,334 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-77270547:ctest-trans_left_vn-88832097', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-77270547', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7020234243382331847', 'uuid-lslong': '10567501825110156890'}, 'enable': 'true', 'created': '2026-05-18T03:22:23', 'last-modified': '2026-05-18T03:22:23', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.464000'}
2026-05-18 03:22:24,345 - DEBUG - Route Targets: ['target:64512:8000010']
2026-05-18 03:22:24,345 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-88832097 passed
2026-05-18 03:22:24,345 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-88832097 in API_Server ======
2026-05-18 03:22:24,345 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:24,351 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:24,366 - DEBUG - Requesting: http://10.0.0.23:8082/project/4ba09285-4ceb-403d-a006-195c7c256e49
2026-05-18 03:22:24,543 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/616ce1d9-7cd6-49c7-92a7-4eebc0fba65a
2026-05-18 03:22:24,554 - DEBUG - =>VN ctest-trans_left_vn-88832097 has no policy to be verified
2026-05-18 03:22:24,554 - DEBUG - Verifying the vn in opserver
2026-05-18 03:22:24,554 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-77270547:ctest-trans_left_vn-88832097 virtual network link through opserver 10.0.0.23
2026-05-18 03:22:24,554 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-18 03:22:24,568 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-77270547:ctest-trans_left_vn-88832097', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-77270547:ctest-trans_left_vn-88832097?flat'}
2026-05-18 03:22:24,568 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-77270547:ctest-trans_left_vn-88832097 virtual network link through opserver 10.0.0.22
2026-05-18 03:22:24,568 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-18 03:22:24,582 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-77270547:ctest-trans_left_vn-88832097', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-77270547:ctest-trans_left_vn-88832097?flat'}
2026-05-18 03:22:24,582 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-77270547:ctest-trans_left_vn-88832097 virtual network link through opserver 10.0.0.240
2026-05-18 03:22:24,582 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-05-18 03:22:24,599 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-77270547:ctest-trans_left_vn-88832097', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-77270547:ctest-trans_left_vn-88832097?flat'}
2026-05-18 03:22:24,599 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-77270547:ctest-trans_left_vn-88832097 is found in opserver
2026-05-18 03:22:24,630 - DEBUG - Do not have enough data to verify VN in agent
2026-05-18 03:22:24,642 - DEBUG - VRF ids for VN ctest-trans_left_vn-88832097: {}
2026-05-18 03:22:24,948 - DEBUG - Response for create_network : {'network': {'id': 'b929ed97-b073-46c3-8655-f24bd5f6b283', 'name': 'ctest-trans_right_vn-33425073', 'tenant_id': '4ba092854ceb403da006195c7c256e49', 'project_id': '4ba092854ceb403da006195c7c256e49', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-77270547', 'ctest-trans_right_vn-33425073'], 'port_security_enabled': True, 'description': ''}}
2026-05-18 03:22:25,184 - DEBUG - Response for create_subnet : {'subnet': {'id': '3517746d-972b-4d2f-a6c0-f22649e7c55a', 'name': '', 'tenant_id': '4ba092854ceb403da006195c7c256e49', 'network_id': 'b929ed97-b073-46c3-8655-f24bd5f6b283', 'ip_version': 4, 'cidr': '170.126.35.128/26', 'allocation_pools': [{'start': '170.126.35.130', 'end': '170.126.35.190'}], 'gateway_ip': '170.126.35.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '170.126.35.130', 'tags': [], 'project_id': '4ba092854ceb403da006195c7c256e49'}}
2026-05-18 03:22:25,208 - INFO - Created VN ctest-trans_right_vn-33425073
2026-05-18 03:22:25,220 - DEBUG - VN ctest-trans_right_vn-33425073 UUID is b929ed97-b073-46c3-8655-f24bd5f6b283
2026-05-18 03:22:25,300 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:25,307 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:25,322 - DEBUG - Requesting: http://10.0.0.23:8082/project/4ba09285-4ceb-403d-a006-195c7c256e49
2026-05-18 03:22:25,419 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/b929ed97-b073-46c3-8655-f24bd5f6b283
2026-05-18 03:22:25,431 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/b929ed97-b073-46c3-8655-f24bd5f6b283
2026-05-18 03:22:25,441 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/2ea2a47f-e248-42dd-8af4-cc761be2846c
2026-05-18 03:22:25,449 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/2ea2a47f-e248-42dd-8af4-cc761be2846c
2026-05-18 03:22:25,456 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/027e547d-6f15-4f5f-8e43-18194f7f4380
2026-05-18 03:22:25,463 - DEBUG - Route Targets: ['target:64512:8000011']
2026-05-18 03:22:25,463 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/b929ed97-b073-46c3-8655-f24bd5f6b283
2026-05-18 03:22:25,472 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/2ea2a47f-e248-42dd-8af4-cc761be2846c
2026-05-18 03:22:25,491 - INFO - Verified VN network id 17 for VN b929ed97-b073-46c3-8655-f24bd5f6b283
2026-05-18 03:22:25,492 - INFO - Verifications in API Server for VN ctest-trans_right_vn-33425073 passed
2026-05-18 03:22:25,492 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/b929ed97-b073-46c3-8655-f24bd5f6b283
2026-05-18 03:22:25,504 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/2ea2a47f-e248-42dd-8af4-cc761be2846c
2026-05-18 03:22:25,512 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/2ea2a47f-e248-42dd-8af4-cc761be2846c
2026-05-18 03:22:25,521 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/027e547d-6f15-4f5f-8e43-18194f7f4380
2026-05-18 03:22:25,535 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-77270547:ctest-trans_right_vn-33425073', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-77270547', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13342456606817994435', 'uuid-lslong': '9679909381628932739'}, 'enable': 'true', 'created': '2026-05-18T03:22:24', 'last-modified': '2026-05-18T03:22:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.415664'}
2026-05-18 03:22:25,540 - DEBUG - Route Targets: ['target:64512:8000011']
2026-05-18 03:22:25,548 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-77270547:ctest-trans_right_vn-33425073', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-77270547', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13342456606817994435', 'uuid-lslong': '9679909381628932739'}, 'enable': 'true', 'created': '2026-05-18T03:22:24', 'last-modified': '2026-05-18T03:22:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.430112'}
2026-05-18 03:22:25,555 - DEBUG - Route Targets: ['target:64512:8000011']
2026-05-18 03:22:25,563 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-77270547:ctest-trans_right_vn-33425073', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-77270547', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13342456606817994435', 'uuid-lslong': '9679909381628932739'}, 'enable': 'true', 'created': '2026-05-18T03:22:24', 'last-modified': '2026-05-18T03:22:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.441889'}
2026-05-18 03:22:25,572 - DEBUG - Route Targets: ['target:64512:8000011']
2026-05-18 03:22:25,572 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-33425073 passed
2026-05-18 03:22:25,573 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-33425073 in API_Server ======
2026-05-18 03:22:25,573 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:25,579 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:25,590 - DEBUG - Requesting: http://10.0.0.23:8082/project/4ba09285-4ceb-403d-a006-195c7c256e49
2026-05-18 03:22:25,689 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/b929ed97-b073-46c3-8655-f24bd5f6b283
2026-05-18 03:22:25,704 - DEBUG - =>VN ctest-trans_right_vn-33425073 has no policy to be verified
2026-05-18 03:22:25,704 - DEBUG - Verifying the vn in opserver
2026-05-18 03:22:25,704 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-77270547:ctest-trans_right_vn-33425073 virtual network link through opserver 10.0.0.23
2026-05-18 03:22:25,704 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-18 03:22:25,721 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-77270547:ctest-trans_right_vn-33425073', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-77270547:ctest-trans_right_vn-33425073?flat'}
2026-05-18 03:22:25,721 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-77270547:ctest-trans_right_vn-33425073 virtual network link through opserver 10.0.0.22
2026-05-18 03:22:25,721 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-18 03:22:25,738 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-77270547:ctest-trans_right_vn-33425073', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-77270547:ctest-trans_right_vn-33425073?flat'}
2026-05-18 03:22:25,738 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-77270547:ctest-trans_right_vn-33425073 virtual network link through opserver 10.0.0.240
2026-05-18 03:22:25,738 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-05-18 03:22:25,752 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-77270547:ctest-trans_right_vn-33425073', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-77270547:ctest-trans_right_vn-33425073?flat'}
2026-05-18 03:22:25,752 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-77270547:ctest-trans_right_vn-33425073 is found in opserver
2026-05-18 03:22:25,787 - DEBUG - Do not have enough data to verify VN in agent
2026-05-18 03:22:25,799 - DEBUG - VRF ids for VN ctest-trans_right_vn-33425073: {}
2026-05-18 03:22:27,173 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5792-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5792-2)
2026-05-18 03:22:28,715 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5792-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5792-1)
2026-05-18 03:22:28,716 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-48075999']
2026-05-18 03:22:29,019 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-48075999'] created succesfully
2026-05-18 03:22:29,509 - DEBUG - Image by name tiny_trans_fw not found
2026-05-18 03:22:29,509 - DEBUG - Installing image tiny_trans_fw
2026-05-18 03:22:29,509 - 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-05-18 03:22:29,509 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-05-18 03:22:29,509 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-05-18 03:22:29,528 - 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-05-18 03:22:29,557 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-05-18 03:22:29,557 - DEBUG - Unzip image
2026-05-18 03:22:29,557 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-05-18 03:22:29,581 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-05-18 03:22:29,581 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-48075999']
2026-05-18 03:22:29,740 - INFO - Service template: ['default-domain', 'ctest-service_template_1-48075999'] deleted successfully.
2026-05-18 03:22:29,740 - INFO - Skip interface_detach for VM ctest-right_vm-25163337 in state BUILD
2026-05-18 03:22:29,740 - INFO - Deleting VM ctest-right_vm-25163337
2026-05-18 03:22:29,740 - ERROR - VM ctest-right_vm-25163337 has failed to come up
2026-05-18 03:22:29,741 - ERROR - Nova failed to get host of the VM
2026-05-18 03:22:29,741 - ERROR - VM ctest-right_vm-25163337 has failed to come up
2026-05-18 03:22:29,741 - ERROR - Nova failed to get host of the VM
2026-05-18 03:22:29,829 - INFO - Skip interface_detach for VM ctest-left_vm-95636721 in state BUILD
2026-05-18 03:22:29,829 - INFO - Deleting VM ctest-left_vm-95636721
2026-05-18 03:22:29,829 - ERROR - VM ctest-left_vm-95636721 has failed to come up
2026-05-18 03:22:29,829 - ERROR - Nova failed to get host of the VM
2026-05-18 03:22:29,830 - ERROR - VM ctest-left_vm-95636721 has failed to come up
2026-05-18 03:22:29,830 - ERROR - Nova failed to get host of the VM
2026-05-18 03:22:29,923 - INFO - Deleting VN ctest-trans_right_vn-33425073
2026-05-18 03:22:30,120 - DEBUG - Response for deleting network ()
2026-05-18 03:22:30,120 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/2ea2a47f-e248-42dd-8af4-cc761be2846c
2026-05-18 03:22:30,127 - DEBUG - Response Code: 404
2026-05-18 03:22:30,127 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:30,138 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:30,170 - DEBUG - Requesting: http://10.0.0.23:8082/project/4ba09285-4ceb-403d-a006-195c7c256e49
2026-05-18 03:22:30,271 - INFO - Validated that VN ctest-trans_right_vn-33425073 is not found in API Server
2026-05-18 03:22:30,305 - DEBUG - VN ctest-trans_right_vn-33425073 is not present in Agent 10.0.0.65
2026-05-18 03:22:30,319 - DEBUG - VN ctest-trans_right_vn-33425073 is not present in Agent 10.0.0.130
2026-05-18 03:22:30,319 - INFO - Validated that VN ctest-trans_right_vn-33425073 is not in any agent
2026-05-18 03:22:30,373 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-33425073 info
2026-05-18 03:22:30,373 - INFO - Deleting VN ctest-trans_left_vn-88832097
2026-05-18 03:22:30,559 - DEBUG - Response for deleting network ()
2026-05-18 03:22:30,559 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/78c0bcc5-cf85-4419-86a8-b706c29f0f03
2026-05-18 03:22:30,566 - DEBUG - Response Code: 404
2026-05-18 03:22:30,566 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:30,583 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:30,599 - DEBUG - Requesting: http://10.0.0.23:8082/project/4ba09285-4ceb-403d-a006-195c7c256e49
2026-05-18 03:22:30,720 - INFO - Validated that VN ctest-trans_left_vn-88832097 is not found in API Server
2026-05-18 03:22:30,781 - DEBUG - VN ctest-trans_left_vn-88832097 is not present in Agent 10.0.0.65
2026-05-18 03:22:30,791 - DEBUG - VN ctest-trans_left_vn-88832097 is not present in Agent 10.0.0.130
2026-05-18 03:22:30,791 - INFO - Validated that VN ctest-trans_left_vn-88832097 is not in any agent
2026-05-18 03:22:30,842 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-88832097 info
2026-05-18 03:22:30,842 - INFO - Deleting VN ctest-right_vn-13033341
2026-05-18 03:22:30,889 - DEBUG - VN 6e56125f-bf3f-4ae8-8366-9dfd3036dd5c still in use: Unable to complete operation on network 6e56125f-bf3f-4ae8-8366-9dfd3036dd5c. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-48e53513-ecde-4c03-82bb-5ebd705b7852']
2026-05-18 03:22:30,889 - WARNING - Deleting VN ctest-right_vn-13033341 failed..Will retry
2026-05-18 03:22:33,090 - DEBUG - Response for deleting network ()
2026-05-18 03:22:33,090 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/e166babc-cd09-4bcc-937f-f850815e7655
2026-05-18 03:22:33,104 - DEBUG - Response Code: 404
2026-05-18 03:22:33,104 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:33,116 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:33,140 - DEBUG - Requesting: http://10.0.0.23:8082/project/4ba09285-4ceb-403d-a006-195c7c256e49
2026-05-18 03:22:33,241 - INFO - Validated that VN ctest-right_vn-13033341 is not found in API Server
2026-05-18 03:22:33,253 - DEBUG - VN ctest-right_vn-13033341 is not present in Agent 10.0.0.65
2026-05-18 03:22:33,264 - DEBUG - VN ctest-right_vn-13033341 is not present in Agent 10.0.0.130
2026-05-18 03:22:33,264 - INFO - Validated that VN ctest-right_vn-13033341 is not in any agent
2026-05-18 03:22:33,298 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-13033341 info
2026-05-18 03:22:33,298 - INFO - Deleting VN ctest-left_vn-51176033
2026-05-18 03:22:33,451 - DEBUG - Response for deleting network ()
2026-05-18 03:22:33,451 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/2c1b9572-b32a-4c3e-b8b7-465c7af7175e
2026-05-18 03:22:33,457 - DEBUG - Response Code: 404
2026-05-18 03:22:33,457 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:33,470 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:33,487 - DEBUG - Requesting: http://10.0.0.23:8082/project/4ba09285-4ceb-403d-a006-195c7c256e49
2026-05-18 03:22:33,589 - INFO - Validated that VN ctest-left_vn-51176033 is not found in API Server
2026-05-18 03:22:33,605 - DEBUG - VN ctest-left_vn-51176033 is not present in Agent 10.0.0.65
2026-05-18 03:22:33,622 - DEBUG - VN ctest-left_vn-51176033 is not present in Agent 10.0.0.130
2026-05-18 03:22:33,622 - INFO - Validated that VN ctest-left_vn-51176033 is not in any agent
2026-05-18 03:22:33,655 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-51176033 info
2026-05-18 03:22:33,655 - INFO - Deleting VN ctest-mgmt_vn-05421288
2026-05-18 03:22:33,846 - DEBUG - Response for deleting network ()
2026-05-18 03:22:33,846 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/8e7b8040-bfd0-42ae-b5af-5bf3874ba74a
2026-05-18 03:22:33,853 - DEBUG - Response Code: 404
2026-05-18 03:22:33,853 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:33,859 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:33,872 - DEBUG - Requesting: http://10.0.0.23:8082/project/4ba09285-4ceb-403d-a006-195c7c256e49
2026-05-18 03:22:33,971 - INFO - Validated that VN ctest-mgmt_vn-05421288 is not found in API Server
2026-05-18 03:22:33,985 - DEBUG - VN ctest-mgmt_vn-05421288 is not present in Agent 10.0.0.65
2026-05-18 03:22:33,997 - DEBUG - VN ctest-mgmt_vn-05421288 is not present in Agent 10.0.0.130
2026-05-18 03:22:33,997 - INFO - Validated that VN ctest-mgmt_vn-05421288 is not in any agent
2026-05-18 03:22:34,034 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-05421288 info
2026-05-18 03:22:35,324 - DEBUG - No XMPP flaps were noticed during the test
2026-05-18 03:22:35,324 - INFO -
2026-05-18 03:22:35,325 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:17]
2026-05-18 03:22:35,325 - INFO - --------------------------------------------------------------------------------
2026-05-18 03:22:36,116 - INFO - Deleted project: ctest-TestSvcRegr-77270547, ID : 4ba09285-4ceb-403d-a006-195c7c256e49
2026-05-18 03:22:36,293 - INFO - Domain Default found not creating
2026-05-18 03:22:36,476 - INFO - Project ctest-TestSvcRegr-23998300 not found, creating it
2026-05-18 03:22:37,106 - INFO - Created Project:ctest-TestSvcRegr-23998300, ID : 4096b98a-d20b-47e4-b69d-3a2581b21ea0
2026-05-18 03:22:39,354 - INFO - ================================================================================
2026-05-18 03:22:39,354 - INFO - STARTING TEST : test_svc_CEM_22032
2026-05-18 03:22:40,631 - DEBUG - Nothing to compare xmpp stats {'10.0.0.65': {'10.20.0.129': '0', '10.20.0.25': '2'}, '10.0.0.130': {'10.20.0.25': '0', '10.20.0.129': '3'}} with
2026-05-18 03:22:40,631 - INFO - Initial checks done. Running the testcase now
2026-05-18 03:22:40,631 - INFO -
2026-05-18 03:22:41,404 - DEBUG - Response for create_network : {'network': {'id': '630594e7-384f-4aa2-bfe2-923ce41f932c', 'name': 'ctest-mgmt_vn-62290352', 'tenant_id': '4096b98ad20b47e4b69d3a2581b21ea0', 'project_id': '4096b98ad20b47e4b69d3a2581b21ea0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-23998300', 'ctest-mgmt_vn-62290352'], 'port_security_enabled': True, 'description': ''}}
2026-05-18 03:22:41,693 - DEBUG - Response for create_subnet : {'subnet': {'id': 'fb318c10-3154-4656-8781-bb9dcbcf16d6', 'name': '', 'tenant_id': '4096b98ad20b47e4b69d3a2581b21ea0', 'network_id': '630594e7-384f-4aa2-bfe2-923ce41f932c', 'ip_version': 4, 'cidr': '177.244.47.64/26', 'allocation_pools': [{'start': '177.244.47.66', 'end': '177.244.47.126'}], 'gateway_ip': '177.244.47.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '177.244.47.66', 'tags': [], 'project_id': '4096b98ad20b47e4b69d3a2581b21ea0'}}
2026-05-18 03:22:41,719 - INFO - Created VN ctest-mgmt_vn-62290352
2026-05-18 03:22:41,732 - DEBUG - VN ctest-mgmt_vn-62290352 UUID is 630594e7-384f-4aa2-bfe2-923ce41f932c
2026-05-18 03:22:41,819 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:42,139 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:42,173 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:42,192 - DEBUG - Requesting: http://10.0.0.23:8082/project/4096b98a-d20b-47e4-b69d-3a2581b21ea0
2026-05-18 03:22:42,301 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/630594e7-384f-4aa2-bfe2-923ce41f932c
2026-05-18 03:22:42,316 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/630594e7-384f-4aa2-bfe2-923ce41f932c
2026-05-18 03:22:42,327 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/0358b4eb-34ef-49a8-bfd3-4a0d98b030fb
2026-05-18 03:22:42,339 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/0358b4eb-34ef-49a8-bfd3-4a0d98b030fb
2026-05-18 03:22:42,347 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/76a4def6-58d7-4733-b0ba-95cc0007f8c8
2026-05-18 03:22:42,354 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-18 03:22:42,354 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/630594e7-384f-4aa2-bfe2-923ce41f932c
2026-05-18 03:22:42,366 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/0358b4eb-34ef-49a8-bfd3-4a0d98b030fb
2026-05-18 03:22:42,389 - INFO - Verified VN network id 13 for VN 630594e7-384f-4aa2-bfe2-923ce41f932c
2026-05-18 03:22:42,391 - INFO - Verifications in API Server for VN ctest-mgmt_vn-62290352 passed
2026-05-18 03:22:42,391 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/630594e7-384f-4aa2-bfe2-923ce41f932c
2026-05-18 03:22:42,408 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/0358b4eb-34ef-49a8-bfd3-4a0d98b030fb
2026-05-18 03:22:42,418 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/0358b4eb-34ef-49a8-bfd3-4a0d98b030fb
2026-05-18 03:22:42,429 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/76a4def6-58d7-4733-b0ba-95cc0007f8c8
2026-05-18 03:22:42,442 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-62290352', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23998300', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7135272905441495714', 'uuid-lslong': '13826774596203811628'}, 'enable': 'true', 'created': '2026-05-18T03:22:41', 'last-modified': '2026-05-18T03:22:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.804956'}
2026-05-18 03:22:42,448 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-18 03:22:42,456 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-62290352', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23998300', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7135272905441495714', 'uuid-lslong': '13826774596203811628'}, 'enable': 'true', 'created': '2026-05-18T03:22:41', 'last-modified': '2026-05-18T03:22:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.813381'}
2026-05-18 03:22:42,468 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-18 03:22:42,479 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-62290352', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23998300', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7135272905441495714', 'uuid-lslong': '13826774596203811628'}, 'enable': 'true', 'created': '2026-05-18T03:22:41', 'last-modified': '2026-05-18T03:22:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.834749'}
2026-05-18 03:22:42,487 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-18 03:22:42,487 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-62290352 passed
2026-05-18 03:22:42,487 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-62290352 in API_Server ======
2026-05-18 03:22:42,487 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:42,496 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:42,510 - DEBUG - Requesting: http://10.0.0.23:8082/project/4096b98a-d20b-47e4-b69d-3a2581b21ea0
2026-05-18 03:22:42,618 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/630594e7-384f-4aa2-bfe2-923ce41f932c
2026-05-18 03:22:42,635 - DEBUG - =>VN ctest-mgmt_vn-62290352 has no policy to be verified
2026-05-18 03:22:42,635 - DEBUG - Verifying the vn in opserver
2026-05-18 03:22:42,635 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-62290352 virtual network link through opserver 10.0.0.23
2026-05-18 03:22:42,635 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-18 03:22:42,966 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-18 03:22:43,039 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-62290352', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-62290352?flat'}
2026-05-18 03:22:43,039 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-62290352 virtual network link through opserver 10.0.0.22
2026-05-18 03:22:43,039 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-18 03:22:43,355 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-18 03:22:43,428 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-62290352', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-62290352?flat'}
2026-05-18 03:22:43,428 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-62290352 virtual network link through opserver 10.0.0.240
2026-05-18 03:22:43,428 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-05-18 03:22:43,742 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-05-18 03:22:43,816 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-62290352', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-62290352?flat'}
2026-05-18 03:22:43,817 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-62290352 is found in opserver
2026-05-18 03:22:43,844 - DEBUG - Do not have enough data to verify VN in agent
2026-05-18 03:22:43,860 - DEBUG - VRF ids for VN ctest-mgmt_vn-62290352: {}
2026-05-18 03:22:44,152 - DEBUG - Response for create_network : {'network': {'id': 'ca028414-56cd-4e40-a037-49876d3335fa', 'name': 'service-left-vn-44749576', 'tenant_id': '4096b98ad20b47e4b69d3a2581b21ea0', 'project_id': '4096b98ad20b47e4b69d3a2581b21ea0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-23998300', 'service-left-vn-44749576'], 'port_security_enabled': True, 'description': ''}}
2026-05-18 03:22:44,427 - DEBUG - Response for create_subnet : {'subnet': {'id': '2b35910b-2146-4fc6-b06c-8ead193615db', 'name': '', 'tenant_id': '4096b98ad20b47e4b69d3a2581b21ea0', 'network_id': 'ca028414-56cd-4e40-a037-49876d3335fa', 'ip_version': 4, 'cidr': '94.197.208.192/26', 'allocation_pools': [{'start': '94.197.208.194', 'end': '94.197.208.254'}], 'gateway_ip': '94.197.208.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '94.197.208.194', 'tags': [], 'project_id': '4096b98ad20b47e4b69d3a2581b21ea0'}}
2026-05-18 03:22:44,449 - INFO - Created VN service-left-vn-44749576
2026-05-18 03:22:44,462 - DEBUG - VN service-left-vn-44749576 UUID is ca028414-56cd-4e40-a037-49876d3335fa
2026-05-18 03:22:44,547 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:44,554 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:44,567 - DEBUG - Requesting: http://10.0.0.23:8082/project/4096b98a-d20b-47e4-b69d-3a2581b21ea0
2026-05-18 03:22:44,674 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/ca028414-56cd-4e40-a037-49876d3335fa
2026-05-18 03:22:44,685 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/ca028414-56cd-4e40-a037-49876d3335fa
2026-05-18 03:22:44,696 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/2dc27763-e5b3-4fb4-8eae-bfc11914aa87
2026-05-18 03:22:44,705 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/2dc27763-e5b3-4fb4-8eae-bfc11914aa87
2026-05-18 03:22:44,714 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/a58bdac5-8ca9-4015-aef2-5a2f314052a0
2026-05-18 03:22:44,723 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-18 03:22:44,723 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/ca028414-56cd-4e40-a037-49876d3335fa
2026-05-18 03:22:44,733 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/2dc27763-e5b3-4fb4-8eae-bfc11914aa87
2026-05-18 03:22:44,750 - INFO - Verified VN network id 14 for VN ca028414-56cd-4e40-a037-49876d3335fa
2026-05-18 03:22:44,750 - INFO - Verifications in API Server for VN service-left-vn-44749576 passed
2026-05-18 03:22:44,750 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/ca028414-56cd-4e40-a037-49876d3335fa
2026-05-18 03:22:44,760 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/2dc27763-e5b3-4fb4-8eae-bfc11914aa87
2026-05-18 03:22:44,767 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/2dc27763-e5b3-4fb4-8eae-bfc11914aa87
2026-05-18 03:22:44,775 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/a58bdac5-8ca9-4015-aef2-5a2f314052a0
2026-05-18 03:22:44,788 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23998300:service-left-vn-44749576', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23998300', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14556342168505372224', 'uuid-lslong': '11544777015789041146'}, 'enable': 'true', 'created': '2026-05-18T03:22:44', 'last-modified': '2026-05-18T03:22:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.418822'}
2026-05-18 03:22:44,793 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-18 03:22:44,800 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23998300:service-left-vn-44749576', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23998300', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14556342168505372224', 'uuid-lslong': '11544777015789041146'}, 'enable': 'true', 'created': '2026-05-18T03:22:44', 'last-modified': '2026-05-18T03:22:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.419850'}
2026-05-18 03:22:44,806 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-18 03:22:44,813 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23998300:service-left-vn-44749576', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23998300', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14556342168505372224', 'uuid-lslong': '11544777015789041146'}, 'enable': 'true', 'created': '2026-05-18T03:22:44', 'last-modified': '2026-05-18T03:22:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.443044'}
2026-05-18 03:22:44,822 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-18 03:22:44,823 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-44749576 passed
2026-05-18 03:22:44,823 - DEBUG - ====Verifying policy data for service-left-vn-44749576 in API_Server ======
2026-05-18 03:22:44,823 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:44,833 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:44,848 - DEBUG - Requesting: http://10.0.0.23:8082/project/4096b98a-d20b-47e4-b69d-3a2581b21ea0
2026-05-18 03:22:44,948 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/ca028414-56cd-4e40-a037-49876d3335fa
2026-05-18 03:22:44,958 - DEBUG - =>VN service-left-vn-44749576 has no policy to be verified
2026-05-18 03:22:44,958 - DEBUG - Verifying the vn in opserver
2026-05-18 03:22:44,958 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23998300:service-left-vn-44749576 virtual network link through opserver 10.0.0.23
2026-05-18 03:22:44,958 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-18 03:22:45,023 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23998300:service-left-vn-44749576', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23998300:service-left-vn-44749576?flat'}
2026-05-18 03:22:45,023 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23998300:service-left-vn-44749576 virtual network link through opserver 10.0.0.22
2026-05-18 03:22:45,023 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-18 03:22:45,094 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23998300:service-left-vn-44749576', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23998300:service-left-vn-44749576?flat'}
2026-05-18 03:22:45,094 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23998300:service-left-vn-44749576 virtual network link through opserver 10.0.0.240
2026-05-18 03:22:45,094 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-05-18 03:22:45,165 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23998300:service-left-vn-44749576', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23998300:service-left-vn-44749576?flat'}
2026-05-18 03:22:45,165 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-23998300:service-left-vn-44749576 is found in opserver
2026-05-18 03:22:45,192 - DEBUG - Do not have enough data to verify VN in agent
2026-05-18 03:22:45,203 - DEBUG - VRF ids for VN service-left-vn-44749576: {}
2026-05-18 03:22:45,494 - DEBUG - Response for create_network : {'network': {'id': '631a384f-1752-4025-a4df-7dcf04e4fa2b', 'name': 'service-right-vn-74955730', 'tenant_id': '4096b98ad20b47e4b69d3a2581b21ea0', 'project_id': '4096b98ad20b47e4b69d3a2581b21ea0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-23998300', 'service-right-vn-74955730'], 'port_security_enabled': True, 'description': ''}}
2026-05-18 03:22:45,740 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a9a71386-9cde-4b86-8cdc-7fca75657300', 'name': '', 'tenant_id': '4096b98ad20b47e4b69d3a2581b21ea0', 'network_id': '631a384f-1752-4025-a4df-7dcf04e4fa2b', 'ip_version': 4, 'cidr': '186.44.22.64/26', 'allocation_pools': [{'start': '186.44.22.66', 'end': '186.44.22.126'}], 'gateway_ip': '186.44.22.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '186.44.22.66', 'tags': [], 'project_id': '4096b98ad20b47e4b69d3a2581b21ea0'}}
2026-05-18 03:22:45,764 - INFO - Created VN service-right-vn-74955730
2026-05-18 03:22:45,857 - DEBUG - VN service-right-vn-74955730 UUID is 631a384f-1752-4025-a4df-7dcf04e4fa2b
2026-05-18 03:22:45,936 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:45,943 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:45,954 - DEBUG - Requesting: http://10.0.0.23:8082/project/4096b98a-d20b-47e4-b69d-3a2581b21ea0
2026-05-18 03:22:46,043 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/631a384f-1752-4025-a4df-7dcf04e4fa2b
2026-05-18 03:22:46,054 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/631a384f-1752-4025-a4df-7dcf04e4fa2b
2026-05-18 03:22:46,064 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/bfa8fc0f-da98-4f3c-a6f6-73a55532f732
2026-05-18 03:22:46,072 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/bfa8fc0f-da98-4f3c-a6f6-73a55532f732
2026-05-18 03:22:46,079 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/8b9c4146-3e35-4207-880e-37b009cf24f7
2026-05-18 03:22:46,087 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-18 03:22:46,087 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/631a384f-1752-4025-a4df-7dcf04e4fa2b
2026-05-18 03:22:46,095 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/bfa8fc0f-da98-4f3c-a6f6-73a55532f732
2026-05-18 03:22:46,112 - INFO - Verified VN network id 15 for VN 631a384f-1752-4025-a4df-7dcf04e4fa2b
2026-05-18 03:22:46,112 - INFO - Verifications in API Server for VN service-right-vn-74955730 passed
2026-05-18 03:22:46,112 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/631a384f-1752-4025-a4df-7dcf04e4fa2b
2026-05-18 03:22:46,123 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/bfa8fc0f-da98-4f3c-a6f6-73a55532f732
2026-05-18 03:22:46,130 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/bfa8fc0f-da98-4f3c-a6f6-73a55532f732
2026-05-18 03:22:46,137 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/8b9c4146-3e35-4207-880e-37b009cf24f7
2026-05-18 03:22:46,149 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23998300:service-right-vn-74955730', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23998300', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7141082071494180901', 'uuid-lslong': '11880352670120475179'}, 'enable': 'true', 'created': '2026-05-18T03:22:45', 'last-modified': '2026-05-18T03:22:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.496701'}
2026-05-18 03:22:46,155 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-18 03:22:46,161 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23998300:service-right-vn-74955730', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23998300', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7141082071494180901', 'uuid-lslong': '11880352670120475179'}, 'enable': 'true', 'created': '2026-05-18T03:22:45', 'last-modified': '2026-05-18T03:22:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.510466'}
2026-05-18 03:22:46,169 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-18 03:22:46,175 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23998300:service-right-vn-74955730', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23998300', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7141082071494180901', 'uuid-lslong': '11880352670120475179'}, 'enable': 'true', 'created': '2026-05-18T03:22:45', 'last-modified': '2026-05-18T03:22:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.522402'}
2026-05-18 03:22:46,182 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-18 03:22:46,182 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-74955730 passed
2026-05-18 03:22:46,182 - DEBUG - ====Verifying policy data for service-right-vn-74955730 in API_Server ======
2026-05-18 03:22:46,182 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:46,189 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:46,205 - DEBUG - Requesting: http://10.0.0.23:8082/project/4096b98a-d20b-47e4-b69d-3a2581b21ea0
2026-05-18 03:22:46,307 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/631a384f-1752-4025-a4df-7dcf04e4fa2b
2026-05-18 03:22:46,318 - DEBUG - =>VN service-right-vn-74955730 has no policy to be verified
2026-05-18 03:22:46,318 - DEBUG - Verifying the vn in opserver
2026-05-18 03:22:46,318 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23998300:service-right-vn-74955730 virtual network link through opserver 10.0.0.23
2026-05-18 03:22:46,318 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-18 03:22:46,396 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23998300:service-right-vn-74955730', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23998300:service-right-vn-74955730?flat'}
2026-05-18 03:22:46,396 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23998300:service-right-vn-74955730 virtual network link through opserver 10.0.0.22
2026-05-18 03:22:46,396 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-18 03:22:46,468 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23998300:service-right-vn-74955730', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23998300:service-right-vn-74955730?flat'}
2026-05-18 03:22:46,468 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23998300:service-right-vn-74955730 virtual network link through opserver 10.0.0.240
2026-05-18 03:22:46,469 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-05-18 03:22:46,545 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23998300:service-right-vn-74955730', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23998300:service-right-vn-74955730?flat'}
2026-05-18 03:22:46,545 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-23998300:service-right-vn-74955730 is found in opserver
2026-05-18 03:22:46,570 - DEBUG - Do not have enough data to verify VN in agent
2026-05-18 03:22:46,580 - DEBUG - VRF ids for VN service-right-vn-74955730: {}
2026-05-18 03:22:46,717 - DEBUG - Services list from nova: [, , , ]
2026-05-18 03:22:47,909 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5792-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5792-2)
2026-05-18 03:22:49,450 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5792-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5792-1)
2026-05-18 03:22:49,451 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-58541950']
2026-05-18 03:22:49,767 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-58541950'] created succesfully
2026-05-18 03:22:50,186 - DEBUG - Image by name tiny_nat_fw not found
2026-05-18 03:22:50,186 - DEBUG - Installing image tiny_nat_fw
2026-05-18 03:22:50,187 - 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-05-18 03:22:50,187 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-18 03:22:50,187 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-18 03:22:50,187 - DEBUG - Unzip image
2026-05-18 03:22:50,187 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-18 03:22:50,211 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-05-18 03:22:50,212 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-58541950']
2026-05-18 03:22:50,336 - INFO - Service template: ['default-domain', 'ctest-service_template_1-58541950'] deleted successfully.
2026-05-18 03:22:50,336 - INFO - Skip interface_detach for VM ctest-right_vm-58321034 in state BUILD
2026-05-18 03:22:50,336 - INFO - Deleting VM ctest-right_vm-58321034
2026-05-18 03:22:50,372 - ERROR - VM ctest-right_vm-58321034 has failed to come up
2026-05-18 03:22:50,372 - ERROR - Nova failed to get host of the VM
2026-05-18 03:22:50,372 - ERROR - VM ctest-right_vm-58321034 has failed to come up
2026-05-18 03:22:50,372 - ERROR - Nova failed to get host of the VM
2026-05-18 03:22:50,483 - INFO - Skip interface_detach for VM ctest-left_vm-09984145 in state BUILD
2026-05-18 03:22:50,483 - INFO - Deleting VM ctest-left_vm-09984145
2026-05-18 03:22:50,483 - ERROR - VM ctest-left_vm-09984145 has failed to come up
2026-05-18 03:22:50,483 - ERROR - Nova failed to get host of the VM
2026-05-18 03:22:50,483 - ERROR - VM ctest-left_vm-09984145 has failed to come up
2026-05-18 03:22:50,483 - ERROR - Nova failed to get host of the VM
2026-05-18 03:22:50,563 - INFO - Deleting VN service-right-vn-74955730
2026-05-18 03:22:50,609 - DEBUG - VN 631a384f-1752-4025-a4df-7dcf04e4fa2b still in use: Unable to complete operation on network 631a384f-1752-4025-a4df-7dcf04e4fa2b. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-d91990c2-d858-4d40-ae9d-cea9377de6a3']
2026-05-18 03:22:50,609 - WARNING - Deleting VN service-right-vn-74955730 failed..Will retry
2026-05-18 03:22:52,793 - DEBUG - Response for deleting network ()
2026-05-18 03:22:52,793 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/bfa8fc0f-da98-4f3c-a6f6-73a55532f732
2026-05-18 03:22:52,801 - DEBUG - Response Code: 404
2026-05-18 03:22:52,801 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:52,811 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:52,834 - DEBUG - Requesting: http://10.0.0.23:8082/project/4096b98a-d20b-47e4-b69d-3a2581b21ea0
2026-05-18 03:22:52,927 - INFO - Validated that VN service-right-vn-74955730 is not found in API Server
2026-05-18 03:22:52,940 - DEBUG - VN service-right-vn-74955730 is not present in Agent 10.0.0.65
2026-05-18 03:22:52,955 - DEBUG - VN service-right-vn-74955730 is not present in Agent 10.0.0.130
2026-05-18 03:22:52,955 - INFO - Validated that VN service-right-vn-74955730 is not in any agent
2026-05-18 03:22:52,993 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-74955730 info
2026-05-18 03:22:52,993 - INFO - Deleting VN service-left-vn-44749576
2026-05-18 03:22:53,190 - DEBUG - Response for deleting network ()
2026-05-18 03:22:53,190 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/2dc27763-e5b3-4fb4-8eae-bfc11914aa87
2026-05-18 03:22:53,199 - DEBUG - Response Code: 404
2026-05-18 03:22:53,199 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:53,212 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:53,240 - DEBUG - Requesting: http://10.0.0.23:8082/project/4096b98a-d20b-47e4-b69d-3a2581b21ea0
2026-05-18 03:22:53,401 - INFO - Validated that VN service-left-vn-44749576 is not found in API Server
2026-05-18 03:22:53,416 - DEBUG - VN service-left-vn-44749576 is not present in Agent 10.0.0.65
2026-05-18 03:22:53,436 - DEBUG - VN service-left-vn-44749576 is not present in Agent 10.0.0.130
2026-05-18 03:22:53,436 - INFO - Validated that VN service-left-vn-44749576 is not in any agent
2026-05-18 03:22:53,476 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-44749576 info
2026-05-18 03:22:53,476 - INFO - Deleting VN ctest-mgmt_vn-62290352
2026-05-18 03:22:53,847 - DEBUG - Response for deleting network ()
2026-05-18 03:22:53,848 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/0358b4eb-34ef-49a8-bfd3-4a0d98b030fb
2026-05-18 03:22:53,855 - DEBUG - Response Code: 404
2026-05-18 03:22:53,855 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:53,870 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:53,887 - DEBUG - Requesting: http://10.0.0.23:8082/project/4096b98a-d20b-47e4-b69d-3a2581b21ea0
2026-05-18 03:22:54,017 - INFO - Validated that VN ctest-mgmt_vn-62290352 is not found in API Server
2026-05-18 03:22:54,037 - DEBUG - VN ctest-mgmt_vn-62290352 is not present in Agent 10.0.0.65
2026-05-18 03:22:54,049 - DEBUG - VN ctest-mgmt_vn-62290352 is not present in Agent 10.0.0.130
2026-05-18 03:22:54,049 - INFO - Validated that VN ctest-mgmt_vn-62290352 is not in any agent
2026-05-18 03:22:54,091 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-62290352 info
2026-05-18 03:22:55,380 - DEBUG - No XMPP flaps were noticed during the test
2026-05-18 03:22:55,380 - INFO -
2026-05-18 03:22:55,380 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:16]
2026-05-18 03:22:55,380 - INFO - --------------------------------------------------------------------------------
2026-05-18 03:22:55,386 - INFO - ================================================================================
2026-05-18 03:22:55,386 - INFO - STARTING TEST : test_svc_in_network_datapath
2026-05-18 03:22:56,693 - DEBUG - Nothing to compare xmpp stats {'10.0.0.65': {'10.20.0.129': '0', '10.20.0.25': '2'}, '10.0.0.130': {'10.20.0.25': '0', '10.20.0.129': '3'}} with
2026-05-18 03:22:56,693 - INFO - Initial checks done. Running the testcase now
2026-05-18 03:22:56,693 - INFO -
2026-05-18 03:22:56,994 - DEBUG - Response for create_network : {'network': {'id': '069669c2-5865-4e21-9732-dcd9690bc85f', 'name': 'ctest-mgmt_vn-94651022', 'tenant_id': '4096b98ad20b47e4b69d3a2581b21ea0', 'project_id': '4096b98ad20b47e4b69d3a2581b21ea0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-23998300', 'ctest-mgmt_vn-94651022'], 'port_security_enabled': True, 'description': ''}}
2026-05-18 03:22:57,246 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f98c6634-65f6-4fa5-884a-b3f974c1dcc6', 'name': '', 'tenant_id': '4096b98ad20b47e4b69d3a2581b21ea0', 'network_id': '069669c2-5865-4e21-9732-dcd9690bc85f', 'ip_version': 4, 'cidr': '61.39.84.128/26', 'allocation_pools': [{'start': '61.39.84.130', 'end': '61.39.84.190'}], 'gateway_ip': '61.39.84.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '61.39.84.130', 'tags': [], 'project_id': '4096b98ad20b47e4b69d3a2581b21ea0'}}
2026-05-18 03:22:57,272 - INFO - Created VN ctest-mgmt_vn-94651022
2026-05-18 03:22:57,286 - DEBUG - VN ctest-mgmt_vn-94651022 UUID is 069669c2-5865-4e21-9732-dcd9690bc85f
2026-05-18 03:22:57,362 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:57,368 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:57,387 - DEBUG - Requesting: http://10.0.0.23:8082/project/4096b98a-d20b-47e4-b69d-3a2581b21ea0
2026-05-18 03:22:57,480 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/069669c2-5865-4e21-9732-dcd9690bc85f
2026-05-18 03:22:57,493 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/069669c2-5865-4e21-9732-dcd9690bc85f
2026-05-18 03:22:57,503 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/e1dff150-8b28-48fc-a13b-f21382ee4abf
2026-05-18 03:22:57,512 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/e1dff150-8b28-48fc-a13b-f21382ee4abf
2026-05-18 03:22:57,521 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/db908b45-7f11-41ed-8770-a5f33661bdde
2026-05-18 03:22:57,531 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-18 03:22:57,531 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/069669c2-5865-4e21-9732-dcd9690bc85f
2026-05-18 03:22:57,540 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/e1dff150-8b28-48fc-a13b-f21382ee4abf
2026-05-18 03:22:57,557 - INFO - Verified VN network id 13 for VN 069669c2-5865-4e21-9732-dcd9690bc85f
2026-05-18 03:22:57,557 - INFO - Verifications in API Server for VN ctest-mgmt_vn-94651022 passed
2026-05-18 03:22:57,557 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/069669c2-5865-4e21-9732-dcd9690bc85f
2026-05-18 03:22:57,567 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/e1dff150-8b28-48fc-a13b-f21382ee4abf
2026-05-18 03:22:57,575 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/e1dff150-8b28-48fc-a13b-f21382ee4abf
2026-05-18 03:22:57,583 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/db908b45-7f11-41ed-8770-a5f33661bdde
2026-05-18 03:22:57,596 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-94651022', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23998300', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '474683094161772065', 'uuid-lslong': '10895013274891044959'}, 'enable': 'true', 'created': '2026-05-18T03:22:56', 'last-modified': '2026-05-18T03:22:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.402139'}
2026-05-18 03:22:57,604 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-18 03:22:57,611 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-94651022', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23998300', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '474683094161772065', 'uuid-lslong': '10895013274891044959'}, 'enable': 'true', 'created': '2026-05-18T03:22:56', 'last-modified': '2026-05-18T03:22:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.421662'}
2026-05-18 03:22:57,618 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-18 03:22:57,623 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-94651022', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23998300', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '474683094161772065', 'uuid-lslong': '10895013274891044959'}, 'enable': 'true', 'created': '2026-05-18T03:22:56', 'last-modified': '2026-05-18T03:22:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.434947'}
2026-05-18 03:22:57,631 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-18 03:22:57,631 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-94651022 passed
2026-05-18 03:22:57,631 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-94651022 in API_Server ======
2026-05-18 03:22:57,631 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:57,637 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:57,650 - DEBUG - Requesting: http://10.0.0.23:8082/project/4096b98a-d20b-47e4-b69d-3a2581b21ea0
2026-05-18 03:22:57,750 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/069669c2-5865-4e21-9732-dcd9690bc85f
2026-05-18 03:22:57,760 - DEBUG - =>VN ctest-mgmt_vn-94651022 has no policy to be verified
2026-05-18 03:22:57,760 - DEBUG - Verifying the vn in opserver
2026-05-18 03:22:57,760 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-94651022 virtual network link through opserver 10.0.0.23
2026-05-18 03:22:57,760 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-18 03:22:57,774 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-94651022', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-94651022?flat'}
2026-05-18 03:22:57,774 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-94651022 virtual network link through opserver 10.0.0.22
2026-05-18 03:22:57,774 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-18 03:22:57,787 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-94651022', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-94651022?flat'}
2026-05-18 03:22:57,787 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-94651022 virtual network link through opserver 10.0.0.240
2026-05-18 03:22:57,787 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-05-18 03:22:57,804 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-94651022', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-94651022?flat'}
2026-05-18 03:22:57,804 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-23998300:ctest-mgmt_vn-94651022 is found in opserver
2026-05-18 03:22:57,827 - DEBUG - Do not have enough data to verify VN in agent
2026-05-18 03:22:57,839 - DEBUG - VRF ids for VN ctest-mgmt_vn-94651022: {}
2026-05-18 03:22:58,125 - DEBUG - Response for create_network : {'network': {'id': 'ae7a657e-0d51-488f-9c5b-222e8d810d92', 'name': 'ctest-left_vn-85495617', 'tenant_id': '4096b98ad20b47e4b69d3a2581b21ea0', 'project_id': '4096b98ad20b47e4b69d3a2581b21ea0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-23998300', 'ctest-left_vn-85495617'], 'port_security_enabled': True, 'description': ''}}
2026-05-18 03:22:58,375 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c5a41e64-09ed-4c59-99bf-020665a387c6', 'name': '', 'tenant_id': '4096b98ad20b47e4b69d3a2581b21ea0', 'network_id': 'ae7a657e-0d51-488f-9c5b-222e8d810d92', 'ip_version': 4, 'cidr': '13.48.152.128/26', 'allocation_pools': [{'start': '13.48.152.130', 'end': '13.48.152.190'}], 'gateway_ip': '13.48.152.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '13.48.152.130', 'tags': [], 'project_id': '4096b98ad20b47e4b69d3a2581b21ea0'}}
2026-05-18 03:22:58,404 - INFO - Created VN ctest-left_vn-85495617
2026-05-18 03:22:58,417 - DEBUG - VN ctest-left_vn-85495617 UUID is ae7a657e-0d51-488f-9c5b-222e8d810d92
2026-05-18 03:22:58,501 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:58,509 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:58,527 - DEBUG - Requesting: http://10.0.0.23:8082/project/4096b98a-d20b-47e4-b69d-3a2581b21ea0
2026-05-18 03:22:58,620 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/ae7a657e-0d51-488f-9c5b-222e8d810d92
2026-05-18 03:22:58,634 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/ae7a657e-0d51-488f-9c5b-222e8d810d92
2026-05-18 03:22:58,645 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/73d0bb4a-f0e7-42ab-b4ee-4501a83c835a
2026-05-18 03:22:58,654 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/73d0bb4a-f0e7-42ab-b4ee-4501a83c835a
2026-05-18 03:22:58,661 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/843513f0-5c5a-4f34-ab38-6198da807332
2026-05-18 03:22:58,668 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-18 03:22:58,668 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/ae7a657e-0d51-488f-9c5b-222e8d810d92
2026-05-18 03:22:58,678 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/73d0bb4a-f0e7-42ab-b4ee-4501a83c835a
2026-05-18 03:22:58,695 - INFO - Verified VN network id 14 for VN ae7a657e-0d51-488f-9c5b-222e8d810d92
2026-05-18 03:22:58,695 - INFO - Verifications in API Server for VN ctest-left_vn-85495617 passed
2026-05-18 03:22:58,695 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/ae7a657e-0d51-488f-9c5b-222e8d810d92
2026-05-18 03:22:58,706 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/73d0bb4a-f0e7-42ab-b4ee-4501a83c835a
2026-05-18 03:22:58,716 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/73d0bb4a-f0e7-42ab-b4ee-4501a83c835a
2026-05-18 03:22:58,723 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/843513f0-5c5a-4f34-ab38-6198da807332
2026-05-18 03:22:58,736 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23998300:ctest-left_vn-85495617', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23998300', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12572472901821876367', 'uuid-lslong': '11266636476135312786'}, 'enable': 'true', 'created': '2026-05-18T03:22:58', 'last-modified': '2026-05-18T03:22:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.429587'}
2026-05-18 03:22:58,742 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-18 03:22:58,749 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23998300:ctest-left_vn-85495617', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23998300', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12572472901821876367', 'uuid-lslong': '11266636476135312786'}, 'enable': 'true', 'created': '2026-05-18T03:22:58', 'last-modified': '2026-05-18T03:22:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.443772'}
2026-05-18 03:22:58,755 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-18 03:22:58,764 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23998300:ctest-left_vn-85495617', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23998300', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12572472901821876367', 'uuid-lslong': '11266636476135312786'}, 'enable': 'true', 'created': '2026-05-18T03:22:58', 'last-modified': '2026-05-18T03:22:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.458880'}
2026-05-18 03:22:58,772 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-18 03:22:58,772 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-85495617 passed
2026-05-18 03:22:58,772 - DEBUG - ====Verifying policy data for ctest-left_vn-85495617 in API_Server ======
2026-05-18 03:22:58,772 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:58,779 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:58,791 - DEBUG - Requesting: http://10.0.0.23:8082/project/4096b98a-d20b-47e4-b69d-3a2581b21ea0
2026-05-18 03:22:58,899 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/ae7a657e-0d51-488f-9c5b-222e8d810d92
2026-05-18 03:22:58,916 - DEBUG - =>VN ctest-left_vn-85495617 has no policy to be verified
2026-05-18 03:22:58,916 - DEBUG - Verifying the vn in opserver
2026-05-18 03:22:58,916 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23998300:ctest-left_vn-85495617 virtual network link through opserver 10.0.0.23
2026-05-18 03:22:58,916 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-18 03:22:58,934 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23998300:ctest-left_vn-85495617', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23998300:ctest-left_vn-85495617?flat'}
2026-05-18 03:22:58,934 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23998300:ctest-left_vn-85495617 virtual network link through opserver 10.0.0.22
2026-05-18 03:22:58,934 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-18 03:22:58,953 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23998300:ctest-left_vn-85495617', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23998300:ctest-left_vn-85495617?flat'}
2026-05-18 03:22:58,953 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23998300:ctest-left_vn-85495617 virtual network link through opserver 10.0.0.240
2026-05-18 03:22:58,953 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-05-18 03:22:58,968 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23998300:ctest-left_vn-85495617', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23998300:ctest-left_vn-85495617?flat'}
2026-05-18 03:22:58,968 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-23998300:ctest-left_vn-85495617 is found in opserver
2026-05-18 03:22:58,990 - DEBUG - Do not have enough data to verify VN in agent
2026-05-18 03:22:59,004 - DEBUG - VRF ids for VN ctest-left_vn-85495617: {}
2026-05-18 03:22:59,360 - DEBUG - Response for create_network : {'network': {'id': 'fe3ea7ff-a35f-4ae5-8e24-1fa6f86ce88a', 'name': 'ctest-right_vn-19384437', 'tenant_id': '4096b98ad20b47e4b69d3a2581b21ea0', 'project_id': '4096b98ad20b47e4b69d3a2581b21ea0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-23998300', 'ctest-right_vn-19384437'], 'port_security_enabled': True, 'description': ''}}
2026-05-18 03:22:59,662 - DEBUG - Response for create_subnet : {'subnet': {'id': '0b2a6e75-9b57-4265-9230-8ce73a2c84db', 'name': '', 'tenant_id': '4096b98ad20b47e4b69d3a2581b21ea0', 'network_id': 'fe3ea7ff-a35f-4ae5-8e24-1fa6f86ce88a', 'ip_version': 4, 'cidr': '93.81.136.0/26', 'allocation_pools': [{'start': '93.81.136.2', 'end': '93.81.136.62'}], 'gateway_ip': '93.81.136.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '93.81.136.2', 'tags': [], 'project_id': '4096b98ad20b47e4b69d3a2581b21ea0'}}
2026-05-18 03:22:59,689 - INFO - Created VN ctest-right_vn-19384437
2026-05-18 03:22:59,704 - DEBUG - VN ctest-right_vn-19384437 UUID is fe3ea7ff-a35f-4ae5-8e24-1fa6f86ce88a
2026-05-18 03:22:59,802 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:22:59,810 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:22:59,825 - DEBUG - Requesting: http://10.0.0.23:8082/project/4096b98a-d20b-47e4-b69d-3a2581b21ea0
2026-05-18 03:22:59,931 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/fe3ea7ff-a35f-4ae5-8e24-1fa6f86ce88a
2026-05-18 03:22:59,947 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/fe3ea7ff-a35f-4ae5-8e24-1fa6f86ce88a
2026-05-18 03:22:59,962 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7883b49a-2cc8-47c1-823c-cfd86c5e7b05
2026-05-18 03:22:59,970 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7883b49a-2cc8-47c1-823c-cfd86c5e7b05
2026-05-18 03:22:59,979 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/1d06279a-ce69-4520-9d7a-b671688f0aab
2026-05-18 03:22:59,987 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-18 03:22:59,987 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/fe3ea7ff-a35f-4ae5-8e24-1fa6f86ce88a
2026-05-18 03:23:00,000 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7883b49a-2cc8-47c1-823c-cfd86c5e7b05
2026-05-18 03:23:00,020 - INFO - Verified VN network id 15 for VN fe3ea7ff-a35f-4ae5-8e24-1fa6f86ce88a
2026-05-18 03:23:00,020 - INFO - Verifications in API Server for VN ctest-right_vn-19384437 passed
2026-05-18 03:23:00,020 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/fe3ea7ff-a35f-4ae5-8e24-1fa6f86ce88a
2026-05-18 03:23:00,037 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7883b49a-2cc8-47c1-823c-cfd86c5e7b05
2026-05-18 03:23:00,045 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7883b49a-2cc8-47c1-823c-cfd86c5e7b05
2026-05-18 03:23:00,053 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/1d06279a-ce69-4520-9d7a-b671688f0aab
2026-05-18 03:23:00,069 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23998300:ctest-right_vn-19384437', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23998300', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18320265050589186789', 'uuid-lslong': '10242346254540269706'}, 'enable': 'true', 'created': '2026-05-18T03:22:59', 'last-modified': '2026-05-18T03:22:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.490958'}
2026-05-18 03:23:00,078 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-18 03:23:00,094 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23998300:ctest-right_vn-19384437', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23998300', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18320265050589186789', 'uuid-lslong': '10242346254540269706'}, 'enable': 'true', 'created': '2026-05-18T03:22:59', 'last-modified': '2026-05-18T03:22:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.500169'}
2026-05-18 03:23:00,103 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-18 03:23:00,116 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23998300:ctest-right_vn-19384437', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23998300', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18320265050589186789', 'uuid-lslong': '10242346254540269706'}, 'enable': 'true', 'created': '2026-05-18T03:22:59', 'last-modified': '2026-05-18T03:22:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.521932'}
2026-05-18 03:23:00,125 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-18 03:23:00,126 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-19384437 passed
2026-05-18 03:23:00,126 - DEBUG - ====Verifying policy data for ctest-right_vn-19384437 in API_Server ======
2026-05-18 03:23:00,126 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:23:00,134 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:23:00,149 - DEBUG - Requesting: http://10.0.0.23:8082/project/4096b98a-d20b-47e4-b69d-3a2581b21ea0
2026-05-18 03:23:00,254 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/fe3ea7ff-a35f-4ae5-8e24-1fa6f86ce88a
2026-05-18 03:23:00,270 - DEBUG - =>VN ctest-right_vn-19384437 has no policy to be verified
2026-05-18 03:23:00,270 - DEBUG - Verifying the vn in opserver
2026-05-18 03:23:00,270 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23998300:ctest-right_vn-19384437 virtual network link through opserver 10.0.0.23
2026-05-18 03:23:00,270 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-05-18 03:23:00,294 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23998300:ctest-right_vn-19384437', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23998300:ctest-right_vn-19384437?flat'}
2026-05-18 03:23:00,295 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23998300:ctest-right_vn-19384437 virtual network link through opserver 10.0.0.22
2026-05-18 03:23:00,295 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-18 03:23:00,309 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23998300:ctest-right_vn-19384437', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23998300:ctest-right_vn-19384437?flat'}
2026-05-18 03:23:00,309 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23998300:ctest-right_vn-19384437 virtual network link through opserver 10.0.0.240
2026-05-18 03:23:00,309 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-05-18 03:23:00,323 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23998300:ctest-right_vn-19384437', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23998300:ctest-right_vn-19384437?flat'}
2026-05-18 03:23:00,323 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-23998300:ctest-right_vn-19384437 is found in opserver
2026-05-18 03:23:00,351 - DEBUG - Do not have enough data to verify VN in agent
2026-05-18 03:23:00,366 - DEBUG - VRF ids for VN ctest-right_vn-19384437: {}
2026-05-18 03:23:01,874 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5792-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5792-1)
2026-05-18 03:23:03,605 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5792-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5792-2)
2026-05-18 03:23:03,606 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-08006704']
2026-05-18 03:23:03,921 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-08006704'] created succesfully
2026-05-18 03:23:04,345 - DEBUG - Image by name tiny_nat_fw not found
2026-05-18 03:23:04,345 - DEBUG - Installing image tiny_nat_fw
2026-05-18 03:23:04,345 - 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-05-18 03:23:04,345 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-18 03:23:04,345 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-18 03:23:04,345 - DEBUG - Unzip image
2026-05-18 03:23:04,345 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-18 03:23:04,370 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-05-18 03:23:04,370 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-08006704']
2026-05-18 03:23:04,468 - INFO - Service template: ['default-domain', 'ctest-service_template_1-08006704'] deleted successfully.
2026-05-18 03:23:04,468 - INFO - Skip interface_detach for VM ctest-right_vm-69441691 in state BUILD
2026-05-18 03:23:04,468 - INFO - Deleting VM ctest-right_vm-69441691
2026-05-18 03:23:04,468 - ERROR - VM ctest-right_vm-69441691 has failed to come up
2026-05-18 03:23:04,468 - ERROR - Nova failed to get host of the VM
2026-05-18 03:23:04,469 - ERROR - VM ctest-right_vm-69441691 has failed to come up
2026-05-18 03:23:04,469 - ERROR - Nova failed to get host of the VM
2026-05-18 03:23:04,630 - INFO - Skip interface_detach for VM ctest-left_vm-45514657 in state BUILD
2026-05-18 03:23:04,630 - INFO - Deleting VM ctest-left_vm-45514657
2026-05-18 03:23:04,630 - ERROR - VM ctest-left_vm-45514657 has failed to come up
2026-05-18 03:23:04,630 - ERROR - Nova failed to get host of the VM
2026-05-18 03:23:04,630 - ERROR - VM ctest-left_vm-45514657 has failed to come up
2026-05-18 03:23:04,630 - ERROR - Nova failed to get host of the VM
2026-05-18 03:23:04,727 - INFO - Deleting VN ctest-right_vn-19384437
2026-05-18 03:23:04,791 - DEBUG - VN fe3ea7ff-a35f-4ae5-8e24-1fa6f86ce88a still in use: Unable to complete operation on network fe3ea7ff-a35f-4ae5-8e24-1fa6f86ce88a. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-f49e2ca5-26a3-41bb-a3f5-02da6c4c278a']
2026-05-18 03:23:04,791 - WARNING - Deleting VN ctest-right_vn-19384437 failed..Will retry
2026-05-18 03:23:06,997 - DEBUG - Response for deleting network ()
2026-05-18 03:23:06,997 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7883b49a-2cc8-47c1-823c-cfd86c5e7b05
2026-05-18 03:23:07,003 - DEBUG - Response Code: 404
2026-05-18 03:23:07,003 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:23:07,018 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:23:07,051 - DEBUG - Requesting: http://10.0.0.23:8082/project/4096b98a-d20b-47e4-b69d-3a2581b21ea0
2026-05-18 03:23:07,156 - INFO - Validated that VN ctest-right_vn-19384437 is not found in API Server
2026-05-18 03:23:07,168 - DEBUG - VN ctest-right_vn-19384437 is not present in Agent 10.0.0.65
2026-05-18 03:23:07,180 - DEBUG - VN ctest-right_vn-19384437 is not present in Agent 10.0.0.130
2026-05-18 03:23:07,180 - INFO - Validated that VN ctest-right_vn-19384437 is not in any agent
2026-05-18 03:23:07,223 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-19384437 info
2026-05-18 03:23:07,223 - INFO - Deleting VN ctest-left_vn-85495617
2026-05-18 03:23:07,406 - DEBUG - Response for deleting network ()
2026-05-18 03:23:07,406 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/73d0bb4a-f0e7-42ab-b4ee-4501a83c835a
2026-05-18 03:23:07,412 - DEBUG - Response Code: 404
2026-05-18 03:23:07,415 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:23:07,425 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:23:07,437 - DEBUG - Requesting: http://10.0.0.23:8082/project/4096b98a-d20b-47e4-b69d-3a2581b21ea0
2026-05-18 03:23:07,528 - INFO - Validated that VN ctest-left_vn-85495617 is not found in API Server
2026-05-18 03:23:07,539 - DEBUG - VN ctest-left_vn-85495617 is not present in Agent 10.0.0.65
2026-05-18 03:23:07,552 - DEBUG - VN ctest-left_vn-85495617 is not present in Agent 10.0.0.130
2026-05-18 03:23:07,552 - INFO - Validated that VN ctest-left_vn-85495617 is not in any agent
2026-05-18 03:23:07,589 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-85495617 info
2026-05-18 03:23:07,589 - INFO - Deleting VN ctest-mgmt_vn-94651022
2026-05-18 03:23:07,739 - DEBUG - Response for deleting network ()
2026-05-18 03:23:07,739 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/e1dff150-8b28-48fc-a13b-f21382ee4abf
2026-05-18 03:23:07,746 - DEBUG - Response Code: 404
2026-05-18 03:23:07,746 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-05-18 03:23:07,754 - DEBUG - Requesting: http://10.0.0.23:8082/domain/4bbec0ba-f2cb-4fcb-b8f1-efc2a7bf0989
2026-05-18 03:23:07,777 - DEBUG - Requesting: http://10.0.0.23:8082/project/4096b98a-d20b-47e4-b69d-3a2581b21ea0
2026-05-18 03:23:07,874 - INFO - Validated that VN ctest-mgmt_vn-94651022 is not found in API Server
2026-05-18 03:23:07,886 - DEBUG - VN ctest-mgmt_vn-94651022 is not present in Agent 10.0.0.65
2026-05-18 03:23:07,897 - DEBUG - VN ctest-mgmt_vn-94651022 is not present in Agent 10.0.0.130
2026-05-18 03:23:07,897 - INFO - Validated that VN ctest-mgmt_vn-94651022 is not in any agent
2026-05-18 03:23:07,934 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-94651022 info
2026-05-18 03:23:09,230 - DEBUG - No XMPP flaps were noticed during the test
2026-05-18 03:23:09,230 - INFO -
2026-05-18 03:23:09,230 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:14]
2026-05-18 03:23:09,231 - INFO - --------------------------------------------------------------------------------
2026-05-18 03:23:10,061 - INFO - Deleted project: ctest-TestSvcRegr-23998300, ID : 4096b98a-d20b-47e4-b69d-3a2581b21ea0