is in ACTIVE state now
2025-08-10 12:32:36,534 - INFO - VM name : ctest-TestBGPaasZone-68115528-50870700
2025-08-10 12:32:36,611 - DEBUG - VM ctest-TestBGPaasZone-68115528-50870700 ID is 07c27a8f-827c-4773-bd4c-38663f683183
2025-08-10 12:32:36,611 - DEBUG - VM ctest-TestBGPaasZone-68115528-50870700 launched on Node an-jenkins-deploy-platform-ansible-os-3786-2
2025-08-10 12:32:36,683 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-machine/07c27a8f-827c-4773-bd4c-38663f683183
2025-08-10 12:32:36,693 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-machine-interface/b21ebcde-ff3f-436a-8fdc-5fe9e8496a6e
2025-08-10 12:32:37,886 - 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.47 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.937 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 = 0.937/2.202/3.467/1.265 ms')
2025-08-10 12:32:37,886 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBGPaasZone-68115528-50870700 passed
2025-08-10 12:32:37,999 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-10 12:32:38,000 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-68115528-50870700, IP 220.174.31.133, Port 22
2025-08-10 12:32:38,065 - 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-08-10 12:32:38,130 - DEBUG - VM ctest-TestBGPaasZone-68115528-50870700 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-10 12:32:43,131 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-10 12:32:43,131 - DEBUG - Waiting to SSH to VM ctest-TestBGPaasZone-68115528-50870700, IP 220.174.31.133, Port 22
2025-08-10 12:32:43,305 - DEBUG - VM ctest-TestBGPaasZone-68115528-50870700 is ready for SSH connections
2025-08-10 12:32:43,428 - INFO - Created control node zone ctest-test-zone-50774567(b934225f-9a4c-4b45-9f2c-c653d0a7fe9d)
2025-08-10 12:32:43,780 - INFO - Created control node zone ctest-test-zone-79415251(57392c5b-dc9b-43dc-9339-aade7759aecd)
2025-08-10 12:32:44,128 - INFO - Created control node zone ctest-test-zone-65519080(9fd275f1-0f32-447d-bd86-e1af1d6c3ea3)
2025-08-10 12:32:44,400 - INFO - Creating BGPaaS ctest-TestBGPaasZone-68115528-86193329
2025-08-10 12:32:44,468 - INFO - BGPaaS: ctest-TestBGPaasZone-68115528-86193329(a1c2385d-977c-4442-87ee-efb6ade48bf3)
2025-08-10 12:32:44,468 - DEBUG - Requesting: http://10.0.0.49:8082/bgp-as-a-service/a1c2385d-977c-4442-87ee-efb6ade48bf3
2025-08-10 12:32:44,481 - INFO - verify_in_api_server passed for BGPaaS obj a1c2385d-977c-4442-87ee-efb6ade48bf3
2025-08-10 12:32:44,481 - INFO - BGPaaS(a1c2385d-977c-4442-87ee-efb6ade48bf3): verify_on_setup passed
2025-08-10 12:32:44,481 - INFO - We will configure BGP on the VM
2025-08-10 12:32:44,884 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-10 12:32:44,884 - INFO - Configuring BGP on ctest-TestBGPaasZone-68115528-78158243
2025-08-10 12:32:44,884 - 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 220.174.31.131;
protocol bgp bgp_1{
local as 65000;
neighbor 220.174.31.129 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 220.174.31.131;
}
protocol bfd {
neighbor 220.174.31.129 local 220.174.31.131 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.56, gateway password: c0ntrail123
2025-08-10 12:32:44,884 - 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 220.174.31.131;
protocol bgp bgp_1{
local as 65000;
neighbor 220.174.31.129 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 220.174.31.131;
}
protocol bfd {
neighbor 220.174.31.129 local 220.174.31.131 multihop on;
}
EOS
2025-08-10 12:32:54,064 - DEBUG - None
2025-08-10 12:32:54,064 - DEBUG - Running remote_cmd, Cmd : cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 220.174.31.130 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 220.174.31.131;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.56, gateway password: c0ntrail123
2025-08-10 12:32:54,064 - DEBUG - cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 220.174.31.130 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 220.174.31.131;
}
EOS
2025-08-10 12:32:54,534 - DEBUG - None
2025-08-10 12:32:54,534 - DEBUG - Running remote_cmd, Cmd : service bird restart, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.56, gateway password: c0ntrail123
2025-08-10 12:32:54,534 - DEBUG - service bird restart
2025-08-10 12:32:56,070 - DEBUG - bird stop/waiting
bird start/running, process 1481
2025-08-10 12:32:56,071 - INFO - Attaching VMI 2004fc6f-b37d-472c-a4d8-9c88301a77eb to BGPaaS a1c2385d-977c-4442-87ee-efb6ade48bf3
2025-08-10 12:32:56,144 - INFO - Attaching the VMI 98fe83a6-ee15-431e-873f-a8bd82d7c2dc to the BGPaaS a1c2385d-977c-4442-87ee-efb6ade48bf3 object
2025-08-10 12:32:56,144 - DEBUG - Running remote_cmd, Cmd : sudo ip addr add 220.174.31.148 dev eth0, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.56, gateway password: c0ntrail123
2025-08-10 12:32:56,144 - DEBUG - sudo ip addr add 220.174.31.148 dev eth0
2025-08-10 12:32:56,781 - DEBUG - None
2025-08-10 12:32:56,844 - INFO - Creating BGPaaS ctest-TestBGPaasZone-68115528-75285119
2025-08-10 12:32:56,916 - INFO - BGPaaS: ctest-TestBGPaasZone-68115528-75285119(7ce5d905-436e-49f8-8f78-af96494deec9)
2025-08-10 12:32:56,916 - DEBUG - Requesting: http://10.0.0.49:8082/bgp-as-a-service/7ce5d905-436e-49f8-8f78-af96494deec9
2025-08-10 12:32:56,926 - INFO - verify_in_api_server passed for BGPaaS obj 7ce5d905-436e-49f8-8f78-af96494deec9
2025-08-10 12:32:56,926 - INFO - BGPaaS(7ce5d905-436e-49f8-8f78-af96494deec9): verify_on_setup passed
2025-08-10 12:32:56,926 - INFO - We will configure BGP on the VM
2025-08-10 12:32:57,320 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-10 12:32:57,320 - INFO - Configuring BGP on ctest-TestBGPaasZone-68115528-14816146
2025-08-10 12:32:57,320 - 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 220.174.31.132;
protocol bgp bgp_1{
local as 65000;
neighbor 220.174.31.129 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 220.174.31.132;
}
protocol bfd {
neighbor 220.174.31.129 local 220.174.31.132 multihop on;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.65, gateway password: c0ntrail123
2025-08-10 12:32:57,320 - 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 220.174.31.132;
protocol bgp bgp_1{
local as 65000;
neighbor 220.174.31.129 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 220.174.31.132;
}
protocol bfd {
neighbor 220.174.31.129 local 220.174.31.132 multihop on;
}
EOS
2025-08-10 12:33:03,106 - DEBUG - None
2025-08-10 12:33:03,106 - DEBUG - Running remote_cmd, Cmd : cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 220.174.31.130 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 220.174.31.132;
}
EOS
, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.65, gateway password: c0ntrail123
2025-08-10 12:33:03,106 - DEBUG - cat >> /etc/bird/bird.conf << EOS
protocol bgp bgp_2{
local as 65000;
neighbor 220.174.31.130 as 64512;
export where source = RTS_STATIC;
export all;
multihop;
#export all;
hold time 90;
bfd on;
source address 220.174.31.132;
}
EOS
2025-08-10 12:33:03,556 - DEBUG - None
2025-08-10 12:33:03,556 - 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-08-10 12:33:03,556 - DEBUG - service bird restart
2025-08-10 12:33:05,042 - DEBUG - bird stop/waiting
bird start/running, process 1481
2025-08-10 12:33:05,042 - INFO - Attaching VMI 2d88e1bf-c0ce-4b4b-8dc6-8f4a2cfdb093 to BGPaaS 7ce5d905-436e-49f8-8f78-af96494deec9
2025-08-10 12:33:05,112 - INFO - Attaching the VMI e1949060-963b-4127-a2c1-06ffefdbcc07 to the BGPaaS 7ce5d905-436e-49f8-8f78-af96494deec9 object
2025-08-10 12:33:05,112 - DEBUG - Running remote_cmd, Cmd : sudo ip addr add 220.174.31.148 dev eth0, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.65, gateway password: c0ntrail123
2025-08-10 12:33:05,112 - DEBUG - sudo ip addr add 220.174.31.148 dev eth0
2025-08-10 12:33:05,693 - DEBUG - None
2025-08-10 12:33:05,693 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-10 12:33:05,707 - ERROR - Not enough BGPaaS sessions seen in control-nodes ['10.20.0.254']
2025-08-10 12:33:11,719 - INFO - BGPaaS session seen in control-node 10.20.0.254
2025-08-10 12:33:11,719 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-10 12:33:11,733 - INFO - BGPaaS session seen in control-node 10.20.0.14
2025-08-10 12:33:11,738 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-10 12:33:11,749 - ERROR - Not enough BGPaaS sessions seen in control-nodes ['10.20.0.254']
2025-08-10 12:33:17,763 - INFO - BGPaaS session seen in control-node 10.20.0.254
2025-08-10 12:33:17,763 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-10 12:33:17,777 - INFO - BGPaaS session seen in control-node 10.20.0.14
2025-08-10 12:33:17,782 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 220.174.31.148, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.56, gateway password: c0ntrail123
2025-08-10 12:33:17,783 - DEBUG - ping -s 56 -c 3 -W 1 220.174.31.148
2025-08-10 12:33:23,674 - DEBUG - PING 220.174.31.148 (220.174.31.148) 56(84) bytes of data.
64 bytes from 220.174.31.148: icmp_seq=1 ttl=64 time=6.36 ms
64 bytes from 220.174.31.148: icmp_seq=2 ttl=64 time=0.802 ms
64 bytes from 220.174.31.148: icmp_seq=3 ttl=64 time=0.845 ms
--- 220.174.31.148 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2004ms
rtt min/avg/max/mdev = 0.802/2.669/6.361/2.610 ms
2025-08-10 12:33:23,675 - INFO - Ping to IP 220.174.31.148 from VM ctest-TestBGPaasZone-68115528-50870700 passed
2025-08-10 12:33:23,675 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-10 12:33:23,687 - INFO - BGPaaS session seen in control-node 10.20.0.254
2025-08-10 12:33:23,687 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-10 12:33:23,701 - INFO - BGPaaS session seen in control-node 10.20.0.14
2025-08-10 12:33:23,706 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-10 12:33:23,716 - INFO - BGPaaS session seen in control-node 10.20.0.254
2025-08-10 12:33:23,717 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-10 12:33:23,730 - INFO - BGPaaS session seen in control-node 10.20.0.14
2025-08-10 12:33:23,735 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 220.174.31.148, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.56, gateway password: c0ntrail123
2025-08-10 12:33:23,735 - DEBUG - ping -s 56 -c 3 -W 1 220.174.31.148
2025-08-10 12:33:26,160 - DEBUG - PING 220.174.31.148 (220.174.31.148) 56(84) bytes of data.
64 bytes from 220.174.31.148: icmp_seq=1 ttl=64 time=3.37 ms
64 bytes from 220.174.31.148: icmp_seq=2 ttl=64 time=0.700 ms
64 bytes from 220.174.31.148: icmp_seq=3 ttl=64 time=0.585 ms
--- 220.174.31.148 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2004ms
rtt min/avg/max/mdev = 0.585/1.554/3.378/1.290 ms
2025-08-10 12:33:26,160 - INFO - Ping to IP 220.174.31.148 from VM ctest-TestBGPaasZone-68115528-50870700 passed
2025-08-10 12:33:26,160 - INFO - Detaching VMI 2d88e1bf-c0ce-4b4b-8dc6-8f4a2cfdb093 from BGPaaS 7ce5d905-436e-49f8-8f78-af96494deec9
2025-08-10 12:33:26,232 - INFO - Deleting BGPaaS ctest-TestBGPaasZone-68115528-75285119(7ce5d905-436e-49f8-8f78-af96494deec9)
2025-08-10 12:33:26,324 - DEBUG - Requesting: http://10.0.0.49:8082/bgp-as-a-service/7ce5d905-436e-49f8-8f78-af96494deec9
2025-08-10 12:33:26,351 - DEBUG - Response Code: 404
2025-08-10 12:33:26,351 - DEBUG - BGPaaS: 7ce5d905-436e-49f8-8f78-af96494deec9 deleted from api server
2025-08-10 12:33:26,351 - INFO - BGPaaS(7ce5d905-436e-49f8-8f78-af96494deec9): verify_on_cleanup passed
2025-08-10 12:33:26,351 - INFO - Detaching VMI 2004fc6f-b37d-472c-a4d8-9c88301a77eb from BGPaaS a1c2385d-977c-4442-87ee-efb6ade48bf3
2025-08-10 12:33:26,444 - INFO - Deleting BGPaaS ctest-TestBGPaasZone-68115528-86193329(a1c2385d-977c-4442-87ee-efb6ade48bf3)
2025-08-10 12:33:26,520 - DEBUG - Requesting: http://10.0.0.49:8082/bgp-as-a-service/a1c2385d-977c-4442-87ee-efb6ade48bf3
2025-08-10 12:33:26,532 - DEBUG - Response Code: 404
2025-08-10 12:33:26,532 - DEBUG - BGPaaS: a1c2385d-977c-4442-87ee-efb6ade48bf3 deleted from api server
2025-08-10 12:33:26,532 - INFO - BGPaaS(a1c2385d-977c-4442-87ee-efb6ade48bf3): verify_on_cleanup passed
2025-08-10 12:33:26,533 - INFO - Deleting Control node zone ctest-test-zone-65519080(9fd275f1-0f32-447d-bd86-e1af1d6c3ea3)
2025-08-10 12:33:26,701 - INFO - Deleting Control node zone ctest-test-zone-79415251(57392c5b-dc9b-43dc-9339-aade7759aecd)
2025-08-10 12:33:26,856 - INFO - Deleting Control node zone ctest-test-zone-50774567(b934225f-9a4c-4b45-9f2c-c653d0a7fe9d)
2025-08-10 12:33:27,008 - INFO - Deleting VM ctest-TestBGPaasZone-68115528-50870700
2025-08-10 12:33:27,073 - INFO - Deleting VM ctest-TestBGPaasZone-68115528-14816146
2025-08-10 12:33:27,132 - INFO - Deleting VM ctest-TestBGPaasZone-68115528-78158243
2025-08-10 12:33:27,194 - INFO - Deleting VN ctest-cnz_vn-77695859
2025-08-10 12:33:27,240 - DEBUG - VN 36735b76-3b2e-4602-8eb3-458418ffb866 still in use: Unable to complete operation on network 36735b76-3b2e-4602-8eb3-458418ffb866. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-56521d4c-6a63-4333-ad48-822afbede15b']
2025-08-10 12:33:27,240 - WARNING - Deleting VN ctest-cnz_vn-77695859 failed..Will retry
2025-08-10 12:33:29,421 - DEBUG - Response for deleting network ()
2025-08-10 12:33:30,658 - DEBUG - Skipping xmpp flap check
2025-08-10 12:33:30,658 - INFO - END TEST : test_bgp_control_node_zones_from_single_vnf : PASSED[0:02:45]
2025-08-10 12:33:30,659 - INFO - --------------------------------------------------------------------------------
2025-08-10 12:33:31,339 - INFO - Deleted project: ctest-TestBGPaasZone-68115528, ID : f6543f82-b915-4ac0-a33c-0fa2fd805b32