]) created on node: (an-jenkins-deploy-platform-ansible-os-4827-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4827-1)
2025-12-01 03:11:00,542 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-42987714']
2025-12-01 03:11:00,871 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-42987714'] created succesfully
2025-12-01 03:11:01,291 - DEBUG - Image by name tiny_nat_fw not found
2025-12-01 03:11:01,291 - DEBUG - Installing image tiny_nat_fw
2025-12-01 03:11:01,291 - 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-12-01 03:11:01,291 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2025-12-01 03:11:01,291 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2025-12-01 03:11:01,315 - 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-12-01 03:11:01,443 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-12-01 03:11:01,443 - DEBUG - Unzip image
2025-12-01 03:11:01,443 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-12-01 03:11:01,478 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2025-12-01 03:11:01,482 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-42987714']
2025-12-01 03:11:01,597 - INFO - Service template: ['default-domain', 'ctest-service_template_1-42987714'] deleted successfully.
2025-12-01 03:11:01,598 - INFO - Skip interface_detach for VM ctest-right_vm-32503413 in state BUILD
2025-12-01 03:11:01,598 - INFO - Deleting VM ctest-right_vm-32503413
2025-12-01 03:11:01,634 - ERROR - VM ctest-right_vm-32503413 has failed to come up
2025-12-01 03:11:01,634 - ERROR - Nova failed to get host of the VM
2025-12-01 03:11:01,634 - ERROR - VM ctest-right_vm-32503413 has failed to come up
2025-12-01 03:11:01,634 - ERROR - Nova failed to get host of the VM
2025-12-01 03:11:01,725 - INFO - Skip interface_detach for VM ctest-left_vm-11355897 in state BUILD
2025-12-01 03:11:01,725 - INFO - Deleting VM ctest-left_vm-11355897
2025-12-01 03:11:01,725 - ERROR - VM ctest-left_vm-11355897 has failed to come up
2025-12-01 03:11:01,725 - ERROR - Nova failed to get host of the VM
2025-12-01 03:11:01,725 - ERROR - VM ctest-left_vm-11355897 has failed to come up
2025-12-01 03:11:01,725 - ERROR - Nova failed to get host of the VM
2025-12-01 03:11:01,811 - INFO - Deleting VN ctest-right_vn-78931911
2025-12-01 03:11:01,865 - DEBUG - VN e59488d4-dad2-4e7f-94a2-64518c804530 still in use: Unable to complete operation on network e59488d4-dad2-4e7f-94a2-64518c804530. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-71289040-6d45-4304-a06b-b1497272175b']
2025-12-01 03:11:01,866 - WARNING - Deleting VN ctest-right_vn-78931911 failed..Will retry
2025-12-01 03:11:03,909 - DEBUG - VN e59488d4-dad2-4e7f-94a2-64518c804530 still in use: Unable to complete operation on network e59488d4-dad2-4e7f-94a2-64518c804530. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-625d8e87-c3f1-41f6-b852-a0fb33f38270']
2025-12-01 03:11:03,909 - WARNING - Deleting VN ctest-right_vn-78931911 failed..Will retry
2025-12-01 03:11:06,089 - DEBUG - Response for deleting network ()
2025-12-01 03:11:06,089 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2f73cf1e-580d-4679-bbdb-eb9dda5ad5fe
2025-12-01 03:11:06,096 - DEBUG - Response Code: 404
2025-12-01 03:11:06,097 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:06,117 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:06,141 - DEBUG - Requesting: http://10.0.0.27:8082/project/84a4a977-ea8d-4100-b2a5-c8f1be3e3f0a
2025-12-01 03:11:06,242 - INFO - Validated that VN ctest-right_vn-78931911 is not found in API Server
2025-12-01 03:11:06,256 - DEBUG - VN ctest-right_vn-78931911 is not present in Agent 10.0.0.22
2025-12-01 03:11:06,270 - DEBUG - VN ctest-right_vn-78931911 is not present in Agent 10.0.0.241
2025-12-01 03:11:06,270 - INFO - Validated that VN ctest-right_vn-78931911 is not in any agent
2025-12-01 03:11:06,304 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-78931911 info
2025-12-01 03:11:06,304 - INFO - Deleting VN ctest-left_vn-19732784
2025-12-01 03:11:06,469 - DEBUG - Response for deleting network ()
2025-12-01 03:11:06,469 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/d179e425-26e1-4b45-b372-845e339974fc
2025-12-01 03:11:06,474 - DEBUG - Response Code: 404
2025-12-01 03:11:06,475 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:06,481 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:06,498 - DEBUG - Requesting: http://10.0.0.27:8082/project/84a4a977-ea8d-4100-b2a5-c8f1be3e3f0a
2025-12-01 03:11:06,591 - INFO - Validated that VN ctest-left_vn-19732784 is not found in API Server
2025-12-01 03:11:06,605 - DEBUG - VN ctest-left_vn-19732784 is not present in Agent 10.0.0.22
2025-12-01 03:11:06,615 - DEBUG - VN ctest-left_vn-19732784 is not present in Agent 10.0.0.241
2025-12-01 03:11:06,615 - INFO - Validated that VN ctest-left_vn-19732784 is not in any agent
2025-12-01 03:11:06,650 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-19732784 info
2025-12-01 03:11:06,650 - INFO - Deleting VN ctest-mgmt_vn-70052575
2025-12-01 03:11:06,832 - DEBUG - Response for deleting network ()
2025-12-01 03:11:06,832 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3c1bf2aa-d983-40b9-b069-669777ef0ed4
2025-12-01 03:11:06,839 - DEBUG - Response Code: 404
2025-12-01 03:11:06,839 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:06,858 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:06,877 - DEBUG - Requesting: http://10.0.0.27:8082/project/84a4a977-ea8d-4100-b2a5-c8f1be3e3f0a
2025-12-01 03:11:06,982 - INFO - Validated that VN ctest-mgmt_vn-70052575 is not found in API Server
2025-12-01 03:11:07,006 - DEBUG - VN ctest-mgmt_vn-70052575 is not present in Agent 10.0.0.22
2025-12-01 03:11:07,018 - DEBUG - VN ctest-mgmt_vn-70052575 is not present in Agent 10.0.0.241
2025-12-01 03:11:07,019 - INFO - Validated that VN ctest-mgmt_vn-70052575 is not in any agent
2025-12-01 03:11:07,055 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-70052575 info
2025-12-01 03:11:07,055 - INFO - Deleting VM ctest-vm-in-third-vn-03771930
2025-12-01 03:11:07,139 - INFO - Deleting VN ctest-third-vn-79095588
2025-12-01 03:11:07,187 - DEBUG - VN 2aeb311f-e6e9-4ae0-a7bc-874931288b7c still in use: Unable to complete operation on network 2aeb311f-e6e9-4ae0-a7bc-874931288b7c. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-0a7c4e75-9860-4d9e-9f14-08b271538cb3']
2025-12-01 03:11:07,188 - WARNING - Deleting VN ctest-third-vn-79095588 failed..Will retry
2025-12-01 03:11:09,340 - DEBUG - Response for deleting network ()
2025-12-01 03:11:10,629 - DEBUG - No XMPP flaps were noticed during the test
2025-12-01 03:11:10,630 - INFO -
2025-12-01 03:11:10,630 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:28]
2025-12-01 03:11:10,630 - INFO - --------------------------------------------------------------------------------
2025-12-01 03:11:10,636 - INFO - ================================================================================
2025-12-01 03:11:10,636 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2025-12-01 03:11:11,940 - DEBUG - Nothing to compare xmpp stats {'10.0.0.22': {'10.20.0.209': '0', '10.20.0.192': '0'}, '10.0.0.241': {'10.20.0.209': '0', '10.20.0.192': '0'}} with
2025-12-01 03:11:11,941 - INFO - Initial checks done. Running the testcase now
2025-12-01 03:11:11,941 - INFO -
2025-12-01 03:11:12,251 - DEBUG - Response for create_network : {'network': {'id': '83d37adc-4de6-4759-8755-c87c90d22269', 'name': 'ctest-mgmt_vn-07736646', 'tenant_id': '84a4a977ea8d4100b2a5c8f1be3e3f0a', 'project_id': '84a4a977ea8d4100b2a5c8f1be3e3f0a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-63352202', 'ctest-mgmt_vn-07736646'], 'port_security_enabled': True, 'description': ''}}
2025-12-01 03:11:12,481 - DEBUG - Response for create_subnet : {'subnet': {'id': '833b95ca-7382-44ba-9912-8faf52059f45', 'name': '', 'tenant_id': '84a4a977ea8d4100b2a5c8f1be3e3f0a', 'network_id': '83d37adc-4de6-4759-8755-c87c90d22269', 'ip_version': 4, 'cidr': '22.161.208.0/26', 'allocation_pools': [{'start': '22.161.208.2', 'end': '22.161.208.62'}], 'gateway_ip': '22.161.208.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '22.161.208.2', 'tags': [], 'project_id': '84a4a977ea8d4100b2a5c8f1be3e3f0a'}}
2025-12-01 03:11:12,508 - INFO - Created VN ctest-mgmt_vn-07736646
2025-12-01 03:11:12,524 - DEBUG - VN ctest-mgmt_vn-07736646 UUID is 83d37adc-4de6-4759-8755-c87c90d22269
2025-12-01 03:11:12,613 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:12,620 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:12,634 - DEBUG - Requesting: http://10.0.0.27:8082/project/84a4a977-ea8d-4100-b2a5-c8f1be3e3f0a
2025-12-01 03:11:12,729 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/83d37adc-4de6-4759-8755-c87c90d22269
2025-12-01 03:11:12,742 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/83d37adc-4de6-4759-8755-c87c90d22269
2025-12-01 03:11:12,752 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/32600fe7-1cf0-48fc-93fb-a6218cb8e2d8
2025-12-01 03:11:12,760 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/32600fe7-1cf0-48fc-93fb-a6218cb8e2d8
2025-12-01 03:11:12,769 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/7a38a7aa-110c-46de-81f4-2d6e6dcfdba3
2025-12-01 03:11:12,778 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-01 03:11:12,778 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/83d37adc-4de6-4759-8755-c87c90d22269
2025-12-01 03:11:12,788 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/32600fe7-1cf0-48fc-93fb-a6218cb8e2d8
2025-12-01 03:11:12,804 - INFO - Verified VN network id 13 for VN 83d37adc-4de6-4759-8755-c87c90d22269
2025-12-01 03:11:12,804 - INFO - Verifications in API Server for VN ctest-mgmt_vn-07736646 passed
2025-12-01 03:11:12,804 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/83d37adc-4de6-4759-8755-c87c90d22269
2025-12-01 03:11:12,814 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/32600fe7-1cf0-48fc-93fb-a6218cb8e2d8
2025-12-01 03:11:12,823 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/32600fe7-1cf0-48fc-93fb-a6218cb8e2d8
2025-12-01 03:11:12,834 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/7a38a7aa-110c-46de-81f4-2d6e6dcfdba3
2025-12-01 03:11:12,850 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-63352202:ctest-mgmt_vn-07736646', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-63352202', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9499071125672839001', 'uuid-lslong': '9751921005471867497'}, 'enable': 'true', 'created': '2025-12-01T03:11:12', 'last-modified': '2025-12-01T03:11:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.422328'}
2025-12-01 03:11:12,855 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-01 03:11:12,860 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-63352202:ctest-mgmt_vn-07736646', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-63352202', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9499071125672839001', 'uuid-lslong': '9751921005471867497'}, 'enable': 'true', 'created': '2025-12-01T03:11:12', 'last-modified': '2025-12-01T03:11:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.433825'}
2025-12-01 03:11:12,866 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-01 03:11:12,872 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-63352202:ctest-mgmt_vn-07736646', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-63352202', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9499071125672839001', 'uuid-lslong': '9751921005471867497'}, 'enable': 'true', 'created': '2025-12-01T03:11:12', 'last-modified': '2025-12-01T03:11:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.444759'}
2025-12-01 03:11:12,880 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-01 03:11:12,880 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-07736646 passed
2025-12-01 03:11:12,880 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-07736646 in API_Server ======
2025-12-01 03:11:12,881 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:12,888 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:12,900 - DEBUG - Requesting: http://10.0.0.27:8082/project/84a4a977-ea8d-4100-b2a5-c8f1be3e3f0a
2025-12-01 03:11:12,998 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/83d37adc-4de6-4759-8755-c87c90d22269
2025-12-01 03:11:13,011 - DEBUG - =>VN ctest-mgmt_vn-07736646 has no policy to be verified
2025-12-01 03:11:13,011 - DEBUG - Verifying the vn in opserver
2025-12-01 03:11:13,011 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-63352202:ctest-mgmt_vn-07736646 virtual network link through opserver 10.0.0.27
2025-12-01 03:11:13,012 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:11:13,025 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-63352202:ctest-mgmt_vn-07736646', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-63352202:ctest-mgmt_vn-07736646?flat'}
2025-12-01 03:11:13,025 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-63352202:ctest-mgmt_vn-07736646 virtual network link through opserver 10.0.0.33
2025-12-01 03:11:13,025 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:11:13,038 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-63352202:ctest-mgmt_vn-07736646', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-63352202:ctest-mgmt_vn-07736646?flat'}
2025-12-01 03:11:13,038 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-63352202:ctest-mgmt_vn-07736646 virtual network link through opserver 10.0.0.23
2025-12-01 03:11:13,038 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:11:13,053 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-63352202:ctest-mgmt_vn-07736646', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-63352202:ctest-mgmt_vn-07736646?flat'}
2025-12-01 03:11:13,053 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-63352202:ctest-mgmt_vn-07736646 is found in opserver
2025-12-01 03:11:13,078 - DEBUG - Do not have enough data to verify VN in agent
2025-12-01 03:11:13,089 - DEBUG - VRF ids for VN ctest-mgmt_vn-07736646: {}
2025-12-01 03:11:13,391 - DEBUG - Response for create_network : {'network': {'id': '79825192-9501-4525-bf3d-641d8b4bf128', 'name': 'ctest-left_vn-13510967', 'tenant_id': '84a4a977ea8d4100b2a5c8f1be3e3f0a', 'project_id': '84a4a977ea8d4100b2a5c8f1be3e3f0a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-63352202', 'ctest-left_vn-13510967'], 'port_security_enabled': True, 'description': ''}}
2025-12-01 03:11:13,685 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e408add5-d79a-4b3a-b590-05ef6a1848a7', 'name': '', 'tenant_id': '84a4a977ea8d4100b2a5c8f1be3e3f0a', 'network_id': '79825192-9501-4525-bf3d-641d8b4bf128', 'ip_version': 4, 'cidr': '22.51.105.192/26', 'allocation_pools': [{'start': '22.51.105.194', 'end': '22.51.105.254'}], 'gateway_ip': '22.51.105.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '22.51.105.194', 'tags': [], 'project_id': '84a4a977ea8d4100b2a5c8f1be3e3f0a'}}
2025-12-01 03:11:13,722 - INFO - Created VN ctest-left_vn-13510967
2025-12-01 03:11:13,737 - DEBUG - VN ctest-left_vn-13510967 UUID is 79825192-9501-4525-bf3d-641d8b4bf128
2025-12-01 03:11:13,831 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:13,839 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:13,856 - DEBUG - Requesting: http://10.0.0.27:8082/project/84a4a977-ea8d-4100-b2a5-c8f1be3e3f0a
2025-12-01 03:11:13,943 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/79825192-9501-4525-bf3d-641d8b4bf128
2025-12-01 03:11:13,963 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/79825192-9501-4525-bf3d-641d8b4bf128
2025-12-01 03:11:13,973 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/d008e9be-1182-4b4f-bfab-2e82f6724f24
2025-12-01 03:11:13,985 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/d008e9be-1182-4b4f-bfab-2e82f6724f24
2025-12-01 03:11:13,994 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/97f60c94-3e3d-4c60-bd0e-4a28bc34546d
2025-12-01 03:11:14,002 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-01 03:11:14,002 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/79825192-9501-4525-bf3d-641d8b4bf128
2025-12-01 03:11:14,012 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/d008e9be-1182-4b4f-bfab-2e82f6724f24
2025-12-01 03:11:14,033 - INFO - Verified VN network id 14 for VN 79825192-9501-4525-bf3d-641d8b4bf128
2025-12-01 03:11:14,034 - INFO - Verifications in API Server for VN ctest-left_vn-13510967 passed
2025-12-01 03:11:14,034 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/79825192-9501-4525-bf3d-641d8b4bf128
2025-12-01 03:11:14,044 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/d008e9be-1182-4b4f-bfab-2e82f6724f24
2025-12-01 03:11:14,053 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/d008e9be-1182-4b4f-bfab-2e82f6724f24
2025-12-01 03:11:14,060 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/97f60c94-3e3d-4c60-bd0e-4a28bc34546d
2025-12-01 03:11:14,075 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-63352202:ctest-left_vn-13510967', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-63352202', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8755650315568629029', 'uuid-lslong': '13780280512877424936'}, 'enable': 'true', 'created': '2025-12-01T03:11:13', 'last-modified': '2025-12-01T03:11:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.455138'}
2025-12-01 03:11:14,081 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-01 03:11:14,086 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-63352202:ctest-left_vn-13510967', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-63352202', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8755650315568629029', 'uuid-lslong': '13780280512877424936'}, 'enable': 'true', 'created': '2025-12-01T03:11:13', 'last-modified': '2025-12-01T03:11:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.461504'}
2025-12-01 03:11:14,092 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-01 03:11:14,098 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-63352202:ctest-left_vn-13510967', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-63352202', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8755650315568629029', 'uuid-lslong': '13780280512877424936'}, 'enable': 'true', 'created': '2025-12-01T03:11:13', 'last-modified': '2025-12-01T03:11:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.483413'}
2025-12-01 03:11:14,104 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-01 03:11:14,104 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-13510967 passed
2025-12-01 03:11:14,105 - DEBUG - ====Verifying policy data for ctest-left_vn-13510967 in API_Server ======
2025-12-01 03:11:14,105 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:14,112 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:14,125 - DEBUG - Requesting: http://10.0.0.27:8082/project/84a4a977-ea8d-4100-b2a5-c8f1be3e3f0a
2025-12-01 03:11:14,226 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/79825192-9501-4525-bf3d-641d8b4bf128
2025-12-01 03:11:14,239 - DEBUG - =>VN ctest-left_vn-13510967 has no policy to be verified
2025-12-01 03:11:14,239 - DEBUG - Verifying the vn in opserver
2025-12-01 03:11:14,239 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-63352202:ctest-left_vn-13510967 virtual network link through opserver 10.0.0.27
2025-12-01 03:11:14,239 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:11:14,254 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-63352202:ctest-left_vn-13510967', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-63352202:ctest-left_vn-13510967?flat'}
2025-12-01 03:11:14,254 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-63352202:ctest-left_vn-13510967 virtual network link through opserver 10.0.0.33
2025-12-01 03:11:14,255 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:11:14,271 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-63352202:ctest-left_vn-13510967', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-63352202:ctest-left_vn-13510967?flat'}
2025-12-01 03:11:14,271 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-63352202:ctest-left_vn-13510967 virtual network link through opserver 10.0.0.23
2025-12-01 03:11:14,271 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:11:14,286 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-63352202:ctest-left_vn-13510967', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-63352202:ctest-left_vn-13510967?flat'}
2025-12-01 03:11:14,286 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-63352202:ctest-left_vn-13510967 is found in opserver
2025-12-01 03:11:14,310 - DEBUG - Do not have enough data to verify VN in agent
2025-12-01 03:11:14,322 - DEBUG - VRF ids for VN ctest-left_vn-13510967: {}
2025-12-01 03:11:14,614 - DEBUG - Response for create_network : {'network': {'id': 'e3e08885-b0b8-41bc-8fc1-87046f57c714', 'name': 'ctest-right_vn-53089364', 'tenant_id': '84a4a977ea8d4100b2a5c8f1be3e3f0a', 'project_id': '84a4a977ea8d4100b2a5c8f1be3e3f0a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-63352202', 'ctest-right_vn-53089364'], 'port_security_enabled': True, 'description': ''}}
2025-12-01 03:11:14,851 - DEBUG - Response for create_subnet : {'subnet': {'id': '10278ab2-5890-436b-9420-6b1b550a0cde', 'name': '', 'tenant_id': '84a4a977ea8d4100b2a5c8f1be3e3f0a', 'network_id': 'e3e08885-b0b8-41bc-8fc1-87046f57c714', 'ip_version': 4, 'cidr': '20.82.237.64/26', 'allocation_pools': [{'start': '20.82.237.66', 'end': '20.82.237.126'}], 'gateway_ip': '20.82.237.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '20.82.237.66', 'tags': [], 'project_id': '84a4a977ea8d4100b2a5c8f1be3e3f0a'}}
2025-12-01 03:11:14,872 - INFO - Created VN ctest-right_vn-53089364
2025-12-01 03:11:14,887 - DEBUG - VN ctest-right_vn-53089364 UUID is e3e08885-b0b8-41bc-8fc1-87046f57c714
2025-12-01 03:11:14,970 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:14,977 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:14,990 - DEBUG - Requesting: http://10.0.0.27:8082/project/84a4a977-ea8d-4100-b2a5-c8f1be3e3f0a
2025-12-01 03:11:15,094 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/e3e08885-b0b8-41bc-8fc1-87046f57c714
2025-12-01 03:11:15,107 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/e3e08885-b0b8-41bc-8fc1-87046f57c714
2025-12-01 03:11:15,119 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7f6234f0-cb8b-4c40-a5f9-13f28ce20fd0
2025-12-01 03:11:15,127 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7f6234f0-cb8b-4c40-a5f9-13f28ce20fd0
2025-12-01 03:11:15,134 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/7aa9a636-1ca4-4288-addc-5d596c557bf6
2025-12-01 03:11:15,142 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-01 03:11:15,142 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/e3e08885-b0b8-41bc-8fc1-87046f57c714
2025-12-01 03:11:15,153 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7f6234f0-cb8b-4c40-a5f9-13f28ce20fd0
2025-12-01 03:11:15,171 - INFO - Verified VN network id 15 for VN e3e08885-b0b8-41bc-8fc1-87046f57c714
2025-12-01 03:11:15,171 - INFO - Verifications in API Server for VN ctest-right_vn-53089364 passed
2025-12-01 03:11:15,171 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/e3e08885-b0b8-41bc-8fc1-87046f57c714
2025-12-01 03:11:15,182 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7f6234f0-cb8b-4c40-a5f9-13f28ce20fd0
2025-12-01 03:11:15,190 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7f6234f0-cb8b-4c40-a5f9-13f28ce20fd0
2025-12-01 03:11:15,199 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/7aa9a636-1ca4-4288-addc-5d596c557bf6
2025-12-01 03:11:15,215 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-63352202:ctest-right_vn-53089364', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-63352202', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16420274349169721788', 'uuid-lslong': '10358709071046493972'}, 'enable': 'true', 'created': '2025-12-01T03:11:14', 'last-modified': '2025-12-01T03:11:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.425479'}
2025-12-01 03:11:15,222 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-01 03:11:15,228 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-63352202:ctest-right_vn-53089364', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-63352202', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16420274349169721788', 'uuid-lslong': '10358709071046493972'}, 'enable': 'true', 'created': '2025-12-01T03:11:14', 'last-modified': '2025-12-01T03:11:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.431359'}
2025-12-01 03:11:15,238 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-01 03:11:15,245 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-63352202:ctest-right_vn-53089364', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-63352202', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16420274349169721788', 'uuid-lslong': '10358709071046493972'}, 'enable': 'true', 'created': '2025-12-01T03:11:14', 'last-modified': '2025-12-01T03:11:14', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.453401'}
2025-12-01 03:11:15,253 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-01 03:11:15,253 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-53089364 passed
2025-12-01 03:11:15,254 - DEBUG - ====Verifying policy data for ctest-right_vn-53089364 in API_Server ======
2025-12-01 03:11:15,254 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:15,262 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:15,276 - DEBUG - Requesting: http://10.0.0.27:8082/project/84a4a977-ea8d-4100-b2a5-c8f1be3e3f0a
2025-12-01 03:11:15,368 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/e3e08885-b0b8-41bc-8fc1-87046f57c714
2025-12-01 03:11:15,380 - DEBUG - =>VN ctest-right_vn-53089364 has no policy to be verified
2025-12-01 03:11:15,380 - DEBUG - Verifying the vn in opserver
2025-12-01 03:11:15,380 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-63352202:ctest-right_vn-53089364 virtual network link through opserver 10.0.0.27
2025-12-01 03:11:15,380 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:11:15,395 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-63352202:ctest-right_vn-53089364', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-63352202:ctest-right_vn-53089364?flat'}
2025-12-01 03:11:15,395 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-63352202:ctest-right_vn-53089364 virtual network link through opserver 10.0.0.33
2025-12-01 03:11:15,395 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:11:15,408 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-63352202:ctest-right_vn-53089364', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-63352202:ctest-right_vn-53089364?flat'}
2025-12-01 03:11:15,408 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-63352202:ctest-right_vn-53089364 virtual network link through opserver 10.0.0.23
2025-12-01 03:11:15,408 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:11:15,425 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-63352202:ctest-right_vn-53089364', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-63352202:ctest-right_vn-53089364?flat'}
2025-12-01 03:11:15,425 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-63352202:ctest-right_vn-53089364 is found in opserver
2025-12-01 03:11:15,448 - DEBUG - Do not have enough data to verify VN in agent
2025-12-01 03:11:15,459 - DEBUG - VRF ids for VN ctest-right_vn-53089364: {}
2025-12-01 03:11:15,753 - DEBUG - Response for create_network : {'network': {'id': '7df22835-8388-426f-963a-6a0398a821c8', 'name': 'ctest-trans_left_vn-58115498', 'tenant_id': '84a4a977ea8d4100b2a5c8f1be3e3f0a', 'project_id': '84a4a977ea8d4100b2a5c8f1be3e3f0a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-63352202', 'ctest-trans_left_vn-58115498'], 'port_security_enabled': True, 'description': ''}}
2025-12-01 03:11:16,015 - DEBUG - Response for create_subnet : {'subnet': {'id': '1999d537-33c9-45a6-aaf7-d4a2fcac6df4', 'name': '', 'tenant_id': '84a4a977ea8d4100b2a5c8f1be3e3f0a', 'network_id': '7df22835-8388-426f-963a-6a0398a821c8', 'ip_version': 4, 'cidr': '82.248.202.128/26', 'allocation_pools': [{'start': '82.248.202.130', 'end': '82.248.202.190'}], 'gateway_ip': '82.248.202.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '82.248.202.130', 'tags': [], 'project_id': '84a4a977ea8d4100b2a5c8f1be3e3f0a'}}
2025-12-01 03:11:16,043 - INFO - Created VN ctest-trans_left_vn-58115498
2025-12-01 03:11:16,055 - DEBUG - VN ctest-trans_left_vn-58115498 UUID is 7df22835-8388-426f-963a-6a0398a821c8
2025-12-01 03:11:16,143 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:16,154 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:16,166 - DEBUG - Requesting: http://10.0.0.27:8082/project/84a4a977-ea8d-4100-b2a5-c8f1be3e3f0a
2025-12-01 03:11:16,269 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/7df22835-8388-426f-963a-6a0398a821c8
2025-12-01 03:11:16,281 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/7df22835-8388-426f-963a-6a0398a821c8
2025-12-01 03:11:16,291 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4861af70-1c26-418b-ba3d-7ec33034ae7a
2025-12-01 03:11:16,300 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4861af70-1c26-418b-ba3d-7ec33034ae7a
2025-12-01 03:11:16,308 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/5af89ecd-cc38-4d0f-a1b2-81922b63ec99
2025-12-01 03:11:16,316 - DEBUG - Route Targets: ['target:64512:8000008']
2025-12-01 03:11:16,316 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/7df22835-8388-426f-963a-6a0398a821c8
2025-12-01 03:11:16,330 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4861af70-1c26-418b-ba3d-7ec33034ae7a
2025-12-01 03:11:16,359 - INFO - Verified VN network id 16 for VN 7df22835-8388-426f-963a-6a0398a821c8
2025-12-01 03:11:16,359 - INFO - Verifications in API Server for VN ctest-trans_left_vn-58115498 passed
2025-12-01 03:11:16,359 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/7df22835-8388-426f-963a-6a0398a821c8
2025-12-01 03:11:16,373 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4861af70-1c26-418b-ba3d-7ec33034ae7a
2025-12-01 03:11:16,383 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4861af70-1c26-418b-ba3d-7ec33034ae7a
2025-12-01 03:11:16,392 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/5af89ecd-cc38-4d0f-a1b2-81922b63ec99
2025-12-01 03:11:16,410 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-63352202:ctest-trans_left_vn-58115498', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-63352202', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9075360409410093679', 'uuid-lslong': '10825081218017010120'}, 'enable': 'true', 'created': '2025-12-01T03:11:15', 'last-modified': '2025-12-01T03:11:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.447122'}
2025-12-01 03:11:16,423 - DEBUG - Route Targets: ['target:64512:8000008']
2025-12-01 03:11:16,428 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-63352202:ctest-trans_left_vn-58115498', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-63352202', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9075360409410093679', 'uuid-lslong': '10825081218017010120'}, 'enable': 'true', 'created': '2025-12-01T03:11:15', 'last-modified': '2025-12-01T03:11:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.468915'}
2025-12-01 03:11:16,435 - DEBUG - Route Targets: ['target:64512:8000008']
2025-12-01 03:11:16,444 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-63352202:ctest-trans_left_vn-58115498', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-63352202', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9075360409410093679', 'uuid-lslong': '10825081218017010120'}, 'enable': 'true', 'created': '2025-12-01T03:11:15', 'last-modified': '2025-12-01T03:11:15', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.482955'}
2025-12-01 03:11:16,454 - DEBUG - Route Targets: ['target:64512:8000008']
2025-12-01 03:11:16,454 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-58115498 passed
2025-12-01 03:11:16,455 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-58115498 in API_Server ======
2025-12-01 03:11:16,455 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:16,464 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:16,479 - DEBUG - Requesting: http://10.0.0.27:8082/project/84a4a977-ea8d-4100-b2a5-c8f1be3e3f0a
2025-12-01 03:11:16,584 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/7df22835-8388-426f-963a-6a0398a821c8
2025-12-01 03:11:16,595 - DEBUG - =>VN ctest-trans_left_vn-58115498 has no policy to be verified
2025-12-01 03:11:16,595 - DEBUG - Verifying the vn in opserver
2025-12-01 03:11:16,595 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-63352202:ctest-trans_left_vn-58115498 virtual network link through opserver 10.0.0.27
2025-12-01 03:11:16,595 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:11:16,609 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-63352202:ctest-trans_left_vn-58115498', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-63352202:ctest-trans_left_vn-58115498?flat'}
2025-12-01 03:11:16,609 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-63352202:ctest-trans_left_vn-58115498 virtual network link through opserver 10.0.0.33
2025-12-01 03:11:16,609 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:11:16,622 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-63352202:ctest-trans_left_vn-58115498', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-63352202:ctest-trans_left_vn-58115498?flat'}
2025-12-01 03:11:16,622 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-63352202:ctest-trans_left_vn-58115498 virtual network link through opserver 10.0.0.23
2025-12-01 03:11:16,622 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:11:16,638 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-63352202:ctest-trans_left_vn-58115498', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-63352202:ctest-trans_left_vn-58115498?flat'}
2025-12-01 03:11:16,638 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-63352202:ctest-trans_left_vn-58115498 is found in opserver
2025-12-01 03:11:16,662 - DEBUG - Do not have enough data to verify VN in agent
2025-12-01 03:11:16,675 - DEBUG - VRF ids for VN ctest-trans_left_vn-58115498: {}
2025-12-01 03:11:16,998 - DEBUG - Response for create_network : {'network': {'id': '569e3363-9854-4186-8c8d-85a73aae5d3e', 'name': 'ctest-trans_right_vn-95517308', 'tenant_id': '84a4a977ea8d4100b2a5c8f1be3e3f0a', 'project_id': '84a4a977ea8d4100b2a5c8f1be3e3f0a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-63352202', 'ctest-trans_right_vn-95517308'], 'port_security_enabled': True, 'description': ''}}
2025-12-01 03:11:17,227 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd734a1d0-0f3c-4286-b23d-cf7bfc314cff', 'name': '', 'tenant_id': '84a4a977ea8d4100b2a5c8f1be3e3f0a', 'network_id': '569e3363-9854-4186-8c8d-85a73aae5d3e', 'ip_version': 4, 'cidr': '154.24.92.192/26', 'allocation_pools': [{'start': '154.24.92.194', 'end': '154.24.92.254'}], 'gateway_ip': '154.24.92.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '154.24.92.194', 'tags': [], 'project_id': '84a4a977ea8d4100b2a5c8f1be3e3f0a'}}
2025-12-01 03:11:17,259 - INFO - Created VN ctest-trans_right_vn-95517308
2025-12-01 03:11:17,271 - DEBUG - VN ctest-trans_right_vn-95517308 UUID is 569e3363-9854-4186-8c8d-85a73aae5d3e
2025-12-01 03:11:17,356 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:17,363 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:17,375 - DEBUG - Requesting: http://10.0.0.27:8082/project/84a4a977-ea8d-4100-b2a5-c8f1be3e3f0a
2025-12-01 03:11:17,481 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/569e3363-9854-4186-8c8d-85a73aae5d3e
2025-12-01 03:11:17,500 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/569e3363-9854-4186-8c8d-85a73aae5d3e
2025-12-01 03:11:17,510 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2c5e830d-fe16-4aec-8a0a-c9eb8dfba6a6
2025-12-01 03:11:17,521 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2c5e830d-fe16-4aec-8a0a-c9eb8dfba6a6
2025-12-01 03:11:17,530 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/c2df35e2-2618-4565-89c6-b33577f91b00
2025-12-01 03:11:17,539 - DEBUG - Route Targets: ['target:64512:8000009']
2025-12-01 03:11:17,539 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/569e3363-9854-4186-8c8d-85a73aae5d3e
2025-12-01 03:11:17,549 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2c5e830d-fe16-4aec-8a0a-c9eb8dfba6a6
2025-12-01 03:11:17,568 - INFO - Verified VN network id 17 for VN 569e3363-9854-4186-8c8d-85a73aae5d3e
2025-12-01 03:11:17,569 - INFO - Verifications in API Server for VN ctest-trans_right_vn-95517308 passed
2025-12-01 03:11:17,569 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/569e3363-9854-4186-8c8d-85a73aae5d3e
2025-12-01 03:11:17,580 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2c5e830d-fe16-4aec-8a0a-c9eb8dfba6a6
2025-12-01 03:11:17,587 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2c5e830d-fe16-4aec-8a0a-c9eb8dfba6a6
2025-12-01 03:11:17,596 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/c2df35e2-2618-4565-89c6-b33577f91b00
2025-12-01 03:11:17,610 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-63352202:ctest-trans_right_vn-95517308', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-63352202', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6241482636432523654', 'uuid-lslong': '10127898090316651838'}, 'enable': 'true', 'created': '2025-12-01T03:11:16', 'last-modified': '2025-12-01T03:11:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.441397'}
2025-12-01 03:11:17,616 - DEBUG - Route Targets: ['target:64512:8000009']
2025-12-01 03:11:17,623 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-63352202:ctest-trans_right_vn-95517308', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-63352202', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6241482636432523654', 'uuid-lslong': '10127898090316651838'}, 'enable': 'true', 'created': '2025-12-01T03:11:16', 'last-modified': '2025-12-01T03:11:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.451394'}
2025-12-01 03:11:17,630 - DEBUG - Route Targets: ['target:64512:8000009']
2025-12-01 03:11:17,636 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-63352202:ctest-trans_right_vn-95517308', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-63352202', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6241482636432523654', 'uuid-lslong': '10127898090316651838'}, 'enable': 'true', 'created': '2025-12-01T03:11:16', 'last-modified': '2025-12-01T03:11:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.463662'}
2025-12-01 03:11:17,643 - DEBUG - Route Targets: ['target:64512:8000009']
2025-12-01 03:11:17,643 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-95517308 passed
2025-12-01 03:11:17,643 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-95517308 in API_Server ======
2025-12-01 03:11:17,643 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:17,651 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:17,665 - DEBUG - Requesting: http://10.0.0.27:8082/project/84a4a977-ea8d-4100-b2a5-c8f1be3e3f0a
2025-12-01 03:11:17,769 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/569e3363-9854-4186-8c8d-85a73aae5d3e
2025-12-01 03:11:17,781 - DEBUG - =>VN ctest-trans_right_vn-95517308 has no policy to be verified
2025-12-01 03:11:17,781 - DEBUG - Verifying the vn in opserver
2025-12-01 03:11:17,781 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-63352202:ctest-trans_right_vn-95517308 virtual network link through opserver 10.0.0.27
2025-12-01 03:11:17,781 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:11:17,794 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-63352202:ctest-trans_right_vn-95517308', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-63352202:ctest-trans_right_vn-95517308?flat'}
2025-12-01 03:11:17,794 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-63352202:ctest-trans_right_vn-95517308 virtual network link through opserver 10.0.0.33
2025-12-01 03:11:17,794 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:11:17,814 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-63352202:ctest-trans_right_vn-95517308', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-63352202:ctest-trans_right_vn-95517308?flat'}
2025-12-01 03:11:17,814 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-63352202:ctest-trans_right_vn-95517308 virtual network link through opserver 10.0.0.23
2025-12-01 03:11:17,814 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:11:17,830 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-63352202:ctest-trans_right_vn-95517308', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-63352202:ctest-trans_right_vn-95517308?flat'}
2025-12-01 03:11:17,830 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-63352202:ctest-trans_right_vn-95517308 is found in opserver
2025-12-01 03:11:17,860 - DEBUG - Do not have enough data to verify VN in agent
2025-12-01 03:11:17,873 - DEBUG - VRF ids for VN ctest-trans_right_vn-95517308: {}
2025-12-01 03:11:19,194 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4827-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4827-1)
2025-12-01 03:11:20,638 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4827-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4827-2)
2025-12-01 03:11:20,639 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-46003612']
2025-12-01 03:11:20,958 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-46003612'] created succesfully
2025-12-01 03:11:21,358 - DEBUG - Image by name tiny_trans_fw not found
2025-12-01 03:11:21,358 - DEBUG - Installing image tiny_trans_fw
2025-12-01 03:11:21,358 - 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-12-01 03:11:21,358 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2025-12-01 03:11:21,358 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2025-12-01 03:11:21,380 - 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-12-01 03:11:21,427 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-12-01 03:11:21,428 - DEBUG - Unzip image
2025-12-01 03:11:21,428 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2025-12-01 03:11:21,450 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2025-12-01 03:11:21,450 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-46003612']
2025-12-01 03:11:21,638 - INFO - Service template: ['default-domain', 'ctest-service_template_1-46003612'] deleted successfully.
2025-12-01 03:11:21,638 - INFO - Skip interface_detach for VM ctest-right_vm-18728782 in state BUILD
2025-12-01 03:11:21,638 - INFO - Deleting VM ctest-right_vm-18728782
2025-12-01 03:11:21,638 - ERROR - VM ctest-right_vm-18728782 has failed to come up
2025-12-01 03:11:21,638 - ERROR - Nova failed to get host of the VM
2025-12-01 03:11:21,638 - ERROR - VM ctest-right_vm-18728782 has failed to come up
2025-12-01 03:11:21,639 - ERROR - Nova failed to get host of the VM
2025-12-01 03:11:21,736 - INFO - Skip interface_detach for VM ctest-left_vm-17897677 in state BUILD
2025-12-01 03:11:21,737 - INFO - Deleting VM ctest-left_vm-17897677
2025-12-01 03:11:21,737 - ERROR - VM ctest-left_vm-17897677 has failed to come up
2025-12-01 03:11:21,737 - ERROR - Nova failed to get host of the VM
2025-12-01 03:11:21,737 - ERROR - VM ctest-left_vm-17897677 has failed to come up
2025-12-01 03:11:21,737 - ERROR - Nova failed to get host of the VM
2025-12-01 03:11:21,825 - INFO - Deleting VN ctest-trans_right_vn-95517308
2025-12-01 03:11:21,969 - DEBUG - Response for deleting network ()
2025-12-01 03:11:21,969 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2c5e830d-fe16-4aec-8a0a-c9eb8dfba6a6
2025-12-01 03:11:21,975 - DEBUG - Response Code: 404
2025-12-01 03:11:21,975 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:21,980 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:22,002 - DEBUG - Requesting: http://10.0.0.27:8082/project/84a4a977-ea8d-4100-b2a5-c8f1be3e3f0a
2025-12-01 03:11:22,110 - INFO - Validated that VN ctest-trans_right_vn-95517308 is not found in API Server
2025-12-01 03:11:22,129 - DEBUG - VN ctest-trans_right_vn-95517308 is not present in Agent 10.0.0.22
2025-12-01 03:11:22,142 - DEBUG - VN ctest-trans_right_vn-95517308 is not present in Agent 10.0.0.241
2025-12-01 03:11:22,142 - INFO - Validated that VN ctest-trans_right_vn-95517308 is not in any agent
2025-12-01 03:11:22,208 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-95517308 info
2025-12-01 03:11:22,208 - INFO - Deleting VN ctest-trans_left_vn-58115498
2025-12-01 03:11:22,364 - DEBUG - Response for deleting network ()
2025-12-01 03:11:22,364 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4861af70-1c26-418b-ba3d-7ec33034ae7a
2025-12-01 03:11:22,374 - DEBUG - Response Code: 404
2025-12-01 03:11:22,374 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:22,380 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:22,416 - DEBUG - Requesting: http://10.0.0.27:8082/project/84a4a977-ea8d-4100-b2a5-c8f1be3e3f0a
2025-12-01 03:11:22,516 - INFO - Validated that VN ctest-trans_left_vn-58115498 is not found in API Server
2025-12-01 03:11:22,529 - DEBUG - VN ctest-trans_left_vn-58115498 is not present in Agent 10.0.0.22
2025-12-01 03:11:22,542 - DEBUG - VN ctest-trans_left_vn-58115498 is not present in Agent 10.0.0.241
2025-12-01 03:11:22,542 - INFO - Validated that VN ctest-trans_left_vn-58115498 is not in any agent
2025-12-01 03:11:22,601 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-58115498 info
2025-12-01 03:11:22,601 - INFO - Deleting VN ctest-right_vn-53089364
2025-12-01 03:11:22,673 - DEBUG - VN e3e08885-b0b8-41bc-8fc1-87046f57c714 still in use: Unable to complete operation on network e3e08885-b0b8-41bc-8fc1-87046f57c714. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-40e23130-5ffc-4a6b-b44b-d839a8c937cf']
2025-12-01 03:11:22,673 - WARNING - Deleting VN ctest-right_vn-53089364 failed..Will retry
2025-12-01 03:11:24,860 - DEBUG - Response for deleting network ()
2025-12-01 03:11:24,860 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7f6234f0-cb8b-4c40-a5f9-13f28ce20fd0
2025-12-01 03:11:24,866 - DEBUG - Response Code: 404
2025-12-01 03:11:24,866 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:24,884 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:24,899 - DEBUG - Requesting: http://10.0.0.27:8082/project/84a4a977-ea8d-4100-b2a5-c8f1be3e3f0a
2025-12-01 03:11:24,983 - INFO - Validated that VN ctest-right_vn-53089364 is not found in API Server
2025-12-01 03:11:24,995 - DEBUG - VN ctest-right_vn-53089364 is not present in Agent 10.0.0.22
2025-12-01 03:11:25,009 - DEBUG - VN ctest-right_vn-53089364 is not present in Agent 10.0.0.241
2025-12-01 03:11:25,009 - INFO - Validated that VN ctest-right_vn-53089364 is not in any agent
2025-12-01 03:11:25,042 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-53089364 info
2025-12-01 03:11:25,042 - INFO - Deleting VN ctest-left_vn-13510967
2025-12-01 03:11:25,189 - DEBUG - Response for deleting network ()
2025-12-01 03:11:25,189 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/d008e9be-1182-4b4f-bfab-2e82f6724f24
2025-12-01 03:11:25,199 - DEBUG - Response Code: 404
2025-12-01 03:11:25,199 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:25,206 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:25,227 - DEBUG - Requesting: http://10.0.0.27:8082/project/84a4a977-ea8d-4100-b2a5-c8f1be3e3f0a
2025-12-01 03:11:25,318 - INFO - Validated that VN ctest-left_vn-13510967 is not found in API Server
2025-12-01 03:11:25,329 - DEBUG - VN ctest-left_vn-13510967 is not present in Agent 10.0.0.22
2025-12-01 03:11:25,340 - DEBUG - VN ctest-left_vn-13510967 is not present in Agent 10.0.0.241
2025-12-01 03:11:25,340 - INFO - Validated that VN ctest-left_vn-13510967 is not in any agent
2025-12-01 03:11:25,375 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-13510967 info
2025-12-01 03:11:25,375 - INFO - Deleting VN ctest-mgmt_vn-07736646
2025-12-01 03:11:25,552 - DEBUG - Response for deleting network ()
2025-12-01 03:11:25,552 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/32600fe7-1cf0-48fc-93fb-a6218cb8e2d8
2025-12-01 03:11:25,578 - DEBUG - Response Code: 404
2025-12-01 03:11:25,578 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:25,585 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:25,597 - DEBUG - Requesting: http://10.0.0.27:8082/project/84a4a977-ea8d-4100-b2a5-c8f1be3e3f0a
2025-12-01 03:11:25,709 - INFO - Validated that VN ctest-mgmt_vn-07736646 is not found in API Server
2025-12-01 03:11:25,724 - DEBUG - VN ctest-mgmt_vn-07736646 is not present in Agent 10.0.0.22
2025-12-01 03:11:25,737 - DEBUG - VN ctest-mgmt_vn-07736646 is not present in Agent 10.0.0.241
2025-12-01 03:11:25,737 - INFO - Validated that VN ctest-mgmt_vn-07736646 is not in any agent
2025-12-01 03:11:25,769 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-07736646 info
2025-12-01 03:11:27,063 - DEBUG - No XMPP flaps were noticed during the test
2025-12-01 03:11:27,063 - INFO -
2025-12-01 03:11:27,063 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:17]
2025-12-01 03:11:27,063 - INFO - --------------------------------------------------------------------------------
2025-12-01 03:11:28,079 - INFO - Deleted project: ctest-TestSvcRegr-63352202, ID : 84a4a977-ea8d-4100-b2a5-c8f1be3e3f0a
2025-12-01 03:11:28,279 - INFO - Domain Default found not creating
2025-12-01 03:11:28,526 - INFO - Project ctest-TestSvcRegr-93862805 not found, creating it
2025-12-01 03:11:29,127 - INFO - Created Project:ctest-TestSvcRegr-93862805, ID : c7983beb-29c6-4a09-903a-3016d9969a4f
2025-12-01 03:11:30,831 - INFO - ================================================================================
2025-12-01 03:11:30,831 - INFO - STARTING TEST : test_svc_CEM_22032
2025-12-01 03:11:32,111 - DEBUG - Nothing to compare xmpp stats {'10.0.0.22': {'10.20.0.209': '0', '10.20.0.192': '0'}, '10.0.0.241': {'10.20.0.209': '0', '10.20.0.192': '0'}} with
2025-12-01 03:11:32,111 - INFO - Initial checks done. Running the testcase now
2025-12-01 03:11:32,111 - INFO -
2025-12-01 03:11:32,934 - DEBUG - Response for create_network : {'network': {'id': 'e65c25e2-fff4-4f8a-b4a8-8429432ea8ad', 'name': 'ctest-mgmt_vn-09016080', 'tenant_id': 'c7983beb29c64a09903a3016d9969a4f', 'project_id': 'c7983beb29c64a09903a3016d9969a4f', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-93862805', 'ctest-mgmt_vn-09016080'], 'port_security_enabled': True, 'description': ''}}
2025-12-01 03:11:33,293 - DEBUG - Response for create_subnet : {'subnet': {'id': '8ff9451d-e25b-40e0-9d1f-ff4abbad8586', 'name': '', 'tenant_id': 'c7983beb29c64a09903a3016d9969a4f', 'network_id': 'e65c25e2-fff4-4f8a-b4a8-8429432ea8ad', 'ip_version': 4, 'cidr': '9.211.188.128/26', 'allocation_pools': [{'start': '9.211.188.130', 'end': '9.211.188.190'}], 'gateway_ip': '9.211.188.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '9.211.188.130', 'tags': [], 'project_id': 'c7983beb29c64a09903a3016d9969a4f'}}
2025-12-01 03:11:33,316 - INFO - Created VN ctest-mgmt_vn-09016080
2025-12-01 03:11:33,332 - DEBUG - VN ctest-mgmt_vn-09016080 UUID is e65c25e2-fff4-4f8a-b4a8-8429432ea8ad
2025-12-01 03:11:33,423 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:33,798 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:33,832 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:33,856 - DEBUG - Requesting: http://10.0.0.27:8082/project/c7983beb-29c6-4a09-903a-3016d9969a4f
2025-12-01 03:11:33,963 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/e65c25e2-fff4-4f8a-b4a8-8429432ea8ad
2025-12-01 03:11:33,983 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/e65c25e2-fff4-4f8a-b4a8-8429432ea8ad
2025-12-01 03:11:33,997 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/9775c39e-0a30-41a6-b7b3-33fd953b4b08
2025-12-01 03:11:34,007 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/9775c39e-0a30-41a6-b7b3-33fd953b4b08
2025-12-01 03:11:34,018 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/9900429c-3c36-427c-a89d-db2f9c78369e
2025-12-01 03:11:34,029 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-01 03:11:34,029 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/e65c25e2-fff4-4f8a-b4a8-8429432ea8ad
2025-12-01 03:11:34,047 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/9775c39e-0a30-41a6-b7b3-33fd953b4b08
2025-12-01 03:11:34,072 - INFO - Verified VN network id 13 for VN e65c25e2-fff4-4f8a-b4a8-8429432ea8ad
2025-12-01 03:11:34,073 - INFO - Verifications in API Server for VN ctest-mgmt_vn-09016080 passed
2025-12-01 03:11:34,073 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/e65c25e2-fff4-4f8a-b4a8-8429432ea8ad
2025-12-01 03:11:34,085 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/9775c39e-0a30-41a6-b7b3-33fd953b4b08
2025-12-01 03:11:34,096 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/9775c39e-0a30-41a6-b7b3-33fd953b4b08
2025-12-01 03:11:34,106 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/9900429c-3c36-427c-a89d-db2f9c78369e
2025-12-01 03:11:34,122 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-09016080', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-93862805', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16599183983467843466', 'uuid-lslong': '13017800035670075565'}, 'enable': 'true', 'created': '2025-12-01T03:11:32', 'last-modified': '2025-12-01T03:11:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.897584'}
2025-12-01 03:11:34,130 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-01 03:11:34,138 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-09016080', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-93862805', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16599183983467843466', 'uuid-lslong': '13017800035670075565'}, 'enable': 'true', 'created': '2025-12-01T03:11:32', 'last-modified': '2025-12-01T03:11:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.921570'}
2025-12-01 03:11:34,148 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-01 03:11:34,156 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-09016080', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-93862805', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16599183983467843466', 'uuid-lslong': '13017800035670075565'}, 'enable': 'true', 'created': '2025-12-01T03:11:32', 'last-modified': '2025-12-01T03:11:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.937375'}
2025-12-01 03:11:34,166 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-01 03:11:34,166 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-09016080 passed
2025-12-01 03:11:34,166 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-09016080 in API_Server ======
2025-12-01 03:11:34,166 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:34,173 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:34,188 - DEBUG - Requesting: http://10.0.0.27:8082/project/c7983beb-29c6-4a09-903a-3016d9969a4f
2025-12-01 03:11:34,306 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/e65c25e2-fff4-4f8a-b4a8-8429432ea8ad
2025-12-01 03:11:34,321 - DEBUG - =>VN ctest-mgmt_vn-09016080 has no policy to be verified
2025-12-01 03:11:34,321 - DEBUG - Verifying the vn in opserver
2025-12-01 03:11:34,322 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-09016080 virtual network link through opserver 10.0.0.27
2025-12-01 03:11:34,322 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:11:34,674 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:11:34,759 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-09016080', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-09016080?flat'}
2025-12-01 03:11:34,759 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-09016080 virtual network link through opserver 10.0.0.33
2025-12-01 03:11:34,760 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:11:35,109 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:11:35,208 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-09016080', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-09016080?flat'}
2025-12-01 03:11:35,208 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-09016080 virtual network link through opserver 10.0.0.23
2025-12-01 03:11:35,209 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:11:35,574 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:11:35,653 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-09016080', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-09016080?flat'}
2025-12-01 03:11:35,653 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-09016080 is found in opserver
2025-12-01 03:11:35,674 - DEBUG - Do not have enough data to verify VN in agent
2025-12-01 03:11:35,684 - DEBUG - VRF ids for VN ctest-mgmt_vn-09016080: {}
2025-12-01 03:11:36,057 - DEBUG - Response for create_network : {'network': {'id': '0f19c142-738d-42ba-81a9-1254734d3f28', 'name': 'service-left-vn-09014760', 'tenant_id': 'c7983beb29c64a09903a3016d9969a4f', 'project_id': 'c7983beb29c64a09903a3016d9969a4f', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-93862805', 'service-left-vn-09014760'], 'port_security_enabled': True, 'description': ''}}
2025-12-01 03:11:36,255 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd36e84d9-30e0-4123-adbd-d2f5df44ad70', 'name': '', 'tenant_id': 'c7983beb29c64a09903a3016d9969a4f', 'network_id': '0f19c142-738d-42ba-81a9-1254734d3f28', 'ip_version': 4, 'cidr': '176.226.246.128/26', 'allocation_pools': [{'start': '176.226.246.130', 'end': '176.226.246.190'}], 'gateway_ip': '176.226.246.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '176.226.246.130', 'tags': [], 'project_id': 'c7983beb29c64a09903a3016d9969a4f'}}
2025-12-01 03:11:36,286 - INFO - Created VN service-left-vn-09014760
2025-12-01 03:11:36,300 - DEBUG - VN service-left-vn-09014760 UUID is 0f19c142-738d-42ba-81a9-1254734d3f28
2025-12-01 03:11:36,411 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:36,418 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:36,431 - DEBUG - Requesting: http://10.0.0.27:8082/project/c7983beb-29c6-4a09-903a-3016d9969a4f
2025-12-01 03:11:36,537 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/0f19c142-738d-42ba-81a9-1254734d3f28
2025-12-01 03:11:36,560 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/0f19c142-738d-42ba-81a9-1254734d3f28
2025-12-01 03:11:36,574 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7cd06519-5d69-48da-aab9-a35730dd6325
2025-12-01 03:11:36,584 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7cd06519-5d69-48da-aab9-a35730dd6325
2025-12-01 03:11:36,593 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/10fd63dc-4480-4dfa-9ab9-02ca167786c2
2025-12-01 03:11:36,602 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-01 03:11:36,602 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/0f19c142-738d-42ba-81a9-1254734d3f28
2025-12-01 03:11:36,612 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7cd06519-5d69-48da-aab9-a35730dd6325
2025-12-01 03:11:36,633 - INFO - Verified VN network id 14 for VN 0f19c142-738d-42ba-81a9-1254734d3f28
2025-12-01 03:11:36,633 - INFO - Verifications in API Server for VN service-left-vn-09014760 passed
2025-12-01 03:11:36,633 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/0f19c142-738d-42ba-81a9-1254734d3f28
2025-12-01 03:11:36,646 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7cd06519-5d69-48da-aab9-a35730dd6325
2025-12-01 03:11:36,655 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7cd06519-5d69-48da-aab9-a35730dd6325
2025-12-01 03:11:36,664 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/10fd63dc-4480-4dfa-9ab9-02ca167786c2
2025-12-01 03:11:36,681 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-93862805:service-left-vn-09014760', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-93862805', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1088113276137325242', 'uuid-lslong': '9343019055877799720'}, 'enable': 'true', 'created': '2025-12-01T03:11:35', 'last-modified': '2025-12-01T03:11:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.465150'}
2025-12-01 03:11:36,689 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-01 03:11:36,695 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-93862805:service-left-vn-09014760', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-93862805', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1088113276137325242', 'uuid-lslong': '9343019055877799720'}, 'enable': 'true', 'created': '2025-12-01T03:11:35', 'last-modified': '2025-12-01T03:11:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.488885'}
2025-12-01 03:11:36,702 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-01 03:11:36,708 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-93862805:service-left-vn-09014760', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-93862805', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1088113276137325242', 'uuid-lslong': '9343019055877799720'}, 'enable': 'true', 'created': '2025-12-01T03:11:35', 'last-modified': '2025-12-01T03:11:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.496892'}
2025-12-01 03:11:36,717 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-01 03:11:36,717 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-09014760 passed
2025-12-01 03:11:36,717 - DEBUG - ====Verifying policy data for service-left-vn-09014760 in API_Server ======
2025-12-01 03:11:36,717 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:36,725 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:36,738 - DEBUG - Requesting: http://10.0.0.27:8082/project/c7983beb-29c6-4a09-903a-3016d9969a4f
2025-12-01 03:11:36,837 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/0f19c142-738d-42ba-81a9-1254734d3f28
2025-12-01 03:11:36,852 - DEBUG - =>VN service-left-vn-09014760 has no policy to be verified
2025-12-01 03:11:36,852 - DEBUG - Verifying the vn in opserver
2025-12-01 03:11:36,852 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-93862805:service-left-vn-09014760 virtual network link through opserver 10.0.0.27
2025-12-01 03:11:36,853 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:11:36,927 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-93862805:service-left-vn-09014760', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-93862805:service-left-vn-09014760?flat'}
2025-12-01 03:11:36,927 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-93862805:service-left-vn-09014760 virtual network link through opserver 10.0.0.33
2025-12-01 03:11:36,927 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:11:37,000 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-93862805:service-left-vn-09014760', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-93862805:service-left-vn-09014760?flat'}
2025-12-01 03:11:37,000 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-93862805:service-left-vn-09014760 virtual network link through opserver 10.0.0.23
2025-12-01 03:11:37,000 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:11:37,069 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-93862805:service-left-vn-09014760', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-93862805:service-left-vn-09014760?flat'}
2025-12-01 03:11:37,069 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-93862805:service-left-vn-09014760 is found in opserver
2025-12-01 03:11:37,092 - DEBUG - Do not have enough data to verify VN in agent
2025-12-01 03:11:37,104 - DEBUG - VRF ids for VN service-left-vn-09014760: {}
2025-12-01 03:11:37,411 - DEBUG - Response for create_network : {'network': {'id': '0d7711ff-8ea9-46ec-909d-a0b0468619be', 'name': 'service-right-vn-56150900', 'tenant_id': 'c7983beb29c64a09903a3016d9969a4f', 'project_id': 'c7983beb29c64a09903a3016d9969a4f', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-93862805', 'service-right-vn-56150900'], 'port_security_enabled': True, 'description': ''}}
2025-12-01 03:11:37,699 - DEBUG - Response for create_subnet : {'subnet': {'id': '3f0c8cda-9d84-4f50-aa9d-e83298b81351', 'name': '', 'tenant_id': 'c7983beb29c64a09903a3016d9969a4f', 'network_id': '0d7711ff-8ea9-46ec-909d-a0b0468619be', 'ip_version': 4, 'cidr': '111.192.162.128/26', 'allocation_pools': [{'start': '111.192.162.130', 'end': '111.192.162.190'}], 'gateway_ip': '111.192.162.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '111.192.162.130', 'tags': [], 'project_id': 'c7983beb29c64a09903a3016d9969a4f'}}
2025-12-01 03:11:37,733 - INFO - Created VN service-right-vn-56150900
2025-12-01 03:11:37,747 - DEBUG - VN service-right-vn-56150900 UUID is 0d7711ff-8ea9-46ec-909d-a0b0468619be
2025-12-01 03:11:37,833 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:37,842 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:37,860 - DEBUG - Requesting: http://10.0.0.27:8082/project/c7983beb-29c6-4a09-903a-3016d9969a4f
2025-12-01 03:11:37,957 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/0d7711ff-8ea9-46ec-909d-a0b0468619be
2025-12-01 03:11:37,975 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/0d7711ff-8ea9-46ec-909d-a0b0468619be
2025-12-01 03:11:37,986 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/f9945e9d-04ff-47bb-ae7d-150a105a4db6
2025-12-01 03:11:37,996 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/f9945e9d-04ff-47bb-ae7d-150a105a4db6
2025-12-01 03:11:38,007 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/ae2f046b-2698-4a81-9fe2-a055ba3f64d9
2025-12-01 03:11:38,015 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-01 03:11:38,015 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/0d7711ff-8ea9-46ec-909d-a0b0468619be
2025-12-01 03:11:38,025 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/f9945e9d-04ff-47bb-ae7d-150a105a4db6
2025-12-01 03:11:38,042 - INFO - Verified VN network id 15 for VN 0d7711ff-8ea9-46ec-909d-a0b0468619be
2025-12-01 03:11:38,042 - INFO - Verifications in API Server for VN service-right-vn-56150900 passed
2025-12-01 03:11:38,043 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/0d7711ff-8ea9-46ec-909d-a0b0468619be
2025-12-01 03:11:38,053 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/f9945e9d-04ff-47bb-ae7d-150a105a4db6
2025-12-01 03:11:38,062 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/f9945e9d-04ff-47bb-ae7d-150a105a4db6
2025-12-01 03:11:38,073 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/ae2f046b-2698-4a81-9fe2-a055ba3f64d9
2025-12-01 03:11:38,090 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-93862805:service-right-vn-56150900', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-93862805', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '970264034029422316', 'uuid-lslong': '10420661791763077566'}, 'enable': 'true', 'created': '2025-12-01T03:11:37', 'last-modified': '2025-12-01T03:11:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.464456'}
2025-12-01 03:11:38,102 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-01 03:11:38,108 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-93862805:service-right-vn-56150900', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-93862805', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '970264034029422316', 'uuid-lslong': '10420661791763077566'}, 'enable': 'true', 'created': '2025-12-01T03:11:37', 'last-modified': '2025-12-01T03:11:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.488258'}
2025-12-01 03:11:38,114 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-01 03:11:38,121 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-93862805:service-right-vn-56150900', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-93862805', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '970264034029422316', 'uuid-lslong': '10420661791763077566'}, 'enable': 'true', 'created': '2025-12-01T03:11:37', 'last-modified': '2025-12-01T03:11:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.501589'}
2025-12-01 03:11:38,129 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-01 03:11:38,129 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-56150900 passed
2025-12-01 03:11:38,129 - DEBUG - ====Verifying policy data for service-right-vn-56150900 in API_Server ======
2025-12-01 03:11:38,129 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:38,137 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:38,156 - DEBUG - Requesting: http://10.0.0.27:8082/project/c7983beb-29c6-4a09-903a-3016d9969a4f
2025-12-01 03:11:38,258 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/0d7711ff-8ea9-46ec-909d-a0b0468619be
2025-12-01 03:11:38,279 - DEBUG - =>VN service-right-vn-56150900 has no policy to be verified
2025-12-01 03:11:38,279 - DEBUG - Verifying the vn in opserver
2025-12-01 03:11:38,279 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-93862805:service-right-vn-56150900 virtual network link through opserver 10.0.0.27
2025-12-01 03:11:38,279 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:11:38,350 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-93862805:service-right-vn-56150900', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-93862805:service-right-vn-56150900?flat'}
2025-12-01 03:11:38,350 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-93862805:service-right-vn-56150900 virtual network link through opserver 10.0.0.33
2025-12-01 03:11:38,350 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:11:38,426 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-93862805:service-right-vn-56150900', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-93862805:service-right-vn-56150900?flat'}
2025-12-01 03:11:38,426 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-93862805:service-right-vn-56150900 virtual network link through opserver 10.0.0.23
2025-12-01 03:11:38,426 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:11:38,499 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-93862805:service-right-vn-56150900', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-93862805:service-right-vn-56150900?flat'}
2025-12-01 03:11:38,499 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-93862805:service-right-vn-56150900 is found in opserver
2025-12-01 03:11:38,523 - DEBUG - Do not have enough data to verify VN in agent
2025-12-01 03:11:38,533 - DEBUG - VRF ids for VN service-right-vn-56150900: {}
2025-12-01 03:11:38,598 - DEBUG - Services list from nova: [, , , ]
2025-12-01 03:11:39,823 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4827-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4827-1)
2025-12-01 03:11:41,419 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4827-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4827-2)
2025-12-01 03:11:41,419 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-26780803']
2025-12-01 03:11:41,745 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-26780803'] created succesfully
2025-12-01 03:11:42,224 - DEBUG - Image by name tiny_nat_fw not found
2025-12-01 03:11:42,224 - DEBUG - Installing image tiny_nat_fw
2025-12-01 03:11:42,224 - 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-12-01 03:11:42,225 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-12-01 03:11:42,226 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-12-01 03:11:42,226 - DEBUG - Unzip image
2025-12-01 03:11:42,226 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-12-01 03:11:42,253 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2025-12-01 03:11:42,253 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-26780803']
2025-12-01 03:11:42,393 - INFO - Service template: ['default-domain', 'ctest-service_template_1-26780803'] deleted successfully.
2025-12-01 03:11:42,394 - INFO - Skip interface_detach for VM ctest-right_vm-10751766 in state BUILD
2025-12-01 03:11:42,394 - INFO - Deleting VM ctest-right_vm-10751766
2025-12-01 03:11:42,428 - ERROR - VM ctest-right_vm-10751766 has failed to come up
2025-12-01 03:11:42,428 - ERROR - Nova failed to get host of the VM
2025-12-01 03:11:42,429 - ERROR - VM ctest-right_vm-10751766 has failed to come up
2025-12-01 03:11:42,429 - ERROR - Nova failed to get host of the VM
2025-12-01 03:11:42,525 - INFO - Skip interface_detach for VM ctest-left_vm-85007851 in state BUILD
2025-12-01 03:11:42,525 - INFO - Deleting VM ctest-left_vm-85007851
2025-12-01 03:11:42,525 - ERROR - VM ctest-left_vm-85007851 has failed to come up
2025-12-01 03:11:42,525 - ERROR - Nova failed to get host of the VM
2025-12-01 03:11:42,525 - ERROR - VM ctest-left_vm-85007851 has failed to come up
2025-12-01 03:11:42,525 - ERROR - Nova failed to get host of the VM
2025-12-01 03:11:42,615 - INFO - Deleting VN service-right-vn-56150900
2025-12-01 03:11:42,671 - DEBUG - VN 0d7711ff-8ea9-46ec-909d-a0b0468619be still in use: Unable to complete operation on network 0d7711ff-8ea9-46ec-909d-a0b0468619be. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-4eddcaff-6345-404c-a37e-81b24fdb4c3e']
2025-12-01 03:11:42,671 - WARNING - Deleting VN service-right-vn-56150900 failed..Will retry
2025-12-01 03:11:44,869 - DEBUG - Response for deleting network ()
2025-12-01 03:11:44,869 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/f9945e9d-04ff-47bb-ae7d-150a105a4db6
2025-12-01 03:11:44,876 - DEBUG - Response Code: 404
2025-12-01 03:11:44,876 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:44,884 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:44,917 - DEBUG - Requesting: http://10.0.0.27:8082/project/c7983beb-29c6-4a09-903a-3016d9969a4f
2025-12-01 03:11:45,026 - INFO - Validated that VN service-right-vn-56150900 is not found in API Server
2025-12-01 03:11:45,040 - DEBUG - VN service-right-vn-56150900 is not present in Agent 10.0.0.22
2025-12-01 03:11:45,054 - DEBUG - VN service-right-vn-56150900 is not present in Agent 10.0.0.241
2025-12-01 03:11:45,054 - INFO - Validated that VN service-right-vn-56150900 is not in any agent
2025-12-01 03:11:45,087 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-56150900 info
2025-12-01 03:11:45,088 - INFO - Deleting VN service-left-vn-09014760
2025-12-01 03:11:45,283 - DEBUG - Response for deleting network ()
2025-12-01 03:11:45,283 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7cd06519-5d69-48da-aab9-a35730dd6325
2025-12-01 03:11:45,289 - DEBUG - Response Code: 404
2025-12-01 03:11:45,289 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:45,295 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:45,352 - DEBUG - Requesting: http://10.0.0.27:8082/project/c7983beb-29c6-4a09-903a-3016d9969a4f
2025-12-01 03:11:45,446 - INFO - Validated that VN service-left-vn-09014760 is not found in API Server
2025-12-01 03:11:45,457 - DEBUG - VN service-left-vn-09014760 is not present in Agent 10.0.0.22
2025-12-01 03:11:45,468 - DEBUG - VN service-left-vn-09014760 is not present in Agent 10.0.0.241
2025-12-01 03:11:45,468 - INFO - Validated that VN service-left-vn-09014760 is not in any agent
2025-12-01 03:11:45,500 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-09014760 info
2025-12-01 03:11:45,500 - INFO - Deleting VN ctest-mgmt_vn-09016080
2025-12-01 03:11:45,670 - DEBUG - Response for deleting network ()
2025-12-01 03:11:45,670 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/9775c39e-0a30-41a6-b7b3-33fd953b4b08
2025-12-01 03:11:45,676 - DEBUG - Response Code: 404
2025-12-01 03:11:45,676 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:45,681 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:45,699 - DEBUG - Requesting: http://10.0.0.27:8082/project/c7983beb-29c6-4a09-903a-3016d9969a4f
2025-12-01 03:11:45,796 - INFO - Validated that VN ctest-mgmt_vn-09016080 is not found in API Server
2025-12-01 03:11:45,808 - DEBUG - VN ctest-mgmt_vn-09016080 is not present in Agent 10.0.0.22
2025-12-01 03:11:45,818 - DEBUG - VN ctest-mgmt_vn-09016080 is not present in Agent 10.0.0.241
2025-12-01 03:11:45,818 - INFO - Validated that VN ctest-mgmt_vn-09016080 is not in any agent
2025-12-01 03:11:45,854 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-09016080 info
2025-12-01 03:11:47,144 - DEBUG - No XMPP flaps were noticed during the test
2025-12-01 03:11:47,144 - INFO -
2025-12-01 03:11:47,144 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:17]
2025-12-01 03:11:47,145 - INFO - --------------------------------------------------------------------------------
2025-12-01 03:11:47,150 - INFO - ================================================================================
2025-12-01 03:11:47,150 - INFO - STARTING TEST : test_svc_in_network_datapath
2025-12-01 03:11:48,448 - DEBUG - Nothing to compare xmpp stats {'10.0.0.22': {'10.20.0.209': '0', '10.20.0.192': '0'}, '10.0.0.241': {'10.20.0.209': '0', '10.20.0.192': '0'}} with
2025-12-01 03:11:48,448 - INFO - Initial checks done. Running the testcase now
2025-12-01 03:11:48,448 - INFO -
2025-12-01 03:11:48,747 - DEBUG - Response for create_network : {'network': {'id': '1751e8d7-223e-4018-934c-62769ba31a15', 'name': 'ctest-mgmt_vn-02820490', 'tenant_id': 'c7983beb29c64a09903a3016d9969a4f', 'project_id': 'c7983beb29c64a09903a3016d9969a4f', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-93862805', 'ctest-mgmt_vn-02820490'], 'port_security_enabled': True, 'description': ''}}
2025-12-01 03:11:49,040 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd16212d6-b4ad-4ba6-a1b4-64eb82b20943', 'name': '', 'tenant_id': 'c7983beb29c64a09903a3016d9969a4f', 'network_id': '1751e8d7-223e-4018-934c-62769ba31a15', 'ip_version': 4, 'cidr': '132.107.27.0/26', 'allocation_pools': [{'start': '132.107.27.2', 'end': '132.107.27.62'}], 'gateway_ip': '132.107.27.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '132.107.27.2', 'tags': [], 'project_id': 'c7983beb29c64a09903a3016d9969a4f'}}
2025-12-01 03:11:49,063 - INFO - Created VN ctest-mgmt_vn-02820490
2025-12-01 03:11:49,078 - DEBUG - VN ctest-mgmt_vn-02820490 UUID is 1751e8d7-223e-4018-934c-62769ba31a15
2025-12-01 03:11:49,161 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:49,167 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:49,179 - DEBUG - Requesting: http://10.0.0.27:8082/project/c7983beb-29c6-4a09-903a-3016d9969a4f
2025-12-01 03:11:49,273 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/1751e8d7-223e-4018-934c-62769ba31a15
2025-12-01 03:11:49,288 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/1751e8d7-223e-4018-934c-62769ba31a15
2025-12-01 03:11:49,298 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/cd22e461-ae42-4bd2-9dca-b668fad2eb99
2025-12-01 03:11:49,306 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/cd22e461-ae42-4bd2-9dca-b668fad2eb99
2025-12-01 03:11:49,314 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/0b5bc3e5-3442-4477-91e0-65543af58ff0
2025-12-01 03:11:49,322 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-01 03:11:49,322 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/1751e8d7-223e-4018-934c-62769ba31a15
2025-12-01 03:11:49,333 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/cd22e461-ae42-4bd2-9dca-b668fad2eb99
2025-12-01 03:11:49,352 - INFO - Verified VN network id 13 for VN 1751e8d7-223e-4018-934c-62769ba31a15
2025-12-01 03:11:49,352 - INFO - Verifications in API Server for VN ctest-mgmt_vn-02820490 passed
2025-12-01 03:11:49,352 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/1751e8d7-223e-4018-934c-62769ba31a15
2025-12-01 03:11:49,363 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/cd22e461-ae42-4bd2-9dca-b668fad2eb99
2025-12-01 03:11:49,373 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/cd22e461-ae42-4bd2-9dca-b668fad2eb99
2025-12-01 03:11:49,381 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/0b5bc3e5-3442-4477-91e0-65543af58ff0
2025-12-01 03:11:49,393 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-02820490', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-93862805', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1680380146676023320', 'uuid-lslong': '10613966683362236949'}, 'enable': 'true', 'created': '2025-12-01T03:11:48', 'last-modified': '2025-12-01T03:11:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.408653'}
2025-12-01 03:11:49,399 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-01 03:11:49,404 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-02820490', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-93862805', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1680380146676023320', 'uuid-lslong': '10613966683362236949'}, 'enable': 'true', 'created': '2025-12-01T03:11:48', 'last-modified': '2025-12-01T03:11:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.422121'}
2025-12-01 03:11:49,410 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-01 03:11:49,415 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-02820490', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-93862805', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1680380146676023320', 'uuid-lslong': '10613966683362236949'}, 'enable': 'true', 'created': '2025-12-01T03:11:48', 'last-modified': '2025-12-01T03:11:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.429238'}
2025-12-01 03:11:49,421 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-01 03:11:49,421 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-02820490 passed
2025-12-01 03:11:49,421 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-02820490 in API_Server ======
2025-12-01 03:11:49,421 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:49,428 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:49,442 - DEBUG - Requesting: http://10.0.0.27:8082/project/c7983beb-29c6-4a09-903a-3016d9969a4f
2025-12-01 03:11:49,533 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/1751e8d7-223e-4018-934c-62769ba31a15
2025-12-01 03:11:49,548 - DEBUG - =>VN ctest-mgmt_vn-02820490 has no policy to be verified
2025-12-01 03:11:49,548 - DEBUG - Verifying the vn in opserver
2025-12-01 03:11:49,548 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-02820490 virtual network link through opserver 10.0.0.27
2025-12-01 03:11:49,548 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:11:49,561 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-02820490', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-02820490?flat'}
2025-12-01 03:11:49,561 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-02820490 virtual network link through opserver 10.0.0.33
2025-12-01 03:11:49,561 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:11:49,574 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-02820490', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-02820490?flat'}
2025-12-01 03:11:49,574 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-02820490 virtual network link through opserver 10.0.0.23
2025-12-01 03:11:49,574 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:11:49,588 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-02820490', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-02820490?flat'}
2025-12-01 03:11:49,588 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-93862805:ctest-mgmt_vn-02820490 is found in opserver
2025-12-01 03:11:49,608 - DEBUG - Do not have enough data to verify VN in agent
2025-12-01 03:11:49,619 - DEBUG - VRF ids for VN ctest-mgmt_vn-02820490: {}
2025-12-01 03:11:49,916 - DEBUG - Response for create_network : {'network': {'id': '051b6d87-d91d-46e6-9695-695feb2de6cc', 'name': 'ctest-left_vn-82395461', 'tenant_id': 'c7983beb29c64a09903a3016d9969a4f', 'project_id': 'c7983beb29c64a09903a3016d9969a4f', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-93862805', 'ctest-left_vn-82395461'], 'port_security_enabled': True, 'description': ''}}
2025-12-01 03:11:50,153 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd37ac9bd-f566-4a30-9698-6c546184a8c1', 'name': '', 'tenant_id': 'c7983beb29c64a09903a3016d9969a4f', 'network_id': '051b6d87-d91d-46e6-9695-695feb2de6cc', 'ip_version': 4, 'cidr': '43.216.137.64/26', 'allocation_pools': [{'start': '43.216.137.66', 'end': '43.216.137.126'}], 'gateway_ip': '43.216.137.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '43.216.137.66', 'tags': [], 'project_id': 'c7983beb29c64a09903a3016d9969a4f'}}
2025-12-01 03:11:50,180 - INFO - Created VN ctest-left_vn-82395461
2025-12-01 03:11:50,197 - DEBUG - VN ctest-left_vn-82395461 UUID is 051b6d87-d91d-46e6-9695-695feb2de6cc
2025-12-01 03:11:50,287 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:50,296 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:50,310 - DEBUG - Requesting: http://10.0.0.27:8082/project/c7983beb-29c6-4a09-903a-3016d9969a4f
2025-12-01 03:11:50,405 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/051b6d87-d91d-46e6-9695-695feb2de6cc
2025-12-01 03:11:50,420 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/051b6d87-d91d-46e6-9695-695feb2de6cc
2025-12-01 03:11:50,431 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/aa0172ae-3991-4864-b219-f36cb5d5fc3b
2025-12-01 03:11:50,445 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/aa0172ae-3991-4864-b219-f36cb5d5fc3b
2025-12-01 03:11:50,454 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/92d314e4-c559-46ce-a466-d2f4539d92aa
2025-12-01 03:11:50,462 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-01 03:11:50,462 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/051b6d87-d91d-46e6-9695-695feb2de6cc
2025-12-01 03:11:50,472 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/aa0172ae-3991-4864-b219-f36cb5d5fc3b
2025-12-01 03:11:50,490 - INFO - Verified VN network id 14 for VN 051b6d87-d91d-46e6-9695-695feb2de6cc
2025-12-01 03:11:50,491 - INFO - Verifications in API Server for VN ctest-left_vn-82395461 passed
2025-12-01 03:11:50,491 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/051b6d87-d91d-46e6-9695-695feb2de6cc
2025-12-01 03:11:50,502 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/aa0172ae-3991-4864-b219-f36cb5d5fc3b
2025-12-01 03:11:50,511 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/aa0172ae-3991-4864-b219-f36cb5d5fc3b
2025-12-01 03:11:50,520 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/92d314e4-c559-46ce-a466-d2f4539d92aa
2025-12-01 03:11:50,535 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-93862805:ctest-left_vn-82395461', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-93862805', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '368008224791414502', 'uuid-lslong': '10850694737907541708'}, 'enable': 'true', 'created': '2025-12-01T03:11:49', 'last-modified': '2025-12-01T03:11:50', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.466309'}
2025-12-01 03:11:50,542 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-01 03:11:50,548 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-93862805:ctest-left_vn-82395461', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-93862805', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '368008224791414502', 'uuid-lslong': '10850694737907541708'}, 'enable': 'true', 'created': '2025-12-01T03:11:49', 'last-modified': '2025-12-01T03:11:50', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.472662'}
2025-12-01 03:11:50,554 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-01 03:11:50,560 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-93862805:ctest-left_vn-82395461', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-93862805', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '368008224791414502', 'uuid-lslong': '10850694737907541708'}, 'enable': 'true', 'created': '2025-12-01T03:11:49', 'last-modified': '2025-12-01T03:11:50', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.485761'}
2025-12-01 03:11:50,568 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-01 03:11:50,568 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-82395461 passed
2025-12-01 03:11:50,568 - DEBUG - ====Verifying policy data for ctest-left_vn-82395461 in API_Server ======
2025-12-01 03:11:50,569 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:50,576 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:50,588 - DEBUG - Requesting: http://10.0.0.27:8082/project/c7983beb-29c6-4a09-903a-3016d9969a4f
2025-12-01 03:11:50,693 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/051b6d87-d91d-46e6-9695-695feb2de6cc
2025-12-01 03:11:50,708 - DEBUG - =>VN ctest-left_vn-82395461 has no policy to be verified
2025-12-01 03:11:50,708 - DEBUG - Verifying the vn in opserver
2025-12-01 03:11:50,708 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-93862805:ctest-left_vn-82395461 virtual network link through opserver 10.0.0.27
2025-12-01 03:11:50,708 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:11:50,721 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-93862805:ctest-left_vn-82395461', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-93862805:ctest-left_vn-82395461?flat'}
2025-12-01 03:11:50,721 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-93862805:ctest-left_vn-82395461 virtual network link through opserver 10.0.0.33
2025-12-01 03:11:50,722 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:11:50,735 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-93862805:ctest-left_vn-82395461', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-93862805:ctest-left_vn-82395461?flat'}
2025-12-01 03:11:50,735 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-93862805:ctest-left_vn-82395461 virtual network link through opserver 10.0.0.23
2025-12-01 03:11:50,735 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:11:50,755 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-93862805:ctest-left_vn-82395461', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-93862805:ctest-left_vn-82395461?flat'}
2025-12-01 03:11:50,755 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-93862805:ctest-left_vn-82395461 is found in opserver
2025-12-01 03:11:50,780 - DEBUG - Do not have enough data to verify VN in agent
2025-12-01 03:11:50,791 - DEBUG - VRF ids for VN ctest-left_vn-82395461: {}
2025-12-01 03:11:51,095 - DEBUG - Response for create_network : {'network': {'id': 'e0370f86-7039-408c-a77c-1f0362eee2f6', 'name': 'ctest-right_vn-10314607', 'tenant_id': 'c7983beb29c64a09903a3016d9969a4f', 'project_id': 'c7983beb29c64a09903a3016d9969a4f', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-93862805', 'ctest-right_vn-10314607'], 'port_security_enabled': True, 'description': ''}}
2025-12-01 03:11:51,298 - DEBUG - Response for create_subnet : {'subnet': {'id': '0c5afff0-d59f-491c-859f-eca739cf83bd', 'name': '', 'tenant_id': 'c7983beb29c64a09903a3016d9969a4f', 'network_id': 'e0370f86-7039-408c-a77c-1f0362eee2f6', 'ip_version': 4, 'cidr': '11.231.99.128/26', 'allocation_pools': [{'start': '11.231.99.130', 'end': '11.231.99.190'}], 'gateway_ip': '11.231.99.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '11.231.99.130', 'tags': [], 'project_id': 'c7983beb29c64a09903a3016d9969a4f'}}
2025-12-01 03:11:51,321 - INFO - Created VN ctest-right_vn-10314607
2025-12-01 03:11:51,333 - DEBUG - VN ctest-right_vn-10314607 UUID is e0370f86-7039-408c-a77c-1f0362eee2f6
2025-12-01 03:11:51,409 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:51,416 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:51,430 - DEBUG - Requesting: http://10.0.0.27:8082/project/c7983beb-29c6-4a09-903a-3016d9969a4f
2025-12-01 03:11:51,535 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/e0370f86-7039-408c-a77c-1f0362eee2f6
2025-12-01 03:11:51,553 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/e0370f86-7039-408c-a77c-1f0362eee2f6
2025-12-01 03:11:51,565 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/a48698e1-b47e-4359-9ea5-39dd69397a7d
2025-12-01 03:11:51,575 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/a48698e1-b47e-4359-9ea5-39dd69397a7d
2025-12-01 03:11:51,583 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/ab699a42-c9e8-49a3-a908-0c9818208832
2025-12-01 03:11:51,590 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-01 03:11:51,590 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/e0370f86-7039-408c-a77c-1f0362eee2f6
2025-12-01 03:11:51,601 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/a48698e1-b47e-4359-9ea5-39dd69397a7d
2025-12-01 03:11:51,619 - INFO - Verified VN network id 15 for VN e0370f86-7039-408c-a77c-1f0362eee2f6
2025-12-01 03:11:51,619 - INFO - Verifications in API Server for VN ctest-right_vn-10314607 passed
2025-12-01 03:11:51,619 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/e0370f86-7039-408c-a77c-1f0362eee2f6
2025-12-01 03:11:51,631 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/a48698e1-b47e-4359-9ea5-39dd69397a7d
2025-12-01 03:11:51,640 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/a48698e1-b47e-4359-9ea5-39dd69397a7d
2025-12-01 03:11:51,648 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/ab699a42-c9e8-49a3-a908-0c9818208832
2025-12-01 03:11:51,661 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-93862805:ctest-right_vn-10314607', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-93862805', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16156399258297778316', 'uuid-lslong': '12068555200851272438'}, 'enable': 'true', 'created': '2025-12-01T03:11:51', 'last-modified': '2025-12-01T03:11:51', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.421720'}
2025-12-01 03:11:51,667 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-01 03:11:51,673 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-93862805:ctest-right_vn-10314607', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-93862805', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16156399258297778316', 'uuid-lslong': '12068555200851272438'}, 'enable': 'true', 'created': '2025-12-01T03:11:51', 'last-modified': '2025-12-01T03:11:51', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.436453'}
2025-12-01 03:11:51,678 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-01 03:11:51,684 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-93862805:ctest-right_vn-10314607', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-93862805', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16156399258297778316', 'uuid-lslong': '12068555200851272438'}, 'enable': 'true', 'created': '2025-12-01T03:11:51', 'last-modified': '2025-12-01T03:11:51', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.439866'}
2025-12-01 03:11:51,690 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-01 03:11:51,691 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-10314607 passed
2025-12-01 03:11:51,691 - DEBUG - ====Verifying policy data for ctest-right_vn-10314607 in API_Server ======
2025-12-01 03:11:51,691 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:51,697 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:51,709 - DEBUG - Requesting: http://10.0.0.27:8082/project/c7983beb-29c6-4a09-903a-3016d9969a4f
2025-12-01 03:11:51,818 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/e0370f86-7039-408c-a77c-1f0362eee2f6
2025-12-01 03:11:51,830 - DEBUG - =>VN ctest-right_vn-10314607 has no policy to be verified
2025-12-01 03:11:51,830 - DEBUG - Verifying the vn in opserver
2025-12-01 03:11:51,830 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-93862805:ctest-right_vn-10314607 virtual network link through opserver 10.0.0.27
2025-12-01 03:11:51,830 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-01 03:11:51,845 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-93862805:ctest-right_vn-10314607', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-93862805:ctest-right_vn-10314607?flat'}
2025-12-01 03:11:51,845 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-93862805:ctest-right_vn-10314607 virtual network link through opserver 10.0.0.33
2025-12-01 03:11:51,845 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-01 03:11:51,859 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-93862805:ctest-right_vn-10314607', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-93862805:ctest-right_vn-10314607?flat'}
2025-12-01 03:11:51,859 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-93862805:ctest-right_vn-10314607 virtual network link through opserver 10.0.0.23
2025-12-01 03:11:51,859 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-01 03:11:51,875 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-93862805:ctest-right_vn-10314607', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-93862805:ctest-right_vn-10314607?flat'}
2025-12-01 03:11:51,875 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-93862805:ctest-right_vn-10314607 is found in opserver
2025-12-01 03:11:51,904 - DEBUG - Do not have enough data to verify VN in agent
2025-12-01 03:11:51,918 - DEBUG - VRF ids for VN ctest-right_vn-10314607: {}
2025-12-01 03:11:53,122 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4827-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4827-2)
2025-12-01 03:11:54,600 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4827-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4827-1)
2025-12-01 03:11:54,601 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-28050159']
2025-12-01 03:11:54,915 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-28050159'] created succesfully
2025-12-01 03:11:55,367 - DEBUG - Image by name tiny_nat_fw not found
2025-12-01 03:11:55,367 - DEBUG - Installing image tiny_nat_fw
2025-12-01 03:11:55,367 - 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-12-01 03:11:55,368 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-12-01 03:11:55,368 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-12-01 03:11:55,368 - DEBUG - Unzip image
2025-12-01 03:11:55,368 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2025-12-01 03:11:55,391 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2025-12-01 03:11:55,391 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-28050159']
2025-12-01 03:11:55,497 - INFO - Service template: ['default-domain', 'ctest-service_template_1-28050159'] deleted successfully.
2025-12-01 03:11:55,498 - INFO - Skip interface_detach for VM ctest-right_vm-65495410 in state BUILD
2025-12-01 03:11:55,498 - INFO - Deleting VM ctest-right_vm-65495410
2025-12-01 03:11:55,498 - ERROR - VM ctest-right_vm-65495410 has failed to come up
2025-12-01 03:11:55,498 - ERROR - Nova failed to get host of the VM
2025-12-01 03:11:55,498 - ERROR - VM ctest-right_vm-65495410 has failed to come up
2025-12-01 03:11:55,498 - ERROR - Nova failed to get host of the VM
2025-12-01 03:11:55,615 - INFO - Skip interface_detach for VM ctest-left_vm-94767306 in state BUILD
2025-12-01 03:11:55,615 - INFO - Deleting VM ctest-left_vm-94767306
2025-12-01 03:11:55,615 - ERROR - VM ctest-left_vm-94767306 has failed to come up
2025-12-01 03:11:55,615 - ERROR - Nova failed to get host of the VM
2025-12-01 03:11:55,615 - ERROR - VM ctest-left_vm-94767306 has failed to come up
2025-12-01 03:11:55,615 - ERROR - Nova failed to get host of the VM
2025-12-01 03:11:55,731 - INFO - Deleting VN ctest-right_vn-10314607
2025-12-01 03:11:55,790 - DEBUG - VN e0370f86-7039-408c-a77c-1f0362eee2f6 still in use: Unable to complete operation on network e0370f86-7039-408c-a77c-1f0362eee2f6. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-a5a79c56-4721-47a0-b264-177435a028a9']
2025-12-01 03:11:55,791 - WARNING - Deleting VN ctest-right_vn-10314607 failed..Will retry
2025-12-01 03:11:58,013 - DEBUG - Response for deleting network ()
2025-12-01 03:11:58,013 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/a48698e1-b47e-4359-9ea5-39dd69397a7d
2025-12-01 03:11:58,021 - DEBUG - Response Code: 404
2025-12-01 03:11:58,021 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:58,031 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:58,081 - DEBUG - Requesting: http://10.0.0.27:8082/project/c7983beb-29c6-4a09-903a-3016d9969a4f
2025-12-01 03:11:58,187 - INFO - Validated that VN ctest-right_vn-10314607 is not found in API Server
2025-12-01 03:11:58,199 - DEBUG - VN ctest-right_vn-10314607 is not present in Agent 10.0.0.22
2025-12-01 03:11:58,211 - DEBUG - VN ctest-right_vn-10314607 is not present in Agent 10.0.0.241
2025-12-01 03:11:58,211 - INFO - Validated that VN ctest-right_vn-10314607 is not in any agent
2025-12-01 03:11:58,241 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-10314607 info
2025-12-01 03:11:58,241 - INFO - Deleting VN ctest-left_vn-82395461
2025-12-01 03:11:58,437 - DEBUG - Response for deleting network ()
2025-12-01 03:11:58,437 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/aa0172ae-3991-4864-b219-f36cb5d5fc3b
2025-12-01 03:11:58,449 - DEBUG - Response Code: 404
2025-12-01 03:11:58,449 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:58,459 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:58,497 - DEBUG - Requesting: http://10.0.0.27:8082/project/c7983beb-29c6-4a09-903a-3016d9969a4f
2025-12-01 03:11:58,643 - INFO - Validated that VN ctest-left_vn-82395461 is not found in API Server
2025-12-01 03:11:58,655 - DEBUG - VN ctest-left_vn-82395461 is not present in Agent 10.0.0.22
2025-12-01 03:11:58,669 - DEBUG - VN ctest-left_vn-82395461 is not present in Agent 10.0.0.241
2025-12-01 03:11:58,669 - INFO - Validated that VN ctest-left_vn-82395461 is not in any agent
2025-12-01 03:11:58,709 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-82395461 info
2025-12-01 03:11:58,709 - INFO - Deleting VN ctest-mgmt_vn-02820490
2025-12-01 03:11:58,866 - DEBUG - Response for deleting network ()
2025-12-01 03:11:58,866 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/cd22e461-ae42-4bd2-9dca-b668fad2eb99
2025-12-01 03:11:58,873 - DEBUG - Response Code: 404
2025-12-01 03:11:58,873 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-01 03:11:58,879 - DEBUG - Requesting: http://10.0.0.27:8082/domain/a276f104-9d2c-4383-87cf-b8e3164113c5
2025-12-01 03:11:58,904 - DEBUG - Requesting: http://10.0.0.27:8082/project/c7983beb-29c6-4a09-903a-3016d9969a4f
2025-12-01 03:11:58,999 - INFO - Validated that VN ctest-mgmt_vn-02820490 is not found in API Server
2025-12-01 03:11:59,012 - DEBUG - VN ctest-mgmt_vn-02820490 is not present in Agent 10.0.0.22
2025-12-01 03:11:59,023 - DEBUG - VN ctest-mgmt_vn-02820490 is not present in Agent 10.0.0.241
2025-12-01 03:11:59,023 - INFO - Validated that VN ctest-mgmt_vn-02820490 is not in any agent
2025-12-01 03:11:59,063 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-02820490 info
2025-12-01 03:12:00,367 - DEBUG - No XMPP flaps were noticed during the test
2025-12-01 03:12:00,367 - INFO -
2025-12-01 03:12:00,367 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:13]
2025-12-01 03:12:00,367 - INFO - --------------------------------------------------------------------------------
2025-12-01 03:12:01,267 - INFO - Deleted project: ctest-TestSvcRegr-93862805, ID : c7983beb-29c6-4a09-903a-3016d9969a4f