TEST SESSION LOGS


DEVICE MAC ADDRESS:E45F01FE3494
TEST CASE ID:3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000
FIRMWARE:rdkb-generic-broadband-image_TDK_rdkb-2024q1-kirkstone_20240319143212

[2024-06-09 03:44:14,342] : ###STARTING TEST CASE: 3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000
[2024-06-09 03:44:14,343] : Starting execution in settop -E4:5F:01:FE:34:94
[2024-06-09 03:44:14,345] : # STEP_1 : Reboot the device #
[2024-06-09 03:44:14,345] : # STEP_2 : Enable Webconfig #
[2024-06-09 03:44:14,346] : # STEP_2.1 : Reboot Device #
[2024-06-09 03:44:14,346] : # STEP_2.2 : Wait for 1 minute #
[2024-06-09 03:44:14,346] : # STEP_2.3 : Enable webconfig - restart webconfig process #
[2024-06-09 03:44:14,346] : # STEP_2.4 : Enable webconfig - set Device.X_RDK_WebConfig.RfcEnable to true #
[2024-06-09 03:44:14,346] : # STEP_2.5 : Check the status of webconfig #
[2024-06-09 03:44:14,346] : # STEP_3 : Check if X-System-Supported-Docs is obtained in webconfig log. #
[2024-06-09 03:44:14,346] : # STEP_4 : Clear Webconfig.log #
[2024-06-09 03:44:14,346] : # STEP_5 : Perform force supplementry sync #
[2024-06-09 03:44:14,346] : # STEP_6 : Check if X-System-Supported-Docs is obtained in webconfig log. #
[2024-06-09 03:44:14,346] : # STEP_7 : Check if X-System-Schema-Version / supportedVersion fetched is NULL is obtained in webconfig log. #

[2024-06-09 03:44:14,347] : [STEP_1] #####################################################
[2024-06-09 03:44:14,347] : [STEP_1] Description : Reboot the device
[2024-06-09 03:44:14,347] : [STEP_1] Expected Result : Device should be rebooted
[2024-06-09 03:44:14,348] : [STEP_1] API Name : REBOOT
[2024-06-09 03:44:14,348] : [STEP_1] #####################################################

[2024-06-09 03:44:14,350] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-06-09 03:44:14,350] : Packages to scan : com.automatics.,com.automatics.core.,com.automatics.scriptless.
[2024-06-09 03:44:14,699] : Total APIs :: 173
[2024-06-09 03:44:14,703] : STARTING METHOD: rebootAndWaitForIpAccusition()
[2024-06-09 03:44:14,703] : SSH Host IP : 192.168.162.209
[2024-06-09 03:44:14,801] : Default SSH custom port is set
<=========================== RESPONSE =======================>
test_connection

<=============================================================>
[2024-06-09 03:44:17,173] : Closing SSH connection from DeviceIP: 192.168.162.209
[2024-06-09 03:44:17,174] : Exiting method isDeviceAccessible. Status - true
[2024-06-09 03:44:17,174] : Entering executeCommandUsingSsh method
[2024-06-09 03:44:17,238] : Default SSH custom port is set
<=========================== RESPONSE =======================>

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

[2024-06-09 03:44:20,069] : Exiting executeCommandUsingSsh method
[2024-06-09 03:44:20,069] : Reboot wait time: 300000
[2024-06-09 03:44:20,072] : 300000 - Maximum waiting time to recover IP as per configuration : 5 minutes
[2024-06-09 03:44:20,072] : Maximum waiting time to recover IP after adding buffer time : 7 minutes
[2024-06-09 03:44:20,072] : Waiting for :2minutes, initial wait time
[2024-06-09 03:46:50,073] : Wait for another 150seconds to verify IP acquisition using existing IP
[2024-06-09 03:46:50,075] : Current Value - 0 Max Value : 150
[2024-06-09 03:46:50,076] : SSH Host IP : 192.168.162.209
[2024-06-09 03:46:50,141] : Default SSH custom port is set
<=========================== RESPONSE =======================>
test_connection

