TEST SESSION LOGS


DEVICE MAC ADDRESS:E45F01F4EE2B
TEST CASE ID:3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001
FIRMWARE:rdkb-generic-broadband-image_rdkb-2024q1-kirkstone_20240417053101.bin

[2024-05-24 15:55:50,855] : ###STARTING TEST CASE: 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001
[2024-05-24 15:55:50,856] : Starting execution in settop -E4:5F:01:F4:EE:2B
[2024-05-24 15:55:50,863] : # STEP_1 : Enable Telemetry #
[2024-05-24 15:55:50,864] : # STEP_2 : Set telemetry version to 2.0.1 #
[2024-05-24 15:55:50,864] : # STEP_3 : Set telemetry config URL to xconf.rdkcentral.com T2 URL #
[2024-05-24 15:55:50,864] : # STEP_4 : Enable webconfig - restart webconfig process #
[2024-05-24 15:55:50,864] : # STEP_5 : Enable webconfig - set Device.X_RDK_WebConfig.RfcEnable to true #
[2024-05-24 15:55:50,864] : # STEP_6 : Get ECM mac of the device #
[2024-05-24 15:55:50,864] : # STEP_7 : Update webconfig telemetry URL #
[2024-05-24 15:55:50,864] : # STEP_8 : Disable webconfig #
[2024-05-24 15:55:50,864] : # STEP_9 : Stop the webconfig process #
[2024-05-24 15:55:50,864] : # STEP_10 : Reboot the device and wait for device to come up #
[2024-05-24 15:55:50,864] : # STEP_11 : Validate Telemetry is enabled in device #
[2024-05-24 15:55:50,865] : # STEP_12 : Validate Telemetry version in device #
[2024-05-24 15:55:50,865] : # STEP_13 : Validate Telemetry Url to have xconf.rdkcentral.com T2 URL #
[2024-05-24 15:55:50,865] : # STEP_14 : Verify telemetry process is up and running #
[2024-05-24 15:55:50,865] : # STEP_15 : Enable webconfig - restart webconfig process #
[2024-05-24 15:55:50,865] : # STEP_16 : Enable webconfig - set Device.X_RDK_WebConfig.RfcEnable to true #
[2024-05-24 15:55:50,865] : # STEP_17 : Validate If supplementary doc information is present in webconfig.properties #
[2024-05-24 15:55:50,865] : # STEP_18 : Validate if X-System-SupplementaryService-Sync: telemetry present in webconfig.log #
[2024-05-24 15:55:50,865] : # STEP_19 : Validate tr181 value for PartnerID #
[2024-05-24 15:55:50,865] : # STEP_20 : Validate header X-System-PartnerID present in webconfig.log and check if it matches with tr181 value #
[2024-05-24 15:55:50,865] : # STEP_21 : Validate force sync for telemetry #
[2024-05-24 15:55:50,865] : # STEP_22 : Validate force sync for telemetry with webconfig logs #
[2024-05-24 15:55:50,866] : # STEP_23 : Validate force sync for telemetry with webconfig logs #
[2024-05-24 15:55:50,866] : # STEP_24 : Validate force sync for primary #
[2024-05-24 15:55:50,866] : # STEP_25 : Validate force sync for primary with primarylogs #
[2024-05-24 15:55:50,866] : # STEP_26 : Validate write access for Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry #
[2024-05-24 15:55:50,866] : # STEP_27 : Validate read access for Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry #
[2024-05-24 15:55:50,866] : # STEP_28 : Validate webconfig DB to not have telemetry #
[2024-05-24 15:55:50,866] : # STEP_29 : Perform Factory reset #
[2024-05-24 15:55:50,866] : # STEP_30 : Wait for CPE to come up after FR #
[2024-05-24 15:55:50,866] : # STEP_31 : Verify webconfig to be disabled by default #
[2024-05-24 15:55:50,866] : # STEP_32 : Enable webconfig - restart webconfig process #
[2024-05-24 15:55:50,867] : # STEP_33 : Enable webconfig #
[2024-05-24 15:55:50,867] : # STEP_34 : Validate default value of supplementary URL #
[2024-05-24 15:55:50,867] : # STEP_35 : Update supplementary telemetry URL value to NULL #
[2024-05-24 15:55:50,867] : # STEP_36 : Validate status_code to be 520/Execution failure on performing forcesync #
[2024-05-24 15:55:50,867] : # STEP_37 : Update default URL #
[2024-05-24 15:55:50,867] : # STEP_38 : update webconfig to false #
[2024-05-24 15:55:50,867] : # STEP_39 : Reactivate the device #
[2024-05-24 15:55:50,867] : # STEP_39.1 : To activate set 2.4GHz SSID #
[2024-05-24 15:55:50,867] : # STEP_39.2 : To activate set 5GHz SSID #
[2024-05-24 15:55:50,867] : # STEP_39.3 : Set KeyPassphrase for 2.4GHz #
[2024-05-24 15:55:50,867] : # STEP_39.4 : Set KeyPassphrase for 5GHz #
[2024-05-24 15:55:50,868] : # STEP_39.5 : Set false to ConfigureWiFi #
[2024-05-24 15:55:50,868] : # STEP_39.6 : Set Device.DeviceInfo.X_RDKCENTRAL-COM_CaptivePortalEnable to false #
[2024-05-24 15:55:50,868] : # STEP_39.7 : Applysettings to Radio 1 #
[2024-05-24 15:55:50,868] : # STEP_39.8 : Applysettings to Radio 2 #
[2024-05-24 15:55:50,868] : # STEP_39.9 : Apply AccessPointSettings to both radios #
[2024-05-24 15:55:50,868] : # STEP_39.10 : Apply RadioSettings to both Radios #

[2024-05-24 15:55:50,869] : [STEP_1] #####################################################
[2024-05-24 15:55:50,869] : [STEP_1] Description : Enable Telemetry
[2024-05-24 15:55:50,869] : [STEP_1] Expected Result : Telemetry must be enabled
[2024-05-24 15:55:50,869] : [STEP_1] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 15:55:50,869] : [STEP_1] #####################################################

[2024-05-24 15:55:50,871] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 15:55:50,873] : Packages to scan : com.automatics.,com.automatics.core.,com.automatics.scriptless.
[2024-05-24 15:55:51,193] : Total APIs :: 173
[2024-05-24 15:55:51,198] : AutomaticsScriptlessTapApi instance not available. Creating new instance
[2024-05-24 15:55:51,202] : Setting webpa Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.Enable dataType 3 value true
[2024-05-24 15:55:51,204] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:55:51,204] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:55:51,205] : COMPLETE URL BUILD FOR "SET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config
[2024-05-24 15:55:51,205] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:55:51,205] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:55:51,251] : REST CLIENT - Processing request
[2024-05-24 15:55:51,658] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config is - 200
[2024-05-24 15:55:51,659] : RESPONSE RECIEVED FOR WEBPA SET REQUEST: 200
[2024-05-24 15:55:51,659] : WEBPA RESPONSE : {"parameters":[{"name":"Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.Enable","message":"Success"}],"statusCode":200}
[2024-05-24 15:55:51,660] : ENDING METHOD: setWebPaParameterValue : Success
[2024-05-24 15:55:51,660] : TR181 Response : {Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.Enable=Success}
[2024-05-24 15:55:51,661] : Presence of parameter true in the command output : true
[2024-05-24 15:55:51,661] : >>>>>> ACTUAL OUTPUT: true
[2024-05-24 15:55:51,661] : >>>>>> EXPECTED OUTPUT: true
[2024-05-24 15:55:51,661] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 15:55:51,661] : >>>>>> VALIDATION STATUS: true
[2024-05-24 15:55:51,661] : >>>>>> INVERT RESULT: false

[2024-05-24 15:55:51,662] : [STEP_1] #####################################################
[2024-05-24 15:55:51,662] : [STEP_1]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 15:55:51,662] : [STEP_1] #####################################################

[2024-05-24 15:55:51,670] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S1][ Execution status : PASS] [Error Message : ]
[2024-05-24 15:55:51,672] : Fetching device property: FIRMWARE_VERSION
[2024-05-24 15:55:51,677] : Fetching device props for E4:5F:01:F4:EE:2B for props [FIRMWARE_VERSION] Url Path: https://automatics-apps.rdkcentral.com/DeviceManager/deviceManagement/getDeviceProps
[2024-05-24 15:55:51,743] : Response: {"mac":"E4:5F:01:F4:EE:2B","HEAD_END":null,"FIRMWARE_VERSION":"cc","ECM_IP_ADDRESS":null,"ESTB_IP_ADDRESS":null}
[2024-05-24 15:55:51,744] : Getting value for property: FIRMWARE_VERSION
[2024-05-24 15:55:51,744] : Value: cc
[2024-05-24 15:55:51,744] : Device property name: FIRMWARE_VERSION value obtained: cc
[2024-05-24 15:55:51,746] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S1","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 15:55:51,760] : Execution result updated successfully

[2024-05-24 15:55:51,760] : [STEP_2] #####################################################
[2024-05-24 15:55:51,760] : [STEP_2] Description : Set telemetry version to 2.0.1
[2024-05-24 15:55:51,760] : [STEP_2] Expected Result : Telemetry version must be set to 2.0.1
[2024-05-24 15:55:51,760] : [STEP_2] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 15:55:51,760] : [STEP_2] #####################################################

[2024-05-24 15:55:51,761] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 15:55:51,764] : Setting webpa Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.Version dataType 0 value 2.0.1
[2024-05-24 15:55:51,764] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:55:51,764] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:55:51,765] : COMPLETE URL BUILD FOR "SET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config
[2024-05-24 15:55:51,765] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:55:51,765] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:55:51,766] : REST CLIENT - Processing request
[2024-05-24 15:55:52,172] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config is - 200
[2024-05-24 15:55:52,173] : RESPONSE RECIEVED FOR WEBPA SET REQUEST: 200
[2024-05-24 15:55:52,173] : WEBPA RESPONSE : {"parameters":[{"name":"Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.Version","message":"Success"}],"statusCode":200}
[2024-05-24 15:55:52,173] : ENDING METHOD: setWebPaParameterValue : Success
[2024-05-24 15:55:52,173] : TR181 Response : {Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.Version=Success}
[2024-05-24 15:55:52,173] : Presence of parameter true in the command output : true
[2024-05-24 15:55:52,174] : >>>>>> ACTUAL OUTPUT: true
[2024-05-24 15:55:52,174] : >>>>>> EXPECTED OUTPUT: true
[2024-05-24 15:55:52,174] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 15:55:52,174] : >>>>>> VALIDATION STATUS: true
[2024-05-24 15:55:52,174] : >>>>>> INVERT RESULT: false

[2024-05-24 15:55:52,174] : [STEP_2] #####################################################
[2024-05-24 15:55:52,174] : [STEP_2]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 15:55:52,174] : [STEP_2] #####################################################

[2024-05-24 15:55:52,179] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S2][ Execution status : PASS] [Error Message : ]
[2024-05-24 15:55:52,180] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S2","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 15:55:52,193] : Execution result updated successfully

[2024-05-24 15:55:52,193] : [STEP_3] #####################################################
[2024-05-24 15:55:52,193] : [STEP_3] Description : Set telemetry config URL to xconf.rdkcentral.com T2 URL
[2024-05-24 15:55:52,193] : [STEP_3] Expected Result : Telemetry URL is set to telemetry xconf.rdkcentral.com T2 URL
[2024-05-24 15:55:52,193] : [STEP_3] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 15:55:52,193] : [STEP_3] #####################################################

[2024-05-24 15:55:52,194] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 15:55:52,197] : Setting webpa Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.ConfigURL dataType 0 value https://xconf.rdkcentral.com:19092/loguploader/getT2Settings
[2024-05-24 15:55:52,197] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:55:52,197] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:55:52,198] : COMPLETE URL BUILD FOR "SET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config
[2024-05-24 15:55:52,198] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:55:52,198] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:55:52,199] : REST CLIENT - Processing request
[2024-05-24 15:55:52,597] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config is - 200
[2024-05-24 15:55:52,598] : RESPONSE RECIEVED FOR WEBPA SET REQUEST: 200
[2024-05-24 15:55:52,598] : WEBPA RESPONSE : {"parameters":[{"name":"Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.ConfigURL","message":"Success"}],"statusCode":200}
[2024-05-24 15:55:52,599] : ENDING METHOD: setWebPaParameterValue : Success
[2024-05-24 15:55:52,599] : TR181 Response : {Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.ConfigURL=Success}
[2024-05-24 15:55:52,599] : Presence of parameter true in the command output : true
[2024-05-24 15:55:52,599] : >>>>>> ACTUAL OUTPUT: true
[2024-05-24 15:55:52,599] : >>>>>> EXPECTED OUTPUT: true
[2024-05-24 15:55:52,599] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 15:55:52,599] : >>>>>> VALIDATION STATUS: true
[2024-05-24 15:55:52,599] : >>>>>> INVERT RESULT: false

[2024-05-24 15:55:52,599] : [STEP_3] #####################################################
[2024-05-24 15:55:52,599] : [STEP_3]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 15:55:52,600] : [STEP_3] #####################################################

[2024-05-24 15:55:52,604] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S3][ Execution status : PASS] [Error Message : ]
[2024-05-24 15:55:52,604] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S3","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 15:55:52,634] : Execution result updated successfully

[2024-05-24 15:55:52,634] : [STEP_4] #####################################################
[2024-05-24 15:55:52,634] : [STEP_4] Description : Enable webconfig - restart webconfig process
[2024-05-24 15:55:52,634] : [STEP_4] Expected Result : Webconfig process should active
[2024-05-24 15:55:52,634] : [STEP_4] API Name : EXECUTE_COMMAND
[2024-05-24 15:55:52,634] : [STEP_4] #####################################################

[2024-05-24 15:55:52,634] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 15:55:52,669] : Entering executeCommandUsingSsh method
[2024-05-24 15:55:52,735] : Default SSH custom port is set
<=========================== RESPONSE =======================>

<=============================================================>

[2024-05-24 15:55:54,880] : Exiting executeCommandUsingSsh method
[2024-05-24 15:55:54,880] : >>>>>> ACTUAL OUTPUT:

[2024-05-24 15:55:54,880] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 15:55:54,880] : >>>>>> VALIDATION PERFORMED: NA
[2024-05-24 15:55:54,880] : >>>>>> VALIDATION STATUS: true
[2024-05-24 15:55:54,880] : >>>>>> INVERT RESULT: false

[2024-05-24 15:55:54,880] : [STEP_4] #####################################################
[2024-05-24 15:55:54,880] : [STEP_4]-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-05-24 15:55:54,880] : [STEP_4] #####################################################

