2025-08-06 09:58:33,715 - INFO - Domain Default found not creating
2025-08-06 09:58:33,884 - INFO - Project ctest-TestEvpnCasesVxlan-69934149 not found, creating it
2025-08-06 09:58:34,493 - INFO - Created Project:ctest-TestEvpnCasesVxlan-69934149, ID : 67ba8d08-c98d-4d52-9e6a-6a2badd3125d
2025-08-06 09:58:36,241 - INFO - ================================================================================
2025-08-06 09:58:36,241 - INFO - STARTING TEST : test_with_vxlan_encap_dns_disabled_for_l2_vn
2025-08-06 09:58:36,241 - INFO - TEST DESCRIPTION : 1. Launch a virtual network with dhcp_enable=False and DNS disabled
2. Launch 3 vm with management interface and other with above vm.
3. Run dhcp server on eth1 in one vm dns server on eth1 in other vm
4. From the test_vm query for dns using dig and nslookup
Maintainer: hkumar@juniper.net
2025-08-06 09:58:37,515 - DEBUG - Skipping xmpp flap check
2025-08-06 09:58:37,515 - INFO - Initial checks done. Running the testcase now
2025-08-06 09:58:37,515 - INFO -
2025-08-06 09:58:37,515 - INFO - Setting new Encap before continuing
2025-08-06 09:58:37,515 - INFO - Read the existing encap priority
2025-08-06 09:58:38,058 - INFO - Created.UUID is {"global-vrouter-config": {"uuid": "5c71d3e2-0190-4eeb-9f1b-bfd2916d7105", "href": "http://10.0.0.38:8082/global-vrouter-config/5c71d3e2-0190-4eeb-9f1b-bfd2916d7105"}}. VXLAN is the highest priority encap
2025-08-06 09:58:38,091 - DEBUG - Services list from nova: [, , , ]
2025-08-06 09:58:38,091 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-3761-1', 'an-jenkins-deploy-platform-ansible-os-3761-2']}
2025-08-06 09:58:38,422 - INFO - Created VN EVPN-MGMT-VN, UUID :7513ec28-f343-49b1-9176-64ed7d8009ec
2025-08-06 09:58:39,174 - INFO - Created VN EVPN-L2-VN, UUID :7c73dca8-0718-4642-aca2-750307130812
2025-08-06 09:58:39,729 - DEBUG - Requesting: http://10.0.0.48:8082/domains
2025-08-06 09:58:40,028 - DEBUG - Requesting: http://10.0.0.48:8082/domains
2025-08-06 09:58:40,067 - DEBUG - Requesting: http://10.0.0.48:8082/domain/e3e88518-0617-4e53-bc15-162decab76e0
2025-08-06 09:58:40,092 - DEBUG - Requesting: http://10.0.0.48:8082/project/67ba8d08-c98d-4d52-9e6a-6a2badd3125d
2025-08-06 09:58:40,197 - DEBUG - Requesting: http://10.0.0.48:8082/virtual-network/7513ec28-f343-49b1-9176-64ed7d8009ec
2025-08-06 09:58:40,219 - DEBUG - Requesting: http://10.0.0.48:8082/virtual-network/7513ec28-f343-49b1-9176-64ed7d8009ec
2025-08-06 09:58:40,234 - DEBUG - Requesting: http://10.0.0.48:8082/routing-instance/b9c7dcee-3baa-412d-b892-d23e5e2659cb
2025-08-06 09:58:40,250 - DEBUG - Requesting: http://10.0.0.48:8082/routing-instance/b9c7dcee-3baa-412d-b892-d23e5e2659cb
2025-08-06 09:58:40,263 - DEBUG - Requesting: http://10.0.0.48:8082/route-target/ca782035-a3c0-4169-a89a-5372d330734e
2025-08-06 09:58:40,274 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-06 09:58:40,274 - DEBUG - Requesting: http://10.0.0.48:8082/virtual-network/7513ec28-f343-49b1-9176-64ed7d8009ec
2025-08-06 09:58:40,290 - DEBUG - Requesting: http://10.0.0.48:8082/routing-instance/b9c7dcee-3baa-412d-b892-d23e5e2659cb
2025-08-06 09:58:40,317 - INFO - Verified VN network id 8 for VN 7513ec28-f343-49b1-9176-64ed7d8009ec
2025-08-06 09:58:40,317 - INFO - Verifications in API Server for VN EVPN-MGMT-VN passed
2025-08-06 09:58:40,318 - DEBUG - Requesting: http://10.0.0.48:8082/virtual-network/7513ec28-f343-49b1-9176-64ed7d8009ec
2025-08-06 09:58:40,333 - DEBUG - Requesting: http://10.0.0.48:8082/routing-instance/b9c7dcee-3baa-412d-b892-d23e5e2659cb
2025-08-06 09:58:40,343 - DEBUG - Requesting: http://10.0.0.48:8082/routing-instance/b9c7dcee-3baa-412d-b892-d23e5e2659cb
2025-08-06 09:58:40,354 - DEBUG - Requesting: http://10.0.0.48:8082/route-target/ca782035-a3c0-4169-a89a-5372d330734e
2025-08-06 09:58:40,372 - DEBUG - Control-node 10.0.0.48 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestEvpnCasesVxlan-69934149', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8436346187619191217', 'uuid-lslong': '10481676153926978028'}, 'enable': 'true', 'created': '2025-08-06T09:58:38', 'last-modified': '2025-08-06T09:58:38', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.763461'}
2025-08-06 09:58:40,382 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-06 09:58:40,392 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestEvpnCasesVxlan-69934149', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8436346187619191217', 'uuid-lslong': '10481676153926978028'}, 'enable': 'true', 'created': '2025-08-06T09:58:38', 'last-modified': '2025-08-06T09:58:38', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.806859'}
2025-08-06 09:58:40,400 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-06 09:58:40,407 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestEvpnCasesVxlan-69934149', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8436346187619191217', 'uuid-lslong': '10481676153926978028'}, 'enable': 'true', 'created': '2025-08-06T09:58:38', 'last-modified': '2025-08-06T09:58:38', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.818785'}
2025-08-06 09:58:40,414 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-06 09:58:40,414 - INFO - On all control nodes, Config, RI and RT verification for VN EVPN-MGMT-VN passed
2025-08-06 09:58:40,414 - DEBUG - ====Verifying policy data for EVPN-MGMT-VN in API_Server ======
2025-08-06 09:58:40,414 - DEBUG - Requesting: http://10.0.0.48:8082/domains
2025-08-06 09:58:40,434 - DEBUG - Requesting: http://10.0.0.48:8082/domain/e3e88518-0617-4e53-bc15-162decab76e0
2025-08-06 09:58:40,459 - DEBUG - Requesting: http://10.0.0.48:8082/project/67ba8d08-c98d-4d52-9e6a-6a2badd3125d
2025-08-06 09:58:40,601 - DEBUG - Requesting: http://10.0.0.48:8082/virtual-network/7513ec28-f343-49b1-9176-64ed7d8009ec
2025-08-06 09:58:40,614 - DEBUG - =>VN EVPN-MGMT-VN has no policy to be verified
2025-08-06 09:58:40,614 - DEBUG - Verifying the vn in opserver
2025-08-06 09:58:40,614 - DEBUG - Verifying the default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN virtual network link through opserver 10.0.0.48
2025-08-06 09:58:40,614 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-networks
2025-08-06 09:58:40,939 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-networks
2025-08-06 09:58:41,002 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN', 'href': 'http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN?flat'}
2025-08-06 09:58:41,002 - DEBUG - Verifying the default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN virtual network link through opserver 10.0.0.254
2025-08-06 09:58:41,002 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-08-06 09:58:41,307 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-08-06 09:58:41,391 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN?flat'}
2025-08-06 09:58:41,392 - DEBUG - Verifying the default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN virtual network link through opserver 10.0.0.38
2025-08-06 09:58:41,392 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-06 09:58:41,695 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-06 09:58:41,764 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN?flat'}
2025-08-06 09:58:41,764 - INFO - Validated that VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is found in opserver
2025-08-06 09:58:41,795 - DEBUG - Do not have enough data to verify VN in agent
2025-08-06 09:58:41,810 - DEBUG - VRF ids for VN EVPN-MGMT-VN: {}
2025-08-06 09:58:41,810 - DEBUG - Requesting: http://10.0.0.48:8082/domains
2025-08-06 09:58:41,820 - DEBUG - Requesting: http://10.0.0.48:8082/domain/e3e88518-0617-4e53-bc15-162decab76e0
2025-08-06 09:58:41,837 - DEBUG - Requesting: http://10.0.0.48:8082/project/67ba8d08-c98d-4d52-9e6a-6a2badd3125d
2025-08-06 09:58:41,959 - DEBUG - Requesting: http://10.0.0.48:8082/virtual-network/7c73dca8-0718-4642-aca2-750307130812
2025-08-06 09:58:41,978 - DEBUG - Requesting: http://10.0.0.48:8082/virtual-network/7c73dca8-0718-4642-aca2-750307130812
2025-08-06 09:58:41,993 - DEBUG - Requesting: http://10.0.0.48:8082/routing-instance/4ccea094-fe50-461a-9221-2c22692102b8
2025-08-06 09:58:42,004 - DEBUG - Requesting: http://10.0.0.48:8082/routing-instance/4ccea094-fe50-461a-9221-2c22692102b8
2025-08-06 09:58:42,012 - DEBUG - Requesting: http://10.0.0.48:8082/route-target/dcc044cc-4b7a-4c2e-a2c1-96b5b71a8071
2025-08-06 09:58:42,021 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-06 09:58:42,021 - DEBUG - Requesting: http://10.0.0.48:8082/virtual-network/7c73dca8-0718-4642-aca2-750307130812
2025-08-06 09:58:42,036 - DEBUG - Requesting: http://10.0.0.48:8082/routing-instance/4ccea094-fe50-461a-9221-2c22692102b8
2025-08-06 09:58:42,058 - INFO - Verified VN network id 9 for VN 7c73dca8-0718-4642-aca2-750307130812
2025-08-06 09:58:42,059 - INFO - Verifications in API Server for VN EVPN-L2-VN passed
2025-08-06 09:58:42,059 - DEBUG - Requesting: http://10.0.0.48:8082/virtual-network/7c73dca8-0718-4642-aca2-750307130812
2025-08-06 09:58:42,074 - DEBUG - Requesting: http://10.0.0.48:8082/routing-instance/4ccea094-fe50-461a-9221-2c22692102b8
2025-08-06 09:58:42,087 - DEBUG - Requesting: http://10.0.0.48:8082/routing-instance/4ccea094-fe50-461a-9221-2c22692102b8
2025-08-06 09:58:42,099 - DEBUG - Requesting: http://10.0.0.48:8082/route-target/dcc044cc-4b7a-4c2e-a2c1-96b5b71a8071
2025-08-06 09:58:42,118 - DEBUG - Control-node 10.0.0.48 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestEvpnCasesVxlan-69934149', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8967753897256437314', 'uuid-lslong': '12439633776614770706'}, 'enable': 'true', 'created': '2025-08-06T09:58:39', 'last-modified': '2025-08-06T09:58:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.524415'}
2025-08-06 09:58:42,129 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-06 09:58:42,140 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestEvpnCasesVxlan-69934149', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8967753897256437314', 'uuid-lslong': '12439633776614770706'}, 'enable': 'true', 'created': '2025-08-06T09:58:39', 'last-modified': '2025-08-06T09:58:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.525649'}
2025-08-06 09:58:42,149 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-06 09:58:42,156 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestEvpnCasesVxlan-69934149', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8967753897256437314', 'uuid-lslong': '12439633776614770706'}, 'enable': 'true', 'created': '2025-08-06T09:58:39', 'last-modified': '2025-08-06T09:58:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.540536'}
2025-08-06 09:58:42,164 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-06 09:58:42,164 - INFO - On all control nodes, Config, RI and RT verification for VN EVPN-L2-VN passed
2025-08-06 09:58:42,164 - DEBUG - ====Verifying policy data for EVPN-L2-VN in API_Server ======
2025-08-06 09:58:42,164 - DEBUG - Requesting: http://10.0.0.48:8082/domains
2025-08-06 09:58:42,172 - DEBUG - Requesting: http://10.0.0.48:8082/domain/e3e88518-0617-4e53-bc15-162decab76e0
2025-08-06 09:58:42,189 - DEBUG - Requesting: http://10.0.0.48:8082/project/67ba8d08-c98d-4d52-9e6a-6a2badd3125d
2025-08-06 09:58:42,291 - DEBUG - Requesting: http://10.0.0.48:8082/virtual-network/7c73dca8-0718-4642-aca2-750307130812
2025-08-06 09:58:42,305 - DEBUG - =>VN EVPN-L2-VN has no policy to be verified
2025-08-06 09:58:42,305 - DEBUG - Verifying the vn in opserver
2025-08-06 09:58:42,305 - DEBUG - Verifying the default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN virtual network link through opserver 10.0.0.48
2025-08-06 09:58:42,305 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-networks
2025-08-06 09:58:42,375 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN', 'href': 'http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN?flat'}
2025-08-06 09:58:42,375 - DEBUG - Verifying the default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN virtual network link through opserver 10.0.0.254
2025-08-06 09:58:42,375 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-08-06 09:58:42,454 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN?flat'}
2025-08-06 09:58:42,454 - DEBUG - Verifying the default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN virtual network link through opserver 10.0.0.38
2025-08-06 09:58:42,454 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-06 09:58:42,521 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN?flat'}
2025-08-06 09:58:42,521 - INFO - Validated that VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN is found in opserver
2025-08-06 09:58:42,549 - DEBUG - Do not have enough data to verify VN in agent
2025-08-06 09:58:42,562 - DEBUG - VRF ids for VN EVPN-L2-VN: {}
2025-08-06 09:58:42,902 - DEBUG - Image by name ubuntu-dns-server not found
2025-08-06 09:58:42,902 - DEBUG - Installing image ubuntu-dns-server
2025-08-06 09:58:42,902 - DEBUG - Image info {'name': 'ubuntu-dns-server.vmdk.gz', 'webserver': '', 'location': '/images/converts/', 'username': 'ubuntu', 'password': 'ubuntu', 'type': 'os', 'flavor': 'contrail_flavor_small', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hw_scsi_model=virtio-scsi --property hw_disk_bus_model=virtio-scsi --property hw_disk_bus=virtio', 'name_docker': 'phusion-baseimage-enablesshd'}
2025-08-06 09:58:42,903 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/converts//ubuntu-dns-server.vmdk.gz
2025-08-06 09:58:42,903 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/converts//ubuntu-dns-server.vmdk.gz
2025-08-06 09:58:42,917 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/converts//ubuntu-dns-server.vmdk.gz -O /contrail-test/images/ubuntu-dns-server.vmdk.gz
2025-08-06 09:58:46,119 - DEBUG - Image has been downloaded to /contrail-test/images/ubuntu-dns-server.vmdk.gz
2025-08-06 09:58:46,119 - DEBUG - Unzip image
2025-08-06 09:58:46,119 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/ubuntu-dns-server.vmdk.gz
2025-08-06 09:59:00,522 - DEBUG - Try to create image in user context
2025-08-06 09:59:08,834 - DEBUG - Image has been created in user context
2025-08-06 09:59:08,834 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: rm -f /contrail-test/images/ubuntu-dns-server.vmdk
2025-08-06 09:59:09,047 - DEBUG - Downloaded image has been removed
2025-08-06 09:59:09,067 - DEBUG - Uploaded image status = active
2025-08-06 09:59:10,435 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3761-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3761-2)
2025-08-06 09:59:12,170 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3761-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3761-2)
2025-08-06 09:59:13,954 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3761-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3761-1)
2025-08-06 09:59:13,954 - INFO - Waiting for VM dhcp-server to be up..
2025-08-06 09:59:14,093 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-08-06 09:59:19,230 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-08-06 09:59:24,359 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-08-06 09:59:29,461 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-08-06 09:59:34,550 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-08-06 09:59:39,657 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-08-06 09:59:44,752 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-08-06 09:59:49,854 - DEBUG - VM is in ACTIVE state now
2025-08-06 09:59:49,854 - INFO - VM name : dhcp-server
2025-08-06 09:59:49,958 - DEBUG - VM dhcp-server ID is 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf
2025-08-06 09:59:49,958 - DEBUG - VM dhcp-server launched on Node an-jenkins-deploy-platform-ansible-os-3761-2
2025-08-06 09:59:50,215 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf
2025-08-06 09:59:50,569 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf
2025-08-06 09:59:50,612 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/32a14af7-8503-433b-8547-9f88c88e2511
2025-08-06 09:59:50,623 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/65dacd9a-ac50-4088-8595-fbfbe3039809
2025-08-06 09:59:53,857 - 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-08-06 09:59:53,857 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM dhcp-server failed!
2025-08-06 09:59:53,876 - DEBUG - Gateway for vn default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is 11.1.1.254 and allocation pool is NOT set
2025-08-06 09:59:57,950 - 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 1008ms')
2025-08-06 09:59:57,951 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM dhcp-server failed!
2025-08-06 09:59:57,977 - DEBUG - Gateway for vn default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is 11.1.1.254 and allocation pool is NOT set
2025-08-06 10:00:02,049 - 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 1010ms')
2025-08-06 10:00:02,050 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM dhcp-server failed!
2025-08-06 10:00:02,073 - DEBUG - Gateway for vn default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is 11.1.1.254 and allocation pool is NOT set
2025-08-06 10:00:06,149 - 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 1010ms')
2025-08-06 10:00:06,149 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM dhcp-server failed!
2025-08-06 10:00:06,169 - DEBUG - Gateway for vn default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is 11.1.1.254 and allocation pool is NOT set
2025-08-06 10:00:10,242 - 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-08-06 10:00:10,243 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM dhcp-server failed!
2025-08-06 10:00:10,261 - DEBUG - Gateway for vn default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is 11.1.1.254 and allocation pool is NOT set
2025-08-06 10:00:14,335 - 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 1009ms')
2025-08-06 10:00:14,335 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM dhcp-server failed!
2025-08-06 10:00:14,352 - DEBUG - Gateway for vn default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is 11.1.1.254 and allocation pool is NOT set
2025-08-06 10:00:18,436 - 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 1017ms')
2025-08-06 10:00:18,436 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM dhcp-server failed!
2025-08-06 10:00:18,458 - DEBUG - Gateway for vn default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is 11.1.1.254 and allocation pool is NOT set
2025-08-06 10:00:22,537 - 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-08-06 10:00:22,537 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM dhcp-server failed!
2025-08-06 10:00:22,557 - DEBUG - Gateway for vn default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is 11.1.1.254 and allocation pool is NOT set
2025-08-06 10:00:26,627 - 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-08-06 10:00:26,627 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM dhcp-server failed!
2025-08-06 10:00:26,650 - DEBUG - Gateway for vn default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is 11.1.1.254 and allocation pool is NOT set
2025-08-06 10:00:30,726 - 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 1004ms')
2025-08-06 10:00:30,726 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM dhcp-server failed!
2025-08-06 10:00:30,744 - DEBUG - Gateway for vn default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is 11.1.1.254 and allocation pool is NOT set
2025-08-06 10:00:34,820 - 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-08-06 10:00:34,820 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM dhcp-server failed!
2025-08-06 10:00:34,841 - DEBUG - Gateway for vn default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is 11.1.1.254 and allocation pool is NOT set
2025-08-06 10:00:38,915 - 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 1009ms')
2025-08-06 10:00:38,916 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM dhcp-server failed!
2025-08-06 10:00:38,936 - DEBUG - Gateway for vn default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is 11.1.1.254 and allocation pool is NOT set
2025-08-06 10:00:43,011 - 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 1010ms')
2025-08-06 10:00:43,011 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM dhcp-server failed!
2025-08-06 10:00:43,039 - DEBUG - Gateway for vn default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is 11.1.1.254 and allocation pool is NOT set
2025-08-06 10:00:47,110 - 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 1004ms')
2025-08-06 10:00:47,110 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM dhcp-server failed!
2025-08-06 10:00:47,128 - DEBUG - Gateway for vn default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is 11.1.1.254 and allocation pool is NOT set
2025-08-06 10:00:51,209 - 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-08-06 10:00:51,209 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM dhcp-server failed!
2025-08-06 10:00:51,234 - DEBUG - Gateway for vn default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is 11.1.1.254 and allocation pool is NOT set
2025-08-06 10:00:55,332 - 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 1027ms')
2025-08-06 10:00:55,332 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM dhcp-server failed!
2025-08-06 10:00:55,350 - DEBUG - Gateway for vn default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is 11.1.1.254 and allocation pool is NOT set
2025-08-06 10:00:59,425 - 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 1006ms')
2025-08-06 10:00:59,426 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM dhcp-server failed!
2025-08-06 10:00:59,446 - DEBUG - Gateway for vn default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is 11.1.1.254 and allocation pool is NOT set
2025-08-06 10:01:01,520 - 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=6.02 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.620 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.620/3.322/6.024/2.702 ms')
2025-08-06 10:01:01,520 - INFO - Ping to Metadata IP 169.254.0.3 of VM dhcp-server passed
2025-08-06 10:01:01,600 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:01:01,601 - DEBUG - Waiting to SSH to VM dhcp-server, IP 11.1.1.252, Port 22
2025-08-06 10:01:01,669 - 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-08-06 10:01:01,779 - DEBUG - VM dhcp-server is NOT ready for SSH connections, VM status: ACTIVE
2025-08-06 10:01:06,780 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:01:06,780 - DEBUG - Waiting to SSH to VM dhcp-server, IP 11.1.1.252, Port 22
2025-08-06 10:01:06,838 - 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-08-06 10:01:06,945 - DEBUG - VM dhcp-server is NOT ready for SSH connections, VM status: ACTIVE
2025-08-06 10:01:11,946 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:01:11,946 - DEBUG - Waiting to SSH to VM dhcp-server, IP 11.1.1.252, Port 22
2025-08-06 10:01:12,017 - 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-08-06 10:01:12,124 - DEBUG - VM dhcp-server is NOT ready for SSH connections, VM status: ACTIVE
2025-08-06 10:01:17,125 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:01:17,125 - DEBUG - Waiting to SSH to VM dhcp-server, IP 11.1.1.252, Port 22
2025-08-06 10:01:17,192 - 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-08-06 10:01:17,310 - DEBUG - VM dhcp-server is NOT ready for SSH connections, VM status: ACTIVE
2025-08-06 10:01:22,311 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:01:22,311 - DEBUG - Waiting to SSH to VM dhcp-server, IP 11.1.1.252, Port 22
2025-08-06 10:01:22,376 - 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-08-06 10:01:22,487 - DEBUG - VM dhcp-server is NOT ready for SSH connections, VM status: ACTIVE
2025-08-06 10:01:27,488 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:01:27,488 - DEBUG - Waiting to SSH to VM dhcp-server, IP 11.1.1.252, Port 22
2025-08-06 10:01:27,557 - 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-08-06 10:01:27,684 - DEBUG - VM dhcp-server is NOT ready for SSH connections, VM status: ACTIVE
2025-08-06 10:01:32,685 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:01:32,685 - DEBUG - Waiting to SSH to VM dhcp-server, IP 11.1.1.252, Port 22
2025-08-06 10:01:32,757 - 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-08-06 10:01:33,080 - DEBUG - VM dhcp-server is NOT ready for SSH connections, VM status: ACTIVE
2025-08-06 10:01:38,082 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:01:38,082 - DEBUG - Waiting to SSH to VM dhcp-server, IP 11.1.1.252, Port 22
2025-08-06 10:01:38,149 - 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-08-06 10:01:38,246 - DEBUG - VM dhcp-server is NOT ready for SSH connections, VM status: ACTIVE
2025-08-06 10:01:43,247 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:01:43,247 - DEBUG - Waiting to SSH to VM dhcp-server, IP 11.1.1.252, Port 22
2025-08-06 10:01:43,317 - 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-08-06 10:01:43,429 - DEBUG - VM dhcp-server is NOT ready for SSH connections, VM status: ACTIVE
2025-08-06 10:01:48,430 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:01:48,430 - DEBUG - Waiting to SSH to VM dhcp-server, IP 11.1.1.252, Port 22
2025-08-06 10:01:48,487 - 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-08-06 10:01:48,613 - DEBUG - VM dhcp-server is NOT ready for SSH connections, VM status: ACTIVE
2025-08-06 10:01:53,614 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:01:53,614 - DEBUG - Waiting to SSH to VM dhcp-server, IP 11.1.1.252, Port 22
2025-08-06 10:01:53,682 - 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-08-06 10:01:53,838 - DEBUG - VM dhcp-server is NOT ready for SSH connections, VM status: ACTIVE
2025-08-06 10:01:58,838 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:01:58,838 - DEBUG - Waiting to SSH to VM dhcp-server, IP 11.1.1.252, Port 22
2025-08-06 10:01:58,904 - 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-08-06 10:01:59,028 - DEBUG - VM dhcp-server is NOT ready for SSH connections, VM status: ACTIVE
2025-08-06 10:02:04,029 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:02:04,029 - DEBUG - Waiting to SSH to VM dhcp-server, IP 11.1.1.252, Port 22
2025-08-06 10:02:04,100 - 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-08-06 10:02:04,239 - DEBUG - VM dhcp-server is NOT ready for SSH connections, VM status: ACTIVE
2025-08-06 10:02:09,239 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:02:09,240 - DEBUG - Waiting to SSH to VM dhcp-server, IP 11.1.1.252, Port 22
2025-08-06 10:02:09,303 - 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-08-06 10:02:09,413 - DEBUG - VM dhcp-server is NOT ready for SSH connections, VM status: ACTIVE
2025-08-06 10:02:14,413 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:02:14,414 - DEBUG - Waiting to SSH to VM dhcp-server, IP 11.1.1.252, Port 22
2025-08-06 10:02:14,589 - DEBUG - VM dhcp-server is ready for SSH connections
2025-08-06 10:02:14,668 - INFO - Waiting for VM dnsserver to be up..
2025-08-06 10:02:14,782 - DEBUG - VM is in ACTIVE state now
2025-08-06 10:02:14,783 - INFO - VM name : dnsserver
2025-08-06 10:02:14,906 - DEBUG - VM dnsserver ID is 29c05397-49d6-4154-9ca1-c719f95d999b
2025-08-06 10:02:14,907 - DEBUG - VM dnsserver launched on Node an-jenkins-deploy-platform-ansible-os-3761-2
2025-08-06 10:02:15,167 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/29c05397-49d6-4154-9ca1-c719f95d999b
2025-08-06 10:02:15,180 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/5d95f136-631d-44b8-9108-d1317d000726
2025-08-06 10:02:15,191 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/e05e3bb7-5e8e-4e38-bda8-b389bca6905e
2025-08-06 10:02:16,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=4.43 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=1.26 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.263/2.845/4.427/1.582 ms')
2025-08-06 10:02:16,408 - INFO - Ping to Metadata IP 169.254.0.4 of VM dnsserver passed
2025-08-06 10:02:16,485 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:02:16,485 - DEBUG - Waiting to SSH to VM dnsserver, IP 11.1.1.250, Port 22
2025-08-06 10:02:16,660 - DEBUG - VM dnsserver is ready for SSH connections
2025-08-06 10:02:16,739 - INFO - Waiting for VM testvm1 to be up..
2025-08-06 10:02:16,847 - DEBUG - VM is in ACTIVE state now
2025-08-06 10:02:16,847 - INFO - VM name : testvm1
2025-08-06 10:02:16,958 - DEBUG - VM testvm1 ID is c8936c2e-27af-47c0-85cf-773081069330
2025-08-06 10:02:16,958 - DEBUG - VM testvm1 launched on Node an-jenkins-deploy-platform-ansible-os-3761-1
2025-08-06 10:02:17,180 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/c8936c2e-27af-47c0-85cf-773081069330
2025-08-06 10:02:17,193 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/09520fdf-e451-4edc-b2c1-6645e696f35d
2025-08-06 10:02:17,206 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/5ed00004-cc4f-4930-901d-aee01cfd855a
2025-08-06 10:02:18,421 - 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=5.56 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.747 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.747/3.151/5.556/2.404 ms')
2025-08-06 10:02:18,421 - INFO - Ping to Metadata IP 169.254.0.3 of VM testvm1 passed
2025-08-06 10:02:18,501 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:02:18,501 - DEBUG - Waiting to SSH to VM testvm1, IP 11.1.1.251, Port 22
2025-08-06 10:02:18,675 - DEBUG - VM testvm1 is ready for SSH connections
2025-08-06 10:02:18,855 - DEBUG - VM is in ACTIVE state now
2025-08-06 10:02:18,855 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:02:18,855 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf
2025-08-06 10:02:18,867 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/32a14af7-8503-433b-8547-9f88c88e2511
2025-08-06 10:02:18,880 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/65dacd9a-ac50-4088-8595-fbfbe3039809
2025-08-06 10:02:18,895 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf
2025-08-06 10:02:18,906 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/32a14af7-8503-433b-8547-9f88c88e2511
2025-08-06 10:02:18,918 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/65dacd9a-ac50-4088-8595-fbfbe3039809
2025-08-06 10:02:18,930 - DEBUG - Requesting: http://10.0.0.38:8082/instance-ip/c36835cc-d561-4ff5-b50e-97b215f17696
2025-08-06 10:02:18,943 - DEBUG - Requesting: http://10.0.0.38:8082/instance-ip/d875033f-bcb8-4dd3-b3ce-4024a849aae4
2025-08-06 10:02:18,955 - DEBUG - Verifying in api server 10.0.0.38
2025-08-06 10:02:18,956 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf
2025-08-06 10:02:18,967 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/32a14af7-8503-433b-8547-9f88c88e2511
2025-08-06 10:02:18,981 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/65dacd9a-ac50-4088-8595-fbfbe3039809
2025-08-06 10:02:18,995 - DEBUG - Requesting: http://10.0.0.38:8082/instance-ip/c36835cc-d561-4ff5-b50e-97b215f17696
2025-08-06 10:02:19,004 - DEBUG - Requesting: http://10.0.0.38:8082/instance-ip/d875033f-bcb8-4dd3-b3ce-4024a849aae4
2025-08-06 10:02:19,015 - INFO - VM dhcp-server verfication in all API Servers passed
2025-08-06 10:02:19,044 - DEBUG - VM dhcp-server Tap interface: {'index': '3', 'name': 'tap65dacd9a-ac', 'uuid': '65dacd9a-ac50-4088-8595-fbfbe3039809', 'vrf_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN:EVPN-MGMT-VN', 'active': 'Active', 'ipv4_active': 'Active', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Enable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Enable', 'type': 'vport', 'label': '27', 'l2_label': '31', 'vxlan_id': '8', 'vn_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN', 'vm_uuid': '7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf', 'vm_name': 'dhcp-server', 'ip_addr': '11.1.1.252', 'mac_addr': '02:65:da:cd:9a:ac', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.3', 'service_vlan_list': None, 'os_ifindex': '148', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:65dacd9a-ac50-4088-8595-fbfbe3039809', 'sg_uuid_list': ['0f0e26f9-2b52-4bc2-b4a2-22003d5b6c5d'], 'static_route_list': None, 'vm_project_uuid': '67ba8d08-c98d-4d52-9e6a-6a2badd3125d', 'admin_state': 'Enabled', 'flow_key_idx': '27', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Active', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '00000000-0000-0000-0000-000000000000', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []}
2025-08-06 10:02:19,045 - DEBUG - Agent 10.0.0.57 vrf name: default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN:EVPN-MGMT-VN
2025-08-06 10:02:19,056 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN:EVPN-MGMT-VN', 'ucindex': '2', 'mcindex': '2', 'l2index': '2', 'source': 'Config; ', 'uc6index': '2', 'vn': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN', 'table_label': '-1', 'vxlan_id': '8', 'evpnindex': '2', 'brindex': '2', 'mplsindex': '0', 'RD': '10.20.0.129:2', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]}
2025-08-06 10:02:19,149 - DEBUG - VM dhcp-server : Tap interface tap65dacd9a-ac is set to Active
2025-08-06 10:02:19,149 - DEBUG - Tap interface tap65dacd9a-ac detail : {'index': '3', 'name': 'tap65dacd9a-ac', 'uuid': '65dacd9a-ac50-4088-8595-fbfbe3039809', 'vrf_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN:EVPN-MGMT-VN', 'active': 'Active', 'ipv4_active': 'Active', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Enable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Enable', 'type': 'vport', 'label': '27', 'l2_label': '31', 'vxlan_id': '8', 'vn_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN', 'vm_uuid': '7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf', 'vm_name': 'dhcp-server', 'ip_addr': '11.1.1.252', 'mac_addr': '02:65:da:cd:9a:ac', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.3', 'service_vlan_list': None, 'os_ifindex': '148', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:65dacd9a-ac50-4088-8595-fbfbe3039809', 'sg_uuid_list': ['0f0e26f9-2b52-4bc2-b4a2-22003d5b6c5d'], 'static_route_list': None, 'vm_project_uuid': '67ba8d08-c98d-4d52-9e6a-6a2badd3125d', 'admin_state': 'Enabled', 'flow_key_idx': '27', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Active', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '00000000-0000-0000-0000-000000000000', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []}
2025-08-06 10:02:19,276 - DEBUG - Starting Layer 2 verification in Agent
2025-08-06 10:02:19,301 - DEBUG - Layer 2 path is seen for VM MAC 02:65:da:cd:9a:ac in agent 10.0.0.57
2025-08-06 10:02:19,302 - DEBUG - Active layer 2 route in agent is present for VMI tap65dacd9a-ac
2025-08-06 10:02:19,302 - DEBUG - vxlan_id (8) matches bw route table and interface table
2025-08-06 10:02:19,312 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is found in Agent of node 10.0.0.49
2025-08-06 10:02:19,412 - DEBUG - VRF IDs of VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is consistent in agent 10.0.0.49
2025-08-06 10:02:19,413 - DEBUG - Route for VM IP ['11.1.1.252'] is consistent in agent 10.0.0.49
2025-08-06 10:02:19,413 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN verification for VM dhcp-server in Agent 10.0.0.49 passed
2025-08-06 10:02:19,533 - DEBUG - Starting all layer 2 verification in agent 10.0.0.49
2025-08-06 10:02:19,548 - DEBUG - Route for VM MAC 02:65:da:cd:9a:ac is consistent in agent 10.0.0.49
2025-08-06 10:02:19,558 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is found in Agent of node 10.0.0.57
2025-08-06 10:02:19,701 - DEBUG - VRF IDs of VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is consistent in agent 10.0.0.57
2025-08-06 10:02:19,701 - DEBUG - Route for VM IP ['11.1.1.252'] is consistent in agent 10.0.0.57
2025-08-06 10:02:19,701 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN verification for VM dhcp-server in Agent 10.0.0.57 passed
2025-08-06 10:02:19,821 - DEBUG - Starting all layer 2 verification in agent 10.0.0.57
2025-08-06 10:02:19,847 - DEBUG - Route for VM MAC 02:65:da:cd:9a:ac is consistent in agent 10.0.0.57
2025-08-06 10:02:19,877 - DEBUG - VM dhcp-server Tap interface: {'index': '5', 'name': 'tap32a14af7-85', 'uuid': '32a14af7-8503-433b-8547-9f88c88e2511', 'vrf_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN:EVPN-L2-VN', 'active': 'Active', 'ipv4_active': 'Ipv4 Inactive < l3-disabled >', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < l3-disabled no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Disable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Disable', 'type': 'vport', 'label': '160253533', 'l2_label': '32', 'vxlan_id': '9', 'vn_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN', 'vm_uuid': '7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf', 'vm_name': 'dhcp-server', 'ip_addr': '44.1.1.251', 'mac_addr': '02:32:a1:4a:f7:85', 'policy': 'Disable', 'fip_list': [], 'mdata_ip_addr': '0.0.0.0', 'service_vlan_list': None, 'os_ifindex': '149', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:32a14af7-8503-433b-8547-9f88c88e2511', 'sg_uuid_list': ['0f0e26f9-2b52-4bc2-b4a2-22003d5b6c5d'], 'static_route_list': None, 'vm_project_uuid': '67ba8d08-c98d-4d52-9e6a-6a2badd3125d', 'admin_state': 'Enabled', 'flow_key_idx': '42', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Inactive', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '00000000-0000-0000-0000-000000000000', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []}
2025-08-06 10:02:19,877 - DEBUG - Agent 10.0.0.57 vrf name: default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN:EVPN-L2-VN
2025-08-06 10:02:19,885 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN:EVPN-L2-VN', 'ucindex': '3', 'mcindex': '3', 'l2index': '3', 'source': 'Config; ', 'uc6index': '3', 'vn': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN', 'table_label': '-1', 'vxlan_id': '9', 'evpnindex': '3', 'brindex': '3', 'mplsindex': '0', 'RD': '10.20.0.129:3', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]}
2025-08-06 10:02:19,961 - DEBUG - VM dhcp-server : Tap interface tap32a14af7-85 is set to Active
2025-08-06 10:02:19,961 - DEBUG - Tap interface tap32a14af7-85 detail : {'index': '5', 'name': 'tap32a14af7-85', 'uuid': '32a14af7-8503-433b-8547-9f88c88e2511', 'vrf_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN:EVPN-L2-VN', 'active': 'Active', 'ipv4_active': 'Ipv4 Inactive < l3-disabled >', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < l3-disabled no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Disable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Disable', 'type': 'vport', 'label': '160253533', 'l2_label': '32', 'vxlan_id': '9', 'vn_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN', 'vm_uuid': '7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf', 'vm_name': 'dhcp-server', 'ip_addr': '44.1.1.251', 'mac_addr': '02:32:a1:4a:f7:85', 'policy': 'Disable', 'fip_list': [], 'mdata_ip_addr': '0.0.0.0', 'service_vlan_list': None, 'os_ifindex': '149', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:32a14af7-8503-433b-8547-9f88c88e2511', 'sg_uuid_list': ['0f0e26f9-2b52-4bc2-b4a2-22003d5b6c5d'], 'static_route_list': None, 'vm_project_uuid': '67ba8d08-c98d-4d52-9e6a-6a2badd3125d', 'admin_state': 'Enabled', 'flow_key_idx': '42', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Inactive', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '00000000-0000-0000-0000-000000000000', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []}
2025-08-06 10:02:20,084 - DEBUG - Starting Layer 2 verification in Agent
2025-08-06 10:02:20,109 - DEBUG - Layer 2 path is seen for VM MAC 02:32:a1:4a:f7:85 in agent 10.0.0.57
2025-08-06 10:02:20,110 - DEBUG - Active layer 2 route in agent is present for VMI tap32a14af7-85
2025-08-06 10:02:20,110 - DEBUG - vxlan_id (9) matches bw route table and interface table
2025-08-06 10:02:20,125 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN is found in Agent of node 10.0.0.49
2025-08-06 10:02:20,204 - DEBUG - VRF IDs of VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN is consistent in agent 10.0.0.49
2025-08-06 10:02:20,205 - DEBUG - Route for VM IP ['44.1.1.251'] is consistent in agent 10.0.0.49
2025-08-06 10:02:20,205 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN verification for VM dhcp-server in Agent 10.0.0.49 passed
2025-08-06 10:02:20,321 - DEBUG - Starting all layer 2 verification in agent 10.0.0.49
2025-08-06 10:02:20,333 - DEBUG - Route for VM MAC 02:32:a1:4a:f7:85 is consistent in agent 10.0.0.49
2025-08-06 10:02:20,341 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN is found in Agent of node 10.0.0.57
2025-08-06 10:02:20,471 - DEBUG - VRF IDs of VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN is consistent in agent 10.0.0.57
2025-08-06 10:02:20,471 - DEBUG - Route for VM IP ['44.1.1.251'] is consistent in agent 10.0.0.57
2025-08-06 10:02:20,471 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN verification for VM dhcp-server in Agent 10.0.0.57 passed
2025-08-06 10:02:20,596 - DEBUG - Starting all layer 2 verification in agent 10.0.0.57
2025-08-06 10:02:20,614 - DEBUG - Route for VM MAC 02:32:a1:4a:f7:85 is consistent in agent 10.0.0.57
2025-08-06 10:02:20,614 - INFO - VM dhcp-server verifications in Compute nodes passed
2025-08-06 10:02:20,869 - DEBUG - Validated VM route 11.1.1.252 in vrouter of 10.0.0.49
2025-08-06 10:02:20,877 - DEBUG - Remote Nh validation passed. Expected Tunnel, label: 10.20.0.129, 27; Got 10.20.0.129,27
2025-08-06 10:02:20,877 - DEBUG - Validated VM route 11.1.1.252 in vrouter of 10.0.0.49
2025-08-06 10:02:21,066 - DEBUG - Validated VM route 11.1.1.252 in vrouter of 10.0.0.57
2025-08-06 10:02:21,078 - DEBUG - Remote Nh validation passed. Expected Tunnel, label: None, 0; Got None,0
2025-08-06 10:02:21,162 - INFO - Validated routes of VM dhcp-server in all vrouters
2025-08-06 10:02:21,895 - DEBUG - Starting all layer2 verification in 10.0.0.38 Control Node
2025-08-06 10:02:22,033 - DEBUG - Layer2 route found for VM MAC 02:65:da:cd:9a:ac in Control-node 10.0.0.38
2025-08-06 10:02:22,034 - DEBUG - L2 Label for VM dhcp-server same between Control-node 10.0.0.38 and Agent, Expected: 8, Seen: 8
2025-08-06 10:02:22,034 - DEBUG - Starting all layer2 verification in 10.0.0.254 Control Node
2025-08-06 10:02:22,170 - DEBUG - Layer2 route found for VM MAC 02:65:da:cd:9a:ac in Control-node 10.0.0.254
2025-08-06 10:02:22,170 - DEBUG - L2 Label for VM dhcp-server same between Control-node 10.0.0.254 and Agent, Expected: 8, Seen: 8
2025-08-06 10:02:22,170 - DEBUG - Starting all layer2 verification in 10.0.0.48 Control Node
2025-08-06 10:02:22,307 - DEBUG - Layer2 route found for VM MAC 02:65:da:cd:9a:ac in Control-node 10.0.0.48
2025-08-06 10:02:22,307 - DEBUG - L2 Label for VM dhcp-server same between Control-node 10.0.0.48 and Agent, Expected: 8, Seen: 8
2025-08-06 10:02:22,615 - DEBUG - Starting all layer2 verification in 10.0.0.38 Control Node
2025-08-06 10:02:22,749 - DEBUG - Layer2 route found for VM MAC 02:32:a1:4a:f7:85 in Control-node 10.0.0.38
2025-08-06 10:02:22,750 - DEBUG - L2 Label for VM dhcp-server same between Control-node 10.0.0.38 and Agent, Expected: 9, Seen: 9
2025-08-06 10:02:22,750 - DEBUG - Starting all layer2 verification in 10.0.0.254 Control Node
2025-08-06 10:02:22,897 - DEBUG - Layer2 route found for VM MAC 02:32:a1:4a:f7:85 in Control-node 10.0.0.254
2025-08-06 10:02:22,897 - DEBUG - L2 Label for VM dhcp-server same between Control-node 10.0.0.254 and Agent, Expected: 9, Seen: 9
2025-08-06 10:02:22,897 - DEBUG - Starting all layer2 verification in 10.0.0.48 Control Node
2025-08-06 10:02:23,029 - DEBUG - Layer2 route found for VM MAC 02:32:a1:4a:f7:85 in Control-node 10.0.0.48
2025-08-06 10:02:23,030 - DEBUG - L2 Label for VM dhcp-server same between Control-node 10.0.0.48 and Agent, Expected: 9, Seen: 9
2025-08-06 10:02:23,030 - INFO - Verification in Control-nodes for VM dhcp-server passed
2025-08-06 10:02:23,030 - DEBUG - Verifying the vm in opserver
2025-08-06 10:02:23,030 - DEBUG - Verifying in collector 10.0.0.38 ...
2025-08-06 10:02:23,030 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-machine/7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf?flat
2025-08-06 10:02:23,056 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:32a14af7-8503-433b-8547-9f88c88e2511?flat
2025-08-06 10:02:23,085 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:65dacd9a-ac50-4088-8595-fbfbe3039809?flat
2025-08-06 10:02:23,166 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:65dacd9a-ac50-4088-8595-fbfbe3039809?flat
2025-08-06 10:02:23,190 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:32a14af7-8503-433b-8547-9f88c88e2511?flat
2025-08-06 10:02:23,215 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:32a14af7-8503-433b-8547-9f88c88e2511?flat
2025-08-06 10:02:23,241 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-machine/7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf?flat
2025-08-06 10:02:23,309 - DEBUG - Verifying vm in vn uve
2025-08-06 10:02:23,309 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:32a14af7-8503-433b-8547-9f88c88e2511?flat
2025-08-06 10:02:23,335 - DEBUG - VM uve shows interface as {'rx_vlan': 65535, 'l2_active': True, 'ip6_active': False, 'ip4_active': False, 'is_health_check_active': True, 'virtual_network': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN', 'mac_address': '02:32:a1:4a:f7:85', 'admin_state': True, 'vn_uuid': '7c73dca8-0718-4642-aca2-750307130812', 'vhostuser_mode': 0, '__T': 1754474405982081, 'vm_uuid': '7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf', 'uuid': '32a14af7-8503-433b-8547-9f88c88e2511', 'ip6_address': '::', 'active': True, 'tx_vlan': 65535, 'fixed_ip4_list': ['44.1.1.251'], 'vm_name': 'dhcp-server', 'gateway': '44.1.1.254', 'ip_address': '44.1.1.251', 'label': 160253533, 'port_mirror_enabled': False}
2025-08-06 10:02:23,335 - DEBUG - VM uve shows ip address as ['44.1.1.251', '::']
2025-08-06 10:02:23,335 - DEBUG - VM uve shows virtual network as default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN
2025-08-06 10:02:23,335 - INFO - Verifying through opserver in 10.0.0.48
2025-08-06 10:02:23,336 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN?flat
2025-08-06 10:02:23,367 - DEBUG - expected vm list 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf
2025-08-06 10:02:23,367 - DEBUG - Extracted vm list ['7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf']
2025-08-06 10:02:23,367 - INFO - VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is present in default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN
2025-08-06 10:02:23,367 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:65dacd9a-ac50-4088-8595-fbfbe3039809?flat
2025-08-06 10:02:23,392 - DEBUG - VM uve shows interface as {'rx_vlan': 65535, 'l2_active': True, 'ip6_active': False, 'ip4_active': True, 'is_health_check_active': True, 'virtual_network': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN', 'mac_address': '02:65:da:cd:9a:ac', 'admin_state': True, 'vn_uuid': '7513ec28-f343-49b1-9176-64ed7d8009ec', 'vhostuser_mode': 0, '__T': 1754474405982107, 'vm_uuid': '7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf', 'uuid': '65dacd9a-ac50-4088-8595-fbfbe3039809', 'ip6_address': '::', 'active': True, 'tx_vlan': 65535, 'fixed_ip4_list': ['11.1.1.252'], 'vm_name': 'dhcp-server', 'gateway': '11.1.1.254', 'ip_address': '11.1.1.252', 'label': 27, 'port_mirror_enabled': False}
2025-08-06 10:02:23,392 - DEBUG - VM uve shows ip address as ['11.1.1.252', '::']
2025-08-06 10:02:23,392 - DEBUG - VM uve shows virtual network as default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN
2025-08-06 10:02:23,392 - INFO - Verifying through opserver in 10.0.0.48
2025-08-06 10:02:23,392 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN?flat
2025-08-06 10:02:23,429 - DEBUG - expected vm list 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf
2025-08-06 10:02:23,429 - DEBUG - Extracted vm list ['7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf']
2025-08-06 10:02:23,429 - INFO - VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is present in default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN
2025-08-06 10:02:23,429 - DEBUG - Verifying vm in vrouter uve
2025-08-06 10:02:23,429 - DEBUG - Getting info from collector 10.0.0.38..
2025-08-06 10:02:23,429 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-machine/7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf?flat
2025-08-06 10:02:23,447 - DEBUG - VM uve shows vrouter as ['an-jenkins-deploy-platform-ansible-os-3761-2']
2025-08-06 10:02:23,448 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-2:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:02:23,530 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-2?flat
2025-08-06 10:02:23,579 - DEBUG - VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:02:23,579 - DEBUG - Validated that VM dhcp-server is in Vrouter an-jenkins-deploy-platform-ansible-os-3761-2 UVE
2025-08-06 10:02:23,579 - DEBUG - Verifying vm tap interface/vn in vrouter uve
2025-08-06 10:02:23,593 - DEBUG - Expected tap interface of VM uuid 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is default-domain:ctest-TestEvpnCasesVxlan-69934149:32a14af7-8503-433b-8547-9f88c88e2511
2025-08-06 10:02:23,594 - DEBUG - Expected VN of VM uuid 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN
2025-08-06 10:02:23,594 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-2:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:02:23,663 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-2?flat
2025-08-06 10:02:23,753 - DEBUG - VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:02:23,753 - INFO - tap interface default-domain:ctest-TestEvpnCasesVxlan-69934149:32a14af7-8503-433b-8547-9f88c88e2511 of vm 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:02:23,753 - DEBUG - Connected network default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN of vm 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:02:23,753 - DEBUG - Expected tap interface of VM uuid 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is default-domain:ctest-TestEvpnCasesVxlan-69934149:65dacd9a-ac50-4088-8595-fbfbe3039809
2025-08-06 10:02:23,753 - DEBUG - Expected VN of VM uuid 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN
2025-08-06 10:02:23,753 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-2:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:02:23,813 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-2?flat
2025-08-06 10:02:23,861 - DEBUG - VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:02:23,861 - INFO - tap interface default-domain:ctest-TestEvpnCasesVxlan-69934149:65dacd9a-ac50-4088-8595-fbfbe3039809 of vm 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:02:23,861 - DEBUG - Connected network default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN of vm 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:02:23,861 - DEBUG - Verifying the 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf virtual network link through opserver 10.0.0.48
2025-08-06 10:02:23,861 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machines
2025-08-06 10:02:23,879 - DEBUG - VM link and name as {'name': '7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf', 'href': 'http://10.0.0.48:8081/analytics/uves/virtual-machine/7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf?flat'}
2025-08-06 10:02:23,879 - DEBUG - Verifying the 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf virtual network link through opserver 10.0.0.254
2025-08-06 10:02:23,879 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-machines
2025-08-06 10:02:23,897 - DEBUG - VM link and name as {'name': '7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-machine/7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf?flat'}
2025-08-06 10:02:23,897 - DEBUG - Verifying the 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf virtual network link through opserver 10.0.0.38
2025-08-06 10:02:23,897 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-machines
2025-08-06 10:02:23,913 - DEBUG - VM link and name as {'name': '7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-machine/7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf?flat'}
2025-08-06 10:02:23,913 - INFO - VM dhcp-server validations in Opserver passed
2025-08-06 10:02:24,017 - DEBUG - VM is in ACTIVE state now
2025-08-06 10:02:24,018 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:02:24,018 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/29c05397-49d6-4154-9ca1-c719f95d999b
2025-08-06 10:02:24,029 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/5d95f136-631d-44b8-9108-d1317d000726
2025-08-06 10:02:24,046 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/e05e3bb7-5e8e-4e38-bda8-b389bca6905e
2025-08-06 10:02:24,064 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/29c05397-49d6-4154-9ca1-c719f95d999b
2025-08-06 10:02:24,076 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/5d95f136-631d-44b8-9108-d1317d000726
2025-08-06 10:02:24,093 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/e05e3bb7-5e8e-4e38-bda8-b389bca6905e
2025-08-06 10:02:24,110 - DEBUG - Requesting: http://10.0.0.38:8082/instance-ip/ac541b1b-901e-4278-8eb8-e52dbbac8f9d
2025-08-06 10:02:24,128 - DEBUG - Requesting: http://10.0.0.38:8082/instance-ip/bbb88681-988b-4f6f-b2b6-96faaf7ce114
2025-08-06 10:02:24,145 - DEBUG - Verifying in api server 10.0.0.38
2025-08-06 10:02:24,145 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/29c05397-49d6-4154-9ca1-c719f95d999b
2025-08-06 10:02:24,157 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/5d95f136-631d-44b8-9108-d1317d000726
2025-08-06 10:02:24,172 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/e05e3bb7-5e8e-4e38-bda8-b389bca6905e
2025-08-06 10:02:24,192 - DEBUG - Requesting: http://10.0.0.38:8082/instance-ip/ac541b1b-901e-4278-8eb8-e52dbbac8f9d
2025-08-06 10:02:24,207 - DEBUG - Requesting: http://10.0.0.38:8082/instance-ip/bbb88681-988b-4f6f-b2b6-96faaf7ce114
2025-08-06 10:02:24,219 - INFO - VM dnsserver verfication in all API Servers passed
2025-08-06 10:02:24,263 - DEBUG - VM dnsserver Tap interface: {'index': '4', 'name': 'tap5d95f136-63', 'uuid': '5d95f136-631d-44b8-9108-d1317d000726', 'vrf_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN:EVPN-MGMT-VN', 'active': 'Active', 'ipv4_active': 'Active', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Enable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Enable', 'type': 'vport', 'label': '34', 'l2_label': '38', 'vxlan_id': '8', 'vn_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN', 'vm_uuid': '29c05397-49d6-4154-9ca1-c719f95d999b', 'vm_name': 'dnsserver', 'ip_addr': '11.1.1.250', 'mac_addr': '02:5d:95:f1:36:63', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.4', 'service_vlan_list': None, 'os_ifindex': '150', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:5d95f136-631d-44b8-9108-d1317d000726', 'sg_uuid_list': ['0f0e26f9-2b52-4bc2-b4a2-22003d5b6c5d'], 'static_route_list': None, 'vm_project_uuid': '67ba8d08-c98d-4d52-9e6a-6a2badd3125d', 'admin_state': 'Enabled', 'flow_key_idx': '38', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Active', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '00000000-0000-0000-0000-000000000000', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []}
2025-08-06 10:02:24,263 - DEBUG - Agent 10.0.0.57 vrf name: default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN:EVPN-MGMT-VN
2025-08-06 10:02:24,272 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN:EVPN-MGMT-VN', 'ucindex': '2', 'mcindex': '2', 'l2index': '2', 'source': 'Config; ', 'uc6index': '2', 'vn': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN', 'table_label': '-1', 'vxlan_id': '8', 'evpnindex': '2', 'brindex': '2', 'mplsindex': '0', 'RD': '10.20.0.129:2', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]}
2025-08-06 10:02:24,372 - DEBUG - VM dnsserver : Tap interface tap5d95f136-63 is set to Active
2025-08-06 10:02:24,373 - DEBUG - Tap interface tap5d95f136-63 detail : {'index': '4', 'name': 'tap5d95f136-63', 'uuid': '5d95f136-631d-44b8-9108-d1317d000726', 'vrf_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN:EVPN-MGMT-VN', 'active': 'Active', 'ipv4_active': 'Active', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Enable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Enable', 'type': 'vport', 'label': '34', 'l2_label': '38', 'vxlan_id': '8', 'vn_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN', 'vm_uuid': '29c05397-49d6-4154-9ca1-c719f95d999b', 'vm_name': 'dnsserver', 'ip_addr': '11.1.1.250', 'mac_addr': '02:5d:95:f1:36:63', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.4', 'service_vlan_list': None, 'os_ifindex': '150', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:5d95f136-631d-44b8-9108-d1317d000726', 'sg_uuid_list': ['0f0e26f9-2b52-4bc2-b4a2-22003d5b6c5d'], 'static_route_list': None, 'vm_project_uuid': '67ba8d08-c98d-4d52-9e6a-6a2badd3125d', 'admin_state': 'Enabled', 'flow_key_idx': '38', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Active', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '00000000-0000-0000-0000-000000000000', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []}
2025-08-06 10:02:24,498 - DEBUG - Starting Layer 2 verification in Agent
2025-08-06 10:02:24,518 - DEBUG - Layer 2 path is seen for VM MAC 02:5d:95:f1:36:63 in agent 10.0.0.57
2025-08-06 10:02:24,519 - DEBUG - Active layer 2 route in agent is present for VMI tap5d95f136-63
2025-08-06 10:02:24,519 - DEBUG - vxlan_id (8) matches bw route table and interface table
2025-08-06 10:02:24,527 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is found in Agent of node 10.0.0.49
2025-08-06 10:02:24,633 - DEBUG - VRF IDs of VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is consistent in agent 10.0.0.49
2025-08-06 10:02:24,634 - DEBUG - Route for VM IP ['11.1.1.250'] is consistent in agent 10.0.0.49
2025-08-06 10:02:24,634 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN verification for VM dnsserver in Agent 10.0.0.49 passed
2025-08-06 10:02:24,756 - DEBUG - Starting all layer 2 verification in agent 10.0.0.49
2025-08-06 10:02:24,776 - DEBUG - Route for VM MAC 02:5d:95:f1:36:63 is consistent in agent 10.0.0.49
2025-08-06 10:02:24,793 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is found in Agent of node 10.0.0.57
2025-08-06 10:02:24,907 - DEBUG - VRF IDs of VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is consistent in agent 10.0.0.57
2025-08-06 10:02:24,908 - DEBUG - Route for VM IP ['11.1.1.250'] is consistent in agent 10.0.0.57
2025-08-06 10:02:24,908 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN verification for VM dnsserver in Agent 10.0.0.57 passed
2025-08-06 10:02:25,024 - DEBUG - Starting all layer 2 verification in agent 10.0.0.57
2025-08-06 10:02:25,042 - DEBUG - Route for VM MAC 02:5d:95:f1:36:63 is consistent in agent 10.0.0.57
2025-08-06 10:02:25,068 - DEBUG - VM dnsserver Tap interface: {'index': '6', 'name': 'tape05e3bb7-5e', 'uuid': 'e05e3bb7-5e8e-4e38-bda8-b389bca6905e', 'vrf_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN:EVPN-L2-VN', 'active': 'Active', 'ipv4_active': 'Ipv4 Inactive < l3-disabled >', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < l3-disabled no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Disable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Disable', 'type': 'vport', 'label': '0', 'l2_label': '39', 'vxlan_id': '9', 'vn_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN', 'vm_uuid': '29c05397-49d6-4154-9ca1-c719f95d999b', 'vm_name': 'dnsserver', 'ip_addr': '44.1.1.250', 'mac_addr': '02:e0:5e:3b:b7:5e', 'policy': 'Disable', 'fip_list': [], 'mdata_ip_addr': '0.0.0.0', 'service_vlan_list': None, 'os_ifindex': '151', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:e05e3bb7-5e8e-4e38-bda8-b389bca6905e', 'sg_uuid_list': ['0f0e26f9-2b52-4bc2-b4a2-22003d5b6c5d'], 'static_route_list': None, 'vm_project_uuid': '67ba8d08-c98d-4d52-9e6a-6a2badd3125d', 'admin_state': 'Enabled', 'flow_key_idx': '41', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Inactive', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '00000000-0000-0000-0000-000000000000', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []}
2025-08-06 10:02:25,068 - DEBUG - Agent 10.0.0.57 vrf name: default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN:EVPN-L2-VN
2025-08-06 10:02:25,075 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN:EVPN-L2-VN', 'ucindex': '3', 'mcindex': '3', 'l2index': '3', 'source': 'Config; ', 'uc6index': '3', 'vn': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN', 'table_label': '-1', 'vxlan_id': '9', 'evpnindex': '3', 'brindex': '3', 'mplsindex': '0', 'RD': '10.20.0.129:3', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]}
2025-08-06 10:02:25,149 - DEBUG - VM dnsserver : Tap interface tape05e3bb7-5e is set to Active
2025-08-06 10:02:25,149 - DEBUG - Tap interface tape05e3bb7-5e detail : {'index': '6', 'name': 'tape05e3bb7-5e', 'uuid': 'e05e3bb7-5e8e-4e38-bda8-b389bca6905e', 'vrf_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN:EVPN-L2-VN', 'active': 'Active', 'ipv4_active': 'Ipv4 Inactive < l3-disabled >', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < l3-disabled no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Disable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Disable', 'type': 'vport', 'label': '0', 'l2_label': '39', 'vxlan_id': '9', 'vn_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN', 'vm_uuid': '29c05397-49d6-4154-9ca1-c719f95d999b', 'vm_name': 'dnsserver', 'ip_addr': '44.1.1.250', 'mac_addr': '02:e0:5e:3b:b7:5e', 'policy': 'Disable', 'fip_list': [], 'mdata_ip_addr': '0.0.0.0', 'service_vlan_list': None, 'os_ifindex': '151', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:e05e3bb7-5e8e-4e38-bda8-b389bca6905e', 'sg_uuid_list': ['0f0e26f9-2b52-4bc2-b4a2-22003d5b6c5d'], 'static_route_list': None, 'vm_project_uuid': '67ba8d08-c98d-4d52-9e6a-6a2badd3125d', 'admin_state': 'Enabled', 'flow_key_idx': '41', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Inactive', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '00000000-0000-0000-0000-000000000000', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []}
2025-08-06 10:02:25,267 - DEBUG - Starting Layer 2 verification in Agent
2025-08-06 10:02:25,285 - DEBUG - Layer 2 path is seen for VM MAC 02:e0:5e:3b:b7:5e in agent 10.0.0.57
2025-08-06 10:02:25,286 - DEBUG - Active layer 2 route in agent is present for VMI tape05e3bb7-5e
2025-08-06 10:02:25,286 - DEBUG - vxlan_id (9) matches bw route table and interface table
2025-08-06 10:02:25,293 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN is found in Agent of node 10.0.0.49
2025-08-06 10:02:25,420 - DEBUG - VRF IDs of VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN is consistent in agent 10.0.0.49
2025-08-06 10:02:25,420 - DEBUG - Route for VM IP ['44.1.1.250'] is consistent in agent 10.0.0.49
2025-08-06 10:02:25,420 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN verification for VM dnsserver in Agent 10.0.0.49 passed
2025-08-06 10:02:25,537 - DEBUG - Starting all layer 2 verification in agent 10.0.0.49
2025-08-06 10:02:25,550 - DEBUG - Route for VM MAC 02:e0:5e:3b:b7:5e is consistent in agent 10.0.0.49
2025-08-06 10:02:25,565 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN is found in Agent of node 10.0.0.57
2025-08-06 10:02:25,702 - DEBUG - VRF IDs of VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN is consistent in agent 10.0.0.57
2025-08-06 10:02:25,702 - DEBUG - Route for VM IP ['44.1.1.250'] is consistent in agent 10.0.0.57
2025-08-06 10:02:25,702 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN verification for VM dnsserver in Agent 10.0.0.57 passed
2025-08-06 10:02:25,818 - DEBUG - Starting all layer 2 verification in agent 10.0.0.57
2025-08-06 10:02:25,842 - DEBUG - Route for VM MAC 02:e0:5e:3b:b7:5e is consistent in agent 10.0.0.57
2025-08-06 10:02:25,842 - INFO - VM dnsserver verifications in Compute nodes passed
2025-08-06 10:02:26,095 - DEBUG - Validated VM route 11.1.1.250 in vrouter of 10.0.0.49
2025-08-06 10:02:26,101 - DEBUG - Remote Nh validation passed. Expected Tunnel, label: 10.20.0.129, 34; Got 10.20.0.129,34
2025-08-06 10:02:26,101 - DEBUG - Validated VM route 11.1.1.250 in vrouter of 10.0.0.49
2025-08-06 10:02:26,288 - DEBUG - Validated VM route 11.1.1.250 in vrouter of 10.0.0.57
2025-08-06 10:02:26,297 - DEBUG - Remote Nh validation passed. Expected Tunnel, label: None, 0; Got None,0
2025-08-06 10:02:26,375 - INFO - Validated routes of VM dnsserver in all vrouters
2025-08-06 10:02:27,103 - DEBUG - Starting all layer2 verification in 10.0.0.38 Control Node
2025-08-06 10:02:27,236 - DEBUG - Layer2 route found for VM MAC 02:5d:95:f1:36:63 in Control-node 10.0.0.38
2025-08-06 10:02:27,236 - DEBUG - L2 Label for VM dnsserver same between Control-node 10.0.0.38 and Agent, Expected: 8, Seen: 8
2025-08-06 10:02:27,236 - DEBUG - Starting all layer2 verification in 10.0.0.254 Control Node
2025-08-06 10:02:27,378 - DEBUG - Layer2 route found for VM MAC 02:5d:95:f1:36:63 in Control-node 10.0.0.254
2025-08-06 10:02:27,378 - DEBUG - L2 Label for VM dnsserver same between Control-node 10.0.0.254 and Agent, Expected: 8, Seen: 8
2025-08-06 10:02:27,378 - DEBUG - Starting all layer2 verification in 10.0.0.48 Control Node
2025-08-06 10:02:27,520 - DEBUG - Layer2 route found for VM MAC 02:5d:95:f1:36:63 in Control-node 10.0.0.48
2025-08-06 10:02:27,520 - DEBUG - L2 Label for VM dnsserver same between Control-node 10.0.0.48 and Agent, Expected: 8, Seen: 8
2025-08-06 10:02:27,826 - DEBUG - Starting all layer2 verification in 10.0.0.38 Control Node
2025-08-06 10:02:27,967 - DEBUG - Layer2 route found for VM MAC 02:e0:5e:3b:b7:5e in Control-node 10.0.0.38
2025-08-06 10:02:27,967 - DEBUG - L2 Label for VM dnsserver same between Control-node 10.0.0.38 and Agent, Expected: 9, Seen: 9
2025-08-06 10:02:27,967 - DEBUG - Starting all layer2 verification in 10.0.0.254 Control Node
2025-08-06 10:02:28,108 - DEBUG - Layer2 route found for VM MAC 02:e0:5e:3b:b7:5e in Control-node 10.0.0.254
2025-08-06 10:02:28,108 - DEBUG - L2 Label for VM dnsserver same between Control-node 10.0.0.254 and Agent, Expected: 9, Seen: 9
2025-08-06 10:02:28,108 - DEBUG - Starting all layer2 verification in 10.0.0.48 Control Node
2025-08-06 10:02:28,250 - DEBUG - Layer2 route found for VM MAC 02:e0:5e:3b:b7:5e in Control-node 10.0.0.48
2025-08-06 10:02:28,251 - DEBUG - L2 Label for VM dnsserver same between Control-node 10.0.0.48 and Agent, Expected: 9, Seen: 9
2025-08-06 10:02:28,251 - INFO - Verification in Control-nodes for VM dnsserver passed
2025-08-06 10:02:28,251 - DEBUG - Verifying the vm in opserver
2025-08-06 10:02:28,251 - DEBUG - Verifying in collector 10.0.0.38 ...
2025-08-06 10:02:28,251 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-machine/29c05397-49d6-4154-9ca1-c719f95d999b?flat
2025-08-06 10:02:28,271 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:5d95f136-631d-44b8-9108-d1317d000726?flat
2025-08-06 10:02:28,305 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:5d95f136-631d-44b8-9108-d1317d000726?flat
2025-08-06 10:02:28,338 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:5d95f136-631d-44b8-9108-d1317d000726?flat
2025-08-06 10:02:28,372 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:e05e3bb7-5e8e-4e38-bda8-b389bca6905e?flat
2025-08-06 10:02:28,405 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:e05e3bb7-5e8e-4e38-bda8-b389bca6905e?flat
2025-08-06 10:02:28,429 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-machine/29c05397-49d6-4154-9ca1-c719f95d999b?flat
2025-08-06 10:02:28,455 - DEBUG - Verifying vm in vn uve
2025-08-06 10:02:28,455 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:5d95f136-631d-44b8-9108-d1317d000726?flat
2025-08-06 10:02:28,493 - DEBUG - VM uve shows interface as {'rx_vlan': 65535, 'l2_active': True, 'ip6_active': False, 'ip4_active': True, 'is_health_check_active': True, 'virtual_network': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN', 'mac_address': '02:5d:95:f1:36:63', 'admin_state': True, 'vn_uuid': '7513ec28-f343-49b1-9176-64ed7d8009ec', 'vhostuser_mode': 0, '__T': 1754474405982099, 'vm_uuid': '29c05397-49d6-4154-9ca1-c719f95d999b', 'uuid': '5d95f136-631d-44b8-9108-d1317d000726', 'ip6_address': '::', 'active': True, 'tx_vlan': 65535, 'fixed_ip4_list': ['11.1.1.250'], 'vm_name': 'dnsserver', 'gateway': '11.1.1.254', 'ip_address': '11.1.1.250', 'label': 34, 'port_mirror_enabled': False}
2025-08-06 10:02:28,493 - DEBUG - VM uve shows ip address as ['11.1.1.250', '::']
2025-08-06 10:02:28,493 - DEBUG - VM uve shows virtual network as default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN
2025-08-06 10:02:28,493 - INFO - Verifying through opserver in 10.0.0.48
2025-08-06 10:02:28,494 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN?flat
2025-08-06 10:02:28,540 - DEBUG - expected vm list 29c05397-49d6-4154-9ca1-c719f95d999b
2025-08-06 10:02:28,540 - DEBUG - Extracted vm list ['29c05397-49d6-4154-9ca1-c719f95d999b']
2025-08-06 10:02:28,540 - INFO - VM 29c05397-49d6-4154-9ca1-c719f95d999b is present in default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN
2025-08-06 10:02:28,540 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:e05e3bb7-5e8e-4e38-bda8-b389bca6905e?flat
2025-08-06 10:02:28,582 - DEBUG - VM uve shows interface as {'rx_vlan': 65535, 'l2_active': True, 'ip6_active': False, 'ip4_active': False, 'is_health_check_active': True, 'virtual_network': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN', 'mac_address': '02:e0:5e:3b:b7:5e', 'admin_state': True, 'vn_uuid': '7c73dca8-0718-4642-aca2-750307130812', 'vhostuser_mode': 0, '__T': 1754474405982151, 'vm_uuid': '29c05397-49d6-4154-9ca1-c719f95d999b', 'uuid': 'e05e3bb7-5e8e-4e38-bda8-b389bca6905e', 'ip6_address': '::', 'active': True, 'tx_vlan': 65535, 'fixed_ip4_list': ['44.1.1.250'], 'vm_name': 'dnsserver', 'gateway': '44.1.1.254', 'ip_address': '44.1.1.250', 'label': 0, 'port_mirror_enabled': False}
2025-08-06 10:02:28,582 - DEBUG - VM uve shows ip address as ['44.1.1.250', '::']
2025-08-06 10:02:28,582 - DEBUG - VM uve shows virtual network as default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN
2025-08-06 10:02:28,582 - INFO - Verifying through opserver in 10.0.0.48
2025-08-06 10:02:28,582 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN?flat
2025-08-06 10:02:28,618 - DEBUG - expected vm list 29c05397-49d6-4154-9ca1-c719f95d999b
2025-08-06 10:02:28,618 - DEBUG - Extracted vm list ['29c05397-49d6-4154-9ca1-c719f95d999b']
2025-08-06 10:02:28,618 - INFO - VM 29c05397-49d6-4154-9ca1-c719f95d999b is present in default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN
2025-08-06 10:02:28,618 - DEBUG - Verifying vm in vrouter uve
2025-08-06 10:02:28,618 - DEBUG - Getting info from collector 10.0.0.38..
2025-08-06 10:02:28,618 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-machine/29c05397-49d6-4154-9ca1-c719f95d999b?flat
2025-08-06 10:02:28,640 - DEBUG - VM uve shows vrouter as ['an-jenkins-deploy-platform-ansible-os-3761-2']
2025-08-06 10:02:28,640 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-2:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:02:28,727 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-2?flat
2025-08-06 10:02:28,775 - DEBUG - VM 29c05397-49d6-4154-9ca1-c719f95d999b is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:02:28,776 - DEBUG - Validated that VM dnsserver is in Vrouter an-jenkins-deploy-platform-ansible-os-3761-2 UVE
2025-08-06 10:02:28,776 - DEBUG - Verifying vm tap interface/vn in vrouter uve
2025-08-06 10:02:28,793 - DEBUG - Expected tap interface of VM uuid 29c05397-49d6-4154-9ca1-c719f95d999b is default-domain:ctest-TestEvpnCasesVxlan-69934149:5d95f136-631d-44b8-9108-d1317d000726
2025-08-06 10:02:28,793 - DEBUG - Expected VN of VM uuid 29c05397-49d6-4154-9ca1-c719f95d999b is default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN
2025-08-06 10:02:28,793 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-2:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:02:28,875 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-2?flat
2025-08-06 10:02:28,927 - DEBUG - VM 29c05397-49d6-4154-9ca1-c719f95d999b is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:02:28,928 - INFO - tap interface default-domain:ctest-TestEvpnCasesVxlan-69934149:5d95f136-631d-44b8-9108-d1317d000726 of vm 29c05397-49d6-4154-9ca1-c719f95d999b is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:02:28,928 - DEBUG - Connected network default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN of vm 29c05397-49d6-4154-9ca1-c719f95d999b is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:02:28,928 - DEBUG - Expected tap interface of VM uuid 29c05397-49d6-4154-9ca1-c719f95d999b is default-domain:ctest-TestEvpnCasesVxlan-69934149:e05e3bb7-5e8e-4e38-bda8-b389bca6905e
2025-08-06 10:02:28,928 - DEBUG - Expected VN of VM uuid 29c05397-49d6-4154-9ca1-c719f95d999b is default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN
2025-08-06 10:02:28,928 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-2:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:02:29,006 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-2?flat
2025-08-06 10:02:29,057 - DEBUG - VM 29c05397-49d6-4154-9ca1-c719f95d999b is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:02:29,057 - INFO - tap interface default-domain:ctest-TestEvpnCasesVxlan-69934149:e05e3bb7-5e8e-4e38-bda8-b389bca6905e of vm 29c05397-49d6-4154-9ca1-c719f95d999b is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:02:29,057 - DEBUG - Connected network default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN of vm 29c05397-49d6-4154-9ca1-c719f95d999b is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:02:29,057 - DEBUG - Verifying the 29c05397-49d6-4154-9ca1-c719f95d999b virtual network link through opserver 10.0.0.48
2025-08-06 10:02:29,057 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machines
2025-08-06 10:02:29,075 - DEBUG - VM link and name as {'name': '29c05397-49d6-4154-9ca1-c719f95d999b', 'href': 'http://10.0.0.48:8081/analytics/uves/virtual-machine/29c05397-49d6-4154-9ca1-c719f95d999b?flat'}
2025-08-06 10:02:29,075 - DEBUG - Verifying the 29c05397-49d6-4154-9ca1-c719f95d999b virtual network link through opserver 10.0.0.254
2025-08-06 10:02:29,075 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-machines
2025-08-06 10:02:29,096 - DEBUG - VM link and name as {'name': '29c05397-49d6-4154-9ca1-c719f95d999b', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-machine/29c05397-49d6-4154-9ca1-c719f95d999b?flat'}
2025-08-06 10:02:29,096 - DEBUG - Verifying the 29c05397-49d6-4154-9ca1-c719f95d999b virtual network link through opserver 10.0.0.38
2025-08-06 10:02:29,096 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-machines
2025-08-06 10:02:29,114 - DEBUG - VM link and name as {'name': '29c05397-49d6-4154-9ca1-c719f95d999b', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-machine/29c05397-49d6-4154-9ca1-c719f95d999b?flat'}
2025-08-06 10:02:29,114 - INFO - VM dnsserver validations in Opserver passed
2025-08-06 10:02:29,229 - DEBUG - VM is in ACTIVE state now
2025-08-06 10:02:29,229 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:02:29,229 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/c8936c2e-27af-47c0-85cf-773081069330
2025-08-06 10:02:29,241 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/09520fdf-e451-4edc-b2c1-6645e696f35d
2025-08-06 10:02:29,257 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/5ed00004-cc4f-4930-901d-aee01cfd855a
2025-08-06 10:02:29,271 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/c8936c2e-27af-47c0-85cf-773081069330
2025-08-06 10:02:29,281 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/09520fdf-e451-4edc-b2c1-6645e696f35d
2025-08-06 10:02:29,294 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/5ed00004-cc4f-4930-901d-aee01cfd855a
2025-08-06 10:02:29,307 - DEBUG - Requesting: http://10.0.0.38:8082/instance-ip/9f8992be-bc05-4109-b941-e8fa2b69638d
2025-08-06 10:02:29,319 - DEBUG - Requesting: http://10.0.0.38:8082/instance-ip/9d553e96-112d-4006-9b0f-ab603a64efef
2025-08-06 10:02:29,331 - DEBUG - Verifying in api server 10.0.0.38
2025-08-06 10:02:29,332 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/c8936c2e-27af-47c0-85cf-773081069330
2025-08-06 10:02:29,341 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/09520fdf-e451-4edc-b2c1-6645e696f35d
2025-08-06 10:02:29,355 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/5ed00004-cc4f-4930-901d-aee01cfd855a
2025-08-06 10:02:29,370 - DEBUG - Requesting: http://10.0.0.38:8082/instance-ip/9f8992be-bc05-4109-b941-e8fa2b69638d
2025-08-06 10:02:29,380 - DEBUG - Requesting: http://10.0.0.38:8082/instance-ip/9d553e96-112d-4006-9b0f-ab603a64efef
2025-08-06 10:02:29,389 - INFO - VM testvm1 verfication in all API Servers passed
2025-08-06 10:02:29,411 - DEBUG - VM testvm1 Tap interface: {'index': '3', 'name': 'tap5ed00004-cc', 'uuid': '5ed00004-cc4f-4930-901d-aee01cfd855a', 'vrf_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN:EVPN-MGMT-VN', 'active': 'Active', 'ipv4_active': 'Active', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Enable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Enable', 'type': 'vport', 'label': '27', 'l2_label': '31', 'vxlan_id': '8', 'vn_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN', 'vm_uuid': 'c8936c2e-27af-47c0-85cf-773081069330', 'vm_name': 'testvm1', 'ip_addr': '11.1.1.251', 'mac_addr': '02:5e:d0:00:04:cc', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.3', 'service_vlan_list': None, 'os_ifindex': '180', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:5ed00004-cc4f-4930-901d-aee01cfd855a', 'sg_uuid_list': ['0f0e26f9-2b52-4bc2-b4a2-22003d5b6c5d'], 'static_route_list': None, 'vm_project_uuid': '67ba8d08-c98d-4d52-9e6a-6a2badd3125d', 'admin_state': 'Enabled', 'flow_key_idx': '33', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Active', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '00000000-0000-0000-0000-000000000000', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []}
2025-08-06 10:02:29,412 - DEBUG - Agent 10.0.0.49 vrf name: default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN:EVPN-MGMT-VN
2025-08-06 10:02:29,420 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN:EVPN-MGMT-VN', 'ucindex': '2', 'mcindex': '2', 'l2index': '2', 'source': 'Config; ', 'uc6index': '2', 'vn': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN', 'table_label': '-1', 'vxlan_id': '8', 'evpnindex': '2', 'brindex': '2', 'mplsindex': '0', 'RD': '10.20.0.193:2', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]}
2025-08-06 10:02:29,508 - DEBUG - VM testvm1 : Tap interface tap5ed00004-cc is set to Active
2025-08-06 10:02:29,508 - DEBUG - Tap interface tap5ed00004-cc detail : {'index': '3', 'name': 'tap5ed00004-cc', 'uuid': '5ed00004-cc4f-4930-901d-aee01cfd855a', 'vrf_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN:EVPN-MGMT-VN', 'active': 'Active', 'ipv4_active': 'Active', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Enable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Enable', 'type': 'vport', 'label': '27', 'l2_label': '31', 'vxlan_id': '8', 'vn_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN', 'vm_uuid': 'c8936c2e-27af-47c0-85cf-773081069330', 'vm_name': 'testvm1', 'ip_addr': '11.1.1.251', 'mac_addr': '02:5e:d0:00:04:cc', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.3', 'service_vlan_list': None, 'os_ifindex': '180', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:5ed00004-cc4f-4930-901d-aee01cfd855a', 'sg_uuid_list': ['0f0e26f9-2b52-4bc2-b4a2-22003d5b6c5d'], 'static_route_list': None, 'vm_project_uuid': '67ba8d08-c98d-4d52-9e6a-6a2badd3125d', 'admin_state': 'Enabled', 'flow_key_idx': '33', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Active', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '00000000-0000-0000-0000-000000000000', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []}
2025-08-06 10:02:29,632 - DEBUG - Starting Layer 2 verification in Agent
2025-08-06 10:02:29,643 - DEBUG - Layer 2 path is seen for VM MAC 02:5e:d0:00:04:cc in agent 10.0.0.49
2025-08-06 10:02:29,644 - DEBUG - Active layer 2 route in agent is present for VMI tap5ed00004-cc
2025-08-06 10:02:29,644 - DEBUG - vxlan_id (8) matches bw route table and interface table
2025-08-06 10:02:29,650 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is found in Agent of node 10.0.0.49
2025-08-06 10:02:29,801 - DEBUG - VRF IDs of VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is consistent in agent 10.0.0.49
2025-08-06 10:02:29,801 - DEBUG - Route for VM IP ['11.1.1.251'] is consistent in agent 10.0.0.49
2025-08-06 10:02:29,801 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN verification for VM testvm1 in Agent 10.0.0.49 passed
2025-08-06 10:02:29,917 - DEBUG - Starting all layer 2 verification in agent 10.0.0.49
2025-08-06 10:02:29,932 - DEBUG - Route for VM MAC 02:5e:d0:00:04:cc is consistent in agent 10.0.0.49
2025-08-06 10:02:29,938 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is found in Agent of node 10.0.0.57
2025-08-06 10:02:30,078 - DEBUG - VRF IDs of VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN is consistent in agent 10.0.0.57
2025-08-06 10:02:30,078 - DEBUG - Route for VM IP ['11.1.1.251'] is consistent in agent 10.0.0.57
2025-08-06 10:02:30,078 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN verification for VM testvm1 in Agent 10.0.0.57 passed
2025-08-06 10:02:30,198 - DEBUG - Starting all layer 2 verification in agent 10.0.0.57
2025-08-06 10:02:30,220 - DEBUG - Route for VM MAC 02:5e:d0:00:04:cc is consistent in agent 10.0.0.57
2025-08-06 10:02:30,247 - DEBUG - VM testvm1 Tap interface: {'index': '4', 'name': 'tap09520fdf-e4', 'uuid': '09520fdf-e451-4edc-b2c1-6645e696f35d', 'vrf_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN:EVPN-L2-VN', 'active': 'Active', 'ipv4_active': 'Ipv4 Inactive < l3-disabled >', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < l3-disabled no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Disable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Disable', 'type': 'vport', 'label': '1749229669', 'l2_label': '32', 'vxlan_id': '9', 'vn_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN', 'vm_uuid': 'c8936c2e-27af-47c0-85cf-773081069330', 'vm_name': 'testvm1', 'ip_addr': '44.1.1.252', 'mac_addr': '02:09:52:0f:df:e4', 'policy': 'Disable', 'fip_list': [], 'mdata_ip_addr': '0.0.0.0', 'service_vlan_list': None, 'os_ifindex': '181', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:09520fdf-e451-4edc-b2c1-6645e696f35d', 'sg_uuid_list': ['0f0e26f9-2b52-4bc2-b4a2-22003d5b6c5d'], 'static_route_list': None, 'vm_project_uuid': '67ba8d08-c98d-4d52-9e6a-6a2badd3125d', 'admin_state': 'Enabled', 'flow_key_idx': '44', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Inactive', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '00000000-0000-0000-0000-000000000000', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []}
2025-08-06 10:02:30,247 - DEBUG - Agent 10.0.0.49 vrf name: default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN:EVPN-L2-VN
2025-08-06 10:02:30,254 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN:EVPN-L2-VN', 'ucindex': '3', 'mcindex': '3', 'l2index': '3', 'source': 'Config; ', 'uc6index': '3', 'vn': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN', 'table_label': '-1', 'vxlan_id': '9', 'evpnindex': '3', 'brindex': '3', 'mplsindex': '0', 'RD': '10.20.0.193:3', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]}
2025-08-06 10:02:30,330 - DEBUG - VM testvm1 : Tap interface tap09520fdf-e4 is set to Active
2025-08-06 10:02:30,330 - DEBUG - Tap interface tap09520fdf-e4 detail : {'index': '4', 'name': 'tap09520fdf-e4', 'uuid': '09520fdf-e451-4edc-b2c1-6645e696f35d', 'vrf_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN:EVPN-L2-VN', 'active': 'Active', 'ipv4_active': 'Ipv4 Inactive < l3-disabled >', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < l3-disabled no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Disable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Disable', 'type': 'vport', 'label': '1749229669', 'l2_label': '32', 'vxlan_id': '9', 'vn_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN', 'vm_uuid': 'c8936c2e-27af-47c0-85cf-773081069330', 'vm_name': 'testvm1', 'ip_addr': '44.1.1.252', 'mac_addr': '02:09:52:0f:df:e4', 'policy': 'Disable', 'fip_list': [], 'mdata_ip_addr': '0.0.0.0', 'service_vlan_list': None, 'os_ifindex': '181', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:09520fdf-e451-4edc-b2c1-6645e696f35d', 'sg_uuid_list': ['0f0e26f9-2b52-4bc2-b4a2-22003d5b6c5d'], 'static_route_list': None, 'vm_project_uuid': '67ba8d08-c98d-4d52-9e6a-6a2badd3125d', 'admin_state': 'Enabled', 'flow_key_idx': '44', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Inactive', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '00000000-0000-0000-0000-000000000000', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []}
2025-08-06 10:02:30,454 - DEBUG - Starting Layer 2 verification in Agent
2025-08-06 10:02:30,471 - DEBUG - Layer 2 path is seen for VM MAC 02:09:52:0f:df:e4 in agent 10.0.0.49
2025-08-06 10:02:30,471 - DEBUG - Active layer 2 route in agent is present for VMI tap09520fdf-e4
2025-08-06 10:02:30,471 - DEBUG - vxlan_id (9) matches bw route table and interface table
2025-08-06 10:02:30,479 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN is found in Agent of node 10.0.0.49
2025-08-06 10:02:30,606 - DEBUG - VRF IDs of VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN is consistent in agent 10.0.0.49
2025-08-06 10:02:30,606 - DEBUG - Route for VM IP ['44.1.1.252'] is consistent in agent 10.0.0.49
2025-08-06 10:02:30,606 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN verification for VM testvm1 in Agent 10.0.0.49 passed
2025-08-06 10:02:30,725 - DEBUG - Starting all layer 2 verification in agent 10.0.0.49
2025-08-06 10:02:30,739 - DEBUG - Route for VM MAC 02:09:52:0f:df:e4 is consistent in agent 10.0.0.49
2025-08-06 10:02:30,746 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN is found in Agent of node 10.0.0.57
2025-08-06 10:02:30,869 - DEBUG - VRF IDs of VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN is consistent in agent 10.0.0.57
2025-08-06 10:02:30,869 - DEBUG - Route for VM IP ['44.1.1.252'] is consistent in agent 10.0.0.57
2025-08-06 10:02:30,869 - DEBUG - VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN verification for VM testvm1 in Agent 10.0.0.57 passed
2025-08-06 10:02:30,984 - DEBUG - Starting all layer 2 verification in agent 10.0.0.57
2025-08-06 10:02:31,006 - DEBUG - Route for VM MAC 02:09:52:0f:df:e4 is consistent in agent 10.0.0.57
2025-08-06 10:02:31,006 - INFO - VM testvm1 verifications in Compute nodes passed
2025-08-06 10:02:31,244 - DEBUG - Validated VM route 11.1.1.251 in vrouter of 10.0.0.49
2025-08-06 10:02:31,251 - DEBUG - Remote Nh validation passed. Expected Tunnel, label: None, 0; Got None,0
2025-08-06 10:02:31,460 - DEBUG - Validated VM route 11.1.1.251 in vrouter of 10.0.0.57
2025-08-06 10:02:31,468 - DEBUG - Remote Nh validation passed. Expected Tunnel, label: 10.20.0.193, 27; Got 10.20.0.193,27
2025-08-06 10:02:31,468 - DEBUG - Validated VM route 11.1.1.251 in vrouter of 10.0.0.57
2025-08-06 10:02:31,544 - INFO - Validated routes of VM testvm1 in all vrouters
2025-08-06 10:02:32,261 - DEBUG - Starting all layer2 verification in 10.0.0.38 Control Node
2025-08-06 10:02:32,399 - DEBUG - Layer2 route found for VM MAC 02:5e:d0:00:04:cc in Control-node 10.0.0.38
2025-08-06 10:02:32,400 - DEBUG - L2 Label for VM testvm1 same between Control-node 10.0.0.38 and Agent, Expected: 8, Seen: 8
2025-08-06 10:02:32,400 - DEBUG - Starting all layer2 verification in 10.0.0.254 Control Node
2025-08-06 10:02:32,543 - DEBUG - Layer2 route found for VM MAC 02:5e:d0:00:04:cc in Control-node 10.0.0.254
2025-08-06 10:02:32,543 - DEBUG - L2 Label for VM testvm1 same between Control-node 10.0.0.254 and Agent, Expected: 8, Seen: 8
2025-08-06 10:02:32,543 - DEBUG - Starting all layer2 verification in 10.0.0.48 Control Node
2025-08-06 10:02:32,696 - DEBUG - Layer2 route found for VM MAC 02:5e:d0:00:04:cc in Control-node 10.0.0.48
2025-08-06 10:02:32,696 - DEBUG - L2 Label for VM testvm1 same between Control-node 10.0.0.48 and Agent, Expected: 8, Seen: 8
2025-08-06 10:02:32,997 - DEBUG - Starting all layer2 verification in 10.0.0.38 Control Node
2025-08-06 10:02:33,136 - DEBUG - Layer2 route found for VM MAC 02:09:52:0f:df:e4 in Control-node 10.0.0.38
2025-08-06 10:02:33,136 - DEBUG - L2 Label for VM testvm1 same between Control-node 10.0.0.38 and Agent, Expected: 9, Seen: 9
2025-08-06 10:02:33,136 - DEBUG - Starting all layer2 verification in 10.0.0.254 Control Node
2025-08-06 10:02:33,280 - DEBUG - Layer2 route found for VM MAC 02:09:52:0f:df:e4 in Control-node 10.0.0.254
2025-08-06 10:02:33,280 - DEBUG - L2 Label for VM testvm1 same between Control-node 10.0.0.254 and Agent, Expected: 9, Seen: 9
2025-08-06 10:02:33,281 - DEBUG - Starting all layer2 verification in 10.0.0.48 Control Node
2025-08-06 10:02:33,422 - DEBUG - Layer2 route found for VM MAC 02:09:52:0f:df:e4 in Control-node 10.0.0.48
2025-08-06 10:02:33,423 - DEBUG - L2 Label for VM testvm1 same between Control-node 10.0.0.48 and Agent, Expected: 9, Seen: 9
2025-08-06 10:02:33,423 - INFO - Verification in Control-nodes for VM testvm1 passed
2025-08-06 10:02:33,423 - DEBUG - Verifying the vm in opserver
2025-08-06 10:02:33,423 - DEBUG - Verifying in collector 10.0.0.38 ...
2025-08-06 10:02:33,423 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-machine/c8936c2e-27af-47c0-85cf-773081069330?flat
2025-08-06 10:02:33,444 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:09520fdf-e451-4edc-b2c1-6645e696f35d?flat
2025-08-06 10:02:33,473 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:5ed00004-cc4f-4930-901d-aee01cfd855a?flat
2025-08-06 10:02:33,502 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:5ed00004-cc4f-4930-901d-aee01cfd855a?flat
2025-08-06 10:02:33,531 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:09520fdf-e451-4edc-b2c1-6645e696f35d?flat
2025-08-06 10:02:33,563 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:09520fdf-e451-4edc-b2c1-6645e696f35d?flat
2025-08-06 10:02:33,592 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-machine/c8936c2e-27af-47c0-85cf-773081069330?flat
2025-08-06 10:02:33,610 - DEBUG - Verifying vm in vn uve
2025-08-06 10:02:33,610 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:09520fdf-e451-4edc-b2c1-6645e696f35d?flat
2025-08-06 10:02:33,640 - DEBUG - VM uve shows interface as {'rx_vlan': 65535, 'l2_active': True, 'ip6_active': False, 'ip4_active': False, 'is_health_check_active': True, 'virtual_network': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN', 'mac_address': '02:09:52:0f:df:e4', 'admin_state': True, 'vn_uuid': '7c73dca8-0718-4642-aca2-750307130812', 'vhostuser_mode': 0, '__T': 1754474366779823, 'vm_uuid': 'c8936c2e-27af-47c0-85cf-773081069330', 'uuid': '09520fdf-e451-4edc-b2c1-6645e696f35d', 'ip6_address': '::', 'active': True, 'tx_vlan': 65535, 'fixed_ip4_list': ['44.1.1.252'], 'vm_name': 'testvm1', 'gateway': '44.1.1.254', 'ip_address': '44.1.1.252', 'label': 1749229669, 'port_mirror_enabled': False}
2025-08-06 10:02:33,640 - DEBUG - VM uve shows ip address as ['44.1.1.252', '::']
2025-08-06 10:02:33,640 - DEBUG - VM uve shows virtual network as default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN
2025-08-06 10:02:33,640 - INFO - Verifying through opserver in 10.0.0.48
2025-08-06 10:02:33,640 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN?flat
2025-08-06 10:02:33,688 - DEBUG - expected vm list c8936c2e-27af-47c0-85cf-773081069330
2025-08-06 10:02:33,688 - DEBUG - Extracted vm list ['c8936c2e-27af-47c0-85cf-773081069330']
2025-08-06 10:02:33,688 - INFO - VM c8936c2e-27af-47c0-85cf-773081069330 is present in default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN
2025-08-06 10:02:33,688 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machine-interface/default-domain:ctest-TestEvpnCasesVxlan-69934149:5ed00004-cc4f-4930-901d-aee01cfd855a?flat
2025-08-06 10:02:33,713 - DEBUG - VM uve shows interface as {'rx_vlan': 65535, 'l2_active': True, 'ip6_active': False, 'ip4_active': True, 'is_health_check_active': True, 'virtual_network': 'default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN', 'mac_address': '02:5e:d0:00:04:cc', 'admin_state': True, 'vn_uuid': '7513ec28-f343-49b1-9176-64ed7d8009ec', 'vhostuser_mode': 0, '__T': 1754474366779847, 'vm_uuid': 'c8936c2e-27af-47c0-85cf-773081069330', 'uuid': '5ed00004-cc4f-4930-901d-aee01cfd855a', 'ip6_address': '::', 'active': True, 'tx_vlan': 65535, 'fixed_ip4_list': ['11.1.1.251'], 'vm_name': 'testvm1', 'gateway': '11.1.1.254', 'ip_address': '11.1.1.251', 'label': 27, 'port_mirror_enabled': False}
2025-08-06 10:02:33,713 - DEBUG - VM uve shows ip address as ['11.1.1.251', '::']
2025-08-06 10:02:33,714 - DEBUG - VM uve shows virtual network as default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN
2025-08-06 10:02:33,714 - INFO - Verifying through opserver in 10.0.0.48
2025-08-06 10:02:33,714 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN?flat
2025-08-06 10:02:33,766 - DEBUG - expected vm list c8936c2e-27af-47c0-85cf-773081069330
2025-08-06 10:02:33,766 - DEBUG - Extracted vm list ['c8936c2e-27af-47c0-85cf-773081069330']
2025-08-06 10:02:33,766 - INFO - VM c8936c2e-27af-47c0-85cf-773081069330 is present in default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN
2025-08-06 10:02:33,766 - DEBUG - Verifying vm in vrouter uve
2025-08-06 10:02:33,766 - DEBUG - Getting info from collector 10.0.0.38..
2025-08-06 10:02:33,766 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-machine/c8936c2e-27af-47c0-85cf-773081069330?flat
2025-08-06 10:02:33,789 - DEBUG - VM uve shows vrouter as ['an-jenkins-deploy-platform-ansible-os-3761-1']
2025-08-06 10:02:33,790 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-1:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:02:33,855 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-1?flat
2025-08-06 10:02:33,901 - DEBUG - VM c8936c2e-27af-47c0-85cf-773081069330 is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-1 uve
2025-08-06 10:02:33,902 - DEBUG - Validated that VM testvm1 is in Vrouter an-jenkins-deploy-platform-ansible-os-3761-1 UVE
2025-08-06 10:02:33,902 - DEBUG - Verifying vm tap interface/vn in vrouter uve
2025-08-06 10:02:33,910 - DEBUG - Expected tap interface of VM uuid c8936c2e-27af-47c0-85cf-773081069330 is default-domain:ctest-TestEvpnCasesVxlan-69934149:09520fdf-e451-4edc-b2c1-6645e696f35d
2025-08-06 10:02:33,911 - DEBUG - Expected VN of VM uuid c8936c2e-27af-47c0-85cf-773081069330 is default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN
2025-08-06 10:02:33,911 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-1:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:02:33,981 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-1?flat
2025-08-06 10:02:34,032 - DEBUG - VM c8936c2e-27af-47c0-85cf-773081069330 is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-1 uve
2025-08-06 10:02:34,032 - INFO - tap interface default-domain:ctest-TestEvpnCasesVxlan-69934149:09520fdf-e451-4edc-b2c1-6645e696f35d of vm c8936c2e-27af-47c0-85cf-773081069330 is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-1 uve
2025-08-06 10:02:34,032 - DEBUG - Connected network default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN of vm c8936c2e-27af-47c0-85cf-773081069330 is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-1 uve
2025-08-06 10:02:34,032 - DEBUG - Expected tap interface of VM uuid c8936c2e-27af-47c0-85cf-773081069330 is default-domain:ctest-TestEvpnCasesVxlan-69934149:5ed00004-cc4f-4930-901d-aee01cfd855a
2025-08-06 10:02:34,032 - DEBUG - Expected VN of VM uuid c8936c2e-27af-47c0-85cf-773081069330 is default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN
2025-08-06 10:02:34,032 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-1:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:02:34,099 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-1?flat
2025-08-06 10:02:34,148 - DEBUG - VM c8936c2e-27af-47c0-85cf-773081069330 is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-1 uve
2025-08-06 10:02:34,148 - INFO - tap interface default-domain:ctest-TestEvpnCasesVxlan-69934149:5ed00004-cc4f-4930-901d-aee01cfd855a of vm c8936c2e-27af-47c0-85cf-773081069330 is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-1 uve
2025-08-06 10:02:34,148 - DEBUG - Connected network default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN of vm c8936c2e-27af-47c0-85cf-773081069330 is present in vrouter an-jenkins-deploy-platform-ansible-os-3761-1 uve
2025-08-06 10:02:34,148 - DEBUG - Verifying the c8936c2e-27af-47c0-85cf-773081069330 virtual network link through opserver 10.0.0.48
2025-08-06 10:02:34,148 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machines
2025-08-06 10:02:34,169 - DEBUG - VM link and name as {'name': 'c8936c2e-27af-47c0-85cf-773081069330', 'href': 'http://10.0.0.48:8081/analytics/uves/virtual-machine/c8936c2e-27af-47c0-85cf-773081069330?flat'}
2025-08-06 10:02:34,169 - DEBUG - Verifying the c8936c2e-27af-47c0-85cf-773081069330 virtual network link through opserver 10.0.0.254
2025-08-06 10:02:34,169 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-machines
2025-08-06 10:02:34,189 - DEBUG - VM link and name as {'name': 'c8936c2e-27af-47c0-85cf-773081069330', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-machine/c8936c2e-27af-47c0-85cf-773081069330?flat'}
2025-08-06 10:02:34,189 - DEBUG - Verifying the c8936c2e-27af-47c0-85cf-773081069330 virtual network link through opserver 10.0.0.38
2025-08-06 10:02:34,189 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-machines
2025-08-06 10:02:34,208 - DEBUG - VM link and name as {'name': 'c8936c2e-27af-47c0-85cf-773081069330', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-machine/c8936c2e-27af-47c0-85cf-773081069330?flat'}
2025-08-06 10:02:34,208 - INFO - VM testvm1 validations in Opserver passed
2025-08-06 10:02:34,208 - DEBUG - Running remote_cmd, Cmd : ifconfig eth1 up, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.57, gateway password: c0ntrail123
2025-08-06 10:02:34,208 - DEBUG - ifconfig eth1 up
2025-08-06 10:02:45,566 - DEBUG - sudo: unable to resolve host dhcp-server
2025-08-06 10:02:45,567 - DEBUG - Running remote_cmd, Cmd : ifconfig, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.57, gateway password: c0ntrail123
2025-08-06 10:02:45,567 - DEBUG - ifconfig
2025-08-06 10:02:46,745 - DEBUG - sudo: unable to resolve host dhcp-server
eth0 Link encap:Ethernet HWaddr 02:65:da:cd:9a:ac
inet addr:11.1.1.252 Bcast:11.1.1.255 Mask:255.255.255.0
inet6 addr: fe80::65:daff:fecd:9aac/64 Scope:Link
UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
RX packets:419 errors:0 dropped:0 overruns:0 frame:0
TX packets:433 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:1000
RX bytes:45294 (45.2 KB) TX bytes:36924 (36.9 KB)
eth1 Link encap:Ethernet HWaddr 02:32:a1:4a:f7:85
inet6 addr: fe80::32:a1ff:fe4a:f785/64 Scope:Link
UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
RX packets:9 errors:0 dropped:0 overruns:0 frame:0
TX packets:2 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:1000
RX bytes:686 (686.0 B) TX bytes:168 (168.0 B)
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:65536 Metric:1
RX packets:8 errors:0 dropped:0 overruns:0 frame:0
TX packets:8 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:0
RX bytes:400 (400.0 B) TX bytes:400 (400.0 B)
2025-08-06 10:02:46,745 - DEBUG - Running remote_cmd, Cmd : ifconfig eth1 13.1.1.252 netmask 255.255.255.0, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.57, gateway password: c0ntrail123
2025-08-06 10:02:46,745 - DEBUG - ifconfig eth1 13.1.1.252 netmask 255.255.255.0
2025-08-06 10:02:47,389 - DEBUG - sudo: unable to resolve host dhcp-server
2025-08-06 10:02:47,389 - DEBUG - Running remote_cmd, Cmd : service isc-dhcp-server restart, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.57, gateway password: c0ntrail123
2025-08-06 10:02:47,389 - DEBUG - service isc-dhcp-server restart
2025-08-06 10:02:49,642 - DEBUG - sudo: unable to resolve host dhcp-server
isc-dhcp-server stop/waiting
isc-dhcp-server start/running, process 1419
2025-08-06 10:02:49,642 - DEBUG - Running remote_cmd, Cmd : ifconfig eth1 up, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.57, gateway password: c0ntrail123
2025-08-06 10:02:49,643 - DEBUG - ifconfig eth1 up
2025-08-06 10:02:54,822 - DEBUG - sudo: unable to resolve host dnsserver
2025-08-06 10:02:54,822 - DEBUG - Running remote_cmd, Cmd : ifconfig, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.57, gateway password: c0ntrail123
2025-08-06 10:02:54,822 - DEBUG - ifconfig
2025-08-06 10:02:55,610 - DEBUG - sudo: unable to resolve host dnsserver
eth0 Link encap:Ethernet HWaddr 02:5d:95:f1:36:63
inet addr:11.1.1.250 Bcast:11.1.1.255 Mask:255.255.255.0
inet6 addr: fe80::5d:95ff:fef1:3663/64 Scope:Link
UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
RX packets:408 errors:0 dropped:0 overruns:0 frame:0
TX packets:447 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:1000
RX bytes:43046 (43.0 KB) TX bytes:37824 (37.8 KB)
eth1 Link encap:Ethernet HWaddr 02:e0:5e:3b:b7:5e
inet6 addr: fe80::e0:5eff:fe3b:b75e/64 Scope:Link
UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
RX packets:14 errors:0 dropped:0 overruns:0 frame:0
TX packets:1 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:1000
RX bytes:1128 (1.1 KB) TX bytes:90 (90.0 B)
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:65536 Metric:1
RX packets:8 errors:0 dropped:0 overruns:0 frame:0
TX packets:8 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:0
RX bytes:400 (400.0 B) TX bytes:400 (400.0 B)
2025-08-06 10:02:55,610 - DEBUG - Running remote_cmd, Cmd : ifconfig eth1 13.1.1.253 netmask 255.255.255.0, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.57, gateway password: c0ntrail123
2025-08-06 10:02:55,610 - DEBUG - ifconfig eth1 13.1.1.253 netmask 255.255.255.0
2025-08-06 10:02:56,252 - DEBUG - sudo: unable to resolve host dnsserver
2025-08-06 10:02:56,252 - DEBUG - Running remote_cmd, Cmd : service bind9 restart, host_string: ubuntu@169.254.0.4, password: ubuntugateway: ubuntu@10.0.0.57, gateway password: c0ntrail123
2025-08-06 10:02:56,252 - DEBUG - service bind9 restart
2025-08-06 10:03:00,147 - DEBUG - sudo: unable to resolve host dnsserver
* Stopping domain name service... bind9
waiting for pid 1171 to die
...done.
* Starting domain name service... bind9
...done.
2025-08-06 10:03:00,147 - DEBUG - Running remote_cmd, Cmd : ifconfig eth1 up, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123
2025-08-06 10:03:00,147 - DEBUG - ifconfig eth1 up
2025-08-06 10:03:36,856 - DEBUG - None
2025-08-06 10:03:36,856 - DEBUG - Running remote_cmd, Cmd : ifconfig, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123
2025-08-06 10:03:36,857 - DEBUG - ifconfig
2025-08-06 10:03:37,381 - DEBUG - eth0 Link encap:Ethernet HWaddr 02:5e:d0:00:04:cc
inet addr:11.1.1.251 Bcast:11.1.1.255 Mask:255.255.255.0
inet6 addr: fe80::5e:d0ff:fe00:4cc/64 Scope:Link
UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
RX packets:405 errors:0 dropped:0 overruns:0 frame:0
TX packets:366 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:1000
RX bytes:35424 (35.4 KB) TX bytes:29150 (29.1 KB)
eth1 Link encap:Ethernet HWaddr 02:09:52:0f:df:e4
inet6 addr: fe80::9:52ff:fe0f:dfe4/64 Scope:Link
UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
RX packets:19 errors:0 dropped:0 overruns:0 frame:0
TX packets:0 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:1000
RX bytes:1566 (1.5 KB) TX bytes:0 (0.0 B)
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-08-06 10:03:37,381 - INFO - Retry 0 for bringing up eth1 up
2025-08-06 10:03:37,382 - DEBUG - Running remote_cmd, Cmd : dhclient eth1, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123
2025-08-06 10:03:37,382 - DEBUG - dhclient eth1
2025-08-06 10:03:40,509 - DEBUG - sethostname BEGIN
declare -x BASH_ENV=""
declare -x BASH_XTRACEFD=""
declare -x CDPATH=""
declare -x ENV=""
declare -x GLOBIGNORE=""
declare -x OLDPWD
declare -x PATH="/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin"
declare -x PWD="/home/ubuntu"
declare -x SHLVL="1"
declare -x interface="eth1"
declare -x pid="1213"
declare -x reason="PREINIT"
++ '[' PREINIT = BOUND ']'
++ echo 'sethostname END'
sethostname END
+ '[' -n '' ']'
+ return
+ exit_status=0
+ for script in '$(run-parts --list $dir)'
+ run_hook /etc/dhcp/dhclient-exit-hooks.d/ntpdate 0
+ local script
+ local exit_status
+ script=/etc/dhcp/dhclient-exit-hooks.d/ntpdate
+ shift
+ '[' -f /etc/dhcp/dhclient-exit-hooks.d/ntpdate ']'
+ . /etc/dhcp/dhclient-exit-hooks.d/ntpdate 0
++ NTPDATE_CONF=/etc/default/ntpdate
++ NTPDATE_DHCP_CONF=/var/lib/ntpdate/default.dhcp
++ ntp_servers_setup
++ case $reason in
+ '[' -n '' ']'
+ return
+ exit_status=0
+ for script in '$(run-parts --list $dir)'
+ run_hook /etc/dhcp/dhclient-exit-hooks.d/rfc3442-classless-routes 0
+ local script
+ local exit_status
+ script=/etc/dhcp/dhclient-exit-hooks.d/rfc3442-classless-routes
+ shift
+ '[' -f /etc/dhcp/dhclient-exit-hooks.d/rfc3442-classless-routes ']'
+ . /etc/dhcp/dhclient-exit-hooks.d/rfc3442-classless-routes 0
++ RUN=yes
++ '[' yes = yes ']'
++ '[' -n '' ']'
+ '[' -n '' ']'
+ return
+ exit_status=0
+ return 0
+ exit 0
sethostname BEGIN
declare -x BASH_ENV=""
declare -x BASH_XTRACEFD=""
declare -x CDPATH=""
declare -x ENV=""
declare -x GLOBIGNORE=""
declare -x OLDPWD
declare -x PATH="/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin"
declare -x PWD="/home/ubuntu"
declare -x SHLVL="1"
declare -x interface="eth1"
declare -x new_broadcast_address="13.1.1.255"
declare -x new_dhcp_lease_time="86400"
declare -x new_dhcp_message_type="5"
declare -x new_dhcp_server_identifier="13.1.1.252"
declare -x new_domain_name="example.org"
declare -x new_domain_name_servers="13.1.1.253"
declare -x new_expiry="1754561018"
declare -x new_ip_address="13.1.1.10"
declare -x new_network_number="13.1.1.0"
declare -x new_subnet_mask="255.255.255.0"
declare -x pid="1213"
declare -x reason="BOUND"
++ '[' BOUND = BOUND ']'
++ echo new_ip_address=13.1.1.10
new_ip_address=13.1.1.10
++ echo new_host_name=
new_host_name=
++ echo new_domain_name=example.org
new_domain_name=example.org
+++ echo
+++ tr _ -
++ updated_hostname=
+++ hostname -s
++ oldhostname=testvm1
++ '[' testvm1 '!=' ']'
/etc/dhcp/dhclient-exit-hooks.d/hostname: line 12: [: testvm1: unary operator expected
++ echo 'sethostname END'
sethostname END
+ '[' -n '' ']'
+ return
+ exit_status=0
+ for script in '$(run-parts --list $dir)'
+ run_hook /etc/dhcp/dhclient-exit-hooks.d/ntpdate 0
+ local script
+ local exit_status
+ script=/etc/dhcp/dhclient-exit-hooks.d/ntpdate
+ shift
+ '[' -f /etc/dhcp/dhclient-exit-hooks.d/ntpdate ']'
+ . /etc/dhcp/dhclient-exit-hooks.d/ntpdate 0
++ NTPDATE_CONF=/etc/default/ntpdate
++ NTPDATE_DHCP_CONF=/var/lib/ntpdate/default.dhcp
++ ntp_servers_setup
++ case $reason in
++ ntp_servers_setup_add
++ '[' -e /var/lib/ntpdate/default.dhcp ']'
++ '[' -z '' ']'
++ ntp_servers_setup_remove
++ rm -f /var/lib/ntpdate/default.dhcp
++ return
+ '[' -n '' ']'
+ return
+ exit_status=0
+ for script in '$(run-parts --list $dir)'
+ run_hook /etc/dhcp/dhclient-exit-hooks.d/rfc3442-classless-routes 0
+ local script
+ local exit_status
+ script=/etc/dhcp/dhclient-exit-hooks.d/rfc3442-classless-routes
+ shift
+ '[' -f /etc/dhcp/dhclient-exit-hooks.d/rfc3442-classless-routes ']'
+ . /etc/dhcp/dhclient-exit-hooks.d/rfc3442-classless-routes 0
++ RUN=yes
++ '[' yes = yes ']'
++ '[' -n '' ']'
+ '[' -n '' ']'
+ return
+ exit_status=0
+ return 0
+ exit 0
2025-08-06 10:03:40,509 - DEBUG - Running remote_cmd, Cmd : ifconfig eth1, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123
2025-08-06 10:03:40,510 - DEBUG - ifconfig eth1
2025-08-06 10:03:40,977 - DEBUG - eth1 Link encap:Ethernet HWaddr 02:09:52:0f:df:e4
inet addr:13.1.1.10 Bcast:13.1.1.255 Mask:255.255.255.0
inet6 addr: fe80::9:52ff:fe0f:dfe4/64 Scope:Link
UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
RX packets:25 errors:0 dropped:0 overruns:0 frame:0
TX packets:7 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:1000
RX bytes:2438 (2.4 KB) TX bytes:1026 (1.0 KB)
2025-08-06 10:03:45,978 - DEBUG - Running remote_cmd, Cmd : dig @13.1.1.253 host1.test.com, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123
2025-08-06 10:03:45,978 - DEBUG - dig @13.1.1.253 host1.test.com
2025-08-06 10:03:46,611 - DEBUG - ; <<>> DiG 9.8.1-P1 <<>> @13.1.1.253 host1.test.com
; (1 server found)
;; global options: +cmd
;; Got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 17706
;; flags: qr aa rd ra; QUERY: 1, ANSWER: 1, AUTHORITY: 1, ADDITIONAL: 1
;; QUESTION SECTION:
;host1.test.com. IN A
;; ANSWER SECTION:
host1.test.com. 38400 IN A 13.1.1.251
;; AUTHORITY SECTION:
test.com. 38400 IN NS dnsserver.test.com.
;; ADDITIONAL SECTION:
dnsserver.test.com. 38400 IN A 13.1.1.253
;; Query time: 44 msec
;; SERVER: 13.1.1.253#53(13.1.1.253)
;; WHEN: Wed Aug 6 10:03:46 2025
;; MSG SIZE rcvd: 88
2025-08-06 10:03:46,611 - INFO - Result for Dns Query is ; <<>> DiG 9.8.1-P1 <<>> @13.1.1.253 host1.test.com
; (1 server found)
;; global options: +cmd
;; Got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 17706
;; flags: qr aa rd ra; QUERY: 1, ANSWER: 1, AUTHORITY: 1, ADDITIONAL: 1
;; QUESTION SECTION:
;host1.test.com. IN A
;; ANSWER SECTION:
host1.test.com. 38400 IN A 13.1.1.251
;; AUTHORITY SECTION:
test.com. 38400 IN NS dnsserver.test.com.
;; ADDITIONAL SECTION:
dnsserver.test.com. 38400 IN A 13.1.1.253
;; Query time: 44 msec
;; SERVER: 13.1.1.253#53(13.1.1.253)
;; WHEN: Wed Aug 6 10:03:46 2025
;; MSG SIZE rcvd: 88
2025-08-06 10:03:46,612 - DEBUG - Running remote_cmd, Cmd : dig @13.1.1.253 juniper.net, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123
2025-08-06 10:03:46,612 - DEBUG - dig @13.1.1.253 juniper.net
2025-08-06 10:03:47,496 - DEBUG - ; <<>> DiG 9.8.1-P1 <<>> @13.1.1.253 juniper.net
; (1 server found)
;; global options: +cmd
;; Got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 37312
;; flags: qr rd ra; QUERY: 1, ANSWER: 1, AUTHORITY: 13, ADDITIONAL: 0
;; QUESTION SECTION:
;juniper.net. IN A
;; ANSWER SECTION:
juniper.net. 28800 IN A 44.224.71.252
;; AUTHORITY SECTION:
. 35712 IN NS c.root-servers.net.
. 35712 IN NS h.root-servers.net.
. 35712 IN NS m.root-servers.net.
. 35712 IN NS f.root-servers.net.
. 35712 IN NS g.root-servers.net.
. 35712 IN NS d.root-servers.net.
. 35712 IN NS a.root-servers.net.
. 35712 IN NS l.root-servers.net.
. 35712 IN NS e.root-servers.net.
. 35712 IN NS k.root-servers.net.
. 35712 IN NS j.root-servers.net.
. 35712 IN NS b.root-servers.net.
. 35712 IN NS i.root-servers.net.
;; Query time: 294 msec
;; SERVER: 13.1.1.253#53(13.1.1.253)
;; WHEN: Wed Aug 6 10:03:47 2025
;; MSG SIZE rcvd: 253
2025-08-06 10:03:47,496 - INFO - Result for Dns Query is ; <<>> DiG 9.8.1-P1 <<>> @13.1.1.253 juniper.net
; (1 server found)
;; global options: +cmd
;; Got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 37312
;; flags: qr rd ra; QUERY: 1, ANSWER: 1, AUTHORITY: 13, ADDITIONAL: 0
;; QUESTION SECTION:
;juniper.net. IN A
;; ANSWER SECTION:
juniper.net. 28800 IN A 44.224.71.252
;; AUTHORITY SECTION:
. 35712 IN NS c.root-servers.net.
. 35712 IN NS h.root-servers.net.
. 35712 IN NS m.root-servers.net.
. 35712 IN NS f.root-servers.net.
. 35712 IN NS g.root-servers.net.
. 35712 IN NS d.root-servers.net.
. 35712 IN NS a.root-servers.net.
. 35712 IN NS l.root-servers.net.
. 35712 IN NS e.root-servers.net.
. 35712 IN NS k.root-servers.net.
. 35712 IN NS j.root-servers.net.
. 35712 IN NS b.root-servers.net.
. 35712 IN NS i.root-servers.net.
;; Query time: 294 msec
;; SERVER: 13.1.1.253#53(13.1.1.253)
;; WHEN: Wed Aug 6 10:03:47 2025
;; MSG SIZE rcvd: 253
2025-08-06 10:03:47,497 - DEBUG - Running remote_cmd, Cmd : dig @13.1.1.253 www.google.com, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123
2025-08-06 10:03:47,497 - DEBUG - dig @13.1.1.253 www.google.com
2025-08-06 10:03:48,204 - DEBUG - ; <<>> DiG 9.8.1-P1 <<>> @13.1.1.253 www.google.com
; (1 server found)
;; global options: +cmd
;; Got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 15710
;; flags: qr rd ra; QUERY: 1, ANSWER: 6, AUTHORITY: 13, ADDITIONAL: 0
;; QUESTION SECTION:
;www.google.com. IN A
;; ANSWER SECTION:
www.google.com. 186 IN A 142.251.15.147
www.google.com. 186 IN A 142.251.15.106
www.google.com. 186 IN A 142.251.15.105
www.google.com. 186 IN A 142.251.15.103
www.google.com. 186 IN A 142.251.15.99
www.google.com. 186 IN A 142.251.15.104
;; AUTHORITY SECTION:
. 7199 IN NS f.root-servers.net.
. 7199 IN NS j.root-servers.net.
. 7199 IN NS k.root-servers.net.
. 7199 IN NS c.root-servers.net.
. 7199 IN NS l.root-servers.net.
. 7199 IN NS h.root-servers.net.
. 7199 IN NS i.root-servers.net.
. 7199 IN NS d.root-servers.net.
. 7199 IN NS g.root-servers.net.
. 7199 IN NS b.root-servers.net.
. 7199 IN NS m.root-servers.net.
. 7199 IN NS e.root-servers.net.
. 7199 IN NS a.root-servers.net.
;; Query time: 55 msec
;; SERVER: 13.1.1.253#53(13.1.1.253)
;; WHEN: Wed Aug 6 10:03:47 2025
;; MSG SIZE rcvd: 339
2025-08-06 10:03:48,204 - INFO - Result for Dns Query is ; <<>> DiG 9.8.1-P1 <<>> @13.1.1.253 www.google.com
; (1 server found)
;; global options: +cmd
;; Got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 15710
;; flags: qr rd ra; QUERY: 1, ANSWER: 6, AUTHORITY: 13, ADDITIONAL: 0
;; QUESTION SECTION:
;www.google.com. IN A
;; ANSWER SECTION:
www.google.com. 186 IN A 142.251.15.147
www.google.com. 186 IN A 142.251.15.106
www.google.com. 186 IN A 142.251.15.105
www.google.com. 186 IN A 142.251.15.103
www.google.com. 186 IN A 142.251.15.99
www.google.com. 186 IN A 142.251.15.104
;; AUTHORITY SECTION:
. 7199 IN NS f.root-servers.net.
. 7199 IN NS j.root-servers.net.
. 7199 IN NS k.root-servers.net.
. 7199 IN NS c.root-servers.net.
. 7199 IN NS l.root-servers.net.
. 7199 IN NS h.root-servers.net.
. 7199 IN NS i.root-servers.net.
. 7199 IN NS d.root-servers.net.
. 7199 IN NS g.root-servers.net.
. 7199 IN NS b.root-servers.net.
. 7199 IN NS m.root-servers.net.
. 7199 IN NS e.root-servers.net.
. 7199 IN NS a.root-servers.net.
;; Query time: 55 msec
;; SERVER: 13.1.1.253#53(13.1.1.253)
;; WHEN: Wed Aug 6 10:03:47 2025
;; MSG SIZE rcvd: 339
2025-08-06 10:03:48,205 - DEBUG - Running remote_cmd, Cmd : nslookup 13.1.1.251 13.1.1.253, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123
2025-08-06 10:03:48,205 - DEBUG - nslookup 13.1.1.251 13.1.1.253
2025-08-06 10:03:49,076 - DEBUG - Server: 13.1.1.253
Address: 13.1.1.253#53
251.1.1.13.in-addr.arpa name = host1.test.com.1.1.13.in-addr.arpa.
2025-08-06 10:03:49,076 - INFO - Result for nslookup is Server: 13.1.1.253
Address: 13.1.1.253#53
251.1.1.13.in-addr.arpa name = host1.test.com.1.1.13.in-addr.arpa.
2025-08-06 10:03:49,076 - INFO - nslookup for host1 succeeded Server: 13.1.1.253
Address: 13.1.1.253#53
251.1.1.13.in-addr.arpa name = host1.test.com.1.1.13.in-addr.arpa.
2025-08-06 10:03:49,076 - INFO - Deleting VM testvm1
2025-08-06 10:03:49,201 - DEBUG - Verifying in api server 10.0.0.38
2025-08-06 10:03:49,201 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/c8936c2e-27af-47c0-85cf-773081069330
2025-08-06 10:03:49,215 - DEBUG - VM ID c8936c2e-27af-47c0-85cf-773081069330 of VM testvm1 is still found in API Server
2025-08-06 10:03:51,215 - DEBUG - Verifying in api server 10.0.0.38
2025-08-06 10:03:51,216 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/c8936c2e-27af-47c0-85cf-773081069330
2025-08-06 10:03:51,224 - DEBUG - Response Code: 404
2025-08-06 10:03:51,224 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/c8936c2e-27af-47c0-85cf-773081069330
2025-08-06 10:03:51,232 - DEBUG - Response Code: 404
2025-08-06 10:03:51,232 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/c8936c2e-27af-47c0-85cf-773081069330
2025-08-06 10:03:51,242 - DEBUG - Response Code: 404
2025-08-06 10:03:51,242 - INFO - VM testvm1 is fully removed in API-Server
2025-08-06 10:03:51,410 - DEBUG - Skipping VM-deletion-check in nova db since mysql_token is not found
2025-08-06 10:03:51,526 - DEBUG - Validated that vrouter 10.0.0.49 does not have VMs route for VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN
2025-08-06 10:03:51,692 - DEBUG - VM route 11.1.1.251 has been marked for discard in VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN of compute 10.0.0.57
2025-08-06 10:03:51,698 - DEBUG - Validated that vrouter 10.0.0.57 does not have VMs route for VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN
2025-08-06 10:03:51,698 - INFO - Validated that all vrouters do not have VMs route for VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN
2025-08-06 10:03:51,743 - DEBUG - Validated that vrouter 10.0.0.49 does not have VMs route for VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN
2025-08-06 10:03:51,772 - DEBUG - VM route 44.1.1.252 is not in vrf 3 of VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN of compute 10.0.0.57
2025-08-06 10:03:51,772 - DEBUG - Validated that vrouter 10.0.0.57 does not have VMs route for VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN
2025-08-06 10:03:51,772 - INFO - Validated that all vrouters do not have VMs route for VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN
2025-08-06 10:03:51,772 - INFO - VM testvm1 is removed in Compute, and routes are removed in all compute nodes
2025-08-06 10:03:52,175 - INFO - Routes for VM testvm1 is removed in all control-nodes
2025-08-06 10:03:52,175 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-1:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:03:52,250 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-1?flat
2025-08-06 10:03:52,299 - DEBUG - VM c8936c2e-27af-47c0-85cf-773081069330 is still present in vrouter an-jenkins-deploy-platform-ansible-os-3761-1 uve
2025-08-06 10:03:52,299 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-08-06 10:03:52,300 - DEBUG - interface for vm c8936c2e-27af-47c0-85cf-773081069330 deleted from vrouter uve ...
2025-08-06 10:03:52,300 - DEBUG - Deleted interface not in error interface list ...
2025-08-06 10:03:55,301 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-1:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:03:55,430 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-1?flat
2025-08-06 10:03:55,528 - DEBUG - VM c8936c2e-27af-47c0-85cf-773081069330 is still present in vrouter an-jenkins-deploy-platform-ansible-os-3761-1 uve
2025-08-06 10:03:55,528 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-08-06 10:03:55,528 - DEBUG - interface for vm c8936c2e-27af-47c0-85cf-773081069330 deleted from vrouter uve ...
2025-08-06 10:03:55,528 - DEBUG - Deleted interface not in error interface list ...
2025-08-06 10:03:58,529 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-1:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:03:58,660 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-1?flat
2025-08-06 10:03:58,756 - DEBUG - VM c8936c2e-27af-47c0-85cf-773081069330 is not present in vrouter an-jenkins-deploy-platform-ansible-os-3761-1 uve
2025-08-06 10:03:58,757 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-08-06 10:03:58,757 - DEBUG - interface for vm c8936c2e-27af-47c0-85cf-773081069330 deleted from vrouter uve ...
2025-08-06 10:03:58,757 - DEBUG - Deleted interface not in error interface list ...
2025-08-06 10:03:58,757 - DEBUG - Validated that VM c8936c2e-27af-47c0-85cf-773081069330 is removed in Vrouter UVE
2025-08-06 10:03:58,757 - DEBUG - Verifying through opserver in 10.0.0.48
2025-08-06 10:03:58,757 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN?flat
2025-08-06 10:03:58,792 - DEBUG - c8936c2e-27af-47c0-85cf-773081069330 BM not in default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN uve
2025-08-06 10:03:58,792 - DEBUG - Validated that VM c8936c2e-27af-47c0-85cf-773081069330 is not present in the VN UVE
2025-08-06 10:03:58,792 - DEBUG - Verifying the c8936c2e-27af-47c0-85cf-773081069330 virtual network link through opserver 10.0.0.48
2025-08-06 10:03:58,792 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machines
2025-08-06 10:03:58,809 - INFO - c8936c2e-27af-47c0-85cf-773081069330 vm uve deleted from opserver
2025-08-06 10:03:58,809 - DEBUG - Verifying the c8936c2e-27af-47c0-85cf-773081069330 virtual network link through opserver 10.0.0.254
2025-08-06 10:03:58,809 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-machines
2025-08-06 10:03:58,827 - INFO - c8936c2e-27af-47c0-85cf-773081069330 vm uve deleted from opserver
2025-08-06 10:03:58,827 - DEBUG - Verifying the c8936c2e-27af-47c0-85cf-773081069330 virtual network link through opserver 10.0.0.38
2025-08-06 10:03:58,827 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-machines
2025-08-06 10:03:58,895 - INFO - c8936c2e-27af-47c0-85cf-773081069330 vm uve deleted from opserver
2025-08-06 10:03:58,895 - INFO - Validated that VM c8936c2e-27af-47c0-85cf-773081069330 is removed from Opserver
2025-08-06 10:03:58,895 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-1:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:03:58,969 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-1?flat
2025-08-06 10:03:59,016 - DEBUG - VM c8936c2e-27af-47c0-85cf-773081069330 is not present in vrouter an-jenkins-deploy-platform-ansible-os-3761-1 uve
2025-08-06 10:03:59,016 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-08-06 10:03:59,016 - DEBUG - interface for vm c8936c2e-27af-47c0-85cf-773081069330 deleted from vrouter uve ...
2025-08-06 10:03:59,016 - DEBUG - Deleted interface not in error interface list ...
2025-08-06 10:03:59,016 - DEBUG - Validated that VM c8936c2e-27af-47c0-85cf-773081069330 is removed in Vrouter UVE
2025-08-06 10:03:59,016 - DEBUG - Verifying through opserver in 10.0.0.48
2025-08-06 10:03:59,017 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN?flat
2025-08-06 10:03:59,049 - DEBUG - c8936c2e-27af-47c0-85cf-773081069330 BM not in default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN uve
2025-08-06 10:03:59,049 - DEBUG - Validated that VM c8936c2e-27af-47c0-85cf-773081069330 is not present in the VN UVE
2025-08-06 10:03:59,049 - DEBUG - Verifying the c8936c2e-27af-47c0-85cf-773081069330 virtual network link through opserver 10.0.0.48
2025-08-06 10:03:59,049 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machines
2025-08-06 10:03:59,072 - INFO - c8936c2e-27af-47c0-85cf-773081069330 vm uve deleted from opserver
2025-08-06 10:03:59,072 - DEBUG - Verifying the c8936c2e-27af-47c0-85cf-773081069330 virtual network link through opserver 10.0.0.254
2025-08-06 10:03:59,073 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-machines
2025-08-06 10:03:59,091 - INFO - c8936c2e-27af-47c0-85cf-773081069330 vm uve deleted from opserver
2025-08-06 10:03:59,091 - DEBUG - Verifying the c8936c2e-27af-47c0-85cf-773081069330 virtual network link through opserver 10.0.0.38
2025-08-06 10:03:59,092 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-machines
2025-08-06 10:03:59,165 - INFO - c8936c2e-27af-47c0-85cf-773081069330 vm uve deleted from opserver
2025-08-06 10:03:59,165 - INFO - Validated that VM c8936c2e-27af-47c0-85cf-773081069330 is removed from Opserver
2025-08-06 10:03:59,165 - INFO - Deleting VM dnsserver
2025-08-06 10:03:59,276 - DEBUG - Verifying in api server 10.0.0.38
2025-08-06 10:03:59,276 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/29c05397-49d6-4154-9ca1-c719f95d999b
2025-08-06 10:03:59,289 - DEBUG - VM ID 29c05397-49d6-4154-9ca1-c719f95d999b of VM dnsserver is still found in API Server
2025-08-06 10:04:01,289 - DEBUG - Verifying in api server 10.0.0.38
2025-08-06 10:04:01,289 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/29c05397-49d6-4154-9ca1-c719f95d999b
2025-08-06 10:04:01,299 - DEBUG - Response Code: 404
2025-08-06 10:04:01,299 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/29c05397-49d6-4154-9ca1-c719f95d999b
2025-08-06 10:04:01,309 - DEBUG - Response Code: 404
2025-08-06 10:04:01,309 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/29c05397-49d6-4154-9ca1-c719f95d999b
2025-08-06 10:04:01,317 - DEBUG - Response Code: 404
2025-08-06 10:04:01,318 - INFO - VM dnsserver is fully removed in API-Server
2025-08-06 10:04:01,474 - DEBUG - Skipping VM-deletion-check in nova db since mysql_token is not found
2025-08-06 10:04:01,555 - DEBUG - Validated that vrouter 10.0.0.49 does not have VMs route for VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN
2025-08-06 10:04:01,701 - DEBUG - VM route 11.1.1.250 has been marked for discard in VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN of compute 10.0.0.57
2025-08-06 10:04:01,707 - DEBUG - Validated that vrouter 10.0.0.57 does not have VMs route for VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN
2025-08-06 10:04:01,707 - INFO - Validated that all vrouters do not have VMs route for VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN
2025-08-06 10:04:01,736 - DEBUG - Validated that vrouter 10.0.0.49 does not have VMs route for VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN
2025-08-06 10:04:01,754 - DEBUG - VM route 44.1.1.250 is not in vrf 3 of VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN of compute 10.0.0.57
2025-08-06 10:04:01,754 - DEBUG - Validated that vrouter 10.0.0.57 does not have VMs route for VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN
2025-08-06 10:04:01,754 - INFO - Validated that all vrouters do not have VMs route for VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN
2025-08-06 10:04:01,755 - INFO - VM dnsserver is removed in Compute, and routes are removed in all compute nodes
2025-08-06 10:04:02,106 - INFO - Routes for VM dnsserver is removed in all control-nodes
2025-08-06 10:04:02,106 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-2:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:04:02,189 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-2?flat
2025-08-06 10:04:02,245 - DEBUG - VM 29c05397-49d6-4154-9ca1-c719f95d999b is still present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:04:02,245 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-08-06 10:04:02,245 - DEBUG - interface for vm 29c05397-49d6-4154-9ca1-c719f95d999b deleted from vrouter uve ...
2025-08-06 10:04:02,245 - DEBUG - Deleted interface not in error interface list ...
2025-08-06 10:04:05,246 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-2:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:04:05,313 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-2?flat
2025-08-06 10:04:05,354 - DEBUG - VM 29c05397-49d6-4154-9ca1-c719f95d999b is still present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:04:05,354 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-08-06 10:04:05,354 - DEBUG - interface for vm 29c05397-49d6-4154-9ca1-c719f95d999b deleted from vrouter uve ...
2025-08-06 10:04:05,354 - DEBUG - Deleted interface not in error interface list ...
2025-08-06 10:04:08,355 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-2:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:04:08,436 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-2?flat
2025-08-06 10:04:08,492 - DEBUG - VM 29c05397-49d6-4154-9ca1-c719f95d999b is not present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:04:08,492 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-08-06 10:04:08,492 - DEBUG - interface for vm 29c05397-49d6-4154-9ca1-c719f95d999b deleted from vrouter uve ...
2025-08-06 10:04:08,492 - DEBUG - Deleted interface not in error interface list ...
2025-08-06 10:04:08,492 - DEBUG - Validated that VM 29c05397-49d6-4154-9ca1-c719f95d999b is removed in Vrouter UVE
2025-08-06 10:04:08,492 - DEBUG - Verifying through opserver in 10.0.0.48
2025-08-06 10:04:08,492 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN?flat
2025-08-06 10:04:08,529 - DEBUG - 29c05397-49d6-4154-9ca1-c719f95d999b BM not in default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN uve
2025-08-06 10:04:08,529 - DEBUG - Validated that VM 29c05397-49d6-4154-9ca1-c719f95d999b is not present in the VN UVE
2025-08-06 10:04:08,529 - DEBUG - Verifying the 29c05397-49d6-4154-9ca1-c719f95d999b virtual network link through opserver 10.0.0.48
2025-08-06 10:04:08,530 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machines
2025-08-06 10:04:08,547 - INFO - 29c05397-49d6-4154-9ca1-c719f95d999b vm uve deleted from opserver
2025-08-06 10:04:08,547 - DEBUG - Verifying the 29c05397-49d6-4154-9ca1-c719f95d999b virtual network link through opserver 10.0.0.254
2025-08-06 10:04:08,547 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-machines
2025-08-06 10:04:08,565 - INFO - 29c05397-49d6-4154-9ca1-c719f95d999b vm uve deleted from opserver
2025-08-06 10:04:08,565 - DEBUG - Verifying the 29c05397-49d6-4154-9ca1-c719f95d999b virtual network link through opserver 10.0.0.38
2025-08-06 10:04:08,565 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-machines
2025-08-06 10:04:08,580 - INFO - 29c05397-49d6-4154-9ca1-c719f95d999b vm uve deleted from opserver
2025-08-06 10:04:08,580 - INFO - Validated that VM 29c05397-49d6-4154-9ca1-c719f95d999b is removed from Opserver
2025-08-06 10:04:08,580 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-2:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:04:08,674 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-2?flat
2025-08-06 10:04:08,743 - DEBUG - VM 29c05397-49d6-4154-9ca1-c719f95d999b is not present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:04:08,743 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-08-06 10:04:08,743 - DEBUG - interface for vm 29c05397-49d6-4154-9ca1-c719f95d999b deleted from vrouter uve ...
2025-08-06 10:04:08,743 - DEBUG - Deleted interface not in error interface list ...
2025-08-06 10:04:08,743 - DEBUG - Validated that VM 29c05397-49d6-4154-9ca1-c719f95d999b is removed in Vrouter UVE
2025-08-06 10:04:08,743 - DEBUG - Verifying through opserver in 10.0.0.48
2025-08-06 10:04:08,744 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN?flat
2025-08-06 10:04:08,775 - DEBUG - 29c05397-49d6-4154-9ca1-c719f95d999b BM not in default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN uve
2025-08-06 10:04:08,776 - DEBUG - Validated that VM 29c05397-49d6-4154-9ca1-c719f95d999b is not present in the VN UVE
2025-08-06 10:04:08,776 - DEBUG - Verifying the 29c05397-49d6-4154-9ca1-c719f95d999b virtual network link through opserver 10.0.0.48
2025-08-06 10:04:08,776 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machines
2025-08-06 10:04:08,793 - INFO - 29c05397-49d6-4154-9ca1-c719f95d999b vm uve deleted from opserver
2025-08-06 10:04:08,793 - DEBUG - Verifying the 29c05397-49d6-4154-9ca1-c719f95d999b virtual network link through opserver 10.0.0.254
2025-08-06 10:04:08,793 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-machines
2025-08-06 10:04:08,811 - INFO - 29c05397-49d6-4154-9ca1-c719f95d999b vm uve deleted from opserver
2025-08-06 10:04:08,811 - DEBUG - Verifying the 29c05397-49d6-4154-9ca1-c719f95d999b virtual network link through opserver 10.0.0.38
2025-08-06 10:04:08,811 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-machines
2025-08-06 10:04:08,828 - INFO - 29c05397-49d6-4154-9ca1-c719f95d999b vm uve deleted from opserver
2025-08-06 10:04:08,828 - INFO - Validated that VM 29c05397-49d6-4154-9ca1-c719f95d999b is removed from Opserver
2025-08-06 10:04:08,828 - INFO - Deleting VM dhcp-server
2025-08-06 10:04:08,919 - DEBUG - Verifying in api server 10.0.0.38
2025-08-06 10:04:08,919 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf
2025-08-06 10:04:08,930 - DEBUG - VM ID 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf of VM dhcp-server is still found in API Server
2025-08-06 10:04:10,930 - DEBUG - Verifying in api server 10.0.0.38
2025-08-06 10:04:10,931 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf
2025-08-06 10:04:10,939 - DEBUG - Response Code: 404
2025-08-06 10:04:10,939 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf
2025-08-06 10:04:10,946 - DEBUG - Response Code: 404
2025-08-06 10:04:10,947 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf
2025-08-06 10:04:10,954 - DEBUG - Response Code: 404
2025-08-06 10:04:10,954 - INFO - VM dhcp-server is fully removed in API-Server
2025-08-06 10:04:11,110 - DEBUG - Skipping VM-deletion-check in nova db since mysql_token is not found
2025-08-06 10:04:11,234 - DEBUG - Validated that vrouter 10.0.0.49 does not have VMs route for VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN
2025-08-06 10:04:11,265 - DEBUG - Validated that vrouter 10.0.0.57 does not have VMs route for VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN
2025-08-06 10:04:11,265 - INFO - Validated that all vrouters do not have VMs route for VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN
2025-08-06 10:04:11,323 - DEBUG - Validated that vrouter 10.0.0.49 does not have VMs route for VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN
2025-08-06 10:04:11,349 - DEBUG - Validated that vrouter 10.0.0.57 does not have VMs route for VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN
2025-08-06 10:04:11,349 - INFO - Validated that all vrouters do not have VMs route for VN default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN
2025-08-06 10:04:11,349 - INFO - VM dhcp-server is removed in Compute, and routes are removed in all compute nodes
2025-08-06 10:04:11,721 - INFO - Routes for VM dhcp-server is removed in all control-nodes
2025-08-06 10:04:11,721 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-2:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:04:11,786 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-2?flat
2025-08-06 10:04:11,834 - DEBUG - VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is still present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:04:11,834 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-08-06 10:04:11,834 - DEBUG - interface for vm 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf deleted from vrouter uve ...
2025-08-06 10:04:11,834 - DEBUG - Deleted interface not in error interface list ...
2025-08-06 10:04:14,834 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-2:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:04:14,911 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-2?flat
2025-08-06 10:04:14,957 - DEBUG - VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is still present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:04:14,957 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-08-06 10:04:14,957 - DEBUG - interface for vm 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf deleted from vrouter uve ...
2025-08-06 10:04:14,957 - DEBUG - Deleted interface not in error interface list ...
2025-08-06 10:04:17,958 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-2:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:04:18,026 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-2?flat
2025-08-06 10:04:18,075 - DEBUG - VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is still present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:04:18,075 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-08-06 10:04:18,075 - DEBUG - interface for vm 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf deleted from vrouter uve ...
2025-08-06 10:04:18,075 - DEBUG - Deleted interface not in error interface list ...
2025-08-06 10:04:21,076 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-2:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:04:21,149 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-2?flat
2025-08-06 10:04:21,195 - DEBUG - VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is still present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:04:21,195 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-08-06 10:04:21,195 - DEBUG - interface for vm 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf deleted from vrouter uve ...
2025-08-06 10:04:21,195 - DEBUG - Deleted interface not in error interface list ...
2025-08-06 10:04:24,196 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-2:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:04:24,283 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-2?flat
2025-08-06 10:04:24,331 - DEBUG - VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is still present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:04:24,331 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-08-06 10:04:24,331 - DEBUG - interface for vm 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf deleted from vrouter uve ...
2025-08-06 10:04:24,331 - DEBUG - Deleted interface not in error interface list ...
2025-08-06 10:04:27,332 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-2:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:04:27,414 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-2?flat
2025-08-06 10:04:27,465 - DEBUG - VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is still present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:04:27,465 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-08-06 10:04:27,465 - DEBUG - interface for vm 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf deleted from vrouter uve ...
2025-08-06 10:04:27,465 - DEBUG - Deleted interface not in error interface list ...
2025-08-06 10:04:30,466 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-2:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:04:30,537 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-2?flat
2025-08-06 10:04:30,582 - DEBUG - VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is still present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:04:30,583 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-08-06 10:04:30,583 - DEBUG - interface for vm 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf deleted from vrouter uve ...
2025-08-06 10:04:30,583 - DEBUG - Deleted interface not in error interface list ...
2025-08-06 10:04:33,583 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-2:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:04:33,682 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-2?flat
2025-08-06 10:04:33,732 - DEBUG - VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is still present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:04:33,732 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-08-06 10:04:33,732 - DEBUG - interface for vm 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf deleted from vrouter uve ...
2025-08-06 10:04:33,732 - DEBUG - Deleted interface not in error interface list ...
2025-08-06 10:04:36,732 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-2:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:04:36,829 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-2?flat
2025-08-06 10:04:36,879 - DEBUG - VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is not present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:04:36,879 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-08-06 10:04:36,879 - DEBUG - interface for vm 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf deleted from vrouter uve ...
2025-08-06 10:04:36,879 - DEBUG - Deleted interface not in error interface list ...
2025-08-06 10:04:36,879 - DEBUG - Validated that VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is removed in Vrouter UVE
2025-08-06 10:04:36,879 - DEBUG - Verifying through opserver in 10.0.0.48
2025-08-06 10:04:36,879 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN?flat
2025-08-06 10:04:36,909 - DEBUG - 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf BM not in default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-MGMT-VN uve
2025-08-06 10:04:36,909 - DEBUG - Validated that VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is not present in the VN UVE
2025-08-06 10:04:36,909 - DEBUG - Verifying the 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf virtual network link through opserver 10.0.0.48
2025-08-06 10:04:36,909 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machines
2025-08-06 10:04:36,927 - DEBUG - No links retuned for 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf
2025-08-06 10:04:36,927 - INFO - 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf vm uve deleted from opserver
2025-08-06 10:04:36,927 - DEBUG - Verifying the 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf virtual network link through opserver 10.0.0.254
2025-08-06 10:04:36,927 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-machines
2025-08-06 10:04:36,945 - DEBUG - No links retuned for 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf
2025-08-06 10:04:36,945 - INFO - 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf vm uve deleted from opserver
2025-08-06 10:04:36,945 - DEBUG - Verifying the 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf virtual network link through opserver 10.0.0.38
2025-08-06 10:04:36,945 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-machines
2025-08-06 10:04:36,963 - DEBUG - No links retuned for 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf
2025-08-06 10:04:36,963 - INFO - 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf vm uve deleted from opserver
2025-08-06 10:04:36,963 - INFO - Validated that VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is removed from Opserver
2025-08-06 10:04:36,964 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3761-2:Compute:contrail-vrouter-agent:0?flat
2025-08-06 10:04:37,033 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3761-2?flat
2025-08-06 10:04:37,079 - DEBUG - VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is not present in vrouter an-jenkins-deploy-platform-ansible-os-3761-2 uve
2025-08-06 10:04:37,079 - DEBUG - Verifying if the vm interface deleted from vroter uve...
2025-08-06 10:04:37,079 - DEBUG - interface for vm 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf deleted from vrouter uve ...
2025-08-06 10:04:37,079 - DEBUG - Deleted interface not in error interface list ...
2025-08-06 10:04:37,079 - DEBUG - Validated that VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is removed in Vrouter UVE
2025-08-06 10:04:37,079 - DEBUG - Verifying through opserver in 10.0.0.48
2025-08-06 10:04:37,079 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-network/default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN?flat
2025-08-06 10:04:37,105 - DEBUG - 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf BM not in default-domain:ctest-TestEvpnCasesVxlan-69934149:EVPN-L2-VN uve
2025-08-06 10:04:37,105 - DEBUG - Validated that VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is not present in the VN UVE
2025-08-06 10:04:37,105 - DEBUG - Verifying the 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf virtual network link through opserver 10.0.0.48
2025-08-06 10:04:37,105 - DEBUG - Requesting: http://10.0.0.48:8081/analytics/uves/virtual-machines
2025-08-06 10:04:37,120 - DEBUG - No links retuned for 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf
2025-08-06 10:04:37,120 - INFO - 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf vm uve deleted from opserver
2025-08-06 10:04:37,120 - DEBUG - Verifying the 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf virtual network link through opserver 10.0.0.254
2025-08-06 10:04:37,120 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-machines
2025-08-06 10:04:37,135 - DEBUG - No links retuned for 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf
2025-08-06 10:04:37,136 - INFO - 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf vm uve deleted from opserver
2025-08-06 10:04:37,136 - DEBUG - Verifying the 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf virtual network link through opserver 10.0.0.38
2025-08-06 10:04:37,136 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-machines
2025-08-06 10:04:37,152 - DEBUG - No links retuned for 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf
2025-08-06 10:04:37,153 - INFO - 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf vm uve deleted from opserver
2025-08-06 10:04:37,153 - INFO - Validated that VM 7f2c47c4-5609-4e2d-b8c4-2a964ef7faaf is removed from Opserver
2025-08-06 10:04:37,153 - INFO - Deleting VN EVPN-L2-VN
2025-08-06 10:04:37,343 - DEBUG - Requesting: http://10.0.0.48:8082/routing-instance/4ccea094-fe50-461a-9221-2c22692102b8
2025-08-06 10:04:37,406 - DEBUG - Response Code: 404
2025-08-06 10:04:37,406 - DEBUG - Requesting: http://10.0.0.48:8082/domains
2025-08-06 10:04:37,416 - DEBUG - Requesting: http://10.0.0.48:8082/domain/e3e88518-0617-4e53-bc15-162decab76e0
2025-08-06 10:04:37,482 - DEBUG - Requesting: http://10.0.0.48:8082/project/67ba8d08-c98d-4d52-9e6a-6a2badd3125d
2025-08-06 10:04:37,613 - INFO - Validated that VN EVPN-L2-VN is not found in API Server
2025-08-06 10:04:37,628 - DEBUG - VN EVPN-L2-VN is not present in Agent 10.0.0.49
2025-08-06 10:04:37,641 - DEBUG - VN EVPN-L2-VN is not present in Agent 10.0.0.57
2025-08-06 10:04:37,641 - INFO - Validated that VN EVPN-L2-VN is not in any agent
2025-08-06 10:04:37,684 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN EVPN-L2-VN info
2025-08-06 10:04:37,684 - INFO - Deleting VN EVPN-MGMT-VN
2025-08-06 10:04:37,814 - DEBUG - Requesting: http://10.0.0.48:8082/routing-instance/b9c7dcee-3baa-412d-b892-d23e5e2659cb
2025-08-06 10:04:37,822 - DEBUG - Response Code: 404
2025-08-06 10:04:37,822 - DEBUG - Requesting: http://10.0.0.48:8082/domains
2025-08-06 10:04:37,831 - DEBUG - Requesting: http://10.0.0.48:8082/domain/e3e88518-0617-4e53-bc15-162decab76e0
2025-08-06 10:04:37,854 - DEBUG - Requesting: http://10.0.0.48:8082/project/67ba8d08-c98d-4d52-9e6a-6a2badd3125d
2025-08-06 10:04:37,953 - INFO - Validated that VN EVPN-MGMT-VN is not found in API Server
2025-08-06 10:04:37,967 - DEBUG - VN EVPN-MGMT-VN is not present in Agent 10.0.0.49
2025-08-06 10:04:37,984 - DEBUG - VN EVPN-MGMT-VN is not present in Agent 10.0.0.57
2025-08-06 10:04:37,984 - INFO - Validated that VN EVPN-MGMT-VN is not in any agent
2025-08-06 10:04:38,024 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN EVPN-MGMT-VN info
2025-08-06 10:04:39,411 - DEBUG - Skipping xmpp flap check
2025-08-06 10:04:39,411 - INFO - END TEST : test_with_vxlan_encap_dns_disabled_for_l2_vn : PASSED[0:06:03]
2025-08-06 10:04:39,411 - INFO - --------------------------------------------------------------------------------
2025-08-06 10:04:40,232 - INFO - Deleted project: ctest-TestEvpnCasesVxlan-69934149, ID : 67ba8d08-c98d-4d52-9e6a-6a2badd3125d