]) created on node: (an-jenkins-deploy-platform-ansible-os-5740-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5740-1)
2026-05-04 03:32:18,693 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-67558808']
2026-05-04 03:32:19,020 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-67558808'] created succesfully
2026-05-04 03:32:19,559 - DEBUG - Image by name tiny_nat_fw not found
2026-05-04 03:32:19,559 - DEBUG - Installing image tiny_nat_fw
2026-05-04 03:32:19,559 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-05-04 03:32:19,560 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-05-04 03:32:19,560 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz
2026-05-04 03:32:19,603 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/tinycore//tinycore-in-network-nat.qcow2.gz -O /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-04 03:32:19,684 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-04 03:32:19,684 - DEBUG - Unzip image
2026-05-04 03:32:19,684 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-04 03:32:19,704 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-05-04 03:32:19,705 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-67558808']
2026-05-04 03:32:19,801 - INFO - Service template: ['default-domain', 'ctest-service_template_1-67558808'] deleted successfully.
2026-05-04 03:32:19,801 - INFO - Skip interface_detach for VM ctest-right_vm-02838427 in state BUILD
2026-05-04 03:32:19,801 - INFO - Deleting VM ctest-right_vm-02838427
2026-05-04 03:32:19,831 - ERROR - VM ctest-right_vm-02838427 has failed to come up
2026-05-04 03:32:19,831 - ERROR - Nova failed to get host of the VM
2026-05-04 03:32:19,832 - ERROR - VM ctest-right_vm-02838427 has failed to come up
2026-05-04 03:32:19,832 - ERROR - Nova failed to get host of the VM
2026-05-04 03:32:19,899 - INFO - Skip interface_detach for VM ctest-left_vm-86810094 in state BUILD
2026-05-04 03:32:19,899 - INFO - Deleting VM ctest-left_vm-86810094
2026-05-04 03:32:19,899 - ERROR - VM ctest-left_vm-86810094 has failed to come up
2026-05-04 03:32:19,899 - ERROR - Nova failed to get host of the VM
2026-05-04 03:32:19,899 - ERROR - VM ctest-left_vm-86810094 has failed to come up
2026-05-04 03:32:19,899 - ERROR - Nova failed to get host of the VM
2026-05-04 03:32:19,972 - INFO - Deleting VN ctest-right_vn-54846619
2026-05-04 03:32:20,020 - DEBUG - VN 5a0a01a7-ab28-4795-8bc1-93f3af4c70f0 still in use: Unable to complete operation on network 5a0a01a7-ab28-4795-8bc1-93f3af4c70f0. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-b0ee606b-a4b4-402c-b4b1-ea8ce2c96bc4']
2026-05-04 03:32:20,020 - WARNING - Deleting VN ctest-right_vn-54846619 failed..Will retry
2026-05-04 03:32:22,215 - DEBUG - Response for deleting network ()
2026-05-04 03:32:22,215 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/187f22e1-ef13-4703-b772-6ff5cfa90477
2026-05-04 03:32:22,222 - DEBUG - Response Code: 404
2026-05-04 03:32:22,223 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:22,230 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:22,261 - DEBUG - Requesting: http://10.0.0.129:8082/project/107ddf4a-cd58-42de-ba90-b7d7550eddad
2026-05-04 03:32:22,384 - INFO - Validated that VN ctest-right_vn-54846619 is not found in API Server
2026-05-04 03:32:22,401 - DEBUG - VN ctest-right_vn-54846619 is not present in Agent 10.0.0.41
2026-05-04 03:32:22,415 - DEBUG - VN ctest-right_vn-54846619 is not present in Agent 10.0.0.141
2026-05-04 03:32:22,415 - INFO - Validated that VN ctest-right_vn-54846619 is not in any agent
2026-05-04 03:32:22,473 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-54846619 info
2026-05-04 03:32:22,473 - INFO - Deleting VN ctest-left_vn-07155593
2026-05-04 03:32:22,725 - DEBUG - Response for deleting network ()
2026-05-04 03:32:22,725 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/14951fa3-b2ce-4949-a56f-0376d108fbfd
2026-05-04 03:32:22,737 - DEBUG - Response Code: 404
2026-05-04 03:32:22,737 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:22,749 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:22,778 - DEBUG - Requesting: http://10.0.0.129:8082/project/107ddf4a-cd58-42de-ba90-b7d7550eddad
2026-05-04 03:32:22,894 - INFO - Validated that VN ctest-left_vn-07155593 is not found in API Server
2026-05-04 03:32:22,926 - DEBUG - VN ctest-left_vn-07155593 is not present in Agent 10.0.0.41
2026-05-04 03:32:22,942 - DEBUG - VN ctest-left_vn-07155593 is not present in Agent 10.0.0.141
2026-05-04 03:32:22,942 - INFO - Validated that VN ctest-left_vn-07155593 is not in any agent
2026-05-04 03:32:23,022 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-07155593 info
2026-05-04 03:32:23,022 - INFO - Deleting VN ctest-mgmt_vn-85484803
2026-05-04 03:32:23,246 - DEBUG - Response for deleting network ()
2026-05-04 03:32:23,246 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/f20baf3c-a959-4b70-bc25-c01b9b2a4e0f
2026-05-04 03:32:23,255 - DEBUG - Response Code: 404
2026-05-04 03:32:23,255 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:23,277 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:23,299 - DEBUG - Requesting: http://10.0.0.129:8082/project/107ddf4a-cd58-42de-ba90-b7d7550eddad
2026-05-04 03:32:23,410 - INFO - Validated that VN ctest-mgmt_vn-85484803 is not found in API Server
2026-05-04 03:32:23,435 - DEBUG - VN ctest-mgmt_vn-85484803 is not present in Agent 10.0.0.41
2026-05-04 03:32:23,447 - DEBUG - VN ctest-mgmt_vn-85484803 is not present in Agent 10.0.0.141
2026-05-04 03:32:23,447 - INFO - Validated that VN ctest-mgmt_vn-85484803 is not in any agent
2026-05-04 03:32:23,490 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-85484803 info
2026-05-04 03:32:23,490 - INFO - Deleting VM ctest-vm-in-third-vn-14941316
2026-05-04 03:32:23,577 - INFO - Deleting VN ctest-third-vn-21491879
2026-05-04 03:32:23,634 - DEBUG - VN b2a2414c-4cea-40c8-864f-1dc6ac1f64f3 still in use: Unable to complete operation on network b2a2414c-4cea-40c8-864f-1dc6ac1f64f3. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-0756a146-bb9d-45b0-b62b-20c31553ec37']
2026-05-04 03:32:23,634 - WARNING - Deleting VN ctest-third-vn-21491879 failed..Will retry
2026-05-04 03:32:25,818 - DEBUG - Response for deleting network ()
2026-05-04 03:32:27,125 - DEBUG - No XMPP flaps were noticed during the test
2026-05-04 03:32:27,126 - INFO -
2026-05-04 03:32:27,126 - INFO - END TEST : test_svc_in_net_nat_with_static_routes : SKIPPED[0:00:26]
2026-05-04 03:32:27,126 - INFO - --------------------------------------------------------------------------------
2026-05-04 03:32:27,130 - INFO - ================================================================================
2026-05-04 03:32:27,130 - INFO - STARTING TEST : test_svc_v2_transparent_datapath
2026-05-04 03:32:28,435 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.193': '0', '10.20.0.129': '0'}, '10.0.0.141': {'10.20.0.18': '0', '10.20.0.193': '0'}} with
2026-05-04 03:32:28,435 - INFO - Initial checks done. Running the testcase now
2026-05-04 03:32:28,435 - INFO -
2026-05-04 03:32:28,744 - DEBUG - Response for create_network : {'network': {'id': '2f1eb57f-68db-4bfb-b6a6-a57db2ac7a90', 'name': 'ctest-mgmt_vn-94793597', 'tenant_id': '107ddf4acd5842deba90b7d7550eddad', 'project_id': '107ddf4acd5842deba90b7d7550eddad', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-09426257', 'ctest-mgmt_vn-94793597'], 'port_security_enabled': True, 'description': ''}}
2026-05-04 03:32:29,024 - DEBUG - Response for create_subnet : {'subnet': {'id': '6f8e26f3-c37e-4f91-b569-4cf9fe7f812a', 'name': '', 'tenant_id': '107ddf4acd5842deba90b7d7550eddad', 'network_id': '2f1eb57f-68db-4bfb-b6a6-a57db2ac7a90', 'ip_version': 4, 'cidr': '169.82.237.192/26', 'allocation_pools': [{'start': '169.82.237.194', 'end': '169.82.237.254'}], 'gateway_ip': '169.82.237.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '169.82.237.194', 'tags': [], 'project_id': '107ddf4acd5842deba90b7d7550eddad'}}
2026-05-04 03:32:29,048 - INFO - Created VN ctest-mgmt_vn-94793597
2026-05-04 03:32:29,063 - DEBUG - VN ctest-mgmt_vn-94793597 UUID is 2f1eb57f-68db-4bfb-b6a6-a57db2ac7a90
2026-05-04 03:32:29,152 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:29,158 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:29,169 - DEBUG - Requesting: http://10.0.0.129:8082/project/107ddf4a-cd58-42de-ba90-b7d7550eddad
2026-05-04 03:32:29,263 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/2f1eb57f-68db-4bfb-b6a6-a57db2ac7a90
2026-05-04 03:32:29,281 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/2f1eb57f-68db-4bfb-b6a6-a57db2ac7a90
2026-05-04 03:32:29,290 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/0b31e4cb-c412-4ab5-908d-50d8a7c3ba8e
2026-05-04 03:32:29,300 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/0b31e4cb-c412-4ab5-908d-50d8a7c3ba8e
2026-05-04 03:32:29,310 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/bb7e112a-777c-4834-8a6f-f17f46127010
2026-05-04 03:32:29,317 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-04 03:32:29,317 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/2f1eb57f-68db-4bfb-b6a6-a57db2ac7a90
2026-05-04 03:32:29,327 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/0b31e4cb-c412-4ab5-908d-50d8a7c3ba8e
2026-05-04 03:32:29,345 - INFO - Verified VN network id 14 for VN 2f1eb57f-68db-4bfb-b6a6-a57db2ac7a90
2026-05-04 03:32:29,346 - INFO - Verifications in API Server for VN ctest-mgmt_vn-94793597 passed
2026-05-04 03:32:29,346 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/2f1eb57f-68db-4bfb-b6a6-a57db2ac7a90
2026-05-04 03:32:29,361 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/0b31e4cb-c412-4ab5-908d-50d8a7c3ba8e
2026-05-04 03:32:29,371 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/0b31e4cb-c412-4ab5-908d-50d8a7c3ba8e
2026-05-04 03:32:29,379 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/bb7e112a-777c-4834-8a6f-f17f46127010
2026-05-04 03:32:29,391 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09426257:ctest-mgmt_vn-94793597', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09426257', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3395350727908609019', 'uuid-lslong': '13161388920323996304'}, 'enable': 'true', 'created': '2026-05-04T03:32:28', 'last-modified': '2026-05-04T03:32:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.432247'}
2026-05-04 03:32:29,399 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-04 03:32:29,405 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09426257:ctest-mgmt_vn-94793597', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09426257', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3395350727908609019', 'uuid-lslong': '13161388920323996304'}, 'enable': 'true', 'created': '2026-05-04T03:32:28', 'last-modified': '2026-05-04T03:32:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.446376'}
2026-05-04 03:32:29,411 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-04 03:32:29,417 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09426257:ctest-mgmt_vn-94793597', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09426257', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3395350727908609019', 'uuid-lslong': '13161388920323996304'}, 'enable': 'true', 'created': '2026-05-04T03:32:28', 'last-modified': '2026-05-04T03:32:28', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.453315'}
2026-05-04 03:32:29,422 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-04 03:32:29,422 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-94793597 passed
2026-05-04 03:32:29,423 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-94793597 in API_Server ======
2026-05-04 03:32:29,423 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:29,430 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:29,441 - DEBUG - Requesting: http://10.0.0.129:8082/project/107ddf4a-cd58-42de-ba90-b7d7550eddad
2026-05-04 03:32:29,545 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/2f1eb57f-68db-4bfb-b6a6-a57db2ac7a90
2026-05-04 03:32:29,558 - DEBUG - =>VN ctest-mgmt_vn-94793597 has no policy to be verified
2026-05-04 03:32:29,558 - DEBUG - Verifying the vn in opserver
2026-05-04 03:32:29,558 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09426257:ctest-mgmt_vn-94793597 virtual network link through opserver 10.0.0.129
2026-05-04 03:32:29,558 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2026-05-04 03:32:29,573 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09426257:ctest-mgmt_vn-94793597', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09426257:ctest-mgmt_vn-94793597?flat'}
2026-05-04 03:32:29,573 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09426257:ctest-mgmt_vn-94793597 virtual network link through opserver 10.0.0.50
2026-05-04 03:32:29,574 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-05-04 03:32:29,590 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09426257:ctest-mgmt_vn-94793597', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09426257:ctest-mgmt_vn-94793597?flat'}
2026-05-04 03:32:29,590 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09426257:ctest-mgmt_vn-94793597 virtual network link through opserver 10.0.0.249
2026-05-04 03:32:29,590 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-04 03:32:29,607 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09426257:ctest-mgmt_vn-94793597', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09426257:ctest-mgmt_vn-94793597?flat'}
2026-05-04 03:32:29,607 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-09426257:ctest-mgmt_vn-94793597 is found in opserver
2026-05-04 03:32:29,632 - DEBUG - Do not have enough data to verify VN in agent
2026-05-04 03:32:29,647 - DEBUG - VRF ids for VN ctest-mgmt_vn-94793597: {}
2026-05-04 03:32:29,932 - DEBUG - Response for create_network : {'network': {'id': '970de11d-c143-4b1f-a2e8-cbc4cabac676', 'name': 'ctest-left_vn-72127539', 'tenant_id': '107ddf4acd5842deba90b7d7550eddad', 'project_id': '107ddf4acd5842deba90b7d7550eddad', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-09426257', 'ctest-left_vn-72127539'], 'port_security_enabled': True, 'description': ''}}
2026-05-04 03:32:30,250 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd54a15f8-5b5c-4a90-a92a-d11063f7f758', 'name': '', 'tenant_id': '107ddf4acd5842deba90b7d7550eddad', 'network_id': '970de11d-c143-4b1f-a2e8-cbc4cabac676', 'ip_version': 4, 'cidr': '72.0.136.128/26', 'allocation_pools': [{'start': '72.0.136.130', 'end': '72.0.136.190'}], 'gateway_ip': '72.0.136.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '72.0.136.130', 'tags': [], 'project_id': '107ddf4acd5842deba90b7d7550eddad'}}
2026-05-04 03:32:30,275 - INFO - Created VN ctest-left_vn-72127539
2026-05-04 03:32:30,291 - DEBUG - VN ctest-left_vn-72127539 UUID is 970de11d-c143-4b1f-a2e8-cbc4cabac676
2026-05-04 03:32:30,372 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:30,379 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:30,391 - DEBUG - Requesting: http://10.0.0.129:8082/project/107ddf4a-cd58-42de-ba90-b7d7550eddad
2026-05-04 03:32:30,489 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/970de11d-c143-4b1f-a2e8-cbc4cabac676
2026-05-04 03:32:30,502 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/970de11d-c143-4b1f-a2e8-cbc4cabac676
2026-05-04 03:32:30,513 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/160ae253-886c-4ca2-803d-5fe5f825b4b7
2026-05-04 03:32:30,521 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/160ae253-886c-4ca2-803d-5fe5f825b4b7
2026-05-04 03:32:30,530 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/66337fe8-e99d-4d76-a34e-7f8305712fa0
2026-05-04 03:32:30,538 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-04 03:32:30,538 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/970de11d-c143-4b1f-a2e8-cbc4cabac676
2026-05-04 03:32:30,550 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/160ae253-886c-4ca2-803d-5fe5f825b4b7
2026-05-04 03:32:30,572 - INFO - Verified VN network id 15 for VN 970de11d-c143-4b1f-a2e8-cbc4cabac676
2026-05-04 03:32:30,572 - INFO - Verifications in API Server for VN ctest-left_vn-72127539 passed
2026-05-04 03:32:30,572 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/970de11d-c143-4b1f-a2e8-cbc4cabac676
2026-05-04 03:32:30,583 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/160ae253-886c-4ca2-803d-5fe5f825b4b7
2026-05-04 03:32:30,592 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/160ae253-886c-4ca2-803d-5fe5f825b4b7
2026-05-04 03:32:30,601 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/66337fe8-e99d-4d76-a34e-7f8305712fa0
2026-05-04 03:32:30,614 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09426257:ctest-left_vn-72127539', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09426257', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10884603392337070879', 'uuid-lslong': '11738856474816464502'}, 'enable': 'true', 'created': '2026-05-04T03:32:29', 'last-modified': '2026-05-04T03:32:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.432981'}
2026-05-04 03:32:30,623 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-04 03:32:30,630 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09426257:ctest-left_vn-72127539', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09426257', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10884603392337070879', 'uuid-lslong': '11738856474816464502'}, 'enable': 'true', 'created': '2026-05-04T03:32:29', 'last-modified': '2026-05-04T03:32:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.450906'}
2026-05-04 03:32:30,636 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-04 03:32:30,642 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09426257:ctest-left_vn-72127539', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09426257', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10884603392337070879', 'uuid-lslong': '11738856474816464502'}, 'enable': 'true', 'created': '2026-05-04T03:32:29', 'last-modified': '2026-05-04T03:32:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.462701'}
2026-05-04 03:32:30,648 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-04 03:32:30,648 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-72127539 passed
2026-05-04 03:32:30,648 - DEBUG - ====Verifying policy data for ctest-left_vn-72127539 in API_Server ======
2026-05-04 03:32:30,648 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:30,655 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:30,667 - DEBUG - Requesting: http://10.0.0.129:8082/project/107ddf4a-cd58-42de-ba90-b7d7550eddad
2026-05-04 03:32:30,762 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/970de11d-c143-4b1f-a2e8-cbc4cabac676
2026-05-04 03:32:30,771 - DEBUG - =>VN ctest-left_vn-72127539 has no policy to be verified
2026-05-04 03:32:30,771 - DEBUG - Verifying the vn in opserver
2026-05-04 03:32:30,771 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09426257:ctest-left_vn-72127539 virtual network link through opserver 10.0.0.129
2026-05-04 03:32:30,771 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2026-05-04 03:32:30,784 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09426257:ctest-left_vn-72127539', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09426257:ctest-left_vn-72127539?flat'}
2026-05-04 03:32:30,785 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09426257:ctest-left_vn-72127539 virtual network link through opserver 10.0.0.50
2026-05-04 03:32:30,785 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-05-04 03:32:30,802 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09426257:ctest-left_vn-72127539', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09426257:ctest-left_vn-72127539?flat'}
2026-05-04 03:32:30,803 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09426257:ctest-left_vn-72127539 virtual network link through opserver 10.0.0.249
2026-05-04 03:32:30,803 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-04 03:32:30,818 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09426257:ctest-left_vn-72127539', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09426257:ctest-left_vn-72127539?flat'}
2026-05-04 03:32:30,818 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-09426257:ctest-left_vn-72127539 is found in opserver
2026-05-04 03:32:30,841 - DEBUG - Do not have enough data to verify VN in agent
2026-05-04 03:32:30,852 - DEBUG - VRF ids for VN ctest-left_vn-72127539: {}
2026-05-04 03:32:31,147 - DEBUG - Response for create_network : {'network': {'id': '80f6a73e-3b73-41b8-b779-f2659c18e057', 'name': 'ctest-right_vn-89560635', 'tenant_id': '107ddf4acd5842deba90b7d7550eddad', 'project_id': '107ddf4acd5842deba90b7d7550eddad', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-09426257', 'ctest-right_vn-89560635'], 'port_security_enabled': True, 'description': ''}}
2026-05-04 03:32:31,392 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e1cd2be3-4b99-4eb6-9920-30964fe54ff3', 'name': '', 'tenant_id': '107ddf4acd5842deba90b7d7550eddad', 'network_id': '80f6a73e-3b73-41b8-b779-f2659c18e057', 'ip_version': 4, 'cidr': '58.56.77.0/26', 'allocation_pools': [{'start': '58.56.77.2', 'end': '58.56.77.62'}], 'gateway_ip': '58.56.77.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '58.56.77.2', 'tags': [], 'project_id': '107ddf4acd5842deba90b7d7550eddad'}}
2026-05-04 03:32:31,418 - INFO - Created VN ctest-right_vn-89560635
2026-05-04 03:32:31,437 - DEBUG - VN ctest-right_vn-89560635 UUID is 80f6a73e-3b73-41b8-b779-f2659c18e057
2026-05-04 03:32:31,516 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:31,522 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:31,533 - DEBUG - Requesting: http://10.0.0.129:8082/project/107ddf4a-cd58-42de-ba90-b7d7550eddad
2026-05-04 03:32:31,641 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/80f6a73e-3b73-41b8-b779-f2659c18e057
2026-05-04 03:32:31,653 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/80f6a73e-3b73-41b8-b779-f2659c18e057
2026-05-04 03:32:31,663 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/c5297402-0d8d-41d8-9c14-cc7f46471bd0
2026-05-04 03:32:31,670 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/c5297402-0d8d-41d8-9c14-cc7f46471bd0
2026-05-04 03:32:31,680 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/85e97bb5-adc0-4d4e-a49d-61bb0275117a
2026-05-04 03:32:31,688 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-04 03:32:31,688 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/80f6a73e-3b73-41b8-b779-f2659c18e057
2026-05-04 03:32:31,699 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/c5297402-0d8d-41d8-9c14-cc7f46471bd0
2026-05-04 03:32:31,717 - INFO - Verified VN network id 16 for VN 80f6a73e-3b73-41b8-b779-f2659c18e057
2026-05-04 03:32:31,717 - INFO - Verifications in API Server for VN ctest-right_vn-89560635 passed
2026-05-04 03:32:31,717 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/80f6a73e-3b73-41b8-b779-f2659c18e057
2026-05-04 03:32:31,727 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/c5297402-0d8d-41d8-9c14-cc7f46471bd0
2026-05-04 03:32:31,735 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/c5297402-0d8d-41d8-9c14-cc7f46471bd0
2026-05-04 03:32:31,743 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/85e97bb5-adc0-4d4e-a49d-61bb0275117a
2026-05-04 03:32:31,755 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09426257:ctest-right_vn-89560635', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09426257', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9292798766852817336', 'uuid-lslong': '13220864699347296343'}, 'enable': 'true', 'created': '2026-05-04T03:32:31', 'last-modified': '2026-05-04T03:32:31', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.418866'}
2026-05-04 03:32:31,761 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-04 03:32:31,766 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09426257:ctest-right_vn-89560635', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09426257', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9292798766852817336', 'uuid-lslong': '13220864699347296343'}, 'enable': 'true', 'created': '2026-05-04T03:32:31', 'last-modified': '2026-05-04T03:32:31', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.429351'}
2026-05-04 03:32:31,772 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-04 03:32:31,779 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09426257:ctest-right_vn-89560635', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09426257', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9292798766852817336', 'uuid-lslong': '13220864699347296343'}, 'enable': 'true', 'created': '2026-05-04T03:32:31', 'last-modified': '2026-05-04T03:32:31', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.442048'}
2026-05-04 03:32:31,785 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-04 03:32:31,785 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-89560635 passed
2026-05-04 03:32:31,785 - DEBUG - ====Verifying policy data for ctest-right_vn-89560635 in API_Server ======
2026-05-04 03:32:31,785 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:31,793 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:31,805 - DEBUG - Requesting: http://10.0.0.129:8082/project/107ddf4a-cd58-42de-ba90-b7d7550eddad
2026-05-04 03:32:31,897 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/80f6a73e-3b73-41b8-b779-f2659c18e057
2026-05-04 03:32:31,912 - DEBUG - =>VN ctest-right_vn-89560635 has no policy to be verified
2026-05-04 03:32:31,913 - DEBUG - Verifying the vn in opserver
2026-05-04 03:32:31,913 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09426257:ctest-right_vn-89560635 virtual network link through opserver 10.0.0.129
2026-05-04 03:32:31,913 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2026-05-04 03:32:31,926 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09426257:ctest-right_vn-89560635', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09426257:ctest-right_vn-89560635?flat'}
2026-05-04 03:32:31,926 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09426257:ctest-right_vn-89560635 virtual network link through opserver 10.0.0.50
2026-05-04 03:32:31,926 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-05-04 03:32:31,941 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09426257:ctest-right_vn-89560635', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09426257:ctest-right_vn-89560635?flat'}
2026-05-04 03:32:31,941 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09426257:ctest-right_vn-89560635 virtual network link through opserver 10.0.0.249
2026-05-04 03:32:31,941 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-04 03:32:31,956 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09426257:ctest-right_vn-89560635', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09426257:ctest-right_vn-89560635?flat'}
2026-05-04 03:32:31,956 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-09426257:ctest-right_vn-89560635 is found in opserver
2026-05-04 03:32:31,979 - DEBUG - Do not have enough data to verify VN in agent
2026-05-04 03:32:31,992 - DEBUG - VRF ids for VN ctest-right_vn-89560635: {}
2026-05-04 03:32:32,277 - DEBUG - Response for create_network : {'network': {'id': '3c67d457-e03c-481a-af03-012e17036b39', 'name': 'ctest-trans_left_vn-88639513', 'tenant_id': '107ddf4acd5842deba90b7d7550eddad', 'project_id': '107ddf4acd5842deba90b7d7550eddad', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-09426257', 'ctest-trans_left_vn-88639513'], 'port_security_enabled': True, 'description': ''}}
2026-05-04 03:32:32,553 - DEBUG - Response for create_subnet : {'subnet': {'id': '67b11d06-0662-4eb4-aaaa-ac5f04fb2243', 'name': '', 'tenant_id': '107ddf4acd5842deba90b7d7550eddad', 'network_id': '3c67d457-e03c-481a-af03-012e17036b39', 'ip_version': 4, 'cidr': '101.106.11.128/26', 'allocation_pools': [{'start': '101.106.11.130', 'end': '101.106.11.190'}], 'gateway_ip': '101.106.11.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '101.106.11.130', 'tags': [], 'project_id': '107ddf4acd5842deba90b7d7550eddad'}}
2026-05-04 03:32:32,580 - INFO - Created VN ctest-trans_left_vn-88639513
2026-05-04 03:32:32,595 - DEBUG - VN ctest-trans_left_vn-88639513 UUID is 3c67d457-e03c-481a-af03-012e17036b39
2026-05-04 03:32:32,680 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:32,687 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:32,698 - DEBUG - Requesting: http://10.0.0.129:8082/project/107ddf4a-cd58-42de-ba90-b7d7550eddad
2026-05-04 03:32:32,799 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/3c67d457-e03c-481a-af03-012e17036b39
2026-05-04 03:32:32,818 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/3c67d457-e03c-481a-af03-012e17036b39
2026-05-04 03:32:32,830 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/3f23d5e1-7dfb-45e6-9622-7af2dd351324
2026-05-04 03:32:32,840 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/3f23d5e1-7dfb-45e6-9622-7af2dd351324
2026-05-04 03:32:32,848 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/0c1d1e55-c7ee-4789-8158-bf802bfa726a
2026-05-04 03:32:32,854 - DEBUG - Route Targets: ['target:64512:8000010']
2026-05-04 03:32:32,854 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/3c67d457-e03c-481a-af03-012e17036b39
2026-05-04 03:32:32,864 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/3f23d5e1-7dfb-45e6-9622-7af2dd351324
2026-05-04 03:32:32,882 - INFO - Verified VN network id 17 for VN 3c67d457-e03c-481a-af03-012e17036b39
2026-05-04 03:32:32,882 - INFO - Verifications in API Server for VN ctest-trans_left_vn-88639513 passed
2026-05-04 03:32:32,882 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/3c67d457-e03c-481a-af03-012e17036b39
2026-05-04 03:32:32,892 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/3f23d5e1-7dfb-45e6-9622-7af2dd351324
2026-05-04 03:32:32,902 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/3f23d5e1-7dfb-45e6-9622-7af2dd351324
2026-05-04 03:32:32,912 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/0c1d1e55-c7ee-4789-8158-bf802bfa726a
2026-05-04 03:32:32,924 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09426257:ctest-trans_left_vn-88639513', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09426257', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4352681038766163994', 'uuid-lslong': '12610924679033744185'}, 'enable': 'true', 'created': '2026-05-04T03:32:32', 'last-modified': '2026-05-04T03:32:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.423599'}
2026-05-04 03:32:32,930 - DEBUG - Route Targets: ['target:64512:8000010']
2026-05-04 03:32:32,936 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09426257:ctest-trans_left_vn-88639513', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09426257', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4352681038766163994', 'uuid-lslong': '12610924679033744185'}, 'enable': 'true', 'created': '2026-05-04T03:32:32', 'last-modified': '2026-05-04T03:32:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.437803'}
2026-05-04 03:32:32,942 - DEBUG - Route Targets: ['target:64512:8000010']
2026-05-04 03:32:32,948 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09426257:ctest-trans_left_vn-88639513', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09426257', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4352681038766163994', 'uuid-lslong': '12610924679033744185'}, 'enable': 'true', 'created': '2026-05-04T03:32:32', 'last-modified': '2026-05-04T03:32:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.447669'}
2026-05-04 03:32:32,954 - DEBUG - Route Targets: ['target:64512:8000010']
2026-05-04 03:32:32,954 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-88639513 passed
2026-05-04 03:32:32,954 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-88639513 in API_Server ======
2026-05-04 03:32:32,954 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:32,961 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:32,977 - DEBUG - Requesting: http://10.0.0.129:8082/project/107ddf4a-cd58-42de-ba90-b7d7550eddad
2026-05-04 03:32:33,086 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/3c67d457-e03c-481a-af03-012e17036b39
2026-05-04 03:32:33,097 - DEBUG - =>VN ctest-trans_left_vn-88639513 has no policy to be verified
2026-05-04 03:32:33,097 - DEBUG - Verifying the vn in opserver
2026-05-04 03:32:33,097 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09426257:ctest-trans_left_vn-88639513 virtual network link through opserver 10.0.0.129
2026-05-04 03:32:33,097 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2026-05-04 03:32:33,114 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09426257:ctest-trans_left_vn-88639513', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09426257:ctest-trans_left_vn-88639513?flat'}
2026-05-04 03:32:33,114 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09426257:ctest-trans_left_vn-88639513 virtual network link through opserver 10.0.0.50
2026-05-04 03:32:33,114 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-05-04 03:32:33,128 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09426257:ctest-trans_left_vn-88639513', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09426257:ctest-trans_left_vn-88639513?flat'}
2026-05-04 03:32:33,128 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09426257:ctest-trans_left_vn-88639513 virtual network link through opserver 10.0.0.249
2026-05-04 03:32:33,128 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-04 03:32:33,145 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09426257:ctest-trans_left_vn-88639513', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09426257:ctest-trans_left_vn-88639513?flat'}
2026-05-04 03:32:33,145 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-09426257:ctest-trans_left_vn-88639513 is found in opserver
2026-05-04 03:32:33,170 - DEBUG - Do not have enough data to verify VN in agent
2026-05-04 03:32:33,183 - DEBUG - VRF ids for VN ctest-trans_left_vn-88639513: {}
2026-05-04 03:32:33,534 - DEBUG - Response for create_network : {'network': {'id': 'a6c22bb3-5065-49af-a61e-a9d326b52838', 'name': 'ctest-trans_right_vn-17463019', 'tenant_id': '107ddf4acd5842deba90b7d7550eddad', 'project_id': '107ddf4acd5842deba90b7d7550eddad', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-09426257', 'ctest-trans_right_vn-17463019'], 'port_security_enabled': True, 'description': ''}}
2026-05-04 03:32:33,801 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a1b99de7-15aa-4797-b59c-bbd400265c6a', 'name': '', 'tenant_id': '107ddf4acd5842deba90b7d7550eddad', 'network_id': 'a6c22bb3-5065-49af-a61e-a9d326b52838', 'ip_version': 4, 'cidr': '54.252.154.64/26', 'allocation_pools': [{'start': '54.252.154.66', 'end': '54.252.154.126'}], 'gateway_ip': '54.252.154.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '54.252.154.66', 'tags': [], 'project_id': '107ddf4acd5842deba90b7d7550eddad'}}
2026-05-04 03:32:33,825 - INFO - Created VN ctest-trans_right_vn-17463019
2026-05-04 03:32:33,842 - DEBUG - VN ctest-trans_right_vn-17463019 UUID is a6c22bb3-5065-49af-a61e-a9d326b52838
2026-05-04 03:32:33,932 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:33,939 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:33,949 - DEBUG - Requesting: http://10.0.0.129:8082/project/107ddf4a-cd58-42de-ba90-b7d7550eddad
2026-05-04 03:32:34,048 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/a6c22bb3-5065-49af-a61e-a9d326b52838
2026-05-04 03:32:34,061 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/a6c22bb3-5065-49af-a61e-a9d326b52838
2026-05-04 03:32:34,071 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/6c768371-d6a8-4895-8d83-f75839ec4fd3
2026-05-04 03:32:34,079 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/6c768371-d6a8-4895-8d83-f75839ec4fd3
2026-05-04 03:32:34,086 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/383b849d-24ec-4f41-81d1-084a6f0edf15
2026-05-04 03:32:34,095 - DEBUG - Route Targets: ['target:64512:8000011']
2026-05-04 03:32:34,095 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/a6c22bb3-5065-49af-a61e-a9d326b52838
2026-05-04 03:32:34,105 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/6c768371-d6a8-4895-8d83-f75839ec4fd3
2026-05-04 03:32:34,123 - INFO - Verified VN network id 18 for VN a6c22bb3-5065-49af-a61e-a9d326b52838
2026-05-04 03:32:34,123 - INFO - Verifications in API Server for VN ctest-trans_right_vn-17463019 passed
2026-05-04 03:32:34,123 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/a6c22bb3-5065-49af-a61e-a9d326b52838
2026-05-04 03:32:34,133 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/6c768371-d6a8-4895-8d83-f75839ec4fd3
2026-05-04 03:32:34,140 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/6c768371-d6a8-4895-8d83-f75839ec4fd3
2026-05-04 03:32:34,147 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/383b849d-24ec-4f41-81d1-084a6f0edf15
2026-05-04 03:32:34,161 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09426257:ctest-trans_right_vn-17463019', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09426257', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12016214804925860271', 'uuid-lslong': '11970191583949957176'}, 'enable': 'true', 'created': '2026-05-04T03:32:33', 'last-modified': '2026-05-04T03:32:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.419926'}
2026-05-04 03:32:34,167 - DEBUG - Route Targets: ['target:64512:8000011']
2026-05-04 03:32:34,173 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09426257:ctest-trans_right_vn-17463019', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09426257', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12016214804925860271', 'uuid-lslong': '11970191583949957176'}, 'enable': 'true', 'created': '2026-05-04T03:32:33', 'last-modified': '2026-05-04T03:32:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.429840'}
2026-05-04 03:32:34,182 - DEBUG - Route Targets: ['target:64512:8000011']
2026-05-04 03:32:34,188 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-09426257:ctest-trans_right_vn-17463019', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-09426257', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12016214804925860271', 'uuid-lslong': '11970191583949957176'}, 'enable': 'true', 'created': '2026-05-04T03:32:33', 'last-modified': '2026-05-04T03:32:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.448797'}
2026-05-04 03:32:34,195 - DEBUG - Route Targets: ['target:64512:8000011']
2026-05-04 03:32:34,195 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-17463019 passed
2026-05-04 03:32:34,195 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-17463019 in API_Server ======
2026-05-04 03:32:34,195 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:34,201 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:34,213 - DEBUG - Requesting: http://10.0.0.129:8082/project/107ddf4a-cd58-42de-ba90-b7d7550eddad
2026-05-04 03:32:34,309 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/a6c22bb3-5065-49af-a61e-a9d326b52838
2026-05-04 03:32:34,319 - DEBUG - =>VN ctest-trans_right_vn-17463019 has no policy to be verified
2026-05-04 03:32:34,319 - DEBUG - Verifying the vn in opserver
2026-05-04 03:32:34,319 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09426257:ctest-trans_right_vn-17463019 virtual network link through opserver 10.0.0.129
2026-05-04 03:32:34,319 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2026-05-04 03:32:34,333 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09426257:ctest-trans_right_vn-17463019', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09426257:ctest-trans_right_vn-17463019?flat'}
2026-05-04 03:32:34,333 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09426257:ctest-trans_right_vn-17463019 virtual network link through opserver 10.0.0.50
2026-05-04 03:32:34,333 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-05-04 03:32:34,348 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09426257:ctest-trans_right_vn-17463019', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09426257:ctest-trans_right_vn-17463019?flat'}
2026-05-04 03:32:34,348 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-09426257:ctest-trans_right_vn-17463019 virtual network link through opserver 10.0.0.249
2026-05-04 03:32:34,348 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-04 03:32:34,365 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-09426257:ctest-trans_right_vn-17463019', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-09426257:ctest-trans_right_vn-17463019?flat'}
2026-05-04 03:32:34,365 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-09426257:ctest-trans_right_vn-17463019 is found in opserver
2026-05-04 03:32:34,390 - DEBUG - Do not have enough data to verify VN in agent
2026-05-04 03:32:34,402 - DEBUG - VRF ids for VN ctest-trans_right_vn-17463019: {}
2026-05-04 03:32:35,656 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5740-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5740-1)
2026-05-04 03:32:37,164 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5740-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5740-2)
2026-05-04 03:32:37,165 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-37582592']
2026-05-04 03:32:37,465 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-37582592'] created succesfully
2026-05-04 03:32:37,943 - DEBUG - Image by name tiny_trans_fw not found
2026-05-04 03:32:37,943 - DEBUG - Installing image tiny_trans_fw
2026-05-04 03:32:37,943 - DEBUG - Image info {'name': 'tinycore-net-transparent-fw.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd'}
2026-05-04 03:32:37,944 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-05-04 03:32:37,944 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz
2026-05-04 03:32:37,962 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/tinycore//tinycore-net-transparent-fw.qcow2.gz -O /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-05-04 03:32:37,989 - DEBUG - Image has been downloaded to /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-05-04 03:32:37,990 - DEBUG - Unzip image
2026-05-04 03:32:37,990 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-05-04 03:32:38,013 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-05-04 03:32:38,014 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-37582592']
2026-05-04 03:32:38,161 - INFO - Service template: ['default-domain', 'ctest-service_template_1-37582592'] deleted successfully.
2026-05-04 03:32:38,161 - INFO - Skip interface_detach for VM ctest-right_vm-45304629 in state BUILD
2026-05-04 03:32:38,161 - INFO - Deleting VM ctest-right_vm-45304629
2026-05-04 03:32:38,161 - ERROR - VM ctest-right_vm-45304629 has failed to come up
2026-05-04 03:32:38,162 - ERROR - Nova failed to get host of the VM
2026-05-04 03:32:38,162 - ERROR - VM ctest-right_vm-45304629 has failed to come up
2026-05-04 03:32:38,162 - ERROR - Nova failed to get host of the VM
2026-05-04 03:32:38,237 - INFO - Skip interface_detach for VM ctest-left_vm-80392020 in state BUILD
2026-05-04 03:32:38,237 - INFO - Deleting VM ctest-left_vm-80392020
2026-05-04 03:32:38,237 - ERROR - VM ctest-left_vm-80392020 has failed to come up
2026-05-04 03:32:38,237 - ERROR - Nova failed to get host of the VM
2026-05-04 03:32:38,237 - ERROR - VM ctest-left_vm-80392020 has failed to come up
2026-05-04 03:32:38,237 - ERROR - Nova failed to get host of the VM
2026-05-04 03:32:38,325 - INFO - Deleting VN ctest-trans_right_vn-17463019
2026-05-04 03:32:38,493 - DEBUG - Response for deleting network ()
2026-05-04 03:32:38,494 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/6c768371-d6a8-4895-8d83-f75839ec4fd3
2026-05-04 03:32:38,500 - DEBUG - Response Code: 404
2026-05-04 03:32:38,500 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:38,506 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:38,531 - DEBUG - Requesting: http://10.0.0.129:8082/project/107ddf4a-cd58-42de-ba90-b7d7550eddad
2026-05-04 03:32:38,631 - INFO - Validated that VN ctest-trans_right_vn-17463019 is not found in API Server
2026-05-04 03:32:38,642 - DEBUG - VN ctest-trans_right_vn-17463019 is not present in Agent 10.0.0.41
2026-05-04 03:32:38,659 - DEBUG - VN ctest-trans_right_vn-17463019 is not present in Agent 10.0.0.141
2026-05-04 03:32:38,659 - INFO - Validated that VN ctest-trans_right_vn-17463019 is not in any agent
2026-05-04 03:32:38,743 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-17463019 info
2026-05-04 03:32:38,743 - INFO - Deleting VN ctest-trans_left_vn-88639513
2026-05-04 03:32:38,959 - DEBUG - Response for deleting network ()
2026-05-04 03:32:38,960 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/3f23d5e1-7dfb-45e6-9622-7af2dd351324
2026-05-04 03:32:38,977 - DEBUG - Response Code: 404
2026-05-04 03:32:38,977 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:38,984 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:38,997 - DEBUG - Requesting: http://10.0.0.129:8082/project/107ddf4a-cd58-42de-ba90-b7d7550eddad
2026-05-04 03:32:39,130 - INFO - Validated that VN ctest-trans_left_vn-88639513 is not found in API Server
2026-05-04 03:32:39,151 - DEBUG - VN ctest-trans_left_vn-88639513 is not present in Agent 10.0.0.41
2026-05-04 03:32:39,176 - DEBUG - VN ctest-trans_left_vn-88639513 is not present in Agent 10.0.0.141
2026-05-04 03:32:39,177 - INFO - Validated that VN ctest-trans_left_vn-88639513 is not in any agent
2026-05-04 03:32:39,233 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-88639513 info
2026-05-04 03:32:39,233 - INFO - Deleting VN ctest-right_vn-89560635
2026-05-04 03:32:39,280 - DEBUG - VN 80f6a73e-3b73-41b8-b779-f2659c18e057 still in use: Unable to complete operation on network 80f6a73e-3b73-41b8-b779-f2659c18e057. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-8fe48067-dff3-42a2-96ea-647874053bad']
2026-05-04 03:32:39,280 - WARNING - Deleting VN ctest-right_vn-89560635 failed..Will retry
2026-05-04 03:32:41,447 - DEBUG - Response for deleting network ()
2026-05-04 03:32:41,448 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/c5297402-0d8d-41d8-9c14-cc7f46471bd0
2026-05-04 03:32:41,459 - DEBUG - Response Code: 404
2026-05-04 03:32:41,459 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:41,468 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:41,528 - DEBUG - Requesting: http://10.0.0.129:8082/project/107ddf4a-cd58-42de-ba90-b7d7550eddad
2026-05-04 03:32:41,639 - INFO - Validated that VN ctest-right_vn-89560635 is not found in API Server
2026-05-04 03:32:41,649 - DEBUG - VN ctest-right_vn-89560635 is not present in Agent 10.0.0.41
2026-05-04 03:32:41,664 - DEBUG - VN ctest-right_vn-89560635 is not present in Agent 10.0.0.141
2026-05-04 03:32:41,664 - INFO - Validated that VN ctest-right_vn-89560635 is not in any agent
2026-05-04 03:32:41,699 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-89560635 info
2026-05-04 03:32:41,700 - INFO - Deleting VN ctest-left_vn-72127539
2026-05-04 03:32:41,903 - DEBUG - Response for deleting network ()
2026-05-04 03:32:41,903 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/160ae253-886c-4ca2-803d-5fe5f825b4b7
2026-05-04 03:32:41,910 - DEBUG - Response Code: 404
2026-05-04 03:32:41,910 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:41,918 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:41,954 - DEBUG - Requesting: http://10.0.0.129:8082/project/107ddf4a-cd58-42de-ba90-b7d7550eddad
2026-05-04 03:32:42,049 - INFO - Validated that VN ctest-left_vn-72127539 is not found in API Server
2026-05-04 03:32:42,062 - DEBUG - VN ctest-left_vn-72127539 is not present in Agent 10.0.0.41
2026-05-04 03:32:42,076 - DEBUG - VN ctest-left_vn-72127539 is not present in Agent 10.0.0.141
2026-05-04 03:32:42,076 - INFO - Validated that VN ctest-left_vn-72127539 is not in any agent
2026-05-04 03:32:42,119 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-72127539 info
2026-05-04 03:32:42,119 - INFO - Deleting VN ctest-mgmt_vn-94793597
2026-05-04 03:32:42,307 - DEBUG - Response for deleting network ()
2026-05-04 03:32:42,307 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/0b31e4cb-c412-4ab5-908d-50d8a7c3ba8e
2026-05-04 03:32:42,314 - DEBUG - Response Code: 404
2026-05-04 03:32:42,314 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:42,325 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:42,343 - DEBUG - Requesting: http://10.0.0.129:8082/project/107ddf4a-cd58-42de-ba90-b7d7550eddad
2026-05-04 03:32:42,456 - INFO - Validated that VN ctest-mgmt_vn-94793597 is not found in API Server
2026-05-04 03:32:42,472 - DEBUG - VN ctest-mgmt_vn-94793597 is not present in Agent 10.0.0.41
2026-05-04 03:32:42,485 - DEBUG - VN ctest-mgmt_vn-94793597 is not present in Agent 10.0.0.141
2026-05-04 03:32:42,485 - INFO - Validated that VN ctest-mgmt_vn-94793597 is not in any agent
2026-05-04 03:32:42,523 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-94793597 info
2026-05-04 03:32:43,842 - DEBUG - No XMPP flaps were noticed during the test
2026-05-04 03:32:43,842 - INFO -
2026-05-04 03:32:43,842 - INFO - END TEST : test_svc_v2_transparent_datapath : SKIPPED[0:00:16]
2026-05-04 03:32:43,842 - INFO - --------------------------------------------------------------------------------
2026-05-04 03:32:44,681 - INFO - Deleted project: ctest-TestSvcRegr-09426257, ID : 107ddf4a-cd58-42de-ba90-b7d7550eddad
2026-05-04 03:32:44,878 - INFO - Domain Default found not creating
2026-05-04 03:32:45,059 - INFO - Project ctest-TestSvcRegr-80409979 not found, creating it
2026-05-04 03:32:45,640 - INFO - Created Project:ctest-TestSvcRegr-80409979, ID : aaf4c007-111f-4f5e-b605-d54fb093b5ad
2026-05-04 03:32:47,302 - INFO - ================================================================================
2026-05-04 03:32:47,303 - INFO - STARTING TEST : test_svc_CEM_22032
2026-05-04 03:32:48,615 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.193': '0', '10.20.0.129': '0'}, '10.0.0.141': {'10.20.0.18': '0', '10.20.0.193': '0'}} with
2026-05-04 03:32:48,615 - INFO - Initial checks done. Running the testcase now
2026-05-04 03:32:48,615 - INFO -
2026-05-04 03:32:49,381 - DEBUG - Response for create_network : {'network': {'id': 'e80903a1-3cef-4c32-b13c-b8200c25adfb', 'name': 'ctest-mgmt_vn-88737367', 'tenant_id': 'aaf4c007111f4f5eb605d54fb093b5ad', 'project_id': 'aaf4c007111f4f5eb605d54fb093b5ad', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-80409979', 'ctest-mgmt_vn-88737367'], 'port_security_enabled': True, 'description': ''}}
2026-05-04 03:32:49,723 - DEBUG - Response for create_subnet : {'subnet': {'id': '9b22d619-d825-4463-b804-d556b27e7e94', 'name': '', 'tenant_id': 'aaf4c007111f4f5eb605d54fb093b5ad', 'network_id': 'e80903a1-3cef-4c32-b13c-b8200c25adfb', 'ip_version': 4, 'cidr': '178.148.44.192/26', 'allocation_pools': [{'start': '178.148.44.194', 'end': '178.148.44.254'}], 'gateway_ip': '178.148.44.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '178.148.44.194', 'tags': [], 'project_id': 'aaf4c007111f4f5eb605d54fb093b5ad'}}
2026-05-04 03:32:49,749 - INFO - Created VN ctest-mgmt_vn-88737367
2026-05-04 03:32:49,762 - DEBUG - VN ctest-mgmt_vn-88737367 UUID is e80903a1-3cef-4c32-b13c-b8200c25adfb
2026-05-04 03:32:49,845 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:50,143 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:50,178 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:50,193 - DEBUG - Requesting: http://10.0.0.129:8082/project/aaf4c007-111f-4f5e-b605-d54fb093b5ad
2026-05-04 03:32:50,309 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/e80903a1-3cef-4c32-b13c-b8200c25adfb
2026-05-04 03:32:50,324 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/e80903a1-3cef-4c32-b13c-b8200c25adfb
2026-05-04 03:32:50,335 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/1b8fdfa8-a27f-4528-862b-48c6230f30f1
2026-05-04 03:32:50,347 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/1b8fdfa8-a27f-4528-862b-48c6230f30f1
2026-05-04 03:32:50,356 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/6c76b2ad-3251-4ddb-8a61-9fdd6eb75591
2026-05-04 03:32:50,363 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-04 03:32:50,363 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/e80903a1-3cef-4c32-b13c-b8200c25adfb
2026-05-04 03:32:50,374 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/1b8fdfa8-a27f-4528-862b-48c6230f30f1
2026-05-04 03:32:50,392 - INFO - Verified VN network id 14 for VN e80903a1-3cef-4c32-b13c-b8200c25adfb
2026-05-04 03:32:50,392 - INFO - Verifications in API Server for VN ctest-mgmt_vn-88737367 passed
2026-05-04 03:32:50,392 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/e80903a1-3cef-4c32-b13c-b8200c25adfb
2026-05-04 03:32:50,403 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/1b8fdfa8-a27f-4528-862b-48c6230f30f1
2026-05-04 03:32:50,410 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/1b8fdfa8-a27f-4528-862b-48c6230f30f1
2026-05-04 03:32:50,417 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/6c76b2ad-3251-4ddb-8a61-9fdd6eb75591
2026-05-04 03:32:50,429 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-88737367', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80409979', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16719899082636610610', 'uuid-lslong': '12771285091098144251'}, 'enable': 'true', 'created': '2026-05-04T03:32:49', 'last-modified': '2026-05-04T03:32:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.784953'}
2026-05-04 03:32:50,435 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-04 03:32:50,442 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-88737367', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80409979', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16719899082636610610', 'uuid-lslong': '12771285091098144251'}, 'enable': 'true', 'created': '2026-05-04T03:32:49', 'last-modified': '2026-05-04T03:32:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.796295'}
2026-05-04 03:32:50,448 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-04 03:32:50,454 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-88737367', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80409979', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16719899082636610610', 'uuid-lslong': '12771285091098144251'}, 'enable': 'true', 'created': '2026-05-04T03:32:49', 'last-modified': '2026-05-04T03:32:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.807164'}
2026-05-04 03:32:50,460 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-04 03:32:50,460 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-88737367 passed
2026-05-04 03:32:50,460 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-88737367 in API_Server ======
2026-05-04 03:32:50,460 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:50,466 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:50,478 - DEBUG - Requesting: http://10.0.0.129:8082/project/aaf4c007-111f-4f5e-b605-d54fb093b5ad
2026-05-04 03:32:50,573 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/e80903a1-3cef-4c32-b13c-b8200c25adfb
2026-05-04 03:32:50,586 - DEBUG - =>VN ctest-mgmt_vn-88737367 has no policy to be verified
2026-05-04 03:32:50,586 - DEBUG - Verifying the vn in opserver
2026-05-04 03:32:50,586 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-88737367 virtual network link through opserver 10.0.0.129
2026-05-04 03:32:50,586 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2026-05-04 03:32:50,886 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2026-05-04 03:32:50,958 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-88737367', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-88737367?flat'}
2026-05-04 03:32:50,958 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-88737367 virtual network link through opserver 10.0.0.50
2026-05-04 03:32:50,959 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-05-04 03:32:51,276 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-05-04 03:32:51,345 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-88737367', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-88737367?flat'}
2026-05-04 03:32:51,345 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-88737367 virtual network link through opserver 10.0.0.249
2026-05-04 03:32:51,345 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-04 03:32:51,648 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-04 03:32:51,727 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-88737367', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-88737367?flat'}
2026-05-04 03:32:51,727 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-88737367 is found in opserver
2026-05-04 03:32:51,749 - DEBUG - Do not have enough data to verify VN in agent
2026-05-04 03:32:51,761 - DEBUG - VRF ids for VN ctest-mgmt_vn-88737367: {}
2026-05-04 03:32:52,183 - DEBUG - Response for create_network : {'network': {'id': 'f34d1a5c-ca53-4ea1-8039-b7df722ca98e', 'name': 'service-left-vn-51728116', 'tenant_id': 'aaf4c007111f4f5eb605d54fb093b5ad', 'project_id': 'aaf4c007111f4f5eb605d54fb093b5ad', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-80409979', 'service-left-vn-51728116'], 'port_security_enabled': True, 'description': ''}}
2026-05-04 03:32:52,490 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c9149b4c-3a16-42a1-9e69-dce58751db9f', 'name': '', 'tenant_id': 'aaf4c007111f4f5eb605d54fb093b5ad', 'network_id': 'f34d1a5c-ca53-4ea1-8039-b7df722ca98e', 'ip_version': 4, 'cidr': '217.172.21.0/26', 'allocation_pools': [{'start': '217.172.21.2', 'end': '217.172.21.62'}], 'gateway_ip': '217.172.21.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '217.172.21.2', 'tags': [], 'project_id': 'aaf4c007111f4f5eb605d54fb093b5ad'}}
2026-05-04 03:32:52,517 - INFO - Created VN service-left-vn-51728116
2026-05-04 03:32:52,533 - DEBUG - VN service-left-vn-51728116 UUID is f34d1a5c-ca53-4ea1-8039-b7df722ca98e
2026-05-04 03:32:52,613 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:52,621 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:52,634 - DEBUG - Requesting: http://10.0.0.129:8082/project/aaf4c007-111f-4f5e-b605-d54fb093b5ad
2026-05-04 03:32:52,730 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/f34d1a5c-ca53-4ea1-8039-b7df722ca98e
2026-05-04 03:32:52,743 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/f34d1a5c-ca53-4ea1-8039-b7df722ca98e
2026-05-04 03:32:52,753 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/d88e0571-a68b-486a-879b-f521f6990e64
2026-05-04 03:32:52,761 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/d88e0571-a68b-486a-879b-f521f6990e64
2026-05-04 03:32:52,768 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/5902e840-f89e-4715-a024-9f2a829e2aab
2026-05-04 03:32:52,775 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-04 03:32:52,775 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/f34d1a5c-ca53-4ea1-8039-b7df722ca98e
2026-05-04 03:32:52,784 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/d88e0571-a68b-486a-879b-f521f6990e64
2026-05-04 03:32:52,800 - INFO - Verified VN network id 15 for VN f34d1a5c-ca53-4ea1-8039-b7df722ca98e
2026-05-04 03:32:52,801 - INFO - Verifications in API Server for VN service-left-vn-51728116 passed
2026-05-04 03:32:52,801 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/f34d1a5c-ca53-4ea1-8039-b7df722ca98e
2026-05-04 03:32:52,812 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/d88e0571-a68b-486a-879b-f521f6990e64
2026-05-04 03:32:52,822 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/d88e0571-a68b-486a-879b-f521f6990e64
2026-05-04 03:32:52,833 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/5902e840-f89e-4715-a024-9f2a829e2aab
2026-05-04 03:32:52,850 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80409979:service-left-vn-51728116', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80409979', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17531697910256979617', 'uuid-lslong': '9239618280848402830'}, 'enable': 'true', 'created': '2026-05-04T03:32:52', 'last-modified': '2026-05-04T03:32:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.429696'}
2026-05-04 03:32:52,858 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-04 03:32:52,865 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80409979:service-left-vn-51728116', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80409979', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17531697910256979617', 'uuid-lslong': '9239618280848402830'}, 'enable': 'true', 'created': '2026-05-04T03:32:52', 'last-modified': '2026-05-04T03:32:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.443453'}
2026-05-04 03:32:52,873 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-04 03:32:52,879 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80409979:service-left-vn-51728116', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80409979', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17531697910256979617', 'uuid-lslong': '9239618280848402830'}, 'enable': 'true', 'created': '2026-05-04T03:32:52', 'last-modified': '2026-05-04T03:32:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.456848'}
2026-05-04 03:32:52,888 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-04 03:32:52,888 - INFO - On all control nodes, Config, RI and RT verification for VN service-left-vn-51728116 passed
2026-05-04 03:32:52,888 - DEBUG - ====Verifying policy data for service-left-vn-51728116 in API_Server ======
2026-05-04 03:32:52,888 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:52,895 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:52,907 - DEBUG - Requesting: http://10.0.0.129:8082/project/aaf4c007-111f-4f5e-b605-d54fb093b5ad
2026-05-04 03:32:53,012 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/f34d1a5c-ca53-4ea1-8039-b7df722ca98e
2026-05-04 03:32:53,027 - DEBUG - =>VN service-left-vn-51728116 has no policy to be verified
2026-05-04 03:32:53,027 - DEBUG - Verifying the vn in opserver
2026-05-04 03:32:53,027 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80409979:service-left-vn-51728116 virtual network link through opserver 10.0.0.129
2026-05-04 03:32:53,027 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2026-05-04 03:32:53,098 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80409979:service-left-vn-51728116', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80409979:service-left-vn-51728116?flat'}
2026-05-04 03:32:53,098 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80409979:service-left-vn-51728116 virtual network link through opserver 10.0.0.50
2026-05-04 03:32:53,098 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-05-04 03:32:53,167 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80409979:service-left-vn-51728116', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80409979:service-left-vn-51728116?flat'}
2026-05-04 03:32:53,167 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80409979:service-left-vn-51728116 virtual network link through opserver 10.0.0.249
2026-05-04 03:32:53,167 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-04 03:32:53,238 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80409979:service-left-vn-51728116', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80409979:service-left-vn-51728116?flat'}
2026-05-04 03:32:53,238 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-80409979:service-left-vn-51728116 is found in opserver
2026-05-04 03:32:53,262 - DEBUG - Do not have enough data to verify VN in agent
2026-05-04 03:32:53,274 - DEBUG - VRF ids for VN service-left-vn-51728116: {}
2026-05-04 03:32:53,568 - DEBUG - Response for create_network : {'network': {'id': 'd5097ef6-418a-4142-bcb5-8d433a50e9b1', 'name': 'service-right-vn-00326594', 'tenant_id': 'aaf4c007111f4f5eb605d54fb093b5ad', 'project_id': 'aaf4c007111f4f5eb605d54fb093b5ad', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-80409979', 'service-right-vn-00326594'], 'port_security_enabled': True, 'description': ''}}
2026-05-04 03:32:53,827 - DEBUG - Response for create_subnet : {'subnet': {'id': '2d2fa174-73ab-425d-976a-2e4622552e37', 'name': '', 'tenant_id': 'aaf4c007111f4f5eb605d54fb093b5ad', 'network_id': 'd5097ef6-418a-4142-bcb5-8d433a50e9b1', 'ip_version': 4, 'cidr': '34.107.13.64/26', 'allocation_pools': [{'start': '34.107.13.66', 'end': '34.107.13.126'}], 'gateway_ip': '34.107.13.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '34.107.13.66', 'tags': [], 'project_id': 'aaf4c007111f4f5eb605d54fb093b5ad'}}
2026-05-04 03:32:53,853 - INFO - Created VN service-right-vn-00326594
2026-05-04 03:32:53,871 - DEBUG - VN service-right-vn-00326594 UUID is d5097ef6-418a-4142-bcb5-8d433a50e9b1
2026-05-04 03:32:53,957 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:53,963 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:53,981 - DEBUG - Requesting: http://10.0.0.129:8082/project/aaf4c007-111f-4f5e-b605-d54fb093b5ad
2026-05-04 03:32:54,079 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/d5097ef6-418a-4142-bcb5-8d433a50e9b1
2026-05-04 03:32:54,090 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/d5097ef6-418a-4142-bcb5-8d433a50e9b1
2026-05-04 03:32:54,099 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/48919696-c85c-4651-a8c3-2feacfa0b1a0
2026-05-04 03:32:54,106 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/48919696-c85c-4651-a8c3-2feacfa0b1a0
2026-05-04 03:32:54,112 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/158b5519-88b2-406d-96ef-cc93df0b488c
2026-05-04 03:32:54,118 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-04 03:32:54,118 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/d5097ef6-418a-4142-bcb5-8d433a50e9b1
2026-05-04 03:32:54,128 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/48919696-c85c-4651-a8c3-2feacfa0b1a0
2026-05-04 03:32:54,146 - INFO - Verified VN network id 16 for VN d5097ef6-418a-4142-bcb5-8d433a50e9b1
2026-05-04 03:32:54,146 - INFO - Verifications in API Server for VN service-right-vn-00326594 passed
2026-05-04 03:32:54,146 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/d5097ef6-418a-4142-bcb5-8d433a50e9b1
2026-05-04 03:32:54,156 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/48919696-c85c-4651-a8c3-2feacfa0b1a0
2026-05-04 03:32:54,164 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/48919696-c85c-4651-a8c3-2feacfa0b1a0
2026-05-04 03:32:54,174 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/158b5519-88b2-406d-96ef-cc93df0b488c
2026-05-04 03:32:54,187 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80409979:service-right-vn-00326594', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80409979', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15350940400995680578', 'uuid-lslong': '13597929969795787185'}, 'enable': 'true', 'created': '2026-05-04T03:32:53', 'last-modified': '2026-05-04T03:32:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.421090'}
2026-05-04 03:32:54,193 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-04 03:32:54,199 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80409979:service-right-vn-00326594', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80409979', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15350940400995680578', 'uuid-lslong': '13597929969795787185'}, 'enable': 'true', 'created': '2026-05-04T03:32:53', 'last-modified': '2026-05-04T03:32:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.428762'}
2026-05-04 03:32:54,208 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-04 03:32:54,214 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80409979:service-right-vn-00326594', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80409979', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15350940400995680578', 'uuid-lslong': '13597929969795787185'}, 'enable': 'true', 'created': '2026-05-04T03:32:53', 'last-modified': '2026-05-04T03:32:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.446319'}
2026-05-04 03:32:54,223 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-04 03:32:54,223 - INFO - On all control nodes, Config, RI and RT verification for VN service-right-vn-00326594 passed
2026-05-04 03:32:54,223 - DEBUG - ====Verifying policy data for service-right-vn-00326594 in API_Server ======
2026-05-04 03:32:54,223 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:32:54,231 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:32:54,246 - DEBUG - Requesting: http://10.0.0.129:8082/project/aaf4c007-111f-4f5e-b605-d54fb093b5ad
2026-05-04 03:32:54,337 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/d5097ef6-418a-4142-bcb5-8d433a50e9b1
2026-05-04 03:32:54,348 - DEBUG - =>VN service-right-vn-00326594 has no policy to be verified
2026-05-04 03:32:54,348 - DEBUG - Verifying the vn in opserver
2026-05-04 03:32:54,348 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80409979:service-right-vn-00326594 virtual network link through opserver 10.0.0.129
2026-05-04 03:32:54,348 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2026-05-04 03:32:54,417 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80409979:service-right-vn-00326594', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80409979:service-right-vn-00326594?flat'}
2026-05-04 03:32:54,417 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80409979:service-right-vn-00326594 virtual network link through opserver 10.0.0.50
2026-05-04 03:32:54,417 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-05-04 03:32:54,494 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80409979:service-right-vn-00326594', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80409979:service-right-vn-00326594?flat'}
2026-05-04 03:32:54,494 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80409979:service-right-vn-00326594 virtual network link through opserver 10.0.0.249
2026-05-04 03:32:54,494 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-04 03:32:54,569 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80409979:service-right-vn-00326594', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80409979:service-right-vn-00326594?flat'}
2026-05-04 03:32:54,569 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-80409979:service-right-vn-00326594 is found in opserver
2026-05-04 03:32:54,590 - DEBUG - Do not have enough data to verify VN in agent
2026-05-04 03:32:54,602 - DEBUG - VRF ids for VN service-right-vn-00326594: {}
2026-05-04 03:32:54,779 - DEBUG - Services list from nova: [, , , ]
2026-05-04 03:32:55,978 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5740-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5740-1)
2026-05-04 03:32:57,488 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5740-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5740-2)
2026-05-04 03:32:57,488 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-20720281']
2026-05-04 03:32:57,805 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-20720281'] created succesfully
2026-05-04 03:32:58,356 - DEBUG - Image by name tiny_nat_fw not found
2026-05-04 03:32:58,356 - DEBUG - Installing image tiny_nat_fw
2026-05-04 03:32:58,356 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-05-04 03:32:58,357 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-04 03:32:58,357 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-04 03:32:58,357 - DEBUG - Unzip image
2026-05-04 03:32:58,357 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-04 03:32:58,374 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-05-04 03:32:58,374 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-20720281']
2026-05-04 03:32:58,473 - INFO - Service template: ['default-domain', 'ctest-service_template_1-20720281'] deleted successfully.
2026-05-04 03:32:58,473 - INFO - Skip interface_detach for VM ctest-right_vm-19950959 in state BUILD
2026-05-04 03:32:58,473 - INFO - Deleting VM ctest-right_vm-19950959
2026-05-04 03:32:58,499 - ERROR - VM ctest-right_vm-19950959 has failed to come up
2026-05-04 03:32:58,499 - ERROR - Nova failed to get host of the VM
2026-05-04 03:32:58,499 - ERROR - VM ctest-right_vm-19950959 has failed to come up
2026-05-04 03:32:58,499 - ERROR - Nova failed to get host of the VM
2026-05-04 03:32:58,573 - INFO - Skip interface_detach for VM ctest-left_vm-90689226 in state BUILD
2026-05-04 03:32:58,573 - INFO - Deleting VM ctest-left_vm-90689226
2026-05-04 03:32:58,573 - ERROR - VM ctest-left_vm-90689226 has failed to come up
2026-05-04 03:32:58,573 - ERROR - Nova failed to get host of the VM
2026-05-04 03:32:58,573 - ERROR - VM ctest-left_vm-90689226 has failed to come up
2026-05-04 03:32:58,573 - ERROR - Nova failed to get host of the VM
2026-05-04 03:32:58,643 - INFO - Deleting VN service-right-vn-00326594
2026-05-04 03:32:58,700 - DEBUG - VN d5097ef6-418a-4142-bcb5-8d433a50e9b1 still in use: Unable to complete operation on network d5097ef6-418a-4142-bcb5-8d433a50e9b1. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-87ae18b4-6985-456b-8488-a0225790f1df']
2026-05-04 03:32:58,700 - WARNING - Deleting VN service-right-vn-00326594 failed..Will retry
2026-05-04 03:33:00,929 - DEBUG - Response for deleting network ()
2026-05-04 03:33:00,929 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/48919696-c85c-4651-a8c3-2feacfa0b1a0
2026-05-04 03:33:00,939 - DEBUG - Response Code: 404
2026-05-04 03:33:00,939 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:33:00,960 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:33:00,976 - DEBUG - Requesting: http://10.0.0.129:8082/project/aaf4c007-111f-4f5e-b605-d54fb093b5ad
2026-05-04 03:33:01,080 - INFO - Validated that VN service-right-vn-00326594 is not found in API Server
2026-05-04 03:33:01,092 - DEBUG - VN service-right-vn-00326594 is not present in Agent 10.0.0.41
2026-05-04 03:33:01,107 - DEBUG - VN service-right-vn-00326594 is not present in Agent 10.0.0.141
2026-05-04 03:33:01,107 - INFO - Validated that VN service-right-vn-00326594 is not in any agent
2026-05-04 03:33:01,144 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-right-vn-00326594 info
2026-05-04 03:33:01,144 - INFO - Deleting VN service-left-vn-51728116
2026-05-04 03:33:01,375 - DEBUG - Response for deleting network ()
2026-05-04 03:33:01,375 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/d88e0571-a68b-486a-879b-f521f6990e64
2026-05-04 03:33:01,382 - DEBUG - Response Code: 404
2026-05-04 03:33:01,382 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:33:01,388 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:33:01,404 - DEBUG - Requesting: http://10.0.0.129:8082/project/aaf4c007-111f-4f5e-b605-d54fb093b5ad
2026-05-04 03:33:01,523 - INFO - Validated that VN service-left-vn-51728116 is not found in API Server
2026-05-04 03:33:01,536 - DEBUG - VN service-left-vn-51728116 is not present in Agent 10.0.0.41
2026-05-04 03:33:01,547 - DEBUG - VN service-left-vn-51728116 is not present in Agent 10.0.0.141
2026-05-04 03:33:01,547 - INFO - Validated that VN service-left-vn-51728116 is not in any agent
2026-05-04 03:33:01,582 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN service-left-vn-51728116 info
2026-05-04 03:33:01,582 - INFO - Deleting VN ctest-mgmt_vn-88737367
2026-05-04 03:33:01,789 - DEBUG - Response for deleting network ()
2026-05-04 03:33:01,789 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/1b8fdfa8-a27f-4528-862b-48c6230f30f1
2026-05-04 03:33:01,798 - DEBUG - Response Code: 404
2026-05-04 03:33:01,798 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:33:01,804 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:33:01,820 - DEBUG - Requesting: http://10.0.0.129:8082/project/aaf4c007-111f-4f5e-b605-d54fb093b5ad
2026-05-04 03:33:01,930 - INFO - Validated that VN ctest-mgmt_vn-88737367 is not found in API Server
2026-05-04 03:33:01,942 - DEBUG - VN ctest-mgmt_vn-88737367 is not present in Agent 10.0.0.41
2026-05-04 03:33:01,955 - DEBUG - VN ctest-mgmt_vn-88737367 is not present in Agent 10.0.0.141
2026-05-04 03:33:01,955 - INFO - Validated that VN ctest-mgmt_vn-88737367 is not in any agent
2026-05-04 03:33:01,991 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-88737367 info
2026-05-04 03:33:03,293 - DEBUG - No XMPP flaps were noticed during the test
2026-05-04 03:33:03,293 - INFO -
2026-05-04 03:33:03,293 - INFO - END TEST : test_svc_CEM_22032 : SKIPPED[0:00:16]
2026-05-04 03:33:03,293 - INFO - --------------------------------------------------------------------------------
2026-05-04 03:33:03,299 - INFO - ================================================================================
2026-05-04 03:33:03,299 - INFO - STARTING TEST : test_svc_in_network_datapath
2026-05-04 03:33:04,601 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.193': '0', '10.20.0.129': '0'}, '10.0.0.141': {'10.20.0.18': '0', '10.20.0.193': '0'}} with
2026-05-04 03:33:04,601 - INFO - Initial checks done. Running the testcase now
2026-05-04 03:33:04,601 - INFO -
2026-05-04 03:33:04,941 - DEBUG - Response for create_network : {'network': {'id': '2256273e-86a2-48ce-91a8-a724f8bb6582', 'name': 'ctest-mgmt_vn-92618606', 'tenant_id': 'aaf4c007111f4f5eb605d54fb093b5ad', 'project_id': 'aaf4c007111f4f5eb605d54fb093b5ad', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-80409979', 'ctest-mgmt_vn-92618606'], 'port_security_enabled': True, 'description': ''}}
2026-05-04 03:33:05,235 - DEBUG - Response for create_subnet : {'subnet': {'id': '05d4a344-e3f7-45b9-9d87-f1e52f648fb2', 'name': '', 'tenant_id': 'aaf4c007111f4f5eb605d54fb093b5ad', 'network_id': '2256273e-86a2-48ce-91a8-a724f8bb6582', 'ip_version': 4, 'cidr': '26.238.88.192/26', 'allocation_pools': [{'start': '26.238.88.194', 'end': '26.238.88.254'}], 'gateway_ip': '26.238.88.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '26.238.88.194', 'tags': [], 'project_id': 'aaf4c007111f4f5eb605d54fb093b5ad'}}
2026-05-04 03:33:05,258 - INFO - Created VN ctest-mgmt_vn-92618606
2026-05-04 03:33:05,271 - DEBUG - VN ctest-mgmt_vn-92618606 UUID is 2256273e-86a2-48ce-91a8-a724f8bb6582
2026-05-04 03:33:05,349 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:33:05,356 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:33:05,368 - DEBUG - Requesting: http://10.0.0.129:8082/project/aaf4c007-111f-4f5e-b605-d54fb093b5ad
2026-05-04 03:33:05,471 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/2256273e-86a2-48ce-91a8-a724f8bb6582
2026-05-04 03:33:05,488 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/2256273e-86a2-48ce-91a8-a724f8bb6582
2026-05-04 03:33:05,497 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/bb0d2c4d-f96e-448c-b74d-6cbd9b871668
2026-05-04 03:33:05,508 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/bb0d2c4d-f96e-448c-b74d-6cbd9b871668
2026-05-04 03:33:05,515 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/5440f772-48de-4609-836f-006d678b5a7f
2026-05-04 03:33:05,524 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-04 03:33:05,524 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/2256273e-86a2-48ce-91a8-a724f8bb6582
2026-05-04 03:33:05,537 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/bb0d2c4d-f96e-448c-b74d-6cbd9b871668
2026-05-04 03:33:05,556 - INFO - Verified VN network id 14 for VN 2256273e-86a2-48ce-91a8-a724f8bb6582
2026-05-04 03:33:05,556 - INFO - Verifications in API Server for VN ctest-mgmt_vn-92618606 passed
2026-05-04 03:33:05,556 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/2256273e-86a2-48ce-91a8-a724f8bb6582
2026-05-04 03:33:05,570 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/bb0d2c4d-f96e-448c-b74d-6cbd9b871668
2026-05-04 03:33:05,580 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/bb0d2c4d-f96e-448c-b74d-6cbd9b871668
2026-05-04 03:33:05,588 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/5440f772-48de-4609-836f-006d678b5a7f
2026-05-04 03:33:05,603 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-92618606', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80409979', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2474208194786904270', 'uuid-lslong': '10495822708820632962'}, 'enable': 'true', 'created': '2026-05-04T03:33:04', 'last-modified': '2026-05-04T03:33:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.422568'}
2026-05-04 03:33:05,609 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-04 03:33:05,616 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-92618606', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80409979', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2474208194786904270', 'uuid-lslong': '10495822708820632962'}, 'enable': 'true', 'created': '2026-05-04T03:33:04', 'last-modified': '2026-05-04T03:33:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.418802'}
2026-05-04 03:33:05,624 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-04 03:33:05,631 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-92618606', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80409979', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2474208194786904270', 'uuid-lslong': '10495822708820632962'}, 'enable': 'true', 'created': '2026-05-04T03:33:04', 'last-modified': '2026-05-04T03:33:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.460479'}
2026-05-04 03:33:05,639 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-04 03:33:05,639 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-92618606 passed
2026-05-04 03:33:05,639 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-92618606 in API_Server ======
2026-05-04 03:33:05,639 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:33:05,647 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:33:05,659 - DEBUG - Requesting: http://10.0.0.129:8082/project/aaf4c007-111f-4f5e-b605-d54fb093b5ad
2026-05-04 03:33:05,762 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/2256273e-86a2-48ce-91a8-a724f8bb6582
2026-05-04 03:33:05,780 - DEBUG - =>VN ctest-mgmt_vn-92618606 has no policy to be verified
2026-05-04 03:33:05,780 - DEBUG - Verifying the vn in opserver
2026-05-04 03:33:05,780 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-92618606 virtual network link through opserver 10.0.0.129
2026-05-04 03:33:05,781 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2026-05-04 03:33:05,796 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-92618606', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-92618606?flat'}
2026-05-04 03:33:05,796 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-92618606 virtual network link through opserver 10.0.0.50
2026-05-04 03:33:05,796 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-05-04 03:33:05,812 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-92618606', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-92618606?flat'}
2026-05-04 03:33:05,813 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-92618606 virtual network link through opserver 10.0.0.249
2026-05-04 03:33:05,813 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-04 03:33:05,828 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-92618606', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-92618606?flat'}
2026-05-04 03:33:05,828 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-80409979:ctest-mgmt_vn-92618606 is found in opserver
2026-05-04 03:33:05,855 - DEBUG - Do not have enough data to verify VN in agent
2026-05-04 03:33:05,869 - DEBUG - VRF ids for VN ctest-mgmt_vn-92618606: {}
2026-05-04 03:33:06,225 - DEBUG - Response for create_network : {'network': {'id': '9f4e9674-a701-428e-9cdb-7445589bdd76', 'name': 'ctest-left_vn-25557141', 'tenant_id': 'aaf4c007111f4f5eb605d54fb093b5ad', 'project_id': 'aaf4c007111f4f5eb605d54fb093b5ad', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-80409979', 'ctest-left_vn-25557141'], 'port_security_enabled': True, 'description': ''}}
2026-05-04 03:33:06,560 - DEBUG - Response for create_subnet : {'subnet': {'id': '13eb7771-d2f3-42e4-8807-0a4384b14e69', 'name': '', 'tenant_id': 'aaf4c007111f4f5eb605d54fb093b5ad', 'network_id': '9f4e9674-a701-428e-9cdb-7445589bdd76', 'ip_version': 4, 'cidr': '147.197.137.64/26', 'allocation_pools': [{'start': '147.197.137.66', 'end': '147.197.137.126'}], 'gateway_ip': '147.197.137.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '147.197.137.66', 'tags': [], 'project_id': 'aaf4c007111f4f5eb605d54fb093b5ad'}}
2026-05-04 03:33:06,586 - INFO - Created VN ctest-left_vn-25557141
2026-05-04 03:33:06,600 - DEBUG - VN ctest-left_vn-25557141 UUID is 9f4e9674-a701-428e-9cdb-7445589bdd76
2026-05-04 03:33:06,700 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:33:06,708 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:33:06,719 - DEBUG - Requesting: http://10.0.0.129:8082/project/aaf4c007-111f-4f5e-b605-d54fb093b5ad
2026-05-04 03:33:06,827 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/9f4e9674-a701-428e-9cdb-7445589bdd76
2026-05-04 03:33:06,841 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/9f4e9674-a701-428e-9cdb-7445589bdd76
2026-05-04 03:33:06,859 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/94039878-aaaa-4955-b9fc-8ddd60d5c869
2026-05-04 03:33:06,874 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/94039878-aaaa-4955-b9fc-8ddd60d5c869
2026-05-04 03:33:06,881 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/ddedf70c-e644-4e23-93ca-101bb9345372
2026-05-04 03:33:06,890 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-04 03:33:06,890 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/9f4e9674-a701-428e-9cdb-7445589bdd76
2026-05-04 03:33:06,900 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/94039878-aaaa-4955-b9fc-8ddd60d5c869
2026-05-04 03:33:06,918 - INFO - Verified VN network id 15 for VN 9f4e9674-a701-428e-9cdb-7445589bdd76
2026-05-04 03:33:06,918 - INFO - Verifications in API Server for VN ctest-left_vn-25557141 passed
2026-05-04 03:33:06,918 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/9f4e9674-a701-428e-9cdb-7445589bdd76
2026-05-04 03:33:06,929 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/94039878-aaaa-4955-b9fc-8ddd60d5c869
2026-05-04 03:33:06,939 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/94039878-aaaa-4955-b9fc-8ddd60d5c869
2026-05-04 03:33:06,949 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/ddedf70c-e644-4e23-93ca-101bb9345372
2026-05-04 03:33:06,965 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80409979:ctest-left_vn-25557141', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80409979', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11479277927976223374', 'uuid-lslong': '11302755531004566902'}, 'enable': 'true', 'created': '2026-05-04T03:33:06', 'last-modified': '2026-05-04T03:33:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.494012'}
2026-05-04 03:33:06,971 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-04 03:33:06,978 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80409979:ctest-left_vn-25557141', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80409979', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11479277927976223374', 'uuid-lslong': '11302755531004566902'}, 'enable': 'true', 'created': '2026-05-04T03:33:06', 'last-modified': '2026-05-04T03:33:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.504468'}
2026-05-04 03:33:06,985 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-04 03:33:06,991 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80409979:ctest-left_vn-25557141', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80409979', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11479277927976223374', 'uuid-lslong': '11302755531004566902'}, 'enable': 'true', 'created': '2026-05-04T03:33:06', 'last-modified': '2026-05-04T03:33:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.522300'}
2026-05-04 03:33:06,997 - DEBUG - Route Targets: ['target:64512:8000008']
2026-05-04 03:33:06,997 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-25557141 passed
2026-05-04 03:33:06,998 - DEBUG - ====Verifying policy data for ctest-left_vn-25557141 in API_Server ======
2026-05-04 03:33:06,998 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:33:07,005 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:33:07,015 - DEBUG - Requesting: http://10.0.0.129:8082/project/aaf4c007-111f-4f5e-b605-d54fb093b5ad
2026-05-04 03:33:07,125 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/9f4e9674-a701-428e-9cdb-7445589bdd76
2026-05-04 03:33:07,136 - DEBUG - =>VN ctest-left_vn-25557141 has no policy to be verified
2026-05-04 03:33:07,136 - DEBUG - Verifying the vn in opserver
2026-05-04 03:33:07,136 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80409979:ctest-left_vn-25557141 virtual network link through opserver 10.0.0.129
2026-05-04 03:33:07,136 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2026-05-04 03:33:07,153 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80409979:ctest-left_vn-25557141', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80409979:ctest-left_vn-25557141?flat'}
2026-05-04 03:33:07,153 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80409979:ctest-left_vn-25557141 virtual network link through opserver 10.0.0.50
2026-05-04 03:33:07,153 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-05-04 03:33:07,172 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80409979:ctest-left_vn-25557141', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80409979:ctest-left_vn-25557141?flat'}
2026-05-04 03:33:07,173 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80409979:ctest-left_vn-25557141 virtual network link through opserver 10.0.0.249
2026-05-04 03:33:07,173 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-04 03:33:07,191 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80409979:ctest-left_vn-25557141', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80409979:ctest-left_vn-25557141?flat'}
2026-05-04 03:33:07,191 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-80409979:ctest-left_vn-25557141 is found in opserver
2026-05-04 03:33:07,221 - DEBUG - Do not have enough data to verify VN in agent
2026-05-04 03:33:07,238 - DEBUG - VRF ids for VN ctest-left_vn-25557141: {}
2026-05-04 03:33:07,583 - DEBUG - Response for create_network : {'network': {'id': 'f6d5e20b-f56a-418e-8692-caa9a723673d', 'name': 'ctest-right_vn-39255761', 'tenant_id': 'aaf4c007111f4f5eb605d54fb093b5ad', 'project_id': 'aaf4c007111f4f5eb605d54fb093b5ad', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-80409979', 'ctest-right_vn-39255761'], 'port_security_enabled': True, 'description': ''}}
2026-05-04 03:33:07,831 - DEBUG - Response for create_subnet : {'subnet': {'id': '3aa96be9-fb71-44ab-aaf1-f8fcce089bfb', 'name': '', 'tenant_id': 'aaf4c007111f4f5eb605d54fb093b5ad', 'network_id': 'f6d5e20b-f56a-418e-8692-caa9a723673d', 'ip_version': 4, 'cidr': '221.232.205.0/26', 'allocation_pools': [{'start': '221.232.205.2', 'end': '221.232.205.62'}], 'gateway_ip': '221.232.205.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '221.232.205.2', 'tags': [], 'project_id': 'aaf4c007111f4f5eb605d54fb093b5ad'}}
2026-05-04 03:33:07,861 - INFO - Created VN ctest-right_vn-39255761
2026-05-04 03:33:07,879 - DEBUG - VN ctest-right_vn-39255761 UUID is f6d5e20b-f56a-418e-8692-caa9a723673d
2026-05-04 03:33:07,973 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:33:07,980 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:33:07,992 - DEBUG - Requesting: http://10.0.0.129:8082/project/aaf4c007-111f-4f5e-b605-d54fb093b5ad
2026-05-04 03:33:08,102 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/f6d5e20b-f56a-418e-8692-caa9a723673d
2026-05-04 03:33:08,117 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/f6d5e20b-f56a-418e-8692-caa9a723673d
2026-05-04 03:33:08,131 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/c14a308a-ea64-4256-8cad-f46e09c9a236
2026-05-04 03:33:08,140 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/c14a308a-ea64-4256-8cad-f46e09c9a236
2026-05-04 03:33:08,154 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/be365568-a7ec-47b2-aa9d-9818c76f3b3e
2026-05-04 03:33:08,166 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-04 03:33:08,166 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/f6d5e20b-f56a-418e-8692-caa9a723673d
2026-05-04 03:33:08,177 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/c14a308a-ea64-4256-8cad-f46e09c9a236
2026-05-04 03:33:08,196 - INFO - Verified VN network id 16 for VN f6d5e20b-f56a-418e-8692-caa9a723673d
2026-05-04 03:33:08,197 - INFO - Verifications in API Server for VN ctest-right_vn-39255761 passed
2026-05-04 03:33:08,197 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/f6d5e20b-f56a-418e-8692-caa9a723673d
2026-05-04 03:33:08,207 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/c14a308a-ea64-4256-8cad-f46e09c9a236
2026-05-04 03:33:08,215 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/c14a308a-ea64-4256-8cad-f46e09c9a236
2026-05-04 03:33:08,223 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/be365568-a7ec-47b2-aa9d-9818c76f3b3e
2026-05-04 03:33:08,235 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80409979:ctest-right_vn-39255761', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80409979', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17786370844359541134', 'uuid-lslong': '9697035777684498237'}, 'enable': 'true', 'created': '2026-05-04T03:33:07', 'last-modified': '2026-05-04T03:33:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.487678'}
2026-05-04 03:33:08,241 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-04 03:33:08,248 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80409979:ctest-right_vn-39255761', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80409979', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17786370844359541134', 'uuid-lslong': '9697035777684498237'}, 'enable': 'true', 'created': '2026-05-04T03:33:07', 'last-modified': '2026-05-04T03:33:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.507734'}
2026-05-04 03:33:08,257 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-04 03:33:08,264 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-80409979:ctest-right_vn-39255761', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-80409979', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17786370844359541134', 'uuid-lslong': '9697035777684498237'}, 'enable': 'true', 'created': '2026-05-04T03:33:07', 'last-modified': '2026-05-04T03:33:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.516959'}
2026-05-04 03:33:08,270 - DEBUG - Route Targets: ['target:64512:8000009']
2026-05-04 03:33:08,270 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-39255761 passed
2026-05-04 03:33:08,270 - DEBUG - ====Verifying policy data for ctest-right_vn-39255761 in API_Server ======
2026-05-04 03:33:08,270 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:33:08,281 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:33:08,298 - DEBUG - Requesting: http://10.0.0.129:8082/project/aaf4c007-111f-4f5e-b605-d54fb093b5ad
2026-05-04 03:33:08,390 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/f6d5e20b-f56a-418e-8692-caa9a723673d
2026-05-04 03:33:08,404 - DEBUG - =>VN ctest-right_vn-39255761 has no policy to be verified
2026-05-04 03:33:08,404 - DEBUG - Verifying the vn in opserver
2026-05-04 03:33:08,404 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80409979:ctest-right_vn-39255761 virtual network link through opserver 10.0.0.129
2026-05-04 03:33:08,404 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2026-05-04 03:33:08,419 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80409979:ctest-right_vn-39255761', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80409979:ctest-right_vn-39255761?flat'}
2026-05-04 03:33:08,419 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80409979:ctest-right_vn-39255761 virtual network link through opserver 10.0.0.50
2026-05-04 03:33:08,419 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-05-04 03:33:08,436 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80409979:ctest-right_vn-39255761', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80409979:ctest-right_vn-39255761?flat'}
2026-05-04 03:33:08,436 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-80409979:ctest-right_vn-39255761 virtual network link through opserver 10.0.0.249
2026-05-04 03:33:08,436 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-04 03:33:08,453 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-80409979:ctest-right_vn-39255761', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-80409979:ctest-right_vn-39255761?flat'}
2026-05-04 03:33:08,453 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-80409979:ctest-right_vn-39255761 is found in opserver
2026-05-04 03:33:08,484 - DEBUG - Do not have enough data to verify VN in agent
2026-05-04 03:33:08,501 - DEBUG - VRF ids for VN ctest-right_vn-39255761: {}
2026-05-04 03:33:09,860 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5740-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5740-2)
2026-05-04 03:33:11,500 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5740-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5740-1)
2026-05-04 03:33:11,501 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-70696106']
2026-05-04 03:33:11,819 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-70696106'] created succesfully
2026-05-04 03:33:12,234 - DEBUG - Image by name tiny_nat_fw not found
2026-05-04 03:33:12,234 - DEBUG - Installing image tiny_nat_fw
2026-05-04 03:33:12,234 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-05-04 03:33:12,234 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-04 03:33:12,234 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-04 03:33:12,234 - DEBUG - Unzip image
2026-05-04 03:33:12,234 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-05-04 03:33:12,259 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-05-04 03:33:12,260 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-70696106']
2026-05-04 03:33:12,361 - INFO - Service template: ['default-domain', 'ctest-service_template_1-70696106'] deleted successfully.
2026-05-04 03:33:12,361 - INFO - Skip interface_detach for VM ctest-right_vm-09100937 in state BUILD
2026-05-04 03:33:12,361 - INFO - Deleting VM ctest-right_vm-09100937
2026-05-04 03:33:12,361 - ERROR - VM ctest-right_vm-09100937 has failed to come up
2026-05-04 03:33:12,362 - ERROR - Nova failed to get host of the VM
2026-05-04 03:33:12,362 - ERROR - VM ctest-right_vm-09100937 has failed to come up
2026-05-04 03:33:12,362 - ERROR - Nova failed to get host of the VM
2026-05-04 03:33:12,459 - INFO - Skip interface_detach for VM ctest-left_vm-87362552 in state BUILD
2026-05-04 03:33:12,459 - INFO - Deleting VM ctest-left_vm-87362552
2026-05-04 03:33:12,459 - ERROR - VM ctest-left_vm-87362552 has failed to come up
2026-05-04 03:33:12,459 - ERROR - Nova failed to get host of the VM
2026-05-04 03:33:12,459 - ERROR - VM ctest-left_vm-87362552 has failed to come up
2026-05-04 03:33:12,459 - ERROR - Nova failed to get host of the VM
2026-05-04 03:33:12,532 - INFO - Deleting VN ctest-right_vn-39255761
2026-05-04 03:33:12,599 - DEBUG - VN f6d5e20b-f56a-418e-8692-caa9a723673d still in use: Unable to complete operation on network f6d5e20b-f56a-418e-8692-caa9a723673d. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-d01b1068-7525-4099-8145-d34f9f9937d0']
2026-05-04 03:33:12,600 - WARNING - Deleting VN ctest-right_vn-39255761 failed..Will retry
2026-05-04 03:33:14,784 - DEBUG - Response for deleting network ()
2026-05-04 03:33:14,784 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/c14a308a-ea64-4256-8cad-f46e09c9a236
2026-05-04 03:33:14,792 - DEBUG - Response Code: 404
2026-05-04 03:33:14,792 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:33:14,798 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:33:14,832 - DEBUG - Requesting: http://10.0.0.129:8082/project/aaf4c007-111f-4f5e-b605-d54fb093b5ad
2026-05-04 03:33:14,931 - INFO - Validated that VN ctest-right_vn-39255761 is not found in API Server
2026-05-04 03:33:14,942 - DEBUG - VN ctest-right_vn-39255761 is not present in Agent 10.0.0.41
2026-05-04 03:33:14,953 - DEBUG - VN ctest-right_vn-39255761 is not present in Agent 10.0.0.141
2026-05-04 03:33:14,953 - INFO - Validated that VN ctest-right_vn-39255761 is not in any agent
2026-05-04 03:33:14,983 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-39255761 info
2026-05-04 03:33:14,983 - INFO - Deleting VN ctest-left_vn-25557141
2026-05-04 03:33:15,179 - DEBUG - Response for deleting network ()
2026-05-04 03:33:15,179 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/94039878-aaaa-4955-b9fc-8ddd60d5c869
2026-05-04 03:33:15,199 - DEBUG - Response Code: 404
2026-05-04 03:33:15,199 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:33:15,210 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:33:15,226 - DEBUG - Requesting: http://10.0.0.129:8082/project/aaf4c007-111f-4f5e-b605-d54fb093b5ad
2026-05-04 03:33:15,324 - INFO - Validated that VN ctest-left_vn-25557141 is not found in API Server
2026-05-04 03:33:15,341 - DEBUG - VN ctest-left_vn-25557141 is not present in Agent 10.0.0.41
2026-05-04 03:33:15,352 - DEBUG - VN ctest-left_vn-25557141 is not present in Agent 10.0.0.141
2026-05-04 03:33:15,352 - INFO - Validated that VN ctest-left_vn-25557141 is not in any agent
2026-05-04 03:33:15,385 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-25557141 info
2026-05-04 03:33:15,385 - INFO - Deleting VN ctest-mgmt_vn-92618606
2026-05-04 03:33:15,542 - DEBUG - Response for deleting network ()
2026-05-04 03:33:15,542 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/bb0d2c4d-f96e-448c-b74d-6cbd9b871668
2026-05-04 03:33:15,548 - DEBUG - Response Code: 404
2026-05-04 03:33:15,548 - DEBUG - Requesting: http://10.0.0.129:8082/domains
2026-05-04 03:33:15,555 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c
2026-05-04 03:33:15,576 - DEBUG - Requesting: http://10.0.0.129:8082/project/aaf4c007-111f-4f5e-b605-d54fb093b5ad
2026-05-04 03:33:15,700 - INFO - Validated that VN ctest-mgmt_vn-92618606 is not found in API Server
2026-05-04 03:33:15,753 - DEBUG - VN ctest-mgmt_vn-92618606 is not present in Agent 10.0.0.41
2026-05-04 03:33:15,782 - DEBUG - VN ctest-mgmt_vn-92618606 is not present in Agent 10.0.0.141
2026-05-04 03:33:15,782 - INFO - Validated that VN ctest-mgmt_vn-92618606 is not in any agent
2026-05-04 03:33:15,831 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-92618606 info
2026-05-04 03:33:17,125 - DEBUG - No XMPP flaps were noticed during the test
2026-05-04 03:33:17,125 - INFO -
2026-05-04 03:33:17,125 - INFO - END TEST : test_svc_in_network_datapath : SKIPPED[0:00:14]
2026-05-04 03:33:17,125 - INFO - --------------------------------------------------------------------------------
2026-05-04 03:33:17,933 - INFO - Deleted project: ctest-TestSvcRegr-80409979, ID : aaf4c007-111f-4f5e-b605-d54fb093b5ad