is in ACTIVE state now
2025-12-08 03:51:33,398 - INFO - VM name : bgpaas_vm1
2025-12-08 03:51:33,483 - DEBUG - VM bgpaas_vm1 ID is b67e8ae6-0549-4f1a-b4e8-aa0f7887f4c5
2025-12-08 03:51:33,483 - DEBUG - VM bgpaas_vm1 launched on Node an-jenkins-deploy-platform-ansible-os-4854-1
2025-12-08 03:51:33,568 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/b67e8ae6-0549-4f1a-b4e8-aa0f7887f4c5
2025-12-08 03:51:33,577 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/336e91c3-4957-49b4-8453-7d80f844686e
2025-12-08 03:51:36,745 - 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-12-08 03:51:36,746 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-12-08 03:51:36,761 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-03886659:ctest-bgpaas_vn-33980465 is 94.34.133.193 and allocation pool is NOT set
2025-12-08 03:51:40,847 - 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 1023ms')
2025-12-08 03:51:40,847 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-12-08 03:51:40,861 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-03886659:ctest-bgpaas_vn-33980465 is 94.34.133.193 and allocation pool is NOT set
2025-12-08 03:51:44,941 - 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 1023ms')
2025-12-08 03:51:44,941 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-12-08 03:51:44,957 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-03886659:ctest-bgpaas_vn-33980465 is 94.34.133.193 and allocation pool is NOT set
2025-12-08 03:51:49,042 - 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 1019ms')
2025-12-08 03:51:49,042 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-12-08 03:51:49,057 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-03886659:ctest-bgpaas_vn-33980465 is 94.34.133.193 and allocation pool is NOT set
2025-12-08 03:51:53,131 - 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 1015ms')
2025-12-08 03:51:53,131 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-12-08 03:51:53,145 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-03886659:ctest-bgpaas_vn-33980465 is 94.34.133.193 and allocation pool is NOT set
2025-12-08 03:51:57,230 - 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 1023ms')
2025-12-08 03:51:57,230 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-12-08 03:51:57,255 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-03886659:ctest-bgpaas_vn-33980465 is 94.34.133.193 and allocation pool is NOT set
2025-12-08 03:52:01,329 - 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-12-08 03:52:01,329 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-12-08 03:52:01,347 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-03886659:ctest-bgpaas_vn-33980465 is 94.34.133.193 and allocation pool is NOT set
2025-12-08 03:52:05,419 - 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 1015ms')
2025-12-08 03:52:05,419 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-12-08 03:52:05,434 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-03886659:ctest-bgpaas_vn-33980465 is 94.34.133.193 and allocation pool is NOT set
2025-12-08 03:52:09,522 - 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-12-08 03:52:09,522 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-12-08 03:52:09,535 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-03886659:ctest-bgpaas_vn-33980465 is 94.34.133.193 and allocation pool is NOT set
2025-12-08 03:52:13,618 - 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 1023ms')
2025-12-08 03:52:13,618 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-12-08 03:52:13,633 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-03886659:ctest-bgpaas_vn-33980465 is 94.34.133.193 and allocation pool is NOT set
2025-12-08 03:52:17,715 - 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-12-08 03:52:17,715 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-12-08 03:52:17,732 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-03886659:ctest-bgpaas_vn-33980465 is 94.34.133.193 and allocation pool is NOT set
2025-12-08 03:52:21,811 - 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 1019ms')
2025-12-08 03:52:21,811 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-12-08 03:52:21,825 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-03886659:ctest-bgpaas_vn-33980465 is 94.34.133.193 and allocation pool is NOT set
2025-12-08 03:52:25,903 - 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-12-08 03:52:25,903 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-12-08 03:52:25,916 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-03886659:ctest-bgpaas_vn-33980465 is 94.34.133.193 and allocation pool is NOT set
2025-12-08 03:52:29,997 - 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 1015ms')
2025-12-08 03:52:29,997 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-12-08 03:52:30,014 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-03886659:ctest-bgpaas_vn-33980465 is 94.34.133.193 and allocation pool is NOT set
2025-12-08 03:52:34,095 - 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-12-08 03:52:34,095 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-12-08 03:52:34,111 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-03886659:ctest-bgpaas_vn-33980465 is 94.34.133.193 and allocation pool is NOT set
2025-12-08 03:52:36,172 - 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=1 ttl=63 time=6.27 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.250 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.250/3.261/6.272/3.011 ms')
2025-12-08 03:52:36,172 - INFO - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 passed
2025-12-08 03:52:36,246 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-08 03:52:36,246 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 94.34.133.196, Port 22
2025-12-08 03:52:36,313 - 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-12-08 03:52:36,400 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-12-08 03:52:41,400 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-08 03:52:41,400 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 94.34.133.196, Port 22
2025-12-08 03:52:41,466 - 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-12-08 03:52:41,552 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-12-08 03:52:46,553 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-08 03:52:46,553 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 94.34.133.196, Port 22
2025-12-08 03:52:46,622 - 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-12-08 03:52:46,713 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-12-08 03:52:51,714 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-08 03:52:51,714 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 94.34.133.196, Port 22
2025-12-08 03:52:51,771 - 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-12-08 03:52:51,850 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-12-08 03:52:56,852 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-08 03:52:56,852 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 94.34.133.196, Port 22
2025-12-08 03:52:56,907 - 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-12-08 03:52:56,994 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-12-08 03:53:01,995 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-08 03:53:01,995 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 94.34.133.196, Port 22
2025-12-08 03:53:02,051 - 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-12-08 03:53:02,152 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-12-08 03:53:07,153 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-08 03:53:07,153 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 94.34.133.196, Port 22
2025-12-08 03:53:07,211 - 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-12-08 03:53:07,293 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-12-08 03:53:12,294 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-08 03:53:12,294 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 94.34.133.196, Port 22
2025-12-08 03:53:12,351 - 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-12-08 03:53:12,440 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-12-08 03:53:17,441 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-08 03:53:17,441 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 94.34.133.196, Port 22
2025-12-08 03:53:17,603 - DEBUG - VM bgpaas_vm1 is ready for SSH connections
2025-12-08 03:53:17,603 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-08 03:53:17,610 - INFO - Creating BGPaaS ctest-TestBGPaaSlocalAS-03886659-46673023
2025-12-08 03:53:17,693 - INFO - BGPaaS: ctest-TestBGPaaSlocalAS-03886659-46673023(810bb51b-511d-4ea1-b6b4-16ad592108d0)
2025-12-08 03:53:17,693 - DEBUG - Requesting: http://10.0.0.23:8082/bgp-as-a-service/810bb51b-511d-4ea1-b6b4-16ad592108d0
2025-12-08 03:53:18,028 - DEBUG - Requesting: http://10.0.0.23:8082/bgp-as-a-service/810bb51b-511d-4ea1-b6b4-16ad592108d0
2025-12-08 03:53:18,062 - INFO - verify_in_api_server passed for BGPaaS obj 810bb51b-511d-4ea1-b6b4-16ad592108d0
2025-12-08 03:53:18,062 - INFO - BGPaaS(810bb51b-511d-4ea1-b6b4-16ad592108d0): verify_on_setup passed
2025-12-08 03:53:18,062 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-08 03:53:18,062 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 94.34.133.196, Port 22
2025-12-08 03:53:18,219 - DEBUG - VM bgpaas_vm1 is ready for SSH connections
2025-12-08 03:53:18,219 - INFO - Attaching VMI 336e91c3-4957-49b4-8453-7d80f844686e to BGPaaS 810bb51b-511d-4ea1-b6b4-16ad592108d0
2025-12-08 03:53:18,297 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-08 03:53:18,297 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-08 03:53:18,397 - INFO - Configuring BGP on the bird
2025-12-08 03:53:18,398 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-08 03:53:18,398 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 94.34.133.196, Port 22
2025-12-08 03:53:18,562 - DEBUG - VM bgpaas_vm1 is ready for SSH connections
2025-12-08 03:53:18,562 - INFO - Configuring BGP on bgpaas_vm1
2025-12-08 03:53:18,562 - 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 94.34.133.196;
protocol bgp bgp_1{
local as 64500;
neighbor 94.34.133.193 as 411;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 94.34.133.196;
}
protocol bfd {
neighbor 94.34.133.193 local 94.34.133.196 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.41, gateway password: c0ntrail123
2025-12-08 03:53:18,563 - 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 94.34.133.196;
protocol bgp bgp_1{
local as 64500;
neighbor 94.34.133.193 as 411;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 94.34.133.196;
}
protocol bfd {
neighbor 94.34.133.193 local 94.34.133.196 multihop on;
}
EOS
2025-12-08 03:53:36,367 - DEBUG - None
2025-12-08 03:53:36,367 - 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 94.34.133.196;
protocol bgp bgp_1{
local as 64500;
neighbor 94.34.133.193 as 411;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 94.34.133.196;
}
protocol bfd {
neighbor 94.34.133.193 local 94.34.133.196 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.41, gateway password: c0ntrail123
2025-12-08 03:53:36,367 - 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 94.34.133.196;
protocol bgp bgp_1{
local as 64500;
neighbor 94.34.133.193 as 411;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 94.34.133.196;
}
protocol bfd {
neighbor 94.34.133.193 local 94.34.133.196 multihop on;
}
EOS
2025-12-08 03:53:37,285 - DEBUG - None
2025-12-08 03:53:37,286 - DEBUG - Running remote_cmd, Cmd : service bird restart, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.41, gateway password: c0ntrail123
2025-12-08 03:53:37,286 - DEBUG - service bird restart
2025-12-08 03:53:40,212 - DEBUG - bird stop/waiting
bird start/running, process 1434
2025-12-08 03:53:40,226 - DEBUG - Requesting: http://10.20.0.145:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-08 03:53:40,245 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-08 03:53:46,284 - DEBUG - Requesting: http://10.20.0.145:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-08 03:53:46,309 - INFO - BGPaaS session seen in control-node 10.20.0.145
2025-12-08 03:53:46,309 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-08 03:53:46,324 - INFO - Detaching VMI 336e91c3-4957-49b4-8453-7d80f844686e from BGPaaS 810bb51b-511d-4ea1-b6b4-16ad592108d0
2025-12-08 03:53:46,413 - INFO - Deleting BGPaaS ctest-TestBGPaaSlocalAS-03886659-46673023(810bb51b-511d-4ea1-b6b4-16ad592108d0)
2025-12-08 03:53:46,492 - DEBUG - Requesting: http://10.0.0.23:8082/bgp-as-a-service/810bb51b-511d-4ea1-b6b4-16ad592108d0
2025-12-08 03:53:46,500 - DEBUG - Response Code: 404
2025-12-08 03:53:46,500 - DEBUG - BGPaaS: 810bb51b-511d-4ea1-b6b4-16ad592108d0 deleted from api server
2025-12-08 03:53:46,500 - INFO - BGPaaS(810bb51b-511d-4ea1-b6b4-16ad592108d0): verify_on_cleanup passed
2025-12-08 03:53:46,501 - INFO - Deleting VM bgpaas_vm1
2025-12-08 03:53:46,645 - INFO - Deleting VM test_vm
2025-12-08 03:53:46,720 - INFO - Deleting VN ctest-bgpaas_vn-33980465
2025-12-08 03:53:46,764 - DEBUG - VN 81fef61f-a7c3-4fa1-bb4f-212b96e99f5f still in use: Unable to complete operation on network 81fef61f-a7c3-4fa1-bb4f-212b96e99f5f. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-4c68acf4-f89d-436b-bab5-671c293451b9']
2025-12-08 03:53:46,765 - WARNING - Deleting VN ctest-bgpaas_vn-33980465 failed..Will retry
2025-12-08 03:53:49,053 - DEBUG - Response for deleting network ()
2025-12-08 03:53:50,362 - DEBUG - Skipping xmpp flap check
2025-12-08 03:53:50,362 - INFO - END TEST : test_basic_bgpaas_local_as : PASSED[0:03:18]
2025-12-08 03:53:50,362 - INFO - --------------------------------------------------------------------------------
2025-12-08 03:53:51,139 - INFO - Deleted project: ctest-TestBGPaaSlocalAS-03886659, ID : d993a32b-3bb5-4c32-882a-71090dd0746d
2025-12-08 03:57:24,755 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-08 03:57:41,590 - DEBUG - Requesting: http://10.20.0.145:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-08 03:57:47,610 - DEBUG - Requesting: http://10.20.0.145:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-08 03:57:57,800 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-08 03:58:03,816 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-08 04:00:52,675 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-08 04:00:52,709 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-08 04:00:58,722 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-08 04:01:10,813 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-08 04:01:10,847 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_BgpNeighborReq?domain=&ip_address=