is in ACTIVE state now
2025-10-29 13:24:42,678 - INFO - VM name : ctest-TestBGPaasZone-83501458-41468477
2025-10-29 13:24:42,765 - DEBUG - VM ctest-TestBGPaasZone-83501458-41468477 ID is 323de285-4d49-4957-8519-a989ec81b5db
2025-10-29 13:24:42,765 - DEBUG - VM ctest-TestBGPaasZone-83501458-41468477 launched on Node an-jenkins-deploy-platform-ansible-os-4521-1
2025-10-29 13:24:42,857 - DEBUG - Requesting: http://10.0.0.48:8082/virtual-machine/323de285-4d49-4957-8519-a989ec81b5db
2025-10-29 13:24:42,868 - DEBUG - Requesting: http://10.0.0.48:8082/virtual-machine-interface/b902c2d1-e7e0-43eb-b8b0-119a71919378
2025-10-29 13:24:44,035 - 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.92 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=1.23 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.229/2.573/3.918/1.344 ms')
2025-10-29 13:24:44,035 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBGPaasZone-83501458-41468477 passed
2025-10-29 13:24:44,104 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-29 13:24:44,104 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-83501458-41468477, IP 106.19.97.69, Port 22
2025-10-29 13:24:44,173 - DEBUG - Error on ssh to ubuntu@169.254.0.4:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.4/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.4/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.4/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-10-29 13:24:44,254 - DEBUG - VM ctest-TestBGPaasZone-83501458-41468477 is NOT ready for SSH connections, VM status: ACTIVE
2025-10-29 13:24:49,255 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-29 13:24:49,255 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-83501458-41468477, IP 106.19.97.69, Port 22
2025-10-29 13:24:49,428 - DEBUG - VM ctest-TestBGPaasZone-83501458-41468477 is ready for SSH connections
2025-10-29 13:24:49,572 - INFO - Created control node zone ctest-test-zone-60502319(c0a539b9-7447-4aa3-860b-3a4f1e1de871)
2025-10-29 13:24:49,924 - INFO - Created control node zone ctest-test-zone-83099398(0706911f-9a58-411b-b7d1-cad32de5c294)
2025-10-29 13:24:50,288 - INFO - Created control node zone ctest-test-zone-65495306(4dea2e72-7d50-4332-984e-9d44970ef869)
2025-10-29 13:24:50,576 - INFO - Creating BGPaaS ctest-TestBGPaasZone-83501458-17206152
2025-10-29 13:24:50,656 - INFO - BGPaaS: ctest-TestBGPaasZone-83501458-17206152(4b4d9240-b521-4e28-8652-3f9548d09b1d)
2025-10-29 13:24:50,656 - DEBUG - Requesting: http://10.0.0.38:8082/bgp-as-a-service/4b4d9240-b521-4e28-8652-3f9548d09b1d
2025-10-29 13:24:50,667 - INFO - verify_in_api_server passed for BGPaaS obj 4b4d9240-b521-4e28-8652-3f9548d09b1d
2025-10-29 13:24:50,667 - INFO - BGPaaS(4b4d9240-b521-4e28-8652-3f9548d09b1d): verify_on_setup passed
2025-10-29 13:24:50,667 - INFO - We will configure BGP on the VM
2025-10-29 13:24:51,104 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-29 13:24:51,104 - INFO - Configuring BGP on ctest-TestBGPaasZone-83501458-76608125
2025-10-29 13:24:51,104 - 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.19.97.67;
protocol bgp bgp_1{
local as 65000;
neighbor 106.19.97.65 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 106.19.97.67;
}
protocol bfd {
neighbor 106.19.97.65 local 106.19.97.67 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123
2025-10-29 13:24:51,104 - 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.19.97.67;
protocol bgp bgp_1{
local as 65000;
neighbor 106.19.97.65 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 106.19.97.67;
}
protocol bfd {
neighbor 106.19.97.65 local 106.19.97.67 multihop on;
}
EOS
2025-10-29 13:25:04,796 - DEBUG - None
2025-10-29 13:25:04,797 - DEBUG - Running remote_cmd, Cmd : cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 106.19.97.66 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 106.19.97.67;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123
2025-10-29 13:25:04,797 - DEBUG - cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 106.19.97.66 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 106.19.97.67;
}
EOS
2025-10-29 13:25:05,929 - DEBUG - None
2025-10-29 13:25:05,929 - DEBUG - Running remote_cmd, Cmd : service bird restart, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123
2025-10-29 13:25:05,929 - DEBUG - service bird restart
2025-10-29 13:25:07,827 - DEBUG - bird stop/waiting
bird start/running, process 1440
2025-10-29 13:25:07,827 - INFO - Attaching VMI 8eebb236-31bf-48c9-bb62-a29c9c77b797 to BGPaaS 4b4d9240-b521-4e28-8652-3f9548d09b1d
2025-10-29 13:25:07,904 - INFO - Attaching the VMI 77ce2871-6753-4366-b9d5-52f95e0777f8 to the BGPaaS 4b4d9240-b521-4e28-8652-3f9548d09b1d object
2025-10-29 13:25:07,904 - DEBUG - Running remote_cmd, Cmd : sudo ip addr add 106.19.97.84 dev eth0, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123
2025-10-29 13:25:07,904 - DEBUG - sudo ip addr add 106.19.97.84 dev eth0
2025-10-29 13:25:08,741 - DEBUG - None
2025-10-29 13:25:08,808 - INFO - Creating BGPaaS ctest-TestBGPaasZone-83501458-67883181
2025-10-29 13:25:08,892 - INFO - BGPaaS: ctest-TestBGPaasZone-83501458-67883181(9ce7a6de-548c-4003-9a46-a791730ba046)
2025-10-29 13:25:08,892 - DEBUG - Requesting: http://10.0.0.38:8082/bgp-as-a-service/9ce7a6de-548c-4003-9a46-a791730ba046
2025-10-29 13:25:08,904 - INFO - verify_in_api_server passed for BGPaaS obj 9ce7a6de-548c-4003-9a46-a791730ba046
2025-10-29 13:25:08,904 - INFO - BGPaaS(9ce7a6de-548c-4003-9a46-a791730ba046): verify_on_setup passed
2025-10-29 13:25:08,904 - INFO - We will configure BGP on the VM
2025-10-29 13:25:09,356 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-29 13:25:09,356 - INFO - Configuring BGP on ctest-TestBGPaasZone-83501458-60999718
2025-10-29 13:25:09,356 - 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.19.97.68;
protocol bgp bgp_1{
local as 65000;
neighbor 106.19.97.65 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 106.19.97.68;
}
protocol bfd {
neighbor 106.19.97.65 local 106.19.97.68 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2025-10-29 13:25:09,356 - 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.19.97.68;
protocol bgp bgp_1{
local as 65000;
neighbor 106.19.97.65 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 106.19.97.68;
}
protocol bfd {
neighbor 106.19.97.65 local 106.19.97.68 multihop on;
}
EOS
2025-10-29 13:25:14,931 - DEBUG - None
2025-10-29 13:25:14,931 - DEBUG - Running remote_cmd, Cmd : cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 106.19.97.66 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 106.19.97.68;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2025-10-29 13:25:14,931 - DEBUG - cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 106.19.97.66 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 106.19.97.68;
}
EOS
2025-10-29 13:25:15,514 - DEBUG - None
2025-10-29 13:25:15,515 - DEBUG - Running remote_cmd, Cmd : service bird restart, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2025-10-29 13:25:15,515 - DEBUG - service bird restart
2025-10-29 13:25:17,359 - DEBUG - bird stop/waiting
bird start/running, process 1437
2025-10-29 13:25:17,359 - INFO - Attaching VMI 90f1fdd5-cb7c-4456-b203-864bd19a5110 to BGPaaS 9ce7a6de-548c-4003-9a46-a791730ba046
2025-10-29 13:25:17,448 - INFO - Attaching the VMI 45f917d0-3f25-4308-a157-b5e8a267b9ff to the BGPaaS 9ce7a6de-548c-4003-9a46-a791730ba046 object
2025-10-29 13:25:17,448 - DEBUG - Running remote_cmd, Cmd : sudo ip addr add 106.19.97.84 dev eth0, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2025-10-29 13:25:17,448 - DEBUG - sudo ip addr add 106.19.97.84 dev eth0
2025-10-29 13:25:18,133 - DEBUG - None
2025-10-29 13:25:18,133 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-29 13:25:18,148 - INFO - BGPaaS session seen in control-node 10.20.0.17
2025-10-29 13:25:18,148 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-29 13:25:18,166 - INFO - BGPaaS session seen in control-node 10.20.0.254
2025-10-29 13:25:18,173 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-29 13:25:18,188 - ERROR - Not enough BGPaaS sessions seen in control-nodes ['10.20.0.17']
2025-10-29 13:25:24,206 - ERROR - Not enough BGPaaS sessions seen in control-nodes ['10.20.0.17']
2025-10-29 13:25:30,222 - INFO - BGPaaS session seen in control-node 10.20.0.17
2025-10-29 13:25:30,223 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-29 13:25:30,242 - INFO - BGPaaS session seen in control-node 10.20.0.254
2025-10-29 13:25:30,248 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 106.19.97.84, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123
2025-10-29 13:25:30,248 - DEBUG - ping -s 56 -c 3 -W 1 106.19.97.84
2025-10-29 13:25:37,174 - DEBUG - PING 106.19.97.84 (106.19.97.84) 56(84) bytes of data.
64 bytes from 106.19.97.84: icmp_seq=1 ttl=64 time=8.23 ms
64 bytes from 106.19.97.84: icmp_seq=2 ttl=64 time=1.01 ms
64 bytes from 106.19.97.84: icmp_seq=3 ttl=64 time=1.12 ms
--- 106.19.97.84 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2005ms
rtt min/avg/max/mdev = 1.014/3.458/8.236/3.378 ms
2025-10-29 13:25:37,174 - INFO - Ping to IP 106.19.97.84 from VM ctest-TestBGPaasZone-83501458-41468477 passed
2025-10-29 13:25:37,174 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-29 13:25:37,187 - INFO - BGPaaS session seen in control-node 10.20.0.17
2025-10-29 13:25:37,188 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-29 13:25:37,210 - INFO - BGPaaS session seen in control-node 10.20.0.254
2025-10-29 13:25:37,218 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-29 13:25:37,230 - INFO - BGPaaS session seen in control-node 10.20.0.17
2025-10-29 13:25:37,231 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-29 13:25:37,249 - INFO - BGPaaS session seen in control-node 10.20.0.254
2025-10-29 13:25:37,255 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 106.19.97.84, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123
2025-10-29 13:25:37,255 - DEBUG - ping -s 56 -c 3 -W 1 106.19.97.84
2025-10-29 13:25:39,768 - DEBUG - PING 106.19.97.84 (106.19.97.84) 56(84) bytes of data.
64 bytes from 106.19.97.84: icmp_seq=1 ttl=64 time=5.52 ms
64 bytes from 106.19.97.84: icmp_seq=2 ttl=64 time=1.30 ms
64 bytes from 106.19.97.84: icmp_seq=3 ttl=64 time=1.36 ms
--- 106.19.97.84 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2005ms
rtt min/avg/max/mdev = 1.306/2.730/5.523/1.975 ms
2025-10-29 13:25:39,768 - INFO - Ping to IP 106.19.97.84 from VM ctest-TestBGPaasZone-83501458-41468477 passed
2025-10-29 13:25:39,768 - INFO - Detaching VMI 90f1fdd5-cb7c-4456-b203-864bd19a5110 from BGPaaS 9ce7a6de-548c-4003-9a46-a791730ba046
2025-10-29 13:25:39,856 - INFO - Deleting BGPaaS ctest-TestBGPaasZone-83501458-67883181(9ce7a6de-548c-4003-9a46-a791730ba046)
2025-10-29 13:25:39,943 - DEBUG - Requesting: http://10.0.0.38:8082/bgp-as-a-service/9ce7a6de-548c-4003-9a46-a791730ba046
2025-10-29 13:25:39,955 - DEBUG - Response Code: 404
2025-10-29 13:25:39,955 - DEBUG - BGPaaS: 9ce7a6de-548c-4003-9a46-a791730ba046 deleted from api server
2025-10-29 13:25:39,955 - INFO - BGPaaS(9ce7a6de-548c-4003-9a46-a791730ba046): verify_on_cleanup passed
2025-10-29 13:25:39,955 - INFO - Detaching VMI 8eebb236-31bf-48c9-bb62-a29c9c77b797 from BGPaaS 4b4d9240-b521-4e28-8652-3f9548d09b1d
2025-10-29 13:25:40,084 - INFO - Deleting BGPaaS ctest-TestBGPaasZone-83501458-17206152(4b4d9240-b521-4e28-8652-3f9548d09b1d)
2025-10-29 13:25:40,157 - DEBUG - Requesting: http://10.0.0.38:8082/bgp-as-a-service/4b4d9240-b521-4e28-8652-3f9548d09b1d
2025-10-29 13:25:40,164 - DEBUG - Response Code: 404
2025-10-29 13:25:40,164 - DEBUG - BGPaaS: 4b4d9240-b521-4e28-8652-3f9548d09b1d deleted from api server
2025-10-29 13:25:40,164 - INFO - BGPaaS(4b4d9240-b521-4e28-8652-3f9548d09b1d): verify_on_cleanup passed
2025-10-29 13:25:40,165 - INFO - Deleting Control node zone ctest-test-zone-65495306(4dea2e72-7d50-4332-984e-9d44970ef869)
2025-10-29 13:25:40,345 - INFO - Deleting Control node zone ctest-test-zone-83099398(0706911f-9a58-411b-b7d1-cad32de5c294)
2025-10-29 13:25:40,516 - INFO - Deleting Control node zone ctest-test-zone-60502319(c0a539b9-7447-4aa3-860b-3a4f1e1de871)
2025-10-29 13:25:40,681 - INFO - Deleting VM ctest-TestBGPaasZone-83501458-41468477
2025-10-29 13:25:40,758 - INFO - Deleting VM ctest-TestBGPaasZone-83501458-60999718
2025-10-29 13:25:40,832 - INFO - Deleting VM ctest-TestBGPaasZone-83501458-76608125
2025-10-29 13:25:40,930 - INFO - Deleting VN ctest-cnz_vn-55562691
2025-10-29 13:25:40,981 - DEBUG - VN cb893028-2df6-40bb-b47c-197609c5abd2 still in use: Unable to complete operation on network cb893028-2df6-40bb-b47c-197609c5abd2. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-192a3c4c-fdc4-4b65-ac33-9d7944616061']
2025-10-29 13:25:40,981 - WARNING - Deleting VN ctest-cnz_vn-55562691 failed..Will retry
2025-10-29 13:25:43,185 - DEBUG - Response for deleting network ()
2025-10-29 13:25:44,477 - DEBUG - Skipping xmpp flap check
2025-10-29 13:25:44,477 - INFO - END TEST : test_bgp_control_node_zones_from_single_vnf : PASSED[0:03:19]
2025-10-29 13:25:44,477 - INFO - --------------------------------------------------------------------------------
2025-10-29 13:25:45,327 - INFO - Deleted project: ctest-TestBGPaasZone-83501458, ID : eba39f82-36e6-4557-b89d-bb806a039e5f