is in ACTIVE state now
2026-05-25 03:46:23,062 - INFO - VM name : ctest-TestSubInterfaces-51424852-05833393
2026-05-25 03:46:23,162 - DEBUG - VM ctest-TestSubInterfaces-51424852-05833393 ID is f0177409-ead7-41fc-9c9f-7f7736c9bf38
2026-05-25 03:46:23,163 - DEBUG - VM ctest-TestSubInterfaces-51424852-05833393 launched on Node an-jenkins-deploy-platform-ansible-os-5822-2
2026-05-25 03:46:23,274 - DEBUG - Requesting: http://10.0.0.131:8082/virtual-machine/f0177409-ead7-41fc-9c9f-7f7736c9bf38
2026-05-25 03:46:23,288 - DEBUG - Requesting: http://10.0.0.131:8082/virtual-machine-interface/b5881108-07b9-43dd-adc6-9ce1c80e4f98
2026-05-25 03:46:24,463 - DEBUG - (True, 'PING 169.254.0.7 (169.254.0.7) 56(84) bytes of data.\r\n64 bytes from 169.254.0.7: icmp_seq=1 ttl=63 time=6.01 ms\r\n64 bytes from 169.254.0.7: icmp_seq=2 ttl=63 time=1.61 ms\r\n\r\n--- 169.254.0.7 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 1.610/3.808/6.006/2.198 ms')
2026-05-25 03:46:24,464 - INFO - Ping to Metadata IP 169.254.0.7 of VM ctest-TestSubInterfaces-51424852-05833393 passed
2026-05-25 03:46:24,542 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-25 03:46:24,542 - DEBUG - Waiting to SSH to VM ctest-TestSubInterfaces-51424852-05833393, IP 14.39.88.69, Port 22
2026-05-25 03:46:24,609 - DEBUG - Error on ssh to ubuntu@169.254.0.7:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.7/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.7/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.7/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-05-25 03:46:24,722 - DEBUG - VM ctest-TestSubInterfaces-51424852-05833393 is NOT ready for SSH connections, VM status: ACTIVE
2026-05-25 03:46:29,722 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-25 03:46:29,723 - DEBUG - Waiting to SSH to VM ctest-TestSubInterfaces-51424852-05833393, IP 14.39.88.69, Port 22
2026-05-25 03:46:29,901 - DEBUG - VM ctest-TestSubInterfaces-51424852-05833393 is ready for SSH connections
2026-05-25 03:46:29,901 - DEBUG - Running remote_cmd, Cmd : ifconfig -a| grep 76.113.227.195 -A2 -B4| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1, host_string: ubuntu@169.254.0.5, password: ubuntugateway: ubuntu@10.0.0.240, gateway password: c0ntrail123
2026-05-25 03:46:29,902 - DEBUG - ifconfig -a| grep 76.113.227.195 -A2 -B4| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1
2026-05-25 03:46:57,372 - DEBUG - None
2026-05-25 03:47:02,373 - DEBUG - Running remote_cmd, Cmd : ifconfig -a| grep 76.113.227.195 -A2 -B4| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1, host_string: ubuntu@169.254.0.5, password: ubuntugateway: ubuntu@10.0.0.240, gateway password: c0ntrail123
2026-05-25 03:47:02,373 - DEBUG - ifconfig -a| grep 76.113.227.195 -A2 -B4| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1
2026-05-25 03:47:04,114 - DEBUG - None
2026-05-25 03:47:09,114 - DEBUG - Running remote_cmd, Cmd : ifconfig -a| grep 76.113.227.195 -A2 -B4| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1, host_string: ubuntu@169.254.0.5, password: ubuntugateway: ubuntu@10.0.0.240, gateway password: c0ntrail123
2026-05-25 03:47:09,115 - DEBUG - ifconfig -a| grep 76.113.227.195 -A2 -B4| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1
2026-05-25 03:47:11,842 - DEBUG - None
2026-05-25 03:47:16,842 - DEBUG - Running remote_cmd, Cmd : ifconfig -a| grep 76.113.227.195 -A2 -B4| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1, host_string: ubuntu@169.254.0.5, password: ubuntugateway: ubuntu@10.0.0.240, gateway password: c0ntrail123
2026-05-25 03:47:16,843 - DEBUG - ifconfig -a| grep 76.113.227.195 -A2 -B4| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1
2026-05-25 03:47:18,881 - DEBUG - eth0.100
2026-05-25 03:47:18,881 - INFO - Interface eth0.100 is found on VM 4035eccc-97c0-48ef-9f1e-80569cbd0cb4
2026-05-25 03:47:18,881 - DEBUG - Running remote_cmd, Cmd : ifconfig -a| grep 115.106.189.3 -A2 -B4| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1, host_string: ubuntu@169.254.0.7, password: ubuntugateway: ubuntu@10.0.0.240, gateway password: c0ntrail123
2026-05-25 03:47:18,882 - DEBUG - ifconfig -a| grep 115.106.189.3 -A2 -B4| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1
2026-05-25 03:48:08,298 - DEBUG - eth0.100
2026-05-25 03:48:08,298 - INFO - Interface eth0.100 is found on VM f0177409-ead7-41fc-9c9f-7f7736c9bf38
2026-05-25 03:48:08,298 - DEBUG - Running remote_cmd, Cmd : route add -net 115.106.189.0/26 dev eth0.100, host_string: ubuntu@169.254.0.5, password: ubuntugateway: ubuntu@10.0.0.240, gateway password: c0ntrail123
2026-05-25 03:48:08,299 - DEBUG - route add -net 115.106.189.0/26 dev eth0.100
2026-05-25 03:48:08,949 - DEBUG - None
2026-05-25 03:48:08,949 - DEBUG - Running remote_cmd, Cmd : route add -net 76.113.227.192/26 dev eth0.100, host_string: ubuntu@169.254.0.7, password: ubuntugateway: ubuntu@10.0.0.240, gateway password: c0ntrail123
2026-05-25 03:48:08,949 - DEBUG - route add -net 76.113.227.192/26 dev eth0.100
2026-05-25 03:48:09,658 - DEBUG - None
2026-05-25 03:48:09,658 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-25 03:48:09,658 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 115.106.189.4, host_string: ubuntu@169.254.0.5, password: ubuntugateway: ubuntu@10.0.0.240, gateway password: c0ntrail123
2026-05-25 03:48:09,658 - DEBUG - ping -s 56 -c 3 -W 1 115.106.189.4
2026-05-25 03:48:12,495 - DEBUG - PING 115.106.189.4 (115.106.189.4) 56(84) bytes of data.
64 bytes from 115.106.189.4: icmp_req=1 ttl=63 time=12.7 ms
64 bytes from 115.106.189.4: icmp_req=2 ttl=63 time=1.74 ms
64 bytes from 115.106.189.4: icmp_req=3 ttl=63 time=2.13 ms
--- 115.106.189.4 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2008ms
rtt min/avg/max/mdev = 1.746/5.537/12.727/5.086 ms
2026-05-25 03:48:12,495 - INFO - Ping to IP 115.106.189.4 from VM ctest-TestSubInterfaces-51424852-02889489 passed
2026-05-25 03:48:12,496 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 115.106.189.3, host_string: ubuntu@169.254.0.5, password: ubuntugateway: ubuntu@10.0.0.240, gateway password: c0ntrail123
2026-05-25 03:48:12,496 - DEBUG - ping -s 56 -c 3 -W 1 115.106.189.3
2026-05-25 03:48:15,127 - DEBUG - PING 115.106.189.3 (115.106.189.3) 56(84) bytes of data.
64 bytes from 115.106.189.3: icmp_req=1 ttl=63 time=12.3 ms
64 bytes from 115.106.189.3: icmp_req=2 ttl=63 time=1.80 ms
64 bytes from 115.106.189.3: icmp_req=3 ttl=63 time=2.64 ms
--- 115.106.189.3 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2003ms
rtt min/avg/max/mdev = 1.803/5.611/12.387/4.803 ms
2026-05-25 03:48:15,128 - INFO - Ping to IP 115.106.189.3 from VM ctest-TestSubInterfaces-51424852-02889489 passed
2026-05-25 03:48:15,128 - INFO - Deleting interface with subnet_id 246086a7-3fc2-44e8-8dc5-98e810e35fc9, port_id None from router 70c6624a-7f6f-4c95-8302-380b3e65bca0
2026-05-25 03:48:15,433 - INFO - Deleting interface with subnet_id 635d70d6-bb25-44aa-bb64-b264c4f666db, port_id None from router 70c6624a-7f6f-4c95-8302-380b3e65bca0
2026-05-25 03:48:15,788 - INFO - Detaching port b5881108-07b9-43dd-adc6-9ce1c80e4f98 from VM ctest-TestSubInterfaces-51424852-05833393
2026-05-25 03:48:15,845 - INFO - Deleting VM ctest-TestSubInterfaces-51424852-05833393
2026-05-25 03:48:16,019 - INFO - Deleting VM ctest-TestSubInterfaces-51424852-93917859
2026-05-25 03:48:16,136 - INFO - Detaching port cc0841df-eb24-4562-a35c-4ef1f11f5ae5 from VM ctest-TestSubInterfaces-51424852-02889489
2026-05-25 03:48:16,189 - INFO - Deleting VM ctest-TestSubInterfaces-51424852-02889489
2026-05-25 03:48:17,643 - DEBUG - No XMPP flaps were noticed during the test
2026-05-25 03:48:17,643 - INFO - END TEST : test_vlan_interface_2 : PASSED[0:03:40]
2026-05-25 03:48:17,643 - INFO - --------------------------------------------------------------------------------
2026-05-25 03:48:17,847 - INFO - Deleted port 50aeca5e-24fe-4b6c-90d6-6b0df91e7171
2026-05-25 03:48:18,151 - DEBUG - Response for delete_port : ()
2026-05-25 03:48:18,151 - INFO - Deleted port b5881108-07b9-43dd-adc6-9ce1c80e4f98
2026-05-25 03:48:18,301 - INFO - Deleted port dc8987ec-3272-42f3-af2f-a059ed2ddea0
2026-05-25 03:48:18,469 - DEBUG - Response for delete_port : ()
2026-05-25 03:48:18,470 - INFO - Deleted port 486370ec-ff2c-40fa-818d-622286368708
2026-05-25 03:48:18,615 - INFO - Deleted port e58a56c6-6404-4099-917c-a52f47c3fbca
2026-05-25 03:48:18,790 - DEBUG - Response for delete_port : ()
2026-05-25 03:48:18,791 - INFO - Deleted port cc0841df-eb24-4562-a35c-4ef1f11f5ae5
2026-05-25 03:48:18,791 - INFO - Deleting VN ctest-vn-60758525
2026-05-25 03:48:18,980 - DEBUG - Response for deleting network ()
2026-05-25 03:48:18,980 - INFO - Deleting VN ctest-vn-07315201
2026-05-25 03:48:19,223 - DEBUG - Response for deleting network ()
2026-05-25 03:48:19,224 - INFO - Deleting VN ctest-vn-40984990
2026-05-25 03:48:19,404 - DEBUG - Response for deleting network ()
2026-05-25 03:48:20,251 - INFO - Deleted project: ctest-TestSubInterfaces-51424852, ID : 919fe2cb-f026-4a7d-a400-6f4d798a2aeb