[2024-05-24 15:55:54,883] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S4][ Execution status : PASS] [Error Message : ]
[2024-05-24 15:55:54,884] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S4","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 15:55:54,896] : Execution result updated successfully

[2024-05-24 15:55:54,896] : [STEP_5] #####################################################
[2024-05-24 15:55:54,896] : [STEP_5] Description : Enable webconfig - set Device.X_RDK_WebConfig.RfcEnable to true
[2024-05-24 15:55:54,896] : [STEP_5] Expected Result : Device.X_RDK_WebConfig.RfcEnable should set to true
[2024-05-24 15:55:54,896] : [STEP_5] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 15:55:54,896] : [STEP_5] #####################################################

[2024-05-24 15:55:54,897] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 15:55:54,900] : Setting webpa Device.X_RDK_WebConfig.RfcEnable dataType 3 value true
[2024-05-24 15:55:54,900] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:55:54,900] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:55:54,900] : COMPLETE URL BUILD FOR "SET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config
[2024-05-24 15:55:54,900] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:55:54,901] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:55:54,901] : REST CLIENT - Processing request
[2024-05-24 15:55:55,306] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config is - 200
[2024-05-24 15:55:55,307] : RESPONSE RECIEVED FOR WEBPA SET REQUEST: 200
[2024-05-24 15:55:55,307] : WEBPA RESPONSE : {"parameters":[{"name":"Device.X_RDK_WebConfig.RfcEnable","message":"Success"}],"statusCode":200}
[2024-05-24 15:55:55,307] : ENDING METHOD: setWebPaParameterValue : Success
[2024-05-24 15:55:55,307] : TR181 Response : {Device.X_RDK_WebConfig.RfcEnable=Success}
[2024-05-24 15:55:55,308] : Presence of parameter true in the command output : true
[2024-05-24 15:55:55,308] : >>>>>> ACTUAL OUTPUT: true
[2024-05-24 15:55:55,308] : >>>>>> EXPECTED OUTPUT: true
[2024-05-24 15:55:55,308] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 15:55:55,308] : >>>>>> VALIDATION STATUS: true
[2024-05-24 15:55:55,308] : >>>>>> INVERT RESULT: false

[2024-05-24 15:55:55,308] : [STEP_5] #####################################################
[2024-05-24 15:55:55,308] : [STEP_5]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 15:55:55,308] : [STEP_5] #####################################################

[2024-05-24 15:55:55,313] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S5][ Execution status : PASS] [Error Message : ]
[2024-05-24 15:55:55,314] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S5","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 15:55:55,328] : Execution result updated successfully

[2024-05-24 15:55:55,328] : [STEP_6] #####################################################
[2024-05-24 15:55:55,328] : [STEP_6] Description : Get ECM mac of the device
[2024-05-24 15:55:55,328] : [STEP_6] Expected Result : ecm mac obtained
[2024-05-24 15:55:55,328] : [STEP_6] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 15:55:55,328] : [STEP_6] #####################################################

[2024-05-24 15:55:55,329] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 15:55:55,332] : TR181 Access Method: WEBPA
[2024-05-24 15:55:55,332] : getWebPaParamValue: Device.DeviceInfo.X_COMCAST-COM_CM_MAC
[2024-05-24 15:55:55,332] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:55:55,332] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:55:55,332] : COMPLETE URL BUILD FOR "GET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config?names=Device.DeviceInfo.X_COMCAST-COM_CM_MAC
[2024-05-24 15:55:55,332] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:55:55,332] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:55:55,332] : REST CLIENT - Processing request
[2024-05-24 15:55:55,743] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config?names=Device.DeviceInfo.X_COMCAST-COM_CM_MAC is - 200
[2024-05-24 15:55:55,743] : RESPONSE RECIEVED FOR WEBPA GET REQUEST: 200
[2024-05-24 15:55:55,743] : WEBPA RESPONSE : {"parameters":[{"name":"Device.DeviceInfo.X_COMCAST-COM_CM_MAC","value":"E4:5F:01:F4:EE:2B","dataType":0,"parameterCount":1,"message":"Success"}],"statusCode":200}
[2024-05-24 15:55:55,743] : WebPa data type: STRING
[2024-05-24 15:55:55,744] : TR181 parametrs status code added 0
[2024-05-24 15:55:55,744] : TR181 Response : [tableName=null, index=null, name=Device.DeviceInfo.X_COMCAST-COM_CM_MAC, protocolSpecificParamName=null, value=E4:5F:01:F4:EE:2B, datatype=STRING, statusCode=0]
[2024-05-24 15:55:55,744] : >>>>>> ACTUAL OUTPUT: E4:5F:01:F4:EE:2B
[2024-05-24 15:55:55,744] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 15:55:55,744] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-05-24 15:55:55,744] : >>>>>> VALIDATION STATUS: true
[2024-05-24 15:55:55,744] : >>>>>> INVERT RESULT: false

[2024-05-24 15:55:55,745] : [STEP_6] #####################################################
[2024-05-24 15:55:55,745] : [STEP_6]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 15:55:55,745] : [STEP_6] #####################################################

[2024-05-24 15:55:55,749] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S6][ Execution status : PASS] [Error Message : ]
[2024-05-24 15:55:55,750] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S6","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 15:55:55,764] : Execution result updated successfully

[2024-05-24 15:55:55,765] : [STEP_7] #####################################################
[2024-05-24 15:55:55,765] : [STEP_7] Description : Update webconfig telemetry URL
[2024-05-24 15:55:55,765] : [STEP_7] Expected Result : webconfig telemetry URL must be set
[2024-05-24 15:55:55,765] : [STEP_7] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 15:55:55,765] : [STEP_7] #####################################################

[2024-05-24 15:55:55,766] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 15:55:55,766] : [BEFORE]: http://webconfig.rdkcentral.com:9007/api/v1/device/{{ecmmac}}/config
[2024-05-24 15:55:55,766] : [AFTER]: http://webconfig.rdkcentral.com:9007/api/v1/device/E4:5F:01:F4:EE:2B/config
[2024-05-24 15:55:55,771] : Setting webpa Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry dataType 0 value http://webconfig.rdkcentral.com:9007/api/v1/device/E4:5F:01:F4:EE:2B/config
[2024-05-24 15:55:55,772] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:55:55,772] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:55:55,772] : COMPLETE URL BUILD FOR "SET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config
[2024-05-24 15:55:55,772] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:55:55,772] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:55:55,773] : REST CLIENT - Processing request
[2024-05-24 15:55:56,168] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config is - 200
[2024-05-24 15:55:56,168] : RESPONSE RECIEVED FOR WEBPA SET REQUEST: 200
[2024-05-24 15:55:56,169] : WEBPA RESPONSE : {"parameters":[{"name":"Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry","message":"Success"}],"statusCode":200}
[2024-05-24 15:55:56,169] : ENDING METHOD: setWebPaParameterValue : Success
[2024-05-24 15:55:56,169] : TR181 Response : {Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry=Success}
[2024-05-24 15:55:56,169] : Presence of parameter true in the command output : true
[2024-05-24 15:55:56,169] : >>>>>> ACTUAL OUTPUT: true
[2024-05-24 15:55:56,169] : >>>>>> EXPECTED OUTPUT: true
[2024-05-24 15:55:56,169] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 15:55:56,169] : >>>>>> VALIDATION STATUS: true
[2024-05-24 15:55:56,170] : >>>>>> INVERT RESULT: false

[2024-05-24 15:55:56,170] : [STEP_7] #####################################################
[2024-05-24 15:55:56,170] : [STEP_7]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 15:55:56,170] : [STEP_7] #####################################################

[2024-05-24 15:55:56,174] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S7][ Execution status : PASS] [Error Message : ]
[2024-05-24 15:55:56,175] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S7","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 15:55:56,189] : Execution result updated successfully

[2024-05-24 15:55:56,190] : [STEP_8] #####################################################
[2024-05-24 15:55:56,190] : [STEP_8] Description : Disable webconfig
[2024-05-24 15:55:56,190] : [STEP_8] Expected Result : Webconfig must be disabled
[2024-05-24 15:55:56,190] : [STEP_8] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 15:55:56,190] : [STEP_8] #####################################################

[2024-05-24 15:55:56,190] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 15:55:56,196] : Setting webpa Device.X_RDK_WebConfig.RfcEnable dataType 3 value false
[2024-05-24 15:55:56,196] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:55:56,196] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:55:56,196] : COMPLETE URL BUILD FOR "SET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config
[2024-05-24 15:55:56,196] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:55:56,196] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:55:56,197] : REST CLIENT - Processing request
[2024-05-24 15:55:56,606] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config is - 200
[2024-05-24 15:55:56,607] : RESPONSE RECIEVED FOR WEBPA SET REQUEST: 200
[2024-05-24 15:55:56,607] : WEBPA RESPONSE : {"parameters":[{"name":"Device.X_RDK_WebConfig.RfcEnable","message":"Success"}],"statusCode":200}
[2024-05-24 15:55:56,607] : ENDING METHOD: setWebPaParameterValue : Success
[2024-05-24 15:55:56,607] : TR181 Response : {Device.X_RDK_WebConfig.RfcEnable=Success}
[2024-05-24 15:55:56,607] : Presence of parameter true in the command output : true
[2024-05-24 15:55:56,607] : >>>>>> ACTUAL OUTPUT: true
[2024-05-24 15:55:56,607] : >>>>>> EXPECTED OUTPUT: true
[2024-05-24 15:55:56,607] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 15:55:56,607] : >>>>>> VALIDATION STATUS: true
[2024-05-24 15:55:56,607] : >>>>>> INVERT RESULT: false

[2024-05-24 15:55:56,608] : [STEP_8] #####################################################
[2024-05-24 15:55:56,608] : [STEP_8]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 15:55:56,608] : [STEP_8] #####################################################

[2024-05-24 15:55:56,612] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S8][ Execution status : PASS] [Error Message : ]
[2024-05-24 15:55:56,612] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S8","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 15:55:56,629] : Execution result updated successfully

[2024-05-24 15:55:56,629] : [STEP_9] #####################################################
[2024-05-24 15:55:56,630] : [STEP_9] Description : Stop the webconfig process
[2024-05-24 15:55:56,630] : [STEP_9] Expected Result : Webconfig process should be stopped
[2024-05-24 15:55:56,630] : [STEP_9] API Name : EXECUTE_COMMAND
[2024-05-24 15:55:56,630] : [STEP_9] #####################################################

[2024-05-24 15:55:56,630] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 15:55:56,648] : Entering executeCommandUsingSsh method
[2024-05-24 15:55:56,734] : Default SSH custom port is set
<=========================== RESPONSE =======================>

<=============================================================>

[2024-05-24 15:55:58,884] : Exiting executeCommandUsingSsh method
[2024-05-24 15:55:58,884] : >>>>>> ACTUAL OUTPUT:

[2024-05-24 15:55:58,884] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 15:55:58,884] : >>>>>> VALIDATION PERFORMED: NA
[2024-05-24 15:55:58,884] : >>>>>> VALIDATION STATUS: true
[2024-05-24 15:55:58,884] : >>>>>> INVERT RESULT: false

[2024-05-24 15:55:58,884] : [STEP_9] #####################################################
[2024-05-24 15:55:58,884] : [STEP_9]-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-05-24 15:55:58,884] : [STEP_9] #####################################################

[2024-05-24 15:55:58,888] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S9][ Execution status : PASS] [Error Message : ]
[2024-05-24 15:55:58,888] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S9","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 15:55:58,902] : Execution result updated successfully

[2024-05-24 15:55:58,902] : [STEP_10] #####################################################
[2024-05-24 15:55:58,902] : [STEP_10] Description : Reboot the device and wait for device to come up
[2024-05-24 15:55:58,902] : [STEP_10] Expected Result : Reboot must be successful and device must be accessible after reboot
[2024-05-24 15:55:58,902] : [STEP_10] API Name : REBOOT
[2024-05-24 15:55:58,902] : [STEP_10] #####################################################

[2024-05-24 15:55:58,902] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 15:55:58,903] : STARTING METHOD: rebootAndWaitForIpAccusition()
[2024-05-24 15:55:58,904] : SSH Host IP : 192.168.162.78
[2024-05-24 15:55:58,964] : Default SSH custom port is set
<=========================== RESPONSE =======================>
test_connection

<=============================================================>
[2024-05-24 15:56:01,101] : Closing SSH connection from DeviceIP: 192.168.162.78
[2024-05-24 15:56:01,101] : Exiting method isDeviceAccessible. Status - true
[2024-05-24 15:56:01,101] : Entering executeCommandUsingSsh method
[2024-05-24 15:56:01,164] : Default SSH custom port is set
<=========================== RESPONSE =======================>

<=============================================================>

[2024-05-24 15:56:03,821] : Exiting executeCommandUsingSsh method
[2024-05-24 15:56:03,822] : Reboot wait time: 300000
[2024-05-24 15:56:03,824] : 300000 - Maximum waiting time to recover IP as per configuration : 5 minutes
[2024-05-24 15:56:03,824] : Maximum waiting time to recover IP after adding buffer time : 7 minutes
[2024-05-24 15:56:03,824] : Waiting for :2minutes, initial wait time
[2024-05-24 15:58:33,825] : Wait for another 150seconds to verify IP acquisition using existing IP
[2024-05-24 15:58:33,827] : Current Value - 0 Max Value : 150
[2024-05-24 15:58:33,828] : SSH Host IP : 192.168.162.78
[2024-05-24 15:58:33,891] : Default SSH custom port is set
<=========================== RESPONSE =======================>
test_connection

<=============================================================>
[2024-05-24 15:58:36,062] : Closing SSH connection from DeviceIP: 192.168.162.78
[2024-05-24 15:58:36,062] : Exiting method isDeviceAccessible. Status - true
[2024-05-24 15:58:36,063] : Device is accessible using IP : IPv4:192.168.162.78 IPv6: null for Build : cc Mac Address : E4:5F:01:F4:EE:2B
[2024-05-24 15:58:36,063] : Completed execution of waitForEstbIpAcquisition() : Status : true. Time taken : 2 minutes
[2024-05-24 15:58:36,063] : SSH Host IP : 192.168.162.78
[2024-05-24 15:58:36,125] : Default SSH custom port is set
<=========================== RESPONSE =======================>
test_connection

<=============================================================>
[2024-05-24 15:58:38,278] : Closing SSH connection from DeviceIP: 192.168.162.78
[2024-05-24 15:58:38,279] : Exiting method isDeviceAccessible. Status - true
[2024-05-24 15:58:38,279] : ENDING METHOD: rebootAndWaitForIpAccusition()
[2024-05-24 15:58:38,279] : >>>>>> ACTUAL OUTPUT: true
[2024-05-24 15:58:38,279] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 15:58:38,279] : >>>>>> VALIDATION PERFORMED: NA
[2024-05-24 15:58:38,279] : >>>>>> VALIDATION STATUS: true
[2024-05-24 15:58:38,279] : >>>>>> INVERT RESULT: false

