【QCM2150】WCN3680 WFA认证11ac AP 4.2.23测试FAIL

本文链接：https://blog.youkuaiyun.com/hanmengaidudu/article/details/127785553
【问题描述】：
ucc测试流程step7 fail。具体ucc log如下：
2022-10-27 14:23:32.190 - INFO - ###########################################################

2022-10-27 14:23:32.207 - INFO - WiFiTestSuite Version [10.10.1]
2022-10-27 14:23:32.207 - INFO - Logging started in file - ./log/N-4.2.23_Oct-27-2022__14-23-32/log_N-4.2.23.log
2022-10-27 14:23:32.207 - INFO - --------------------------------------------------------------------------------
2022-10-27 14:23:32.221 - INFO - Test Info
2022-10-27 14:23:32.221 - INFO - --------------------------------------------------------------------------------
2022-10-27 14:23:32.221 - INFO - Test Prog Name    : N
2022-10-27 14:23:32.221 - INFO - Test ID           : N-4.2.23
2022-10-27 14:23:32.221 - INFO - Test Usermode     : precert 
2022-10-27 14:23:32.237 - INFO - Test CmdPath      : ..\cmds\WTS-11n
2022-10-27 14:23:32.237 - INFO - Test InitFile     : AllInitConfig_N.txt
2022-10-27 14:23:32.237 - INFO - Test TB File      : \802.11n-Testbed-APs.txt
2022-10-27 14:23:32.237 - INFO - Test Start Time   : 2022-10-27 14:23:32
2022-10-27 14:23:32.253 - INFO - --------------------------------------------------------------------------------
2022-10-27 14:23:32.253 - INFO - Processing DUTInfo.txt file....
2022-10-27 14:23:32.253 - INFO - ---------------------------------------

2022-10-27 14:23:32.269 - INFO - Processing MasterTestInfo.xml file....
2022-10-27 14:23:32.269 - INFO - ---------------------------------------

2022-10-27 14:23:32.394 - INFO - Testplan version=WTS-11n-Testplan-v2.17
2022-10-27 14:23:32.408 - INFO - 
         Testcase Init File = AllInitConfig_N.txt 

2022-10-27 14:23:32.408 - INFO - Processing AllInitConfig_N.txt file....
2022-10-27 14:23:32.408 - INFO - ---------------------------------------

2022-10-27 14:23:32.456 - INFO - stream1 1415 Frames / second
2022-10-27 14:23:32.456 - INFO - stream2 1262 Frames / second
2022-10-27 14:23:32.456 - INFO - stream3 1262 Frames / second
2022-10-27 14:23:32.471 - INFO - stream_trans 191 Frames / second
2022-10-27 14:23:32.471 - INFO - Processing AllInitCommand_N.txt file....
2022-10-27 14:23:32.471 - INFO - ---------------------------------------

2022-10-27 14:23:32.503 - INFO - 
         Testcase Command File = N-4.2.23.txt 

2022-10-27 14:23:32.503 - INFO - START: TEST CASE [N-4.2.23.txt] 
2022-10-27 14:23:32.503 - INFO - Processing N-4.2.23.txt file....
2022-10-27 14:23:32.503 - INFO - ---------------------------------------

2022-10-27 14:23:34.671 - INFO - 
===============Testbed device check==============================
2022-10-27 14:23:34.671 - INFO - Device [HostAPD <RADIUSSERVER>] control network IP and Port not found, skipping...
2022-10-27 14:23:34.671 - INFO - Device [Microsoft <RADIUSSERVER>] control network IP and Port not found, skipping...
2022-10-27 14:23:34.671 - INFO - Device [Radiator <RADIUSSERVER>] control network IP and Port not found, skipping...
2022-10-27 14:23:34.687 - INFO - Device [Realtek11n <STA>] control network IP and Port not found, skipping...
2022-10-27 14:23:34.687 - INFO - Device [MarvellVHT <STA>] control network IP and Port not found, skipping...
2022-10-27 14:23:34.687 - INFO - Device [PowerSwitch <POWERSWITCH>] control network IP and Port not found, skipping...
2022-10-27 14:23:34.983 - INFO - 
        ~~~~~ Pre-configuration for the test ~~~~~

2022-10-27 14:23:34.999 - INFO - echo ~~~~ $DutMacAddress = 24:d9:51:fd:e1:26 ~~~~
2022-10-27 14:23:34.999 - INFO - 
        ~~~~~ [Inside of 11n-testbed-reset.txt ] ~~~~~

2022-10-27 14:23:34.999 - INFO - 
        ~~~~~ [ Resetting testbed STA] ~~~~~

2022-10-27 14:23:34.999 - INFO - 
        ~~~~~ [ Resetting 11n STA 1 Realtek 11n] ~~~~~

2022-10-27 14:23:35.015 - INFO - 
        ~~~~~ [ Resetting 11n STA 2 Broadcomvht as 11n] ~~~~~

2022-10-27 14:23:35.015 - INFO - broadcomvht (192.168.250.42:9000) ---> device_list_interfaces,interfaceType,802.11
2022-10-27 14:23:35.233 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,interfaceType,802.11,interfaceId,eth0


2022-10-27 14:23:35.233 - INFO - broadcomvht (192.168.250.42:9000) ---> sta_set_11n,interface,eth0,reset_default,11n
2022-10-27 14:23:39.663 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:23:39.663 - INFO - 
        ~~~~~ [ Resetting 11n STA 3 Intel11n] ~~~~~

2022-10-27 14:23:39.678 - INFO - intel11n (192.168.250.79:9000) ---> device_list_interfaces,interfaceType,802.11
2022-10-27 14:23:39.881 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE,interfaceType,802.11,interfaceID,6300


2022-10-27 14:23:39.897 - INFO - intel11n (192.168.250.79:9000) ---> sta_set_11n,interface,6300,reset_default,11n
2022-10-27 14:23:39.928 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE


2022-10-27 14:23:39.928 - INFO - 
        ~~~~~ [ Resetting 11n STA 4  Marvellvht as 11n] ~~~~~

2022-10-27 14:23:39.990 - INFO - AP_CONFIG_AGENT (192.165.112.233:7000) ---> AccessPoint,APUT,IPAddress,192.165.112.200,UserName,root,Password,5up,HostName,~,PowerSwitchPort,4
2022-10-27 14:23:40.085 - INFO - AP_CONFIG_AGENT (192.165.112.233:7000) <-- status,COMPLETE,Access Point Added


2022-10-27 14:23:40.099 - INFO - AP_CONFIG_AGENT (192.165.112.233:7000) ---> AccessPoint,Atheros11nAP,IPAddress,192.165.112.123,UserName,-,Password,-,HostName,-,PowerSwitchPort,8
2022-10-27 14:23:40.147 - INFO - AP_CONFIG_AGENT (192.165.112.233:7000) <-- status,COMPLETE,Access Point Added


2022-10-27 14:23:40.163 - INFO - AP_CONFIG_AGENT (192.165.112.233:7000) ---> AccessPoint,Marvell11nAP,IPAddress,192.165.112.3,UserName,telnet,Password,default,HostName,~,PowerSwitchPort,5
2022-10-27 14:23:40.224 - INFO - AP_CONFIG_AGENT (192.165.112.233:7000) <-- status,COMPLETE,Access Point Added


