is in ACTIVE state now
2025-01-20 02:19:17,418 - INFO - VM name : ctest-fvn_vm1_name-00633200
2025-01-20 02:19:17,519 - DEBUG - VM ctest-fvn_vm1_name-00633200 ID is 17d35987-a463-440e-a3a4-5aca15df8f06
2025-01-20 02:19:17,520 - DEBUG - VM ctest-fvn_vm1_name-00633200 launched on Node cn-jenkins-deploy-platform-ansible-os-2651-1
2025-01-20 02:19:17,612 - DEBUG - Requesting: http://10.0.0.40:8082/virtual-machine/17d35987-a463-440e-a3a4-5aca15df8f06
2025-01-20 02:19:17,626 - DEBUG - Requesting: http://10.0.0.40:8082/virtual-machine-interface/9aac2625-3dda-46d0-896a-a076c65aa62f
2025-01-20 02:19:18,825 - 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=6.05 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=1.10 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 = 1.099/3.574/6.049/2.475 ms')
2025-01-20 02:19:18,825 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-fvn_vm1_name-00633200 passed
2025-01-20 02:19:18,992 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-20 02:19:18,992 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1_name-00633200, IP 71.223.161.195, Port 22
2025-01-20 02:19:19,079 - DEBUG - VM ctest-fvn_vm1_name-00633200 is ready for SSH connections
2025-01-20 02:19:19,256 - INFO - FIP 71.223.161.196 verification for passed on all Control-nodes
2025-01-20 02:19:19,256 - INFO - FIP ID d3d0d9fb-d805-434d-83d3-71945cda8c02(71.223.161.196) validation in Control node passed
2025-01-20 02:19:19,294 - DEBUG - agent_label query returned:{'nh': {'type': 'interface', 'ref_count': '12', 'valid': 'true', 'policy': 'enabled', 'itf': 'tap8b0fe0bf-ad', 'mac': ['2:8b:f:e0:bf:ad'], 'mcast': 'disabled', 'nh_index': '23', '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.5', 'dest_vn_list': ['default-domain:ctest-FloatingipBasicTestSanity-75034157:ctest-fvn-97624998'], '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-01-20 02:19:19,294 - DEBUG - Route for FIP IP 71.223.161.196 is present in agent 10.0.0.40
2025-01-20 02:19:19,294 - DEBUG - FIP 71.223.161.196 verification for VM ctest-vn1_vm1_name-59077994 in Agent 10.0.0.40 passed
2025-01-20 02:19:19,294 - INFO - FIP ID d3d0d9fb-d805-434d-83d3-71945cda8c02(71.223.161.196) validation in agents passed
2025-01-20 02:19:19,294 - DEBUG - Requesting: http://10.0.0.40:8082/floating-ip/d3d0d9fb-d805-434d-83d3-71945cda8c02
2025-01-20 02:19:19,308 - DEBUG - FIP d3d0d9fb-d805-434d-83d3-71945cda8c02 is present in API server
2025-01-20 02:19:19,308 - INFO - FIP ID d3d0d9fb-d805-434d-83d3-71945cda8c02(71.223.161.196) validation in API Server passed
2025-01-20 02:19:19,308 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-20 02:19:19,308 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 71.223.161.195, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.40, gateway password: c0ntrail123
2025-01-20 02:19:19,309 - DEBUG - ping -s 56 -c 3 -W 1 71.223.161.195
2025-01-20 02:19:22,495 - DEBUG - PING 71.223.161.195 (71.223.161.195): 56 data bytes
64 bytes from 71.223.161.195: seq=0 ttl=63 time=4.678 ms
64 bytes from 71.223.161.195: seq=1 ttl=63 time=0.922 ms
64 bytes from 71.223.161.195: seq=2 ttl=63 time=0.844 ms
--- 71.223.161.195 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.844/2.148/4.678 ms
2025-01-20 02:19:22,495 - INFO - Ping to IP 71.223.161.195 from VM ctest-vn1_vm1_name-59077994 passed
2025-01-20 02:19:22,495 - DEBUG - Disassociating port from FIP ID : d3d0d9fb-d805-434d-83d3-71945cda8c02
2025-01-20 02:19:22,550 - DEBUG - Deleting FIP ID d3d0d9fb-d805-434d-83d3-71945cda8c02
2025-01-20 02:19:22,606 - INFO - Deleting the FIP pool ctest-some-pool-26104744
2025-01-20 02:19:22,711 - DEBUG - Control-node Ifmap-view does not have FIP pool ctest-some-pool-26104744 information
2025-01-20 02:19:22,711 - INFO - Deleting VM ctest-fvn_vm1_name-00633200
2025-01-20 02:19:22,792 - INFO - Deleting VM ctest-vn1_vm1_name-59077994
2025-01-20 02:19:22,902 - INFO - Deleting VN ctest-vn1-30997069
2025-01-20 02:19:22,951 - DEBUG - VN c1065bef-7a1b-4c69-a635-f6756b1c60a3 still in use: Unable to complete operation on network c1065bef-7a1b-4c69-a635-f6756b1c60a3. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-66eac4a4-28c4-4cff-946f-e14390955e1b']
2025-01-20 02:19:22,951 - WARNING - Deleting VN ctest-vn1-30997069 failed..Will retry
2025-01-20 02:19:25,083 - DEBUG - Response for deleting network ()
2025-01-20 02:19:25,083 - DEBUG - Requesting: http://10.0.0.40:8082/routing-instance/f919ec7c-8820-4231-b9b6-2f3fcec1fcd2
2025-01-20 02:19:25,095 - DEBUG - Response Code: 404
2025-01-20 02:19:25,095 - DEBUG - Requesting: http://10.0.0.40:8082/domains
2025-01-20 02:19:25,102 - DEBUG - Requesting: http://10.0.0.40:8082/domain/21c3f377-201f-4207-b4ef-b03c1c786541
2025-01-20 02:19:25,163 - DEBUG - Requesting: http://10.0.0.40:8082/project/3df0d02a-0907-44d5-a2a9-6b0da565fd97
2025-01-20 02:19:25,236 - INFO - Validated that VN ctest-vn1-30997069 is not found in API Server
2025-01-20 02:19:25,250 - DEBUG - VN ctest-vn1-30997069 is not present in Agent 10.0.0.40
2025-01-20 02:19:25,250 - INFO - Validated that VN ctest-vn1-30997069 is not in any agent
2025-01-20 02:19:25,269 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-30997069 info
2025-01-20 02:19:25,269 - INFO - Deleting VN ctest-fvn-97624998
2025-01-20 02:19:25,396 - DEBUG - Response for deleting network ()
2025-01-20 02:19:25,396 - DEBUG - Requesting: http://10.0.0.40:8082/routing-instance/47a530ec-cd9e-4a64-8c0e-e30ae9ee8d84
2025-01-20 02:19:25,406 - DEBUG - Response Code: 404
2025-01-20 02:19:25,406 - DEBUG - Requesting: http://10.0.0.40:8082/domains
2025-01-20 02:19:25,414 - DEBUG - Requesting: http://10.0.0.40:8082/domain/21c3f377-201f-4207-b4ef-b03c1c786541
2025-01-20 02:19:25,474 - DEBUG - Requesting: http://10.0.0.40:8082/project/3df0d02a-0907-44d5-a2a9-6b0da565fd97
2025-01-20 02:19:25,555 - INFO - Validated that VN ctest-fvn-97624998 is not found in API Server
2025-01-20 02:19:25,569 - DEBUG - VN ctest-fvn-97624998 is not present in Agent 10.0.0.40
2025-01-20 02:19:25,569 - INFO - Validated that VN ctest-fvn-97624998 is not in any agent
2025-01-20 02:19:25,589 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fvn-97624998 info
2025-01-20 02:19:25,863 - DEBUG - No XMPP flaps were noticed during the test
2025-01-20 02:19:25,863 - INFO - END TEST : test_floating_ip : PASSED[0:00:26]
2025-01-20 02:19:25,863 - INFO - --------------------------------------------------------------------------------
2025-01-20 02:19:26,594 - INFO - Deleted project: ctest-FloatingipBasicTestSanity-75034157, ID : 3df0d02a-0907-44d5-a2a9-6b0da565fd97