is in ACTIVE state now
2026-06-19 14:02:03,623 - INFO - VM name : ctest-TestBasicPolicy-15099110-89178838
2026-06-19 14:02:03,696 - DEBUG - VM ctest-TestBasicPolicy-15099110-89178838 ID is 694ef4c3-9a4b-4e45-8718-f813a418af84
2026-06-19 14:02:03,696 - DEBUG - VM ctest-TestBasicPolicy-15099110-89178838 launched on Node cn-jenkins-deploy-platform-ansible-os-5993-1
2026-06-19 14:02:03,776 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/694ef4c3-9a4b-4e45-8718-f813a418af84
2026-06-19 14:02:03,785 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/a39d168b-5527-4648-b42c-013da4b11c6c
2026-06-19 14:02:05,029 - 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=7.57 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=3.69 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 = 3.691/5.630/7.570/1.939 ms')
2026-06-19 14:02:05,029 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBasicPolicy-15099110-89178838 passed
2026-06-19 14:02:05,177 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-19 14:02:05,177 - DEBUG - Waiting to SSH to VM ctest-TestBasicPolicy-15099110-89178838, IP 50.62.20.131, Port 22
2026-06-19 14:02:05,243 - 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-06-19 14:02:05,314 - DEBUG - VM ctest-TestBasicPolicy-15099110-89178838 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-19 14:02:10,315 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-19 14:02:10,315 - DEBUG - Waiting to SSH to VM ctest-TestBasicPolicy-15099110-89178838, IP 50.62.20.131, Port 22
2026-06-19 14:02:10,483 - DEBUG - VM ctest-TestBasicPolicy-15099110-89178838 is ready for SSH connections
2026-06-19 14:02:10,483 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-19 14:02:10,483 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 50.62.20.131, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.33, gateway password: c0ntrail123
2026-06-19 14:02:10,483 - DEBUG - ping -s 56 -c 3 -W 1 50.62.20.131
2026-06-19 14:02:14,496 - DEBUG - PING 50.62.20.131 (50.62.20.131): 56 data bytes
64 bytes from 50.62.20.131: seq=0 ttl=63 time=3.750 ms
64 bytes from 50.62.20.131: seq=1 ttl=63 time=0.957 ms
64 bytes from 50.62.20.131: seq=2 ttl=63 time=1.082 ms
--- 50.62.20.131 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.957/1.929/3.750 ms
2026-06-19 14:02:14,496 - INFO - Ping to IP 50.62.20.131 from VM ctest-TestBasicPolicy-15099110-65938617 passed
2026-06-19 14:02:14,665 - DEBUG - Policy Update Response {"network-policy": {"uuid": "0631060d-c6db-4fb4-aff6-20931cea2dc0", "href": "http://10.0.0.33:8082/network-policy/0631060d-c6db-4fb4-aff6-20931cea2dc0"}}
2026-06-19 14:02:14,665 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-19 14:02:14,665 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 50.62.20.131, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.33, gateway password: c0ntrail123
2026-06-19 14:02:14,665 - DEBUG - ping -s 56 -c 3 -W 1 50.62.20.131
2026-06-19 14:02:17,785 - DEBUG - PING 50.62.20.131 (50.62.20.131): 56 data bytes
64 bytes from 50.62.20.131: seq=0 ttl=63 time=1.317 ms
--- 50.62.20.131 ping statistics ---
3 packets transmitted, 1 packets received, 66% packet loss
round-trip min/avg/max = 1.317/1.317/1.317 ms
2026-06-19 14:02:17,785 - WARNING - Ping to IP 50.62.20.131 from VM ctest-TestBasicPolicy-15099110-65938617 failed
2026-06-19 14:02:17,786 - INFO - Deleting VM ctest-TestBasicPolicy-15099110-89178838
2026-06-19 14:02:17,869 - INFO - Deleting VM ctest-TestBasicPolicy-15099110-65938617
2026-06-19 14:02:18,198 - INFO - Deleted policy ctest-policy-allow-all-08384035
2026-06-19 14:02:18,198 - INFO - Deleting VN ctest-vn-96889156
2026-06-19 14:02:18,227 - DEBUG - VN 3296a87b-e1f0-4904-977e-93e563b9527d still in use: Unable to complete operation on network 3296a87b-e1f0-4904-977e-93e563b9527d. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-992b8e9e-8134-4ca4-9dba-80a24fd1ca6a']
2026-06-19 14:02:18,227 - WARNING - Deleting VN ctest-vn-96889156 failed..Will retry
2026-06-19 14:02:20,324 - DEBUG - Response for deleting network ()
2026-06-19 14:02:20,325 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/78aefe2b-0393-42b9-ad70-3c71514d92d4
2026-06-19 14:02:20,334 - DEBUG - Response Code: 404
2026-06-19 14:02:20,334 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-19 14:02:20,339 - DEBUG - Requesting: http://10.0.0.33:8082/domain/0d5cbf3e-7f62-4ab5-9f6d-d039e28ff9b6
2026-06-19 14:02:20,390 - DEBUG - Requesting: http://10.0.0.33:8082/project/48fa83c8-0db8-4a94-9f02-baa9338f58d5
2026-06-19 14:02:20,463 - INFO - Validated that VN ctest-vn-96889156 is not found in API Server
2026-06-19 14:02:20,474 - DEBUG - VN ctest-vn-96889156 is not present in Agent 10.0.0.33
2026-06-19 14:02:20,474 - INFO - Validated that VN ctest-vn-96889156 is not in any agent
2026-06-19 14:02:20,489 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-96889156 info
2026-06-19 14:02:20,489 - INFO - Deleting VN ctest-vn-72866206
2026-06-19 14:02:20,597 - DEBUG - Response for deleting network ()
2026-06-19 14:02:20,597 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/a0f809cd-1b67-45aa-a44d-7407d4426f2a
2026-06-19 14:02:20,601 - DEBUG - Response Code: 404
2026-06-19 14:02:20,601 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-06-19 14:02:20,616 - DEBUG - Requesting: http://10.0.0.33:8082/domain/0d5cbf3e-7f62-4ab5-9f6d-d039e28ff9b6
2026-06-19 14:02:20,670 - DEBUG - Requesting: http://10.0.0.33:8082/project/48fa83c8-0db8-4a94-9f02-baa9338f58d5
2026-06-19 14:02:20,742 - INFO - Validated that VN ctest-vn-72866206 is not found in API Server
2026-06-19 14:02:20,753 - DEBUG - VN ctest-vn-72866206 is not present in Agent 10.0.0.33
2026-06-19 14:02:20,753 - INFO - Validated that VN ctest-vn-72866206 is not in any agent
2026-06-19 14:02:20,767 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-72866206 info
2026-06-19 14:02:21,027 - DEBUG - No XMPP flaps were noticed during the test
2026-06-19 14:02:21,028 - INFO - END TEST : test_basic_policy_allow_deny : PASSED[0:00:40]
2026-06-19 14:02:21,029 - INFO - --------------------------------------------------------------------------------
2026-06-19 14:02:21,758 - INFO - Deleted project: ctest-TestBasicPolicy-15099110, ID : 48fa83c8-0db8-4a94-9f02-baa9338f58d5