2022-10-27 14:23:40.224 - INFO - AP_CONFIG_AGENT (192.165.112.233:7000) ---> AccessPoint,RalinkAP,IPAddress,192.165.112.4,UserName,,Password,,HostName,,PowerSwitchPort,1
2022-10-27 14:23:40.286 - INFO - AP_CONFIG_AGENT (192.165.112.233:7000) <-- status,COMPLETE,Access Point Added


2022-10-27 14:23:40.302 - INFO - AP_CONFIG_AGENT (192.165.112.233:7000) ---> AccessPoint,Broadcom11nAP,SerialPortIP,192.165.112.7 2001,IPAddress,192.165.112.2,UserName,,Password,admin,HostName,#,PowerSwitchPort,3
2022-10-27 14:23:40.365 - INFO - AP_CONFIG_AGENT (192.165.112.233:7000) <-- status,COMPLETE,Access Point Added


2022-10-27 14:23:40.365 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_start,filename,SnifferTrace_N-4.2.23,channel,6
2022-10-27 14:23:45.607 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE


2022-10-27 14:23:45.607 - INFO - 
        ~~~~~ [Configuring APUT] ~~~~~

2022-10-27 14:23:45.622 - INFO - DUT (192.168.250.200:9000) ---> ap_set_wireless,NAME,APUT,CHANNEL,6,SSID,test0101,MODE,11ng,RTS,2347,FRGMNT,2346,BCNINT,100
2022-10-27 14:23:45.996 - INFO - DUT (192.168.250.200:9000) <-- status,COMPLETE


2022-10-27 14:23:45.996 - INFO - DUT (192.168.250.200:9000) ---> ap_set_security,NAME,APUT,KEYMGNT,WPA2-PSK,PSK,12345678
2022-10-27 14:23:46.028 - INFO - DUT (192.168.250.200:9000) <-- status,COMPLETE

2022-10-27 14:23:46.028 - INFO - DUT (192.168.250.200:9000) ---> ap_config_commit,NAME,APUT
2022-10-27 14:23:47.822 - INFO - DUT (192.168.250.200:9000) <-- status,COMPLETE


2022-10-27 14:23:47.838 - INFO - 
        ~~~~~ [ Configuring Testbed STA(s) ] ~~~~~

2022-10-27 14:23:47.852 - INFO - 
        ~~~~~ [ Configuring STA3 ] ~~~~~

2022-10-27 14:23:47.868 - INFO - broadcomvht (192.168.250.42:9000) ---> ca_get_version
2022-10-27 14:23:48.086 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,version,1.139


2022-10-27 14:23:48.086 - INFO - broadcomvht (192.168.250.42:9000) ---> device_get_info
2022-10-27 14:23:48.305 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,vendor,Broadcom,model,4360MCB,version,6.30.190.17


2022-10-27 14:23:48.680 - INFO - broadcomvht (192.168.250.42:9000) ---> device_list_interfaces,interfaceType,802.11
2022-10-27 14:23:48.914 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,interfaceType,802.11,interfaceId,eth0


2022-10-27 14:23:48.914 - INFO - broadcomvht (192.168.250.42:9000) ---> sta_preset_testparameters,interface,eth0,supplicant,ZeroConfig,mode,11g,RTS,2347,FRGMNT,2346,preamble,long,powersave,off,wmm,on,HT,off
2022-10-27 14:23:55.372 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:23:55.388 - INFO - broadcomvht (192.168.250.42:9000) ---> sta_get_info,interface,eth0
2022-10-27 14:23:55.591 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,vendorInfo_1,Broadcom,vendorInfo_2,4360


2022-10-27 14:23:55.591 - INFO - broadcomvht (192.168.250.42:9000) ---> sta_set_psk,interface,eth0,ssid,test0101,passphrase,12345678,encpType,aes-ccmp,keymgmttype,wpa2
2022-10-27 14:23:58.632 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:23:58.632 - INFO - broadcomvht (192.168.250.42:9000) ---> sta_set_ip_config,interface,eth0,dhcp,0,ip,192.165.112.42,mask,255.255.0.0
2022-10-27 14:23:58.867 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:23:58.867 - INFO - broadcomvht (192.168.250.42:9000) ---> sta_associate,interface,eth0,ssid,test0101
2022-10-27 14:24:02.891 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:24:12.923 - INFO - broadcomvht (192.168.250.42:9000) ---> sta_is_connected,interface,eth0
2022-10-27 14:24:13.141 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,connected,1


2022-10-27 14:24:13.141 - INFO - broadcomvht (192.168.250.42:9000) ---> sta_get_bssid,interface,eth0
2022-10-27 14:24:13.358 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,bssid,24:D9:51:FD:E1:26


2022-10-27 14:24:13.358 - INFO - broadcomvht (192.168.250.42:9000) ---> sta_get_ip_config,interface,eth0
2022-10-27 14:24:13.578 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,dhcp,0,ip,192.165.112.42,netmask,255.255.0.0,dns,0.0.0.0


2022-10-27 14:24:13.578 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_reset
2022-10-27 14:24:14.592 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:24:14.592 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_send_ping,destination,192.165.112.200,framesize,1000,frameRate,2,duration,5
2022-10-27 14:24:15.621 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,streamID,76


2022-10-27 14:24:15.637 - INFO - Sleep... 5 seconds
2022-10-27 14:24:20.644 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_stop_ping,streamID,76
2022-10-27 14:24:23.796 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,sent,10,replies,10,consectimeout,0


2022-10-27 14:24:23.826 - INFO - 
        ~~~~~ [ Configuring STA3 ] ~~~~~

2022-10-27 14:24:23.842 - INFO - intel11n (192.168.250.79:9000) ---> ca_get_version
2022-10-27 14:24:23.858 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE,version,WIN7_WIN8_DUT-v9.0.0


2022-10-27 14:24:23.874 - INFO - intel11n (192.168.250.79:9000) ---> device_get_info
2022-10-27 14:24:24.138 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE,vendor,Intel,model,6300-1 ,version, 13.5.0.6 



2022-10-27 14:24:24.545 - INFO - intel11n (192.168.250.79:9000) ---> device_list_interfaces,interfaceType,802.11
2022-10-27 14:24:24.747 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE,interfaceType,802.11,interfaceID,6300


2022-10-27 14:24:24.763 - INFO - intel11n (192.168.250.79:9000) ---> sta_preset_testparameters,interface,6300,supplicant,ZeroConfig,mode,11g,RTS,2347,FRGMNT,2346,preamble,long,powersave,off,wmm,off,HT,off
2022-10-27 14:24:31.517 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE


2022-10-27 14:24:31.533 - INFO - intel11n (192.168.250.79:9000) ---> sta_get_info,interface,6300
2022-10-27 14:24:31.720 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE,interface,6300,vendor,XXX,cardtype,802.11


2022-10-27 14:24:31.720 - INFO - intel11n (192.168.250.79:9000) ---> sta_set_psk,interface,6300,ssid,test0101,passphrase,12345678,encpType,aes-ccmp,keymgmttype,wpa2
2022-10-27 14:24:32.157 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE


2022-10-27 14:24:32.173 - INFO - intel11n (192.168.250.79:9000) ---> sta_set_ip_config,interface,6300,dhcp,0,ip,192.165.112.79,mask,255.255.0.0
2022-10-27 14:24:34.559 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE


2022-10-27 14:24:34.559 - INFO - intel11n (192.168.250.79:9000) ---> sta_associate,interface,6300,ssid,test0101
2022-10-27 14:24:34.966 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE


