is in ACTIVE state now
2025-10-08 18:16:25,826 - INFO - VM name : ctest-TestBGPaasZone-23877428-40039119
2025-10-08 18:16:25,899 - DEBUG - VM ctest-TestBGPaasZone-23877428-40039119 ID is e13a0e4c-0c12-4056-a190-991302a52c67
2025-10-08 18:16:25,899 - DEBUG - VM ctest-TestBGPaasZone-23877428-40039119 launched on Node an-jenkins-deploy-platform-ansible-os-4239-2
2025-10-08 18:16:25,971 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine/e13a0e4c-0c12-4056-a190-991302a52c67
2025-10-08 18:16:25,982 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine-interface/94494a09-d810-4ab4-afdf-182f37cb214e
2025-10-08 18:16:27,171 - 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.35 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=1.28 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.275/2.313/3.352/1.038 ms')
2025-10-08 18:16:27,172 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBGPaasZone-23877428-40039119 passed
2025-10-08 18:16:27,240 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-08 18:16:27,240 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-23877428-40039119, IP 92.13.191.197, Port 22
2025-10-08 18:16:27,306 - 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-08 18:16:27,390 - DEBUG - VM ctest-TestBGPaasZone-23877428-40039119 is NOT ready for SSH connections, VM status: ACTIVE
2025-10-08 18:16:32,390 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-08 18:16:32,390 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-23877428-40039119, IP 92.13.191.197, Port 22
2025-10-08 18:16:32,563 - DEBUG - VM ctest-TestBGPaasZone-23877428-40039119 is ready for SSH connections
2025-10-08 18:16:32,708 - INFO - Created control node zone ctest-test-zone-01911598(67abad31-9e80-4efa-b1b5-a1758c436bd7)
2025-10-08 18:16:33,080 - INFO - Created control node zone ctest-test-zone-81722765(a60cf07f-2e60-4a91-bbdf-d991c2229df5)
2025-10-08 18:16:33,436 - INFO - Created control node zone ctest-test-zone-12224789(5cdd2406-05e5-49b8-9758-4c3298d3175b)
2025-10-08 18:16:33,724 - INFO - Creating BGPaaS ctest-TestBGPaasZone-23877428-97732236
2025-10-08 18:16:33,804 - INFO - BGPaaS: ctest-TestBGPaasZone-23877428-97732236(f6c3b6a7-be82-4534-895b-eb9cc29784bf)
2025-10-08 18:16:33,805 - DEBUG - Requesting: http://10.0.0.56:8082/bgp-as-a-service/f6c3b6a7-be82-4534-895b-eb9cc29784bf
2025-10-08 18:16:33,814 - INFO - verify_in_api_server passed for BGPaaS obj f6c3b6a7-be82-4534-895b-eb9cc29784bf
2025-10-08 18:16:33,814 - INFO - BGPaaS(f6c3b6a7-be82-4534-895b-eb9cc29784bf): verify_on_setup passed
2025-10-08 18:16:33,814 - INFO - We will configure BGP on the VM
2025-10-08 18:16:34,252 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-08 18:16:34,252 - INFO - Configuring BGP on ctest-TestBGPaasZone-23877428-70687304
2025-10-08 18:16:34,253 - 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 92.13.191.195;
protocol bgp bgp_1{
local as 65000;
neighbor 92.13.191.193 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 92.13.191.195;
}
protocol bfd {
neighbor 92.13.191.193 local 92.13.191.195 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.19, gateway password: c0ntrail123
2025-10-08 18:16:34,253 - 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 92.13.191.195;
protocol bgp bgp_1{
local as 65000;
neighbor 92.13.191.193 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 92.13.191.195;
}
protocol bfd {
neighbor 92.13.191.193 local 92.13.191.195 multihop on;
}
EOS
2025-10-08 18:16:43,483 - DEBUG - None
2025-10-08 18:16:43,483 - DEBUG - Running remote_cmd, Cmd : cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 92.13.191.194 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 92.13.191.195;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.19, gateway password: c0ntrail123
2025-10-08 18:16:43,483 - DEBUG - cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 92.13.191.194 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 92.13.191.195;
}
EOS
2025-10-08 18:16:43,987 - DEBUG - None
2025-10-08 18:16:43,987 - DEBUG - Running remote_cmd, Cmd : service bird restart, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.19, gateway password: c0ntrail123
2025-10-08 18:16:43,987 - DEBUG - service bird restart
2025-10-08 18:16:45,696 - DEBUG - bird stop/waiting
bird start/running, process 1438
2025-10-08 18:16:45,696 - INFO - Attaching VMI bf5d1060-d634-4d28-b9f3-82cddbdbfc68 to BGPaaS f6c3b6a7-be82-4534-895b-eb9cc29784bf
2025-10-08 18:16:45,772 - INFO - Attaching the VMI 8706e2c7-eac5-4349-9c60-bfc89e4b2b16 to the BGPaaS f6c3b6a7-be82-4534-895b-eb9cc29784bf object
2025-10-08 18:16:45,772 - DEBUG - Running remote_cmd, Cmd : sudo ip addr add 92.13.191.212 dev eth0, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.19, gateway password: c0ntrail123
2025-10-08 18:16:45,773 - DEBUG - sudo ip addr add 92.13.191.212 dev eth0
2025-10-08 18:16:46,421 - DEBUG - None
2025-10-08 18:16:46,484 - INFO - Creating BGPaaS ctest-TestBGPaasZone-23877428-72350668
2025-10-08 18:16:46,560 - INFO - BGPaaS: ctest-TestBGPaasZone-23877428-72350668(594c8634-9340-4073-ab9b-fe0623b90e0a)
2025-10-08 18:16:46,560 - DEBUG - Requesting: http://10.0.0.56:8082/bgp-as-a-service/594c8634-9340-4073-ab9b-fe0623b90e0a
2025-10-08 18:16:46,572 - INFO - verify_in_api_server passed for BGPaaS obj 594c8634-9340-4073-ab9b-fe0623b90e0a
2025-10-08 18:16:46,572 - INFO - BGPaaS(594c8634-9340-4073-ab9b-fe0623b90e0a): verify_on_setup passed
2025-10-08 18:16:46,572 - INFO - We will configure BGP on the VM
2025-10-08 18:16:46,988 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-08 18:16:46,988 - INFO - Configuring BGP on ctest-TestBGPaasZone-23877428-13861975
2025-10-08 18:16:46,989 - 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 92.13.191.196;
protocol bgp bgp_1{
local as 65000;
neighbor 92.13.191.193 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 92.13.191.196;
}
protocol bfd {
neighbor 92.13.191.193 local 92.13.191.196 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.33, gateway password: c0ntrail123
2025-10-08 18:16:46,989 - 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 92.13.191.196;
protocol bgp bgp_1{
local as 65000;
neighbor 92.13.191.193 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 92.13.191.196;
}
protocol bfd {
neighbor 92.13.191.193 local 92.13.191.196 multihop on;
}
EOS
2025-10-08 18:16:53,048 - DEBUG - None
2025-10-08 18:16:53,049 - DEBUG - Running remote_cmd, Cmd : cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 92.13.191.194 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 92.13.191.196;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.33, gateway password: c0ntrail123
2025-10-08 18:16:53,049 - DEBUG - cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 92.13.191.194 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 92.13.191.196;
}
EOS
2025-10-08 18:16:53,531 - DEBUG - None
2025-10-08 18:16:53,532 - DEBUG - Running remote_cmd, Cmd : service bird restart, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.33, gateway password: c0ntrail123
2025-10-08 18:16:53,532 - DEBUG - service bird restart
2025-10-08 18:16:55,276 - DEBUG - bird stop/waiting
bird start/running, process 1484
2025-10-08 18:16:55,276 - INFO - Attaching VMI e67d3eee-eb3a-45ff-b820-ac6c4ed67f4e to BGPaaS 594c8634-9340-4073-ab9b-fe0623b90e0a
2025-10-08 18:16:55,360 - INFO - Attaching the VMI c33d9810-b3e1-424f-a306-b955f4e6bd32 to the BGPaaS 594c8634-9340-4073-ab9b-fe0623b90e0a object
2025-10-08 18:16:55,360 - DEBUG - Running remote_cmd, Cmd : sudo ip addr add 92.13.191.212 dev eth0, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.33, gateway password: c0ntrail123
2025-10-08 18:16:55,360 - DEBUG - sudo ip addr add 92.13.191.212 dev eth0
2025-10-08 18:16:56,014 - DEBUG - None
2025-10-08 18:16:56,014 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-08 18:16:56,026 - INFO - BGPaaS session seen in control-node 10.20.0.192
2025-10-08 18:16:56,026 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-08 18:16:56,045 - INFO - BGPaaS session seen in control-node 10.20.0.19
2025-10-08 18:16:56,053 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-08 18:16:56,066 - ERROR - Not enough BGPaaS sessions seen in control-nodes ['10.20.0.192']
2025-10-08 18:17:02,082 - INFO - BGPaaS session seen in control-node 10.20.0.192
2025-10-08 18:17:02,083 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-08 18:17:02,101 - ERROR - Not enough BGPaaS sessions seen in control-nodes ['10.20.0.19']
2025-10-08 18:17:08,118 - INFO - BGPaaS session seen in control-node 10.20.0.19
2025-10-08 18:17:08,123 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 92.13.191.212, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.19, gateway password: c0ntrail123
2025-10-08 18:17:08,123 - DEBUG - ping -s 56 -c 3 -W 1 92.13.191.212
2025-10-08 18:17:14,168 - DEBUG - PING 92.13.191.212 (92.13.191.212) 56(84) bytes of data.
64 bytes from 92.13.191.212: icmp_seq=1 ttl=64 time=9.05 ms
64 bytes from 92.13.191.212: icmp_seq=2 ttl=64 time=1.78 ms
64 bytes from 92.13.191.212: icmp_seq=3 ttl=64 time=1.15 ms
--- 92.13.191.212 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2004ms
rtt min/avg/max/mdev = 1.159/4.002/9.059/3.585 ms
2025-10-08 18:17:14,168 - INFO - Ping to IP 92.13.191.212 from VM ctest-TestBGPaasZone-23877428-40039119 passed
2025-10-08 18:17:14,168 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-08 18:17:14,181 - INFO - BGPaaS session seen in control-node 10.20.0.192
2025-10-08 18:17:14,182 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-08 18:17:14,197 - INFO - BGPaaS session seen in control-node 10.20.0.19
2025-10-08 18:17:14,203 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-08 18:17:14,215 - INFO - BGPaaS session seen in control-node 10.20.0.192
2025-10-08 18:17:14,215 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-08 18:17:14,230 - INFO - BGPaaS session seen in control-node 10.20.0.19
2025-10-08 18:17:14,235 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 92.13.191.212, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.19, gateway password: c0ntrail123
2025-10-08 18:17:14,235 - DEBUG - ping -s 56 -c 3 -W 1 92.13.191.212
2025-10-08 18:17:16,747 - DEBUG - PING 92.13.191.212 (92.13.191.212) 56(84) bytes of data.
64 bytes from 92.13.191.212: icmp_seq=1 ttl=64 time=2.38 ms
64 bytes from 92.13.191.212: icmp_seq=2 ttl=64 time=1.32 ms
64 bytes from 92.13.191.212: icmp_seq=3 ttl=64 time=1.40 ms
--- 92.13.191.212 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2005ms
rtt min/avg/max/mdev = 1.321/1.702/2.381/0.483 ms
2025-10-08 18:17:16,747 - INFO - Ping to IP 92.13.191.212 from VM ctest-TestBGPaasZone-23877428-40039119 passed
2025-10-08 18:17:16,747 - INFO - Detaching VMI e67d3eee-eb3a-45ff-b820-ac6c4ed67f4e from BGPaaS 594c8634-9340-4073-ab9b-fe0623b90e0a
2025-10-08 18:17:16,832 - INFO - Deleting BGPaaS ctest-TestBGPaasZone-23877428-72350668(594c8634-9340-4073-ab9b-fe0623b90e0a)
2025-10-08 18:17:16,909 - DEBUG - Requesting: http://10.0.0.56:8082/bgp-as-a-service/594c8634-9340-4073-ab9b-fe0623b90e0a
2025-10-08 18:17:16,917 - DEBUG - Response Code: 404
2025-10-08 18:17:16,917 - DEBUG - BGPaaS: 594c8634-9340-4073-ab9b-fe0623b90e0a deleted from api server
2025-10-08 18:17:16,917 - INFO - BGPaaS(594c8634-9340-4073-ab9b-fe0623b90e0a): verify_on_cleanup passed
2025-10-08 18:17:16,917 - INFO - Detaching VMI bf5d1060-d634-4d28-b9f3-82cddbdbfc68 from BGPaaS f6c3b6a7-be82-4534-895b-eb9cc29784bf
2025-10-08 18:17:17,008 - INFO - Deleting BGPaaS ctest-TestBGPaasZone-23877428-97732236(f6c3b6a7-be82-4534-895b-eb9cc29784bf)
2025-10-08 18:17:17,077 - DEBUG - Requesting: http://10.0.0.56:8082/bgp-as-a-service/f6c3b6a7-be82-4534-895b-eb9cc29784bf
2025-10-08 18:17:17,083 - DEBUG - Response Code: 404
2025-10-08 18:17:17,083 - DEBUG - BGPaaS: f6c3b6a7-be82-4534-895b-eb9cc29784bf deleted from api server
2025-10-08 18:17:17,083 - INFO - BGPaaS(f6c3b6a7-be82-4534-895b-eb9cc29784bf): verify_on_cleanup passed
2025-10-08 18:17:17,083 - INFO - Deleting Control node zone ctest-test-zone-12224789(5cdd2406-05e5-49b8-9758-4c3298d3175b)
2025-10-08 18:17:17,238 - INFO - Deleting Control node zone ctest-test-zone-81722765(a60cf07f-2e60-4a91-bbdf-d991c2229df5)
2025-10-08 18:17:17,386 - INFO - Deleting Control node zone ctest-test-zone-01911598(67abad31-9e80-4efa-b1b5-a1758c436bd7)
2025-10-08 18:17:17,542 - INFO - Deleting VM ctest-TestBGPaasZone-23877428-40039119
2025-10-08 18:17:17,617 - INFO - Deleting VM ctest-TestBGPaasZone-23877428-13861975
2025-10-08 18:17:17,681 - INFO - Deleting VM ctest-TestBGPaasZone-23877428-70687304
2025-10-08 18:17:17,747 - INFO - Deleting VN ctest-cnz_vn-07119594
2025-10-08 18:17:17,789 - DEBUG - VN fd40ab23-2194-4cd8-ba82-bf6ca06e0009 still in use: Unable to complete operation on network fd40ab23-2194-4cd8-ba82-bf6ca06e0009. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-b23dceec-3f6c-4e06-8e3a-ee89565a66c3']
2025-10-08 18:17:17,790 - WARNING - Deleting VN ctest-cnz_vn-07119594 failed..Will retry
2025-10-08 18:17:20,011 - DEBUG - Response for deleting network ()
2025-10-08 18:17:21,276 - DEBUG - Skipping xmpp flap check
2025-10-08 18:17:21,276 - INFO - END TEST : test_bgp_control_node_zones_from_single_vnf : PASSED[0:03:03]
2025-10-08 18:17:21,276 - INFO - --------------------------------------------------------------------------------
2025-10-08 18:17:22,029 - INFO - Deleted project: ctest-TestBGPaasZone-23877428, ID : 4ddb00fd-716b-474a-b70d-18454024bbc5