<=============================================================>
[2024-06-09 03:46:52,411] : Closing SSH connection from DeviceIP: 192.168.162.209
[2024-06-09 03:46:52,411] : Exiting method isDeviceAccessible. Status - true
[2024-06-09 03:46:52,411] : Fetching device property: FIRMWARE_VERSION
[2024-06-09 03:46:52,416] : Fetching device props for E4:5F:01:FE:34:94 for props [FIRMWARE_VERSION] Url Path: https://automatics-apps.rdkcentral.com/DeviceManager/deviceManagement/getDeviceProps
[2024-06-09 03:46:52,486] : Response: {"mac":"E4:5F:01:FE:34:94","HEAD_END":null,"FIRMWARE_VERSION":"rdkb","ECM_IP_ADDRESS":null,"ESTB_IP_ADDRESS":null}
[2024-06-09 03:46:52,486] : Getting value for property: FIRMWARE_VERSION
[2024-06-09 03:46:52,486] : Value: rdkb
[2024-06-09 03:46:52,487] : Device property name: FIRMWARE_VERSION value obtained: rdkb
[2024-06-09 03:46:52,487] : Device is accessible using IP : IPv4:192.168.162.209 IPv6: null for Build : rdkb Mac Address : E4:5F:01:FE:34:94
[2024-06-09 03:46:52,487] : Completed execution of waitForEstbIpAcquisition() : Status : true. Time taken : 2 minutes
[2024-06-09 03:46:52,487] : SSH Host IP : 192.168.162.209
[2024-06-09 03:46:52,579] : Default SSH custom port is set
<=========================== RESPONSE =======================>
test_connection

<=============================================================>
[2024-06-09 03:46:54,866] : Closing SSH connection from DeviceIP: 192.168.162.209
[2024-06-09 03:46:54,866] : Exiting method isDeviceAccessible. Status - true
[2024-06-09 03:46:54,866] : ENDING METHOD: rebootAndWaitForIpAccusition()
[2024-06-09 03:46:54,867] : >>>>>> ACTUAL OUTPUT: true
[2024-06-09 03:46:54,867] : >>>>>> EXPECTED OUTPUT: NA
[2024-06-09 03:46:54,867] : >>>>>> VALIDATION PERFORMED: NA
[2024-06-09 03:46:54,867] : >>>>>> VALIDATION STATUS: true
[2024-06-09 03:46:54,867] : >>>>>> INVERT RESULT: false

[2024-06-09 03:46:54,868] : [STEP_1] #####################################################
[2024-06-09 03:46:54,868] : [STEP_1]-[API Name: REBOOT]-[Execution Status: PASS]
[2024-06-09 03:46:54,868] : [STEP_1] #####################################################

[2024-06-09 03:46:54,872] : [STB MAC : E4:5F:01:FE:34:94][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000] [step Number : S1][ Execution status : PASS] [Error Message : ]
[2024-06-09 03:46:54,875] : Result Details ->{"JMD_ID":"2824","manualId":"3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000","stepNumber":"S1","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_TDK_rdkb-2024q1-kirkstone_20240319143212","macAddress":"E4:5F:01:FE:34:94","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000"}
[2024-06-09 03:46:54,905] : Execution result updated successfully
[2024-06-09 03:46:54,906] : 2 CheckPoint/USER_DEFINED_UTILITY

[2024-06-09 03:46:54,906] : [STEP_2] #####################################################
[2024-06-09 03:46:54,906] : [STEP_2] Description : Enable Webconfig
[2024-06-09 03:46:54,906] : [STEP_2] Expected Result : Webconfig should be enabled
[2024-06-09 03:46:54,906] : [STEP_2] API Name : ENABLE_WEBCONFIG
[2024-06-09 03:46:54,906] : [STEP_2] #####################################################

[2024-06-09 03:46:54,906] : (STEP_2.1) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-06-09 03:46:54,907] : (STEP_2.1) Description : Reboot Device
[2024-06-09 03:46:54,907] : (STEP_2.1) Expected Result : Device should be rebootted
[2024-06-09 03:46:54,907] : (STEP_2.1) API Name : REBOOT
[2024-06-09 03:46:54,907] : (STEP_2.1) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-06-09 03:46:54,907] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-06-09 03:46:54,908] : STARTING METHOD: rebootAndWaitForIpAccusition()
[2024-06-09 03:46:54,908] : SSH Host IP : 192.168.162.209
[2024-06-09 03:46:54,972] : Default SSH custom port is set
<=========================== RESPONSE =======================>
test_connection

