2025-10-14 11:16:07,909 - INFO - Domain Default found not creating
2025-10-14 11:16:08,083 - INFO - Project ctest-TestECMPConfigHashFeature-66869881 not found, creating it
2025-10-14 11:16:08,776 - INFO - Created Project:ctest-TestECMPConfigHashFeature-66869881, ID : 9889252d-f2e2-4515-bbbe-2ec45d21b118 
2025-10-14 11:16:11,183 - DEBUG - Response for create_network : {'network': {'id': '1f9bb86f-0114-42f1-b389-83dba8b6dd81', 'name': 'ctest-mgmt_ctest-TestECMPConfigHashFeature-66869881-92776735', 'tenant_id': '9889252df2e24515bbbe2ec45d21b118', 'project_id': '9889252df2e24515bbbe2ec45d21b118', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestECMPConfigHashFeature-66869881', 'ctest-mgmt_ctest-TestECMPConfigHashFeature-66869881-92776735'], 'port_security_enabled': True, 'description': ''}}
2025-10-14 11:16:11,541 - DEBUG - Response for create_subnet : {'subnet': {'id': 'caa4fe2f-4f79-42f8-a0b7-893e0f240026', 'name': '', 'tenant_id': '9889252df2e24515bbbe2ec45d21b118', 'network_id': '1f9bb86f-0114-42f1-b389-83dba8b6dd81', 'ip_version': 4, 'cidr': '128.210.124.64/26', 'allocation_pools': [{'start': '128.210.124.66', 'end': '128.210.124.126'}], 'gateway_ip': '128.210.124.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '128.210.124.66', 'tags': [], 'project_id': '9889252df2e24515bbbe2ec45d21b118'}}
2025-10-14 11:16:11,577 - INFO - Created VN ctest-mgmt_ctest-TestECMPConfigHashFeature-66869881-92776735
2025-10-14 11:16:11,590 - DEBUG - VN ctest-mgmt_ctest-TestECMPConfigHashFeature-66869881-92776735 UUID is 1f9bb86f-0114-42f1-b389-83dba8b6dd81
2025-10-14 11:16:12,210 - DEBUG - Response for create_network : {'network': {'id': '22f8cd74-8459-4285-9196-42af993a24a7', 'name': 'ctest-left_ctest-TestECMPConfigHashFeature-66869881-91393336', 'tenant_id': '9889252df2e24515bbbe2ec45d21b118', 'project_id': '9889252df2e24515bbbe2ec45d21b118', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestECMPConfigHashFeature-66869881', 'ctest-left_ctest-TestECMPConfigHashFeature-66869881-91393336'], 'port_security_enabled': True, 'description': ''}}
2025-10-14 11:16:12,620 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a2ce20aa-03c4-448b-9a7f-fab5bc31e3a9', 'name': '', 'tenant_id': '9889252df2e24515bbbe2ec45d21b118', 'network_id': '22f8cd74-8459-4285-9196-42af993a24a7', 'ip_version': 4, 'cidr': '86.162.49.192/26', 'allocation_pools': [{'start': '86.162.49.194', 'end': '86.162.49.254'}], 'gateway_ip': '86.162.49.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '86.162.49.194', 'tags': [], 'project_id': '9889252df2e24515bbbe2ec45d21b118'}}
2025-10-14 11:16:12,653 - INFO - Created VN ctest-left_ctest-TestECMPConfigHashFeature-66869881-91393336
2025-10-14 11:16:12,669 - DEBUG - VN ctest-left_ctest-TestECMPConfigHashFeature-66869881-91393336 UUID is 22f8cd74-8459-4285-9196-42af993a24a7
2025-10-14 11:16:13,202 - DEBUG - Response for create_network : {'network': {'id': '8425bbde-2caf-4106-a947-5c1e47563de7', 'name': 'ctest-right_ctest-TestECMPConfigHashFeature-66869881-35042639', 'tenant_id': '9889252df2e24515bbbe2ec45d21b118', 'project_id': '9889252df2e24515bbbe2ec45d21b118', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestECMPConfigHashFeature-66869881', 'ctest-right_ctest-TestECMPConfigHashFeature-66869881-35042639'], 'port_security_enabled': True, 'description': ''}}
2025-10-14 11:16:13,532 - DEBUG - Response for create_subnet : {'subnet': {'id': '221df515-8a40-46a0-9ebb-d9ec8c08473a', 'name': '', 'tenant_id': '9889252df2e24515bbbe2ec45d21b118', 'network_id': '8425bbde-2caf-4106-a947-5c1e47563de7', 'ip_version': 4, 'cidr': '29.15.131.192/26', 'allocation_pools': [{'start': '29.15.131.194', 'end': '29.15.131.254'}], 'gateway_ip': '29.15.131.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '29.15.131.194', 'tags': [], 'project_id': '9889252df2e24515bbbe2ec45d21b118'}}
2025-10-14 11:16:13,563 - INFO - Created VN ctest-right_ctest-TestECMPConfigHashFeature-66869881-35042639
2025-10-14 11:16:13,584 - DEBUG - VN ctest-right_ctest-TestECMPConfigHashFeature-66869881-35042639 UUID is 8425bbde-2caf-4106-a947-5c1e47563de7
2025-10-14 11:16:13,731 - DEBUG - Services list from nova: [, , , ]
2025-10-14 11:16:13,751 - DEBUG - Image by name cirros-traffic not found
2025-10-14 11:16:13,751 - DEBUG - Installing image cirros-traffic
2025-10-14 11:16:13,751 - DEBUG - Image info {'name': 'cirros-0.4.0-x86_64-disk.img', 'webserver': '', 'location': '/images/converts/', 'username': 'cirros', 'password': 'gocubsgo', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hw_scsi_model=virtio-scsi --property hw_disk_bus_model=virtio-scsi --property hw_disk_bus=virtio', 'name_docker': 'phusion-baseimage-enablesshd'}
2025-10-14 11:16:13,752 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/converts//cirros-0.4.0-x86_64-disk.img
2025-10-14 11:16:13,752 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/converts//cirros-0.4.0-x86_64-disk.img
2025-10-14 11:16:13,763 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/converts//cirros-0.4.0-x86_64-disk.img -O /contrail-test/images/cirros-0.4.0-x86_64-disk.img
2025-10-14 11:16:13,859 - DEBUG - Image has been downloaded to /contrail-test/images/cirros-0.4.0-x86_64-disk.img
2025-10-14 11:16:13,860 - DEBUG - Try to create image in user context
2025-10-14 11:16:14,046 - DEBUG - Image has been created in user context
2025-10-14 11:16:14,046 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: rm -f /contrail-test/images/cirros-0.4.0-x86_64-disk.img
2025-10-14 11:16:14,058 - DEBUG - Downloaded image has been removed
2025-10-14 11:16:14,072 - DEBUG - Uploaded image status = active
2025-10-14 11:16:15,148 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4312-30), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4312-30)
2025-10-14 11:16:16,558 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4312-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4312-1)
2025-10-14 11:16:16,561 - INFO - ================================================================================
2025-10-14 11:16:16,561 - INFO - STARTING TEST    : test_ecmp_hash_src_ip
2025-10-14 11:16:16,561 - INFO - TEST DESCRIPTION : 
            Validates ecmp hash when only source ip is configured
            Maintainer : cmallam@juniper.net
        
2025-10-14 11:16:17,239 - DEBUG - Nothing to compare xmpp stats {'10.0.0.65': {'10.20.0.17': '0', '10.20.0.210': '0'}, '10.0.0.22': {'10.20.0.210': '0', '10.20.0.14': '0'}} with
2025-10-14 11:16:17,239 - INFO - Initial checks done. Running the testcase now
2025-10-14 11:16:17,239 - INFO - 
2025-10-14 11:16:17,240 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-4312-30', 'an-jenkins-deploy-platform-ansible-os-4312-1']}
2025-10-14 11:16:17,240 - INFO - Skipped as test requires at least 3 nodes, but only 2 found
2025-10-14 11:16:17,910 - DEBUG - No XMPP flaps were noticed during the test
2025-10-14 11:16:17,910 - INFO - 
2025-10-14 11:16:17,911 - INFO - END TEST : test_ecmp_hash_src_ip : SKIPPED[0:00:01]
2025-10-14 11:16:17,911 - INFO - --------------------------------------------------------------------------------
2025-10-14 11:16:17,912 - INFO - Skip interface_detach for VM ctest-right_vm_ctest-TestECMPConfigHashFeature-66869881-56663770 in state BUILD
2025-10-14 11:16:17,913 - INFO - Deleting VM ctest-right_vm_ctest-TestECMPConfigHashFeature-66869881-56663770
2025-10-14 11:16:17,946 - ERROR - VM ctest-right_vm_ctest-TestECMPConfigHashFeature-66869881-56663770 has failed to come up
2025-10-14 11:16:17,946 - ERROR - Nova failed to get host of the VM
2025-10-14 11:16:17,946 - ERROR - VM ctest-right_vm_ctest-TestECMPConfigHashFeature-66869881-56663770 has failed to come up
2025-10-14 11:16:17,946 - ERROR - Nova failed to get host of the VM
2025-10-14 11:16:18,073 - INFO - Skip interface_detach for VM ctest-left_vm_ctest-TestECMPConfigHashFeature-66869881-44196120 in state BUILD
2025-10-14 11:16:18,073 - INFO - Deleting VM ctest-left_vm_ctest-TestECMPConfigHashFeature-66869881-44196120
2025-10-14 11:16:18,073 - ERROR - VM ctest-left_vm_ctest-TestECMPConfigHashFeature-66869881-44196120 has failed to come up
2025-10-14 11:16:18,073 - ERROR - Nova failed to get host of the VM
2025-10-14 11:16:18,073 - ERROR - VM ctest-left_vm_ctest-TestECMPConfigHashFeature-66869881-44196120 has failed to come up
2025-10-14 11:16:18,073 - ERROR - Nova failed to get host of the VM
2025-10-14 11:16:18,176 - INFO - Deleting VN ctest-left_ctest-TestECMPConfigHashFeature-66869881-91393336 
2025-10-14 11:16:18,250 - DEBUG - VN 22f8cd74-8459-4285-9196-42af993a24a7 still in use: Unable to complete operation on network 22f8cd74-8459-4285-9196-42af993a24a7. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-99bfbfd4-9c6f-46c1-aafd-3cc1552577e4']
2025-10-14 11:16:18,250 - WARNING - Deleting VN ctest-left_ctest-TestECMPConfigHashFeature-66869881-91393336 failed..Will retry
2025-10-14 11:16:20,469 - DEBUG - Response for deleting network ()
2025-10-14 11:16:20,469 - INFO - Deleting VN ctest-right_ctest-TestECMPConfigHashFeature-66869881-35042639 
2025-10-14 11:16:20,680 - DEBUG - VN 8425bbde-2caf-4106-a947-5c1e47563de7 still in use: Unable to complete operation on network 8425bbde-2caf-4106-a947-5c1e47563de7. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-695f8470-4973-4287-8eac-284b5d1217a5']
2025-10-14 11:16:20,680 - WARNING - Deleting VN ctest-right_ctest-TestECMPConfigHashFeature-66869881-35042639 failed..Will retry
2025-10-14 11:16:22,750 - DEBUG - VN 8425bbde-2caf-4106-a947-5c1e47563de7 still in use: Unable to complete operation on network 8425bbde-2caf-4106-a947-5c1e47563de7. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-04170b47-d15d-4f26-8122-08c371306f55']
2025-10-14 11:16:22,750 - WARNING - Deleting VN ctest-right_ctest-TestECMPConfigHashFeature-66869881-35042639 failed..Will retry
2025-10-14 11:16:24,966 - DEBUG - Response for deleting network ()
2025-10-14 11:16:24,966 - INFO - Deleting VN ctest-mgmt_ctest-TestECMPConfigHashFeature-66869881-92776735 
2025-10-14 11:16:25,207 - DEBUG - Response for deleting network ()
2025-10-14 11:16:26,045 - INFO - Deleted project: ctest-TestECMPConfigHashFeature-66869881, ID : 9889252d-f2e2-4515-bbbe-2ec45d21b118