is in ACTIVE state now
2025-10-23 03:53:59,227 - INFO - VM name : bgpaas_vm1
2025-10-23 03:53:59,318 - DEBUG - VM bgpaas_vm1 ID is ca889300-c0e8-48c9-89dc-65b10774a9be
2025-10-23 03:53:59,318 - DEBUG - VM bgpaas_vm1 launched on Node an-jenkins-deploy-platform-ansible-os-4448-1
2025-10-23 03:53:59,403 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-machine/ca889300-c0e8-48c9-89dc-65b10774a9be
2025-10-23 03:53:59,413 - DEBUG - Requesting: http://10.0.0.133:8082/virtual-machine-interface/2c254ba8-91f6-458c-b68c-1893f289d49c
2025-10-23 03:54:02,585 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1005ms')
2025-10-23 03:54:02,585 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-10-23 03:54:02,602 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-08354474:ctest-bgpaas_vn-68907403 is 86.153.179.193 and allocation pool is NOT set
2025-10-23 03:54:06,672 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1011ms')
2025-10-23 03:54:06,672 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-10-23 03:54:06,690 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-08354474:ctest-bgpaas_vn-68907403 is 86.153.179.193 and allocation pool is NOT set
2025-10-23 03:54:10,777 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1017ms')
2025-10-23 03:54:10,777 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-10-23 03:54:10,800 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-08354474:ctest-bgpaas_vn-68907403 is 86.153.179.193 and allocation pool is NOT set
2025-10-23 03:54:14,864 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1004ms')
2025-10-23 03:54:14,864 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-10-23 03:54:14,878 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-08354474:ctest-bgpaas_vn-68907403 is 86.153.179.193 and allocation pool is NOT set
2025-10-23 03:54:18,960 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1024ms')
2025-10-23 03:54:18,960 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-10-23 03:54:18,977 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-08354474:ctest-bgpaas_vn-68907403 is 86.153.179.193 and allocation pool is NOT set
2025-10-23 03:54:23,065 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1021ms')
2025-10-23 03:54:23,065 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-10-23 03:54:23,079 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-08354474:ctest-bgpaas_vn-68907403 is 86.153.179.193 and allocation pool is NOT set
2025-10-23 03:54:27,156 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1017ms')
2025-10-23 03:54:27,157 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-10-23 03:54:27,172 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-08354474:ctest-bgpaas_vn-68907403 is 86.153.179.193 and allocation pool is NOT set
2025-10-23 03:54:31,247 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1016ms')
2025-10-23 03:54:31,247 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-10-23 03:54:31,263 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-08354474:ctest-bgpaas_vn-68907403 is 86.153.179.193 and allocation pool is NOT set
2025-10-23 03:54:35,346 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1021ms')
2025-10-23 03:54:35,346 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-10-23 03:54:35,359 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-08354474:ctest-bgpaas_vn-68907403 is 86.153.179.193 and allocation pool is NOT set
2025-10-23 03:54:39,448 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1020ms')
2025-10-23 03:54:39,448 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-10-23 03:54:39,464 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-08354474:ctest-bgpaas_vn-68907403 is 86.153.179.193 and allocation pool is NOT set
2025-10-23 03:54:43,541 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms')
2025-10-23 03:54:43,542 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-10-23 03:54:43,555 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-08354474:ctest-bgpaas_vn-68907403 is 86.153.179.193 and allocation pool is NOT set
2025-10-23 03:54:47,637 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1016ms')
2025-10-23 03:54:47,638 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-10-23 03:54:47,653 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-08354474:ctest-bgpaas_vn-68907403 is 86.153.179.193 and allocation pool is NOT set
2025-10-23 03:54:51,735 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1017ms')
2025-10-23 03:54:51,735 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-10-23 03:54:51,753 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-08354474:ctest-bgpaas_vn-68907403 is 86.153.179.193 and allocation pool is NOT set
2025-10-23 03:54:55,833 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1007ms')
2025-10-23 03:54:55,833 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-10-23 03:54:55,847 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-08354474:ctest-bgpaas_vn-68907403 is 86.153.179.193 and allocation pool is NOT set
2025-10-23 03:54:59,926 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms')
2025-10-23 03:54:59,926 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-10-23 03:54:59,940 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-08354474:ctest-bgpaas_vn-68907403 is 86.153.179.193 and allocation pool is NOT set
2025-10-23 03:55:04,025 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1018ms')
2025-10-23 03:55:04,025 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-10-23 03:55:04,039 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-08354474:ctest-bgpaas_vn-68907403 is 86.153.179.193 and allocation pool is NOT set
2025-10-23 03:55:08,113 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1012ms')
2025-10-23 03:55:08,113 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-10-23 03:55:08,128 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-08354474:ctest-bgpaas_vn-68907403 is 86.153.179.193 and allocation pool is NOT set
2025-10-23 03:55:12,209 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1020ms')
2025-10-23 03:55:12,209 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-10-23 03:55:12,228 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-08354474:ctest-bgpaas_vn-68907403 is 86.153.179.193 and allocation pool is NOT set
2025-10-23 03:55:16,307 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.36 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1017ms\r\nrtt min/avg/max/mdev = 2.358/2.358/2.358/0.000 ms')
2025-10-23 03:55:16,307 - INFO - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 passed
2025-10-23 03:55:16,373 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 03:55:16,374 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 86.153.179.196, Port 22
2025-10-23 03:55:16,440 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-10-23 03:55:16,543 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-10-23 03:55:21,543 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 03:55:21,543 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 86.153.179.196, Port 22
2025-10-23 03:55:21,613 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-10-23 03:55:21,703 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-10-23 03:55:26,703 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 03:55:26,703 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 86.153.179.196, Port 22
2025-10-23 03:55:26,773 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-10-23 03:55:26,858 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-10-23 03:55:31,859 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 03:55:31,859 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 86.153.179.196, Port 22
2025-10-23 03:55:31,928 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-10-23 03:55:32,009 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-10-23 03:55:37,010 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 03:55:37,010 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 86.153.179.196, Port 22
2025-10-23 03:55:37,081 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-10-23 03:55:37,173 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-10-23 03:55:42,173 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 03:55:42,174 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 86.153.179.196, Port 22
2025-10-23 03:55:42,240 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-10-23 03:55:42,323 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-10-23 03:55:47,324 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 03:55:47,325 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 86.153.179.196, Port 22
2025-10-23 03:55:47,392 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-10-23 03:55:47,487 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-10-23 03:55:52,488 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 03:55:52,488 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 86.153.179.196, Port 22
2025-10-23 03:55:52,558 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-10-23 03:55:52,646 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-10-23 03:55:57,646 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 03:55:57,647 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 86.153.179.196, Port 22
2025-10-23 03:55:57,713 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-10-23 03:55:57,796 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-10-23 03:56:02,796 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 03:56:02,796 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 86.153.179.196, Port 22
2025-10-23 03:56:02,866 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-10-23 03:56:02,954 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-10-23 03:56:07,955 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 03:56:07,955 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 86.153.179.196, Port 22
2025-10-23 03:56:08,137 - DEBUG - VM bgpaas_vm1 is ready for SSH connections
2025-10-23 03:56:08,137 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 03:56:08,143 - INFO - Creating BGPaaS ctest-TestBGPaaSlocalAS-08354474-50082479
2025-10-23 03:56:08,216 - INFO - BGPaaS: ctest-TestBGPaaSlocalAS-08354474-50082479(74116635-f491-4b4d-ba2b-480c5e22517d)
2025-10-23 03:56:08,216 - DEBUG - Requesting: http://10.0.0.41:8082/bgp-as-a-service/74116635-f491-4b4d-ba2b-480c5e22517d
2025-10-23 03:56:08,557 - DEBUG - Requesting: http://10.0.0.41:8082/bgp-as-a-service/74116635-f491-4b4d-ba2b-480c5e22517d
2025-10-23 03:56:08,593 - INFO - verify_in_api_server passed for BGPaaS obj 74116635-f491-4b4d-ba2b-480c5e22517d
2025-10-23 03:56:08,594 - INFO - BGPaaS(74116635-f491-4b4d-ba2b-480c5e22517d): verify_on_setup passed
2025-10-23 03:56:08,594 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 03:56:08,594 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 86.153.179.196, Port 22
2025-10-23 03:56:08,761 - DEBUG - VM bgpaas_vm1 is ready for SSH connections
2025-10-23 03:56:08,761 - INFO - Attaching VMI 2c254ba8-91f6-458c-b68c-1893f289d49c to BGPaaS 74116635-f491-4b4d-ba2b-480c5e22517d
2025-10-23 03:56:08,836 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 03:56:08,836 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 03:56:08,995 - INFO - Configuring BGP on the bird
2025-10-23 03:56:08,995 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 03:56:08,995 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 86.153.179.196, Port 22
2025-10-23 03:56:09,154 - DEBUG - VM bgpaas_vm1 is ready for SSH connections
2025-10-23 03:56:09,154 - INFO - Configuring BGP on bgpaas_vm1
2025-10-23 03:56:09,154 - DEBUG - Running remote_cmd, Cmd : cat > /etc/bird/bird.conf << EOS
protocol device {
scan time 10; # Scan interfaces every 10 seconds
}
protocol kernel {
persist; # Don't remove routes on bird shutdown
scan time 20; # Scan kernel routing table every 20 seconds
import all; # Default is import all
#export all; # Default is export none
}
protocol direct {
interface "eth*";
}
router id 86.153.179.196;
protocol bgp bgp_1{
local as 64500;
neighbor 86.153.179.193 as 782;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 86.153.179.196;
}
protocol bfd {
neighbor 86.153.179.193 local 86.153.179.196 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.48, gateway password: c0ntrail123
2025-10-23 03:56:09,154 - DEBUG - cat > /etc/bird/bird.conf << EOS
protocol device {
scan time 10; # Scan interfaces every 10 seconds
}
protocol kernel {
persist; # Don't remove routes on bird shutdown
scan time 20; # Scan kernel routing table every 20 seconds
import all; # Default is import all
#export all; # Default is export none
}
protocol direct {
interface "eth*";
}
router id 86.153.179.196;
protocol bgp bgp_1{
local as 64500;
neighbor 86.153.179.193 as 782;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 86.153.179.196;
}
protocol bfd {
neighbor 86.153.179.193 local 86.153.179.196 multihop on;
}
EOS
2025-10-23 03:56:31,400 - DEBUG - None
2025-10-23 03:56:31,401 - DEBUG - Running remote_cmd, Cmd : cat > /etc/bird/bird.conf << EOS
protocol device {
scan time 10; # Scan interfaces every 10 seconds
}
protocol kernel {
persist; # Don't remove routes on bird shutdown
scan time 20; # Scan kernel routing table every 20 seconds
import all; # Default is import all
#export all; # Default is export none
}
protocol direct {
interface "eth*";
}
router id 86.153.179.196;
protocol bgp bgp_1{
local as 64500;
neighbor 86.153.179.193 as 782;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 86.153.179.196;
}
protocol bfd {
neighbor 86.153.179.193 local 86.153.179.196 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.48, gateway password: c0ntrail123
2025-10-23 03:56:31,401 - DEBUG - cat > /etc/bird/bird.conf << EOS
protocol device {
scan time 10; # Scan interfaces every 10 seconds
}
protocol kernel {
persist; # Don't remove routes on bird shutdown
scan time 20; # Scan kernel routing table every 20 seconds
import all; # Default is import all
#export all; # Default is export none
}
protocol direct {
interface "eth*";
}
router id 86.153.179.196;
protocol bgp bgp_1{
local as 64500;
neighbor 86.153.179.193 as 782;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 86.153.179.196;
}
protocol bfd {
neighbor 86.153.179.193 local 86.153.179.196 multihop on;
}
EOS
2025-10-23 03:56:32,935 - DEBUG - None
2025-10-23 03:56:32,935 - DEBUG - Running remote_cmd, Cmd : service bird restart, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.48, gateway password: c0ntrail123
2025-10-23 03:56:32,935 - DEBUG - service bird restart
2025-10-23 03:56:36,645 - DEBUG - bird stop/waiting
bird start/running, process 1435
2025-10-23 03:56:36,657 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 03:56:36,681 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 03:56:42,726 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 03:56:42,745 - INFO - BGPaaS session seen in control-node 10.20.0.14
2025-10-23 03:56:42,745 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 03:56:42,760 - INFO - Detaching VMI 2c254ba8-91f6-458c-b68c-1893f289d49c from BGPaaS 74116635-f491-4b4d-ba2b-480c5e22517d
2025-10-23 03:56:42,833 - INFO - Deleting BGPaaS ctest-TestBGPaaSlocalAS-08354474-50082479(74116635-f491-4b4d-ba2b-480c5e22517d)
2025-10-23 03:56:42,873 - DEBUG - Requesting: http://10.0.0.41:8082/bgp-as-a-service/74116635-f491-4b4d-ba2b-480c5e22517d
2025-10-23 03:56:42,886 - DEBUG - Response Code: 404
2025-10-23 03:56:42,886 - DEBUG - BGPaaS: 74116635-f491-4b4d-ba2b-480c5e22517d deleted from api server
2025-10-23 03:56:42,886 - INFO - BGPaaS(74116635-f491-4b4d-ba2b-480c5e22517d): verify_on_cleanup passed
2025-10-23 03:56:42,887 - INFO - Deleting VM bgpaas_vm1
2025-10-23 03:56:43,016 - INFO - Deleting VM test_vm
2025-10-23 03:56:43,123 - INFO - Deleting VN ctest-bgpaas_vn-68907403
2025-10-23 03:56:43,170 - DEBUG - VN ae60cf13-a298-46db-b7a2-1bb3ae3833e7 still in use: Unable to complete operation on network ae60cf13-a298-46db-b7a2-1bb3ae3833e7. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-3d9e7f92-8d5e-4fe9-be70-d03027428bf9']
2025-10-23 03:56:43,170 - WARNING - Deleting VN ctest-bgpaas_vn-68907403 failed..Will retry
2025-10-23 03:56:45,384 - DEBUG - Response for deleting network ()
2025-10-23 03:56:46,727 - DEBUG - Skipping xmpp flap check
2025-10-23 03:56:46,727 - INFO - END TEST : test_basic_bgpaas_local_as : PASSED[0:03:54]
2025-10-23 03:56:46,727 - INFO - --------------------------------------------------------------------------------
2025-10-23 03:56:47,492 - INFO - Deleted project: ctest-TestBGPaaSlocalAS-08354474, ID : 63aef0c2-aea2-4383-9641-58245629ebfc
2025-10-23 04:00:31,789 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 04:00:31,821 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 04:00:37,849 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 04:00:43,872 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 04:01:01,502 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 04:01:12,498 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 04:01:18,516 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 04:01:18,549 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 04:04:43,841 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 04:04:43,857 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 04:04:43,883 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 04:04:49,899 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 04:04:55,917 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 04:04:55,932 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 04:05:03,387 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 04:05:03,417 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 04:05:03,446 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-10-23 04:05:03,470 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=