is in ACTIVE state now
2026-02-10 18:22:45,776 - INFO - VM name : ctest-TestBasicPolicy-11213617-81463867
2026-02-10 18:22:45,961 - DEBUG - VM ctest-TestBasicPolicy-11213617-81463867 ID is 0e677035-7820-4554-b179-facbee0ccf29
2026-02-10 18:22:45,961 - DEBUG - VM ctest-TestBasicPolicy-11213617-81463867 launched on Node cn-jenkins-deploy-platform-ansible-os-5281-1
2026-02-10 18:22:46,141 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine/0e677035-7820-4554-b179-facbee0ccf29
2026-02-10 18:22:46,154 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine-interface/40247834-e1b5-47f1-be35-17e21e43e93c
2026-02-10 18:22:47,435 - 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.75 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=2.15 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 = 2.154/2.951/3.749/0.797 ms')
2026-02-10 18:22:47,435 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBasicPolicy-11213617-81463867 passed
2026-02-10 18:22:47,614 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-10 18:22:47,614 - DEBUG - Waiting to SSH to VM ctest-TestBasicPolicy-11213617-81463867, IP 105.39.78.3, Port 22
2026-02-10 18:22:47,693 - DEBUG - Error on ssh to cirros@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': ''}
2026-02-10 18:22:47,901 - DEBUG - VM ctest-TestBasicPolicy-11213617-81463867 is NOT ready for SSH connections, VM status: ACTIVE
2026-02-10 18:22:52,902 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-10 18:22:52,902 - DEBUG - Waiting to SSH to VM ctest-TestBasicPolicy-11213617-81463867, IP 105.39.78.3, Port 22
2026-02-10 18:22:53,097 - DEBUG - VM ctest-TestBasicPolicy-11213617-81463867 is ready for SSH connections
2026-02-10 18:22:53,097 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-10 18:22:53,097 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 105.39.78.3, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.242, gateway password: c0ntrail123
2026-02-10 18:22:53,097 - DEBUG - ping -s 56 -c 3 -W 1 105.39.78.3
2026-02-10 18:22:57,362 - DEBUG - PING 105.39.78.3 (105.39.78.3): 56 data bytes
64 bytes from 105.39.78.3: seq=0 ttl=63 time=3.494 ms
64 bytes from 105.39.78.3: seq=1 ttl=63 time=1.897 ms
64 bytes from 105.39.78.3: seq=2 ttl=63 time=1.579 ms
--- 105.39.78.3 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.579/2.323/3.494 ms
2026-02-10 18:22:57,362 - INFO - Ping to IP 105.39.78.3 from VM ctest-TestBasicPolicy-11213617-80481390 passed
2026-02-10 18:22:57,613 - DEBUG - Policy Update Response {"network-policy": {"uuid": "f72c279b-490e-4b29-bddf-917859bfda48", "href": "http://10.0.0.242:8082/network-policy/f72c279b-490e-4b29-bddf-917859bfda48"}}
2026-02-10 18:22:57,613 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-10 18:22:57,613 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 105.39.78.3, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.242, gateway password: c0ntrail123
2026-02-10 18:22:57,614 - DEBUG - ping -s 56 -c 3 -W 1 105.39.78.3
2026-02-10 18:23:00,943 - DEBUG - PING 105.39.78.3 (105.39.78.3): 56 data bytes
64 bytes from 105.39.78.3: seq=0 ttl=63 time=2.095 ms
--- 105.39.78.3 ping statistics ---
3 packets transmitted, 1 packets received, 66% packet loss
round-trip min/avg/max = 2.095/2.095/2.095 ms
2026-02-10 18:23:00,943 - WARNING - Ping to IP 105.39.78.3 from VM ctest-TestBasicPolicy-11213617-80481390 failed
2026-02-10 18:23:00,943 - INFO - Deleting VM ctest-TestBasicPolicy-11213617-81463867
2026-02-10 18:23:01,114 - INFO - Deleting VM ctest-TestBasicPolicy-11213617-80481390
2026-02-10 18:23:01,849 - INFO - Deleted policy ctest-policy-allow-all-59683567
2026-02-10 18:23:01,849 - INFO - Deleting VN ctest-vn-82430931
2026-02-10 18:23:01,914 - DEBUG - VN a0e4186f-b72d-4967-8344-691a36a69251 still in use: Unable to complete operation on network a0e4186f-b72d-4967-8344-691a36a69251. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-aa8b5cb6-f4ef-4a77-81bb-9312092e0b2c']
2026-02-10 18:23:01,915 - WARNING - Deleting VN ctest-vn-82430931 failed..Will retry
2026-02-10 18:23:04,153 - DEBUG - Response for deleting network ()
2026-02-10 18:23:04,153 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/a8054fd5-867d-4430-9eaa-c1cbb0174878
2026-02-10 18:23:04,160 - DEBUG - Response Code: 404
2026-02-10 18:23:04,160 - DEBUG - Requesting: http://10.0.0.242:8082/domains
2026-02-10 18:23:04,167 - DEBUG - Requesting: http://10.0.0.242:8082/domain/d3aa0490-5e83-4562-bbf1-3a9306597ed6
2026-02-10 18:23:04,233 - DEBUG - Requesting: http://10.0.0.242:8082/project/4ccc2064-55cd-450a-96b3-aa7b31a7469e
2026-02-10 18:23:04,315 - INFO - Validated that VN ctest-vn-82430931 is not found in API Server
2026-02-10 18:23:04,326 - DEBUG - VN ctest-vn-82430931 is not present in Agent 10.0.0.242
2026-02-10 18:23:04,326 - INFO - Validated that VN ctest-vn-82430931 is not in any agent
2026-02-10 18:23:04,339 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-82430931 info
2026-02-10 18:23:04,339 - INFO - Deleting VN ctest-vn-39652190
2026-02-10 18:23:04,454 - DEBUG - Response for deleting network ()
2026-02-10 18:23:04,454 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/614b34db-34ef-49b6-91c3-136e986b92b0
2026-02-10 18:23:04,460 - DEBUG - Response Code: 404
2026-02-10 18:23:04,461 - DEBUG - Requesting: http://10.0.0.242:8082/domains
2026-02-10 18:23:04,465 - DEBUG - Requesting: http://10.0.0.242:8082/domain/d3aa0490-5e83-4562-bbf1-3a9306597ed6
2026-02-10 18:23:04,519 - DEBUG - Requesting: http://10.0.0.242:8082/project/4ccc2064-55cd-450a-96b3-aa7b31a7469e
2026-02-10 18:23:04,621 - INFO - Validated that VN ctest-vn-39652190 is not found in API Server
2026-02-10 18:23:04,637 - DEBUG - VN ctest-vn-39652190 is not present in Agent 10.0.0.242
2026-02-10 18:23:04,637 - INFO - Validated that VN ctest-vn-39652190 is not in any agent
2026-02-10 18:23:04,660 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-39652190 info
2026-02-10 18:23:04,983 - DEBUG - No XMPP flaps were noticed during the test
2026-02-10 18:23:04,983 - INFO - END TEST : test_basic_policy_allow_deny : PASSED[0:00:39]
2026-02-10 18:23:04,983 - INFO - --------------------------------------------------------------------------------
2026-02-10 18:23:05,880 - INFO - Deleted project: ctest-TestBasicPolicy-11213617, ID : 4ccc2064-55cd-450a-96b3-aa7b31a7469e