is in ACTIVE state now
2025-12-04 04:21:26,669 - INFO - VM name : ctest-TestBGPaasZone-71545073-39505419
2025-12-04 04:21:26,761 - DEBUG - VM ctest-TestBGPaasZone-71545073-39505419 ID is 3233d3a7-e080-43cd-8ce4-44774dbcda62
2025-12-04 04:21:26,762 - DEBUG - VM ctest-TestBGPaasZone-71545073-39505419 launched on Node an-jenkins-deploy-platform-ansible-os-4840-2
2025-12-04 04:21:26,851 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/3233d3a7-e080-43cd-8ce4-44774dbcda62
2025-12-04 04:21:26,861 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/8e70c0f0-f233-404c-aaf6-8812737cd216
2025-12-04 04:21:28,038 - 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=4.33 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=1.17 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.168/2.749/4.330/1.581 ms')
2025-12-04 04:21:28,038 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBGPaasZone-71545073-39505419 passed
2025-12-04 04:21:28,110 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-04 04:21:28,110 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-71545073-39505419, IP 174.33.42.69, Port 22
2025-12-04 04:21:28,295 - DEBUG - VM ctest-TestBGPaasZone-71545073-39505419 is ready for SSH connections
2025-12-04 04:21:28,433 - INFO - Created control node zone ctest-test-zone-12360526(6b5c942b-8cab-47a7-8de4-514c0fa38118)
2025-12-04 04:21:28,802 - INFO - Created control node zone ctest-test-zone-29699927(cae6e61e-60a2-46d8-bb11-5694826e074b)
2025-12-04 04:21:29,165 - INFO - Created control node zone ctest-test-zone-64046659(3c02469d-b668-461f-81d6-01df74570af1)
2025-12-04 04:21:29,449 - INFO - Creating BGPaaS ctest-TestBGPaasZone-71545073-68550403
2025-12-04 04:21:29,533 - INFO - BGPaaS: ctest-TestBGPaasZone-71545073-68550403(f344dc8a-569a-4946-90f4-005aadcf1b58)
2025-12-04 04:21:29,533 - DEBUG - Requesting: http://10.0.0.27:8082/bgp-as-a-service/f344dc8a-569a-4946-90f4-005aadcf1b58
2025-12-04 04:21:29,546 - INFO - verify_in_api_server passed for BGPaaS obj f344dc8a-569a-4946-90f4-005aadcf1b58
2025-12-04 04:21:29,546 - INFO - BGPaaS(f344dc8a-569a-4946-90f4-005aadcf1b58): verify_on_setup passed
2025-12-04 04:21:29,546 - INFO - We will configure BGP on the VM
2025-12-04 04:21:29,977 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-04 04:21:29,977 - INFO - Configuring BGP on ctest-TestBGPaasZone-71545073-05192889
2025-12-04 04:21:29,977 - 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 174.33.42.67;
protocol bgp bgp_1{
local as 65000;
neighbor 174.33.42.65 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 174.33.42.67;
}
protocol bfd {
neighbor 174.33.42.65 local 174.33.42.67 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.130, gateway password: c0ntrail123
2025-12-04 04:21:29,977 - 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 174.33.42.67;
protocol bgp bgp_1{
local as 65000;
neighbor 174.33.42.65 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 174.33.42.67;
}
protocol bfd {
neighbor 174.33.42.65 local 174.33.42.67 multihop on;
}
EOS
2025-12-04 04:21:50,188 - DEBUG - None
2025-12-04 04:21:50,188 - DEBUG - Running remote_cmd, Cmd : cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 174.33.42.66 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 174.33.42.67;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.130, gateway password: c0ntrail123
2025-12-04 04:21:50,188 - DEBUG - cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 174.33.42.66 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 174.33.42.67;
}
EOS
2025-12-04 04:21:50,769 - DEBUG - None
2025-12-04 04:21:50,769 - DEBUG - Running remote_cmd, Cmd : service bird restart, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.130, gateway password: c0ntrail123
2025-12-04 04:21:50,769 - DEBUG - service bird restart
2025-12-04 04:21:52,749 - DEBUG - bird stop/waiting
bird start/running, process 1435
2025-12-04 04:21:52,749 - INFO - Attaching VMI 14686f1e-806b-4ae8-afba-7723281d321f to BGPaaS f344dc8a-569a-4946-90f4-005aadcf1b58
2025-12-04 04:21:52,829 - INFO - Attaching the VMI b5156211-ddae-4c8d-b06e-45988d3b30a5 to the BGPaaS f344dc8a-569a-4946-90f4-005aadcf1b58 object
2025-12-04 04:21:52,829 - DEBUG - Running remote_cmd, Cmd : sudo ip addr add 174.33.42.84 dev eth0, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.130, gateway password: c0ntrail123
2025-12-04 04:21:52,829 - DEBUG - sudo ip addr add 174.33.42.84 dev eth0
2025-12-04 04:21:53,574 - DEBUG - None
2025-12-04 04:21:53,641 - INFO - Creating BGPaaS ctest-TestBGPaasZone-71545073-25904271
2025-12-04 04:21:53,721 - INFO - BGPaaS: ctest-TestBGPaasZone-71545073-25904271(6908110c-c024-401e-9e28-1840d7611582)
2025-12-04 04:21:53,721 - DEBUG - Requesting: http://10.0.0.27:8082/bgp-as-a-service/6908110c-c024-401e-9e28-1840d7611582
2025-12-04 04:21:53,737 - INFO - verify_in_api_server passed for BGPaaS obj 6908110c-c024-401e-9e28-1840d7611582
2025-12-04 04:21:53,737 - INFO - BGPaaS(6908110c-c024-401e-9e28-1840d7611582): verify_on_setup passed
2025-12-04 04:21:53,737 - INFO - We will configure BGP on the VM
2025-12-04 04:21:54,189 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-04 04:21:54,189 - INFO - Configuring BGP on ctest-TestBGPaasZone-71545073-82307021
2025-12-04 04:21:54,189 - 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 174.33.42.68;
protocol bgp bgp_1{
local as 65000;
neighbor 174.33.42.65 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 174.33.42.68;
}
protocol bfd {
neighbor 174.33.42.65 local 174.33.42.68 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.22, gateway password: c0ntrail123
2025-12-04 04:21:54,190 - 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 174.33.42.68;
protocol bgp bgp_1{
local as 65000;
neighbor 174.33.42.65 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 174.33.42.68;
}
protocol bfd {
neighbor 174.33.42.65 local 174.33.42.68 multihop on;
}
EOS
2025-12-04 04:22:10,130 - DEBUG - None
2025-12-04 04:22:10,131 - DEBUG - Running remote_cmd, Cmd : cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 174.33.42.66 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 174.33.42.68;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.22, gateway password: c0ntrail123
2025-12-04 04:22:10,131 - DEBUG - cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 174.33.42.66 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 174.33.42.68;
}
EOS
2025-12-04 04:22:10,689 - DEBUG - None
2025-12-04 04:22:10,689 - DEBUG - Running remote_cmd, Cmd : service bird restart, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.22, gateway password: c0ntrail123
2025-12-04 04:22:10,689 - DEBUG - service bird restart
2025-12-04 04:22:12,605 - DEBUG - bird stop/waiting
bird start/running, process 1441
2025-12-04 04:22:12,605 - INFO - Attaching VMI c32339de-9ea2-4923-ae97-b1134d9723f4 to BGPaaS 6908110c-c024-401e-9e28-1840d7611582
2025-12-04 04:22:12,685 - INFO - Attaching the VMI 875cef7f-7d52-451e-a53c-9327483b642d to the BGPaaS 6908110c-c024-401e-9e28-1840d7611582 object
2025-12-04 04:22:12,685 - DEBUG - Running remote_cmd, Cmd : sudo ip addr add 174.33.42.84 dev eth0, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.22, gateway password: c0ntrail123
2025-12-04 04:22:12,685 - DEBUG - sudo ip addr add 174.33.42.84 dev eth0
2025-12-04 04:22:13,463 - DEBUG - None
2025-12-04 04:22:13,464 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-04 04:22:13,464 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-04 04:22:13,479 - INFO - BGPaaS session seen in control-node 10.20.0.254
2025-12-04 04:22:13,479 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-04 04:22:13,500 - INFO - BGPaaS session seen in control-node 10.20.0.209
2025-12-04 04:22:13,507 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-04 04:22:13,507 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-04 04:22:13,521 - ERROR - Not enough BGPaaS sessions seen in control-nodes ['10.20.0.254']
2025-12-04 04:22:19,522 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-04 04:22:19,537 - ERROR - Not enough BGPaaS sessions seen in control-nodes ['10.20.0.254']
2025-12-04 04:22:25,538 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-04 04:22:25,552 - INFO - BGPaaS session seen in control-node 10.20.0.254
2025-12-04 04:22:25,552 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-04 04:22:25,570 - INFO - BGPaaS session seen in control-node 10.20.0.209
2025-12-04 04:22:25,576 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 174.33.42.84, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.130, gateway password: c0ntrail123
2025-12-04 04:22:25,577 - DEBUG - ping -s 56 -c 3 -W 1 174.33.42.84
2025-12-04 04:22:37,489 - DEBUG - PING 174.33.42.84 (174.33.42.84) 56(84) bytes of data.
64 bytes from 174.33.42.84: icmp_seq=1 ttl=64 time=9.71 ms
64 bytes from 174.33.42.84: icmp_seq=2 ttl=64 time=1.34 ms
64 bytes from 174.33.42.84: icmp_seq=3 ttl=64 time=1.59 ms
--- 174.33.42.84 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2004ms
rtt min/avg/max/mdev = 1.341/4.217/9.712/3.887 ms
2025-12-04 04:22:37,489 - INFO - Ping to IP 174.33.42.84 from VM ctest-TestBGPaasZone-71545073-39505419 passed
2025-12-04 04:22:37,489 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-04 04:22:37,490 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-04 04:22:37,503 - INFO - BGPaaS session seen in control-node 10.20.0.254
2025-12-04 04:22:37,504 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-04 04:22:37,521 - INFO - BGPaaS session seen in control-node 10.20.0.209
2025-12-04 04:22:37,527 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-04 04:22:37,527 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-04 04:22:37,539 - INFO - BGPaaS session seen in control-node 10.20.0.254
2025-12-04 04:22:37,540 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-04 04:22:37,555 - INFO - BGPaaS session seen in control-node 10.20.0.209
2025-12-04 04:22:37,562 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 174.33.42.84, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.130, gateway password: c0ntrail123
2025-12-04 04:22:37,562 - DEBUG - ping -s 56 -c 3 -W 1 174.33.42.84
2025-12-04 04:22:40,115 - DEBUG - PING 174.33.42.84 (174.33.42.84) 56(84) bytes of data.
64 bytes from 174.33.42.84: icmp_seq=1 ttl=64 time=7.36 ms
64 bytes from 174.33.42.84: icmp_seq=2 ttl=64 time=1.53 ms
64 bytes from 174.33.42.84: icmp_seq=3 ttl=64 time=1.74 ms
--- 174.33.42.84 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2004ms
rtt min/avg/max/mdev = 1.534/3.547/7.366/2.701 ms
2025-12-04 04:22:40,115 - INFO - Ping to IP 174.33.42.84 from VM ctest-TestBGPaasZone-71545073-39505419 passed
2025-12-04 04:22:40,116 - INFO - Detaching VMI c32339de-9ea2-4923-ae97-b1134d9723f4 from BGPaaS 6908110c-c024-401e-9e28-1840d7611582
2025-12-04 04:22:40,197 - INFO - Deleting BGPaaS ctest-TestBGPaasZone-71545073-25904271(6908110c-c024-401e-9e28-1840d7611582)
2025-12-04 04:22:40,253 - DEBUG - Requesting: http://10.0.0.27:8082/bgp-as-a-service/6908110c-c024-401e-9e28-1840d7611582
2025-12-04 04:22:40,294 - DEBUG - Response Code: 404
2025-12-04 04:22:40,294 - DEBUG - BGPaaS: 6908110c-c024-401e-9e28-1840d7611582 deleted from api server
2025-12-04 04:22:40,294 - INFO - BGPaaS(6908110c-c024-401e-9e28-1840d7611582): verify_on_cleanup passed
2025-12-04 04:22:40,294 - INFO - Detaching VMI 14686f1e-806b-4ae8-afba-7723281d321f from BGPaaS f344dc8a-569a-4946-90f4-005aadcf1b58
2025-12-04 04:22:40,373 - INFO - Deleting BGPaaS ctest-TestBGPaasZone-71545073-68550403(f344dc8a-569a-4946-90f4-005aadcf1b58)
2025-12-04 04:22:40,444 - DEBUG - Requesting: http://10.0.0.27:8082/bgp-as-a-service/f344dc8a-569a-4946-90f4-005aadcf1b58
2025-12-04 04:22:40,451 - DEBUG - Response Code: 404
2025-12-04 04:22:40,452 - DEBUG - BGPaaS: f344dc8a-569a-4946-90f4-005aadcf1b58 deleted from api server
2025-12-04 04:22:40,452 - INFO - BGPaaS(f344dc8a-569a-4946-90f4-005aadcf1b58): verify_on_cleanup passed
2025-12-04 04:22:40,452 - INFO - Deleting Control node zone ctest-test-zone-64046659(3c02469d-b668-461f-81d6-01df74570af1)
2025-12-04 04:22:40,609 - INFO - Deleting Control node zone ctest-test-zone-29699927(cae6e61e-60a2-46d8-bb11-5694826e074b)
2025-12-04 04:22:40,773 - INFO - Deleting Control node zone ctest-test-zone-12360526(6b5c942b-8cab-47a7-8de4-514c0fa38118)
2025-12-04 04:22:40,982 - INFO - Deleting VM ctest-TestBGPaasZone-71545073-39505419
2025-12-04 04:22:41,104 - INFO - Deleting VM ctest-TestBGPaasZone-71545073-82307021
2025-12-04 04:22:41,186 - INFO - Deleting VM ctest-TestBGPaasZone-71545073-05192889
2025-12-04 04:22:41,274 - INFO - Deleting VN ctest-cnz_vn-29600866
2025-12-04 04:22:41,324 - DEBUG - VN e9dbbf1f-bd9f-4a92-ab7b-5d39dba74ce0 still in use: Unable to complete operation on network e9dbbf1f-bd9f-4a92-ab7b-5d39dba74ce0. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-9dddf5bf-cea9-4092-bcfb-60776996dc00']
2025-12-04 04:22:41,324 - WARNING - Deleting VN ctest-cnz_vn-29600866 failed..Will retry
2025-12-04 04:22:43,589 - DEBUG - Response for deleting network ()
2025-12-04 04:22:44,871 - DEBUG - Skipping xmpp flap check
2025-12-04 04:22:44,871 - INFO - END TEST : test_bgp_control_node_zones_from_single_vnf : PASSED[0:03:51]
2025-12-04 04:22:44,871 - INFO - --------------------------------------------------------------------------------
2025-12-04 04:22:45,651 - INFO - Deleted project: ctest-TestBGPaasZone-71545073, ID : 3e6601da-ed4f-4cbe-8ace-4d9b1f84a6b4