TEST SESSION LOGS


DEVICE MAC ADDRESS:D83ADD0A430E
TEST CASE ID:TC-RDKB-RFC-SUBDOC-1000
FIRMWARE:rdkb-generic-broadband-image_rdk-next_20240918011910

[2024-09-23 10:01:58,315] : ###STARTING TEST CASE: TC-RDKB-RFC-SUBDOC-1000
[2024-09-23 10:01:58,341] : Starting execution in settop -D8:3A:DD:0A:43:0E
[2024-09-23 10:01:58,344] : # STEP_PRE_1 : Display the partner id of the device #
[2024-09-23 10:01:58,344] : # STEP_PRE_2 : Get the mac of device #
[2024-09-23 10:01:58,351] : # STEP_PRE_3 : Set the webconfig URL #
[2024-09-23 10:01:58,351] : # STEP_PRE_4 : Dispaly the webconfig.URL #
[2024-09-23 10:01:58,351] : # STEP_1 : Trigger ForceSync with cloud #
[2024-09-23 10:01:58,352] : # STEP_2 : Verify webconfig.properties file is updated with defaultrfc, rfc true #
[2024-09-23 10:01:58,352] : # STEP_3 : Verify webconfig logs the defaultrfc subdoc is received from cloud and applied to device #
[2024-09-23 10:01:58,352] : # STEP_4 : Get the supported subdocs header from webconfig.properties file #
[2024-09-23 10:01:58,352] : # STEP_5 : Get the subdocs header from webconfig logs during cloud sync #
[2024-09-23 10:01:58,352] : # STEP_6 : Validate all the subdocs header are received #
[2024-09-23 10:01:58,352] : # STEP_7 : Get the RFC supported subdocs header from webconfig.properties file #
[2024-09-23 10:01:58,352] : # STEP_8 : Get the RFC supported subdocs header from webconfig.properties file #
[2024-09-23 10:01:58,352] : # STEP_9 : Verify RFC supported subdocs header is logged in webconfig logs #
[2024-09-23 10:01:58,352] : # STEP_10 : Verify RFC supported subdocs header is logged in webconfig logs #

[2024-09-23 10:01:58,353] : [STEP_PRE_1] #####################################################
[2024-09-23 10:01:58,353] : [STEP_PRE_1] Description : Display the partner id of the device
[2024-09-23 10:01:58,354] : [STEP_PRE_1] Expected Result : Partner ID should be displayed
[2024-09-23 10:01:58,354] : [STEP_PRE_1] API Name : EXECUTE_COMMAND
[2024-09-23 10:01:58,354] : [STEP_PRE_1] #####################################################

[2024-09-23 10:01:58,367] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-09-23 10:01:58,368] : Packages to scan : com.automatics.,com.rdkm
[2024-09-23 10:01:58,648] : Total APIs :: 174
[2024-09-23 10:01:58,672] : Entering executeCommandUsingSsh method
[2024-09-23 10:01:58,788] : Default SSH custom port is set
<=========================== RESPONSE =======================>
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
Execution succeed.
Parameter 1 name: Device.DeviceInfo.X_RDKCENTRAL-COM_Syndication.PartnerId
type: string, value: RDKM

<=============================================================>
subsystem_prefix eRT.
Execution succeed.
Parameter 1 name: Device.DeviceInfo.X_RDKCENTRAL-COM_Syndication.PartnerId
type: string, value: RDKM


[2024-09-23 10:02:00,951] : Exiting executeCommandUsingSsh method
[2024-09-23 10:02:00,956] : Presence of parameter Execution succeed in the command output : true
[2024-09-23 10:02:00,956] : >>>>>> ACTUAL OUTPUT: CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
Execution succeed.
Parameter 1 name: Device.DeviceInfo.X_RDKCENTRAL-COM_Syndication.PartnerId
type: string, value: RDKM


[2024-09-23 10:02:00,956] : >>>>>> EXPECTED OUTPUT: Execution succeed
[2024-09-23 10:02:00,956] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-09-23 10:02:00,956] : >>>>>> VALIDATION STATUS: true
[2024-09-23 10:02:00,957] : >>>>>> INVERT RESULT: false

[2024-09-23 10:02:00,957] : [STEP_PRE_1] #####################################################
[2024-09-23 10:02:00,958] : [STEP_PRE_1]-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-09-23 10:02:00,958] : [STEP_PRE_1] #####################################################

