is in ACTIVE state now
2026-08-17 13:38:18,831 - INFO - VM name : ctest-TestBasicPolicy-45347005-73289731
2026-08-17 13:38:18,916 - DEBUG - VM ctest-TestBasicPolicy-45347005-73289731 ID is 1499f5b1-ea28-44be-832e-a16a0bb0420e
2026-08-17 13:38:18,916 - DEBUG - VM ctest-TestBasicPolicy-45347005-73289731 launched on Node cn-jenkins-deploy-platform-ansible-os-6175-1
2026-08-17 13:38:18,999 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/1499f5b1-ea28-44be-832e-a16a0bb0420e
2026-08-17 13:38:19,009 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/baefe4cd-995b-40c8-a3bf-576ec646f01d
2026-08-17 13:38:20,260 - 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=10.2 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.597 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 = 0.597/5.383/10.170/4.786 ms')
2026-08-17 13:38:20,260 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBasicPolicy-45347005-73289731 passed
2026-08-17 13:38:20,415 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-08-17 13:38:20,415 - DEBUG - Waiting to SSH to VM ctest-TestBasicPolicy-45347005-73289731, IP 11.173.28.195, Port 22
2026-08-17 13:38:20,480 - 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-08-17 13:38:20,561 - DEBUG - VM ctest-TestBasicPolicy-45347005-73289731 is NOT ready for SSH connections, VM status: ACTIVE
2026-08-17 13:38:25,562 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-08-17 13:38:25,562 - DEBUG - Waiting to SSH to VM ctest-TestBasicPolicy-45347005-73289731, IP 11.173.28.195, Port 22
2026-08-17 13:38:25,628 - 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-08-17 13:38:25,722 - DEBUG - VM ctest-TestBasicPolicy-45347005-73289731 is NOT ready for SSH connections, VM status: ACTIVE
2026-08-17 13:38:30,723 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-08-17 13:38:30,723 - DEBUG - Waiting to SSH to VM ctest-TestBasicPolicy-45347005-73289731, IP 11.173.28.195, Port 22
2026-08-17 13:38:30,896 - DEBUG - VM ctest-TestBasicPolicy-45347005-73289731 is ready for SSH connections
2026-08-17 13:38:30,897 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-08-17 13:38:30,897 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 11.173.28.195, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2026-08-17 13:38:30,897 - DEBUG - ping -s 56 -c 3 -W 1 11.173.28.195
2026-08-17 13:38:34,907 - DEBUG - PING 11.173.28.195 (11.173.28.195): 56 data bytes
64 bytes from 11.173.28.195: seq=0 ttl=63 time=4.594 ms
64 bytes from 11.173.28.195: seq=1 ttl=63 time=1.434 ms
64 bytes from 11.173.28.195: seq=2 ttl=63 time=1.334 ms
--- 11.173.28.195 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.334/2.454/4.594 ms
2026-08-17 13:38:34,907 - INFO - Ping to IP 11.173.28.195 from VM ctest-TestBasicPolicy-45347005-89070684 passed
2026-08-17 13:38:35,090 - DEBUG - Policy Update Response {"network-policy": {"uuid": "37652427-7d0c-4348-a3a2-9a0ef8d608a8", "href": "http://10.0.0.50:8082/network-policy/37652427-7d0c-4348-a3a2-9a0ef8d608a8"}}
2026-08-17 13:38:35,091 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-08-17 13:38:35,091 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 11.173.28.195, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2026-08-17 13:38:35,091 - DEBUG - ping -s 56 -c 3 -W 1 11.173.28.195
2026-08-17 13:38:38,229 - DEBUG - PING 11.173.28.195 (11.173.28.195): 56 data bytes
64 bytes from 11.173.28.195: seq=0 ttl=63 time=1.679 ms
--- 11.173.28.195 ping statistics ---
3 packets transmitted, 1 packets received, 66% packet loss
round-trip min/avg/max = 1.679/1.679/1.679 ms
2026-08-17 13:38:38,229 - WARNING - Ping to IP 11.173.28.195 from VM ctest-TestBasicPolicy-45347005-89070684 failed
2026-08-17 13:38:38,230 - INFO - Deleting VM ctest-TestBasicPolicy-45347005-73289731
2026-08-17 13:38:38,308 - INFO - Deleting VM ctest-TestBasicPolicy-45347005-89070684
2026-08-17 13:38:38,732 - INFO - Deleted policy ctest-policy-allow-all-15746620
2026-08-17 13:38:38,733 - INFO - Deleting VN ctest-vn-68746405
2026-08-17 13:38:38,768 - DEBUG - VN 8b28b7f7-3ff9-4749-ac30-986419943ba9 still in use: Unable to complete operation on network 8b28b7f7-3ff9-4749-ac30-986419943ba9. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-fd3d2dc6-ecbd-4d2c-b8cf-2082859e909b']
2026-08-17 13:38:38,768 - WARNING - Deleting VN ctest-vn-68746405 failed..Will retry
2026-08-17 13:38:40,893 - DEBUG - Response for deleting network ()
2026-08-17 13:38:40,893 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/ee29fff7-7d0a-4500-ac81-99a096fa1b18
2026-08-17 13:38:40,900 - DEBUG - Response Code: 404
2026-08-17 13:38:40,900 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2026-08-17 13:38:40,908 - DEBUG - Requesting: http://10.0.0.50:8082/domain/55f9187f-9b6f-476a-a9fa-b1c71f09ff9d
2026-08-17 13:38:40,965 - DEBUG - Requesting: http://10.0.0.50:8082/project/69d46e03-8f3a-43b3-a858-b9b89d033eff
2026-08-17 13:38:41,040 - INFO - Validated that VN ctest-vn-68746405 is not found in API Server
2026-08-17 13:38:41,051 - DEBUG - VN ctest-vn-68746405 is not present in Agent 10.0.0.50
2026-08-17 13:38:41,051 - INFO - Validated that VN ctest-vn-68746405 is not in any agent
2026-08-17 13:38:41,069 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-68746405 info
2026-08-17 13:38:41,069 - INFO - Deleting VN ctest-vn-32968569
2026-08-17 13:38:41,198 - DEBUG - Response for deleting network ()
2026-08-17 13:38:41,198 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/f7f65e00-7a01-4de7-897a-67bede3bd26e
2026-08-17 13:38:41,209 - DEBUG - Response Code: 404
2026-08-17 13:38:41,209 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2026-08-17 13:38:41,216 - DEBUG - Requesting: http://10.0.0.50:8082/domain/55f9187f-9b6f-476a-a9fa-b1c71f09ff9d
2026-08-17 13:38:41,273 - DEBUG - Requesting: http://10.0.0.50:8082/project/69d46e03-8f3a-43b3-a858-b9b89d033eff
2026-08-17 13:38:41,348 - INFO - Validated that VN ctest-vn-32968569 is not found in API Server
2026-08-17 13:38:41,359 - DEBUG - VN ctest-vn-32968569 is not present in Agent 10.0.0.50
2026-08-17 13:38:41,359 - INFO - Validated that VN ctest-vn-32968569 is not in any agent
2026-08-17 13:38:41,377 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-32968569 info
2026-08-17 13:38:41,650 - DEBUG - No XMPP flaps were noticed during the test
2026-08-17 13:38:41,650 - INFO - END TEST : test_basic_policy_allow_deny : PASSED[0:01:15]
2026-08-17 13:38:41,650 - INFO - --------------------------------------------------------------------------------
2026-08-17 13:38:42,450 - INFO - Deleted project: ctest-TestBasicPolicy-45347005, ID : 69d46e03-8f3a-43b3-a858-b9b89d033eff