[2024-05-24 15:58:38,279] : [STEP_10] #####################################################
[2024-05-24 15:58:38,279] : [STEP_10]-[API Name: REBOOT]-[Execution Status: PASS]
[2024-05-24 15:58:38,279] : [STEP_10] #####################################################

[2024-05-24 15:58:38,282] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S10][ Execution status : PASS] [Error Message : ]
[2024-05-24 15:58:38,282] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S10","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 15:58:38,296] : Execution result updated successfully

[2024-05-24 15:58:38,296] : [STEP_11] #####################################################
[2024-05-24 15:58:38,296] : [STEP_11] Description : Validate Telemetry is enabled in device
[2024-05-24 15:58:38,296] : [STEP_11] Expected Result : Telemetry must be enabled
[2024-05-24 15:58:38,296] : [STEP_11] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 15:58:38,297] : [STEP_11] #####################################################

[2024-05-24 15:58:38,297] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 15:58:38,300] : TR181 Access Method: WEBPA
[2024-05-24 15:58:38,300] : getWebPaParamValue: Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.Enable
[2024-05-24 15:58:38,300] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:58:38,300] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:58:38,300] : COMPLETE URL BUILD FOR "GET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config?names=Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.Enable
[2024-05-24 15:58:38,300] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:58:38,300] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:58:38,300] : REST CLIENT - Processing request
[2024-05-24 15:58:38,698] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config?names=Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.Enable is - 200
[2024-05-24 15:58:38,699] : RESPONSE RECIEVED FOR WEBPA GET REQUEST: 200
[2024-05-24 15:58:38,699] : WEBPA RESPONSE : {"parameters":[{"name":"Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.Enable","value":"true","dataType":3,"parameterCount":1,"message":"Success"}],"statusCode":200}
[2024-05-24 15:58:38,699] : WebPa data type: BOOLEAN
[2024-05-24 15:58:38,699] : TR181 parametrs status code added 0
[2024-05-24 15:58:38,700] : TR181 Response : [tableName=null, index=null, name=Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.Enable, protocolSpecificParamName=null, value=true, datatype=BOOLEAN, statusCode=0]
[2024-05-24 15:58:38,700] : Presence of parameter true in the command output : true
[2024-05-24 15:58:38,700] : >>>>>> ACTUAL OUTPUT: true
[2024-05-24 15:58:38,700] : >>>>>> EXPECTED OUTPUT: true
[2024-05-24 15:58:38,700] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 15:58:38,700] : >>>>>> VALIDATION STATUS: true
[2024-05-24 15:58:38,700] : >>>>>> INVERT RESULT: false

[2024-05-24 15:58:38,700] : [STEP_11] #####################################################
[2024-05-24 15:58:38,700] : [STEP_11]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 15:58:38,700] : [STEP_11] #####################################################

[2024-05-24 15:58:38,702] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S11][ Execution status : PASS] [Error Message : ]
[2024-05-24 15:58:38,703] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S11","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 15:58:38,715] : Execution result updated successfully

[2024-05-24 15:58:38,715] : [STEP_12] #####################################################
[2024-05-24 15:58:38,715] : [STEP_12] Description : Validate Telemetry version in device
[2024-05-24 15:58:38,715] : [STEP_12] Expected Result : Telemetry version should be 2.0.1
[2024-05-24 15:58:38,715] : [STEP_12] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 15:58:38,715] : [STEP_12] #####################################################

[2024-05-24 15:58:38,715] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 15:58:38,718] : TR181 Access Method: WEBPA
[2024-05-24 15:58:38,718] : getWebPaParamValue: Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.Version
[2024-05-24 15:58:38,719] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:58:38,719] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:58:38,719] : COMPLETE URL BUILD FOR "GET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config?names=Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.Version
[2024-05-24 15:58:38,719] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:58:38,719] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:58:38,719] : REST CLIENT - Processing request
[2024-05-24 15:58:39,110] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config?names=Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.Version is - 200
[2024-05-24 15:58:39,110] : RESPONSE RECIEVED FOR WEBPA GET REQUEST: 200
[2024-05-24 15:58:39,110] : WEBPA RESPONSE : {"parameters":[{"name":"Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.Version","value":"2.0.1","dataType":0,"parameterCount":1,"message":"Success"}],"statusCode":200}
[2024-05-24 15:58:39,111] : WebPa data type: STRING
[2024-05-24 15:58:39,111] : TR181 parametrs status code added 0
[2024-05-24 15:58:39,111] : TR181 Response : [tableName=null, index=null, name=Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.Version, protocolSpecificParamName=null, value=2.0.1, datatype=STRING, statusCode=0]
[2024-05-24 15:58:39,111] : Presence of parameter 2.0.1 in the command output : true
[2024-05-24 15:58:39,111] : >>>>>> ACTUAL OUTPUT: 2.0.1
[2024-05-24 15:58:39,111] : >>>>>> EXPECTED OUTPUT: 2.0.1
[2024-05-24 15:58:39,111] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 15:58:39,111] : >>>>>> VALIDATION STATUS: true
[2024-05-24 15:58:39,111] : >>>>>> INVERT RESULT: false

[2024-05-24 15:58:39,111] : [STEP_12] #####################################################
[2024-05-24 15:58:39,111] : [STEP_12]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 15:58:39,111] : [STEP_12] #####################################################

[2024-05-24 15:58:39,114] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S12][ Execution status : PASS] [Error Message : ]
[2024-05-24 15:58:39,114] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S12","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 15:58:39,126] : Execution result updated successfully

[2024-05-24 15:58:39,126] : [STEP_13] #####################################################
[2024-05-24 15:58:39,126] : [STEP_13] Description : Validate Telemetry Url to have xconf.rdkcentral.com T2 URL
[2024-05-24 15:58:39,126] : [STEP_13] Expected Result : Telemetry URL is must be set to telemetry xconf.rdkcentral.com T2 URL
[2024-05-24 15:58:39,126] : [STEP_13] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 15:58:39,126] : [STEP_13] #####################################################

[2024-05-24 15:58:39,127] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 15:58:39,130] : TR181 Access Method: WEBPA
[2024-05-24 15:58:39,130] : getWebPaParamValue: Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.ConfigURL
[2024-05-24 15:58:39,130] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:58:39,130] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:58:39,130] : COMPLETE URL BUILD FOR "GET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config?names=Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.ConfigURL
[2024-05-24 15:58:39,130] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:58:39,130] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:58:39,130] : REST CLIENT - Processing request
[2024-05-24 15:58:39,519] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config?names=Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.ConfigURL is - 200
[2024-05-24 15:58:39,519] : RESPONSE RECIEVED FOR WEBPA GET REQUEST: 200
[2024-05-24 15:58:39,519] : WEBPA RESPONSE : {"parameters":[{"name":"Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.ConfigURL","value":"https://xconf.rdkcentral.com:19092/loguploader/getT2Settings","dataType":0,"parameterCount":1,"message":"Success"}],"statusCode":200}
[2024-05-24 15:58:39,519] : WebPa data type: STRING
[2024-05-24 15:58:39,520] : TR181 parametrs status code added 0
[2024-05-24 15:58:39,520] : TR181 Response : [tableName=null, index=null, name=Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.ConfigURL, protocolSpecificParamName=null, value=https://xconf.rdkcentral.com:19092/loguploader/getT2Settings, datatype=STRING, statusCode=0]
[2024-05-24 15:58:39,520] : Presence of parameter https://xconf.rdkcentral.com:19092/loguploader/getT2Settings in the command output : true
[2024-05-24 15:58:39,520] : >>>>>> ACTUAL OUTPUT: https://xconf.rdkcentral.com:19092/loguploader/getT2Settings
[2024-05-24 15:58:39,520] : >>>>>> EXPECTED OUTPUT: https://xconf.rdkcentral.com:19092/loguploader/getT2Settings
[2024-05-24 15:58:39,520] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 15:58:39,520] : >>>>>> VALIDATION STATUS: true
[2024-05-24 15:58:39,520] : >>>>>> INVERT RESULT: false

[2024-05-24 15:58:39,520] : [STEP_13] #####################################################
[2024-05-24 15:58:39,520] : [STEP_13]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 15:58:39,520] : [STEP_13] #####################################################

[2024-05-24 15:58:39,523] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S13][ Execution status : PASS] [Error Message : ]
[2024-05-24 15:58:39,523] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S13","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 15:58:39,537] : Execution result updated successfully

[2024-05-24 15:58:39,538] : [STEP_14] #####################################################
[2024-05-24 15:58:39,538] : [STEP_14] Description : Verify telemetry process is up and running
[2024-05-24 15:58:39,538] : [STEP_14] Expected Result : Telemetry process must be up and running
[2024-05-24 15:58:39,538] : [STEP_14] API Name : GET_PID_OF_PROCESS
[2024-05-24 15:58:39,538] : [STEP_14] #####################################################

[2024-05-24 15:58:39,538] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 15:58:39,547] : Entering getProcessPid method
[2024-05-24 15:58:39,548] : Entering executeCommandUsingSsh method
[2024-05-24 15:58:39,610] : Default SSH custom port is set
<=========================== RESPONSE =======================>
2520

<=============================================================>


[2024-05-24 15:58:41,745] : Exiting executeCommandUsingSsh method
[2024-05-24 15:58:41,745] : PID of 'telemetry2_0' is: 2520
[2024-05-24 15:58:41,745] : Exiting getProcessPid method
[2024-05-24 15:58:41,745] : >>>>>> ACTUAL OUTPUT: 2520
[2024-05-24 15:58:41,745] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 15:58:41,745] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-05-24 15:58:41,745] : >>>>>> VALIDATION STATUS: true
[2024-05-24 15:58:41,746] : >>>>>> INVERT RESULT: false

[2024-05-24 15:58:41,746] : [STEP_14] #####################################################
[2024-05-24 15:58:41,746] : [STEP_14]-[API Name: GET_PID_OF_PROCESS]-[Execution Status: PASS]
[2024-05-24 15:58:41,746] : [STEP_14] #####################################################

[2024-05-24 15:58:41,748] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S14][ Execution status : PASS] [Error Message : ]
[2024-05-24 15:58:41,749] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S14","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 15:58:41,763] : Execution result updated successfully

[2024-05-24 15:58:41,763] : [STEP_15] #####################################################
[2024-05-24 15:58:41,763] : [STEP_15] Description : Enable webconfig - restart webconfig process
[2024-05-24 15:58:41,763] : [STEP_15] Expected Result : Webconfig process should active
[2024-05-24 15:58:41,763] : [STEP_15] API Name : EXECUTE_COMMAND
[2024-05-24 15:58:41,763] : [STEP_15] #####################################################

[2024-05-24 15:58:41,764] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 15:58:41,772] : Entering executeCommandUsingSsh method
[2024-05-24 15:58:41,833] : Default SSH custom port is set
<=========================== RESPONSE =======================>

<=============================================================>

[2024-05-24 15:58:43,984] : Exiting executeCommandUsingSsh method
[2024-05-24 15:58:43,984] : >>>>>> ACTUAL OUTPUT:

[2024-05-24 15:58:43,985] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 15:58:43,985] : >>>>>> VALIDATION PERFORMED: NA
[2024-05-24 15:58:43,985] : >>>>>> VALIDATION STATUS: true
[2024-05-24 15:58:43,985] : >>>>>> INVERT RESULT: false

[2024-05-24 15:58:43,985] : [STEP_15] #####################################################
[2024-05-24 15:58:43,985] : [STEP_15]-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-05-24 15:58:43,985] : [STEP_15] #####################################################

[2024-05-24 15:58:43,989] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S15][ Execution status : PASS] [Error Message : ]
[2024-05-24 15:58:43,989] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S15","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 15:58:44,005] : Execution result updated successfully

[2024-05-24 15:58:44,005] : [STEP_16] #####################################################
[2024-05-24 15:58:44,005] : [STEP_16] Description : Enable webconfig - set Device.X_RDK_WebConfig.RfcEnable to true
[2024-05-24 15:58:44,005] : [STEP_16] Expected Result : Device.X_RDK_WebConfig.RfcEnable should set to true
[2024-05-24 15:58:44,005] : [STEP_16] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 15:58:44,006] : [STEP_16] #####################################################

[2024-05-24 15:58:44,006] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 15:58:44,010] : Setting webpa Device.X_RDK_WebConfig.RfcEnable dataType 3 value true
[2024-05-24 15:58:44,010] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:58:44,010] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:58:44,011] : COMPLETE URL BUILD FOR "SET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config
[2024-05-24 15:58:44,011] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:58:44,011] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:58:44,011] : REST CLIENT - Processing request
[2024-05-24 15:58:44,406] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config is - 200
[2024-05-24 15:58:44,406] : RESPONSE RECIEVED FOR WEBPA SET REQUEST: 200
[2024-05-24 15:58:44,406] : WEBPA RESPONSE : {"parameters":[{"name":"Device.X_RDK_WebConfig.RfcEnable","message":"Success"}],"statusCode":200}
[2024-05-24 15:58:44,407] : ENDING METHOD: setWebPaParameterValue : Success
[2024-05-24 15:58:44,407] : TR181 Response : {Device.X_RDK_WebConfig.RfcEnable=Success}
[2024-05-24 15:58:44,407] : Presence of parameter true in the command output : true
[2024-05-24 15:58:44,407] : >>>>>> ACTUAL OUTPUT: true
[2024-05-24 15:58:44,407] : >>>>>> EXPECTED OUTPUT: true
[2024-05-24 15:58:44,407] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 15:58:44,407] : >>>>>> VALIDATION STATUS: true
[2024-05-24 15:58:44,407] : >>>>>> INVERT RESULT: false

[2024-05-24 15:58:44,407] : [STEP_16] #####################################################
[2024-05-24 15:58:44,407] : [STEP_16]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 15:58:44,407] : [STEP_16] #####################################################

[2024-05-24 15:58:44,409] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S16][ Execution status : PASS] [Error Message : ]
[2024-05-24 15:58:44,410] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S16","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 15:58:44,424] : Execution result updated successfully

[2024-05-24 15:58:44,425] : [STEP_17] #####################################################
[2024-05-24 15:58:44,425] : [STEP_17] Description : Validate If supplementary doc information is present in webconfig.properties
[2024-05-24 15:58:44,425] : [STEP_17] Expected Result : properties file must contain WEBCONFIG_SUPPLEMENTARY_DOCS=telemetry
[2024-05-24 15:58:44,425] : [STEP_17] API Name : SEARCH_IN_LOG
[2024-05-24 15:58:44,425] : [STEP_17] #####################################################