[2024-09-23 10:02:00,976] : [STB MAC : D8:3A:DD:0A:43:0E][ Manual test ID : PRE_TC-RDKB-RFC-SUBDOC-1000] [step Number : S1][ Execution status : PASS] [Error Message : ]
[2024-09-23 10:02:00,977] : Entered into updateExecutionStatus method
[2024-09-23 10:02:00,979] : Fetching device property: FIRMWARE_VERSION
[2024-09-23 10:02:00,988] : Fetching device props for D8:3A:DD:0A:43:0E for props [FIRMWARE_VERSION] Url Path: https://automatics-apps.rdkcentral.com/DeviceManager/deviceManagement/getDeviceProps
[2024-09-23 10:02:01,084] : Response: {"mac":"D8:3A:DD:0A:43:0E","HEAD_END":null,"FIRMWARE_VERSION":"rdkb-generic","ECM_IP_ADDRESS":null,"ESTB_IP_ADDRESS":null}
[2024-09-23 10:02:01,084] : Getting value for property: FIRMWARE_VERSION
[2024-09-23 10:02:01,085] : Value: rdkb-generic
[2024-09-23 10:02:01,085] : Device property name: FIRMWARE_VERSION value obtained: rdkb-generic
[2024-09-23 10:02:01,087] : Result Details ->{"JMD_ID":"95035","manualId":"PRE_TC-RDKB-RFC-SUBDOC-1000","stepNumber":"S1","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_rdk-next_20240918011910","macAddress":"D8:3A:DD:0A:43:0E","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"TC-RDKB-RFC-SUBDOC-1000"}
[2024-09-23 10:02:01,120] : Execution result updated successfully
[2024-09-23 10:02:01,120] : Exited from updateExecutionStatus method

[2024-09-23 10:02:01,121] : [STEP_PRE_2] #####################################################
[2024-09-23 10:02:01,121] : [STEP_PRE_2] Description : Get the mac of device
[2024-09-23 10:02:01,121] : [STEP_PRE_2] Expected Result : CM Mac should be obtained
[2024-09-23 10:02:01,121] : [STEP_PRE_2] API Name : EXECUTE_WEBPA_COMMAND
[2024-09-23 10:02:01,121] : [STEP_PRE_2] #####################################################

[2024-09-23 10:02:01,122] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-09-23 10:02:01,137] : AutomaticsScriptlessTapApi instance not available. Creating new instance
[2024-09-23 10:02:01,138] : TR181 Access Method: WEBPA
[2024-09-23 10:02:01,140] : getWebPaParamValue: Device.DeviceInfo.X_COMCAST-COM_CM_MAC
[2024-09-23 10:02:01,141] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-09-23 10:02:01,141] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-09-23 10:02:01,142] : COMPLETE URL BUILD FOR "GET" IS : http://52.88.248.43:9003/api/v2/device/mac:D83ADD0A430E/config?names=Device.DeviceInfo.X_COMCAST-COM_CM_MAC
[2024-09-23 10:02:01,142] : Reading webpaProvider from partner partner-applicationContext.xml
[2024-09-23 10:02:01,142] : Since webpaProvider not configured in partner, reading default implementation in Automatics.
[2024-09-23 10:02:01,145] : REST CLIENT - Processing request
[2024-09-23 10:02:01,585] : REST CLIENT - Response from - http://52.88.248.43:9003/api/v2/device/mac:D83ADD0A430E/config?names=Device.DeviceInfo.X_COMCAST-COM_CM_MAC is - 200
[2024-09-23 10:02:01,587] : RESPONSE RECIEVED FOR WEBPA GET REQUEST: 200
[2024-09-23 10:02:01,587] : WEBPA RESPONSE : {"parameters":[{"name":"Device.DeviceInfo.X_COMCAST-COM_CM_MAC","value":"D8:3A:DD:0A:43:0E","dataType":0,"parameterCount":1,"message":"Success"}],"statusCode":200}
[2024-09-23 10:02:01,589] : WebPa data type: STRING
[2024-09-23 10:02:01,589] : TR181 parametrs status code added 0
[2024-09-23 10:02:01,590] : TR181 Response : [tableName=null, index=null, name=Device.DeviceInfo.X_COMCAST-COM_CM_MAC, protocolSpecificParamName=null, value=D8:3A:DD:0A:43:0E, datatype=STRING, statusCode=0]
[2024-09-23 10:02:01,590] : >>>>>> ACTUAL OUTPUT: D8:3A:DD:0A:43:0E
[2024-09-23 10:02:01,590] : >>>>>> EXPECTED OUTPUT: NA
[2024-09-23 10:02:01,590] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-09-23 10:02:01,590] : >>>>>> VALIDATION STATUS: true
[2024-09-23 10:02:01,590] : >>>>>> INVERT RESULT: false

[2024-09-23 10:02:01,590] : [STEP_PRE_2] #####################################################
[2024-09-23 10:02:01,590] : [STEP_PRE_2]-[API Name: EXECUTE_WEBPA_COMMAND]-[Execution Status: PASS]
[2024-09-23 10:02:01,591] : [STEP_PRE_2] #####################################################