2022-10-27 14:24:44.980 - INFO - intel11n (192.168.250.79:9000) ---> sta_is_connected,interface,6300
2022-10-27 14:24:45.292 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE,connected,1


2022-10-27 14:24:45.292 - INFO - intel11n (192.168.250.79:9000) ---> sta_get_bssid,interface,6300
2022-10-27 14:24:45.605 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE,bssid,24:d9:51:fd:e1:26


2022-10-27 14:24:45.605 - INFO - intel11n (192.168.250.79:9000) ---> sta_get_ip_config,interface,6300
2022-10-27 14:24:45.854 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE,dhcp,0,ip,192.165.112.79,mask,192.165.0.0/16,primary-dns,0


2022-10-27 14:24:45.854 - INFO - intel11n (192.168.250.79:9000) ---> traffic_agent_reset
2022-10-27 14:24:45.869 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE


2022-10-27 14:24:45.869 - INFO - intel11n (192.168.250.79:9000) ---> traffic_send_ping,destination,192.165.112.200,framesize,1000,frameRate,2,duration,5
2022-10-27 14:24:45.931 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE,streamID,140


2022-10-27 14:24:45.931 - INFO - Sleep... 5 seconds
2022-10-27 14:24:50.940 - INFO - intel11n (192.168.250.79:9000) ---> traffic_stop_ping,streamID,140
2022-10-27 14:24:51.095 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE,sent,10,replies,10


2022-10-27 14:24:51.111 - INFO - 
        ~~~~~ [ Running - STEP 2 and 3] ~~~~~

2022-10-27 14:24:55.151 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_stop
2022-10-27 14:24:55.369 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE


2022-10-27 14:24:55.369 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,framename,beacon,BK_CWmin,4
2022-10-27 14:25:20.424 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:20.424 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,framename,beacon,BK_CWmax,10
2022-10-27 14:25:20.641 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:20.641 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,framename,beacon,BK_AIFSN,7
2022-10-27 14:25:20.861 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:20.861 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,framename,beacon,BK_TXOP,0
2022-10-27 14:25:21.078 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:21.078 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,framename,beacon,BK_ACM,no
2022-10-27 14:25:21.312 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:21.312 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,framename,beacon,BE_CWmin,4
2022-10-27 14:25:21.532 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:21.532 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,framename,beacon,BE_CWmax,10
2022-10-27 14:25:21.750 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:21.750 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,framename,beacon,BE_AIFSN,3
2022-10-27 14:25:22.000 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:22.000 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,framename,beacon,BE_TXOP,0
2022-10-27 14:25:22.233 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:22.233 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,framename,beacon,BE_ACM,no
2022-10-27 14:25:22.451 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:22.451 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,framename,beacon,VI_CWmin,3
2022-10-27 14:25:22.670 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:22.670 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,framename,beacon,VI_CWmax,4
2022-10-27 14:25:22.888 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:22.888 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,framename,beacon,VI_AIFSN,2
2022-10-27 14:25:23.122 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:23.122 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,framename,beacon,VI_TXOP,94
2022-10-27 14:25:23.341 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:23.341 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,framename,beacon,VI_ACM,no
2022-10-27 14:25:23.559 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:23.559 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,framename,beacon,VO_CWmin,2
2022-10-27 14:25:23.793 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:23.793 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,framename,beacon,VO_CWmax,3
2022-10-27 14:25:24.012 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:24.012 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,framename,beacon,VO_AIFSN,2
2022-10-27 14:25:24.230 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:24.230 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,framename,beacon,VO_TXOP,47
2022-10-27 14:25:24.448 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:24.448 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,framename,beacon,VO_ACM,no
2022-10-27 14:25:24.683 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:24.683 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,00:10:18:f8:e3:2d,framename,probereq,wmmie,0
2022-10-27 14:25:24.931 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:24.947 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,3C:A9:F4:7F:B6:3C,framename,probereq,wmmie,0
2022-10-27 14:25:25.213 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:25.213 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,dstmac,00:10:18:f8:e3:2d,framename,proberesp,wmmie,1
2022-10-27 14:25:25.477 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:25.493 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,dstmac,3C:A9:F4:7F:B6:3C,framename,proberesp,wmmie,1
2022-10-27 14:25:25.759 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:25.759 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,00:10:18:f8:e3:2d,bssid,24:d9:51:fd:e1:26,framename,assoreq,wmmie,1
2022-10-27 14:25:26.009 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:26.023 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,3C:A9:F4:7F:B6:3C,bssid,24:d9:51:fd:e1:26,framename,assoreq,wmmie,0
2022-10-27 14:25:26.273 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:26.289 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,dstmac,00:10:18:f8:e3:2d,framename,assoresp,wmmie,1
2022-10-27 14:25:26.539 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:26.555 - INFO - SNIFFER (192.168.250.5:9999) ---> sniffer_control_field_check,filename,SnifferTrace_N-4.2.23,srcmac,24:d9:51:fd:e1:26,dstmac,3C:A9:F4:7F:B6:3C,framename,assoresp,wmmie,1
2022-10-27 14:25:26.819 - INFO - SNIFFER (192.168.250.5:9999) <-- status,COMPLETE,CheckResult,SUCCESS


2022-10-27 14:25:26.819 - INFO - 
        ~~~~~ [ Running - STEP 4] ~~~~~

2022-10-27 14:25:26.835 - INFO - 
        ~~~~~ [ Starting Traffic ] ~~~~~

2022-10-27 14:25:26.851 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_reset
2022-10-27 14:25:27.865 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:25:27.865 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_reset
2022-10-27 14:25:27.943 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE

2022-10-27 14:25:32.966 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_config,profile,IPTV,direction,send,destination,192.165.112.42,destinationPort,5600,sourcePort,5600,duration,10,payloadSize,1470,trafficClass,BestEffort,frameRate,1415
2022-10-27 14:25:33.232 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE,streamID,61


2022-10-27 14:25:33.232 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_config,profile,IPTV,direction,receive,source,192.165.112.200,sourcePort,5600,destinationPort,5600
2022-10-27 14:25:34.246 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,streamID,77


2022-10-27 14:25:34.246 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_config,profile,IPTV,direction,send,destination,192.165.112.42,destinationPort,5601,sourcePort,5601,duration,10,payloadSize,1470,trafficClass,Video,frameRate,1262
2022-10-27 14:25:34.276 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE,streamID,62

2022-10-27 14:25:34.276 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_config,profile,IPTV,direction,receive,source,192.165.112.200,sourcePort,5601,destinationPort,5601
2022-10-27 14:25:35.290 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,streamID,78


2022-10-27 14:25:35.305 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_receive_start,streamID,77
2022-10-27 14:25:36.305 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:25:36.319 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_receive_start,streamID,78
2022-10-27 14:25:37.319 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:25:38.348 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_send,streamID,61 62
2022-10-27 14:25:38.364 - INFO - DUT             <--1 status,RUNNING


2022-10-27 14:25:48.378 - INFO - DUT             <--1 status,COMPLETE,streamID,61 62,txFrames,10067 12620,rxFrames,0 0,txPayloadBytes,14798490 18551400,rxPayloadBytes,0 0,outOfSequenceFrames,0 0


