2025-08-03 01:02:11,182 - INFO - Domain Default found not creating
2025-08-03 01:02:11,415 - INFO - Project ctest-TestIpVlanLearning-55827545 not found, creating it
2025-08-03 01:02:11,982 - INFO - Created Project:ctest-TestIpVlanLearning-55827545, ID : 9e52b3e6-5d1d-48a6-91c6-cbb2a1a4f8fd
2025-08-03 01:02:13,671 - DEBUG - Services list from nova: [, , , ]
2025-08-03 01:02:13,671 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-3743-2', 'an-jenkins-deploy-platform-ansible-os-3743-1']}
2025-08-03 01:02:13,672 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-3743-2', 'an-jenkins-deploy-platform-ansible-os-3743-1']}
2025-08-03 01:02:14,533 - DEBUG - Response for create_network : {'network': {'id': 'fa8b2ae6-e036-442e-bfdf-06601b60282c', 'name': 'ctest-vn1-13762801', 'tenant_id': '9e52b3e65d1d48a691c6cbb2a1a4f8fd', 'project_id': '9e52b3e65d1d48a691c6cbb2a1a4f8fd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestIpVlanLearning-55827545', 'ctest-vn1-13762801'], 'port_security_enabled': True, 'description': ''}}
2025-08-03 01:02:14,855 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c99e8b95-7748-4ad2-8412-38984298925d', 'name': '', 'tenant_id': '9e52b3e65d1d48a691c6cbb2a1a4f8fd', 'network_id': 'fa8b2ae6-e036-442e-bfdf-06601b60282c', 'ip_version': 4, 'cidr': '153.106.126.0/24', 'allocation_pools': [{'start': '153.106.126.2', 'end': '153.106.126.254'}], 'gateway_ip': '153.106.126.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '153.106.126.2', 'tags': [], 'project_id': '9e52b3e65d1d48a691c6cbb2a1a4f8fd'}}
2025-08-03 01:02:14,889 - INFO - Created VN ctest-vn1-13762801
2025-08-03 01:02:14,922 - DEBUG - VN ctest-vn1-13762801 UUID is fa8b2ae6-e036-442e-bfdf-06601b60282c
2025-08-03 01:02:15,395 - DEBUG - Response for create_network : {'network': {'id': '79989ae0-c508-4da5-ae42-c93074181dbb', 'name': 'ctest-vn2-56951453', 'tenant_id': '9e52b3e65d1d48a691c6cbb2a1a4f8fd', 'project_id': '9e52b3e65d1d48a691c6cbb2a1a4f8fd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestIpVlanLearning-55827545', 'ctest-vn2-56951453'], 'port_security_enabled': True, 'description': ''}}
2025-08-03 01:02:15,716 - DEBUG - Response for create_subnet : {'subnet': {'id': '006b4102-7483-4fa9-9b77-3e8a95c7d3d4', 'name': '', 'tenant_id': '9e52b3e65d1d48a691c6cbb2a1a4f8fd', 'network_id': '79989ae0-c508-4da5-ae42-c93074181dbb', 'ip_version': 4, 'cidr': '41.212.20.0/24', 'allocation_pools': [{'start': '41.212.20.2', 'end': '41.212.20.254'}], 'gateway_ip': '41.212.20.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '41.212.20.2', 'tags': [], 'project_id': '9e52b3e65d1d48a691c6cbb2a1a4f8fd'}}
2025-08-03 01:02:15,746 - INFO - Created VN ctest-vn2-56951453
2025-08-03 01:02:15,760 - DEBUG - VN ctest-vn2-56951453 UUID is 79989ae0-c508-4da5-ae42-c93074181dbb
2025-08-03 01:02:15,873 - DEBUG - Updating mac_ip_learning flag on VN default-domain:ctest-TestIpVlanLearning-55827545:ctest-vn1-13762801 to True
2025-08-03 01:02:16,001 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/fa8b2ae6-e036-442e-bfdf-06601b60282c
2025-08-03 01:02:16,296 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/fa8b2ae6-e036-442e-bfdf-06601b60282c
2025-08-03 01:02:16,339 - DEBUG - Updating mac_ip_learning flag on VN default-domain:ctest-TestIpVlanLearning-55827545:ctest-vn2-56951453 to True
2025-08-03 01:02:16,513 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/79989ae0-c508-4da5-ae42-c93074181dbb
2025-08-03 01:02:16,672 - DEBUG - Image by name crpd-ipvlan not found
2025-08-03 01:02:16,672 - DEBUG - Installing image crpd-ipvlan
2025-08-03 01:02:16,672 - DEBUG - Image info {'name': 'docker-crpd-ipvlan2.qcow2', 'webserver': '', 'location': '/images/crpd/', 'username': 'centos', 'password': 'centos', 'type': 'os', 'flavor': 'contrail_crpd', 'params': '--container-format bare --disk-format qcow2 --property vmware_disktype="sparse" --property vmware_adaptertype="ide"', 'name_docker': 'phusion-baseimage-enablesshd'}
2025-08-03 01:02:16,673 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/crpd//docker-crpd-ipvlan2.qcow2
2025-08-03 01:02:16,673 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/crpd//docker-crpd-ipvlan2.qcow2
2025-08-03 01:02:16,695 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/crpd//docker-crpd-ipvlan2.qcow2 -O /contrail-test/images/docker-crpd-ipvlan2.qcow2
2025-08-03 01:02:16,733 - DEBUG - Image has been downloaded to /contrail-test/images/docker-crpd-ipvlan2.qcow2
2025-08-03 01:02:16,733 - DEBUG - Try to create image in user context
2025-08-03 01:02:16,845 - DEBUG - Image has been created in user context
2025-08-03 01:02:16,845 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: rm -f /contrail-test/images/docker-crpd-ipvlan2.qcow2
2025-08-03 01:02:16,860 - DEBUG - Downloaded image has been removed
2025-08-03 01:02:16,874 - DEBUG - Uploaded image status = active
2025-08-03 01:02:18,124 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3743-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3743-1)
2025-08-03 01:02:19,760 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3743-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3743-1)
2025-08-03 01:02:21,069 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3743-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3743-2)
2025-08-03 01:02:22,329 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3743-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3743-2)
2025-08-03 01:02:22,329 - INFO - Waiting for VM ctest-crpd-vm1-12121439 to be up..
2025-08-03 01:02:22,404 - DEBUG - VM is in ERROR state now
2025-08-03 01:02:22,404 - ERROR - VM in error state.
2025-08-03 01:02:22,404 - ERROR - VM is not in ACTIVE state
2025-08-03 01:02:22,505 - ERROR - Fatal Nova Exception while getting VM detail
2025-08-03 01:02:22,505 - DEBUG - None
2025-08-03 01:02:22,506 - INFO - Skip interface_detach for VM ctest-crpd-vm4-61849171 in state BUILD
2025-08-03 01:02:22,506 - INFO - Deleting VM ctest-crpd-vm4-61849171
2025-08-03 01:02:22,533 - ERROR - VM ctest-crpd-vm4-61849171 has failed to come up
2025-08-03 01:02:22,533 - ERROR - Nova failed to get host of the VM
2025-08-03 01:02:22,533 - ERROR - VM ctest-crpd-vm4-61849171 has failed to come up
2025-08-03 01:02:22,533 - ERROR - Nova failed to get host of the VM
2025-08-03 01:02:22,716 - INFO - Skip interface_detach for VM ctest-crpd-vm3-13267098 in state BUILD
2025-08-03 01:02:22,716 - INFO - Deleting VM ctest-crpd-vm3-13267098
2025-08-03 01:02:22,716 - ERROR - VM ctest-crpd-vm3-13267098 has failed to come up
2025-08-03 01:02:22,716 - ERROR - Nova failed to get host of the VM
2025-08-03 01:02:22,717 - ERROR - VM ctest-crpd-vm3-13267098 has failed to come up
2025-08-03 01:02:22,717 - ERROR - Nova failed to get host of the VM
2025-08-03 01:02:22,896 - INFO - Skip interface_detach for VM ctest-crpd-vm2-26012376 in state BUILD
2025-08-03 01:02:22,896 - INFO - Deleting VM ctest-crpd-vm2-26012376
2025-08-03 01:02:22,897 - ERROR - VM ctest-crpd-vm2-26012376 has failed to come up
2025-08-03 01:02:22,897 - ERROR - Nova failed to get host of the VM
2025-08-03 01:02:22,897 - ERROR - VM ctest-crpd-vm2-26012376 has failed to come up
2025-08-03 01:02:22,897 - ERROR - Nova failed to get host of the VM
2025-08-03 01:02:23,074 - INFO - Skip interface_detach for VM ctest-crpd-vm1-12121439 in state ERROR
2025-08-03 01:02:23,074 - INFO - Deleting VM ctest-crpd-vm1-12121439
2025-08-03 01:02:23,074 - ERROR - VM ctest-crpd-vm1-12121439 has failed to come up
2025-08-03 01:02:23,074 - ERROR - Fault seen in nova show is: {'code': 500, 'created': '2025-08-03T01:02:18Z', 'message': 'No valid host was found. ', 'details': 'Traceback (most recent call last):\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/conductor/manager.py", line 1581, in schedule_and_build_instances\n instance_uuids, return_alternates=True)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/conductor/manager.py", line 942, in _schedule_instances\n return_alternates=return_alternates)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/scheduler/client/query.py", line 42, in select_destinations\n instance_uuids, return_objects, return_alternates)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/scheduler/rpcapi.py", line 160, in select_destinations\n return cctxt.call(ctxt, \'select_destinations\', **msg_args)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/rpc/client.py", line 192, in call\n retry=self.retry, transport_options=self.transport_options)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/transport.py", line 128, in _send\n transport_options=transport_options)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/_drivers/amqpdriver.py", line 691, in send\n transport_options=transport_options)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/_drivers/amqpdriver.py", line 681, in _send\n raise result\nnova.exception_Remote.NoValidHost_Remote: No valid host was found. \nTraceback (most recent call last):\n\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/rpc/server.py", line 241, in inner\n return func(*args, **kwargs)\n\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/scheduler/manager.py", line 209, in select_destinations\n raise exception.NoValidHost(reason="")\n\nnova.exception.NoValidHost: No valid host was found. \n\n'}
2025-08-03 01:02:23,081 - INFO - Deleting VN ctest-vn2-56951453
2025-08-03 01:02:23,309 - DEBUG - Response for deleting network ()
2025-08-03 01:02:23,309 - INFO - Deleting VN ctest-vn1-13762801
2025-08-03 01:02:23,488 - DEBUG - Response for deleting network ()
2025-08-03 01:02:23,490 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-3743-2', 'an-jenkins-deploy-platform-ansible-os-3743-1']}
2025-08-03 01:02:23,833 - DEBUG - Response for create_network : {'network': {'id': '736be655-a8d0-4cce-a22d-c3572dcfc368', 'name': 'ctest-vn1-51673596', 'tenant_id': '9e52b3e65d1d48a691c6cbb2a1a4f8fd', 'project_id': '9e52b3e65d1d48a691c6cbb2a1a4f8fd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestIpVlanLearning-55827545', 'ctest-vn1-51673596'], 'port_security_enabled': True, 'description': ''}}
2025-08-03 01:02:24,098 - DEBUG - Response for create_subnet : {'subnet': {'id': '0dd5fa41-069a-4171-ab12-72064bc7819a', 'name': '', 'tenant_id': '9e52b3e65d1d48a691c6cbb2a1a4f8fd', 'network_id': '736be655-a8d0-4cce-a22d-c3572dcfc368', 'ip_version': 4, 'cidr': '21.117.111.0/24', 'allocation_pools': [{'start': '21.117.111.2', 'end': '21.117.111.254'}], 'gateway_ip': '21.117.111.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '21.117.111.2', 'tags': [], 'project_id': '9e52b3e65d1d48a691c6cbb2a1a4f8fd'}}
2025-08-03 01:02:24,135 - INFO - Created VN ctest-vn1-51673596
2025-08-03 01:02:24,165 - DEBUG - VN ctest-vn1-51673596 UUID is 736be655-a8d0-4cce-a22d-c3572dcfc368
2025-08-03 01:02:24,741 - DEBUG - Response for create_network : {'network': {'id': '198ae7a1-39aa-478a-843d-ccbc6b22803e', 'name': 'ctest-vn2-20554801', 'tenant_id': '9e52b3e65d1d48a691c6cbb2a1a4f8fd', 'project_id': '9e52b3e65d1d48a691c6cbb2a1a4f8fd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestIpVlanLearning-55827545', 'ctest-vn2-20554801'], 'port_security_enabled': True, 'description': ''}}
2025-08-03 01:02:25,117 - DEBUG - Response for create_subnet : {'subnet': {'id': '4e5305ba-7fa6-44ff-ba31-4a291671f6fa', 'name': '', 'tenant_id': '9e52b3e65d1d48a691c6cbb2a1a4f8fd', 'network_id': '198ae7a1-39aa-478a-843d-ccbc6b22803e', 'ip_version': 4, 'cidr': '181.137.246.0/24', 'allocation_pools': [{'start': '181.137.246.2', 'end': '181.137.246.254'}], 'gateway_ip': '181.137.246.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '181.137.246.2', 'tags': [], 'project_id': '9e52b3e65d1d48a691c6cbb2a1a4f8fd'}}
2025-08-03 01:02:25,150 - INFO - Created VN ctest-vn2-20554801
2025-08-03 01:02:25,168 - DEBUG - VN ctest-vn2-20554801 UUID is 198ae7a1-39aa-478a-843d-ccbc6b22803e
2025-08-03 01:02:25,265 - DEBUG - Updating mac_ip_learning flag on VN default-domain:ctest-TestIpVlanLearning-55827545:ctest-vn1-51673596 to True
2025-08-03 01:02:25,445 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/736be655-a8d0-4cce-a22d-c3572dcfc368
2025-08-03 01:02:25,462 - DEBUG - Updating mac_ip_learning flag on VN default-domain:ctest-TestIpVlanLearning-55827545:ctest-vn2-20554801 to True
2025-08-03 01:02:25,621 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/198ae7a1-39aa-478a-843d-ccbc6b22803e
2025-08-03 01:02:27,108 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3743-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3743-1)
2025-08-03 01:02:28,372 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3743-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3743-1)
2025-08-03 01:02:29,669 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3743-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3743-2)
2025-08-03 01:02:31,026 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3743-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3743-2)
2025-08-03 01:02:31,027 - INFO - Waiting for VM ctest-crpd-vm1-67142157 to be up..
2025-08-03 01:02:31,116 - DEBUG - VM is in ERROR state now
2025-08-03 01:02:31,116 - ERROR - VM in error state.
2025-08-03 01:02:31,116 - ERROR - VM is not in ACTIVE state
2025-08-03 01:02:31,226 - ERROR - Fatal Nova Exception while getting VM detail
2025-08-03 01:02:31,226 - DEBUG - None
2025-08-03 01:02:31,226 - INFO - Skip interface_detach for VM ctest-crpd-vm4-52438446 in state BUILD
2025-08-03 01:02:31,226 - INFO - Deleting VM ctest-crpd-vm4-52438446
2025-08-03 01:02:31,226 - ERROR - VM ctest-crpd-vm4-52438446 has failed to come up
2025-08-03 01:02:31,226 - ERROR - Nova failed to get host of the VM
2025-08-03 01:02:31,227 - ERROR - VM ctest-crpd-vm4-52438446 has failed to come up
2025-08-03 01:02:31,227 - ERROR - Nova failed to get host of the VM
2025-08-03 01:02:31,426 - INFO - Skip interface_detach for VM ctest-crpd-vm3-34110712 in state BUILD
2025-08-03 01:02:31,426 - INFO - Deleting VM ctest-crpd-vm3-34110712
2025-08-03 01:02:31,426 - ERROR - VM ctest-crpd-vm3-34110712 has failed to come up
2025-08-03 01:02:31,426 - ERROR - Nova failed to get host of the VM
2025-08-03 01:02:31,426 - ERROR - VM ctest-crpd-vm3-34110712 has failed to come up
2025-08-03 01:02:31,427 - ERROR - Nova failed to get host of the VM
2025-08-03 01:02:31,602 - INFO - Skip interface_detach for VM ctest-crpd-vm2-54887586 in state BUILD
2025-08-03 01:02:31,602 - INFO - Deleting VM ctest-crpd-vm2-54887586
2025-08-03 01:02:31,602 - ERROR - VM ctest-crpd-vm2-54887586 has failed to come up
2025-08-03 01:02:31,602 - ERROR - Nova failed to get host of the VM
2025-08-03 01:02:31,602 - ERROR - VM ctest-crpd-vm2-54887586 has failed to come up
2025-08-03 01:02:31,602 - ERROR - Nova failed to get host of the VM
2025-08-03 01:02:31,770 - INFO - Skip interface_detach for VM ctest-crpd-vm1-67142157 in state ERROR
2025-08-03 01:02:31,770 - INFO - Deleting VM ctest-crpd-vm1-67142157
2025-08-03 01:02:31,770 - ERROR - VM ctest-crpd-vm1-67142157 has failed to come up
2025-08-03 01:02:31,770 - ERROR - Fault seen in nova show is: {'code': 500, 'created': '2025-08-03T01:02:27Z', 'message': 'No valid host was found. ', 'details': 'Traceback (most recent call last):\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/conductor/manager.py", line 1581, in schedule_and_build_instances\n instance_uuids, return_alternates=True)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/conductor/manager.py", line 942, in _schedule_instances\n return_alternates=return_alternates)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/scheduler/client/query.py", line 42, in select_destinations\n instance_uuids, return_objects, return_alternates)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/scheduler/rpcapi.py", line 160, in select_destinations\n return cctxt.call(ctxt, \'select_destinations\', **msg_args)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/rpc/client.py", line 192, in call\n retry=self.retry, transport_options=self.transport_options)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/transport.py", line 128, in _send\n transport_options=transport_options)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/_drivers/amqpdriver.py", line 691, in send\n transport_options=transport_options)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/_drivers/amqpdriver.py", line 681, in _send\n raise result\nnova.exception_Remote.NoValidHost_Remote: No valid host was found. \nTraceback (most recent call last):\n\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/rpc/server.py", line 241, in inner\n return func(*args, **kwargs)\n\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/scheduler/manager.py", line 209, in select_destinations\n raise exception.NoValidHost(reason="")\n\nnova.exception.NoValidHost: No valid host was found. \n\n'}
2025-08-03 01:02:31,770 - INFO - Deleting VN ctest-vn2-20554801
2025-08-03 01:02:32,031 - DEBUG - Response for deleting network ()
2025-08-03 01:02:32,031 - INFO - Deleting VN ctest-vn1-51673596
2025-08-03 01:02:32,204 - DEBUG - Response for deleting network ()
2025-08-03 01:02:32,997 - INFO - Deleted project: ctest-TestIpVlanLearning-55827545, ID : 9e52b3e6-5d1d-48a6-91c6-cbb2a1a4f8fd