[2024-09-23 10:02:01,593] : [STB MAC : D8:3A:DD:0A:43:0E][ Manual test ID : PRE_TC-RDKB-RFC-SUBDOC-1000] [step Number : S2][ Execution status : PASS] [Error Message : ]
[2024-09-23 10:02:01,593] : Entered into updateExecutionStatus method
[2024-09-23 10:02:01,594] : Result Details ->{"JMD_ID":"95035","manualId":"PRE_TC-RDKB-RFC-SUBDOC-1000","stepNumber":"S2","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_rdk-next_20240918011910","macAddress":"D8:3A:DD:0A:43:0E","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"TC-RDKB-RFC-SUBDOC-1000"}
[2024-09-23 10:02:01,608] : Execution result updated successfully
[2024-09-23 10:02:01,608] : Exited from updateExecutionStatus method

[2024-09-23 10:02:01,609] : [STEP_PRE_3] #####################################################
[2024-09-23 10:02:01,609] : [STEP_PRE_3] Description : Set the webconfig URL
[2024-09-23 10:02:01,609] : [STEP_PRE_3] Expected Result : Webconfig URL should be set
[2024-09-23 10:02:01,609] : [STEP_PRE_3] API Name : EXECUTE_COMMAND
[2024-09-23 10:02:01,609] : [STEP_PRE_3] #####################################################

[2024-09-23 10:02:01,610] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-09-23 10:02:01,610] : [BEFORE]: dmcli eRT setv Device.X_RDK_WebConfig.URL string http://webconfig.rdkcentral.com:9007/api/v1/device/{{ecmmac}}/config
[2024-09-23 10:02:01,610] : [AFTER]: dmcli eRT setv Device.X_RDK_WebConfig.URL string http://webconfig.rdkcentral.com:9007/api/v1/device/D8:3A:DD:0A:43:0E/config
[2024-09-23 10:02:01,627] : Entering executeCommandUsingSsh method
[2024-09-23 10:02:01,690] : Default SSH custom port is set
<=========================== RESPONSE =======================>
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
Execution succeed.

<=============================================================>
subsystem_prefix eRT.
Execution succeed.


[2024-09-23 10:02:03,819] : Exiting executeCommandUsingSsh method
[2024-09-23 10:02:03,819] : Presence of parameter Execution succeed in the command output : true
[2024-09-23 10:02:03,819] : >>>>>> ACTUAL OUTPUT: CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
Execution succeed.


[2024-09-23 10:02:03,819] : >>>>>> EXPECTED OUTPUT: Execution succeed
[2024-09-23 10:02:03,819] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-09-23 10:02:03,819] : >>>>>> VALIDATION STATUS: true
[2024-09-23 10:02:03,819] : >>>>>> INVERT RESULT: false

[2024-09-23 10:02:03,819] : [STEP_PRE_3] #####################################################
[2024-09-23 10:02:03,819] : [STEP_PRE_3]-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-09-23 10:02:03,819] : [STEP_PRE_3] #####################################################

[2024-09-23 10:02:03,821] : [STB MAC : D8:3A:DD:0A:43:0E][ Manual test ID : PRE_TC-RDKB-RFC-SUBDOC-1000] [step Number : S3][ Execution status : PASS] [Error Message : ]
[2024-09-23 10:02:03,821] : Entered into updateExecutionStatus method
[2024-09-23 10:02:03,822] : Result Details ->{"JMD_ID":"95035","manualId":"PRE_TC-RDKB-RFC-SUBDOC-1000","stepNumber":"S3","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_rdk-next_20240918011910","macAddress":"D8:3A:DD:0A:43:0E","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"TC-RDKB-RFC-SUBDOC-1000"}
[2024-09-23 10:02:03,834] : Execution result updated successfully
[2024-09-23 10:02:03,834] : Exited from updateExecutionStatus method

[2024-09-23 10:02:03,834] : [STEP_PRE_4] #####################################################
[2024-09-23 10:02:03,834] : [STEP_PRE_4] Description : Dispaly the webconfig.URL
[2024-09-23 10:02:03,834] : [STEP_PRE_4] Expected Result : Webconfig URL should be set
[2024-09-23 10:02:03,835] : [STEP_PRE_4] API Name : EXECUTE_COMMAND
[2024-09-23 10:02:03,835] : [STEP_PRE_4] #####################################################

[2024-09-23 10:02:03,835] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-09-23 10:02:03,844] : Entering executeCommandUsingSsh method
[2024-09-23 10:02:03,909] : Default SSH custom port is set
<=========================== RESPONSE =======================>
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
Execution succeed.
Parameter 1 name: Device.X_RDK_WebConfig.URL
type: string, value: http://webconfig.rdkcentral.com:9007/api/v1/device/D8:3A:DD:0A:43:0E/config

<=============================================================>
subsystem_prefix eRT.
Execution succeed.
Parameter 1 name: Device.X_RDK_WebConfig.URL
type: string, value: http://webconfig.rdkcentral.com:9007/api/v1/device/D8:3A:DD:0A:43:0E/config


[2024-09-23 10:02:06,041] : Exiting executeCommandUsingSsh method
[2024-09-23 10:02:06,041] : >>>>>> ACTUAL OUTPUT: CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
Execution succeed.
Parameter 1 name: Device.X_RDK_WebConfig.URL
type: string, value: http://webconfig.rdkcentral.com:9007/api/v1/device/D8:3A:DD:0A:43:0E/config


[2024-09-23 10:02:06,041] : >>>>>> EXPECTED OUTPUT: NA
[2024-09-23 10:02:06,041] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-09-23 10:02:06,041] : >>>>>> VALIDATION STATUS: true
[2024-09-23 10:02:06,041] : >>>>>> INVERT RESULT: false

[2024-09-23 10:02:06,042] : [STEP_PRE_4] #####################################################
[2024-09-23 10:02:06,042] : [STEP_PRE_4]-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-09-23 10:02:06,042] : [STEP_PRE_4] #####################################################

