]) created on node: (an-jenkins-deploy-platform-ansible-os-5860-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5860-2)
2026-06-01 03:08:56,685 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-29728724']
2026-06-01 03:08:56,978 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-29728724'] created succesfully
2026-06-01 03:08:57,424 - DEBUG - Image by name tiny_nat_fw not found
2026-06-01 03:08:57,424 - DEBUG - Installing image tiny_nat_fw
2026-06-01 03:08:57,424 - 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-06-01 03:08:57,425 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-06-01 03:08:57,425 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-06-01 03:08:57,440 - 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-06-01 03:08:57,486 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-06-01 03:08:57,486 - DEBUG - Unzip image
2026-06-01 03:08:57,486 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-06-01 03:08:57,518 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-06-01 03:08:57,519 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-29728724']
2026-06-01 03:08:57,641 - INFO - Service template: ['default-domain', 'ctest-service_template_1-29728724'] deleted successfully.
2026-06-01 03:08:57,641 - INFO - Skip interface_detach for VM ctest-right_vm-35197862 in state BUILD
2026-06-01 03:08:57,641 - INFO - Deleting VM ctest-right_vm-35197862
2026-06-01 03:08:57,683 - ERROR - VM ctest-right_vm-35197862 has failed to come up
2026-06-01 03:08:57,684 - ERROR - Nova failed to get host of the VM
2026-06-01 03:08:57,684 - ERROR - VM ctest-right_vm-35197862 has failed to come up
2026-06-01 03:08:57,684 - ERROR - Nova failed to get host of the VM
2026-06-01 03:08:57,750 - INFO - Skip interface_detach for VM ctest-left_vm-40055580 in state BUILD
2026-06-01 03:08:57,750 - INFO - Deleting VM ctest-left_vm-40055580
2026-06-01 03:08:57,750 - ERROR - VM ctest-left_vm-40055580 has failed to come up
2026-06-01 03:08:57,751 - ERROR - Nova failed to get host of the VM
2026-06-01 03:08:57,751 - ERROR - VM ctest-left_vm-40055580 has failed to come up
2026-06-01 03:08:57,751 - ERROR - Nova failed to get host of the VM
2026-06-01 03:08:57,819 - INFO - Deleting VN ctest-right_vn-69692475
2026-06-01 03:08:57,874 - DEBUG - VN c2fb63c9-1ccc-4a72-b32e-6e5e2a402c90 still in use: Unable to complete operation on network c2fb63c9-1ccc-4a72-b32e-6e5e2a402c90. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-8b25542f-9467-4a58-b072-40ba8b0318e9']
2026-06-01 03:08:57,875 - WARNING - Deleting VN ctest-right_vn-69692475 failed..Will retry
2026-06-01 03:09:00,053 - DEBUG - Response for deleting network ()
2026-06-01 03:09:00,053 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/676190c6-6827-4713-a436-dc69eea2d784
2026-06-01 03:09:00,059 - DEBUG - Response Code: 404
2026-06-01 03:09:00,060 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:00,067 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:00,091 - DEBUG - Requesting: http://10.0.0.240:8082/project/f0da36ac-15d8-4f41-a0d0-785095caf57f
2026-06-01 03:09:00,201 - INFO - Validated that VN ctest-right_vn-69692475 is not found in API Server
2026-06-01 03:09:00,212 - DEBUG - VN ctest-right_vn-69692475 is not present in Agent 10.0.0.130
2026-06-01 03:09:00,224 - DEBUG - VN ctest-right_vn-69692475 is not present in Agent 10.0.0.73
2026-06-01 03:09:00,225 - INFO - Validated that VN ctest-right_vn-69692475 is not in any agent
2026-06-01 03:09:00,261 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-69692475 info
2026-06-01 03:09:00,261 - INFO - Deleting VN ctest-left_vn-65764097
2026-06-01 03:09:00,473 - DEBUG - Response for deleting network ()
2026-06-01 03:09:00,473 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/615f441e-11c7-4f00-b7b6-4a3279648f4a
2026-06-01 03:09:00,478 - DEBUG - Response Code: 404
2026-06-01 03:09:00,479 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:00,485 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:00,508 - DEBUG - Requesting: http://10.0.0.240:8082/project/f0da36ac-15d8-4f41-a0d0-785095caf57f
2026-06-01 03:09:00,624 - INFO - Validated that VN ctest-left_vn-65764097 is not found in API Server
2026-06-01 03:09:00,635 - DEBUG - VN ctest-left_vn-65764097 is not present in Agent 10.0.0.130
2026-06-01 03:09:00,648 - DEBUG - VN ctest-left_vn-65764097 is not present in Agent 10.0.0.73
2026-06-01 03:09:00,648 - INFO - Validated that VN ctest-left_vn-65764097 is not in any agent
2026-06-01 03:09:00,683 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-65764097 info
2026-06-01 03:09:00,683 - INFO - Deleting VN ctest-mgmt_vn-71851088
2026-06-01 03:09:00,878 - DEBUG - Response for deleting network ()
2026-06-01 03:09:00,878 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/7fab2741-740c-43c5-9e1c-029290022c01
2026-06-01 03:09:00,883 - DEBUG - Response Code: 404
2026-06-01 03:09:00,883 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:00,890 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:00,910 - DEBUG - Requesting: http://10.0.0.240:8082/project/f0da36ac-15d8-4f41-a0d0-785095caf57f
2026-06-01 03:09:01,021 - INFO - Validated that VN ctest-mgmt_vn-71851088 is not found in API Server
2026-06-01 03:09:01,033 - DEBUG - VN ctest-mgmt_vn-71851088 is not present in Agent 10.0.0.130
2026-06-01 03:09:01,046 - DEBUG - VN ctest-mgmt_vn-71851088 is not present in Agent 10.0.0.73
2026-06-01 03:09:01,046 - INFO - Validated that VN ctest-mgmt_vn-71851088 is not in any agent
2026-06-01 03:09:01,082 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-71851088 info
2026-06-01 03:09:01,082 - INFO - Deleting VM ctest-vm-in-third-vn-24307327
2026-06-01 03:09:01,153 - INFO - Deleting VN ctest-third-vn-81948265
2026-06-01 03:09:01,193 - DEBUG - VN 606f837b-1ad5-4b81-80ba-3f2b4b79f269 still in use: Unable to complete operation on network 606f837b-1ad5-4b81-80ba-3f2b4b79f269. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-a455571e-84bb-4b82-a55e-d05be03b4ab9']
2026-06-01 03:09:01,193 - WARNING - Deleting VN ctest-third-vn-81948265 failed..Will retry
2026-06-01 03:09:03,382 - DEBUG - Response for deleting network ()
2026-06-01 03:09:04,680 - DEBUG - No XMPP flaps were noticed during the test
2026-06-01 03:09:04,680 - INFO -
2026-06-01 03:09:04,680 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:25]
2026-06-01 03:09:04,681 - INFO - --------------------------------------------------------------------------------
2026-06-01 03:09:04,684 - INFO - ================================================================================
2026-06-01 03:09:04,684 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2026-06-01 03:09:05,960 - DEBUG - Nothing to compare xmpp stats {'10.0.0.130': {'10.20.0.193': '0', '10.20.0.129': '0'}, '10.0.0.73': {'10.20.0.193': '0', '10.20.0.129': '0'}} with
2026-06-01 03:09:05,960 - INFO - Initial checks done. Running the testcase now
2026-06-01 03:09:05,960 - INFO -
2026-06-01 03:09:06,240 - DEBUG - Response for create_network : {'network': {'id': 'ca676e43-f9e2-4fd3-bd42-9dd70d589d18', 'name': 'ctest-mgmt_vn-14252248', 'tenant_id': 'f0da36ac15d84f41a0d0785095caf57f', 'project_id': 'f0da36ac15d84f41a0d0785095caf57f', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-35355821', 'ctest-mgmt_vn-14252248'], 'port_security_enabled': True, 'description': ''}}
2026-06-01 03:09:06,478 - DEBUG - Response for create_subnet : {'subnet': {'id': '2f1098bb-ecb4-4b9d-982b-4925b5312a9d', 'name': '', 'tenant_id': 'f0da36ac15d84f41a0d0785095caf57f', 'network_id': 'ca676e43-f9e2-4fd3-bd42-9dd70d589d18', 'ip_version': 4, 'cidr': '140.153.211.64/26', 'allocation_pools': [{'start': '140.153.211.66', 'end': '140.153.211.126'}], 'gateway_ip': '140.153.211.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '140.153.211.66', 'tags': [], 'project_id': 'f0da36ac15d84f41a0d0785095caf57f'}}
2026-06-01 03:09:06,499 - INFO - Created VN ctest-mgmt_vn-14252248
2026-06-01 03:09:06,512 - DEBUG - VN ctest-mgmt_vn-14252248 UUID is ca676e43-f9e2-4fd3-bd42-9dd70d589d18
2026-06-01 03:09:06,589 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:06,596 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:06,610 - DEBUG - Requesting: http://10.0.0.240:8082/project/f0da36ac-15d8-4f41-a0d0-785095caf57f
2026-06-01 03:09:06,703 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/ca676e43-f9e2-4fd3-bd42-9dd70d589d18
2026-06-01 03:09:06,721 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/ca676e43-f9e2-4fd3-bd42-9dd70d589d18
2026-06-01 03:09:06,731 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/47fae670-c638-4c73-a4f0-3f63f4d20edb
2026-06-01 03:09:06,740 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/47fae670-c638-4c73-a4f0-3f63f4d20edb
2026-06-01 03:09:06,747 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/482b5320-3f5c-4985-bf97-fc7e8fef7178
2026-06-01 03:09:06,753 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-01 03:09:06,753 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/ca676e43-f9e2-4fd3-bd42-9dd70d589d18
2026-06-01 03:09:06,761 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/47fae670-c638-4c73-a4f0-3f63f4d20edb
2026-06-01 03:09:06,779 - INFO - Verified VN network id 16 for VN ca676e43-f9e2-4fd3-bd42-9dd70d589d18
2026-06-01 03:09:06,779 - INFO - Verifications in API Server for VN ctest-mgmt_vn-14252248 passed
2026-06-01 03:09:06,780 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/ca676e43-f9e2-4fd3-bd42-9dd70d589d18
2026-06-01 03:09:06,799 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/47fae670-c638-4c73-a4f0-3f63f4d20edb
2026-06-01 03:09:06,808 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/47fae670-c638-4c73-a4f0-3f63f4d20edb
2026-06-01 03:09:06,816 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/482b5320-3f5c-4985-bf97-fc7e8fef7178
2026-06-01 03:09:06,829 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-35355821:ctest-mgmt_vn-14252248', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-35355821', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14584747156496863187', 'uuid-lslong': '13637636168598723864'}, 'enable': 'true', 'created': '2026-06-01T03:09:06', 'last-modified': '2026-06-01T03:09:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.404047'}
2026-06-01 03:09:06,835 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-01 03:09:06,840 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-35355821:ctest-mgmt_vn-14252248', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-35355821', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14584747156496863187', 'uuid-lslong': '13637636168598723864'}, 'enable': 'true', 'created': '2026-06-01T03:09:06', 'last-modified': '2026-06-01T03:09:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.413132'}
2026-06-01 03:09:06,846 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-01 03:09:06,852 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-35355821:ctest-mgmt_vn-14252248', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-35355821', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14584747156496863187', 'uuid-lslong': '13637636168598723864'}, 'enable': 'true', 'created': '2026-06-01T03:09:06', 'last-modified': '2026-06-01T03:09:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.425437'}
2026-06-01 03:09:06,858 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-01 03:09:06,858 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-14252248 passed
2026-06-01 03:09:06,858 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-14252248 in API_Server ======
2026-06-01 03:09:06,858 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:06,865 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:06,880 - DEBUG - Requesting: http://10.0.0.240:8082/project/f0da36ac-15d8-4f41-a0d0-785095caf57f
2026-06-01 03:09:06,980 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/ca676e43-f9e2-4fd3-bd42-9dd70d589d18
2026-06-01 03:09:06,991 - DEBUG - =>VN ctest-mgmt_vn-14252248 has no policy to be verified
2026-06-01 03:09:06,991 - DEBUG - Verifying the vn in opserver
2026-06-01 03:09:06,991 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-35355821:ctest-mgmt_vn-14252248 virtual network link through opserver 10.0.0.240
2026-06-01 03:09:06,991 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-06-01 03:09:07,005 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-35355821:ctest-mgmt_vn-14252248', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-35355821:ctest-mgmt_vn-14252248?flat'}
2026-06-01 03:09:07,006 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-35355821:ctest-mgmt_vn-14252248 virtual network link through opserver 10.0.0.249
2026-06-01 03:09:07,006 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-06-01 03:09:07,025 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-35355821:ctest-mgmt_vn-14252248', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-35355821:ctest-mgmt_vn-14252248?flat'}
2026-06-01 03:09:07,025 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-35355821:ctest-mgmt_vn-14252248 virtual network link through opserver 10.0.0.65
2026-06-01 03:09:07,026 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-06-01 03:09:07,045 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-35355821:ctest-mgmt_vn-14252248', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-35355821:ctest-mgmt_vn-14252248?flat'}
2026-06-01 03:09:07,045 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-35355821:ctest-mgmt_vn-14252248 is found in opserver
2026-06-01 03:09:07,066 - DEBUG - Do not have enough data to verify VN in agent
2026-06-01 03:09:07,078 - DEBUG - VRF ids for VN ctest-mgmt_vn-14252248: {}
2026-06-01 03:09:07,442 - DEBUG - Response for create_network : {'network': {'id': '427735a2-604d-422d-be2e-8076aeb15fd9', 'name': 'ctest-left_vn-83401495', 'tenant_id': 'f0da36ac15d84f41a0d0785095caf57f', 'project_id': 'f0da36ac15d84f41a0d0785095caf57f', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-35355821', 'ctest-left_vn-83401495'], 'port_security_enabled': True, 'description': ''}}
2026-06-01 03:09:07,759 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f669c06a-4f44-44b0-bb35-7e2350a3026d', 'name': '', 'tenant_id': 'f0da36ac15d84f41a0d0785095caf57f', 'network_id': '427735a2-604d-422d-be2e-8076aeb15fd9', 'ip_version': 4, 'cidr': '96.49.43.192/26', 'allocation_pools': [{'start': '96.49.43.194', 'end': '96.49.43.254'}], 'gateway_ip': '96.49.43.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '96.49.43.194', 'tags': [], 'project_id': 'f0da36ac15d84f41a0d0785095caf57f'}}
2026-06-01 03:09:07,791 - INFO - Created VN ctest-left_vn-83401495
2026-06-01 03:09:07,806 - DEBUG - VN ctest-left_vn-83401495 UUID is 427735a2-604d-422d-be2e-8076aeb15fd9
2026-06-01 03:09:07,914 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:07,921 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:07,936 - DEBUG - Requesting: http://10.0.0.240:8082/project/f0da36ac-15d8-4f41-a0d0-785095caf57f
2026-06-01 03:09:08,056 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/427735a2-604d-422d-be2e-8076aeb15fd9
2026-06-01 03:09:08,068 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/427735a2-604d-422d-be2e-8076aeb15fd9
2026-06-01 03:09:08,079 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/11b45fd3-9847-4f9f-9ee6-34f7ca66fab4
2026-06-01 03:09:08,088 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/11b45fd3-9847-4f9f-9ee6-34f7ca66fab4
2026-06-01 03:09:08,097 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/ec9acdbf-1e18-42fc-b205-2067dbceea88
2026-06-01 03:09:08,107 - DEBUG - Route Targets: ['target:64512:8000007']
2026-06-01 03:09:08,108 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/427735a2-604d-422d-be2e-8076aeb15fd9
2026-06-01 03:09:08,117 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/11b45fd3-9847-4f9f-9ee6-34f7ca66fab4
2026-06-01 03:09:08,134 - INFO - Verified VN network id 17 for VN 427735a2-604d-422d-be2e-8076aeb15fd9
2026-06-01 03:09:08,134 - INFO - Verifications in API Server for VN ctest-left_vn-83401495 passed
2026-06-01 03:09:08,134 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/427735a2-604d-422d-be2e-8076aeb15fd9
2026-06-01 03:09:08,146 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/11b45fd3-9847-4f9f-9ee6-34f7ca66fab4
2026-06-01 03:09:08,153 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/11b45fd3-9847-4f9f-9ee6-34f7ca66fab4
2026-06-01 03:09:08,163 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/ec9acdbf-1e18-42fc-b205-2067dbceea88
2026-06-01 03:09:08,177 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-35355821:ctest-left_vn-83401495', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-35355821', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4789355700248461869', 'uuid-lslong': '13704031963360354265'}, 'enable': 'true', 'created': '2026-06-01T03:09:07', 'last-modified': '2026-06-01T03:09:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.499413'}
2026-06-01 03:09:08,182 - DEBUG - Route Targets: ['target:64512:8000007']
2026-06-01 03:09:08,188 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-35355821:ctest-left_vn-83401495', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-35355821', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4789355700248461869', 'uuid-lslong': '13704031963360354265'}, 'enable': 'true', 'created': '2026-06-01T03:09:07', 'last-modified': '2026-06-01T03:09:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.510590'}
2026-06-01 03:09:08,196 - DEBUG - Route Targets: ['target:64512:8000007']
2026-06-01 03:09:08,206 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-35355821:ctest-left_vn-83401495', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-35355821', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4789355700248461869', 'uuid-lslong': '13704031963360354265'}, 'enable': 'true', 'created': '2026-06-01T03:09:07', 'last-modified': '2026-06-01T03:09:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.522969'}
2026-06-01 03:09:08,217 - DEBUG - Route Targets: ['target:64512:8000007']
2026-06-01 03:09:08,217 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-83401495 passed
2026-06-01 03:09:08,217 - DEBUG - ====Verifying policy data for ctest-left_vn-83401495 in API_Server ======
2026-06-01 03:09:08,217 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:08,223 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:08,236 - DEBUG - Requesting: http://10.0.0.240:8082/project/f0da36ac-15d8-4f41-a0d0-785095caf57f
2026-06-01 03:09:08,342 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/427735a2-604d-422d-be2e-8076aeb15fd9
2026-06-01 03:09:08,355 - DEBUG - =>VN ctest-left_vn-83401495 has no policy to be verified
2026-06-01 03:09:08,355 - DEBUG - Verifying the vn in opserver
2026-06-01 03:09:08,355 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-35355821:ctest-left_vn-83401495 virtual network link through opserver 10.0.0.240
2026-06-01 03:09:08,355 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-06-01 03:09:08,372 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-35355821:ctest-left_vn-83401495', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-35355821:ctest-left_vn-83401495?flat'}
2026-06-01 03:09:08,372 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-35355821:ctest-left_vn-83401495 virtual network link through opserver 10.0.0.249
2026-06-01 03:09:08,373 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-06-01 03:09:08,389 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-35355821:ctest-left_vn-83401495', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-35355821:ctest-left_vn-83401495?flat'}
2026-06-01 03:09:08,389 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-35355821:ctest-left_vn-83401495 virtual network link through opserver 10.0.0.65
2026-06-01 03:09:08,389 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-06-01 03:09:08,402 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-35355821:ctest-left_vn-83401495', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-35355821:ctest-left_vn-83401495?flat'}
2026-06-01 03:09:08,402 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-35355821:ctest-left_vn-83401495 is found in opserver
2026-06-01 03:09:08,424 - DEBUG - Do not have enough data to verify VN in agent
2026-06-01 03:09:08,434 - DEBUG - VRF ids for VN ctest-left_vn-83401495: {}
2026-06-01 03:09:08,742 - DEBUG - Response for create_network : {'network': {'id': 'f8140fce-2a30-414e-a2ef-7eab72229af9', 'name': 'ctest-right_vn-51255527', 'tenant_id': 'f0da36ac15d84f41a0d0785095caf57f', 'project_id': 'f0da36ac15d84f41a0d0785095caf57f', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-35355821', 'ctest-right_vn-51255527'], 'port_security_enabled': True, 'description': ''}}
2026-06-01 03:09:09,024 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c9e470b7-dcf0-4124-8213-7c6032f5a911', 'name': '', 'tenant_id': 'f0da36ac15d84f41a0d0785095caf57f', 'network_id': 'f8140fce-2a30-414e-a2ef-7eab72229af9', 'ip_version': 4, 'cidr': '15.174.76.192/26', 'allocation_pools': [{'start': '15.174.76.194', 'end': '15.174.76.254'}], 'gateway_ip': '15.174.76.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '15.174.76.194', 'tags': [], 'project_id': 'f0da36ac15d84f41a0d0785095caf57f'}}
2026-06-01 03:09:09,054 - INFO - Created VN ctest-right_vn-51255527
2026-06-01 03:09:09,066 - DEBUG - VN ctest-right_vn-51255527 UUID is f8140fce-2a30-414e-a2ef-7eab72229af9
2026-06-01 03:09:09,152 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:09,158 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:09,170 - DEBUG - Requesting: http://10.0.0.240:8082/project/f0da36ac-15d8-4f41-a0d0-785095caf57f
2026-06-01 03:09:09,261 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/f8140fce-2a30-414e-a2ef-7eab72229af9
2026-06-01 03:09:09,286 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/f8140fce-2a30-414e-a2ef-7eab72229af9
2026-06-01 03:09:09,297 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/476a5c8b-c530-4412-832e-e98a19ef3ccf
2026-06-01 03:09:09,306 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/476a5c8b-c530-4412-832e-e98a19ef3ccf
2026-06-01 03:09:09,313 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/085a664c-77fd-4ea9-abd6-23eeeaea4b49
2026-06-01 03:09:09,322 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-01 03:09:09,322 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/f8140fce-2a30-414e-a2ef-7eab72229af9
2026-06-01 03:09:09,335 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/476a5c8b-c530-4412-832e-e98a19ef3ccf
2026-06-01 03:09:09,353 - INFO - Verified VN network id 18 for VN f8140fce-2a30-414e-a2ef-7eab72229af9
2026-06-01 03:09:09,353 - INFO - Verifications in API Server for VN ctest-right_vn-51255527 passed
2026-06-01 03:09:09,353 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/f8140fce-2a30-414e-a2ef-7eab72229af9
2026-06-01 03:09:09,364 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/476a5c8b-c530-4412-832e-e98a19ef3ccf
2026-06-01 03:09:09,373 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/476a5c8b-c530-4412-832e-e98a19ef3ccf
2026-06-01 03:09:09,380 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/085a664c-77fd-4ea9-abd6-23eeeaea4b49
2026-06-01 03:09:09,400 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-35355821:ctest-right_vn-51255527', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-35355821', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17875930199085826382', 'uuid-lslong': '11740742028397550329'}, 'enable': 'true', 'created': '2026-06-01T03:09:08', 'last-modified': '2026-06-01T03:09:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.458056'}
2026-06-01 03:09:09,405 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-01 03:09:09,412 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-35355821:ctest-right_vn-51255527', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-35355821', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17875930199085826382', 'uuid-lslong': '11740742028397550329'}, 'enable': 'true', 'created': '2026-06-01T03:09:08', 'last-modified': '2026-06-01T03:09:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.466189'}
2026-06-01 03:09:09,418 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-01 03:09:09,424 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-35355821:ctest-right_vn-51255527', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-35355821', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17875930199085826382', 'uuid-lslong': '11740742028397550329'}, 'enable': 'true', 'created': '2026-06-01T03:09:08', 'last-modified': '2026-06-01T03:09:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.481889'}
2026-06-01 03:09:09,432 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-01 03:09:09,432 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-51255527 passed
2026-06-01 03:09:09,432 - DEBUG - ====Verifying policy data for ctest-right_vn-51255527 in API_Server ======
2026-06-01 03:09:09,432 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:09,440 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:09,453 - DEBUG - Requesting: http://10.0.0.240:8082/project/f0da36ac-15d8-4f41-a0d0-785095caf57f
2026-06-01 03:09:09,556 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/f8140fce-2a30-414e-a2ef-7eab72229af9
2026-06-01 03:09:09,568 - DEBUG - =>VN ctest-right_vn-51255527 has no policy to be verified
2026-06-01 03:09:09,568 - DEBUG - Verifying the vn in opserver
2026-06-01 03:09:09,568 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-35355821:ctest-right_vn-51255527 virtual network link through opserver 10.0.0.240
2026-06-01 03:09:09,568 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-06-01 03:09:09,583 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-35355821:ctest-right_vn-51255527', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-35355821:ctest-right_vn-51255527?flat'}
2026-06-01 03:09:09,583 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-35355821:ctest-right_vn-51255527 virtual network link through opserver 10.0.0.249
2026-06-01 03:09:09,583 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-06-01 03:09:09,599 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-35355821:ctest-right_vn-51255527', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-35355821:ctest-right_vn-51255527?flat'}
2026-06-01 03:09:09,599 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-35355821:ctest-right_vn-51255527 virtual network link through opserver 10.0.0.65
2026-06-01 03:09:09,599 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-06-01 03:09:09,620 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-35355821:ctest-right_vn-51255527', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-35355821:ctest-right_vn-51255527?flat'}
2026-06-01 03:09:09,620 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-35355821:ctest-right_vn-51255527 is found in opserver
2026-06-01 03:09:09,641 - DEBUG - Do not have enough data to verify VN in agent
2026-06-01 03:09:09,651 - DEBUG - VRF ids for VN ctest-right_vn-51255527: {}
2026-06-01 03:09:09,954 - DEBUG - Response for create_network : {'network': {'id': 'ce1352c5-ec30-4f19-ad57-913239a149c2', 'name': 'ctest-trans_left_vn-41418819', 'tenant_id': 'f0da36ac15d84f41a0d0785095caf57f', 'project_id': 'f0da36ac15d84f41a0d0785095caf57f', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-35355821', 'ctest-trans_left_vn-41418819'], 'port_security_enabled': True, 'description': ''}}
2026-06-01 03:09:10,213 - DEBUG - Response for create_subnet : {'subnet': {'id': '1a2c3eec-95a7-47a0-8e94-2da56e732c90', 'name': '', 'tenant_id': 'f0da36ac15d84f41a0d0785095caf57f', 'network_id': 'ce1352c5-ec30-4f19-ad57-913239a149c2', 'ip_version': 4, 'cidr': '40.197.61.64/26', 'allocation_pools': [{'start': '40.197.61.66', 'end': '40.197.61.126'}], 'gateway_ip': '40.197.61.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '40.197.61.66', 'tags': [], 'project_id': 'f0da36ac15d84f41a0d0785095caf57f'}}
2026-06-01 03:09:10,252 - INFO - Created VN ctest-trans_left_vn-41418819
2026-06-01 03:09:10,265 - DEBUG - VN ctest-trans_left_vn-41418819 UUID is ce1352c5-ec30-4f19-ad57-913239a149c2
2026-06-01 03:09:10,348 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:10,354 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:10,365 - DEBUG - Requesting: http://10.0.0.240:8082/project/f0da36ac-15d8-4f41-a0d0-785095caf57f
2026-06-01 03:09:10,470 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/ce1352c5-ec30-4f19-ad57-913239a149c2
2026-06-01 03:09:10,485 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/ce1352c5-ec30-4f19-ad57-913239a149c2
2026-06-01 03:09:10,495 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/3d797309-dd6f-4529-936d-4e2d146c1de6
2026-06-01 03:09:10,504 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/3d797309-dd6f-4529-936d-4e2d146c1de6
2026-06-01 03:09:10,513 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/e77a3f59-4f25-4d11-b89c-760b10b4b127
2026-06-01 03:09:10,520 - DEBUG - Route Targets: ['target:64512:8000009']
2026-06-01 03:09:10,520 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/ce1352c5-ec30-4f19-ad57-913239a149c2
2026-06-01 03:09:10,530 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/3d797309-dd6f-4529-936d-4e2d146c1de6
2026-06-01 03:09:10,546 - INFO - Verified VN network id 19 for VN ce1352c5-ec30-4f19-ad57-913239a149c2
2026-06-01 03:09:10,546 - INFO - Verifications in API Server for VN ctest-trans_left_vn-41418819 passed
2026-06-01 03:09:10,546 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/ce1352c5-ec30-4f19-ad57-913239a149c2
2026-06-01 03:09:10,555 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/3d797309-dd6f-4529-936d-4e2d146c1de6
2026-06-01 03:09:10,561 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/3d797309-dd6f-4529-936d-4e2d146c1de6
2026-06-01 03:09:10,568 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/e77a3f59-4f25-4d11-b89c-760b10b4b127
2026-06-01 03:09:10,583 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-35355821:ctest-trans_left_vn-41418819', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-35355821', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14849303406395281177', 'uuid-lslong': '12490611736436623810'}, 'enable': 'true', 'created': '2026-06-01T03:09:09', 'last-modified': '2026-06-01T03:09:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.421401'}
2026-06-01 03:09:10,590 - DEBUG - Route Targets: ['target:64512:8000009']
2026-06-01 03:09:10,596 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-35355821:ctest-trans_left_vn-41418819', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-35355821', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14849303406395281177', 'uuid-lslong': '12490611736436623810'}, 'enable': 'true', 'created': '2026-06-01T03:09:09', 'last-modified': '2026-06-01T03:09:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.444469'}
2026-06-01 03:09:10,603 - DEBUG - Route Targets: ['target:64512:8000009']
2026-06-01 03:09:10,609 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-35355821:ctest-trans_left_vn-41418819', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-35355821', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14849303406395281177', 'uuid-lslong': '12490611736436623810'}, 'enable': 'true', 'created': '2026-06-01T03:09:09', 'last-modified': '2026-06-01T03:09:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.456166'}
2026-06-01 03:09:10,614 - DEBUG - Route Targets: ['target:64512:8000009']
2026-06-01 03:09:10,615 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-41418819 passed
2026-06-01 03:09:10,615 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-41418819 in API_Server ======
2026-06-01 03:09:10,615 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:10,621 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:10,632 - DEBUG - Requesting: http://10.0.0.240:8082/project/f0da36ac-15d8-4f41-a0d0-785095caf57f
2026-06-01 03:09:10,728 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/ce1352c5-ec30-4f19-ad57-913239a149c2
2026-06-01 03:09:10,742 - DEBUG - =>VN ctest-trans_left_vn-41418819 has no policy to be verified
2026-06-01 03:09:10,742 - DEBUG - Verifying the vn in opserver
2026-06-01 03:09:10,742 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-35355821:ctest-trans_left_vn-41418819 virtual network link through opserver 10.0.0.240
2026-06-01 03:09:10,742 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-06-01 03:09:10,757 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-35355821:ctest-trans_left_vn-41418819', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-35355821:ctest-trans_left_vn-41418819?flat'}
2026-06-01 03:09:10,757 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-35355821:ctest-trans_left_vn-41418819 virtual network link through opserver 10.0.0.249
2026-06-01 03:09:10,757 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-06-01 03:09:10,772 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-35355821:ctest-trans_left_vn-41418819', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-35355821:ctest-trans_left_vn-41418819?flat'}
2026-06-01 03:09:10,772 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-35355821:ctest-trans_left_vn-41418819 virtual network link through opserver 10.0.0.65
2026-06-01 03:09:10,772 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-06-01 03:09:10,786 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-35355821:ctest-trans_left_vn-41418819', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-35355821:ctest-trans_left_vn-41418819?flat'}
2026-06-01 03:09:10,786 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-35355821:ctest-trans_left_vn-41418819 is found in opserver
2026-06-01 03:09:10,808 - DEBUG - Do not have enough data to verify VN in agent
2026-06-01 03:09:10,819 - DEBUG - VRF ids for VN ctest-trans_left_vn-41418819: {}
2026-06-01 03:09:11,127 - DEBUG - Response for create_network : {'network': {'id': '91e91c3f-22df-4a1c-8cbd-1233871dde2f', 'name': 'ctest-trans_right_vn-05021714', 'tenant_id': 'f0da36ac15d84f41a0d0785095caf57f', 'project_id': 'f0da36ac15d84f41a0d0785095caf57f', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-35355821', 'ctest-trans_right_vn-05021714'], 'port_security_enabled': True, 'description': ''}}
2026-06-01 03:09:11,349 - DEBUG - Response for create_subnet : {'subnet': {'id': '02b3920a-5927-439b-84b4-350246c7896a', 'name': '', 'tenant_id': 'f0da36ac15d84f41a0d0785095caf57f', 'network_id': '91e91c3f-22df-4a1c-8cbd-1233871dde2f', 'ip_version': 4, 'cidr': '208.98.234.0/26', 'allocation_pools': [{'start': '208.98.234.2', 'end': '208.98.234.62'}], 'gateway_ip': '208.98.234.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '208.98.234.2', 'tags': [], 'project_id': 'f0da36ac15d84f41a0d0785095caf57f'}}
2026-06-01 03:09:11,374 - INFO - Created VN ctest-trans_right_vn-05021714
2026-06-01 03:09:11,396 - DEBUG - VN ctest-trans_right_vn-05021714 UUID is 91e91c3f-22df-4a1c-8cbd-1233871dde2f
2026-06-01 03:09:11,470 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:11,476 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:11,487 - DEBUG - Requesting: http://10.0.0.240:8082/project/f0da36ac-15d8-4f41-a0d0-785095caf57f
2026-06-01 03:09:11,576 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/91e91c3f-22df-4a1c-8cbd-1233871dde2f
2026-06-01 03:09:11,589 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/91e91c3f-22df-4a1c-8cbd-1233871dde2f
2026-06-01 03:09:11,601 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/cacd24bf-90af-43c1-8ce6-da331ced8399
2026-06-01 03:09:11,609 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/cacd24bf-90af-43c1-8ce6-da331ced8399
2026-06-01 03:09:11,617 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/6b85ee44-c7df-4d69-926f-f4a26e8ba24d
2026-06-01 03:09:11,624 - DEBUG - Route Targets: ['target:64512:8000010']
2026-06-01 03:09:11,624 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/91e91c3f-22df-4a1c-8cbd-1233871dde2f
2026-06-01 03:09:11,633 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/cacd24bf-90af-43c1-8ce6-da331ced8399
2026-06-01 03:09:11,649 - INFO - Verified VN network id 20 for VN 91e91c3f-22df-4a1c-8cbd-1233871dde2f
2026-06-01 03:09:11,649 - INFO - Verifications in API Server for VN ctest-trans_right_vn-05021714 passed
2026-06-01 03:09:11,650 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/91e91c3f-22df-4a1c-8cbd-1233871dde2f
2026-06-01 03:09:11,663 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/cacd24bf-90af-43c1-8ce6-da331ced8399
2026-06-01 03:09:11,672 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/cacd24bf-90af-43c1-8ce6-da331ced8399
2026-06-01 03:09:11,681 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/6b85ee44-c7df-4d69-926f-f4a26e8ba24d
2026-06-01 03:09:11,695 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-35355821:ctest-trans_right_vn-05021714', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-35355821', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10513965862566709788', 'uuid-lslong': '10141281948427738671'}, 'enable': 'true', 'created': '2026-06-01T03:09:11', 'last-modified': '2026-06-01T03:09:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.414083'}
2026-06-01 03:09:11,700 - DEBUG - Route Targets: ['target:64512:8000010']
2026-06-01 03:09:11,707 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-35355821:ctest-trans_right_vn-05021714', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-35355821', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10513965862566709788', 'uuid-lslong': '10141281948427738671'}, 'enable': 'true', 'created': '2026-06-01T03:09:11', 'last-modified': '2026-06-01T03:09:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.427557'}
2026-06-01 03:09:11,714 - DEBUG - Route Targets: ['target:64512:8000010']
2026-06-01 03:09:11,720 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-35355821:ctest-trans_right_vn-05021714', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-35355821', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10513965862566709788', 'uuid-lslong': '10141281948427738671'}, 'enable': 'true', 'created': '2026-06-01T03:09:11', 'last-modified': '2026-06-01T03:09:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.435499'}
2026-06-01 03:09:11,726 - DEBUG - Route Targets: ['target:64512:8000010']
2026-06-01 03:09:11,726 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-05021714 passed
2026-06-01 03:09:11,726 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-05021714 in API_Server ======
2026-06-01 03:09:11,726 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:11,733 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:11,744 - DEBUG - Requesting: http://10.0.0.240:8082/project/f0da36ac-15d8-4f41-a0d0-785095caf57f
2026-06-01 03:09:11,850 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/91e91c3f-22df-4a1c-8cbd-1233871dde2f
2026-06-01 03:09:11,864 - DEBUG - =>VN ctest-trans_right_vn-05021714 has no policy to be verified
2026-06-01 03:09:11,864 - DEBUG - Verifying the vn in opserver
2026-06-01 03:09:11,864 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-35355821:ctest-trans_right_vn-05021714 virtual network link through opserver 10.0.0.240
2026-06-01 03:09:11,864 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-06-01 03:09:11,878 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-35355821:ctest-trans_right_vn-05021714', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-35355821:ctest-trans_right_vn-05021714?flat'}
2026-06-01 03:09:11,878 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-35355821:ctest-trans_right_vn-05021714 virtual network link through opserver 10.0.0.249
2026-06-01 03:09:11,878 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-06-01 03:09:11,893 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-35355821:ctest-trans_right_vn-05021714', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-35355821:ctest-trans_right_vn-05021714?flat'}
2026-06-01 03:09:11,893 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-35355821:ctest-trans_right_vn-05021714 virtual network link through opserver 10.0.0.65
2026-06-01 03:09:11,893 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-06-01 03:09:11,909 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-35355821:ctest-trans_right_vn-05021714', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-35355821:ctest-trans_right_vn-05021714?flat'}
2026-06-01 03:09:11,909 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-35355821:ctest-trans_right_vn-05021714 is found in opserver
2026-06-01 03:09:11,931 - DEBUG - Do not have enough data to verify VN in agent
2026-06-01 03:09:11,944 - DEBUG - VRF ids for VN ctest-trans_right_vn-05021714: {}
2026-06-01 03:09:13,198 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5860-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5860-2)
2026-06-01 03:09:14,574 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5860-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5860-1)
2026-06-01 03:09:14,574 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-92119290']
2026-06-01 03:09:14,871 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-92119290'] created succesfully
2026-06-01 03:09:15,404 - DEBUG - Image by name tiny_trans_fw not found
2026-06-01 03:09:15,404 - DEBUG - Installing image tiny_trans_fw
2026-06-01 03:09:15,404 - 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-06-01 03:09:15,404 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-06-01 03:09:15,404 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-06-01 03:09:15,425 - 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-06-01 03:09:15,477 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-06-01 03:09:15,478 - DEBUG - Unzip image
2026-06-01 03:09:15,478 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-06-01 03:09:15,514 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-06-01 03:09:15,515 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-92119290']
2026-06-01 03:09:15,625 - INFO - Service template: ['default-domain', 'ctest-service_template_1-92119290'] deleted successfully.
2026-06-01 03:09:15,625 - INFO - Skip interface_detach for VM ctest-right_vm-38482990 in state BUILD
2026-06-01 03:09:15,625 - INFO - Deleting VM ctest-right_vm-38482990
2026-06-01 03:09:15,625 - ERROR - VM ctest-right_vm-38482990 has failed to come up
2026-06-01 03:09:15,625 - ERROR - Nova failed to get host of the VM
2026-06-01 03:09:15,625 - ERROR - VM ctest-right_vm-38482990 has failed to come up
2026-06-01 03:09:15,625 - ERROR - Nova failed to get host of the VM
2026-06-01 03:09:15,713 - INFO - Skip interface_detach for VM ctest-left_vm-69030081 in state BUILD
2026-06-01 03:09:15,713 - INFO - Deleting VM ctest-left_vm-69030081
2026-06-01 03:09:15,713 - ERROR - VM ctest-left_vm-69030081 has failed to come up
2026-06-01 03:09:15,713 - ERROR - Nova failed to get host of the VM
2026-06-01 03:09:15,713 - ERROR - VM ctest-left_vm-69030081 has failed to come up
2026-06-01 03:09:15,713 - ERROR - Nova failed to get host of the VM
2026-06-01 03:09:15,800 - INFO - Deleting VN ctest-trans_right_vn-05021714
2026-06-01 03:09:15,947 - DEBUG - Response for deleting network ()
2026-06-01 03:09:15,947 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/cacd24bf-90af-43c1-8ce6-da331ced8399
2026-06-01 03:09:15,953 - DEBUG - Response Code: 404
2026-06-01 03:09:15,953 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:15,959 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:16,028 - DEBUG - Requesting: http://10.0.0.240:8082/project/f0da36ac-15d8-4f41-a0d0-785095caf57f
2026-06-01 03:09:16,125 - INFO - Validated that VN ctest-trans_right_vn-05021714 is not found in API Server
2026-06-01 03:09:16,140 - DEBUG - VN ctest-trans_right_vn-05021714 is not present in Agent 10.0.0.130
2026-06-01 03:09:16,151 - DEBUG - VN ctest-trans_right_vn-05021714 is not present in Agent 10.0.0.73
2026-06-01 03:09:16,151 - INFO - Validated that VN ctest-trans_right_vn-05021714 is not in any agent
2026-06-01 03:09:16,191 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-05021714 info
2026-06-01 03:09:16,191 - INFO - Deleting VN ctest-trans_left_vn-41418819
2026-06-01 03:09:16,369 - DEBUG - Response for deleting network ()
2026-06-01 03:09:16,369 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/3d797309-dd6f-4529-936d-4e2d146c1de6
2026-06-01 03:09:16,378 - DEBUG - Response Code: 404
2026-06-01 03:09:16,378 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:16,384 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:16,396 - DEBUG - Requesting: http://10.0.0.240:8082/project/f0da36ac-15d8-4f41-a0d0-785095caf57f
2026-06-01 03:09:16,489 - INFO - Validated that VN ctest-trans_left_vn-41418819 is not found in API Server
2026-06-01 03:09:16,519 - DEBUG - VN ctest-trans_left_vn-41418819 is not present in Agent 10.0.0.130
2026-06-01 03:09:16,529 - DEBUG - VN ctest-trans_left_vn-41418819 is not present in Agent 10.0.0.73
2026-06-01 03:09:16,529 - INFO - Validated that VN ctest-trans_left_vn-41418819 is not in any agent
2026-06-01 03:09:16,586 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-41418819 info
2026-06-01 03:09:16,586 - INFO - Deleting VN ctest-right_vn-51255527
2026-06-01 03:09:16,656 - DEBUG - VN f8140fce-2a30-414e-a2ef-7eab72229af9 still in use: Unable to complete operation on network f8140fce-2a30-414e-a2ef-7eab72229af9. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-f936e035-e283-4cfb-8961-c142752bda52']
2026-06-01 03:09:16,656 - WARNING - Deleting VN ctest-right_vn-51255527 failed..Will retry
2026-06-01 03:09:18,845 - DEBUG - Response for deleting network ()
2026-06-01 03:09:18,846 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/476a5c8b-c530-4412-832e-e98a19ef3ccf
2026-06-01 03:09:18,851 - DEBUG - Response Code: 404
2026-06-01 03:09:18,851 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:18,859 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:18,876 - DEBUG - Requesting: http://10.0.0.240:8082/project/f0da36ac-15d8-4f41-a0d0-785095caf57f
2026-06-01 03:09:18,967 - INFO - Validated that VN ctest-right_vn-51255527 is not found in API Server
2026-06-01 03:09:18,978 - DEBUG - VN ctest-right_vn-51255527 is not present in Agent 10.0.0.130
2026-06-01 03:09:18,991 - DEBUG - VN ctest-right_vn-51255527 is not present in Agent 10.0.0.73
2026-06-01 03:09:18,991 - INFO - Validated that VN ctest-right_vn-51255527 is not in any agent
2026-06-01 03:09:19,022 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-51255527 info
2026-06-01 03:09:19,022 - INFO - Deleting VN ctest-left_vn-83401495
2026-06-01 03:09:19,181 - DEBUG - Response for deleting network ()
2026-06-01 03:09:19,181 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/11b45fd3-9847-4f9f-9ee6-34f7ca66fab4
2026-06-01 03:09:19,188 - DEBUG - Response Code: 404
2026-06-01 03:09:19,188 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:19,195 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:19,251 - DEBUG - Requesting: http://10.0.0.240:8082/project/f0da36ac-15d8-4f41-a0d0-785095caf57f
2026-06-01 03:09:19,355 - INFO - Validated that VN ctest-left_vn-83401495 is not found in API Server
2026-06-01 03:09:19,365 - DEBUG - VN ctest-left_vn-83401495 is not present in Agent 10.0.0.130
2026-06-01 03:09:19,375 - DEBUG - VN ctest-left_vn-83401495 is not present in Agent 10.0.0.73
2026-06-01 03:09:19,375 - INFO - Validated that VN ctest-left_vn-83401495 is not in any agent
2026-06-01 03:09:19,405 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-83401495 info
2026-06-01 03:09:19,405 - INFO - Deleting VN ctest-mgmt_vn-14252248
2026-06-01 03:09:19,565 - DEBUG - Response for deleting network ()
2026-06-01 03:09:19,565 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/47fae670-c638-4c73-a4f0-3f63f4d20edb
2026-06-01 03:09:19,571 - DEBUG - Response Code: 404
2026-06-01 03:09:19,572 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:19,579 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:19,591 - DEBUG - Requesting: http://10.0.0.240:8082/project/f0da36ac-15d8-4f41-a0d0-785095caf57f
2026-06-01 03:09:19,700 - INFO - Validated that VN ctest-mgmt_vn-14252248 is not found in API Server
2026-06-01 03:09:19,711 - DEBUG - VN ctest-mgmt_vn-14252248 is not present in Agent 10.0.0.130
2026-06-01 03:09:19,722 - DEBUG - VN ctest-mgmt_vn-14252248 is not present in Agent 10.0.0.73
2026-06-01 03:09:19,722 - INFO - Validated that VN ctest-mgmt_vn-14252248 is not in any agent
2026-06-01 03:09:19,757 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-14252248 info
2026-06-01 03:09:21,063 - DEBUG - No XMPP flaps were noticed during the test
2026-06-01 03:09:21,063 - INFO -
2026-06-01 03:09:21,063 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:17]
2026-06-01 03:09:21,063 - INFO - --------------------------------------------------------------------------------
2026-06-01 03:09:21,854 - INFO - Deleted project: ctest-TestSvcRegr-35355821, ID : f0da36ac-15d8-4f41-a0d0-785095caf57f
2026-06-01 03:09:22,027 - INFO - Domain Default found not creating
2026-06-01 03:09:22,190 - INFO - Project ctest-TestSvcRegr-32939500 not found, creating it
2026-06-01 03:09:22,702 - INFO - Created Project:ctest-TestSvcRegr-32939500, ID : e8617e39-f15f-45c1-95e9-38a5587a0387
2026-06-01 03:09:24,767 - INFO - ================================================================================
2026-06-01 03:09:24,767 - INFO - STARTING TEST : test_svc_CEM_22032
2026-06-01 03:09:26,043 - DEBUG - Nothing to compare xmpp stats {'10.0.0.130': {'10.20.0.193': '0', '10.20.0.129': '0'}, '10.0.0.73': {'10.20.0.193': '0', '10.20.0.129': '0'}} with
2026-06-01 03:09:26,043 - INFO - Initial checks done. Running the testcase now
2026-06-01 03:09:26,043 - INFO -
2026-06-01 03:09:26,779 - DEBUG - Response for create_network : {'network': {'id': 'aa021c84-c8cb-4a50-a21d-4226f33b739f', 'name': 'ctest-mgmt_vn-28202515', 'tenant_id': 'e8617e39f15f45c195e938a5587a0387', 'project_id': 'e8617e39f15f45c195e938a5587a0387', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-32939500', 'ctest-mgmt_vn-28202515'], 'port_security_enabled': True, 'description': ''}}
2026-06-01 03:09:27,045 - DEBUG - Response for create_subnet : {'subnet': {'id': '746b412d-4f53-4755-992a-cd3ba6d2f55b', 'name': '', 'tenant_id': 'e8617e39f15f45c195e938a5587a0387', 'network_id': 'aa021c84-c8cb-4a50-a21d-4226f33b739f', 'ip_version': 4, 'cidr': '94.22.192.64/26', 'allocation_pools': [{'start': '94.22.192.66', 'end': '94.22.192.126'}], 'gateway_ip': '94.22.192.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '94.22.192.66', 'tags': [], 'project_id': 'e8617e39f15f45c195e938a5587a0387'}}
2026-06-01 03:09:27,065 - INFO - Created VN ctest-mgmt_vn-28202515
2026-06-01 03:09:27,076 - DEBUG - VN ctest-mgmt_vn-28202515 UUID is aa021c84-c8cb-4a50-a21d-4226f33b739f
2026-06-01 03:09:27,152 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:27,443 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:27,477 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:27,523 - DEBUG - Requesting: http://10.0.0.240:8082/project/e8617e39-f15f-45c1-95e9-38a5587a0387
2026-06-01 03:09:27,611 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/aa021c84-c8cb-4a50-a21d-4226f33b739f
2026-06-01 03:09:27,622 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/aa021c84-c8cb-4a50-a21d-4226f33b739f
2026-06-01 03:09:27,632 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/3525935c-b25f-44d3-aa71-aa847fedcdeb
2026-06-01 03:09:27,643 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/3525935c-b25f-44d3-aa71-aa847fedcdeb
2026-06-01 03:09:27,651 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/b70a4035-eb32-4f67-abb1-5521094c8621
2026-06-01 03:09:27,657 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-01 03:09:27,657 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/aa021c84-c8cb-4a50-a21d-4226f33b739f
2026-06-01 03:09:27,666 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/3525935c-b25f-44d3-aa71-aa847fedcdeb
2026-06-01 03:09:27,681 - INFO - Verified VN network id 16 for VN aa021c84-c8cb-4a50-a21d-4226f33b739f
2026-06-01 03:09:27,681 - INFO - Verifications in API Server for VN ctest-mgmt_vn-28202515 passed
2026-06-01 03:09:27,681 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/aa021c84-c8cb-4a50-a21d-4226f33b739f
2026-06-01 03:09:27,690 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/3525935c-b25f-44d3-aa71-aa847fedcdeb
2026-06-01 03:09:27,698 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/3525935c-b25f-44d3-aa71-aa847fedcdeb
2026-06-01 03:09:27,705 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/b70a4035-eb32-4f67-abb1-5521094c8621
2026-06-01 03:09:27,717 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-28202515', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-32939500', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12250385293031197264', 'uuid-lslong': '11681565743525884831'}, 'enable': 'true', 'created': '2026-06-01T03:09:26', 'last-modified': '2026-06-01T03:09:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.746061'}
2026-06-01 03:09:27,723 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-01 03:09:27,728 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-28202515', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-32939500', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12250385293031197264', 'uuid-lslong': '11681565743525884831'}, 'enable': 'true', 'created': '2026-06-01T03:09:26', 'last-modified': '2026-06-01T03:09:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.759311'}
2026-06-01 03:09:27,734 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-01 03:09:27,738 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-28202515', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-32939500', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12250385293031197264', 'uuid-lslong': '11681565743525884831'}, 'enable': 'true', 'created': '2026-06-01T03:09:26', 'last-modified': '2026-06-01T03:09:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.766468'}
2026-06-01 03:09:27,743 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-01 03:09:27,743 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-28202515 passed
2026-06-01 03:09:27,743 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-28202515 in API_Server ======
2026-06-01 03:09:27,743 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:27,750 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:27,760 - DEBUG - Requesting: http://10.0.0.240:8082/project/e8617e39-f15f-45c1-95e9-38a5587a0387
2026-06-01 03:09:27,857 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/aa021c84-c8cb-4a50-a21d-4226f33b739f
2026-06-01 03:09:27,866 - DEBUG - =>VN ctest-mgmt_vn-28202515 has no policy to be verified
2026-06-01 03:09:27,866 - DEBUG - Verifying the vn in opserver
2026-06-01 03:09:27,866 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-28202515 virtual network link through opserver 10.0.0.240
2026-06-01 03:09:27,867 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-06-01 03:09:28,167 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-06-01 03:09:28,228 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-28202515', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-28202515?flat'}
2026-06-01 03:09:28,228 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-28202515 virtual network link through opserver 10.0.0.249
2026-06-01 03:09:28,229 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-06-01 03:09:28,531 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-06-01 03:09:28,598 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-28202515', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-28202515?flat'}
2026-06-01 03:09:28,598 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-28202515 virtual network link through opserver 10.0.0.65
2026-06-01 03:09:28,598 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-06-01 03:09:28,904 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-06-01 03:09:28,967 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-28202515', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-28202515?flat'}
2026-06-01 03:09:28,967 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-28202515 is found in opserver
2026-06-01 03:09:28,989 - DEBUG - Do not have enough data to verify VN in agent
2026-06-01 03:09:28,998 - DEBUG - VRF ids for VN ctest-mgmt_vn-28202515: {}
2026-06-01 03:09:29,327 - DEBUG - Response for create_network : {'network': {'id': 'c32b876b-041b-4ab2-8495-0cb2c8217acf', 'name': 'service-left-vn-65342702', 'tenant_id': 'e8617e39f15f45c195e938a5587a0387', 'project_id': 'e8617e39f15f45c195e938a5587a0387', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-32939500', 'service-left-vn-65342702'], 'port_security_enabled': True, 'description': ''}}
2026-06-01 03:09:29,606 - DEBUG - Response for create_subnet : {'subnet': {'id': '984592f1-c9f5-4dc4-a3f8-e5d1ad6a41e5', 'name': '', 'tenant_id': 'e8617e39f15f45c195e938a5587a0387', 'network_id': 'c32b876b-041b-4ab2-8495-0cb2c8217acf', 'ip_version': 4, 'cidr': '23.230.204.0/26', 'allocation_pools': [{'start': '23.230.204.2', 'end': '23.230.204.62'}], 'gateway_ip': '23.230.204.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '23.230.204.2', 'tags': [], 'project_id': 'e8617e39f15f45c195e938a5587a0387'}}
2026-06-01 03:09:29,635 - INFO - Created VN service-left-vn-65342702
2026-06-01 03:09:29,651 - DEBUG - VN service-left-vn-65342702 UUID is c32b876b-041b-4ab2-8495-0cb2c8217acf
2026-06-01 03:09:29,728 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:29,736 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:29,751 - DEBUG - Requesting: http://10.0.0.240:8082/project/e8617e39-f15f-45c1-95e9-38a5587a0387
2026-06-01 03:09:29,853 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/c32b876b-041b-4ab2-8495-0cb2c8217acf
2026-06-01 03:09:29,865 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/c32b876b-041b-4ab2-8495-0cb2c8217acf
2026-06-01 03:09:29,875 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/342b7411-d553-409d-8936-096829c81134
2026-06-01 03:09:29,883 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/342b7411-d553-409d-8936-096829c81134
2026-06-01 03:09:29,890 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/b42afdcb-626a-48ca-aafa-5ba9a428ac9a
2026-06-01 03:09:29,898 - DEBUG - Route Targets: ['target:64512:8000007']
2026-06-01 03:09:29,898 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/c32b876b-041b-4ab2-8495-0cb2c8217acf
2026-06-01 03:09:29,907 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/342b7411-d553-409d-8936-096829c81134
2026-06-01 03:09:29,923 - INFO - Verified VN network id 17 for VN c32b876b-041b-4ab2-8495-0cb2c8217acf
2026-06-01 03:09:29,923 - INFO - Verifications in API Server for VN service-left-vn-65342702 passed
2026-06-01 03:09:29,923 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/c32b876b-041b-4ab2-8495-0cb2c8217acf
2026-06-01 03:09:29,933 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/342b7411-d553-409d-8936-096829c81134
2026-06-01 03:09:29,943 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/342b7411-d553-409d-8936-096829c81134
2026-06-01 03:09:29,950 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/b42afdcb-626a-48ca-aafa-5ba9a428ac9a
2026-06-01 03:09:29,960 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-32939500:service-left-vn-65342702', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-32939500', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14063483155094653618', 'uuid-lslong': '9553556146537724623'}, 'enable': 'true', 'created': '2026-06-01T03:09:29', 'last-modified': '2026-06-01T03:09:29', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.405494'}
2026-06-01 03:09:29,965 - DEBUG - Route Targets: ['target:64512:8000007']
2026-06-01 03:09:29,970 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-32939500:service-left-vn-65342702', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-32939500', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14063483155094653618', 'uuid-lslong': '9553556146537724623'}, 'enable': 'true', 'created': '2026-06-01T03:09:29', 'last-modified': '2026-06-01T03:09:29', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.414635'}
2026-06-01 03:09:29,976 - DEBUG - Route Targets: ['target:64512:8000007']
2026-06-01 03:09:29,981 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-32939500:service-left-vn-65342702', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-32939500', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14063483155094653618', 'uuid-lslong': '9553556146537724623'}, 'enable': 'true', 'created': '2026-06-01T03:09:29', 'last-modified': '2026-06-01T03:09:29', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.423877'}
2026-06-01 03:09:29,987 - DEBUG - Route Targets: ['target:64512:8000007']
2026-06-01 03:09:29,988 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-65342702 passed
2026-06-01 03:09:29,988 - DEBUG - ====Verifying policy data for service-left-vn-65342702 in API_Server ======
2026-06-01 03:09:29,988 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:29,994 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:30,005 - DEBUG - Requesting: http://10.0.0.240:8082/project/e8617e39-f15f-45c1-95e9-38a5587a0387
2026-06-01 03:09:30,102 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/c32b876b-041b-4ab2-8495-0cb2c8217acf
2026-06-01 03:09:30,115 - DEBUG - =>VN service-left-vn-65342702 has no policy to be verified
2026-06-01 03:09:30,115 - DEBUG - Verifying the vn in opserver
2026-06-01 03:09:30,115 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-32939500:service-left-vn-65342702 virtual network link through opserver 10.0.0.240
2026-06-01 03:09:30,116 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-06-01 03:09:30,181 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-32939500:service-left-vn-65342702', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-32939500:service-left-vn-65342702?flat'}
2026-06-01 03:09:30,181 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-32939500:service-left-vn-65342702 virtual network link through opserver 10.0.0.249
2026-06-01 03:09:30,181 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-06-01 03:09:30,244 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-32939500:service-left-vn-65342702', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-32939500:service-left-vn-65342702?flat'}
2026-06-01 03:09:30,244 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-32939500:service-left-vn-65342702 virtual network link through opserver 10.0.0.65
2026-06-01 03:09:30,245 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-06-01 03:09:30,300 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-32939500:service-left-vn-65342702', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-32939500:service-left-vn-65342702?flat'}
2026-06-01 03:09:30,300 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-32939500:service-left-vn-65342702 is found in opserver
2026-06-01 03:09:30,320 - DEBUG - Do not have enough data to verify VN in agent
2026-06-01 03:09:30,330 - DEBUG - VRF ids for VN service-left-vn-65342702: {}
2026-06-01 03:09:30,616 - DEBUG - Response for create_network : {'network': {'id': 'abd972ed-acd6-468c-a65f-0faf0c23a8a3', 'name': 'service-right-vn-96562417', 'tenant_id': 'e8617e39f15f45c195e938a5587a0387', 'project_id': 'e8617e39f15f45c195e938a5587a0387', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-32939500', 'service-right-vn-96562417'], 'port_security_enabled': True, 'description': ''}}
2026-06-01 03:09:30,869 - DEBUG - Response for create_subnet : {'subnet': {'id': '278fbcba-9dc8-4242-85d4-b73d72f5f4a3', 'name': '', 'tenant_id': 'e8617e39f15f45c195e938a5587a0387', 'network_id': 'abd972ed-acd6-468c-a65f-0faf0c23a8a3', 'ip_version': 4, 'cidr': '66.181.226.0/26', 'allocation_pools': [{'start': '66.181.226.2', 'end': '66.181.226.62'}], 'gateway_ip': '66.181.226.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '66.181.226.2', 'tags': [], 'project_id': 'e8617e39f15f45c195e938a5587a0387'}}
2026-06-01 03:09:30,891 - INFO - Created VN service-right-vn-96562417
2026-06-01 03:09:30,902 - DEBUG - VN service-right-vn-96562417 UUID is abd972ed-acd6-468c-a65f-0faf0c23a8a3
2026-06-01 03:09:30,987 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:30,993 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:31,005 - DEBUG - Requesting: http://10.0.0.240:8082/project/e8617e39-f15f-45c1-95e9-38a5587a0387
2026-06-01 03:09:31,101 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/abd972ed-acd6-468c-a65f-0faf0c23a8a3
2026-06-01 03:09:31,112 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/abd972ed-acd6-468c-a65f-0faf0c23a8a3
2026-06-01 03:09:31,121 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/008cef5a-b5a6-4e9c-a89c-7b1705017637
2026-06-01 03:09:31,128 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/008cef5a-b5a6-4e9c-a89c-7b1705017637
2026-06-01 03:09:31,135 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/53fdb183-76fd-4d03-a189-317ba16223c5
2026-06-01 03:09:31,142 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-01 03:09:31,142 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/abd972ed-acd6-468c-a65f-0faf0c23a8a3
2026-06-01 03:09:31,156 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/008cef5a-b5a6-4e9c-a89c-7b1705017637
2026-06-01 03:09:31,173 - INFO - Verified VN network id 18 for VN abd972ed-acd6-468c-a65f-0faf0c23a8a3
2026-06-01 03:09:31,173 - INFO - Verifications in API Server for VN service-right-vn-96562417 passed
2026-06-01 03:09:31,173 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/abd972ed-acd6-468c-a65f-0faf0c23a8a3
2026-06-01 03:09:31,185 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/008cef5a-b5a6-4e9c-a89c-7b1705017637
2026-06-01 03:09:31,192 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/008cef5a-b5a6-4e9c-a89c-7b1705017637
2026-06-01 03:09:31,199 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/53fdb183-76fd-4d03-a189-317ba16223c5
2026-06-01 03:09:31,211 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-32939500:service-right-vn-96562417', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-32939500', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12383055015564428940', 'uuid-lslong': '11988317977580906659'}, 'enable': 'true', 'created': '2026-06-01T03:09:30', 'last-modified': '2026-06-01T03:09:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.421784'}
2026-06-01 03:09:31,217 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-01 03:09:31,223 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-32939500:service-right-vn-96562417', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-32939500', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12383055015564428940', 'uuid-lslong': '11988317977580906659'}, 'enable': 'true', 'created': '2026-06-01T03:09:30', 'last-modified': '2026-06-01T03:09:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.432278'}
2026-06-01 03:09:31,232 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-01 03:09:31,238 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-32939500:service-right-vn-96562417', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-32939500', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12383055015564428940', 'uuid-lslong': '11988317977580906659'}, 'enable': 'true', 'created': '2026-06-01T03:09:30', 'last-modified': '2026-06-01T03:09:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.447582'}
2026-06-01 03:09:31,243 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-01 03:09:31,243 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-96562417 passed
2026-06-01 03:09:31,243 - DEBUG - ====Verifying policy data for service-right-vn-96562417 in API_Server ======
2026-06-01 03:09:31,243 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:31,250 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:31,261 - DEBUG - Requesting: http://10.0.0.240:8082/project/e8617e39-f15f-45c1-95e9-38a5587a0387
2026-06-01 03:09:31,367 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/abd972ed-acd6-468c-a65f-0faf0c23a8a3
2026-06-01 03:09:31,377 - DEBUG - =>VN service-right-vn-96562417 has no policy to be verified
2026-06-01 03:09:31,378 - DEBUG - Verifying the vn in opserver
2026-06-01 03:09:31,378 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-32939500:service-right-vn-96562417 virtual network link through opserver 10.0.0.240
2026-06-01 03:09:31,378 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-06-01 03:09:31,443 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-32939500:service-right-vn-96562417', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-32939500:service-right-vn-96562417?flat'}
2026-06-01 03:09:31,443 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-32939500:service-right-vn-96562417 virtual network link through opserver 10.0.0.249
2026-06-01 03:09:31,443 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-06-01 03:09:31,529 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-32939500:service-right-vn-96562417', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-32939500:service-right-vn-96562417?flat'}
2026-06-01 03:09:31,529 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-32939500:service-right-vn-96562417 virtual network link through opserver 10.0.0.65
2026-06-01 03:09:31,529 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-06-01 03:09:31,599 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-32939500:service-right-vn-96562417', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-32939500:service-right-vn-96562417?flat'}
2026-06-01 03:09:31,599 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-32939500:service-right-vn-96562417 is found in opserver
2026-06-01 03:09:31,619 - DEBUG - Do not have enough data to verify VN in agent
2026-06-01 03:09:31,629 - DEBUG - VRF ids for VN service-right-vn-96562417: {}
2026-06-01 03:09:31,773 - DEBUG - Services list from nova: [, , , ]
2026-06-01 03:09:32,956 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5860-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5860-2)
2026-06-01 03:09:34,523 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5860-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5860-1)
2026-06-01 03:09:34,524 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-85988008']
2026-06-01 03:09:34,856 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-85988008'] created succesfully
2026-06-01 03:09:35,262 - DEBUG - Image by name tiny_nat_fw not found
2026-06-01 03:09:35,262 - DEBUG - Installing image tiny_nat_fw
2026-06-01 03:09:35,262 - 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-06-01 03:09:35,262 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-06-01 03:09:35,262 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-06-01 03:09:35,262 - DEBUG - Unzip image
2026-06-01 03:09:35,262 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-06-01 03:09:35,287 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-06-01 03:09:35,288 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-85988008']
2026-06-01 03:09:35,397 - INFO - Service template: ['default-domain', 'ctest-service_template_1-85988008'] deleted successfully.
2026-06-01 03:09:35,397 - INFO - Skip interface_detach for VM ctest-right_vm-88674492 in state BUILD
2026-06-01 03:09:35,397 - INFO - Deleting VM ctest-right_vm-88674492
2026-06-01 03:09:35,441 - ERROR - VM ctest-right_vm-88674492 has failed to come up
2026-06-01 03:09:35,442 - ERROR - Nova failed to get host of the VM
2026-06-01 03:09:35,442 - ERROR - VM ctest-right_vm-88674492 has failed to come up
2026-06-01 03:09:35,443 - ERROR - Nova failed to get host of the VM
2026-06-01 03:09:35,550 - INFO - Skip interface_detach for VM ctest-left_vm-77924474 in state BUILD
2026-06-01 03:09:35,550 - INFO - Deleting VM ctest-left_vm-77924474
2026-06-01 03:09:35,550 - ERROR - VM ctest-left_vm-77924474 has failed to come up
2026-06-01 03:09:35,550 - ERROR - Nova failed to get host of the VM
2026-06-01 03:09:35,550 - ERROR - VM ctest-left_vm-77924474 has failed to come up
2026-06-01 03:09:35,550 - ERROR - Nova failed to get host of the VM
2026-06-01 03:09:35,647 - INFO - Deleting VN service-right-vn-96562417
2026-06-01 03:09:35,690 - DEBUG - VN abd972ed-acd6-468c-a65f-0faf0c23a8a3 still in use: Unable to complete operation on network abd972ed-acd6-468c-a65f-0faf0c23a8a3. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-746827de-24b9-4d50-9581-94ae0c483c7c']
2026-06-01 03:09:35,690 - WARNING - Deleting VN service-right-vn-96562417 failed..Will retry
2026-06-01 03:09:37,912 - DEBUG - Response for deleting network ()
2026-06-01 03:09:37,912 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/008cef5a-b5a6-4e9c-a89c-7b1705017637
2026-06-01 03:09:37,924 - DEBUG - Response Code: 404
2026-06-01 03:09:37,924 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:37,931 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:37,949 - DEBUG - Requesting: http://10.0.0.240:8082/project/e8617e39-f15f-45c1-95e9-38a5587a0387
2026-06-01 03:09:38,053 - INFO - Validated that VN service-right-vn-96562417 is not found in API Server
2026-06-01 03:09:38,069 - DEBUG - VN service-right-vn-96562417 is not present in Agent 10.0.0.130
2026-06-01 03:09:38,080 - DEBUG - VN service-right-vn-96562417 is not present in Agent 10.0.0.73
2026-06-01 03:09:38,080 - INFO - Validated that VN service-right-vn-96562417 is not in any agent
2026-06-01 03:09:38,116 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-96562417 info
2026-06-01 03:09:38,116 - INFO - Deleting VN service-left-vn-65342702
2026-06-01 03:09:38,313 - DEBUG - Response for deleting network ()
2026-06-01 03:09:38,313 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/342b7411-d553-409d-8936-096829c81134
2026-06-01 03:09:38,318 - DEBUG - Response Code: 404
2026-06-01 03:09:38,318 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:38,326 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:38,386 - DEBUG - Requesting: http://10.0.0.240:8082/project/e8617e39-f15f-45c1-95e9-38a5587a0387
2026-06-01 03:09:38,487 - INFO - Validated that VN service-left-vn-65342702 is not found in API Server
2026-06-01 03:09:38,498 - DEBUG - VN service-left-vn-65342702 is not present in Agent 10.0.0.130
2026-06-01 03:09:38,510 - DEBUG - VN service-left-vn-65342702 is not present in Agent 10.0.0.73
2026-06-01 03:09:38,510 - INFO - Validated that VN service-left-vn-65342702 is not in any agent
2026-06-01 03:09:38,544 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-65342702 info
2026-06-01 03:09:38,544 - INFO - Deleting VN ctest-mgmt_vn-28202515
2026-06-01 03:09:38,731 - DEBUG - Response for deleting network ()
2026-06-01 03:09:38,731 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/3525935c-b25f-44d3-aa71-aa847fedcdeb
2026-06-01 03:09:38,738 - DEBUG - Response Code: 404
2026-06-01 03:09:38,738 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:38,746 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:38,783 - DEBUG - Requesting: http://10.0.0.240:8082/project/e8617e39-f15f-45c1-95e9-38a5587a0387
2026-06-01 03:09:38,898 - INFO - Validated that VN ctest-mgmt_vn-28202515 is not found in API Server
2026-06-01 03:09:38,909 - DEBUG - VN ctest-mgmt_vn-28202515 is not present in Agent 10.0.0.130
2026-06-01 03:09:38,925 - DEBUG - VN ctest-mgmt_vn-28202515 is not present in Agent 10.0.0.73
2026-06-01 03:09:38,925 - INFO - Validated that VN ctest-mgmt_vn-28202515 is not in any agent
2026-06-01 03:09:38,967 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-28202515 info
2026-06-01 03:09:40,253 - DEBUG - No XMPP flaps were noticed during the test
2026-06-01 03:09:40,253 - INFO -
2026-06-01 03:09:40,253 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:16]
2026-06-01 03:09:40,253 - INFO - --------------------------------------------------------------------------------
2026-06-01 03:09:40,267 - INFO - ================================================================================
2026-06-01 03:09:40,267 - INFO - STARTING TEST : test_svc_in_network_datapath
2026-06-01 03:09:41,563 - DEBUG - Nothing to compare xmpp stats {'10.0.0.130': {'10.20.0.193': '0', '10.20.0.129': '0'}, '10.0.0.73': {'10.20.0.193': '0', '10.20.0.129': '0'}} with
2026-06-01 03:09:41,563 - INFO - Initial checks done. Running the testcase now
2026-06-01 03:09:41,563 - INFO -
2026-06-01 03:09:41,865 - DEBUG - Response for create_network : {'network': {'id': '75076727-7340-43c6-b62d-0db0760d082c', 'name': 'ctest-mgmt_vn-82069420', 'tenant_id': 'e8617e39f15f45c195e938a5587a0387', 'project_id': 'e8617e39f15f45c195e938a5587a0387', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-32939500', 'ctest-mgmt_vn-82069420'], 'port_security_enabled': True, 'description': ''}}
2026-06-01 03:09:42,109 - DEBUG - Response for create_subnet : {'subnet': {'id': '6e3bcd49-a0db-422e-92eb-26db91ad4a59', 'name': '', 'tenant_id': 'e8617e39f15f45c195e938a5587a0387', 'network_id': '75076727-7340-43c6-b62d-0db0760d082c', 'ip_version': 4, 'cidr': '145.42.84.192/26', 'allocation_pools': [{'start': '145.42.84.194', 'end': '145.42.84.254'}], 'gateway_ip': '145.42.84.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '145.42.84.194', 'tags': [], 'project_id': 'e8617e39f15f45c195e938a5587a0387'}}
2026-06-01 03:09:42,130 - INFO - Created VN ctest-mgmt_vn-82069420
2026-06-01 03:09:42,141 - DEBUG - VN ctest-mgmt_vn-82069420 UUID is 75076727-7340-43c6-b62d-0db0760d082c
2026-06-01 03:09:42,227 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:42,234 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:42,256 - DEBUG - Requesting: http://10.0.0.240:8082/project/e8617e39-f15f-45c1-95e9-38a5587a0387
2026-06-01 03:09:42,346 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/75076727-7340-43c6-b62d-0db0760d082c
2026-06-01 03:09:42,360 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/75076727-7340-43c6-b62d-0db0760d082c
2026-06-01 03:09:42,375 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/ba53192c-a0c7-4d36-9b6b-200e987bbaec
2026-06-01 03:09:42,392 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/ba53192c-a0c7-4d36-9b6b-200e987bbaec
2026-06-01 03:09:42,409 - DEBUG - Route Targets: []
2026-06-01 03:09:42,409 - DEBUG - RT names not yet present for VN ctest-mgmt_vn-82069420
2026-06-01 03:09:47,410 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:47,417 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:47,427 - DEBUG - Requesting: http://10.0.0.240:8082/project/e8617e39-f15f-45c1-95e9-38a5587a0387
2026-06-01 03:09:47,545 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/75076727-7340-43c6-b62d-0db0760d082c
2026-06-01 03:09:47,563 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/75076727-7340-43c6-b62d-0db0760d082c
2026-06-01 03:09:47,575 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/ba53192c-a0c7-4d36-9b6b-200e987bbaec
2026-06-01 03:09:47,594 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/ba53192c-a0c7-4d36-9b6b-200e987bbaec
2026-06-01 03:09:47,605 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/f0e04e5a-e5e1-4681-98d7-ae10e5ceb1bc
2026-06-01 03:09:47,619 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-01 03:09:47,620 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/75076727-7340-43c6-b62d-0db0760d082c
2026-06-01 03:09:47,633 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/ba53192c-a0c7-4d36-9b6b-200e987bbaec
2026-06-01 03:09:47,666 - INFO - Verified VN network id 16 for VN 75076727-7340-43c6-b62d-0db0760d082c
2026-06-01 03:09:47,666 - INFO - Verifications in API Server for VN ctest-mgmt_vn-82069420 passed
2026-06-01 03:09:47,666 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/75076727-7340-43c6-b62d-0db0760d082c
2026-06-01 03:09:47,696 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/ba53192c-a0c7-4d36-9b6b-200e987bbaec
2026-06-01 03:09:47,705 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/ba53192c-a0c7-4d36-9b6b-200e987bbaec
2026-06-01 03:09:47,713 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/f0e04e5a-e5e1-4681-98d7-ae10e5ceb1bc
2026-06-01 03:09:47,723 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-82069420', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-32939500', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8432822246409520070', 'uuid-lslong': '13127163540400834604'}, 'enable': 'true', 'created': '2026-06-01T03:09:41', 'last-modified': '2026-06-01T03:09:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.670695'}
2026-06-01 03:09:47,730 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-01 03:09:47,742 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-82069420', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-32939500', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8432822246409520070', 'uuid-lslong': '13127163540400834604'}, 'enable': 'true', 'created': '2026-06-01T03:09:41', 'last-modified': '2026-06-01T03:09:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.689705'}
2026-06-01 03:09:47,755 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-01 03:09:47,765 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-82069420', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-32939500', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8432822246409520070', 'uuid-lslong': '13127163540400834604'}, 'enable': 'true', 'created': '2026-06-01T03:09:41', 'last-modified': '2026-06-01T03:09:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.715103'}
2026-06-01 03:09:47,771 - DEBUG - Route Targets: ['target:64512:8000006']
2026-06-01 03:09:47,771 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-82069420 passed
2026-06-01 03:09:47,771 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-82069420 in API_Server ======
2026-06-01 03:09:47,771 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:47,778 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:47,791 - DEBUG - Requesting: http://10.0.0.240:8082/project/e8617e39-f15f-45c1-95e9-38a5587a0387
2026-06-01 03:09:47,920 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/75076727-7340-43c6-b62d-0db0760d082c
2026-06-01 03:09:47,943 - DEBUG - =>VN ctest-mgmt_vn-82069420 has no policy to be verified
2026-06-01 03:09:47,943 - DEBUG - Verifying the vn in opserver
2026-06-01 03:09:47,943 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-82069420 virtual network link through opserver 10.0.0.240
2026-06-01 03:09:47,943 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-06-01 03:09:47,958 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-82069420', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-82069420?flat'}
2026-06-01 03:09:47,958 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-82069420 virtual network link through opserver 10.0.0.249
2026-06-01 03:09:47,958 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-06-01 03:09:47,980 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-82069420', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-82069420?flat'}
2026-06-01 03:09:47,980 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-82069420 virtual network link through opserver 10.0.0.65
2026-06-01 03:09:47,980 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-06-01 03:09:48,006 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-82069420', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-82069420?flat'}
2026-06-01 03:09:48,006 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-32939500:ctest-mgmt_vn-82069420 is found in opserver
2026-06-01 03:09:48,031 - DEBUG - Do not have enough data to verify VN in agent
2026-06-01 03:09:48,053 - DEBUG - VRF ids for VN ctest-mgmt_vn-82069420: {}
2026-06-01 03:09:48,393 - DEBUG - Response for create_network : {'network': {'id': '9c917d48-0ea1-43d5-b983-cbd77891df78', 'name': 'ctest-left_vn-65299160', 'tenant_id': 'e8617e39f15f45c195e938a5587a0387', 'project_id': 'e8617e39f15f45c195e938a5587a0387', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-32939500', 'ctest-left_vn-65299160'], 'port_security_enabled': True, 'description': ''}}
2026-06-01 03:09:48,615 - DEBUG - Response for create_subnet : {'subnet': {'id': '0703a208-2fdb-47f4-93c3-d199f8df9ee3', 'name': '', 'tenant_id': 'e8617e39f15f45c195e938a5587a0387', 'network_id': '9c917d48-0ea1-43d5-b983-cbd77891df78', 'ip_version': 4, 'cidr': '45.76.107.0/26', 'allocation_pools': [{'start': '45.76.107.2', 'end': '45.76.107.62'}], 'gateway_ip': '45.76.107.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '45.76.107.2', 'tags': [], 'project_id': 'e8617e39f15f45c195e938a5587a0387'}}
2026-06-01 03:09:48,640 - INFO - Created VN ctest-left_vn-65299160
2026-06-01 03:09:48,655 - DEBUG - VN ctest-left_vn-65299160 UUID is 9c917d48-0ea1-43d5-b983-cbd77891df78
2026-06-01 03:09:48,730 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:48,737 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:48,751 - DEBUG - Requesting: http://10.0.0.240:8082/project/e8617e39-f15f-45c1-95e9-38a5587a0387
2026-06-01 03:09:48,843 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/9c917d48-0ea1-43d5-b983-cbd77891df78
2026-06-01 03:09:48,858 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/9c917d48-0ea1-43d5-b983-cbd77891df78
2026-06-01 03:09:48,869 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/105785fe-2236-4c96-9a5a-628700de5335
2026-06-01 03:09:48,878 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/105785fe-2236-4c96-9a5a-628700de5335
2026-06-01 03:09:48,888 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/8751a8bd-688f-4c56-92c5-173c396762d8
2026-06-01 03:09:48,897 - DEBUG - Route Targets: ['target:64512:8000007']
2026-06-01 03:09:48,897 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/9c917d48-0ea1-43d5-b983-cbd77891df78
2026-06-01 03:09:48,907 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/105785fe-2236-4c96-9a5a-628700de5335
2026-06-01 03:09:48,927 - INFO - Verified VN network id 17 for VN 9c917d48-0ea1-43d5-b983-cbd77891df78
2026-06-01 03:09:48,928 - INFO - Verifications in API Server for VN ctest-left_vn-65299160 passed
2026-06-01 03:09:48,928 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/9c917d48-0ea1-43d5-b983-cbd77891df78
2026-06-01 03:09:48,942 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/105785fe-2236-4c96-9a5a-628700de5335
2026-06-01 03:09:48,951 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/105785fe-2236-4c96-9a5a-628700de5335
2026-06-01 03:09:48,961 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/8751a8bd-688f-4c56-92c5-173c396762d8
2026-06-01 03:09:48,975 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-32939500:ctest-left_vn-65299160', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-32939500', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11281936289976370133', 'uuid-lslong': '13367752245266997112'}, 'enable': 'true', 'created': '2026-06-01T03:09:48', 'last-modified': '2026-06-01T03:09:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.412163'}
2026-06-01 03:09:48,981 - DEBUG - Route Targets: ['target:64512:8000007']
2026-06-01 03:09:48,990 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-32939500:ctest-left_vn-65299160', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-32939500', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11281936289976370133', 'uuid-lslong': '13367752245266997112'}, 'enable': 'true', 'created': '2026-06-01T03:09:48', 'last-modified': '2026-06-01T03:09:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.420601'}
2026-06-01 03:09:48,999 - DEBUG - Route Targets: ['target:64512:8000007']
2026-06-01 03:09:49,005 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-32939500:ctest-left_vn-65299160', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-32939500', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11281936289976370133', 'uuid-lslong': '13367752245266997112'}, 'enable': 'true', 'created': '2026-06-01T03:09:48', 'last-modified': '2026-06-01T03:09:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.440004'}
2026-06-01 03:09:49,014 - DEBUG - Route Targets: ['target:64512:8000007']
2026-06-01 03:09:49,014 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-65299160 passed
2026-06-01 03:09:49,014 - DEBUG - ====Verifying policy data for ctest-left_vn-65299160 in API_Server ======
2026-06-01 03:09:49,014 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:49,023 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:49,036 - DEBUG - Requesting: http://10.0.0.240:8082/project/e8617e39-f15f-45c1-95e9-38a5587a0387
2026-06-01 03:09:49,165 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/9c917d48-0ea1-43d5-b983-cbd77891df78
2026-06-01 03:09:49,177 - DEBUG - =>VN ctest-left_vn-65299160 has no policy to be verified
2026-06-01 03:09:49,177 - DEBUG - Verifying the vn in opserver
2026-06-01 03:09:49,177 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-32939500:ctest-left_vn-65299160 virtual network link through opserver 10.0.0.240
2026-06-01 03:09:49,177 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-06-01 03:09:49,190 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-32939500:ctest-left_vn-65299160', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-32939500:ctest-left_vn-65299160?flat'}
2026-06-01 03:09:49,190 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-32939500:ctest-left_vn-65299160 virtual network link through opserver 10.0.0.249
2026-06-01 03:09:49,190 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-06-01 03:09:49,209 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-32939500:ctest-left_vn-65299160', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-32939500:ctest-left_vn-65299160?flat'}
2026-06-01 03:09:49,209 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-32939500:ctest-left_vn-65299160 virtual network link through opserver 10.0.0.65
2026-06-01 03:09:49,209 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-06-01 03:09:49,224 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-32939500:ctest-left_vn-65299160', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-32939500:ctest-left_vn-65299160?flat'}
2026-06-01 03:09:49,224 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-32939500:ctest-left_vn-65299160 is found in opserver
2026-06-01 03:09:49,248 - DEBUG - Do not have enough data to verify VN in agent
2026-06-01 03:09:49,262 - DEBUG - VRF ids for VN ctest-left_vn-65299160: {}
2026-06-01 03:09:49,549 - DEBUG - Response for create_network : {'network': {'id': 'df83116d-bcf7-4261-a98b-a6f667f095bc', 'name': 'ctest-right_vn-01590886', 'tenant_id': 'e8617e39f15f45c195e938a5587a0387', 'project_id': 'e8617e39f15f45c195e938a5587a0387', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-32939500', 'ctest-right_vn-01590886'], 'port_security_enabled': True, 'description': ''}}
2026-06-01 03:09:49,833 - DEBUG - Response for create_subnet : {'subnet': {'id': '35bf6855-354e-47cb-9769-fee330a91562', 'name': '', 'tenant_id': 'e8617e39f15f45c195e938a5587a0387', 'network_id': 'df83116d-bcf7-4261-a98b-a6f667f095bc', 'ip_version': 4, 'cidr': '71.18.66.192/26', 'allocation_pools': [{'start': '71.18.66.194', 'end': '71.18.66.254'}], 'gateway_ip': '71.18.66.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '71.18.66.194', 'tags': [], 'project_id': 'e8617e39f15f45c195e938a5587a0387'}}
2026-06-01 03:09:49,857 - INFO - Created VN ctest-right_vn-01590886
2026-06-01 03:09:49,870 - DEBUG - VN ctest-right_vn-01590886 UUID is df83116d-bcf7-4261-a98b-a6f667f095bc
2026-06-01 03:09:49,945 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:49,953 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:49,966 - DEBUG - Requesting: http://10.0.0.240:8082/project/e8617e39-f15f-45c1-95e9-38a5587a0387
2026-06-01 03:09:50,135 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/df83116d-bcf7-4261-a98b-a6f667f095bc
2026-06-01 03:09:50,150 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/df83116d-bcf7-4261-a98b-a6f667f095bc
2026-06-01 03:09:50,162 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/cb85d83c-6b50-4581-9259-169c1c102423
2026-06-01 03:09:50,177 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/cb85d83c-6b50-4581-9259-169c1c102423
2026-06-01 03:09:50,186 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/5d1222eb-b335-47b8-823d-d72afa02a3b0
2026-06-01 03:09:50,194 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-01 03:09:50,194 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/df83116d-bcf7-4261-a98b-a6f667f095bc
2026-06-01 03:09:50,205 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/cb85d83c-6b50-4581-9259-169c1c102423
2026-06-01 03:09:50,223 - INFO - Verified VN network id 18 for VN df83116d-bcf7-4261-a98b-a6f667f095bc
2026-06-01 03:09:50,223 - INFO - Verifications in API Server for VN ctest-right_vn-01590886 passed
2026-06-01 03:09:50,223 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/df83116d-bcf7-4261-a98b-a6f667f095bc
2026-06-01 03:09:50,235 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/cb85d83c-6b50-4581-9259-169c1c102423
2026-06-01 03:09:50,243 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/cb85d83c-6b50-4581-9259-169c1c102423
2026-06-01 03:09:50,250 - DEBUG - Requesting: http://10.0.0.240:8082/route-target/5d1222eb-b335-47b8-823d-d72afa02a3b0
2026-06-01 03:09:50,261 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-32939500:ctest-right_vn-01590886', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-32939500', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16105735855426454113', 'uuid-lslong': '12217041991408588220'}, 'enable': 'true', 'created': '2026-06-01T03:09:49', 'last-modified': '2026-06-01T03:09:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.503661'}
2026-06-01 03:09:50,268 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-01 03:09:50,274 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-32939500:ctest-right_vn-01590886', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-32939500', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16105735855426454113', 'uuid-lslong': '12217041991408588220'}, 'enable': 'true', 'created': '2026-06-01T03:09:49', 'last-modified': '2026-06-01T03:09:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.518015'}
2026-06-01 03:09:50,281 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-01 03:09:50,287 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-32939500:ctest-right_vn-01590886', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-32939500', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16105735855426454113', 'uuid-lslong': '12217041991408588220'}, 'enable': 'true', 'created': '2026-06-01T03:09:49', 'last-modified': '2026-06-01T03:09:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.529728'}
2026-06-01 03:09:50,295 - DEBUG - Route Targets: ['target:64512:8000008']
2026-06-01 03:09:50,295 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-01590886 passed
2026-06-01 03:09:50,295 - DEBUG - ====Verifying policy data for ctest-right_vn-01590886 in API_Server ======
2026-06-01 03:09:50,295 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:50,302 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:50,312 - DEBUG - Requesting: http://10.0.0.240:8082/project/e8617e39-f15f-45c1-95e9-38a5587a0387
2026-06-01 03:09:50,412 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-network/df83116d-bcf7-4261-a98b-a6f667f095bc
2026-06-01 03:09:50,421 - DEBUG - =>VN ctest-right_vn-01590886 has no policy to be verified
2026-06-01 03:09:50,421 - DEBUG - Verifying the vn in opserver
2026-06-01 03:09:50,421 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-32939500:ctest-right_vn-01590886 virtual network link through opserver 10.0.0.240
2026-06-01 03:09:50,421 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-06-01 03:09:50,432 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-32939500:ctest-right_vn-01590886', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-32939500:ctest-right_vn-01590886?flat'}
2026-06-01 03:09:50,432 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-32939500:ctest-right_vn-01590886 virtual network link through opserver 10.0.0.249
2026-06-01 03:09:50,432 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-06-01 03:09:50,451 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-32939500:ctest-right_vn-01590886', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-32939500:ctest-right_vn-01590886?flat'}
2026-06-01 03:09:50,451 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-32939500:ctest-right_vn-01590886 virtual network link through opserver 10.0.0.65
2026-06-01 03:09:50,451 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2026-06-01 03:09:50,464 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-32939500:ctest-right_vn-01590886', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-32939500:ctest-right_vn-01590886?flat'}
2026-06-01 03:09:50,464 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-32939500:ctest-right_vn-01590886 is found in opserver
2026-06-01 03:09:50,486 - DEBUG - Do not have enough data to verify VN in agent
2026-06-01 03:09:50,496 - DEBUG - VRF ids for VN ctest-right_vn-01590886: {}
2026-06-01 03:09:51,718 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5860-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5860-1)
2026-06-01 03:09:53,148 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5860-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5860-2)
2026-06-01 03:09:53,148 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-91533924']
2026-06-01 03:09:53,456 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-91533924'] created succesfully
2026-06-01 03:09:53,884 - DEBUG - Image by name tiny_nat_fw not found
2026-06-01 03:09:53,885 - DEBUG - Installing image tiny_nat_fw
2026-06-01 03:09:53,885 - 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-06-01 03:09:53,885 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-06-01 03:09:53,885 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-06-01 03:09:53,885 - DEBUG - Unzip image
2026-06-01 03:09:53,885 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-06-01 03:09:53,908 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-06-01 03:09:53,908 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-91533924']
2026-06-01 03:09:54,001 - INFO - Service template: ['default-domain', 'ctest-service_template_1-91533924'] deleted successfully.
2026-06-01 03:09:54,001 - INFO - Skip interface_detach for VM ctest-right_vm-24798296 in state BUILD
2026-06-01 03:09:54,001 - INFO - Deleting VM ctest-right_vm-24798296
2026-06-01 03:09:54,001 - ERROR - VM ctest-right_vm-24798296 has failed to come up
2026-06-01 03:09:54,001 - ERROR - Nova failed to get host of the VM
2026-06-01 03:09:54,002 - ERROR - VM ctest-right_vm-24798296 has failed to come up
2026-06-01 03:09:54,002 - ERROR - Nova failed to get host of the VM
2026-06-01 03:09:54,120 - INFO - Skip interface_detach for VM ctest-left_vm-46063019 in state BUILD
2026-06-01 03:09:54,120 - INFO - Deleting VM ctest-left_vm-46063019
2026-06-01 03:09:54,120 - ERROR - VM ctest-left_vm-46063019 has failed to come up
2026-06-01 03:09:54,120 - ERROR - Nova failed to get host of the VM
2026-06-01 03:09:54,120 - ERROR - VM ctest-left_vm-46063019 has failed to come up
2026-06-01 03:09:54,120 - ERROR - Nova failed to get host of the VM
2026-06-01 03:09:54,186 - INFO - Deleting VN ctest-right_vn-01590886
2026-06-01 03:09:54,237 - DEBUG - VN df83116d-bcf7-4261-a98b-a6f667f095bc still in use: Unable to complete operation on network df83116d-bcf7-4261-a98b-a6f667f095bc. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-80abfd02-d96e-4b1c-9ff3-6293bf0ea809']
2026-06-01 03:09:54,237 - WARNING - Deleting VN ctest-right_vn-01590886 failed..Will retry
2026-06-01 03:09:56,447 - DEBUG - Response for deleting network ()
2026-06-01 03:09:56,447 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/cb85d83c-6b50-4581-9259-169c1c102423
2026-06-01 03:09:56,460 - DEBUG - Response Code: 404
2026-06-01 03:09:56,460 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:56,467 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:56,525 - DEBUG - Requesting: http://10.0.0.240:8082/project/e8617e39-f15f-45c1-95e9-38a5587a0387
2026-06-01 03:09:56,625 - INFO - Validated that VN ctest-right_vn-01590886 is not found in API Server
2026-06-01 03:09:56,635 - DEBUG - VN ctest-right_vn-01590886 is not present in Agent 10.0.0.130
2026-06-01 03:09:56,645 - DEBUG - VN ctest-right_vn-01590886 is not present in Agent 10.0.0.73
2026-06-01 03:09:56,645 - INFO - Validated that VN ctest-right_vn-01590886 is not in any agent
2026-06-01 03:09:56,678 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-01590886 info
2026-06-01 03:09:56,678 - INFO - Deleting VN ctest-left_vn-65299160
2026-06-01 03:09:56,838 - DEBUG - Response for deleting network ()
2026-06-01 03:09:56,838 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/105785fe-2236-4c96-9a5a-628700de5335
2026-06-01 03:09:56,843 - DEBUG - Response Code: 404
2026-06-01 03:09:56,843 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:56,849 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:56,906 - DEBUG - Requesting: http://10.0.0.240:8082/project/e8617e39-f15f-45c1-95e9-38a5587a0387
2026-06-01 03:09:56,997 - INFO - Validated that VN ctest-left_vn-65299160 is not found in API Server
2026-06-01 03:09:57,010 - DEBUG - VN ctest-left_vn-65299160 is not present in Agent 10.0.0.130
2026-06-01 03:09:57,020 - DEBUG - VN ctest-left_vn-65299160 is not present in Agent 10.0.0.73
2026-06-01 03:09:57,020 - INFO - Validated that VN ctest-left_vn-65299160 is not in any agent
2026-06-01 03:09:57,053 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-65299160 info
2026-06-01 03:09:57,053 - INFO - Deleting VN ctest-mgmt_vn-82069420
2026-06-01 03:09:57,212 - DEBUG - Response for deleting network ()
2026-06-01 03:09:57,213 - DEBUG - Requesting: http://10.0.0.240:8082/routing-instance/ba53192c-a0c7-4d36-9b6b-200e987bbaec
2026-06-01 03:09:57,218 - DEBUG - Response Code: 404
2026-06-01 03:09:57,218 - DEBUG - Requesting: http://10.0.0.240:8082/domains
2026-06-01 03:09:57,223 - DEBUG - Requesting: http://10.0.0.240:8082/domain/6a7c2c01-0945-4b55-86ca-3789a2d806b2
2026-06-01 03:09:57,245 - DEBUG - Requesting: http://10.0.0.240:8082/project/e8617e39-f15f-45c1-95e9-38a5587a0387
2026-06-01 03:09:57,332 - INFO - Validated that VN ctest-mgmt_vn-82069420 is not found in API Server
2026-06-01 03:09:57,344 - DEBUG - VN ctest-mgmt_vn-82069420 is not present in Agent 10.0.0.130
2026-06-01 03:09:57,356 - DEBUG - VN ctest-mgmt_vn-82069420 is not present in Agent 10.0.0.73
2026-06-01 03:09:57,356 - INFO - Validated that VN ctest-mgmt_vn-82069420 is not in any agent
2026-06-01 03:09:57,388 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-82069420 info
2026-06-01 03:09:58,684 - DEBUG - No XMPP flaps were noticed during the test
2026-06-01 03:09:58,684 - INFO -
2026-06-01 03:09:58,684 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:18]
2026-06-01 03:09:58,684 - INFO - --------------------------------------------------------------------------------
2026-06-01 03:09:59,450 - INFO - Deleted project: ctest-TestSvcRegr-32939500, ID : e8617e39-f15f-45c1-95e9-38a5587a0387