]) created on node: (an-jenkins-deploy-platform-ansible-os-4945-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4945-1)
2026-01-01 02:59:15,187 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-55266450']
2026-01-01 02:59:15,497 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-55266450'] created succesfully
2026-01-01 02:59:15,960 - DEBUG - Image by name tiny_nat_fw not found
2026-01-01 02:59:15,960 - DEBUG - Installing image tiny_nat_fw
2026-01-01 02:59:15,960 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-01-01 02:59:15,961 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-01-01 02:59:15,961 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-01-01 02:59:15,977 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz -O /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-01-01 02:59:16,235 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-01-01 02:59:16,235 - DEBUG - Unzip image
2026-01-01 02:59:16,235 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-01-01 02:59:16,261 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-01-01 02:59:16,261 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-55266450']
2026-01-01 02:59:16,358 - INFO - Service template: ['default-domain', 'ctest-service_template_1-55266450'] deleted successfully.
2026-01-01 02:59:16,359 - INFO - Skip interface_detach for VM ctest-right_vm-89985497 in state BUILD
2026-01-01 02:59:16,359 - INFO - Deleting VM ctest-right_vm-89985497
2026-01-01 02:59:16,391 - ERROR - VM ctest-right_vm-89985497 has failed to come up
2026-01-01 02:59:16,391 - ERROR - Nova failed to get host of the VM
2026-01-01 02:59:16,391 - ERROR - VM ctest-right_vm-89985497 has failed to come up
2026-01-01 02:59:16,391 - ERROR - Nova failed to get host of the VM
2026-01-01 02:59:16,470 - INFO - Skip interface_detach for VM ctest-left_vm-61799995 in state BUILD
2026-01-01 02:59:16,470 - INFO - Deleting VM ctest-left_vm-61799995
2026-01-01 02:59:16,470 - ERROR - VM ctest-left_vm-61799995 has failed to come up
2026-01-01 02:59:16,470 - ERROR - Nova failed to get host of the VM
2026-01-01 02:59:16,470 - ERROR - VM ctest-left_vm-61799995 has failed to come up
2026-01-01 02:59:16,470 - ERROR - Nova failed to get host of the VM
2026-01-01 02:59:16,553 - INFO - Deleting VN ctest-right_vn-94262154
2026-01-01 02:59:16,594 - DEBUG - VN e236d61e-fa13-4001-b206-f6f149ed935d still in use: Unable to complete operation on network e236d61e-fa13-4001-b206-f6f149ed935d. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-ed292ff6-372c-4dc0-8520-1aa4e45ea741']
2026-01-01 02:59:16,594 - WARNING - Deleting VN ctest-right_vn-94262154 failed..Will retry
2026-01-01 02:59:18,751 - DEBUG - Response for deleting network ()
2026-01-01 02:59:18,751 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/20844bad-0213-4030-9333-faa67ce96b84
2026-01-01 02:59:18,758 - DEBUG - Response Code: 404
2026-01-01 02:59:18,758 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:18,772 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:18,830 - DEBUG - Requesting: http://10.0.0.38:8082/project/775c6c81-e5ad-4321-a830-c63bee406068
2026-01-01 02:59:18,929 - INFO - Validated that VN ctest-right_vn-94262154 is not found in API Server
2026-01-01 02:59:18,944 - DEBUG - VN ctest-right_vn-94262154 is not present in Agent 10.0.0.242
2026-01-01 02:59:18,956 - DEBUG - VN ctest-right_vn-94262154 is not present in Agent 10.0.0.23
2026-01-01 02:59:18,956 - INFO - Validated that VN ctest-right_vn-94262154 is not in any agent
2026-01-01 02:59:18,993 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-94262154 info
2026-01-01 02:59:18,993 - INFO - Deleting VN ctest-left_vn-77423549
2026-01-01 02:59:19,186 - DEBUG - Response for deleting network ()
2026-01-01 02:59:19,186 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/3e4331a9-589d-4095-9615-b07aee0c434b
2026-01-01 02:59:19,193 - DEBUG - Response Code: 404
2026-01-01 02:59:19,193 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:19,200 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:19,253 - DEBUG - Requesting: http://10.0.0.38:8082/project/775c6c81-e5ad-4321-a830-c63bee406068
2026-01-01 02:59:19,355 - INFO - Validated that VN ctest-left_vn-77423549 is not found in API Server
2026-01-01 02:59:19,366 - DEBUG - VN ctest-left_vn-77423549 is not present in Agent 10.0.0.242
2026-01-01 02:59:19,377 - DEBUG - VN ctest-left_vn-77423549 is not present in Agent 10.0.0.23
2026-01-01 02:59:19,377 - INFO - Validated that VN ctest-left_vn-77423549 is not in any agent
2026-01-01 02:59:19,412 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-77423549 info
2026-01-01 02:59:19,412 - INFO - Deleting VN ctest-mgmt_vn-50723943
2026-01-01 02:59:19,594 - DEBUG - Response for deleting network ()
2026-01-01 02:59:19,595 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/a246254f-0952-4539-9be6-0602da89c87d
2026-01-01 02:59:19,602 - DEBUG - Response Code: 404
2026-01-01 02:59:19,602 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:19,608 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:19,632 - DEBUG - Requesting: http://10.0.0.38:8082/project/775c6c81-e5ad-4321-a830-c63bee406068
2026-01-01 02:59:19,748 - INFO - Validated that VN ctest-mgmt_vn-50723943 is not found in API Server
2026-01-01 02:59:19,761 - DEBUG - VN ctest-mgmt_vn-50723943 is not present in Agent 10.0.0.242
2026-01-01 02:59:19,773 - DEBUG - VN ctest-mgmt_vn-50723943 is not present in Agent 10.0.0.23
2026-01-01 02:59:19,773 - INFO - Validated that VN ctest-mgmt_vn-50723943 is not in any agent
2026-01-01 02:59:19,810 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-50723943 info
2026-01-01 02:59:19,810 - INFO - Deleting VM ctest-vm-in-third-vn-53586770
2026-01-01 02:59:19,884 - INFO - Deleting VN ctest-third-vn-13097762
2026-01-01 02:59:19,935 - DEBUG - VN 3c20234d-faa5-4051-aaa7-3380f08ac6bc still in use: Unable to complete operation on network 3c20234d-faa5-4051-aaa7-3380f08ac6bc. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-f6ae5103-99e1-42f2-ace6-4dd3ce2b716c']
2026-01-01 02:59:19,935 - WARNING - Deleting VN ctest-third-vn-13097762 failed..Will retry
2026-01-01 02:59:22,164 - DEBUG - Response for deleting network ()
2026-01-01 02:59:23,443 - DEBUG - No XMPP flaps were noticed during the test
2026-01-01 02:59:23,444 - INFO -
2026-01-01 02:59:23,444 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:26]
2026-01-01 02:59:23,444 - INFO - --------------------------------------------------------------------------------
2026-01-01 02:59:23,447 - INFO - ================================================================================
2026-01-01 02:59:23,447 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2026-01-01 02:59:24,733 - DEBUG - Nothing to compare xmpp stats {'10.0.0.242': {'10.20.0.14': '0', '10.20.0.18': '0'}, '10.0.0.23': {'10.20.0.14': '0', '10.20.0.18': '0'}} with
2026-01-01 02:59:24,733 - INFO - Initial checks done. Running the testcase now
2026-01-01 02:59:24,733 - INFO -
2026-01-01 02:59:25,014 - DEBUG - Response for create_network : {'network': {'id': 'd8153e1f-9abe-4633-a6bd-882f4d9de5f2', 'name': 'ctest-mgmt_vn-75823920', 'tenant_id': '775c6c81e5ad4321a830c63bee406068', 'project_id': '775c6c81e5ad4321a830c63bee406068', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-95509401', 'ctest-mgmt_vn-75823920'], 'port_security_enabled': True, 'description': ''}}
2026-01-01 02:59:25,331 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd5b4985e-94e4-4fc4-bc6e-036730923487', 'name': '', 'tenant_id': '775c6c81e5ad4321a830c63bee406068', 'network_id': 'd8153e1f-9abe-4633-a6bd-882f4d9de5f2', 'ip_version': 4, 'cidr': '180.39.145.64/26', 'allocation_pools': [{'start': '180.39.145.66', 'end': '180.39.145.126'}], 'gateway_ip': '180.39.145.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '180.39.145.66', 'tags': [], 'project_id': '775c6c81e5ad4321a830c63bee406068'}}
2026-01-01 02:59:25,359 - INFO - Created VN ctest-mgmt_vn-75823920
2026-01-01 02:59:25,376 - DEBUG - VN ctest-mgmt_vn-75823920 UUID is d8153e1f-9abe-4633-a6bd-882f4d9de5f2
2026-01-01 02:59:25,467 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:25,477 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:25,490 - DEBUG - Requesting: http://10.0.0.38:8082/project/775c6c81-e5ad-4321-a830-c63bee406068
2026-01-01 02:59:25,610 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/d8153e1f-9abe-4633-a6bd-882f4d9de5f2
2026-01-01 02:59:25,623 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/d8153e1f-9abe-4633-a6bd-882f4d9de5f2
2026-01-01 02:59:25,633 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/6109dfa5-6dd9-4d12-9334-330475101726
2026-01-01 02:59:25,649 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/6109dfa5-6dd9-4d12-9334-330475101726
2026-01-01 02:59:25,658 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/f54d84d9-d639-4e70-a49f-77d32cd49bfe
2026-01-01 02:59:25,666 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-01 02:59:25,667 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/d8153e1f-9abe-4633-a6bd-882f4d9de5f2
2026-01-01 02:59:25,677 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/6109dfa5-6dd9-4d12-9334-330475101726
2026-01-01 02:59:25,694 - INFO - Verified VN network id 14 for VN d8153e1f-9abe-4633-a6bd-882f4d9de5f2
2026-01-01 02:59:25,694 - INFO - Verifications in API Server for VN ctest-mgmt_vn-75823920 passed
2026-01-01 02:59:25,694 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/d8153e1f-9abe-4633-a6bd-882f4d9de5f2
2026-01-01 02:59:25,706 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/6109dfa5-6dd9-4d12-9334-330475101726
2026-01-01 02:59:25,721 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/6109dfa5-6dd9-4d12-9334-330475101726
2026-01-01 02:59:25,730 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/f54d84d9-d639-4e70-a49f-77d32cd49bfe
2026-01-01 02:59:25,743 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95509401:ctest-mgmt_vn-75823920', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95509401', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15570419592164427315', 'uuid-lslong': '12014909117641385458'}, 'enable': 'true', 'created': '2026-01-01T02:59:24', 'last-modified': '2026-01-01T02:59:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.500678'}
2026-01-01 02:59:25,749 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-01 02:59:25,758 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95509401:ctest-mgmt_vn-75823920', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95509401', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15570419592164427315', 'uuid-lslong': '12014909117641385458'}, 'enable': 'true', 'created': '2026-01-01T02:59:24', 'last-modified': '2026-01-01T02:59:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.516339'}
2026-01-01 02:59:25,766 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-01 02:59:25,772 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95509401:ctest-mgmt_vn-75823920', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95509401', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15570419592164427315', 'uuid-lslong': '12014909117641385458'}, 'enable': 'true', 'created': '2026-01-01T02:59:24', 'last-modified': '2026-01-01T02:59:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.535996'}
2026-01-01 02:59:25,780 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-01 02:59:25,780 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-75823920 passed
2026-01-01 02:59:25,780 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-75823920 in API_Server ======
2026-01-01 02:59:25,780 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:25,787 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:25,800 - DEBUG - Requesting: http://10.0.0.38:8082/project/775c6c81-e5ad-4321-a830-c63bee406068
2026-01-01 02:59:25,902 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/d8153e1f-9abe-4633-a6bd-882f4d9de5f2
2026-01-01 02:59:25,911 - DEBUG - =>VN ctest-mgmt_vn-75823920 has no policy to be verified
2026-01-01 02:59:25,911 - DEBUG - Verifying the vn in opserver
2026-01-01 02:59:25,911 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95509401:ctest-mgmt_vn-75823920 virtual network link through opserver 10.0.0.38
2026-01-01 02:59:25,912 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-01-01 02:59:25,924 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95509401:ctest-mgmt_vn-75823920', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95509401:ctest-mgmt_vn-75823920?flat'}
2026-01-01 02:59:25,924 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95509401:ctest-mgmt_vn-75823920 virtual network link through opserver 10.0.0.249
2026-01-01 02:59:25,925 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-01-01 02:59:25,938 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95509401:ctest-mgmt_vn-75823920', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95509401:ctest-mgmt_vn-75823920?flat'}
2026-01-01 02:59:25,938 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95509401:ctest-mgmt_vn-75823920 virtual network link through opserver 10.0.0.27
2026-01-01 02:59:25,938 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-01-01 02:59:25,950 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95509401:ctest-mgmt_vn-75823920', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95509401:ctest-mgmt_vn-75823920?flat'}
2026-01-01 02:59:25,951 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-95509401:ctest-mgmt_vn-75823920 is found in opserver
2026-01-01 02:59:25,972 - DEBUG - Do not have enough data to verify VN in agent
2026-01-01 02:59:25,982 - DEBUG - VRF ids for VN ctest-mgmt_vn-75823920: {}
2026-01-01 02:59:26,269 - DEBUG - Response for create_network : {'network': {'id': '78db49e1-b7c2-4ef4-8f83-6f00e6927e91', 'name': 'ctest-left_vn-08692162', 'tenant_id': '775c6c81e5ad4321a830c63bee406068', 'project_id': '775c6c81e5ad4321a830c63bee406068', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-95509401', 'ctest-left_vn-08692162'], 'port_security_enabled': True, 'description': ''}}
2026-01-01 02:59:26,545 - DEBUG - Response for create_subnet : {'subnet': {'id': 'fdff6ea5-0154-489e-afd6-fb16fe18b248', 'name': '', 'tenant_id': '775c6c81e5ad4321a830c63bee406068', 'network_id': '78db49e1-b7c2-4ef4-8f83-6f00e6927e91', 'ip_version': 4, 'cidr': '81.69.217.0/26', 'allocation_pools': [{'start': '81.69.217.2', 'end': '81.69.217.62'}], 'gateway_ip': '81.69.217.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '81.69.217.2', 'tags': [], 'project_id': '775c6c81e5ad4321a830c63bee406068'}}
2026-01-01 02:59:26,572 - INFO - Created VN ctest-left_vn-08692162
2026-01-01 02:59:26,583 - DEBUG - VN ctest-left_vn-08692162 UUID is 78db49e1-b7c2-4ef4-8f83-6f00e6927e91
2026-01-01 02:59:26,660 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:26,667 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:26,682 - DEBUG - Requesting: http://10.0.0.38:8082/project/775c6c81-e5ad-4321-a830-c63bee406068
2026-01-01 02:59:26,800 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/78db49e1-b7c2-4ef4-8f83-6f00e6927e91
2026-01-01 02:59:26,819 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/78db49e1-b7c2-4ef4-8f83-6f00e6927e91
2026-01-01 02:59:26,831 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/d56fe7d4-2822-452e-945a-dcd6efd6ba08
2026-01-01 02:59:26,842 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/d56fe7d4-2822-452e-945a-dcd6efd6ba08
2026-01-01 02:59:26,852 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/aef979c5-b700-442d-94fc-b2e64873e101
2026-01-01 02:59:26,871 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-01 02:59:26,871 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/78db49e1-b7c2-4ef4-8f83-6f00e6927e91
2026-01-01 02:59:26,887 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/d56fe7d4-2822-452e-945a-dcd6efd6ba08
2026-01-01 02:59:26,906 - INFO - Verified VN network id 15 for VN 78db49e1-b7c2-4ef4-8f83-6f00e6927e91
2026-01-01 02:59:26,907 - INFO - Verifications in API Server for VN ctest-left_vn-08692162 passed
2026-01-01 02:59:26,907 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/78db49e1-b7c2-4ef4-8f83-6f00e6927e91
2026-01-01 02:59:26,923 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/d56fe7d4-2822-452e-945a-dcd6efd6ba08
2026-01-01 02:59:26,935 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/d56fe7d4-2822-452e-945a-dcd6efd6ba08
2026-01-01 02:59:26,942 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/aef979c5-b700-442d-94fc-b2e64873e101
2026-01-01 02:59:26,957 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95509401:ctest-left_vn-08692162', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95509401', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8708635538250419956', 'uuid-lslong': '10341231219031834257'}, 'enable': 'true', 'created': '2026-01-01T02:59:26', 'last-modified': '2026-01-01T02:59:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.480673'}
2026-01-01 02:59:26,963 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-01 02:59:26,969 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95509401:ctest-left_vn-08692162', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95509401', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8708635538250419956', 'uuid-lslong': '10341231219031834257'}, 'enable': 'true', 'created': '2026-01-01T02:59:26', 'last-modified': '2026-01-01T02:59:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.498277'}
2026-01-01 02:59:26,975 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-01 02:59:26,982 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95509401:ctest-left_vn-08692162', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95509401', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8708635538250419956', 'uuid-lslong': '10341231219031834257'}, 'enable': 'true', 'created': '2026-01-01T02:59:26', 'last-modified': '2026-01-01T02:59:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.509043'}
2026-01-01 02:59:26,992 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-01 02:59:26,992 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-08692162 passed
2026-01-01 02:59:26,993 - DEBUG - ====Verifying policy data for ctest-left_vn-08692162 in API_Server ======
2026-01-01 02:59:26,993 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:27,000 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:27,015 - DEBUG - Requesting: http://10.0.0.38:8082/project/775c6c81-e5ad-4321-a830-c63bee406068
2026-01-01 02:59:27,115 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/78db49e1-b7c2-4ef4-8f83-6f00e6927e91
2026-01-01 02:59:27,126 - DEBUG - =>VN ctest-left_vn-08692162 has no policy to be verified
2026-01-01 02:59:27,126 - DEBUG - Verifying the vn in opserver
2026-01-01 02:59:27,126 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95509401:ctest-left_vn-08692162 virtual network link through opserver 10.0.0.38
2026-01-01 02:59:27,126 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-01-01 02:59:27,139 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95509401:ctest-left_vn-08692162', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95509401:ctest-left_vn-08692162?flat'}
2026-01-01 02:59:27,139 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95509401:ctest-left_vn-08692162 virtual network link through opserver 10.0.0.249
2026-01-01 02:59:27,139 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-01-01 02:59:27,152 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95509401:ctest-left_vn-08692162', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95509401:ctest-left_vn-08692162?flat'}
2026-01-01 02:59:27,152 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95509401:ctest-left_vn-08692162 virtual network link through opserver 10.0.0.27
2026-01-01 02:59:27,152 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-01-01 02:59:27,164 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95509401:ctest-left_vn-08692162', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95509401:ctest-left_vn-08692162?flat'}
2026-01-01 02:59:27,165 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-95509401:ctest-left_vn-08692162 is found in opserver
2026-01-01 02:59:27,188 - DEBUG - Do not have enough data to verify VN in agent
2026-01-01 02:59:27,200 - DEBUG - VRF ids for VN ctest-left_vn-08692162: {}
2026-01-01 02:59:27,501 - DEBUG - Response for create_network : {'network': {'id': 'ab058641-b613-4437-b277-670ff8cf9ae7', 'name': 'ctest-right_vn-69624264', 'tenant_id': '775c6c81e5ad4321a830c63bee406068', 'project_id': '775c6c81e5ad4321a830c63bee406068', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-95509401', 'ctest-right_vn-69624264'], 'port_security_enabled': True, 'description': ''}}
2026-01-01 02:59:27,770 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e9d81157-2c7d-4890-9dd4-b18df643cc72', 'name': '', 'tenant_id': '775c6c81e5ad4321a830c63bee406068', 'network_id': 'ab058641-b613-4437-b277-670ff8cf9ae7', 'ip_version': 4, 'cidr': '84.135.159.128/26', 'allocation_pools': [{'start': '84.135.159.130', 'end': '84.135.159.190'}], 'gateway_ip': '84.135.159.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '84.135.159.130', 'tags': [], 'project_id': '775c6c81e5ad4321a830c63bee406068'}}
2026-01-01 02:59:27,792 - INFO - Created VN ctest-right_vn-69624264
2026-01-01 02:59:27,804 - DEBUG - VN ctest-right_vn-69624264 UUID is ab058641-b613-4437-b277-670ff8cf9ae7
2026-01-01 02:59:27,888 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:27,895 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:27,908 - DEBUG - Requesting: http://10.0.0.38:8082/project/775c6c81-e5ad-4321-a830-c63bee406068
2026-01-01 02:59:28,021 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/ab058641-b613-4437-b277-670ff8cf9ae7
2026-01-01 02:59:28,037 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/ab058641-b613-4437-b277-670ff8cf9ae7
2026-01-01 02:59:28,051 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b385655f-0d2d-4c2d-9948-80adcd3460b6
2026-01-01 02:59:28,061 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b385655f-0d2d-4c2d-9948-80adcd3460b6
2026-01-01 02:59:28,071 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/2470d994-b3f7-4923-9c7b-87d72f60bc18
2026-01-01 02:59:28,082 - DEBUG - Route Targets: ['target:64512:8000007']
2026-01-01 02:59:28,082 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/ab058641-b613-4437-b277-670ff8cf9ae7
2026-01-01 02:59:28,094 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b385655f-0d2d-4c2d-9948-80adcd3460b6
2026-01-01 02:59:28,116 - INFO - Verified VN network id 16 for VN ab058641-b613-4437-b277-670ff8cf9ae7
2026-01-01 02:59:28,116 - INFO - Verifications in API Server for VN ctest-right_vn-69624264 passed
2026-01-01 02:59:28,116 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/ab058641-b613-4437-b277-670ff8cf9ae7
2026-01-01 02:59:28,128 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b385655f-0d2d-4c2d-9948-80adcd3460b6
2026-01-01 02:59:28,137 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b385655f-0d2d-4c2d-9948-80adcd3460b6
2026-01-01 02:59:28,145 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/2470d994-b3f7-4923-9c7b-87d72f60bc18
2026-01-01 02:59:28,164 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95509401:ctest-right_vn-69624264', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95509401', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12323403572154942519', 'uuid-lslong': '12859860579276266215'}, 'enable': 'true', 'created': '2026-01-01T02:59:27', 'last-modified': '2026-01-01T02:59:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.460509'}
2026-01-01 02:59:28,172 - DEBUG - Route Targets: ['target:64512:8000007']
2026-01-01 02:59:28,178 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95509401:ctest-right_vn-69624264', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95509401', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12323403572154942519', 'uuid-lslong': '12859860579276266215'}, 'enable': 'true', 'created': '2026-01-01T02:59:27', 'last-modified': '2026-01-01T02:59:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.481276'}
2026-01-01 02:59:28,184 - DEBUG - Route Targets: ['target:64512:8000007']
2026-01-01 02:59:28,191 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95509401:ctest-right_vn-69624264', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95509401', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12323403572154942519', 'uuid-lslong': '12859860579276266215'}, 'enable': 'true', 'created': '2026-01-01T02:59:27', 'last-modified': '2026-01-01T02:59:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.493997'}
2026-01-01 02:59:28,197 - DEBUG - Route Targets: ['target:64512:8000007']
2026-01-01 02:59:28,197 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-69624264 passed
2026-01-01 02:59:28,197 - DEBUG - ====Verifying policy data for ctest-right_vn-69624264 in API_Server ======
2026-01-01 02:59:28,198 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:28,204 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:28,218 - DEBUG - Requesting: http://10.0.0.38:8082/project/775c6c81-e5ad-4321-a830-c63bee406068
2026-01-01 02:59:28,317 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/ab058641-b613-4437-b277-670ff8cf9ae7
2026-01-01 02:59:28,332 - DEBUG - =>VN ctest-right_vn-69624264 has no policy to be verified
2026-01-01 02:59:28,332 - DEBUG - Verifying the vn in opserver
2026-01-01 02:59:28,333 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95509401:ctest-right_vn-69624264 virtual network link through opserver 10.0.0.38
2026-01-01 02:59:28,333 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-01-01 02:59:28,349 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95509401:ctest-right_vn-69624264', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95509401:ctest-right_vn-69624264?flat'}
2026-01-01 02:59:28,349 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95509401:ctest-right_vn-69624264 virtual network link through opserver 10.0.0.249
2026-01-01 02:59:28,349 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-01-01 02:59:28,363 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95509401:ctest-right_vn-69624264', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95509401:ctest-right_vn-69624264?flat'}
2026-01-01 02:59:28,363 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95509401:ctest-right_vn-69624264 virtual network link through opserver 10.0.0.27
2026-01-01 02:59:28,363 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-01-01 02:59:28,377 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95509401:ctest-right_vn-69624264', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95509401:ctest-right_vn-69624264?flat'}
2026-01-01 02:59:28,377 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-95509401:ctest-right_vn-69624264 is found in opserver
2026-01-01 02:59:28,400 - DEBUG - Do not have enough data to verify VN in agent
2026-01-01 02:59:28,411 - DEBUG - VRF ids for VN ctest-right_vn-69624264: {}
2026-01-01 02:59:28,753 - DEBUG - Response for create_network : {'network': {'id': 'd671816c-9192-42ce-b186-2d0971f08b09', 'name': 'ctest-trans_left_vn-53055846', 'tenant_id': '775c6c81e5ad4321a830c63bee406068', 'project_id': '775c6c81e5ad4321a830c63bee406068', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-95509401', 'ctest-trans_left_vn-53055846'], 'port_security_enabled': True, 'description': ''}}
2026-01-01 02:59:28,963 - DEBUG - Response for create_subnet : {'subnet': {'id': '615860f2-7fff-41a9-b081-ee50f640bc10', 'name': '', 'tenant_id': '775c6c81e5ad4321a830c63bee406068', 'network_id': 'd671816c-9192-42ce-b186-2d0971f08b09', 'ip_version': 4, 'cidr': '118.68.215.128/26', 'allocation_pools': [{'start': '118.68.215.130', 'end': '118.68.215.190'}], 'gateway_ip': '118.68.215.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '118.68.215.130', 'tags': [], 'project_id': '775c6c81e5ad4321a830c63bee406068'}}
2026-01-01 02:59:28,986 - INFO - Created VN ctest-trans_left_vn-53055846
2026-01-01 02:59:29,002 - DEBUG - VN ctest-trans_left_vn-53055846 UUID is d671816c-9192-42ce-b186-2d0971f08b09
2026-01-01 02:59:29,080 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:29,087 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:29,100 - DEBUG - Requesting: http://10.0.0.38:8082/project/775c6c81-e5ad-4321-a830-c63bee406068
2026-01-01 02:59:29,199 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/d671816c-9192-42ce-b186-2d0971f08b09
2026-01-01 02:59:29,211 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/d671816c-9192-42ce-b186-2d0971f08b09
2026-01-01 02:59:29,232 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/bd600940-91b0-44ba-b8b2-b1af3421c4de
2026-01-01 02:59:29,241 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/bd600940-91b0-44ba-b8b2-b1af3421c4de
2026-01-01 02:59:29,250 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/7a8c9bf5-8005-44e4-ba8d-77793e4ef98f
2026-01-01 02:59:29,258 - DEBUG - Route Targets: ['target:64512:8000008']
2026-01-01 02:59:29,258 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/d671816c-9192-42ce-b186-2d0971f08b09
2026-01-01 02:59:29,269 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/bd600940-91b0-44ba-b8b2-b1af3421c4de
2026-01-01 02:59:29,287 - INFO - Verified VN network id 17 for VN d671816c-9192-42ce-b186-2d0971f08b09
2026-01-01 02:59:29,287 - INFO - Verifications in API Server for VN ctest-trans_left_vn-53055846 passed
2026-01-01 02:59:29,288 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/d671816c-9192-42ce-b186-2d0971f08b09
2026-01-01 02:59:29,299 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/bd600940-91b0-44ba-b8b2-b1af3421c4de
2026-01-01 02:59:29,308 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/bd600940-91b0-44ba-b8b2-b1af3421c4de
2026-01-01 02:59:29,316 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/7a8c9bf5-8005-44e4-ba8d-77793e4ef98f
2026-01-01 02:59:29,329 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95509401:ctest-trans_left_vn-53055846', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95509401', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15452274099783615182', 'uuid-lslong': '12791961310182017801'}, 'enable': 'true', 'created': '2026-01-01T02:59:28', 'last-modified': '2026-01-01T02:59:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.418870'}
2026-01-01 02:59:29,335 - DEBUG - Route Targets: ['target:64512:8000008']
2026-01-01 02:59:29,340 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95509401:ctest-trans_left_vn-53055846', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95509401', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15452274099783615182', 'uuid-lslong': '12791961310182017801'}, 'enable': 'true', 'created': '2026-01-01T02:59:28', 'last-modified': '2026-01-01T02:59:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.426715'}
2026-01-01 02:59:29,346 - DEBUG - Route Targets: ['target:64512:8000008']
2026-01-01 02:59:29,351 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95509401:ctest-trans_left_vn-53055846', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95509401', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15452274099783615182', 'uuid-lslong': '12791961310182017801'}, 'enable': 'true', 'created': '2026-01-01T02:59:28', 'last-modified': '2026-01-01T02:59:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.441693'}
2026-01-01 02:59:29,357 - DEBUG - Route Targets: ['target:64512:8000008']
2026-01-01 02:59:29,357 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-53055846 passed
2026-01-01 02:59:29,357 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-53055846 in API_Server ======
2026-01-01 02:59:29,357 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:29,365 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:29,377 - DEBUG - Requesting: http://10.0.0.38:8082/project/775c6c81-e5ad-4321-a830-c63bee406068
2026-01-01 02:59:29,472 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/d671816c-9192-42ce-b186-2d0971f08b09
2026-01-01 02:59:29,484 - DEBUG - =>VN ctest-trans_left_vn-53055846 has no policy to be verified
2026-01-01 02:59:29,484 - DEBUG - Verifying the vn in opserver
2026-01-01 02:59:29,484 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95509401:ctest-trans_left_vn-53055846 virtual network link through opserver 10.0.0.38
2026-01-01 02:59:29,484 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-01-01 02:59:29,496 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95509401:ctest-trans_left_vn-53055846', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95509401:ctest-trans_left_vn-53055846?flat'}
2026-01-01 02:59:29,496 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95509401:ctest-trans_left_vn-53055846 virtual network link through opserver 10.0.0.249
2026-01-01 02:59:29,496 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-01-01 02:59:29,510 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95509401:ctest-trans_left_vn-53055846', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95509401:ctest-trans_left_vn-53055846?flat'}
2026-01-01 02:59:29,510 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95509401:ctest-trans_left_vn-53055846 virtual network link through opserver 10.0.0.27
2026-01-01 02:59:29,510 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-01-01 02:59:29,525 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95509401:ctest-trans_left_vn-53055846', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95509401:ctest-trans_left_vn-53055846?flat'}
2026-01-01 02:59:29,525 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-95509401:ctest-trans_left_vn-53055846 is found in opserver
2026-01-01 02:59:29,555 - DEBUG - Do not have enough data to verify VN in agent
2026-01-01 02:59:29,567 - DEBUG - VRF ids for VN ctest-trans_left_vn-53055846: {}
2026-01-01 02:59:29,894 - DEBUG - Response for create_network : {'network': {'id': 'a72ac526-c9ac-4504-8eba-7fee34b092d8', 'name': 'ctest-trans_right_vn-28757072', 'tenant_id': '775c6c81e5ad4321a830c63bee406068', 'project_id': '775c6c81e5ad4321a830c63bee406068', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-95509401', 'ctest-trans_right_vn-28757072'], 'port_security_enabled': True, 'description': ''}}
2026-01-01 02:59:30,182 - DEBUG - Response for create_subnet : {'subnet': {'id': 'db93467e-a700-44f9-a7f3-755b27a6ec2c', 'name': '', 'tenant_id': '775c6c81e5ad4321a830c63bee406068', 'network_id': 'a72ac526-c9ac-4504-8eba-7fee34b092d8', 'ip_version': 4, 'cidr': '173.82.39.128/26', 'allocation_pools': [{'start': '173.82.39.130', 'end': '173.82.39.190'}], 'gateway_ip': '173.82.39.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '173.82.39.130', 'tags': [], 'project_id': '775c6c81e5ad4321a830c63bee406068'}}
2026-01-01 02:59:30,209 - INFO - Created VN ctest-trans_right_vn-28757072
2026-01-01 02:59:30,221 - DEBUG - VN ctest-trans_right_vn-28757072 UUID is a72ac526-c9ac-4504-8eba-7fee34b092d8
2026-01-01 02:59:30,303 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:30,311 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:30,322 - DEBUG - Requesting: http://10.0.0.38:8082/project/775c6c81-e5ad-4321-a830-c63bee406068
2026-01-01 02:59:30,444 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/a72ac526-c9ac-4504-8eba-7fee34b092d8
2026-01-01 02:59:30,460 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/a72ac526-c9ac-4504-8eba-7fee34b092d8
2026-01-01 02:59:30,473 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/eec00b19-9f3d-4663-b7a2-f95d775492e0
2026-01-01 02:59:30,484 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/eec00b19-9f3d-4663-b7a2-f95d775492e0
2026-01-01 02:59:30,494 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/ecb88fc7-45aa-4ca1-87b4-4fa7e3e1a823
2026-01-01 02:59:30,503 - DEBUG - Route Targets: ['target:64512:8000009']
2026-01-01 02:59:30,503 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/a72ac526-c9ac-4504-8eba-7fee34b092d8
2026-01-01 02:59:30,515 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/eec00b19-9f3d-4663-b7a2-f95d775492e0
2026-01-01 02:59:30,532 - INFO - Verified VN network id 18 for VN a72ac526-c9ac-4504-8eba-7fee34b092d8
2026-01-01 02:59:30,532 - INFO - Verifications in API Server for VN ctest-trans_right_vn-28757072 passed
2026-01-01 02:59:30,532 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/a72ac526-c9ac-4504-8eba-7fee34b092d8
2026-01-01 02:59:30,543 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/eec00b19-9f3d-4663-b7a2-f95d775492e0
2026-01-01 02:59:30,553 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/eec00b19-9f3d-4663-b7a2-f95d775492e0
2026-01-01 02:59:30,562 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/ecb88fc7-45aa-4ca1-87b4-4fa7e3e1a823
2026-01-01 02:59:30,576 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95509401:ctest-trans_right_vn-28757072', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95509401', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12045656923738752260', 'uuid-lslong': '10284673360116880088'}, 'enable': 'true', 'created': '2026-01-01T02:59:29', 'last-modified': '2026-01-01T02:59:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.456636'}
2026-01-01 02:59:30,584 - DEBUG - Route Targets: ['target:64512:8000009']
2026-01-01 02:59:30,590 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95509401:ctest-trans_right_vn-28757072', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95509401', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12045656923738752260', 'uuid-lslong': '10284673360116880088'}, 'enable': 'true', 'created': '2026-01-01T02:59:29', 'last-modified': '2026-01-01T02:59:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.479625'}
2026-01-01 02:59:30,596 - DEBUG - Route Targets: ['target:64512:8000009']
2026-01-01 02:59:30,601 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95509401:ctest-trans_right_vn-28757072', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95509401', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12045656923738752260', 'uuid-lslong': '10284673360116880088'}, 'enable': 'true', 'created': '2026-01-01T02:59:29', 'last-modified': '2026-01-01T02:59:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.491496'}
2026-01-01 02:59:30,609 - DEBUG - Route Targets: ['target:64512:8000009']
2026-01-01 02:59:30,610 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-28757072 passed
2026-01-01 02:59:30,610 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-28757072 in API_Server ======
2026-01-01 02:59:30,610 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:30,617 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:30,630 - DEBUG - Requesting: http://10.0.0.38:8082/project/775c6c81-e5ad-4321-a830-c63bee406068
2026-01-01 02:59:30,738 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/a72ac526-c9ac-4504-8eba-7fee34b092d8
2026-01-01 02:59:30,748 - DEBUG - =>VN ctest-trans_right_vn-28757072 has no policy to be verified
2026-01-01 02:59:30,748 - DEBUG - Verifying the vn in opserver
2026-01-01 02:59:30,748 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95509401:ctest-trans_right_vn-28757072 virtual network link through opserver 10.0.0.38
2026-01-01 02:59:30,748 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-01-01 02:59:30,762 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95509401:ctest-trans_right_vn-28757072', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95509401:ctest-trans_right_vn-28757072?flat'}
2026-01-01 02:59:30,762 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95509401:ctest-trans_right_vn-28757072 virtual network link through opserver 10.0.0.249
2026-01-01 02:59:30,762 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-01-01 02:59:30,776 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95509401:ctest-trans_right_vn-28757072', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95509401:ctest-trans_right_vn-28757072?flat'}
2026-01-01 02:59:30,776 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95509401:ctest-trans_right_vn-28757072 virtual network link through opserver 10.0.0.27
2026-01-01 02:59:30,776 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-01-01 02:59:30,789 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95509401:ctest-trans_right_vn-28757072', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95509401:ctest-trans_right_vn-28757072?flat'}
2026-01-01 02:59:30,789 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-95509401:ctest-trans_right_vn-28757072 is found in opserver
2026-01-01 02:59:30,812 - DEBUG - Do not have enough data to verify VN in agent
2026-01-01 02:59:30,826 - DEBUG - VRF ids for VN ctest-trans_right_vn-28757072: {}
2026-01-01 02:59:31,918 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4945-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4945-1)
2026-01-01 02:59:33,200 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4945-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4945-2)
2026-01-01 02:59:33,200 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-47822452']
2026-01-01 02:59:33,505 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-47822452'] created succesfully
2026-01-01 02:59:33,903 - DEBUG - Image by name tiny_trans_fw not found
2026-01-01 02:59:33,903 - DEBUG - Installing image tiny_trans_fw
2026-01-01 02:59:33,903 - DEBUG - Image info {'name': 'tinycore-net-transparent-fw.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd'}
2026-01-01 02:59:33,903 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-01-01 02:59:33,903 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-01-01 02:59:33,932 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz -O /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-01-01 02:59:33,984 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-01-01 02:59:33,984 - DEBUG - Unzip image
2026-01-01 02:59:33,984 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-01-01 02:59:34,011 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-01-01 02:59:34,012 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-47822452']
2026-01-01 02:59:34,114 - INFO - Service template: ['default-domain', 'ctest-service_template_1-47822452'] deleted successfully.
2026-01-01 02:59:34,115 - INFO - Skip interface_detach for VM ctest-right_vm-67008689 in state BUILD
2026-01-01 02:59:34,116 - INFO - Deleting VM ctest-right_vm-67008689
2026-01-01 02:59:34,119 - ERROR - VM ctest-right_vm-67008689 has failed to come up
2026-01-01 02:59:34,119 - ERROR - Nova failed to get host of the VM
2026-01-01 02:59:34,120 - ERROR - VM ctest-right_vm-67008689 has failed to come up
2026-01-01 02:59:34,120 - ERROR - Nova failed to get host of the VM
2026-01-01 02:59:34,234 - INFO - Skip interface_detach for VM ctest-left_vm-09792811 in state BUILD
2026-01-01 02:59:34,235 - INFO - Deleting VM ctest-left_vm-09792811
2026-01-01 02:59:34,235 - ERROR - VM ctest-left_vm-09792811 has failed to come up
2026-01-01 02:59:34,235 - ERROR - Nova failed to get host of the VM
2026-01-01 02:59:34,235 - ERROR - VM ctest-left_vm-09792811 has failed to come up
2026-01-01 02:59:34,235 - ERROR - Nova failed to get host of the VM
2026-01-01 02:59:34,340 - INFO - Deleting VN ctest-trans_right_vn-28757072
2026-01-01 02:59:34,528 - DEBUG - Response for deleting network ()
2026-01-01 02:59:34,528 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/eec00b19-9f3d-4663-b7a2-f95d775492e0
2026-01-01 02:59:34,542 - DEBUG - Response Code: 404
2026-01-01 02:59:34,542 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:34,549 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:34,608 - DEBUG - Requesting: http://10.0.0.38:8082/project/775c6c81-e5ad-4321-a830-c63bee406068
2026-01-01 02:59:34,700 - INFO - Validated that VN ctest-trans_right_vn-28757072 is not found in API Server
2026-01-01 02:59:34,711 - DEBUG - VN ctest-trans_right_vn-28757072 is not present in Agent 10.0.0.242
2026-01-01 02:59:34,725 - DEBUG - VN ctest-trans_right_vn-28757072 is not present in Agent 10.0.0.23
2026-01-01 02:59:34,725 - INFO - Validated that VN ctest-trans_right_vn-28757072 is not in any agent
2026-01-01 02:59:34,782 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-28757072 info
2026-01-01 02:59:34,782 - INFO - Deleting VN ctest-trans_left_vn-53055846
2026-01-01 02:59:34,935 - DEBUG - Response for deleting network ()
2026-01-01 02:59:34,935 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/bd600940-91b0-44ba-b8b2-b1af3421c4de
2026-01-01 02:59:34,941 - DEBUG - Response Code: 404
2026-01-01 02:59:34,942 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:34,956 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:35,025 - DEBUG - Requesting: http://10.0.0.38:8082/project/775c6c81-e5ad-4321-a830-c63bee406068
2026-01-01 02:59:35,155 - INFO - Validated that VN ctest-trans_left_vn-53055846 is not found in API Server
2026-01-01 02:59:35,169 - DEBUG - VN ctest-trans_left_vn-53055846 is not present in Agent 10.0.0.242
2026-01-01 02:59:35,206 - DEBUG - VN ctest-trans_left_vn-53055846 is not present in Agent 10.0.0.23
2026-01-01 02:59:35,206 - INFO - Validated that VN ctest-trans_left_vn-53055846 is not in any agent
2026-01-01 02:59:35,246 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-53055846 info
2026-01-01 02:59:35,246 - INFO - Deleting VN ctest-right_vn-69624264
2026-01-01 02:59:35,289 - DEBUG - VN ab058641-b613-4437-b277-670ff8cf9ae7 still in use: Unable to complete operation on network ab058641-b613-4437-b277-670ff8cf9ae7. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-4d5e49f2-b1e4-41a7-a8a5-a9a51d143b33']
2026-01-01 02:59:35,289 - WARNING - Deleting VN ctest-right_vn-69624264 failed..Will retry
2026-01-01 02:59:37,455 - DEBUG - Response for deleting network ()
2026-01-01 02:59:37,455 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b385655f-0d2d-4c2d-9948-80adcd3460b6
2026-01-01 02:59:37,464 - DEBUG - Response Code: 404
2026-01-01 02:59:37,464 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:37,474 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:37,508 - DEBUG - Requesting: http://10.0.0.38:8082/project/775c6c81-e5ad-4321-a830-c63bee406068
2026-01-01 02:59:37,611 - INFO - Validated that VN ctest-right_vn-69624264 is not found in API Server
2026-01-01 02:59:37,624 - DEBUG - VN ctest-right_vn-69624264 is not present in Agent 10.0.0.242
2026-01-01 02:59:37,635 - DEBUG - VN ctest-right_vn-69624264 is not present in Agent 10.0.0.23
2026-01-01 02:59:37,635 - INFO - Validated that VN ctest-right_vn-69624264 is not in any agent
2026-01-01 02:59:37,673 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-69624264 info
2026-01-01 02:59:37,673 - INFO - Deleting VN ctest-left_vn-08692162
2026-01-01 02:59:37,856 - DEBUG - Response for deleting network ()
2026-01-01 02:59:37,856 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/d56fe7d4-2822-452e-945a-dcd6efd6ba08
2026-01-01 02:59:37,865 - DEBUG - Response Code: 404
2026-01-01 02:59:37,865 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:37,871 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:37,924 - DEBUG - Requesting: http://10.0.0.38:8082/project/775c6c81-e5ad-4321-a830-c63bee406068
2026-01-01 02:59:38,013 - INFO - Validated that VN ctest-left_vn-08692162 is not found in API Server
2026-01-01 02:59:38,030 - DEBUG - VN ctest-left_vn-08692162 is not present in Agent 10.0.0.242
2026-01-01 02:59:38,041 - DEBUG - VN ctest-left_vn-08692162 is not present in Agent 10.0.0.23
2026-01-01 02:59:38,041 - INFO - Validated that VN ctest-left_vn-08692162 is not in any agent
2026-01-01 02:59:38,076 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-08692162 info
2026-01-01 02:59:38,076 - INFO - Deleting VN ctest-mgmt_vn-75823920
2026-01-01 02:59:38,243 - DEBUG - Response for deleting network ()
2026-01-01 02:59:38,243 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/6109dfa5-6dd9-4d12-9334-330475101726
2026-01-01 02:59:38,250 - DEBUG - Response Code: 404
2026-01-01 02:59:38,250 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:38,256 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:38,269 - DEBUG - Requesting: http://10.0.0.38:8082/project/775c6c81-e5ad-4321-a830-c63bee406068
2026-01-01 02:59:38,392 - INFO - Validated that VN ctest-mgmt_vn-75823920 is not found in API Server
2026-01-01 02:59:38,404 - DEBUG - VN ctest-mgmt_vn-75823920 is not present in Agent 10.0.0.242
2026-01-01 02:59:38,414 - DEBUG - VN ctest-mgmt_vn-75823920 is not present in Agent 10.0.0.23
2026-01-01 02:59:38,414 - INFO - Validated that VN ctest-mgmt_vn-75823920 is not in any agent
2026-01-01 02:59:38,455 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-75823920 info
2026-01-01 02:59:39,743 - DEBUG - No XMPP flaps were noticed during the test
2026-01-01 02:59:39,743 - INFO -
2026-01-01 02:59:39,743 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:16]
2026-01-01 02:59:39,744 - INFO - --------------------------------------------------------------------------------
2026-01-01 02:59:40,507 - INFO - Deleted project: ctest-TestSvcRegr-95509401, ID : 775c6c81-e5ad-4321-a830-c63bee406068
2026-01-01 02:59:40,707 - INFO - Domain Default found not creating
2026-01-01 02:59:40,900 - INFO - Project ctest-TestSvcRegr-72543752 not found, creating it
2026-01-01 02:59:41,432 - INFO - Created Project:ctest-TestSvcRegr-72543752, ID : 0890eefe-6fe3-458f-9ed8-8432b5f10ff3
2026-01-01 02:59:43,000 - INFO - ================================================================================
2026-01-01 02:59:43,000 - INFO - STARTING TEST : test_svc_CEM_22032
2026-01-01 02:59:44,278 - DEBUG - Nothing to compare xmpp stats {'10.0.0.242': {'10.20.0.14': '0', '10.20.0.18': '0'}, '10.0.0.23': {'10.20.0.14': '0', '10.20.0.18': '0'}} with
2026-01-01 02:59:44,278 - INFO - Initial checks done. Running the testcase now
2026-01-01 02:59:44,278 - INFO -
2026-01-01 02:59:44,984 - DEBUG - Response for create_network : {'network': {'id': '3cb9f810-475a-4cb6-8471-7411a80cfe68', 'name': 'ctest-mgmt_vn-40435190', 'tenant_id': '0890eefe6fe3458f9ed88432b5f10ff3', 'project_id': '0890eefe6fe3458f9ed88432b5f10ff3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-72543752', 'ctest-mgmt_vn-40435190'], 'port_security_enabled': True, 'description': ''}}
2026-01-01 02:59:45,238 - DEBUG - Response for create_subnet : {'subnet': {'id': '1ffacac0-917e-406c-af6f-61977c6d9b9d', 'name': '', 'tenant_id': '0890eefe6fe3458f9ed88432b5f10ff3', 'network_id': '3cb9f810-475a-4cb6-8471-7411a80cfe68', 'ip_version': 4, 'cidr': '38.178.80.128/26', 'allocation_pools': [{'start': '38.178.80.130', 'end': '38.178.80.190'}], 'gateway_ip': '38.178.80.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '38.178.80.130', 'tags': [], 'project_id': '0890eefe6fe3458f9ed88432b5f10ff3'}}
2026-01-01 02:59:45,263 - INFO - Created VN ctest-mgmt_vn-40435190
2026-01-01 02:59:45,278 - DEBUG - VN ctest-mgmt_vn-40435190 UUID is 3cb9f810-475a-4cb6-8471-7411a80cfe68
2026-01-01 02:59:45,353 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:45,665 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:45,701 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:45,719 - DEBUG - Requesting: http://10.0.0.38:8082/project/0890eefe-6fe3-458f-9ed8-8432b5f10ff3
2026-01-01 02:59:45,822 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/3cb9f810-475a-4cb6-8471-7411a80cfe68
2026-01-01 02:59:45,836 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/3cb9f810-475a-4cb6-8471-7411a80cfe68
2026-01-01 02:59:45,847 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b2c9059f-6f98-42e3-8e80-407e92150d7c
2026-01-01 02:59:45,858 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b2c9059f-6f98-42e3-8e80-407e92150d7c
2026-01-01 02:59:45,867 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/72bf6c3d-f366-48a4-bf0f-48d3ad80e046
2026-01-01 02:59:45,876 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-01 02:59:45,876 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/3cb9f810-475a-4cb6-8471-7411a80cfe68
2026-01-01 02:59:45,887 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b2c9059f-6f98-42e3-8e80-407e92150d7c
2026-01-01 02:59:45,904 - INFO - Verified VN network id 14 for VN 3cb9f810-475a-4cb6-8471-7411a80cfe68
2026-01-01 02:59:45,904 - INFO - Verifications in API Server for VN ctest-mgmt_vn-40435190 passed
2026-01-01 02:59:45,904 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/3cb9f810-475a-4cb6-8471-7411a80cfe68
2026-01-01 02:59:45,917 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b2c9059f-6f98-42e3-8e80-407e92150d7c
2026-01-01 02:59:45,925 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b2c9059f-6f98-42e3-8e80-407e92150d7c
2026-01-01 02:59:45,933 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/72bf6c3d-f366-48a4-bf0f-48d3ad80e046
2026-01-01 02:59:45,946 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-40435190', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72543752', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4375801261767412918', 'uuid-lslong': '9543536704557481576'}, 'enable': 'true', 'created': '2026-01-01T02:59:44', 'last-modified': '2026-01-01T02:59:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.762169'}
2026-01-01 02:59:45,955 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-01 02:59:45,960 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-40435190', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72543752', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4375801261767412918', 'uuid-lslong': '9543536704557481576'}, 'enable': 'true', 'created': '2026-01-01T02:59:44', 'last-modified': '2026-01-01T02:59:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.775477'}
2026-01-01 02:59:45,966 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-01 02:59:45,973 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-40435190', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72543752', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4375801261767412918', 'uuid-lslong': '9543536704557481576'}, 'enable': 'true', 'created': '2026-01-01T02:59:44', 'last-modified': '2026-01-01T02:59:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.788951'}
2026-01-01 02:59:45,981 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-01 02:59:45,981 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-40435190 passed
2026-01-01 02:59:45,981 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-40435190 in API_Server ======
2026-01-01 02:59:45,981 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:45,990 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:46,004 - DEBUG - Requesting: http://10.0.0.38:8082/project/0890eefe-6fe3-458f-9ed8-8432b5f10ff3
2026-01-01 02:59:46,116 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/3cb9f810-475a-4cb6-8471-7411a80cfe68
2026-01-01 02:59:46,129 - DEBUG - =>VN ctest-mgmt_vn-40435190 has no policy to be verified
2026-01-01 02:59:46,129 - DEBUG - Verifying the vn in opserver
2026-01-01 02:59:46,129 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-40435190 virtual network link through opserver 10.0.0.38
2026-01-01 02:59:46,130 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-01-01 02:59:46,443 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-01-01 02:59:46,519 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-40435190', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-40435190?flat'}
2026-01-01 02:59:46,519 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-40435190 virtual network link through opserver 10.0.0.249
2026-01-01 02:59:46,519 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-01-01 02:59:46,826 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-01-01 02:59:46,897 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-40435190', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-40435190?flat'}
2026-01-01 02:59:46,898 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-40435190 virtual network link through opserver 10.0.0.27
2026-01-01 02:59:46,898 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-01-01 02:59:47,202 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-01-01 02:59:47,279 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-40435190', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-40435190?flat'}
2026-01-01 02:59:47,279 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-40435190 is found in opserver
2026-01-01 02:59:47,301 - DEBUG - Do not have enough data to verify VN in agent
2026-01-01 02:59:47,311 - DEBUG - VRF ids for VN ctest-mgmt_vn-40435190: {}
2026-01-01 02:59:47,623 - DEBUG - Response for create_network : {'network': {'id': 'bdce3dc3-f1a4-48f1-8f7c-f97e7bb05b22', 'name': 'service-left-vn-54854627', 'tenant_id': '0890eefe6fe3458f9ed88432b5f10ff3', 'project_id': '0890eefe6fe3458f9ed88432b5f10ff3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-72543752', 'service-left-vn-54854627'], 'port_security_enabled': True, 'description': ''}}
2026-01-01 02:59:47,876 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e6e6113a-fced-43fe-a6f3-61780c61c841', 'name': '', 'tenant_id': '0890eefe6fe3458f9ed88432b5f10ff3', 'network_id': 'bdce3dc3-f1a4-48f1-8f7c-f97e7bb05b22', 'ip_version': 4, 'cidr': '128.111.28.192/26', 'allocation_pools': [{'start': '128.111.28.194', 'end': '128.111.28.254'}], 'gateway_ip': '128.111.28.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '128.111.28.194', 'tags': [], 'project_id': '0890eefe6fe3458f9ed88432b5f10ff3'}}
2026-01-01 02:59:47,901 - INFO - Created VN service-left-vn-54854627
2026-01-01 02:59:47,917 - DEBUG - VN service-left-vn-54854627 UUID is bdce3dc3-f1a4-48f1-8f7c-f97e7bb05b22
2026-01-01 02:59:47,991 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:47,998 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:48,010 - DEBUG - Requesting: http://10.0.0.38:8082/project/0890eefe-6fe3-458f-9ed8-8432b5f10ff3
2026-01-01 02:59:48,110 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/bdce3dc3-f1a4-48f1-8f7c-f97e7bb05b22
2026-01-01 02:59:48,124 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/bdce3dc3-f1a4-48f1-8f7c-f97e7bb05b22
2026-01-01 02:59:48,134 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/80582e5d-3139-4283-b548-7bc4131a82e9
2026-01-01 02:59:48,142 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/80582e5d-3139-4283-b548-7bc4131a82e9
2026-01-01 02:59:48,150 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/f2ddc791-be1c-47b8-aca8-e4cbd88d4050
2026-01-01 02:59:48,158 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-01 02:59:48,158 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/bdce3dc3-f1a4-48f1-8f7c-f97e7bb05b22
2026-01-01 02:59:48,169 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/80582e5d-3139-4283-b548-7bc4131a82e9
2026-01-01 02:59:48,188 - INFO - Verified VN network id 15 for VN bdce3dc3-f1a4-48f1-8f7c-f97e7bb05b22
2026-01-01 02:59:48,188 - INFO - Verifications in API Server for VN service-left-vn-54854627 passed
2026-01-01 02:59:48,188 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/bdce3dc3-f1a4-48f1-8f7c-f97e7bb05b22
2026-01-01 02:59:48,198 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/80582e5d-3139-4283-b548-7bc4131a82e9
2026-01-01 02:59:48,208 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/80582e5d-3139-4283-b548-7bc4131a82e9
2026-01-01 02:59:48,217 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/f2ddc791-be1c-47b8-aca8-e4cbd88d4050
2026-01-01 02:59:48,231 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72543752:service-left-vn-54854627', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72543752', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13676937030152767729', 'uuid-lslong': '10339413166172166946'}, 'enable': 'true', 'created': '2026-01-01T02:59:47', 'last-modified': '2026-01-01T02:59:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.407706'}
2026-01-01 02:59:48,239 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-01 02:59:48,245 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72543752:service-left-vn-54854627', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72543752', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13676937030152767729', 'uuid-lslong': '10339413166172166946'}, 'enable': 'true', 'created': '2026-01-01T02:59:47', 'last-modified': '2026-01-01T02:59:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.422371'}
2026-01-01 02:59:48,253 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-01 02:59:48,259 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72543752:service-left-vn-54854627', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72543752', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13676937030152767729', 'uuid-lslong': '10339413166172166946'}, 'enable': 'true', 'created': '2026-01-01T02:59:47', 'last-modified': '2026-01-01T02:59:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.436377'}
2026-01-01 02:59:48,266 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-01 02:59:48,266 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-54854627 passed
2026-01-01 02:59:48,266 - DEBUG - ====Verifying policy data for service-left-vn-54854627 in API_Server ======
2026-01-01 02:59:48,266 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:48,273 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:48,285 - DEBUG - Requesting: http://10.0.0.38:8082/project/0890eefe-6fe3-458f-9ed8-8432b5f10ff3
2026-01-01 02:59:48,380 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/bdce3dc3-f1a4-48f1-8f7c-f97e7bb05b22
2026-01-01 02:59:48,390 - DEBUG - =>VN service-left-vn-54854627 has no policy to be verified
2026-01-01 02:59:48,390 - DEBUG - Verifying the vn in opserver
2026-01-01 02:59:48,390 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72543752:service-left-vn-54854627 virtual network link through opserver 10.0.0.38
2026-01-01 02:59:48,390 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-01-01 02:59:48,473 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72543752:service-left-vn-54854627', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72543752:service-left-vn-54854627?flat'}
2026-01-01 02:59:48,474 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72543752:service-left-vn-54854627 virtual network link through opserver 10.0.0.249
2026-01-01 02:59:48,474 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-01-01 02:59:48,558 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72543752:service-left-vn-54854627', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72543752:service-left-vn-54854627?flat'}
2026-01-01 02:59:48,558 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72543752:service-left-vn-54854627 virtual network link through opserver 10.0.0.27
2026-01-01 02:59:48,558 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-01-01 02:59:48,641 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72543752:service-left-vn-54854627', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72543752:service-left-vn-54854627?flat'}
2026-01-01 02:59:48,641 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-72543752:service-left-vn-54854627 is found in opserver
2026-01-01 02:59:48,665 - DEBUG - Do not have enough data to verify VN in agent
2026-01-01 02:59:48,675 - DEBUG - VRF ids for VN service-left-vn-54854627: {}
2026-01-01 02:59:48,947 - DEBUG - Response for create_network : {'network': {'id': '75669a66-e03e-4efc-bd4b-b1da2912c560', 'name': 'service-right-vn-03729404', 'tenant_id': '0890eefe6fe3458f9ed88432b5f10ff3', 'project_id': '0890eefe6fe3458f9ed88432b5f10ff3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-72543752', 'service-right-vn-03729404'], 'port_security_enabled': True, 'description': ''}}
2026-01-01 02:59:49,219 - DEBUG - Response for create_subnet : {'subnet': {'id': '0dcc1d77-026a-4178-9895-ebb159797094', 'name': '', 'tenant_id': '0890eefe6fe3458f9ed88432b5f10ff3', 'network_id': '75669a66-e03e-4efc-bd4b-b1da2912c560', 'ip_version': 4, 'cidr': '190.217.61.64/26', 'allocation_pools': [{'start': '190.217.61.66', 'end': '190.217.61.126'}], 'gateway_ip': '190.217.61.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '190.217.61.66', 'tags': [], 'project_id': '0890eefe6fe3458f9ed88432b5f10ff3'}}
2026-01-01 02:59:49,247 - INFO - Created VN service-right-vn-03729404
2026-01-01 02:59:49,259 - DEBUG - VN service-right-vn-03729404 UUID is 75669a66-e03e-4efc-bd4b-b1da2912c560
2026-01-01 02:59:49,342 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:49,350 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:49,364 - DEBUG - Requesting: http://10.0.0.38:8082/project/0890eefe-6fe3-458f-9ed8-8432b5f10ff3
2026-01-01 02:59:49,475 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/75669a66-e03e-4efc-bd4b-b1da2912c560
2026-01-01 02:59:49,492 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/75669a66-e03e-4efc-bd4b-b1da2912c560
2026-01-01 02:59:49,503 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/7b9f21f3-a0d6-4960-a984-290b5e0229a0
2026-01-01 02:59:49,512 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/7b9f21f3-a0d6-4960-a984-290b5e0229a0
2026-01-01 02:59:49,522 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/f990578b-4cc1-4977-a1e1-55a341291fda
2026-01-01 02:59:49,531 - DEBUG - Route Targets: ['target:64512:8000007']
2026-01-01 02:59:49,531 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/75669a66-e03e-4efc-bd4b-b1da2912c560
2026-01-01 02:59:49,542 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/7b9f21f3-a0d6-4960-a984-290b5e0229a0
2026-01-01 02:59:49,562 - INFO - Verified VN network id 16 for VN 75669a66-e03e-4efc-bd4b-b1da2912c560
2026-01-01 02:59:49,562 - INFO - Verifications in API Server for VN service-right-vn-03729404 passed
2026-01-01 02:59:49,562 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/75669a66-e03e-4efc-bd4b-b1da2912c560
2026-01-01 02:59:49,574 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/7b9f21f3-a0d6-4960-a984-290b5e0229a0
2026-01-01 02:59:49,585 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/7b9f21f3-a0d6-4960-a984-290b5e0229a0
2026-01-01 02:59:49,594 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/f990578b-4cc1-4977-a1e1-55a341291fda
2026-01-01 02:59:49,608 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72543752:service-right-vn-03729404', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72543752', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8459618716701576956', 'uuid-lslong': '13640191446971762016'}, 'enable': 'true', 'created': '2026-01-01T02:59:48', 'last-modified': '2026-01-01T02:59:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.458575'}
2026-01-01 02:59:49,614 - DEBUG - Route Targets: ['target:64512:8000007']
2026-01-01 02:59:49,623 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72543752:service-right-vn-03729404', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72543752', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8459618716701576956', 'uuid-lslong': '13640191446971762016'}, 'enable': 'true', 'created': '2026-01-01T02:59:48', 'last-modified': '2026-01-01T02:59:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.476966'}
2026-01-01 02:59:49,631 - DEBUG - Route Targets: ['target:64512:8000007']
2026-01-01 02:59:49,637 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72543752:service-right-vn-03729404', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72543752', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8459618716701576956', 'uuid-lslong': '13640191446971762016'}, 'enable': 'true', 'created': '2026-01-01T02:59:48', 'last-modified': '2026-01-01T02:59:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.491298'}
2026-01-01 02:59:49,644 - DEBUG - Route Targets: ['target:64512:8000007']
2026-01-01 02:59:49,644 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-03729404 passed
2026-01-01 02:59:49,644 - DEBUG - ====Verifying policy data for service-right-vn-03729404 in API_Server ======
2026-01-01 02:59:49,644 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:49,653 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:49,671 - DEBUG - Requesting: http://10.0.0.38:8082/project/0890eefe-6fe3-458f-9ed8-8432b5f10ff3
2026-01-01 02:59:49,778 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/75669a66-e03e-4efc-bd4b-b1da2912c560
2026-01-01 02:59:49,790 - DEBUG - =>VN service-right-vn-03729404 has no policy to be verified
2026-01-01 02:59:49,790 - DEBUG - Verifying the vn in opserver
2026-01-01 02:59:49,790 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72543752:service-right-vn-03729404 virtual network link through opserver 10.0.0.38
2026-01-01 02:59:49,791 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-01-01 02:59:49,872 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72543752:service-right-vn-03729404', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72543752:service-right-vn-03729404?flat'}
2026-01-01 02:59:49,872 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72543752:service-right-vn-03729404 virtual network link through opserver 10.0.0.249
2026-01-01 02:59:49,872 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-01-01 02:59:49,947 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72543752:service-right-vn-03729404', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72543752:service-right-vn-03729404?flat'}
2026-01-01 02:59:49,947 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72543752:service-right-vn-03729404 virtual network link through opserver 10.0.0.27
2026-01-01 02:59:49,947 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-01-01 02:59:50,041 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72543752:service-right-vn-03729404', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72543752:service-right-vn-03729404?flat'}
2026-01-01 02:59:50,041 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-72543752:service-right-vn-03729404 is found in opserver
2026-01-01 02:59:50,065 - DEBUG - Do not have enough data to verify VN in agent
2026-01-01 02:59:50,076 - DEBUG - VRF ids for VN service-right-vn-03729404: {}
2026-01-01 02:59:50,143 - DEBUG - Services list from nova: [, , , ]
2026-01-01 02:59:51,240 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4945-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4945-1)
2026-01-01 02:59:52,638 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4945-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4945-2)
2026-01-01 02:59:52,640 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-19331915']
2026-01-01 02:59:52,938 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-19331915'] created succesfully
2026-01-01 02:59:53,326 - DEBUG - Image by name tiny_nat_fw not found
2026-01-01 02:59:53,326 - DEBUG - Installing image tiny_nat_fw
2026-01-01 02:59:53,326 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-01-01 02:59:53,327 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-01-01 02:59:53,327 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-01-01 02:59:53,327 - DEBUG - Unzip image
2026-01-01 02:59:53,327 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-01-01 02:59:53,354 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-01-01 02:59:53,354 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-19331915']
2026-01-01 02:59:53,455 - INFO - Service template: ['default-domain', 'ctest-service_template_1-19331915'] deleted successfully.
2026-01-01 02:59:53,455 - INFO - Skip interface_detach for VM ctest-right_vm-51946573 in state BUILD
2026-01-01 02:59:53,455 - INFO - Deleting VM ctest-right_vm-51946573
2026-01-01 02:59:53,494 - ERROR - VM ctest-right_vm-51946573 has failed to come up
2026-01-01 02:59:53,494 - ERROR - Nova failed to get host of the VM
2026-01-01 02:59:53,494 - ERROR - VM ctest-right_vm-51946573 has failed to come up
2026-01-01 02:59:53,494 - ERROR - Nova failed to get host of the VM
2026-01-01 02:59:53,679 - INFO - Skip interface_detach for VM ctest-left_vm-24795336 in state BUILD
2026-01-01 02:59:53,679 - INFO - Deleting VM ctest-left_vm-24795336
2026-01-01 02:59:53,679 - ERROR - VM ctest-left_vm-24795336 has failed to come up
2026-01-01 02:59:53,679 - ERROR - Nova failed to get host of the VM
2026-01-01 02:59:53,680 - ERROR - VM ctest-left_vm-24795336 has failed to come up
2026-01-01 02:59:53,680 - ERROR - Nova failed to get host of the VM
2026-01-01 02:59:53,783 - INFO - Deleting VN service-right-vn-03729404
2026-01-01 02:59:53,896 - DEBUG - VN 75669a66-e03e-4efc-bd4b-b1da2912c560 still in use: Unable to complete operation on network 75669a66-e03e-4efc-bd4b-b1da2912c560. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-ab539f66-17a5-4453-ab74-7fc700e7120e']
2026-01-01 02:59:53,896 - WARNING - Deleting VN service-right-vn-03729404 failed..Will retry
2026-01-01 02:59:56,061 - DEBUG - Response for deleting network ()
2026-01-01 02:59:56,061 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/7b9f21f3-a0d6-4960-a984-290b5e0229a0
2026-01-01 02:59:56,069 - DEBUG - Response Code: 404
2026-01-01 02:59:56,069 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:56,075 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:56,142 - DEBUG - Requesting: http://10.0.0.38:8082/project/0890eefe-6fe3-458f-9ed8-8432b5f10ff3
2026-01-01 02:59:56,229 - INFO - Validated that VN service-right-vn-03729404 is not found in API Server
2026-01-01 02:59:56,239 - DEBUG - VN service-right-vn-03729404 is not present in Agent 10.0.0.242
2026-01-01 02:59:56,251 - DEBUG - VN service-right-vn-03729404 is not present in Agent 10.0.0.23
2026-01-01 02:59:56,251 - INFO - Validated that VN service-right-vn-03729404 is not in any agent
2026-01-01 02:59:56,285 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-03729404 info
2026-01-01 02:59:56,285 - INFO - Deleting VN service-left-vn-54854627
2026-01-01 02:59:56,441 - DEBUG - Response for deleting network ()
2026-01-01 02:59:56,441 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/80582e5d-3139-4283-b548-7bc4131a82e9
2026-01-01 02:59:56,447 - DEBUG - Response Code: 404
2026-01-01 02:59:56,448 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:56,460 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:56,476 - DEBUG - Requesting: http://10.0.0.38:8082/project/0890eefe-6fe3-458f-9ed8-8432b5f10ff3
2026-01-01 02:59:56,576 - INFO - Validated that VN service-left-vn-54854627 is not found in API Server
2026-01-01 02:59:56,589 - DEBUG - VN service-left-vn-54854627 is not present in Agent 10.0.0.242
2026-01-01 02:59:56,602 - DEBUG - VN service-left-vn-54854627 is not present in Agent 10.0.0.23
2026-01-01 02:59:56,602 - INFO - Validated that VN service-left-vn-54854627 is not in any agent
2026-01-01 02:59:56,635 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-54854627 info
2026-01-01 02:59:56,635 - INFO - Deleting VN ctest-mgmt_vn-40435190
2026-01-01 02:59:56,785 - DEBUG - Response for deleting network ()
2026-01-01 02:59:56,785 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b2c9059f-6f98-42e3-8e80-407e92150d7c
2026-01-01 02:59:56,791 - DEBUG - Response Code: 404
2026-01-01 02:59:56,791 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 02:59:56,808 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 02:59:56,821 - DEBUG - Requesting: http://10.0.0.38:8082/project/0890eefe-6fe3-458f-9ed8-8432b5f10ff3
2026-01-01 02:59:56,909 - INFO - Validated that VN ctest-mgmt_vn-40435190 is not found in API Server
2026-01-01 02:59:56,921 - DEBUG - VN ctest-mgmt_vn-40435190 is not present in Agent 10.0.0.242
2026-01-01 02:59:56,932 - DEBUG - VN ctest-mgmt_vn-40435190 is not present in Agent 10.0.0.23
2026-01-01 02:59:56,932 - INFO - Validated that VN ctest-mgmt_vn-40435190 is not in any agent
2026-01-01 02:59:56,965 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-40435190 info
2026-01-01 02:59:58,240 - DEBUG - No XMPP flaps were noticed during the test
2026-01-01 02:59:58,240 - INFO -
2026-01-01 02:59:58,240 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:15]
2026-01-01 02:59:58,240 - INFO - --------------------------------------------------------------------------------
2026-01-01 02:59:58,243 - INFO - ================================================================================
2026-01-01 02:59:58,243 - INFO - STARTING TEST : test_svc_in_network_datapath
2026-01-01 02:59:59,514 - DEBUG - Nothing to compare xmpp stats {'10.0.0.242': {'10.20.0.14': '0', '10.20.0.18': '0'}, '10.0.0.23': {'10.20.0.14': '0', '10.20.0.18': '0'}} with
2026-01-01 02:59:59,514 - INFO - Initial checks done. Running the testcase now
2026-01-01 02:59:59,514 - INFO -
2026-01-01 02:59:59,820 - DEBUG - Response for create_network : {'network': {'id': 'febc26a7-f385-4119-bae3-67fb0c0c198c', 'name': 'ctest-mgmt_vn-88416480', 'tenant_id': '0890eefe6fe3458f9ed88432b5f10ff3', 'project_id': '0890eefe6fe3458f9ed88432b5f10ff3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-72543752', 'ctest-mgmt_vn-88416480'], 'port_security_enabled': True, 'description': ''}}
2026-01-01 03:00:00,120 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a41f71f1-902b-447d-86bf-f7af793b30ad', 'name': '', 'tenant_id': '0890eefe6fe3458f9ed88432b5f10ff3', 'network_id': 'febc26a7-f385-4119-bae3-67fb0c0c198c', 'ip_version': 4, 'cidr': '142.4.0.64/26', 'allocation_pools': [{'start': '142.4.0.66', 'end': '142.4.0.126'}], 'gateway_ip': '142.4.0.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '142.4.0.66', 'tags': [], 'project_id': '0890eefe6fe3458f9ed88432b5f10ff3'}}
2026-01-01 03:00:00,146 - INFO - Created VN ctest-mgmt_vn-88416480
2026-01-01 03:00:00,159 - DEBUG - VN ctest-mgmt_vn-88416480 UUID is febc26a7-f385-4119-bae3-67fb0c0c198c
2026-01-01 03:00:00,243 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 03:00:00,252 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 03:00:00,268 - DEBUG - Requesting: http://10.0.0.38:8082/project/0890eefe-6fe3-458f-9ed8-8432b5f10ff3
2026-01-01 03:00:00,379 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/febc26a7-f385-4119-bae3-67fb0c0c198c
2026-01-01 03:00:00,392 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/febc26a7-f385-4119-bae3-67fb0c0c198c
2026-01-01 03:00:00,404 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/0963fea4-b609-407b-9de3-a7d8bf4292f1
2026-01-01 03:00:00,421 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/0963fea4-b609-407b-9de3-a7d8bf4292f1
2026-01-01 03:00:00,431 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/91d5c057-b590-4cf2-93b0-56e4fbc90ebd
2026-01-01 03:00:00,440 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-01 03:00:00,440 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/febc26a7-f385-4119-bae3-67fb0c0c198c
2026-01-01 03:00:00,450 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/0963fea4-b609-407b-9de3-a7d8bf4292f1
2026-01-01 03:00:00,469 - INFO - Verified VN network id 14 for VN febc26a7-f385-4119-bae3-67fb0c0c198c
2026-01-01 03:00:00,469 - INFO - Verifications in API Server for VN ctest-mgmt_vn-88416480 passed
2026-01-01 03:00:00,469 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/febc26a7-f385-4119-bae3-67fb0c0c198c
2026-01-01 03:00:00,481 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/0963fea4-b609-407b-9de3-a7d8bf4292f1
2026-01-01 03:00:00,491 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/0963fea4-b609-407b-9de3-a7d8bf4292f1
2026-01-01 03:00:00,501 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/91d5c057-b590-4cf2-93b0-56e4fbc90ebd
2026-01-01 03:00:00,515 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-88416480', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72543752', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18355588684042289433', 'uuid-lslong': '13466721638704486796'}, 'enable': 'true', 'created': '2026-01-01T02:59:59', 'last-modified': '2026-01-01T03:00:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.458011'}
2026-01-01 03:00:00,522 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-01 03:00:00,530 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-88416480', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72543752', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18355588684042289433', 'uuid-lslong': '13466721638704486796'}, 'enable': 'true', 'created': '2026-01-01T02:59:59', 'last-modified': '2026-01-01T03:00:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.471092'}
2026-01-01 03:00:00,538 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-01 03:00:00,544 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-88416480', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72543752', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18355588684042289433', 'uuid-lslong': '13466721638704486796'}, 'enable': 'true', 'created': '2026-01-01T02:59:59', 'last-modified': '2026-01-01T03:00:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.486689'}
2026-01-01 03:00:00,554 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-01 03:00:00,554 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-88416480 passed
2026-01-01 03:00:00,554 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-88416480 in API_Server ======
2026-01-01 03:00:00,554 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 03:00:00,575 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 03:00:00,594 - DEBUG - Requesting: http://10.0.0.38:8082/project/0890eefe-6fe3-458f-9ed8-8432b5f10ff3
2026-01-01 03:00:00,713 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/febc26a7-f385-4119-bae3-67fb0c0c198c
2026-01-01 03:00:00,734 - DEBUG - =>VN ctest-mgmt_vn-88416480 has no policy to be verified
2026-01-01 03:00:00,734 - DEBUG - Verifying the vn in opserver
2026-01-01 03:00:00,734 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-88416480 virtual network link through opserver 10.0.0.38
2026-01-01 03:00:00,734 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-01-01 03:00:00,780 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-88416480', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-88416480?flat'}
2026-01-01 03:00:00,780 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-88416480 virtual network link through opserver 10.0.0.249
2026-01-01 03:00:00,780 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-01-01 03:00:00,806 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-88416480', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-88416480?flat'}
2026-01-01 03:00:00,806 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-88416480 virtual network link through opserver 10.0.0.27
2026-01-01 03:00:00,806 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-01-01 03:00:00,840 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-88416480', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-88416480?flat'}
2026-01-01 03:00:00,840 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-72543752:ctest-mgmt_vn-88416480 is found in opserver
2026-01-01 03:00:00,870 - DEBUG - Do not have enough data to verify VN in agent
2026-01-01 03:00:00,887 - DEBUG - VRF ids for VN ctest-mgmt_vn-88416480: {}
2026-01-01 03:00:01,251 - DEBUG - Response for create_network : {'network': {'id': '52dfe836-2597-48e7-b5ac-0c6d86257897', 'name': 'ctest-left_vn-07632142', 'tenant_id': '0890eefe6fe3458f9ed88432b5f10ff3', 'project_id': '0890eefe6fe3458f9ed88432b5f10ff3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-72543752', 'ctest-left_vn-07632142'], 'port_security_enabled': True, 'description': ''}}
2026-01-01 03:00:01,516 - DEBUG - Response for create_subnet : {'subnet': {'id': '403f1732-9ce8-43e1-bed3-3af827dd3c7f', 'name': '', 'tenant_id': '0890eefe6fe3458f9ed88432b5f10ff3', 'network_id': '52dfe836-2597-48e7-b5ac-0c6d86257897', 'ip_version': 4, 'cidr': '208.233.66.192/26', 'allocation_pools': [{'start': '208.233.66.194', 'end': '208.233.66.254'}], 'gateway_ip': '208.233.66.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '208.233.66.194', 'tags': [], 'project_id': '0890eefe6fe3458f9ed88432b5f10ff3'}}
2026-01-01 03:00:01,541 - INFO - Created VN ctest-left_vn-07632142
2026-01-01 03:00:01,553 - DEBUG - VN ctest-left_vn-07632142 UUID is 52dfe836-2597-48e7-b5ac-0c6d86257897
2026-01-01 03:00:01,639 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 03:00:01,647 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 03:00:01,663 - DEBUG - Requesting: http://10.0.0.38:8082/project/0890eefe-6fe3-458f-9ed8-8432b5f10ff3
2026-01-01 03:00:01,774 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/52dfe836-2597-48e7-b5ac-0c6d86257897
2026-01-01 03:00:01,790 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/52dfe836-2597-48e7-b5ac-0c6d86257897
2026-01-01 03:00:01,803 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/983d7258-6bed-4738-bf99-92dfd5f6390c
2026-01-01 03:00:01,813 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/983d7258-6bed-4738-bf99-92dfd5f6390c
2026-01-01 03:00:01,824 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/47b24444-8f68-46f9-8e29-2b54c450a3ae
2026-01-01 03:00:01,833 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-01 03:00:01,833 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/52dfe836-2597-48e7-b5ac-0c6d86257897
2026-01-01 03:00:01,845 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/983d7258-6bed-4738-bf99-92dfd5f6390c
2026-01-01 03:00:01,864 - INFO - Verified VN network id 15 for VN 52dfe836-2597-48e7-b5ac-0c6d86257897
2026-01-01 03:00:01,864 - INFO - Verifications in API Server for VN ctest-left_vn-07632142 passed
2026-01-01 03:00:01,864 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/52dfe836-2597-48e7-b5ac-0c6d86257897
2026-01-01 03:00:01,877 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/983d7258-6bed-4738-bf99-92dfd5f6390c
2026-01-01 03:00:01,893 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/983d7258-6bed-4738-bf99-92dfd5f6390c
2026-01-01 03:00:01,905 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/47b24444-8f68-46f9-8e29-2b54c450a3ae
2026-01-01 03:00:01,929 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72543752:ctest-left_vn-07632142', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72543752', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5971746950173116647', 'uuid-lslong': '13090851881400760471'}, 'enable': 'true', 'created': '2026-01-01T03:00:01', 'last-modified': '2026-01-01T03:00:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.473744'}
2026-01-01 03:00:01,938 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-01 03:00:01,945 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72543752:ctest-left_vn-07632142', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72543752', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5971746950173116647', 'uuid-lslong': '13090851881400760471'}, 'enable': 'true', 'created': '2026-01-01T03:00:01', 'last-modified': '2026-01-01T03:00:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.491611'}
2026-01-01 03:00:01,952 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-01 03:00:01,959 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72543752:ctest-left_vn-07632142', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72543752', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5971746950173116647', 'uuid-lslong': '13090851881400760471'}, 'enable': 'true', 'created': '2026-01-01T03:00:01', 'last-modified': '2026-01-01T03:00:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.502632'}
2026-01-01 03:00:01,966 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-01 03:00:01,966 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-07632142 passed
2026-01-01 03:00:01,966 - DEBUG - ====Verifying policy data for ctest-left_vn-07632142 in API_Server ======
2026-01-01 03:00:01,966 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 03:00:01,975 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 03:00:01,990 - DEBUG - Requesting: http://10.0.0.38:8082/project/0890eefe-6fe3-458f-9ed8-8432b5f10ff3
2026-01-01 03:00:02,102 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/52dfe836-2597-48e7-b5ac-0c6d86257897
2026-01-01 03:00:02,116 - DEBUG - =>VN ctest-left_vn-07632142 has no policy to be verified
2026-01-01 03:00:02,116 - DEBUG - Verifying the vn in opserver
2026-01-01 03:00:02,116 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72543752:ctest-left_vn-07632142 virtual network link through opserver 10.0.0.38
2026-01-01 03:00:02,116 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-01-01 03:00:02,128 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72543752:ctest-left_vn-07632142', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72543752:ctest-left_vn-07632142?flat'}
2026-01-01 03:00:02,128 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72543752:ctest-left_vn-07632142 virtual network link through opserver 10.0.0.249
2026-01-01 03:00:02,128 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-01-01 03:00:02,142 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72543752:ctest-left_vn-07632142', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72543752:ctest-left_vn-07632142?flat'}
2026-01-01 03:00:02,142 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72543752:ctest-left_vn-07632142 virtual network link through opserver 10.0.0.27
2026-01-01 03:00:02,142 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-01-01 03:00:02,156 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72543752:ctest-left_vn-07632142', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72543752:ctest-left_vn-07632142?flat'}
2026-01-01 03:00:02,156 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-72543752:ctest-left_vn-07632142 is found in opserver
2026-01-01 03:00:02,181 - DEBUG - Do not have enough data to verify VN in agent
2026-01-01 03:00:02,194 - DEBUG - VRF ids for VN ctest-left_vn-07632142: {}
2026-01-01 03:00:02,492 - DEBUG - Response for create_network : {'network': {'id': '4549c4aa-57e2-4fc6-a57e-84ab88206e94', 'name': 'ctest-right_vn-76916781', 'tenant_id': '0890eefe6fe3458f9ed88432b5f10ff3', 'project_id': '0890eefe6fe3458f9ed88432b5f10ff3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-72543752', 'ctest-right_vn-76916781'], 'port_security_enabled': True, 'description': ''}}
2026-01-01 03:00:02,743 - DEBUG - Response for create_subnet : {'subnet': {'id': '3bcaea33-a830-40a7-87c4-9b430c138ef5', 'name': '', 'tenant_id': '0890eefe6fe3458f9ed88432b5f10ff3', 'network_id': '4549c4aa-57e2-4fc6-a57e-84ab88206e94', 'ip_version': 4, 'cidr': '59.93.55.128/26', 'allocation_pools': [{'start': '59.93.55.130', 'end': '59.93.55.190'}], 'gateway_ip': '59.93.55.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '59.93.55.130', 'tags': [], 'project_id': '0890eefe6fe3458f9ed88432b5f10ff3'}}
2026-01-01 03:00:02,773 - INFO - Created VN ctest-right_vn-76916781
2026-01-01 03:00:02,788 - DEBUG - VN ctest-right_vn-76916781 UUID is 4549c4aa-57e2-4fc6-a57e-84ab88206e94
2026-01-01 03:00:02,885 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 03:00:02,896 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 03:00:02,909 - DEBUG - Requesting: http://10.0.0.38:8082/project/0890eefe-6fe3-458f-9ed8-8432b5f10ff3
2026-01-01 03:00:03,016 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/4549c4aa-57e2-4fc6-a57e-84ab88206e94
2026-01-01 03:00:03,031 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/4549c4aa-57e2-4fc6-a57e-84ab88206e94
2026-01-01 03:00:03,043 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/c9f5d5d2-e924-4ac8-8190-9073ca73e5e5
2026-01-01 03:00:03,052 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/c9f5d5d2-e924-4ac8-8190-9073ca73e5e5
2026-01-01 03:00:03,062 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/7f026601-997f-48b1-a36b-a2f9e2671bf7
2026-01-01 03:00:03,069 - DEBUG - Route Targets: ['target:64512:8000007']
2026-01-01 03:00:03,069 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/4549c4aa-57e2-4fc6-a57e-84ab88206e94
2026-01-01 03:00:03,079 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/c9f5d5d2-e924-4ac8-8190-9073ca73e5e5
2026-01-01 03:00:03,097 - INFO - Verified VN network id 16 for VN 4549c4aa-57e2-4fc6-a57e-84ab88206e94
2026-01-01 03:00:03,098 - INFO - Verifications in API Server for VN ctest-right_vn-76916781 passed
2026-01-01 03:00:03,099 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/4549c4aa-57e2-4fc6-a57e-84ab88206e94
2026-01-01 03:00:03,112 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/c9f5d5d2-e924-4ac8-8190-9073ca73e5e5
2026-01-01 03:00:03,122 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/c9f5d5d2-e924-4ac8-8190-9073ca73e5e5
2026-01-01 03:00:03,132 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/7f026601-997f-48b1-a36b-a2f9e2671bf7
2026-01-01 03:00:03,148 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72543752:ctest-right_vn-76916781', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72543752', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4992737897814839238', 'uuid-lslong': '11925114735581752980'}, 'enable': 'true', 'created': '2026-01-01T03:00:02', 'last-modified': '2026-01-01T03:00:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.495732'}
2026-01-01 03:00:03,156 - DEBUG - Route Targets: ['target:64512:8000007']
2026-01-01 03:00:03,163 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72543752:ctest-right_vn-76916781', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72543752', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4992737897814839238', 'uuid-lslong': '11925114735581752980'}, 'enable': 'true', 'created': '2026-01-01T03:00:02', 'last-modified': '2026-01-01T03:00:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.511487'}
2026-01-01 03:00:03,170 - DEBUG - Route Targets: ['target:64512:8000007']
2026-01-01 03:00:03,178 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72543752:ctest-right_vn-76916781', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72543752', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4992737897814839238', 'uuid-lslong': '11925114735581752980'}, 'enable': 'true', 'created': '2026-01-01T03:00:02', 'last-modified': '2026-01-01T03:00:02', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.525495'}
2026-01-01 03:00:03,186 - DEBUG - Route Targets: ['target:64512:8000007']
2026-01-01 03:00:03,186 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-76916781 passed
2026-01-01 03:00:03,187 - DEBUG - ====Verifying policy data for ctest-right_vn-76916781 in API_Server ======
2026-01-01 03:00:03,187 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 03:00:03,195 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 03:00:03,213 - DEBUG - Requesting: http://10.0.0.38:8082/project/0890eefe-6fe3-458f-9ed8-8432b5f10ff3
2026-01-01 03:00:03,316 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/4549c4aa-57e2-4fc6-a57e-84ab88206e94
2026-01-01 03:00:03,335 - DEBUG - =>VN ctest-right_vn-76916781 has no policy to be verified
2026-01-01 03:00:03,335 - DEBUG - Verifying the vn in opserver
2026-01-01 03:00:03,336 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72543752:ctest-right_vn-76916781 virtual network link through opserver 10.0.0.38
2026-01-01 03:00:03,336 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-01-01 03:00:03,351 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72543752:ctest-right_vn-76916781', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72543752:ctest-right_vn-76916781?flat'}
2026-01-01 03:00:03,351 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72543752:ctest-right_vn-76916781 virtual network link through opserver 10.0.0.249
2026-01-01 03:00:03,351 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-01-01 03:00:03,369 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72543752:ctest-right_vn-76916781', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72543752:ctest-right_vn-76916781?flat'}
2026-01-01 03:00:03,369 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72543752:ctest-right_vn-76916781 virtual network link through opserver 10.0.0.27
2026-01-01 03:00:03,369 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-01-01 03:00:03,384 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72543752:ctest-right_vn-76916781', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72543752:ctest-right_vn-76916781?flat'}
2026-01-01 03:00:03,384 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-72543752:ctest-right_vn-76916781 is found in opserver
2026-01-01 03:00:03,412 - DEBUG - Do not have enough data to verify VN in agent
2026-01-01 03:00:03,426 - DEBUG - VRF ids for VN ctest-right_vn-76916781: {}
2026-01-01 03:00:04,553 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4945-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4945-2)
2026-01-01 03:00:06,061 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4945-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4945-1)
2026-01-01 03:00:06,061 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-21227809']
2026-01-01 03:00:06,393 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-21227809'] created succesfully
2026-01-01 03:00:06,789 - DEBUG - Image by name tiny_nat_fw not found
2026-01-01 03:00:06,789 - DEBUG - Installing image tiny_nat_fw
2026-01-01 03:00:06,789 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-01-01 03:00:06,790 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-01-01 03:00:06,790 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-01-01 03:00:06,790 - DEBUG - Unzip image
2026-01-01 03:00:06,790 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-01-01 03:00:06,815 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-01-01 03:00:06,817 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-21227809']
2026-01-01 03:00:06,926 - INFO - Service template: ['default-domain', 'ctest-service_template_1-21227809'] deleted successfully.
2026-01-01 03:00:06,927 - INFO - Skip interface_detach for VM ctest-right_vm-13638181 in state BUILD
2026-01-01 03:00:06,927 - INFO - Deleting VM ctest-right_vm-13638181
2026-01-01 03:00:06,927 - ERROR - VM ctest-right_vm-13638181 has failed to come up
2026-01-01 03:00:06,928 - ERROR - Nova failed to get host of the VM
2026-01-01 03:00:06,928 - ERROR - VM ctest-right_vm-13638181 has failed to come up
2026-01-01 03:00:06,928 - ERROR - Nova failed to get host of the VM
2026-01-01 03:00:07,040 - INFO - Skip interface_detach for VM ctest-left_vm-94974480 in state BUILD
2026-01-01 03:00:07,040 - INFO - Deleting VM ctest-left_vm-94974480
2026-01-01 03:00:07,041 - ERROR - VM ctest-left_vm-94974480 has failed to come up
2026-01-01 03:00:07,041 - ERROR - Nova failed to get host of the VM
2026-01-01 03:00:07,041 - ERROR - VM ctest-left_vm-94974480 has failed to come up
2026-01-01 03:00:07,041 - ERROR - Nova failed to get host of the VM
2026-01-01 03:00:07,126 - INFO - Deleting VN ctest-right_vn-76916781
2026-01-01 03:00:07,179 - DEBUG - VN 4549c4aa-57e2-4fc6-a57e-84ab88206e94 still in use: Unable to complete operation on network 4549c4aa-57e2-4fc6-a57e-84ab88206e94. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-1879bc03-918e-4555-945a-134223b11e0d']
2026-01-01 03:00:07,179 - WARNING - Deleting VN ctest-right_vn-76916781 failed..Will retry
2026-01-01 03:00:09,397 - DEBUG - Response for deleting network ()
2026-01-01 03:00:09,398 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/c9f5d5d2-e924-4ac8-8190-9073ca73e5e5
2026-01-01 03:00:09,414 - DEBUG - Response Code: 404
2026-01-01 03:00:09,414 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 03:00:09,420 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 03:00:09,442 - DEBUG - Requesting: http://10.0.0.38:8082/project/0890eefe-6fe3-458f-9ed8-8432b5f10ff3
2026-01-01 03:00:09,554 - INFO - Validated that VN ctest-right_vn-76916781 is not found in API Server
2026-01-01 03:00:09,566 - DEBUG - VN ctest-right_vn-76916781 is not present in Agent 10.0.0.242
2026-01-01 03:00:09,582 - DEBUG - VN ctest-right_vn-76916781 is not present in Agent 10.0.0.23
2026-01-01 03:00:09,582 - INFO - Validated that VN ctest-right_vn-76916781 is not in any agent
2026-01-01 03:00:09,627 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-76916781 info
2026-01-01 03:00:09,627 - INFO - Deleting VN ctest-left_vn-07632142
2026-01-01 03:00:09,793 - DEBUG - Response for deleting network ()
2026-01-01 03:00:09,793 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/983d7258-6bed-4738-bf99-92dfd5f6390c
2026-01-01 03:00:09,799 - DEBUG - Response Code: 404
2026-01-01 03:00:09,800 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 03:00:09,811 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 03:00:09,825 - DEBUG - Requesting: http://10.0.0.38:8082/project/0890eefe-6fe3-458f-9ed8-8432b5f10ff3
2026-01-01 03:00:09,916 - INFO - Validated that VN ctest-left_vn-07632142 is not found in API Server
2026-01-01 03:00:09,929 - DEBUG - VN ctest-left_vn-07632142 is not present in Agent 10.0.0.242
2026-01-01 03:00:09,944 - DEBUG - VN ctest-left_vn-07632142 is not present in Agent 10.0.0.23
2026-01-01 03:00:09,944 - INFO - Validated that VN ctest-left_vn-07632142 is not in any agent
2026-01-01 03:00:09,980 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-07632142 info
2026-01-01 03:00:09,981 - INFO - Deleting VN ctest-mgmt_vn-88416480
2026-01-01 03:00:10,159 - DEBUG - Response for deleting network ()
2026-01-01 03:00:10,159 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/0963fea4-b609-407b-9de3-a7d8bf4292f1
2026-01-01 03:00:10,166 - DEBUG - Response Code: 404
2026-01-01 03:00:10,166 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-01-01 03:00:10,181 - DEBUG - Requesting: http://10.0.0.38:8082/domain/b5800509-dc40-4626-b491-badce4b95394
2026-01-01 03:00:10,237 - DEBUG - Requesting: http://10.0.0.38:8082/project/0890eefe-6fe3-458f-9ed8-8432b5f10ff3
2026-01-01 03:00:10,333 - INFO - Validated that VN ctest-mgmt_vn-88416480 is not found in API Server
2026-01-01 03:00:10,345 - DEBUG - VN ctest-mgmt_vn-88416480 is not present in Agent 10.0.0.242
2026-01-01 03:00:10,358 - DEBUG - VN ctest-mgmt_vn-88416480 is not present in Agent 10.0.0.23
2026-01-01 03:00:10,358 - INFO - Validated that VN ctest-mgmt_vn-88416480 is not in any agent
2026-01-01 03:00:10,394 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-88416480 info
2026-01-01 03:00:11,671 - DEBUG - No XMPP flaps were noticed during the test
2026-01-01 03:00:11,671 - INFO -
2026-01-01 03:00:11,671 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:13]
2026-01-01 03:00:11,671 - INFO - --------------------------------------------------------------------------------
2026-01-01 03:00:12,466 - INFO - Deleted project: ctest-TestSvcRegr-72543752, ID : 0890eefe-6fe3-458f-9ed8-8432b5f10ff3