is in ACTIVE state now
2025-02-06 02:17:48,865 - INFO - VM name : ctest-fvn_vm1_name-29303960
2025-02-06 02:17:48,952 - DEBUG - VM ctest-fvn_vm1_name-29303960 ID is 5e6f502f-77e3-4eea-8b07-47e166febf50
2025-02-06 02:17:48,953 - DEBUG - VM ctest-fvn_vm1_name-29303960 launched on Node an-jenkins-deploy-platform-ansible-os-2696-1
2025-02-06 02:17:49,033 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/5e6f502f-77e3-4eea-8b07-47e166febf50
2025-02-06 02:17:49,044 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/c6a0c371-2195-4083-b7b0-67d0368792bd
2025-02-06 02:17:50,202 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=3.38 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.277 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.277/1.827/3.378/1.550 ms')
2025-02-06 02:17:50,202 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-fvn_vm1_name-29303960 passed
2025-02-06 02:17:50,312 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-02-06 02:17:50,312 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1_name-29303960, IP 61.0.12.3, Port 22
2025-02-06 02:17:50,381 - DEBUG - VM ctest-fvn_vm1_name-29303960 is ready for SSH connections
2025-02-06 02:17:50,551 - INFO - Route for FIP 61.0.12.4 is fine on Control-node 10.0.0.41
2025-02-06 02:17:50,560 - INFO - Route for FIP 61.0.12.4 is fine on Control-node 10.0.0.38
2025-02-06 02:17:50,568 - INFO - Route for FIP 61.0.12.4 is fine on Control-node 10.0.0.23
2025-02-06 02:17:50,569 - INFO - FIP 61.0.12.4 verification for passed on all Control-nodes
2025-02-06 02:17:50,569 - INFO - FIP ID dc7f2672-ab2d-46f8-ba9e-3dcfa1ddcd66(61.0.12.4) validation in Control node passed
2025-02-06 02:17:50,592 - DEBUG - agent_label query returned:{'nh': {'type': 'tunnel', 'ref_count': '15', 'valid': 'true', 'policy': 'disabled', 'sip': '10.20.0.22', 'dip': '10.20.0.18', 'vrf': 'default-domain:default-project:ip-fabric:__default__', 'mac': ['fa:16:3e:38:5f:cf'], 'tunnel_type': 'MPLSoUDP', 'nh_index': '22', 'vxlan_flag': 'false', 'intf_flags': '0', 'isid': '0', 'learning_enabled': 'false', 'etree_leaf': 'false', 'layer2_control_word': 'false', 'crypt_all_traffic': 'false', 'crypt_path_available': 'false', 'crypt_interface': None}, 'label': '25', 'vxlan_id': '0', 'peer': '10.20.0.10', 'dest_vn_list': ['default-domain:ctest-FloatingipBasicTestSanity-21807850:ctest-fvn-98907874'], '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': '25', '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}
2025-02-06 02:17:50,592 - DEBUG - Route for FIP IP 61.0.12.4 is present in agent 10.0.0.28
2025-02-06 02:17:50,592 - DEBUG - FIP 61.0.12.4 verification for VM ctest-vn1_vm1_name-55104166 in Agent 10.0.0.28 passed
2025-02-06 02:17:50,613 - DEBUG - agent_label query returned:{'nh': {'type': 'interface', 'ref_count': '16', 'valid': 'true', 'policy': 'enabled', 'itf': 'tapab433c62-c6', 'mac': ['2:ab:43:3c:62:c6'], 'mcast': 'disabled', 'nh_index': '31', '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': '25', 'vxlan_id': '0', 'peer': '10.20.0.10', 'dest_vn_list': ['default-domain:ctest-FloatingipBasicTestSanity-21807850:ctest-fvn-98907874'], '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': '25', '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}
2025-02-06 02:17:50,613 - DEBUG - Route for FIP IP 61.0.12.4 is present in agent 10.0.0.65
2025-02-06 02:17:50,614 - DEBUG - FIP 61.0.12.4 verification for VM ctest-vn1_vm1_name-55104166 in Agent 10.0.0.65 passed
2025-02-06 02:17:50,614 - INFO - FIP ID dc7f2672-ab2d-46f8-ba9e-3dcfa1ddcd66(61.0.12.4) validation in agents passed
2025-02-06 02:17:50,614 - DEBUG - Requesting: http://10.0.0.23:8082/floating-ip/dc7f2672-ab2d-46f8-ba9e-3dcfa1ddcd66
2025-02-06 02:17:50,622 - DEBUG - FIP dc7f2672-ab2d-46f8-ba9e-3dcfa1ddcd66 is present in API server
2025-02-06 02:17:50,622 - INFO - FIP ID dc7f2672-ab2d-46f8-ba9e-3dcfa1ddcd66(61.0.12.4) validation in API Server passed
2025-02-06 02:17:50,622 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-02-06 02:17:50,622 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 61.0.12.3, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.65, gateway password: c0ntrail123
2025-02-06 02:17:50,623 - DEBUG - ping -s 56 -c 3 -W 1 61.0.12.3
2025-02-06 02:17:53,457 - DEBUG - PING 61.0.12.3 (61.0.12.3): 56 data bytes
64 bytes from 61.0.12.3: seq=0 ttl=64 time=5.815 ms
64 bytes from 61.0.12.3: seq=1 ttl=64 time=1.007 ms
64 bytes from 61.0.12.3: seq=2 ttl=64 time=0.923 ms
--- 61.0.12.3 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.923/2.581/5.815 ms
2025-02-06 02:17:53,457 - INFO - Ping to IP 61.0.12.3 from VM ctest-vn1_vm1_name-55104166 passed
2025-02-06 02:17:53,457 - DEBUG - Disassociating port from FIP ID : dc7f2672-ab2d-46f8-ba9e-3dcfa1ddcd66
2025-02-06 02:17:53,547 - DEBUG - Deleting FIP ID dc7f2672-ab2d-46f8-ba9e-3dcfa1ddcd66
2025-02-06 02:17:53,643 - INFO - Deleting the FIP pool ctest-some-pool-66804021
2025-02-06 02:17:53,769 - DEBUG - Control-node Ifmap-view does not have FIP pool ctest-some-pool-66804021 information
2025-02-06 02:17:53,775 - DEBUG - Control-node Ifmap-view does not have FIP pool ctest-some-pool-66804021 information
2025-02-06 02:17:53,784 - DEBUG - Control-node Ifmap-view does not have FIP pool ctest-some-pool-66804021 information
2025-02-06 02:17:53,785 - INFO - Deleting VM ctest-fvn_vm1_name-29303960
2025-02-06 02:17:53,874 - INFO - Deleting VM ctest-vn1_vm1_name-55104166
2025-02-06 02:17:53,952 - INFO - Deleting VN ctest-vn1-96493903
2025-02-06 02:17:53,994 - DEBUG - VN f762c846-f86d-4ffb-a2d4-8166cadf9320 still in use: Unable to complete operation on network f762c846-f86d-4ffb-a2d4-8166cadf9320. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-b67225e5-dda7-42fb-94fa-0bf13cd96399']
2025-02-06 02:17:53,994 - WARNING - Deleting VN ctest-vn1-96493903 failed..Will retry
2025-02-06 02:17:56,188 - DEBUG - Response for deleting network ()
2025-02-06 02:17:56,189 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/048d84a0-49a2-4534-883e-e45ae6b97a5c
2025-02-06 02:17:56,195 - DEBUG - Response Code: 404
2025-02-06 02:17:56,196 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-02-06 02:17:56,209 - DEBUG - Requesting: http://10.0.0.23:8082/domain/eaa2de1f-ced4-47cc-99cf-d5f3acfa72fe
2025-02-06 02:17:56,266 - DEBUG - Requesting: http://10.0.0.23:8082/project/e685b0d8-2fac-4aa0-bf5c-0a26fd8fc01a
2025-02-06 02:17:56,369 - INFO - Validated that VN ctest-vn1-96493903 is not found in API Server
2025-02-06 02:17:56,382 - DEBUG - VN ctest-vn1-96493903 is not present in Agent 10.0.0.28
2025-02-06 02:17:56,392 - DEBUG - VN ctest-vn1-96493903 is not present in Agent 10.0.0.65
2025-02-06 02:17:56,392 - INFO - Validated that VN ctest-vn1-96493903 is not in any agent
2025-02-06 02:17:56,424 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-96493903 info
2025-02-06 02:17:56,424 - INFO - Deleting VN ctest-fvn-98907874
2025-02-06 02:17:56,585 - DEBUG - Response for deleting network ()
2025-02-06 02:17:56,585 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/b01d7e4b-c1b0-4b89-a6eb-9ca1cda32b97
2025-02-06 02:17:56,593 - DEBUG - Response Code: 404
2025-02-06 02:17:56,594 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-02-06 02:17:56,600 - DEBUG - Requesting: http://10.0.0.23:8082/domain/eaa2de1f-ced4-47cc-99cf-d5f3acfa72fe
2025-02-06 02:17:56,616 - DEBUG - Requesting: http://10.0.0.23:8082/project/e685b0d8-2fac-4aa0-bf5c-0a26fd8fc01a
2025-02-06 02:17:56,728 - INFO - Validated that VN ctest-fvn-98907874 is not found in API Server
2025-02-06 02:17:56,743 - DEBUG - VN ctest-fvn-98907874 is not present in Agent 10.0.0.28
2025-02-06 02:17:56,754 - DEBUG - VN ctest-fvn-98907874 is not present in Agent 10.0.0.65
2025-02-06 02:17:56,754 - INFO - Validated that VN ctest-fvn-98907874 is not in any agent
2025-02-06 02:17:56,786 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fvn-98907874 info
2025-02-06 02:17:58,060 - DEBUG - No XMPP flaps were noticed during the test
2025-02-06 02:17:58,061 - INFO - END TEST : test_floating_ip : PASSED[0:00:35]
2025-02-06 02:17:58,061 - INFO - --------------------------------------------------------------------------------
2025-02-06 02:17:58,844 - INFO - Deleted project: ctest-FloatingipBasicTestSanity-21807850, ID : e685b0d8-2fac-4aa0-bf5c-0a26fd8fc01a