[2024-05-24 15:58:44,426] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 15:58:44,435] : COMMAND TO BE EXECUTED: grep -i WEBCONFIG_SUPPLEMENTARY_DOCS=telemetry /etc/webconfig.properties
[2024-05-24 15:59:14,436] : Entering executeCommandUsingSsh method
[2024-05-24 15:59:14,498] : Default SSH custom port is set
<=========================== RESPONSE =======================>
WEBCONFIG_SUPPLEMENTARY_DOCS=telemetry

<=============================================================>


[2024-05-24 15:59:16,624] : Exiting executeCommandUsingSsh method
[2024-05-24 15:59:16,625] : SEARCH RESPONSE FOR - WEBCONFIG_SUPPLEMENTARY_DOCS=telemetry IN THE LOG FILE - /etc/webconfig.properties IS : WEBCONFIG_SUPPLEMENTARY_DOCS=telemetry
[2024-05-24 15:59:16,625] : >>>>>> ACTUAL OUTPUT: WEBCONFIG_SUPPLEMENTARY_DOCS=telemetry
[2024-05-24 15:59:16,625] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 15:59:16,625] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-05-24 15:59:16,625] : >>>>>> VALIDATION STATUS: true
[2024-05-24 15:59:16,625] : >>>>>> INVERT RESULT: false

[2024-05-24 15:59:16,625] : [STEP_17] #####################################################
[2024-05-24 15:59:16,625] : [STEP_17]-[API Name: SEARCH_IN_LOG]-[Execution Status: PASS]
[2024-05-24 15:59:16,625] : [STEP_17] #####################################################

[2024-05-24 15:59:16,630] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S17][ Execution status : PASS] [Error Message : ]
[2024-05-24 15:59:16,630] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S17","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 15:59:16,656] : Execution result updated successfully

[2024-05-24 15:59:16,656] : [STEP_18] #####################################################
[2024-05-24 15:59:16,656] : [STEP_18] Description : Validate if X-System-SupplementaryService-Sync: telemetry present in webconfig.log
[2024-05-24 15:59:16,656] : [STEP_18] Expected Result : Value X-System-SupplementaryService-Sync: telemetry must be present in webconfig.log
[2024-05-24 15:59:16,656] : [STEP_18] API Name : SEARCH_IN_LOG
[2024-05-24 15:59:16,656] : [STEP_18] #####################################################

[2024-05-24 15:59:16,656] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 15:59:16,664] : COMMAND TO BE EXECUTED: grep -i "X-System-SupplementaryService-Sync: telemetry" /rdklogs/logs/WEBCONFIGlog.txt.0
[2024-05-24 15:59:46,665] : Entering executeCommandUsingSsh method
[2024-05-24 15:59:46,728] : Default SSH custom port is set
<=========================== RESPONSE =======================>
240524-15:59:24.605132 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: supplementaryDocs_header formed X-System-SupplementaryService-Sync: telemetry

<=============================================================>


[2024-05-24 15:59:48,870] : Exiting executeCommandUsingSsh method
[2024-05-24 15:59:48,870] : SEARCH RESPONSE FOR - X-System-SupplementaryService-Sync: telemetry IN THE LOG FILE - /rdklogs/logs/WEBCONFIGlog.txt.0 IS : 240524-15:59:24.605132 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: supplementaryDocs_header formed X-System-SupplementaryService-Sync: telemetry
[2024-05-24 15:59:48,870] : >>>>>> ACTUAL OUTPUT: 240524-15:59:24.605132 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: supplementaryDocs_header formed X-System-SupplementaryService-Sync: telemetry
[2024-05-24 15:59:48,870] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 15:59:48,870] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-05-24 15:59:48,870] : >>>>>> VALIDATION STATUS: true
[2024-05-24 15:59:48,870] : >>>>>> INVERT RESULT: false

[2024-05-24 15:59:48,870] : [STEP_18] #####################################################
[2024-05-24 15:59:48,870] : [STEP_18]-[API Name: SEARCH_IN_LOG]-[Execution Status: PASS]
[2024-05-24 15:59:48,871] : [STEP_18] #####################################################

[2024-05-24 15:59:48,873] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S18][ Execution status : PASS] [Error Message : ]
[2024-05-24 15:59:48,874] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S18","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 15:59:48,888] : Execution result updated successfully

[2024-05-24 15:59:48,888] : [STEP_19] #####################################################
[2024-05-24 15:59:48,888] : [STEP_19] Description : Validate tr181 value for PartnerID
[2024-05-24 15:59:48,888] : [STEP_19] Expected Result : Value Partner ID must be obtained
[2024-05-24 15:59:48,888] : [STEP_19] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 15:59:48,888] : [STEP_19] #####################################################

[2024-05-24 15:59:48,889] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 15:59:48,891] : TR181 Access Method: WEBPA
[2024-05-24 15:59:48,891] : getWebPaParamValue: Device.DeviceInfo.X_RDKCENTRAL-COM_Syndication.PartnerId
[2024-05-24 15:59:48,892] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:59:48,892] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:59:48,892] : COMPLETE URL BUILD FOR "GET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config?names=Device.DeviceInfo.X_RDKCENTRAL-COM_Syndication.PartnerId
[2024-05-24 15:59:48,892] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 15:59:48,892] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 15:59:48,892] : REST CLIENT - Processing request
[2024-05-24 15:59:49,288] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config?names=Device.DeviceInfo.X_RDKCENTRAL-COM_Syndication.PartnerId is - 200
[2024-05-24 15:59:49,289] : RESPONSE RECIEVED FOR WEBPA GET REQUEST: 200
[2024-05-24 15:59:49,289] : WEBPA RESPONSE : {"parameters":[{"name":"Device.DeviceInfo.X_RDKCENTRAL-COM_Syndication.PartnerId","value":"RDKM","dataType":0,"parameterCount":1,"message":"Success"}],"statusCode":200}
[2024-05-24 15:59:49,290] : WebPa data type: STRING
[2024-05-24 15:59:49,290] : TR181 parametrs status code added 0
[2024-05-24 15:59:49,290] : TR181 Response : [tableName=null, index=null, name=Device.DeviceInfo.X_RDKCENTRAL-COM_Syndication.PartnerId, protocolSpecificParamName=null, value=RDKM, datatype=STRING, statusCode=0]
[2024-05-24 15:59:49,290] : >>>>>> ACTUAL OUTPUT: RDKM
[2024-05-24 15:59:49,290] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 15:59:49,290] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-05-24 15:59:49,290] : >>>>>> VALIDATION STATUS: true
[2024-05-24 15:59:49,290] : >>>>>> INVERT RESULT: false

[2024-05-24 15:59:49,290] : [STEP_19] #####################################################
[2024-05-24 15:59:49,290] : [STEP_19]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 15:59:49,290] : [STEP_19] #####################################################

[2024-05-24 15:59:49,294] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S19][ Execution status : PASS] [Error Message : ]
[2024-05-24 15:59:49,295] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S19","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 15:59:49,307] : Execution result updated successfully

[2024-05-24 15:59:49,308] : [STEP_20] #####################################################
[2024-05-24 15:59:49,308] : [STEP_20] Description : Validate header X-System-PartnerID present in webconfig.log and check if it matches with tr181 value
[2024-05-24 15:59:49,308] : [STEP_20] Expected Result : Value X-System-PartnerID : must be present in webconfig.log
[2024-05-24 15:59:49,308] : [STEP_20] API Name : SEARCH_IN_LOG
[2024-05-24 15:59:49,308] : [STEP_20] #####################################################

[2024-05-24 15:59:49,308] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 15:59:49,313] : COMMAND TO BE EXECUTED: grep -i X-System-PartnerID: /rdklogs/logs/WEBCONFIGlog.txt.0
[2024-05-24 16:00:19,313] : Entering executeCommandUsingSsh method
[2024-05-24 16:00:19,376] : Default SSH custom port is set
<=========================== RESPONSE =======================>
240524-15:59:24.608301 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: PartnerID_header formed X-System-PartnerID: RDKM

<=============================================================>


[2024-05-24 16:00:21,520] : Exiting executeCommandUsingSsh method
[2024-05-24 16:00:21,520] : SEARCH RESPONSE FOR - X-System-PartnerID: IN THE LOG FILE - /rdklogs/logs/WEBCONFIGlog.txt.0 IS : 240524-15:59:24.608301 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: PartnerID_header formed X-System-PartnerID: RDKM
[2024-05-24 16:00:21,520] : >>>>>> ACTUAL OUTPUT: 240524-15:59:24.608301 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: PartnerID_header formed X-System-PartnerID: RDKM
[2024-05-24 16:00:21,520] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 16:00:21,520] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-05-24 16:00:21,521] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:00:21,521] : >>>>>> INVERT RESULT: false

[2024-05-24 16:00:21,521] : [STEP_20] #####################################################
[2024-05-24 16:00:21,521] : [STEP_20]-[API Name: SEARCH_IN_LOG]-[Execution Status: PASS]
[2024-05-24 16:00:21,521] : [STEP_20] #####################################################

[2024-05-24 16:00:21,526] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S20][ Execution status : PASS] [Error Message : ]
[2024-05-24 16:00:21,526] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S20","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 16:00:21,542] : Execution result updated successfully

[2024-05-24 16:00:21,542] : [STEP_21] #####################################################
[2024-05-24 16:00:21,542] : [STEP_21] Description : Validate force sync for telemetry
[2024-05-24 16:00:21,542] : [STEP_21] Expected Result : Force sync must be successful
[2024-05-24 16:00:21,542] : [STEP_21] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 16:00:21,542] : [STEP_21] #####################################################

[2024-05-24 16:00:21,543] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:00:21,545] : Setting webpa Device.X_RDK_WebConfig.ForceSync dataType 0 value telemetry
[2024-05-24 16:00:21,546] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 16:00:21,546] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 16:00:21,546] : COMPLETE URL BUILD FOR "SET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config
[2024-05-24 16:00:21,546] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 16:00:21,546] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 16:00:21,547] : REST CLIENT - Processing request
[2024-05-24 16:00:21,939] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config is - 200
[2024-05-24 16:00:21,940] : RESPONSE RECIEVED FOR WEBPA SET REQUEST: 200
[2024-05-24 16:00:21,940] : WEBPA RESPONSE : {"parameters":[{"name":"Device.X_RDK_WebConfig.ForceSync","message":"Success"}],"statusCode":200}
[2024-05-24 16:00:21,940] : ENDING METHOD: setWebPaParameterValue : Success
[2024-05-24 16:00:21,940] : TR181 Response : {Device.X_RDK_WebConfig.ForceSync=Success}
[2024-05-24 16:00:21,940] : Presence of parameter true in the command output : true
[2024-05-24 16:00:21,940] : >>>>>> ACTUAL OUTPUT: true
[2024-05-24 16:00:21,940] : >>>>>> EXPECTED OUTPUT: true
[2024-05-24 16:00:21,940] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 16:00:21,941] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:00:21,941] : >>>>>> INVERT RESULT: false

[2024-05-24 16:00:21,941] : [STEP_21] #####################################################
[2024-05-24 16:00:21,941] : [STEP_21]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:00:21,941] : [STEP_21] #####################################################

[2024-05-24 16:00:21,944] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S21][ Execution status : PASS] [Error Message : ]
[2024-05-24 16:00:21,945] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S21","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 16:00:21,960] : Execution result updated successfully

[2024-05-24 16:00:21,960] : [STEP_22] #####################################################
[2024-05-24 16:00:21,960] : [STEP_22] Description : Validate force sync for telemetry with webconfig logs
[2024-05-24 16:00:21,960] : [STEP_22] Expected Result : Value Received supplementary poke request for telemetry must be present in webconfig.log
[2024-05-24 16:00:21,960] : [STEP_22] API Name : SEARCH_IN_LOG
[2024-05-24 16:00:21,960] : [STEP_22] #####################################################

[2024-05-24 16:00:21,961] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:00:21,968] : COMMAND TO BE EXECUTED: grep -i "Received supplementary poke request for telemetry" /rdklogs/logs/WEBCONFIGlog.txt.0
[2024-05-24 16:00:51,969] : Entering executeCommandUsingSsh method
[2024-05-24 16:00:52,035] : Default SSH custom port is set
<=========================== RESPONSE =======================>
240524-16:00:21.786476 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: Received supplementary poke request for telemetry

<=============================================================>


[2024-05-24 16:00:54,166] : Exiting executeCommandUsingSsh method
[2024-05-24 16:00:54,166] : SEARCH RESPONSE FOR - Received supplementary poke request for telemetry IN THE LOG FILE - /rdklogs/logs/WEBCONFIGlog.txt.0 IS : 240524-16:00:21.786476 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: Received supplementary poke request for telemetry
[2024-05-24 16:00:54,166] : >>>>>> ACTUAL OUTPUT: 240524-16:00:21.786476 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: Received supplementary poke request for telemetry
[2024-05-24 16:00:54,166] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 16:00:54,166] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-05-24 16:00:54,166] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:00:54,166] : >>>>>> INVERT RESULT: false

[2024-05-24 16:00:54,166] : [STEP_22] #####################################################
[2024-05-24 16:00:54,166] : [STEP_22]-[API Name: SEARCH_IN_LOG]-[Execution Status: PASS]
[2024-05-24 16:00:54,166] : [STEP_22] #####################################################

[2024-05-24 16:00:54,169] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S22][ Execution status : PASS] [Error Message : ]
[2024-05-24 16:00:54,169] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S22","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 16:00:54,182] : Execution result updated successfully

[2024-05-24 16:00:54,183] : [STEP_23] #####################################################
[2024-05-24 16:00:54,183] : [STEP_23] Description : Validate force sync for telemetry with webconfig logs
[2024-05-24 16:00:54,183] : [STEP_23] Expected Result : Value doc telemetry is updated to version must be present in webconfig.log
[2024-05-24 16:00:54,183] : [STEP_23] API Name : SEARCH_IN_LOG
[2024-05-24 16:00:54,183] : [STEP_23] #####################################################