<=============================================================>
[2024-06-09 03:46:57,219] : Closing SSH connection from DeviceIP: 192.168.162.209
[2024-06-09 03:46:57,219] : Exiting method isDeviceAccessible. Status - true
[2024-06-09 03:46:57,219] : Entering executeCommandUsingSsh method
[2024-06-09 03:46:57,287] : Default SSH custom port is set
<=========================== RESPONSE =======================>

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

[2024-06-09 03:47:00,159] : Exiting executeCommandUsingSsh method
[2024-06-09 03:47:00,159] : Reboot wait time: 300000
[2024-06-09 03:47:00,159] : 300000 - Maximum waiting time to recover IP as per configuration : 5 minutes
[2024-06-09 03:47:00,159] : Maximum waiting time to recover IP after adding buffer time : 7 minutes
[2024-06-09 03:47:00,159] : Waiting for :2minutes, initial wait time
[2024-06-09 03:49:30,160] : Wait for another 150seconds to verify IP acquisition using existing IP
[2024-06-09 03:49:30,160] : Current Value - 0 Max Value : 150
[2024-06-09 03:49:30,160] : SSH Host IP : 192.168.162.209
[2024-06-09 03:49:30,225] : Default SSH custom port is set
<=========================== RESPONSE =======================>
test_connection

<=============================================================>
[2024-06-09 03:49:32,475] : Closing SSH connection from DeviceIP: 192.168.162.209
[2024-06-09 03:49:32,483] : Exiting method isDeviceAccessible. Status - true
[2024-06-09 03:49:32,483] : Device is accessible using IP : IPv4:192.168.162.209 IPv6: null for Build : rdkb Mac Address : E4:5F:01:FE:34:94
[2024-06-09 03:49:32,483] : Completed execution of waitForEstbIpAcquisition() : Status : true. Time taken : 2 minutes
[2024-06-09 03:49:32,483] : SSH Host IP : 192.168.162.209
[2024-06-09 03:49:32,573] : Default SSH custom port is set
<=========================== RESPONSE =======================>
test_connection

<=============================================================>
[2024-06-09 03:49:34,866] : Closing SSH connection from DeviceIP: 192.168.162.209
[2024-06-09 03:49:34,866] : Exiting method isDeviceAccessible. Status - true
[2024-06-09 03:49:34,866] : ENDING METHOD: rebootAndWaitForIpAccusition()
[2024-06-09 03:49:34,866] : Presence of parameter true in the command output : true
[2024-06-09 03:49:34,866] : >>>>>> ACTUAL OUTPUT: true
[2024-06-09 03:49:34,867] : >>>>>> EXPECTED OUTPUT: true
[2024-06-09 03:49:34,867] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-06-09 03:49:34,867] : >>>>>> VALIDATION STATUS: true
[2024-06-09 03:49:34,867] : >>>>>> INVERT RESULT: false
[2024-06-09 03:49:34,867] : (STEP_2.1) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-06-09 03:49:34,867] : (STEP_2.1)-[API Name: REBOOT]-[Execution Status: PASS]
[2024-06-09 03:49:34,867] : (STEP_2.1) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-06-09 03:49:34,868] : (STEP_2.2) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-06-09 03:49:34,868] : (STEP_2.2) Description : Wait for 1 minute
[2024-06-09 03:49:34,868] : (STEP_2.2) Expected Result : Device should be up
[2024-06-09 03:49:34,868] : (STEP_2.2) API Name : WAIT_TILL
[2024-06-09 03:49:34,868] : (STEP_2.2) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-06-09 03:49:34,868] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-06-09 03:50:34,875] : >>>>>> ACTUAL OUTPUT: null
[2024-06-09 03:50:34,875] : >>>>>> EXPECTED OUTPUT: NA
[2024-06-09 03:50:34,875] : >>>>>> VALIDATION PERFORMED: NA
[2024-06-09 03:50:34,875] : >>>>>> VALIDATION STATUS: true
[2024-06-09 03:50:34,875] : >>>>>> INVERT RESULT: false
[2024-06-09 03:50:34,875] : (STEP_2.2) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-06-09 03:50:34,875] : (STEP_2.2)-[API Name: WAIT_TILL]-[Execution Status: PASS]
[2024-06-09 03:50:34,875] : (STEP_2.2) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-06-09 03:50:34,876] : (STEP_2.3) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-06-09 03:50:34,876] : (STEP_2.3) Description : Enable webconfig - restart webconfig process
[2024-06-09 03:50:34,876] : (STEP_2.3) Expected Result : Webconfig process should active
[2024-06-09 03:50:34,876] : (STEP_2.3) API Name : EXECUTE_COMMAND
[2024-06-09 03:50:34,876] : (STEP_2.3) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-06-09 03:50:34,876] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-06-09 03:50:34,890] : Entering executeCommandUsingSsh method
[2024-06-09 03:50:34,952] : Default SSH custom port is set
<=========================== RESPONSE =======================>

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

