is in ACTIVE state now
2025-12-01 04:03:26,035 - INFO - VM name : ctest-TestBGPaasZone-92773783-97720765
2025-12-01 04:03:26,130 - DEBUG - VM ctest-TestBGPaasZone-92773783-97720765 ID is 8b127a0b-3cab-49c0-aee0-677ca5d7558a
2025-12-01 04:03:26,130 - DEBUG - VM ctest-TestBGPaasZone-92773783-97720765 launched on Node an-jenkins-deploy-platform-ansible-os-4827-2
2025-12-01 04:03:26,228 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/8b127a0b-3cab-49c0-aee0-677ca5d7558a
2025-12-01 04:03:26,242 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/799f8585-c911-4e23-b57b-397c04a742cf
2025-12-01 04:03:27,427 - 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.85 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=1.57 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 1.569/2.708/3.848/1.139 ms')
2025-12-01 04:03:27,427 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBGPaasZone-92773783-97720765 passed
2025-12-01 04:03:27,499 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-01 04:03:27,500 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-92773783-97720765, IP 202.53.152.5, Port 22
2025-12-01 04:03:27,659 - DEBUG - VM ctest-TestBGPaasZone-92773783-97720765 is ready for SSH connections
2025-12-01 04:03:27,801 - INFO - Created control node zone ctest-test-zone-34798379(5a7f4666-5122-4491-9f07-aad7bab31510)
2025-12-01 04:03:28,169 - INFO - Created control node zone ctest-test-zone-97826767(7084e3dd-7c64-4592-8247-a6e65f264afe)
2025-12-01 04:03:28,534 - INFO - Created control node zone ctest-test-zone-84207018(2d8cd848-1662-4d3f-bd2f-f4b22ab2c449)
2025-12-01 04:03:28,833 - INFO - Creating BGPaaS ctest-TestBGPaasZone-92773783-44713127
2025-12-01 04:03:28,921 - INFO - BGPaaS: ctest-TestBGPaasZone-92773783-44713127(d086a33a-c489-44c5-bfe9-2b5bef8b86ce)
2025-12-01 04:03:28,922 - DEBUG - Requesting: http://10.0.0.27:8082/bgp-as-a-service/d086a33a-c489-44c5-bfe9-2b5bef8b86ce
2025-12-01 04:03:28,935 - INFO - verify_in_api_server passed for BGPaaS obj d086a33a-c489-44c5-bfe9-2b5bef8b86ce
2025-12-01 04:03:28,935 - INFO - BGPaaS(d086a33a-c489-44c5-bfe9-2b5bef8b86ce): verify_on_setup passed
2025-12-01 04:03:28,935 - INFO - We will configure BGP on the VM
2025-12-01 04:03:29,410 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-01 04:03:29,410 - INFO - Configuring BGP on ctest-TestBGPaasZone-92773783-97618660
2025-12-01 04:03:29,410 - 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 202.53.152.3;
protocol bgp bgp_1{
local as 65000;
neighbor 202.53.152.1 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 202.53.152.3;
}
protocol bfd {
neighbor 202.53.152.1 local 202.53.152.3 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.241, gateway password: c0ntrail123
2025-12-01 04:03:29,410 - 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 202.53.152.3;
protocol bgp bgp_1{
local as 65000;
neighbor 202.53.152.1 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 202.53.152.3;
}
protocol bfd {
neighbor 202.53.152.1 local 202.53.152.3 multihop on;
}
EOS
2025-12-01 04:03:44,975 - DEBUG - None
2025-12-01 04:03:44,975 - DEBUG - Running remote_cmd, Cmd : cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 202.53.152.2 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 202.53.152.3;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.241, gateway password: c0ntrail123
2025-12-01 04:03:44,976 - DEBUG - cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 202.53.152.2 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 202.53.152.3;
}
EOS
2025-12-01 04:03:46,080 - DEBUG - None
2025-12-01 04:03:46,080 - DEBUG - Running remote_cmd, Cmd : service bird restart, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.241, gateway password: c0ntrail123
2025-12-01 04:03:46,080 - DEBUG - service bird restart
2025-12-01 04:03:49,712 - DEBUG - bird stop/waiting
bird start/running, process 1439
2025-12-01 04:03:49,712 - INFO - Attaching VMI e5844ab1-24e5-4259-8c40-b623809afa32 to BGPaaS d086a33a-c489-44c5-bfe9-2b5bef8b86ce
2025-12-01 04:03:49,793 - INFO - Attaching the VMI 42d4b8f0-12d6-470b-848f-da3f00f807dc to the BGPaaS d086a33a-c489-44c5-bfe9-2b5bef8b86ce object
2025-12-01 04:03:49,794 - DEBUG - Running remote_cmd, Cmd : sudo ip addr add 202.53.152.20 dev eth0, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.241, gateway password: c0ntrail123
2025-12-01 04:03:49,794 - DEBUG - sudo ip addr add 202.53.152.20 dev eth0
2025-12-01 04:03:51,234 - DEBUG - None
2025-12-01 04:03:51,305 - INFO - Creating BGPaaS ctest-TestBGPaasZone-92773783-57789121
2025-12-01 04:03:51,394 - INFO - BGPaaS: ctest-TestBGPaasZone-92773783-57789121(7bf7fa7e-c857-4a85-8177-c7bc411a7fcd)
2025-12-01 04:03:51,394 - DEBUG - Requesting: http://10.0.0.27:8082/bgp-as-a-service/7bf7fa7e-c857-4a85-8177-c7bc411a7fcd
2025-12-01 04:03:51,409 - INFO - verify_in_api_server passed for BGPaaS obj 7bf7fa7e-c857-4a85-8177-c7bc411a7fcd
2025-12-01 04:03:51,409 - INFO - BGPaaS(7bf7fa7e-c857-4a85-8177-c7bc411a7fcd): verify_on_setup passed
2025-12-01 04:03:51,409 - INFO - We will configure BGP on the VM
2025-12-01 04:03:51,866 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-01 04:03:51,866 - INFO - Configuring BGP on ctest-TestBGPaasZone-92773783-77727819
2025-12-01 04:03:51,866 - 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 202.53.152.4;
protocol bgp bgp_1{
local as 65000;
neighbor 202.53.152.1 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 202.53.152.4;
}
protocol bfd {
neighbor 202.53.152.1 local 202.53.152.4 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.22, gateway password: c0ntrail123
2025-12-01 04:03:51,866 - 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 202.53.152.4;
protocol bgp bgp_1{
local as 65000;
neighbor 202.53.152.1 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 202.53.152.4;
}
protocol bfd {
neighbor 202.53.152.1 local 202.53.152.4 multihop on;
}
EOS
2025-12-01 04:03:57,667 - DEBUG - None
2025-12-01 04:03:57,667 - DEBUG - Running remote_cmd, Cmd : cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 202.53.152.2 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 202.53.152.4;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.22, gateway password: c0ntrail123
2025-12-01 04:03:57,667 - DEBUG - cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 202.53.152.2 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 202.53.152.4;
}
EOS
2025-12-01 04:03:58,249 - DEBUG - None
2025-12-01 04:03:58,249 - 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-01 04:03:58,249 - DEBUG - service bird restart
2025-12-01 04:03:59,973 - DEBUG - bird stop/waiting
bird start/running, process 1441
2025-12-01 04:03:59,973 - INFO - Attaching VMI dd06fa81-0ba8-4831-adce-a8d74e02dc2d to BGPaaS 7bf7fa7e-c857-4a85-8177-c7bc411a7fcd
2025-12-01 04:04:00,063 - INFO - Attaching the VMI af224982-e5b7-4485-bfb3-b8f97e140288 to the BGPaaS 7bf7fa7e-c857-4a85-8177-c7bc411a7fcd object
2025-12-01 04:04:00,063 - DEBUG - Running remote_cmd, Cmd : sudo ip addr add 202.53.152.20 dev eth0, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.22, gateway password: c0ntrail123
2025-12-01 04:04:00,066 - DEBUG - sudo ip addr add 202.53.152.20 dev eth0
2025-12-01 04:04:00,826 - DEBUG - None
2025-12-01 04:04:00,826 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-01 04:04:00,826 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-01 04:04:00,837 - INFO - BGPaaS session seen in control-node 10.20.0.193
2025-12-01 04:04:00,838 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-01 04:04:00,855 - INFO - BGPaaS session seen in control-node 10.20.0.209
2025-12-01 04:04:00,862 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-01 04:04:00,862 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-01 04:04:00,873 - ERROR - Not enough BGPaaS sessions seen in control-nodes ['10.20.0.193']
2025-12-01 04:04:06,873 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-01 04:04:06,893 - ERROR - Not enough BGPaaS sessions seen in control-nodes ['10.20.0.193']
2025-12-01 04:04:12,893 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-01 04:04:12,909 - INFO - BGPaaS session seen in control-node 10.20.0.193
2025-12-01 04:04:12,909 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-01 04:04:12,926 - INFO - BGPaaS session seen in control-node 10.20.0.209
2025-12-01 04:04:12,933 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 202.53.152.20, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.241, gateway password: c0ntrail123
2025-12-01 04:04:12,933 - DEBUG - ping -s 56 -c 3 -W 1 202.53.152.20
2025-12-01 04:04:19,610 - DEBUG - PING 202.53.152.20 (202.53.152.20) 56(84) bytes of data.
64 bytes from 202.53.152.20: icmp_seq=1 ttl=64 time=8.81 ms
64 bytes from 202.53.152.20: icmp_seq=2 ttl=64 time=1.14 ms
64 bytes from 202.53.152.20: icmp_seq=3 ttl=64 time=1.33 ms
--- 202.53.152.20 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2005ms
rtt min/avg/max/mdev = 1.148/3.766/8.817/3.572 ms
2025-12-01 04:04:19,610 - INFO - Ping to IP 202.53.152.20 from VM ctest-TestBGPaasZone-92773783-97720765 passed
2025-12-01 04:04:19,610 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-01 04:04:19,610 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-01 04:04:19,623 - INFO - BGPaaS session seen in control-node 10.20.0.193
2025-12-01 04:04:19,624 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-01 04:04:19,644 - INFO - BGPaaS session seen in control-node 10.20.0.209
2025-12-01 04:04:19,652 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-01 04:04:19,652 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_BgpNeighborReq?domain=&ip_address=
2025-12-01 04:04:19,669 - INFO - BGPaaS session seen in control-node 10.20.0.193
2025-12-01 04:04:19,669 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-01 04:04:19,689 - INFO - BGPaaS session seen in control-node 10.20.0.209
2025-12-01 04:04:19,695 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 202.53.152.20, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.241, gateway password: c0ntrail123
2025-12-01 04:04:19,696 - DEBUG - ping -s 56 -c 3 -W 1 202.53.152.20
2025-12-01 04:04:22,271 - DEBUG - PING 202.53.152.20 (202.53.152.20) 56(84) bytes of data.
64 bytes from 202.53.152.20: icmp_seq=1 ttl=64 time=1.80 ms
64 bytes from 202.53.152.20: icmp_seq=2 ttl=64 time=1.01 ms
64 bytes from 202.53.152.20: icmp_seq=3 ttl=64 time=0.841 ms
--- 202.53.152.20 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2005ms
rtt min/avg/max/mdev = 0.841/1.222/1.807/0.420 ms
2025-12-01 04:04:22,271 - INFO - Ping to IP 202.53.152.20 from VM ctest-TestBGPaasZone-92773783-97720765 passed
2025-12-01 04:04:22,271 - INFO - Detaching VMI dd06fa81-0ba8-4831-adce-a8d74e02dc2d from BGPaaS 7bf7fa7e-c857-4a85-8177-c7bc411a7fcd
2025-12-01 04:04:22,359 - INFO - Deleting BGPaaS ctest-TestBGPaasZone-92773783-57789121(7bf7fa7e-c857-4a85-8177-c7bc411a7fcd)
2025-12-01 04:04:22,439 - DEBUG - Requesting: http://10.0.0.27:8082/bgp-as-a-service/7bf7fa7e-c857-4a85-8177-c7bc411a7fcd
2025-12-01 04:04:22,523 - DEBUG - Response Code: 404
2025-12-01 04:04:22,523 - DEBUG - BGPaaS: 7bf7fa7e-c857-4a85-8177-c7bc411a7fcd deleted from api server
2025-12-01 04:04:22,523 - INFO - BGPaaS(7bf7fa7e-c857-4a85-8177-c7bc411a7fcd): verify_on_cleanup passed
2025-12-01 04:04:22,524 - INFO - Detaching VMI e5844ab1-24e5-4259-8c40-b623809afa32 from BGPaaS d086a33a-c489-44c5-bfe9-2b5bef8b86ce
2025-12-01 04:04:22,644 - INFO - Deleting BGPaaS ctest-TestBGPaasZone-92773783-44713127(d086a33a-c489-44c5-bfe9-2b5bef8b86ce)
2025-12-01 04:04:22,733 - DEBUG - Requesting: http://10.0.0.27:8082/bgp-as-a-service/d086a33a-c489-44c5-bfe9-2b5bef8b86ce
2025-12-01 04:04:22,745 - DEBUG - Response Code: 404
2025-12-01 04:04:22,745 - DEBUG - BGPaaS: d086a33a-c489-44c5-bfe9-2b5bef8b86ce deleted from api server
2025-12-01 04:04:22,745 - INFO - BGPaaS(d086a33a-c489-44c5-bfe9-2b5bef8b86ce): verify_on_cleanup passed
2025-12-01 04:04:22,745 - INFO - Deleting Control node zone ctest-test-zone-84207018(2d8cd848-1662-4d3f-bd2f-f4b22ab2c449)
2025-12-01 04:04:22,922 - INFO - Deleting Control node zone ctest-test-zone-97826767(7084e3dd-7c64-4592-8247-a6e65f264afe)
2025-12-01 04:04:23,102 - INFO - Deleting Control node zone ctest-test-zone-34798379(5a7f4666-5122-4491-9f07-aad7bab31510)
2025-12-01 04:04:23,278 - INFO - Deleting VM ctest-TestBGPaasZone-92773783-97720765
2025-12-01 04:04:23,411 - INFO - Deleting VM ctest-TestBGPaasZone-92773783-77727819
2025-12-01 04:04:23,502 - INFO - Deleting VM ctest-TestBGPaasZone-92773783-97618660
2025-12-01 04:04:23,576 - INFO - Deleting VN ctest-cnz_vn-51384197
2025-12-01 04:04:23,622 - DEBUG - VN 9bd8449c-3ee9-4813-b0e3-5bd0914645b3 still in use: Unable to complete operation on network 9bd8449c-3ee9-4813-b0e3-5bd0914645b3. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-e523ac5b-43fb-4bc3-b0c6-f13a6cbb3a2d']
2025-12-01 04:04:23,622 - WARNING - Deleting VN ctest-cnz_vn-51384197 failed..Will retry
2025-12-01 04:04:25,839 - DEBUG - Response for deleting network ()
2025-12-01 04:04:27,146 - DEBUG - Skipping xmpp flap check
2025-12-01 04:04:27,146 - INFO - END TEST : test_bgp_control_node_zones_from_single_vnf : PASSED[0:03:31]
2025-12-01 04:04:27,146 - INFO - --------------------------------------------------------------------------------
2025-12-01 04:04:28,036 - INFO - Deleted project: ctest-TestBGPaasZone-92773783, ID : db591ac0-6775-4b26-839c-90b9b85e530d