is in ACTIVE state now
2026-07-06 16:54:43,739 - INFO - VM name : ctest-TestBGPaasZone-06147855-91114085
2026-07-06 16:54:43,812 - DEBUG - VM ctest-TestBGPaasZone-06147855-91114085 ID is 20015d88-1e2b-419d-9d64-8d6bc7066d9c
2026-07-06 16:54:43,812 - DEBUG - VM ctest-TestBGPaasZone-06147855-91114085 launched on Node an-jenkins-deploy-platform-ansible-os-6083-2
2026-07-06 16:54:43,877 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/20015d88-1e2b-419d-9d64-8d6bc7066d9c
2026-07-06 16:54:43,888 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/c13a305a-cf09-4c5d-ac0c-87d4f9f576cb
2026-07-06 16:54:45,053 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n64 bytes from 169.254.0.4: icmp_seq=1 ttl=63 time=3.56 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=1.12 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 1.116/2.340/3.564/1.224 ms')
2026-07-06 16:54:45,053 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBGPaasZone-06147855-91114085 passed
2026-07-06 16:54:45,123 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-07-06 16:54:45,123 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-06147855-91114085, IP 151.169.81.69, Port 22
2026-07-06 16:54:45,295 - DEBUG - VM ctest-TestBGPaasZone-06147855-91114085 is ready for SSH connections
2026-07-06 16:54:45,435 - INFO - Created control node zone ctest-test-zone-78752592(ba4c9135-5aea-4a47-85d2-19b981ae55a0)
2026-07-06 16:54:45,783 - INFO - Created control node zone ctest-test-zone-58538334(062b9a05-3cd1-4c13-85e4-365d40692273)
2026-07-06 16:54:46,135 - INFO - Created control node zone ctest-test-zone-65801519(cf411754-80c8-4516-9dbf-161ea9702808)
2026-07-06 16:54:46,419 - INFO - Creating BGPaaS ctest-TestBGPaasZone-06147855-43464728
2026-07-06 16:54:46,495 - INFO - BGPaaS: ctest-TestBGPaasZone-06147855-43464728(ffbf8c99-0643-4a9b-947d-301f8cb8ec8f)
2026-07-06 16:54:46,495 - DEBUG - Requesting: http://10.0.0.50:8082/bgp-as-a-service/ffbf8c99-0643-4a9b-947d-301f8cb8ec8f
2026-07-06 16:54:46,506 - INFO - verify_in_api_server passed for BGPaaS obj ffbf8c99-0643-4a9b-947d-301f8cb8ec8f
2026-07-06 16:54:46,506 - INFO - BGPaaS(ffbf8c99-0643-4a9b-947d-301f8cb8ec8f): verify_on_setup passed
2026-07-06 16:54:46,506 - INFO - We will configure BGP on the VM
2026-07-06 16:54:46,907 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-07-06 16:54:46,907 - INFO - Configuring BGP on ctest-TestBGPaasZone-06147855-99548661
2026-07-06 16:54:46,907 - 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 151.169.81.67;
protocol bgp bgp_1{
local as 65000;
neighbor 151.169.81.65 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 151.169.81.67;
}
protocol bfd {
neighbor 151.169.81.65 local 151.169.81.67 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.57, gateway password: c0ntrail123
2026-07-06 16:54:46,907 - 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 151.169.81.67;
protocol bgp bgp_1{
local as 65000;
neighbor 151.169.81.65 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 151.169.81.67;
}
protocol bfd {
neighbor 151.169.81.65 local 151.169.81.67 multihop on;
}
EOS
2026-07-06 16:55:00,575 - DEBUG - None
2026-07-06 16:55:00,575 - DEBUG - Running remote_cmd, Cmd : cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 151.169.81.66 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 151.169.81.67;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.57, gateway password: c0ntrail123
2026-07-06 16:55:00,575 - DEBUG - cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 151.169.81.66 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 151.169.81.67;
}
EOS
2026-07-06 16:55:00,872 - DEBUG - None
2026-07-06 16:55:00,872 - DEBUG - Running remote_cmd, Cmd : service bird restart, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.57, gateway password: c0ntrail123
2026-07-06 16:55:00,873 - DEBUG - service bird restart
2026-07-06 16:55:01,657 - DEBUG - bird stop/waiting
bird start/running, process 1437
2026-07-06 16:55:01,657 - INFO - Attaching VMI 88aa587a-ad68-4304-a888-0fc2196f7aac to BGPaaS ffbf8c99-0643-4a9b-947d-301f8cb8ec8f
2026-07-06 16:55:01,731 - INFO - Attaching the VMI fd7955e6-a9b7-49ef-a3b3-c8535a970fe9 to the BGPaaS ffbf8c99-0643-4a9b-947d-301f8cb8ec8f object
2026-07-06 16:55:01,731 - DEBUG - Running remote_cmd, Cmd : sudo ip addr add 151.169.81.84 dev eth0, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.57, gateway password: c0ntrail123
2026-07-06 16:55:01,731 - DEBUG - sudo ip addr add 151.169.81.84 dev eth0
2026-07-06 16:55:02,106 - DEBUG - None
2026-07-06 16:55:02,179 - INFO - Creating BGPaaS ctest-TestBGPaasZone-06147855-43668855
2026-07-06 16:55:02,255 - INFO - BGPaaS: ctest-TestBGPaasZone-06147855-43668855(df0789c6-9ed2-4a4a-ae58-9f31352c251d)
2026-07-06 16:55:02,255 - DEBUG - Requesting: http://10.0.0.50:8082/bgp-as-a-service/df0789c6-9ed2-4a4a-ae58-9f31352c251d
2026-07-06 16:55:02,264 - INFO - verify_in_api_server passed for BGPaaS obj df0789c6-9ed2-4a4a-ae58-9f31352c251d
2026-07-06 16:55:02,264 - INFO - BGPaaS(df0789c6-9ed2-4a4a-ae58-9f31352c251d): verify_on_setup passed
2026-07-06 16:55:02,265 - INFO - We will configure BGP on the VM
2026-07-06 16:55:02,679 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-07-06 16:55:02,679 - INFO - Configuring BGP on ctest-TestBGPaasZone-06147855-95259987
2026-07-06 16:55:02,679 - 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 151.169.81.68;
protocol bgp bgp_1{
local as 65000;
neighbor 151.169.81.65 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 151.169.81.68;
}
protocol bfd {
neighbor 151.169.81.65 local 151.169.81.68 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.19, gateway password: c0ntrail123
2026-07-06 16:55:02,679 - 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 151.169.81.68;
protocol bgp bgp_1{
local as 65000;
neighbor 151.169.81.65 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 151.169.81.68;
}
protocol bfd {
neighbor 151.169.81.65 local 151.169.81.68 multihop on;
}
EOS
2026-07-06 16:55:13,835 - DEBUG - None
2026-07-06 16:55:13,835 - DEBUG - Running remote_cmd, Cmd : cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 151.169.81.66 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 151.169.81.68;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.19, gateway password: c0ntrail123
2026-07-06 16:55:13,835 - DEBUG - cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 151.169.81.66 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 151.169.81.68;
}
EOS
2026-07-06 16:55:14,102 - DEBUG - None
2026-07-06 16:55:14,102 - DEBUG - Running remote_cmd, Cmd : service bird restart, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.19, gateway password: c0ntrail123
2026-07-06 16:55:14,102 - DEBUG - service bird restart
2026-07-06 16:55:14,894 - DEBUG - bird stop/waiting
bird start/running, process 1447
2026-07-06 16:55:14,894 - INFO - Attaching VMI 5cc7b67c-4603-437b-8d56-e6ae1c2a9ff2 to BGPaaS df0789c6-9ed2-4a4a-ae58-9f31352c251d
2026-07-06 16:55:14,967 - INFO - Attaching the VMI 0afc3cf5-b1c1-4fa2-9799-abb0872b12ef to the BGPaaS df0789c6-9ed2-4a4a-ae58-9f31352c251d object
2026-07-06 16:55:14,967 - DEBUG - Running remote_cmd, Cmd : sudo ip addr add 151.169.81.84 dev eth0, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.19, gateway password: c0ntrail123
2026-07-06 16:55:14,967 - DEBUG - sudo ip addr add 151.169.81.84 dev eth0
2026-07-06 16:55:15,294 - DEBUG - None
2026-07-06 16:55:15,295 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-07-06 16:55:15,322 - INFO - BGPaaS session seen in control-node 10.20.0.254
2026-07-06 16:55:15,322 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-07-06 16:55:15,322 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_BgpNeighborReq?domain=&ip_address=
2026-07-06 16:55:15,345 - INFO - BGPaaS session seen in control-node 10.20.0.25
2026-07-06 16:55:15,356 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-07-06 16:55:15,371 - ERROR - Not enough BGPaaS sessions seen in control-nodes ['10.20.0.254']
2026-07-06 16:55:21,386 - INFO - BGPaaS session seen in control-node 10.20.0.254
2026-07-06 16:55:21,387 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-07-06 16:55:21,387 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_BgpNeighborReq?domain=&ip_address=
2026-07-06 16:55:21,403 - ERROR - Not enough BGPaaS sessions seen in control-nodes ['10.20.0.25']
2026-07-06 16:55:27,405 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_BgpNeighborReq?domain=&ip_address=
2026-07-06 16:55:27,421 - INFO - BGPaaS session seen in control-node 10.20.0.25
2026-07-06 16:55:27,427 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 151.169.81.84, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.57, gateway password: c0ntrail123
2026-07-06 16:55:27,427 - DEBUG - ping -s 56 -c 3 -W 1 151.169.81.84
2026-07-06 16:55:38,766 - DEBUG - PING 151.169.81.84 (151.169.81.84) 56(84) bytes of data.
64 bytes from 151.169.81.84: icmp_seq=1 ttl=64 time=3.83 ms
64 bytes from 151.169.81.84: icmp_seq=2 ttl=64 time=1.01 ms
64 bytes from 151.169.81.84: icmp_seq=3 ttl=64 time=0.968 ms
--- 151.169.81.84 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2004ms
rtt min/avg/max/mdev = 0.968/1.936/3.832/1.341 ms
2026-07-06 16:55:38,766 - INFO - Ping to IP 151.169.81.84 from VM ctest-TestBGPaasZone-06147855-91114085 passed
2026-07-06 16:55:38,766 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-07-06 16:55:38,779 - INFO - BGPaaS session seen in control-node 10.20.0.254
2026-07-06 16:55:38,779 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-07-06 16:55:38,779 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_BgpNeighborReq?domain=&ip_address=
2026-07-06 16:55:38,795 - INFO - BGPaaS session seen in control-node 10.20.0.25
2026-07-06 16:55:38,809 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-07-06 16:55:38,820 - INFO - BGPaaS session seen in control-node 10.20.0.254
2026-07-06 16:55:38,820 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-07-06 16:55:38,820 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_BgpNeighborReq?domain=&ip_address=
2026-07-06 16:55:38,835 - INFO - BGPaaS session seen in control-node 10.20.0.25
2026-07-06 16:55:38,841 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 151.169.81.84, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.57, gateway password: c0ntrail123
2026-07-06 16:55:38,842 - DEBUG - ping -s 56 -c 3 -W 1 151.169.81.84
2026-07-06 16:55:41,104 - DEBUG - PING 151.169.81.84 (151.169.81.84) 56(84) bytes of data.
64 bytes from 151.169.81.84: icmp_seq=1 ttl=64 time=1.54 ms
64 bytes from 151.169.81.84: icmp_seq=2 ttl=64 time=1.05 ms
64 bytes from 151.169.81.84: icmp_seq=3 ttl=64 time=0.994 ms
--- 151.169.81.84 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2003ms
rtt min/avg/max/mdev = 0.994/1.199/1.546/0.248 ms
2026-07-06 16:55:41,104 - INFO - Ping to IP 151.169.81.84 from VM ctest-TestBGPaasZone-06147855-91114085 passed
2026-07-06 16:55:41,104 - INFO - Detaching VMI 5cc7b67c-4603-437b-8d56-e6ae1c2a9ff2 from BGPaaS df0789c6-9ed2-4a4a-ae58-9f31352c251d
2026-07-06 16:55:41,183 - INFO - Deleting BGPaaS ctest-TestBGPaasZone-06147855-43668855(df0789c6-9ed2-4a4a-ae58-9f31352c251d)
2026-07-06 16:55:41,261 - DEBUG - Requesting: http://10.0.0.50:8082/bgp-as-a-service/df0789c6-9ed2-4a4a-ae58-9f31352c251d
2026-07-06 16:55:41,274 - DEBUG - Response Code: 404
2026-07-06 16:55:41,274 - DEBUG - BGPaaS: df0789c6-9ed2-4a4a-ae58-9f31352c251d deleted from api server
2026-07-06 16:55:41,274 - INFO - BGPaaS(df0789c6-9ed2-4a4a-ae58-9f31352c251d): verify_on_cleanup passed
2026-07-06 16:55:41,274 - INFO - Detaching VMI 88aa587a-ad68-4304-a888-0fc2196f7aac from BGPaaS ffbf8c99-0643-4a9b-947d-301f8cb8ec8f
2026-07-06 16:55:41,367 - INFO - Deleting BGPaaS ctest-TestBGPaasZone-06147855-43464728(ffbf8c99-0643-4a9b-947d-301f8cb8ec8f)
2026-07-06 16:55:41,484 - DEBUG - Requesting: http://10.0.0.50:8082/bgp-as-a-service/ffbf8c99-0643-4a9b-947d-301f8cb8ec8f
2026-07-06 16:55:41,489 - DEBUG - Response Code: 404
2026-07-06 16:55:41,489 - DEBUG - BGPaaS: ffbf8c99-0643-4a9b-947d-301f8cb8ec8f deleted from api server
2026-07-06 16:55:41,490 - INFO - BGPaaS(ffbf8c99-0643-4a9b-947d-301f8cb8ec8f): verify_on_cleanup passed
2026-07-06 16:55:41,490 - INFO - Deleting Control node zone ctest-test-zone-65801519(cf411754-80c8-4516-9dbf-161ea9702808)
2026-07-06 16:55:41,635 - INFO - Deleting Control node zone ctest-test-zone-58538334(062b9a05-3cd1-4c13-85e4-365d40692273)
2026-07-06 16:55:41,784 - INFO - Deleting Control node zone ctest-test-zone-78752592(ba4c9135-5aea-4a47-85d2-19b981ae55a0)
2026-07-06 16:55:41,927 - INFO - Deleting VM ctest-TestBGPaasZone-06147855-91114085
2026-07-06 16:55:41,995 - INFO - Deleting VM ctest-TestBGPaasZone-06147855-95259987
2026-07-06 16:55:42,052 - INFO - Deleting VM ctest-TestBGPaasZone-06147855-99548661
2026-07-06 16:55:42,110 - INFO - Deleting VN ctest-cnz_vn-73263702
2026-07-06 16:55:42,150 - DEBUG - VN ed98a58c-f43d-40cb-aac2-332465938412 still in use: Unable to complete operation on network ed98a58c-f43d-40cb-aac2-332465938412. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-33c17181-877a-46b6-acee-03408741be64']
2026-07-06 16:55:42,150 - WARNING - Deleting VN ctest-cnz_vn-73263702 failed..Will retry
2026-07-06 16:55:44,203 - DEBUG - VN ed98a58c-f43d-40cb-aac2-332465938412 still in use: Unable to complete operation on network ed98a58c-f43d-40cb-aac2-332465938412. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-60f89806-df15-47e8-a29f-98b7baf81beb']
2026-07-06 16:55:44,203 - WARNING - Deleting VN ctest-cnz_vn-73263702 failed..Will retry
2026-07-06 16:55:46,409 - DEBUG - Response for deleting network ()
2026-07-06 16:55:47,695 - DEBUG - Skipping xmpp flap check
2026-07-06 16:55:47,695 - INFO - END TEST : test_bgp_control_node_zones_from_single_vnf : PASSED[0:02:50]
2026-07-06 16:55:47,695 - INFO - --------------------------------------------------------------------------------
2026-07-06 16:55:48,433 - INFO - Deleted project: ctest-TestBGPaasZone-06147855, ID : 8bb202fe-5ea9-40e9-98ff-43f2bafaa456