[2024-06-09 03:50:37,212] : Exiting executeCommandUsingSsh method
[2024-06-09 03:50:37,212] : >>>>>> ACTUAL OUTPUT:

[2024-06-09 03:50:37,212] : >>>>>> EXPECTED OUTPUT: NA
[2024-06-09 03:50:37,212] : >>>>>> VALIDATION PERFORMED: NA
[2024-06-09 03:50:37,212] : >>>>>> VALIDATION STATUS: true
[2024-06-09 03:50:37,213] : >>>>>> INVERT RESULT: false
[2024-06-09 03:50:37,213] : (STEP_2.3) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-06-09 03:50:37,213] : (STEP_2.3)-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-06-09 03:50:37,213] : (STEP_2.3) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-06-09 03:50:37,213] : (STEP_2.4) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-06-09 03:50:37,213] : (STEP_2.4) Description : Enable webconfig - set Device.X_RDK_WebConfig.RfcEnable to true
[2024-06-09 03:50:37,213] : (STEP_2.4) Expected Result : Device.X_RDK_WebConfig.RfcEnable should set to true
[2024-06-09 03:50:37,213] : (STEP_2.4) API Name : EXECUTE_WEBPA_COMMAND
[2024-06-09 03:50:37,213] : (STEP_2.4) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-06-09 03:50:37,214] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-06-09 03:50:37,219] : AutomaticsScriptlessTapApi instance not available. Creating new instance
[2024-06-09 03:50:37,225] : Setting webpa Device.X_RDK_WebConfig.RfcEnable dataType 0 value true
[2024-06-09 03:50:37,227] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-06-09 03:50:37,228] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-06-09 03:50:37,229] : COMPLETE URL BUILD FOR "SET" IS : http://52.88.248.43:9003/api/v2/device/mac:E45F01FE3494/config
[2024-06-09 03:50:37,229] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-06-09 03:50:37,229] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-06-09 03:50:37,273] : REST CLIENT - Processing request
[2024-06-09 03:50:37,686] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:E45F01FE3494/config is - 520
[2024-06-09 03:50:37,687] : RESPONSE RECIEVED FOR WEBPA SET REQUEST: 520
[2024-06-09 03:50:37,688] : WEBPA RESPONSE : {"parameters":[{"name":"Device.X_RDK_WebConfig.RfcEnable","message":"Invalid parameter value"}],"statusCode":520}
[2024-06-09 03:50:37,688] : ENDING METHOD: setWebPaParameterValue : Invalid parameter value
[2024-06-09 03:50:37,688] : TR181 Response : {Device.X_RDK_WebConfig.RfcEnable=Invalid parameter value}
[2024-06-09 03:50:37,688] : Presence of parameter true in the command output : true
[2024-06-09 03:50:37,688] : >>>>>> ACTUAL OUTPUT: true
[2024-06-09 03:50:37,688] : >>>>>> EXPECTED OUTPUT: true
[2024-06-09 03:50:37,688] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-06-09 03:50:37,688] : >>>>>> VALIDATION STATUS: true
[2024-06-09 03:50:37,688] : >>>>>> INVERT RESULT: false
[2024-06-09 03:50:37,689] : (STEP_2.4) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-06-09 03:50:37,689] : (STEP_2.4)-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-06-09 03:50:37,689] : (STEP_2.4) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-06-09 03:50:37,689] : (STEP_2.5) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-06-09 03:50:37,689] : (STEP_2.5) Description : Check the status of webconfig
[2024-06-09 03:50:37,689] : (STEP_2.5) Expected Result : Webconfig process should be actice
[2024-06-09 03:50:37,689] : (STEP_2.5) API Name : EXECUTE_COMMAND
[2024-06-09 03:50:37,689] : (STEP_2.5) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-06-09 03:50:37,690] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-06-09 03:50:37,714] : Entering executeCommandUsingSsh method
[2024-06-09 03:50:37,803] : Default SSH custom port is set
<=========================== RESPONSE =======================>
● webconfig.service - webconfig service
Loaded: loaded ([]8;;file://RaspberryPi-Gateway/lib/systemd/system/webconfi
g.serviceG/lib/systemd/system/webconfig.service[]8;;G; enabled; vendor preset: e
nabled)
Active: active (running) since Sun 2024-06-09 03:50:37 UTC; 2s
ago
Main PID: 7249 (webconfig)
Tasks: 4 (limit: 4915)
CGroup: /system.slice/webconfig.service
└─ 7249 /usr/bin/webconfig

