is in ACTIVE state now
2025-08-06 10:07:43,631 - INFO - VM name : ctest-TestPbbEvpnMacLearning-51609701-29369902
2025-08-06 10:07:43,725 - DEBUG - VM ctest-TestPbbEvpnMacLearning-51609701-29369902 ID is fcd7f404-4e74-4069-b6d8-750ef45c4cc4
2025-08-06 10:07:43,725 - DEBUG - VM ctest-TestPbbEvpnMacLearning-51609701-29369902 launched on Node an-jenkins-deploy-platform-ansible-os-3761-2
2025-08-06 10:07:43,827 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/fcd7f404-4e74-4069-b6d8-750ef45c4cc4
2025-08-06 10:07:43,841 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/4ab91d33-a678-4b55-971a-5c7110e79648
2025-08-06 10:07:45,036 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=6.01 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=4.52 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 = 4.517/5.261/6.006/0.744 ms')
2025-08-06 10:07:45,036 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestPbbEvpnMacLearning-51609701-29369902 passed
2025-08-06 10:07:45,113 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:07:45,113 - DEBUG - Waiting to SSH to VM ctest-TestPbbEvpnMacLearning-51609701-29369902, IP 10.10.10.4, Port 22
2025-08-06 10:07:45,181 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-08-06 10:07:45,307 - DEBUG - VM ctest-TestPbbEvpnMacLearning-51609701-29369902 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-06 10:07:50,308 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:07:50,308 - DEBUG - Waiting to SSH to VM ctest-TestPbbEvpnMacLearning-51609701-29369902, IP 10.10.10.4, Port 22
2025-08-06 10:07:50,379 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-08-06 10:07:50,496 - DEBUG - VM ctest-TestPbbEvpnMacLearning-51609701-29369902 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-06 10:07:55,497 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:07:55,497 - DEBUG - Waiting to SSH to VM ctest-TestPbbEvpnMacLearning-51609701-29369902, IP 10.10.10.4, Port 22
2025-08-06 10:07:55,673 - DEBUG - VM ctest-TestPbbEvpnMacLearning-51609701-29369902 is ready for SSH connections
2025-08-06 10:07:55,673 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:07:55,673 - DEBUG - Running remote_cmd, Cmd : echo "10.10.10.3 ctest-TestPbbEvpnMacLearning-51609701-22749427" >> /etc/hosts, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123
2025-08-06 10:07:55,673 - DEBUG - echo "10.10.10.3 ctest-TestPbbEvpnMacLearning-51609701-22749427" >> /etc/hosts
2025-08-06 10:08:33,283 - DEBUG - None
2025-08-06 10:08:33,284 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:08:33,284 - DEBUG - Running remote_cmd, Cmd : echo "10.10.10.4 ctest-TestPbbEvpnMacLearning-51609701-29369902" >> /etc/hosts, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.57, gateway password: c0ntrail123
2025-08-06 10:08:33,284 - DEBUG - echo "10.10.10.4 ctest-TestPbbEvpnMacLearning-51609701-29369902" >> /etc/hosts
2025-08-06 10:09:15,078 - DEBUG - None
2025-08-06 10:09:15,078 - DEBUG - Updating PBB EVPN on VN default-domain:ctest-TestPbbEvpnMacLearning-51609701:vn1 to True
2025-08-06 10:09:15,202 - DEBUG - Requesting: http://10.0.0.48:8082/virtual-network/e36e6f9a-c775-47a6-a330-8d96a4a9d822
2025-08-06 10:09:15,225 - DEBUG - Updating PBB etree on VN default-domain:ctest-TestPbbEvpnMacLearning-51609701:vn1 to False
2025-08-06 10:09:15,354 - DEBUG - Requesting: http://10.0.0.48:8082/virtual-network/e36e6f9a-c775-47a6-a330-8d96a4a9d822
2025-08-06 10:09:15,478 - INFO - Setting flood_unknown_unicast flag of VN vn1 to True
2025-08-06 10:09:15,479 - DEBUG - Updating MAC Learning on VN default-domain:ctest-TestPbbEvpnMacLearning-51609701:vn1 to True
2025-08-06 10:09:15,586 - DEBUG - Requesting: http://10.0.0.48:8082/virtual-network/e36e6f9a-c775-47a6-a330-8d96a4a9d822
2025-08-06 10:09:15,603 - DEBUG - Updating MAC Limit control on VN default-domain:ctest-TestPbbEvpnMacLearning-51609701:vn1 to mac_limit = 1024, mac_limit_action = log
2025-08-06 10:09:15,722 - DEBUG - Requesting: http://10.0.0.48:8082/virtual-network/e36e6f9a-c775-47a6-a330-8d96a4a9d822
2025-08-06 10:09:15,738 - DEBUG - Updating MAC Move on VN default-domain:ctest-TestPbbEvpnMacLearning-51609701:vn1 to mac_move_limit = 1024, mac_move_time_window = 30, mac_move_limit_action = log
2025-08-06 10:09:15,862 - DEBUG - Requesting: http://10.0.0.48:8082/virtual-network/e36e6f9a-c775-47a6-a330-8d96a4a9d822
2025-08-06 10:09:15,878 - DEBUG - Updating MAC Aging on VN default-domain:ctest-TestPbbEvpnMacLearning-51609701:vn1 to 300
2025-08-06 10:09:16,010 - DEBUG - Requesting: http://10.0.0.48:8082/virtual-network/e36e6f9a-c775-47a6-a330-8d96a4a9d822
2025-08-06 10:09:16,033 - INFO - Adding Bridge Domain 4637319a-820f-4fc0-ab2a-79a2226e02ff to VMI 826dc782-3d5b-4fb6-9968-fc67501b1b6f
2025-08-06 10:09:16,181 - INFO - Verification for Bridge Domain uuid 4637319a-820f-4fc0-ab2a-79a2226e02ff for VMI 826dc782-3d5b-4fb6-9968-fc67501b1b6f passed in agent 10.0.0.49
2025-08-06 10:09:16,224 - INFO - Verifications in Agent 10.0.0.49 for BD ctest-bd_ctest-TestPbbEvpnMacLearning-51609701-09214279 for VN info passed
2025-08-06 10:09:16,224 - INFO - Adding Bridge Domain 4637319a-820f-4fc0-ab2a-79a2226e02ff to VMI 4ab91d33-a678-4b55-971a-5c7110e79648
2025-08-06 10:09:16,393 - INFO - Verification for Bridge Domain uuid 4637319a-820f-4fc0-ab2a-79a2226e02ff for VMI 4ab91d33-a678-4b55-971a-5c7110e79648 passed in agent 10.0.0.57
2025-08-06 10:09:16,431 - INFO - Verifications in Agent 10.0.0.57 for BD ctest-bd_ctest-TestPbbEvpnMacLearning-51609701-09214279 for VN info passed
2025-08-06 10:11:16,432 - DEBUG - Running remote_cmd, Cmd : test -f /etc/redhat-release && ifconfig | grep -i -B 2 "02:82:6d:c7:82:3d" | grep flags | awk '{print \\$1}' || ifconfig | grep "02:82:6d:c7:82:3d" | awk '{print $1}' | head -1, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123
2025-08-06 10:11:16,432 - DEBUG - test -f /etc/redhat-release && ifconfig | grep -i -B 2 "02:82:6d:c7:82:3d" | grep flags | awk '{print \\$1}' || ifconfig | grep "02:82:6d:c7:82:3d" | awk '{print $1}' | head -1
2025-08-06 10:11:16,874 - DEBUG - eth0
2025-08-06 10:11:17,049 - DEBUG - file transfer done ['/tmp/program.py']
2025-08-06 10:11:17,049 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-06 10:11:17,050 - DEBUG - Copied file /tmp/tmpaq3v8dma/program.py to 10.10.10.3
2025-08-06 10:11:17,050 - DEBUG - Running remote_cmd, Cmd : python /tmp/program.py 1>/tmp/scapy_ctest-random-66060572.pid_stdout.log 2>/tmp/scapy_ctest-random-66060572.pid_stderr.log, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.49, gateway password: c0ntrail123
2025-08-06 10:11:17,050 - DEBUG - nohup python /tmp/program.py 1>/tmp/scapy_ctest-random-66060572.pid_stdout.log 2>/tmp/scapy_ctest-random-66060572.pid_stderr.log & echo $! > /tmp/scapy_ctest-random-66060572.pid
2025-08-06 10:11:17,479 - DEBUG - None
2025-08-06 10:11:22,529 - DEBUG - L2 routes found in agent is: {'mac': '00:16:3e:28:63:18', 'routes': [{'mac': '00:16:3e:28:63:18', 'src_vrf': 'default-domain:ctest-TestPbbEvpnMacLearning-51609701:vn1:vn1:4637319a-820f-4fc0-ab2a-79a2226e02ff', 'path_list': [{'nh': {'type': 'interface', 'ref_count': '13', 'valid': 'true', 'policy': 'enabled', 'itf': 'tap826dc782-3d', 'mac': ['2:82:6d:c7:82:3d'], 'mcast': 'disabled', 'nh_index': '35', 'vxlan_flag': 'false', 'intf_flags': '2', 'isid': '0', 'learning_enabled': 'true', 'etree_leaf': 'false', 'layer2_control_word': 'true', 'crypt_all_traffic': 'false', 'crypt_path_available': 'false', 'crypt_interface': None}, 'label': '31', 'vxlan_id': '8', 'peer': 'EVPN', 'dest_vn_list': ['default-domain:ctest-TestPbbEvpnMacLearning-51609701:vn1'], 'unresolved': 'false', 'sg_list': ['8000005'], 'supported_tunnel_type': 'MPLSoGRE MPLSoUDP VxLAN', 'active_tunnel_type': 'MPLSoUDP', 'stale': 'false', 'path_preference_data': {'sequence': '0', 'preference': '100', 'ecmp': 'false', 'wait_for_traffic': 'true'}, 'info': '0-00:16:3e:28:63:18-0.0.0.0/32 DynamicMacLearningPeer', 'active_label': '31', 'ecmp_hashing_fields': 'l3-source-address,l3-destination-address,l4-protocol,l4-source-port,l4-destination-port,', 'communities': None, 'peer_sequence_number': '0', 'etree_leaf': 'false', 'layer2_control_word': 'true', 'tag_list': None, 'inactive': 'false', 'origin_vn': None}]}]}
2025-08-06 10:11:22,538 - INFO - Detaching port 4ab91d33-a678-4b55-971a-5c7110e79648 from VM ctest-TestPbbEvpnMacLearning-51609701-29369902
2025-08-06 10:11:22,579 - INFO - Deleting VM ctest-TestPbbEvpnMacLearning-51609701-29369902
2025-08-06 10:11:22,666 - INFO - Detaching port 826dc782-3d5b-4fb6-9968-fc67501b1b6f from VM ctest-TestPbbEvpnMacLearning-51609701-22749427
2025-08-06 10:11:22,716 - INFO - Deleting VM ctest-TestPbbEvpnMacLearning-51609701-22749427
2025-08-06 10:11:23,127 - DEBUG - Response for delete_port : ()
2025-08-06 10:11:23,127 - INFO - Deleted port 4ab91d33-a678-4b55-971a-5c7110e79648
2025-08-06 10:11:23,395 - DEBUG - Response for delete_port : ()
2025-08-06 10:11:23,395 - INFO - Deleted port 826dc782-3d5b-4fb6-9968-fc67501b1b6f
2025-08-06 10:11:23,428 - INFO - Deleted Bridge Domain 4637319a-820f-4fc0-ab2a-79a2226e02ff
2025-08-06 10:11:23,438 - INFO - Bridge Domain ctest-bd_ctest-TestPbbEvpnMacLearning-51609701-09214279 is removed from Agent 10.0.0.49
2025-08-06 10:11:23,449 - INFO - Bridge Domain ctest-bd_ctest-TestPbbEvpnMacLearning-51609701-09214279 is removed from Agent 10.0.0.57
2025-08-06 10:11:23,449 - DEBUG - Deleting RT for VN vn1
2025-08-06 10:11:23,618 - INFO - Deleting VN vn1
2025-08-06 10:11:23,957 - DEBUG - Response for deleting network ()
2025-08-06 10:11:25,269 - ERROR - 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/pbb_evpn/test_pbb_evpn.py", line 83, in test_mac_learning_single_isid
cmac=stream['src_cmac'])
File "/contrail-test/common/pbb_evpn/base.py", line 634, in verify_mac_learning
vmi_fixture.mac_address, nh_type, mpls_label, isid)
File "/contrail-test/common/pbb_evpn/base.py", line 729, in validate_pbb_l2_route
'mac']) != EUI(bmac)):
File "/usr/local/lib/python3.6/site-packages/netaddr/eui/__init__.py", line 387, in __init__
self.value = addr
File "/usr/local/lib/python3.6/site-packages/netaddr/eui/__init__.py", line 423, in _set_value
self._value = module.str_to_int(value)
File "/usr/local/lib/python3.6/site-packages/netaddr/strategy/eui48.py", line 178, in str_to_int
raise TypeError('%r is not str() or unicode()!' % addr)
TypeError: ['2:82:6d:c7:82:3d'] is not str() or unicode()!
2025-08-06 10:11:25,270 - DEBUG - Skipping xmpp flap check
2025-08-06 10:11:25,270 - INFO -
2025-08-06 10:11:25,270 - INFO - END TEST : test_mac_learning_single_isid : FAILED[0:04:45]
2025-08-06 10:11:25,270 - INFO - --------------------------------------------------------------------------------
2025-08-06 10:11:26,168 - INFO - Deleted project: ctest-TestPbbEvpnMacLearning-51609701, ID : a075b458-d8f1-4107-8e34-5e37362c156e