2025-08-07 03:10:20,844 - INFO - Domain Default found not creating
2025-08-07 03:10:21,010 - INFO - Project ctest-TestStaticRouteTables-69894839 not found, creating it
2025-08-07 03:10:21,642 - INFO - Created Project:ctest-TestStaticRouteTables-69894839, ID : ef03d53a-1900-41fb-aaf0-c1ac0c178f87
2025-08-07 03:10:23,294 - INFO - ================================================================================
2025-08-07 03:10:23,294 - INFO - STARTING TEST : test_interface_static_table
2025-08-07 03:10:23,294 - INFO - TEST DESCRIPTION :
Description: Validate interface static table
Test steps:
1. Creating vm's - vm1 and vm2 and middle vm in networks vn1 and vn2.
2. Creating interface static table betn left and right vm
3. Apply static table to the middle ports.
4. Checking for ping and tcp traffic between vm1 and vm2.
Pass criteria: Ping between the VMs should be successful and route should be in the agent
2025-08-07 03:10:24,619 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.17': '0', '10.20.0.25': '0'}, '10.0.0.61': {'10.20.0.17': '0', '10.20.0.25': '0'}} with
2025-08-07 03:10:24,619 - INFO - Initial checks done. Running the testcase now
2025-08-07 03:10:24,619 - INFO -
2025-08-07 03:10:25,489 - DEBUG - Response for create_network : {'network': {'id': '60fd3c34-ac67-4bfa-b591-f751ec3cfc26', 'name': 'ctest-vn-80308814', 'tenant_id': 'ef03d53a190041fbaaf0c1ac0c178f87', 'project_id': 'ef03d53a190041fbaaf0c1ac0c178f87', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestStaticRouteTables-69894839', 'ctest-vn-80308814'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 03:10:25,892 - DEBUG - Response for create_subnet : {'subnet': {'id': '44d698db-e60b-43ee-aa5d-8fb03f39734f', 'name': '', 'tenant_id': 'ef03d53a190041fbaaf0c1ac0c178f87', 'network_id': '60fd3c34-ac67-4bfa-b591-f751ec3cfc26', 'ip_version': 4, 'cidr': '105.73.79.128/26', 'allocation_pools': [{'start': '105.73.79.130', 'end': '105.73.79.190'}], 'gateway_ip': '105.73.79.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '105.73.79.130', 'tags': [], 'project_id': 'ef03d53a190041fbaaf0c1ac0c178f87'}}
2025-08-07 03:10:25,919 - INFO - Created VN ctest-vn-80308814
2025-08-07 03:10:25,933 - DEBUG - VN ctest-vn-80308814 UUID is 60fd3c34-ac67-4bfa-b591-f751ec3cfc26
2025-08-07 03:10:26,434 - DEBUG - Response for create_network : {'network': {'id': '2f51352d-e72a-43ea-98af-8850e0872493', 'name': 'ctest-vn-11839803', 'tenant_id': 'ef03d53a190041fbaaf0c1ac0c178f87', 'project_id': 'ef03d53a190041fbaaf0c1ac0c178f87', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestStaticRouteTables-69894839', 'ctest-vn-11839803'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 03:10:26,746 - DEBUG - Response for create_subnet : {'subnet': {'id': '58627cce-bdfe-4633-bf12-5e7501039fd2', 'name': '', 'tenant_id': 'ef03d53a190041fbaaf0c1ac0c178f87', 'network_id': '2f51352d-e72a-43ea-98af-8850e0872493', 'ip_version': 4, 'cidr': '104.140.112.192/26', 'allocation_pools': [{'start': '104.140.112.194', 'end': '104.140.112.254'}], 'gateway_ip': '104.140.112.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '104.140.112.194', 'tags': [], 'project_id': 'ef03d53a190041fbaaf0c1ac0c178f87'}}
2025-08-07 03:10:26,776 - INFO - Created VN ctest-vn-11839803
2025-08-07 03:10:26,795 - DEBUG - VN ctest-vn-11839803 UUID is 2f51352d-e72a-43ea-98af-8850e0872493
2025-08-07 03:10:26,972 - DEBUG - Services list from nova: [, , , ]
2025-08-07 03:10:28,206 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3767-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3767-2)
2025-08-07 03:10:29,685 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3767-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3767-1)
2025-08-07 03:10:29,686 - INFO - Waiting for VM ctest-TestStaticRouteTables-69894839-57631693 to be up..
2025-08-07 03:10:29,791 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-08-07 03:10:34,894 - DEBUG - VM is in ACTIVE state now
2025-08-07 03:10:34,894 - INFO - VM name : ctest-TestStaticRouteTables-69894839-57631693
2025-08-07 03:10:34,982 - DEBUG - VM ctest-TestStaticRouteTables-69894839-57631693 ID is 952c4948-2eb9-44a4-9a90-b2ffbecdcf11
2025-08-07 03:10:35,006 - DEBUG - VM ctest-TestStaticRouteTables-69894839-57631693 launched on Node an-jenkins-deploy-platform-ansible-os-3767-2
2025-08-07 03:10:35,110 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/952c4948-2eb9-44a4-9a90-b2ffbecdcf11
2025-08-07 03:10:35,417 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/952c4948-2eb9-44a4-9a90-b2ffbecdcf11
2025-08-07 03:10:35,454 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/810ba9db-b01e-4c7f-89d8-86620f220a9a
2025-08-07 03:10:38,683 - 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-08-07 03:10:38,683 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-57631693 failed!
2025-08-07 03:10:38,700 - DEBUG - Gateway for vn default-domain:ctest-TestStaticRouteTables-69894839:ctest-vn-80308814 is 105.73.79.129 and allocation pool is NOT set
2025-08-07 03:10:42,787 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1021ms')
2025-08-07 03:10:42,787 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-57631693 failed!
2025-08-07 03:10:42,806 - DEBUG - Gateway for vn default-domain:ctest-TestStaticRouteTables-69894839:ctest-vn-80308814 is 105.73.79.129 and allocation pool is NOT set
2025-08-07 03:10:46,881 - 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-07 03:10:46,881 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-57631693 failed!
2025-08-07 03:10:46,898 - DEBUG - Gateway for vn default-domain:ctest-TestStaticRouteTables-69894839:ctest-vn-80308814 is 105.73.79.129 and allocation pool is NOT set
2025-08-07 03:10:50,988 - 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 1020ms')
2025-08-07 03:10:50,988 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-57631693 failed!
2025-08-07 03:10:51,006 - DEBUG - Gateway for vn default-domain:ctest-TestStaticRouteTables-69894839:ctest-vn-80308814 is 105.73.79.129 and allocation pool is NOT set
2025-08-07 03:10:55,105 - 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 1036ms')
2025-08-07 03:10:55,105 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-57631693 failed!
2025-08-07 03:10:55,123 - DEBUG - Gateway for vn default-domain:ctest-TestStaticRouteTables-69894839:ctest-vn-80308814 is 105.73.79.129 and allocation pool is NOT set
2025-08-07 03:10:59,201 - 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 1019ms')
2025-08-07 03:10:59,201 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-57631693 failed!
2025-08-07 03:10:59,220 - DEBUG - Gateway for vn default-domain:ctest-TestStaticRouteTables-69894839:ctest-vn-80308814 is 105.73.79.129 and allocation pool is NOT set
2025-08-07 03:11:03,295 - 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-07 03:11:03,295 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-57631693 failed!
2025-08-07 03:11:03,312 - DEBUG - Gateway for vn default-domain:ctest-TestStaticRouteTables-69894839:ctest-vn-80308814 is 105.73.79.129 and allocation pool is NOT set
2025-08-07 03:11:07,396 - 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 1019ms')
2025-08-07 03:11:07,396 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-57631693 failed!
2025-08-07 03:11:07,415 - DEBUG - Gateway for vn default-domain:ctest-TestStaticRouteTables-69894839:ctest-vn-80308814 is 105.73.79.129 and allocation pool is NOT set
2025-08-07 03:11:09,477 - 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=16.3 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=3.66 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.664/9.958/16.253/6.294 ms')
2025-08-07 03:11:09,477 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-57631693 passed
2025-08-07 03:11:09,592 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 03:11:09,593 - DEBUG - Waiting to SSH to VM ctest-TestStaticRouteTables-69894839-57631693, IP 105.73.79.131, Port 22
2025-08-07 03:11:09,659 - 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-07 03:11:09,754 - DEBUG - VM ctest-TestStaticRouteTables-69894839-57631693 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-07 03:11:14,755 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 03:11:14,755 - DEBUG - Waiting to SSH to VM ctest-TestStaticRouteTables-69894839-57631693, IP 105.73.79.131, Port 22
2025-08-07 03:11:14,814 - 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-07 03:11:14,939 - DEBUG - VM ctest-TestStaticRouteTables-69894839-57631693 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-07 03:11:19,940 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 03:11:19,940 - DEBUG - Waiting to SSH to VM ctest-TestStaticRouteTables-69894839-57631693, IP 105.73.79.131, Port 22
2025-08-07 03:11:20,010 - 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-07 03:11:20,107 - DEBUG - VM ctest-TestStaticRouteTables-69894839-57631693 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-07 03:11:25,108 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 03:11:25,108 - DEBUG - Waiting to SSH to VM ctest-TestStaticRouteTables-69894839-57631693, IP 105.73.79.131, Port 22
2025-08-07 03:11:25,165 - 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-07 03:11:25,272 - DEBUG - VM ctest-TestStaticRouteTables-69894839-57631693 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-07 03:11:30,273 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 03:11:30,273 - DEBUG - Waiting to SSH to VM ctest-TestStaticRouteTables-69894839-57631693, IP 105.73.79.131, Port 22
2025-08-07 03:11:30,440 - DEBUG - VM ctest-TestStaticRouteTables-69894839-57631693 is ready for SSH connections
2025-08-07 03:11:30,440 - INFO - Waiting for VM ctest-TestStaticRouteTables-69894839-12042743 to be up..
2025-08-07 03:11:30,538 - DEBUG - VM is in ACTIVE state now
2025-08-07 03:11:30,538 - INFO - VM name : ctest-TestStaticRouteTables-69894839-12042743
2025-08-07 03:11:30,632 - DEBUG - VM ctest-TestStaticRouteTables-69894839-12042743 ID is 74dcb3df-ca94-4da9-abed-e93cd79c4f86
2025-08-07 03:11:30,632 - DEBUG - VM ctest-TestStaticRouteTables-69894839-12042743 launched on Node an-jenkins-deploy-platform-ansible-os-3767-1
2025-08-07 03:11:30,719 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/74dcb3df-ca94-4da9-abed-e93cd79c4f86
2025-08-07 03:11:30,732 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/488b532e-f96d-499f-8a88-b0f0a41a18c8
2025-08-07 03:11:31,959 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=3.44 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=3.73 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.438/3.584/3.731/0.146 ms')
2025-08-07 03:11:31,959 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-12042743 passed
2025-08-07 03:11:32,079 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 03:11:32,079 - DEBUG - Waiting to SSH to VM ctest-TestStaticRouteTables-69894839-12042743, IP 104.140.112.195, Port 22
2025-08-07 03:11:32,144 - 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-07 03:11:32,238 - DEBUG - VM ctest-TestStaticRouteTables-69894839-12042743 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-07 03:11:37,239 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 03:11:37,239 - DEBUG - Waiting to SSH to VM ctest-TestStaticRouteTables-69894839-12042743, IP 104.140.112.195, Port 22
2025-08-07 03:11:37,309 - 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-07 03:11:37,400 - DEBUG - VM ctest-TestStaticRouteTables-69894839-12042743 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-07 03:11:42,402 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 03:11:42,402 - DEBUG - Waiting to SSH to VM ctest-TestStaticRouteTables-69894839-12042743, IP 104.140.112.195, Port 22
2025-08-07 03:11:42,576 - DEBUG - VM ctest-TestStaticRouteTables-69894839-12042743 is ready for SSH connections
2025-08-07 03:11:42,786 - DEBUG - Image by name ubuntu not found
2025-08-07 03:11:42,786 - DEBUG - Installing image ubuntu
2025-08-07 03:11:42,786 - DEBUG - Image info {'name': 'ubuntu.vmdk.gz', 'webserver': '', 'location': '/images/converts/', 'username': 'ubuntu', 'password': 'ubuntu', 'type': 'os', 'flavor': 'contrail_flavor_tiny', '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-07 03:11:42,786 - DEBUG - Image build path file:///contrail-test/images/ubuntu.vmdk.gz
2025-08-07 03:11:42,787 - DEBUG - Download image from local file file:///contrail-test/images/ubuntu.vmdk.gz
2025-08-07 03:11:42,787 - DEBUG - Unzip image
2025-08-07 03:11:42,787 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/ubuntu.vmdk.gz
2025-08-07 03:11:42,805 - INFO - image /contrail-test/images/ubuntu.vmdk is not found
2025-08-07 03:11:42,806 - INFO - Deleting VM ctest-TestStaticRouteTables-69894839-12042743
2025-08-07 03:11:42,883 - INFO - Deleting VM ctest-TestStaticRouteTables-69894839-57631693
2025-08-07 03:11:42,956 - INFO - Deleting VN ctest-vn-11839803
2025-08-07 03:11:43,004 - DEBUG - VN 2f51352d-e72a-43ea-98af-8850e0872493 still in use: Unable to complete operation on network 2f51352d-e72a-43ea-98af-8850e0872493. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-4b7a1c77-bef5-4211-a064-e0739a335315']
2025-08-07 03:11:43,004 - WARNING - Deleting VN ctest-vn-11839803 failed..Will retry
2025-08-07 03:11:45,235 - DEBUG - Response for deleting network ()
2025-08-07 03:11:45,235 - INFO - Deleting VN ctest-vn-80308814
2025-08-07 03:11:45,498 - DEBUG - Response for deleting network ()
2025-08-07 03:11:46,795 - DEBUG - No XMPP flaps were noticed during the test
2025-08-07 03:11:46,795 - INFO -
2025-08-07 03:11:46,795 - INFO - END TEST : test_interface_static_table : SKIPPED[0:01:23]
2025-08-07 03:11:46,795 - INFO - --------------------------------------------------------------------------------
2025-08-07 03:11:46,799 - INFO - ================================================================================
2025-08-07 03:11:46,799 - INFO - STARTING TEST : test_network_route_table
2025-08-07 03:11:46,799 - INFO - TEST DESCRIPTION :
Description: Validate network static table
Test steps:
1. Creating vm's - vm1 and vm2 and middle vm in networks vn1 and vn2.
2. Creating network static table betn left and right vm
3. Apply static table to the middle ports.
4. Checking for ping and tcp traffic between vm1 and vm2.
Pass criteria: Ping between the VMs should be successful and route should be in the agent
2025-08-07 03:11:48,122 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.17': '0', '10.20.0.25': '0'}, '10.0.0.61': {'10.20.0.17': '0', '10.20.0.25': '0'}} with
2025-08-07 03:11:48,122 - INFO - Initial checks done. Running the testcase now
2025-08-07 03:11:48,122 - INFO -
2025-08-07 03:11:48,423 - DEBUG - Response for create_network : {'network': {'id': '7c9ba314-48a3-4ff5-a94a-d8280d11cc94', 'name': 'ctest-vn-24523018', 'tenant_id': 'ef03d53a190041fbaaf0c1ac0c178f87', 'project_id': 'ef03d53a190041fbaaf0c1ac0c178f87', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestStaticRouteTables-69894839', 'ctest-vn-24523018'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 03:11:48,694 - DEBUG - Response for create_subnet : {'subnet': {'id': '258c02c4-7a3d-456a-b968-65eca8b96b20', 'name': '', 'tenant_id': 'ef03d53a190041fbaaf0c1ac0c178f87', 'network_id': '7c9ba314-48a3-4ff5-a94a-d8280d11cc94', 'ip_version': 4, 'cidr': '111.51.64.64/26', 'allocation_pools': [{'start': '111.51.64.66', 'end': '111.51.64.126'}], 'gateway_ip': '111.51.64.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '111.51.64.66', 'tags': [], 'project_id': 'ef03d53a190041fbaaf0c1ac0c178f87'}}
2025-08-07 03:11:48,723 - INFO - Created VN ctest-vn-24523018
2025-08-07 03:11:48,738 - DEBUG - VN ctest-vn-24523018 UUID is 7c9ba314-48a3-4ff5-a94a-d8280d11cc94
2025-08-07 03:11:49,166 - DEBUG - Response for create_network : {'network': {'id': '223163de-89b1-416b-b3ba-5fcce56846cd', 'name': 'ctest-vn-19024874', 'tenant_id': 'ef03d53a190041fbaaf0c1ac0c178f87', 'project_id': 'ef03d53a190041fbaaf0c1ac0c178f87', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestStaticRouteTables-69894839', 'ctest-vn-19024874'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 03:11:49,472 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd805a629-78fd-4fcd-bb86-ffabf82f2368', 'name': '', 'tenant_id': 'ef03d53a190041fbaaf0c1ac0c178f87', 'network_id': '223163de-89b1-416b-b3ba-5fcce56846cd', 'ip_version': 4, 'cidr': '55.246.67.192/26', 'allocation_pools': [{'start': '55.246.67.194', 'end': '55.246.67.254'}], 'gateway_ip': '55.246.67.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '55.246.67.194', 'tags': [], 'project_id': 'ef03d53a190041fbaaf0c1ac0c178f87'}}
2025-08-07 03:11:49,498 - INFO - Created VN ctest-vn-19024874
2025-08-07 03:11:49,518 - DEBUG - VN ctest-vn-19024874 UUID is 223163de-89b1-416b-b3ba-5fcce56846cd
2025-08-07 03:11:50,822 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3767-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3767-1)
2025-08-07 03:11:52,341 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3767-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3767-2)
2025-08-07 03:11:52,341 - INFO - Waiting for VM ctest-TestStaticRouteTables-69894839-72450090 to be up..
2025-08-07 03:11:52,442 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-08-07 03:11:57,539 - DEBUG - VM is in ACTIVE state now
2025-08-07 03:11:57,539 - INFO - VM name : ctest-TestStaticRouteTables-69894839-72450090
2025-08-07 03:11:57,640 - DEBUG - VM ctest-TestStaticRouteTables-69894839-72450090 ID is 330ae93a-3b3f-45eb-bb95-640dfb7412d1
2025-08-07 03:11:57,640 - DEBUG - VM ctest-TestStaticRouteTables-69894839-72450090 launched on Node an-jenkins-deploy-platform-ansible-os-3767-1
2025-08-07 03:11:57,740 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/330ae93a-3b3f-45eb-bb95-640dfb7412d1
2025-08-07 03:11:57,752 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/0d60bbfd-7c16-4ddc-8294-6886acc3a374
2025-08-07 03:12:00,994 - 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-07 03:12:00,994 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-72450090 failed!
2025-08-07 03:12:01,017 - DEBUG - Gateway for vn default-domain:ctest-TestStaticRouteTables-69894839:ctest-vn-24523018 is 111.51.64.65 and allocation pool is NOT set
2025-08-07 03:12:05,093 - 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-07 03:12:05,093 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-72450090 failed!
2025-08-07 03:12:05,113 - DEBUG - Gateway for vn default-domain:ctest-TestStaticRouteTables-69894839:ctest-vn-24523018 is 111.51.64.65 and allocation pool is NOT set
2025-08-07 03:12:09,188 - 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-07 03:12:09,188 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-72450090 failed!
2025-08-07 03:12:09,206 - DEBUG - Gateway for vn default-domain:ctest-TestStaticRouteTables-69894839:ctest-vn-24523018 is 111.51.64.65 and allocation pool is NOT set
2025-08-07 03:12:13,279 - 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-07 03:12:13,279 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-72450090 failed!
2025-08-07 03:12:13,301 - DEBUG - Gateway for vn default-domain:ctest-TestStaticRouteTables-69894839:ctest-vn-24523018 is 111.51.64.65 and allocation pool is NOT set
2025-08-07 03:12:17,373 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1012ms')
2025-08-07 03:12:17,373 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-72450090 failed!
2025-08-07 03:12:17,393 - DEBUG - Gateway for vn default-domain:ctest-TestStaticRouteTables-69894839:ctest-vn-24523018 is 111.51.64.65 and allocation pool is NOT set
2025-08-07 03:12:21,473 - 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-07 03:12:21,473 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-72450090 failed!
2025-08-07 03:12:21,489 - DEBUG - Gateway for vn default-domain:ctest-TestStaticRouteTables-69894839:ctest-vn-24523018 is 111.51.64.65 and allocation pool is NOT set
2025-08-07 03:12:25,574 - 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-07 03:12:25,574 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-72450090 failed!
2025-08-07 03:12:25,591 - DEBUG - Gateway for vn default-domain:ctest-TestStaticRouteTables-69894839:ctest-vn-24523018 is 111.51.64.65 and allocation pool is NOT set
2025-08-07 03:12:29,666 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1012ms')
2025-08-07 03:12:29,666 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-72450090 failed!
2025-08-07 03:12:29,682 - DEBUG - Gateway for vn default-domain:ctest-TestStaticRouteTables-69894839:ctest-vn-24523018 is 111.51.64.65 and allocation pool is NOT set
2025-08-07 03:12:33,769 - 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 1016ms')
2025-08-07 03:12:33,769 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-72450090 failed!
2025-08-07 03:12:33,786 - DEBUG - Gateway for vn default-domain:ctest-TestStaticRouteTables-69894839:ctest-vn-24523018 is 111.51.64.65 and allocation pool is NOT set
2025-08-07 03:12:37,859 - 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-07 03:12:37,859 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-72450090 failed!
2025-08-07 03:12:37,880 - DEBUG - Gateway for vn default-domain:ctest-TestStaticRouteTables-69894839:ctest-vn-24523018 is 111.51.64.65 and allocation pool is NOT set
2025-08-07 03:12:39,949 - 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=11.8 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.97 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 1.971/6.864/11.758/4.893 ms')
2025-08-07 03:12:39,949 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-72450090 passed
2025-08-07 03:12:40,064 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 03:12:40,064 - DEBUG - Waiting to SSH to VM ctest-TestStaticRouteTables-69894839-72450090, IP 111.51.64.67, Port 22
2025-08-07 03:12:40,133 - 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-07 03:12:40,261 - DEBUG - VM ctest-TestStaticRouteTables-69894839-72450090 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-07 03:12:45,261 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 03:12:45,262 - DEBUG - Waiting to SSH to VM ctest-TestStaticRouteTables-69894839-72450090, IP 111.51.64.67, Port 22
2025-08-07 03:12:45,329 - 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-07 03:12:45,420 - DEBUG - VM ctest-TestStaticRouteTables-69894839-72450090 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-07 03:12:50,421 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 03:12:50,422 - DEBUG - Waiting to SSH to VM ctest-TestStaticRouteTables-69894839-72450090, IP 111.51.64.67, Port 22
2025-08-07 03:12:50,541 - 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-07 03:12:50,636 - DEBUG - VM ctest-TestStaticRouteTables-69894839-72450090 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-07 03:12:55,637 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 03:12:55,637 - DEBUG - Waiting to SSH to VM ctest-TestStaticRouteTables-69894839-72450090, IP 111.51.64.67, Port 22
2025-08-07 03:12:55,705 - 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-07 03:12:55,797 - DEBUG - VM ctest-TestStaticRouteTables-69894839-72450090 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-07 03:13:00,798 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 03:13:00,798 - DEBUG - Waiting to SSH to VM ctest-TestStaticRouteTables-69894839-72450090, IP 111.51.64.67, Port 22
2025-08-07 03:13:00,969 - DEBUG - VM ctest-TestStaticRouteTables-69894839-72450090 is ready for SSH connections
2025-08-07 03:13:00,969 - INFO - Waiting for VM ctest-TestStaticRouteTables-69894839-91043067 to be up..
2025-08-07 03:13:01,070 - DEBUG - VM is in ACTIVE state now
2025-08-07 03:13:01,070 - INFO - VM name : ctest-TestStaticRouteTables-69894839-91043067
2025-08-07 03:13:01,218 - DEBUG - VM ctest-TestStaticRouteTables-69894839-91043067 ID is fa26246f-f96d-4535-9fcc-fec2023974f9
2025-08-07 03:13:01,218 - DEBUG - VM ctest-TestStaticRouteTables-69894839-91043067 launched on Node an-jenkins-deploy-platform-ansible-os-3767-2
2025-08-07 03:13:01,330 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/fa26246f-f96d-4535-9fcc-fec2023974f9
2025-08-07 03:13:01,344 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/1fd7d334-98a5-4a71-b4aa-32ace5be578a
2025-08-07 03:13:02,573 - 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=2.38 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.90 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 2.383/2.639/2.895/0.256 ms')
2025-08-07 03:13:02,573 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestStaticRouteTables-69894839-91043067 passed
2025-08-07 03:13:02,693 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 03:13:02,693 - DEBUG - Waiting to SSH to VM ctest-TestStaticRouteTables-69894839-91043067, IP 55.246.67.195, Port 22
2025-08-07 03:13:02,853 - DEBUG - VM ctest-TestStaticRouteTables-69894839-91043067 is ready for SSH connections
2025-08-07 03:13:03,070 - DEBUG - Image by name ubuntu not found
2025-08-07 03:13:03,070 - DEBUG - Installing image ubuntu
2025-08-07 03:13:03,070 - DEBUG - Image info {'name': 'ubuntu.vmdk.gz', 'webserver': '', 'location': '/images/converts/', 'username': 'ubuntu', 'password': 'ubuntu', 'type': 'os', 'flavor': 'contrail_flavor_tiny', '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-07 03:13:03,071 - DEBUG - Image build path file:///contrail-test/images/ubuntu.vmdk.gz
2025-08-07 03:13:03,071 - DEBUG - Download image from local file file:///contrail-test/images/ubuntu.vmdk.gz
2025-08-07 03:13:03,071 - DEBUG - Unzip image
2025-08-07 03:13:03,071 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/ubuntu.vmdk.gz
2025-08-07 03:13:03,092 - INFO - image /contrail-test/images/ubuntu.vmdk is not found
2025-08-07 03:13:03,092 - INFO - Deleting VM ctest-TestStaticRouteTables-69894839-91043067
2025-08-07 03:13:03,173 - INFO - Deleting VM ctest-TestStaticRouteTables-69894839-72450090
2025-08-07 03:13:03,253 - INFO - Deleting VN ctest-vn-19024874
2025-08-07 03:13:03,300 - DEBUG - VN 223163de-89b1-416b-b3ba-5fcce56846cd still in use: Unable to complete operation on network 223163de-89b1-416b-b3ba-5fcce56846cd. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-e72d855c-1498-4bbc-90e4-77cf5d4c83f0']
2025-08-07 03:13:03,300 - WARNING - Deleting VN ctest-vn-19024874 failed..Will retry
2025-08-07 03:13:05,492 - DEBUG - Response for deleting network ()
2025-08-07 03:13:05,492 - INFO - Deleting VN ctest-vn-24523018
2025-08-07 03:13:05,691 - DEBUG - Response for deleting network ()
2025-08-07 03:13:06,994 - DEBUG - No XMPP flaps were noticed during the test
2025-08-07 03:13:06,994 - INFO -
2025-08-07 03:13:06,994 - INFO - END TEST : test_network_route_table : SKIPPED[0:01:20]
2025-08-07 03:13:06,994 - INFO - --------------------------------------------------------------------------------
2025-08-07 03:13:07,786 - INFO - Deleted project: ctest-TestStaticRouteTables-69894839, ID : ef03d53a-1900-41fb-aaf0-c1ac0c178f87