[2024-09-23 10:02:06,044] : [STB MAC : D8:3A:DD:0A:43:0E][ Manual test ID : PRE_TC-RDKB-RFC-SUBDOC-1000] [step Number : S4][ Execution status : PASS] [Error Message : ]
[2024-09-23 10:02:06,044] : Entered into updateExecutionStatus method
[2024-09-23 10:02:06,044] : Result Details ->{"JMD_ID":"95035","manualId":"PRE_TC-RDKB-RFC-SUBDOC-1000","stepNumber":"S4","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_rdk-next_20240918011910","macAddress":"D8:3A:DD:0A:43:0E","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"TC-RDKB-RFC-SUBDOC-1000"}
[2024-09-23 10:02:06,056] : Execution result updated successfully
[2024-09-23 10:02:06,056] : Exited from updateExecutionStatus method

[2024-09-23 10:02:06,056] : [STEP_1] #####################################################
[2024-09-23 10:02:06,056] : [STEP_1] Description : Trigger ForceSync with cloud
[2024-09-23 10:02:06,056] : [STEP_1] Expected Result : ForceSync should be triggered to sync with cloud
[2024-09-23 10:02:06,057] : [STEP_1] API Name : EXECUTE_COMMAND
[2024-09-23 10:02:06,057] : [STEP_1] #####################################################

[2024-09-23 10:02:06,057] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-09-23 10:02:06,066] : Entering executeCommandUsingSsh method
[2024-09-23 10:02:06,128] : Default SSH custom port is set
<=========================== RESPONSE =======================>
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
Execution succeed.

<=============================================================>
subsystem_prefix eRT.
Execution succeed.


[2024-09-23 10:02:08,325] : Exiting executeCommandUsingSsh method
[2024-09-23 10:02:08,325] : Presence of parameter Execution succeed in the command output : true
[2024-09-23 10:02:08,325] : >>>>>> ACTUAL OUTPUT: CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
Execution succeed.


[2024-09-23 10:02:08,325] : >>>>>> EXPECTED OUTPUT: Execution succeed
[2024-09-23 10:02:08,325] : >>>>>> VALIDATION PERFORMED: CONTAINS
[2024-09-23 10:02:08,325] : >>>>>> VALIDATION STATUS: true
[2024-09-23 10:02:08,325] : >>>>>> INVERT RESULT: false

[2024-09-23 10:02:08,325] : [STEP_1] #####################################################
[2024-09-23 10:02:08,325] : [STEP_1]-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-09-23 10:02:08,326] : [STEP_1] #####################################################

[2024-09-23 10:02:08,327] : [STB MAC : D8:3A:DD:0A:43:0E][ Manual test ID : TC-RDKB-RFC-SUBDOC-1000] [step Number : S1][ Execution status : PASS] [Error Message : ]
[2024-09-23 10:02:08,328] : Entered into updateExecutionStatus method
[2024-09-23 10:02:08,328] : Result Details ->{"JMD_ID":"95035","manualId":"TC-RDKB-RFC-SUBDOC-1000","stepNumber":"S1","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_rdk-next_20240918011910","macAddress":"D8:3A:DD:0A:43:0E","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"TC-RDKB-RFC-SUBDOC-1000"}
[2024-09-23 10:02:08,346] : Execution result updated successfully
[2024-09-23 10:02:08,346] : Exited from updateExecutionStatus method

[2024-09-23 10:02:08,346] : [STEP_2] #####################################################
[2024-09-23 10:02:08,346] : [STEP_2] Description : Verify webconfig.properties file is updated with defaultrfc, rfc true
[2024-09-23 10:02:08,346] : [STEP_2] Expected Result : defaultrfc and rfc subdocs should be set to true by default
[2024-09-23 10:02:08,346] : [STEP_2] API Name : EXECUTE_COMMAND
[2024-09-23 10:02:08,346] : [STEP_2] #####################################################

[2024-09-23 10:02:08,347] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-09-23 10:02:08,362] : Entering executeCommandUsingSsh method
[2024-09-23 10:02:08,422] : Default SSH custom port is set
<=========================== RESPONSE =======================>
WEBCONFIG_SUBDOC_MAP_8=telemetry:1:true

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


[2024-09-23 10:02:10,574] : Exiting executeCommandUsingSsh method
[2024-09-23 10:02:10,574] : >>>>>> ACTUAL OUTPUT: WEBCONFIG_SUBDOC_MAP_8=telemetry:1:true


[2024-09-23 10:02:10,574] : >>>>>> EXPECTED OUTPUT: NA
[2024-09-23 10:02:10,574] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-09-23 10:02:10,574] : >>>>>> VALIDATION STATUS: true
[2024-09-23 10:02:10,574] : >>>>>> INVERT RESULT: false

[2024-09-23 10:02:10,574] : [STEP_2] #####################################################
[2024-09-23 10:02:10,574] : [STEP_2]-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-09-23 10:02:10,574] : [STEP_2] #####################################################

