2026-06-04 20:02:46,652 - INFO - Domain Default found not creating
2026-06-04 20:02:46,930 - INFO - Project ctest-TestBGPaasZone-98256530 not found, creating it
2026-06-04 20:02:47,435 - INFO - Created Project:ctest-TestBGPaasZone-98256530, ID : eb9f6732-704a-4e9b-93a8-4f28e2739072
2026-06-04 20:02:48,978 - DEBUG - Services list from nova: [, , , ]
2026-06-04 20:02:48,978 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5893-2', 'an-jenkins-deploy-platform-ansible-os-5893-1']}
2026-06-04 20:02:48,980 - INFO - ================================================================================
2026-06-04 20:02:48,980 - INFO - STARTING TEST : test_bgp_control_node_zone
2026-06-04 20:02:50,225 - DEBUG - Skipping xmpp flap check
2026-06-04 20:02:50,225 - INFO - Initial checks done. Running the testcase now
2026-06-04 20:02:50,225 - INFO -
2026-06-04 20:02:50,225 - INFO - executing bgp_control_zone test
2026-06-04 20:02:50,888 - DEBUG - Response for create_network : {'network': {'id': 'd971105b-e6e2-4287-b2a5-1442b4f28c8d', 'name': 'ctest-cnz_vn-19494782', 'tenant_id': 'eb9f6732704a4e9b93a84f28e2739072', 'project_id': 'eb9f6732704a4e9b93a84f28e2739072', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBGPaasZone-98256530', 'ctest-cnz_vn-19494782'], 'port_security_enabled': True, 'description': ''}}
2026-06-04 20:02:51,231 - DEBUG - Response for create_subnet : {'subnet': {'id': '05968dd0-fefc-4f35-adad-e168c4e05c1b', 'name': '', 'tenant_id': 'eb9f6732704a4e9b93a84f28e2739072', 'network_id': 'd971105b-e6e2-4287-b2a5-1442b4f28c8d', 'ip_version': 4, 'cidr': '165.171.247.0/26', 'allocation_pools': [{'start': '165.171.247.2', 'end': '165.171.247.62'}], 'gateway_ip': '165.171.247.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '165.171.247.2', 'tags': [], 'project_id': 'eb9f6732704a4e9b93a84f28e2739072'}}
2026-06-04 20:02:51,253 - INFO - Created VN ctest-cnz_vn-19494782
2026-06-04 20:02:51,263 - DEBUG - VN ctest-cnz_vn-19494782 UUID is d971105b-e6e2-4287-b2a5-1442b4f28c8d
2026-06-04 20:02:52,796 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5893-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5893-2)
2026-06-04 20:02:54,582 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5893-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5893-1)
2026-06-04 20:02:56,715 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5893-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5893-2)
2026-06-04 20:02:56,715 - INFO - Waiting for VM ctest-TestBGPaasZone-98256530-43364182 to be up..
2026-06-04 20:02:56,846 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-06-04 20:03:01,998 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-06-04 20:03:07,086 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-06-04 20:03:12,172 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-06-04 20:03:17,274 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-06-04 20:03:22,362 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-06-04 20:03:27,444 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-06-04 20:03:32,567 - DEBUG - VM is in ACTIVE state now
2026-06-04 20:03:32,568 - INFO - VM name : ctest-TestBGPaasZone-98256530-43364182
2026-06-04 20:03:32,693 - DEBUG - VM ctest-TestBGPaasZone-98256530-43364182 ID is 2711f700-a9df-4310-9c1e-0fd1d68061f0
2026-06-04 20:03:32,720 - DEBUG - VM ctest-TestBGPaasZone-98256530-43364182 launched on Node an-jenkins-deploy-platform-ansible-os-5893-2
2026-06-04 20:03:32,800 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine/2711f700-a9df-4310-9c1e-0fd1d68061f0
2026-06-04 20:03:33,110 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine/2711f700-a9df-4310-9c1e-0fd1d68061f0
2026-06-04 20:03:33,162 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine-interface/8c3c55ae-d702-4a6f-978b-976f542ed201
2026-06-04 20:03:36,348 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1022ms')
2026-06-04 20:03:36,349 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-43364182 failed!
2026-06-04 20:03:36,362 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-19494782 is 165.171.247.1 and allocation pool is NOT set
2026-06-04 20:03:40,440 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1019ms')
2026-06-04 20:03:40,441 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-43364182 failed!
2026-06-04 20:03:40,455 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-19494782 is 165.171.247.1 and allocation pool is NOT set
2026-06-04 20:03:44,542 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1022ms')
2026-06-04 20:03:44,542 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-43364182 failed!
2026-06-04 20:03:44,557 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-19494782 is 165.171.247.1 and allocation pool is NOT set
2026-06-04 20:03:48,634 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1019ms')
2026-06-04 20:03:48,634 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-43364182 failed!
2026-06-04 20:03:48,651 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-19494782 is 165.171.247.1 and allocation pool is NOT set
2026-06-04 20:03:52,737 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1022ms')
2026-06-04 20:03:52,737 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-43364182 failed!
2026-06-04 20:03:52,751 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-19494782 is 165.171.247.1 and allocation pool is NOT set
2026-06-04 20:03:56,823 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms')
2026-06-04 20:03:56,823 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-43364182 failed!
2026-06-04 20:03:56,839 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-19494782 is 165.171.247.1 and allocation pool is NOT set
2026-06-04 20:04:00,928 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1027ms')
2026-06-04 20:04:00,929 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-43364182 failed!
2026-06-04 20:04:00,944 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-19494782 is 165.171.247.1 and allocation pool is NOT set
2026-06-04 20:04:05,023 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms')
2026-06-04 20:04:05,023 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-43364182 failed!
2026-06-04 20:04:05,038 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-19494782 is 165.171.247.1 and allocation pool is NOT set
2026-06-04 20:04:09,110 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1015ms')
2026-06-04 20:04:09,110 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-43364182 failed!
2026-06-04 20:04:09,133 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-19494782 is 165.171.247.1 and allocation pool is NOT set
2026-06-04 20:04:13,205 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms')
2026-06-04 20:04:13,205 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-43364182 failed!
2026-06-04 20:04:13,221 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-19494782 is 165.171.247.1 and allocation pool is NOT set
2026-06-04 20:04:17,307 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1021ms')
2026-06-04 20:04:17,307 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-43364182 failed!
2026-06-04 20:04:17,320 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-19494782 is 165.171.247.1 and allocation pool is NOT set
2026-06-04 20:04:21,410 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1027ms')
2026-06-04 20:04:21,410 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-43364182 failed!
2026-06-04 20:04:21,424 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-19494782 is 165.171.247.1 and allocation pool is NOT set
2026-06-04 20:04:25,498 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms')
2026-06-04 20:04:25,498 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-43364182 failed!
2026-06-04 20:04:25,513 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-19494782 is 165.171.247.1 and allocation pool is NOT set
2026-06-04 20:04:29,596 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1019ms')
2026-06-04 20:04:29,596 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-43364182 failed!
2026-06-04 20:04:29,609 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-19494782 is 165.171.247.1 and allocation pool is NOT set
2026-06-04 20:04:33,692 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1019ms')
2026-06-04 20:04:33,692 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-43364182 failed!
2026-06-04 20:04:33,706 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-19494782 is 165.171.247.1 and allocation pool is NOT set
2026-06-04 20:04:37,790 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1018ms')
2026-06-04 20:04:37,790 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-43364182 failed!
2026-06-04 20:04:37,804 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-19494782 is 165.171.247.1 and allocation pool is NOT set
2026-06-04 20:04:39,868 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n64 bytes from 169.254.0.6: icmp_seq=1 ttl=63 time=2.32 ms\r\n64 bytes from 169.254.0.6: icmp_seq=2 ttl=63 time=0.992 ms\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.992/1.655/2.319/0.663 ms')
2026-06-04 20:04:39,868 - INFO - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-43364182 passed
2026-06-04 20:04:39,942 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:04:39,942 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-43364182, IP 165.171.247.3, Port 22
2026-06-04 20:04:39,999 - DEBUG - Error on ssh to ubuntu@169.254.0.6:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-04 20:04:40,133 - DEBUG - VM ctest-TestBGPaasZone-98256530-43364182 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-04 20:04:45,134 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:04:45,134 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-43364182, IP 165.171.247.3, Port 22
2026-06-04 20:04:45,198 - DEBUG - Error on ssh to ubuntu@169.254.0.6:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-04 20:04:45,285 - DEBUG - VM ctest-TestBGPaasZone-98256530-43364182 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-04 20:04:50,285 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:04:50,285 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-43364182, IP 165.171.247.3, Port 22
2026-06-04 20:04:50,350 - DEBUG - Error on ssh to ubuntu@169.254.0.6:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-04 20:04:50,434 - DEBUG - VM ctest-TestBGPaasZone-98256530-43364182 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-04 20:04:55,435 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:04:55,435 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-43364182, IP 165.171.247.3, Port 22
2026-06-04 20:04:55,503 - DEBUG - Error on ssh to ubuntu@169.254.0.6:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-04 20:04:55,584 - DEBUG - VM ctest-TestBGPaasZone-98256530-43364182 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-04 20:05:00,585 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:05:00,585 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-43364182, IP 165.171.247.3, Port 22
2026-06-04 20:05:00,640 - DEBUG - Error on ssh to ubuntu@169.254.0.6:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-04 20:05:00,732 - DEBUG - VM ctest-TestBGPaasZone-98256530-43364182 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-04 20:05:05,732 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:05:05,733 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-43364182, IP 165.171.247.3, Port 22
2026-06-04 20:05:05,798 - DEBUG - Error on ssh to ubuntu@169.254.0.6:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-04 20:05:05,879 - DEBUG - VM ctest-TestBGPaasZone-98256530-43364182 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-04 20:05:10,879 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:05:10,879 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-43364182, IP 165.171.247.3, Port 22
2026-06-04 20:05:10,946 - DEBUG - Error on ssh to ubuntu@169.254.0.6:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-04 20:05:11,048 - DEBUG - VM ctest-TestBGPaasZone-98256530-43364182 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-04 20:05:16,049 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:05:16,049 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-43364182, IP 165.171.247.3, Port 22
2026-06-04 20:05:16,104 - DEBUG - Error on ssh to ubuntu@169.254.0.6:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-04 20:05:16,189 - DEBUG - VM ctest-TestBGPaasZone-98256530-43364182 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-04 20:05:21,190 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:05:21,191 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-43364182, IP 165.171.247.3, Port 22
2026-06-04 20:05:21,249 - DEBUG - Error on ssh to ubuntu@169.254.0.6:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-04 20:05:21,332 - DEBUG - VM ctest-TestBGPaasZone-98256530-43364182 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-04 20:05:26,333 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:05:26,333 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-43364182, IP 165.171.247.3, Port 22
2026-06-04 20:05:26,488 - DEBUG - VM ctest-TestBGPaasZone-98256530-43364182 is ready for SSH connections
2026-06-04 20:05:26,488 - INFO - Waiting for VM ctest-TestBGPaasZone-98256530-07205872 to be up..
2026-06-04 20:05:26,572 - DEBUG - VM is in ACTIVE state now
2026-06-04 20:05:26,572 - INFO - VM name : ctest-TestBGPaasZone-98256530-07205872
2026-06-04 20:05:26,652 - DEBUG - VM ctest-TestBGPaasZone-98256530-07205872 ID is 0a9ae88a-2844-46aa-a224-1cc6c628afaa
2026-06-04 20:05:26,652 - DEBUG - VM ctest-TestBGPaasZone-98256530-07205872 launched on Node an-jenkins-deploy-platform-ansible-os-5893-1
2026-06-04 20:05:26,732 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine/0a9ae88a-2844-46aa-a224-1cc6c628afaa
2026-06-04 20:05:26,742 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine-interface/0751d691-bc87-40f9-9e97-6fabc98e05ed
2026-06-04 20:05:27,919 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n64 bytes from 169.254.0.6: icmp_seq=1 ttl=63 time=4.21 ms\r\n64 bytes from 169.254.0.6: icmp_seq=2 ttl=63 time=0.659 ms\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.659/2.432/4.206/1.773 ms')
2026-06-04 20:05:27,919 - INFO - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-07205872 passed
2026-06-04 20:05:27,986 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:05:27,986 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-07205872, IP 165.171.247.4, Port 22
2026-06-04 20:05:28,152 - DEBUG - VM ctest-TestBGPaasZone-98256530-07205872 is ready for SSH connections
2026-06-04 20:05:28,152 - INFO - Waiting for VM ctest-TestBGPaasZone-98256530-38633469 to be up..
2026-06-04 20:05:28,214 - DEBUG - VM is in ERROR state now
2026-06-04 20:05:28,215 - ERROR - VM in error state.
2026-06-04 20:05:28,215 - ERROR - VM is not in ACTIVE state
2026-06-04 20:05:28,305 - ERROR - Fatal Nova Exception while getting VM detail
2026-06-04 20:05:28,306 - DEBUG - None
2026-06-04 20:05:28,306 - ERROR - VM ctest-TestBGPaasZone-98256530-38633469 has not booted
2026-06-04 20:05:28,306 - INFO - Deleting VM ctest-TestBGPaasZone-98256530-43364182
2026-06-04 20:05:28,375 - INFO - Deleting VM ctest-TestBGPaasZone-98256530-07205872
2026-06-04 20:05:28,440 - INFO - Skip interface_detach for VM ctest-TestBGPaasZone-98256530-38633469 in state ERROR
2026-06-04 20:05:28,440 - INFO - Deleting VM ctest-TestBGPaasZone-98256530-38633469
2026-06-04 20:05:28,440 - ERROR - VM ctest-TestBGPaasZone-98256530-38633469 has failed to come up
2026-06-04 20:05:28,440 - ERROR - Fault seen in nova show is: {'code': 500, 'created': '2026-06-04T20:02:56Z', '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'}
2026-06-04 20:05:28,447 - INFO - Skip interface_detach for VM ctest-TestBGPaasZone-98256530-38633469 in state ERROR
2026-06-04 20:05:28,447 - INFO - Deleting VM ctest-TestBGPaasZone-98256530-38633469
2026-06-04 20:05:28,447 - ERROR - VM ctest-TestBGPaasZone-98256530-38633469 has failed to come up
2026-06-04 20:05:28,447 - ERROR - Fault seen in nova show is: {'code': 500, 'created': '2026-06-04T20:02:56Z', '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'}
2026-06-04 20:05:28,448 - INFO - Deleting VN ctest-cnz_vn-19494782
2026-06-04 20:05:28,498 - DEBUG - VN d971105b-e6e2-4287-b2a5-1442b4f28c8d still in use: Unable to complete operation on network d971105b-e6e2-4287-b2a5-1442b4f28c8d. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-3847fb0c-20fb-4a02-81c2-856cae21d45b']
2026-06-04 20:05:28,498 - WARNING - Deleting VN ctest-cnz_vn-19494782 failed..Will retry
2026-06-04 20:05:30,673 - DEBUG - Response for deleting network ()
2026-06-04 20:05:31,941 - ERROR - AssertionError
Python 3.9.25: /usr/bin/python3
Thu Jun 4 20:05:28 2026
A problem occurred in a Python script. Here is the sequence of
function calls leading up to the error, in the order they occurred.
/contrail-test/tcutils/wrappers.py in wrapper(self=, *args=(), **kwargs={})
78 log.info('Initial checks done. Running the testcase now')
79 log.info('')
80 result = function(self, *args, **kwargs)
81 if self.inputs.upgrade:
82 pid = os.getpid()
result = None
function =
self =
args = ()
kwargs = {}
/contrail-test/serial_scripts/bgpaas/test_bgpaas_zone.py in test_bgp_control_node_zone(self=)
57 cnt = 0
58 self.logger.info('executing bgp_control_zone test')
59 assert self.basic_control_node_zone_setup()
60 # update control node zone with different bgp routers
61 self.update_control_node_zones(self.cnzs)
self =
self.basic_control_node_zone_setup = >
/contrail-test/serial_scripts/bgpaas/test_bgpaas_zone.py in basic_control_node_zone_setup(self=, ctrl_zone=None)
31 self.vms.append(self.create_vm(vn_fixture=self.vn, image_name='ubuntu-bird'))
32 self.client_vm = self.create_vm(vn_fixture=self.vn, image_name='ubuntu-bird')
33 self.check_vms_booted(self.vms + [self.client_vm])
34 for bgp_name in self.inputs.bgp_names:
35 self.cnzs += self.create_control_node_zones("test-zone",[bgp_name])
self =
self.check_vms_booted = >
self.vms = [, ]
self.client_vm =
/contrail-test/common/base.py in check_vms_booted(cls=, vms_list=[, , ], do_assert=True)
719 if failed and do_assert:
720 for vm_fixture in vms_list:
721 vm_fixture.cleanUp()
722 assert False, 'One or more vm-boots failed. Check logs'
723 if failed:
vm_fixture =
vm_fixture.cleanUp = >
/contrail-test/fixtures/vm_test.py in cleanUp(self=)
2050
2051 def cleanUp(self):
2052 self.delete()
2053 super(VMFixture, self).cleanUp()
2054
self =
self.delete = >
/contrail-test/fixtures/vm_test.py in delete(self=, verify=False, force=False)
2080 self.webui.delete_vm(self)
2081 else:
2082 self.orch.delete_vm(vm_obj, force=force)
2083 self.vm_objs.remove(vm_obj)
2084 if self.inputs.ns_agilio_vrouter_data:
self =
self.orch =
self.orch.delete_vm = >
vm_obj =
force = False
/contrail-test/fixtures/openstack.py in delete_vm(self=, vm_obj=, **kwargs={'force': False})
119
120 def delete_vm(self, vm_obj, **kwargs):
121 return self.nova_h.delete_vm(vm_obj, **kwargs)
122
123 def is_vm_deleted(self, vm_obj, **kwargs):
self =
self.nova_h =
self.nova_h.delete_vm = >
vm_obj =
kwargs = {'force': False}
/contrail-test/fixtures/nova_test.py in delete_vm(self=, vm_obj=, force=False)
763 def delete_vm(self, vm_obj, force=False):
764 if not force:
765 self.get_nova_host_of_vm(vm_obj)
766 vm_obj.delete()
767 # end _delete_vm
self =
self.get_nova_host_of_vm = >
vm_obj =
/contrail-test/fixtures/nova_test.py in get_nova_host_of_vm(self=, vm_obj=)
734 self.logger.error('VM %s has failed to come up' % vm_obj.name)
735 self.logger.error('Fault seen in nova show is: %s' % vm_obj.__dict__['fault'])
736 assert False, 'Fault seen in nova show %s is: %s' % (
737 vm_obj.id, vm_obj.__dict__['fault'])
738 else:
vm_obj =
vm_obj.id = 'ad34ded2-421c-4300-afb3-7e76ffd13446'
vm_obj.__dict__ = {'OS-DCF:diskConfig': 'MANUAL', 'OS-EXT-AZ:availability_zone': 'nova', 'OS-EXT-SRV-ATTR:host': None, 'OS-EXT-SRV-ATTR:hypervisor_hostname': None, 'OS-EXT-SRV-ATTR:instance_name': 'instance-00000009', 'OS-EXT-STS:power_state': 0, 'OS-EXT-STS:task_state': None, 'OS-EXT-STS:vm_state': 'error', 'OS-SRV-USG:launched_at': None, 'OS-SRV-USG:terminated_at': None, ...}
AssertionError: Fault seen in nova show ad34ded2-421c-4300-afb3-7e76ffd13446 is: {'code': 500, 'created': '2026-06-04T20:02:56Z', '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'}
__cause__ = None
__class__ =
__context__ = None
__delattr__ =
__dict__ = {}
__dir__ =
__doc__ = 'Assertion failed.'
__eq__ =
__format__ =
__ge__ =
__getattribute__ =
__gt__ =
__hash__ =
__init__ =
__init_subclass__ =
__le__ =
__lt__ =
__ne__ =
__new__ =
__reduce__ =
__reduce_ex__ =
__repr__ =
__setattr__ =
__setstate__ =
__sizeof__ =
__str__ =
__subclasshook__ =
__suppress_context__ = False
__traceback__ =
args = (r"Fault seen in nova show ad34ded2-421c-4300-afb3-...tion.NoValidHost: No valid host was found. \n\n'}",)
with_traceback =
The above is a description of an error in a Python program. Here is
the original traceback:
Traceback (most recent call last):
File "/contrail-test/tcutils/wrappers.py", line 80, in wrapper
result = function(self, *args, **kwargs)
File "/contrail-test/serial_scripts/bgpaas/test_bgpaas_zone.py", line 59, in test_bgp_control_node_zone
assert self.basic_control_node_zone_setup()
File "/contrail-test/serial_scripts/bgpaas/test_bgpaas_zone.py", line 33, in basic_control_node_zone_setup
self.check_vms_booted(self.vms + [self.client_vm])
File "/contrail-test/common/base.py", line 721, in check_vms_booted
vm_fixture.cleanUp()
File "/contrail-test/fixtures/vm_test.py", line 2052, in cleanUp
self.delete()
File "/contrail-test/fixtures/vm_test.py", line 2082, in delete
self.orch.delete_vm(vm_obj, force=force)
File "/contrail-test/fixtures/openstack.py", line 121, in delete_vm
return self.nova_h.delete_vm(vm_obj, **kwargs)
File "/contrail-test/fixtures/nova_test.py", line 765, in delete_vm
self.get_nova_host_of_vm(vm_obj)
File "/contrail-test/fixtures/nova_test.py", line 736, in get_nova_host_of_vm
assert False, 'Fault seen in nova show %s is: %s' % (
AssertionError: Fault seen in nova show ad34ded2-421c-4300-afb3-7e76ffd13446 is: {'code': 500, 'created': '2026-06-04T20:02:56Z', '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'}
2026-06-04 20:05:31,941 - DEBUG - Skipping xmpp flap check
2026-06-04 20:05:31,941 - INFO -
2026-06-04 20:05:31,941 - INFO - END TEST : test_bgp_control_node_zone : FAILED[0:02:43]
2026-06-04 20:05:31,941 - INFO - --------------------------------------------------------------------------------
2026-06-04 20:05:31,944 - INFO - ================================================================================
2026-06-04 20:05:31,944 - INFO - STARTING TEST : test_bgp_control_node_zones_from_single_vnf
2026-06-04 20:05:33,204 - DEBUG - Skipping xmpp flap check
2026-06-04 20:05:33,204 - INFO - Initial checks done. Running the testcase now
2026-06-04 20:05:33,204 - INFO -
2026-06-04 20:05:33,204 - INFO - executing bgp_control_zone agent restart test
2026-06-04 20:05:33,513 - DEBUG - Response for create_network : {'network': {'id': 'd768371f-a395-4b36-9e3a-84f977181fe1', 'name': 'ctest-cnz_vn-88440214', 'tenant_id': 'eb9f6732704a4e9b93a84f28e2739072', 'project_id': 'eb9f6732704a4e9b93a84f28e2739072', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBGPaasZone-98256530', 'ctest-cnz_vn-88440214'], 'port_security_enabled': True, 'description': ''}}
2026-06-04 20:05:33,729 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e103208e-b140-406f-bf1d-47fcc661ae00', 'name': '', 'tenant_id': 'eb9f6732704a4e9b93a84f28e2739072', 'network_id': 'd768371f-a395-4b36-9e3a-84f977181fe1', 'ip_version': 4, 'cidr': '78.198.188.192/26', 'allocation_pools': [{'start': '78.198.188.194', 'end': '78.198.188.254'}], 'gateway_ip': '78.198.188.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '78.198.188.194', 'tags': [], 'project_id': 'eb9f6732704a4e9b93a84f28e2739072'}}
2026-06-04 20:05:33,759 - INFO - Created VN ctest-cnz_vn-88440214
2026-06-04 20:05:33,772 - DEBUG - VN ctest-cnz_vn-88440214 UUID is d768371f-a395-4b36-9e3a-84f977181fe1
2026-06-04 20:05:35,279 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5893-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5893-1)
2026-06-04 20:05:36,995 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5893-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5893-2)
2026-06-04 20:05:38,645 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5893-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5893-1)
2026-06-04 20:05:38,645 - INFO - Waiting for VM ctest-TestBGPaasZone-98256530-91375284 to be up..
2026-06-04 20:05:38,725 - DEBUG - VM is in ACTIVE state now
2026-06-04 20:05:38,725 - INFO - VM name : ctest-TestBGPaasZone-98256530-91375284
2026-06-04 20:05:38,843 - DEBUG - VM ctest-TestBGPaasZone-98256530-91375284 ID is bc63f77e-0b84-4ebe-b2ae-c57d1d1e581f
2026-06-04 20:05:38,843 - DEBUG - VM ctest-TestBGPaasZone-98256530-91375284 launched on Node an-jenkins-deploy-platform-ansible-os-5893-1
2026-06-04 20:05:38,935 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine/bc63f77e-0b84-4ebe-b2ae-c57d1d1e581f
2026-06-04 20:05:38,945 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine-interface/e173086c-b366-440f-ae08-44c567fe05f0
2026-06-04 20:05:42,123 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms')
2026-06-04 20:05:42,123 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-91375284 failed!
2026-06-04 20:05:42,136 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-88440214 is 78.198.188.193 and allocation pool is NOT set
2026-06-04 20:05:46,224 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1024ms')
2026-06-04 20:05:46,224 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-91375284 failed!
2026-06-04 20:05:46,239 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-88440214 is 78.198.188.193 and allocation pool is NOT set
2026-06-04 20:05:50,324 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1017ms')
2026-06-04 20:05:50,324 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-91375284 failed!
2026-06-04 20:05:50,339 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-88440214 is 78.198.188.193 and allocation pool is NOT set
2026-06-04 20:05:54,415 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1012ms')
2026-06-04 20:05:54,415 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-91375284 failed!
2026-06-04 20:05:54,430 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-88440214 is 78.198.188.193 and allocation pool is NOT set
2026-06-04 20:05:58,514 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1016ms')
2026-06-04 20:05:58,514 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-91375284 failed!
2026-06-04 20:05:58,530 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-88440214 is 78.198.188.193 and allocation pool is NOT set
2026-06-04 20:06:02,604 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1011ms')
2026-06-04 20:06:02,604 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-91375284 failed!
2026-06-04 20:06:02,618 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-88440214 is 78.198.188.193 and allocation pool is NOT set
2026-06-04 20:06:06,703 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1019ms')
2026-06-04 20:06:06,704 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-91375284 failed!
2026-06-04 20:06:06,718 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-88440214 is 78.198.188.193 and allocation pool is NOT set
2026-06-04 20:06:10,797 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1015ms')
2026-06-04 20:06:10,797 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-91375284 failed!
2026-06-04 20:06:10,814 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-88440214 is 78.198.188.193 and allocation pool is NOT set
2026-06-04 20:06:14,891 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms')
2026-06-04 20:06:14,891 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-91375284 failed!
2026-06-04 20:06:14,906 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-88440214 is 78.198.188.193 and allocation pool is NOT set
2026-06-04 20:06:18,984 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1017ms')
2026-06-04 20:06:18,984 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-91375284 failed!
2026-06-04 20:06:19,000 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-88440214 is 78.198.188.193 and allocation pool is NOT set
2026-06-04 20:06:23,087 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1022ms')
2026-06-04 20:06:23,087 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-91375284 failed!
2026-06-04 20:06:23,101 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-88440214 is 78.198.188.193 and allocation pool is NOT set
2026-06-04 20:06:27,178 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms')
2026-06-04 20:06:27,178 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-91375284 failed!
2026-06-04 20:06:27,191 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-88440214 is 78.198.188.193 and allocation pool is NOT set
2026-06-04 20:06:31,278 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1022ms')
2026-06-04 20:06:31,278 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-91375284 failed!
2026-06-04 20:06:31,291 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-88440214 is 78.198.188.193 and allocation pool is NOT set
2026-06-04 20:06:35,372 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1009ms')
2026-06-04 20:06:35,372 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-91375284 failed!
2026-06-04 20:06:35,387 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-88440214 is 78.198.188.193 and allocation pool is NOT set
2026-06-04 20:06:39,462 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1018ms')
2026-06-04 20:06:39,462 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-91375284 failed!
2026-06-04 20:06:39,480 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-88440214 is 78.198.188.193 and allocation pool is NOT set
2026-06-04 20:06:43,567 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1021ms')
2026-06-04 20:06:43,567 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-91375284 failed!
2026-06-04 20:06:43,582 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaasZone-98256530:ctest-cnz_vn-88440214 is 78.198.188.193 and allocation pool is NOT set
2026-06-04 20:06:45,647 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n64 bytes from 169.254.0.6: icmp_seq=1 ttl=63 time=7.96 ms\r\n64 bytes from 169.254.0.6: icmp_seq=2 ttl=63 time=2.62 ms\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 2.623/5.290/7.957/2.667 ms')
2026-06-04 20:06:45,647 - INFO - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-91375284 passed
2026-06-04 20:06:45,721 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:06:45,721 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-91375284, IP 78.198.188.195, Port 22
2026-06-04 20:06:45,790 - DEBUG - Error on ssh to ubuntu@169.254.0.6:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-04 20:06:45,884 - DEBUG - VM ctest-TestBGPaasZone-98256530-91375284 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-04 20:06:50,885 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:06:50,885 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-91375284, IP 78.198.188.195, Port 22
2026-06-04 20:06:50,951 - DEBUG - Error on ssh to ubuntu@169.254.0.6:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-04 20:06:51,028 - DEBUG - VM ctest-TestBGPaasZone-98256530-91375284 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-04 20:06:56,029 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:06:56,029 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-91375284, IP 78.198.188.195, Port 22
2026-06-04 20:06:56,083 - DEBUG - Error on ssh to ubuntu@169.254.0.6:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-04 20:06:56,174 - DEBUG - VM ctest-TestBGPaasZone-98256530-91375284 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-04 20:07:01,175 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:07:01,176 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-91375284, IP 78.198.188.195, Port 22
2026-06-04 20:07:01,243 - DEBUG - Error on ssh to ubuntu@169.254.0.6:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-04 20:07:01,328 - DEBUG - VM ctest-TestBGPaasZone-98256530-91375284 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-04 20:07:06,328 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:07:06,329 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-91375284, IP 78.198.188.195, Port 22
2026-06-04 20:07:06,394 - DEBUG - Error on ssh to ubuntu@169.254.0.6:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-04 20:07:06,481 - DEBUG - VM ctest-TestBGPaasZone-98256530-91375284 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-04 20:07:11,482 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:07:11,482 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-91375284, IP 78.198.188.195, Port 22
2026-06-04 20:07:11,540 - DEBUG - Error on ssh to ubuntu@169.254.0.6:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-04 20:07:11,625 - DEBUG - VM ctest-TestBGPaasZone-98256530-91375284 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-04 20:07:16,626 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:07:16,626 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-91375284, IP 78.198.188.195, Port 22
2026-06-04 20:07:16,684 - DEBUG - Error on ssh to ubuntu@169.254.0.6:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-04 20:07:16,766 - DEBUG - VM ctest-TestBGPaasZone-98256530-91375284 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-04 20:07:21,767 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:07:21,767 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-91375284, IP 78.198.188.195, Port 22
2026-06-04 20:07:21,835 - DEBUG - Error on ssh to ubuntu@169.254.0.6:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-04 20:07:21,919 - DEBUG - VM ctest-TestBGPaasZone-98256530-91375284 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-04 20:07:26,919 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:07:26,920 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-91375284, IP 78.198.188.195, Port 22
2026-06-04 20:07:26,986 - DEBUG - Error on ssh to ubuntu@169.254.0.6:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-06-04 20:07:27,086 - DEBUG - VM ctest-TestBGPaasZone-98256530-91375284 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-04 20:07:32,087 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:07:32,087 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-91375284, IP 78.198.188.195, Port 22
2026-06-04 20:07:32,244 - DEBUG - VM ctest-TestBGPaasZone-98256530-91375284 is ready for SSH connections
2026-06-04 20:07:32,244 - INFO - Waiting for VM ctest-TestBGPaasZone-98256530-52430643 to be up..
2026-06-04 20:07:32,324 - DEBUG - VM is in ACTIVE state now
2026-06-04 20:07:32,324 - INFO - VM name : ctest-TestBGPaasZone-98256530-52430643
2026-06-04 20:07:32,403 - DEBUG - VM ctest-TestBGPaasZone-98256530-52430643 ID is f5d85c19-e508-45fa-baa6-18bf5f38f411
2026-06-04 20:07:32,403 - DEBUG - VM ctest-TestBGPaasZone-98256530-52430643 launched on Node an-jenkins-deploy-platform-ansible-os-5893-2
2026-06-04 20:07:32,488 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine/f5d85c19-e508-45fa-baa6-18bf5f38f411
2026-06-04 20:07:32,501 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine-interface/164c3864-8192-4917-9941-fb2215b426da
2026-06-04 20:07:33,661 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n64 bytes from 169.254.0.6: icmp_seq=1 ttl=63 time=3.72 ms\r\n64 bytes from 169.254.0.6: icmp_seq=2 ttl=63 time=1.23 ms\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 1.233/2.474/3.715/1.241 ms')
2026-06-04 20:07:33,661 - INFO - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-98256530-52430643 passed
2026-06-04 20:07:33,732 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:07:33,732 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-98256530-52430643, IP 78.198.188.196, Port 22
2026-06-04 20:07:33,888 - DEBUG - VM ctest-TestBGPaasZone-98256530-52430643 is ready for SSH connections
2026-06-04 20:07:33,888 - INFO - Waiting for VM ctest-TestBGPaasZone-98256530-99247213 to be up..
2026-06-04 20:07:33,942 - DEBUG - VM is in ERROR state now
2026-06-04 20:07:33,942 - ERROR - VM in error state.
2026-06-04 20:07:33,942 - ERROR - VM is not in ACTIVE state
2026-06-04 20:07:34,016 - ERROR - Fatal Nova Exception while getting VM detail
2026-06-04 20:07:34,017 - DEBUG - None
2026-06-04 20:07:34,017 - ERROR - VM ctest-TestBGPaasZone-98256530-99247213 has not booted
2026-06-04 20:07:34,017 - INFO - Deleting VM ctest-TestBGPaasZone-98256530-91375284
2026-06-04 20:07:34,077 - INFO - Deleting VM ctest-TestBGPaasZone-98256530-52430643
2026-06-04 20:07:34,140 - INFO - Skip interface_detach for VM ctest-TestBGPaasZone-98256530-99247213 in state ERROR
2026-06-04 20:07:34,140 - INFO - Deleting VM ctest-TestBGPaasZone-98256530-99247213
2026-06-04 20:07:34,140 - ERROR - VM ctest-TestBGPaasZone-98256530-99247213 has failed to come up
2026-06-04 20:07:34,140 - ERROR - Fault seen in nova show is: {'code': 500, 'created': '2026-06-04T20:05:38Z', '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'}
2026-06-04 20:07:34,142 - INFO - Skip interface_detach for VM ctest-TestBGPaasZone-98256530-99247213 in state ERROR
2026-06-04 20:07:34,143 - INFO - Deleting VM ctest-TestBGPaasZone-98256530-99247213
2026-06-04 20:07:34,143 - ERROR - VM ctest-TestBGPaasZone-98256530-99247213 has failed to come up
2026-06-04 20:07:34,143 - ERROR - Fault seen in nova show is: {'code': 500, 'created': '2026-06-04T20:05:38Z', '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'}
2026-06-04 20:07:34,143 - INFO - Deleting VN ctest-cnz_vn-88440214
2026-06-04 20:07:34,179 - DEBUG - VN d768371f-a395-4b36-9e3a-84f977181fe1 still in use: Unable to complete operation on network d768371f-a395-4b36-9e3a-84f977181fe1. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-5c45de1d-2080-441d-a4ce-0f84384d81d1']
2026-06-04 20:07:34,179 - WARNING - Deleting VN ctest-cnz_vn-88440214 failed..Will retry
2026-06-04 20:07:36,356 - DEBUG - Response for deleting network ()
2026-06-04 20:07:37,608 - ERROR - AssertionError
Python 3.9.25: /usr/bin/python3
Thu Jun 4 20:07:34 2026
A problem occurred in a Python script. Here is the sequence of
function calls leading up to the error, in the order they occurred.
/contrail-test/tcutils/wrappers.py in wrapper(self=, *args=(), **kwargs={})
78 log.info('Initial checks done. Running the testcase now')
79 log.info('')
80 result = function(self, *args, **kwargs)
81 if self.inputs.upgrade:
82 pid = os.getpid()
result = None
function =
self =
args = ()
kwargs = {}
/contrail-test/serial_scripts/bgpaas/test_bgpaas_zone.py in test_bgp_control_node_zones_from_single_vnf(self=)
145 self.logger.info('executing bgp_control_zone agent restart test')
146 host_ips = []
147 assert self.basic_control_node_zone_setup('both-zones')
148 for vm in self.vms:
149 assert self.verify_bgpaas_in_control_nodes_and_agent(self.bgpaas_fixtures[cnt],vm)
self =
self.basic_control_node_zone_setup = >
/contrail-test/serial_scripts/bgpaas/test_bgpaas_zone.py in basic_control_node_zone_setup(self=, ctrl_zone='both-zones')
31 self.vms.append(self.create_vm(vn_fixture=self.vn, image_name='ubuntu-bird'))
32 self.client_vm = self.create_vm(vn_fixture=self.vn, image_name='ubuntu-bird')
33 self.check_vms_booted(self.vms + [self.client_vm])
34 for bgp_name in self.inputs.bgp_names:
35 self.cnzs += self.create_control_node_zones("test-zone",[bgp_name])
self =
self.check_vms_booted = >
self.vms = [, ]
self.client_vm =
/contrail-test/common/base.py in check_vms_booted(cls=, vms_list=[, , ], do_assert=True)
719 if failed and do_assert:
720 for vm_fixture in vms_list:
721 vm_fixture.cleanUp()
722 assert False, 'One or more vm-boots failed. Check logs'
723 if failed:
vm_fixture =
vm_fixture.cleanUp = >
/contrail-test/fixtures/vm_test.py in cleanUp(self=)
2050
2051 def cleanUp(self):
2052 self.delete()
2053 super(VMFixture, self).cleanUp()
2054
self =
self.delete = >
/contrail-test/fixtures/vm_test.py in delete(self=, verify=False, force=False)
2080 self.webui.delete_vm(self)
2081 else:
2082 self.orch.delete_vm(vm_obj, force=force)
2083 self.vm_objs.remove(vm_obj)
2084 if self.inputs.ns_agilio_vrouter_data:
self =
self.orch =
self.orch.delete_vm = >
vm_obj =
force = False
/contrail-test/fixtures/openstack.py in delete_vm(self=, vm_obj=, **kwargs={'force': False})
119
120 def delete_vm(self, vm_obj, **kwargs):
121 return self.nova_h.delete_vm(vm_obj, **kwargs)
122
123 def is_vm_deleted(self, vm_obj, **kwargs):
self =
self.nova_h =
self.nova_h.delete_vm = >
vm_obj =
kwargs = {'force': False}
/contrail-test/fixtures/nova_test.py in delete_vm(self=, vm_obj=, force=False)
763 def delete_vm(self, vm_obj, force=False):
764 if not force:
765 self.get_nova_host_of_vm(vm_obj)
766 vm_obj.delete()
767 # end _delete_vm
self =
self.get_nova_host_of_vm = >
vm_obj =
/contrail-test/fixtures/nova_test.py in get_nova_host_of_vm(self=, vm_obj=)
734 self.logger.error('VM %s has failed to come up' % vm_obj.name)
735 self.logger.error('Fault seen in nova show is: %s' % vm_obj.__dict__['fault'])
736 assert False, 'Fault seen in nova show %s is: %s' % (
737 vm_obj.id, vm_obj.__dict__['fault'])
738 else:
vm_obj =
vm_obj.id = '493596f8-43de-446b-95a6-5cb3f91c1008'
vm_obj.__dict__ = {'OS-DCF:diskConfig': 'MANUAL', 'OS-EXT-AZ:availability_zone': 'nova', 'OS-EXT-SRV-ATTR:host': None, 'OS-EXT-SRV-ATTR:hypervisor_hostname': None, 'OS-EXT-SRV-ATTR:instance_name': 'instance-0000000a', 'OS-EXT-STS:power_state': 0, 'OS-EXT-STS:task_state': None, 'OS-EXT-STS:vm_state': 'error', 'OS-SRV-USG:launched_at': None, 'OS-SRV-USG:terminated_at': None, ...}
AssertionError: Fault seen in nova show 493596f8-43de-446b-95a6-5cb3f91c1008 is: {'code': 500, 'created': '2026-06-04T20:05:38Z', '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'}
__cause__ = None
__class__ =
__context__ = None
__delattr__ =
__dict__ = {}
__dir__ =
__doc__ = 'Assertion failed.'
__eq__ =
__format__ =
__ge__ =
__getattribute__ =
__gt__ =
__hash__ =
__init__ =
__init_subclass__ =
__le__ =
__lt__ =
__ne__ =
__new__ =
__reduce__ =
__reduce_ex__ =
__repr__ =
__setattr__ =
__setstate__ =
__sizeof__ =
__str__ =
__subclasshook__ =
__suppress_context__ = False
__traceback__ =
args = (r"Fault seen in nova show 493596f8-43de-446b-95a6-...tion.NoValidHost: No valid host was found. \n\n'}",)
with_traceback =
The above is a description of an error in a Python program. Here is
the original traceback:
Traceback (most recent call last):
File "/contrail-test/tcutils/wrappers.py", line 80, in wrapper
result = function(self, *args, **kwargs)
File "/contrail-test/serial_scripts/bgpaas/test_bgpaas_zone.py", line 147, in test_bgp_control_node_zones_from_single_vnf
assert self.basic_control_node_zone_setup('both-zones')
File "/contrail-test/serial_scripts/bgpaas/test_bgpaas_zone.py", line 33, in basic_control_node_zone_setup
self.check_vms_booted(self.vms + [self.client_vm])
File "/contrail-test/common/base.py", line 721, in check_vms_booted
vm_fixture.cleanUp()
File "/contrail-test/fixtures/vm_test.py", line 2052, in cleanUp
self.delete()
File "/contrail-test/fixtures/vm_test.py", line 2082, in delete
self.orch.delete_vm(vm_obj, force=force)
File "/contrail-test/fixtures/openstack.py", line 121, in delete_vm
return self.nova_h.delete_vm(vm_obj, **kwargs)
File "/contrail-test/fixtures/nova_test.py", line 765, in delete_vm
self.get_nova_host_of_vm(vm_obj)
File "/contrail-test/fixtures/nova_test.py", line 736, in get_nova_host_of_vm
assert False, 'Fault seen in nova show %s is: %s' % (
AssertionError: Fault seen in nova show 493596f8-43de-446b-95a6-5cb3f91c1008 is: {'code': 500, 'created': '2026-06-04T20:05:38Z', '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'}
2026-06-04 20:07:37,608 - DEBUG - Skipping xmpp flap check
2026-06-04 20:07:37,608 - INFO -
2026-06-04 20:07:37,609 - INFO - END TEST : test_bgp_control_node_zones_from_single_vnf : FAILED[0:02:06]
2026-06-04 20:07:37,609 - INFO - --------------------------------------------------------------------------------
2026-06-04 20:07:38,349 - INFO - Deleted project: ctest-TestBGPaasZone-98256530, ID : eb9f6732-704a-4e9b-93a8-4f28e2739072