[2024-05-24 16:00:54,183] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:00:54,188] : COMMAND TO BE EXECUTED: grep -i "doc telemetry is updated to version" /rdklogs/logs/WEBCONFIGlog.txt.0
[2024-05-24 16:01:24,189] : Entering executeCommandUsingSsh method
[2024-05-24 16:01:24,253] : Default SSH custom port is set
<=========================== RESPONSE =======================>
240524-15:59:25.287725 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: doc telemetry is updated to version 1844306334 status pending error_details none error_code 0 trans_id 0 temp->retry_count 0
240524-15:59:25.288269 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: doc telemetry is updated to version 1844306334 status pending error_details none error_code 0 trans_id 46509 temp->retry_count 0
240524-15:59:25.312445 [mod=WEBCONFIG, lvl=INFO] [tid=6151] WEBCONFIG: doc telemetry is updated to version 1844306334 status success error_details none error_code 0 trans_id 46509 temp->retry_count 0
240524-16:00:22.387864 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: doc telemetry is updated to version 1124799245 status pending error_details none error_code 0 trans_id 0 temp->retry_count 0
240524-16:00:22.388424 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: doc telemetry is updated to version 1124799245 status pending error_details none error_code 0 trans_id 44169 temp->retry_count 0
240524-16:00:22.412409 [mod=WEBCONFIG, lvl=INFO] [tid=6151] WEBCONFIG: doc telemetry is updated to version 1124799245 status success error_details none error_code 0 trans_id 44169 temp->retry_count 0

<=============================================================>
240524-15:59:25.288269 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: doc telemetry is updated to version 1844306334 status pending error_details none error_code 0 trans_id 46509 temp->retry_count 0
240524-15:59:25.312445 [mod=WEBCONFIG, lvl=INFO] [tid=6151] WEBCONFIG: doc telemetry is updated to version 1844306334 status success error_details none error_code 0 trans_id 46509 temp->retry_count 0
240524-16:00:22.387864 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: doc telemetry is updated to version 1124799245 status pending error_details none error_code 0 trans_id 0 temp->retry_count 0
240524-16:00:22.388424 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: doc telemetry is updated to version 1124799245 status pending error_details none error_code 0 trans_id 44169 temp->retry_count 0
240524-16:00:22.412409 [mod=WEBCONFIG, lvl=INFO] [tid=6151] WEBCONFIG: doc telemetry is updated to version 1124799245 status success error_details none error_code 0 trans_id 44169 temp->retry_count 0


[2024-05-24 16:01:26,398] : Exiting executeCommandUsingSsh method
[2024-05-24 16:01:26,398] : SEARCH RESPONSE FOR - doc telemetry is updated to version IN THE LOG FILE - /rdklogs/logs/WEBCONFIGlog.txt.0 IS : 240524-15:59:25.287725 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: doc telemetry is updated to version 1844306334 status pending error_details none error_code 0 trans_id 0 temp->retry_count 0
240524-15:59:25.288269 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: doc telemetry is updated to version 1844306334 status pending error_details none error_code 0 trans_id 46509 temp->retry_count 0
240524-15:59:25.312445 [mod=WEBCONFIG, lvl=INFO] [tid=6151] WEBCONFIG: doc telemetry is updated to version 1844306334 status success error_details none error_code 0 trans_id 46509 temp->retry_count 0
240524-16:00:22.387864 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: doc telemetry is updated to version 1124799245 status pending error_details none error_code 0 trans_id 0 temp->retry_count 0
240524-16:00:22.388424 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: doc telemetry is updated to version 1124799245 status pending error_details none error_code 0 trans_id 44169 temp->retry_count 0
240524-16:00:22.412409 [mod=WEBCONFIG, lvl=INFO] [tid=6151] WEBCONFIG: doc telemetry is updated to version 1124799245 status success error_details none error_code 0 trans_id 44169 temp->retry_count 0
[2024-05-24 16:01:26,398] : >>>>>> ACTUAL OUTPUT: 240524-15:59:25.287725 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: doc telemetry is updated to version 1844306334 status pending error_details none error_code 0 trans_id 0 temp->retry_count 0
240524-15:59:25.288269 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: doc telemetry is updated to version 1844306334 status pending error_details none error_code 0 trans_id 46509 temp->retry_count 0
240524-15:59:25.312445 [mod=WEBCONFIG, lvl=INFO] [tid=6151] WEBCONFIG: doc telemetry is updated to version 1844306334 status success error_details none error_code 0 trans_id 46509 temp->retry_count 0
240524-16:00:22.387864 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: doc telemetry is updated to version 1124799245 status pending error_details none error_code 0 trans_id 0 temp->retry_count 0
240524-16:00:22.388424 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: doc telemetry is updated to version 1124799245 status pending error_details none error_code 0 trans_id 44169 temp->retry_count 0
240524-16:00:22.412409 [mod=WEBCONFIG, lvl=INFO] [tid=6151] WEBCONFIG: doc telemetry is updated to version 1124799245 status success error_details none error_code 0 trans_id 44169 temp->retry_count 0
[2024-05-24 16:01:26,398] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 16:01:26,398] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-05-24 16:01:26,398] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:01:26,398] : >>>>>> INVERT RESULT: false

[2024-05-24 16:01:26,398] : [STEP_23] #####################################################
[2024-05-24 16:01:26,398] : [STEP_23]-[API Name: SEARCH_IN_LOG]-[Execution Status: PASS]
[2024-05-24 16:01:26,398] : [STEP_23] #####################################################

[2024-05-24 16:01:26,401] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S23][ Execution status : PASS] [Error Message : ]
[2024-05-24 16:01:26,401] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S23","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 16:01:26,415] : Execution result updated successfully

[2024-05-24 16:01:26,415] : [STEP_24] #####################################################
[2024-05-24 16:01:26,415] : [STEP_24] Description : Validate force sync for primary
[2024-05-24 16:01:26,415] : [STEP_24] Expected Result : Primary poke must be successful
[2024-05-24 16:01:26,415] : [STEP_24] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 16:01:26,415] : [STEP_24] #####################################################

[2024-05-24 16:01:26,416] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:01:26,419] : Setting webpa Device.X_RDK_WebConfig.ForceSync dataType 0 value Primary
[2024-05-24 16:01:26,419] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 16:01:26,419] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 16:01:26,419] : COMPLETE URL BUILD FOR "SET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config
[2024-05-24 16:01:26,419] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 16:01:26,419] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 16:01:26,420] : REST CLIENT - Processing request
[2024-05-24 16:01:26,826] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config is - 200
[2024-05-24 16:01:26,826] : RESPONSE RECIEVED FOR WEBPA SET REQUEST: 200
[2024-05-24 16:01:26,827] : WEBPA RESPONSE : {"parameters":[{"name":"Device.X_RDK_WebConfig.ForceSync","message":"Success"}],"statusCode":200}
[2024-05-24 16:01:26,827] : ENDING METHOD: setWebPaParameterValue : Success
[2024-05-24 16:01:26,827] : TR181 Response : {Device.X_RDK_WebConfig.ForceSync=Success}
[2024-05-24 16:01:26,827] : Presence of parameter true in the command output : true
[2024-05-24 16:01:26,827] : >>>>>> ACTUAL OUTPUT: true
[2024-05-24 16:01:26,827] : >>>>>> EXPECTED OUTPUT: true
[2024-05-24 16:01:26,827] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 16:01:26,827] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:01:26,827] : >>>>>> INVERT RESULT: false

[2024-05-24 16:01:26,827] : [STEP_24] #####################################################
[2024-05-24 16:01:26,827] : [STEP_24]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:01:26,828] : [STEP_24] #####################################################

[2024-05-24 16:01:26,831] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S24][ Execution status : PASS] [Error Message : ]
[2024-05-24 16:01:26,832] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S24","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 16:01:26,845] : Execution result updated successfully

[2024-05-24 16:01:26,846] : [STEP_25] #####################################################
[2024-05-24 16:01:26,846] : [STEP_25] Description : Validate force sync for primary with primarylogs
[2024-05-24 16:01:26,846] : [STEP_25] Expected Result : Primary poke must be successful
[2024-05-24 16:01:26,846] : [STEP_25] API Name : SEARCH_IN_LOG
[2024-05-24 16:01:26,846] : [STEP_25] #####################################################

[2024-05-24 16:01:26,846] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:01:26,854] : COMMAND TO BE EXECUTED: grep -i "Webconfig root ConfigURL is" /rdklogs/logs/WEBCONFIGlog.txt.0
[2024-05-24 16:01:56,854] : Entering executeCommandUsingSsh method
[2024-05-24 16:01:56,915] : Default SSH custom port is set
<=========================== RESPONSE =======================>
240524-15:59:24.618179 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: Webconfig root ConfigURL is http://webconfig.rdkcentral.com:9007/api/v1/device/E4:5F:01:F4:EE:2B/config
240524-16:00:21.850973 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: Webconfig root ConfigURL is http://webconfig.rdkcentral.com:9007/api/v1/device/E4:5F:01:F4:EE:2B/config

<=============================================================>
240524-16:00:21.850973 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: Webconfig root ConfigURL is http://webconfig.rdkcentral.com:9007/api/v1/device/E4:5F:01:F4:EE:2B/config


[2024-05-24 16:01:59,046] : Exiting executeCommandUsingSsh method
[2024-05-24 16:01:59,046] : SEARCH RESPONSE FOR - Webconfig root ConfigURL is IN THE LOG FILE - /rdklogs/logs/WEBCONFIGlog.txt.0 IS : 240524-15:59:24.618179 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: Webconfig root ConfigURL is http://webconfig.rdkcentral.com:9007/api/v1/device/E4:5F:01:F4:EE:2B/config
240524-16:00:21.850973 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: Webconfig root ConfigURL is http://webconfig.rdkcentral.com:9007/api/v1/device/E4:5F:01:F4:EE:2B/config
[2024-05-24 16:01:59,047] : >>>>>> ACTUAL OUTPUT: 240524-15:59:24.618179 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: Webconfig root ConfigURL is http://webconfig.rdkcentral.com:9007/api/v1/device/E4:5F:01:F4:EE:2B/config
240524-16:00:21.850973 [mod=WEBCONFIG, lvl=INFO] [tid=6146] WEBCONFIG: Webconfig root ConfigURL is http://webconfig.rdkcentral.com:9007/api/v1/device/E4:5F:01:F4:EE:2B/config
[2024-05-24 16:01:59,047] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 16:01:59,047] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-05-24 16:01:59,047] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:01:59,047] : >>>>>> INVERT RESULT: false

[2024-05-24 16:01:59,047] : [STEP_25] #####################################################
[2024-05-24 16:01:59,047] : [STEP_25]-[API Name: SEARCH_IN_LOG]-[Execution Status: PASS]
[2024-05-24 16:01:59,047] : [STEP_25] #####################################################

[2024-05-24 16:01:59,051] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S25][ Execution status : PASS] [Error Message : ]
[2024-05-24 16:01:59,051] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S25","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 16:01:59,075] : Execution result updated successfully

[2024-05-24 16:01:59,075] : [STEP_26] #####################################################
[2024-05-24 16:01:59,075] : [STEP_26] Description : Validate write access for Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry
[2024-05-24 16:01:59,075] : [STEP_26] Expected Result : tr181 must allow write telemetry url
[2024-05-24 16:01:59,075] : [STEP_26] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 16:01:59,075] : [STEP_26] #####################################################

[2024-05-24 16:01:59,075] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:01:59,076] : [BEFORE]: http://webconfig.rdkcentral.com:9007/api/v1/device/{{ecmmac}}/config
[2024-05-24 16:01:59,076] : [AFTER]: http://webconfig.rdkcentral.com:9007/api/v1/device/E4:5F:01:F4:EE:2B/config
[2024-05-24 16:01:59,080] : Setting webpa Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry dataType 0 value http://webconfig.rdkcentral.com:9007/api/v1/device/E4:5F:01:F4:EE:2B/config
[2024-05-24 16:01:59,080] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 16:01:59,080] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 16:01:59,080] : COMPLETE URL BUILD FOR "SET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config
[2024-05-24 16:01:59,080] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 16:01:59,080] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 16:01:59,081] : REST CLIENT - Processing request
[2024-05-24 16:01:59,482] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config is - 200
[2024-05-24 16:01:59,482] : RESPONSE RECIEVED FOR WEBPA SET REQUEST: 200
[2024-05-24 16:01:59,482] : WEBPA RESPONSE : {"parameters":[{"name":"Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry","message":"Success"}],"statusCode":200}
[2024-05-24 16:01:59,483] : ENDING METHOD: setWebPaParameterValue : Success
[2024-05-24 16:01:59,483] : TR181 Response : {Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry=Success}
[2024-05-24 16:01:59,483] : Presence of parameter true in the command output : true
[2024-05-24 16:01:59,483] : >>>>>> ACTUAL OUTPUT: true
[2024-05-24 16:01:59,483] : >>>>>> EXPECTED OUTPUT: true
[2024-05-24 16:01:59,483] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 16:01:59,483] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:01:59,483] : >>>>>> INVERT RESULT: false

[2024-05-24 16:01:59,483] : [STEP_26] #####################################################
[2024-05-24 16:01:59,483] : [STEP_26]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:01:59,483] : [STEP_26] #####################################################

[2024-05-24 16:01:59,486] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S26][ Execution status : PASS] [Error Message : ]
[2024-05-24 16:01:59,486] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S26","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 16:01:59,498] : Execution result updated successfully

[2024-05-24 16:01:59,498] : [STEP_27] #####################################################
[2024-05-24 16:01:59,498] : [STEP_27] Description : Validate read access for Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry
[2024-05-24 16:01:59,498] : [STEP_27] Expected Result : tr181 must allow read to supplementary telemetry url
[2024-05-24 16:01:59,498] : [STEP_27] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 16:01:59,498] : [STEP_27] #####################################################

[2024-05-24 16:01:59,498] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:01:59,501] : TR181 Access Method: WEBPA
[2024-05-24 16:01:59,501] : getWebPaParamValue: Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry
[2024-05-24 16:01:59,502] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 16:01:59,502] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 16:01:59,502] : COMPLETE URL BUILD FOR "GET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config?names=Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry
[2024-05-24 16:01:59,502] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 16:01:59,502] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 16:01:59,502] : REST CLIENT - Processing request
[2024-05-24 16:01:59,893] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config?names=Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry is - 200
[2024-05-24 16:01:59,893] : RESPONSE RECIEVED FOR WEBPA GET REQUEST: 200
[2024-05-24 16:01:59,893] : WEBPA RESPONSE : {"parameters":[{"name":"Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry","value":"http://webconfig.rdkcentral.com:9007/api/v1/device/E4:5F:01:F4:EE:2B/config","dataType":0,"parameterCount":1,"message":"Success"}],"statusCode":200}
[2024-05-24 16:01:59,894] : WebPa data type: STRING
[2024-05-24 16:01:59,894] : TR181 parametrs status code added 0
[2024-05-24 16:01:59,894] : TR181 Response : [tableName=null, index=null, name=Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry, protocolSpecificParamName=null, value=http://webconfig.rdkcentral.com:9007/api/v1/device/E4:5F:01:F4:EE:2B/config, datatype=STRING, statusCode=0]
[2024-05-24 16:01:59,894] : >>>>>> ACTUAL OUTPUT: http://webconfig.rdkcentral.com:9007/api/v1/device/E4:5F:01:F4:EE:2B/config
[2024-05-24 16:01:59,894] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 16:01:59,894] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-05-24 16:01:59,894] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:01:59,894] : >>>>>> INVERT RESULT: false

