is in ACTIVE state now
2025-11-10 03:46:51,808 - INFO - VM name : ctest-TestBGPaasZone-46888661-25472087
2025-11-10 03:46:51,902 - DEBUG - VM ctest-TestBGPaasZone-46888661-25472087 ID is 6b991494-27ad-4db8-a886-6b8ab94d54bb
2025-11-10 03:46:51,902 - DEBUG - VM ctest-TestBGPaasZone-46888661-25472087 launched on Node an-jenkins-deploy-platform-ansible-os-4674-2
2025-11-10 03:46:52,000 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/6b991494-27ad-4db8-a886-6b8ab94d54bb
2025-11-10 03:46:52,012 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/7e0215f9-32d7-405a-a224-e1b6dcd2c508
2025-11-10 03:46:53,185 - 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.32 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=2.49 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 = 2.487/2.905/3.324/0.418 ms')
2025-11-10 03:46:53,185 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBGPaasZone-46888661-25472087 passed
2025-11-10 03:46:53,259 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-10 03:46:53,259 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-46888661-25472087, IP 189.157.242.133, Port 22
2025-11-10 03:46:53,434 - DEBUG - VM ctest-TestBGPaasZone-46888661-25472087 is ready for SSH connections
2025-11-10 03:46:53,577 - INFO - Created control node zone ctest-test-zone-85291866(02e01bb1-5183-4a53-8291-894439a6513a)
2025-11-10 03:46:53,937 - INFO - Created control node zone ctest-test-zone-12540227(412f1bae-78e9-4ead-aa5f-fd7a7b44b6e9)
2025-11-10 03:46:54,316 - INFO - Created control node zone ctest-test-zone-21803006(6e68a476-9553-40eb-81db-f3aac31f8355)
2025-11-10 03:46:54,624 - INFO - Creating BGPaaS ctest-TestBGPaasZone-46888661-61788788
2025-11-10 03:46:54,705 - INFO - BGPaaS: ctest-TestBGPaasZone-46888661-61788788(9566e8cb-6e19-4e91-9543-fb5fdc12583b)
2025-11-10 03:46:54,705 - DEBUG - Requesting: http://10.0.0.22:8082/bgp-as-a-service/9566e8cb-6e19-4e91-9543-fb5fdc12583b
2025-11-10 03:46:54,721 - INFO - verify_in_api_server passed for BGPaaS obj 9566e8cb-6e19-4e91-9543-fb5fdc12583b
2025-11-10 03:46:54,721 - INFO - BGPaaS(9566e8cb-6e19-4e91-9543-fb5fdc12583b): verify_on_setup passed
2025-11-10 03:46:54,721 - INFO - We will configure BGP on the VM
2025-11-10 03:46:55,184 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-10 03:46:55,185 - INFO - Configuring BGP on ctest-TestBGPaasZone-46888661-99096104
2025-11-10 03:46:55,185 - 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 189.157.242.131;
protocol bgp bgp_1{
local as 65000;
neighbor 189.157.242.129 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 189.157.242.131;
}
protocol bfd {
neighbor 189.157.242.129 local 189.157.242.131 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.130, gateway password: c0ntrail123
2025-11-10 03:46:55,185 - 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 189.157.242.131;
protocol bgp bgp_1{
local as 65000;
neighbor 189.157.242.129 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 189.157.242.131;
}
protocol bfd {
neighbor 189.157.242.129 local 189.157.242.131 multihop on;
}
EOS
2025-11-10 03:47:09,772 - DEBUG - None
2025-11-10 03:47:09,772 - DEBUG - Running remote_cmd, Cmd : cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 189.157.242.130 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 189.157.242.131;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.130, gateway password: c0ntrail123
2025-11-10 03:47:09,772 - DEBUG - cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 189.157.242.130 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 189.157.242.131;
}
EOS
2025-11-10 03:47:10,798 - DEBUG - None
2025-11-10 03:47:10,798 - 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-11-10 03:47:10,798 - DEBUG - service bird restart
2025-11-10 03:47:13,263 - DEBUG - bird stop/waiting
bird start/running, process 1440
2025-11-10 03:47:13,263 - INFO - Attaching VMI 6391100e-6ffd-48fa-8b99-fbe064342abe to BGPaaS 9566e8cb-6e19-4e91-9543-fb5fdc12583b
2025-11-10 03:47:13,340 - INFO - Attaching the VMI 620f1156-8fcd-48f6-bb51-089ff2961bdb to the BGPaaS 9566e8cb-6e19-4e91-9543-fb5fdc12583b object
2025-11-10 03:47:13,341 - DEBUG - Running remote_cmd, Cmd : sudo ip addr add 189.157.242.148 dev eth0, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.130, gateway password: c0ntrail123
2025-11-10 03:47:13,341 - DEBUG - sudo ip addr add 189.157.242.148 dev eth0
2025-11-10 03:47:14,062 - DEBUG - None
2025-11-10 03:47:14,128 - INFO - Creating BGPaaS ctest-TestBGPaasZone-46888661-98012016
2025-11-10 03:47:14,212 - INFO - BGPaaS: ctest-TestBGPaasZone-46888661-98012016(9d2275eb-310f-479e-9cc2-05f50db49571)
2025-11-10 03:47:14,213 - DEBUG - Requesting: http://10.0.0.22:8082/bgp-as-a-service/9d2275eb-310f-479e-9cc2-05f50db49571
2025-11-10 03:47:14,224 - INFO - verify_in_api_server passed for BGPaaS obj 9d2275eb-310f-479e-9cc2-05f50db49571
2025-11-10 03:47:14,225 - INFO - BGPaaS(9d2275eb-310f-479e-9cc2-05f50db49571): verify_on_setup passed
2025-11-10 03:47:14,226 - INFO - We will configure BGP on the VM
2025-11-10 03:47:14,677 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-10 03:47:14,677 - INFO - Configuring BGP on ctest-TestBGPaasZone-46888661-32939699
2025-11-10 03:47:14,677 - 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 189.157.242.132;
protocol bgp bgp_1{
local as 65000;
neighbor 189.157.242.129 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 189.157.242.132;
}
protocol bfd {
neighbor 189.157.242.129 local 189.157.242.132 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.65, gateway password: c0ntrail123
2025-11-10 03:47:14,677 - 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 189.157.242.132;
protocol bgp bgp_1{
local as 65000;
neighbor 189.157.242.129 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 189.157.242.132;
}
protocol bfd {
neighbor 189.157.242.129 local 189.157.242.132 multihop on;
}
EOS
2025-11-10 03:47:21,117 - DEBUG - None
2025-11-10 03:47:21,117 - DEBUG - Running remote_cmd, Cmd : cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 189.157.242.130 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 189.157.242.132;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.65, gateway password: c0ntrail123
2025-11-10 03:47:21,117 - DEBUG - cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 189.157.242.130 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 189.157.242.132;
}
EOS
2025-11-10 03:47:21,608 - DEBUG - None
2025-11-10 03:47:21,608 - 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-11-10 03:47:21,608 - DEBUG - service bird restart
2025-11-10 03:47:23,297 - DEBUG - bird stop/waiting
bird start/running, process 1439
2025-11-10 03:47:23,297 - INFO - Attaching VMI 4e27a2d6-feea-4170-80e4-cfd4db21fcb0 to BGPaaS 9d2275eb-310f-479e-9cc2-05f50db49571
2025-11-10 03:47:23,376 - INFO - Attaching the VMI 1a0aa22e-01ff-440c-942d-f9e8eaab9284 to the BGPaaS 9d2275eb-310f-479e-9cc2-05f50db49571 object
2025-11-10 03:47:23,377 - DEBUG - Running remote_cmd, Cmd : sudo ip addr add 189.157.242.148 dev eth0, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.65, gateway password: c0ntrail123
2025-11-10 03:47:23,377 - DEBUG - sudo ip addr add 189.157.242.148 dev eth0
2025-11-10 03:47:23,998 - DEBUG - None
2025-11-10 03:47:23,998 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-10 03:47:24,014 - INFO - BGPaaS session seen in control-node 10.20.0.193
2025-11-10 03:47:24,015 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-10 03:47:24,015 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-11-10 03:47:24,032 - INFO - BGPaaS session seen in control-node 10.20.0.129
2025-11-10 03:47:24,038 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-10 03:47:24,061 - ERROR - Not enough BGPaaS sessions seen in control-nodes ['10.20.0.193']
2025-11-10 03:47:30,079 - ERROR - Not enough BGPaaS sessions seen in control-nodes ['10.20.0.193']
2025-11-10 03:47:36,097 - INFO - BGPaaS session seen in control-node 10.20.0.193
2025-11-10 03:47:36,097 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-10 03:47:36,097 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-11-10 03:47:36,118 - INFO - BGPaaS session seen in control-node 10.20.0.129
2025-11-10 03:47:36,125 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 189.157.242.148, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.130, gateway password: c0ntrail123
2025-11-10 03:47:36,125 - DEBUG - ping -s 56 -c 3 -W 1 189.157.242.148
2025-11-10 03:47:42,576 - DEBUG - PING 189.157.242.148 (189.157.242.148) 56(84) bytes of data.
64 bytes from 189.157.242.148: icmp_seq=1 ttl=64 time=8.23 ms
64 bytes from 189.157.242.148: icmp_seq=2 ttl=64 time=1.16 ms
64 bytes from 189.157.242.148: icmp_seq=3 ttl=64 time=0.954 ms
--- 189.157.242.148 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2005ms
rtt min/avg/max/mdev = 0.954/3.450/8.232/3.382 ms
2025-11-10 03:47:42,576 - INFO - Ping to IP 189.157.242.148 from VM ctest-TestBGPaasZone-46888661-25472087 passed
2025-11-10 03:47:42,576 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-10 03:47:42,603 - INFO - BGPaaS session seen in control-node 10.20.0.193
2025-11-10 03:47:42,603 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-10 03:47:42,603 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-11-10 03:47:42,622 - INFO - BGPaaS session seen in control-node 10.20.0.129
2025-11-10 03:47:42,628 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-10 03:47:42,646 - INFO - BGPaaS session seen in control-node 10.20.0.193
2025-11-10 03:47:42,647 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-10 03:47:42,647 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-11-10 03:47:42,664 - INFO - BGPaaS session seen in control-node 10.20.0.129
2025-11-10 03:47:42,671 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 189.157.242.148, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.130, gateway password: c0ntrail123
2025-11-10 03:47:42,671 - DEBUG - ping -s 56 -c 3 -W 1 189.157.242.148
2025-11-10 03:47:45,205 - DEBUG - PING 189.157.242.148 (189.157.242.148) 56(84) bytes of data.
64 bytes from 189.157.242.148: icmp_seq=1 ttl=64 time=1.90 ms
64 bytes from 189.157.242.148: icmp_seq=2 ttl=64 time=1.01 ms
64 bytes from 189.157.242.148: icmp_seq=3 ttl=64 time=1.23 ms
--- 189.157.242.148 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2004ms
rtt min/avg/max/mdev = 1.010/1.383/1.903/0.380 ms
2025-11-10 03:47:45,205 - INFO - Ping to IP 189.157.242.148 from VM ctest-TestBGPaasZone-46888661-25472087 passed
2025-11-10 03:47:45,205 - INFO - Detaching VMI 4e27a2d6-feea-4170-80e4-cfd4db21fcb0 from BGPaaS 9d2275eb-310f-479e-9cc2-05f50db49571
2025-11-10 03:47:45,365 - INFO - Deleting BGPaaS ctest-TestBGPaasZone-46888661-98012016(9d2275eb-310f-479e-9cc2-05f50db49571)
2025-11-10 03:47:45,460 - DEBUG - Requesting: http://10.0.0.22:8082/bgp-as-a-service/9d2275eb-310f-479e-9cc2-05f50db49571
2025-11-10 03:47:45,469 - DEBUG - Response Code: 404
2025-11-10 03:47:45,469 - DEBUG - BGPaaS: 9d2275eb-310f-479e-9cc2-05f50db49571 deleted from api server
2025-11-10 03:47:45,469 - INFO - BGPaaS(9d2275eb-310f-479e-9cc2-05f50db49571): verify_on_cleanup passed
2025-11-10 03:47:45,469 - INFO - Detaching VMI 6391100e-6ffd-48fa-8b99-fbe064342abe from BGPaaS 9566e8cb-6e19-4e91-9543-fb5fdc12583b
2025-11-10 03:47:45,568 - INFO - Deleting BGPaaS ctest-TestBGPaasZone-46888661-61788788(9566e8cb-6e19-4e91-9543-fb5fdc12583b)
2025-11-10 03:47:45,636 - DEBUG - Requesting: http://10.0.0.22:8082/bgp-as-a-service/9566e8cb-6e19-4e91-9543-fb5fdc12583b
2025-11-10 03:47:45,657 - DEBUG - Response Code: 404
2025-11-10 03:47:45,658 - DEBUG - BGPaaS: 9566e8cb-6e19-4e91-9543-fb5fdc12583b deleted from api server
2025-11-10 03:47:45,658 - INFO - BGPaaS(9566e8cb-6e19-4e91-9543-fb5fdc12583b): verify_on_cleanup passed
2025-11-10 03:47:45,659 - INFO - Deleting Control node zone ctest-test-zone-21803006(6e68a476-9553-40eb-81db-f3aac31f8355)
2025-11-10 03:47:45,808 - INFO - Deleting Control node zone ctest-test-zone-12540227(412f1bae-78e9-4ead-aa5f-fd7a7b44b6e9)
2025-11-10 03:47:45,956 - INFO - Deleting Control node zone ctest-test-zone-85291866(02e01bb1-5183-4a53-8291-894439a6513a)
2025-11-10 03:47:46,102 - INFO - Deleting VM ctest-TestBGPaasZone-46888661-25472087
2025-11-10 03:47:46,174 - INFO - Deleting VM ctest-TestBGPaasZone-46888661-32939699
2025-11-10 03:47:46,243 - INFO - Deleting VM ctest-TestBGPaasZone-46888661-99096104
2025-11-10 03:47:46,321 - INFO - Deleting VN ctest-cnz_vn-04048773
2025-11-10 03:47:46,362 - DEBUG - VN 2b4b710e-7a9d-4665-befb-cbcb59e0291c still in use: Unable to complete operation on network 2b4b710e-7a9d-4665-befb-cbcb59e0291c. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-e5799b05-f5bb-4cf1-9b09-e710f4870890']
2025-11-10 03:47:46,362 - WARNING - Deleting VN ctest-cnz_vn-04048773 failed..Will retry
2025-11-10 03:47:48,593 - DEBUG - Response for deleting network ()
2025-11-10 03:47:49,868 - DEBUG - Skipping xmpp flap check
2025-11-10 03:47:49,868 - INFO - END TEST : test_bgp_control_node_zones_from_single_vnf : PASSED[0:03:17]
2025-11-10 03:47:49,868 - INFO - --------------------------------------------------------------------------------
2025-11-10 03:47:50,619 - INFO - Deleted project: ctest-TestBGPaasZone-46888661, ID : 7304cc16-5459-4cc3-929b-b3818d42db06