2024 Jun 09 03:50:37 RaspberryPi-Gateway systemd[1]: Started webconfig service.
2024 Jun 09 03:50:37 RaspberryPi-Gateway webconfig[7249]: rdk_dyn_log_initg_dl_s
ocket = 3 __progname = webconfig

~
~
~
~
~
~
~
~
standard input
<=============================================================>
Loaded: loaded ([]8;;file://RaspberryPi-Gateway/lib/systemd/system/webconfi
g.serviceG/lib/systemd/system/webconfig.service[]8;;G; enabled; vendor preset: e
nabled)
Active: active (running) since Sun 2024-06-09 03:50:37 UTC; 2s
ago
Main PID: 7249 (webconfig)
Tasks: 4 (limit: 4915)
CGroup: /system.slice/webconfig.service
└─ 7249 /usr/bin/webconfig

2024 Jun 09 03:50:37 RaspberryPi-Gateway systemd[1]: Started webconfig service.
2024 Jun 09 03:50:37 RaspberryPi-Gateway webconfig[7249]: rdk_dyn_log_initg_dl_s
ocket = 3 __progname = webconfig

~
~
~
~
~
~
~
~
standard input

[2024-06-09 04:00:40,226] : Exiting executeCommandUsingSsh method
[2024-06-09 04:00:40,226] : Presence of parameter active (running) in the command output : true
[2024-06-09 04:00:40,227] : >>>>>> ACTUAL OUTPUT: ● webconfig.service - webconfig service
Loaded: loaded ([]8;;file://RaspberryPi-Gateway/lib/systemd/system/webconfi
g.serviceG/lib/systemd/system/webconfig.service[]8;;G; enabled; vendor preset: e
nabled)
Active: active (running) since Sun 2024-06-09 03:50:37 UTC; 2s
ago
Main PID: 7249 (webconfig)
Tasks: 4 (limit: 4915)
CGroup: /system.slice/webconfig.service
└─ 7249 /usr/bin/webconfig

2024 Jun 09 03:50:37 RaspberryPi-Gateway systemd[1]: Started webconfig service.
2024 Jun 09 03:50:37 RaspberryPi-Gateway webconfig[7249]: rdk_dyn_log_initg_dl_s
ocket = 3 __progname = webconfig

~
~
~
~
~
~
~
~
standard input

[2024-06-09 04:00:40,227] : >>>>>> EXPECTED OUTPUT: active (running)
[2024-06-09 04:00:40,227] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-06-09 04:00:40,227] : >>>>>> VALIDATION STATUS: true
[2024-06-09 04:00:40,227] : >>>>>> INVERT RESULT: false
[2024-06-09 04:00:40,228] : (STEP_2.5) >>>>>>>>>>>>>>>>>>>>>>>>>
[2024-06-09 04:00:40,228] : (STEP_2.5)-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-06-09 04:00:40,228] : (STEP_2.5) >>>>>>>>>>>>>>>>>>>>>>>>>

[2024-06-09 04:00:40,228] : [STEP_2] #####################################################
[2024-06-09 04:00:40,228] : [STEP_2]-[API Name: ENABLE_WEBCONFIG]-[Execution Status: PASS]
[2024-06-09 04:00:40,228] : [STEP_2] #####################################################

[2024-06-09 04:00:40,230] : [STB MAC : E4:5F:01:FE:34:94][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000] [step Number : S2][ Execution status : PASS] [Error Message : ]
[2024-06-09 04:00:40,231] : Result Details ->{"JMD_ID":"2824","manualId":"3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000","stepNumber":"S2","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_TDK_rdkb-2024q1-kirkstone_20240319143212","macAddress":"E4:5F:01:FE:34:94","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000"}
[2024-06-09 04:00:40,301] : Execution result updated successfully