2022-10-27 14:25:48.378 - INFO - DUT (192.168.250.200:9000) <--  SEND Stream - 61;192.168.250.200:9000 Completed 
2022-10-27 14:25:48.378 - INFO - DUT (192.168.250.200:9000) <--  SEND Stream - 62;192.168.250.200:9000 Completed 
2022-10-27 14:25:50.657 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_receive_stop,streamID,78 77
2022-10-27 14:25:50.657 - INFO - broadcomvht     <--1 status,RUNNING


2022-10-27 14:25:51.654 - INFO - broadcomvht     <--1 status,COMPLETE,streamID, 78 77,txFrames, 0 0,rxFrames, 12620 10065,txPayloadBytes, 0 0,rxPayloadBytes, 18551400 14795550,outOfSequenceFrames 0 0


2022-10-27 14:25:51.671 - INFO - broadcomvht (192.168.250.42:9000) <----  RECV Stream - 78;192.168.250.42:9000 Completed 
2022-10-27 14:25:51.671 - INFO - broadcomvht (192.168.250.42:9000) <----  RECV Stream - 77;192.168.250.42:9000 Completed 
2022-10-27 14:26:00.687 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_reset
2022-10-27 14:26:01.686 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:26:01.701 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_reset
2022-10-27 14:26:01.763 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE

2022-10-27 14:26:01.763 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_config,profile,IPTV,direction,send,destination,192.165.112.42,destinationPort,5600,sourcePort,5600,duration,10,payloadSize,1470,trafficClass,BestEffort,frameRate,1415
2022-10-27 14:26:01.795 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE,streamID,63

2022-10-27 14:26:01.795 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_config,profile,IPTV,direction,receive,source,192.165.112.200,sourcePort,5600,destinationPort,5600
2022-10-27 14:26:02.809 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,streamID,79


2022-10-27 14:26:02.809 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_config,profile,IPTV,direction,send,destination,192.165.112.42,destinationPort,5601,sourcePort,5601,duration,10,payloadSize,1470,trafficClass,Video,frameRate,1262
2022-10-27 14:26:02.839 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE,streamID,64

2022-10-27 14:26:02.839 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_config,profile,IPTV,direction,receive,source,192.165.112.200,sourcePort,5601,destinationPort,5601
2022-10-27 14:26:03.854 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,streamID,80


2022-10-27 14:26:03.869 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_config,profile,IPTV,direction,send,destination,192.165.112.79,destinationPort,5602,sourcePort,5602,duration,10,payloadSize,1470,trafficClass,BestEffort,frameRate,1262
2022-10-27 14:26:03.885 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE,streamID,65

2022-10-27 14:26:03.901 - INFO - intel11n (192.168.250.79:9000) ---> traffic_agent_config,profile,IPTV,direction,receive,source,192.165.112.200,sourcePort,5602,destinationPort,5602
2022-10-27 14:26:04.042 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE,streamID,141


2022-10-27 14:26:04.056 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_receive_start,streamID,79
2022-10-27 14:26:05.055 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:26:05.071 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_receive_start,streamID,80
2022-10-27 14:26:06.069 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:26:06.085 - INFO - intel11n (192.168.250.79:9000) ---> traffic_agent_receive_start,streamID,141
2022-10-27 14:26:06.115 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE


2022-10-27 14:26:07.130 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_send,streamID,63 64 65
2022-10-27 14:26:07.145 - INFO - DUT             <--1 status,RUNNING


2022-10-27 14:26:17.161 - INFO - DUT             <--1 status,COMPLETE,streamID,63 64 65,txFrames,3750 12620 6997,rxFrames,0 0 0,txPayloadBytes,5512500 18551400 10285590,rxPayloadBytes,0 0 0,outOfSequenceFrames,0 0 0


2022-10-27 14:26:17.161 - INFO - DUT (192.168.250.200:9000) <--  SEND Stream - 63;192.168.250.200:9000 Completed 
2022-10-27 14:26:17.161 - INFO - DUT (192.168.250.200:9000) <--  SEND Stream - 64;192.168.250.200:9000 Completed 
2022-10-27 14:26:17.177 - INFO - DUT (192.168.250.200:9000) <--  SEND Stream - 65;192.168.250.200:9000 Completed 
2022-10-27 14:26:19.438 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_receive_stop,streamID,80 79
2022-10-27 14:26:19.438 - INFO - broadcomvht     <--1 status,RUNNING


2022-10-27 14:26:20.437 - INFO - broadcomvht     <--1 status,COMPLETE,streamID, 80 79,txFrames, 0 0,rxFrames, 12620 3750,txPayloadBytes, 0 0,rxPayloadBytes, 18551400 5512500,outOfSequenceFrames 0 0


2022-10-27 14:26:20.453 - INFO - broadcomvht (192.168.250.42:9000) <----  RECV Stream - 80;192.168.250.42:9000 Completed 
2022-10-27 14:26:20.453 - INFO - broadcomvht (192.168.250.42:9000) <----  RECV Stream - 79;192.168.250.42:9000 Completed 
2022-10-27 14:26:26.459 - INFO - intel11n (192.168.250.79:9000) ---> traffic_agent_receive_stop,streamID,141
2022-10-27 14:26:26.459 - INFO - intel11n        <--1 status,RUNNING


2022-10-27 14:26:26.506 - INFO - intel11n        <--1 status,COMPLETE,streamID, 141,txFrames, 0,rxFrames, 6997,txPayloadBytes, 0,rxPayloadBytes, 10285590,outOfSequenceFrames 0


2022-10-27 14:26:26.506 - INFO - intel11n (192.168.250.79:9000) <----  RECV Stream - 141;192.168.250.79:9000 Completed 
2022-10-27 14:26:36.473 - INFO - 

         --------------------STREAM RESULTS-----------------------
2022-10-27 14:26:36.473 - INFO - 

         ----- RTP_1-BestEffort ( 192.168.250.200:9000 --> 192.168.250.42:9000 ) PHASE  = 1 -----
2022-10-27 14:26:36.473 - INFO - 
           RX            0  Bytes   |  TX    14798490   | Stream ID = 61
2022-10-27 14:26:36.490 - INFO - 
           RX     14795550  Bytes   |  TX           0   | Stream ID = 77
2022-10-27 14:26:36.490 - INFO - 

         ----- RTP_2-Video ( 192.168.250.200:9000 --> 192.168.250.42:9000 ) PHASE  = 1 -----
2022-10-27 14:26:36.505 - INFO - 
           RX            0  Bytes   |  TX    18551400   | Stream ID = 62
2022-10-27 14:26:36.505 - INFO - 
           RX     18551400  Bytes   |  TX           0   | Stream ID = 78
2022-10-27 14:26:36.505 - INFO - 

         ----- RTP_1-BestEffort ( 192.168.250.200:9000 --> 192.168.250.42:9000 ) PHASE  = 2 -----
2022-10-27 14:26:36.520 - INFO - 
           RX            0  Bytes   |  TX     5512500   | Stream ID = 63
2022-10-27 14:26:36.520 - INFO - 
           RX      5512500  Bytes   |  TX           0   | Stream ID = 79
2022-10-27 14:26:36.520 - INFO - 

         ----- RTP_2-Video ( 192.168.250.200:9000 --> 192.168.250.42:9000 ) PHASE  = 2 -----
2022-10-27 14:26:36.520 - INFO - 
           RX            0  Bytes   |  TX    18551400   | Stream ID = 64
2022-10-27 14:26:36.520 - INFO - 
           RX     18551400  Bytes   |  TX           0   | Stream ID = 80