[2024-09-23 10:02:10,576] : [STB MAC : D8:3A:DD:0A:43:0E][ Manual test ID : TC-RDKB-RFC-SUBDOC-1000] [step Number : S2][ Execution status : PASS] [Error Message : ]
[2024-09-23 10:02:10,576] : Entered into updateExecutionStatus method
[2024-09-23 10:02:10,576] : Result Details ->{"JMD_ID":"95035","manualId":"TC-RDKB-RFC-SUBDOC-1000","stepNumber":"S2","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_rdk-next_20240918011910","macAddress":"D8:3A:DD:0A:43:0E","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"TC-RDKB-RFC-SUBDOC-1000"}
[2024-09-23 10:02:10,589] : Execution result updated successfully
[2024-09-23 10:02:10,589] : Exited from updateExecutionStatus method

[2024-09-23 10:02:10,589] : [STEP_3] #####################################################
[2024-09-23 10:02:10,589] : [STEP_3] Description : Verify webconfig logs the defaultrfc subdoc is received from cloud and applied to device
[2024-09-23 10:02:10,589] : [STEP_3] Expected Result : webconfig logs should log the defaultrfc subdoc is received from cloud and applied successfully
[2024-09-23 10:02:10,589] : [STEP_3] API Name : EXECUTE_COMMAND
[2024-09-23 10:02:10,589] : [STEP_3] #####################################################

[2024-09-23 10:02:10,590] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-09-23 10:02:10,606] : Entering executeCommandUsingSsh method
[2024-09-23 10:02:10,673] : Default SSH custom port is set
<=========================== RESPONSE =======================>
240923-10:02:08.196531 [mod=WEBCONFIG, lvl=INFO] [tid=3631] WEBCONFIG: docList fetched root

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


[2024-09-23 10:02:12,807] : Exiting executeCommandUsingSsh method
[2024-09-23 10:02:12,807] : >>>>>> ACTUAL OUTPUT: 240923-10:02:08.196531 [mod=WEBCONFIG, lvl=INFO] [tid=3631] WEBCONFIG: docList fetched root


[2024-09-23 10:02:12,807] : >>>>>> EXPECTED OUTPUT: NA
[2024-09-23 10:02:12,807] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-09-23 10:02:12,807] : >>>>>> VALIDATION STATUS: true
[2024-09-23 10:02:12,807] : >>>>>> INVERT RESULT: false

[2024-09-23 10:02:12,808] : [STEP_3] #####################################################
[2024-09-23 10:02:12,808] : [STEP_3]-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-09-23 10:02:12,808] : [STEP_3] #####################################################

[2024-09-23 10:02:12,809] : [STB MAC : D8:3A:DD:0A:43:0E][ Manual test ID : TC-RDKB-RFC-SUBDOC-1000] [step Number : S3][ Execution status : PASS] [Error Message : ]
[2024-09-23 10:02:12,809] : Entered into updateExecutionStatus method
[2024-09-23 10:02:12,809] : Result Details ->{"JMD_ID":"95035","manualId":"TC-RDKB-RFC-SUBDOC-1000","stepNumber":"S3","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_rdk-next_20240918011910","macAddress":"D8:3A:DD:0A:43:0E","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"TC-RDKB-RFC-SUBDOC-1000"}
[2024-09-23 10:02:12,823] : Execution result updated successfully
[2024-09-23 10:02:12,823] : Exited from updateExecutionStatus method

[2024-09-23 10:02:12,823] : [STEP_4] #####################################################
[2024-09-23 10:02:12,823] : [STEP_4] Description : Get the supported subdocs header from webconfig.properties file
[2024-09-23 10:02:12,823] : [STEP_4] Expected Result : Headers of all available subdocs should be present
[2024-09-23 10:02:12,823] : [STEP_4] API Name : EXECUTE_COMMAND
[2024-09-23 10:02:12,823] : [STEP_4] #####################################################

[2024-09-23 10:02:12,824] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-09-23 10:02:12,833] : Entering executeCommandUsingSsh method
[2024-09-23 10:02:12,894] : Default SSH custom port is set
<=========================== RESPONSE =======================>
16777247,33554435,50331649,67108865,83886081,100663297,117440513,134217729,201326594,218103809

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


[2024-09-23 10:02:15,030] : Exiting executeCommandUsingSsh method
[2024-09-23 10:02:15,030] : >>>>>> ACTUAL OUTPUT: 16777247,33554435,50331649,67108865,83886081,100663297,117440513,134217729,201326594,218103809


[2024-09-23 10:02:15,030] : >>>>>> EXPECTED OUTPUT: NA
[2024-09-23 10:02:15,030] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-09-23 10:02:15,030] : >>>>>> VALIDATION STATUS: true
[2024-09-23 10:02:15,030] : >>>>>> INVERT RESULT: false

[2024-09-23 10:02:15,030] : [STEP_4] #####################################################
[2024-09-23 10:02:15,030] : [STEP_4]-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-09-23 10:02:15,030] : [STEP_4] #####################################################

