is in ACTIVE state now
2026-04-02 04:10:08,973 - INFO - VM name : ctest-TestBGPaasZone-33847598-60226986
2026-04-02 04:10:09,074 - DEBUG - VM ctest-TestBGPaasZone-33847598-60226986 ID is fb91f83e-911b-42c1-b4a4-650bc44bcef2
2026-04-02 04:10:09,074 - DEBUG - VM ctest-TestBGPaasZone-33847598-60226986 launched on Node an-jenkins-deploy-platform-ansible-os-5575-1
2026-04-02 04:10:09,173 - DEBUG - Requesting: http://10.0.0.48:8082/virtual-machine/fb91f83e-911b-42c1-b4a4-650bc44bcef2
2026-04-02 04:10:09,186 - DEBUG - Requesting: http://10.0.0.48:8082/virtual-machine-interface/5bca717d-6842-46d2-bcf2-d40ffb1e6f9a
2026-04-02 04:10:10,371 - 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=12.6 ms\r\n64 bytes from 169.254.0.6: icmp_seq=2 ttl=63 time=3.73 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 = 3.729/8.157/12.586/4.428 ms')
2026-04-02 04:10:10,371 - INFO - Ping to Metadata IP 169.254.0.6 of VM ctest-TestBGPaasZone-33847598-60226986 passed
2026-04-02 04:10:10,452 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-02 04:10:10,452 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-33847598-60226986, IP 106.77.201.5, Port 22
2026-04-02 04:10:10,628 - DEBUG - VM ctest-TestBGPaasZone-33847598-60226986 is ready for SSH connections
2026-04-02 04:10:10,777 - INFO - Created control node zone ctest-test-zone-18804254(a8994755-74c3-4f34-8613-1147e5778cf5)
2026-04-02 04:10:11,133 - INFO - Created control node zone ctest-test-zone-89944042(cec72c56-b684-415d-b5c2-36cd14c1effd)
2026-04-02 04:10:11,489 - INFO - Created control node zone ctest-test-zone-59132230(96f3adf8-b8b3-4479-b08e-406db7ce9cce)
2026-04-02 04:10:11,781 - INFO - Creating BGPaaS ctest-TestBGPaasZone-33847598-72374928
2026-04-02 04:10:11,865 - INFO - BGPaaS: ctest-TestBGPaasZone-33847598-72374928(1d34bf54-e4d0-48fc-bdcb-72e8e5ee1e6f)
2026-04-02 04:10:11,865 - DEBUG - Requesting: http://10.0.0.73:8082/bgp-as-a-service/1d34bf54-e4d0-48fc-bdcb-72e8e5ee1e6f
2026-04-02 04:10:11,876 - INFO - verify_in_api_server passed for BGPaaS obj 1d34bf54-e4d0-48fc-bdcb-72e8e5ee1e6f
2026-04-02 04:10:11,876 - INFO - BGPaaS(1d34bf54-e4d0-48fc-bdcb-72e8e5ee1e6f): verify_on_setup passed
2026-04-02 04:10:11,876 - INFO - We will configure BGP on the VM
2026-04-02 04:10:12,325 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-02 04:10:12,325 - INFO - Configuring BGP on ctest-TestBGPaasZone-33847598-05709137
2026-04-02 04:10:12,325 - 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 106.77.201.3;
protocol bgp bgp_1{
local as 65000;
neighbor 106.77.201.1 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 106.77.201.3;
}
protocol bfd {
neighbor 106.77.201.1 local 106.77.201.3 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.5, password: ubuntugateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2026-04-02 04:10:12,325 - 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 106.77.201.3;
protocol bgp bgp_1{
local as 65000;
neighbor 106.77.201.1 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 106.77.201.3;
}
protocol bfd {
neighbor 106.77.201.1 local 106.77.201.3 multihop on;
}
EOS
2026-04-02 04:10:33,208 - DEBUG - None
2026-04-02 04:10:33,209 - DEBUG - Running remote_cmd, Cmd : cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 106.77.201.2 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 106.77.201.3;
}
EOS
, host_string: ubuntu@169.254.0.5, password: ubuntugateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2026-04-02 04:10:33,209 - DEBUG - cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 106.77.201.2 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 106.77.201.3;
}
EOS
2026-04-02 04:10:34,446 - DEBUG - None
2026-04-02 04:10:34,446 - DEBUG - Running remote_cmd, Cmd : service bird restart, host_string: ubuntu@169.254.0.5, password: ubuntugateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2026-04-02 04:10:34,446 - DEBUG - service bird restart
2026-04-02 04:10:38,629 - DEBUG - bird stop/waiting
bird start/running, process 1423
2026-04-02 04:10:38,630 - INFO - Attaching VMI ba70f2ae-7bfa-46ea-8b82-8ad63a97adc8 to BGPaaS 1d34bf54-e4d0-48fc-bdcb-72e8e5ee1e6f
2026-04-02 04:10:38,710 - INFO - Attaching the VMI 0c71184e-d852-42b2-a3ab-abde2d8f1dab to the BGPaaS 1d34bf54-e4d0-48fc-bdcb-72e8e5ee1e6f object
2026-04-02 04:10:38,710 - DEBUG - Running remote_cmd, Cmd : sudo ip addr add 106.77.201.20 dev eth0, host_string: ubuntu@169.254.0.5, password: ubuntugateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2026-04-02 04:10:38,710 - DEBUG - sudo ip addr add 106.77.201.20 dev eth0
2026-04-02 04:10:40,603 - DEBUG - None
2026-04-02 04:10:40,665 - INFO - Creating BGPaaS ctest-TestBGPaasZone-33847598-95484373
2026-04-02 04:10:40,745 - INFO - BGPaaS: ctest-TestBGPaasZone-33847598-95484373(0c7c9b4c-198e-405a-bb4c-912672127e04)
2026-04-02 04:10:40,745 - DEBUG - Requesting: http://10.0.0.73:8082/bgp-as-a-service/0c7c9b4c-198e-405a-bb4c-912672127e04
2026-04-02 04:10:40,755 - INFO - verify_in_api_server passed for BGPaaS obj 0c7c9b4c-198e-405a-bb4c-912672127e04
2026-04-02 04:10:40,755 - INFO - BGPaaS(0c7c9b4c-198e-405a-bb4c-912672127e04): verify_on_setup passed
2026-04-02 04:10:40,755 - INFO - We will configure BGP on the VM
2026-04-02 04:10:41,173 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-02 04:10:41,173 - INFO - Configuring BGP on ctest-TestBGPaasZone-33847598-37254038
2026-04-02 04:10:41,173 - 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 106.77.201.4;
protocol bgp bgp_1{
local as 65000;
neighbor 106.77.201.1 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 106.77.201.4;
}
protocol bfd {
neighbor 106.77.201.1 local 106.77.201.4 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.5, password: ubuntugateway: ubuntu@10.0.0.128, gateway password: c0ntrail123
2026-04-02 04:10:41,174 - 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 106.77.201.4;
protocol bgp bgp_1{
local as 65000;
neighbor 106.77.201.1 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 106.77.201.4;
}
protocol bfd {
neighbor 106.77.201.1 local 106.77.201.4 multihop on;
}
EOS
2026-04-02 04:10:46,617 - DEBUG - None
2026-04-02 04:10:46,617 - DEBUG - Running remote_cmd, Cmd : cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 106.77.201.2 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 106.77.201.4;
}
EOS
, host_string: ubuntu@169.254.0.5, password: ubuntugateway: ubuntu@10.0.0.128, gateway password: c0ntrail123
2026-04-02 04:10:46,617 - DEBUG - cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 106.77.201.2 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 106.77.201.4;
}
EOS
2026-04-02 04:10:47,137 - DEBUG - None
2026-04-02 04:10:47,138 - DEBUG - Running remote_cmd, Cmd : service bird restart, host_string: ubuntu@169.254.0.5, password: ubuntugateway: ubuntu@10.0.0.128, gateway password: c0ntrail123
2026-04-02 04:10:47,138 - DEBUG - service bird restart
2026-04-02 04:10:48,829 - DEBUG - bird stop/waiting
bird start/running, process 1434
2026-04-02 04:10:48,830 - INFO - Attaching VMI 8c05c2bf-237e-480b-9d89-9e3a16f9faf6 to BGPaaS 0c7c9b4c-198e-405a-bb4c-912672127e04
2026-04-02 04:10:48,911 - INFO - Attaching the VMI 1fe58c30-7b96-4095-9277-9d643ce6e8dc to the BGPaaS 0c7c9b4c-198e-405a-bb4c-912672127e04 object
2026-04-02 04:10:48,913 - DEBUG - Running remote_cmd, Cmd : sudo ip addr add 106.77.201.20 dev eth0, host_string: ubuntu@169.254.0.5, password: ubuntugateway: ubuntu@10.0.0.128, gateway password: c0ntrail123
2026-04-02 04:10:48,913 - DEBUG - sudo ip addr add 106.77.201.20 dev eth0
2026-04-02 04:10:49,554 - DEBUG - None
2026-04-02 04:10:49,554 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-02 04:10:49,567 - INFO - BGPaaS session seen in control-node 10.20.0.254
2026-04-02 04:10:49,570 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-02 04:10:49,570 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_BgpNeighborReq?domain=&ip_address=
2026-04-02 04:10:49,583 - INFO - BGPaaS session seen in control-node 10.20.0.18
2026-04-02 04:10:49,591 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-02 04:10:49,614 - ERROR - Not enough BGPaaS sessions seen in control-nodes ['10.20.0.254']
2026-04-02 04:10:55,629 - ERROR - Not enough BGPaaS sessions seen in control-nodes ['10.20.0.254']
2026-04-02 04:11:01,646 - INFO - BGPaaS session seen in control-node 10.20.0.254
2026-04-02 04:11:01,646 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-02 04:11:01,646 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_BgpNeighborReq?domain=&ip_address=
2026-04-02 04:11:01,660 - INFO - BGPaaS session seen in control-node 10.20.0.18
2026-04-02 04:11:01,666 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 106.77.201.20, host_string: ubuntu@169.254.0.6, password: ubuntugateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2026-04-02 04:11:01,666 - DEBUG - ping -s 56 -c 3 -W 1 106.77.201.20
2026-04-02 04:11:09,543 - DEBUG - PING 106.77.201.20 (106.77.201.20) 56(84) bytes of data.
64 bytes from 106.77.201.20: icmp_seq=1 ttl=64 time=13.3 ms
64 bytes from 106.77.201.20: icmp_seq=2 ttl=64 time=1.09 ms
64 bytes from 106.77.201.20: icmp_seq=3 ttl=64 time=1.19 ms
--- 106.77.201.20 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2004ms
rtt min/avg/max/mdev = 1.095/5.216/13.356/5.756 ms
2026-04-02 04:11:09,544 - INFO - Ping to IP 106.77.201.20 from VM ctest-TestBGPaasZone-33847598-60226986 passed
2026-04-02 04:11:09,544 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-02 04:11:09,558 - INFO - BGPaaS session seen in control-node 10.20.0.254
2026-04-02 04:11:09,559 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-02 04:11:09,559 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_BgpNeighborReq?domain=&ip_address=
2026-04-02 04:11:09,572 - INFO - BGPaaS session seen in control-node 10.20.0.18
2026-04-02 04:11:09,577 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-02 04:11:09,591 - INFO - BGPaaS session seen in control-node 10.20.0.254
2026-04-02 04:11:09,592 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-02 04:11:09,592 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_BgpNeighborReq?domain=&ip_address=
2026-04-02 04:11:09,605 - INFO - BGPaaS session seen in control-node 10.20.0.18
2026-04-02 04:11:09,612 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 106.77.201.20, host_string: ubuntu@169.254.0.6, password: ubuntugateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2026-04-02 04:11:09,612 - DEBUG - ping -s 56 -c 3 -W 1 106.77.201.20
2026-04-02 04:11:12,213 - DEBUG - PING 106.77.201.20 (106.77.201.20) 56(84) bytes of data.
64 bytes from 106.77.201.20: icmp_seq=1 ttl=64 time=6.30 ms
64 bytes from 106.77.201.20: icmp_seq=2 ttl=64 time=1.28 ms
64 bytes from 106.77.201.20: icmp_seq=3 ttl=64 time=1.51 ms
--- 106.77.201.20 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2004ms
rtt min/avg/max/mdev = 1.289/3.037/6.304/2.312 ms
2026-04-02 04:11:12,213 - INFO - Ping to IP 106.77.201.20 from VM ctest-TestBGPaasZone-33847598-60226986 passed
2026-04-02 04:11:12,213 - INFO - Detaching VMI 8c05c2bf-237e-480b-9d89-9e3a16f9faf6 from BGPaaS 0c7c9b4c-198e-405a-bb4c-912672127e04
2026-04-02 04:11:12,301 - INFO - Deleting BGPaaS ctest-TestBGPaasZone-33847598-95484373(0c7c9b4c-198e-405a-bb4c-912672127e04)
2026-04-02 04:11:12,368 - DEBUG - Requesting: http://10.0.0.73:8082/bgp-as-a-service/0c7c9b4c-198e-405a-bb4c-912672127e04
2026-04-02 04:11:12,399 - DEBUG - Response Code: 404
2026-04-02 04:11:12,399 - DEBUG - BGPaaS: 0c7c9b4c-198e-405a-bb4c-912672127e04 deleted from api server
2026-04-02 04:11:12,399 - INFO - BGPaaS(0c7c9b4c-198e-405a-bb4c-912672127e04): verify_on_cleanup passed
2026-04-02 04:11:12,399 - INFO - Detaching VMI ba70f2ae-7bfa-46ea-8b82-8ad63a97adc8 from BGPaaS 1d34bf54-e4d0-48fc-bdcb-72e8e5ee1e6f
2026-04-02 04:11:12,505 - INFO - Deleting BGPaaS ctest-TestBGPaasZone-33847598-72374928(1d34bf54-e4d0-48fc-bdcb-72e8e5ee1e6f)
2026-04-02 04:11:12,569 - DEBUG - Requesting: http://10.0.0.73:8082/bgp-as-a-service/1d34bf54-e4d0-48fc-bdcb-72e8e5ee1e6f
2026-04-02 04:11:12,576 - DEBUG - Response Code: 404
2026-04-02 04:11:12,576 - DEBUG - BGPaaS: 1d34bf54-e4d0-48fc-bdcb-72e8e5ee1e6f deleted from api server
2026-04-02 04:11:12,576 - INFO - BGPaaS(1d34bf54-e4d0-48fc-bdcb-72e8e5ee1e6f): verify_on_cleanup passed
2026-04-02 04:11:12,576 - INFO - Deleting Control node zone ctest-test-zone-59132230(96f3adf8-b8b3-4479-b08e-406db7ce9cce)
2026-04-02 04:11:12,734 - INFO - Deleting Control node zone ctest-test-zone-89944042(cec72c56-b684-415d-b5c2-36cd14c1effd)
2026-04-02 04:11:12,937 - INFO - Deleting Control node zone ctest-test-zone-18804254(a8994755-74c3-4f34-8613-1147e5778cf5)
2026-04-02 04:11:13,120 - INFO - Deleting VM ctest-TestBGPaasZone-33847598-60226986
2026-04-02 04:11:13,217 - INFO - Deleting VM ctest-TestBGPaasZone-33847598-37254038
2026-04-02 04:11:13,306 - INFO - Deleting VM ctest-TestBGPaasZone-33847598-05709137
2026-04-02 04:11:13,371 - INFO - Deleting VN ctest-cnz_vn-12583132
2026-04-02 04:11:13,426 - DEBUG - VN 248d53ff-bdcb-4169-94b5-69bbc9755f7b still in use: Unable to complete operation on network 248d53ff-bdcb-4169-94b5-69bbc9755f7b. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-46d5f56c-1796-4c5a-8463-8f503ff09a9d']
2026-04-02 04:11:13,426 - WARNING - Deleting VN ctest-cnz_vn-12583132 failed..Will retry
2026-04-02 04:11:15,670 - DEBUG - Response for deleting network ()
2026-04-02 04:11:16,945 - DEBUG - Skipping xmpp flap check
2026-04-02 04:11:16,945 - INFO - END TEST : test_bgp_control_node_zones_from_single_vnf : PASSED[0:03:58]
2026-04-02 04:11:16,945 - INFO - --------------------------------------------------------------------------------
2026-04-02 04:11:17,713 - INFO - Deleted project: ctest-TestBGPaasZone-33847598, ID : 1d2390a0-2d4f-4c60-ba7e-76761f0dec6c