2022-10-27 14:26:36.536 - INFO - 

         ----- RTP_3-BestEffort ( 192.168.250.200:9000 --> 192.168.250.79:9000 ) PHASE  = 2 -----
2022-10-27 14:26:36.536 - INFO - 
           RX            0  Bytes   |  TX    10285590   | Stream ID = 65
2022-10-27 14:26:36.536 - INFO - 
           RX     10285590  Bytes   |  TX           0   | Stream ID = 141
2022-10-27 14:26:36.536 - INFO - --------------------------SUMMARY----------------------------------
2022-10-27 14:26:36.536 - INFO -                                               | Phase1 (Bytes) | Phase2 (Bytes)
2022-10-27 14:26:36.552 - INFO - -------------------------------------------------------------------
2022-10-27 14:26:36.552 - INFO - 
       RTP1_BestEffort [192.168.250.200:9000-->192.168.250.42:9000]     |   14795550 |    5512500
2022-10-27 14:26:36.552 - INFO - 
       RTP2_Video      [192.168.250.200:9000-->192.168.250.42:9000]     |   18551400 |   18551400
2022-10-27 14:26:36.552 - INFO - 
       RTP3_BestEffort [192.168.250.200:9000-->192.168.250.79:9000]     |            |   10285590
2022-10-27 14:26:36.552 - INFO - 
       ----------------RESULT---------------------------

2022-10-27 14:26:36.552 - INFO - Video Phase 1 = 18551400 Bytes | Video Phase 2 = 18551400 Bytes 
2022-10-27 14:26:36.552 - INFO - Expected  > 90 %
2022-10-27 14:26:36.568 - INFO - Actual -   100.0 %
2022-10-27 14:26:36.568 - INFO - TEST RESULT ---> STEP4-PASS
2022-10-27 14:26:36.568 - INFO - 
       ------------------------------------------------
