2025-10-30 03:27:03,522 - INFO - Domain Default found not creating
2025-10-30 03:27:03,667 - INFO - Project ctest-DisablePolicyEcmpIpv6-68363638 not found, creating it
2025-10-30 03:27:04,176 - INFO - Created Project:ctest-DisablePolicyEcmpIpv6-68363638, ID : 414da9af-65ef-4eca-9fc8-4e363348bd6f
2025-10-30 03:27:05,696 - INFO - ================================================================================
2025-10-30 03:27:05,696 - INFO - STARTING TEST : test_ecmp_with_static_routes
2025-10-30 03:27:05,696 - INFO - TEST DESCRIPTION :
Description: Verify disabling policy for ECMP routes with static routes on VM
Steps:
1. launch 1 VN and launch 3 VMs in it.
2. create a static route for a new subnet prefix and add this on 2 VMIs.
this will create 2 ECMP routes.
3. Disable the policy on all VMIs.
4. Now from 3rd VM send traffic to an IP from static route prefix
5. add new ECMP destinations and verify load is distributed to new destinations too
6. remove ECMP destinations and verify load is distributed to remaining destinations
Pass criteria:
1. traffic should go through fine
2. flows should not be created
3. load should be distributed among ecmp routes.
2025-10-30 03:27:06,996 - DEBUG - Nothing to compare xmpp stats {'10.0.0.129': {'10.20.0.131': '0', '10.20.0.254': '0'}, '10.0.0.65': {'10.20.0.254': '0', '10.20.0.131': '0'}} with
2025-10-30 03:27:06,996 - INFO - Address family configured is dual
2025-10-30 03:27:06,996 - INFO - we are setting address family as v6
2025-10-30 03:27:06,996 - INFO - we are setting address family as v6
2025-10-30 03:27:06,996 - INFO - Initial checks done. Running the testcase now
2025-10-30 03:27:06,996 - INFO -
2025-10-30 03:27:07,021 - DEBUG - Services list from nova: [, , , ]
2025-10-30 03:27:07,021 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-4535-2', 'an-jenkins-deploy-platform-ansible-os-4535-1']}
2025-10-30 03:27:07,741 - DEBUG - Response for create_network : {'network': {'id': 'a2fce4c3-00f2-47d4-8d40-473c388768e3', 'name': 'ctest-vn-74880512', 'tenant_id': '414da9af65ef4eca9fc84e363348bd6f', 'project_id': '414da9af65ef4eca9fc84e363348bd6f', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-DisablePolicyEcmpIpv6-68363638', 'ctest-vn-74880512'], 'port_security_enabled': True, 'description': ''}}
2025-10-30 03:27:08,075 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a9f1c2e6-084a-4b4c-95e8-9e39b214bc0d', 'name': '', 'tenant_id': '414da9af65ef4eca9fc84e363348bd6f', 'network_id': 'a2fce4c3-00f2-47d4-8d40-473c388768e3', 'ip_version': 6, 'cidr': '3f62:ae8f:58f6:f3d:39d3:a166::/96', 'allocation_pools': [{'start': '3f62:ae8f:58f6:f3d:39d3:a166:0:2', 'end': '3f62:ae8f:58f6:f3d:39d3:a166:ffff:fffe'}], 'gateway_ip': '3f62:ae8f:58f6:f3d:39d3:a166:0:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '3f62:ae8f:58f6:f3d:39d3:a166:0:2', 'tags': [], 'project_id': '414da9af65ef4eca9fc84e363348bd6f'}}
2025-10-30 03:27:08,355 - DEBUG - Response for create_subnet : {'subnet': {'id': '93f6812c-edca-4f42-8acc-6c55f7064872', 'name': '', 'tenant_id': '414da9af65ef4eca9fc84e363348bd6f', 'network_id': 'a2fce4c3-00f2-47d4-8d40-473c388768e3', 'ip_version': 4, 'cidr': '73.171.220.0/26', 'allocation_pools': [{'start': '73.171.220.2', 'end': '73.171.220.62'}], 'gateway_ip': '73.171.220.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '73.171.220.2', 'tags': [], 'project_id': '414da9af65ef4eca9fc84e363348bd6f'}}
2025-10-30 03:27:08,382 - INFO - Created VN ctest-vn-74880512
2025-10-30 03:27:08,394 - DEBUG - VN ctest-vn-74880512 UUID is a2fce4c3-00f2-47d4-8d40-473c388768e3
2025-10-30 03:27:08,500 - DEBUG - Requesting: http://10.0.0.242:8082/domains
2025-10-30 03:27:08,803 - DEBUG - Requesting: http://10.0.0.242:8082/domains
2025-10-30 03:27:08,836 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f
2025-10-30 03:27:08,856 - DEBUG - Requesting: http://10.0.0.242:8082/project/414da9af-65ef-4eca-9fc8-4e363348bd6f
2025-10-30 03:27:08,953 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/a2fce4c3-00f2-47d4-8d40-473c388768e3
2025-10-30 03:27:08,965 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/a2fce4c3-00f2-47d4-8d40-473c388768e3
2025-10-30 03:27:08,974 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/29be58be-722d-4f9a-a09e-ca20a5e2c341
2025-10-30 03:27:08,983 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/29be58be-722d-4f9a-a09e-ca20a5e2c341
2025-10-30 03:27:08,992 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/6020749f-9b5f-4d00-bdf3-d4cd3f697d18
2025-10-30 03:27:09,000 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-30 03:27:09,000 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/a2fce4c3-00f2-47d4-8d40-473c388768e3
2025-10-30 03:27:09,010 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/29be58be-722d-4f9a-a09e-ca20a5e2c341
2025-10-30 03:27:09,032 - INFO - Verified VN network id 13 for VN a2fce4c3-00f2-47d4-8d40-473c388768e3
2025-10-30 03:27:09,032 - INFO - Verifications in API Server for VN ctest-vn-74880512 passed
2025-10-30 03:27:09,032 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/a2fce4c3-00f2-47d4-8d40-473c388768e3
2025-10-30 03:27:09,044 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/29be58be-722d-4f9a-a09e-ca20a5e2c341
2025-10-30 03:27:09,052 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/29be58be-722d-4f9a-a09e-ca20a5e2c341
2025-10-30 03:27:09,061 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/6020749f-9b5f-4d00-bdf3-d4cd3f697d18
2025-10-30 03:27:09,074 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-DisablePolicyEcmpIpv6-68363638', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11744513454461044692', 'uuid-lslong': '10178213481829329123'}, 'enable': 'true', 'created': '2025-10-30T03:27:07', 'last-modified': '2025-10-30T03:27:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.790046'}
2025-10-30 03:27:09,081 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-30 03:27:09,086 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-DisablePolicyEcmpIpv6-68363638', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11744513454461044692', 'uuid-lslong': '10178213481829329123'}, 'enable': 'true', 'created': '2025-10-30T03:27:07', 'last-modified': '2025-10-30T03:27:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.809614'}
2025-10-30 03:27:09,093 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-30 03:27:09,100 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-DisablePolicyEcmpIpv6-68363638', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11744513454461044692', 'uuid-lslong': '10178213481829329123'}, 'enable': 'true', 'created': '2025-10-30T03:27:07', 'last-modified': '2025-10-30T03:27:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.821567'}
2025-10-30 03:27:09,108 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-30 03:27:09,108 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn-74880512 passed
2025-10-30 03:27:09,108 - DEBUG - ====Verifying policy data for ctest-vn-74880512 in API_Server ======
2025-10-30 03:27:09,108 - DEBUG - Requesting: http://10.0.0.242:8082/domains
2025-10-30 03:27:09,116 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f
2025-10-30 03:27:09,130 - DEBUG - Requesting: http://10.0.0.242:8082/project/414da9af-65ef-4eca-9fc8-4e363348bd6f
2025-10-30 03:27:09,239 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/a2fce4c3-00f2-47d4-8d40-473c388768e3
2025-10-30 03:27:09,252 - DEBUG - =>VN ctest-vn-74880512 has no policy to be verified
2025-10-30 03:27:09,252 - DEBUG - Verifying the vn in opserver
2025-10-30 03:27:09,252 - DEBUG - Verifying the default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 virtual network link through opserver 10.0.0.242
2025-10-30 03:27:09,252 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2025-10-30 03:27:09,549 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2025-10-30 03:27:09,611 - DEBUG - vn link and name as {'name': 'default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512?flat'}
2025-10-30 03:27:09,611 - DEBUG - Verifying the default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 virtual network link through opserver 10.0.0.254
2025-10-30 03:27:09,611 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-10-30 03:27:09,912 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-10-30 03:27:09,971 - DEBUG - vn link and name as {'name': 'default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512?flat'}
2025-10-30 03:27:09,971 - DEBUG - Verifying the default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 virtual network link through opserver 10.0.0.240
2025-10-30 03:27:09,971 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2025-10-30 03:27:10,281 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2025-10-30 03:27:10,366 - DEBUG - vn link and name as {'name': 'default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512?flat'}
2025-10-30 03:27:10,366 - INFO - Validated that VN default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is found in opserver
2025-10-30 03:27:10,398 - DEBUG - Do not have enough data to verify VN in agent
2025-10-30 03:27:10,409 - DEBUG - VRF ids for VN ctest-vn-74880512: {}
2025-10-30 03:27:10,409 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-4535-2', 'an-jenkins-deploy-platform-ansible-os-4535-1']}
2025-10-30 03:27:11,637 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4535-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4535-2)
2025-10-30 03:27:11,637 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-4535-2', 'an-jenkins-deploy-platform-ansible-os-4535-1']}
2025-10-30 03:27:13,033 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4535-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4535-1)
2025-10-30 03:27:14,573 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4535-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4535-1)
2025-10-30 03:27:14,573 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-4535-2', 'an-jenkins-deploy-platform-ansible-os-4535-1']}
2025-10-30 03:27:16,112 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4535-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4535-2)
2025-10-30 03:27:16,112 - INFO - Waiting for VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 to be up..
2025-10-30 03:27:16,226 - DEBUG - VM is in ACTIVE state now
2025-10-30 03:27:16,226 - INFO - VM name : ctest-DisablePolicyEcmpIpv6-68363638-04637086
2025-10-30 03:27:16,325 - DEBUG - VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 ID is 5bb5a7d7-2466-404d-ba24-65bbff3bafc1
2025-10-30 03:27:16,325 - DEBUG - VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 launched on Node an-jenkins-deploy-platform-ansible-os-4535-1
2025-10-30 03:27:16,427 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine/5bb5a7d7-2466-404d-ba24-65bbff3bafc1
2025-10-30 03:27:16,937 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine/5bb5a7d7-2466-404d-ba24-65bbff3bafc1
2025-10-30 03:27:16,995 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine-interface/ae6138d2-e376-4552-af9d-8f0aedd68997
2025-10-30 03:27:20,173 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1002ms')
2025-10-30 03:27:20,173 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 failed!
2025-10-30 03:27:20,188 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 3f62:ae8f:58f6:f3d:39d3:a166:0:1 and allocation pool is NOT set
2025-10-30 03:27:20,188 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 73.171.220.1 and allocation pool is NOT set
2025-10-30 03:27:24,268 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1012ms')
2025-10-30 03:27:24,268 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 failed!
2025-10-30 03:27:24,285 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 3f62:ae8f:58f6:f3d:39d3:a166:0:1 and allocation pool is NOT set
2025-10-30 03:27:24,285 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 73.171.220.1 and allocation pool is NOT set
2025-10-30 03:27:28,367 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1011ms')
2025-10-30 03:27:28,368 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 failed!
2025-10-30 03:27:28,386 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 3f62:ae8f:58f6:f3d:39d3:a166:0:1 and allocation pool is NOT set
2025-10-30 03:27:28,387 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 73.171.220.1 and allocation pool is NOT set
2025-10-30 03:27:32,453 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1005ms')
2025-10-30 03:27:32,453 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 failed!
2025-10-30 03:27:32,468 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 3f62:ae8f:58f6:f3d:39d3:a166:0:1 and allocation pool is NOT set
2025-10-30 03:27:32,468 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 73.171.220.1 and allocation pool is NOT set
2025-10-30 03:27:36,557 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1021ms')
2025-10-30 03:27:36,557 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 failed!
2025-10-30 03:27:36,572 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 3f62:ae8f:58f6:f3d:39d3:a166:0:1 and allocation pool is NOT set
2025-10-30 03:27:36,573 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 73.171.220.1 and allocation pool is NOT set
2025-10-30 03:27:40,652 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1015ms')
2025-10-30 03:27:40,653 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 failed!
2025-10-30 03:27:40,667 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 3f62:ae8f:58f6:f3d:39d3:a166:0:1 and allocation pool is NOT set
2025-10-30 03:27:40,667 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 73.171.220.1 and allocation pool is NOT set
2025-10-30 03:27:44,753 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1023ms')
2025-10-30 03:27:44,753 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 failed!
2025-10-30 03:27:44,773 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 3f62:ae8f:58f6:f3d:39d3:a166:0:1 and allocation pool is NOT set
2025-10-30 03:27:44,773 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 73.171.220.1 and allocation pool is NOT set
2025-10-30 03:27:48,840 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1007ms')
2025-10-30 03:27:48,840 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 failed!
2025-10-30 03:27:48,858 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 3f62:ae8f:58f6:f3d:39d3:a166:0:1 and allocation pool is NOT set
2025-10-30 03:27:48,858 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 73.171.220.1 and allocation pool is NOT set
2025-10-30 03:27:52,941 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms')
2025-10-30 03:27:52,942 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 failed!
2025-10-30 03:27:52,959 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 3f62:ae8f:58f6:f3d:39d3:a166:0:1 and allocation pool is NOT set
2025-10-30 03:27:52,959 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 73.171.220.1 and allocation pool is NOT set
2025-10-30 03:27:57,029 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1015ms')
2025-10-30 03:27:57,029 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 failed!
2025-10-30 03:27:57,045 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 3f62:ae8f:58f6:f3d:39d3:a166:0:1 and allocation pool is NOT set
2025-10-30 03:27:57,045 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 73.171.220.1 and allocation pool is NOT set
2025-10-30 03:28:01,128 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1023ms')
2025-10-30 03:28:01,128 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 failed!
2025-10-30 03:28:01,144 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 3f62:ae8f:58f6:f3d:39d3:a166:0:1 and allocation pool is NOT set
2025-10-30 03:28:01,144 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 73.171.220.1 and allocation pool is NOT set
2025-10-30 03:28:05,225 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1023ms')
2025-10-30 03:28:05,225 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 failed!
2025-10-30 03:28:05,242 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 3f62:ae8f:58f6:f3d:39d3:a166:0:1 and allocation pool is NOT set
2025-10-30 03:28:05,242 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 73.171.220.1 and allocation pool is NOT set
2025-10-30 03:28:09,321 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1018ms')
2025-10-30 03:28:09,321 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 failed!
2025-10-30 03:28:09,340 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 3f62:ae8f:58f6:f3d:39d3:a166:0:1 and allocation pool is NOT set
2025-10-30 03:28:09,340 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 73.171.220.1 and allocation pool is NOT set
2025-10-30 03:28:13,421 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms')
2025-10-30 03:28:13,422 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 failed!
2025-10-30 03:28:13,437 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 3f62:ae8f:58f6:f3d:39d3:a166:0:1 and allocation pool is NOT set
2025-10-30 03:28:13,437 - DEBUG - Gateway for vn default-domain:ctest-DisablePolicyEcmpIpv6-68363638:ctest-vn-74880512 is 73.171.220.1 and allocation pool is NOT set
2025-10-30 03:28:15,506 - 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=12.1 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=3.69 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 = 3.690/7.893/12.096/4.203 ms')
2025-10-30 03:28:15,506 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 passed
2025-10-30 03:28:15,573 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-30 03:28:15,573 - DEBUG - Waiting to SSH to VM ctest-DisablePolicyEcmpIpv6-68363638-04637086, IP 3f62:ae8f:58f6:f3d:39d3:a166:0:4, Port 22
2025-10-30 03:28:15,642 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-10-30 03:28:15,733 - DEBUG - VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 is NOT ready for SSH connections, VM status: ACTIVE
2025-10-30 03:28:20,734 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-30 03:28:20,734 - DEBUG - Waiting to SSH to VM ctest-DisablePolicyEcmpIpv6-68363638-04637086, IP 3f62:ae8f:58f6:f3d:39d3:a166:0:4, Port 22
2025-10-30 03:28:20,802 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-10-30 03:28:20,885 - DEBUG - VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 is NOT ready for SSH connections, VM status: ACTIVE
2025-10-30 03:28:25,886 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-30 03:28:25,886 - DEBUG - Waiting to SSH to VM ctest-DisablePolicyEcmpIpv6-68363638-04637086, IP 3f62:ae8f:58f6:f3d:39d3:a166:0:4, Port 22
2025-10-30 03:28:25,954 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-10-30 03:28:26,038 - DEBUG - VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 is NOT ready for SSH connections, VM status: ACTIVE
2025-10-30 03:28:31,038 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-30 03:28:31,039 - DEBUG - Waiting to SSH to VM ctest-DisablePolicyEcmpIpv6-68363638-04637086, IP 3f62:ae8f:58f6:f3d:39d3:a166:0:4, Port 22
2025-10-30 03:28:31,106 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-10-30 03:28:31,192 - DEBUG - VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 is NOT ready for SSH connections, VM status: ACTIVE
2025-10-30 03:28:36,193 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-30 03:28:36,193 - DEBUG - Waiting to SSH to VM ctest-DisablePolicyEcmpIpv6-68363638-04637086, IP 3f62:ae8f:58f6:f3d:39d3:a166:0:4, Port 22
2025-10-30 03:28:36,259 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-10-30 03:28:36,355 - DEBUG - VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 is NOT ready for SSH connections, VM status: ACTIVE
2025-10-30 03:28:41,356 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-30 03:28:41,356 - DEBUG - Waiting to SSH to VM ctest-DisablePolicyEcmpIpv6-68363638-04637086, IP 3f62:ae8f:58f6:f3d:39d3:a166:0:4, Port 22
2025-10-30 03:28:41,512 - DEBUG - VM ctest-DisablePolicyEcmpIpv6-68363638-04637086 is ready for SSH connections
2025-10-30 03:28:41,512 - INFO - Waiting for VM ctest-DisablePolicyEcmpIpv6-68363638-57246092 to be up..
2025-10-30 03:28:41,605 - DEBUG - VM is in ACTIVE state now
2025-10-30 03:28:41,605 - INFO - VM name : ctest-DisablePolicyEcmpIpv6-68363638-57246092
2025-10-30 03:28:41,695 - DEBUG - VM ctest-DisablePolicyEcmpIpv6-68363638-57246092 ID is 161cbbb1-3893-4103-960d-8dfada93a64a
2025-10-30 03:28:41,696 - DEBUG - VM ctest-DisablePolicyEcmpIpv6-68363638-57246092 launched on Node an-jenkins-deploy-platform-ansible-os-4535-1
2025-10-30 03:28:41,793 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine/161cbbb1-3893-4103-960d-8dfada93a64a
2025-10-30 03:28:41,805 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine-interface/7dbf6f47-2ae8-4959-8a85-00e6f9945be5
2025-10-30 03:28:42,978 - 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=4.52 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=3.85 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.847/4.181/4.515/0.334 ms')
2025-10-30 03:28:42,978 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-DisablePolicyEcmpIpv6-68363638-57246092 passed
2025-10-30 03:28:43,050 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-30 03:28:43,050 - DEBUG - Waiting to SSH to VM ctest-DisablePolicyEcmpIpv6-68363638-57246092, IP 3f62:ae8f:58f6:f3d:39d3:a166:0:5, Port 22
2025-10-30 03:28:43,219 - DEBUG - VM ctest-DisablePolicyEcmpIpv6-68363638-57246092 is ready for SSH connections
2025-10-30 03:28:43,220 - INFO - Waiting for VM ctest-DisablePolicyEcmpIpv6-68363638-99061260 to be up..
2025-10-30 03:28:43,318 - DEBUG - VM is in ACTIVE state now
2025-10-30 03:28:43,319 - INFO - VM name : ctest-DisablePolicyEcmpIpv6-68363638-99061260
2025-10-30 03:28:43,402 - DEBUG - VM ctest-DisablePolicyEcmpIpv6-68363638-99061260 ID is 9d186ca4-4e31-4d9a-8478-aa807aac55bf
2025-10-30 03:28:43,402 - DEBUG - VM ctest-DisablePolicyEcmpIpv6-68363638-99061260 launched on Node an-jenkins-deploy-platform-ansible-os-4535-2
2025-10-30 03:28:43,487 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine/9d186ca4-4e31-4d9a-8478-aa807aac55bf
2025-10-30 03:28:43,508 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine-interface/9a0693e7-658b-44ed-b9be-41ed69206b3e
2025-10-30 03:28:44,665 - 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.26 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.12 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 = 1.122/2.188/3.255/1.066 ms')
2025-10-30 03:28:44,665 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-DisablePolicyEcmpIpv6-68363638-99061260 passed
2025-10-30 03:28:44,733 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-30 03:28:44,733 - DEBUG - Waiting to SSH to VM ctest-DisablePolicyEcmpIpv6-68363638-99061260, IP 3f62:ae8f:58f6:f3d:39d3:a166:0:3, Port 22
2025-10-30 03:28:44,900 - DEBUG - VM ctest-DisablePolicyEcmpIpv6-68363638-99061260 is ready for SSH connections
2025-10-30 03:28:44,900 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-30 03:28:44,900 - DEBUG - Running remote_cmd, Cmd : ifconfig -a| grep 3f62:ae8f:58f6:f3d:39d3:a166:0:4 -A2 -B4| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.129, gateway password: c0ntrail123
2025-10-30 03:28:44,901 - DEBUG - ifconfig -a| grep 3f62:ae8f:58f6:f3d:39d3:a166:0:4 -A2 -B4| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1
2025-10-30 03:29:05,502 - DEBUG - eth0
2025-10-30 03:29:05,502 - DEBUG - Running remote_cmd, Cmd : sysctl net.ipv6.conf.eth0.accept_dad=0, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.129, gateway password: c0ntrail123
2025-10-30 03:29:05,502 - DEBUG - sysctl net.ipv6.conf.eth0.accept_dad=0
2025-10-30 03:29:06,069 - DEBUG - net.ipv6.conf.eth0.accept_dad = 0
2025-10-30 03:29:06,316 - INFO - Created InterfaceRouteTable ['default-domain', 'ctest-DisablePolicyEcmpIpv6-68363638', 'ctest-intf-rtb-99238604'](UUID 1e57b298-a51c-46c9-b537-9fb6bbd93434), prefixes : ['2fc1:34a1:735a:3f46:6bb7:bd07::/96']
2025-10-30 03:29:06,388 - INFO - Added intf route table 1e57b298-a51c-46c9-b537-9fb6bbd93434 to port ae6138d2-e376-4552-af9d-8f0aedd68997
2025-10-30 03:29:06,389 - DEBUG - Running remote_cmd, Cmd : ifconfig -a| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.129, gateway password: c0ntrail123
2025-10-30 03:29:06,389 - DEBUG - ifconfig -a| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1
2025-10-30 03:29:06,863 - DEBUG - eth0
2025-10-30 03:29:06,863 - DEBUG - Running remote_cmd, Cmd : ifconfig eth0 inet6 add 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.129, gateway password: c0ntrail123
2025-10-30 03:29:06,863 - DEBUG - ifconfig eth0 inet6 add 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b
2025-10-30 03:29:07,404 - DEBUG - None
2025-10-30 03:29:07,405 - DEBUG - Running remote_cmd, Cmd : ifconfig -a, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.129, gateway password: c0ntrail123
2025-10-30 03:29:07,405 - DEBUG - ifconfig -a
2025-10-30 03:29:07,954 - DEBUG - eth0 Link encap:Ethernet HWaddr 02:ae:61:38:d2:e3
inet addr:73.171.220.4 Bcast:73.171.220.63 Mask:255.255.255.192
inet6 addr: fe80::ae:61ff:fe38:d2e3/64 Scope:Link
inet6 addr: 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b/128 Scope:Global
inet6 addr: 3f62:ae8f:58f6:f3d:39d3:a166:0:4/64 Scope:Global
UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
RX packets:482 errors:0 dropped:0 overruns:0 frame:0
TX packets:363 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:1000
RX bytes:46643 (46.6 KB) TX bytes:34202 (34.2 KB)
lo Link encap:Local Loopback
inet addr:127.0.0.1 Mask:255.0.0.0
inet6 addr: ::1/128 Scope:Host
UP LOOPBACK RUNNING MTU:16436 Metric:1
RX packets:0 errors:0 dropped:0 overruns:0 frame:0
TX packets:0 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:0
RX bytes:0 (0.0 B) TX bytes:0 (0.0 B)
2025-10-30 03:29:07,954 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-30 03:29:07,954 - DEBUG - Running remote_cmd, Cmd : ifconfig -a| grep 3f62:ae8f:58f6:f3d:39d3:a166:0:5 -A2 -B4| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.129, gateway password: c0ntrail123
2025-10-30 03:29:07,954 - DEBUG - ifconfig -a| grep 3f62:ae8f:58f6:f3d:39d3:a166:0:5 -A2 -B4| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1
2025-10-30 03:29:52,271 - DEBUG - eth0
2025-10-30 03:29:52,271 - DEBUG - Running remote_cmd, Cmd : sysctl net.ipv6.conf.eth0.accept_dad=0, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.129, gateway password: c0ntrail123
2025-10-30 03:29:52,271 - DEBUG - sysctl net.ipv6.conf.eth0.accept_dad=0
2025-10-30 03:29:52,865 - DEBUG - net.ipv6.conf.eth0.accept_dad = 0
2025-10-30 03:29:53,109 - INFO - Created InterfaceRouteTable ['default-domain', 'ctest-DisablePolicyEcmpIpv6-68363638', 'ctest-intf-rtb-36140543'](UUID 785d3250-c112-43d1-a87f-837c7d045b52), prefixes : ['2fc1:34a1:735a:3f46:6bb7:bd07::/96']
2025-10-30 03:29:53,181 - INFO - Added intf route table 785d3250-c112-43d1-a87f-837c7d045b52 to port 7dbf6f47-2ae8-4959-8a85-00e6f9945be5
2025-10-30 03:29:53,181 - DEBUG - Running remote_cmd, Cmd : ifconfig -a| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.129, gateway password: c0ntrail123
2025-10-30 03:29:53,181 - DEBUG - ifconfig -a| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1
2025-10-30 03:29:53,652 - DEBUG - eth0
2025-10-30 03:29:53,652 - DEBUG - Running remote_cmd, Cmd : ifconfig eth0 inet6 add 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.129, gateway password: c0ntrail123
2025-10-30 03:29:53,652 - DEBUG - ifconfig eth0 inet6 add 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b
2025-10-30 03:29:54,208 - DEBUG - None
2025-10-30 03:29:54,208 - DEBUG - Running remote_cmd, Cmd : ifconfig -a, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.129, gateway password: c0ntrail123
2025-10-30 03:29:54,208 - DEBUG - ifconfig -a
2025-10-30 03:29:54,786 - DEBUG - eth0 Link encap:Ethernet HWaddr 02:7d:bf:6f:47:2a
inet addr:73.171.220.5 Bcast:73.171.220.63 Mask:255.255.255.192
inet6 addr: fe80::7d:bfff:fe6f:472a/64 Scope:Link
inet6 addr: 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b/128 Scope:Global
inet6 addr: 3f62:ae8f:58f6:f3d:39d3:a166:0:5/64 Scope:Global
UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
RX packets:480 errors:0 dropped:0 overruns:0 frame:0
TX packets:413 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:1000
RX bytes:45539 (45.5 KB) TX bytes:37616 (37.6 KB)
lo Link encap:Local Loopback
inet addr:127.0.0.1 Mask:255.0.0.0
inet6 addr: ::1/128 Scope:Host
UP LOOPBACK RUNNING MTU:16436 Metric:1
RX packets:0 errors:0 dropped:0 overruns:0 frame:0
TX packets:0 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:0
RX bytes:0 (0.0 B) TX bytes:0 (0.0 B)
2025-10-30 03:29:54,856 - INFO - Policy DISABLED on VMI 9a0693e7-658b-44ed-b9be-41ed69206b3e
2025-10-30 03:29:54,932 - INFO - Policy DISABLED on VMI ae6138d2-e376-4552-af9d-8f0aedd68997
2025-10-30 03:29:55,012 - INFO - Policy DISABLED on VMI 7dbf6f47-2ae8-4959-8a85-00e6f9945be5
2025-10-30 03:29:55,028 - INFO - ECMP routes found in agent 10.0.0.129, for prefix 2fc1:34a1:735a:3f46:6bb7:bd07::/96
2025-10-30 03:29:55,028 - INFO - Tap interface tapae6138d2-e3 found in ecmp routes in agent 10.0.0.129
2025-10-30 03:29:55,029 - INFO - Tap interface tap7dbf6f47-2a found in ecmp routes in agent 10.0.0.129
2025-10-30 03:29:55,043 - INFO - ECMP routes found in agent 10.0.0.129, for prefix 2fc1:34a1:735a:3f46:6bb7:bd07::/96
2025-10-30 03:29:55,129 - DEBUG - Executing command: sudo tcpdump -nni tapae6138d2-e3 -U '(udp and src host 3f62:ae8f:58f6:f3d:39d3:a166:0:3 and dst host 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b and dst port 11000)' -w /tmp/tapae6138d2-e3_ctest-random-10763491.pcap
2025-10-30 03:29:55,589 - DEBUG - Executing command: sudo tcpdump -nni tap7dbf6f47-2a -U '(udp and src host 3f62:ae8f:58f6:f3d:39d3:a166:0:3 and dst host 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b and dst port 11000)' -w /tmp/tap7dbf6f47-2a_ctest-random-41125002.pcap
2025-10-30 03:29:55,678 - DEBUG - Running remote_cmd, Cmd : dd bs=100 count=1 if=/dev/zero of=icmp_error;nc -6 -q 2 -u -p 16205 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b 11000 < icmp_error, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.65, gateway password: c0ntrail123
2025-10-30 03:29:55,678 - DEBUG - dd bs=100 count=1 if=/dev/zero of=icmp_error;nc -6 -q 2 -u -p 16205 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b 11000 < icmp_error
2025-10-30 03:30:34,790 - DEBUG - 1+0 records in
1+0 records out
100 bytes (100 B) copied, 0.000921458 s, 109 kB/s
2025-10-30 03:30:34,790 - DEBUG - Executing command: sudo tcpdump -nnr /tmp/tapae6138d2-e3_ctest-random-10763491.pcap | grep -c length
2025-10-30 03:30:34,804 - DEBUG - STDOUT: 0
2025-10-30 03:30:34,804 - DEBUG - STDERR: reading from file /tmp/tapae6138d2-e3_ctest-random-10763491.pcap, link-type EN10MB (Ethernet), snapshot length 262144
2025-10-30 03:30:34,804 - WARNING - No packets are found in tcpdump output file /tmp/tapae6138d2-e3_ctest-random-10763491.pcap but expected some packets
2025-10-30 03:30:36,805 - DEBUG - Executing command: sudo tcpdump -nnr /tmp/tapae6138d2-e3_ctest-random-10763491.pcap | grep -c length
2025-10-30 03:30:36,820 - DEBUG - STDOUT: 0
2025-10-30 03:30:36,820 - DEBUG - STDERR: reading from file /tmp/tapae6138d2-e3_ctest-random-10763491.pcap, link-type EN10MB (Ethernet), snapshot length 262144
2025-10-30 03:30:36,820 - WARNING - No packets are found in tcpdump output file /tmp/tapae6138d2-e3_ctest-random-10763491.pcap but expected some packets
2025-10-30 03:30:38,821 - DEBUG - Executing command: sudo tcpdump -nnr /tmp/tapae6138d2-e3_ctest-random-10763491.pcap | grep -c length
2025-10-30 03:30:38,837 - DEBUG - STDOUT: 0
2025-10-30 03:30:38,837 - DEBUG - STDERR: reading from file /tmp/tapae6138d2-e3_ctest-random-10763491.pcap, link-type EN10MB (Ethernet), snapshot length 262144
2025-10-30 03:30:38,837 - WARNING - No packets are found in tcpdump output file /tmp/tapae6138d2-e3_ctest-random-10763491.pcap but expected some packets
2025-10-30 03:30:40,838 - DEBUG - Executing command: sudo tcpdump -nnr /tmp/tapae6138d2-e3_ctest-random-10763491.pcap | grep -c length
2025-10-30 03:30:40,852 - DEBUG - STDOUT: 0
2025-10-30 03:30:40,852 - DEBUG - STDERR: reading from file /tmp/tapae6138d2-e3_ctest-random-10763491.pcap, link-type EN10MB (Ethernet), snapshot length 262144
2025-10-30 03:30:40,853 - WARNING - No packets are found in tcpdump output file /tmp/tapae6138d2-e3_ctest-random-10763491.pcap but expected some packets
2025-10-30 03:30:42,853 - DEBUG - Executing command: sudo tcpdump -nnr /tmp/tapae6138d2-e3_ctest-random-10763491.pcap | grep -c length
2025-10-30 03:30:42,868 - DEBUG - STDOUT: 0
2025-10-30 03:30:42,869 - DEBUG - STDERR: reading from file /tmp/tapae6138d2-e3_ctest-random-10763491.pcap, link-type EN10MB (Ethernet), snapshot length 262144
2025-10-30 03:30:42,869 - WARNING - No packets are found in tcpdump output file /tmp/tapae6138d2-e3_ctest-random-10763491.pcap but expected some packets
2025-10-30 03:30:44,870 - DEBUG - Executing command: sudo tcpdump -nnr /tmp/tapae6138d2-e3_ctest-random-10763491.pcap | grep -c length
2025-10-30 03:30:44,884 - DEBUG - STDOUT: 0
2025-10-30 03:30:44,884 - DEBUG - STDERR: reading from file /tmp/tapae6138d2-e3_ctest-random-10763491.pcap, link-type EN10MB (Ethernet), snapshot length 262144
2025-10-30 03:30:44,884 - WARNING - No packets are found in tcpdump output file /tmp/tapae6138d2-e3_ctest-random-10763491.pcap but expected some packets
2025-10-30 03:30:46,885 - DEBUG - Executing command: sudo tcpdump -nnr /tmp/tapae6138d2-e3_ctest-random-10763491.pcap | grep -c length
2025-10-30 03:30:46,899 - DEBUG - STDOUT: 0
2025-10-30 03:30:46,899 - DEBUG - STDERR: reading from file /tmp/tapae6138d2-e3_ctest-random-10763491.pcap, link-type EN10MB (Ethernet), snapshot length 262144
2025-10-30 03:30:46,899 - WARNING - No packets are found in tcpdump output file /tmp/tapae6138d2-e3_ctest-random-10763491.pcap but expected some packets
2025-10-30 03:30:46,899 - DEBUG - Executing command: sudo tcpdump -nnr /tmp/tap7dbf6f47-2a_ctest-random-41125002.pcap | grep -c length
2025-10-30 03:30:46,913 - DEBUG - STDOUT: 1
2025-10-30 03:30:46,913 - DEBUG - STDERR: reading from file /tmp/tap7dbf6f47-2a_ctest-random-41125002.pcap, link-type EN10MB (Ethernet), snapshot length 262144
2025-10-30 03:30:46,913 - INFO - 1 packets are found in tcpdump output as expected
2025-10-30 03:30:46,913 - DEBUG - Executing command: sudo kill $(ps -ef|grep tcpdump | grep pcap| awk '{print $2}')
2025-10-30 03:30:48,958 - INFO - Tcpdump verification on VM 3f62:ae8f:58f6:f3d:39d3:a166:0:5 passed
2025-10-30 03:30:49,226 - DEBUG - Forward and reverse flows for match {'sip': '3f62:ae8f:58f6:f3d:39d3:a166:0:3', 'dip': '2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b', 'sport': '16205', 'dport': '11000', 'proto': '17', 'vrf_id': '2'}: 0, 0
2025-10-30 03:30:49,228 - DEBUG - Flow verification PASSED on node: 10.0.0.129 for VMs - Sender: 3f62:ae8f:58f6:f3d:39d3:a166:0:3, Receiver: 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b, Flow count expected: 0 0, got: 0 0
2025-10-30 03:30:49,228 - DEBUG - Executing command: sudo kill $(ps -ef|grep tcpdump | grep pcap| awk '{print $2}')
2025-10-30 03:30:51,237 - DEBUG - Executing command: sudo kill $(ps -ef|grep tcpdump | grep pcap| awk '{print $2}')
2025-10-30 03:30:53,532 - DEBUG - Forward and reverse flows for match {'sip': '3f62:ae8f:58f6:f3d:39d3:a166:0:3', 'dip': '2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b', 'sport': '16205', 'dport': '11000', 'proto': '17', 'vrf_id': '2'}: 0, 0
2025-10-30 03:30:53,533 - DEBUG - Flow verification PASSED on node: 10.0.0.65 for VMs - Sender: 3f62:ae8f:58f6:f3d:39d3:a166:0:3, Receiver: 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b, Flow count expected: 0 0, got: 0 0
2025-10-30 03:30:53,533 - INFO - Traffic verification for ECMP passed
2025-10-30 03:30:53,533 - INFO - Waiting for VM ctest-DisablePolicyEcmpIpv6-68363638-08797746 to be up..
2025-10-30 03:30:53,621 - DEBUG - VM is in ACTIVE state now
2025-10-30 03:30:53,621 - INFO - VM name : ctest-DisablePolicyEcmpIpv6-68363638-08797746
2025-10-30 03:30:53,703 - DEBUG - VM ctest-DisablePolicyEcmpIpv6-68363638-08797746 ID is 8db72b82-f4ab-4f55-b4e3-73ee270304c6
2025-10-30 03:30:53,703 - DEBUG - VM ctest-DisablePolicyEcmpIpv6-68363638-08797746 launched on Node an-jenkins-deploy-platform-ansible-os-4535-2
2025-10-30 03:30:53,788 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine/8db72b82-f4ab-4f55-b4e3-73ee270304c6
2025-10-30 03:30:53,798 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine-interface/21daa14e-68dc-4438-b1fc-07a0bf4baf94
2025-10-30 03:30:54,950 - 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=2.68 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.375 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.375/1.525/2.675/1.150 ms')
2025-10-30 03:30:54,950 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-DisablePolicyEcmpIpv6-68363638-08797746 passed
2025-10-30 03:30:55,019 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-30 03:30:55,019 - DEBUG - Waiting to SSH to VM ctest-DisablePolicyEcmpIpv6-68363638-08797746, IP 3f62:ae8f:58f6:f3d:39d3:a166:0:6, Port 22
2025-10-30 03:30:55,188 - DEBUG - VM ctest-DisablePolicyEcmpIpv6-68363638-08797746 is ready for SSH connections
2025-10-30 03:30:55,256 - INFO - Policy DISABLED on VMI 21daa14e-68dc-4438-b1fc-07a0bf4baf94
2025-10-30 03:30:55,256 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-30 03:30:55,257 - DEBUG - Running remote_cmd, Cmd : ifconfig -a| grep 3f62:ae8f:58f6:f3d:39d3:a166:0:6 -A2 -B4| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.65, gateway password: c0ntrail123
2025-10-30 03:30:55,257 - DEBUG - ifconfig -a| grep 3f62:ae8f:58f6:f3d:39d3:a166:0:6 -A2 -B4| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1
2025-10-30 03:31:32,527 - DEBUG - eth0
2025-10-30 03:31:32,528 - DEBUG - Running remote_cmd, Cmd : sysctl net.ipv6.conf.eth0.accept_dad=0, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.65, gateway password: c0ntrail123
2025-10-30 03:31:32,528 - DEBUG - sysctl net.ipv6.conf.eth0.accept_dad=0
2025-10-30 03:31:33,041 - DEBUG - net.ipv6.conf.eth0.accept_dad = 0
2025-10-30 03:31:33,272 - INFO - Created InterfaceRouteTable ['default-domain', 'ctest-DisablePolicyEcmpIpv6-68363638', 'ctest-intf-rtb-88452755'](UUID 45c2f90f-196f-4ac3-8c11-03c8c97b7443), prefixes : ['2fc1:34a1:735a:3f46:6bb7:bd07::/96']
2025-10-30 03:31:33,340 - INFO - Added intf route table 45c2f90f-196f-4ac3-8c11-03c8c97b7443 to port 21daa14e-68dc-4438-b1fc-07a0bf4baf94
2025-10-30 03:31:33,341 - DEBUG - Running remote_cmd, Cmd : ifconfig -a| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.65, gateway password: c0ntrail123
2025-10-30 03:31:33,341 - DEBUG - ifconfig -a| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1
2025-10-30 03:31:33,784 - DEBUG - eth0
2025-10-30 03:31:33,784 - DEBUG - Running remote_cmd, Cmd : ifconfig eth0 inet6 add 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.65, gateway password: c0ntrail123
2025-10-30 03:31:33,784 - DEBUG - ifconfig eth0 inet6 add 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b
2025-10-30 03:31:34,278 - DEBUG - None
2025-10-30 03:31:34,278 - DEBUG - Running remote_cmd, Cmd : ifconfig -a, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.65, gateway password: c0ntrail123
2025-10-30 03:31:34,278 - DEBUG - ifconfig -a
2025-10-30 03:31:34,785 - DEBUG - eth0 Link encap:Ethernet HWaddr 02:21:da:a1:4e:68
inet addr:73.171.220.6 Bcast:73.171.220.63 Mask:255.255.255.192
inet6 addr: 3f62:ae8f:58f6:f3d:39d3:a166:0:6/64 Scope:Global
inet6 addr: 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b/128 Scope:Global
inet6 addr: fe80::21:daff:fea1:4e68/64 Scope:Link
UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
RX packets:583 errors:0 dropped:0 overruns:0 frame:0
TX packets:520 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:1000
RX bytes:52009 (52.0 KB) TX bytes:44366 (44.3 KB)
lo Link encap:Local Loopback
inet addr:127.0.0.1 Mask:255.0.0.0
inet6 addr: ::1/128 Scope:Host
UP LOOPBACK RUNNING MTU:16436 Metric:1
RX packets:0 errors:0 dropped:0 overruns:0 frame:0
TX packets:0 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:0
RX bytes:0 (0.0 B) TX bytes:0 (0.0 B)
2025-10-30 03:31:34,785 - INFO - Deleting VM ctest-DisablePolicyEcmpIpv6-68363638-04637086
2025-10-30 03:31:34,940 - INFO - Removed intf route table 1e57b298-a51c-46c9-b537-9fb6bbd93434 from port ae6138d2-e376-4552-af9d-8f0aedd68997
2025-10-30 03:31:34,976 - INFO - Deleted Interface route table 1e57b298-a51c-46c9-b537-9fb6bbd93434
2025-10-30 03:31:34,990 - INFO - ECMP routes found in agent 10.0.0.129, for prefix 2fc1:34a1:735a:3f46:6bb7:bd07::/96
2025-10-30 03:31:34,990 - INFO - Tap interface tap7dbf6f47-2a found in ecmp routes in agent 10.0.0.129
2025-10-30 03:31:35,002 - INFO - ECMP routes found in agent 10.0.0.65, for prefix 2fc1:34a1:735a:3f46:6bb7:bd07::/96
2025-10-30 03:31:35,002 - INFO - Tap interface tap21daa14e-68 found in ecmp routes in agent 10.0.0.65
2025-10-30 03:31:35,108 - DEBUG - Executing command: sudo tcpdump -nni tap7dbf6f47-2a -U '(udp and src host 3f62:ae8f:58f6:f3d:39d3:a166:0:3 and dst host 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b and dst port 11000)' -w /tmp/tap7dbf6f47-2a_ctest-random-61050030.pcap
2025-10-30 03:31:35,600 - DEBUG - Executing command: sudo tcpdump -nni tap21daa14e-68 -U '(udp and src host 3f62:ae8f:58f6:f3d:39d3:a166:0:3 and dst host 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b and dst port 11000)' -w /tmp/tap21daa14e-68_ctest-random-77473892.pcap
2025-10-30 03:31:35,958 - DEBUG - Running remote_cmd, Cmd : dd bs=100 count=1 if=/dev/zero of=icmp_error;nc -6 -q 2 -u -p 41005 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b 11000 < icmp_error, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.65, gateway password: c0ntrail123
2025-10-30 03:31:35,959 - DEBUG - dd bs=100 count=1 if=/dev/zero of=icmp_error;nc -6 -q 2 -u -p 41005 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b 11000 < icmp_error
2025-10-30 03:31:38,490 - DEBUG - 1+0 records in
1+0 records out
100 bytes (100 B) copied, 0.00106354 s, 94.0 kB/s
2025-10-30 03:31:38,490 - DEBUG - Executing command: sudo tcpdump -nnr /tmp/tap7dbf6f47-2a_ctest-random-61050030.pcap | grep -c length
2025-10-30 03:31:38,506 - DEBUG - STDOUT: 1
2025-10-30 03:31:38,506 - DEBUG - STDERR: reading from file /tmp/tap7dbf6f47-2a_ctest-random-61050030.pcap, link-type EN10MB (Ethernet), snapshot length 262144
2025-10-30 03:31:38,506 - INFO - 1 packets are found in tcpdump output as expected
2025-10-30 03:31:38,506 - DEBUG - Executing command: sudo kill $(ps -ef|grep tcpdump | grep pcap| awk '{print $2}')
2025-10-30 03:31:40,550 - INFO - Tcpdump verification on VM 3f62:ae8f:58f6:f3d:39d3:a166:0:5 passed
2025-10-30 03:31:40,801 - DEBUG - Forward and reverse flows for match {'sip': '3f62:ae8f:58f6:f3d:39d3:a166:0:3', 'dip': '2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b', 'sport': '41005', 'dport': '11000', 'proto': '17', 'vrf_id': '2'}: 0, 0
2025-10-30 03:31:40,801 - DEBUG - Flow verification PASSED on node: 10.0.0.129 for VMs - Sender: 3f62:ae8f:58f6:f3d:39d3:a166:0:3, Receiver: 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b, Flow count expected: 0 0, got: 0 0
2025-10-30 03:31:40,801 - DEBUG - Executing command: sudo kill $(ps -ef|grep tcpdump | grep pcap| awk '{print $2}')
2025-10-30 03:31:42,809 - DEBUG - Executing command: sudo kill $(ps -ef|grep tcpdump | grep pcap| awk '{print $2}')
2025-10-30 03:31:45,121 - DEBUG - Forward and reverse flows for match {'sip': '3f62:ae8f:58f6:f3d:39d3:a166:0:3', 'dip': '2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b', 'sport': '41005', 'dport': '11000', 'proto': '17', 'vrf_id': '2'}: 0, 0
2025-10-30 03:31:45,122 - DEBUG - Flow verification PASSED on node: 10.0.0.65 for VMs - Sender: 3f62:ae8f:58f6:f3d:39d3:a166:0:3, Receiver: 2fc1:34a1:735a:3f46:6bb7:bd07:9999:aa7b, Flow count expected: 0 0, got: 0 0
2025-10-30 03:31:45,122 - INFO - Traffic verification for ECMP passed
2025-10-30 03:31:45,122 - INFO - Deleting VM ctest-DisablePolicyEcmpIpv6-68363638-08797746
2025-10-30 03:31:45,269 - INFO - Removed intf route table 45c2f90f-196f-4ac3-8c11-03c8c97b7443 from port 21daa14e-68dc-4438-b1fc-07a0bf4baf94
2025-10-30 03:31:45,302 - INFO - Deleted Interface route table 45c2f90f-196f-4ac3-8c11-03c8c97b7443
2025-10-30 03:31:45,302 - INFO - Deleting VM ctest-DisablePolicyEcmpIpv6-68363638-57246092
2025-10-30 03:31:45,456 - INFO - Removed intf route table 785d3250-c112-43d1-a87f-837c7d045b52 from port 7dbf6f47-2ae8-4959-8a85-00e6f9945be5
2025-10-30 03:31:45,497 - INFO - Deleted Interface route table 785d3250-c112-43d1-a87f-837c7d045b52
2025-10-30 03:31:45,497 - INFO - Deleting VM ctest-DisablePolicyEcmpIpv6-68363638-99061260
2025-10-30 03:31:45,581 - INFO - Deleting VN ctest-vn-74880512
2025-10-30 03:31:45,634 - DEBUG - VN a2fce4c3-00f2-47d4-8d40-473c388768e3 still in use: Unable to complete operation on network a2fce4c3-00f2-47d4-8d40-473c388768e3. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-df3367be-16ab-4bdd-816d-7375e5540a4e']
2025-10-30 03:31:45,634 - WARNING - Deleting VN ctest-vn-74880512 failed..Will retry
2025-10-30 03:31:47,880 - DEBUG - Response for deleting network ()
2025-10-30 03:31:47,880 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/29be58be-722d-4f9a-a09e-ca20a5e2c341
2025-10-30 03:31:47,886 - DEBUG - Response Code: 404
2025-10-30 03:31:47,886 - DEBUG - Requesting: http://10.0.0.242:8082/domains
2025-10-30 03:31:47,892 - DEBUG - Requesting: http://10.0.0.242:8082/domain/2be6ea5e-665d-4a78-a8ec-f940f567f06f
2025-10-30 03:31:47,921 - DEBUG - Requesting: http://10.0.0.242:8082/project/414da9af-65ef-4eca-9fc8-4e363348bd6f
2025-10-30 03:31:48,027 - INFO - Validated that VN ctest-vn-74880512 is not found in API Server
2025-10-30 03:31:48,037 - DEBUG - VN ctest-vn-74880512 is not present in Agent 10.0.0.129
2025-10-30 03:31:48,046 - DEBUG - VN ctest-vn-74880512 is not present in Agent 10.0.0.65
2025-10-30 03:31:48,046 - INFO - Validated that VN ctest-vn-74880512 is not in any agent
2025-10-30 03:31:48,080 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-74880512 info
2025-10-30 03:31:49,357 - DEBUG - No XMPP flaps were noticed during the test
2025-10-30 03:31:49,357 - INFO - END TEST : test_ecmp_with_static_routes : PASSED[0:04:44]
2025-10-30 03:31:49,357 - INFO - --------------------------------------------------------------------------------
2025-10-30 03:31:50,166 - INFO - Deleted project: ctest-DisablePolicyEcmpIpv6-68363638, ID : 414da9af-65ef-4eca-9fc8-4e363348bd6f