[2024-05-24 16:01:59,894] : [STEP_27] #####################################################
[2024-05-24 16:01:59,894] : [STEP_27]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:01:59,894] : [STEP_27] #####################################################

[2024-05-24 16:01:59,897] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S27][ Execution status : PASS] [Error Message : ]
[2024-05-24 16:01:59,897] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S27","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 16:01:59,909] : Execution result updated successfully

[2024-05-24 16:01:59,910] : [STEP_28] #####################################################
[2024-05-24 16:01:59,910] : [STEP_28] Description : Validate webconfig DB to not have telemetry
[2024-05-24 16:01:59,910] : [STEP_28] Expected Result : telemetry must not be present in webconfig DB
[2024-05-24 16:01:59,910] : [STEP_28] API Name : EXECUTE_COMMAND
[2024-05-24 16:01:59,910] : [STEP_28] #####################################################

[2024-05-24 16:01:59,910] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:01:59,919] : Entering executeCommandUsingSsh method
[2024-05-24 16:01:59,983] : Default SSH custom port is set
<=========================== RESPONSE =======================>
rbus_open for component webcfg_decoder
rbus_init is success. ret is 0

msgpack decoded data is:
{"webcfgdb":[{"name":"root", "version":0, "root_string":"NONE"}]}

<=============================================================>
rbus_init is success. ret is 0

msgpack decoded data is:
{"webcfgdb":[{"name":"root", "version":0, "root_string":"NONE"}]}


[2024-05-24 16:02:02,145] : Exiting executeCommandUsingSsh method
[2024-05-24 16:02:02,145] : Presence of parameter telemetry in the command output : false
[2024-05-24 16:02:02,145] : >>>>>> ACTUAL OUTPUT: rbus_open for component webcfg_decoder
rbus_init is success. ret is 0

msgpack decoded data is:
{"webcfgdb":[{"name":"root", "version":0, "root_string":"NONE"}]}


[2024-05-24 16:02:02,145] : >>>>>> EXPECTED OUTPUT: telemetry
[2024-05-24 16:02:02,145] : >>>>>> VALIDATION PERFORMED: NOT_CONTAINS
[2024-05-24 16:02:02,145] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:02:02,145] : >>>>>> INVERT RESULT: false

[2024-05-24 16:02:02,145] : [STEP_28] #####################################################
[2024-05-24 16:02:02,145] : [STEP_28]-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:02:02,145] : [STEP_28] #####################################################

[2024-05-24 16:02:02,148] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S28][ Execution status : PASS] [Error Message : ]
[2024-05-24 16:02:02,148] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S28","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 16:02:02,160] : Execution result updated successfully

[2024-05-24 16:02:02,160] : [STEP_29] #####################################################
[2024-05-24 16:02:02,160] : [STEP_29] Description : Perform Factory reset
[2024-05-24 16:02:02,160] : [STEP_29] Expected Result : Factory Reset must be sccessful
[2024-05-24 16:02:02,160] : [STEP_29] API Name : EXECUTE_COMMAND
[2024-05-24 16:02:02,161] : [STEP_29] #####################################################

[2024-05-24 16:02:02,161] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:02:02,170] : Entering executeCommandUsingSsh method
[2024-05-24 16:02:02,229] : Default SSH custom port is set
<=========================== RESPONSE =======================>
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.pam): Device.X_CISCO_COM_DeviceControl.FactoryReset
Execution succeed.

<=============================================================>
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.pam): Device.X_CISCO_COM_DeviceControl.FactoryReset
Execution succeed.


[2024-05-24 16:02:04,372] : Exiting executeCommandUsingSsh method
[2024-05-24 16:02:04,372] : >>>>>> ACTUAL OUTPUT: CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.pam): Device.X_CISCO_COM_DeviceControl.FactoryReset
Execution succeed.


[2024-05-24 16:02:04,373] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 16:02:04,373] : >>>>>> VALIDATION PERFORMED: NA
[2024-05-24 16:02:04,373] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:02:04,373] : >>>>>> INVERT RESULT: false

[2024-05-24 16:02:04,373] : [STEP_29] #####################################################
[2024-05-24 16:02:04,373] : [STEP_29]-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:02:04,373] : [STEP_29] #####################################################

[2024-05-24 16:02:04,376] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S29][ Execution status : PASS] [Error Message : ]
[2024-05-24 16:02:04,377] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S29","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 16:02:04,389] : Execution result updated successfully

[2024-05-24 16:02:04,389] : [STEP_30] #####################################################
[2024-05-24 16:02:04,390] : [STEP_30] Description : Wait for CPE to come up after FR
[2024-05-24 16:02:04,390] : [STEP_30] Expected Result : Device should be up after FR
[2024-05-24 16:02:04,390] : [STEP_30] API Name : WAIT_FOR_ESTBIP_ACQUISITION
[2024-05-24 16:02:04,390] : [STEP_30] #####################################################

[2024-05-24 16:02:04,390] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:02:04,397] : Reboot wait time: 300000
[2024-05-24 16:02:04,397] : 300000 - Maximum waiting time to recover IP as per configuration : 5 minutes
[2024-05-24 16:02:04,397] : Maximum waiting time to recover IP after adding buffer time : 7 minutes
[2024-05-24 16:02:04,397] : Waiting for :2minutes, initial wait time
[2024-05-24 16:04:34,398] : Wait for another 150seconds to verify IP acquisition using existing IP
[2024-05-24 16:04:34,398] : Current Value - 0 Max Value : 150
[2024-05-24 16:04:34,398] : SSH Host IP : 192.168.162.78
[2024-05-24 16:04:34,459] : Default SSH custom port is set
<=========================== RESPONSE =======================>
test_connection

<=============================================================>
[2024-05-24 16:04:36,591] : Closing SSH connection from DeviceIP: 192.168.162.78
[2024-05-24 16:04:36,591] : Exiting method isDeviceAccessible. Status - true
[2024-05-24 16:04:36,591] : Device is accessible using IP : IPv4:192.168.162.78 IPv6: null for Build : cc Mac Address : E4:5F:01:F4:EE:2B
[2024-05-24 16:04:36,591] : Completed execution of waitForEstbIpAcquisition() : Status : true. Time taken : 2 minutes
[2024-05-24 16:04:36,591] : >>>>>> ACTUAL OUTPUT: true
[2024-05-24 16:04:36,591] : >>>>>> EXPECTED OUTPUT: true
[2024-05-24 16:04:36,592] : >>>>>> VALIDATION PERFORMED: EQUALS
[2024-05-24 16:04:36,592] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:04:36,592] : >>>>>> INVERT RESULT: false

[2024-05-24 16:04:36,592] : [STEP_30] #####################################################
[2024-05-24 16:04:36,592] : [STEP_30]-[API Name: WAIT_FOR_ESTBIP_ACQUISITION]-[Execution Status: PASS]
[2024-05-24 16:04:36,592] : [STEP_30] #####################################################

[2024-05-24 16:04:36,596] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S30][ Execution status : PASS] [Error Message : ]
[2024-05-24 16:04:36,596] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S30","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 16:04:36,621] : Execution result updated successfully

[2024-05-24 16:04:36,621] : [STEP_31] #####################################################
[2024-05-24 16:04:36,621] : [STEP_31] Description : Verify webconfig to be disabled by default
[2024-05-24 16:04:36,622] : [STEP_31] Expected Result : Webconfig must be disabled by default
[2024-05-24 16:04:36,622] : [STEP_31] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 16:04:36,622] : [STEP_31] #####################################################

[2024-05-24 16:04:36,622] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:04:36,626] : TR181 Access Method: WEBPA
[2024-05-24 16:04:36,627] : getWebPaParamValue: Device.X_RDK_WebConfig.RfcEnable
[2024-05-24 16:04:36,627] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 16:04:36,627] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 16:04:36,627] : COMPLETE URL BUILD FOR "GET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config?names=Device.X_RDK_WebConfig.RfcEnable
[2024-05-24 16:04:36,627] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 16:04:36,627] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 16:04:36,627] : REST CLIENT - Processing request
[2024-05-24 16:04:37,026] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config?names=Device.X_RDK_WebConfig.RfcEnable is - 520
[2024-05-24 16:04:37,026] : RESPONSE RECIEVED FOR WEBPA GET REQUEST: 520
[2024-05-24 16:04:37,026] : WEBPA RESPONSE : {"message":"Error unsupported namespace","statusCode":520}
[2024-05-24 16:04:37,027] : Exception occured
java.lang.reflect.InvocationTargetException: null
at jdk.internal.reflect.GeneratedMethodAccessor43.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
at java.base/java.lang.reflect.Method.invoke(Unknown Source)
at com.automatics.scriptless.safe.InvokationUtils.executeStep(InvokationUtils.java:431)
at com.automatics.scriptless.safe.InvokationUtils.invokeMethod(InvokationUtils.java:200)
at com.automatics.scriptless.safe.SafeEngine.performStepOperation(SafeEngine.java:622)
at com.automatics.scriptless.safe.SafeEngine.execute(SafeEngine.java:430)
at com.automatics.scriptless.safe.SafeEngine.traverseTest(SafeEngine.java:89)
at com.automatics.scriptless.utils.RackUtils.performCustomTest(RackUtils.java:296)
at com.automatics.scriptless.test.CustomTest.processCustomJob(CustomTest.java:91)
at com.automatics.scriptless.test.CustomTest.customTestStarter(CustomTest.java:62)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
at java.base/java.lang.reflect.Method.invoke(Unknown Source)
at org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:134)
at org.testng.internal.TestInvoker.invokeMethod(TestInvoker.java:597)
at org.testng.internal.TestInvoker.invokeTestMethod(TestInvoker.java:173)
at org.testng.internal.TestMethodWithDataProviderMethodWorker.call(TestMethodWithDataProviderMethodWorker.java:77)
at org.testng.internal.TestMethodWithDataProviderMethodWorker.call(TestMethodWithDataProviderMethodWorker.java:15)
at java.base/java.util.concurrent.FutureTask.run(Unknown Source)
at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)
at java.base/java.util.concurrent.FutureTask.run(Unknown Source)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.base/java.lang.Thread.run(Unknown Source)
Caused by: java.lang.NullPointerException: Cannot invoke "java.util.Collection.toArray()" because "<parameter1>" is null
at java.base/java.util.ArrayList.addAll(Unknown Source)
at com.automatics.tap.AutomaticsTapApi.getTR181ParameterValue(AutomaticsTapApi.java:6788)
at com.automatics.tap.AutomaticsTapApi.getTR181ParameterValues(AutomaticsTapApi.java:6761)
at com.automatics.tap.AutomaticsScriptlessTapApi.executeWebpaCommand(AutomaticsScriptlessTapApi.java:565)
... 26 common frames omitted
[2024-05-24 16:04:37,028] : Presence of parameter Can't find destination component in the command output : false
[2024-05-24 16:04:37,028] : >>>>>> ACTUAL OUTPUT: null
[2024-05-24 16:04:37,028] : >>>>>> EXPECTED OUTPUT: Can't find destination component
[2024-05-24 16:04:37,028] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 16:04:37,028] : >>>>>> VALIDATION STATUS: false
[2024-05-24 16:04:37,028] : >>>>>> INVERT RESULT: false
[2024-05-24 16:04:37,028] : Presence of parameter true in the command output : false
[2024-05-24 16:04:37,028] : >>>>>> ACTUAL OUTPUT: null
[2024-05-24 16:04:37,028] : >>>>>> EXPECTED OUTPUT: true
[2024-05-24 16:04:37,028] : >>>>>> VALIDATION PERFORMED: NOT_CONTAINS
[2024-05-24 16:04:37,028] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:04:37,028] : >>>>>> INVERT RESULT: false

[2024-05-24 16:04:37,029] : [STEP_31] #####################################################
[2024-05-24 16:04:37,029] : [STEP_31]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:04:37,029] : [STEP_31] #####################################################

[2024-05-24 16:04:37,050] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S31][ Execution status : PASS] [Error Message : ]
[2024-05-24 16:04:37,051] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S31","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 16:04:37,065] : Execution result updated successfully

[2024-05-24 16:04:37,066] : [STEP_32] #####################################################
[2024-05-24 16:04:37,066] : [STEP_32] Description : Enable webconfig - restart webconfig process
[2024-05-24 16:04:37,066] : [STEP_32] Expected Result : Webconfig process should active
[2024-05-24 16:04:37,066] : [STEP_32] API Name : EXECUTE_COMMAND
[2024-05-24 16:04:37,066] : [STEP_32] #####################################################

[2024-05-24 16:04:37,066] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:04:37,079] : Entering executeCommandUsingSsh method
[2024-05-24 16:04:37,139] : Default SSH custom port is set
<=========================== RESPONSE =======================>

<=============================================================>

[2024-05-24 16:04:39,289] : Exiting executeCommandUsingSsh method
[2024-05-24 16:04:39,289] : >>>>>> ACTUAL OUTPUT:

[2024-05-24 16:04:39,289] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 16:04:39,290] : >>>>>> VALIDATION PERFORMED: NA
[2024-05-24 16:04:39,290] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:04:39,290] : >>>>>> INVERT RESULT: false

[2024-05-24 16:04:39,290] : [STEP_32] #####################################################
[2024-05-24 16:04:39,290] : [STEP_32]-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:04:39,290] : [STEP_32] #####################################################

[2024-05-24 16:04:39,292] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S32][ Execution status : PASS] [Error Message : ]
[2024-05-24 16:04:39,293] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S32","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 16:04:39,305] : Execution result updated successfully

[2024-05-24 16:04:39,305] : [STEP_33] #####################################################
[2024-05-24 16:04:39,305] : [STEP_33] Description : Enable webconfig
[2024-05-24 16:04:39,305] : [STEP_33] Expected Result : WEbconfig must be enabled
[2024-05-24 16:04:39,305] : [STEP_33] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 16:04:39,305] : [STEP_33] #####################################################