[2024-06-09 04:00:40,301] : [STEP_3] #####################################################
[2024-06-09 04:00:40,301] : [STEP_3] Description : Check if X-System-Supported-Docs is obtained in webconfig log.
[2024-06-09 04:00:40,301] : [STEP_3] Expected Result : Check if headerX-System-Supported-Docs is obtained after force supplementry sync in Webconfig.log file
[2024-06-09 04:00:40,301] : [STEP_3] API Name : SEARCH_IN_LOG
[2024-06-09 04:00:40,301] : [STEP_3] #####################################################

[2024-06-09 04:00:40,302] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-06-09 04:00:40,310] : COMMAND TO BE EXECUTED: grep -i X-System-Supported-Docs /rdklogs/logs/WEBCONFIGlog.txt.0
[2024-06-09 04:01:40,310] : Entering executeCommandUsingSsh method
[2024-06-09 04:01:40,374] : Default SSH custom port is set
<=========================== RESPONSE =======================>
240609-03:58:25.133986 [mod=WEBCONFIG, lvl=INFO] [tid=9283] WEBCONFIG: supportedDocs_header formed X-System-Supported-Docs: 16777247,33554435,50331649,67108865,83886081,100663297,117440513,134217729,201326594,218103809

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


[2024-06-09 04:01:42,563] : Exiting executeCommandUsingSsh method
[2024-06-09 04:01:42,563] : SEARCH RESPONSE FOR - X-System-Supported-Docs IN THE LOG FILE - /rdklogs/logs/WEBCONFIGlog.txt.0 IS : 240609-03:58:25.133986 [mod=WEBCONFIG, lvl=INFO] [tid=9283] WEBCONFIG: supportedDocs_header formed X-System-Supported-Docs: 16777247,33554435,50331649,67108865,83886081,100663297,117440513,134217729,201326594,218103809
[2024-06-09 04:01:42,563] : >>>>>> ACTUAL OUTPUT: 240609-03:58:25.133986 [mod=WEBCONFIG, lvl=INFO] [tid=9283] WEBCONFIG: supportedDocs_header formed X-System-Supported-Docs: 16777247,33554435,50331649,67108865,83886081,100663297,117440513,134217729,201326594,218103809
[2024-06-09 04:01:42,563] : >>>>>> EXPECTED OUTPUT: NA
[2024-06-09 04:01:42,563] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-06-09 04:01:42,563] : >>>>>> VALIDATION STATUS: true
[2024-06-09 04:01:42,564] : >>>>>> INVERT RESULT: false

[2024-06-09 04:01:42,564] : [STEP_3] #####################################################
[2024-06-09 04:01:42,564] : [STEP_3]-[API Name: SEARCH_IN_LOG]-[Execution Status: PASS]
[2024-06-09 04:01:42,564] : [STEP_3] #####################################################

[2024-06-09 04:01:42,566] : [STB MAC : E4:5F:01:FE:34:94][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000] [step Number : S3][ Execution status : PASS] [Error Message : ]
[2024-06-09 04:01:42,567] : Result Details ->{"JMD_ID":"2824","manualId":"3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000","stepNumber":"S3","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_TDK_rdkb-2024q1-kirkstone_20240319143212","macAddress":"E4:5F:01:FE:34:94","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000"}
[2024-06-09 04:01:42,635] : Execution result updated successfully

[2024-06-09 04:01:42,636] : [STEP_4] #####################################################
[2024-06-09 04:01:42,636] : [STEP_4] Description : Clear Webconfig.log
[2024-06-09 04:01:42,636] : [STEP_4] Expected Result : Logs should be cleared properly
[2024-06-09 04:01:42,636] : [STEP_4] API Name : EXECUTE_COMMAND
[2024-06-09 04:01:42,636] : [STEP_4] #####################################################

[2024-06-09 04:01:42,636] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-06-09 04:01:42,651] : Entering executeCommandUsingSsh method
[2024-06-09 04:01:42,733] : Default SSH custom port is set
<=========================== RESPONSE =======================>

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

[2024-06-09 04:01:44,990] : Exiting executeCommandUsingSsh method
[2024-06-09 04:01:44,990] : >>>>>> ACTUAL OUTPUT:

[2024-06-09 04:01:44,990] : >>>>>> EXPECTED OUTPUT: NA
[2024-06-09 04:01:44,990] : >>>>>> VALIDATION PERFORMED: NA
[2024-06-09 04:01:44,990] : >>>>>> VALIDATION STATUS: true
[2024-06-09 04:01:44,990] : >>>>>> INVERT RESULT: false

