]) created on node: (an-jenkins-deploy-platform-ansible-os-5841-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5841-1)
2026-05-28 03:18:58,708 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-16663335']
2026-05-28 03:18:59,004 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-16663335'] created succesfully
2026-05-28 03:18:59,521 - DEBUG - Image by name tiny_nat_fw not found
2026-05-28 03:18:59,522 - DEBUG - Installing image tiny_nat_fw
2026-05-28 03:18:59,522 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-05-28 03:18:59,522 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-05-28 03:18:59,522 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-05-28 03:18:59,542 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz -O /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-28 03:18:59,721 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-28 03:18:59,721 - DEBUG - Unzip image
2026-05-28 03:18:59,721 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-28 03:18:59,748 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-05-28 03:18:59,749 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-16663335']
2026-05-28 03:18:59,849 - INFO - Service template: ['default-domain', 'ctest-service_template_1-16663335'] deleted successfully.
2026-05-28 03:18:59,849 - INFO - Skip interface_detach for VM ctest-right_vm-54385371 in state BUILD
2026-05-28 03:18:59,849 - INFO - Deleting VM ctest-right_vm-54385371
2026-05-28 03:18:59,888 - ERROR - VM ctest-right_vm-54385371 has failed to come up
2026-05-28 03:18:59,888 - ERROR - Nova failed to get host of the VM
2026-05-28 03:18:59,888 - ERROR - VM ctest-right_vm-54385371 has failed to come up
2026-05-28 03:18:59,888 - ERROR - Nova failed to get host of the VM
2026-05-28 03:18:59,977 - INFO - Skip interface_detach for VM ctest-left_vm-79480193 in state BUILD
2026-05-28 03:18:59,978 - INFO - Deleting VM ctest-left_vm-79480193
2026-05-28 03:18:59,978 - ERROR - VM ctest-left_vm-79480193 has failed to come up
2026-05-28 03:18:59,978 - ERROR - Nova failed to get host of the VM
2026-05-28 03:18:59,978 - ERROR - VM ctest-left_vm-79480193 has failed to come up
2026-05-28 03:18:59,978 - ERROR - Nova failed to get host of the VM
2026-05-28 03:19:00,067 - INFO - Deleting VN ctest-right_vn-40791674
2026-05-28 03:19:00,133 - DEBUG - VN fb9c0c79-8750-460e-8204-0db430e1c682 still in use: Unable to complete operation on network fb9c0c79-8750-460e-8204-0db430e1c682. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-520a4346-0919-4886-b77f-6e88794ad5ba']
2026-05-28 03:19:00,133 - WARNING - Deleting VN ctest-right_vn-40791674 failed..Will retry
2026-05-28 03:19:02,320 - DEBUG - Response for deleting network ()
2026-05-28 03:19:02,320 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/5116ec8e-e403-44e0-a069-02a6f13fe852
2026-05-28 03:19:02,331 - DEBUG - Response Code: 404
2026-05-28 03:19:02,332 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:02,357 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:02,377 - DEBUG - Requesting: http://10.0.0.133:8082/project/366b7c46-c949-4871-a088-8fe8eabbdf1a
2026-05-28 03:19:02,479 - INFO - Validated that VN ctest-right_vn-40791674 is not found in API Server
2026-05-28 03:19:02,493 - DEBUG - VN ctest-right_vn-40791674 is not present in Agent 10.0.0.48
2026-05-28 03:19:02,510 - DEBUG - VN ctest-right_vn-40791674 is not present in Agent 10.0.0.49
2026-05-28 03:19:02,510 - INFO - Validated that VN ctest-right_vn-40791674 is not in any agent
2026-05-28 03:19:02,560 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-40791674 info
2026-05-28 03:19:02,560 - INFO - Deleting VN ctest-left_vn-87653288
2026-05-28 03:19:02,777 - DEBUG - Response for deleting network ()
2026-05-28 03:19:02,777 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/3b9e2161-49a8-4214-ad30-3c32d748b91c
2026-05-28 03:19:02,790 - DEBUG - Response Code: 404
2026-05-28 03:19:02,790 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:02,807 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:02,827 - DEBUG - Requesting: http://10.0.0.133:8082/project/366b7c46-c949-4871-a088-8fe8eabbdf1a
2026-05-28 03:19:02,953 - INFO - Validated that VN ctest-left_vn-87653288 is not found in API Server
2026-05-28 03:19:02,971 - DEBUG - VN ctest-left_vn-87653288 is not present in Agent 10.0.0.48
2026-05-28 03:19:02,985 - DEBUG - VN ctest-left_vn-87653288 is not present in Agent 10.0.0.49
2026-05-28 03:19:02,985 - INFO - Validated that VN ctest-left_vn-87653288 is not in any agent
2026-05-28 03:19:03,036 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-87653288 info
2026-05-28 03:19:03,036 - INFO - Deleting VN ctest-mgmt_vn-83130205
2026-05-28 03:19:03,213 - DEBUG - Response for deleting network ()
2026-05-28 03:19:03,213 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/7865adb7-9e9d-404c-8d90-51e444efac65
2026-05-28 03:19:03,221 - DEBUG - Response Code: 404
2026-05-28 03:19:03,221 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:03,229 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:03,287 - DEBUG - Requesting: http://10.0.0.133:8082/project/366b7c46-c949-4871-a088-8fe8eabbdf1a
2026-05-28 03:19:03,393 - INFO - Validated that VN ctest-mgmt_vn-83130205 is not found in API Server
2026-05-28 03:19:03,414 - DEBUG - VN ctest-mgmt_vn-83130205 is not present in Agent 10.0.0.48
2026-05-28 03:19:03,427 - DEBUG - VN ctest-mgmt_vn-83130205 is not present in Agent 10.0.0.49
2026-05-28 03:19:03,427 - INFO - Validated that VN ctest-mgmt_vn-83130205 is not in any agent
2026-05-28 03:19:03,470 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-83130205 info
2026-05-28 03:19:03,470 - INFO - Deleting VM ctest-vm-in-third-vn-63767305
2026-05-28 03:19:03,586 - INFO - Deleting VN ctest-third-vn-75363214
2026-05-28 03:19:03,651 - DEBUG - VN d5d6aab3-eb80-47a8-a700-53a682514231 still in use: Unable to complete operation on network d5d6aab3-eb80-47a8-a700-53a682514231. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-ea3c3960-d018-4fc9-a46a-d762f5af1247']
2026-05-28 03:19:03,651 - WARNING - Deleting VN ctest-third-vn-75363214 failed..Will retry
2026-05-28 03:19:05,817 - DEBUG - Response for deleting network ()
2026-05-28 03:19:07,143 - DEBUG - No XMPP flaps were noticed during the test
2026-05-28 03:19:07,143 - INFO -
2026-05-28 03:19:07,143 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:29]
2026-05-28 03:19:07,143 - INFO - --------------------------------------------------------------------------------
2026-05-28 03:19:07,147 - INFO - ================================================================================
2026-05-28 03:19:07,147 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2026-05-28 03:19:08,470 - DEBUG - Nothing to compare xmpp stats {'10.0.0.48': {'10.20.0.252': '1', '10.20.0.249': '0'}, '10.0.0.49': {'10.20.0.249': '0', '10.20.0.19': '0'}} with
2026-05-28 03:19:08,470 - INFO - Initial checks done. Running the testcase now
2026-05-28 03:19:08,470 - INFO -
2026-05-28 03:19:08,784 - DEBUG - Response for create_network : {'network': {'id': '3aa1bc9b-2504-474d-beb0-61130bed95de', 'name': 'ctest-mgmt_vn-47655269', 'tenant_id': '366b7c46c9494871a0888fe8eabbdf1a', 'project_id': '366b7c46c9494871a0888fe8eabbdf1a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-27878877', 'ctest-mgmt_vn-47655269'], 'port_security_enabled': True, 'description': ''}}
2026-05-28 03:19:09,074 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd568ac18-e2f0-4aac-be5b-eec8a4889cf3', 'name': '', 'tenant_id': '366b7c46c9494871a0888fe8eabbdf1a', 'network_id': '3aa1bc9b-2504-474d-beb0-61130bed95de', 'ip_version': 4, 'cidr': '202.39.137.192/26', 'allocation_pools': [{'start': '202.39.137.194', 'end': '202.39.137.254'}], 'gateway_ip': '202.39.137.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '202.39.137.194', 'tags': [], 'project_id': '366b7c46c9494871a0888fe8eabbdf1a'}}
2026-05-28 03:19:09,101 - INFO - Created VN ctest-mgmt_vn-47655269
2026-05-28 03:19:09,116 - DEBUG - VN ctest-mgmt_vn-47655269 UUID is 3aa1bc9b-2504-474d-beb0-61130bed95de
2026-05-28 03:19:09,201 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:09,208 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:09,221 - DEBUG - Requesting: http://10.0.0.133:8082/project/366b7c46-c949-4871-a088-8fe8eabbdf1a
2026-05-28 03:19:09,314 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/3aa1bc9b-2504-474d-beb0-61130bed95de
2026-05-28 03:19:09,330 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/3aa1bc9b-2504-474d-beb0-61130bed95de
2026-05-28 03:19:09,341 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/715ef9f9-31e2-4295-af33-d6ee1cbe2a47
2026-05-28 03:19:09,354 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/715ef9f9-31e2-4295-af33-d6ee1cbe2a47
2026-05-28 03:19:09,364 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/7833ec76-1000-4c58-a3ec-384c8550549c
2026-05-28 03:19:09,373 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-28 03:19:09,373 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/3aa1bc9b-2504-474d-beb0-61130bed95de
2026-05-28 03:19:09,384 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/715ef9f9-31e2-4295-af33-d6ee1cbe2a47
2026-05-28 03:19:09,405 - INFO - Verified VN network id 13 for VN 3aa1bc9b-2504-474d-beb0-61130bed95de
2026-05-28 03:19:09,405 - INFO - Verifications in API Server for VN ctest-mgmt_vn-47655269 passed
2026-05-28 03:19:09,405 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/3aa1bc9b-2504-474d-beb0-61130bed95de
2026-05-28 03:19:09,417 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/715ef9f9-31e2-4295-af33-d6ee1cbe2a47
2026-05-28 03:19:09,427 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/715ef9f9-31e2-4295-af33-d6ee1cbe2a47
2026-05-28 03:19:09,436 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/7833ec76-1000-4c58-a3ec-384c8550549c
2026-05-28 03:19:09,450 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27878877:ctest-mgmt_vn-47655269', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27878877', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4224865299977226061', 'uuid-lslong': '13740589197539775966'}, 'enable': 'true', 'created': '2026-05-28T03:19:08', 'last-modified': '2026-05-28T03:19:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.445710'}
2026-05-28 03:19:09,456 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-28 03:19:09,464 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27878877:ctest-mgmt_vn-47655269', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27878877', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4224865299977226061', 'uuid-lslong': '13740589197539775966'}, 'enable': 'true', 'created': '2026-05-28T03:19:08', 'last-modified': '2026-05-28T03:19:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.461212'}
2026-05-28 03:19:09,472 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-28 03:19:09,478 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27878877:ctest-mgmt_vn-47655269', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27878877', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4224865299977226061', 'uuid-lslong': '13740589197539775966'}, 'enable': 'true', 'created': '2026-05-28T03:19:08', 'last-modified': '2026-05-28T03:19:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.472397'}
2026-05-28 03:19:09,486 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-28 03:19:09,486 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-47655269 passed
2026-05-28 03:19:09,486 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-47655269 in API_Server ======
2026-05-28 03:19:09,486 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:09,495 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:09,509 - DEBUG - Requesting: http://10.0.0.133:8082/project/366b7c46-c949-4871-a088-8fe8eabbdf1a
2026-05-28 03:19:09,612 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/3aa1bc9b-2504-474d-beb0-61130bed95de
2026-05-28 03:19:09,630 - DEBUG - =>VN ctest-mgmt_vn-47655269 has no policy to be verified
2026-05-28 03:19:09,630 - DEBUG - Verifying the vn in opserver
2026-05-28 03:19:09,630 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27878877:ctest-mgmt_vn-47655269 virtual network link through opserver 10.0.0.133
2026-05-28 03:19:09,630 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-05-28 03:19:09,648 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27878877:ctest-mgmt_vn-47655269', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27878877:ctest-mgmt_vn-47655269?flat'}
2026-05-28 03:19:09,648 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27878877:ctest-mgmt_vn-47655269 virtual network link through opserver 10.0.0.41
2026-05-28 03:19:09,648 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-05-28 03:19:09,667 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27878877:ctest-mgmt_vn-47655269', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27878877:ctest-mgmt_vn-47655269?flat'}
2026-05-28 03:19:09,667 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27878877:ctest-mgmt_vn-47655269 virtual network link through opserver 10.0.0.131
2026-05-28 03:19:09,667 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-05-28 03:19:09,684 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27878877:ctest-mgmt_vn-47655269', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27878877:ctest-mgmt_vn-47655269?flat'}
2026-05-28 03:19:09,684 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-27878877:ctest-mgmt_vn-47655269 is found in opserver
2026-05-28 03:19:09,714 - DEBUG - Do not have enough data to verify VN in agent
2026-05-28 03:19:09,732 - DEBUG - VRF ids for VN ctest-mgmt_vn-47655269: {}
2026-05-28 03:19:10,025 - DEBUG - Response for create_network : {'network': {'id': 'e0f8de67-e388-4fde-88a2-2b5b1a4ae9ba', 'name': 'ctest-left_vn-32361369', 'tenant_id': '366b7c46c9494871a0888fe8eabbdf1a', 'project_id': '366b7c46c9494871a0888fe8eabbdf1a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-27878877', 'ctest-left_vn-32361369'], 'port_security_enabled': True, 'description': ''}}
2026-05-28 03:19:10,295 - DEBUG - Response for create_subnet : {'subnet': {'id': '0bc1fab7-c697-4780-b7f7-7f9915103a3a', 'name': '', 'tenant_id': '366b7c46c9494871a0888fe8eabbdf1a', 'network_id': 'e0f8de67-e388-4fde-88a2-2b5b1a4ae9ba', 'ip_version': 4, 'cidr': '181.135.252.128/26', 'allocation_pools': [{'start': '181.135.252.130', 'end': '181.135.252.190'}], 'gateway_ip': '181.135.252.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '181.135.252.130', 'tags': [], 'project_id': '366b7c46c9494871a0888fe8eabbdf1a'}}
2026-05-28 03:19:10,326 - INFO - Created VN ctest-left_vn-32361369
2026-05-28 03:19:10,341 - DEBUG - VN ctest-left_vn-32361369 UUID is e0f8de67-e388-4fde-88a2-2b5b1a4ae9ba
2026-05-28 03:19:10,437 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:10,445 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:10,458 - DEBUG - Requesting: http://10.0.0.133:8082/project/366b7c46-c949-4871-a088-8fe8eabbdf1a
2026-05-28 03:19:10,564 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/e0f8de67-e388-4fde-88a2-2b5b1a4ae9ba
2026-05-28 03:19:10,584 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/e0f8de67-e388-4fde-88a2-2b5b1a4ae9ba
2026-05-28 03:19:10,596 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/6eeb104c-961b-455a-9e22-2a5127cf0d2f
2026-05-28 03:19:10,608 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/6eeb104c-961b-455a-9e22-2a5127cf0d2f
2026-05-28 03:19:10,622 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/0b0fa5bf-1d23-4666-874d-c8f3f6b9d7bc
2026-05-28 03:19:10,636 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-28 03:19:10,636 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/e0f8de67-e388-4fde-88a2-2b5b1a4ae9ba
2026-05-28 03:19:10,651 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/6eeb104c-961b-455a-9e22-2a5127cf0d2f
2026-05-28 03:19:10,676 - INFO - Verified VN network id 14 for VN e0f8de67-e388-4fde-88a2-2b5b1a4ae9ba
2026-05-28 03:19:10,676 - INFO - Verifications in API Server for VN ctest-left_vn-32361369 passed
2026-05-28 03:19:10,676 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/e0f8de67-e388-4fde-88a2-2b5b1a4ae9ba
2026-05-28 03:19:10,688 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/6eeb104c-961b-455a-9e22-2a5127cf0d2f
2026-05-28 03:19:10,698 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/6eeb104c-961b-455a-9e22-2a5127cf0d2f
2026-05-28 03:19:10,710 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/0b0fa5bf-1d23-4666-874d-c8f3f6b9d7bc
2026-05-28 03:19:10,732 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27878877:ctest-left_vn-32361369', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27878877', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16210951396500459486', 'uuid-lslong': '9845479405668460986'}, 'enable': 'true', 'created': '2026-05-28T03:19:09', 'last-modified': '2026-05-28T03:19:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.490810'}
2026-05-28 03:19:10,740 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-28 03:19:10,746 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27878877:ctest-left_vn-32361369', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27878877', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16210951396500459486', 'uuid-lslong': '9845479405668460986'}, 'enable': 'true', 'created': '2026-05-28T03:19:09', 'last-modified': '2026-05-28T03:19:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.511472'}
2026-05-28 03:19:10,756 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-28 03:19:10,762 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27878877:ctest-left_vn-32361369', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27878877', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16210951396500459486', 'uuid-lslong': '9845479405668460986'}, 'enable': 'true', 'created': '2026-05-28T03:19:09', 'last-modified': '2026-05-28T03:19:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.530575'}
2026-05-28 03:19:10,774 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-28 03:19:10,774 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-32361369 passed
2026-05-28 03:19:10,775 - DEBUG - ====Verifying policy data for ctest-left_vn-32361369 in API_Server ======
2026-05-28 03:19:10,775 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:10,787 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:10,802 - DEBUG - Requesting: http://10.0.0.133:8082/project/366b7c46-c949-4871-a088-8fe8eabbdf1a
2026-05-28 03:19:10,899 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/e0f8de67-e388-4fde-88a2-2b5b1a4ae9ba
2026-05-28 03:19:10,912 - DEBUG - =>VN ctest-left_vn-32361369 has no policy to be verified
2026-05-28 03:19:10,912 - DEBUG - Verifying the vn in opserver
2026-05-28 03:19:10,912 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27878877:ctest-left_vn-32361369 virtual network link through opserver 10.0.0.133
2026-05-28 03:19:10,912 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-05-28 03:19:10,927 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27878877:ctest-left_vn-32361369', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27878877:ctest-left_vn-32361369?flat'}
2026-05-28 03:19:10,927 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27878877:ctest-left_vn-32361369 virtual network link through opserver 10.0.0.41
2026-05-28 03:19:10,927 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-05-28 03:19:11,319 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27878877:ctest-left_vn-32361369', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27878877:ctest-left_vn-32361369?flat'}
2026-05-28 03:19:11,319 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27878877:ctest-left_vn-32361369 virtual network link through opserver 10.0.0.131
2026-05-28 03:19:11,319 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-05-28 03:19:11,335 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27878877:ctest-left_vn-32361369', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27878877:ctest-left_vn-32361369?flat'}
2026-05-28 03:19:11,335 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-27878877:ctest-left_vn-32361369 is found in opserver
2026-05-28 03:19:11,371 - DEBUG - Do not have enough data to verify VN in agent
2026-05-28 03:19:11,386 - DEBUG - VRF ids for VN ctest-left_vn-32361369: {}
2026-05-28 03:19:12,099 - DEBUG - Response for create_network : {'network': {'id': '64363910-d14f-4421-b32c-bccee96069d1', 'name': 'ctest-right_vn-18479223', 'tenant_id': '366b7c46c9494871a0888fe8eabbdf1a', 'project_id': '366b7c46c9494871a0888fe8eabbdf1a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-27878877', 'ctest-right_vn-18479223'], 'port_security_enabled': True, 'description': ''}}
2026-05-28 03:19:12,370 - DEBUG - Response for create_subnet : {'subnet': {'id': '462adc5b-1a20-455f-ae38-821faa3c337f', 'name': '', 'tenant_id': '366b7c46c9494871a0888fe8eabbdf1a', 'network_id': '64363910-d14f-4421-b32c-bccee96069d1', 'ip_version': 4, 'cidr': '169.153.21.64/26', 'allocation_pools': [{'start': '169.153.21.66', 'end': '169.153.21.126'}], 'gateway_ip': '169.153.21.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '169.153.21.66', 'tags': [], 'project_id': '366b7c46c9494871a0888fe8eabbdf1a'}}
2026-05-28 03:19:12,415 - INFO - Created VN ctest-right_vn-18479223
2026-05-28 03:19:12,431 - DEBUG - VN ctest-right_vn-18479223 UUID is 64363910-d14f-4421-b32c-bccee96069d1
2026-05-28 03:19:12,529 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:12,536 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:12,550 - DEBUG - Requesting: http://10.0.0.133:8082/project/366b7c46-c949-4871-a088-8fe8eabbdf1a
2026-05-28 03:19:12,660 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/64363910-d14f-4421-b32c-bccee96069d1
2026-05-28 03:19:12,680 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/64363910-d14f-4421-b32c-bccee96069d1
2026-05-28 03:19:12,701 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/6923adb2-9af9-467a-900f-e74ed13944bf
2026-05-28 03:19:12,712 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/6923adb2-9af9-467a-900f-e74ed13944bf
2026-05-28 03:19:12,725 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/2969fed8-1c59-42e8-8b8c-962ab3b012ff
2026-05-28 03:19:12,737 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-28 03:19:12,737 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/64363910-d14f-4421-b32c-bccee96069d1
2026-05-28 03:19:12,755 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/6923adb2-9af9-467a-900f-e74ed13944bf
2026-05-28 03:19:12,789 - INFO - Verified VN network id 15 for VN 64363910-d14f-4421-b32c-bccee96069d1
2026-05-28 03:19:12,789 - INFO - Verifications in API Server for VN ctest-right_vn-18479223 passed
2026-05-28 03:19:12,789 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/64363910-d14f-4421-b32c-bccee96069d1
2026-05-28 03:19:12,807 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/6923adb2-9af9-467a-900f-e74ed13944bf
2026-05-28 03:19:12,822 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/6923adb2-9af9-467a-900f-e74ed13944bf
2026-05-28 03:19:12,835 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/2969fed8-1c59-42e8-8b8c-962ab3b012ff
2026-05-28 03:19:12,851 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27878877:ctest-right_vn-18479223', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27878877', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7221021796929061921', 'uuid-lslong': '12910901828629064145'}, 'enable': 'true', 'created': '2026-05-28T03:19:11', 'last-modified': '2026-05-28T03:19:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.556529'}
2026-05-28 03:19:12,860 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-28 03:19:12,867 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27878877:ctest-right_vn-18479223', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27878877', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7221021796929061921', 'uuid-lslong': '12910901828629064145'}, 'enable': 'true', 'created': '2026-05-28T03:19:11', 'last-modified': '2026-05-28T03:19:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.569974'}
2026-05-28 03:19:12,874 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-28 03:19:12,881 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27878877:ctest-right_vn-18479223', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27878877', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7221021796929061921', 'uuid-lslong': '12910901828629064145'}, 'enable': 'true', 'created': '2026-05-28T03:19:11', 'last-modified': '2026-05-28T03:19:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.589486'}
2026-05-28 03:19:12,889 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-28 03:19:12,889 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-18479223 passed
2026-05-28 03:19:12,889 - DEBUG - ====Verifying policy data for ctest-right_vn-18479223 in API_Server ======
2026-05-28 03:19:12,889 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:12,901 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:12,916 - DEBUG - Requesting: http://10.0.0.133:8082/project/366b7c46-c949-4871-a088-8fe8eabbdf1a
2026-05-28 03:19:13,020 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/64363910-d14f-4421-b32c-bccee96069d1
2026-05-28 03:19:13,038 - DEBUG - =>VN ctest-right_vn-18479223 has no policy to be verified
2026-05-28 03:19:13,039 - DEBUG - Verifying the vn in opserver
2026-05-28 03:19:13,039 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27878877:ctest-right_vn-18479223 virtual network link through opserver 10.0.0.133
2026-05-28 03:19:13,039 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-05-28 03:19:13,061 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27878877:ctest-right_vn-18479223', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27878877:ctest-right_vn-18479223?flat'}
2026-05-28 03:19:13,061 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27878877:ctest-right_vn-18479223 virtual network link through opserver 10.0.0.41
2026-05-28 03:19:13,061 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-05-28 03:19:13,090 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27878877:ctest-right_vn-18479223', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27878877:ctest-right_vn-18479223?flat'}
2026-05-28 03:19:13,090 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27878877:ctest-right_vn-18479223 virtual network link through opserver 10.0.0.131
2026-05-28 03:19:13,090 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-05-28 03:19:13,114 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27878877:ctest-right_vn-18479223', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27878877:ctest-right_vn-18479223?flat'}
2026-05-28 03:19:13,114 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-27878877:ctest-right_vn-18479223 is found in opserver
2026-05-28 03:19:13,147 - DEBUG - Do not have enough data to verify VN in agent
2026-05-28 03:19:13,161 - DEBUG - VRF ids for VN ctest-right_vn-18479223: {}
2026-05-28 03:19:13,481 - DEBUG - Response for create_network : {'network': {'id': '7a2ae864-e8fd-4ab4-b208-908953d6ddb0', 'name': 'ctest-trans_left_vn-62359214', 'tenant_id': '366b7c46c9494871a0888fe8eabbdf1a', 'project_id': '366b7c46c9494871a0888fe8eabbdf1a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-27878877', 'ctest-trans_left_vn-62359214'], 'port_security_enabled': True, 'description': ''}}
2026-05-28 03:19:13,705 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c0668552-5b74-472c-aa34-61f8ee3a377b', 'name': '', 'tenant_id': '366b7c46c9494871a0888fe8eabbdf1a', 'network_id': '7a2ae864-e8fd-4ab4-b208-908953d6ddb0', 'ip_version': 4, 'cidr': '162.2.204.128/26', 'allocation_pools': [{'start': '162.2.204.130', 'end': '162.2.204.190'}], 'gateway_ip': '162.2.204.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '162.2.204.130', 'tags': [], 'project_id': '366b7c46c9494871a0888fe8eabbdf1a'}}
2026-05-28 03:19:13,730 - INFO - Created VN ctest-trans_left_vn-62359214
2026-05-28 03:19:13,742 - DEBUG - VN ctest-trans_left_vn-62359214 UUID is 7a2ae864-e8fd-4ab4-b208-908953d6ddb0
2026-05-28 03:19:13,822 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:13,830 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:13,844 - DEBUG - Requesting: http://10.0.0.133:8082/project/366b7c46-c949-4871-a088-8fe8eabbdf1a
2026-05-28 03:19:13,953 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/7a2ae864-e8fd-4ab4-b208-908953d6ddb0
2026-05-28 03:19:13,966 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/7a2ae864-e8fd-4ab4-b208-908953d6ddb0
2026-05-28 03:19:13,979 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/09c82ec1-9f22-46e5-bbea-5163f33a2c4b
2026-05-28 03:19:13,995 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/09c82ec1-9f22-46e5-bbea-5163f33a2c4b
2026-05-28 03:19:14,007 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/47f222df-b7d8-4ea9-be06-9b18477888a1
2026-05-28 03:19:14,019 - DEBUG - Route Targets: ['target:64512:8000010']
2026-05-28 03:19:14,019 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/7a2ae864-e8fd-4ab4-b208-908953d6ddb0
2026-05-28 03:19:14,034 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/09c82ec1-9f22-46e5-bbea-5163f33a2c4b
2026-05-28 03:19:14,058 - INFO - Verified VN network id 16 for VN 7a2ae864-e8fd-4ab4-b208-908953d6ddb0
2026-05-28 03:19:14,058 - INFO - Verifications in API Server for VN ctest-trans_left_vn-62359214 passed
2026-05-28 03:19:14,059 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/7a2ae864-e8fd-4ab4-b208-908953d6ddb0
2026-05-28 03:19:14,071 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/09c82ec1-9f22-46e5-bbea-5163f33a2c4b
2026-05-28 03:19:14,080 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/09c82ec1-9f22-46e5-bbea-5163f33a2c4b
2026-05-28 03:19:14,091 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/47f222df-b7d8-4ea9-be06-9b18477888a1
2026-05-28 03:19:14,106 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27878877:ctest-trans_left_vn-62359214', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27878877', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8803103941752343220', 'uuid-lslong': '12828662458056367536'}, 'enable': 'true', 'created': '2026-05-28T03:19:13', 'last-modified': '2026-05-28T03:19:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.466564'}
2026-05-28 03:19:14,113 - DEBUG - Route Targets: ['target:64512:8000010']
2026-05-28 03:19:14,121 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27878877:ctest-trans_left_vn-62359214', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27878877', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8803103941752343220', 'uuid-lslong': '12828662458056367536'}, 'enable': 'true', 'created': '2026-05-28T03:19:13', 'last-modified': '2026-05-28T03:19:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.480897'}
2026-05-28 03:19:14,127 - DEBUG - Route Targets: ['target:64512:8000010']
2026-05-28 03:19:14,133 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27878877:ctest-trans_left_vn-62359214', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27878877', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8803103941752343220', 'uuid-lslong': '12828662458056367536'}, 'enable': 'true', 'created': '2026-05-28T03:19:13', 'last-modified': '2026-05-28T03:19:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.490739'}
2026-05-28 03:19:14,142 - DEBUG - Route Targets: ['target:64512:8000010']
2026-05-28 03:19:14,142 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-62359214 passed
2026-05-28 03:19:14,142 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-62359214 in API_Server ======
2026-05-28 03:19:14,142 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:14,149 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:14,163 - DEBUG - Requesting: http://10.0.0.133:8082/project/366b7c46-c949-4871-a088-8fe8eabbdf1a
2026-05-28 03:19:14,267 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/7a2ae864-e8fd-4ab4-b208-908953d6ddb0
2026-05-28 03:19:14,279 - DEBUG - =>VN ctest-trans_left_vn-62359214 has no policy to be verified
2026-05-28 03:19:14,279 - DEBUG - Verifying the vn in opserver
2026-05-28 03:19:14,279 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27878877:ctest-trans_left_vn-62359214 virtual network link through opserver 10.0.0.133
2026-05-28 03:19:14,279 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-05-28 03:19:14,293 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27878877:ctest-trans_left_vn-62359214', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27878877:ctest-trans_left_vn-62359214?flat'}
2026-05-28 03:19:14,293 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27878877:ctest-trans_left_vn-62359214 virtual network link through opserver 10.0.0.41
2026-05-28 03:19:14,293 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-05-28 03:19:14,308 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27878877:ctest-trans_left_vn-62359214', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27878877:ctest-trans_left_vn-62359214?flat'}
2026-05-28 03:19:14,308 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27878877:ctest-trans_left_vn-62359214 virtual network link through opserver 10.0.0.131
2026-05-28 03:19:14,308 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-05-28 03:19:14,325 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27878877:ctest-trans_left_vn-62359214', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27878877:ctest-trans_left_vn-62359214?flat'}
2026-05-28 03:19:14,325 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-27878877:ctest-trans_left_vn-62359214 is found in opserver
2026-05-28 03:19:14,353 - DEBUG - Do not have enough data to verify VN in agent
2026-05-28 03:19:14,367 - DEBUG - VRF ids for VN ctest-trans_left_vn-62359214: {}
2026-05-28 03:19:14,661 - DEBUG - Response for create_network : {'network': {'id': '09601913-8f88-4f2f-9b96-2be8c0ee2df3', 'name': 'ctest-trans_right_vn-69837696', 'tenant_id': '366b7c46c9494871a0888fe8eabbdf1a', 'project_id': '366b7c46c9494871a0888fe8eabbdf1a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-27878877', 'ctest-trans_right_vn-69837696'], 'port_security_enabled': True, 'description': ''}}
2026-05-28 03:19:14,870 - DEBUG - Response for create_subnet : {'subnet': {'id': '3e0c92dd-e1e4-4fec-b301-880b26c4bad3', 'name': '', 'tenant_id': '366b7c46c9494871a0888fe8eabbdf1a', 'network_id': '09601913-8f88-4f2f-9b96-2be8c0ee2df3', 'ip_version': 4, 'cidr': '204.244.200.128/26', 'allocation_pools': [{'start': '204.244.200.130', 'end': '204.244.200.190'}], 'gateway_ip': '204.244.200.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '204.244.200.130', 'tags': [], 'project_id': '366b7c46c9494871a0888fe8eabbdf1a'}}
2026-05-28 03:19:14,898 - INFO - Created VN ctest-trans_right_vn-69837696
2026-05-28 03:19:14,910 - DEBUG - VN ctest-trans_right_vn-69837696 UUID is 09601913-8f88-4f2f-9b96-2be8c0ee2df3
2026-05-28 03:19:14,995 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:15,005 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:15,022 - DEBUG - Requesting: http://10.0.0.133:8082/project/366b7c46-c949-4871-a088-8fe8eabbdf1a
2026-05-28 03:19:15,140 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/09601913-8f88-4f2f-9b96-2be8c0ee2df3
2026-05-28 03:19:15,155 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/09601913-8f88-4f2f-9b96-2be8c0ee2df3
2026-05-28 03:19:15,166 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/8c7fd087-be18-4931-ba38-c6046246be74
2026-05-28 03:19:15,177 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/8c7fd087-be18-4931-ba38-c6046246be74
2026-05-28 03:19:15,185 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/77ebe449-5e2a-4fa2-81f4-4caf92b36ef7
2026-05-28 03:19:15,197 - DEBUG - Route Targets: ['target:64512:8000011']
2026-05-28 03:19:15,197 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/09601913-8f88-4f2f-9b96-2be8c0ee2df3
2026-05-28 03:19:15,214 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/8c7fd087-be18-4931-ba38-c6046246be74
2026-05-28 03:19:15,241 - INFO - Verified VN network id 17 for VN 09601913-8f88-4f2f-9b96-2be8c0ee2df3
2026-05-28 03:19:15,242 - INFO - Verifications in API Server for VN ctest-trans_right_vn-69837696 passed
2026-05-28 03:19:15,243 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/09601913-8f88-4f2f-9b96-2be8c0ee2df3
2026-05-28 03:19:15,254 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/8c7fd087-be18-4931-ba38-c6046246be74
2026-05-28 03:19:15,263 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/8c7fd087-be18-4931-ba38-c6046246be74
2026-05-28 03:19:15,271 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/77ebe449-5e2a-4fa2-81f4-4caf92b36ef7
2026-05-28 03:19:15,285 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27878877:ctest-trans_right_vn-69837696', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27878877', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '675567515908722479', 'uuid-lslong': '11211196601054670323'}, 'enable': 'true', 'created': '2026-05-28T03:19:14', 'last-modified': '2026-05-28T03:19:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.461417'}
2026-05-28 03:19:15,291 - DEBUG - Route Targets: ['target:64512:8000011']
2026-05-28 03:19:15,297 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27878877:ctest-trans_right_vn-69837696', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27878877', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '675567515908722479', 'uuid-lslong': '11211196601054670323'}, 'enable': 'true', 'created': '2026-05-28T03:19:14', 'last-modified': '2026-05-28T03:19:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.478494'}
2026-05-28 03:19:15,305 - DEBUG - Route Targets: ['target:64512:8000011']
2026-05-28 03:19:15,313 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-27878877:ctest-trans_right_vn-69837696', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-27878877', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '675567515908722479', 'uuid-lslong': '11211196601054670323'}, 'enable': 'true', 'created': '2026-05-28T03:19:14', 'last-modified': '2026-05-28T03:19:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.495244'}
2026-05-28 03:19:15,322 - DEBUG - Route Targets: ['target:64512:8000011']
2026-05-28 03:19:15,322 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-69837696 passed
2026-05-28 03:19:15,322 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-69837696 in API_Server ======
2026-05-28 03:19:15,322 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:15,329 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:15,342 - DEBUG - Requesting: http://10.0.0.133:8082/project/366b7c46-c949-4871-a088-8fe8eabbdf1a
2026-05-28 03:19:15,444 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/09601913-8f88-4f2f-9b96-2be8c0ee2df3
2026-05-28 03:19:15,455 - DEBUG - =>VN ctest-trans_right_vn-69837696 has no policy to be verified
2026-05-28 03:19:15,455 - DEBUG - Verifying the vn in opserver
2026-05-28 03:19:15,455 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27878877:ctest-trans_right_vn-69837696 virtual network link through opserver 10.0.0.133
2026-05-28 03:19:15,455 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-05-28 03:19:15,471 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27878877:ctest-trans_right_vn-69837696', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27878877:ctest-trans_right_vn-69837696?flat'}
2026-05-28 03:19:15,471 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27878877:ctest-trans_right_vn-69837696 virtual network link through opserver 10.0.0.41
2026-05-28 03:19:15,471 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-05-28 03:19:15,486 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27878877:ctest-trans_right_vn-69837696', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27878877:ctest-trans_right_vn-69837696?flat'}
2026-05-28 03:19:15,486 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-27878877:ctest-trans_right_vn-69837696 virtual network link through opserver 10.0.0.131
2026-05-28 03:19:15,486 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-05-28 03:19:15,502 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-27878877:ctest-trans_right_vn-69837696', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-27878877:ctest-trans_right_vn-69837696?flat'}
2026-05-28 03:19:15,502 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-27878877:ctest-trans_right_vn-69837696 is found in opserver
2026-05-28 03:19:15,646 - DEBUG - Do not have enough data to verify VN in agent
2026-05-28 03:19:15,661 - DEBUG - VRF ids for VN ctest-trans_right_vn-69837696: {}
2026-05-28 03:19:17,300 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5841-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5841-1)
2026-05-28 03:19:18,916 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5841-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5841-2)
2026-05-28 03:19:18,917 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-59292239']
2026-05-28 03:19:19,230 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-59292239'] created succesfully
2026-05-28 03:19:19,739 - DEBUG - Image by name tiny_trans_fw not found
2026-05-28 03:19:19,739 - DEBUG - Installing image tiny_trans_fw
2026-05-28 03:19:19,739 - DEBUG - Image info {'name': 'tinycore-net-transparent-fw.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd'}
2026-05-28 03:19:19,739 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-05-28 03:19:19,739 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-05-28 03:19:19,761 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz -O /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-05-28 03:19:19,830 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-05-28 03:19:19,830 - DEBUG - Unzip image
2026-05-28 03:19:19,830 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-05-28 03:19:19,859 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-05-28 03:19:19,860 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-59292239']
2026-05-28 03:19:19,965 - INFO - Service template: ['default-domain', 'ctest-service_template_1-59292239'] deleted successfully.
2026-05-28 03:19:19,965 - INFO - Skip interface_detach for VM ctest-right_vm-98830879 in state BUILD
2026-05-28 03:19:19,965 - INFO - Deleting VM ctest-right_vm-98830879
2026-05-28 03:19:19,965 - ERROR - VM ctest-right_vm-98830879 has failed to come up
2026-05-28 03:19:19,965 - ERROR - Nova failed to get host of the VM
2026-05-28 03:19:19,965 - ERROR - VM ctest-right_vm-98830879 has failed to come up
2026-05-28 03:19:19,965 - ERROR - Nova failed to get host of the VM
2026-05-28 03:19:20,069 - INFO - Skip interface_detach for VM ctest-left_vm-40121345 in state BUILD
2026-05-28 03:19:20,070 - INFO - Deleting VM ctest-left_vm-40121345
2026-05-28 03:19:20,070 - ERROR - VM ctest-left_vm-40121345 has failed to come up
2026-05-28 03:19:20,071 - ERROR - Nova failed to get host of the VM
2026-05-28 03:19:20,071 - ERROR - VM ctest-left_vm-40121345 has failed to come up
2026-05-28 03:19:20,071 - ERROR - Nova failed to get host of the VM
2026-05-28 03:19:20,243 - INFO - Deleting VN ctest-trans_right_vn-69837696
2026-05-28 03:19:20,614 - DEBUG - Response for deleting network ()
2026-05-28 03:19:20,614 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/8c7fd087-be18-4931-ba38-c6046246be74
2026-05-28 03:19:20,623 - DEBUG - Response Code: 404
2026-05-28 03:19:20,623 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:20,631 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:20,691 - DEBUG - Requesting: http://10.0.0.133:8082/project/366b7c46-c949-4871-a088-8fe8eabbdf1a
2026-05-28 03:19:20,824 - INFO - Validated that VN ctest-trans_right_vn-69837696 is not found in API Server
2026-05-28 03:19:20,843 - DEBUG - VN ctest-trans_right_vn-69837696 is not present in Agent 10.0.0.48
2026-05-28 03:19:20,868 - DEBUG - VN ctest-trans_right_vn-69837696 is not present in Agent 10.0.0.49
2026-05-28 03:19:20,868 - INFO - Validated that VN ctest-trans_right_vn-69837696 is not in any agent
2026-05-28 03:19:20,959 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-69837696 info
2026-05-28 03:19:20,959 - INFO - Deleting VN ctest-trans_left_vn-62359214
2026-05-28 03:19:21,216 - DEBUG - Response for deleting network ()
2026-05-28 03:19:21,217 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/09c82ec1-9f22-46e5-bbea-5163f33a2c4b
2026-05-28 03:19:21,226 - DEBUG - Response Code: 404
2026-05-28 03:19:21,226 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:21,239 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:21,265 - DEBUG - Requesting: http://10.0.0.133:8082/project/366b7c46-c949-4871-a088-8fe8eabbdf1a
2026-05-28 03:19:21,413 - INFO - Validated that VN ctest-trans_left_vn-62359214 is not found in API Server
2026-05-28 03:19:21,429 - DEBUG - VN ctest-trans_left_vn-62359214 is not present in Agent 10.0.0.48
2026-05-28 03:19:21,475 - DEBUG - VN ctest-trans_left_vn-62359214 is not present in Agent 10.0.0.49
2026-05-28 03:19:21,476 - INFO - Validated that VN ctest-trans_left_vn-62359214 is not in any agent
2026-05-28 03:19:21,528 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-62359214 info
2026-05-28 03:19:21,528 - INFO - Deleting VN ctest-right_vn-18479223
2026-05-28 03:19:21,606 - DEBUG - VN 64363910-d14f-4421-b32c-bccee96069d1 still in use: Unable to complete operation on network 64363910-d14f-4421-b32c-bccee96069d1. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-7405efac-eee4-4524-9a05-b15cb99c7293']
2026-05-28 03:19:21,606 - WARNING - Deleting VN ctest-right_vn-18479223 failed..Will retry
2026-05-28 03:19:23,807 - DEBUG - Response for deleting network ()
2026-05-28 03:19:23,807 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/6923adb2-9af9-467a-900f-e74ed13944bf
2026-05-28 03:19:23,823 - DEBUG - Response Code: 404
2026-05-28 03:19:23,823 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:23,832 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:23,848 - DEBUG - Requesting: http://10.0.0.133:8082/project/366b7c46-c949-4871-a088-8fe8eabbdf1a
2026-05-28 03:19:23,942 - INFO - Validated that VN ctest-right_vn-18479223 is not found in API Server
2026-05-28 03:19:23,955 - DEBUG - VN ctest-right_vn-18479223 is not present in Agent 10.0.0.48
2026-05-28 03:19:23,967 - DEBUG - VN ctest-right_vn-18479223 is not present in Agent 10.0.0.49
2026-05-28 03:19:23,967 - INFO - Validated that VN ctest-right_vn-18479223 is not in any agent
2026-05-28 03:19:24,004 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-18479223 info
2026-05-28 03:19:24,004 - INFO - Deleting VN ctest-left_vn-32361369
2026-05-28 03:19:24,195 - DEBUG - Response for deleting network ()
2026-05-28 03:19:24,195 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/6eeb104c-961b-455a-9e22-2a5127cf0d2f
2026-05-28 03:19:24,210 - DEBUG - Response Code: 404
2026-05-28 03:19:24,210 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:24,222 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:24,279 - DEBUG - Requesting: http://10.0.0.133:8082/project/366b7c46-c949-4871-a088-8fe8eabbdf1a
2026-05-28 03:19:24,392 - INFO - Validated that VN ctest-left_vn-32361369 is not found in API Server
2026-05-28 03:19:24,405 - DEBUG - VN ctest-left_vn-32361369 is not present in Agent 10.0.0.48
2026-05-28 03:19:24,417 - DEBUG - VN ctest-left_vn-32361369 is not present in Agent 10.0.0.49
2026-05-28 03:19:24,417 - INFO - Validated that VN ctest-left_vn-32361369 is not in any agent
2026-05-28 03:19:24,455 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-32361369 info
2026-05-28 03:19:24,455 - INFO - Deleting VN ctest-mgmt_vn-47655269
2026-05-28 03:19:24,668 - DEBUG - Response for deleting network ()
2026-05-28 03:19:24,668 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/715ef9f9-31e2-4295-af33-d6ee1cbe2a47
2026-05-28 03:19:24,674 - DEBUG - Response Code: 404
2026-05-28 03:19:24,674 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:24,680 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:24,694 - DEBUG - Requesting: http://10.0.0.133:8082/project/366b7c46-c949-4871-a088-8fe8eabbdf1a
2026-05-28 03:19:24,793 - INFO - Validated that VN ctest-mgmt_vn-47655269 is not found in API Server
2026-05-28 03:19:24,809 - DEBUG - VN ctest-mgmt_vn-47655269 is not present in Agent 10.0.0.48
2026-05-28 03:19:24,822 - DEBUG - VN ctest-mgmt_vn-47655269 is not present in Agent 10.0.0.49
2026-05-28 03:19:24,822 - INFO - Validated that VN ctest-mgmt_vn-47655269 is not in any agent
2026-05-28 03:19:24,859 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-47655269 info
2026-05-28 03:19:26,157 - DEBUG - No XMPP flaps were noticed during the test
2026-05-28 03:19:26,157 - INFO -
2026-05-28 03:19:26,157 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:19]
2026-05-28 03:19:26,157 - INFO - --------------------------------------------------------------------------------
2026-05-28 03:19:27,085 - INFO - Deleted project: ctest-TestSvcRegr-27878877, ID : 366b7c46-c949-4871-a088-8fe8eabbdf1a
2026-05-28 03:19:27,297 - INFO - Domain Default found not creating
2026-05-28 03:19:27,522 - INFO - Project ctest-TestSvcRegr-22565827 not found, creating it
2026-05-28 03:19:28,127 - INFO - Created Project:ctest-TestSvcRegr-22565827, ID : f7e3aa19-3d41-434f-8c2d-abffdf6d8f39
2026-05-28 03:19:29,938 - INFO - ================================================================================
2026-05-28 03:19:29,940 - INFO - STARTING TEST : test_svc_CEM_22032
2026-05-28 03:19:31,297 - DEBUG - Nothing to compare xmpp stats {'10.0.0.48': {'10.20.0.252': '1', '10.20.0.249': '0'}, '10.0.0.49': {'10.20.0.249': '0', '10.20.0.19': '0'}} with
2026-05-28 03:19:31,297 - INFO - Initial checks done. Running the testcase now
2026-05-28 03:19:31,297 - INFO -
2026-05-28 03:19:32,104 - DEBUG - Response for create_network : {'network': {'id': '68bd7577-79f1-4e9a-8a44-107cef440e8c', 'name': 'ctest-mgmt_vn-43884553', 'tenant_id': 'f7e3aa193d41434f8c2dabffdf6d8f39', 'project_id': 'f7e3aa193d41434f8c2dabffdf6d8f39', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-22565827', 'ctest-mgmt_vn-43884553'], 'port_security_enabled': True, 'description': ''}}
2026-05-28 03:19:32,447 - DEBUG - Response for create_subnet : {'subnet': {'id': 'cba1dfb8-1aab-4d47-98e8-7e75d45b1ca5', 'name': '', 'tenant_id': 'f7e3aa193d41434f8c2dabffdf6d8f39', 'network_id': '68bd7577-79f1-4e9a-8a44-107cef440e8c', 'ip_version': 4, 'cidr': '94.219.119.0/26', 'allocation_pools': [{'start': '94.219.119.2', 'end': '94.219.119.62'}], 'gateway_ip': '94.219.119.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '94.219.119.2', 'tags': [], 'project_id': 'f7e3aa193d41434f8c2dabffdf6d8f39'}}
2026-05-28 03:19:32,474 - INFO - Created VN ctest-mgmt_vn-43884553
2026-05-28 03:19:32,490 - DEBUG - VN ctest-mgmt_vn-43884553 UUID is 68bd7577-79f1-4e9a-8a44-107cef440e8c
2026-05-28 03:19:32,580 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:32,906 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:32,952 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:32,975 - DEBUG - Requesting: http://10.0.0.133:8082/project/f7e3aa19-3d41-434f-8c2d-abffdf6d8f39
2026-05-28 03:19:33,082 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/68bd7577-79f1-4e9a-8a44-107cef440e8c
2026-05-28 03:19:33,097 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/68bd7577-79f1-4e9a-8a44-107cef440e8c
2026-05-28 03:19:33,109 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/3156e72d-5f6a-4ada-b99b-ee6ad607049b
2026-05-28 03:19:33,122 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/3156e72d-5f6a-4ada-b99b-ee6ad607049b
2026-05-28 03:19:33,135 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/9833a2d3-4261-4a8f-9bca-9bb16e424aca
2026-05-28 03:19:33,145 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-28 03:19:33,145 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/68bd7577-79f1-4e9a-8a44-107cef440e8c
2026-05-28 03:19:33,157 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/3156e72d-5f6a-4ada-b99b-ee6ad607049b
2026-05-28 03:19:33,176 - INFO - Verified VN network id 13 for VN 68bd7577-79f1-4e9a-8a44-107cef440e8c
2026-05-28 03:19:33,176 - INFO - Verifications in API Server for VN ctest-mgmt_vn-43884553 passed
2026-05-28 03:19:33,177 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/68bd7577-79f1-4e9a-8a44-107cef440e8c
2026-05-28 03:19:33,190 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/3156e72d-5f6a-4ada-b99b-ee6ad607049b
2026-05-28 03:19:33,199 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/3156e72d-5f6a-4ada-b99b-ee6ad607049b
2026-05-28 03:19:33,209 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/9833a2d3-4261-4a8f-9bca-9bb16e424aca
2026-05-28 03:19:33,226 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-43884553', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22565827', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7547317706550234778', 'uuid-lslong': '9963106404426583692'}, 'enable': 'true', 'created': '2026-05-28T03:19:32', 'last-modified': '2026-05-28T03:19:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.820797'}
2026-05-28 03:19:33,235 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-28 03:19:33,241 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-43884553', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22565827', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7547317706550234778', 'uuid-lslong': '9963106404426583692'}, 'enable': 'true', 'created': '2026-05-28T03:19:32', 'last-modified': '2026-05-28T03:19:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.838239'}
2026-05-28 03:19:33,249 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-28 03:19:33,257 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-43884553', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22565827', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7547317706550234778', 'uuid-lslong': '9963106404426583692'}, 'enable': 'true', 'created': '2026-05-28T03:19:32', 'last-modified': '2026-05-28T03:19:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.860795'}
2026-05-28 03:19:33,266 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-28 03:19:33,267 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-43884553 passed
2026-05-28 03:19:33,267 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-43884553 in API_Server ======
2026-05-28 03:19:33,267 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:33,277 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:33,293 - DEBUG - Requesting: http://10.0.0.133:8082/project/f7e3aa19-3d41-434f-8c2d-abffdf6d8f39
2026-05-28 03:19:33,403 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/68bd7577-79f1-4e9a-8a44-107cef440e8c
2026-05-28 03:19:33,417 - DEBUG - =>VN ctest-mgmt_vn-43884553 has no policy to be verified
2026-05-28 03:19:33,417 - DEBUG - Verifying the vn in opserver
2026-05-28 03:19:33,417 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-43884553 virtual network link through opserver 10.0.0.133
2026-05-28 03:19:33,418 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-05-28 03:19:33,738 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-05-28 03:19:33,823 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-43884553', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-43884553?flat'}
2026-05-28 03:19:33,823 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-43884553 virtual network link through opserver 10.0.0.41
2026-05-28 03:19:33,823 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-05-28 03:19:34,136 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-05-28 03:19:34,217 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-43884553', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-43884553?flat'}
2026-05-28 03:19:34,217 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-43884553 virtual network link through opserver 10.0.0.131
2026-05-28 03:19:34,217 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-05-28 03:19:34,532 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-05-28 03:19:34,626 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-43884553', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-43884553?flat'}
2026-05-28 03:19:34,626 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-43884553 is found in opserver
2026-05-28 03:19:34,671 - DEBUG - Do not have enough data to verify VN in agent
2026-05-28 03:19:34,682 - DEBUG - VRF ids for VN ctest-mgmt_vn-43884553: {}
2026-05-28 03:19:35,002 - DEBUG - Response for create_network : {'network': {'id': '11f29ac8-93d8-4594-91f0-46a55c3ce188', 'name': 'service-left-vn-25828698', 'tenant_id': 'f7e3aa193d41434f8c2dabffdf6d8f39', 'project_id': 'f7e3aa193d41434f8c2dabffdf6d8f39', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-22565827', 'service-left-vn-25828698'], 'port_security_enabled': True, 'description': ''}}
2026-05-28 03:19:35,322 - DEBUG - Response for create_subnet : {'subnet': {'id': '1020213f-91dd-4a71-badf-81a7361fbbd4', 'name': '', 'tenant_id': 'f7e3aa193d41434f8c2dabffdf6d8f39', 'network_id': '11f29ac8-93d8-4594-91f0-46a55c3ce188', 'ip_version': 4, 'cidr': '217.182.35.192/26', 'allocation_pools': [{'start': '217.182.35.194', 'end': '217.182.35.254'}], 'gateway_ip': '217.182.35.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '217.182.35.194', 'tags': [], 'project_id': 'f7e3aa193d41434f8c2dabffdf6d8f39'}}
2026-05-28 03:19:35,358 - INFO - Created VN service-left-vn-25828698
2026-05-28 03:19:35,380 - DEBUG - VN service-left-vn-25828698 UUID is 11f29ac8-93d8-4594-91f0-46a55c3ce188
2026-05-28 03:19:35,496 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:35,505 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:35,531 - DEBUG - Requesting: http://10.0.0.133:8082/project/f7e3aa19-3d41-434f-8c2d-abffdf6d8f39
2026-05-28 03:19:35,639 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/11f29ac8-93d8-4594-91f0-46a55c3ce188
2026-05-28 03:19:35,656 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/11f29ac8-93d8-4594-91f0-46a55c3ce188
2026-05-28 03:19:35,667 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/e1ff73c5-8595-4398-91a6-054cd890989f
2026-05-28 03:19:35,677 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/e1ff73c5-8595-4398-91a6-054cd890989f
2026-05-28 03:19:35,685 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/1df6e395-34c6-4cf7-8706-2b32a3285a3d
2026-05-28 03:19:35,695 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-28 03:19:35,695 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/11f29ac8-93d8-4594-91f0-46a55c3ce188
2026-05-28 03:19:35,708 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/e1ff73c5-8595-4398-91a6-054cd890989f
2026-05-28 03:19:35,730 - INFO - Verified VN network id 14 for VN 11f29ac8-93d8-4594-91f0-46a55c3ce188
2026-05-28 03:19:35,730 - INFO - Verifications in API Server for VN service-left-vn-25828698 passed
2026-05-28 03:19:35,731 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/11f29ac8-93d8-4594-91f0-46a55c3ce188
2026-05-28 03:19:35,752 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/e1ff73c5-8595-4398-91a6-054cd890989f
2026-05-28 03:19:35,767 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/e1ff73c5-8595-4398-91a6-054cd890989f
2026-05-28 03:19:35,777 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/1df6e395-34c6-4cf7-8706-2b32a3285a3d
2026-05-28 03:19:35,796 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22565827:service-left-vn-25828698', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22565827', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1293266229273314708', 'uuid-lslong': '10515982805941150088'}, 'enable': 'true', 'created': '2026-05-28T03:19:34', 'last-modified': '2026-05-28T03:19:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.565672'}
2026-05-28 03:19:35,813 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-28 03:19:35,821 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22565827:service-left-vn-25828698', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22565827', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1293266229273314708', 'uuid-lslong': '10515982805941150088'}, 'enable': 'true', 'created': '2026-05-28T03:19:34', 'last-modified': '2026-05-28T03:19:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.595105'}
2026-05-28 03:19:35,829 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-28 03:19:35,839 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22565827:service-left-vn-25828698', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22565827', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1293266229273314708', 'uuid-lslong': '10515982805941150088'}, 'enable': 'true', 'created': '2026-05-28T03:19:34', 'last-modified': '2026-05-28T03:19:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.607607'}
2026-05-28 03:19:35,848 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-28 03:19:35,848 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-25828698 passed
2026-05-28 03:19:35,848 - DEBUG - ====Verifying policy data for service-left-vn-25828698 in API_Server ======
2026-05-28 03:19:35,849 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:35,860 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:35,878 - DEBUG - Requesting: http://10.0.0.133:8082/project/f7e3aa19-3d41-434f-8c2d-abffdf6d8f39
2026-05-28 03:19:36,006 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/11f29ac8-93d8-4594-91f0-46a55c3ce188
2026-05-28 03:19:36,024 - DEBUG - =>VN service-left-vn-25828698 has no policy to be verified
2026-05-28 03:19:36,024 - DEBUG - Verifying the vn in opserver
2026-05-28 03:19:36,024 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22565827:service-left-vn-25828698 virtual network link through opserver 10.0.0.133
2026-05-28 03:19:36,024 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-05-28 03:19:36,126 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22565827:service-left-vn-25828698', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22565827:service-left-vn-25828698?flat'}
2026-05-28 03:19:36,127 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22565827:service-left-vn-25828698 virtual network link through opserver 10.0.0.41
2026-05-28 03:19:36,127 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-05-28 03:19:36,209 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22565827:service-left-vn-25828698', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22565827:service-left-vn-25828698?flat'}
2026-05-28 03:19:36,209 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22565827:service-left-vn-25828698 virtual network link through opserver 10.0.0.131
2026-05-28 03:19:36,209 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-05-28 03:19:36,304 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22565827:service-left-vn-25828698', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22565827:service-left-vn-25828698?flat'}
2026-05-28 03:19:36,304 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-22565827:service-left-vn-25828698 is found in opserver
2026-05-28 03:19:36,336 - DEBUG - Do not have enough data to verify VN in agent
2026-05-28 03:19:36,352 - DEBUG - VRF ids for VN service-left-vn-25828698: {}
2026-05-28 03:19:36,784 - DEBUG - Response for create_network : {'network': {'id': 'f389f654-63d4-471c-852e-c3dc10015b1d', 'name': 'service-right-vn-25195515', 'tenant_id': 'f7e3aa193d41434f8c2dabffdf6d8f39', 'project_id': 'f7e3aa193d41434f8c2dabffdf6d8f39', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-22565827', 'service-right-vn-25195515'], 'port_security_enabled': True, 'description': ''}}
2026-05-28 03:19:37,107 - DEBUG - Response for create_subnet : {'subnet': {'id': '10b266e2-b7a1-449a-94f8-d202dca35215', 'name': '', 'tenant_id': 'f7e3aa193d41434f8c2dabffdf6d8f39', 'network_id': 'f389f654-63d4-471c-852e-c3dc10015b1d', 'ip_version': 4, 'cidr': '114.112.29.64/26', 'allocation_pools': [{'start': '114.112.29.66', 'end': '114.112.29.126'}], 'gateway_ip': '114.112.29.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '114.112.29.66', 'tags': [], 'project_id': 'f7e3aa193d41434f8c2dabffdf6d8f39'}}
2026-05-28 03:19:37,137 - INFO - Created VN service-right-vn-25195515
2026-05-28 03:19:37,151 - DEBUG - VN service-right-vn-25195515 UUID is f389f654-63d4-471c-852e-c3dc10015b1d
2026-05-28 03:19:37,273 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:37,284 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:37,299 - DEBUG - Requesting: http://10.0.0.133:8082/project/f7e3aa19-3d41-434f-8c2d-abffdf6d8f39
2026-05-28 03:19:37,406 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/f389f654-63d4-471c-852e-c3dc10015b1d
2026-05-28 03:19:37,437 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/f389f654-63d4-471c-852e-c3dc10015b1d
2026-05-28 03:19:37,455 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/f79e379d-a12a-421a-8cdc-3bbff8df4d48
2026-05-28 03:19:37,475 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/f79e379d-a12a-421a-8cdc-3bbff8df4d48
2026-05-28 03:19:37,487 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/368325ba-6b22-4e84-a51f-ffd4f9980f32
2026-05-28 03:19:37,497 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-28 03:19:37,497 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/f389f654-63d4-471c-852e-c3dc10015b1d
2026-05-28 03:19:37,518 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/f79e379d-a12a-421a-8cdc-3bbff8df4d48
2026-05-28 03:19:37,546 - INFO - Verified VN network id 15 for VN f389f654-63d4-471c-852e-c3dc10015b1d
2026-05-28 03:19:37,546 - INFO - Verifications in API Server for VN service-right-vn-25195515 passed
2026-05-28 03:19:37,546 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/f389f654-63d4-471c-852e-c3dc10015b1d
2026-05-28 03:19:37,566 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/f79e379d-a12a-421a-8cdc-3bbff8df4d48
2026-05-28 03:19:37,579 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/f79e379d-a12a-421a-8cdc-3bbff8df4d48
2026-05-28 03:19:37,589 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/368325ba-6b22-4e84-a51f-ffd4f9980f32
2026-05-28 03:19:37,606 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22565827:service-right-vn-25195515', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22565827', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17548828265338390300', 'uuid-lslong': '9596823205901851421'}, 'enable': 'true', 'created': '2026-05-28T03:19:36', 'last-modified': '2026-05-28T03:19:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.572441'}
2026-05-28 03:19:37,620 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-28 03:19:37,627 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22565827:service-right-vn-25195515', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22565827', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17548828265338390300', 'uuid-lslong': '9596823205901851421'}, 'enable': 'true', 'created': '2026-05-28T03:19:36', 'last-modified': '2026-05-28T03:19:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.598561'}
2026-05-28 03:19:37,635 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-28 03:19:37,644 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22565827:service-right-vn-25195515', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22565827', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17548828265338390300', 'uuid-lslong': '9596823205901851421'}, 'enable': 'true', 'created': '2026-05-28T03:19:36', 'last-modified': '2026-05-28T03:19:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.617536'}
2026-05-28 03:19:37,653 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-28 03:19:37,654 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-25195515 passed
2026-05-28 03:19:37,654 - DEBUG - ====Verifying policy data for service-right-vn-25195515 in API_Server ======
2026-05-28 03:19:37,654 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:37,666 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:37,686 - DEBUG - Requesting: http://10.0.0.133:8082/project/f7e3aa19-3d41-434f-8c2d-abffdf6d8f39
2026-05-28 03:19:37,834 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/f389f654-63d4-471c-852e-c3dc10015b1d
2026-05-28 03:19:37,852 - DEBUG - =>VN service-right-vn-25195515 has no policy to be verified
2026-05-28 03:19:37,852 - DEBUG - Verifying the vn in opserver
2026-05-28 03:19:37,852 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22565827:service-right-vn-25195515 virtual network link through opserver 10.0.0.133
2026-05-28 03:19:37,852 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-05-28 03:19:37,957 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22565827:service-right-vn-25195515', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22565827:service-right-vn-25195515?flat'}
2026-05-28 03:19:37,957 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22565827:service-right-vn-25195515 virtual network link through opserver 10.0.0.41
2026-05-28 03:19:37,957 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-05-28 03:19:38,067 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22565827:service-right-vn-25195515', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22565827:service-right-vn-25195515?flat'}
2026-05-28 03:19:38,067 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22565827:service-right-vn-25195515 virtual network link through opserver 10.0.0.131
2026-05-28 03:19:38,067 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-05-28 03:19:38,154 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22565827:service-right-vn-25195515', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22565827:service-right-vn-25195515?flat'}
2026-05-28 03:19:38,154 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-22565827:service-right-vn-25195515 is found in opserver
2026-05-28 03:19:38,187 - DEBUG - Do not have enough data to verify VN in agent
2026-05-28 03:19:38,204 - DEBUG - VRF ids for VN service-right-vn-25195515: {}
2026-05-28 03:19:38,401 - DEBUG - Services list from nova: [, , , ]
2026-05-28 03:19:39,956 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5841-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5841-1)
2026-05-28 03:19:41,878 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5841-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5841-2)
2026-05-28 03:19:41,878 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-67907691']
2026-05-28 03:19:42,197 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-67907691'] created succesfully
2026-05-28 03:19:42,727 - DEBUG - Image by name tiny_nat_fw not found
2026-05-28 03:19:42,727 - DEBUG - Installing image tiny_nat_fw
2026-05-28 03:19:42,727 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-05-28 03:19:42,728 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-28 03:19:42,728 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-28 03:19:42,728 - DEBUG - Unzip image
2026-05-28 03:19:42,728 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-28 03:19:42,762 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-05-28 03:19:42,763 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-67907691']
2026-05-28 03:19:42,865 - INFO - Service template: ['default-domain', 'ctest-service_template_1-67907691'] deleted successfully.
2026-05-28 03:19:42,865 - INFO - Skip interface_detach for VM ctest-right_vm-36334006 in state BUILD
2026-05-28 03:19:42,865 - INFO - Deleting VM ctest-right_vm-36334006
2026-05-28 03:19:42,938 - ERROR - VM ctest-right_vm-36334006 has failed to come up
2026-05-28 03:19:42,940 - ERROR - Nova failed to get host of the VM
2026-05-28 03:19:42,941 - ERROR - VM ctest-right_vm-36334006 has failed to come up
2026-05-28 03:19:42,941 - ERROR - Nova failed to get host of the VM
2026-05-28 03:19:43,070 - INFO - Skip interface_detach for VM ctest-left_vm-90001732 in state BUILD
2026-05-28 03:19:43,071 - INFO - Deleting VM ctest-left_vm-90001732
2026-05-28 03:19:43,071 - ERROR - VM ctest-left_vm-90001732 has failed to come up
2026-05-28 03:19:43,072 - ERROR - Nova failed to get host of the VM
2026-05-28 03:19:43,072 - ERROR - VM ctest-left_vm-90001732 has failed to come up
2026-05-28 03:19:43,073 - ERROR - Nova failed to get host of the VM
2026-05-28 03:19:43,161 - INFO - Deleting VN service-right-vn-25195515
2026-05-28 03:19:43,215 - DEBUG - VN f389f654-63d4-471c-852e-c3dc10015b1d still in use: Unable to complete operation on network f389f654-63d4-471c-852e-c3dc10015b1d. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-eb217668-a3f3-4f55-9701-bf3c79dc7158']
2026-05-28 03:19:43,215 - WARNING - Deleting VN service-right-vn-25195515 failed..Will retry
2026-05-28 03:19:45,554 - DEBUG - Response for deleting network ()
2026-05-28 03:19:45,554 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/f79e379d-a12a-421a-8cdc-3bbff8df4d48
2026-05-28 03:19:45,565 - DEBUG - Response Code: 404
2026-05-28 03:19:45,565 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:45,583 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:45,612 - DEBUG - Requesting: http://10.0.0.133:8082/project/f7e3aa19-3d41-434f-8c2d-abffdf6d8f39
2026-05-28 03:19:45,722 - INFO - Validated that VN service-right-vn-25195515 is not found in API Server
2026-05-28 03:19:45,746 - DEBUG - VN service-right-vn-25195515 is not present in Agent 10.0.0.48
2026-05-28 03:19:45,761 - DEBUG - VN service-right-vn-25195515 is not present in Agent 10.0.0.49
2026-05-28 03:19:45,763 - INFO - Validated that VN service-right-vn-25195515 is not in any agent
2026-05-28 03:19:45,817 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-25195515 info
2026-05-28 03:19:45,817 - INFO - Deleting VN service-left-vn-25828698
2026-05-28 03:19:46,063 - DEBUG - Response for deleting network ()
2026-05-28 03:19:46,063 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/e1ff73c5-8595-4398-91a6-054cd890989f
2026-05-28 03:19:46,072 - DEBUG - Response Code: 404
2026-05-28 03:19:46,073 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:46,085 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:46,141 - DEBUG - Requesting: http://10.0.0.133:8082/project/f7e3aa19-3d41-434f-8c2d-abffdf6d8f39
2026-05-28 03:19:46,252 - INFO - Validated that VN service-left-vn-25828698 is not found in API Server
2026-05-28 03:19:46,264 - DEBUG - VN service-left-vn-25828698 is not present in Agent 10.0.0.48
2026-05-28 03:19:46,275 - DEBUG - VN service-left-vn-25828698 is not present in Agent 10.0.0.49
2026-05-28 03:19:46,275 - INFO - Validated that VN service-left-vn-25828698 is not in any agent
2026-05-28 03:19:46,319 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-25828698 info
2026-05-28 03:19:46,319 - INFO - Deleting VN ctest-mgmt_vn-43884553
2026-05-28 03:19:46,494 - DEBUG - Response for deleting network ()
2026-05-28 03:19:46,494 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/3156e72d-5f6a-4ada-b99b-ee6ad607049b
2026-05-28 03:19:46,506 - DEBUG - Response Code: 404
2026-05-28 03:19:46,506 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:46,528 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:46,557 - DEBUG - Requesting: http://10.0.0.133:8082/project/f7e3aa19-3d41-434f-8c2d-abffdf6d8f39
2026-05-28 03:19:46,672 - INFO - Validated that VN ctest-mgmt_vn-43884553 is not found in API Server
2026-05-28 03:19:46,697 - DEBUG - VN ctest-mgmt_vn-43884553 is not present in Agent 10.0.0.48
2026-05-28 03:19:46,714 - DEBUG - VN ctest-mgmt_vn-43884553 is not present in Agent 10.0.0.49
2026-05-28 03:19:46,714 - INFO - Validated that VN ctest-mgmt_vn-43884553 is not in any agent
2026-05-28 03:19:46,771 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-43884553 info
2026-05-28 03:19:48,109 - DEBUG - No XMPP flaps were noticed during the test
2026-05-28 03:19:48,109 - INFO -
2026-05-28 03:19:48,109 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:19]
2026-05-28 03:19:48,109 - INFO - --------------------------------------------------------------------------------
2026-05-28 03:19:48,114 - INFO - ================================================================================
2026-05-28 03:19:48,114 - INFO - STARTING TEST : test_svc_in_network_datapath
2026-05-28 03:19:49,418 - DEBUG - Nothing to compare xmpp stats {'10.0.0.48': {'10.20.0.252': '1', '10.20.0.249': '0'}, '10.0.0.49': {'10.20.0.249': '0', '10.20.0.19': '0'}} with
2026-05-28 03:19:49,418 - INFO - Initial checks done. Running the testcase now
2026-05-28 03:19:49,418 - INFO -
2026-05-28 03:19:49,798 - DEBUG - Response for create_network : {'network': {'id': '4b7f047d-932a-49c8-8625-355de6abf931', 'name': 'ctest-mgmt_vn-19715146', 'tenant_id': 'f7e3aa193d41434f8c2dabffdf6d8f39', 'project_id': 'f7e3aa193d41434f8c2dabffdf6d8f39', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-22565827', 'ctest-mgmt_vn-19715146'], 'port_security_enabled': True, 'description': ''}}
2026-05-28 03:19:50,032 - DEBUG - Response for create_subnet : {'subnet': {'id': '608914a0-b936-437b-b3b1-258e35d92e14', 'name': '', 'tenant_id': 'f7e3aa193d41434f8c2dabffdf6d8f39', 'network_id': '4b7f047d-932a-49c8-8625-355de6abf931', 'ip_version': 4, 'cidr': '143.31.61.64/26', 'allocation_pools': [{'start': '143.31.61.66', 'end': '143.31.61.126'}], 'gateway_ip': '143.31.61.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '143.31.61.66', 'tags': [], 'project_id': 'f7e3aa193d41434f8c2dabffdf6d8f39'}}
2026-05-28 03:19:50,057 - INFO - Created VN ctest-mgmt_vn-19715146
2026-05-28 03:19:50,071 - DEBUG - VN ctest-mgmt_vn-19715146 UUID is 4b7f047d-932a-49c8-8625-355de6abf931
2026-05-28 03:19:50,161 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:50,169 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:50,182 - DEBUG - Requesting: http://10.0.0.133:8082/project/f7e3aa19-3d41-434f-8c2d-abffdf6d8f39
2026-05-28 03:19:50,293 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/4b7f047d-932a-49c8-8625-355de6abf931
2026-05-28 03:19:50,310 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/4b7f047d-932a-49c8-8625-355de6abf931
2026-05-28 03:19:50,323 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/c420e000-45f7-4112-b7ea-caba58069821
2026-05-28 03:19:50,333 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/c420e000-45f7-4112-b7ea-caba58069821
2026-05-28 03:19:50,342 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/54aa0c98-96d7-42d4-bff2-25cdbef90cdc
2026-05-28 03:19:50,352 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-28 03:19:50,352 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/4b7f047d-932a-49c8-8625-355de6abf931
2026-05-28 03:19:50,363 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/c420e000-45f7-4112-b7ea-caba58069821
2026-05-28 03:19:50,384 - INFO - Verified VN network id 13 for VN 4b7f047d-932a-49c8-8625-355de6abf931
2026-05-28 03:19:50,384 - INFO - Verifications in API Server for VN ctest-mgmt_vn-19715146 passed
2026-05-28 03:19:50,384 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/4b7f047d-932a-49c8-8625-355de6abf931
2026-05-28 03:19:50,397 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/c420e000-45f7-4112-b7ea-caba58069821
2026-05-28 03:19:50,407 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/c420e000-45f7-4112-b7ea-caba58069821
2026-05-28 03:19:50,417 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/54aa0c98-96d7-42d4-bff2-25cdbef90cdc
2026-05-28 03:19:50,431 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-19715146', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22565827', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5440071812273293768', 'uuid-lslong': '9666190852638898481'}, 'enable': 'true', 'created': '2026-05-28T03:19:49', 'last-modified': '2026-05-28T03:19:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.457656'}
2026-05-28 03:19:50,440 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-28 03:19:50,446 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-19715146', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22565827', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5440071812273293768', 'uuid-lslong': '9666190852638898481'}, 'enable': 'true', 'created': '2026-05-28T03:19:49', 'last-modified': '2026-05-28T03:19:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.478335'}
2026-05-28 03:19:50,454 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-28 03:19:50,461 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-19715146', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22565827', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5440071812273293768', 'uuid-lslong': '9666190852638898481'}, 'enable': 'true', 'created': '2026-05-28T03:19:49', 'last-modified': '2026-05-28T03:19:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.487261'}
2026-05-28 03:19:50,469 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-28 03:19:50,469 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-19715146 passed
2026-05-28 03:19:50,470 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-19715146 in API_Server ======
2026-05-28 03:19:50,470 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:50,477 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:50,494 - DEBUG - Requesting: http://10.0.0.133:8082/project/f7e3aa19-3d41-434f-8c2d-abffdf6d8f39
2026-05-28 03:19:50,598 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/4b7f047d-932a-49c8-8625-355de6abf931
2026-05-28 03:19:50,614 - DEBUG - =>VN ctest-mgmt_vn-19715146 has no policy to be verified
2026-05-28 03:19:50,614 - DEBUG - Verifying the vn in opserver
2026-05-28 03:19:50,614 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-19715146 virtual network link through opserver 10.0.0.133
2026-05-28 03:19:50,615 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-05-28 03:19:50,631 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-19715146', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-19715146?flat'}
2026-05-28 03:19:50,632 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-19715146 virtual network link through opserver 10.0.0.41
2026-05-28 03:19:50,632 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-05-28 03:19:50,647 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-19715146', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-19715146?flat'}
2026-05-28 03:19:50,647 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-19715146 virtual network link through opserver 10.0.0.131
2026-05-28 03:19:50,647 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-05-28 03:19:50,662 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-19715146', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-19715146?flat'}
2026-05-28 03:19:50,662 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-22565827:ctest-mgmt_vn-19715146 is found in opserver
2026-05-28 03:19:50,689 - DEBUG - Do not have enough data to verify VN in agent
2026-05-28 03:19:50,704 - DEBUG - VRF ids for VN ctest-mgmt_vn-19715146: {}
2026-05-28 03:19:50,996 - DEBUG - Response for create_network : {'network': {'id': 'f0bdb2c5-df6c-4d54-9e77-185a6bda2e34', 'name': 'ctest-left_vn-05807489', 'tenant_id': 'f7e3aa193d41434f8c2dabffdf6d8f39', 'project_id': 'f7e3aa193d41434f8c2dabffdf6d8f39', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-22565827', 'ctest-left_vn-05807489'], 'port_security_enabled': True, 'description': ''}}
2026-05-28 03:19:51,280 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f39c0f83-655d-4989-a2cc-6de758af7a50', 'name': '', 'tenant_id': 'f7e3aa193d41434f8c2dabffdf6d8f39', 'network_id': 'f0bdb2c5-df6c-4d54-9e77-185a6bda2e34', 'ip_version': 4, 'cidr': '88.228.253.64/26', 'allocation_pools': [{'start': '88.228.253.66', 'end': '88.228.253.126'}], 'gateway_ip': '88.228.253.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '88.228.253.66', 'tags': [], 'project_id': 'f7e3aa193d41434f8c2dabffdf6d8f39'}}
2026-05-28 03:19:51,308 - INFO - Created VN ctest-left_vn-05807489
2026-05-28 03:19:51,327 - DEBUG - VN ctest-left_vn-05807489 UUID is f0bdb2c5-df6c-4d54-9e77-185a6bda2e34
2026-05-28 03:19:51,414 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:51,426 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:51,450 - DEBUG - Requesting: http://10.0.0.133:8082/project/f7e3aa19-3d41-434f-8c2d-abffdf6d8f39
2026-05-28 03:19:51,569 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/f0bdb2c5-df6c-4d54-9e77-185a6bda2e34
2026-05-28 03:19:51,587 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/f0bdb2c5-df6c-4d54-9e77-185a6bda2e34
2026-05-28 03:19:51,601 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/cdc373c7-9e02-48a4-b07f-59a119a883f3
2026-05-28 03:19:51,614 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/cdc373c7-9e02-48a4-b07f-59a119a883f3
2026-05-28 03:19:51,627 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/0c6f19ec-7c8e-4729-842e-6ffdfa18ec5c
2026-05-28 03:19:51,637 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-28 03:19:51,637 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/f0bdb2c5-df6c-4d54-9e77-185a6bda2e34
2026-05-28 03:19:51,649 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/cdc373c7-9e02-48a4-b07f-59a119a883f3
2026-05-28 03:19:51,669 - INFO - Verified VN network id 14 for VN f0bdb2c5-df6c-4d54-9e77-185a6bda2e34
2026-05-28 03:19:51,669 - INFO - Verifications in API Server for VN ctest-left_vn-05807489 passed
2026-05-28 03:19:51,669 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/f0bdb2c5-df6c-4d54-9e77-185a6bda2e34
2026-05-28 03:19:51,682 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/cdc373c7-9e02-48a4-b07f-59a119a883f3
2026-05-28 03:19:51,694 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/cdc373c7-9e02-48a4-b07f-59a119a883f3
2026-05-28 03:19:51,707 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/0c6f19ec-7c8e-4729-842e-6ffdfa18ec5c
2026-05-28 03:19:51,731 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22565827:ctest-left_vn-05807489', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22565827', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17347217902627736916', 'uuid-lslong': '11418622156856766004'}, 'enable': 'true', 'created': '2026-05-28T03:19:50', 'last-modified': '2026-05-28T03:19:51', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.528335'}
2026-05-28 03:19:51,742 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-28 03:19:51,751 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22565827:ctest-left_vn-05807489', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22565827', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17347217902627736916', 'uuid-lslong': '11418622156856766004'}, 'enable': 'true', 'created': '2026-05-28T03:19:50', 'last-modified': '2026-05-28T03:19:51', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.549675'}
2026-05-28 03:19:51,759 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-28 03:19:51,767 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22565827:ctest-left_vn-05807489', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22565827', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17347217902627736916', 'uuid-lslong': '11418622156856766004'}, 'enable': 'true', 'created': '2026-05-28T03:19:50', 'last-modified': '2026-05-28T03:19:51', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.566526'}
2026-05-28 03:19:51,776 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-28 03:19:51,777 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-05807489 passed
2026-05-28 03:19:51,777 - DEBUG - ====Verifying policy data for ctest-left_vn-05807489 in API_Server ======
2026-05-28 03:19:51,777 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:51,788 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:51,805 - DEBUG - Requesting: http://10.0.0.133:8082/project/f7e3aa19-3d41-434f-8c2d-abffdf6d8f39
2026-05-28 03:19:51,944 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/f0bdb2c5-df6c-4d54-9e77-185a6bda2e34
2026-05-28 03:19:51,958 - DEBUG - =>VN ctest-left_vn-05807489 has no policy to be verified
2026-05-28 03:19:51,958 - DEBUG - Verifying the vn in opserver
2026-05-28 03:19:51,958 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22565827:ctest-left_vn-05807489 virtual network link through opserver 10.0.0.133
2026-05-28 03:19:51,958 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-05-28 03:19:51,977 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22565827:ctest-left_vn-05807489', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22565827:ctest-left_vn-05807489?flat'}
2026-05-28 03:19:51,977 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22565827:ctest-left_vn-05807489 virtual network link through opserver 10.0.0.41
2026-05-28 03:19:51,977 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-05-28 03:19:51,997 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22565827:ctest-left_vn-05807489', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22565827:ctest-left_vn-05807489?flat'}
2026-05-28 03:19:51,997 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22565827:ctest-left_vn-05807489 virtual network link through opserver 10.0.0.131
2026-05-28 03:19:51,997 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-05-28 03:19:52,016 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22565827:ctest-left_vn-05807489', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22565827:ctest-left_vn-05807489?flat'}
2026-05-28 03:19:52,016 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-22565827:ctest-left_vn-05807489 is found in opserver
2026-05-28 03:19:52,052 - DEBUG - Do not have enough data to verify VN in agent
2026-05-28 03:19:52,068 - DEBUG - VRF ids for VN ctest-left_vn-05807489: {}
2026-05-28 03:19:52,506 - DEBUG - Response for create_network : {'network': {'id': '1e1ddd75-5606-4ad2-889d-d9ebff241dca', 'name': 'ctest-right_vn-14538588', 'tenant_id': 'f7e3aa193d41434f8c2dabffdf6d8f39', 'project_id': 'f7e3aa193d41434f8c2dabffdf6d8f39', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-22565827', 'ctest-right_vn-14538588'], 'port_security_enabled': True, 'description': ''}}
2026-05-28 03:19:52,779 - DEBUG - Response for create_subnet : {'subnet': {'id': '137530fe-0142-4804-af9b-98278da2701f', 'name': '', 'tenant_id': 'f7e3aa193d41434f8c2dabffdf6d8f39', 'network_id': '1e1ddd75-5606-4ad2-889d-d9ebff241dca', 'ip_version': 4, 'cidr': '27.235.197.192/26', 'allocation_pools': [{'start': '27.235.197.194', 'end': '27.235.197.254'}], 'gateway_ip': '27.235.197.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '27.235.197.194', 'tags': [], 'project_id': 'f7e3aa193d41434f8c2dabffdf6d8f39'}}
2026-05-28 03:19:52,813 - INFO - Created VN ctest-right_vn-14538588
2026-05-28 03:19:52,837 - DEBUG - VN ctest-right_vn-14538588 UUID is 1e1ddd75-5606-4ad2-889d-d9ebff241dca
2026-05-28 03:19:52,991 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:53,000 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:53,023 - DEBUG - Requesting: http://10.0.0.133:8082/project/f7e3aa19-3d41-434f-8c2d-abffdf6d8f39
2026-05-28 03:19:53,142 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/1e1ddd75-5606-4ad2-889d-d9ebff241dca
2026-05-28 03:19:53,165 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/1e1ddd75-5606-4ad2-889d-d9ebff241dca
2026-05-28 03:19:53,183 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/1d757cc5-23f5-4eac-95f7-6128bebb7b90
2026-05-28 03:19:53,207 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/1d757cc5-23f5-4eac-95f7-6128bebb7b90
2026-05-28 03:19:53,221 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/eeef47c3-6d77-4505-b298-dfa473aa24a0
2026-05-28 03:19:53,235 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-28 03:19:53,235 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/1e1ddd75-5606-4ad2-889d-d9ebff241dca
2026-05-28 03:19:53,249 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/1d757cc5-23f5-4eac-95f7-6128bebb7b90
2026-05-28 03:19:53,270 - INFO - Verified VN network id 15 for VN 1e1ddd75-5606-4ad2-889d-d9ebff241dca
2026-05-28 03:19:53,271 - INFO - Verifications in API Server for VN ctest-right_vn-14538588 passed
2026-05-28 03:19:53,271 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/1e1ddd75-5606-4ad2-889d-d9ebff241dca
2026-05-28 03:19:53,283 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/1d757cc5-23f5-4eac-95f7-6128bebb7b90
2026-05-28 03:19:53,293 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/1d757cc5-23f5-4eac-95f7-6128bebb7b90
2026-05-28 03:19:53,304 - DEBUG - Requesting: http://10.0.0.133:8082/route-target/eeef47c3-6d77-4505-b298-dfa473aa24a0
2026-05-28 03:19:53,322 - DEBUG - Control-node 10.0.0.133 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22565827:ctest-right_vn-14538588', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22565827', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2170134091486612178', 'uuid-lslong': '9844263968122871242'}, 'enable': 'true', 'created': '2026-05-28T03:19:52', 'last-modified': '2026-05-28T03:19:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.611091'}
2026-05-28 03:19:53,331 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-28 03:19:53,338 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22565827:ctest-right_vn-14538588', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22565827', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2170134091486612178', 'uuid-lslong': '9844263968122871242'}, 'enable': 'true', 'created': '2026-05-28T03:19:52', 'last-modified': '2026-05-28T03:19:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.621567'}
2026-05-28 03:19:53,346 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-28 03:19:53,354 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22565827:ctest-right_vn-14538588', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22565827', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2170134091486612178', 'uuid-lslong': '9844263968122871242'}, 'enable': 'true', 'created': '2026-05-28T03:19:52', 'last-modified': '2026-05-28T03:19:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.643090'}
2026-05-28 03:19:53,361 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-28 03:19:53,361 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-14538588 passed
2026-05-28 03:19:53,361 - DEBUG - ====Verifying policy data for ctest-right_vn-14538588 in API_Server ======
2026-05-28 03:19:53,361 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:19:53,369 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:19:53,385 - DEBUG - Requesting: http://10.0.0.133:8082/project/f7e3aa19-3d41-434f-8c2d-abffdf6d8f39
2026-05-28 03:19:53,496 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-network/1e1ddd75-5606-4ad2-889d-d9ebff241dca
2026-05-28 03:19:53,516 - DEBUG - =>VN ctest-right_vn-14538588 has no policy to be verified
2026-05-28 03:19:53,516 - DEBUG - Verifying the vn in opserver
2026-05-28 03:19:53,516 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22565827:ctest-right_vn-14538588 virtual network link through opserver 10.0.0.133
2026-05-28 03:19:53,516 - DEBUG - Requesting: http://10.0.0.133:8081/analytics/uves/virtual-networks
2026-05-28 03:19:53,533 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22565827:ctest-right_vn-14538588', 'href': 'http://10.0.0.133:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22565827:ctest-right_vn-14538588?flat'}
2026-05-28 03:19:53,533 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22565827:ctest-right_vn-14538588 virtual network link through opserver 10.0.0.41
2026-05-28 03:19:53,533 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-05-28 03:19:53,547 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22565827:ctest-right_vn-14538588', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22565827:ctest-right_vn-14538588?flat'}
2026-05-28 03:19:53,548 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22565827:ctest-right_vn-14538588 virtual network link through opserver 10.0.0.131
2026-05-28 03:19:53,548 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2026-05-28 03:19:53,564 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22565827:ctest-right_vn-14538588', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22565827:ctest-right_vn-14538588?flat'}
2026-05-28 03:19:53,564 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-22565827:ctest-right_vn-14538588 is found in opserver
2026-05-28 03:19:53,594 - DEBUG - Do not have enough data to verify VN in agent
2026-05-28 03:19:53,611 - DEBUG - VRF ids for VN ctest-right_vn-14538588: {}
2026-05-28 03:19:55,133 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5841-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5841-2)
2026-05-28 03:19:56,831 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5841-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5841-1)
2026-05-28 03:19:56,831 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-23862224']
2026-05-28 03:19:57,150 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-23862224'] created succesfully
2026-05-28 03:19:57,613 - DEBUG - Image by name tiny_nat_fw not found
2026-05-28 03:19:57,613 - DEBUG - Installing image tiny_nat_fw
2026-05-28 03:19:57,613 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-05-28 03:19:57,613 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-28 03:19:57,613 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-28 03:19:57,614 - DEBUG - Unzip image
2026-05-28 03:19:57,614 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-28 03:19:57,651 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-05-28 03:19:57,652 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-23862224']
2026-05-28 03:19:57,773 - INFO - Service template: ['default-domain', 'ctest-service_template_1-23862224'] deleted successfully.
2026-05-28 03:19:57,774 - INFO - Skip interface_detach for VM ctest-right_vm-47265396 in state BUILD
2026-05-28 03:19:57,775 - INFO - Deleting VM ctest-right_vm-47265396
2026-05-28 03:19:57,776 - ERROR - VM ctest-right_vm-47265396 has failed to come up
2026-05-28 03:19:57,776 - ERROR - Nova failed to get host of the VM
2026-05-28 03:19:57,776 - ERROR - VM ctest-right_vm-47265396 has failed to come up
2026-05-28 03:19:57,776 - ERROR - Nova failed to get host of the VM
2026-05-28 03:19:57,945 - INFO - Skip interface_detach for VM ctest-left_vm-12531602 in state BUILD
2026-05-28 03:19:57,945 - INFO - Deleting VM ctest-left_vm-12531602
2026-05-28 03:19:57,945 - ERROR - VM ctest-left_vm-12531602 has failed to come up
2026-05-28 03:19:57,945 - ERROR - Nova failed to get host of the VM
2026-05-28 03:19:57,945 - ERROR - VM ctest-left_vm-12531602 has failed to come up
2026-05-28 03:19:57,945 - ERROR - Nova failed to get host of the VM
2026-05-28 03:19:58,056 - INFO - Deleting VN ctest-right_vn-14538588
2026-05-28 03:19:58,136 - DEBUG - VN 1e1ddd75-5606-4ad2-889d-d9ebff241dca still in use: Unable to complete operation on network 1e1ddd75-5606-4ad2-889d-d9ebff241dca. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-95cc2bce-5b40-4885-ab7d-b88906c5e933']
2026-05-28 03:19:58,137 - WARNING - Deleting VN ctest-right_vn-14538588 failed..Will retry
2026-05-28 03:20:00,365 - DEBUG - Response for deleting network ()
2026-05-28 03:20:00,365 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/1d757cc5-23f5-4eac-95f7-6128bebb7b90
2026-05-28 03:20:00,374 - DEBUG - Response Code: 404
2026-05-28 03:20:00,374 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:20:00,395 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:20:00,418 - DEBUG - Requesting: http://10.0.0.133:8082/project/f7e3aa19-3d41-434f-8c2d-abffdf6d8f39
2026-05-28 03:20:00,548 - INFO - Validated that VN ctest-right_vn-14538588 is not found in API Server
2026-05-28 03:20:00,562 - DEBUG - VN ctest-right_vn-14538588 is not present in Agent 10.0.0.48
2026-05-28 03:20:00,579 - DEBUG - VN ctest-right_vn-14538588 is not present in Agent 10.0.0.49
2026-05-28 03:20:00,579 - INFO - Validated that VN ctest-right_vn-14538588 is not in any agent
2026-05-28 03:20:00,634 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-14538588 info
2026-05-28 03:20:00,634 - INFO - Deleting VN ctest-left_vn-05807489
2026-05-28 03:20:00,886 - DEBUG - Response for deleting network ()
2026-05-28 03:20:00,886 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/cdc373c7-9e02-48a4-b07f-59a119a883f3
2026-05-28 03:20:00,898 - DEBUG - Response Code: 404
2026-05-28 03:20:00,898 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:20:00,912 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:20:00,941 - DEBUG - Requesting: http://10.0.0.133:8082/project/f7e3aa19-3d41-434f-8c2d-abffdf6d8f39
2026-05-28 03:20:01,064 - INFO - Validated that VN ctest-left_vn-05807489 is not found in API Server
2026-05-28 03:20:01,082 - DEBUG - VN ctest-left_vn-05807489 is not present in Agent 10.0.0.48
2026-05-28 03:20:01,108 - DEBUG - VN ctest-left_vn-05807489 is not present in Agent 10.0.0.49
2026-05-28 03:20:01,108 - INFO - Validated that VN ctest-left_vn-05807489 is not in any agent
2026-05-28 03:20:01,164 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-05807489 info
2026-05-28 03:20:01,164 - INFO - Deleting VN ctest-mgmt_vn-19715146
2026-05-28 03:20:01,429 - DEBUG - Response for deleting network ()
2026-05-28 03:20:01,429 - DEBUG - Requesting: http://10.0.0.133:8082/routing-instance/c420e000-45f7-4112-b7ea-caba58069821
2026-05-28 03:20:01,450 - DEBUG - Response Code: 404
2026-05-28 03:20:01,450 - DEBUG - Requesting: http://10.0.0.133:8082/domains
2026-05-28 03:20:01,466 - DEBUG - Requesting: http://10.0.0.133:8082/domain/b78f3d96-9484-4108-bfa1-c06500362770
2026-05-28 03:20:01,491 - DEBUG - Requesting: http://10.0.0.133:8082/project/f7e3aa19-3d41-434f-8c2d-abffdf6d8f39
2026-05-28 03:20:01,624 - INFO - Validated that VN ctest-mgmt_vn-19715146 is not found in API Server
2026-05-28 03:20:01,639 - DEBUG - VN ctest-mgmt_vn-19715146 is not present in Agent 10.0.0.48
2026-05-28 03:20:01,654 - DEBUG - VN ctest-mgmt_vn-19715146 is not present in Agent 10.0.0.49
2026-05-28 03:20:01,654 - INFO - Validated that VN ctest-mgmt_vn-19715146 is not in any agent
2026-05-28 03:20:01,710 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-19715146 info
2026-05-28 03:20:03,052 - DEBUG - No XMPP flaps were noticed during the test
2026-05-28 03:20:03,053 - INFO -
2026-05-28 03:20:03,053 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:15]
2026-05-28 03:20:03,053 - INFO - --------------------------------------------------------------------------------
2026-05-28 03:20:04,536 - INFO - Deleted project: ctest-TestSvcRegr-22565827, ID : f7e3aa19-3d41-434f-8c2d-abffdf6d8f39