2022-10-27 14:26:41.591 - INFO - Sleep... 5 seconds
2022-10-27 14:26:46.598 - INFO - 
        ~~~~~ [ Running - STEP 5 ~~~~~

2022-10-27 14:26:46.598 - INFO - 
        ~~~~~ [ Starting Traffic ] ~~~~~

2022-10-27 14:26:46.598 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_reset
2022-10-27 14:26:47.612 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:26:47.612 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_reset
2022-10-27 14:26:47.674 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE

2022-10-27 14:26:52.713 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_config,profile,IPTV,direction,send,destination,192.165.112.42,destinationPort,5600,sourcePort,5600,duration,10,payloadSize,1470,trafficClass,BestEffort,frameRate,1415
2022-10-27 14:26:52.776 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE,streamID,66

2022-10-27 14:26:52.776 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_config,profile,IPTV,direction,receive,source,192.165.112.200,sourcePort,5600,destinationPort,5600
2022-10-27 14:26:53.775 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,streamID,81


2022-10-27 14:26:53.789 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_config,profile,IPTV,direction,send,destination,192.165.112.42,destinationPort,5601,sourcePort,5601,duration,10,payloadSize,1470,trafficClass,Video,frameRate,1262
2022-10-27 14:26:53.805 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE,streamID,67

2022-10-27 14:26:53.821 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_config,profile,IPTV,direction,receive,source,192.165.112.200,sourcePort,5601,destinationPort,5601
2022-10-27 14:26:54.819 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,streamID,82


2022-10-27 14:26:54.835 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_receive_start,streamID,81
2022-10-27 14:26:55.848 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:26:55.848 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_receive_start,streamID,82
2022-10-27 14:26:56.862 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:26:57.877 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_send,streamID,66 67
2022-10-27 14:26:57.892 - INFO - DUT             <--1 status,RUNNING


2022-10-27 14:27:07.892 - INFO - DUT             <--1 status,COMPLETE,streamID,66 67,txFrames,10769 12620,rxFrames,0 0,txPayloadBytes,15830430 18551400,rxPayloadBytes,0 0,outOfSequenceFrames,0 0


2022-10-27 14:27:07.907 - INFO - DUT (192.168.250.200:9000) <--  SEND Stream - 66;192.168.250.200:9000 Completed 
2022-10-27 14:27:07.907 - INFO - DUT (192.168.250.200:9000) <--  SEND Stream - 67;192.168.250.200:9000 Completed 
2022-10-27 14:27:10.186 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_receive_stop,streamID,82 81
2022-10-27 14:27:10.186 - INFO - broadcomvht     <--1 status,RUNNING


2022-10-27 14:27:11.184 - INFO - broadcomvht     <--1 status,COMPLETE,streamID, 82 81,txFrames, 0 0,rxFrames, 12620 10769,txPayloadBytes, 0 0,rxPayloadBytes, 18551400 15830430,outOfSequenceFrames 0 0


2022-10-27 14:27:11.200 - INFO - broadcomvht (192.168.250.42:9000) <----  RECV Stream - 82;192.168.250.42:9000 Completed 
2022-10-27 14:27:11.200 - INFO - broadcomvht (192.168.250.42:9000) <----  RECV Stream - 81;192.168.250.42:9000 Completed 
2022-10-27 14:27:20.217 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_reset
2022-10-27 14:27:21.214 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:27:21.230 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_reset
2022-10-27 14:27:21.292 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE

2022-10-27 14:27:21.292 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_config,profile,IPTV,direction,send,destination,192.165.112.42,destinationPort,5600,sourcePort,5600,duration,10,payloadSize,1470,trafficClass,BestEffort,frameRate,1415
2022-10-27 14:27:21.309 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE,streamID,68

2022-10-27 14:27:21.309 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_config,profile,IPTV,direction,receive,source,192.165.112.200,sourcePort,5600,destinationPort,5600
2022-10-27 14:27:22.322 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,streamID,83


2022-10-27 14:27:22.322 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_config,profile,IPTV,direction,send,destination,192.165.112.42,destinationPort,5601,sourcePort,5601,duration,10,payloadSize,1470,trafficClass,Video,frameRate,1262
2022-10-27 14:27:22.354 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE,streamID,69

2022-10-27 14:27:22.354 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_config,profile,IPTV,direction,receive,source,192.165.112.200,sourcePort,5601,destinationPort,5601
2022-10-27 14:27:23.368 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,streamID,84


2022-10-27 14:27:23.382 - INFO - intel11n (192.168.250.79:9000) ---> traffic_agent_config,profile,IPTV,direction,send,destination,192.165.112.200,destinationPort,5602,sourcePort,5602,duration,10,payloadSize,1470,trafficClass,BestEffort,frameRate,1262
2022-10-27 14:27:23.523 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE,streamID,142


2022-10-27 14:27:23.539 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_config,profile,IPTV,direction,receive,source,192.165.112.79,sourcePort,5602,destinationPort,5602
2022-10-27 14:27:23.555 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE,streamID,70

2022-10-27 14:27:23.571 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_receive_start,streamID,83
2022-10-27 14:27:24.569 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:27:24.585 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_receive_start,streamID,84
2022-10-27 14:27:25.582 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:27:25.598 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_receive_start,streamID,70
2022-10-27 14:27:25.832 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE


2022-10-27 14:27:26.846 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_send,streamID,68 69
2022-10-27 14:27:26.861 - INFO - DUT             <--1 status,RUNNING


2022-10-27 14:27:27.861 - INFO - intel11n (192.168.250.79:9000) ---> traffic_agent_send,streamID,142
2022-10-27 14:27:27.861 - INFO - intel11n        <--1 status,RUNNING


2022-10-27 14:27:36.861 - INFO - DUT             <--1 status,COMPLETE,streamID,68 69,txFrames,7888 12620,rxFrames,0 0,txPayloadBytes,11595360 18551400,rxPayloadBytes,0 0,outOfSequenceFrames,0 0


2022-10-27 14:27:36.877 - INFO - DUT (192.168.250.200:9000) <--  SEND Stream - 68;192.168.250.200:9000 Completed 
2022-10-27 14:27:36.877 - INFO - DUT (192.168.250.200:9000) <--  SEND Stream - 69;192.168.250.200:9000 Completed 
2022-10-27 14:27:39.138 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_receive_stop,streamID,84 83
2022-10-27 14:27:39.138 - INFO - broadcomvht     <--1 status,RUNNING


2022-10-27 14:27:40.138 - INFO - broadcomvht     <--1 status,COMPLETE,streamID, 84 83,txFrames, 0 0,rxFrames, 12620 7888,txPayloadBytes, 0 0,rxPayloadBytes, 18551400 11595360,outOfSequenceFrames 0 0


2022-10-27 14:27:40.153 - INFO - broadcomvht (192.168.250.42:9000) <----  RECV Stream - 84;192.168.250.42:9000 Completed 
2022-10-27 14:27:40.153 - INFO - broadcomvht (192.168.250.42:9000) <----  RECV Stream - 83;192.168.250.42:9000 Completed 
2022-10-27 14:27:41.806 - INFO - intel11n        <--1 status,COMPLETE,streamID, 142,txFrames,2526 ,rxFrames,0 ,txPayloadBytes,3713220 ,rxPayloadBytes,0 ,outOfSequenceFrames0 


2022-10-27 14:27:41.806 - INFO - intel11n (192.168.250.79:9000) <--  SEND Stream - 142;192.168.250.79:9000 Completed 
2022-10-27 14:27:46.158 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_receive_stop,streamID,70
2022-10-27 14:27:46.221 - INFO - DUT             <--1 status,RUNNING


2022-10-27 14:27:46.424 - INFO - DUT             <--1 status,COMPLETE,streamID,70,txFrames,0,rxFrames,2526,txPayloadBytes,0,rxPayloadBytes,3713220,outOfSequenceFrames,0


2022-10-27 14:27:46.424 - INFO - DUT (192.168.250.200:9000) <----  RECV Stream - 70;192.168.250.200:9000 Completed 
2022-10-27 14:27:56.174 - INFO - 
       ----------------RESULT---------------------------

2022-10-27 14:27:56.174 - INFO - Video Phase 1 = 18551400 Bytes | Video Phase 2 = 18551400 Bytes 
2022-10-27 14:27:56.174 - INFO - Expected  > 90 %
2022-10-27 14:27:56.174 - INFO - Actual -   100.0 %
2022-10-27 14:27:56.174 - INFO - TEST RESULT ---> STEP5-PASS
2022-10-27 14:27:56.174 - INFO - 
       ------------------------------------------------
2022-10-27 14:28:01.197 - INFO - Sleep... 5 seconds
2022-10-27 14:28:06.204 - INFO - 
        ~~~~~ [ Running - STEP 6] ~~~~~

2022-10-27 14:28:11.243 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_reset
2022-10-27 14:28:12.243 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:28:12.257 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_reset
2022-10-27 14:28:12.539 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE


2022-10-27 14:28:12.539 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_config,profile,IPTV,direction,send,destination,192.165.112.200,destinationPort,5600,sourcePort,5600,duration,10,payloadSize,1470,trafficClass,BestEffort,frameRate,1415
2022-10-27 14:28:13.552 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,streamID,85


2022-10-27 14:28:13.552 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_config,profile,IPTV,direction,receive,source,192.165.112.42,sourcePort,5600,destinationPort,5600
2022-10-27 14:28:13.569 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE,streamID,71

2022-10-27 14:28:13.584 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_config,profile,IPTV,direction,send,destination,192.165.112.200,destinationPort,5601,sourcePort,5601,duration,10,payloadSize,1470,trafficClass,Video,frameRate,1262
2022-10-27 14:28:14.582 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,streamID,86


2022-10-27 14:28:14.598 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_config,profile,IPTV,direction,receive,source,192.165.112.42,sourcePort,5601,destinationPort,5601
2022-10-27 14:28:14.832 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE,streamID,72


2022-10-27 14:28:14.832 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_receive_start,streamID,72
2022-10-27 14:28:14.864 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE

2022-10-27 14:28:14.864 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_receive_start,streamID,71
2022-10-27 14:28:15.098 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE


2022-10-27 14:28:16.111 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_send,streamID,85 86
2022-10-27 14:28:16.111 - INFO - broadcomvht     <--1 status,RUNNING


2022-10-27 14:28:29.121 - INFO - broadcomvht     <--1 status,COMPLETE,streamID, 85 86,txFrames,14160 12630 ,rxFrames,0 0 ,txPayloadBytes,20815200 18566100 ,rxPayloadBytes, 0  0 ,outOfSequenceFrames0 0 


2022-10-27 14:28:29.121 - INFO - broadcomvht (192.168.250.42:9000) <--  SEND Stream - 85;192.168.250.42:9000 Completed 
2022-10-27 14:28:29.138 - INFO - broadcomvht (192.168.250.42:9000) <--  SEND Stream - 86;192.168.250.42:9000 Completed 
2022-10-27 14:28:31.509 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_receive_stop,streamID,71 72
2022-10-27 14:28:31.555 - INFO - DUT             <--1 status,RUNNING


2022-10-27 14:28:31.773 - INFO - DUT             <--1 status,COMPLETE,streamID,71 72,txFrames,0 0,rxFrames,11757 12630,txPayloadBytes,0 0,rxPayloadBytes,17282790 18566100,outOfSequenceFrames,0 0


2022-10-27 14:28:31.773 - INFO - DUT (192.168.250.200:9000) <----  RECV Stream - 71;192.168.250.200:9000 Completed 
2022-10-27 14:28:31.773 - INFO - DUT (192.168.250.200:9000) <----  RECV Stream - 72;192.168.250.200:9000 Completed 
2022-10-27 14:28:41.539 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_reset
2022-10-27 14:28:42.538 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:28:42.553 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_reset
2022-10-27 14:28:42.599 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE

2022-10-27 14:28:42.615 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_config,profile,IPTV,direction,send,destination,192.165.112.200,destinationPort,5600,sourcePort,5600,duration,10,payloadSize,1470,trafficClass,BestEffort,frameRate,1415
2022-10-27 14:28:43.630 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,streamID,87


2022-10-27 14:28:43.630 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_config,profile,IPTV,direction,receive,source,192.165.112.42,sourcePort,5600,destinationPort,5600
2022-10-27 14:28:43.661 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE,streamID,73

2022-10-27 14:28:43.661 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_config,profile,IPTV,direction,send,destination,192.165.112.200,destinationPort,5601,sourcePort,5601,duration,10,payloadSize,1470,trafficClass,Video,frameRate,1262
2022-10-27 14:28:44.674 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,streamID,88


2022-10-27 14:28:44.690 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_config,profile,IPTV,direction,receive,source,192.165.112.42,sourcePort,5601,destinationPort,5601
2022-10-27 14:28:44.706 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE,streamID,74

2022-10-27 14:28:44.721 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_config,profile,IPTV,direction,send,destination,192.165.112.79,destinationPort,5602,sourcePort,5602,duration,10,payloadSize,1470,trafficClass,BestEffort,frameRate,1262
2022-10-27 14:28:44.737 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE,streamID,75

2022-10-27 14:28:44.753 - INFO - intel11n (192.168.250.79:9000) ---> traffic_agent_config,profile,IPTV,direction,receive,source,192.165.112.200,sourcePort,5602,destinationPort,5602
2022-10-27 14:28:44.878 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE,streamID,143


2022-10-27 14:28:44.894 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_receive_start,streamID,74
2022-10-27 14:28:45.111 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE


2022-10-27 14:28:45.111 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_receive_start,streamID,73
2022-10-27 14:28:45.345 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE


2022-10-27 14:28:45.345 - INFO - intel11n (192.168.250.79:9000) ---> traffic_agent_receive_start,streamID,143
2022-10-27 14:28:45.392 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE


2022-10-27 14:28:46.421 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_send,streamID,87 88
2022-10-27 14:28:46.421 - INFO - broadcomvht     <--1 status,RUNNING


2022-10-27 14:28:47.436 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_send,streamID,75
2022-10-27 14:28:47.451 - INFO - DUT             <--1 status,RUNNING


2022-10-27 14:28:57.467 - INFO - DUT             <--1 status,COMPLETE,streamID,75,txFrames,8739,rxFrames,0,txPayloadBytes,12846330,rxPayloadBytes,0,outOfSequenceFrames,0


2022-10-27 14:28:57.467 - INFO - DUT (192.168.250.200:9000) <--  SEND Stream - 75;192.168.250.200:9000 Completed 
2022-10-27 14:28:59.433 - INFO - broadcomvht     <--1 status,COMPLETE,streamID, 87 88,txFrames,14160 12630 ,rxFrames,0 0 ,txPayloadBytes,20815200 18566100 ,rxPayloadBytes, 0  0 ,outOfSequenceFrames0 0 


2022-10-27 14:28:59.433 - INFO - broadcomvht (192.168.250.42:9000) <--  SEND Stream - 87;192.168.250.42:9000 Completed 
2022-10-27 14:28:59.433 - INFO - broadcomvht (192.168.250.42:9000) <--  SEND Stream - 88;192.168.250.42:9000 Completed 
2022-10-27 14:29:01.803 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_receive_stop,streamID,73 74
2022-10-27 14:29:01.819 - INFO - DUT             <--1 status,RUNNING


2022-10-27 14:29:02.038 - INFO - DUT             <--1 status,COMPLETE,streamID,73 74,txFrames,0 0,rxFrames,6136 12205,txPayloadBytes,0 0,rxPayloadBytes,9019920 17941350,outOfSequenceFrames,0 0


2022-10-27 14:29:02.038 - INFO - DUT (192.168.250.200:9000) <----  RECV Stream - 73;192.168.250.200:9000 Completed 
2022-10-27 14:29:02.053 - INFO - DUT (192.168.250.200:9000) <----  RECV Stream - 74;192.168.250.200:9000 Completed 
2022-10-27 14:29:08.823 - INFO - intel11n (192.168.250.79:9000) ---> traffic_agent_receive_stop,streamID,143
2022-10-27 14:29:08.823 - INFO - intel11n        <--1 status,RUNNING


2022-10-27 14:29:08.871 - INFO - intel11n        <--1 status,COMPLETE,streamID, 143,txFrames, 0,rxFrames, 8739,txPayloadBytes, 0,rxPayloadBytes, 12846330,outOfSequenceFrames 0


2022-10-27 14:29:08.871 - INFO - intel11n (192.168.250.79:9000) <----  RECV Stream - 143;192.168.250.79:9000 Completed 
2022-10-27 14:29:18.838 - INFO - 
       ----------------RESULT---------------------------

2022-10-27 14:29:18.838 - INFO - Video Phase 1 = 18566100 Bytes | Video Phase 2 = 17941350 Bytes 
2022-10-27 14:29:18.838 - INFO - Expected  > 90 %
2022-10-27 14:29:18.855 - INFO - Actual -  96.634 %
2022-10-27 14:29:18.855 - INFO - TEST RESULT ---> STEP6-PASS
2022-10-27 14:29:18.855 - INFO - 
       ------------------------------------------------
2022-10-27 14:29:23.894 - INFO - Sleep... 5 seconds
2022-10-27 14:29:28.901 - INFO - 
        ~~~~~ [ Running - STEP 7] ~~~~~

2022-10-27 14:29:28.917 - INFO - 
        ~~~~~ [ Starting Traffic ] ~~~~~

2022-10-27 14:29:28.917 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_reset
2022-10-27 14:29:29.930 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:29:29.946 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_reset
2022-10-27 14:29:30.180 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE


2022-10-27 14:29:35.203 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_config,profile,IPTV,direction,send,destination,192.165.112.42,destinationPort,5600,sourcePort,5600,duration,10,payloadSize,1470,trafficClass,BestEffort,frameRate,1415
2022-10-27 14:29:35.219 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE,streamID,76

2022-10-27 14:29:35.234 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_config,profile,IPTV,direction,receive,source,192.165.112.200,sourcePort,5600,destinationPort,5600
2022-10-27 14:29:36.233 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,streamID,89


2022-10-27 14:29:36.249 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_config,profile,IPTV,direction,send,destination,192.165.112.200,destinationPort,5601,sourcePort,5601,duration,10,payloadSize,1470,trafficClass,Video,frameRate,1262
2022-10-27 14:29:37.263 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,streamID,90


2022-10-27 14:29:37.263 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_config,profile,IPTV,direction,receive,source,192.165.112.42,sourcePort,5601,destinationPort,5601
2022-10-27 14:29:37.293 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE,streamID,77

2022-10-27 14:29:37.293 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_receive_start,streamID,89
2022-10-27 14:29:38.308 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:29:38.308 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_receive_start,streamID,77
2022-10-27 14:29:38.542 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE


2022-10-27 14:29:39.555 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_send,streamID,76
2022-10-27 14:29:39.572 - INFO - DUT             <--1 status,RUNNING


2022-10-27 14:29:40.569 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_send,streamID,90
2022-10-27 14:29:40.569 - INFO - broadcomvht     <--1 status,RUNNING


2022-10-27 14:29:49.571 - INFO - DUT             <--1 status,COMPLETE,streamID,76,txFrames,12026,rxFrames,0,txPayloadBytes,17678220,rxPayloadBytes,0,outOfSequenceFrames,0


2022-10-27 14:29:49.586 - INFO - DUT (192.168.250.200:9000) <--  SEND Stream - 76;192.168.250.200:9000 Completed 
2022-10-27 14:29:53.579 - INFO - broadcomvht     <--1 status,COMPLETE,streamID, 90,txFrames,12630 ,rxFrames,0 ,txPayloadBytes,18566100 ,rxPayloadBytes, 0 ,outOfSequenceFrames0 


2022-10-27 14:29:53.579 - INFO - broadcomvht (192.168.250.42:9000) <--  SEND Stream - 90;192.168.250.42:9000 Completed 
2022-10-27 14:29:55.967 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_receive_stop,streamID,77
2022-10-27 14:29:56.029 - INFO - DUT             <--1 status,RUNNING


2022-10-27 14:29:56.247 - INFO - DUT             <--1 status,COMPLETE,streamID,77,txFrames,0,rxFrames,12630,txPayloadBytes,0,rxPayloadBytes,18566100,outOfSequenceFrames,0


2022-10-27 14:29:56.247 - INFO - DUT (192.168.250.200:9000) <----  RECV Stream - 77;192.168.250.200:9000 Completed 
2022-10-27 14:30:02.986 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_receive_stop,streamID,89
2022-10-27 14:30:02.986 - INFO - broadcomvht     <--1 status,RUNNING


2022-10-27 14:30:03.986 - INFO - broadcomvht     <--1 status,COMPLETE,streamID, 89,txFrames, 0,rxFrames, 12026,txPayloadBytes, 0,rxPayloadBytes, 17678220,outOfSequenceFrames 0


2022-10-27 14:30:04.000 - INFO - broadcomvht (192.168.250.42:9000) <----  RECV Stream - 89;192.168.250.42:9000 Completed 
2022-10-27 14:30:13.017 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_reset
2022-10-27 14:30:14.016 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:30:14.032 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_reset
2022-10-27 14:30:14.095 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE

2022-10-27 14:30:14.095 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_config,profile,IPTV,direction,send,destination,192.165.112.42,destinationPort,5600,sourcePort,5600,duration,10,payloadSize,1470,trafficClass,BestEffort,frameRate,1415
2022-10-27 14:30:14.344 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE,streamID,78


2022-10-27 14:30:14.344 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_config,profile,IPTV,direction,receive,source,192.165.112.200,sourcePort,5600,destinationPort,5600
2022-10-27 14:30:15.358 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,streamID,91


2022-10-27 14:30:15.358 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_config,profile,IPTV,direction,send,destination,192.165.112.200,destinationPort,5601,sourcePort,5601,duration,10,payloadSize,1470,trafficClass,Video,frameRate,1262
2022-10-27 14:30:16.371 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE,streamID,92


2022-10-27 14:30:16.388 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_config,profile,IPTV,direction,receive,source,192.165.112.42,sourcePort,5601,destinationPort,5601
2022-10-27 14:30:16.403 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE,streamID,79

2022-10-27 14:30:16.418 - INFO - intel11n (192.168.250.79:9000) ---> traffic_agent_config,profile,IPTV,direction,send,destination,192.165.112.200,destinationPort,5602,sourcePort,5602,duration,10,payloadSize,1470,trafficClass,BestEffort,frameRate,1262
2022-10-27 14:30:16.559 - INFO - intel11n (192.168.250.79:9000) <-- status,COMPLETE,streamID,144
2022-10-27 14:30:16.575 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_config,profile,IPTV,direction,receive,source,192.165.112.79,sourcePort,5602,destinationPort,5602
2022-10-27 14:30:16.591 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE,streamID,80

2022-10-27 14:30:16.591 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_receive_start,streamID,91
2022-10-27 14:30:17.605 - INFO - broadcomvht (192.168.250.42:9000) <-- status,COMPLETE


2022-10-27 14:30:17.605 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_receive_start,streamID,79
2022-10-27 14:30:17.635 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE

2022-10-27 14:30:17.651 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_receive_start,streamID,80
2022-10-27 14:30:17.884 - INFO - PC_ENDPOINT (192.168.250.200:9000) <-- status,COMPLETE


2022-10-27 14:30:18.898 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_send,streamID,78
2022-10-27 14:30:18.914 - INFO - DUT             <--1 status,RUNNING


2022-10-27 14:30:19.913 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_send,streamID,92
2022-10-27 14:30:19.913 - INFO - broadcomvht     <--1 status,RUNNING


2022-10-27 14:30:20.927 - INFO - intel11n (192.168.250.79:9000) ---> traffic_agent_send,streamID,144
2022-10-27 14:30:20.927 - INFO - intel11n        <--1 status,RUNNING


2022-10-27 14:30:28.914 - INFO - DUT             <--1 status,COMPLETE,streamID,78,txFrames,10379,rxFrames,0,txPayloadBytes,15257130,rxPayloadBytes,0,outOfSequenceFrames,0


2022-10-27 14:30:28.930 - INFO - DUT (192.168.250.200:9000) <--  SEND Stream - 78;192.168.250.200:9000 Completed 
2022-10-27 14:30:32.924 - INFO - broadcomvht     <--1 status,COMPLETE,streamID, 92,txFrames,12630 ,rxFrames,0 ,txPayloadBytes,18566100 ,rxPayloadBytes, 0 ,outOfSequenceFrames0 


2022-10-27 14:30:32.924 - INFO - broadcomvht (192.168.250.42:9000) <--  SEND Stream - 92;192.168.250.42:9000 Completed 
2022-10-27 14:30:35.841 - INFO - intel11n        <--1 status,COMPLETE,streamID, 144,txFrames,2526 ,rxFrames,0 ,txPayloadBytes,3713220 ,rxPayloadBytes,0 ,outOfSequenceFrames0 


2022-10-27 14:30:35.841 - INFO - intel11n (192.168.250.79:9000) <--  SEND Stream - 144;192.168.250.79:9000 Completed 
2022-10-27 14:30:38.384 - INFO - PC_ENDPOINT (192.168.250.200:9000) ---> traffic_agent_receive_stop,streamID,79 80
2022-10-27 14:30:38.446 - INFO - DUT             <--1 status,RUNNING


2022-10-27 14:30:38.664 - INFO - DUT             <--1 status,COMPLETE,streamID,79 80,txFrames,0 0,rxFrames,12630 2526,txPayloadBytes,0 0,rxPayloadBytes,18566100 3713220,outOfSequenceFrames,0 0


2022-10-27 14:30:38.664 - INFO - DUT (192.168.250.200:9000) <----  RECV Stream - 79;192.168.250.200:9000 Completed 
2022-10-27 14:30:38.664 - INFO - DUT (192.168.250.200:9000) <----  RECV Stream - 80;192.168.250.200:9000 Completed 
2022-10-27 14:30:45.404 - INFO - broadcomvht (192.168.250.42:9000) ---> traffic_agent_receive_stop,streamID,91
2022-10-27 14:30:45.404 - INFO - broadcomvht     <--1 status,RUNNING


2022-10-27 14:30:46.401 - INFO - broadcomvht     <--1 status,COMPLETE,streamID, 91,txFrames, 0,rxFrames, 10379,txPayloadBytes, 0,rxPayloadBytes, 15257130,outOfSequenceFrames 0


2022-10-27 14:30:46.417 - INFO - broadcomvht (192.168.250.42:9000) <----  RECV Stream - 91;192.168.250.42:9000 Completed 
2022-10-27 14:30:55.418 - INFO - 
       ----------------RESULT---------------------------

2022-10-27 14:30:55.418 - INFO - Expected  <= 130 %
2022-10-27 14:30:55.418 - INFO - Actual -  410.88 %
2022-10-27 14:30:55.418 - INFO - TEST RESULT ---> STEP7-FAILED
2022-10-27 14:30:55.418 - INFO - 
       ------------------------------------------------
2022-10-27 14:30:55.418 - INFO - 
    FINAL TEST RESULT  --->            FAIL
2022-10-27 14:30:55.418 - INFO -      END: TEST CASE [N-4.2.23]
2022-10-27 14:30:55.700 - INFO - FAIL