[2024-06-09 04:01:44,990] : [STEP_4] #####################################################
[2024-06-09 04:01:44,990] : [STEP_4]-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-06-09 04:01:44,990] : [STEP_4] #####################################################

[2024-06-09 04:01:44,991] : [STB MAC : E4:5F:01:FE:34:94][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000] [step Number : S4][ Execution status : PASS] [Error Message : ]
[2024-06-09 04:01:44,992] : Result Details ->{"JMD_ID":"2824","manualId":"3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000","stepNumber":"S4","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_TDK_rdkb-2024q1-kirkstone_20240319143212","macAddress":"E4:5F:01:FE:34:94","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000"}
[2024-06-09 04:01:45,008] : Execution result updated successfully

[2024-06-09 04:01:45,009] : [STEP_5] #####################################################
[2024-06-09 04:01:45,009] : [STEP_5] Description : Perform force supplementry sync
[2024-06-09 04:01:45,009] : [STEP_5] Expected Result : Value set of Device.X_RDK_WebConfig.ForceSync should be successful
[2024-06-09 04:01:45,009] : [STEP_5] API Name : EXECUTE_WEBPA_COMMAND
[2024-06-09 04:01:45,009] : [STEP_5] #####################################################

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

[2024-06-09 04:01:45,421] : [STEP_5] #####################################################
[2024-06-09 04:01:45,421] : [STEP_5]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-06-09 04:01:45,421] : [STEP_5] #####################################################

[2024-06-09 04:01:45,422] : [STB MAC : E4:5F:01:FE:34:94][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000] [step Number : S5][ Execution status : PASS] [Error Message : ]
[2024-06-09 04:01:45,423] : Result Details ->{"JMD_ID":"2824","manualId":"3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000","stepNumber":"S5","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_TDK_rdkb-2024q1-kirkstone_20240319143212","macAddress":"E4:5F:01:FE:34:94","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000"}
[2024-06-09 04:01:45,436] : Execution result updated successfully

[2024-06-09 04:01:45,436] : [STEP_6] #####################################################
[2024-06-09 04:01:45,436] : [STEP_6] Description : Check if X-System-Supported-Docs is obtained in webconfig log.
[2024-06-09 04:01:45,436] : [STEP_6] Expected Result : Check if headerX-System-Supported-Docs is obtained after force supplementry sync in Webconfig.log file
[2024-06-09 04:01:45,437] : [STEP_6] API Name : SEARCH_IN_LOG
[2024-06-09 04:01:45,437] : [STEP_6] #####################################################

[2024-06-09 04:01:45,437] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-06-09 04:01:45,443] : COMMAND TO BE EXECUTED: grep -i X-System-Supported-Docs /rdklogs/logs/WEBCONFIGlog.txt.0
[2024-06-09 04:02:45,443] : Entering executeCommandUsingSsh method
[2024-06-09 04:02:45,505] : Default SSH custom port is set
<=========================== RESPONSE =======================>
240609-04:01:45.334622 [mod=WEBCONFIG, lvl=INFO] [tid=9283] WEBCONFIG: supportedDocs_header formed X-System-Supported-Docs: 16777247,33554435,50331649,67108865,83886081,100663297,117440513,134217729,201326594,218103809

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


[2024-06-09 04:02:47,785] : Exiting executeCommandUsingSsh method
[2024-06-09 04:02:47,785] : SEARCH RESPONSE FOR - X-System-Supported-Docs IN THE LOG FILE - /rdklogs/logs/WEBCONFIGlog.txt.0 IS : 240609-04:01:45.334622 [mod=WEBCONFIG, lvl=INFO] [tid=9283] WEBCONFIG: supportedDocs_header formed X-System-Supported-Docs: 16777247,33554435,50331649,67108865,83886081,100663297,117440513,134217729,201326594,218103809
[2024-06-09 04:02:47,785] : >>>>>> ACTUAL OUTPUT: 240609-04:01:45.334622 [mod=WEBCONFIG, lvl=INFO] [tid=9283] WEBCONFIG: supportedDocs_header formed X-System-Supported-Docs: 16777247,33554435,50331649,67108865,83886081,100663297,117440513,134217729,201326594,218103809
[2024-06-09 04:02:47,785] : >>>>>> EXPECTED OUTPUT: NA
[2024-06-09 04:02:47,785] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-06-09 04:02:47,786] : >>>>>> VALIDATION STATUS: true
[2024-06-09 04:02:47,786] : >>>>>> INVERT RESULT: false