[2024-05-24 16:04:39,305] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:04:39,309] : Setting webpa Device.X_RDK_WebConfig.RfcEnable dataType 3 value true
[2024-05-24 16:04:39,309] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 16:04:39,309] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 16:04:39,309] : COMPLETE URL BUILD FOR "SET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config
[2024-05-24 16:04:39,309] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 16:04:39,309] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 16:04:39,310] : REST CLIENT - Processing request
[2024-05-24 16:04:39,709] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config is - 200
[2024-05-24 16:04:39,709] : RESPONSE RECIEVED FOR WEBPA SET REQUEST: 200
[2024-05-24 16:04:39,709] : WEBPA RESPONSE : {"parameters":[{"name":"Device.X_RDK_WebConfig.RfcEnable","message":"Success"}],"statusCode":200}
[2024-05-24 16:04:39,709] : ENDING METHOD: setWebPaParameterValue : Success
[2024-05-24 16:04:39,710] : TR181 Response : {Device.X_RDK_WebConfig.RfcEnable=Success}
[2024-05-24 16:04:39,710] : Presence of parameter true in the command output : true
[2024-05-24 16:04:39,710] : >>>>>> ACTUAL OUTPUT: true
[2024-05-24 16:04:39,710] : >>>>>> EXPECTED OUTPUT: true
[2024-05-24 16:04:39,710] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 16:04:39,710] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:04:39,710] : >>>>>> INVERT RESULT: false

[2024-05-24 16:04:39,710] : [STEP_33] #####################################################
[2024-05-24 16:04:39,710] : [STEP_33]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:04:39,710] : [STEP_33] #####################################################

[2024-05-24 16:04:39,712] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S33][ Execution status : PASS] [Error Message : ]
[2024-05-24 16:04:39,713] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S33","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 16:04:39,725] : Execution result updated successfully

[2024-05-24 16:04:39,725] : [STEP_34] #####################################################
[2024-05-24 16:04:39,725] : [STEP_34] Description : Validate default value of supplementary URL
[2024-05-24 16:04:39,725] : [STEP_34] Expected Result : Default SupplementaryService Telemetry URL must be http://webconfig.rdkcentral.com:9007/api/v1/device/<ecmmac>/config
[2024-05-24 16:04:39,725] : [STEP_34] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 16:04:39,725] : [STEP_34] #####################################################

[2024-05-24 16:04:39,726] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:04:39,728] : TR181 Access Method: WEBPA
[2024-05-24 16:04:39,729] : getWebPaParamValue: Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry
[2024-05-24 16:04:39,729] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 16:04:39,729] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 16:04:39,729] : COMPLETE URL BUILD FOR "GET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config?names=Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry
[2024-05-24 16:04:39,729] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 16:04:39,729] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 16:04:39,729] : REST CLIENT - Processing request
[2024-05-24 16:04:40,127] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config?names=Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry is - 200
[2024-05-24 16:04:40,128] : RESPONSE RECIEVED FOR WEBPA GET REQUEST: 200
[2024-05-24 16:04:40,128] : WEBPA RESPONSE : {"parameters":[{"name":"Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry","value":"","dataType":0,"parameterCount":1,"message":"Success"}],"statusCode":200}
[2024-05-24 16:04:40,128] : WebPa data type: STRING
[2024-05-24 16:04:40,128] : TR181 parametrs status code added 0
[2024-05-24 16:04:40,128] : TR181 Response : [tableName=null, index=null, name=Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry, protocolSpecificParamName=null, value=, datatype=STRING, statusCode=0]
[2024-05-24 16:04:40,128] : >>>>>> ACTUAL OUTPUT:
[2024-05-24 16:04:40,128] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 16:04:40,128] : >>>>>> VALIDATION PERFORMED: NULL
[2024-05-24 16:04:40,128] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:04:40,128] : >>>>>> INVERT RESULT: false

[2024-05-24 16:04:40,129] : [STEP_34] #####################################################
[2024-05-24 16:04:40,129] : [STEP_34]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:04:40,129] : [STEP_34] #####################################################

[2024-05-24 16:04:40,131] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S34][ Execution status : PASS] [Error Message : ]
[2024-05-24 16:04:40,131] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S34","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 16:04:40,146] : Execution result updated successfully

[2024-05-24 16:04:40,146] : [STEP_35] #####################################################
[2024-05-24 16:04:40,146] : [STEP_35] Description : Update supplementary telemetry URL value to NULL
[2024-05-24 16:04:40,146] : [STEP_35] Expected Result : Webconfig URL param must be set properly
[2024-05-24 16:04:40,146] : [STEP_35] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 16:04:40,146] : [STEP_35] #####################################################

[2024-05-24 16:04:40,146] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:04:40,149] : Setting webpa Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry dataType 0 value NULL
[2024-05-24 16:04:40,149] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 16:04:40,149] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 16:04:40,150] : COMPLETE URL BUILD FOR "SET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config
[2024-05-24 16:04:40,150] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 16:04:40,150] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 16:04:40,150] : REST CLIENT - Processing request
[2024-05-24 16:04:40,547] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config is - 200
[2024-05-24 16:04:40,547] : RESPONSE RECIEVED FOR WEBPA SET REQUEST: 200
[2024-05-24 16:04:40,547] : WEBPA RESPONSE : {"parameters":[{"name":"Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry","message":"Success"}],"statusCode":200}
[2024-05-24 16:04:40,547] : ENDING METHOD: setWebPaParameterValue : Success
[2024-05-24 16:04:40,547] : TR181 Response : {Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry=Success}
[2024-05-24 16:04:40,548] : Presence of parameter true in the command output : true
[2024-05-24 16:04:40,548] : >>>>>> ACTUAL OUTPUT: true
[2024-05-24 16:04:40,548] : >>>>>> EXPECTED OUTPUT: true
[2024-05-24 16:04:40,548] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 16:04:40,548] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:04:40,548] : >>>>>> INVERT RESULT: false

[2024-05-24 16:04:40,548] : [STEP_35] #####################################################
[2024-05-24 16:04:40,548] : [STEP_35]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:04:40,548] : [STEP_35] #####################################################

[2024-05-24 16:04:40,550] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S35][ Execution status : PASS] [Error Message : ]
[2024-05-24 16:04:40,551] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S35","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 16:04:40,563] : Execution result updated successfully

[2024-05-24 16:04:40,563] : [STEP_36] #####################################################
[2024-05-24 16:04:40,563] : [STEP_36] Description : Validate status_code to be 520/Execution failure on performing forcesync
[2024-05-24 16:04:40,563] : [STEP_36] Expected Result : error code 520/execution failure must be generated on foce sync
[2024-05-24 16:04:40,563] : [STEP_36] API Name : EXECUTE_COMMAND
[2024-05-24 16:04:40,563] : [STEP_36] #####################################################

[2024-05-24 16:04:40,563] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:04:40,572] : Entering executeCommandUsingSsh method
[2024-05-24 16:04:40,636] : Default SSH custom port is set
<=========================== RESPONSE =======================>
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(webconfig): Device.X_RDK_WebConfig.ForceSync
Execution fail(error code:CCSP_FAILURE(102)).

<=============================================================>
subsystem_prefix eRT.
setv from/to component(webconfig): Device.X_RDK_WebConfig.ForceSync
Execution fail(error code:CCSP_FAILURE(102)).


[2024-05-24 16:04:42,771] : Exiting executeCommandUsingSsh method
[2024-05-24 16:04:42,771] : Presence of parameter Execution fail(error code:CCSP_FAILURE(102)) in the command output : true
[2024-05-24 16:04:42,771] : >>>>>> ACTUAL OUTPUT: CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(webconfig): Device.X_RDK_WebConfig.ForceSync
Execution fail(error code:CCSP_FAILURE(102)).


[2024-05-24 16:04:42,771] : >>>>>> EXPECTED OUTPUT: Execution fail(error code:CCSP_FAILURE(102))
[2024-05-24 16:04:42,771] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 16:04:42,771] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:04:42,771] : >>>>>> INVERT RESULT: false

[2024-05-24 16:04:42,771] : [STEP_36] #####################################################
[2024-05-24 16:04:42,771] : [STEP_36]-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:04:42,771] : [STEP_36] #####################################################

[2024-05-24 16:04:42,775] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S36][ Execution status : PASS] [Error Message : ]
[2024-05-24 16:04:42,775] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S36","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 16:04:42,789] : Execution result updated successfully

[2024-05-24 16:04:42,790] : [STEP_37] #####################################################
[2024-05-24 16:04:42,790] : [STEP_37] Description : Update default URL
[2024-05-24 16:04:42,790] : [STEP_37] Expected Result : Url must be set successfully
[2024-05-24 16:04:42,790] : [STEP_37] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 16:04:42,790] : [STEP_37] #####################################################

[2024-05-24 16:04:42,790] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:04:42,790] : [BEFORE]: http://webconfig.rdkcentral.com:9007/api/v1/device/{{ecmmac}}/config
[2024-05-24 16:04:42,790] : [AFTER]: http://webconfig.rdkcentral.com:9007/api/v1/device/E4:5F:01:F4:EE:2B/config
[2024-05-24 16:04:42,795] : Setting webpa Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry dataType 0 value http://webconfig.rdkcentral.com:9007/api/v1/device/E4:5F:01:F4:EE:2B/config
[2024-05-24 16:04:42,795] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 16:04:42,795] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 16:04:42,795] : COMPLETE URL BUILD FOR "SET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config
[2024-05-24 16:04:42,795] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 16:04:42,795] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 16:04:42,796] : REST CLIENT - Processing request
[2024-05-24 16:04:43,200] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config is - 200
[2024-05-24 16:04:43,200] : RESPONSE RECIEVED FOR WEBPA SET REQUEST: 200
[2024-05-24 16:04:43,200] : WEBPA RESPONSE : {"parameters":[{"name":"Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry","message":"Success"}],"statusCode":200}
[2024-05-24 16:04:43,200] : ENDING METHOD: setWebPaParameterValue : Success
[2024-05-24 16:04:43,200] : TR181 Response : {Device.X_RDK_WebConfig.SupplementaryServiceUrls.Telemetry=Success}
[2024-05-24 16:04:43,200] : Presence of parameter true in the command output : true
[2024-05-24 16:04:43,200] : >>>>>> ACTUAL OUTPUT: true
[2024-05-24 16:04:43,200] : >>>>>> EXPECTED OUTPUT: true
[2024-05-24 16:04:43,201] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 16:04:43,201] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:04:43,201] : >>>>>> INVERT RESULT: false

[2024-05-24 16:04:43,201] : [STEP_37] #####################################################
[2024-05-24 16:04:43,201] : [STEP_37]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:04:43,201] : [STEP_37] #####################################################

[2024-05-24 16:04:43,203] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S37][ Execution status : PASS] [Error Message : ]
[2024-05-24 16:04:43,204] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S37","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 16:04:43,217] : Execution result updated successfully

[2024-05-24 16:04:43,217] : [STEP_38] #####################################################
[2024-05-24 16:04:43,217] : [STEP_38] Description : update webconfig to false
[2024-05-24 16:04:43,217] : [STEP_38] Expected Result : webconfig must be disabled
[2024-05-24 16:04:43,217] : [STEP_38] API Name : EXECUTE_WEBPA_COMMAND
[2024-05-24 16:04:43,217] : [STEP_38] #####################################################

[2024-05-24 16:04:43,217] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:04:43,220] : Setting webpa Device.X_RDK_WebConfig.RfcEnable dataType 3 value false
[2024-05-24 16:04:43,220] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 16:04:43,220] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 16:04:43,220] : COMPLETE URL BUILD FOR "SET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config
[2024-05-24 16:04:43,220] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-05-24 16:04:43,220] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-05-24 16:04:43,221] : REST CLIENT - Processing request
[2024-05-24 16:04:43,617] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01F4EE2B/config is - 200
[2024-05-24 16:04:43,617] : RESPONSE RECIEVED FOR WEBPA SET REQUEST: 200
[2024-05-24 16:04:43,617] : WEBPA RESPONSE : {"parameters":[{"name":"Device.X_RDK_WebConfig.RfcEnable","message":"Success"}],"statusCode":200}
[2024-05-24 16:04:43,617] : ENDING METHOD: setWebPaParameterValue : Success
[2024-05-24 16:04:43,617] : TR181 Response : {Device.X_RDK_WebConfig.RfcEnable=Success}
[2024-05-24 16:04:43,617] : Presence of parameter true in the command output : true
[2024-05-24 16:04:43,618] : >>>>>> ACTUAL OUTPUT: true
[2024-05-24 16:04:43,618] : >>>>>> EXPECTED OUTPUT: true
[2024-05-24 16:04:43,618] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 16:04:43,618] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:04:43,618] : >>>>>> INVERT RESULT: false

[2024-05-24 16:04:43,618] : [STEP_38] #####################################################
[2024-05-24 16:04:43,618] : [STEP_38]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:04:43,618] : [STEP_38] #####################################################

[2024-05-24 16:04:43,620] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S38][ Execution status : PASS] [Error Message : ]
[2024-05-24 16:04:43,621] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S38","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 16:04:43,633] : Execution result updated successfully
[2024-05-24 16:04:43,633] : 39 CheckPoint/USER_DEFINED_UTILITY

[2024-05-24 16:04:43,633] : [STEP_39] #####################################################
[2024-05-24 16:04:43,633] : [STEP_39] Description : Reactivate the device
[2024-05-24 16:04:43,633] : [STEP_39] Expected Result : cpe must be reactivated
[2024-05-24 16:04:43,634] : [STEP_39] API Name : REACTIVATE_POST_FR
[2024-05-24 16:04:43,634] : [STEP_39] #####################################################

[2024-05-24 16:04:43,634] : (STEP_39.1) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:43,634] : (STEP_39.1) Description : To activate set 2.4GHz SSID
[2024-05-24 16:04:43,634] : (STEP_39.1) Expected Result : Successfully set 2.4GHz SSID
[2024-05-24 16:04:43,635] : (STEP_39.1) API Name : EXECUTE_COMMAND
[2024-05-24 16:04:43,635] : (STEP_39.1) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:43,635] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:04:43,647] : Entering executeCommandUsingSsh method
[2024-05-24 16:04:43,706] : Default SSH custom port is set
<=========================== RESPONSE =======================>
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.SSID.1.SSID
Execution succeed.

<=============================================================>
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.SSID.1.SSID
Execution succeed.


[2024-05-24 16:04:45,833] : Exiting executeCommandUsingSsh method
[2024-05-24 16:04:45,834] : >>>>>> ACTUAL OUTPUT: CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.SSID.1.SSID
Execution succeed.


[2024-05-24 16:04:45,834] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 16:04:45,834] : >>>>>> VALIDATION PERFORMED: NA
[2024-05-24 16:04:45,834] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:04:45,834] : >>>>>> INVERT RESULT: false
[2024-05-24 16:04:45,834] : (STEP_39.1) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:45,834] : (STEP_39.1)-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:04:45,834] : (STEP_39.1) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:45,834] : (STEP_39.2) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:45,834] : (STEP_39.2) Description : To activate set 5GHz SSID
[2024-05-24 16:04:45,835] : (STEP_39.2) Expected Result : Successfully set 5GHz SSID
[2024-05-24 16:04:45,835] : (STEP_39.2) API Name : EXECUTE_COMMAND
[2024-05-24 16:04:45,835] : (STEP_39.2) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:45,835] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:04:45,844] : Entering executeCommandUsingSsh method
[2024-05-24 16:04:45,902] : Default SSH custom port is set
<=========================== RESPONSE =======================>
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.SSID.2.SSID
Execution succeed.

