is in ACTIVE state now
2025-08-07 20:32:29,923 - INFO - VM name : bgpaas_vm1
2025-08-07 20:32:30,019 - DEBUG - VM bgpaas_vm1 ID is d23df2f2-e0e0-4b7a-9907-6b71ef72bb39
2025-08-07 20:32:30,019 - DEBUG - VM bgpaas_vm1 launched on Node an-jenkins-deploy-platform-ansible-os-3775-1
2025-08-07 20:32:30,103 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine/d23df2f2-e0e0-4b7a-9907-6b71ef72bb39
2025-08-07 20:32:30,115 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine-interface/bac85117-2ddc-458b-bb7f-c2176ffb7544
2025-08-07 20:32:33,410 - 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 1035ms')
2025-08-07 20:32:33,410 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-08-07 20:32:33,430 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-88395954:ctest-bgpaas_vn-20018941 is 183.232.93.1 and allocation pool is NOT set
2025-08-07 20:32:37,539 - 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 1025ms')
2025-08-07 20:32:37,539 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-08-07 20:32:37,559 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-88395954:ctest-bgpaas_vn-20018941 is 183.232.93.1 and allocation pool is NOT set
2025-08-07 20:32:41,669 - 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 1026ms')
2025-08-07 20:32:41,669 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-08-07 20:32:41,687 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-88395954:ctest-bgpaas_vn-20018941 is 183.232.93.1 and allocation pool is NOT set
2025-08-07 20:32:45,794 - 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 1028ms')
2025-08-07 20:32:45,795 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-08-07 20:32:45,811 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-88395954:ctest-bgpaas_vn-20018941 is 183.232.93.1 and allocation pool is NOT set
2025-08-07 20:32:49,931 - 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-08-07 20:32:49,931 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-08-07 20:32:49,951 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-88395954:ctest-bgpaas_vn-20018941 is 183.232.93.1 and allocation pool is NOT set
2025-08-07 20:32:54,018 - 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 1002ms')
2025-08-07 20:32:54,019 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-08-07 20:32:54,038 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-88395954:ctest-bgpaas_vn-20018941 is 183.232.93.1 and allocation pool is NOT set
2025-08-07 20:32:58,119 - 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-08-07 20:32:58,119 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-08-07 20:32:58,144 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-88395954:ctest-bgpaas_vn-20018941 is 183.232.93.1 and allocation pool is NOT set
2025-08-07 20:33:02,216 - 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 1006ms')
2025-08-07 20:33:02,216 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-08-07 20:33:02,239 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-88395954:ctest-bgpaas_vn-20018941 is 183.232.93.1 and allocation pool is NOT set
2025-08-07 20:33:06,312 - 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 1009ms')
2025-08-07 20:33:06,312 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-08-07 20:33:06,333 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-88395954:ctest-bgpaas_vn-20018941 is 183.232.93.1 and allocation pool is NOT set
2025-08-07 20:33:10,411 - 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-08-07 20:33:10,411 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-08-07 20:33:10,427 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-88395954:ctest-bgpaas_vn-20018941 is 183.232.93.1 and allocation pool is NOT set
2025-08-07 20:33:14,529 - 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-08-07 20:33:14,530 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-08-07 20:33:14,547 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-88395954:ctest-bgpaas_vn-20018941 is 183.232.93.1 and allocation pool is NOT set
2025-08-07 20:33:18,667 - 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 1031ms')
2025-08-07 20:33:18,667 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-08-07 20:33:18,687 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-88395954:ctest-bgpaas_vn-20018941 is 183.232.93.1 and allocation pool is NOT set
2025-08-07 20:33:22,793 - 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-08-07 20:33:22,793 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-08-07 20:33:22,810 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-88395954:ctest-bgpaas_vn-20018941 is 183.232.93.1 and allocation pool is NOT set
2025-08-07 20:33:26,917 - 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 1010ms')
2025-08-07 20:33:26,917 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-08-07 20:33:26,938 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-88395954:ctest-bgpaas_vn-20018941 is 183.232.93.1 and allocation pool is NOT set
2025-08-07 20:33:31,048 - 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-08-07 20:33:31,048 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 failed!
2025-08-07 20:33:31,071 - DEBUG - Gateway for vn default-domain:ctest-TestBGPaaSlocalAS-88395954:ctest-bgpaas_vn-20018941 is 183.232.93.1 and allocation pool is NOT set
2025-08-07 20:33:33,144 - 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=3.64 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.92 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 = 1.924/2.782/3.640/0.858 ms')
2025-08-07 20:33:33,144 - INFO - Ping to Metadata IP 169.254.0.3 of VM bgpaas_vm1 passed
2025-08-07 20:33:33,265 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 20:33:33,265 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 183.232.93.4, Port 22
2025-08-07 20:33:33,356 - 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-08-07 20:33:33,459 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-07 20:33:38,459 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 20:33:38,459 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 183.232.93.4, Port 22
2025-08-07 20:33:38,547 - 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-08-07 20:33:38,635 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-07 20:33:43,637 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 20:33:43,637 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 183.232.93.4, Port 22
2025-08-07 20:33:43,717 - 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-08-07 20:33:43,808 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-07 20:33:48,810 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 20:33:48,810 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 183.232.93.4, Port 22
2025-08-07 20:33:48,899 - 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-08-07 20:33:48,993 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-07 20:33:53,993 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 20:33:53,994 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 183.232.93.4, Port 22
2025-08-07 20:33:54,087 - 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-08-07 20:33:54,185 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-07 20:33:59,186 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 20:33:59,186 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 183.232.93.4, Port 22
2025-08-07 20:33:59,276 - 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-08-07 20:33:59,361 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-07 20:34:04,362 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 20:34:04,362 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 183.232.93.4, Port 22
2025-08-07 20:34:04,452 - 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-08-07 20:34:04,558 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-07 20:34:09,560 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 20:34:09,560 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 183.232.93.4, Port 22
2025-08-07 20:34:09,627 - 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-08-07 20:34:09,723 - DEBUG - VM bgpaas_vm1 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-07 20:34:14,723 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 20:34:14,724 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 183.232.93.4, Port 22
2025-08-07 20:34:14,922 - DEBUG - VM bgpaas_vm1 is ready for SSH connections
2025-08-07 20:34:14,922 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 20:34:14,930 - INFO - Creating BGPaaS ctest-TestBGPaaSlocalAS-88395954-20211043
2025-08-07 20:34:15,015 - INFO - BGPaaS: ctest-TestBGPaaSlocalAS-88395954-20211043(da9f81e2-8b5c-4634-9450-b021ea19604d)
2025-08-07 20:34:15,016 - DEBUG - Requesting: http://10.0.0.19:8082/bgp-as-a-service/da9f81e2-8b5c-4634-9450-b021ea19604d
2025-08-07 20:34:15,318 - DEBUG - Requesting: http://10.0.0.19:8082/bgp-as-a-service/da9f81e2-8b5c-4634-9450-b021ea19604d
2025-08-07 20:34:15,360 - INFO - verify_in_api_server passed for BGPaaS obj da9f81e2-8b5c-4634-9450-b021ea19604d
2025-08-07 20:34:15,360 - INFO - BGPaaS(da9f81e2-8b5c-4634-9450-b021ea19604d): verify_on_setup passed
2025-08-07 20:34:15,360 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 20:34:15,360 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 183.232.93.4, Port 22
2025-08-07 20:34:15,539 - DEBUG - VM bgpaas_vm1 is ready for SSH connections
2025-08-07 20:34:15,539 - INFO - Attaching VMI bac85117-2ddc-458b-bb7f-c2176ffb7544 to BGPaaS da9f81e2-8b5c-4634-9450-b021ea19604d
2025-08-07 20:34:15,623 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 20:34:15,623 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 20:34:15,773 - INFO - Configuring BGP on the bird
2025-08-07 20:34:15,773 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 20:34:15,773 - DEBUG - Waiting to SSH to VM bgpaas_vm1, IP 183.232.93.4, Port 22
2025-08-07 20:34:15,973 - DEBUG - VM bgpaas_vm1 is ready for SSH connections
2025-08-07 20:34:15,973 - INFO - Configuring BGP on bgpaas_vm1
2025-08-07 20:34:15,974 - 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 183.232.93.4;
protocol bgp bgp_1{
local as 64500;
neighbor 183.232.93.1 as 412;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 183.232.93.4;
}
protocol bfd {
neighbor 183.232.93.1 local 183.232.93.4 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.65, gateway password: c0ntrail123
2025-08-07 20:34:15,974 - 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 183.232.93.4;
protocol bgp bgp_1{
local as 64500;
neighbor 183.232.93.1 as 412;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 183.232.93.4;
}
protocol bfd {
neighbor 183.232.93.1 local 183.232.93.4 multihop on;
}
EOS
2025-08-07 20:34:34,956 - DEBUG - None
2025-08-07 20:34:34,956 - 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 183.232.93.4;
protocol bgp bgp_1{
local as 64500;
neighbor 183.232.93.1 as 412;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 183.232.93.4;
}
protocol bfd {
neighbor 183.232.93.1 local 183.232.93.4 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.65, gateway password: c0ntrail123
2025-08-07 20:34:34,956 - 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 183.232.93.4;
protocol bgp bgp_1{
local as 64500;
neighbor 183.232.93.1 as 412;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 183.232.93.4;
}
protocol bfd {
neighbor 183.232.93.1 local 183.232.93.4 multihop on;
}
EOS
2025-08-07 20:34:36,070 - DEBUG - None
2025-08-07 20:34:36,070 - DEBUG - Running remote_cmd, Cmd : service bird restart, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.65, gateway password: c0ntrail123
2025-08-07 20:34:36,070 - DEBUG - service bird restart
2025-08-07 20:34:37,791 - DEBUG - bird stop/waiting
bird start/running, process 1437
2025-08-07 20:34:37,808 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-08-07 20:34:37,832 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-08-07 20:34:43,881 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-08-07 20:34:43,903 - INFO - BGPaaS session seen in control-node 10.20.0.193
2025-08-07 20:34:43,904 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-08-07 20:34:43,919 - INFO - Detaching VMI bac85117-2ddc-458b-bb7f-c2176ffb7544 from BGPaaS da9f81e2-8b5c-4634-9450-b021ea19604d
2025-08-07 20:34:43,995 - INFO - Deleting BGPaaS ctest-TestBGPaaSlocalAS-88395954-20211043(da9f81e2-8b5c-4634-9450-b021ea19604d)
2025-08-07 20:34:44,054 - DEBUG - Requesting: http://10.0.0.19:8082/bgp-as-a-service/da9f81e2-8b5c-4634-9450-b021ea19604d
2025-08-07 20:34:44,064 - DEBUG - Response Code: 404
2025-08-07 20:34:44,064 - DEBUG - BGPaaS: da9f81e2-8b5c-4634-9450-b021ea19604d deleted from api server
2025-08-07 20:34:44,064 - INFO - BGPaaS(da9f81e2-8b5c-4634-9450-b021ea19604d): verify_on_cleanup passed
2025-08-07 20:34:44,065 - INFO - Deleting VM bgpaas_vm1
2025-08-07 20:34:44,194 - INFO - Deleting VM test_vm
2025-08-07 20:34:44,292 - INFO - Deleting VN ctest-bgpaas_vn-20018941
2025-08-07 20:34:44,338 - DEBUG - VN 446bb244-9875-40f5-9228-41557d17c3b2 still in use: Unable to complete operation on network 446bb244-9875-40f5-9228-41557d17c3b2. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-072148e7-6a49-4f74-a860-672467e1529e']
2025-08-07 20:34:44,338 - WARNING - Deleting VN ctest-bgpaas_vn-20018941 failed..Will retry
2025-08-07 20:34:46,582 - DEBUG - Response for deleting network ()
2025-08-07 20:34:47,920 - DEBUG - Skipping xmpp flap check
2025-08-07 20:34:47,920 - INFO - END TEST : test_basic_bgpaas_local_as : PASSED[0:03:28]
2025-08-07 20:34:47,921 - INFO - --------------------------------------------------------------------------------
2025-08-07 20:34:48,740 - INFO - Deleted project: ctest-TestBGPaaSlocalAS-88395954, ID : 0029beaf-f033-42ae-ae3f-fb3bd71fa21c
2025-08-07 20:38:27,142 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-08-07 20:38:50,767 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-08-07 20:38:56,789 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-08-07 20:39:07,395 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-08-07 20:39:13,417 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-08-07 20:42:09,407 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-08-07 20:42:09,460 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-08-07 20:42:15,480 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-08-07 20:42:21,500 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-08-07 20:42:28,460 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-08-07 20:42:28,506 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_BgpNeighborReq?domain=&ip_address=