]) created on node: (an-jenkins-deploy-platform-ansible-os-3786-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3786-1)
2025-08-10 11:49:51,827 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-36257396']
2025-08-10 11:49:52,139 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-36257396'] created succesfully
2025-08-10 11:49:52,495 - DEBUG - Image by name tiny_nat_fw not found
2025-08-10 11:49:52,495 - DEBUG - Installing image tiny_nat_fw
2025-08-10 11:49:52,495 - 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'"}
2025-08-10 11:49:52,496 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2025-08-10 11:49:52,496 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2025-08-10 11:49:52,520 - 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
2025-08-10 11:49:52,582 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-08-10 11:49:52,582 - DEBUG - Unzip image
2025-08-10 11:49:52,583 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-08-10 11:49:52,600 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2025-08-10 11:49:52,600 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-36257396']
2025-08-10 11:49:52,740 - INFO - Service template: ['default-domain', 'ctest-service_template_1-36257396'] deleted successfully.
2025-08-10 11:49:52,740 - INFO - Skip interface_detach for VM ctest-right_vm-98670557 in state BUILD
2025-08-10 11:49:52,740 - INFO - Deleting VM ctest-right_vm-98670557
2025-08-10 11:49:52,799 - ERROR - VM ctest-right_vm-98670557 has failed to come up
2025-08-10 11:49:52,799 - ERROR - Nova failed to get host of the VM
2025-08-10 11:49:52,799 - ERROR - VM ctest-right_vm-98670557 has failed to come up
2025-08-10 11:49:52,799 - ERROR - Nova failed to get host of the VM
2025-08-10 11:49:52,892 - INFO - Skip interface_detach for VM ctest-left_vm-26699729 in state BUILD
2025-08-10 11:49:52,892 - INFO - Deleting VM ctest-left_vm-26699729
2025-08-10 11:49:52,892 - ERROR - VM ctest-left_vm-26699729 has failed to come up
2025-08-10 11:49:52,892 - ERROR - Nova failed to get host of the VM
2025-08-10 11:49:52,892 - ERROR - VM ctest-left_vm-26699729 has failed to come up
2025-08-10 11:49:52,892 - ERROR - Nova failed to get host of the VM
2025-08-10 11:49:52,963 - INFO - Deleting VN ctest-right_vn-68603940
2025-08-10 11:49:53,010 - DEBUG - VN 7f145dad-8363-4eb0-b11a-167ce14b5c4d still in use: Unable to complete operation on network 7f145dad-8363-4eb0-b11a-167ce14b5c4d. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-1c525902-7942-4dc4-9752-0ff69b7de48f']
2025-08-10 11:49:53,010 - WARNING - Deleting VN ctest-right_vn-68603940 failed..Will retry
2025-08-10 11:49:55,186 - DEBUG - Response for deleting network ()
2025-08-10 11:49:55,186 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/12e53b58-9501-4ec2-bcc6-fb88d3776f9b
2025-08-10 11:49:55,195 - DEBUG - Response Code: 404
2025-08-10 11:49:55,196 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:49:55,202 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:49:55,223 - DEBUG - Requesting: http://10.0.0.49:8082/project/fea17821-d266-432a-9089-138c12fbcc61
2025-08-10 11:49:55,341 - INFO - Validated that VN ctest-right_vn-68603940 is not found in API Server
2025-08-10 11:49:55,352 - DEBUG - VN ctest-right_vn-68603940 is not present in Agent 10.0.0.65
2025-08-10 11:49:55,362 - DEBUG - VN ctest-right_vn-68603940 is not present in Agent 10.0.0.56
2025-08-10 11:49:55,362 - INFO - Validated that VN ctest-right_vn-68603940 is not in any agent
2025-08-10 11:49:55,392 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-68603940 info
2025-08-10 11:49:55,392 - INFO - Deleting VN ctest-left_vn-68732429
2025-08-10 11:49:55,574 - DEBUG - Response for deleting network ()
2025-08-10 11:49:55,574 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/e6250283-5c9c-49c0-9c46-e39f2d9a5071
2025-08-10 11:49:55,587 - DEBUG - Response Code: 404
2025-08-10 11:49:55,587 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:49:55,597 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:49:55,649 - DEBUG - Requesting: http://10.0.0.49:8082/project/fea17821-d266-432a-9089-138c12fbcc61
2025-08-10 11:49:55,741 - INFO - Validated that VN ctest-left_vn-68732429 is not found in API Server
2025-08-10 11:49:55,755 - DEBUG - VN ctest-left_vn-68732429 is not present in Agent 10.0.0.65
2025-08-10 11:49:55,764 - DEBUG - VN ctest-left_vn-68732429 is not present in Agent 10.0.0.56
2025-08-10 11:49:55,764 - INFO - Validated that VN ctest-left_vn-68732429 is not in any agent
2025-08-10 11:49:55,797 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-68732429 info
2025-08-10 11:49:55,797 - INFO - Deleting VN ctest-mgmt_vn-24151132
2025-08-10 11:49:55,949 - DEBUG - Response for deleting network ()
2025-08-10 11:49:55,949 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/5b7bdb0b-85e5-4ba6-8669-f69639da10a8
2025-08-10 11:49:55,955 - DEBUG - Response Code: 404
2025-08-10 11:49:55,955 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:49:55,967 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:49:55,983 - DEBUG - Requesting: http://10.0.0.49:8082/project/fea17821-d266-432a-9089-138c12fbcc61
2025-08-10 11:49:56,062 - INFO - Validated that VN ctest-mgmt_vn-24151132 is not found in API Server
2025-08-10 11:49:56,077 - DEBUG - VN ctest-mgmt_vn-24151132 is not present in Agent 10.0.0.65
2025-08-10 11:49:56,088 - DEBUG - VN ctest-mgmt_vn-24151132 is not present in Agent 10.0.0.56
2025-08-10 11:49:56,088 - INFO - Validated that VN ctest-mgmt_vn-24151132 is not in any agent
2025-08-10 11:49:56,123 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-24151132 info
2025-08-10 11:49:56,124 - INFO - Deleting VM ctest-vm-in-third-vn-17417822
2025-08-10 11:49:56,189 - INFO - Deleting VN ctest-third-vn-48924536
2025-08-10 11:49:56,229 - DEBUG - VN c0621f0a-c77c-4d6d-8319-b09fd5ae3ca0 still in use: Unable to complete operation on network c0621f0a-c77c-4d6d-8319-b09fd5ae3ca0. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-a6780f40-b75e-4b7b-9564-c4074ad9cdaf']
2025-08-10 11:49:56,230 - WARNING - Deleting VN ctest-third-vn-48924536 failed..Will retry
2025-08-10 11:49:58,362 - DEBUG - Response for deleting network ()
2025-08-10 11:49:59,612 - DEBUG - No XMPP flaps were noticed during the test
2025-08-10 11:49:59,612 - INFO -
2025-08-10 11:49:59,612 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:23]
2025-08-10 11:49:59,612 - INFO - --------------------------------------------------------------------------------
2025-08-10 11:49:59,615 - INFO - ================================================================================
2025-08-10 11:49:59,615 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2025-08-10 11:50:00,871 - DEBUG - Nothing to compare xmpp stats {'10.0.0.65': {'10.20.0.14': '0', '10.20.0.25': '0'}, '10.0.0.56': {'10.20.0.254': '0', '10.20.0.14': '0'}} with
2025-08-10 11:50:00,871 - INFO - Initial checks done. Running the testcase now
2025-08-10 11:50:00,871 - INFO -
2025-08-10 11:50:01,123 - DEBUG - Response for create_network : {'network': {'id': '5a0f753d-b6ec-4073-bc97-5c20faa6083b', 'name': 'ctest-mgmt_vn-98283675', 'tenant_id': 'fea17821d266432a9089138c12fbcc61', 'project_id': 'fea17821d266432a9089138c12fbcc61', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-07146533', 'ctest-mgmt_vn-98283675'], 'port_security_enabled': True, 'description': ''}}
2025-08-10 11:50:01,297 - DEBUG - Response for create_subnet : {'subnet': {'id': '9ffe0688-c5c4-4f32-add4-60ab4bc352b6', 'name': '', 'tenant_id': 'fea17821d266432a9089138c12fbcc61', 'network_id': '5a0f753d-b6ec-4073-bc97-5c20faa6083b', 'ip_version': 4, 'cidr': '72.112.9.192/26', 'allocation_pools': [{'start': '72.112.9.194', 'end': '72.112.9.254'}], 'gateway_ip': '72.112.9.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '72.112.9.194', 'tags': [], 'project_id': 'fea17821d266432a9089138c12fbcc61'}}
2025-08-10 11:50:01,318 - INFO - Created VN ctest-mgmt_vn-98283675
2025-08-10 11:50:01,330 - DEBUG - VN ctest-mgmt_vn-98283675 UUID is 5a0f753d-b6ec-4073-bc97-5c20faa6083b
2025-08-10 11:50:01,387 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:01,393 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:01,403 - DEBUG - Requesting: http://10.0.0.49:8082/project/fea17821-d266-432a-9089-138c12fbcc61
2025-08-10 11:50:01,492 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/5a0f753d-b6ec-4073-bc97-5c20faa6083b
2025-08-10 11:50:01,502 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/5a0f753d-b6ec-4073-bc97-5c20faa6083b
2025-08-10 11:50:01,510 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/8e5f2e3a-08f6-4988-a90d-b4518f59437a
2025-08-10 11:50:01,517 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/8e5f2e3a-08f6-4988-a90d-b4518f59437a
2025-08-10 11:50:01,523 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/de55dfb7-4afd-44c7-9975-155bb257f023
2025-08-10 11:50:01,529 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-10 11:50:01,529 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/5a0f753d-b6ec-4073-bc97-5c20faa6083b
2025-08-10 11:50:01,538 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/8e5f2e3a-08f6-4988-a90d-b4518f59437a
2025-08-10 11:50:01,552 - INFO - Verified VN network id 15 for VN 5a0f753d-b6ec-4073-bc97-5c20faa6083b
2025-08-10 11:50:01,552 - INFO - Verifications in API Server for VN ctest-mgmt_vn-98283675 passed
2025-08-10 11:50:01,552 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/5a0f753d-b6ec-4073-bc97-5c20faa6083b
2025-08-10 11:50:01,561 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/8e5f2e3a-08f6-4988-a90d-b4518f59437a
2025-08-10 11:50:01,567 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/8e5f2e3a-08f6-4988-a90d-b4518f59437a
2025-08-10 11:50:01,574 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/de55dfb7-4afd-44c7-9975-155bb257f023
2025-08-10 11:50:01,586 - DEBUG - Control-node 10.0.0.49 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07146533:ctest-mgmt_vn-98283675', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07146533', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6489534495986565235', 'uuid-lslong': '13589431697327654971'}, 'enable': 'true', 'created': '2025-08-10T11:50:01', 'last-modified': '2025-08-10T11:50:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.343988'}
2025-08-10 11:50:01,592 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-10 11:50:01,599 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07146533:ctest-mgmt_vn-98283675', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07146533', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6489534495986565235', 'uuid-lslong': '13589431697327654971'}, 'enable': 'true', 'created': '2025-08-10T11:50:01', 'last-modified': '2025-08-10T11:50:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.347640'}
2025-08-10 11:50:01,605 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-10 11:50:01,611 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07146533:ctest-mgmt_vn-98283675', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07146533', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6489534495986565235', 'uuid-lslong': '13589431697327654971'}, 'enable': 'true', 'created': '2025-08-10T11:50:01', 'last-modified': '2025-08-10T11:50:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.366354'}
2025-08-10 11:50:01,617 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-10 11:50:01,617 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-98283675 passed
2025-08-10 11:50:01,617 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-98283675 in API_Server ======
2025-08-10 11:50:01,617 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:01,624 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:01,637 - DEBUG - Requesting: http://10.0.0.49:8082/project/fea17821-d266-432a-9089-138c12fbcc61
2025-08-10 11:50:01,726 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/5a0f753d-b6ec-4073-bc97-5c20faa6083b
2025-08-10 11:50:01,737 - DEBUG - =>VN ctest-mgmt_vn-98283675 has no policy to be verified
2025-08-10 11:50:01,737 - DEBUG - Verifying the vn in opserver
2025-08-10 11:50:01,737 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07146533:ctest-mgmt_vn-98283675 virtual network link through opserver 10.0.0.49
2025-08-10 11:50:01,737 - DEBUG - Requesting: http://10.0.0.49:8081/analytics/uves/virtual-networks
2025-08-10 11:50:01,750 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07146533:ctest-mgmt_vn-98283675', 'href': 'http://10.0.0.49:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07146533:ctest-mgmt_vn-98283675?flat'}
2025-08-10 11:50:01,750 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07146533:ctest-mgmt_vn-98283675 virtual network link through opserver 10.0.0.254
2025-08-10 11:50:01,750 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-08-10 11:50:01,761 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07146533:ctest-mgmt_vn-98283675', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07146533:ctest-mgmt_vn-98283675?flat'}
2025-08-10 11:50:01,761 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07146533:ctest-mgmt_vn-98283675 virtual network link through opserver 10.0.0.57
2025-08-10 11:50:01,761 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-08-10 11:50:01,773 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07146533:ctest-mgmt_vn-98283675', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07146533:ctest-mgmt_vn-98283675?flat'}
2025-08-10 11:50:01,773 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-07146533:ctest-mgmt_vn-98283675 is found in opserver
2025-08-10 11:50:01,793 - DEBUG - Do not have enough data to verify VN in agent
2025-08-10 11:50:01,802 - DEBUG - VRF ids for VN ctest-mgmt_vn-98283675: {}
2025-08-10 11:50:02,039 - DEBUG - Response for create_network : {'network': {'id': '5bd8279c-f993-45ff-a280-08bd4edf18db', 'name': 'ctest-left_vn-60140736', 'tenant_id': 'fea17821d266432a9089138c12fbcc61', 'project_id': 'fea17821d266432a9089138c12fbcc61', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-07146533', 'ctest-left_vn-60140736'], 'port_security_enabled': True, 'description': ''}}
2025-08-10 11:50:02,265 - DEBUG - Response for create_subnet : {'subnet': {'id': '6d568562-d46f-4e7b-a72d-34e155f8955d', 'name': '', 'tenant_id': 'fea17821d266432a9089138c12fbcc61', 'network_id': '5bd8279c-f993-45ff-a280-08bd4edf18db', 'ip_version': 4, 'cidr': '145.17.22.192/26', 'allocation_pools': [{'start': '145.17.22.194', 'end': '145.17.22.254'}], 'gateway_ip': '145.17.22.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '145.17.22.194', 'tags': [], 'project_id': 'fea17821d266432a9089138c12fbcc61'}}
2025-08-10 11:50:02,284 - INFO - Created VN ctest-left_vn-60140736
2025-08-10 11:50:02,296 - DEBUG - VN ctest-left_vn-60140736 UUID is 5bd8279c-f993-45ff-a280-08bd4edf18db
2025-08-10 11:50:02,356 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:02,361 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:02,372 - DEBUG - Requesting: http://10.0.0.49:8082/project/fea17821-d266-432a-9089-138c12fbcc61
2025-08-10 11:50:02,456 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/5bd8279c-f993-45ff-a280-08bd4edf18db
2025-08-10 11:50:02,466 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/5bd8279c-f993-45ff-a280-08bd4edf18db
2025-08-10 11:50:02,475 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/29c35aa7-00e5-49a6-b557-d9f6bf5e6965
2025-08-10 11:50:02,483 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/29c35aa7-00e5-49a6-b557-d9f6bf5e6965
2025-08-10 11:50:02,489 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/348dfa6c-d229-4d25-adca-052c06200a66
2025-08-10 11:50:02,496 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-10 11:50:02,496 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/5bd8279c-f993-45ff-a280-08bd4edf18db
2025-08-10 11:50:02,504 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/29c35aa7-00e5-49a6-b557-d9f6bf5e6965
2025-08-10 11:50:02,518 - INFO - Verified VN network id 16 for VN 5bd8279c-f993-45ff-a280-08bd4edf18db
2025-08-10 11:50:02,518 - INFO - Verifications in API Server for VN ctest-left_vn-60140736 passed
2025-08-10 11:50:02,518 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/5bd8279c-f993-45ff-a280-08bd4edf18db
2025-08-10 11:50:02,527 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/29c35aa7-00e5-49a6-b557-d9f6bf5e6965
2025-08-10 11:50:02,533 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/29c35aa7-00e5-49a6-b557-d9f6bf5e6965
2025-08-10 11:50:02,539 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/348dfa6c-d229-4d25-adca-052c06200a66
2025-08-10 11:50:02,551 - DEBUG - Control-node 10.0.0.49 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07146533:ctest-left_vn-60140736', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07146533', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6618083207576503807', 'uuid-lslong': '11709368640328374491'}, 'enable': 'true', 'created': '2025-08-10T11:50:01', 'last-modified': '2025-08-10T11:50:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.327544'}
2025-08-10 11:50:02,557 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-10 11:50:02,562 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07146533:ctest-left_vn-60140736', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07146533', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6618083207576503807', 'uuid-lslong': '11709368640328374491'}, 'enable': 'true', 'created': '2025-08-10T11:50:01', 'last-modified': '2025-08-10T11:50:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.343573'}
2025-08-10 11:50:02,568 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-10 11:50:02,573 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07146533:ctest-left_vn-60140736', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07146533', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6618083207576503807', 'uuid-lslong': '11709368640328374491'}, 'enable': 'true', 'created': '2025-08-10T11:50:01', 'last-modified': '2025-08-10T11:50:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.352497'}
2025-08-10 11:50:02,579 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-10 11:50:02,579 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-60140736 passed
2025-08-10 11:50:02,579 - DEBUG - ====Verifying policy data for ctest-left_vn-60140736 in API_Server ======
2025-08-10 11:50:02,580 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:02,585 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:02,595 - DEBUG - Requesting: http://10.0.0.49:8082/project/fea17821-d266-432a-9089-138c12fbcc61
2025-08-10 11:50:02,683 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/5bd8279c-f993-45ff-a280-08bd4edf18db
2025-08-10 11:50:02,695 - DEBUG - =>VN ctest-left_vn-60140736 has no policy to be verified
2025-08-10 11:50:02,695 - DEBUG - Verifying the vn in opserver
2025-08-10 11:50:02,695 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07146533:ctest-left_vn-60140736 virtual network link through opserver 10.0.0.49
2025-08-10 11:50:02,695 - DEBUG - Requesting: http://10.0.0.49:8081/analytics/uves/virtual-networks
2025-08-10 11:50:02,707 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07146533:ctest-left_vn-60140736', 'href': 'http://10.0.0.49:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07146533:ctest-left_vn-60140736?flat'}
2025-08-10 11:50:02,707 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07146533:ctest-left_vn-60140736 virtual network link through opserver 10.0.0.254
2025-08-10 11:50:02,707 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-08-10 11:50:02,718 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07146533:ctest-left_vn-60140736', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07146533:ctest-left_vn-60140736?flat'}
2025-08-10 11:50:02,718 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07146533:ctest-left_vn-60140736 virtual network link through opserver 10.0.0.57
2025-08-10 11:50:02,718 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-08-10 11:50:02,730 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07146533:ctest-left_vn-60140736', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07146533:ctest-left_vn-60140736?flat'}
2025-08-10 11:50:02,730 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-07146533:ctest-left_vn-60140736 is found in opserver
2025-08-10 11:50:02,750 - DEBUG - Do not have enough data to verify VN in agent
2025-08-10 11:50:02,760 - DEBUG - VRF ids for VN ctest-left_vn-60140736: {}
2025-08-10 11:50:02,999 - DEBUG - Response for create_network : {'network': {'id': '695a82f5-08dc-4835-acf2-31399da98c8d', 'name': 'ctest-right_vn-48655534', 'tenant_id': 'fea17821d266432a9089138c12fbcc61', 'project_id': 'fea17821d266432a9089138c12fbcc61', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-07146533', 'ctest-right_vn-48655534'], 'port_security_enabled': True, 'description': ''}}
2025-08-10 11:50:03,235 - DEBUG - Response for create_subnet : {'subnet': {'id': '1b5eb61f-2f3d-4c9d-abb4-56e7f69f6775', 'name': '', 'tenant_id': 'fea17821d266432a9089138c12fbcc61', 'network_id': '695a82f5-08dc-4835-acf2-31399da98c8d', 'ip_version': 4, 'cidr': '80.153.132.64/26', 'allocation_pools': [{'start': '80.153.132.66', 'end': '80.153.132.126'}], 'gateway_ip': '80.153.132.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '80.153.132.66', 'tags': [], 'project_id': 'fea17821d266432a9089138c12fbcc61'}}
2025-08-10 11:50:03,252 - INFO - Created VN ctest-right_vn-48655534
2025-08-10 11:50:03,263 - DEBUG - VN ctest-right_vn-48655534 UUID is 695a82f5-08dc-4835-acf2-31399da98c8d
2025-08-10 11:50:03,318 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:03,323 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:03,334 - DEBUG - Requesting: http://10.0.0.49:8082/project/fea17821-d266-432a-9089-138c12fbcc61
2025-08-10 11:50:03,429 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/695a82f5-08dc-4835-acf2-31399da98c8d
2025-08-10 11:50:03,444 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/695a82f5-08dc-4835-acf2-31399da98c8d
2025-08-10 11:50:03,456 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/a0deac93-6055-4c52-80be-ddceb604682d
2025-08-10 11:50:03,472 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/a0deac93-6055-4c52-80be-ddceb604682d
2025-08-10 11:50:03,478 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/aaa4e510-6769-4c7d-aa2b-bca1c12d650b
2025-08-10 11:50:03,484 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-10 11:50:03,484 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/695a82f5-08dc-4835-acf2-31399da98c8d
2025-08-10 11:50:03,494 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/a0deac93-6055-4c52-80be-ddceb604682d
2025-08-10 11:50:03,508 - INFO - Verified VN network id 17 for VN 695a82f5-08dc-4835-acf2-31399da98c8d
2025-08-10 11:50:03,508 - INFO - Verifications in API Server for VN ctest-right_vn-48655534 passed
2025-08-10 11:50:03,508 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/695a82f5-08dc-4835-acf2-31399da98c8d
2025-08-10 11:50:03,517 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/a0deac93-6055-4c52-80be-ddceb604682d
2025-08-10 11:50:03,523 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/a0deac93-6055-4c52-80be-ddceb604682d
2025-08-10 11:50:03,529 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/aaa4e510-6769-4c7d-aa2b-bca1c12d650b
2025-08-10 11:50:03,541 - DEBUG - Control-node 10.0.0.49 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07146533:ctest-right_vn-48655534', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07146533', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7591524110813644853', 'uuid-lslong': '12462077242415615117'}, 'enable': 'true', 'created': '2025-08-10T11:50:02', 'last-modified': '2025-08-10T11:50:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.357467'}
2025-08-10 11:50:03,546 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-10 11:50:03,552 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07146533:ctest-right_vn-48655534', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07146533', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7591524110813644853', 'uuid-lslong': '12462077242415615117'}, 'enable': 'true', 'created': '2025-08-10T11:50:02', 'last-modified': '2025-08-10T11:50:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.363079'}
2025-08-10 11:50:03,558 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-10 11:50:03,563 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07146533:ctest-right_vn-48655534', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07146533', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7591524110813644853', 'uuid-lslong': '12462077242415615117'}, 'enable': 'true', 'created': '2025-08-10T11:50:02', 'last-modified': '2025-08-10T11:50:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.379909'}
2025-08-10 11:50:03,569 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-10 11:50:03,569 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-48655534 passed
2025-08-10 11:50:03,569 - DEBUG - ====Verifying policy data for ctest-right_vn-48655534 in API_Server ======
2025-08-10 11:50:03,569 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:03,574 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:03,585 - DEBUG - Requesting: http://10.0.0.49:8082/project/fea17821-d266-432a-9089-138c12fbcc61
2025-08-10 11:50:03,669 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/695a82f5-08dc-4835-acf2-31399da98c8d
2025-08-10 11:50:03,680 - DEBUG - =>VN ctest-right_vn-48655534 has no policy to be verified
2025-08-10 11:50:03,680 - DEBUG - Verifying the vn in opserver
2025-08-10 11:50:03,680 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07146533:ctest-right_vn-48655534 virtual network link through opserver 10.0.0.49
2025-08-10 11:50:03,680 - DEBUG - Requesting: http://10.0.0.49:8081/analytics/uves/virtual-networks
2025-08-10 11:50:03,691 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07146533:ctest-right_vn-48655534', 'href': 'http://10.0.0.49:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07146533:ctest-right_vn-48655534?flat'}
2025-08-10 11:50:03,691 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07146533:ctest-right_vn-48655534 virtual network link through opserver 10.0.0.254
2025-08-10 11:50:03,691 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-08-10 11:50:03,703 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07146533:ctest-right_vn-48655534', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07146533:ctest-right_vn-48655534?flat'}
2025-08-10 11:50:03,703 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07146533:ctest-right_vn-48655534 virtual network link through opserver 10.0.0.57
2025-08-10 11:50:03,703 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-08-10 11:50:03,717 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07146533:ctest-right_vn-48655534', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07146533:ctest-right_vn-48655534?flat'}
2025-08-10 11:50:03,717 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-07146533:ctest-right_vn-48655534 is found in opserver
2025-08-10 11:50:03,736 - DEBUG - Do not have enough data to verify VN in agent
2025-08-10 11:50:03,745 - DEBUG - VRF ids for VN ctest-right_vn-48655534: {}
2025-08-10 11:50:04,008 - DEBUG - Response for create_network : {'network': {'id': 'ec93c644-6053-40eb-8672-3d18c197c4ae', 'name': 'ctest-trans_left_vn-99242465', 'tenant_id': 'fea17821d266432a9089138c12fbcc61', 'project_id': 'fea17821d266432a9089138c12fbcc61', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-07146533', 'ctest-trans_left_vn-99242465'], 'port_security_enabled': True, 'description': ''}}
2025-08-10 11:50:04,196 - DEBUG - Response for create_subnet : {'subnet': {'id': '97cdb271-28d3-499d-80f5-f214f7518873', 'name': '', 'tenant_id': 'fea17821d266432a9089138c12fbcc61', 'network_id': 'ec93c644-6053-40eb-8672-3d18c197c4ae', 'ip_version': 4, 'cidr': '27.93.83.192/26', 'allocation_pools': [{'start': '27.93.83.194', 'end': '27.93.83.254'}], 'gateway_ip': '27.93.83.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '27.93.83.194', 'tags': [], 'project_id': 'fea17821d266432a9089138c12fbcc61'}}
2025-08-10 11:50:04,215 - INFO - Created VN ctest-trans_left_vn-99242465
2025-08-10 11:50:04,228 - DEBUG - VN ctest-trans_left_vn-99242465 UUID is ec93c644-6053-40eb-8672-3d18c197c4ae
2025-08-10 11:50:04,282 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:04,287 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:04,297 - DEBUG - Requesting: http://10.0.0.49:8082/project/fea17821-d266-432a-9089-138c12fbcc61
2025-08-10 11:50:04,381 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/ec93c644-6053-40eb-8672-3d18c197c4ae
2025-08-10 11:50:04,391 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/ec93c644-6053-40eb-8672-3d18c197c4ae
2025-08-10 11:50:04,399 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/dcf13744-64c7-4ce3-b7e6-9243278ca987
2025-08-10 11:50:04,406 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/dcf13744-64c7-4ce3-b7e6-9243278ca987
2025-08-10 11:50:04,412 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/81ea4bf6-3289-4e8f-a666-a937f420dd38
2025-08-10 11:50:04,417 - DEBUG - Route Targets: ['target:64512:8000008']
2025-08-10 11:50:04,417 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/ec93c644-6053-40eb-8672-3d18c197c4ae
2025-08-10 11:50:04,426 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/dcf13744-64c7-4ce3-b7e6-9243278ca987
2025-08-10 11:50:04,439 - INFO - Verified VN network id 18 for VN ec93c644-6053-40eb-8672-3d18c197c4ae
2025-08-10 11:50:04,439 - INFO - Verifications in API Server for VN ctest-trans_left_vn-99242465 passed
2025-08-10 11:50:04,439 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/ec93c644-6053-40eb-8672-3d18c197c4ae
2025-08-10 11:50:04,448 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/dcf13744-64c7-4ce3-b7e6-9243278ca987
2025-08-10 11:50:04,454 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/dcf13744-64c7-4ce3-b7e6-9243278ca987
2025-08-10 11:50:04,460 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/81ea4bf6-3289-4e8f-a666-a937f420dd38
2025-08-10 11:50:04,471 - DEBUG - Control-node 10.0.0.49 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07146533:ctest-trans_left_vn-99242465', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07146533', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17047187011503603947', 'uuid-lslong': '9687872924963816622'}, 'enable': 'true', 'created': '2025-08-10T11:50:03', 'last-modified': '2025-08-10T11:50:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.316679'}
2025-08-10 11:50:04,477 - DEBUG - Route Targets: ['target:64512:8000008']
2025-08-10 11:50:04,482 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07146533:ctest-trans_left_vn-99242465', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07146533', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17047187011503603947', 'uuid-lslong': '9687872924963816622'}, 'enable': 'true', 'created': '2025-08-10T11:50:03', 'last-modified': '2025-08-10T11:50:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.326627'}
2025-08-10 11:50:04,488 - DEBUG - Route Targets: ['target:64512:8000008']
2025-08-10 11:50:04,493 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07146533:ctest-trans_left_vn-99242465', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07146533', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17047187011503603947', 'uuid-lslong': '9687872924963816622'}, 'enable': 'true', 'created': '2025-08-10T11:50:03', 'last-modified': '2025-08-10T11:50:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.340155'}
2025-08-10 11:50:04,499 - DEBUG - Route Targets: ['target:64512:8000008']
2025-08-10 11:50:04,499 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-99242465 passed
2025-08-10 11:50:04,499 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-99242465 in API_Server ======
2025-08-10 11:50:04,499 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:04,504 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:04,514 - DEBUG - Requesting: http://10.0.0.49:8082/project/fea17821-d266-432a-9089-138c12fbcc61
2025-08-10 11:50:04,604 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/ec93c644-6053-40eb-8672-3d18c197c4ae
2025-08-10 11:50:04,613 - DEBUG - =>VN ctest-trans_left_vn-99242465 has no policy to be verified
2025-08-10 11:50:04,613 - DEBUG - Verifying the vn in opserver
2025-08-10 11:50:04,613 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07146533:ctest-trans_left_vn-99242465 virtual network link through opserver 10.0.0.49
2025-08-10 11:50:04,613 - DEBUG - Requesting: http://10.0.0.49:8081/analytics/uves/virtual-networks
2025-08-10 11:50:04,624 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07146533:ctest-trans_left_vn-99242465', 'href': 'http://10.0.0.49:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07146533:ctest-trans_left_vn-99242465?flat'}
2025-08-10 11:50:04,624 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07146533:ctest-trans_left_vn-99242465 virtual network link through opserver 10.0.0.254
2025-08-10 11:50:04,624 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-08-10 11:50:04,635 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07146533:ctest-trans_left_vn-99242465', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07146533:ctest-trans_left_vn-99242465?flat'}
2025-08-10 11:50:04,635 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07146533:ctest-trans_left_vn-99242465 virtual network link through opserver 10.0.0.57
2025-08-10 11:50:04,635 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-08-10 11:50:04,647 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07146533:ctest-trans_left_vn-99242465', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07146533:ctest-trans_left_vn-99242465?flat'}
2025-08-10 11:50:04,647 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-07146533:ctest-trans_left_vn-99242465 is found in opserver
2025-08-10 11:50:04,666 - DEBUG - Do not have enough data to verify VN in agent
2025-08-10 11:50:04,675 - DEBUG - VRF ids for VN ctest-trans_left_vn-99242465: {}
2025-08-10 11:50:04,904 - DEBUG - Response for create_network : {'network': {'id': '19bbf95b-4bc0-40b5-85f8-e0dd636f9e32', 'name': 'ctest-trans_right_vn-73411589', 'tenant_id': 'fea17821d266432a9089138c12fbcc61', 'project_id': 'fea17821d266432a9089138c12fbcc61', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-07146533', 'ctest-trans_right_vn-73411589'], 'port_security_enabled': True, 'description': ''}}
2025-08-10 11:50:05,137 - DEBUG - Response for create_subnet : {'subnet': {'id': '5b907ca3-0d6a-4754-afbc-c993094c2a7a', 'name': '', 'tenant_id': 'fea17821d266432a9089138c12fbcc61', 'network_id': '19bbf95b-4bc0-40b5-85f8-e0dd636f9e32', 'ip_version': 4, 'cidr': '148.87.24.128/26', 'allocation_pools': [{'start': '148.87.24.130', 'end': '148.87.24.190'}], 'gateway_ip': '148.87.24.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '148.87.24.130', 'tags': [], 'project_id': 'fea17821d266432a9089138c12fbcc61'}}
2025-08-10 11:50:05,155 - INFO - Created VN ctest-trans_right_vn-73411589
2025-08-10 11:50:05,165 - DEBUG - VN ctest-trans_right_vn-73411589 UUID is 19bbf95b-4bc0-40b5-85f8-e0dd636f9e32
2025-08-10 11:50:05,223 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:05,229 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:05,240 - DEBUG - Requesting: http://10.0.0.49:8082/project/fea17821-d266-432a-9089-138c12fbcc61
2025-08-10 11:50:05,319 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/19bbf95b-4bc0-40b5-85f8-e0dd636f9e32
2025-08-10 11:50:05,332 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/19bbf95b-4bc0-40b5-85f8-e0dd636f9e32
2025-08-10 11:50:05,340 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/5439e91a-ad39-4c2d-8b0a-aee73192de94
2025-08-10 11:50:05,348 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/5439e91a-ad39-4c2d-8b0a-aee73192de94
2025-08-10 11:50:05,354 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/d213785c-0cac-4936-94a2-d03f913b61de
2025-08-10 11:50:05,360 - DEBUG - Route Targets: ['target:64512:8000009']
2025-08-10 11:50:05,360 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/19bbf95b-4bc0-40b5-85f8-e0dd636f9e32
2025-08-10 11:50:05,368 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/5439e91a-ad39-4c2d-8b0a-aee73192de94
2025-08-10 11:50:05,382 - INFO - Verified VN network id 19 for VN 19bbf95b-4bc0-40b5-85f8-e0dd636f9e32
2025-08-10 11:50:05,382 - INFO - Verifications in API Server for VN ctest-trans_right_vn-73411589 passed
2025-08-10 11:50:05,382 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/19bbf95b-4bc0-40b5-85f8-e0dd636f9e32
2025-08-10 11:50:05,390 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/5439e91a-ad39-4c2d-8b0a-aee73192de94
2025-08-10 11:50:05,396 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/5439e91a-ad39-4c2d-8b0a-aee73192de94
2025-08-10 11:50:05,402 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/d213785c-0cac-4936-94a2-d03f913b61de
2025-08-10 11:50:05,413 - DEBUG - Control-node 10.0.0.49 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07146533:ctest-trans_right_vn-73411589', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07146533', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1854349842101321909', 'uuid-lslong': '9653713042729311794'}, 'enable': 'true', 'created': '2025-08-10T11:50:04', 'last-modified': '2025-08-10T11:50:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.319623'}
2025-08-10 11:50:05,419 - DEBUG - Route Targets: ['target:64512:8000009']
2025-08-10 11:50:05,426 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07146533:ctest-trans_right_vn-73411589', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07146533', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1854349842101321909', 'uuid-lslong': '9653713042729311794'}, 'enable': 'true', 'created': '2025-08-10T11:50:04', 'last-modified': '2025-08-10T11:50:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.325224'}
2025-08-10 11:50:05,431 - DEBUG - Route Targets: ['target:64512:8000009']
2025-08-10 11:50:05,437 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-07146533:ctest-trans_right_vn-73411589', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-07146533', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1854349842101321909', 'uuid-lslong': '9653713042729311794'}, 'enable': 'true', 'created': '2025-08-10T11:50:04', 'last-modified': '2025-08-10T11:50:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.342163'}
2025-08-10 11:50:05,442 - DEBUG - Route Targets: ['target:64512:8000009']
2025-08-10 11:50:05,442 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-73411589 passed
2025-08-10 11:50:05,443 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-73411589 in API_Server ======
2025-08-10 11:50:05,443 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:05,447 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:05,458 - DEBUG - Requesting: http://10.0.0.49:8082/project/fea17821-d266-432a-9089-138c12fbcc61
2025-08-10 11:50:05,538 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/19bbf95b-4bc0-40b5-85f8-e0dd636f9e32
2025-08-10 11:50:05,547 - DEBUG - =>VN ctest-trans_right_vn-73411589 has no policy to be verified
2025-08-10 11:50:05,547 - DEBUG - Verifying the vn in opserver
2025-08-10 11:50:05,547 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07146533:ctest-trans_right_vn-73411589 virtual network link through opserver 10.0.0.49
2025-08-10 11:50:05,547 - DEBUG - Requesting: http://10.0.0.49:8081/analytics/uves/virtual-networks
2025-08-10 11:50:05,557 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07146533:ctest-trans_right_vn-73411589', 'href': 'http://10.0.0.49:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07146533:ctest-trans_right_vn-73411589?flat'}
2025-08-10 11:50:05,557 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07146533:ctest-trans_right_vn-73411589 virtual network link through opserver 10.0.0.254
2025-08-10 11:50:05,558 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-08-10 11:50:05,568 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07146533:ctest-trans_right_vn-73411589', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07146533:ctest-trans_right_vn-73411589?flat'}
2025-08-10 11:50:05,568 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-07146533:ctest-trans_right_vn-73411589 virtual network link through opserver 10.0.0.57
2025-08-10 11:50:05,568 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-08-10 11:50:05,579 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-07146533:ctest-trans_right_vn-73411589', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-07146533:ctest-trans_right_vn-73411589?flat'}
2025-08-10 11:50:05,579 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-07146533:ctest-trans_right_vn-73411589 is found in opserver
2025-08-10 11:50:05,601 - DEBUG - Do not have enough data to verify VN in agent
2025-08-10 11:50:05,612 - DEBUG - VRF ids for VN ctest-trans_right_vn-73411589: {}
2025-08-10 11:50:06,561 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3786-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3786-1)
2025-08-10 11:50:07,659 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3786-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3786-2)
2025-08-10 11:50:07,660 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-55064329']
2025-08-10 11:50:07,949 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-55064329'] created succesfully
2025-08-10 11:50:08,274 - DEBUG - Image by name tiny_trans_fw not found
2025-08-10 11:50:08,274 - DEBUG - Installing image tiny_trans_fw
2025-08-10 11:50:08,274 - 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'}
2025-08-10 11:50:08,274 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2025-08-10 11:50:08,274 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2025-08-10 11:50:08,290 - 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
2025-08-10 11:50:08,316 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-08-10 11:50:08,316 - DEBUG - Unzip image
2025-08-10 11:50:08,316 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-08-10 11:50:08,329 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2025-08-10 11:50:08,329 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-55064329']
2025-08-10 11:50:08,464 - INFO - Service template: ['default-domain', 'ctest-service_template_1-55064329'] deleted successfully.
2025-08-10 11:50:08,464 - INFO - Skip interface_detach for VM ctest-right_vm-81080881 in state BUILD
2025-08-10 11:50:08,464 - INFO - Deleting VM ctest-right_vm-81080881
2025-08-10 11:50:08,464 - ERROR - VM ctest-right_vm-81080881 has failed to come up
2025-08-10 11:50:08,464 - ERROR - Nova failed to get host of the VM
2025-08-10 11:50:08,464 - ERROR - VM ctest-right_vm-81080881 has failed to come up
2025-08-10 11:50:08,464 - ERROR - Nova failed to get host of the VM
2025-08-10 11:50:08,539 - INFO - Skip interface_detach for VM ctest-left_vm-63072367 in state BUILD
2025-08-10 11:50:08,539 - INFO - Deleting VM ctest-left_vm-63072367
2025-08-10 11:50:08,539 - ERROR - VM ctest-left_vm-63072367 has failed to come up
2025-08-10 11:50:08,539 - ERROR - Nova failed to get host of the VM
2025-08-10 11:50:08,539 - ERROR - VM ctest-left_vm-63072367 has failed to come up
2025-08-10 11:50:08,539 - ERROR - Nova failed to get host of the VM
2025-08-10 11:50:08,600 - INFO - Deleting VN ctest-trans_right_vn-73411589
2025-08-10 11:50:08,744 - DEBUG - Response for deleting network ()
2025-08-10 11:50:08,744 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/5439e91a-ad39-4c2d-8b0a-aee73192de94
2025-08-10 11:50:08,750 - DEBUG - Response Code: 404
2025-08-10 11:50:08,750 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:08,766 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:08,794 - DEBUG - Requesting: http://10.0.0.49:8082/project/fea17821-d266-432a-9089-138c12fbcc61
2025-08-10 11:50:08,887 - INFO - Validated that VN ctest-trans_right_vn-73411589 is not found in API Server
2025-08-10 11:50:08,899 - DEBUG - VN ctest-trans_right_vn-73411589 is not present in Agent 10.0.0.65
2025-08-10 11:50:08,910 - DEBUG - VN ctest-trans_right_vn-73411589 is not present in Agent 10.0.0.56
2025-08-10 11:50:08,910 - INFO - Validated that VN ctest-trans_right_vn-73411589 is not in any agent
2025-08-10 11:50:08,941 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-73411589 info
2025-08-10 11:50:08,941 - INFO - Deleting VN ctest-trans_left_vn-99242465
2025-08-10 11:50:09,081 - DEBUG - Response for deleting network ()
2025-08-10 11:50:09,081 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/dcf13744-64c7-4ce3-b7e6-9243278ca987
2025-08-10 11:50:09,088 - DEBUG - Response Code: 404
2025-08-10 11:50:09,088 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:09,095 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:09,107 - DEBUG - Requesting: http://10.0.0.49:8082/project/fea17821-d266-432a-9089-138c12fbcc61
2025-08-10 11:50:09,189 - INFO - Validated that VN ctest-trans_left_vn-99242465 is not found in API Server
2025-08-10 11:50:09,207 - DEBUG - VN ctest-trans_left_vn-99242465 is not present in Agent 10.0.0.65
2025-08-10 11:50:09,230 - DEBUG - VN ctest-trans_left_vn-99242465 is not present in Agent 10.0.0.56
2025-08-10 11:50:09,230 - INFO - Validated that VN ctest-trans_left_vn-99242465 is not in any agent
2025-08-10 11:50:09,278 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-99242465 info
2025-08-10 11:50:09,278 - INFO - Deleting VN ctest-right_vn-48655534
2025-08-10 11:50:09,318 - DEBUG - VN 695a82f5-08dc-4835-acf2-31399da98c8d still in use: Unable to complete operation on network 695a82f5-08dc-4835-acf2-31399da98c8d. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-83c55f53-77bf-4d26-9b19-cf47a72a8e3e']
2025-08-10 11:50:09,318 - WARNING - Deleting VN ctest-right_vn-48655534 failed..Will retry
2025-08-10 11:50:11,453 - DEBUG - Response for deleting network ()
2025-08-10 11:50:11,453 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/a0deac93-6055-4c52-80be-ddceb604682d
2025-08-10 11:50:11,460 - DEBUG - Response Code: 404
2025-08-10 11:50:11,460 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:11,467 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:11,485 - DEBUG - Requesting: http://10.0.0.49:8082/project/fea17821-d266-432a-9089-138c12fbcc61
2025-08-10 11:50:11,568 - INFO - Validated that VN ctest-right_vn-48655534 is not found in API Server
2025-08-10 11:50:11,578 - DEBUG - VN ctest-right_vn-48655534 is not present in Agent 10.0.0.65
2025-08-10 11:50:11,588 - DEBUG - VN ctest-right_vn-48655534 is not present in Agent 10.0.0.56
2025-08-10 11:50:11,589 - INFO - Validated that VN ctest-right_vn-48655534 is not in any agent
2025-08-10 11:50:11,618 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-48655534 info
2025-08-10 11:50:11,618 - INFO - Deleting VN ctest-left_vn-60140736
2025-08-10 11:50:11,748 - DEBUG - Response for deleting network ()
2025-08-10 11:50:11,748 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/29c35aa7-00e5-49a6-b557-d9f6bf5e6965
2025-08-10 11:50:11,753 - DEBUG - Response Code: 404
2025-08-10 11:50:11,753 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:11,768 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:11,821 - DEBUG - Requesting: http://10.0.0.49:8082/project/fea17821-d266-432a-9089-138c12fbcc61
2025-08-10 11:50:11,904 - INFO - Validated that VN ctest-left_vn-60140736 is not found in API Server
2025-08-10 11:50:11,914 - DEBUG - VN ctest-left_vn-60140736 is not present in Agent 10.0.0.65
2025-08-10 11:50:11,924 - DEBUG - VN ctest-left_vn-60140736 is not present in Agent 10.0.0.56
2025-08-10 11:50:11,924 - INFO - Validated that VN ctest-left_vn-60140736 is not in any agent
2025-08-10 11:50:11,955 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-60140736 info
2025-08-10 11:50:11,955 - INFO - Deleting VN ctest-mgmt_vn-98283675
2025-08-10 11:50:12,075 - DEBUG - Response for deleting network ()
2025-08-10 11:50:12,075 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/8e5f2e3a-08f6-4988-a90d-b4518f59437a
2025-08-10 11:50:12,080 - DEBUG - Response Code: 404
2025-08-10 11:50:12,081 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:12,088 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:12,109 - DEBUG - Requesting: http://10.0.0.49:8082/project/fea17821-d266-432a-9089-138c12fbcc61
2025-08-10 11:50:12,199 - INFO - Validated that VN ctest-mgmt_vn-98283675 is not found in API Server
2025-08-10 11:50:12,211 - DEBUG - VN ctest-mgmt_vn-98283675 is not present in Agent 10.0.0.65
2025-08-10 11:50:12,223 - DEBUG - VN ctest-mgmt_vn-98283675 is not present in Agent 10.0.0.56
2025-08-10 11:50:12,223 - INFO - Validated that VN ctest-mgmt_vn-98283675 is not in any agent
2025-08-10 11:50:12,253 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-98283675 info
2025-08-10 11:50:13,487 - DEBUG - No XMPP flaps were noticed during the test
2025-08-10 11:50:13,487 - INFO -
2025-08-10 11:50:13,487 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:14]
2025-08-10 11:50:13,487 - INFO - --------------------------------------------------------------------------------
2025-08-10 11:50:14,144 - INFO - Deleted project: ctest-TestSvcRegr-07146533, ID : fea17821-d266-432a-9089-138c12fbcc61
2025-08-10 11:50:14,288 - INFO - Domain Default found not creating
2025-08-10 11:50:14,410 - INFO - Project ctest-TestSvcRegr-90707582 not found, creating it
2025-08-10 11:50:14,874 - INFO - Created Project:ctest-TestSvcRegr-90707582, ID : ef568445-e279-4bff-9593-06d1aeed0174
2025-08-10 11:50:16,277 - INFO - ================================================================================
2025-08-10 11:50:16,277 - INFO - STARTING TEST : test_svc_CEM_22032
2025-08-10 11:50:17,526 - DEBUG - Nothing to compare xmpp stats {'10.0.0.65': {'10.20.0.14': '0', '10.20.0.25': '0'}, '10.0.0.56': {'10.20.0.254': '0', '10.20.0.14': '0'}} with
2025-08-10 11:50:17,526 - INFO - Initial checks done. Running the testcase now
2025-08-10 11:50:17,526 - INFO -
2025-08-10 11:50:18,111 - DEBUG - Response for create_network : {'network': {'id': '917da4ac-8af0-43ea-8cae-269294286f41', 'name': 'ctest-mgmt_vn-23455920', 'tenant_id': 'ef568445e2794bff959306d1aeed0174', 'project_id': 'ef568445e2794bff959306d1aeed0174', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-90707582', 'ctest-mgmt_vn-23455920'], 'port_security_enabled': True, 'description': ''}}
2025-08-10 11:50:18,354 - DEBUG - Response for create_subnet : {'subnet': {'id': '39b8eb7d-04ee-4bd1-9ed4-e7c517a98525', 'name': '', 'tenant_id': 'ef568445e2794bff959306d1aeed0174', 'network_id': '917da4ac-8af0-43ea-8cae-269294286f41', 'ip_version': 4, 'cidr': '100.190.159.0/26', 'allocation_pools': [{'start': '100.190.159.2', 'end': '100.190.159.62'}], 'gateway_ip': '100.190.159.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '100.190.159.2', 'tags': [], 'project_id': 'ef568445e2794bff959306d1aeed0174'}}
2025-08-10 11:50:18,372 - INFO - Created VN ctest-mgmt_vn-23455920
2025-08-10 11:50:18,382 - DEBUG - VN ctest-mgmt_vn-23455920 UUID is 917da4ac-8af0-43ea-8cae-269294286f41
2025-08-10 11:50:18,435 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:18,721 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:18,746 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:18,760 - DEBUG - Requesting: http://10.0.0.49:8082/project/ef568445-e279-4bff-9593-06d1aeed0174
2025-08-10 11:50:18,841 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/917da4ac-8af0-43ea-8cae-269294286f41
2025-08-10 11:50:18,852 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/917da4ac-8af0-43ea-8cae-269294286f41
2025-08-10 11:50:18,860 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/42a6f327-6577-45c1-ab5e-513385fce7f4
2025-08-10 11:50:18,866 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/42a6f327-6577-45c1-ab5e-513385fce7f4
2025-08-10 11:50:18,872 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/f110283a-d07b-4c6b-bb3c-16978629ecf0
2025-08-10 11:50:18,878 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-10 11:50:18,878 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/917da4ac-8af0-43ea-8cae-269294286f41
2025-08-10 11:50:18,886 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/42a6f327-6577-45c1-ab5e-513385fce7f4
2025-08-10 11:50:18,899 - INFO - Verified VN network id 15 for VN 917da4ac-8af0-43ea-8cae-269294286f41
2025-08-10 11:50:18,899 - INFO - Verifications in API Server for VN ctest-mgmt_vn-23455920 passed
2025-08-10 11:50:18,899 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/917da4ac-8af0-43ea-8cae-269294286f41
2025-08-10 11:50:18,908 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/42a6f327-6577-45c1-ab5e-513385fce7f4
2025-08-10 11:50:18,913 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/42a6f327-6577-45c1-ab5e-513385fce7f4
2025-08-10 11:50:18,919 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/f110283a-d07b-4c6b-bb3c-16978629ecf0
2025-08-10 11:50:18,930 - DEBUG - Control-node 10.0.0.49 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-23455920', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-90707582', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10483716568560714730', 'uuid-lslong': '10137082222250323777'}, 'enable': 'true', 'created': '2025-08-10T11:50:18', 'last-modified': '2025-08-10T11:50:18', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.622677'}
2025-08-10 11:50:18,937 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-10 11:50:18,943 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-23455920', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-90707582', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10483716568560714730', 'uuid-lslong': '10137082222250323777'}, 'enable': 'true', 'created': '2025-08-10T11:50:18', 'last-modified': '2025-08-10T11:50:18', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.631728'}
2025-08-10 11:50:18,949 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-10 11:50:18,954 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-23455920', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-90707582', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10483716568560714730', 'uuid-lslong': '10137082222250323777'}, 'enable': 'true', 'created': '2025-08-10T11:50:18', 'last-modified': '2025-08-10T11:50:18', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.647357'}
2025-08-10 11:50:18,960 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-10 11:50:18,960 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-23455920 passed
2025-08-10 11:50:18,960 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-23455920 in API_Server ======
2025-08-10 11:50:18,960 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:18,965 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:18,975 - DEBUG - Requesting: http://10.0.0.49:8082/project/ef568445-e279-4bff-9593-06d1aeed0174
2025-08-10 11:50:19,059 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/917da4ac-8af0-43ea-8cae-269294286f41
2025-08-10 11:50:19,068 - DEBUG - =>VN ctest-mgmt_vn-23455920 has no policy to be verified
2025-08-10 11:50:19,068 - DEBUG - Verifying the vn in opserver
2025-08-10 11:50:19,068 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-23455920 virtual network link through opserver 10.0.0.49
2025-08-10 11:50:19,069 - DEBUG - Requesting: http://10.0.0.49:8081/analytics/uves/virtual-networks
2025-08-10 11:50:19,355 - DEBUG - Requesting: http://10.0.0.49:8081/analytics/uves/virtual-networks
2025-08-10 11:50:19,400 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-23455920', 'href': 'http://10.0.0.49:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-23455920?flat'}
2025-08-10 11:50:19,400 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-23455920 virtual network link through opserver 10.0.0.254
2025-08-10 11:50:19,400 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-08-10 11:50:19,685 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-08-10 11:50:19,738 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-23455920', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-23455920?flat'}
2025-08-10 11:50:19,738 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-23455920 virtual network link through opserver 10.0.0.57
2025-08-10 11:50:19,738 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-08-10 11:50:20,023 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-08-10 11:50:20,071 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-23455920', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-23455920?flat'}
2025-08-10 11:50:20,071 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-23455920 is found in opserver
2025-08-10 11:50:20,091 - DEBUG - Do not have enough data to verify VN in agent
2025-08-10 11:50:20,101 - DEBUG - VRF ids for VN ctest-mgmt_vn-23455920: {}
2025-08-10 11:50:20,325 - DEBUG - Response for create_network : {'network': {'id': '9419cb3b-a401-4e96-bfe7-78e741d7666d', 'name': 'service-left-vn-71740705', 'tenant_id': 'ef568445e2794bff959306d1aeed0174', 'project_id': 'ef568445e2794bff959306d1aeed0174', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-90707582', 'service-left-vn-71740705'], 'port_security_enabled': True, 'description': ''}}
2025-08-10 11:50:20,505 - DEBUG - Response for create_subnet : {'subnet': {'id': 'b68fc18e-bac6-469a-840c-b8435e05a2c3', 'name': '', 'tenant_id': 'ef568445e2794bff959306d1aeed0174', 'network_id': '9419cb3b-a401-4e96-bfe7-78e741d7666d', 'ip_version': 4, 'cidr': '161.82.26.128/26', 'allocation_pools': [{'start': '161.82.26.130', 'end': '161.82.26.190'}], 'gateway_ip': '161.82.26.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '161.82.26.130', 'tags': [], 'project_id': 'ef568445e2794bff959306d1aeed0174'}}
2025-08-10 11:50:20,523 - INFO - Created VN service-left-vn-71740705
2025-08-10 11:50:20,535 - DEBUG - VN service-left-vn-71740705 UUID is 9419cb3b-a401-4e96-bfe7-78e741d7666d
2025-08-10 11:50:20,586 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:20,591 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:20,602 - DEBUG - Requesting: http://10.0.0.49:8082/project/ef568445-e279-4bff-9593-06d1aeed0174
2025-08-10 11:50:20,688 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/9419cb3b-a401-4e96-bfe7-78e741d7666d
2025-08-10 11:50:20,699 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/9419cb3b-a401-4e96-bfe7-78e741d7666d
2025-08-10 11:50:20,707 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/6082f627-20ef-4327-8575-02ea86db26cd
2025-08-10 11:50:20,713 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/6082f627-20ef-4327-8575-02ea86db26cd
2025-08-10 11:50:20,719 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/aedfdb98-1bc2-482a-9967-fd57b8903d92
2025-08-10 11:50:20,726 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-10 11:50:20,726 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/9419cb3b-a401-4e96-bfe7-78e741d7666d
2025-08-10 11:50:20,734 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/6082f627-20ef-4327-8575-02ea86db26cd
2025-08-10 11:50:20,748 - INFO - Verified VN network id 16 for VN 9419cb3b-a401-4e96-bfe7-78e741d7666d
2025-08-10 11:50:20,748 - INFO - Verifications in API Server for VN service-left-vn-71740705 passed
2025-08-10 11:50:20,749 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/9419cb3b-a401-4e96-bfe7-78e741d7666d
2025-08-10 11:50:20,757 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/6082f627-20ef-4327-8575-02ea86db26cd
2025-08-10 11:50:20,763 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/6082f627-20ef-4327-8575-02ea86db26cd
2025-08-10 11:50:20,769 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/aedfdb98-1bc2-482a-9967-fd57b8903d92
2025-08-10 11:50:20,780 - DEBUG - Control-node 10.0.0.49 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-90707582:service-left-vn-71740705', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-90707582', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10671784249046158998', 'uuid-lslong': '13828154115501811309'}, 'enable': 'true', 'created': '2025-08-10T11:50:20', 'last-modified': '2025-08-10T11:50:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.315166'}
2025-08-10 11:50:20,786 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-10 11:50:20,791 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-90707582:service-left-vn-71740705', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-90707582', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10671784249046158998', 'uuid-lslong': '13828154115501811309'}, 'enable': 'true', 'created': '2025-08-10T11:50:20', 'last-modified': '2025-08-10T11:50:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.327314'}
2025-08-10 11:50:20,797 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-10 11:50:20,802 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-90707582:service-left-vn-71740705', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-90707582', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10671784249046158998', 'uuid-lslong': '13828154115501811309'}, 'enable': 'true', 'created': '2025-08-10T11:50:20', 'last-modified': '2025-08-10T11:50:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.332714'}
2025-08-10 11:50:20,808 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-10 11:50:20,808 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-71740705 passed
2025-08-10 11:50:20,808 - DEBUG - ====Verifying policy data for service-left-vn-71740705 in API_Server ======
2025-08-10 11:50:20,808 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:20,813 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:20,824 - DEBUG - Requesting: http://10.0.0.49:8082/project/ef568445-e279-4bff-9593-06d1aeed0174
2025-08-10 11:50:20,913 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/9419cb3b-a401-4e96-bfe7-78e741d7666d
2025-08-10 11:50:20,934 - DEBUG - =>VN service-left-vn-71740705 has no policy to be verified
2025-08-10 11:50:20,934 - DEBUG - Verifying the vn in opserver
2025-08-10 11:50:20,934 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-90707582:service-left-vn-71740705 virtual network link through opserver 10.0.0.49
2025-08-10 11:50:20,934 - DEBUG - Requesting: http://10.0.0.49:8081/analytics/uves/virtual-networks
2025-08-10 11:50:21,187 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-90707582:service-left-vn-71740705', 'href': 'http://10.0.0.49:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-90707582:service-left-vn-71740705?flat'}
2025-08-10 11:50:21,187 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-90707582:service-left-vn-71740705 virtual network link through opserver 10.0.0.254
2025-08-10 11:50:21,187 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-08-10 11:50:21,509 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-90707582:service-left-vn-71740705', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-90707582:service-left-vn-71740705?flat'}
2025-08-10 11:50:21,509 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-90707582:service-left-vn-71740705 virtual network link through opserver 10.0.0.57
2025-08-10 11:50:21,509 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-08-10 11:50:21,569 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-90707582:service-left-vn-71740705', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-90707582:service-left-vn-71740705?flat'}
2025-08-10 11:50:21,569 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-90707582:service-left-vn-71740705 is found in opserver
2025-08-10 11:50:21,589 - DEBUG - Do not have enough data to verify VN in agent
2025-08-10 11:50:21,598 - DEBUG - VRF ids for VN service-left-vn-71740705: {}
2025-08-10 11:50:21,835 - DEBUG - Response for create_network : {'network': {'id': 'a2570cc7-10d6-4886-b9f6-4ba67b662c65', 'name': 'service-right-vn-80101689', 'tenant_id': 'ef568445e2794bff959306d1aeed0174', 'project_id': 'ef568445e2794bff959306d1aeed0174', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-90707582', 'service-right-vn-80101689'], 'port_security_enabled': True, 'description': ''}}
2025-08-10 11:50:22,043 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd1dc179f-ebab-41fc-954d-9a2d1dc8c586', 'name': '', 'tenant_id': 'ef568445e2794bff959306d1aeed0174', 'network_id': 'a2570cc7-10d6-4886-b9f6-4ba67b662c65', 'ip_version': 4, 'cidr': '46.165.10.64/26', 'allocation_pools': [{'start': '46.165.10.66', 'end': '46.165.10.126'}], 'gateway_ip': '46.165.10.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '46.165.10.66', 'tags': [], 'project_id': 'ef568445e2794bff959306d1aeed0174'}}
2025-08-10 11:50:22,061 - INFO - Created VN service-right-vn-80101689
2025-08-10 11:50:22,070 - DEBUG - VN service-right-vn-80101689 UUID is a2570cc7-10d6-4886-b9f6-4ba67b662c65
2025-08-10 11:50:22,124 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:22,129 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:22,139 - DEBUG - Requesting: http://10.0.0.49:8082/project/ef568445-e279-4bff-9593-06d1aeed0174
2025-08-10 11:50:22,232 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/a2570cc7-10d6-4886-b9f6-4ba67b662c65
2025-08-10 11:50:22,244 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/a2570cc7-10d6-4886-b9f6-4ba67b662c65
2025-08-10 11:50:22,252 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/5d6d5a7d-76b8-4785-a67b-d96e1e1ba492
2025-08-10 11:50:22,259 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/5d6d5a7d-76b8-4785-a67b-d96e1e1ba492
2025-08-10 11:50:22,265 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/72cc8af5-745a-4388-9ad5-247c56b44627
2025-08-10 11:50:22,271 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-10 11:50:22,271 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/a2570cc7-10d6-4886-b9f6-4ba67b662c65
2025-08-10 11:50:22,279 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/5d6d5a7d-76b8-4785-a67b-d96e1e1ba492
2025-08-10 11:50:22,292 - INFO - Verified VN network id 17 for VN a2570cc7-10d6-4886-b9f6-4ba67b662c65
2025-08-10 11:50:22,292 - INFO - Verifications in API Server for VN service-right-vn-80101689 passed
2025-08-10 11:50:22,292 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/a2570cc7-10d6-4886-b9f6-4ba67b662c65
2025-08-10 11:50:22,301 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/5d6d5a7d-76b8-4785-a67b-d96e1e1ba492
2025-08-10 11:50:22,307 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/5d6d5a7d-76b8-4785-a67b-d96e1e1ba492
2025-08-10 11:50:22,313 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/72cc8af5-745a-4388-9ad5-247c56b44627
2025-08-10 11:50:22,324 - DEBUG - Control-node 10.0.0.49 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-90707582:service-right-vn-80101689', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-90707582', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11697832606238656646', 'uuid-lslong': '13399980919694437477'}, 'enable': 'true', 'created': '2025-08-10T11:50:21', 'last-modified': '2025-08-10T11:50:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.319258'}
2025-08-10 11:50:22,329 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-10 11:50:22,334 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-90707582:service-right-vn-80101689', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-90707582', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11697832606238656646', 'uuid-lslong': '13399980919694437477'}, 'enable': 'true', 'created': '2025-08-10T11:50:21', 'last-modified': '2025-08-10T11:50:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.331596'}
2025-08-10 11:50:22,341 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-10 11:50:22,346 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-90707582:service-right-vn-80101689', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-90707582', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11697832606238656646', 'uuid-lslong': '13399980919694437477'}, 'enable': 'true', 'created': '2025-08-10T11:50:21', 'last-modified': '2025-08-10T11:50:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.337092'}
2025-08-10 11:50:22,351 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-10 11:50:22,351 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-80101689 passed
2025-08-10 11:50:22,352 - DEBUG - ====Verifying policy data for service-right-vn-80101689 in API_Server ======
2025-08-10 11:50:22,352 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:22,356 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:22,366 - DEBUG - Requesting: http://10.0.0.49:8082/project/ef568445-e279-4bff-9593-06d1aeed0174
2025-08-10 11:50:22,446 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/a2570cc7-10d6-4886-b9f6-4ba67b662c65
2025-08-10 11:50:22,455 - DEBUG - =>VN service-right-vn-80101689 has no policy to be verified
2025-08-10 11:50:22,455 - DEBUG - Verifying the vn in opserver
2025-08-10 11:50:22,455 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-90707582:service-right-vn-80101689 virtual network link through opserver 10.0.0.49
2025-08-10 11:50:22,455 - DEBUG - Requesting: http://10.0.0.49:8081/analytics/uves/virtual-networks
2025-08-10 11:50:22,465 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-90707582:service-right-vn-80101689', 'href': 'http://10.0.0.49:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-90707582:service-right-vn-80101689?flat'}
2025-08-10 11:50:22,465 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-90707582:service-right-vn-80101689 virtual network link through opserver 10.0.0.254
2025-08-10 11:50:22,465 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-08-10 11:50:22,476 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-90707582:service-right-vn-80101689', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-90707582:service-right-vn-80101689?flat'}
2025-08-10 11:50:22,476 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-90707582:service-right-vn-80101689 virtual network link through opserver 10.0.0.57
2025-08-10 11:50:22,476 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-08-10 11:50:22,522 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-90707582:service-right-vn-80101689', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-90707582:service-right-vn-80101689?flat'}
2025-08-10 11:50:22,522 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-90707582:service-right-vn-80101689 is found in opserver
2025-08-10 11:50:22,542 - DEBUG - Do not have enough data to verify VN in agent
2025-08-10 11:50:22,552 - DEBUG - VRF ids for VN service-right-vn-80101689: {}
2025-08-10 11:50:22,599 - DEBUG - Services list from nova: [, , , ]
2025-08-10 11:50:23,512 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3786-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3786-1)
2025-08-10 11:50:24,617 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3786-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3786-2)
2025-08-10 11:50:24,618 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-23905078']
2025-08-10 11:50:24,918 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-23905078'] created succesfully
2025-08-10 11:50:25,265 - DEBUG - Image by name tiny_nat_fw not found
2025-08-10 11:50:25,265 - DEBUG - Installing image tiny_nat_fw
2025-08-10 11:50:25,265 - 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'"}
2025-08-10 11:50:25,266 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-08-10 11:50:25,266 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-08-10 11:50:25,266 - DEBUG - Unzip image
2025-08-10 11:50:25,266 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-08-10 11:50:25,282 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2025-08-10 11:50:25,283 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-23905078']
2025-08-10 11:50:25,448 - INFO - Service template: ['default-domain', 'ctest-service_template_1-23905078'] deleted successfully.
2025-08-10 11:50:25,448 - INFO - Skip interface_detach for VM ctest-right_vm-67988734 in state BUILD
2025-08-10 11:50:25,448 - INFO - Deleting VM ctest-right_vm-67988734
2025-08-10 11:50:25,473 - ERROR - VM ctest-right_vm-67988734 has failed to come up
2025-08-10 11:50:25,473 - ERROR - Nova failed to get host of the VM
2025-08-10 11:50:25,473 - ERROR - VM ctest-right_vm-67988734 has failed to come up
2025-08-10 11:50:25,473 - ERROR - Nova failed to get host of the VM
2025-08-10 11:50:25,540 - INFO - Skip interface_detach for VM ctest-left_vm-17325494 in state BUILD
2025-08-10 11:50:25,540 - INFO - Deleting VM ctest-left_vm-17325494
2025-08-10 11:50:25,540 - ERROR - VM ctest-left_vm-17325494 has failed to come up
2025-08-10 11:50:25,540 - ERROR - Nova failed to get host of the VM
2025-08-10 11:50:25,540 - ERROR - VM ctest-left_vm-17325494 has failed to come up
2025-08-10 11:50:25,540 - ERROR - Nova failed to get host of the VM
2025-08-10 11:50:25,600 - INFO - Deleting VN service-right-vn-80101689
2025-08-10 11:50:25,637 - DEBUG - VN a2570cc7-10d6-4886-b9f6-4ba67b662c65 still in use: Unable to complete operation on network a2570cc7-10d6-4886-b9f6-4ba67b662c65. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-4e7dd58f-f720-44f2-888f-a3d790eb17d0']
2025-08-10 11:50:25,637 - WARNING - Deleting VN service-right-vn-80101689 failed..Will retry
2025-08-10 11:50:27,814 - DEBUG - Response for deleting network ()
2025-08-10 11:50:27,814 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/5d6d5a7d-76b8-4785-a67b-d96e1e1ba492
2025-08-10 11:50:27,821 - DEBUG - Response Code: 404
2025-08-10 11:50:27,821 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:27,827 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:27,895 - DEBUG - Requesting: http://10.0.0.49:8082/project/ef568445-e279-4bff-9593-06d1aeed0174
2025-08-10 11:50:27,985 - INFO - Validated that VN service-right-vn-80101689 is not found in API Server
2025-08-10 11:50:27,997 - DEBUG - VN service-right-vn-80101689 is not present in Agent 10.0.0.65
2025-08-10 11:50:28,007 - DEBUG - VN service-right-vn-80101689 is not present in Agent 10.0.0.56
2025-08-10 11:50:28,007 - INFO - Validated that VN service-right-vn-80101689 is not in any agent
2025-08-10 11:50:28,037 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-80101689 info
2025-08-10 11:50:28,037 - INFO - Deleting VN service-left-vn-71740705
2025-08-10 11:50:28,184 - DEBUG - Response for deleting network ()
2025-08-10 11:50:28,184 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/6082f627-20ef-4327-8575-02ea86db26cd
2025-08-10 11:50:28,190 - DEBUG - Response Code: 404
2025-08-10 11:50:28,190 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:28,195 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:28,205 - DEBUG - Requesting: http://10.0.0.49:8082/project/ef568445-e279-4bff-9593-06d1aeed0174
2025-08-10 11:50:28,304 - INFO - Validated that VN service-left-vn-71740705 is not found in API Server
2025-08-10 11:50:28,315 - DEBUG - VN service-left-vn-71740705 is not present in Agent 10.0.0.65
2025-08-10 11:50:28,325 - DEBUG - VN service-left-vn-71740705 is not present in Agent 10.0.0.56
2025-08-10 11:50:28,325 - INFO - Validated that VN service-left-vn-71740705 is not in any agent
2025-08-10 11:50:28,355 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-71740705 info
2025-08-10 11:50:28,355 - INFO - Deleting VN ctest-mgmt_vn-23455920
2025-08-10 11:50:28,512 - DEBUG - Response for deleting network ()
2025-08-10 11:50:28,512 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/42a6f327-6577-45c1-ab5e-513385fce7f4
2025-08-10 11:50:28,518 - DEBUG - Response Code: 404
2025-08-10 11:50:28,519 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:28,536 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:28,548 - DEBUG - Requesting: http://10.0.0.49:8082/project/ef568445-e279-4bff-9593-06d1aeed0174
2025-08-10 11:50:28,663 - INFO - Validated that VN ctest-mgmt_vn-23455920 is not found in API Server
2025-08-10 11:50:28,674 - DEBUG - VN ctest-mgmt_vn-23455920 is not present in Agent 10.0.0.65
2025-08-10 11:50:28,686 - DEBUG - VN ctest-mgmt_vn-23455920 is not present in Agent 10.0.0.56
2025-08-10 11:50:28,686 - INFO - Validated that VN ctest-mgmt_vn-23455920 is not in any agent
2025-08-10 11:50:28,734 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-23455920 info
2025-08-10 11:50:29,975 - DEBUG - No XMPP flaps were noticed during the test
2025-08-10 11:50:29,975 - INFO -
2025-08-10 11:50:29,975 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:13]
2025-08-10 11:50:29,975 - INFO - --------------------------------------------------------------------------------
2025-08-10 11:50:29,978 - INFO - ================================================================================
2025-08-10 11:50:29,978 - INFO - STARTING TEST : test_svc_in_network_datapath
2025-08-10 11:50:31,223 - DEBUG - Nothing to compare xmpp stats {'10.0.0.65': {'10.20.0.14': '0', '10.20.0.25': '0'}, '10.0.0.56': {'10.20.0.254': '0', '10.20.0.14': '0'}} with
2025-08-10 11:50:31,224 - INFO - Initial checks done. Running the testcase now
2025-08-10 11:50:31,224 - INFO -
2025-08-10 11:50:31,460 - DEBUG - Response for create_network : {'network': {'id': 'bec53c95-6508-4f87-95cb-ffc61d0cf460', 'name': 'ctest-mgmt_vn-49242934', 'tenant_id': 'ef568445e2794bff959306d1aeed0174', 'project_id': 'ef568445e2794bff959306d1aeed0174', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-90707582', 'ctest-mgmt_vn-49242934'], 'port_security_enabled': True, 'description': ''}}
2025-08-10 11:50:31,680 - DEBUG - Response for create_subnet : {'subnet': {'id': 'fb3d7db9-6735-4442-b63e-b43190e9ed97', 'name': '', 'tenant_id': 'ef568445e2794bff959306d1aeed0174', 'network_id': 'bec53c95-6508-4f87-95cb-ffc61d0cf460', 'ip_version': 4, 'cidr': '194.82.133.0/26', 'allocation_pools': [{'start': '194.82.133.2', 'end': '194.82.133.62'}], 'gateway_ip': '194.82.133.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '194.82.133.2', 'tags': [], 'project_id': 'ef568445e2794bff959306d1aeed0174'}}
2025-08-10 11:50:31,698 - INFO - Created VN ctest-mgmt_vn-49242934
2025-08-10 11:50:31,708 - DEBUG - VN ctest-mgmt_vn-49242934 UUID is bec53c95-6508-4f87-95cb-ffc61d0cf460
2025-08-10 11:50:31,767 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:31,773 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:31,784 - DEBUG - Requesting: http://10.0.0.49:8082/project/ef568445-e279-4bff-9593-06d1aeed0174
2025-08-10 11:50:31,864 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/bec53c95-6508-4f87-95cb-ffc61d0cf460
2025-08-10 11:50:31,877 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/bec53c95-6508-4f87-95cb-ffc61d0cf460
2025-08-10 11:50:31,885 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/5ea6834d-b1ec-4087-ae7c-12283c2ff19d
2025-08-10 11:50:31,892 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/5ea6834d-b1ec-4087-ae7c-12283c2ff19d
2025-08-10 11:50:31,898 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/ff116578-fcea-4d59-bec7-5db713dbd456
2025-08-10 11:50:31,904 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-10 11:50:31,904 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/bec53c95-6508-4f87-95cb-ffc61d0cf460
2025-08-10 11:50:31,912 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/5ea6834d-b1ec-4087-ae7c-12283c2ff19d
2025-08-10 11:50:31,926 - INFO - Verified VN network id 15 for VN bec53c95-6508-4f87-95cb-ffc61d0cf460
2025-08-10 11:50:31,926 - INFO - Verifications in API Server for VN ctest-mgmt_vn-49242934 passed
2025-08-10 11:50:31,926 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/bec53c95-6508-4f87-95cb-ffc61d0cf460
2025-08-10 11:50:31,935 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/5ea6834d-b1ec-4087-ae7c-12283c2ff19d
2025-08-10 11:50:31,941 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/5ea6834d-b1ec-4087-ae7c-12283c2ff19d
2025-08-10 11:50:31,947 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/ff116578-fcea-4d59-bec7-5db713dbd456
2025-08-10 11:50:31,957 - DEBUG - Control-node 10.0.0.49 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-49242934', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-90707582', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13746460049961144199', 'uuid-lslong': '10794002158279521376'}, 'enable': 'true', 'created': '2025-08-10T11:50:31', 'last-modified': '2025-08-10T11:50:31', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.322944'}
2025-08-10 11:50:31,964 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-10 11:50:31,969 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-49242934', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-90707582', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13746460049961144199', 'uuid-lslong': '10794002158279521376'}, 'enable': 'true', 'created': '2025-08-10T11:50:31', 'last-modified': '2025-08-10T11:50:31', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.330328'}
2025-08-10 11:50:31,975 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-10 11:50:31,980 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-49242934', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-90707582', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13746460049961144199', 'uuid-lslong': '10794002158279521376'}, 'enable': 'true', 'created': '2025-08-10T11:50:31', 'last-modified': '2025-08-10T11:50:31', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.338274'}
2025-08-10 11:50:31,986 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-10 11:50:31,986 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-49242934 passed
2025-08-10 11:50:31,986 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-49242934 in API_Server ======
2025-08-10 11:50:31,986 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:31,991 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:32,003 - DEBUG - Requesting: http://10.0.0.49:8082/project/ef568445-e279-4bff-9593-06d1aeed0174
2025-08-10 11:50:32,084 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/bec53c95-6508-4f87-95cb-ffc61d0cf460
2025-08-10 11:50:32,093 - DEBUG - =>VN ctest-mgmt_vn-49242934 has no policy to be verified
2025-08-10 11:50:32,093 - DEBUG - Verifying the vn in opserver
2025-08-10 11:50:32,093 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-49242934 virtual network link through opserver 10.0.0.49
2025-08-10 11:50:32,093 - DEBUG - Requesting: http://10.0.0.49:8081/analytics/uves/virtual-networks
2025-08-10 11:50:32,107 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-49242934', 'href': 'http://10.0.0.49:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-49242934?flat'}
2025-08-10 11:50:32,107 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-49242934 virtual network link through opserver 10.0.0.254
2025-08-10 11:50:32,107 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-08-10 11:50:32,119 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-49242934', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-49242934?flat'}
2025-08-10 11:50:32,119 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-49242934 virtual network link through opserver 10.0.0.57
2025-08-10 11:50:32,119 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-08-10 11:50:32,132 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-49242934', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-49242934?flat'}
2025-08-10 11:50:32,132 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-90707582:ctest-mgmt_vn-49242934 is found in opserver
2025-08-10 11:50:32,152 - DEBUG - Do not have enough data to verify VN in agent
2025-08-10 11:50:32,161 - DEBUG - VRF ids for VN ctest-mgmt_vn-49242934: {}
2025-08-10 11:50:32,394 - DEBUG - Response for create_network : {'network': {'id': '30a34b48-45da-4bc7-89e1-da1f76b84945', 'name': 'ctest-left_vn-52719526', 'tenant_id': 'ef568445e2794bff959306d1aeed0174', 'project_id': 'ef568445e2794bff959306d1aeed0174', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-90707582', 'ctest-left_vn-52719526'], 'port_security_enabled': True, 'description': ''}}
2025-08-10 11:50:32,585 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd2f8032d-27ea-4883-9e48-f8d9fda64fe4', 'name': '', 'tenant_id': 'ef568445e2794bff959306d1aeed0174', 'network_id': '30a34b48-45da-4bc7-89e1-da1f76b84945', 'ip_version': 4, 'cidr': '109.17.121.192/26', 'allocation_pools': [{'start': '109.17.121.194', 'end': '109.17.121.254'}], 'gateway_ip': '109.17.121.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '109.17.121.194', 'tags': [], 'project_id': 'ef568445e2794bff959306d1aeed0174'}}
2025-08-10 11:50:32,602 - INFO - Created VN ctest-left_vn-52719526
2025-08-10 11:50:32,612 - DEBUG - VN ctest-left_vn-52719526 UUID is 30a34b48-45da-4bc7-89e1-da1f76b84945
2025-08-10 11:50:32,666 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:32,672 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:32,682 - DEBUG - Requesting: http://10.0.0.49:8082/project/ef568445-e279-4bff-9593-06d1aeed0174
2025-08-10 11:50:32,763 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/30a34b48-45da-4bc7-89e1-da1f76b84945
2025-08-10 11:50:32,782 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/30a34b48-45da-4bc7-89e1-da1f76b84945
2025-08-10 11:50:32,791 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/14ce1238-f707-4859-b32d-53abba0de1c4
2025-08-10 11:50:32,800 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/14ce1238-f707-4859-b32d-53abba0de1c4
2025-08-10 11:50:32,807 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/c970593e-e4eb-40d2-92fd-5661c658f3be
2025-08-10 11:50:32,814 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-10 11:50:32,814 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/30a34b48-45da-4bc7-89e1-da1f76b84945
2025-08-10 11:50:32,823 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/14ce1238-f707-4859-b32d-53abba0de1c4
2025-08-10 11:50:32,836 - INFO - Verified VN network id 16 for VN 30a34b48-45da-4bc7-89e1-da1f76b84945
2025-08-10 11:50:32,836 - INFO - Verifications in API Server for VN ctest-left_vn-52719526 passed
2025-08-10 11:50:32,836 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/30a34b48-45da-4bc7-89e1-da1f76b84945
2025-08-10 11:50:32,845 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/14ce1238-f707-4859-b32d-53abba0de1c4
2025-08-10 11:50:32,851 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/14ce1238-f707-4859-b32d-53abba0de1c4
2025-08-10 11:50:32,856 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/c970593e-e4eb-40d2-92fd-5661c658f3be
2025-08-10 11:50:32,868 - DEBUG - Control-node 10.0.0.49 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-90707582:ctest-left_vn-52719526', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-90707582', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3504727708806040519', 'uuid-lslong': '9935462081626655045'}, 'enable': 'true', 'created': '2025-08-10T11:50:32', 'last-modified': '2025-08-10T11:50:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.325064'}
2025-08-10 11:50:32,873 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-10 11:50:32,879 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-90707582:ctest-left_vn-52719526', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-90707582', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3504727708806040519', 'uuid-lslong': '9935462081626655045'}, 'enable': 'true', 'created': '2025-08-10T11:50:32', 'last-modified': '2025-08-10T11:50:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.336346'}
2025-08-10 11:50:32,884 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-10 11:50:32,889 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-90707582:ctest-left_vn-52719526', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-90707582', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3504727708806040519', 'uuid-lslong': '9935462081626655045'}, 'enable': 'true', 'created': '2025-08-10T11:50:32', 'last-modified': '2025-08-10T11:50:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.343846'}
2025-08-10 11:50:32,895 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-10 11:50:32,895 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-52719526 passed
2025-08-10 11:50:32,896 - DEBUG - ====Verifying policy data for ctest-left_vn-52719526 in API_Server ======
2025-08-10 11:50:32,896 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:32,900 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:32,910 - DEBUG - Requesting: http://10.0.0.49:8082/project/ef568445-e279-4bff-9593-06d1aeed0174
2025-08-10 11:50:32,996 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/30a34b48-45da-4bc7-89e1-da1f76b84945
2025-08-10 11:50:33,005 - DEBUG - =>VN ctest-left_vn-52719526 has no policy to be verified
2025-08-10 11:50:33,005 - DEBUG - Verifying the vn in opserver
2025-08-10 11:50:33,005 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-90707582:ctest-left_vn-52719526 virtual network link through opserver 10.0.0.49
2025-08-10 11:50:33,005 - DEBUG - Requesting: http://10.0.0.49:8081/analytics/uves/virtual-networks
2025-08-10 11:50:33,050 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-90707582:ctest-left_vn-52719526', 'href': 'http://10.0.0.49:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-90707582:ctest-left_vn-52719526?flat'}
2025-08-10 11:50:33,051 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-90707582:ctest-left_vn-52719526 virtual network link through opserver 10.0.0.254
2025-08-10 11:50:33,051 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-08-10 11:50:33,093 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-90707582:ctest-left_vn-52719526', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-90707582:ctest-left_vn-52719526?flat'}
2025-08-10 11:50:33,093 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-90707582:ctest-left_vn-52719526 virtual network link through opserver 10.0.0.57
2025-08-10 11:50:33,093 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-08-10 11:50:33,104 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-90707582:ctest-left_vn-52719526', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-90707582:ctest-left_vn-52719526?flat'}
2025-08-10 11:50:33,104 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-90707582:ctest-left_vn-52719526 is found in opserver
2025-08-10 11:50:33,124 - DEBUG - Do not have enough data to verify VN in agent
2025-08-10 11:50:33,134 - DEBUG - VRF ids for VN ctest-left_vn-52719526: {}
2025-08-10 11:50:33,363 - DEBUG - Response for create_network : {'network': {'id': 'b92e983f-06ca-42ba-a7df-48859d374238', 'name': 'ctest-right_vn-17421444', 'tenant_id': 'ef568445e2794bff959306d1aeed0174', 'project_id': 'ef568445e2794bff959306d1aeed0174', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-90707582', 'ctest-right_vn-17421444'], 'port_security_enabled': True, 'description': ''}}
2025-08-10 11:50:33,604 - DEBUG - Response for create_subnet : {'subnet': {'id': '2361efaf-772f-4e88-a928-0f403a93018b', 'name': '', 'tenant_id': 'ef568445e2794bff959306d1aeed0174', 'network_id': 'b92e983f-06ca-42ba-a7df-48859d374238', 'ip_version': 4, 'cidr': '26.162.24.192/26', 'allocation_pools': [{'start': '26.162.24.194', 'end': '26.162.24.254'}], 'gateway_ip': '26.162.24.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '26.162.24.194', 'tags': [], 'project_id': 'ef568445e2794bff959306d1aeed0174'}}
2025-08-10 11:50:33,623 - INFO - Created VN ctest-right_vn-17421444
2025-08-10 11:50:33,634 - DEBUG - VN ctest-right_vn-17421444 UUID is b92e983f-06ca-42ba-a7df-48859d374238
2025-08-10 11:50:33,692 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:33,698 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:33,709 - DEBUG - Requesting: http://10.0.0.49:8082/project/ef568445-e279-4bff-9593-06d1aeed0174
2025-08-10 11:50:33,795 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/b92e983f-06ca-42ba-a7df-48859d374238
2025-08-10 11:50:33,806 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/b92e983f-06ca-42ba-a7df-48859d374238
2025-08-10 11:50:33,814 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/f44fff74-7b2e-44cc-a74a-34d43dadcbb2
2025-08-10 11:50:33,820 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/f44fff74-7b2e-44cc-a74a-34d43dadcbb2
2025-08-10 11:50:33,827 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/adcbbdc1-96a0-4ba9-8341-fa8ae1da80ec
2025-08-10 11:50:33,832 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-10 11:50:33,832 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/b92e983f-06ca-42ba-a7df-48859d374238
2025-08-10 11:50:33,841 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/f44fff74-7b2e-44cc-a74a-34d43dadcbb2
2025-08-10 11:50:33,854 - INFO - Verified VN network id 17 for VN b92e983f-06ca-42ba-a7df-48859d374238
2025-08-10 11:50:33,854 - INFO - Verifications in API Server for VN ctest-right_vn-17421444 passed
2025-08-10 11:50:33,854 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/b92e983f-06ca-42ba-a7df-48859d374238
2025-08-10 11:50:33,862 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/f44fff74-7b2e-44cc-a74a-34d43dadcbb2
2025-08-10 11:50:33,868 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/f44fff74-7b2e-44cc-a74a-34d43dadcbb2
2025-08-10 11:50:33,874 - DEBUG - Requesting: http://10.0.0.49:8082/route-target/adcbbdc1-96a0-4ba9-8341-fa8ae1da80ec
2025-08-10 11:50:33,886 - DEBUG - Control-node 10.0.0.49 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-90707582:ctest-right_vn-17421444', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-90707582', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13343770142409638586', 'uuid-lslong': '12096466862845936184'}, 'enable': 'true', 'created': '2025-08-10T11:50:33', 'last-modified': '2025-08-10T11:50:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.343160'}
2025-08-10 11:50:33,892 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-10 11:50:33,899 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-90707582:ctest-right_vn-17421444', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-90707582', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13343770142409638586', 'uuid-lslong': '12096466862845936184'}, 'enable': 'true', 'created': '2025-08-10T11:50:33', 'last-modified': '2025-08-10T11:50:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.350654'}
2025-08-10 11:50:33,905 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-10 11:50:33,910 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-90707582:ctest-right_vn-17421444', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-90707582', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13343770142409638586', 'uuid-lslong': '12096466862845936184'}, 'enable': 'true', 'created': '2025-08-10T11:50:33', 'last-modified': '2025-08-10T11:50:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.370885'}
2025-08-10 11:50:33,916 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-10 11:50:33,916 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-17421444 passed
2025-08-10 11:50:33,916 - DEBUG - ====Verifying policy data for ctest-right_vn-17421444 in API_Server ======
2025-08-10 11:50:33,916 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:33,921 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:33,931 - DEBUG - Requesting: http://10.0.0.49:8082/project/ef568445-e279-4bff-9593-06d1aeed0174
2025-08-10 11:50:34,021 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-network/b92e983f-06ca-42ba-a7df-48859d374238
2025-08-10 11:50:34,030 - DEBUG - =>VN ctest-right_vn-17421444 has no policy to be verified
2025-08-10 11:50:34,030 - DEBUG - Verifying the vn in opserver
2025-08-10 11:50:34,030 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-90707582:ctest-right_vn-17421444 virtual network link through opserver 10.0.0.49
2025-08-10 11:50:34,030 - DEBUG - Requesting: http://10.0.0.49:8081/analytics/uves/virtual-networks
2025-08-10 11:50:34,040 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-90707582:ctest-right_vn-17421444', 'href': 'http://10.0.0.49:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-90707582:ctest-right_vn-17421444?flat'}
2025-08-10 11:50:34,040 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-90707582:ctest-right_vn-17421444 virtual network link through opserver 10.0.0.254
2025-08-10 11:50:34,040 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-08-10 11:50:34,051 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-90707582:ctest-right_vn-17421444', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-90707582:ctest-right_vn-17421444?flat'}
2025-08-10 11:50:34,051 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-90707582:ctest-right_vn-17421444 virtual network link through opserver 10.0.0.57
2025-08-10 11:50:34,051 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-08-10 11:50:34,062 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-90707582:ctest-right_vn-17421444', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-90707582:ctest-right_vn-17421444?flat'}
2025-08-10 11:50:34,062 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-90707582:ctest-right_vn-17421444 is found in opserver
2025-08-10 11:50:34,082 - DEBUG - Do not have enough data to verify VN in agent
2025-08-10 11:50:34,092 - DEBUG - VRF ids for VN ctest-right_vn-17421444: {}
2025-08-10 11:50:35,022 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3786-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3786-2)
2025-08-10 11:50:36,132 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3786-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3786-1)
2025-08-10 11:50:36,132 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-85570262']
2025-08-10 11:50:36,428 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-85570262'] created succesfully
2025-08-10 11:50:36,730 - DEBUG - Image by name tiny_nat_fw not found
2025-08-10 11:50:36,730 - DEBUG - Installing image tiny_nat_fw
2025-08-10 11:50:36,730 - 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'"}
2025-08-10 11:50:36,731 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-08-10 11:50:36,731 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-08-10 11:50:36,731 - DEBUG - Unzip image
2025-08-10 11:50:36,731 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-08-10 11:50:36,765 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2025-08-10 11:50:36,765 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-85570262']
2025-08-10 11:50:36,868 - INFO - Service template: ['default-domain', 'ctest-service_template_1-85570262'] deleted successfully.
2025-08-10 11:50:36,868 - INFO - Skip interface_detach for VM ctest-right_vm-77042482 in state BUILD
2025-08-10 11:50:36,868 - INFO - Deleting VM ctest-right_vm-77042482
2025-08-10 11:50:36,868 - ERROR - VM ctest-right_vm-77042482 has failed to come up
2025-08-10 11:50:36,868 - ERROR - Nova failed to get host of the VM
2025-08-10 11:50:36,868 - ERROR - VM ctest-right_vm-77042482 has failed to come up
2025-08-10 11:50:36,868 - ERROR - Nova failed to get host of the VM
2025-08-10 11:50:36,920 - INFO - Skip interface_detach for VM ctest-left_vm-19030714 in state BUILD
2025-08-10 11:50:36,920 - INFO - Deleting VM ctest-left_vm-19030714
2025-08-10 11:50:36,921 - ERROR - VM ctest-left_vm-19030714 has failed to come up
2025-08-10 11:50:36,921 - ERROR - Nova failed to get host of the VM
2025-08-10 11:50:36,921 - ERROR - VM ctest-left_vm-19030714 has failed to come up
2025-08-10 11:50:36,921 - ERROR - Nova failed to get host of the VM
2025-08-10 11:50:36,971 - INFO - Deleting VN ctest-right_vn-17421444
2025-08-10 11:50:37,003 - DEBUG - VN b92e983f-06ca-42ba-a7df-48859d374238 still in use: Unable to complete operation on network b92e983f-06ca-42ba-a7df-48859d374238. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-29be6d9b-5c1b-4a4a-baec-549bb1e73845']
2025-08-10 11:50:37,003 - WARNING - Deleting VN ctest-right_vn-17421444 failed..Will retry
2025-08-10 11:50:39,134 - DEBUG - Response for deleting network ()
2025-08-10 11:50:39,134 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/f44fff74-7b2e-44cc-a74a-34d43dadcbb2
2025-08-10 11:50:39,148 - DEBUG - Response Code: 404
2025-08-10 11:50:39,148 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:39,154 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:39,167 - DEBUG - Requesting: http://10.0.0.49:8082/project/ef568445-e279-4bff-9593-06d1aeed0174
2025-08-10 11:50:39,244 - INFO - Validated that VN ctest-right_vn-17421444 is not found in API Server
2025-08-10 11:50:39,255 - DEBUG - VN ctest-right_vn-17421444 is not present in Agent 10.0.0.65
2025-08-10 11:50:39,265 - DEBUG - VN ctest-right_vn-17421444 is not present in Agent 10.0.0.56
2025-08-10 11:50:39,265 - INFO - Validated that VN ctest-right_vn-17421444 is not in any agent
2025-08-10 11:50:39,294 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-17421444 info
2025-08-10 11:50:39,294 - INFO - Deleting VN ctest-left_vn-52719526
2025-08-10 11:50:39,414 - DEBUG - Response for deleting network ()
2025-08-10 11:50:39,414 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/14ce1238-f707-4859-b32d-53abba0de1c4
2025-08-10 11:50:39,419 - DEBUG - Response Code: 404
2025-08-10 11:50:39,419 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:39,427 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:39,439 - DEBUG - Requesting: http://10.0.0.49:8082/project/ef568445-e279-4bff-9593-06d1aeed0174
2025-08-10 11:50:39,524 - INFO - Validated that VN ctest-left_vn-52719526 is not found in API Server
2025-08-10 11:50:39,535 - DEBUG - VN ctest-left_vn-52719526 is not present in Agent 10.0.0.65
2025-08-10 11:50:39,545 - DEBUG - VN ctest-left_vn-52719526 is not present in Agent 10.0.0.56
2025-08-10 11:50:39,545 - INFO - Validated that VN ctest-left_vn-52719526 is not in any agent
2025-08-10 11:50:39,575 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-52719526 info
2025-08-10 11:50:39,575 - INFO - Deleting VN ctest-mgmt_vn-49242934
2025-08-10 11:50:39,694 - DEBUG - Response for deleting network ()
2025-08-10 11:50:39,694 - DEBUG - Requesting: http://10.0.0.49:8082/routing-instance/5ea6834d-b1ec-4087-ae7c-12283c2ff19d
2025-08-10 11:50:39,700 - DEBUG - Response Code: 404
2025-08-10 11:50:39,700 - DEBUG - Requesting: http://10.0.0.49:8082/domains
2025-08-10 11:50:39,711 - DEBUG - Requesting: http://10.0.0.49:8082/domain/506b9682-8eb9-488e-ab69-24d332f4d228
2025-08-10 11:50:39,769 - DEBUG - Requesting: http://10.0.0.49:8082/project/ef568445-e279-4bff-9593-06d1aeed0174
2025-08-10 11:50:39,851 - INFO - Validated that VN ctest-mgmt_vn-49242934 is not found in API Server
2025-08-10 11:50:39,862 - DEBUG - VN ctest-mgmt_vn-49242934 is not present in Agent 10.0.0.65
2025-08-10 11:50:39,872 - DEBUG - VN ctest-mgmt_vn-49242934 is not present in Agent 10.0.0.56
2025-08-10 11:50:39,872 - INFO - Validated that VN ctest-mgmt_vn-49242934 is not in any agent
2025-08-10 11:50:39,904 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-49242934 info
2025-08-10 11:50:41,151 - DEBUG - No XMPP flaps were noticed during the test
2025-08-10 11:50:41,151 - INFO -
2025-08-10 11:50:41,151 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:12]
2025-08-10 11:50:41,151 - INFO - --------------------------------------------------------------------------------
2025-08-10 11:50:41,814 - INFO - Deleted project: ctest-TestSvcRegr-90707582, ID : ef568445-e279-4bff-9593-06d1aeed0174