[2024-09-23 10:02:15,032] : [STB MAC : D8:3A:DD:0A:43:0E][ Manual test ID : TC-RDKB-RFC-SUBDOC-1000] [step Number : S4][ Execution status : PASS] [Error Message : ]
[2024-09-23 10:02:15,032] : Entered into updateExecutionStatus method
[2024-09-23 10:02:15,034] : Result Details ->{"JMD_ID":"95035","manualId":"TC-RDKB-RFC-SUBDOC-1000","stepNumber":"S4","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_rdk-next_20240918011910","macAddress":"D8:3A:DD:0A:43:0E","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"TC-RDKB-RFC-SUBDOC-1000"}
[2024-09-23 10:02:15,049] : Execution result updated successfully
[2024-09-23 10:02:15,049] : Exited from updateExecutionStatus method

[2024-09-23 10:02:15,049] : [STEP_5] #####################################################
[2024-09-23 10:02:15,049] : [STEP_5] Description : Get the subdocs header from webconfig logs during cloud sync
[2024-09-23 10:02:15,049] : [STEP_5] Expected Result : Subdocs header available should be populated
[2024-09-23 10:02:15,049] : [STEP_5] API Name : EXECUTE_COMMAND
[2024-09-23 10:02:15,049] : [STEP_5] #####################################################

[2024-09-23 10:02:15,050] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-09-23 10:02:15,069] : Entering executeCommandUsingSsh method
[2024-09-23 10:02:15,147] : Default SSH custom port is set
<=========================== RESPONSE =======================>
16777247,33554435,50331649,67108865,83886081,100663297,117440513,134217729,201326594,218103809

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


[2024-09-23 10:02:17,264] : Exiting executeCommandUsingSsh method
[2024-09-23 10:02:17,265] : >>>>>> ACTUAL OUTPUT: 16777247,33554435,50331649,67108865,83886081,100663297,117440513,134217729,201326594,218103809


[2024-09-23 10:02:17,265] : >>>>>> EXPECTED OUTPUT: NA
[2024-09-23 10:02:17,265] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-09-23 10:02:17,265] : >>>>>> VALIDATION STATUS: true
[2024-09-23 10:02:17,265] : >>>>>> INVERT RESULT: false

[2024-09-23 10:02:17,265] : [STEP_5] #####################################################
[2024-09-23 10:02:17,265] : [STEP_5]-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-09-23 10:02:17,265] : [STEP_5] #####################################################

[2024-09-23 10:02:17,267] : [STB MAC : D8:3A:DD:0A:43:0E][ Manual test ID : TC-RDKB-RFC-SUBDOC-1000] [step Number : S5][ Execution status : PASS] [Error Message : ]
[2024-09-23 10:02:17,267] : Entered into updateExecutionStatus method
[2024-09-23 10:02:17,267] : Result Details ->{"JMD_ID":"95035","manualId":"TC-RDKB-RFC-SUBDOC-1000","stepNumber":"S5","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_rdk-next_20240918011910","macAddress":"D8:3A:DD:0A:43:0E","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"TC-RDKB-RFC-SUBDOC-1000"}
[2024-09-23 10:02:17,280] : Execution result updated successfully
[2024-09-23 10:02:17,280] : Exited from updateExecutionStatus method

[2024-09-23 10:02:17,280] : [STEP_6] #####################################################
[2024-09-23 10:02:17,280] : [STEP_6] Description : Validate all the subdocs header are received
[2024-09-23 10:02:17,280] : [STEP_6] Expected Result :
[2024-09-23 10:02:17,280] : [STEP_6] API Name : IF
[2024-09-23 10:02:17,280] : [STEP_6] #####################################################

[2024-09-23 10:02:17,280] : [BEFORE]: {{docOut}}
[2024-09-23 10:02:17,280] : [AFTER]: 16777247,33554435,50331649,67108865,83886081,100663297,117440513,134217729,201326594,218103809
[2024-09-23 10:02:17,280] : [BEFORE]: {{verOut}}
[2024-09-23 10:02:17,280] : [AFTER]: 16777247,33554435,50331649,67108865,83886081,100663297,117440513,134217729,201326594,218103809
[2024-09-23 10:02:17,280] : >>>>>> ACTUAL OUTPUT: 16777247,33554435,50331649,67108865,83886081,100663297,117440513,134217729,201326594,218103809
[2024-09-23 10:02:17,281] : >>>>>> EXPECTED OUTPUT: 16777247,33554435,50331649,67108865,83886081,100663297,117440513,134217729,201326594,218103809
[2024-09-23 10:02:17,281] : >>>>>> VALIDATION PERFORMED: EQUALS
[2024-09-23 10:02:17,281] : >>>>>> VALIDATION STATUS: true
[2024-09-23 10:02:17,281] : >>>>>> INVERT RESULT: false

[2024-09-23 10:02:17,281] : [STEP_6] #####################################################
[2024-09-23 10:02:17,281] : [STEP_6]-[API Name: IF]-[Execution Status: PASS]
[2024-09-23 10:02:17,281] : [STEP_6] #####################################################

[2024-09-23 10:02:17,282] : [STB MAC : D8:3A:DD:0A:43:0E][ Manual test ID : TC-RDKB-RFC-SUBDOC-1000] [step Number : S6][ Execution status : PASS] [Error Message : ]
[2024-09-23 10:02:17,282] : Entered into updateExecutionStatus method
[2024-09-23 10:02:17,283] : Result Details ->{"JMD_ID":"95035","manualId":"TC-RDKB-RFC-SUBDOC-1000","stepNumber":"S6","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_rdk-next_20240918011910","macAddress":"D8:3A:DD:0A:43:0E","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"TC-RDKB-RFC-SUBDOC-1000"}
[2024-09-23 10:02:17,295] : Execution result updated successfully
[2024-09-23 10:02:17,295] : Exited from updateExecutionStatus method

[2024-09-23 10:02:17,295] : [STEP_7] #####################################################
[2024-09-23 10:02:17,295] : [STEP_7] Description : Get the RFC supported subdocs header from webconfig.properties file
[2024-09-23 10:02:17,295] : [STEP_7] Expected Result : rfc subdoc version should be obtained
[2024-09-23 10:02:17,295] : [STEP_7] API Name : EXECUTE_COMMAND
[2024-09-23 10:02:17,295] : [STEP_7] #####################################################

[2024-09-23 10:02:17,296] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-09-23 10:02:17,305] : Entering executeCommandUsingSsh method
[2024-09-23 10:02:17,372] : Default SSH custom port is set
<=========================== RESPONSE =======================>
134217729

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


[2024-09-23 10:02:19,501] : Exiting executeCommandUsingSsh method
[2024-09-23 10:02:19,501] : >>>>>> ACTUAL OUTPUT: 134217729


[2024-09-23 10:02:19,501] : >>>>>> EXPECTED OUTPUT: NA
[2024-09-23 10:02:19,501] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-09-23 10:02:19,501] : >>>>>> VALIDATION STATUS: true
[2024-09-23 10:02:19,501] : >>>>>> INVERT RESULT: false