<=============================================================>
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.SSID.2.SSID
Execution succeed.


[2024-05-24 16:04:48,035] : Exiting executeCommandUsingSsh method
[2024-05-24 16:04:48,035] : >>>>>> ACTUAL OUTPUT: CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.SSID.2.SSID
Execution succeed.


[2024-05-24 16:04:48,035] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 16:04:48,035] : >>>>>> VALIDATION PERFORMED: NA
[2024-05-24 16:04:48,035] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:04:48,035] : >>>>>> INVERT RESULT: false
[2024-05-24 16:04:48,035] : (STEP_39.2) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:48,035] : (STEP_39.2)-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:04:48,035] : (STEP_39.2) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:48,035] : (STEP_39.3) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:48,035] : (STEP_39.3) Description : Set KeyPassphrase for 2.4GHz
[2024-05-24 16:04:48,035] : (STEP_39.3) Expected Result : Successfully set KeyPassphrase for 2.4GHz
[2024-05-24 16:04:48,035] : (STEP_39.3) API Name : EXECUTE_COMMAND
[2024-05-24 16:04:48,036] : (STEP_39.3) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:48,036] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:04:48,044] : Entering executeCommandUsingSsh method
[2024-05-24 16:04:48,104] : Default SSH custom port is set
<=========================== RESPONSE =======================>
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.AccessPoint.1.Security.X_COMCAST-COM_KeyPassphrase
Execution fail(error code:CCSP_ERR_INVALID_PARAMETER_VALUE(9007)).

<=============================================================>
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.AccessPoint.1.Security.X_COMCAST-COM_KeyPassphrase
Execution fail(error code:CCSP_ERR_INVALID_PARAMETER_VALUE(9007)).


[2024-05-24 16:04:50,256] : Exiting executeCommandUsingSsh method
[2024-05-24 16:04:50,256] : >>>>>> ACTUAL OUTPUT: CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.AccessPoint.1.Security.X_COMCAST-COM_KeyPassphrase
Execution fail(error code:CCSP_ERR_INVALID_PARAMETER_VALUE(9007)).


[2024-05-24 16:04:50,256] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 16:04:50,256] : >>>>>> VALIDATION PERFORMED: NA
[2024-05-24 16:04:50,256] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:04:50,256] : >>>>>> INVERT RESULT: false
[2024-05-24 16:04:50,256] : (STEP_39.3) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:50,257] : (STEP_39.3)-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:04:50,257] : (STEP_39.3) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:50,257] : (STEP_39.4) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:50,257] : (STEP_39.4) Description : Set KeyPassphrase for 5GHz
[2024-05-24 16:04:50,257] : (STEP_39.4) Expected Result : Successfully set KeyPassphrase for 5GHz
[2024-05-24 16:04:50,257] : (STEP_39.4) API Name : EXECUTE_COMMAND
[2024-05-24 16:04:50,257] : (STEP_39.4) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:50,257] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:04:50,266] : Entering executeCommandUsingSsh method
[2024-05-24 16:04:50,324] : Default SSH custom port is set
<=========================== RESPONSE =======================>
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.AccessPoint.2.Security.X_COMCAST-COM_KeyPassphrase
Execution fail(error code:CCSP_ERR_INVALID_PARAMETER_VALUE(9007)).

<=============================================================>
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.AccessPoint.2.Security.X_COMCAST-COM_KeyPassphrase
Execution fail(error code:CCSP_ERR_INVALID_PARAMETER_VALUE(9007)).


[2024-05-24 16:04:56,174] : Exiting executeCommandUsingSsh method
[2024-05-24 16:04:56,174] : >>>>>> ACTUAL OUTPUT: CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.AccessPoint.2.Security.X_COMCAST-COM_KeyPassphrase
Execution fail(error code:CCSP_ERR_INVALID_PARAMETER_VALUE(9007)).


[2024-05-24 16:04:56,174] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 16:04:56,174] : >>>>>> VALIDATION PERFORMED: NA
[2024-05-24 16:04:56,174] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:04:56,174] : >>>>>> INVERT RESULT: false
[2024-05-24 16:04:56,174] : (STEP_39.4) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:56,174] : (STEP_39.4)-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:04:56,174] : (STEP_39.4) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:56,174] : (STEP_39.5) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:56,174] : (STEP_39.5) Description : Set false to ConfigureWiFi
[2024-05-24 16:04:56,174] : (STEP_39.5) Expected Result : ConfigureWiFi should set to false
[2024-05-24 16:04:56,174] : (STEP_39.5) API Name : EXECUTE_COMMAND
[2024-05-24 16:04:56,174] : (STEP_39.5) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:56,175] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:04:56,184] : Entering executeCommandUsingSsh method
[2024-05-24 16:04:56,243] : Default SSH custom port is set
<=========================== RESPONSE =======================>
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.pam): Device.DeviceInfo.X_RDKCENTRAL-COM_ConfigureWiFi
Execution succeed.

<=============================================================>
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.pam): Device.DeviceInfo.X_RDKCENTRAL-COM_ConfigureWiFi
Execution succeed.


[2024-05-24 16:04:58,401] : Exiting executeCommandUsingSsh method
[2024-05-24 16:04:58,401] : >>>>>> ACTUAL OUTPUT: CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.pam): Device.DeviceInfo.X_RDKCENTRAL-COM_ConfigureWiFi
Execution succeed.


[2024-05-24 16:04:58,401] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 16:04:58,401] : >>>>>> VALIDATION PERFORMED: NA
[2024-05-24 16:04:58,402] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:04:58,402] : >>>>>> INVERT RESULT: false
[2024-05-24 16:04:58,402] : (STEP_39.5) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:58,402] : (STEP_39.5)-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:04:58,402] : (STEP_39.5) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:58,402] : (STEP_39.6) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:58,402] : (STEP_39.6) Description : Set Device.DeviceInfo.X_RDKCENTRAL-COM_CaptivePortalEnable to false
[2024-05-24 16:04:58,402] : (STEP_39.6) Expected Result : Successfully set Device.DeviceInfo.X_RDKCENTRAL-COM_CaptivePortalEnable to false
[2024-05-24 16:04:58,402] : (STEP_39.6) API Name : EXECUTE_COMMAND
[2024-05-24 16:04:58,402] : (STEP_39.6) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:04:58,402] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:04:58,411] : Entering executeCommandUsingSsh method
[2024-05-24 16:04:58,469] : Default SSH custom port is set
<=========================== RESPONSE =======================>
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.pam): Device.DeviceInfo.X_RDKCENTRAL-COM_CaptivePortalEnable
Execution succeed.

<=============================================================>
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.pam): Device.DeviceInfo.X_RDKCENTRAL-COM_CaptivePortalEnable
Execution succeed.


[2024-05-24 16:05:00,697] : Exiting executeCommandUsingSsh method
[2024-05-24 16:05:00,697] : >>>>>> ACTUAL OUTPUT: CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.pam): Device.DeviceInfo.X_RDKCENTRAL-COM_CaptivePortalEnable
Execution succeed.


[2024-05-24 16:05:00,697] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 16:05:00,698] : >>>>>> VALIDATION PERFORMED: NA
[2024-05-24 16:05:00,698] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:05:00,698] : >>>>>> INVERT RESULT: false
[2024-05-24 16:05:00,698] : (STEP_39.6) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:05:00,698] : (STEP_39.6)-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:05:00,698] : (STEP_39.6) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:05:00,698] : (STEP_39.7) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:05:00,698] : (STEP_39.7) Description : Applysettings to Radio 1
[2024-05-24 16:05:00,698] : (STEP_39.7) Expected Result : Applysettings to Radio 1
[2024-05-24 16:05:00,698] : (STEP_39.7) API Name : EXECUTE_COMMAND
[2024-05-24 16:05:00,698] : (STEP_39.7) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:05:00,699] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:05:00,707] : Entering executeCommandUsingSsh method
[2024-05-24 16:05:00,767] : Default SSH custom port is set
<=========================== RESPONSE =======================>
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.Radio.1.X_CISCO_COM_ApplySetting
Execution succeed.

<=============================================================>
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.Radio.1.X_CISCO_COM_ApplySetting
Execution succeed.


[2024-05-24 16:05:02,920] : Exiting executeCommandUsingSsh method
[2024-05-24 16:05:02,920] : >>>>>> ACTUAL OUTPUT: CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.Radio.1.X_CISCO_COM_ApplySetting
Execution succeed.


[2024-05-24 16:05:02,921] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 16:05:02,921] : >>>>>> VALIDATION PERFORMED: NA
[2024-05-24 16:05:02,921] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:05:02,921] : >>>>>> INVERT RESULT: false
[2024-05-24 16:05:02,921] : (STEP_39.7) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:05:02,921] : (STEP_39.7)-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:05:02,921] : (STEP_39.7) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:05:02,921] : (STEP_39.8) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:05:02,921] : (STEP_39.8) Description : Applysettings to Radio 2
[2024-05-24 16:05:02,921] : (STEP_39.8) Expected Result : Applysettings to Radio 2
[2024-05-24 16:05:02,921] : (STEP_39.8) API Name : EXECUTE_COMMAND
[2024-05-24 16:05:02,921] : (STEP_39.8) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:05:02,922] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:05:02,930] : Entering executeCommandUsingSsh method
[2024-05-24 16:05:02,989] : Default SSH custom port is set
<=========================== RESPONSE =======================>
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.Radio.2.X_CISCO_COM_ApplySetting
Execution succeed.

<=============================================================>
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.Radio.2.X_CISCO_COM_ApplySetting
Execution succeed.


[2024-05-24 16:05:05,123] : Exiting executeCommandUsingSsh method
[2024-05-24 16:05:05,123] : >>>>>> ACTUAL OUTPUT: CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.Radio.2.X_CISCO_COM_ApplySetting
Execution succeed.


[2024-05-24 16:05:05,123] : >>>>>> EXPECTED OUTPUT: NA
[2024-05-24 16:05:05,123] : >>>>>> VALIDATION PERFORMED: NA
[2024-05-24 16:05:05,123] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:05:05,123] : >>>>>> INVERT RESULT: false
[2024-05-24 16:05:05,123] : (STEP_39.8) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:05:05,123] : (STEP_39.8)-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:05:05,123] : (STEP_39.8) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:05:05,123] : (STEP_39.9) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:05:05,123] : (STEP_39.9) Description : Apply AccessPointSettings to both radios
[2024-05-24 16:05:05,123] : (STEP_39.9) Expected Result : Apply AccessPointSettings to both Radios
[2024-05-24 16:05:05,123] : (STEP_39.9) API Name : EXECUTE_COMMAND
[2024-05-24 16:05:05,124] : (STEP_39.9) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:05:05,124] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:05:05,133] : Entering executeCommandUsingSsh method
[2024-05-24 16:05:05,193] : Default SSH custom port is set
<=========================== RESPONSE =======================>
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.ApplyAccessPointSettings
Execution succeed.

<=============================================================>
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.ApplyAccessPointSettings
Execution succeed.


[2024-05-24 16:05:07,326] : Exiting executeCommandUsingSsh method
[2024-05-24 16:05:07,326] : Presence of parameter Execution succeed in the command output : true
[2024-05-24 16:05:07,326] : >>>>>> ACTUAL OUTPUT: CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.ApplyAccessPointSettings
Execution succeed.


[2024-05-24 16:05:07,326] : >>>>>> EXPECTED OUTPUT: Execution succeed
[2024-05-24 16:05:07,326] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 16:05:07,326] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:05:07,326] : >>>>>> INVERT RESULT: false
[2024-05-24 16:05:07,327] : (STEP_39.9) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:05:07,327] : (STEP_39.9)-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:05:07,327] : (STEP_39.9) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:05:07,327] : (STEP_39.10) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:05:07,327] : (STEP_39.10) Description : Apply RadioSettings to both Radios
[2024-05-24 16:05:07,327] : (STEP_39.10) Expected Result : Apply RadioSettings
[2024-05-24 16:05:07,327] : (STEP_39.10) API Name : EXECUTE_COMMAND
[2024-05-24 16:05:07,327] : (STEP_39.10) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:05:07,327] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-05-24 16:05:07,336] : Entering executeCommandUsingSsh method
[2024-05-24 16:05:07,395] : Default SSH custom port is set
<=========================== RESPONSE =======================>
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.ApplyRadioSettings
Execution succeed.

<=============================================================>
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.ApplyRadioSettings
Execution succeed.


[2024-05-24 16:05:09,528] : Exiting executeCommandUsingSsh method
[2024-05-24 16:05:09,528] : Presence of parameter Execution succeed in the command output : true
[2024-05-24 16:05:09,528] : >>>>>> ACTUAL OUTPUT: CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.ApplyRadioSettings
Execution succeed.


[2024-05-24 16:05:09,528] : >>>>>> EXPECTED OUTPUT: Execution succeed
[2024-05-24 16:05:09,528] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-05-24 16:05:09,528] : >>>>>> VALIDATION STATUS: true
[2024-05-24 16:05:09,528] : >>>>>> INVERT RESULT: false
[2024-05-24 16:05:09,528] : (STEP_39.10) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-05-24 16:05:09,528] : (STEP_39.10)-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-05-24 16:05:09,528] : (STEP_39.10) >>>>>>>>>>>>>>>>>>>>>>>>>

[2024-05-24 16:05:09,528] : [STEP_39] #####################################################
[2024-05-24 16:05:09,528] : [STEP_39]-[API Name: REACTIVATE_POST_FR]-[Execution Status: PASS]
[2024-05-24 16:05:09,528] : [STEP_39] #####################################################

[2024-05-24 16:05:09,531] : [STB MAC : E4:5F:01:F4:EE:2B][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001] [step Number : S39][ Execution status : PASS] [Error Message : ]
[2024-05-24 16:05:09,532] : Result Details ->{"JMD_ID":"2790","manualId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001","stepNumber":"S39","testType":"GROUP_OR_AUTOID","buildName":"cc","macAddress":"E4:5F:01:F4:EE:2B","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG_TELEMETRY_1001"}
[2024-05-24 16:05:09,545] : Execution result updated successfully
[2024-05-24 16:05:09,546] : Execution Completed in settop -E4:5F:01:F4:EE:2B
[2024-05-24 16:05:09,546] : Mac:: E4:5F:01:F4:EE:2B Status:: true Total Count:: 0