is in ACTIVE state now
2026-06-01 03:34:49,539 - INFO - VM name : ctest-TestSubInterfaces-82146987-78012812
2026-06-01 03:34:49,651 - DEBUG - VM ctest-TestSubInterfaces-82146987-78012812 ID is 6a2ca147-2d44-4fd2-975b-dcb274dbc184
2026-06-01 03:34:49,651 - DEBUG - VM ctest-TestSubInterfaces-82146987-78012812 launched on Node an-jenkins-deploy-platform-ansible-os-5860-2
2026-06-01 03:34:49,802 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/6a2ca147-2d44-4fd2-975b-dcb274dbc184
2026-06-01 03:34:49,813 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/cdda236c-a85a-4628-b933-9279c44c8831
2026-06-01 03:34:50,984 - 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=7.84 ms\r\n64 bytes from 169.254.0.7: icmp_seq=2 ttl=63 time=1.93 ms\r\n\r\n--- 169.254.0.7 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 1.931/4.886/7.841/2.955 ms')
2026-06-01 03:34:50,984 - INFO - Ping to Metadata IP 169.254.0.7 of VM ctest-TestSubInterfaces-82146987-78012812 passed
2026-06-01 03:34:51,057 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-01 03:34:51,057 - DEBUG - Waiting to SSH to VM ctest-TestSubInterfaces-82146987-78012812, IP 33.238.35.69, Port 22
2026-06-01 03:34:51,125 - 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-06-01 03:34:51,205 - DEBUG - VM ctest-TestSubInterfaces-82146987-78012812 is NOT ready for SSH connections, VM status: ACTIVE
2026-06-01 03:34:56,206 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-01 03:34:56,206 - DEBUG - Waiting to SSH to VM ctest-TestSubInterfaces-82146987-78012812, IP 33.238.35.69, Port 22
2026-06-01 03:34:56,381 - DEBUG - VM ctest-TestSubInterfaces-82146987-78012812 is ready for SSH connections
2026-06-01 03:34:56,382 - DEBUG - Running remote_cmd, Cmd : ifconfig -a| grep 143.175.170.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.73, gateway password: c0ntrail123
2026-06-01 03:34:56,382 - DEBUG - ifconfig -a| grep 143.175.170.195 -A2 -B4| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1
2026-06-01 03:35:12,115 - DEBUG - None
2026-06-01 03:35:17,116 - DEBUG - Running remote_cmd, Cmd : ifconfig -a| grep 143.175.170.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.73, gateway password: c0ntrail123
2026-06-01 03:35:17,116 - DEBUG - ifconfig -a| grep 143.175.170.195 -A2 -B4| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1
2026-06-01 03:35:18,738 - DEBUG - None
2026-06-01 03:35:23,739 - DEBUG - Running remote_cmd, Cmd : ifconfig -a| grep 143.175.170.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.73, gateway password: c0ntrail123
2026-06-01 03:35:23,739 - DEBUG - ifconfig -a| grep 143.175.170.195 -A2 -B4| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1
2026-06-01 03:35:25,939 - DEBUG - eth0.100
2026-06-01 03:35:25,939 - INFO - Interface eth0.100 is found on VM df3fb9da-b230-41a8-b1e0-994a4e30ef27
2026-06-01 03:35:25,939 - DEBUG - Running remote_cmd, Cmd : ifconfig -a| grep 46.121.160.67 -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.73, gateway password: c0ntrail123
2026-06-01 03:35:25,939 - DEBUG - ifconfig -a| grep 46.121.160.67 -A2 -B4| grep -i 'hwaddr\|flags' | awk '{print $1}' | cut -d ':' -f 1
2026-06-01 03:36:11,219 - DEBUG - eth0.100
2026-06-01 03:36:11,219 - INFO - Interface eth0.100 is found on VM 6a2ca147-2d44-4fd2-975b-dcb274dbc184
2026-06-01 03:36:11,219 - DEBUG - Running remote_cmd, Cmd : route add -net 46.121.160.64/26 dev eth0.100, host_string: ubuntu@169.254.0.5, password: ubuntugateway: ubuntu@10.0.0.73, gateway password: c0ntrail123
2026-06-01 03:36:11,219 - DEBUG - route add -net 46.121.160.64/26 dev eth0.100
2026-06-01 03:36:11,771 - DEBUG - None
2026-06-01 03:36:11,771 - DEBUG - Running remote_cmd, Cmd : route add -net 143.175.170.192/26 dev eth0.100, host_string: ubuntu@169.254.0.7, password: ubuntugateway: ubuntu@10.0.0.73, gateway password: c0ntrail123
2026-06-01 03:36:11,771 - DEBUG - route add -net 143.175.170.192/26 dev eth0.100
2026-06-01 03:36:12,380 - DEBUG - None
2026-06-01 03:36:12,380 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-01 03:36:12,380 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 46.121.160.68, host_string: ubuntu@169.254.0.5, password: ubuntugateway: ubuntu@10.0.0.73, gateway password: c0ntrail123
2026-06-01 03:36:12,380 - DEBUG - ping -s 56 -c 3 -W 1 46.121.160.68
2026-06-01 03:36:14,913 - DEBUG - PING 46.121.160.68 (46.121.160.68) 56(84) bytes of data.
64 bytes from 46.121.160.68: icmp_req=1 ttl=63 time=13.4 ms
64 bytes from 46.121.160.68: icmp_req=2 ttl=63 time=1.24 ms
64 bytes from 46.121.160.68: icmp_req=3 ttl=63 time=1.06 ms
--- 46.121.160.68 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2005ms
rtt min/avg/max/mdev = 1.066/5.246/13.431/5.788 ms
2026-06-01 03:36:14,913 - INFO - Ping to IP 46.121.160.68 from VM ctest-TestSubInterfaces-82146987-53347583 passed
2026-06-01 03:36:14,913 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 46.121.160.67, host_string: ubuntu@169.254.0.5, password: ubuntugateway: ubuntu@10.0.0.73, gateway password: c0ntrail123
2026-06-01 03:36:14,914 - DEBUG - ping -s 56 -c 3 -W 1 46.121.160.67
2026-06-01 03:36:17,462 - DEBUG - PING 46.121.160.67 (46.121.160.67) 56(84) bytes of data.
64 bytes from 46.121.160.67: icmp_req=1 ttl=63 time=7.36 ms
64 bytes from 46.121.160.67: icmp_req=2 ttl=63 time=1.01 ms
64 bytes from 46.121.160.67: icmp_req=3 ttl=63 time=0.899 ms
--- 46.121.160.67 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2003ms
rtt min/avg/max/mdev = 0.899/3.092/7.366/3.022 ms
2026-06-01 03:36:17,462 - INFO - Ping to IP 46.121.160.67 from VM ctest-TestSubInterfaces-82146987-53347583 passed
2026-06-01 03:36:17,462 - INFO - Deleting interface with subnet_id 4e3fcb30-0ece-4c76-bfaa-88bb7541718e, port_id None from router 85b9d813-20b4-4c65-8473-f85866c9352e
2026-06-01 03:36:17,719 - INFO - Deleting interface with subnet_id aafbfdbf-f269-431e-91b3-9b61b380049b, port_id None from router 85b9d813-20b4-4c65-8473-f85866c9352e
2026-06-01 03:36:18,095 - INFO - Detaching port cdda236c-a85a-4628-b933-9279c44c8831 from VM ctest-TestSubInterfaces-82146987-78012812
2026-06-01 03:36:18,133 - INFO - Deleting VM ctest-TestSubInterfaces-82146987-78012812
2026-06-01 03:36:18,239 - INFO - Deleting VM ctest-TestSubInterfaces-82146987-78283625
2026-06-01 03:36:18,304 - INFO - Detaching port 53efdf9b-12f6-4661-b6d0-13f594790b8b from VM ctest-TestSubInterfaces-82146987-53347583
2026-06-01 03:36:18,335 - INFO - Deleting VM ctest-TestSubInterfaces-82146987-53347583
2026-06-01 03:36:19,714 - DEBUG - No XMPP flaps were noticed during the test
2026-06-01 03:36:19,715 - INFO - END TEST : test_vlan_interface_2 : PASSED[0:02:42]
2026-06-01 03:36:19,715 - INFO - --------------------------------------------------------------------------------
2026-06-01 03:36:19,857 - INFO - Deleted port fa8da74a-a02e-41a4-82dc-8908e8482057
2026-06-01 03:36:20,032 - DEBUG - Response for delete_port : ()
2026-06-01 03:36:20,032 - INFO - Deleted port cdda236c-a85a-4628-b933-9279c44c8831
2026-06-01 03:36:20,167 - INFO - Deleted port 6949e18c-3487-4073-ae2b-67321fc88b8f
2026-06-01 03:36:20,344 - DEBUG - Response for delete_port : ()
2026-06-01 03:36:20,344 - INFO - Deleted port 7f2d78ba-4d00-46c9-bbe9-62b831104b23
2026-06-01 03:36:20,490 - INFO - Deleted port 0149a2d8-7a52-4540-9669-60ff21d15460
2026-06-01 03:36:20,700 - DEBUG - Response for delete_port : ()
2026-06-01 03:36:20,700 - INFO - Deleted port 53efdf9b-12f6-4661-b6d0-13f594790b8b
2026-06-01 03:36:20,700 - INFO - Deleting VN ctest-vn-10366633
2026-06-01 03:36:20,872 - DEBUG - Response for deleting network ()
2026-06-01 03:36:20,872 - INFO - Deleting VN ctest-vn-35098063
2026-06-01 03:36:21,062 - DEBUG - Response for deleting network ()
2026-06-01 03:36:21,063 - INFO - Deleting VN ctest-vn-28496769
2026-06-01 03:36:21,305 - DEBUG - Response for deleting network ()
2026-06-01 03:36:22,038 - INFO - Deleted project: ctest-TestSubInterfaces-82146987, ID : 80ffae79-a1aa-47df-b2ac-4b692645fa60