2025-10-15 15:57:02,628 - INFO - Domain Default found not creating
2025-10-15 15:57:02,778 - INFO - Project ctest-TestECMPSanity-37835179 not found, creating it
2025-10-15 15:57:03,300 - INFO - Created Project:ctest-TestECMPSanity-37835179, ID : f54c9067-e32f-432d-b049-43d9892bee8a 
2025-10-15 15:57:05,469 - DEBUG - Response for create_network : {'network': {'id': 'd9caccaa-28c9-4636-9b9b-cb62ce0df9ba', 'name': 'ctest-mgmt_ctest-TestECMPSanity-37835179-60810536', 'tenant_id': 'f54c9067e32f432db04943d9892bee8a', 'project_id': 'f54c9067e32f432db04943d9892bee8a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestECMPSanity-37835179', 'ctest-mgmt_ctest-TestECMPSanity-37835179-60810536'], 'port_security_enabled': True, 'description': ''}}
2025-10-15 15:57:05,703 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a76edec5-aad8-48b9-86de-72c915b2fa98', 'name': '', 'tenant_id': 'f54c9067e32f432db04943d9892bee8a', 'network_id': 'd9caccaa-28c9-4636-9b9b-cb62ce0df9ba', 'ip_version': 4, 'cidr': '80.119.95.64/26', 'allocation_pools': [{'start': '80.119.95.66', 'end': '80.119.95.126'}], 'gateway_ip': '80.119.95.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '80.119.95.66', 'tags': [], 'project_id': 'f54c9067e32f432db04943d9892bee8a'}}
2025-10-15 15:57:05,729 - INFO - Created VN ctest-mgmt_ctest-TestECMPSanity-37835179-60810536
2025-10-15 15:57:05,748 - DEBUG - VN ctest-mgmt_ctest-TestECMPSanity-37835179-60810536 UUID is d9caccaa-28c9-4636-9b9b-cb62ce0df9ba
2025-10-15 15:57:06,107 - DEBUG - Response for create_network : {'network': {'id': '25ab3aff-b089-47bb-8de6-c6bbd2d22094', 'name': 'ctest-left_ctest-TestECMPSanity-37835179-65731562', 'tenant_id': 'f54c9067e32f432db04943d9892bee8a', 'project_id': 'f54c9067e32f432db04943d9892bee8a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestECMPSanity-37835179', 'ctest-left_ctest-TestECMPSanity-37835179-65731562'], 'port_security_enabled': True, 'description': ''}}
2025-10-15 15:57:06,367 - DEBUG - Response for create_subnet : {'subnet': {'id': '24518888-b19e-41fe-a05d-db99b1aa8846', 'name': '', 'tenant_id': 'f54c9067e32f432db04943d9892bee8a', 'network_id': '25ab3aff-b089-47bb-8de6-c6bbd2d22094', 'ip_version': 4, 'cidr': '7.182.63.128/26', 'allocation_pools': [{'start': '7.182.63.130', 'end': '7.182.63.190'}], 'gateway_ip': '7.182.63.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '7.182.63.130', 'tags': [], 'project_id': 'f54c9067e32f432db04943d9892bee8a'}}
2025-10-15 15:57:06,392 - INFO - Created VN ctest-left_ctest-TestECMPSanity-37835179-65731562
2025-10-15 15:57:06,405 - DEBUG - VN ctest-left_ctest-TestECMPSanity-37835179-65731562 UUID is 25ab3aff-b089-47bb-8de6-c6bbd2d22094
2025-10-15 15:57:06,780 - DEBUG - Response for create_network : {'network': {'id': '902ed8ff-26a3-427a-8e5d-b4ef1cc1a26a', 'name': 'ctest-right_ctest-TestECMPSanity-37835179-78146528', 'tenant_id': 'f54c9067e32f432db04943d9892bee8a', 'project_id': 'f54c9067e32f432db04943d9892bee8a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestECMPSanity-37835179', 'ctest-right_ctest-TestECMPSanity-37835179-78146528'], 'port_security_enabled': True, 'description': ''}}
2025-10-15 15:57:06,988 - DEBUG - Response for create_subnet : {'subnet': {'id': 'b97ed205-8cf1-40d7-bf8c-777dc21d51fa', 'name': '', 'tenant_id': 'f54c9067e32f432db04943d9892bee8a', 'network_id': '902ed8ff-26a3-427a-8e5d-b4ef1cc1a26a', 'ip_version': 4, 'cidr': '3.106.90.64/26', 'allocation_pools': [{'start': '3.106.90.66', 'end': '3.106.90.126'}], 'gateway_ip': '3.106.90.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '3.106.90.66', 'tags': [], 'project_id': 'f54c9067e32f432db04943d9892bee8a'}}
2025-10-15 15:57:07,016 - INFO - Created VN ctest-right_ctest-TestECMPSanity-37835179-78146528
2025-10-15 15:57:07,030 - DEBUG - VN ctest-right_ctest-TestECMPSanity-37835179-78146528 UUID is 902ed8ff-26a3-427a-8e5d-b4ef1cc1a26a
2025-10-15 15:57:07,176 - DEBUG - Services list from nova: [, , , ]
2025-10-15 15:57:08,170 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4330-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4330-1)
2025-10-15 15:57:09,381 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4330-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4330-2)
2025-10-15 15:57:09,384 - INFO - ================================================================================
2025-10-15 15:57:09,384 - INFO - STARTING TEST    : test_ecmp_svc_in_network_with_static_route_no_policy
2025-10-15 15:57:09,384 - INFO - TEST DESCRIPTION : 
        Description:    Validate service chaining in-network mode datapath having a static route entries of the either virtual networks pointing to the corresponding interfaces of the
        service instance. We will not configure any policy.
        Test steps:
            1.  Creating vm's - vm1 and vm2 in networks vn1 and vn2.
            2.  Creating a service instance in in-network mode with 1 instance and left-interface of the service instance sharing the IP and both the left and the right interfaces enabled for static route.
            3.  Delete the policy.
            4.  Checking for ping and tcp traffic between vm1 and vm2.
        Pass criteria: Ping between the VMs should be successful and TCP traffic should reach vm2 from vm1.
        Maintainer : ganeshahv@juniper.net
        
2025-10-15 15:57:10,075 - DEBUG - Nothing to compare xmpp stats {'10.0.0.141': {'10.20.0.5': '0', '10.20.0.18': '0'}, '10.0.0.33': {'10.20.0.18': '0', '10.20.0.252': '0'}} with
2025-10-15 15:57:10,075 - INFO - Initial checks done. Running the testcase now
2025-10-15 15:57:10,075 - INFO - 
2025-10-15 15:57:10,075 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-65496006']
2025-10-15 15:57:10,389 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-65496006'] created succesfully
2025-10-15 15:57:10,683 - DEBUG - Image by name tiny_in_net not found
2025-10-15 15:57:10,683 - DEBUG - Installing image tiny_in_net
2025-10-15 15:57:10,683 - DEBUG - Image info {'name': 'tinycore-in-network.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_in_net/tinycore-in-network-flat.vmdk', 'shrinked_vmdk': "'no'"}
2025-10-15 15:57:10,683 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network.qcow2.gz
2025-10-15 15:57:10,683 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network.qcow2.gz
2025-10-15 15:57:10,683 - DEBUG - Unzip image
2025-10-15 15:57:10,683 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network.qcow2.gz
2025-10-15 15:57:10,695 - INFO - image /contrail-test/images/tinycore-in-network.qcow2 is not found
2025-10-15 15:57:10,695 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-65496006']
2025-10-15 15:57:10,805 - INFO - Service template: ['default-domain', 'ctest-service_template_1-65496006'] deleted successfully.
2025-10-15 15:57:11,507 - DEBUG - No XMPP flaps were noticed during the test
2025-10-15 15:57:11,508 - INFO - 
2025-10-15 15:57:11,508 - INFO - END TEST : test_ecmp_svc_in_network_with_static_route_no_policy : SKIPPED[0:00:02]
2025-10-15 15:57:11,508 - INFO - --------------------------------------------------------------------------------
2025-10-15 15:57:11,511 - INFO - ================================================================================
2025-10-15 15:57:11,512 - INFO - STARTING TEST    : test_ecmp_svc_v2_transparent_with_3_instance
2025-10-15 15:57:11,512 - INFO - TEST DESCRIPTION : 
           Description: Validate ECMP with version 2 service chaining transparent mode datapath having service instance
           Test steps:
                1.Creating vm's - vm1 and vm2 in networks vn1 and vn2.
                2.Creating a service instance in transparent mode with 3 instances.
                3.Creating a service chain by applying the service instance as a service in a policy between the VNs.
                4.Checking for ping and bidirectional tcp traffic between vm1 and vm2.
           Pass criteria: Ping between the VMs should be successful and TCP traffic should reach vm2 from vm1 and vice-versa.
           Maintainer : ganeshahv@juniper.net
        
2025-10-15 15:57:12,178 - DEBUG - Nothing to compare xmpp stats {'10.0.0.141': {'10.20.0.5': '0', '10.20.0.18': '0'}, '10.0.0.33': {'10.20.0.18': '0', '10.20.0.252': '0'}} with
2025-10-15 15:57:12,178 - INFO - Initial checks done. Running the testcase now
2025-10-15 15:57:12,178 - INFO - 
2025-10-15 15:57:12,178 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-4330-1', 'an-jenkins-deploy-platform-ansible-os-4330-2']}
2025-10-15 15:57:12,178 - INFO - Skipped as test requires at least 3 nodes, but only 2 found
2025-10-15 15:57:12,835 - DEBUG - No XMPP flaps were noticed during the test
2025-10-15 15:57:12,835 - INFO - 
2025-10-15 15:57:12,836 - INFO - END TEST : test_ecmp_svc_v2_transparent_with_3_instance : SKIPPED[0:00:01]
2025-10-15 15:57:12,836 - INFO - --------------------------------------------------------------------------------
2025-10-15 15:57:12,837 - INFO - Skip interface_detach for VM ctest-right_vm_ctest-TestECMPSanity-37835179-63567634 in state BUILD
2025-10-15 15:57:12,837 - INFO - Deleting VM ctest-right_vm_ctest-TestECMPSanity-37835179-63567634
2025-10-15 15:57:12,869 - ERROR - VM ctest-right_vm_ctest-TestECMPSanity-37835179-63567634 has failed to come up
2025-10-15 15:57:12,869 - ERROR - Nova failed to get host of the VM
2025-10-15 15:57:12,869 - ERROR - VM ctest-right_vm_ctest-TestECMPSanity-37835179-63567634 has failed to come up
2025-10-15 15:57:12,870 - ERROR - Nova failed to get host of the VM
2025-10-15 15:57:12,941 - INFO - Skip interface_detach for VM ctest-left_vm_ctest-TestECMPSanity-37835179-57336775 in state BUILD
2025-10-15 15:57:12,941 - INFO - Deleting VM ctest-left_vm_ctest-TestECMPSanity-37835179-57336775
2025-10-15 15:57:12,941 - ERROR - VM ctest-left_vm_ctest-TestECMPSanity-37835179-57336775 has failed to come up
2025-10-15 15:57:12,941 - ERROR - Nova failed to get host of the VM
2025-10-15 15:57:12,941 - ERROR - VM ctest-left_vm_ctest-TestECMPSanity-37835179-57336775 has failed to come up
2025-10-15 15:57:12,941 - ERROR - Nova failed to get host of the VM
2025-10-15 15:57:13,012 - INFO - Deleting VN ctest-left_ctest-TestECMPSanity-37835179-65731562 
2025-10-15 15:57:13,066 - DEBUG - VN 25ab3aff-b089-47bb-8de6-c6bbd2d22094 still in use: Unable to complete operation on network 25ab3aff-b089-47bb-8de6-c6bbd2d22094. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-c09d8753-39c4-4930-bbab-ff7e043981a2']
2025-10-15 15:57:13,066 - WARNING - Deleting VN ctest-left_ctest-TestECMPSanity-37835179-65731562 failed..Will retry
2025-10-15 15:57:15,262 - DEBUG - Response for deleting network ()
2025-10-15 15:57:15,263 - INFO - Deleting VN ctest-right_ctest-TestECMPSanity-37835179-78146528 
2025-10-15 15:57:15,443 - DEBUG - Response for deleting network ()
2025-10-15 15:57:15,443 - INFO - Deleting VN ctest-mgmt_ctest-TestECMPSanity-37835179-60810536 
2025-10-15 15:57:15,600 - DEBUG - Response for deleting network ()
2025-10-15 15:57:16,336 - INFO - Deleted project: ctest-TestECMPSanity-37835179, ID : f54c9067-e32f-432d-b049-43d9892bee8a