is in ACTIVE state now
2026-09-14 18:03:11,991 - INFO - VM name : ctest-fvn_vm1_name-84422678
2026-09-14 18:03:12,090 - DEBUG - VM ctest-fvn_vm1_name-84422678 ID is b81c982b-365b-43d0-92e0-21a39f6af748
2026-09-14 18:03:12,090 - DEBUG - VM ctest-fvn_vm1_name-84422678 launched on Node cn-jenkins-deploy-platform-ansible-os-6282-1
2026-09-14 18:03:12,187 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/b81c982b-365b-43d0-92e0-21a39f6af748
2026-09-14 18:03:12,199 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/e2d128ac-9443-4e45-9ea8-493550a39f11
2026-09-14 18:03:13,408 - 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.85 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.574 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.574/2.210/3.846/1.636 ms')
2026-09-14 18:03:13,408 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-fvn_vm1_name-84422678 passed
2026-09-14 18:03:13,564 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-09-14 18:03:13,564 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1_name-84422678, IP 89.0.143.3, Port 22
2026-09-14 18:03:13,656 - DEBUG - VM ctest-fvn_vm1_name-84422678 is ready for SSH connections
2026-09-14 18:03:13,807 - INFO - FIP 89.0.143.4 verification for passed on all Control-nodes
2026-09-14 18:03:13,807 - INFO - FIP ID c48c17d0-6c14-4d3d-9b9e-f262c0a7db3e(89.0.143.4) validation in Control node passed
2026-09-14 18:03:13,833 - DEBUG - agent_label query returned:{'nh': {'type': 'interface', 'ref_count': '12', 'valid': 'true', 'policy': 'enabled', 'itf': 'tap406045b0-b8', 'mac': ['2:40:60:45:b0:b8'], 'mcast': 'disabled', 'nh_index': '27', 'vxlan_flag': 'false', 'intf_flags': '1', 'isid': '0', 'learning_enabled': 'false', 'etree_leaf': 'false', 'layer2_control_word': 'false', 'crypt_all_traffic': 'false', 'crypt_path_available': 'false', 'crypt_interface': None}, 'label': '27', 'vxlan_id': '0', 'peer': '10.20.0.17', 'dest_vn_list': ['default-domain:ctest-FloatingipBasicTestSanity-64178052:ctest-fvn-62572325'], 'unresolved': 'false', 'sg_list': ['8000004'], 'supported_tunnel_type': 'MPLSoGRE MPLSoUDP ', 'active_tunnel_type': 'MPLSoUDP', 'stale': 'false', 'path_preference_data': {'sequence': '0', 'preference': '200', 'ecmp': 'true'}, 'active_label': '27', 'ecmp_hashing_fields': 'l3-source-address,l3-destination-address,l4-protocol,l4-source-port,l4-destination-port,', 'communities': None, 'peer_sequence_number': '1', 'etree_leaf': 'false', 'layer2_control_word': 'false', 'tag_list': None, 'inactive': 'false', 'origin_vn': None}
2026-09-14 18:03:13,834 - DEBUG - Route for FIP IP 89.0.143.4 is present in agent 10.0.0.50
2026-09-14 18:03:13,834 - DEBUG - FIP 89.0.143.4 verification for VM ctest-vn1_vm1_name-11403453 in Agent 10.0.0.50 passed
2026-09-14 18:03:13,834 - INFO - FIP ID c48c17d0-6c14-4d3d-9b9e-f262c0a7db3e(89.0.143.4) validation in agents passed
2026-09-14 18:03:13,834 - DEBUG - Requesting: http://10.0.0.50:8082/floating-ip/c48c17d0-6c14-4d3d-9b9e-f262c0a7db3e
2026-09-14 18:03:13,846 - DEBUG - FIP c48c17d0-6c14-4d3d-9b9e-f262c0a7db3e is present in API server
2026-09-14 18:03:13,846 - INFO - FIP ID c48c17d0-6c14-4d3d-9b9e-f262c0a7db3e(89.0.143.4) validation in API Server passed
2026-09-14 18:03:13,846 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-09-14 18:03:13,846 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 89.0.143.3, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2026-09-14 18:03:13,847 - DEBUG - ping -s 56 -c 3 -W 1 89.0.143.3
2026-09-14 18:03:16,963 - DEBUG - PING 89.0.143.3 (89.0.143.3): 56 data bytes
64 bytes from 89.0.143.3: seq=0 ttl=63 time=5.641 ms
64 bytes from 89.0.143.3: seq=1 ttl=63 time=1.400 ms
64 bytes from 89.0.143.3: seq=2 ttl=63 time=1.373 ms
--- 89.0.143.3 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.373/2.804/5.641 ms
2026-09-14 18:03:16,963 - INFO - Ping to IP 89.0.143.3 from VM ctest-vn1_vm1_name-11403453 passed
2026-09-14 18:03:16,964 - DEBUG - Disassociating port from FIP ID : c48c17d0-6c14-4d3d-9b9e-f262c0a7db3e
2026-09-14 18:03:17,033 - DEBUG - Deleting FIP ID c48c17d0-6c14-4d3d-9b9e-f262c0a7db3e
2026-09-14 18:03:17,103 - INFO - Deleting the FIP pool ctest-some-pool-25272149
2026-09-14 18:03:17,211 - DEBUG - Control-node Ifmap-view does not have FIP pool ctest-some-pool-25272149 information
2026-09-14 18:03:17,211 - INFO - Deleting VM ctest-fvn_vm1_name-84422678
2026-09-14 18:03:17,296 - INFO - Deleting VM ctest-vn1_vm1_name-11403453
2026-09-14 18:03:17,382 - INFO - Deleting VN ctest-vn1-22097162
2026-09-14 18:03:17,423 - DEBUG - VN cdd3435e-658b-4cbc-8082-8dc32c26bbd1 still in use: Unable to complete operation on network cdd3435e-658b-4cbc-8082-8dc32c26bbd1. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-d37d8fa1-e01e-4477-89a6-5ea026d28b31']
2026-09-14 18:03:17,423 - WARNING - Deleting VN ctest-vn1-22097162 failed..Will retry
2026-09-14 18:03:19,508 - DEBUG - VN cdd3435e-658b-4cbc-8082-8dc32c26bbd1 still in use: Unable to complete operation on network cdd3435e-658b-4cbc-8082-8dc32c26bbd1. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-fae1687d-f3e6-439d-abcf-c32e4dffbcc6']
2026-09-14 18:03:19,508 - WARNING - Deleting VN ctest-vn1-22097162 failed..Will retry
2026-09-14 18:03:21,647 - DEBUG - Response for deleting network ()
2026-09-14 18:03:21,647 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/a7a2cfd8-94d3-4623-b300-c9377247040d
2026-09-14 18:03:21,653 - DEBUG - Response Code: 404
2026-09-14 18:03:21,653 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2026-09-14 18:03:21,660 - DEBUG - Requesting: http://10.0.0.50:8082/domain/1f147e5b-d4e7-46bd-855b-7eae0a98705d
2026-09-14 18:03:21,727 - DEBUG - Requesting: http://10.0.0.50:8082/project/b6b25dc8-ca4b-4209-8c0a-d5b447276bc9
2026-09-14 18:03:21,819 - INFO - Validated that VN ctest-vn1-22097162 is not found in API Server
2026-09-14 18:03:21,836 - DEBUG - VN ctest-vn1-22097162 is not present in Agent 10.0.0.50
2026-09-14 18:03:21,836 - INFO - Validated that VN ctest-vn1-22097162 is not in any agent
2026-09-14 18:03:21,857 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-22097162 info
2026-09-14 18:03:21,857 - INFO - Deleting VN ctest-fvn-62572325
2026-09-14 18:03:21,998 - DEBUG - Response for deleting network ()
2026-09-14 18:03:21,998 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/5bd82c30-b8d4-4f73-8cdf-99de2d340b3d
2026-09-14 18:03:22,012 - DEBUG - Response Code: 404
2026-09-14 18:03:22,012 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2026-09-14 18:03:22,019 - DEBUG - Requesting: http://10.0.0.50:8082/domain/1f147e5b-d4e7-46bd-855b-7eae0a98705d
2026-09-14 18:03:22,074 - DEBUG - Requesting: http://10.0.0.50:8082/project/b6b25dc8-ca4b-4209-8c0a-d5b447276bc9
2026-09-14 18:03:22,160 - INFO - Validated that VN ctest-fvn-62572325 is not found in API Server
2026-09-14 18:03:22,174 - DEBUG - VN ctest-fvn-62572325 is not present in Agent 10.0.0.50
2026-09-14 18:03:22,174 - INFO - Validated that VN ctest-fvn-62572325 is not in any agent
2026-09-14 18:03:22,194 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fvn-62572325 info
2026-09-14 18:03:22,455 - DEBUG - No XMPP flaps were noticed during the test
2026-09-14 18:03:22,455 - INFO - END TEST : test_floating_ip : PASSED[0:01:03]
2026-09-14 18:03:22,455 - INFO - --------------------------------------------------------------------------------
2026-09-14 18:03:23,238 - INFO - Deleted project: ctest-FloatingipBasicTestSanity-64178052, ID : b6b25dc8-ca4b-4209-8c0a-d5b447276bc9