[2024-09-23 10:02:19,501] : [STEP_7] #####################################################
[2024-09-23 10:02:19,501] : [STEP_7]-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-09-23 10:02:19,501] : [STEP_7] #####################################################

[2024-09-23 10:02:19,503] : [STB MAC : D8:3A:DD:0A:43:0E][ Manual test ID : TC-RDKB-RFC-SUBDOC-1000] [step Number : S7][ Execution status : PASS] [Error Message : ]
[2024-09-23 10:02:19,503] : Entered into updateExecutionStatus method
[2024-09-23 10:02:19,503] : Result Details ->{"JMD_ID":"95035","manualId":"TC-RDKB-RFC-SUBDOC-1000","stepNumber":"S7","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_rdk-next_20240918011910","macAddress":"D8:3A:DD:0A:43:0E","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"TC-RDKB-RFC-SUBDOC-1000"}
[2024-09-23 10:02:19,518] : Execution result updated successfully
[2024-09-23 10:02:19,518] : Exited from updateExecutionStatus method

[2024-09-23 10:02:19,518] : [STEP_8] #####################################################
[2024-09-23 10:02:19,518] : [STEP_8] Description : Get the RFC supported subdocs header from webconfig.properties file
[2024-09-23 10:02:19,518] : [STEP_8] Expected Result : rfc subdoc version should be obtained
[2024-09-23 10:02:19,518] : [STEP_8] API Name : EXECUTE_COMMAND
[2024-09-23 10:02:19,518] : [STEP_8] #####################################################

[2024-09-23 10:02:19,519] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-09-23 10:02:19,528] : Entering executeCommandUsingSsh method
[2024-09-23 10:02:19,593] : Default SSH custom port is set
<=========================== RESPONSE =======================>
117440513

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


[2024-09-23 10:02:21,699] : Exiting executeCommandUsingSsh method
[2024-09-23 10:02:21,699] : >>>>>> ACTUAL OUTPUT: 117440513


[2024-09-23 10:02:21,699] : >>>>>> EXPECTED OUTPUT: NA
[2024-09-23 10:02:21,699] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-09-23 10:02:21,699] : >>>>>> VALIDATION STATUS: true
[2024-09-23 10:02:21,699] : >>>>>> INVERT RESULT: false

[2024-09-23 10:02:21,699] : [STEP_8] #####################################################
[2024-09-23 10:02:21,699] : [STEP_8]-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-09-23 10:02:21,699] : [STEP_8] #####################################################

[2024-09-23 10:02:21,701] : [STB MAC : D8:3A:DD:0A:43:0E][ Manual test ID : TC-RDKB-RFC-SUBDOC-1000] [step Number : S8][ Execution status : PASS] [Error Message : ]
[2024-09-23 10:02:21,701] : Entered into updateExecutionStatus method
[2024-09-23 10:02:21,701] : Result Details ->{"JMD_ID":"95035","manualId":"TC-RDKB-RFC-SUBDOC-1000","stepNumber":"S8","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_rdk-next_20240918011910","macAddress":"D8:3A:DD:0A:43:0E","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"TC-RDKB-RFC-SUBDOC-1000"}
[2024-09-23 10:02:21,713] : Execution result updated successfully
[2024-09-23 10:02:21,713] : Exited from updateExecutionStatus method

[2024-09-23 10:02:21,713] : [STEP_9] #####################################################
[2024-09-23 10:02:21,713] : [STEP_9] Description : Verify RFC supported subdocs header is logged in webconfig logs
[2024-09-23 10:02:21,713] : [STEP_9] Expected Result : RFC supported subdocs header should be logged in webconfig logs
[2024-09-23 10:02:21,714] : [STEP_9] API Name : EXECUTE_COMMAND
[2024-09-23 10:02:21,714] : [STEP_9] #####################################################

[2024-09-23 10:02:21,714] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-09-23 10:02:21,723] : Entering executeCommandUsingSsh method
[2024-09-23 10:02:21,783] : Default SSH custom port is set
<=========================== RESPONSE =======================>
134217729

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


