]) created on node: (an-jenkins-deploy-platform-ansible-os-6324-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6324-2)
2026-09-28 03:49:47,509 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-01034448']
2026-09-28 03:49:47,844 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-01034448'] created succesfully
2026-09-28 03:49:48,192 - DEBUG - Image by name tiny_nat_fw not found
2026-09-28 03:49:48,192 - DEBUG - Installing image tiny_nat_fw
2026-09-28 03:49:48,192 - 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-09-28 03:49:48,193 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-09-28 03:49:48,193 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-09-28 03:49:48,218 - 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-09-28 03:49:48,375 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-09-28 03:49:48,375 - DEBUG - Unzip image
2026-09-28 03:49:48,375 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-09-28 03:49:48,403 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-09-28 03:49:48,403 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-01034448']
2026-09-28 03:49:48,509 - INFO - Service template: ['default-domain', 'ctest-service_template_1-01034448'] deleted successfully.
2026-09-28 03:49:48,509 - INFO - Skip interface_detach for VM ctest-right_vm-88976195 in state BUILD
2026-09-28 03:49:48,510 - INFO - Deleting VM ctest-right_vm-88976195
2026-09-28 03:49:48,558 - ERROR - VM ctest-right_vm-88976195 has failed to come up
2026-09-28 03:49:48,558 - ERROR - Nova failed to get host of the VM
2026-09-28 03:49:48,559 - ERROR - VM ctest-right_vm-88976195 has failed to come up
2026-09-28 03:49:48,559 - ERROR - Nova failed to get host of the VM
2026-09-28 03:49:48,843 - INFO - Skip interface_detach for VM ctest-left_vm-66291061 in state BUILD
2026-09-28 03:49:48,844 - INFO - Deleting VM ctest-left_vm-66291061
2026-09-28 03:49:48,844 - ERROR - VM ctest-left_vm-66291061 has failed to come up
2026-09-28 03:49:48,844 - ERROR - Nova failed to get host of the VM
2026-09-28 03:49:48,844 - ERROR - VM ctest-left_vm-66291061 has failed to come up
2026-09-28 03:49:48,844 - ERROR - Nova failed to get host of the VM
2026-09-28 03:49:48,958 - INFO - Deleting VN ctest-right_vn-21673000
2026-09-28 03:49:49,163 - DEBUG - Response for deleting network ()
2026-09-28 03:49:49,163 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/5396cb02-d989-4593-bfc3-c0517de4e967
2026-09-28 03:49:49,177 - DEBUG - Response Code: 404
2026-09-28 03:49:49,178 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:49:49,198 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:49:49,221 - DEBUG - Requesting: http://10.0.0.176:8082/project/15f9ffcd-103e-45bc-93c9-8b5281a2473a
2026-09-28 03:49:49,342 - INFO - Validated that VN ctest-right_vn-21673000 is not found in API Server
2026-09-28 03:49:49,359 - DEBUG - VN ctest-right_vn-21673000 is not present in Agent 10.0.0.38
2026-09-28 03:49:49,382 - DEBUG - VN ctest-right_vn-21673000 is not present in Agent 10.0.0.162
2026-09-28 03:49:49,382 - INFO - Validated that VN ctest-right_vn-21673000 is not in any agent
2026-09-28 03:49:49,427 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-21673000 info
2026-09-28 03:49:49,427 - INFO - Deleting VN ctest-left_vn-15643881
2026-09-28 03:49:49,656 - DEBUG - Response for deleting network ()
2026-09-28 03:49:49,656 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/95155865-1473-4acd-aae2-3687f369e58b
2026-09-28 03:49:49,666 - DEBUG - Response Code: 404
2026-09-28 03:49:49,666 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:49:49,677 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:49:49,700 - DEBUG - Requesting: http://10.0.0.176:8082/project/15f9ffcd-103e-45bc-93c9-8b5281a2473a
2026-09-28 03:49:49,823 - INFO - Validated that VN ctest-left_vn-15643881 is not found in API Server
2026-09-28 03:49:49,840 - DEBUG - VN ctest-left_vn-15643881 is not present in Agent 10.0.0.38
2026-09-28 03:49:49,852 - DEBUG - VN ctest-left_vn-15643881 is not present in Agent 10.0.0.162
2026-09-28 03:49:49,852 - INFO - Validated that VN ctest-left_vn-15643881 is not in any agent
2026-09-28 03:49:49,899 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-15643881 info
2026-09-28 03:49:49,899 - INFO - Deleting VN ctest-mgmt_vn-33401415
2026-09-28 03:49:50,092 - DEBUG - Response for deleting network ()
2026-09-28 03:49:50,092 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/27307543-741a-4971-b9ec-a26ccd2604a6
2026-09-28 03:49:50,100 - DEBUG - Response Code: 404
2026-09-28 03:49:50,101 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:49:50,135 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:49:50,156 - DEBUG - Requesting: http://10.0.0.176:8082/project/15f9ffcd-103e-45bc-93c9-8b5281a2473a
2026-09-28 03:49:50,284 - INFO - Validated that VN ctest-mgmt_vn-33401415 is not found in API Server
2026-09-28 03:49:50,306 - DEBUG - VN ctest-mgmt_vn-33401415 is not present in Agent 10.0.0.38
2026-09-28 03:49:50,322 - DEBUG - VN ctest-mgmt_vn-33401415 is not present in Agent 10.0.0.162
2026-09-28 03:49:50,322 - INFO - Validated that VN ctest-mgmt_vn-33401415 is not in any agent
2026-09-28 03:49:50,379 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-33401415 info
2026-09-28 03:49:50,380 - INFO - Deleting VM ctest-vm-in-third-vn-40197768
2026-09-28 03:49:50,486 - INFO - Deleting VN ctest-third-vn-42805934
2026-09-28 03:49:50,536 - DEBUG - VN 967163d7-87b2-471a-85ba-fc92146baf94 still in use: Unable to complete operation on network 967163d7-87b2-471a-85ba-fc92146baf94. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-a71769a5-1b06-405b-8a4b-8046e98ab5df']
2026-09-28 03:49:50,537 - WARNING - Deleting VN ctest-third-vn-42805934 failed..Will retry
2026-09-28 03:49:52,610 - DEBUG - VN 967163d7-87b2-471a-85ba-fc92146baf94 still in use: Unable to complete operation on network 967163d7-87b2-471a-85ba-fc92146baf94. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-6e2c79b3-8667-498a-a6e8-3595b7f39b2d']
2026-09-28 03:49:52,610 - WARNING - Deleting VN ctest-third-vn-42805934 failed..Will retry
2026-09-28 03:49:54,809 - DEBUG - Response for deleting network ()
2026-09-28 03:49:56,154 - DEBUG - No XMPP flaps were noticed during the test
2026-09-28 03:49:56,154 - INFO -
2026-09-28 03:49:56,154 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:52]
2026-09-28 03:49:56,155 - INFO - --------------------------------------------------------------------------------
2026-09-28 03:49:56,160 - INFO - ================================================================================
2026-09-28 03:49:56,160 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2026-09-28 03:49:57,559 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.254': '0', '10.20.0.25': '0'}, '10.0.0.162': {'10.20.0.25': '0', '10.20.0.254': '0'}} with
2026-09-28 03:49:57,559 - INFO - Initial checks done. Running the testcase now
2026-09-28 03:49:57,559 - INFO -
2026-09-28 03:49:57,895 - DEBUG - Response for create_network : {'network': {'id': 'c62a52ab-b1d9-4a58-9b90-83b30ea5eff2', 'name': 'ctest-mgmt_vn-18871927', 'tenant_id': '15f9ffcd103e45bc93c98b5281a2473a', 'project_id': '15f9ffcd103e45bc93c98b5281a2473a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-23462778', 'ctest-mgmt_vn-18871927'], 'port_security_enabled': True, 'description': ''}}
2026-09-28 03:49:58,183 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a2533862-d3c3-40b4-94b3-6dd1fbd8053e', 'name': '', 'tenant_id': '15f9ffcd103e45bc93c98b5281a2473a', 'network_id': 'c62a52ab-b1d9-4a58-9b90-83b30ea5eff2', 'ip_version': 4, 'cidr': '158.36.170.0/26', 'allocation_pools': [{'start': '158.36.170.2', 'end': '158.36.170.62'}], 'gateway_ip': '158.36.170.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '158.36.170.2', 'tags': [], 'project_id': '15f9ffcd103e45bc93c98b5281a2473a'}}
2026-09-28 03:49:58,212 - INFO - Created VN ctest-mgmt_vn-18871927
2026-09-28 03:49:58,230 - DEBUG - VN ctest-mgmt_vn-18871927 UUID is c62a52ab-b1d9-4a58-9b90-83b30ea5eff2
2026-09-28 03:49:58,321 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:49:58,329 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:49:58,345 - DEBUG - Requesting: http://10.0.0.176:8082/project/15f9ffcd-103e-45bc-93c9-8b5281a2473a
2026-09-28 03:49:58,473 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/c62a52ab-b1d9-4a58-9b90-83b30ea5eff2
2026-09-28 03:49:58,495 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/c62a52ab-b1d9-4a58-9b90-83b30ea5eff2
2026-09-28 03:49:58,509 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/a3bb039c-da3f-4e15-82ea-d66d6623e25b
2026-09-28 03:49:58,521 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/a3bb039c-da3f-4e15-82ea-d66d6623e25b
2026-09-28 03:49:58,531 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/f0615a32-f3db-485e-8a98-3027955f04ea
2026-09-28 03:49:58,542 - DEBUG - Route Targets: ['target:64512:8000005']
2026-09-28 03:49:58,542 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/c62a52ab-b1d9-4a58-9b90-83b30ea5eff2
2026-09-28 03:49:58,555 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/a3bb039c-da3f-4e15-82ea-d66d6623e25b
2026-09-28 03:49:58,578 - INFO - Verified VN network id 13 for VN c62a52ab-b1d9-4a58-9b90-83b30ea5eff2
2026-09-28 03:49:58,579 - INFO - Verifications in API Server for VN ctest-mgmt_vn-18871927 passed
2026-09-28 03:49:58,579 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/c62a52ab-b1d9-4a58-9b90-83b30ea5eff2
2026-09-28 03:49:58,594 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/a3bb039c-da3f-4e15-82ea-d66d6623e25b
2026-09-28 03:49:58,603 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/a3bb039c-da3f-4e15-82ea-d66d6623e25b
2026-09-28 03:49:58,612 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/f0615a32-f3db-485e-8a98-3027955f04ea
2026-09-28 03:49:58,631 - DEBUG - Control-node 10.0.0.176 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23462778:ctest-mgmt_vn-18871927', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23462778', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14279316465908271704', 'uuid-lslong': '11209604277593305074'}, 'enable': 'true', 'created': '2026-09-28T03:49:57', 'last-modified': '2026-09-28T03:49:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.519665'}
2026-09-28 03:49:58,639 - DEBUG - Route Targets: ['target:64512:8000005']
2026-09-28 03:49:58,648 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23462778:ctest-mgmt_vn-18871927', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23462778', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14279316465908271704', 'uuid-lslong': '11209604277593305074'}, 'enable': 'true', 'created': '2026-09-28T03:49:57', 'last-modified': '2026-09-28T03:49:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.547683'}
2026-09-28 03:49:58,656 - DEBUG - Route Targets: ['target:64512:8000005']
2026-09-28 03:49:58,665 - DEBUG - Control-node 10.0.0.161 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23462778:ctest-mgmt_vn-18871927', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23462778', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14279316465908271704', 'uuid-lslong': '11209604277593305074'}, 'enable': 'true', 'created': '2026-09-28T03:49:57', 'last-modified': '2026-09-28T03:49:58', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.555484'}
2026-09-28 03:49:58,675 - DEBUG - Route Targets: ['target:64512:8000005']
2026-09-28 03:49:58,675 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-18871927 passed
2026-09-28 03:49:58,675 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-18871927 in API_Server ======
2026-09-28 03:49:58,675 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:49:58,684 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:49:58,701 - DEBUG - Requesting: http://10.0.0.176:8082/project/15f9ffcd-103e-45bc-93c9-8b5281a2473a
2026-09-28 03:49:58,819 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/c62a52ab-b1d9-4a58-9b90-83b30ea5eff2
2026-09-28 03:49:58,832 - DEBUG - =>VN ctest-mgmt_vn-18871927 has no policy to be verified
2026-09-28 03:49:58,832 - DEBUG - Verifying the vn in opserver
2026-09-28 03:49:58,832 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23462778:ctest-mgmt_vn-18871927 virtual network link through opserver 10.0.0.176
2026-09-28 03:49:58,832 - DEBUG - Requesting: http://10.0.0.176:8081/analytics/uves/virtual-networks
2026-09-28 03:49:58,850 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23462778:ctest-mgmt_vn-18871927', 'href': 'http://10.0.0.176:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23462778:ctest-mgmt_vn-18871927?flat'}
2026-09-28 03:49:58,850 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23462778:ctest-mgmt_vn-18871927 virtual network link through opserver 10.0.0.177
2026-09-28 03:49:58,850 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-09-28 03:49:58,865 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23462778:ctest-mgmt_vn-18871927', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23462778:ctest-mgmt_vn-18871927?flat'}
2026-09-28 03:49:58,865 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23462778:ctest-mgmt_vn-18871927 virtual network link through opserver 10.0.0.161
2026-09-28 03:49:58,865 - DEBUG - Requesting: http://10.0.0.161:8081/analytics/uves/virtual-networks
2026-09-28 03:49:58,881 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23462778:ctest-mgmt_vn-18871927', 'href': 'http://10.0.0.161:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23462778:ctest-mgmt_vn-18871927?flat'}
2026-09-28 03:49:58,881 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-23462778:ctest-mgmt_vn-18871927 is found in opserver
2026-09-28 03:49:58,912 - DEBUG - Do not have enough data to verify VN in agent
2026-09-28 03:49:58,925 - DEBUG - VRF ids for VN ctest-mgmt_vn-18871927: {}
2026-09-28 03:49:59,316 - DEBUG - Response for create_network : {'network': {'id': 'a59e0a63-f04d-4326-afce-d1b2fe190b9e', 'name': 'ctest-left_vn-03387586', 'tenant_id': '15f9ffcd103e45bc93c98b5281a2473a', 'project_id': '15f9ffcd103e45bc93c98b5281a2473a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-23462778', 'ctest-left_vn-03387586'], 'port_security_enabled': True, 'description': ''}}
2026-09-28 03:49:59,685 - DEBUG - Response for create_subnet : {'subnet': {'id': '5467fadb-0b3b-43bc-a488-0211f2be5b0e', 'name': '', 'tenant_id': '15f9ffcd103e45bc93c98b5281a2473a', 'network_id': 'a59e0a63-f04d-4326-afce-d1b2fe190b9e', 'ip_version': 4, 'cidr': '77.35.190.128/26', 'allocation_pools': [{'start': '77.35.190.130', 'end': '77.35.190.190'}], 'gateway_ip': '77.35.190.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '77.35.190.130', 'tags': [], 'project_id': '15f9ffcd103e45bc93c98b5281a2473a'}}
2026-09-28 03:49:59,711 - INFO - Created VN ctest-left_vn-03387586
2026-09-28 03:49:59,731 - DEBUG - VN ctest-left_vn-03387586 UUID is a59e0a63-f04d-4326-afce-d1b2fe190b9e
2026-09-28 03:49:59,818 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:49:59,827 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:49:59,842 - DEBUG - Requesting: http://10.0.0.176:8082/project/15f9ffcd-103e-45bc-93c9-8b5281a2473a
2026-09-28 03:49:59,964 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/a59e0a63-f04d-4326-afce-d1b2fe190b9e
2026-09-28 03:49:59,984 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/a59e0a63-f04d-4326-afce-d1b2fe190b9e
2026-09-28 03:49:59,998 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/8a022c0e-77be-4235-ae29-6901822b2e26
2026-09-28 03:50:00,011 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/8a022c0e-77be-4235-ae29-6901822b2e26
2026-09-28 03:50:00,023 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/e2299c5b-7bd1-48f5-8ef5-4595af43f2d7
2026-09-28 03:50:00,037 - DEBUG - Route Targets: ['target:64512:8000007']
2026-09-28 03:50:00,037 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/a59e0a63-f04d-4326-afce-d1b2fe190b9e
2026-09-28 03:50:00,051 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/8a022c0e-77be-4235-ae29-6901822b2e26
2026-09-28 03:50:00,077 - INFO - Verified VN network id 14 for VN a59e0a63-f04d-4326-afce-d1b2fe190b9e
2026-09-28 03:50:00,077 - INFO - Verifications in API Server for VN ctest-left_vn-03387586 passed
2026-09-28 03:50:00,077 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/a59e0a63-f04d-4326-afce-d1b2fe190b9e
2026-09-28 03:50:00,093 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/8a022c0e-77be-4235-ae29-6901822b2e26
2026-09-28 03:50:00,103 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/8a022c0e-77be-4235-ae29-6901822b2e26
2026-09-28 03:50:00,112 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/e2299c5b-7bd1-48f5-8ef5-4595af43f2d7
2026-09-28 03:50:00,131 - DEBUG - Control-node 10.0.0.176 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23462778:ctest-left_vn-03387586', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23462778', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11933987486928028454', 'uuid-lslong': '12668293368537222046'}, 'enable': 'true', 'created': '2026-09-28T03:49:59', 'last-modified': '2026-09-28T03:49:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.531230'}
2026-09-28 03:50:00,141 - DEBUG - Route Targets: ['target:64512:8000007']
2026-09-28 03:50:00,147 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23462778:ctest-left_vn-03387586', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23462778', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11933987486928028454', 'uuid-lslong': '12668293368537222046'}, 'enable': 'true', 'created': '2026-09-28T03:49:59', 'last-modified': '2026-09-28T03:49:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.549682'}
2026-09-28 03:50:00,156 - DEBUG - Route Targets: ['target:64512:8000007']
2026-09-28 03:50:00,166 - DEBUG - Control-node 10.0.0.161 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23462778:ctest-left_vn-03387586', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23462778', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11933987486928028454', 'uuid-lslong': '12668293368537222046'}, 'enable': 'true', 'created': '2026-09-28T03:49:59', 'last-modified': '2026-09-28T03:49:59', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.559444'}
2026-09-28 03:50:00,174 - DEBUG - Route Targets: ['target:64512:8000007']
2026-09-28 03:50:00,174 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-03387586 passed
2026-09-28 03:50:00,174 - DEBUG - ====Verifying policy data for ctest-left_vn-03387586 in API_Server ======
2026-09-28 03:50:00,174 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:00,182 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:00,197 - DEBUG - Requesting: http://10.0.0.176:8082/project/15f9ffcd-103e-45bc-93c9-8b5281a2473a
2026-09-28 03:50:00,336 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/a59e0a63-f04d-4326-afce-d1b2fe190b9e
2026-09-28 03:50:00,359 - DEBUG - =>VN ctest-left_vn-03387586 has no policy to be verified
2026-09-28 03:50:00,359 - DEBUG - Verifying the vn in opserver
2026-09-28 03:50:00,359 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23462778:ctest-left_vn-03387586 virtual network link through opserver 10.0.0.176
2026-09-28 03:50:00,359 - DEBUG - Requesting: http://10.0.0.176:8081/analytics/uves/virtual-networks
2026-09-28 03:50:00,377 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23462778:ctest-left_vn-03387586', 'href': 'http://10.0.0.176:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23462778:ctest-left_vn-03387586?flat'}
2026-09-28 03:50:00,377 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23462778:ctest-left_vn-03387586 virtual network link through opserver 10.0.0.177
2026-09-28 03:50:00,377 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-09-28 03:50:00,395 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23462778:ctest-left_vn-03387586', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23462778:ctest-left_vn-03387586?flat'}
2026-09-28 03:50:00,395 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23462778:ctest-left_vn-03387586 virtual network link through opserver 10.0.0.161
2026-09-28 03:50:00,395 - DEBUG - Requesting: http://10.0.0.161:8081/analytics/uves/virtual-networks
2026-09-28 03:50:00,412 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23462778:ctest-left_vn-03387586', 'href': 'http://10.0.0.161:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23462778:ctest-left_vn-03387586?flat'}
2026-09-28 03:50:00,412 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-23462778:ctest-left_vn-03387586 is found in opserver
2026-09-28 03:50:00,438 - DEBUG - Do not have enough data to verify VN in agent
2026-09-28 03:50:00,451 - DEBUG - VRF ids for VN ctest-left_vn-03387586: {}
2026-09-28 03:50:00,895 - DEBUG - Response for create_network : {'network': {'id': '2d2d9fe2-5631-4bf1-a70b-15ae8a536fda', 'name': 'ctest-right_vn-03836285', 'tenant_id': '15f9ffcd103e45bc93c98b5281a2473a', 'project_id': '15f9ffcd103e45bc93c98b5281a2473a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-23462778', 'ctest-right_vn-03836285'], 'port_security_enabled': True, 'description': ''}}
2026-09-28 03:50:01,231 - DEBUG - Response for create_subnet : {'subnet': {'id': '6d917427-9527-418f-9b4e-1be0813be050', 'name': '', 'tenant_id': '15f9ffcd103e45bc93c98b5281a2473a', 'network_id': '2d2d9fe2-5631-4bf1-a70b-15ae8a536fda', 'ip_version': 4, 'cidr': '75.163.180.64/26', 'allocation_pools': [{'start': '75.163.180.66', 'end': '75.163.180.126'}], 'gateway_ip': '75.163.180.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '75.163.180.66', 'tags': [], 'project_id': '15f9ffcd103e45bc93c98b5281a2473a'}}
2026-09-28 03:50:01,260 - INFO - Created VN ctest-right_vn-03836285
2026-09-28 03:50:01,278 - DEBUG - VN ctest-right_vn-03836285 UUID is 2d2d9fe2-5631-4bf1-a70b-15ae8a536fda
2026-09-28 03:50:01,380 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:01,390 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:01,407 - DEBUG - Requesting: http://10.0.0.176:8082/project/15f9ffcd-103e-45bc-93c9-8b5281a2473a
2026-09-28 03:50:01,544 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/2d2d9fe2-5631-4bf1-a70b-15ae8a536fda
2026-09-28 03:50:01,572 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/2d2d9fe2-5631-4bf1-a70b-15ae8a536fda
2026-09-28 03:50:01,590 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/25308fb1-b52a-450a-b878-810ef9b88928
2026-09-28 03:50:01,601 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/25308fb1-b52a-450a-b878-810ef9b88928
2026-09-28 03:50:01,616 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/c4a27d0e-c83f-4830-a370-fd002322a337
2026-09-28 03:50:01,628 - DEBUG - Route Targets: ['target:64512:8000008']
2026-09-28 03:50:01,628 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/2d2d9fe2-5631-4bf1-a70b-15ae8a536fda
2026-09-28 03:50:01,644 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/25308fb1-b52a-450a-b878-810ef9b88928
2026-09-28 03:50:01,668 - INFO - Verified VN network id 15 for VN 2d2d9fe2-5631-4bf1-a70b-15ae8a536fda
2026-09-28 03:50:01,669 - INFO - Verifications in API Server for VN ctest-right_vn-03836285 passed
2026-09-28 03:50:01,669 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/2d2d9fe2-5631-4bf1-a70b-15ae8a536fda
2026-09-28 03:50:01,687 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/25308fb1-b52a-450a-b878-810ef9b88928
2026-09-28 03:50:01,704 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/25308fb1-b52a-450a-b878-810ef9b88928
2026-09-28 03:50:01,716 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/c4a27d0e-c83f-4830-a370-fd002322a337
2026-09-28 03:50:01,737 - DEBUG - Control-node 10.0.0.176 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23462778:ctest-right_vn-03836285', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23462778', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3255433900116233201', 'uuid-lslong': '12036738268466999258'}, 'enable': 'true', 'created': '2026-09-28T03:50:00', 'last-modified': '2026-09-28T03:50:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.626727'}
2026-09-28 03:50:01,745 - DEBUG - Route Targets: ['target:64512:8000008']
2026-09-28 03:50:01,753 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23462778:ctest-right_vn-03836285', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23462778', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3255433900116233201', 'uuid-lslong': '12036738268466999258'}, 'enable': 'true', 'created': '2026-09-28T03:50:00', 'last-modified': '2026-09-28T03:50:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.625681'}
2026-09-28 03:50:01,766 - DEBUG - Route Targets: ['target:64512:8000008']
2026-09-28 03:50:01,776 - DEBUG - Control-node 10.0.0.161 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23462778:ctest-right_vn-03836285', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23462778', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3255433900116233201', 'uuid-lslong': '12036738268466999258'}, 'enable': 'true', 'created': '2026-09-28T03:50:00', 'last-modified': '2026-09-28T03:50:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.648557'}
2026-09-28 03:50:01,785 - DEBUG - Route Targets: ['target:64512:8000008']
2026-09-28 03:50:01,786 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-03836285 passed
2026-09-28 03:50:01,786 - DEBUG - ====Verifying policy data for ctest-right_vn-03836285 in API_Server ======
2026-09-28 03:50:01,786 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:01,795 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:01,810 - DEBUG - Requesting: http://10.0.0.176:8082/project/15f9ffcd-103e-45bc-93c9-8b5281a2473a
2026-09-28 03:50:01,961 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/2d2d9fe2-5631-4bf1-a70b-15ae8a536fda
2026-09-28 03:50:01,987 - DEBUG - =>VN ctest-right_vn-03836285 has no policy to be verified
2026-09-28 03:50:01,987 - DEBUG - Verifying the vn in opserver
2026-09-28 03:50:01,987 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23462778:ctest-right_vn-03836285 virtual network link through opserver 10.0.0.176
2026-09-28 03:50:01,987 - DEBUG - Requesting: http://10.0.0.176:8081/analytics/uves/virtual-networks
2026-09-28 03:50:02,015 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23462778:ctest-right_vn-03836285', 'href': 'http://10.0.0.176:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23462778:ctest-right_vn-03836285?flat'}
2026-09-28 03:50:02,015 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23462778:ctest-right_vn-03836285 virtual network link through opserver 10.0.0.177
2026-09-28 03:50:02,015 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-09-28 03:50:02,034 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23462778:ctest-right_vn-03836285', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23462778:ctest-right_vn-03836285?flat'}
2026-09-28 03:50:02,034 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23462778:ctest-right_vn-03836285 virtual network link through opserver 10.0.0.161
2026-09-28 03:50:02,034 - DEBUG - Requesting: http://10.0.0.161:8081/analytics/uves/virtual-networks
2026-09-28 03:50:02,053 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23462778:ctest-right_vn-03836285', 'href': 'http://10.0.0.161:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23462778:ctest-right_vn-03836285?flat'}
2026-09-28 03:50:02,053 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-23462778:ctest-right_vn-03836285 is found in opserver
2026-09-28 03:50:02,085 - DEBUG - Do not have enough data to verify VN in agent
2026-09-28 03:50:02,103 - DEBUG - VRF ids for VN ctest-right_vn-03836285: {}
2026-09-28 03:50:02,549 - DEBUG - Response for create_network : {'network': {'id': '26bc7971-c60d-4dc4-a8fd-03b5ca7f5a89', 'name': 'ctest-trans_left_vn-90573095', 'tenant_id': '15f9ffcd103e45bc93c98b5281a2473a', 'project_id': '15f9ffcd103e45bc93c98b5281a2473a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-23462778', 'ctest-trans_left_vn-90573095'], 'port_security_enabled': True, 'description': ''}}
2026-09-28 03:50:02,891 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e5d2d192-1fff-417b-8843-8d0b9dcc6652', 'name': '', 'tenant_id': '15f9ffcd103e45bc93c98b5281a2473a', 'network_id': '26bc7971-c60d-4dc4-a8fd-03b5ca7f5a89', 'ip_version': 4, 'cidr': '168.118.188.128/26', 'allocation_pools': [{'start': '168.118.188.130', 'end': '168.118.188.190'}], 'gateway_ip': '168.118.188.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '168.118.188.130', 'tags': [], 'project_id': '15f9ffcd103e45bc93c98b5281a2473a'}}
2026-09-28 03:50:02,928 - INFO - Created VN ctest-trans_left_vn-90573095
2026-09-28 03:50:02,943 - DEBUG - VN ctest-trans_left_vn-90573095 UUID is 26bc7971-c60d-4dc4-a8fd-03b5ca7f5a89
2026-09-28 03:50:03,040 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:03,048 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:03,067 - DEBUG - Requesting: http://10.0.0.176:8082/project/15f9ffcd-103e-45bc-93c9-8b5281a2473a
2026-09-28 03:50:03,204 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/26bc7971-c60d-4dc4-a8fd-03b5ca7f5a89
2026-09-28 03:50:03,226 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/26bc7971-c60d-4dc4-a8fd-03b5ca7f5a89
2026-09-28 03:50:03,243 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/bd4d3229-6cd0-401a-887d-23c6e7a0507e
2026-09-28 03:50:03,257 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/bd4d3229-6cd0-401a-887d-23c6e7a0507e
2026-09-28 03:50:03,269 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/483eb766-78f7-4658-aca8-de7c306958e2
2026-09-28 03:50:03,280 - DEBUG - Route Targets: ['target:64512:8000009']
2026-09-28 03:50:03,280 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/26bc7971-c60d-4dc4-a8fd-03b5ca7f5a89
2026-09-28 03:50:03,295 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/bd4d3229-6cd0-401a-887d-23c6e7a0507e
2026-09-28 03:50:03,325 - INFO - Verified VN network id 16 for VN 26bc7971-c60d-4dc4-a8fd-03b5ca7f5a89
2026-09-28 03:50:03,326 - INFO - Verifications in API Server for VN ctest-trans_left_vn-90573095 passed
2026-09-28 03:50:03,326 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/26bc7971-c60d-4dc4-a8fd-03b5ca7f5a89
2026-09-28 03:50:03,337 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/bd4d3229-6cd0-401a-887d-23c6e7a0507e
2026-09-28 03:50:03,346 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/bd4d3229-6cd0-401a-887d-23c6e7a0507e
2026-09-28 03:50:03,354 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/483eb766-78f7-4658-aca8-de7c306958e2
2026-09-28 03:50:03,370 - DEBUG - Control-node 10.0.0.176 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23462778:ctest-trans_left_vn-90573095', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23462778', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2791239398623890884', 'uuid-lslong': '12176893046800997001'}, 'enable': 'true', 'created': '2026-09-28T03:50:02', 'last-modified': '2026-09-28T03:50:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.565068'}
2026-09-28 03:50:03,379 - DEBUG - Route Targets: ['target:64512:8000009']
2026-09-28 03:50:03,385 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23462778:ctest-trans_left_vn-90573095', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23462778', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2791239398623890884', 'uuid-lslong': '12176893046800997001'}, 'enable': 'true', 'created': '2026-09-28T03:50:02', 'last-modified': '2026-09-28T03:50:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.576659'}
2026-09-28 03:50:03,391 - DEBUG - Route Targets: ['target:64512:8000009']
2026-09-28 03:50:03,398 - DEBUG - Control-node 10.0.0.161 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23462778:ctest-trans_left_vn-90573095', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23462778', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2791239398623890884', 'uuid-lslong': '12176893046800997001'}, 'enable': 'true', 'created': '2026-09-28T03:50:02', 'last-modified': '2026-09-28T03:50:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.588696'}
2026-09-28 03:50:03,406 - DEBUG - Route Targets: ['target:64512:8000009']
2026-09-28 03:50:03,406 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-90573095 passed
2026-09-28 03:50:03,406 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-90573095 in API_Server ======
2026-09-28 03:50:03,406 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:03,413 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:03,429 - DEBUG - Requesting: http://10.0.0.176:8082/project/15f9ffcd-103e-45bc-93c9-8b5281a2473a
2026-09-28 03:50:03,553 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/26bc7971-c60d-4dc4-a8fd-03b5ca7f5a89
2026-09-28 03:50:03,566 - DEBUG - =>VN ctest-trans_left_vn-90573095 has no policy to be verified
2026-09-28 03:50:03,566 - DEBUG - Verifying the vn in opserver
2026-09-28 03:50:03,566 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23462778:ctest-trans_left_vn-90573095 virtual network link through opserver 10.0.0.176
2026-09-28 03:50:03,566 - DEBUG - Requesting: http://10.0.0.176:8081/analytics/uves/virtual-networks
2026-09-28 03:50:03,581 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23462778:ctest-trans_left_vn-90573095', 'href': 'http://10.0.0.176:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23462778:ctest-trans_left_vn-90573095?flat'}
2026-09-28 03:50:03,582 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23462778:ctest-trans_left_vn-90573095 virtual network link through opserver 10.0.0.177
2026-09-28 03:50:03,582 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-09-28 03:50:03,598 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23462778:ctest-trans_left_vn-90573095', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23462778:ctest-trans_left_vn-90573095?flat'}
2026-09-28 03:50:03,598 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23462778:ctest-trans_left_vn-90573095 virtual network link through opserver 10.0.0.161
2026-09-28 03:50:03,598 - DEBUG - Requesting: http://10.0.0.161:8081/analytics/uves/virtual-networks
2026-09-28 03:50:03,615 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23462778:ctest-trans_left_vn-90573095', 'href': 'http://10.0.0.161:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23462778:ctest-trans_left_vn-90573095?flat'}
2026-09-28 03:50:03,616 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-23462778:ctest-trans_left_vn-90573095 is found in opserver
2026-09-28 03:50:03,641 - DEBUG - Do not have enough data to verify VN in agent
2026-09-28 03:50:03,654 - DEBUG - VRF ids for VN ctest-trans_left_vn-90573095: {}
2026-09-28 03:50:04,015 - DEBUG - Response for create_network : {'network': {'id': '4e23e3b7-2893-44e5-9b3f-61ff5ee3553b', 'name': 'ctest-trans_right_vn-65713482', 'tenant_id': '15f9ffcd103e45bc93c98b5281a2473a', 'project_id': '15f9ffcd103e45bc93c98b5281a2473a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-23462778', 'ctest-trans_right_vn-65713482'], 'port_security_enabled': True, 'description': ''}}
2026-09-28 03:50:04,350 - DEBUG - Response for create_subnet : {'subnet': {'id': 'b5b6968c-8b48-4e7a-a670-940dcc299d5a', 'name': '', 'tenant_id': '15f9ffcd103e45bc93c98b5281a2473a', 'network_id': '4e23e3b7-2893-44e5-9b3f-61ff5ee3553b', 'ip_version': 4, 'cidr': '44.154.231.0/26', 'allocation_pools': [{'start': '44.154.231.2', 'end': '44.154.231.62'}], 'gateway_ip': '44.154.231.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '44.154.231.2', 'tags': [], 'project_id': '15f9ffcd103e45bc93c98b5281a2473a'}}
2026-09-28 03:50:04,380 - INFO - Created VN ctest-trans_right_vn-65713482
2026-09-28 03:50:04,399 - DEBUG - VN ctest-trans_right_vn-65713482 UUID is 4e23e3b7-2893-44e5-9b3f-61ff5ee3553b
2026-09-28 03:50:04,481 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:04,489 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:04,511 - DEBUG - Requesting: http://10.0.0.176:8082/project/15f9ffcd-103e-45bc-93c9-8b5281a2473a
2026-09-28 03:50:04,641 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/4e23e3b7-2893-44e5-9b3f-61ff5ee3553b
2026-09-28 03:50:04,662 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/4e23e3b7-2893-44e5-9b3f-61ff5ee3553b
2026-09-28 03:50:04,687 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/68ef95eb-863e-4743-9969-96b7c781a190
2026-09-28 03:50:04,698 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/68ef95eb-863e-4743-9969-96b7c781a190
2026-09-28 03:50:04,712 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/0dfb0eb2-e90d-4ca4-b574-c1e47a28724a
2026-09-28 03:50:04,724 - DEBUG - Route Targets: ['target:64512:8000010']
2026-09-28 03:50:04,724 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/4e23e3b7-2893-44e5-9b3f-61ff5ee3553b
2026-09-28 03:50:04,740 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/68ef95eb-863e-4743-9969-96b7c781a190
2026-09-28 03:50:04,763 - INFO - Verified VN network id 17 for VN 4e23e3b7-2893-44e5-9b3f-61ff5ee3553b
2026-09-28 03:50:04,763 - INFO - Verifications in API Server for VN ctest-trans_right_vn-65713482 passed
2026-09-28 03:50:04,763 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/4e23e3b7-2893-44e5-9b3f-61ff5ee3553b
2026-09-28 03:50:04,777 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/68ef95eb-863e-4743-9969-96b7c781a190
2026-09-28 03:50:04,786 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/68ef95eb-863e-4743-9969-96b7c781a190
2026-09-28 03:50:04,798 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/0dfb0eb2-e90d-4ca4-b574-c1e47a28724a
2026-09-28 03:50:04,815 - DEBUG - Control-node 10.0.0.176 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23462778:ctest-trans_right_vn-65713482', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23462778', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5630594334942512357', 'uuid-lslong': '11186767748848112955'}, 'enable': 'true', 'created': '2026-09-28T03:50:03', 'last-modified': '2026-09-28T03:50:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.565299'}
2026-09-28 03:50:04,826 - DEBUG - Route Targets: ['target:64512:8000010']
2026-09-28 03:50:04,834 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23462778:ctest-trans_right_vn-65713482', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23462778', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5630594334942512357', 'uuid-lslong': '11186767748848112955'}, 'enable': 'true', 'created': '2026-09-28T03:50:03', 'last-modified': '2026-09-28T03:50:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.580405'}
2026-09-28 03:50:04,841 - DEBUG - Route Targets: ['target:64512:8000010']
2026-09-28 03:50:04,851 - DEBUG - Control-node 10.0.0.161 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-23462778:ctest-trans_right_vn-65713482', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-23462778', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5630594334942512357', 'uuid-lslong': '11186767748848112955'}, 'enable': 'true', 'created': '2026-09-28T03:50:03', 'last-modified': '2026-09-28T03:50:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.595930'}
2026-09-28 03:50:04,863 - DEBUG - Route Targets: ['target:64512:8000010']
2026-09-28 03:50:04,863 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-65713482 passed
2026-09-28 03:50:04,863 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-65713482 in API_Server ======
2026-09-28 03:50:04,863 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:04,872 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:04,888 - DEBUG - Requesting: http://10.0.0.176:8082/project/15f9ffcd-103e-45bc-93c9-8b5281a2473a
2026-09-28 03:50:05,009 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/4e23e3b7-2893-44e5-9b3f-61ff5ee3553b
2026-09-28 03:50:05,023 - DEBUG - =>VN ctest-trans_right_vn-65713482 has no policy to be verified
2026-09-28 03:50:05,023 - DEBUG - Verifying the vn in opserver
2026-09-28 03:50:05,023 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23462778:ctest-trans_right_vn-65713482 virtual network link through opserver 10.0.0.176
2026-09-28 03:50:05,023 - DEBUG - Requesting: http://10.0.0.176:8081/analytics/uves/virtual-networks
2026-09-28 03:50:05,038 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23462778:ctest-trans_right_vn-65713482', 'href': 'http://10.0.0.176:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23462778:ctest-trans_right_vn-65713482?flat'}
2026-09-28 03:50:05,038 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23462778:ctest-trans_right_vn-65713482 virtual network link through opserver 10.0.0.177
2026-09-28 03:50:05,038 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-09-28 03:50:05,055 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23462778:ctest-trans_right_vn-65713482', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23462778:ctest-trans_right_vn-65713482?flat'}
2026-09-28 03:50:05,055 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-23462778:ctest-trans_right_vn-65713482 virtual network link through opserver 10.0.0.161
2026-09-28 03:50:05,055 - DEBUG - Requesting: http://10.0.0.161:8081/analytics/uves/virtual-networks
2026-09-28 03:50:05,072 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-23462778:ctest-trans_right_vn-65713482', 'href': 'http://10.0.0.161:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-23462778:ctest-trans_right_vn-65713482?flat'}
2026-09-28 03:50:05,072 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-23462778:ctest-trans_right_vn-65713482 is found in opserver
2026-09-28 03:50:05,100 - DEBUG - Do not have enough data to verify VN in agent
2026-09-28 03:50:05,116 - DEBUG - VRF ids for VN ctest-trans_right_vn-65713482: {}
2026-09-28 03:50:05,668 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6324-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6324-2)
2026-09-28 03:50:06,268 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6324-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6324-1)
2026-09-28 03:50:06,269 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-58021802']
2026-09-28 03:50:06,618 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-58021802'] created succesfully
2026-09-28 03:50:06,921 - DEBUG - Image by name tiny_trans_fw not found
2026-09-28 03:50:06,921 - DEBUG - Installing image tiny_trans_fw
2026-09-28 03:50:06,921 - 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-09-28 03:50:06,921 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-09-28 03:50:06,921 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-09-28 03:50:06,945 - 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-09-28 03:50:06,994 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-09-28 03:50:06,994 - DEBUG - Unzip image
2026-09-28 03:50:06,994 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-09-28 03:50:07,019 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-09-28 03:50:07,020 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-58021802']
2026-09-28 03:50:07,137 - INFO - Service template: ['default-domain', 'ctest-service_template_1-58021802'] deleted successfully.
2026-09-28 03:50:07,138 - INFO - Skip interface_detach for VM ctest-right_vm-12824885 in state BUILD
2026-09-28 03:50:07,138 - INFO - Deleting VM ctest-right_vm-12824885
2026-09-28 03:50:07,138 - ERROR - VM ctest-right_vm-12824885 has failed to come up
2026-09-28 03:50:07,138 - ERROR - Nova failed to get host of the VM
2026-09-28 03:50:07,138 - ERROR - VM ctest-right_vm-12824885 has failed to come up
2026-09-28 03:50:07,138 - ERROR - Nova failed to get host of the VM
2026-09-28 03:50:07,306 - INFO - Skip interface_detach for VM ctest-left_vm-37830803 in state BUILD
2026-09-28 03:50:07,306 - INFO - Deleting VM ctest-left_vm-37830803
2026-09-28 03:50:07,307 - ERROR - VM ctest-left_vm-37830803 has failed to come up
2026-09-28 03:50:07,307 - ERROR - Nova failed to get host of the VM
2026-09-28 03:50:07,307 - ERROR - VM ctest-left_vm-37830803 has failed to come up
2026-09-28 03:50:07,307 - ERROR - Nova failed to get host of the VM
2026-09-28 03:50:07,405 - INFO - Deleting VN ctest-trans_right_vn-65713482
2026-09-28 03:50:07,622 - DEBUG - Response for deleting network ()
2026-09-28 03:50:07,623 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/68ef95eb-863e-4743-9969-96b7c781a190
2026-09-28 03:50:07,632 - DEBUG - Response Code: 404
2026-09-28 03:50:07,632 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:07,646 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:07,676 - DEBUG - Requesting: http://10.0.0.176:8082/project/15f9ffcd-103e-45bc-93c9-8b5281a2473a
2026-09-28 03:50:07,798 - INFO - Validated that VN ctest-trans_right_vn-65713482 is not found in API Server
2026-09-28 03:50:07,814 - DEBUG - VN ctest-trans_right_vn-65713482 is not present in Agent 10.0.0.38
2026-09-28 03:50:07,830 - DEBUG - VN ctest-trans_right_vn-65713482 is not present in Agent 10.0.0.162
2026-09-28 03:50:07,830 - INFO - Validated that VN ctest-trans_right_vn-65713482 is not in any agent
2026-09-28 03:50:07,876 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-65713482 info
2026-09-28 03:50:07,876 - INFO - Deleting VN ctest-trans_left_vn-90573095
2026-09-28 03:50:08,091 - DEBUG - Response for deleting network ()
2026-09-28 03:50:08,091 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/bd4d3229-6cd0-401a-887d-23c6e7a0507e
2026-09-28 03:50:08,099 - DEBUG - Response Code: 404
2026-09-28 03:50:08,099 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:08,121 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:08,140 - DEBUG - Requesting: http://10.0.0.176:8082/project/15f9ffcd-103e-45bc-93c9-8b5281a2473a
2026-09-28 03:50:08,294 - INFO - Validated that VN ctest-trans_left_vn-90573095 is not found in API Server
2026-09-28 03:50:08,315 - DEBUG - VN ctest-trans_left_vn-90573095 is not present in Agent 10.0.0.38
2026-09-28 03:50:08,337 - DEBUG - VN ctest-trans_left_vn-90573095 is not present in Agent 10.0.0.162
2026-09-28 03:50:08,337 - INFO - Validated that VN ctest-trans_left_vn-90573095 is not in any agent
2026-09-28 03:50:08,384 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-90573095 info
2026-09-28 03:50:08,384 - INFO - Deleting VN ctest-right_vn-03836285
2026-09-28 03:50:08,604 - DEBUG - Response for deleting network ()
2026-09-28 03:50:08,604 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/25308fb1-b52a-450a-b878-810ef9b88928
2026-09-28 03:50:08,613 - DEBUG - Response Code: 404
2026-09-28 03:50:08,613 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:08,621 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:08,646 - DEBUG - Requesting: http://10.0.0.176:8082/project/15f9ffcd-103e-45bc-93c9-8b5281a2473a
2026-09-28 03:50:08,774 - INFO - Validated that VN ctest-right_vn-03836285 is not found in API Server
2026-09-28 03:50:08,790 - DEBUG - VN ctest-right_vn-03836285 is not present in Agent 10.0.0.38
2026-09-28 03:50:08,805 - DEBUG - VN ctest-right_vn-03836285 is not present in Agent 10.0.0.162
2026-09-28 03:50:08,805 - INFO - Validated that VN ctest-right_vn-03836285 is not in any agent
2026-09-28 03:50:08,854 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-03836285 info
2026-09-28 03:50:08,855 - INFO - Deleting VN ctest-left_vn-03387586
2026-09-28 03:50:09,070 - DEBUG - Response for deleting network ()
2026-09-28 03:50:09,070 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/8a022c0e-77be-4235-ae29-6901822b2e26
2026-09-28 03:50:09,077 - DEBUG - Response Code: 404
2026-09-28 03:50:09,078 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:09,091 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:09,120 - DEBUG - Requesting: http://10.0.0.176:8082/project/15f9ffcd-103e-45bc-93c9-8b5281a2473a
2026-09-28 03:50:09,252 - INFO - Validated that VN ctest-left_vn-03387586 is not found in API Server
2026-09-28 03:50:09,268 - DEBUG - VN ctest-left_vn-03387586 is not present in Agent 10.0.0.38
2026-09-28 03:50:09,281 - DEBUG - VN ctest-left_vn-03387586 is not present in Agent 10.0.0.162
2026-09-28 03:50:09,281 - INFO - Validated that VN ctest-left_vn-03387586 is not in any agent
2026-09-28 03:50:09,332 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-03387586 info
2026-09-28 03:50:09,332 - INFO - Deleting VN ctest-mgmt_vn-18871927
2026-09-28 03:50:09,588 - DEBUG - Response for deleting network ()
2026-09-28 03:50:09,588 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/a3bb039c-da3f-4e15-82ea-d66d6623e25b
2026-09-28 03:50:09,600 - DEBUG - Response Code: 404
2026-09-28 03:50:09,603 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:09,614 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:09,631 - DEBUG - Requesting: http://10.0.0.176:8082/project/15f9ffcd-103e-45bc-93c9-8b5281a2473a
2026-09-28 03:50:09,764 - INFO - Validated that VN ctest-mgmt_vn-18871927 is not found in API Server
2026-09-28 03:50:09,778 - DEBUG - VN ctest-mgmt_vn-18871927 is not present in Agent 10.0.0.38
2026-09-28 03:50:09,791 - DEBUG - VN ctest-mgmt_vn-18871927 is not present in Agent 10.0.0.162
2026-09-28 03:50:09,791 - INFO - Validated that VN ctest-mgmt_vn-18871927 is not in any agent
2026-09-28 03:50:09,830 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-18871927 info
2026-09-28 03:50:11,173 - DEBUG - No XMPP flaps were noticed during the test
2026-09-28 03:50:11,173 - INFO -
2026-09-28 03:50:11,173 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:15]
2026-09-28 03:50:11,173 - INFO - --------------------------------------------------------------------------------
2026-09-28 03:50:12,165 - INFO - Deleted project: ctest-TestSvcRegr-23462778, ID : 15f9ffcd-103e-45bc-93c9-8b5281a2473a
2026-09-28 03:50:12,406 - INFO - Domain Default found not creating
2026-09-28 03:50:12,616 - INFO - Project ctest-TestSvcRegr-07405767 not found, creating it
2026-09-28 03:50:13,351 - INFO - Created Project:ctest-TestSvcRegr-07405767, ID : c56f0bcb-2de3-4648-ba9d-dad2bc3967e0
2026-09-28 03:50:15,457 - INFO - ================================================================================
2026-09-28 03:50:15,457 - INFO - STARTING TEST : test_svc_CEM_22032
2026-09-28 03:50:16,806 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.254': '0', '10.20.0.25': '0'}, '10.0.0.162': {'10.20.0.25': '0', '10.20.0.254': '0'}} with
2026-09-28 03:50:16,806 - INFO - Initial checks done. Running the testcase now
2026-09-28 03:50:16,806 - INFO -
2026-09-28 03:50:17,714 - DEBUG - Response for create_network : {'network': {'id': '10469e15-02e0-42e5-b6d4-8a6b51ec62f0', 'name': 'ctest-mgmt_vn-08847631', 'tenant_id': 'c56f0bcb2de34648ba9ddad2bc3967e0', 'project_id': 'c56f0bcb2de34648ba9ddad2bc3967e0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-07405767', 'ctest-mgmt_vn-08847631'], 'port_security_enabled': True, 'description': ''}}
2026-09-28 03:50:18,096 - DEBUG - Response for create_subnet : {'subnet': {'id': '2b6c350d-e0ad-40b7-ad21-c19bc85c430c', 'name': '', 'tenant_id': 'c56f0bcb2de34648ba9ddad2bc3967e0', 'network_id': '10469e15-02e0-42e5-b6d4-8a6b51ec62f0', 'ip_version': 4, 'cidr': '121.156.31.0/26', 'allocation_pools': [{'start': '121.156.31.2', 'end': '121.156.31.62'}], 'gateway_ip': '121.156.31.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '121.156.31.2', 'tags': [], 'project_id': 'c56f0bcb2de34648ba9ddad2bc3967e0'}}
2026-09-28 03:50:18,124 - INFO - Created VN ctest-mgmt_vn-08847631
2026-09-28 03:50:18,141 - DEBUG - VN ctest-mgmt_vn-08847631 UUID is 10469e15-02e0-42e5-b6d4-8a6b51ec62f0
2026-09-28 03:50:18,234 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:18,630 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:18,666 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:18,690 - DEBUG - Requesting: http://10.0.0.176:8082/project/c56f0bcb-2de3-4648-ba9d-dad2bc3967e0
2026-09-28 03:50:18,812 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/10469e15-02e0-42e5-b6d4-8a6b51ec62f0
2026-09-28 03:50:18,829 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/10469e15-02e0-42e5-b6d4-8a6b51ec62f0
2026-09-28 03:50:18,842 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/689c0225-d397-411b-9217-2237e4690ea5
2026-09-28 03:50:18,857 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/689c0225-d397-411b-9217-2237e4690ea5
2026-09-28 03:50:18,870 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/c4a48e3b-e100-40b1-af33-e48becf20f04
2026-09-28 03:50:18,890 - DEBUG - Route Targets: ['target:64512:8000005']
2026-09-28 03:50:18,890 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/10469e15-02e0-42e5-b6d4-8a6b51ec62f0
2026-09-28 03:50:18,907 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/689c0225-d397-411b-9217-2237e4690ea5
2026-09-28 03:50:18,935 - INFO - Verified VN network id 13 for VN 10469e15-02e0-42e5-b6d4-8a6b51ec62f0
2026-09-28 03:50:18,935 - INFO - Verifications in API Server for VN ctest-mgmt_vn-08847631 passed
2026-09-28 03:50:18,935 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/10469e15-02e0-42e5-b6d4-8a6b51ec62f0
2026-09-28 03:50:18,950 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/689c0225-d397-411b-9217-2237e4690ea5
2026-09-28 03:50:18,960 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/689c0225-d397-411b-9217-2237e4690ea5
2026-09-28 03:50:18,970 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/c4a48e3b-e100-40b1-af33-e48becf20f04
2026-09-28 03:50:18,988 - DEBUG - Control-node 10.0.0.176 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-08847631', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07405767', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1172798566056346341', 'uuid-lslong': '13174307003506123504'}, 'enable': 'true', 'created': '2026-09-28T03:50:17', 'last-modified': '2026-09-28T03:50:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.977146'}
2026-09-28 03:50:18,998 - DEBUG - Route Targets: ['target:64512:8000005']
2026-09-28 03:50:19,006 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-08847631', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07405767', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1172798566056346341', 'uuid-lslong': '13174307003506123504'}, 'enable': 'true', 'created': '2026-09-28T03:50:17', 'last-modified': '2026-09-28T03:50:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.990149'}
2026-09-28 03:50:19,018 - DEBUG - Route Targets: ['target:64512:8000005']
2026-09-28 03:50:19,027 - DEBUG - Control-node 10.0.0.161 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-08847631', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07405767', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1172798566056346341', 'uuid-lslong': '13174307003506123504'}, 'enable': 'true', 'created': '2026-09-28T03:50:17', 'last-modified': '2026-09-28T03:50:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.012230'}
2026-09-28 03:50:19,036 - DEBUG - Route Targets: ['target:64512:8000005']
2026-09-28 03:50:19,036 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-08847631 passed
2026-09-28 03:50:19,036 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-08847631 in API_Server ======
2026-09-28 03:50:19,036 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:19,047 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:19,062 - DEBUG - Requesting: http://10.0.0.176:8082/project/c56f0bcb-2de3-4648-ba9d-dad2bc3967e0
2026-09-28 03:50:19,183 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/10469e15-02e0-42e5-b6d4-8a6b51ec62f0
2026-09-28 03:50:19,196 - DEBUG - =>VN ctest-mgmt_vn-08847631 has no policy to be verified
2026-09-28 03:50:19,196 - DEBUG - Verifying the vn in opserver
2026-09-28 03:50:19,196 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-08847631 virtual network link through opserver 10.0.0.176
2026-09-28 03:50:19,196 - DEBUG - Requesting: http://10.0.0.176:8081/analytics/uves/virtual-networks
2026-09-28 03:50:19,571 - DEBUG - Requesting: http://10.0.0.176:8081/analytics/uves/virtual-networks
2026-09-28 03:50:19,639 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-08847631', 'href': 'http://10.0.0.176:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-08847631?flat'}
2026-09-28 03:50:19,639 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-08847631 virtual network link through opserver 10.0.0.177
2026-09-28 03:50:19,639 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-09-28 03:50:20,017 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-09-28 03:50:20,088 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-08847631', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-08847631?flat'}
2026-09-28 03:50:20,088 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-08847631 virtual network link through opserver 10.0.0.161
2026-09-28 03:50:20,089 - DEBUG - Requesting: http://10.0.0.161:8081/analytics/uves/virtual-networks
2026-09-28 03:50:20,473 - DEBUG - Requesting: http://10.0.0.161:8081/analytics/uves/virtual-networks
2026-09-28 03:50:20,553 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-08847631', 'href': 'http://10.0.0.161:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-08847631?flat'}
2026-09-28 03:50:20,554 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-08847631 is found in opserver
2026-09-28 03:50:20,585 - DEBUG - Do not have enough data to verify VN in agent
2026-09-28 03:50:20,601 - DEBUG - VRF ids for VN ctest-mgmt_vn-08847631: {}
2026-09-28 03:50:20,970 - DEBUG - Response for create_network : {'network': {'id': '879f3205-2954-4c76-ba23-a097102d51d1', 'name': 'service-left-vn-09745930', 'tenant_id': 'c56f0bcb2de34648ba9ddad2bc3967e0', 'project_id': 'c56f0bcb2de34648ba9ddad2bc3967e0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-07405767', 'service-left-vn-09745930'], 'port_security_enabled': True, 'description': ''}}
2026-09-28 03:50:21,329 - DEBUG - Response for create_subnet : {'subnet': {'id': '552590b9-a0d1-41d3-985e-90a9dc877730', 'name': '', 'tenant_id': 'c56f0bcb2de34648ba9ddad2bc3967e0', 'network_id': '879f3205-2954-4c76-ba23-a097102d51d1', 'ip_version': 4, 'cidr': '89.245.123.192/26', 'allocation_pools': [{'start': '89.245.123.194', 'end': '89.245.123.254'}], 'gateway_ip': '89.245.123.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '89.245.123.194', 'tags': [], 'project_id': 'c56f0bcb2de34648ba9ddad2bc3967e0'}}
2026-09-28 03:50:21,358 - INFO - Created VN service-left-vn-09745930
2026-09-28 03:50:21,377 - DEBUG - VN service-left-vn-09745930 UUID is 879f3205-2954-4c76-ba23-a097102d51d1
2026-09-28 03:50:21,476 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:21,486 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:21,501 - DEBUG - Requesting: http://10.0.0.176:8082/project/c56f0bcb-2de3-4648-ba9d-dad2bc3967e0
2026-09-28 03:50:21,642 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/879f3205-2954-4c76-ba23-a097102d51d1
2026-09-28 03:50:21,665 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/879f3205-2954-4c76-ba23-a097102d51d1
2026-09-28 03:50:21,678 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/4ebad6ab-3108-438e-951b-51bbe7050135
2026-09-28 03:50:21,687 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/4ebad6ab-3108-438e-951b-51bbe7050135
2026-09-28 03:50:21,696 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/ed1a2613-d461-41cc-b282-3e5e68f2f399
2026-09-28 03:50:21,707 - DEBUG - Route Targets: ['target:64512:8000007']
2026-09-28 03:50:21,707 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/879f3205-2954-4c76-ba23-a097102d51d1
2026-09-28 03:50:21,720 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/4ebad6ab-3108-438e-951b-51bbe7050135
2026-09-28 03:50:21,745 - INFO - Verified VN network id 14 for VN 879f3205-2954-4c76-ba23-a097102d51d1
2026-09-28 03:50:21,745 - INFO - Verifications in API Server for VN service-left-vn-09745930 passed
2026-09-28 03:50:21,745 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/879f3205-2954-4c76-ba23-a097102d51d1
2026-09-28 03:50:21,758 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/4ebad6ab-3108-438e-951b-51bbe7050135
2026-09-28 03:50:21,769 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/4ebad6ab-3108-438e-951b-51bbe7050135
2026-09-28 03:50:21,779 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/ed1a2613-d461-41cc-b282-3e5e68f2f399
2026-09-28 03:50:21,798 - DEBUG - Control-node 10.0.0.176 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07405767:service-left-vn-09745930', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07405767', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9772584714166881398', 'uuid-lslong': '13412740685911380433'}, 'enable': 'true', 'created': '2026-09-28T03:50:20', 'last-modified': '2026-09-28T03:50:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.567507'}
2026-09-28 03:50:21,813 - DEBUG - Route Targets: ['target:64512:8000007']
2026-09-28 03:50:21,823 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07405767:service-left-vn-09745930', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07405767', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9772584714166881398', 'uuid-lslong': '13412740685911380433'}, 'enable': 'true', 'created': '2026-09-28T03:50:20', 'last-modified': '2026-09-28T03:50:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.589636'}
2026-09-28 03:50:21,832 - DEBUG - Route Targets: ['target:64512:8000007']
2026-09-28 03:50:21,846 - DEBUG - Control-node 10.0.0.161 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07405767:service-left-vn-09745930', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07405767', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9772584714166881398', 'uuid-lslong': '13412740685911380433'}, 'enable': 'true', 'created': '2026-09-28T03:50:20', 'last-modified': '2026-09-28T03:50:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.613215'}
2026-09-28 03:50:21,856 - DEBUG - Route Targets: ['target:64512:8000007']
2026-09-28 03:50:21,856 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-09745930 passed
2026-09-28 03:50:21,857 - DEBUG - ====Verifying policy data for service-left-vn-09745930 in API_Server ======
2026-09-28 03:50:21,857 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:21,865 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:21,889 - DEBUG - Requesting: http://10.0.0.176:8082/project/c56f0bcb-2de3-4648-ba9d-dad2bc3967e0
2026-09-28 03:50:22,010 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/879f3205-2954-4c76-ba23-a097102d51d1
2026-09-28 03:50:22,026 - DEBUG - =>VN service-left-vn-09745930 has no policy to be verified
2026-09-28 03:50:22,026 - DEBUG - Verifying the vn in opserver
2026-09-28 03:50:22,026 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07405767:service-left-vn-09745930 virtual network link through opserver 10.0.0.176
2026-09-28 03:50:22,026 - DEBUG - Requesting: http://10.0.0.176:8081/analytics/uves/virtual-networks
2026-09-28 03:50:22,110 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07405767:service-left-vn-09745930', 'href': 'http://10.0.0.176:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07405767:service-left-vn-09745930?flat'}
2026-09-28 03:50:22,111 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07405767:service-left-vn-09745930 virtual network link through opserver 10.0.0.177
2026-09-28 03:50:22,111 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-09-28 03:50:22,186 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07405767:service-left-vn-09745930', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07405767:service-left-vn-09745930?flat'}
2026-09-28 03:50:22,186 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07405767:service-left-vn-09745930 virtual network link through opserver 10.0.0.161
2026-09-28 03:50:22,186 - DEBUG - Requesting: http://10.0.0.161:8081/analytics/uves/virtual-networks
2026-09-28 03:50:22,247 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07405767:service-left-vn-09745930', 'href': 'http://10.0.0.161:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07405767:service-left-vn-09745930?flat'}
2026-09-28 03:50:22,247 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-07405767:service-left-vn-09745930 is found in opserver
2026-09-28 03:50:22,276 - DEBUG - Do not have enough data to verify VN in agent
2026-09-28 03:50:22,288 - DEBUG - VRF ids for VN service-left-vn-09745930: {}
2026-09-28 03:50:22,737 - DEBUG - Response for create_network : {'network': {'id': '4e7d608b-70cd-4947-b550-147b5b622ccc', 'name': 'service-right-vn-45258962', 'tenant_id': 'c56f0bcb2de34648ba9ddad2bc3967e0', 'project_id': 'c56f0bcb2de34648ba9ddad2bc3967e0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-07405767', 'service-right-vn-45258962'], 'port_security_enabled': True, 'description': ''}}
2026-09-28 03:50:23,089 - DEBUG - Response for create_subnet : {'subnet': {'id': '4d2182f6-2879-4f57-8aae-55fb52f5d165', 'name': '', 'tenant_id': 'c56f0bcb2de34648ba9ddad2bc3967e0', 'network_id': '4e7d608b-70cd-4947-b550-147b5b622ccc', 'ip_version': 4, 'cidr': '194.113.161.0/26', 'allocation_pools': [{'start': '194.113.161.2', 'end': '194.113.161.62'}], 'gateway_ip': '194.113.161.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '194.113.161.2', 'tags': [], 'project_id': 'c56f0bcb2de34648ba9ddad2bc3967e0'}}
2026-09-28 03:50:23,129 - INFO - Created VN service-right-vn-45258962
2026-09-28 03:50:23,147 - DEBUG - VN service-right-vn-45258962 UUID is 4e7d608b-70cd-4947-b550-147b5b622ccc
2026-09-28 03:50:23,251 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:23,264 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:23,282 - DEBUG - Requesting: http://10.0.0.176:8082/project/c56f0bcb-2de3-4648-ba9d-dad2bc3967e0
2026-09-28 03:50:23,417 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/4e7d608b-70cd-4947-b550-147b5b622ccc
2026-09-28 03:50:23,432 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/4e7d608b-70cd-4947-b550-147b5b622ccc
2026-09-28 03:50:23,445 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/7a294afd-191c-4fee-902c-f5cf54a8466b
2026-09-28 03:50:23,457 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/7a294afd-191c-4fee-902c-f5cf54a8466b
2026-09-28 03:50:23,469 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/136e5190-e6f8-4f47-b209-09e9a6c6b7af
2026-09-28 03:50:23,480 - DEBUG - Route Targets: ['target:64512:8000008']
2026-09-28 03:50:23,480 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/4e7d608b-70cd-4947-b550-147b5b622ccc
2026-09-28 03:50:23,495 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/7a294afd-191c-4fee-902c-f5cf54a8466b
2026-09-28 03:50:23,523 - INFO - Verified VN network id 15 for VN 4e7d608b-70cd-4947-b550-147b5b622ccc
2026-09-28 03:50:23,523 - INFO - Verifications in API Server for VN service-right-vn-45258962 passed
2026-09-28 03:50:23,523 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/4e7d608b-70cd-4947-b550-147b5b622ccc
2026-09-28 03:50:23,538 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/7a294afd-191c-4fee-902c-f5cf54a8466b
2026-09-28 03:50:23,552 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/7a294afd-191c-4fee-902c-f5cf54a8466b
2026-09-28 03:50:23,564 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/136e5190-e6f8-4f47-b209-09e9a6c6b7af
2026-09-28 03:50:23,587 - DEBUG - Control-node 10.0.0.176 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07405767:service-right-vn-45258962', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07405767', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5655782859056433479', 'uuid-lslong': '13064965039048502476'}, 'enable': 'true', 'created': '2026-09-28T03:50:22', 'last-modified': '2026-09-28T03:50:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.605051'}
2026-09-28 03:50:23,595 - DEBUG - Route Targets: ['target:64512:8000008']
2026-09-28 03:50:23,601 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07405767:service-right-vn-45258962', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07405767', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5655782859056433479', 'uuid-lslong': '13064965039048502476'}, 'enable': 'true', 'created': '2026-09-28T03:50:22', 'last-modified': '2026-09-28T03:50:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.606007'}
2026-09-28 03:50:23,607 - DEBUG - Route Targets: ['target:64512:8000008']
2026-09-28 03:50:23,614 - DEBUG - Control-node 10.0.0.161 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07405767:service-right-vn-45258962', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07405767', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5655782859056433479', 'uuid-lslong': '13064965039048502476'}, 'enable': 'true', 'created': '2026-09-28T03:50:22', 'last-modified': '2026-09-28T03:50:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.633475'}
2026-09-28 03:50:23,622 - DEBUG - Route Targets: ['target:64512:8000008']
2026-09-28 03:50:23,622 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-45258962 passed
2026-09-28 03:50:23,623 - DEBUG - ====Verifying policy data for service-right-vn-45258962 in API_Server ======
2026-09-28 03:50:23,623 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:23,632 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:23,651 - DEBUG - Requesting: http://10.0.0.176:8082/project/c56f0bcb-2de3-4648-ba9d-dad2bc3967e0
2026-09-28 03:50:23,791 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/4e7d608b-70cd-4947-b550-147b5b622ccc
2026-09-28 03:50:23,806 - DEBUG - =>VN service-right-vn-45258962 has no policy to be verified
2026-09-28 03:50:23,806 - DEBUG - Verifying the vn in opserver
2026-09-28 03:50:23,806 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07405767:service-right-vn-45258962 virtual network link through opserver 10.0.0.176
2026-09-28 03:50:23,806 - DEBUG - Requesting: http://10.0.0.176:8081/analytics/uves/virtual-networks
2026-09-28 03:50:23,873 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07405767:service-right-vn-45258962', 'href': 'http://10.0.0.176:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07405767:service-right-vn-45258962?flat'}
2026-09-28 03:50:23,873 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07405767:service-right-vn-45258962 virtual network link through opserver 10.0.0.177
2026-09-28 03:50:23,873 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-09-28 03:50:23,938 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07405767:service-right-vn-45258962', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07405767:service-right-vn-45258962?flat'}
2026-09-28 03:50:23,938 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07405767:service-right-vn-45258962 virtual network link through opserver 10.0.0.161
2026-09-28 03:50:23,938 - DEBUG - Requesting: http://10.0.0.161:8081/analytics/uves/virtual-networks
2026-09-28 03:50:24,017 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07405767:service-right-vn-45258962', 'href': 'http://10.0.0.161:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07405767:service-right-vn-45258962?flat'}
2026-09-28 03:50:24,017 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-07405767:service-right-vn-45258962 is found in opserver
2026-09-28 03:50:24,042 - DEBUG - Do not have enough data to verify VN in agent
2026-09-28 03:50:24,054 - DEBUG - VRF ids for VN service-right-vn-45258962: {}
2026-09-28 03:50:24,141 - DEBUG - Services list from nova: [, , , ]
2026-09-28 03:50:24,775 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6324-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6324-2)
2026-09-28 03:50:25,411 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6324-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6324-1)
2026-09-28 03:50:25,411 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-69414488']
2026-09-28 03:50:25,738 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-69414488'] created succesfully
2026-09-28 03:50:26,039 - DEBUG - Image by name tiny_nat_fw not found
2026-09-28 03:50:26,039 - DEBUG - Installing image tiny_nat_fw
2026-09-28 03:50:26,039 - 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-09-28 03:50:26,040 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-09-28 03:50:26,040 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-09-28 03:50:26,040 - DEBUG - Unzip image
2026-09-28 03:50:26,040 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-09-28 03:50:26,074 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-09-28 03:50:26,074 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-69414488']
2026-09-28 03:50:26,193 - INFO - Service template: ['default-domain', 'ctest-service_template_1-69414488'] deleted successfully.
2026-09-28 03:50:26,194 - INFO - Skip interface_detach for VM ctest-right_vm-11873514 in state BUILD
2026-09-28 03:50:26,194 - INFO - Deleting VM ctest-right_vm-11873514
2026-09-28 03:50:26,235 - ERROR - VM ctest-right_vm-11873514 has failed to come up
2026-09-28 03:50:26,235 - ERROR - Nova failed to get host of the VM
2026-09-28 03:50:26,235 - ERROR - VM ctest-right_vm-11873514 has failed to come up
2026-09-28 03:50:26,235 - ERROR - Nova failed to get host of the VM
2026-09-28 03:50:26,394 - INFO - Skip interface_detach for VM ctest-left_vm-20717992 in state BUILD
2026-09-28 03:50:26,395 - INFO - Deleting VM ctest-left_vm-20717992
2026-09-28 03:50:26,395 - ERROR - VM ctest-left_vm-20717992 has failed to come up
2026-09-28 03:50:26,395 - ERROR - Nova failed to get host of the VM
2026-09-28 03:50:26,395 - ERROR - VM ctest-left_vm-20717992 has failed to come up
2026-09-28 03:50:26,395 - ERROR - Nova failed to get host of the VM
2026-09-28 03:50:26,554 - INFO - Deleting VN service-right-vn-45258962
2026-09-28 03:50:26,773 - DEBUG - Response for deleting network ()
2026-09-28 03:50:26,773 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/7a294afd-191c-4fee-902c-f5cf54a8466b
2026-09-28 03:50:26,780 - DEBUG - Response Code: 404
2026-09-28 03:50:26,780 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:26,787 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:26,815 - DEBUG - Requesting: http://10.0.0.176:8082/project/c56f0bcb-2de3-4648-ba9d-dad2bc3967e0
2026-09-28 03:50:26,979 - INFO - Validated that VN service-right-vn-45258962 is not found in API Server
2026-09-28 03:50:26,995 - DEBUG - VN service-right-vn-45258962 is not present in Agent 10.0.0.38
2026-09-28 03:50:27,009 - DEBUG - VN service-right-vn-45258962 is not present in Agent 10.0.0.162
2026-09-28 03:50:27,010 - INFO - Validated that VN service-right-vn-45258962 is not in any agent
2026-09-28 03:50:27,047 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-45258962 info
2026-09-28 03:50:27,047 - INFO - Deleting VN service-left-vn-09745930
2026-09-28 03:50:27,318 - DEBUG - Response for deleting network ()
2026-09-28 03:50:27,318 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/4ebad6ab-3108-438e-951b-51bbe7050135
2026-09-28 03:50:27,326 - DEBUG - Response Code: 404
2026-09-28 03:50:27,326 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:27,336 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:27,351 - DEBUG - Requesting: http://10.0.0.176:8082/project/c56f0bcb-2de3-4648-ba9d-dad2bc3967e0
2026-09-28 03:50:27,453 - INFO - Validated that VN service-left-vn-09745930 is not found in API Server
2026-09-28 03:50:27,471 - DEBUG - VN service-left-vn-09745930 is not present in Agent 10.0.0.38
2026-09-28 03:50:27,489 - DEBUG - VN service-left-vn-09745930 is not present in Agent 10.0.0.162
2026-09-28 03:50:27,489 - INFO - Validated that VN service-left-vn-09745930 is not in any agent
2026-09-28 03:50:27,546 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-09745930 info
2026-09-28 03:50:27,546 - INFO - Deleting VN ctest-mgmt_vn-08847631
2026-09-28 03:50:27,741 - DEBUG - Response for deleting network ()
2026-09-28 03:50:27,741 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/689c0225-d397-411b-9217-2237e4690ea5
2026-09-28 03:50:27,749 - DEBUG - Response Code: 404
2026-09-28 03:50:27,750 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:27,760 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:27,824 - DEBUG - Requesting: http://10.0.0.176:8082/project/c56f0bcb-2de3-4648-ba9d-dad2bc3967e0
2026-09-28 03:50:27,947 - INFO - Validated that VN ctest-mgmt_vn-08847631 is not found in API Server
2026-09-28 03:50:27,960 - DEBUG - VN ctest-mgmt_vn-08847631 is not present in Agent 10.0.0.38
2026-09-28 03:50:27,974 - DEBUG - VN ctest-mgmt_vn-08847631 is not present in Agent 10.0.0.162
2026-09-28 03:50:27,974 - INFO - Validated that VN ctest-mgmt_vn-08847631 is not in any agent
2026-09-28 03:50:28,020 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-08847631 info
2026-09-28 03:50:29,405 - DEBUG - No XMPP flaps were noticed during the test
2026-09-28 03:50:29,406 - INFO -
2026-09-28 03:50:29,406 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:14]
2026-09-28 03:50:29,406 - INFO - --------------------------------------------------------------------------------
2026-09-28 03:50:29,414 - INFO - ================================================================================
2026-09-28 03:50:29,414 - INFO - STARTING TEST : test_svc_in_network_datapath
2026-09-28 03:50:30,779 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.254': '0', '10.20.0.25': '0'}, '10.0.0.162': {'10.20.0.25': '0', '10.20.0.254': '0'}} with
2026-09-28 03:50:30,779 - INFO - Initial checks done. Running the testcase now
2026-09-28 03:50:30,779 - INFO -
2026-09-28 03:50:31,147 - DEBUG - Response for create_network : {'network': {'id': '9bb98bce-a4d7-4d81-a786-f507faf832fe', 'name': 'ctest-mgmt_vn-13389648', 'tenant_id': 'c56f0bcb2de34648ba9ddad2bc3967e0', 'project_id': 'c56f0bcb2de34648ba9ddad2bc3967e0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-07405767', 'ctest-mgmt_vn-13389648'], 'port_security_enabled': True, 'description': ''}}
2026-09-28 03:50:31,400 - DEBUG - Response for create_subnet : {'subnet': {'id': '1148a326-c723-492f-8b82-6eb7007cdbd9', 'name': '', 'tenant_id': 'c56f0bcb2de34648ba9ddad2bc3967e0', 'network_id': '9bb98bce-a4d7-4d81-a786-f507faf832fe', 'ip_version': 4, 'cidr': '93.142.45.128/26', 'allocation_pools': [{'start': '93.142.45.130', 'end': '93.142.45.190'}], 'gateway_ip': '93.142.45.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '93.142.45.130', 'tags': [], 'project_id': 'c56f0bcb2de34648ba9ddad2bc3967e0'}}
2026-09-28 03:50:31,426 - INFO - Created VN ctest-mgmt_vn-13389648
2026-09-28 03:50:31,444 - DEBUG - VN ctest-mgmt_vn-13389648 UUID is 9bb98bce-a4d7-4d81-a786-f507faf832fe
2026-09-28 03:50:31,534 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:31,542 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:31,564 - DEBUG - Requesting: http://10.0.0.176:8082/project/c56f0bcb-2de3-4648-ba9d-dad2bc3967e0
2026-09-28 03:50:31,738 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/9bb98bce-a4d7-4d81-a786-f507faf832fe
2026-09-28 03:50:31,763 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/9bb98bce-a4d7-4d81-a786-f507faf832fe
2026-09-28 03:50:31,779 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/70b52d4d-3b29-4103-aa36-edaee50d498f
2026-09-28 03:50:31,798 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/70b52d4d-3b29-4103-aa36-edaee50d498f
2026-09-28 03:50:31,811 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/74802e03-0a3a-40f9-a347-504a609a17f1
2026-09-28 03:50:31,823 - DEBUG - Route Targets: ['target:64512:8000005']
2026-09-28 03:50:31,823 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/9bb98bce-a4d7-4d81-a786-f507faf832fe
2026-09-28 03:50:31,836 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/70b52d4d-3b29-4103-aa36-edaee50d498f
2026-09-28 03:50:31,857 - INFO - Verified VN network id 13 for VN 9bb98bce-a4d7-4d81-a786-f507faf832fe
2026-09-28 03:50:31,857 - INFO - Verifications in API Server for VN ctest-mgmt_vn-13389648 passed
2026-09-28 03:50:31,858 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/9bb98bce-a4d7-4d81-a786-f507faf832fe
2026-09-28 03:50:31,876 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/70b52d4d-3b29-4103-aa36-edaee50d498f
2026-09-28 03:50:31,889 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/70b52d4d-3b29-4103-aa36-edaee50d498f
2026-09-28 03:50:31,901 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/74802e03-0a3a-40f9-a347-504a609a17f1
2026-09-28 03:50:31,922 - DEBUG - Control-node 10.0.0.176 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-13389648', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07405767', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11221153666215398785', 'uuid-lslong': '12071605265837339390'}, 'enable': 'true', 'created': '2026-09-28T03:50:31', 'last-modified': '2026-09-28T03:50:31', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.596298'}
2026-09-28 03:50:31,931 - DEBUG - Route Targets: ['target:64512:8000005']
2026-09-28 03:50:31,941 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-13389648', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07405767', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11221153666215398785', 'uuid-lslong': '12071605265837339390'}, 'enable': 'true', 'created': '2026-09-28T03:50:31', 'last-modified': '2026-09-28T03:50:31', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.615181'}
2026-09-28 03:50:31,948 - DEBUG - Route Targets: ['target:64512:8000005']
2026-09-28 03:50:31,956 - DEBUG - Control-node 10.0.0.161 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-13389648', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07405767', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11221153666215398785', 'uuid-lslong': '12071605265837339390'}, 'enable': 'true', 'created': '2026-09-28T03:50:31', 'last-modified': '2026-09-28T03:50:31', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.614251'}
2026-09-28 03:50:31,963 - DEBUG - Route Targets: ['target:64512:8000005']
2026-09-28 03:50:31,963 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-13389648 passed
2026-09-28 03:50:31,963 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-13389648 in API_Server ======
2026-09-28 03:50:31,963 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:31,974 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:31,997 - DEBUG - Requesting: http://10.0.0.176:8082/project/c56f0bcb-2de3-4648-ba9d-dad2bc3967e0
2026-09-28 03:50:32,131 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/9bb98bce-a4d7-4d81-a786-f507faf832fe
2026-09-28 03:50:32,150 - DEBUG - =>VN ctest-mgmt_vn-13389648 has no policy to be verified
2026-09-28 03:50:32,150 - DEBUG - Verifying the vn in opserver
2026-09-28 03:50:32,150 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-13389648 virtual network link through opserver 10.0.0.176
2026-09-28 03:50:32,150 - DEBUG - Requesting: http://10.0.0.176:8081/analytics/uves/virtual-networks
2026-09-28 03:50:32,167 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-13389648', 'href': 'http://10.0.0.176:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-13389648?flat'}
2026-09-28 03:50:32,167 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-13389648 virtual network link through opserver 10.0.0.177
2026-09-28 03:50:32,167 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-09-28 03:50:32,183 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-13389648', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-13389648?flat'}
2026-09-28 03:50:32,183 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-13389648 virtual network link through opserver 10.0.0.161
2026-09-28 03:50:32,183 - DEBUG - Requesting: http://10.0.0.161:8081/analytics/uves/virtual-networks
2026-09-28 03:50:32,201 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-13389648', 'href': 'http://10.0.0.161:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-13389648?flat'}
2026-09-28 03:50:32,201 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-07405767:ctest-mgmt_vn-13389648 is found in opserver
2026-09-28 03:50:32,232 - DEBUG - Do not have enough data to verify VN in agent
2026-09-28 03:50:32,247 - DEBUG - VRF ids for VN ctest-mgmt_vn-13389648: {}
2026-09-28 03:50:32,608 - DEBUG - Response for create_network : {'network': {'id': '42a569cf-2c99-434e-805f-48307692a32b', 'name': 'ctest-left_vn-93619767', 'tenant_id': 'c56f0bcb2de34648ba9ddad2bc3967e0', 'project_id': 'c56f0bcb2de34648ba9ddad2bc3967e0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-07405767', 'ctest-left_vn-93619767'], 'port_security_enabled': True, 'description': ''}}
2026-09-28 03:50:32,894 - DEBUG - Response for create_subnet : {'subnet': {'id': '7bede7cc-aa38-4592-b7eb-fc3abbe5e99c', 'name': '', 'tenant_id': 'c56f0bcb2de34648ba9ddad2bc3967e0', 'network_id': '42a569cf-2c99-434e-805f-48307692a32b', 'ip_version': 4, 'cidr': '34.149.247.0/26', 'allocation_pools': [{'start': '34.149.247.2', 'end': '34.149.247.62'}], 'gateway_ip': '34.149.247.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '34.149.247.2', 'tags': [], 'project_id': 'c56f0bcb2de34648ba9ddad2bc3967e0'}}
2026-09-28 03:50:32,932 - INFO - Created VN ctest-left_vn-93619767
2026-09-28 03:50:32,955 - DEBUG - VN ctest-left_vn-93619767 UUID is 42a569cf-2c99-434e-805f-48307692a32b
2026-09-28 03:50:33,060 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:33,071 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:33,087 - DEBUG - Requesting: http://10.0.0.176:8082/project/c56f0bcb-2de3-4648-ba9d-dad2bc3967e0
2026-09-28 03:50:33,223 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/42a569cf-2c99-434e-805f-48307692a32b
2026-09-28 03:50:33,236 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/42a569cf-2c99-434e-805f-48307692a32b
2026-09-28 03:50:33,248 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/1d5875a3-962b-4e0d-846f-b538e2f8675c
2026-09-28 03:50:33,260 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/1d5875a3-962b-4e0d-846f-b538e2f8675c
2026-09-28 03:50:33,275 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/51cce607-de71-4076-93ff-7718fe1ea2ba
2026-09-28 03:50:33,286 - DEBUG - Route Targets: ['target:64512:8000007']
2026-09-28 03:50:33,286 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/42a569cf-2c99-434e-805f-48307692a32b
2026-09-28 03:50:33,300 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/1d5875a3-962b-4e0d-846f-b538e2f8675c
2026-09-28 03:50:33,324 - INFO - Verified VN network id 14 for VN 42a569cf-2c99-434e-805f-48307692a32b
2026-09-28 03:50:33,324 - INFO - Verifications in API Server for VN ctest-left_vn-93619767 passed
2026-09-28 03:50:33,324 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/42a569cf-2c99-434e-805f-48307692a32b
2026-09-28 03:50:33,337 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/1d5875a3-962b-4e0d-846f-b538e2f8675c
2026-09-28 03:50:33,350 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/1d5875a3-962b-4e0d-846f-b538e2f8675c
2026-09-28 03:50:33,360 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/51cce607-de71-4076-93ff-7718fe1ea2ba
2026-09-28 03:50:33,382 - DEBUG - Control-node 10.0.0.176 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07405767:ctest-left_vn-93619767', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07405767', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4802360916187890510', 'uuid-lslong': '9250191532627239723'}, 'enable': 'true', 'created': '2026-09-28T03:50:32', 'last-modified': '2026-09-28T03:50:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.575213'}
2026-09-28 03:50:33,391 - DEBUG - Route Targets: ['target:64512:8000007']
2026-09-28 03:50:33,400 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07405767:ctest-left_vn-93619767', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07405767', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4802360916187890510', 'uuid-lslong': '9250191532627239723'}, 'enable': 'true', 'created': '2026-09-28T03:50:32', 'last-modified': '2026-09-28T03:50:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.594752'}
2026-09-28 03:50:33,407 - DEBUG - Route Targets: ['target:64512:8000007']
2026-09-28 03:50:33,414 - DEBUG - Control-node 10.0.0.161 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07405767:ctest-left_vn-93619767', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07405767', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4802360916187890510', 'uuid-lslong': '9250191532627239723'}, 'enable': 'true', 'created': '2026-09-28T03:50:32', 'last-modified': '2026-09-28T03:50:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.607188'}
2026-09-28 03:50:33,423 - DEBUG - Route Targets: ['target:64512:8000007']
2026-09-28 03:50:33,423 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-93619767 passed
2026-09-28 03:50:33,423 - DEBUG - ====Verifying policy data for ctest-left_vn-93619767 in API_Server ======
2026-09-28 03:50:33,423 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:33,433 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:33,449 - DEBUG - Requesting: http://10.0.0.176:8082/project/c56f0bcb-2de3-4648-ba9d-dad2bc3967e0
2026-09-28 03:50:33,571 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/42a569cf-2c99-434e-805f-48307692a32b
2026-09-28 03:50:33,588 - DEBUG - =>VN ctest-left_vn-93619767 has no policy to be verified
2026-09-28 03:50:33,588 - DEBUG - Verifying the vn in opserver
2026-09-28 03:50:33,588 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07405767:ctest-left_vn-93619767 virtual network link through opserver 10.0.0.176
2026-09-28 03:50:33,588 - DEBUG - Requesting: http://10.0.0.176:8081/analytics/uves/virtual-networks
2026-09-28 03:50:33,604 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07405767:ctest-left_vn-93619767', 'href': 'http://10.0.0.176:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07405767:ctest-left_vn-93619767?flat'}
2026-09-28 03:50:33,605 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07405767:ctest-left_vn-93619767 virtual network link through opserver 10.0.0.177
2026-09-28 03:50:33,605 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-09-28 03:50:33,622 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07405767:ctest-left_vn-93619767', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07405767:ctest-left_vn-93619767?flat'}
2026-09-28 03:50:33,622 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07405767:ctest-left_vn-93619767 virtual network link through opserver 10.0.0.161
2026-09-28 03:50:33,622 - DEBUG - Requesting: http://10.0.0.161:8081/analytics/uves/virtual-networks
2026-09-28 03:50:33,639 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07405767:ctest-left_vn-93619767', 'href': 'http://10.0.0.161:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07405767:ctest-left_vn-93619767?flat'}
2026-09-28 03:50:33,639 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-07405767:ctest-left_vn-93619767 is found in opserver
2026-09-28 03:50:33,670 - DEBUG - Do not have enough data to verify VN in agent
2026-09-28 03:50:33,689 - DEBUG - VRF ids for VN ctest-left_vn-93619767: {}
2026-09-28 03:50:34,034 - DEBUG - Response for create_network : {'network': {'id': '3dae00be-7127-4dcb-ac18-fc4a52b29f9e', 'name': 'ctest-right_vn-73639032', 'tenant_id': 'c56f0bcb2de34648ba9ddad2bc3967e0', 'project_id': 'c56f0bcb2de34648ba9ddad2bc3967e0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-07405767', 'ctest-right_vn-73639032'], 'port_security_enabled': True, 'description': ''}}
2026-09-28 03:50:34,343 - DEBUG - Response for create_subnet : {'subnet': {'id': '49e1424e-63c0-4172-997e-7b34e34d8d7f', 'name': '', 'tenant_id': 'c56f0bcb2de34648ba9ddad2bc3967e0', 'network_id': '3dae00be-7127-4dcb-ac18-fc4a52b29f9e', 'ip_version': 4, 'cidr': '69.9.216.128/26', 'allocation_pools': [{'start': '69.9.216.130', 'end': '69.9.216.190'}], 'gateway_ip': '69.9.216.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '69.9.216.130', 'tags': [], 'project_id': 'c56f0bcb2de34648ba9ddad2bc3967e0'}}
2026-09-28 03:50:34,371 - INFO - Created VN ctest-right_vn-73639032
2026-09-28 03:50:34,397 - DEBUG - VN ctest-right_vn-73639032 UUID is 3dae00be-7127-4dcb-ac18-fc4a52b29f9e
2026-09-28 03:50:34,484 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:34,493 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:34,509 - DEBUG - Requesting: http://10.0.0.176:8082/project/c56f0bcb-2de3-4648-ba9d-dad2bc3967e0
2026-09-28 03:50:34,632 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/3dae00be-7127-4dcb-ac18-fc4a52b29f9e
2026-09-28 03:50:34,649 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/3dae00be-7127-4dcb-ac18-fc4a52b29f9e
2026-09-28 03:50:34,664 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/7115d852-8bae-4a7a-bd9e-af99d52d1d67
2026-09-28 03:50:34,674 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/7115d852-8bae-4a7a-bd9e-af99d52d1d67
2026-09-28 03:50:34,683 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/20035bbd-9efe-4a53-bef7-ebccd7a69527
2026-09-28 03:50:34,694 - DEBUG - Route Targets: ['target:64512:8000008']
2026-09-28 03:50:34,694 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/3dae00be-7127-4dcb-ac18-fc4a52b29f9e
2026-09-28 03:50:34,707 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/7115d852-8bae-4a7a-bd9e-af99d52d1d67
2026-09-28 03:50:34,733 - INFO - Verified VN network id 15 for VN 3dae00be-7127-4dcb-ac18-fc4a52b29f9e
2026-09-28 03:50:34,734 - INFO - Verifications in API Server for VN ctest-right_vn-73639032 passed
2026-09-28 03:50:34,734 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/3dae00be-7127-4dcb-ac18-fc4a52b29f9e
2026-09-28 03:50:34,748 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/7115d852-8bae-4a7a-bd9e-af99d52d1d67
2026-09-28 03:50:34,759 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/7115d852-8bae-4a7a-bd9e-af99d52d1d67
2026-09-28 03:50:34,771 - DEBUG - Requesting: http://10.0.0.176:8082/route-target/20035bbd-9efe-4a53-bef7-ebccd7a69527
2026-09-28 03:50:34,786 - DEBUG - Control-node 10.0.0.176 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07405767:ctest-right_vn-73639032', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07405767', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4444490700203445707', 'uuid-lslong': '12400938970109878174'}, 'enable': 'true', 'created': '2026-09-28T03:50:33', 'last-modified': '2026-09-28T03:50:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.512641'}
2026-09-28 03:50:34,795 - DEBUG - Route Targets: ['target:64512:8000008']
2026-09-28 03:50:34,803 - DEBUG - Control-node 10.0.0.177 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07405767:ctest-right_vn-73639032', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07405767', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4444490700203445707', 'uuid-lslong': '12400938970109878174'}, 'enable': 'true', 'created': '2026-09-28T03:50:33', 'last-modified': '2026-09-28T03:50:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.534219'}
2026-09-28 03:50:34,811 - DEBUG - Route Targets: ['target:64512:8000008']
2026-09-28 03:50:34,819 - DEBUG - Control-node 10.0.0.161 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07405767:ctest-right_vn-73639032', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07405767', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4444490700203445707', 'uuid-lslong': '12400938970109878174'}, 'enable': 'true', 'created': '2026-09-28T03:50:33', 'last-modified': '2026-09-28T03:50:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.558216'}
2026-09-28 03:50:34,826 - DEBUG - Route Targets: ['target:64512:8000008']
2026-09-28 03:50:34,826 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-73639032 passed
2026-09-28 03:50:34,827 - DEBUG - ====Verifying policy data for ctest-right_vn-73639032 in API_Server ======
2026-09-28 03:50:34,827 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:34,835 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:34,857 - DEBUG - Requesting: http://10.0.0.176:8082/project/c56f0bcb-2de3-4648-ba9d-dad2bc3967e0
2026-09-28 03:50:34,970 - DEBUG - Requesting: http://10.0.0.176:8082/virtual-network/3dae00be-7127-4dcb-ac18-fc4a52b29f9e
2026-09-28 03:50:34,984 - DEBUG - =>VN ctest-right_vn-73639032 has no policy to be verified
2026-09-28 03:50:34,984 - DEBUG - Verifying the vn in opserver
2026-09-28 03:50:34,984 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07405767:ctest-right_vn-73639032 virtual network link through opserver 10.0.0.176
2026-09-28 03:50:34,984 - DEBUG - Requesting: http://10.0.0.176:8081/analytics/uves/virtual-networks
2026-09-28 03:50:34,999 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07405767:ctest-right_vn-73639032', 'href': 'http://10.0.0.176:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07405767:ctest-right_vn-73639032?flat'}
2026-09-28 03:50:34,999 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07405767:ctest-right_vn-73639032 virtual network link through opserver 10.0.0.177
2026-09-28 03:50:34,999 - DEBUG - Requesting: http://10.0.0.177:8081/analytics/uves/virtual-networks
2026-09-28 03:50:35,018 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07405767:ctest-right_vn-73639032', 'href': 'http://10.0.0.177:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07405767:ctest-right_vn-73639032?flat'}
2026-09-28 03:50:35,018 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07405767:ctest-right_vn-73639032 virtual network link through opserver 10.0.0.161
2026-09-28 03:50:35,019 - DEBUG - Requesting: http://10.0.0.161:8081/analytics/uves/virtual-networks
2026-09-28 03:50:35,036 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07405767:ctest-right_vn-73639032', 'href': 'http://10.0.0.161:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07405767:ctest-right_vn-73639032?flat'}
2026-09-28 03:50:35,037 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-07405767:ctest-right_vn-73639032 is found in opserver
2026-09-28 03:50:35,062 - DEBUG - Do not have enough data to verify VN in agent
2026-09-28 03:50:35,076 - DEBUG - VRF ids for VN ctest-right_vn-73639032: {}
2026-09-28 03:50:35,591 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6324-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6324-1)
2026-09-28 03:50:36,104 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6324-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6324-2)
2026-09-28 03:50:36,104 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-01824453']
2026-09-28 03:50:36,423 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-01824453'] created succesfully
2026-09-28 03:50:36,702 - DEBUG - Image by name tiny_nat_fw not found
2026-09-28 03:50:36,702 - DEBUG - Installing image tiny_nat_fw
2026-09-28 03:50:36,702 - 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-09-28 03:50:36,703 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-09-28 03:50:36,703 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-09-28 03:50:36,703 - DEBUG - Unzip image
2026-09-28 03:50:36,703 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-09-28 03:50:36,730 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-09-28 03:50:36,731 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-01824453']
2026-09-28 03:50:36,837 - INFO - Service template: ['default-domain', 'ctest-service_template_1-01824453'] deleted successfully.
2026-09-28 03:50:36,838 - INFO - Skip interface_detach for VM ctest-right_vm-98924136 in state BUILD
2026-09-28 03:50:36,838 - INFO - Deleting VM ctest-right_vm-98924136
2026-09-28 03:50:36,838 - ERROR - VM ctest-right_vm-98924136 has failed to come up
2026-09-28 03:50:36,838 - ERROR - Nova failed to get host of the VM
2026-09-28 03:50:36,839 - ERROR - VM ctest-right_vm-98924136 has failed to come up
2026-09-28 03:50:36,839 - ERROR - Nova failed to get host of the VM
2026-09-28 03:50:37,023 - INFO - Skip interface_detach for VM ctest-left_vm-50806702 in state BUILD
2026-09-28 03:50:37,025 - INFO - Deleting VM ctest-left_vm-50806702
2026-09-28 03:50:37,025 - ERROR - VM ctest-left_vm-50806702 has failed to come up
2026-09-28 03:50:37,025 - ERROR - Nova failed to get host of the VM
2026-09-28 03:50:37,025 - ERROR - VM ctest-left_vm-50806702 has failed to come up
2026-09-28 03:50:37,026 - ERROR - Nova failed to get host of the VM
2026-09-28 03:50:37,201 - INFO - Deleting VN ctest-right_vn-73639032
2026-09-28 03:50:37,394 - DEBUG - Response for deleting network ()
2026-09-28 03:50:37,394 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/7115d852-8bae-4a7a-bd9e-af99d52d1d67
2026-09-28 03:50:37,402 - DEBUG - Response Code: 404
2026-09-28 03:50:37,402 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:37,411 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:37,448 - DEBUG - Requesting: http://10.0.0.176:8082/project/c56f0bcb-2de3-4648-ba9d-dad2bc3967e0
2026-09-28 03:50:37,567 - INFO - Validated that VN ctest-right_vn-73639032 is not found in API Server
2026-09-28 03:50:37,585 - DEBUG - VN ctest-right_vn-73639032 is not present in Agent 10.0.0.38
2026-09-28 03:50:37,602 - DEBUG - VN ctest-right_vn-73639032 is not present in Agent 10.0.0.162
2026-09-28 03:50:37,602 - INFO - Validated that VN ctest-right_vn-73639032 is not in any agent
2026-09-28 03:50:37,648 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-73639032 info
2026-09-28 03:50:37,649 - INFO - Deleting VN ctest-left_vn-93619767
2026-09-28 03:50:37,872 - DEBUG - Response for deleting network ()
2026-09-28 03:50:37,872 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/1d5875a3-962b-4e0d-846f-b538e2f8675c
2026-09-28 03:50:37,880 - DEBUG - Response Code: 404
2026-09-28 03:50:37,880 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:37,887 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:37,953 - DEBUG - Requesting: http://10.0.0.176:8082/project/c56f0bcb-2de3-4648-ba9d-dad2bc3967e0
2026-09-28 03:50:38,076 - INFO - Validated that VN ctest-left_vn-93619767 is not found in API Server
2026-09-28 03:50:38,097 - DEBUG - VN ctest-left_vn-93619767 is not present in Agent 10.0.0.38
2026-09-28 03:50:38,113 - DEBUG - VN ctest-left_vn-93619767 is not present in Agent 10.0.0.162
2026-09-28 03:50:38,113 - INFO - Validated that VN ctest-left_vn-93619767 is not in any agent
2026-09-28 03:50:38,159 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-93619767 info
2026-09-28 03:50:38,159 - INFO - Deleting VN ctest-mgmt_vn-13389648
2026-09-28 03:50:38,378 - DEBUG - Response for deleting network ()
2026-09-28 03:50:38,378 - DEBUG - Requesting: http://10.0.0.176:8082/routing-instance/70b52d4d-3b29-4103-aa36-edaee50d498f
2026-09-28 03:50:38,393 - DEBUG - Response Code: 404
2026-09-28 03:50:38,393 - DEBUG - Requesting: http://10.0.0.176:8082/domains
2026-09-28 03:50:38,402 - DEBUG - Requesting: http://10.0.0.176:8082/domain/6a7973b0-69cf-4d5f-a060-1b4d1311d404
2026-09-28 03:50:38,418 - DEBUG - Requesting: http://10.0.0.176:8082/project/c56f0bcb-2de3-4648-ba9d-dad2bc3967e0
2026-09-28 03:50:38,537 - INFO - Validated that VN ctest-mgmt_vn-13389648 is not found in API Server
2026-09-28 03:50:38,554 - DEBUG - VN ctest-mgmt_vn-13389648 is not present in Agent 10.0.0.38
2026-09-28 03:50:38,566 - DEBUG - VN ctest-mgmt_vn-13389648 is not present in Agent 10.0.0.162
2026-09-28 03:50:38,567 - INFO - Validated that VN ctest-mgmt_vn-13389648 is not in any agent
2026-09-28 03:50:38,612 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-13389648 info
2026-09-28 03:50:39,957 - DEBUG - No XMPP flaps were noticed during the test
2026-09-28 03:50:39,957 - INFO -
2026-09-28 03:50:39,957 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:10]
2026-09-28 03:50:39,957 - INFO - --------------------------------------------------------------------------------
2026-09-28 03:50:41,652 - INFO - Deleted project: ctest-TestSvcRegr-07405767, ID : c56f0bcb-2de3-4648-ba9d-dad2bc3967e0