[2024-06-09 04:02:47,786] : [STEP_6] #####################################################
[2024-06-09 04:02:47,786] : [STEP_6]-[API Name: SEARCH_IN_LOG]-[Execution Status: PASS]
[2024-06-09 04:02:47,786] : [STEP_6] #####################################################

[2024-06-09 04:02:47,787] : [STB MAC : E4:5F:01:FE:34:94][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000] [step Number : S6][ Execution status : PASS] [Error Message : ]
[2024-06-09 04:02:47,787] : Result Details ->{"JMD_ID":"2824","manualId":"3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000","stepNumber":"S6","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_TDK_rdkb-2024q1-kirkstone_20240319143212","macAddress":"E4:5F:01:FE:34:94","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000"}
[2024-06-09 04:02:47,803] : Execution result updated successfully

[2024-06-09 04:02:47,803] : [STEP_7] #####################################################
[2024-06-09 04:02:47,803] : [STEP_7] Description : Check if X-System-Schema-Version / supportedVersion fetched is NULL is obtained in webconfig log.
[2024-06-09 04:02:47,803] : [STEP_7] Expected Result : Check if headerX-System-Schema-Version /supportedVersion fetched is NULLis obtained after force supplementry sync in Webconfig.log file
[2024-06-09 04:02:47,803] : [STEP_7] API Name : SEARCH_IN_LOG
[2024-06-09 04:02:47,803] : [STEP_7] #####################################################

[2024-06-09 04:02:47,804] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-06-09 04:02:47,809] : COMMAND TO BE EXECUTED: grep -i "supportedVersion fetched is NULL" /rdklogs/logs/WEBCONFIGlog.txt.0
[2024-06-09 04:03:47,810] : Entering executeCommandUsingSsh method
[2024-06-09 04:03:47,873] : Default SSH custom port is set
<=========================== RESPONSE =======================>
240609-04:01:45.334583 [mod=WEBCONFIG, lvl=INFO] [tid=9283] WEBCONFIG: supportedVersion fetched is NULL

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


[2024-06-09 04:03:50,127] : Exiting executeCommandUsingSsh method
[2024-06-09 04:03:50,127] : SEARCH RESPONSE FOR - supportedVersion fetched is NULL IN THE LOG FILE - /rdklogs/logs/WEBCONFIGlog.txt.0 IS : 240609-04:01:45.334583 [mod=WEBCONFIG, lvl=INFO] [tid=9283] WEBCONFIG: supportedVersion fetched is NULL
[2024-06-09 04:03:50,128] : >>>>>> ACTUAL OUTPUT: 240609-04:01:45.334583 [mod=WEBCONFIG, lvl=INFO] [tid=9283] WEBCONFIG: supportedVersion fetched is NULL
[2024-06-09 04:03:50,128] : >>>>>> EXPECTED OUTPUT: NA
[2024-06-09 04:03:50,128] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-06-09 04:03:50,128] : >>>>>> VALIDATION STATUS: true
[2024-06-09 04:03:50,128] : >>>>>> INVERT RESULT: false

[2024-06-09 04:03:50,128] : [STEP_7] #####################################################
[2024-06-09 04:03:50,128] : [STEP_7]-[API Name: SEARCH_IN_LOG]-[Execution Status: PASS]
[2024-06-09 04:03:50,128] : [STEP_7] #####################################################

[2024-06-09 04:03:50,129] : [STB MAC : E4:5F:01:FE:34:94][ Manual test ID : 3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000] [step Number : S7][ Execution status : PASS] [Error Message : ]
[2024-06-09 04:03:50,130] : Result Details ->{"JMD_ID":"2824","manualId":"3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000","stepNumber":"S7","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_TDK_rdkb-2024q1-kirkstone_20240319143212","macAddress":"E4:5F:01:FE:34:94","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"3DOT0-TC-RDKB-WEBCONFIG-PRISUPHDR-1000"}
[2024-06-09 04:03:50,156] : Execution result updated successfully
[2024-06-09 04:03:50,156] : Execution Completed in settop -E4:5F:01:FE:34:94
[2024-06-09 04:03:50,157] : Mac:: E4:5F:01:FE:34:94 Status:: true Total Count:: 0