2025-07-31 05:51:34,112 - INFO - Domain Default found not creating 2025-07-31 05:51:34,482 - INFO - Project ctest-TestBasicVMVN0-68332753 not found, creating it 2025-07-31 05:51:35,112 - INFO - Created Project:ctest-TestBasicVMVN0-68332753, ID : ac5f5468-d7a8-4019-8ee1-9a411ff512b3 2025-07-31 05:51:37,389 - INFO - ================================================================================ 2025-07-31 05:51:37,389 - INFO - STARTING TEST : test_control_node_switchover 2025-07-31 05:51:37,390 - INFO - TEST DESCRIPTION : Stop the control node and check peering with agent fallback to other control node. 1. Pick one VN from respource pool which has 2 VM's in it 2. Verify ping between VM's 3. Find active control node in cluster by agent inspect 4. Stop control service on active control node 5. Verify agents are connected to new active control-node using xmpp connections 6. Bring back control service on previous active node 7. Verify ping between VM's again after bringing up control serveice Pass criteria: Step 2,5 and 7 should pass 2025-07-31 05:51:38,755 - DEBUG - Skipping xmpp flap check 2025-07-31 05:51:38,756 - INFO - Initial checks done. Running the testcase now 2025-07-31 05:51:38,756 - INFO - 2025-07-31 05:51:39,642 - DEBUG - Response for create_network : {'network': {'id': '304e52d1-73ef-4b44-a26e-0f79c9c721f6', 'name': 'ctest-vn1-27189330', 'tenant_id': 'ac5f5468d7a840198ee19a411ff512b3', 'project_id': 'ac5f5468d7a840198ee19a411ff512b3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN0-68332753', 'ctest-vn1-27189330'], 'port_security_enabled': True, 'description': ''}} 2025-07-31 05:51:39,980 - DEBUG - Response for create_subnet : {'subnet': {'id': '93ffe374-0d29-4b01-a040-84442f6e5fe0', 'name': '', 'tenant_id': 'ac5f5468d7a840198ee19a411ff512b3', 'network_id': '304e52d1-73ef-4b44-a26e-0f79c9c721f6', 'ip_version': 4, 'cidr': '192.168.1.0/24', 'allocation_pools': [{'start': '192.168.1.2', 'end': '192.168.1.254'}], 'gateway_ip': '192.168.1.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '192.168.1.2', 'tags': [], 'project_id': 'ac5f5468d7a840198ee19a411ff512b3'}} 2025-07-31 05:51:40,010 - INFO - Created VN ctest-vn1-27189330 2025-07-31 05:51:40,026 - DEBUG - VN ctest-vn1-27189330 UUID is 304e52d1-73ef-4b44-a26e-0f79c9c721f6 2025-07-31 05:51:40,118 - DEBUG - Requesting: http://10.0.0.41:8082/domains 2025-07-31 05:51:40,454 - DEBUG - Requesting: http://10.0.0.41:8082/domains 2025-07-31 05:51:40,518 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7 2025-07-31 05:51:40,570 - DEBUG - Requesting: http://10.0.0.41:8082/project/ac5f5468-d7a8-4019-8ee1-9a411ff512b3 2025-07-31 05:51:40,693 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/304e52d1-73ef-4b44-a26e-0f79c9c721f6 2025-07-31 05:51:40,716 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/304e52d1-73ef-4b44-a26e-0f79c9c721f6 2025-07-31 05:51:40,745 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/733d4d03-9370-45de-8752-cddabbba342d 2025-07-31 05:51:40,764 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/733d4d03-9370-45de-8752-cddabbba342d 2025-07-31 05:51:40,782 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/06e98230-0c61-451c-a8de-014345481980 2025-07-31 05:51:40,797 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-07-31 05:51:40,797 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/304e52d1-73ef-4b44-a26e-0f79c9c721f6 2025-07-31 05:51:40,817 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/733d4d03-9370-45de-8752-cddabbba342d 2025-07-31 05:51:40,846 - INFO - Verified VN network id 13 for VN 304e52d1-73ef-4b44-a26e-0f79c9c721f6 2025-07-31 05:51:40,846 - INFO - Verifications in API Server for VN ctest-vn1-27189330 passed 2025-07-31 05:51:40,846 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/304e52d1-73ef-4b44-a26e-0f79c9c721f6 2025-07-31 05:51:40,867 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/733d4d03-9370-45de-8752-cddabbba342d 2025-07-31 05:51:40,878 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/733d4d03-9370-45de-8752-cddabbba342d 2025-07-31 05:51:40,889 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/06e98230-0c61-451c-a8de-014345481980 2025-07-31 05:51:40,916 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN0-68332753', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3480810621550676804', 'uuid-lslong': '11704309497333228022'}, 'enable': 'true', 'created': '2025-07-31T05:51:39', 'last-modified': '2025-07-31T05:51:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.002002'} 2025-07-31 05:51:40,930 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-07-31 05:51:40,938 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN0-68332753', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3480810621550676804', 'uuid-lslong': '11704309497333228022'}, 'enable': 'true', 'created': '2025-07-31T05:51:39', 'last-modified': '2025-07-31T05:51:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.033611'} 2025-07-31 05:51:40,949 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-07-31 05:51:40,959 - DEBUG - Control-node 10.0.0.61 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN0-68332753', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3480810621550676804', 'uuid-lslong': '11704309497333228022'}, 'enable': 'true', 'created': '2025-07-31T05:51:39', 'last-modified': '2025-07-31T05:51:39', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.053429'} 2025-07-31 05:51:40,969 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-07-31 05:51:40,970 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-27189330 passed 2025-07-31 05:51:40,970 - DEBUG - ====Verifying policy data for ctest-vn1-27189330 in API_Server ====== 2025-07-31 05:51:40,970 - DEBUG - Requesting: http://10.0.0.41:8082/domains 2025-07-31 05:51:40,981 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7 2025-07-31 05:51:41,009 - DEBUG - Requesting: http://10.0.0.41:8082/project/ac5f5468-d7a8-4019-8ee1-9a411ff512b3 2025-07-31 05:51:41,156 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/304e52d1-73ef-4b44-a26e-0f79c9c721f6 2025-07-31 05:51:41,178 - DEBUG - =>VN ctest-vn1-27189330 has no policy to be verified 2025-07-31 05:51:41,178 - DEBUG - Verifying the vn in opserver 2025-07-31 05:51:41,179 - DEBUG - Verifying the default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330 virtual network link through opserver 10.0.0.41 2025-07-31 05:51:41,179 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks 2025-07-31 05:51:41,506 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks 2025-07-31 05:51:41,630 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330?flat'} 2025-07-31 05:51:41,631 - DEBUG - Verifying the default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330 virtual network link through opserver 10.0.0.38 2025-07-31 05:51:41,631 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-07-31 05:51:41,952 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-07-31 05:51:42,035 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330?flat'} 2025-07-31 05:51:42,035 - DEBUG - Verifying the default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330 virtual network link through opserver 10.0.0.61 2025-07-31 05:51:42,035 - DEBUG - Requesting: http://10.0.0.61:8081/analytics/uves/virtual-networks 2025-07-31 05:51:42,363 - DEBUG - Requesting: http://10.0.0.61:8081/analytics/uves/virtual-networks 2025-07-31 05:51:42,507 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330', 'href': 'http://10.0.0.61:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330?flat'} 2025-07-31 05:51:42,508 - INFO - Validated that VN default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330 is found in opserver 2025-07-31 05:51:42,560 - DEBUG - Do not have enough data to verify VN in agent 2025-07-31 05:51:42,590 - DEBUG - VRF ids for VN ctest-vn1-27189330: {} 2025-07-31 05:51:42,777 - DEBUG - Services list from nova: [, , , ] 2025-07-31 05:51:44,319 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3732-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3732-1) 2025-07-31 05:51:45,942 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3732-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3732-2) 2025-07-31 05:51:45,943 - INFO - Waiting for VM ctest-vn1_vm1-17812600 to be up.. 2025-07-31 05:51:46,046 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-07-31 05:51:51,171 - DEBUG - VM is in ACTIVE state now 2025-07-31 05:51:51,171 - INFO - VM name : ctest-vn1_vm1-17812600 2025-07-31 05:51:51,276 - DEBUG - VM ctest-vn1_vm1-17812600 ID is 70ba7e6d-dca5-4968-a9a1-ee4fa4cd6b1a 2025-07-31 05:51:51,308 - DEBUG - VM ctest-vn1_vm1-17812600 launched on Node an-jenkins-deploy-platform-ansible-os-3732-1 2025-07-31 05:51:51,420 - DEBUG - Requesting: http://10.0.0.61:8082/virtual-machine/70ba7e6d-dca5-4968-a9a1-ee4fa4cd6b1a 2025-07-31 05:51:51,762 - DEBUG - Requesting: http://10.0.0.61:8082/virtual-machine/70ba7e6d-dca5-4968-a9a1-ee4fa4cd6b1a 2025-07-31 05:51:51,805 - DEBUG - Requesting: http://10.0.0.61:8082/virtual-machine-interface/1d6863d8-05ae-4e16-9814-fccb20f637ff 2025-07-31 05:51:55,019 - 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 1030ms') 2025-07-31 05:51:55,020 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-17812600 failed! 2025-07-31 05:51:55,044 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330 is 192.168.1.1 and allocation pool is NOT set 2025-07-31 05:51:59,119 - 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-07-31 05:51:59,119 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-17812600 failed! 2025-07-31 05:51:59,150 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330 is 192.168.1.1 and allocation pool is NOT set 2025-07-31 05:52:03,241 - 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 1022ms') 2025-07-31 05:52:03,242 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-17812600 failed! 2025-07-31 05:52:03,266 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330 is 192.168.1.1 and allocation pool is NOT set 2025-07-31 05:52:07,341 - 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-07-31 05:52:07,341 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-17812600 failed! 2025-07-31 05:52:07,369 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330 is 192.168.1.1 and allocation pool is NOT set 2025-07-31 05:52:11,430 - 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 1000ms') 2025-07-31 05:52:11,430 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-17812600 failed! 2025-07-31 05:52:11,456 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330 is 192.168.1.1 and allocation pool is NOT set 2025-07-31 05:52:15,534 - 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-07-31 05:52:15,535 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-17812600 failed! 2025-07-31 05:52:15,566 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330 is 192.168.1.1 and allocation pool is NOT set 2025-07-31 05:52:19,663 - 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-07-31 05:52:19,663 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-17812600 failed! 2025-07-31 05:52:19,694 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330 is 192.168.1.1 and allocation pool is NOT set 2025-07-31 05:52:23,794 - 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 1034ms') 2025-07-31 05:52:23,794 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-17812600 failed! 2025-07-31 05:52:23,818 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-27189330 is 192.168.1.1 and allocation pool is NOT set 2025-07-31 05:52:25,897 - 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=8.29 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=7.98 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 = 7.977/8.132/8.287/0.155 ms') 2025-07-31 05:52:25,897 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-17812600 passed 2025-07-31 05:52:25,988 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-07-31 05:52:25,988 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-17812600, IP 192.168.1.3, Port 22 2025-07-31 05:52:26,059 - 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-07-31 05:52:26,223 - DEBUG - VM ctest-vn1_vm1-17812600 is NOT ready for SSH connections, VM status: ACTIVE 2025-07-31 05:52:31,224 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-07-31 05:52:31,224 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-17812600, IP 192.168.1.3, Port 22 2025-07-31 05:52:31,286 - 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-07-31 05:52:31,481 - DEBUG - VM ctest-vn1_vm1-17812600 is NOT ready for SSH connections, VM status: ACTIVE 2025-07-31 05:52:36,482 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-07-31 05:52:36,482 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-17812600, IP 192.168.1.3, Port 22 2025-07-31 05:52:36,689 - 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-07-31 05:52:36,859 - DEBUG - VM ctest-vn1_vm1-17812600 is NOT ready for SSH connections, VM status: ACTIVE 2025-07-31 05:52:41,860 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-07-31 05:52:41,861 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-17812600, IP 192.168.1.3, Port 22 2025-07-31 05:52:41,932 - 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-07-31 05:52:42,089 - DEBUG - VM ctest-vn1_vm1-17812600 is NOT ready for SSH connections, VM status: ACTIVE 2025-07-31 05:52:47,090 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-07-31 05:52:47,090 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-17812600, IP 192.168.1.3, Port 22 2025-07-31 05:52:47,267 - DEBUG - VM ctest-vn1_vm1-17812600 is ready for SSH connections 2025-07-31 05:52:47,267 - INFO - Waiting for VM ctest-vn1_vm2-83275941 to be up.. 2025-07-31 05:52:47,424 - DEBUG - VM is in ACTIVE state now 2025-07-31 05:52:47,424 - INFO - VM name : ctest-vn1_vm2-83275941 2025-07-31 05:52:47,557 - DEBUG - VM ctest-vn1_vm2-83275941 ID is 6d6d0494-e200-4af8-85df-df6e08e086cd 2025-07-31 05:52:47,557 - DEBUG - VM ctest-vn1_vm2-83275941 launched on Node an-jenkins-deploy-platform-ansible-os-3732-2 2025-07-31 05:52:47,696 - DEBUG - Requesting: http://10.0.0.61:8082/virtual-machine/6d6d0494-e200-4af8-85df-df6e08e086cd 2025-07-31 05:52:47,713 - DEBUG - Requesting: http://10.0.0.61:8082/virtual-machine-interface/08082acd-e7da-4170-96c2-f65987d88a9b 2025-07-31 05:52:48,936 - 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=15.3 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=3.09 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 3.094/9.175/15.257/6.081 ms') 2025-07-31 05:52:48,936 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm2-83275941 passed 2025-07-31 05:52:49,027 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-07-31 05:52:49,027 - DEBUG - Waiting to SSH to VM ctest-vn1_vm2-83275941, IP 192.168.1.4, Port 22 2025-07-31 05:52:49,098 - 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-07-31 05:52:49,259 - DEBUG - VM ctest-vn1_vm2-83275941 is NOT ready for SSH connections, VM status: ACTIVE 2025-07-31 05:52:54,260 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-07-31 05:52:54,261 - DEBUG - Waiting to SSH to VM ctest-vn1_vm2-83275941, IP 192.168.1.4, Port 22 2025-07-31 05:52:54,337 - 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-07-31 05:52:54,520 - DEBUG - VM ctest-vn1_vm2-83275941 is NOT ready for SSH connections, VM status: ACTIVE 2025-07-31 05:52:59,522 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-07-31 05:52:59,522 - DEBUG - Waiting to SSH to VM ctest-vn1_vm2-83275941, IP 192.168.1.4, Port 22 2025-07-31 05:52:59,713 - DEBUG - VM ctest-vn1_vm2-83275941 is ready for SSH connections 2025-07-31 05:52:59,713 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-07-31 05:52:59,713 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 192.168.1.4, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.27, gateway password: c0ntrail123 2025-07-31 05:52:59,713 - DEBUG - ping -s 56 -c 3 -W 1 192.168.1.4 2025-07-31 05:53:45,486 - DEBUG - PING 192.168.1.4 (192.168.1.4) 56(84) bytes of data. 64 bytes from 192.168.1.4: icmp_req=1 ttl=64 time=14.8 ms 64 bytes from 192.168.1.4: icmp_req=2 ttl=64 time=1.33 ms 64 bytes from 192.168.1.4: icmp_req=3 ttl=64 time=1.35 ms --- 192.168.1.4 ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2004ms rtt min/avg/max/mdev = 1.338/5.840/14.832/6.358 ms 2025-07-31 05:53:45,487 - INFO - Ping to IP 192.168.1.4 from VM ctest-vn1_vm1-17812600 passed 2025-07-31 05:53:45,487 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-07-31 05:53:45,488 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 192.168.1.3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.57, gateway password: c0ntrail123 2025-07-31 05:53:45,488 - DEBUG - ping -s 56 -c 3 -W 1 192.168.1.3 2025-07-31 05:54:35,678 - DEBUG - PING 192.168.1.3 (192.168.1.3) 56(84) bytes of data. 64 bytes from 192.168.1.3: icmp_req=1 ttl=64 time=7.09 ms 64 bytes from 192.168.1.3: icmp_req=2 ttl=64 time=1.69 ms 64 bytes from 192.168.1.3: icmp_req=3 ttl=64 time=1.52 ms --- 192.168.1.3 ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2004ms rtt min/avg/max/mdev = 1.522/3.437/7.099/2.590 ms 2025-07-31 05:54:35,678 - INFO - Ping to IP 192.168.1.3 from VM ctest-vn1_vm2-83275941 passed 2025-07-31 05:54:35,688 - INFO - Active control node from the Agent 10.0.0.27 is 10.0.0.38 2025-07-31 05:54:35,688 - INFO - Stoping the Control service in 10.0.0.38 2025-07-31 05:54:36,095 - INFO - 10.0.0.38 2025-07-31 05:54:36,096 - INFO - control:inactive 2025-07-31 05:54:36,096 - INFO - Contrail services control are down on nodes 10.0.0.38 2025-07-31 05:54:36,102 - INFO - Deleting VM ctest-vn1_vm2-83275941 2025-07-31 05:54:36,259 - INFO - Deleting VM ctest-vn1_vm1-17812600 2025-07-31 05:54:36,349 - INFO - Deleting VN ctest-vn1-27189330 2025-07-31 05:54:36,416 - DEBUG - VN 304e52d1-73ef-4b44-a26e-0f79c9c721f6 still in use: Unable to complete operation on network 304e52d1-73ef-4b44-a26e-0f79c9c721f6. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-e9a0c1d8-72b0-4300-b47f-52a5fc59ca82'] 2025-07-31 05:54:36,416 - WARNING - Deleting VN ctest-vn1-27189330 failed..Will retry 2025-07-31 05:54:38,696 - DEBUG - Response for deleting network () 2025-07-31 05:54:38,696 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/733d4d03-9370-45de-8752-cddabbba342d 2025-07-31 05:54:38,706 - DEBUG - Response Code: 404 2025-07-31 05:54:38,706 - DEBUG - Requesting: http://10.0.0.41:8082/domains 2025-07-31 05:54:38,714 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7 2025-07-31 05:54:38,788 - DEBUG - Requesting: http://10.0.0.41:8082/project/ac5f5468-d7a8-4019-8ee1-9a411ff512b3 2025-07-31 05:54:38,890 - INFO - Validated that VN ctest-vn1-27189330 is not found in API Server 2025-07-31 05:54:38,904 - DEBUG - VN ctest-vn1-27189330 is not present in Agent 10.0.0.27 2025-07-31 05:54:38,920 - DEBUG - VN ctest-vn1-27189330 is not present in Agent 10.0.0.57 2025-07-31 05:54:38,920 - INFO - Validated that VN ctest-vn1-27189330 is not in any agent 2025-07-31 05:54:40,273 - ERROR - NameError Python 3.6.8: /usr/bin/python3 Thu Jul 31 05:54:36 2025 A problem occurred in a Python script. Here is the sequence of function calls leading up to the error, in the order they occurred. /contrail-test/tcutils/wrappers.py in wrapper(self=, *args=(), **kwargs={}) 78 log.info('Initial checks done. Running the testcase now') 79 log.info('') 80 result = function(self, *args, **kwargs) 81 if self.inputs.upgrade: 82 pid = os.getpid() result = None function = self = args = () kwargs = {} /contrail-test/serial_scripts/vm_regression/test_vm_serial.py in test_control_node_switchover(self=) 652 'contrail-control', [active_controller_host_ip], 653 container='control') 654 sleep(5) 655 656 # Check the control node shifted to other control node sleep undefined NameError: name 'sleep' is not defined __cause__ = None __class__ = __context__ = None __delattr__ = __dict__ = {} __dir__ = __doc__ = 'Name not found globally.' __eq__ = __format__ = __ge__ = __getattribute__ = __gt__ = __hash__ = __init__ = __init_subclass__ = __le__ = __lt__ = __ne__ = __new__ = __reduce__ = __reduce_ex__ = __repr__ = __setattr__ = __setstate__ = __sizeof__ = __str__ = __subclasshook__ = __suppress_context__ = False __traceback__ = args = ("name 'sleep' is not defined",) with_traceback = The above is a description of an error in a Python program. Here is the original traceback: Traceback (most recent call last): File "/contrail-test/tcutils/wrappers.py", line 80, in wrapper result = function(self, *args, **kwargs) File "/contrail-test/serial_scripts/vm_regression/test_vm_serial.py", line 654, in test_control_node_switchover sleep(5) NameError: name 'sleep' is not defined 2025-07-31 05:54:40,276 - DEBUG - Skipping xmpp flap check 2025-07-31 05:54:40,277 - INFO -
2025-07-31 05:54:40,278 - INFO - END TEST : test_control_node_switchover : FAILED[0:03:03]
2025-07-31 05:54:40,278 - INFO - -------------------------------------------------------------------------------- 2025-07-31 05:54:40,290 - INFO - ================================================================================ 2025-07-31 05:54:40,290 - INFO - STARTING TEST : test_process_restart_in_policy_between_vns 2025-07-31 05:54:40,290 - INFO - TEST DESCRIPTION : Test to validate that with policy having rule to check icmp fwding between VMs on different VNs , ping between VMs should pass with process restarts 1. Pick 2 VN's from resource pool which has one VM each 2. Create policy with icmp allow rule between those VN's and bind it networks 3. Ping from one VM to another VM 4. Restart process 'vrouter' and 'control' on setup 5. Ping again between VM's after process restart Pass criteria: Step 2,3,4 and 5 should pass 2025-07-31 05:54:41,647 - DEBUG - Skipping xmpp flap check 2025-07-31 05:54:41,647 - INFO - Initial checks done. Running the testcase now 2025-07-31 05:54:41,648 - INFO - 2025-07-31 05:54:41,663 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-89062862, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn2-26175813, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None] 2025-07-31 05:54:41,989 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn2-26175813, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-89062862, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None] 2025-07-31 05:54:42,577 - INFO - Created VN ctest-vn1-89062862, UUID :660dfdaa-3bad-4644-b384-f2e4e197d382 2025-07-31 05:54:42,974 - DEBUG - Requesting: http://10.0.0.41:8082/domains 2025-07-31 05:54:42,981 - DEBUG - Requesting: http://10.0.0.41:8082/domain/34dad5b7-e30d-42c7-8ff4-7b0d7fa576d7 2025-07-31 05:54:42,996 - DEBUG - Requesting: http://10.0.0.41:8082/project/ac5f5468-d7a8-4019-8ee1-9a411ff512b3 2025-07-31 05:54:43,134 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/660dfdaa-3bad-4644-b384-f2e4e197d382 2025-07-31 05:54:43,153 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/660dfdaa-3bad-4644-b384-f2e4e197d382 2025-07-31 05:54:43,169 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/97cf50fe-51bd-4c9b-8221-54ea0640463c 2025-07-31 05:54:43,179 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/97cf50fe-51bd-4c9b-8221-54ea0640463c 2025-07-31 05:54:43,190 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/b2510aef-cb25-47e6-bf42-e132ed75be55 2025-07-31 05:54:43,201 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-07-31 05:54:43,201 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/660dfdaa-3bad-4644-b384-f2e4e197d382 2025-07-31 05:54:43,214 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/97cf50fe-51bd-4c9b-8221-54ea0640463c 2025-07-31 05:54:43,233 - INFO - Verified VN network id 13 for VN 660dfdaa-3bad-4644-b384-f2e4e197d382 2025-07-31 05:54:43,233 - INFO - Verifications in API Server for VN ctest-vn1-89062862 passed 2025-07-31 05:54:43,233 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/660dfdaa-3bad-4644-b384-f2e4e197d382 2025-07-31 05:54:43,245 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/97cf50fe-51bd-4c9b-8221-54ea0640463c 2025-07-31 05:54:43,258 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/97cf50fe-51bd-4c9b-8221-54ea0640463c 2025-07-31 05:54:43,275 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/b2510aef-cb25-47e6-bf42-e132ed75be55 2025-07-31 05:54:43,299 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-89062862', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN0-68332753', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7353812674153367108', 'uuid-lslong': '12935731094566196098'}, 'enable': 'true', 'created': '2025-07-31T05:54:42', 'last-modified': '2025-07-31T05:54:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.570688'} 2025-07-31 05:54:43,309 - DEBUG - Route Targets: ['target:64512:8000007'] 2025-07-31 05:54:43,319 - INFO - Deleting VN ctest-vn1-89062862 2025-07-31 05:54:43,513 - INFO - Deleted policy policy2 2025-07-31 05:54:43,562 - INFO - Deleted policy policy1 2025-07-31 05:54:44,890 - ERROR - AttributeError Python 3.6.8: /usr/bin/python3 Thu Jul 31 05:54:43 2025 A problem occurred in a Python script. Here is the sequence of function calls leading up to the error, in the order they occurred. /contrail-test/tcutils/wrappers.py in wrapper(self=, *args=(), **kwargs={}) 78 log.info('Initial checks done. Running the testcase now') 79 log.info('') 80 result = function(self, *args, **kwargs) 81 if self.inputs.upgrade: 82 pid = os.getpid() result = None function = self = args = () kwargs = {} /contrail-test/serial_scripts/vm_regression/test_vm_serial.py in test_process_restart_in_policy_between_vns(self=) 397 connections=self.connections)) 398 vn1_fixture = self.create_vn(vn1_name, vn1_subnets, option='contrail') 399 assert vn1_fixture.verify_on_setup() 400 vn1_fixture.bind_policies( 401 [policy1_fixture.policy_fq_name], vn1_fixture.vn_id) vn1_fixture = vn1_fixture.verify_on_setup = > /contrail-test/fixtures/vn_test.py in verify_on_setup(self=) 579 "One or more verifications in API Server for VN %s failed" % (self.vn_name)) 580 return result 581 if not self.verify_vn_in_control_nodes(): 582 result = result and False 583 self.logger.error( self = self.verify_vn_in_control_nodes = .deco_retry..f_retry of > /contrail-test/tcutils/util.py in f_retry(*args=(,), **kwargs={}) 82 mtries, mdelay = tries, delay # make mutable 83 84 result = f(*args, **kwargs) # first attempt 85 rv = result 86 final = False result undefined f = args = (,) kwargs = {} /contrail-test/fixtures/vn_test.py in verify_vn_in_control_nodes(self=) 927 for cn in self.inputs.bgp_ips: 928 cn_config_vn_obj = self.cn_inspect[cn].get_cn_config_vn( 929 vn_name=self.vn_name, project=self.project_name, domain=self.domain_name) 930 if not cn_config_vn_obj: 931 self.logger.warn('Control-node %s does not have VN %s info ' % vn_name undefined self = self.vn_name = 'ctest-vn1-89062862' project undefined self.project_name = 'ctest-TestBasicVMVN0-68332753' domain undefined self.domain_name = 'default-domain' /contrail-test/tcutils/control/cn_introspect_utils.py in get_cn_config_vn(self=, domain='default-domain', project='ctest-TestBasicVMVN0-68332753', vn_name='ctest-vn1-89062862') 139 def get_cn_config_vn(self, domain='default-domain', project='admin', vn_name='default-virtual-network'): 140 m = 'virtual-network:' + domain + ':' + project + ':' + vn_name 141 return self._get_if_map_table_entry(m) 142 143 def get_cn_config_fip_pool(self, domain='default-domain', project='admin', vn_name='default-virtual-network', fip_pool_name='default-floating-ip-pool'): self = self._get_if_map_table_entry = > m = 'virtual-network:default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-89062862' /contrail-test/tcutils/control/cn_introspect_utils.py in _get_if_map_table_entry(self=, match='virtual-network:default-domain:ctest-TestBasicVMVN0-68332753:ctest-vn1-89062862') 37 new_table_req = 'Snh_IFMapTableShowReq?table_name=' + table_name.group(1) + '&search_string=' + match 38 p = self.dict_get(new_table_req) 39 xp = p.xpath('./IFMapTableShowResp/ifmap_db/list/IFMapNodeShowInfo') 40 if not xp: 41 # sometime ./xpath dosen't work; work around xp undefined p = None p.xpath undefined AttributeError: 'NoneType' object has no attribute 'xpath' __cause__ = None __class__ = __context__ = None __delattr__ = __dict__ = {} __dir__ = __doc__ = 'Attribute not found.' __eq__ = __format__ = __ge__ = __getattribute__ = __gt__ = __hash__ = __init__ = __init_subclass__ = __le__ = __lt__ = __ne__ = __new__ = __reduce__ = __reduce_ex__ = __repr__ = __setattr__ = __setstate__ = __sizeof__ = __str__ = __subclasshook__ = __suppress_context__ = False __traceback__ = args = ("'NoneType' object has no attribute 'xpath'",) with_traceback = The above is a description of an error in a Python program. Here is the original traceback: Traceback (most recent call last): File "/contrail-test/tcutils/wrappers.py", line 80, in wrapper result = function(self, *args, **kwargs) File "/contrail-test/serial_scripts/vm_regression/test_vm_serial.py", line 399, in test_process_restart_in_policy_between_vns assert vn1_fixture.verify_on_setup() File "/contrail-test/fixtures/vn_test.py", line 581, in verify_on_setup if not self.verify_vn_in_control_nodes(): File "/contrail-test/tcutils/util.py", line 84, in f_retry result = f(*args, **kwargs) # first attempt File "/contrail-test/fixtures/vn_test.py", line 929, in verify_vn_in_control_nodes vn_name=self.vn_name, project=self.project_name, domain=self.domain_name) File "/contrail-test/tcutils/control/cn_introspect_utils.py", line 141, in get_cn_config_vn return self._get_if_map_table_entry(m) File "/contrail-test/tcutils/control/cn_introspect_utils.py", line 39, in _get_if_map_table_entry xp = p.xpath('./IFMapTableShowResp/ifmap_db/list/IFMapNodeShowInfo') AttributeError: 'NoneType' object has no attribute 'xpath' 2025-07-31 05:54:44,891 - DEBUG - Skipping xmpp flap check 2025-07-31 05:54:44,891 - INFO -
2025-07-31 05:54:44,892 - INFO - END TEST : test_process_restart_in_policy_between_vns : FAILED[0:00:04]
2025-07-31 05:54:44,892 - INFO - -------------------------------------------------------------------------------- 2025-07-31 05:54:44,902 - INFO - ================================================================================ 2025-07-31 05:54:44,902 - INFO - STARTING TEST : test_underlay_broadcast_traffic_handling 2025-07-31 05:54:44,902 - INFO - TEST DESCRIPTION : Test the underlay brocast traffic handling by vrouter. (Bug-1545229). 1. Send broadcast traffic from one compute node. 2. Other compute in same subnet should receive that traffic. 3. Receiving compute should treat this traffic as underlay. 4. Compute should not replicate the packet and send the copy back. Pass criteria: Step 3-4 should pass Maintainer : chhandak@juniper.net 2025-07-31 05:54:46,257 - DEBUG - Skipping xmpp flap check 2025-07-31 05:54:46,258 - INFO - Initial checks done. Running the testcase now 2025-07-31 05:54:46,258 - INFO - 2025-07-31 05:54:46,690 - INFO - Agent interface name: ens6 2025-07-31 05:54:46,785 - DEBUG - Executing command: sudo tcpdump -nni ens6 -U host 10.20.0.255 -w /tmp/ens6_ctest-random-18274889.pcap 2025-07-31 05:54:48,294 - ERROR - NameError Python 3.6.8: /usr/bin/python3 Thu Jul 31 05:54:46 2025 A problem occurred in a Python script. Here is the sequence of function calls leading up to the error, in the order they occurred. /contrail-test/tcutils/wrappers.py in wrapper(self=, *args=(), **kwargs={}) 78 log.info('Initial checks done. Running the testcase now') 79 log.info('') 80 result = function(self, *args, **kwargs) 81 if self.inputs.upgrade: 82 pid = os.getpid() result = None function = self = args = () kwargs = {} /contrail-test/serial_scripts/vm_regression/test_vm_serial.py in test_underlay_broadcast_traffic_handling(self=) 914 compute_password, comp_intf, filters, self.logger) 915 916 sleep(5) 917 918 # Ping broadcast address sleep undefined NameError: name 'sleep' is not defined __cause__ = None __class__ = __context__ = None __delattr__ = __dict__ = {} __dir__ = __doc__ = 'Name not found globally.' __eq__ = __format__ = __ge__ = __getattribute__ = __gt__ = __hash__ = __init__ = __init_subclass__ = __le__ = __lt__ = __ne__ = __new__ = __reduce__ = __reduce_ex__ = __repr__ = __setattr__ = __setstate__ = __sizeof__ = __str__ = __subclasshook__ = __suppress_context__ = False __traceback__ = args = ("name 'sleep' is not defined",) with_traceback = The above is a description of an error in a Python program. Here is the original traceback: Traceback (most recent call last): File "/contrail-test/tcutils/wrappers.py", line 80, in wrapper result = function(self, *args, **kwargs) File "/contrail-test/serial_scripts/vm_regression/test_vm_serial.py", line 916, in test_underlay_broadcast_traffic_handling sleep(5) NameError: name 'sleep' is not defined 2025-07-31 05:54:48,294 - DEBUG - Skipping xmpp flap check 2025-07-31 05:54:48,296 - INFO -
2025-07-31 05:54:48,296 - INFO - END TEST : test_underlay_broadcast_traffic_handling : FAILED[0:00:04]
2025-07-31 05:54:48,296 - INFO - -------------------------------------------------------------------------------- 2025-07-31 05:54:49,163 - INFO - Deleted project: ctest-TestBasicVMVN0-68332753, ID : ac5f5468-d7a8-4019-8ee1-9a411ff512b3