[2024-09-23 10:02:23,915] : Exiting executeCommandUsingSsh method
[2024-09-23 10:02:23,915] : >>>>>> ACTUAL OUTPUT: 134217729


[2024-09-23 10:02:23,915] : >>>>>> EXPECTED OUTPUT: NA
[2024-09-23 10:02:23,915] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-09-23 10:02:23,915] : >>>>>> VALIDATION STATUS: true
[2024-09-23 10:02:23,915] : >>>>>> INVERT RESULT: false

[2024-09-23 10:02:23,915] : [STEP_9] #####################################################
[2024-09-23 10:02:23,915] : [STEP_9]-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-09-23 10:02:23,915] : [STEP_9] #####################################################

[2024-09-23 10:02:23,916] : [STB MAC : D8:3A:DD:0A:43:0E][ Manual test ID : TC-RDKB-RFC-SUBDOC-1000] [step Number : S9][ Execution status : PASS] [Error Message : ]
[2024-09-23 10:02:23,916] : Entered into updateExecutionStatus method
[2024-09-23 10:02:23,917] : Result Details ->{"JMD_ID":"95035","manualId":"TC-RDKB-RFC-SUBDOC-1000","stepNumber":"S9","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_rdk-next_20240918011910","macAddress":"D8:3A:DD:0A:43:0E","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"TC-RDKB-RFC-SUBDOC-1000"}
[2024-09-23 10:02:23,930] : Execution result updated successfully
[2024-09-23 10:02:23,930] : Exited from updateExecutionStatus method

[2024-09-23 10:02:23,930] : [STEP_10] #####################################################
[2024-09-23 10:02:23,931] : [STEP_10] Description : Verify RFC supported subdocs header is logged in webconfig logs
[2024-09-23 10:02:23,931] : [STEP_10] Expected Result : RFC supported subdocs header should be logged in webconfig logs
[2024-09-23 10:02:23,931] : [STEP_10] API Name : EXECUTE_COMMAND
[2024-09-23 10:02:23,931] : [STEP_10] #####################################################

[2024-09-23 10:02:23,931] : Device Model mapped to Automatics model name : Rpi-RDKB
[2024-09-23 10:02:23,940] : Entering executeCommandUsingSsh method
[2024-09-23 10:02:24,003] : Default SSH custom port is set
<=========================== RESPONSE =======================>
117440513

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


[2024-09-23 10:02:26,148] : Exiting executeCommandUsingSsh method
[2024-09-23 10:02:26,148] : >>>>>> ACTUAL OUTPUT: 117440513


[2024-09-23 10:02:26,149] : >>>>>> EXPECTED OUTPUT: NA
[2024-09-23 10:02:26,149] : >>>>>> VALIDATION PERFORMED: NOT_NULL
[2024-09-23 10:02:26,149] : >>>>>> VALIDATION STATUS: true
[2024-09-23 10:02:26,149] : >>>>>> INVERT RESULT: false

[2024-09-23 10:02:26,149] : [STEP_10] #####################################################
[2024-09-23 10:02:26,149] : [STEP_10]-[API Name: EXECUTE_COMMAND]-[Execution Status: PASS]
[2024-09-23 10:02:26,149] : [STEP_10] #####################################################

[2024-09-23 10:02:26,150] : [STB MAC : D8:3A:DD:0A:43:0E][ Manual test ID : TC-RDKB-RFC-SUBDOC-1000] [step Number : S10][ Execution status : PASS] [Error Message : ]
[2024-09-23 10:02:26,150] : Entered into updateExecutionStatus method
[2024-09-23 10:02:26,151] : Result Details ->{"JMD_ID":"95035","manualId":"TC-RDKB-RFC-SUBDOC-1000","stepNumber":"S10","testType":"GROUP_OR_AUTOID","buildName":"rdkb-generic-broadband-image_rdk-next_20240918011910","macAddress":"D8:3A:DD:0A:43:0E","remarks":"","executionStatus":"PASS","skipRemaining":false,"partnerName":"RDKM","automationId":"TC-RDKB-RFC-SUBDOC-1000"}
[2024-09-23 10:02:26,164] : Execution result updated successfully
[2024-09-23 10:02:26,164] : Exited from updateExecutionStatus method
[2024-09-23 10:02:26,165] : Execution Completed in settop -D8:3A:DD:0A:43:0E
[2024-09-23 10:02:26,165] : Mac:: D8:3A:DD:0A:43:0E Status:: true Total Count:: 0