2025-10-29 11:34:39,918 - INFO - Domain Default found not creating
2025-10-29 11:34:40,092 - INFO - Project ctest-TestECMPConfigHashFeature-98945208 not found, creating it
2025-10-29 11:34:40,844 - INFO - Created Project:ctest-TestECMPConfigHashFeature-98945208, ID : 99c57f10-2016-4606-841f-ea2bafb86997 
2025-10-29 11:34:43,178 - DEBUG - Response for create_network : {'network': {'id': '27671291-027a-48de-8cb3-2d5eaf2d4d43', 'name': 'ctest-mgmt_ctest-TestECMPConfigHashFeature-98945208-05542323', 'tenant_id': '99c57f1020164606841fea2bafb86997', 'project_id': '99c57f1020164606841fea2bafb86997', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestECMPConfigHashFeature-98945208', 'ctest-mgmt_ctest-TestECMPConfigHashFeature-98945208-05542323'], 'port_security_enabled': True, 'description': ''}}
2025-10-29 11:34:43,482 - DEBUG - Response for create_subnet : {'subnet': {'id': '97825b3a-18cb-4274-917a-d0c9f454c9b1', 'name': '', 'tenant_id': '99c57f1020164606841fea2bafb86997', 'network_id': '27671291-027a-48de-8cb3-2d5eaf2d4d43', 'ip_version': 4, 'cidr': '110.9.86.192/26', 'allocation_pools': [{'start': '110.9.86.194', 'end': '110.9.86.254'}], 'gateway_ip': '110.9.86.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '110.9.86.194', 'tags': [], 'project_id': '99c57f1020164606841fea2bafb86997'}}
2025-10-29 11:34:43,520 - INFO - Created VN ctest-mgmt_ctest-TestECMPConfigHashFeature-98945208-05542323
2025-10-29 11:34:43,545 - DEBUG - VN ctest-mgmt_ctest-TestECMPConfigHashFeature-98945208-05542323 UUID is 27671291-027a-48de-8cb3-2d5eaf2d4d43
2025-10-29 11:34:43,985 - DEBUG - Response for create_network : {'network': {'id': '55097c1c-b2e5-4739-8c58-3169e01cdaa2', 'name': 'ctest-left_ctest-TestECMPConfigHashFeature-98945208-14610135', 'tenant_id': '99c57f1020164606841fea2bafb86997', 'project_id': '99c57f1020164606841fea2bafb86997', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestECMPConfigHashFeature-98945208', 'ctest-left_ctest-TestECMPConfigHashFeature-98945208-14610135'], 'port_security_enabled': True, 'description': ''}}
2025-10-29 11:34:44,261 - DEBUG - Response for create_subnet : {'subnet': {'id': 'b0e6e874-145f-40cf-8251-7f16bec41cd3', 'name': '', 'tenant_id': '99c57f1020164606841fea2bafb86997', 'network_id': '55097c1c-b2e5-4739-8c58-3169e01cdaa2', 'ip_version': 4, 'cidr': '9.1.114.0/26', 'allocation_pools': [{'start': '9.1.114.2', 'end': '9.1.114.62'}], 'gateway_ip': '9.1.114.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '9.1.114.2', 'tags': [], 'project_id': '99c57f1020164606841fea2bafb86997'}}
2025-10-29 11:34:44,288 - INFO - Created VN ctest-left_ctest-TestECMPConfigHashFeature-98945208-14610135
2025-10-29 11:34:44,299 - DEBUG - VN ctest-left_ctest-TestECMPConfigHashFeature-98945208-14610135 UUID is 55097c1c-b2e5-4739-8c58-3169e01cdaa2
2025-10-29 11:34:44,785 - DEBUG - Response for create_network : {'network': {'id': 'f2c77bcf-bef1-4433-97b3-c582e8b68ef3', 'name': 'ctest-right_ctest-TestECMPConfigHashFeature-98945208-13378599', 'tenant_id': '99c57f1020164606841fea2bafb86997', 'project_id': '99c57f1020164606841fea2bafb86997', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestECMPConfigHashFeature-98945208', 'ctest-right_ctest-TestECMPConfigHashFeature-98945208-13378599'], 'port_security_enabled': True, 'description': ''}}
2025-10-29 11:34:45,073 - DEBUG - Response for create_subnet : {'subnet': {'id': '66f9bbf1-ae49-43fb-b96d-5f4d954decca', 'name': '', 'tenant_id': '99c57f1020164606841fea2bafb86997', 'network_id': 'f2c77bcf-bef1-4433-97b3-c582e8b68ef3', 'ip_version': 4, 'cidr': '220.76.212.128/26', 'allocation_pools': [{'start': '220.76.212.130', 'end': '220.76.212.190'}], 'gateway_ip': '220.76.212.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '220.76.212.130', 'tags': [], 'project_id': '99c57f1020164606841fea2bafb86997'}}
2025-10-29 11:34:45,101 - INFO - Created VN ctest-right_ctest-TestECMPConfigHashFeature-98945208-13378599
2025-10-29 11:34:45,116 - DEBUG - VN ctest-right_ctest-TestECMPConfigHashFeature-98945208-13378599 UUID is f2c77bcf-bef1-4433-97b3-c582e8b68ef3
2025-10-29 11:34:45,260 - DEBUG - Services list from nova: [, , , ]
2025-10-29 11:34:45,284 - DEBUG - Image by name cirros-traffic not found
2025-10-29 11:34:45,284 - DEBUG - Installing image cirros-traffic
2025-10-29 11:34:45,284 - 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-29 11:34:45,284 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/converts//cirros-0.4.0-x86_64-disk.img
2025-10-29 11:34:45,284 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/converts//cirros-0.4.0-x86_64-disk.img
2025-10-29 11:34:45,298 - 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-29 11:34:45,404 - DEBUG - Image has been downloaded to /contrail-test/images/cirros-0.4.0-x86_64-disk.img
2025-10-29 11:34:45,405 - DEBUG - Try to create image in user context
2025-10-29 11:34:45,628 - DEBUG - Image has been created in user context
2025-10-29 11:34:45,628 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: rm -f /contrail-test/images/cirros-0.4.0-x86_64-disk.img
2025-10-29 11:34:45,641 - DEBUG - Downloaded image has been removed
2025-10-29 11:34:45,657 - DEBUG - Uploaded image status = active
2025-10-29 11:34:46,761 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4521-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4521-2)
2025-10-29 11:34:48,422 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4521-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4521-1)
2025-10-29 11:34:48,429 - INFO - ================================================================================
2025-10-29 11:34:48,430 - INFO - STARTING TEST    : test_ecmp_hash_src_ip
2025-10-29 11:34:48,430 - INFO - TEST DESCRIPTION : 
            Validates ecmp hash when only source ip is configured
            Maintainer : cmallam@juniper.net
        
2025-10-29 11:34:49,096 - DEBUG - Nothing to compare xmpp stats {'10.0.0.49': {'10.20.0.17': '0', '10.20.0.254': '0'}, '10.0.0.50': {'10.20.0.254': '0', '10.20.0.14': '0'}} with
2025-10-29 11:34:49,096 - INFO - Initial checks done. Running the testcase now
2025-10-29 11:34:49,096 - INFO - 
2025-10-29 11:34:49,097 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-4521-2', 'an-jenkins-deploy-platform-ansible-os-4521-1']}
2025-10-29 11:34:49,097 - INFO - Skipped as test requires at least 3 nodes, but only 2 found
2025-10-29 11:34:49,849 - DEBUG - No XMPP flaps were noticed during the test
2025-10-29 11:34:49,849 - INFO - 
2025-10-29 11:34:49,849 - INFO - END TEST : test_ecmp_hash_src_ip : SKIPPED[0:00:01]
2025-10-29 11:34:49,849 - INFO - --------------------------------------------------------------------------------
2025-10-29 11:34:49,854 - INFO - Skip interface_detach for VM ctest-right_vm_ctest-TestECMPConfigHashFeature-98945208-03667195 in state BUILD
2025-10-29 11:34:49,854 - INFO - Deleting VM ctest-right_vm_ctest-TestECMPConfigHashFeature-98945208-03667195
2025-10-29 11:34:49,883 - ERROR - VM ctest-right_vm_ctest-TestECMPConfigHashFeature-98945208-03667195 has failed to come up
2025-10-29 11:34:49,883 - ERROR - Nova failed to get host of the VM
2025-10-29 11:34:49,883 - ERROR - VM ctest-right_vm_ctest-TestECMPConfigHashFeature-98945208-03667195 has failed to come up
2025-10-29 11:34:49,883 - ERROR - Nova failed to get host of the VM
2025-10-29 11:34:49,968 - INFO - Skip interface_detach for VM ctest-left_vm_ctest-TestECMPConfigHashFeature-98945208-30778084 in state BUILD
2025-10-29 11:34:49,969 - INFO - Deleting VM ctest-left_vm_ctest-TestECMPConfigHashFeature-98945208-30778084
2025-10-29 11:34:49,970 - ERROR - VM ctest-left_vm_ctest-TestECMPConfigHashFeature-98945208-30778084 has failed to come up
2025-10-29 11:34:49,970 - ERROR - Nova failed to get host of the VM
2025-10-29 11:34:49,970 - ERROR - VM ctest-left_vm_ctest-TestECMPConfigHashFeature-98945208-30778084 has failed to come up
2025-10-29 11:34:49,970 - ERROR - Nova failed to get host of the VM
2025-10-29 11:34:50,069 - INFO - Deleting VN ctest-left_ctest-TestECMPConfigHashFeature-98945208-14610135 
2025-10-29 11:34:50,136 - DEBUG - VN 55097c1c-b2e5-4739-8c58-3169e01cdaa2 still in use: Unable to complete operation on network 55097c1c-b2e5-4739-8c58-3169e01cdaa2. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-5ee58199-8807-4ffb-9daa-f16305533afe']
2025-10-29 11:34:50,136 - WARNING - Deleting VN ctest-left_ctest-TestECMPConfigHashFeature-98945208-14610135 failed..Will retry
2025-10-29 11:34:52,310 - DEBUG - Response for deleting network ()
2025-10-29 11:34:52,310 - INFO - Deleting VN ctest-right_ctest-TestECMPConfigHashFeature-98945208-13378599 
2025-10-29 11:34:52,371 - DEBUG - VN f2c77bcf-bef1-4433-97b3-c582e8b68ef3 still in use: Unable to complete operation on network f2c77bcf-bef1-4433-97b3-c582e8b68ef3. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-f158d5f8-01de-4447-a981-b16c12964c91']
2025-10-29 11:34:52,371 - WARNING - Deleting VN ctest-right_ctest-TestECMPConfigHashFeature-98945208-13378599 failed..Will retry
2025-10-29 11:34:54,450 - DEBUG - VN f2c77bcf-bef1-4433-97b3-c582e8b68ef3 still in use: Unable to complete operation on network f2c77bcf-bef1-4433-97b3-c582e8b68ef3. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-58eb9af2-10d6-4d4d-9e1f-de28f6b534f3']
2025-10-29 11:34:54,450 - WARNING - Deleting VN ctest-right_ctest-TestECMPConfigHashFeature-98945208-13378599 failed..Will retry
2025-10-29 11:34:56,639 - DEBUG - Response for deleting network ()
2025-10-29 11:34:56,639 - INFO - Deleting VN ctest-mgmt_ctest-TestECMPConfigHashFeature-98945208-05542323 
2025-10-29 11:34:56,843 - DEBUG - Response for deleting network ()
2025-10-29 11:34:57,630 - INFO - Deleted project: ctest-TestECMPConfigHashFeature-98945208, ID : 99c57f10-2016-4606-841f-ea2bafb86997