Versions Compared

Key

  • This line was added.
  • This line was removed.
  • Formatting was changed.

...

  1.   Xconf Server
  2.   BPI with rdkb image
  3.   telemetry2_0

Environment Setup - Single Profile 

2.1.  Pre- requisites for Single Profile

...

{"header":"bootuptime_ClientConnectComplete_split","content":"ccsp-lm-lite","type":<event>","pollingFrequency":"0"}

 

Log File

$ cat /rdklogs/logs/telemetry2_0.txt.0

...

languagebash
themeDJango
titleTelemetry2 Logs
collapsetrue

Environment Setup - Multi Profile 

Pre-requisties


root@Filogic-GW:~# dmcli eRT getv Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
Execution succeed.
Parameter    1 name: Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.Enable
               type:       bool,    value: true 
Parameter    2 name: Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.ConfigURL
               type:     string,    value: https://xconf.rdkcentral.com:19092/loguploader/getT2Settings 
Parameter    3 name: Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.Version
               type:     string,    value: 2.0.1 
Parameter    4 name: Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.MessageBusSource.Enable
               type:       bool,    value: true 
Parameter    5 name: Device.DeviceInfo.X_RDKCENTRAL-COM_RFC.Feature.Telemetry.MTLS.Enable
               type:       bool,    value: false 

MultiProfile validation through dmcli

Code Block
languagebash
titledmcli
collapsetrue
root@Filogic-GW:/nvram/.t2reportprofiles# dmcli eRT getv Device.X_RDKCENTRAL-COM_T2.
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
Execution succeed.
Parameter    1 name: Device.X_RDKCENTRAL-COM_T2.ReportProfiles
               type:     string,    value: {"profiles":[{"name":"RDKB_CCSPWiFi_Profile","hash":"hash1","value":{"Name":"RDKB_CCSPWifi_Profile","Description":"Report to check WiFi Parameters","Version":"1","Protocol":"HTTP","EncodingType":"JSON","ReportingInterval":180,"TimeReference":"0001-01-01T00:00:00Z","ActivationTimeOut":1800,"Parameter":[{"type":"dataModel","reference":"Profile.Name"},{"type":"dataModel","reference":"Profile.Version"},{"type":"dataModel","reference":"Device.WiFi.Radio.1.Stats.X_COMCAST-COM_NoiseFloor"},{"type":"event","eventName":"2GclientMac_split","component":"wifihealth","use":"absolute"},{"type":"event","eventName":"5GclientMac_split","component":"wifihealth","use":"absolute"},{"type":"event","name":"wifiradio WIFI_COUNT","eventName":"WIFI_MAC_1_TOTAL_COUNT:0","component":"wifiradio","use":"count","reportEmpty":false},{"type":"dataModel","name":"UPTIME","reference":"Device.DeviceInfo.UpTime","use":"absolute"}],"HTTP":{"URL":"https://xconf.rdkcentral.com/xconf/telemetry_upload.php","Compression":"None","Method":"POST","RequestURIParameter":[{"Name":"deviceId","Reference":"Device.DeviceInfo.X_COMCAST-COM_CM_MAC"},{"Name":"reportName","Reference":"Profile.Name"}]},"JSONEncoding":{"ReportFormat":"NameValuePair","ReportTimestamp":"None"}}},{"name":"RDKB_SelfHeal_Profile","hash":"hash2","value":{"Name":"RDKB_SelfHeal_Profile","Description":"Report to check SelfHeal Parameters","Version":"2","Protocol":"HTTP","EncodingType":"JSON","ReportingInterval":180,"TimeReference":"0001-01-01T00:00:00Z","ActivationTimeOut":1800,"Parameter":[{"type":"dataModel","reference":"Profile.Name"},{"type":"dataModel","reference":"Profile.Version"},{"type":"dataModel","name":"UPTIME","reference":"Device.DeviceInfo.UpTime","use":"absolute"},{"type":"dataModel","reference":"Device.DeviceInfo.UpTime","use":"absolute"},{"type":"event","eventName":"SYS_ERROR_AdvSecurity_NotRunning","component":"SELF_HEAL","use":"absolute"},{"type":"event","eventName":"SYS_SH_lighttpdCrash","component":"test-and-diagnostic","use":"count","reportEmpty":false},{"type":"dataModel","name":"WAN_SSH_STATUS","reference":"Device.DeviceInfo.X_RDKCENTRAL-COM_Syndication.WANsideSSH.Enable","use":"absolute"}],"HTTP":{"URL":"https://xconf.rdkcentral.com/xconf/telemetry_upload.php","Compression":"None","Method":"POST","RequestURIParameter":[{"Name":"deviceId","Reference":"Device.DeviceInfo.X_COMCAST-COM_CM_MAC"},{"Name":"reportName","Reference":"Profile.Name"}]},"JSONEncoding":{"ReportFormat":"NameValuePair","ReportTimestamp":"None"}}}]} 
Parameter    2 name: Device.X_RDKCENTRAL-COM_T2.ReportProfilesMsgPack
               type:     string,    value:  
Parameter    3 name: Device.X_RDKCENTRAL-COM_T2.Temp_ReportProfiles
               type:     string,    value:  

root@Filogic-GW:/nvram/.t2reportprofiles# ls
RDKB_CCSPWiFi_Profile  RDKB_SelfHeal_Profile
root@Filogic-GW:/nvram/.t2reportprofiles# 


Logs

Code Block
languagebash
titleLogs
collapsetrue

240902-05:42:48.397488 [mod=T2, lvl=INFO] [tid=4725] Reporting Adjustments parameters check done successfully
240902-05:42:48.397596 [mod=T2, lvl=INFO] [tid=4725] Profile Name: RDKB_SelfHeal_Profile
Configured httpURIReqParam count = 2 
240902-05:42:48.397611 [mod=T2, lvl=INFO] [tid=4725] Number of httpURIReqParam added  = 2 
240902-05:42:48.397779 [mod=T2, lvl=INFO] [tid=4725] Number of tr181params/markers successfully added in profile = 7 
240902-05:42:48.398110 [mod=T2, lvl=INFO] [tid=4725] Starting TimeoutThread for profile : RDKB_SelfHeal_Profile
240902-05:42:48.398273 [mod=T2, lvl=INFO] [tid=4725] T2ER isn't initialized or dispatch thread is already running
240902-05:42:48.398292 [mod=T2, lvl=INFO] [tid=4725] Successfully enabled profile : RDKB_SelfHeal_Profile
240902-05:42:48.398311 [mod=T2, lvl=INFO] [tid=4725] T2ER isn't initialized or dispatch thread is already running
240902-05:42:48.398441 [mod=T2, lvl=INFO] [tid=4725] Reporting Adjustments parameters check done successfully
240902-05:42:48.398476 [mod=T2, lvl=INFO] [tid=83168] Waiting for 180 sec for next TIMEOUT for profile as reporting interval is taken - RDKB_SelfHeal_Profile
240902-05:42:48.398508 [mod=T2, lvl=INFO] [tid=83168] Waiting for timeref or reporting interval for the profile - RDKB_SelfHeal_Profile is started
240902-05:42:48.398536 [mod=T2, lvl=INFO] [tid=4725] Profile Name: RDKB_CCSPWiFi_Profile
Configured httpURIReqParam count = 2 
240902-05:42:48.398549 [mod=T2, lvl=INFO] [tid=4725] Number of httpURIReqParam added  = 2 
240902-05:42:48.398711 [mod=T2, lvl=INFO] [tid=4725] Number of tr181params/markers successfully added in profile = 7 
240902-05:42:48.398971 [mod=T2, lvl=INFO] [tid=4725] Starting TimeoutThread for profile : RDKB_CCSPWiFi_Profile
240902-05:42:48.399103 [mod=T2, lvl=INFO] [tid=4725] T2ER isn't initialized or dispatch thread is already running
240902-05:42:48.399119 [mod=T2, lvl=INFO] [tid=4725] Successfully enabled profile : RDKB_CCSPWiFi_Profile
240902-05:42:48.399138 [mod=T2, lvl=INFO] [tid=4725] T2ER isn't initialized or dispatch thread is already running
240902-05:42:48.399183 [mod=T2, lvl=ERROR] [tid=4725] removeProfileFromDisk,237: command failed
240902-05:42:48.399199 [mod=T2, lvl=INFO] [tid=4725] profiles.msgpack is removed from disk 
240902-05:42:48.399247 [mod=T2, lvl=INFO] [tid=4725] rbuscore.c:2326 RBus Enabled

240902-05:42:48.399476 [mod=T2, lvl=INFO] [tid=83169] Waiting for 180 sec for next TIMEOUT for profile as reporting interval is taken - RDKB_CCSPWiFi_Profile
240902-05:42:48.399514 [mod=T2, lvl=INFO] [tid=83169] Waiting for timeref or reporting interval for the profile - RDKB_CCSPWiFi_Profile is started
240902-05:42:48.401993 [mod=T2, lvl=INFO] [tid=4725] process_rp_thread: Waiting for event from tr-181 
240902-05:42:57.000129 [mod=T2, lvl=INFO] [tid=4761] TIMEDOUT -- trying fetchConfigurations again
240902-05:42:57.008034 [mod=T2, lvl=INFO] [tid=4761] doHttpGet with url https://xconf.rdkcentral.com:19092/loguploader/getT2Settings?estbMacAddress=ba:78:2f:16:80:e4&firmwareVersion=rdkb-generic-broadband-image_rdk-next_20240902053956&model=BananapiBPI-R4&partnerId=RDKM&accountId=&ecmMacAddress=ba:78:2f:16:80:e4&env=dev&controllerId=2504&channelMapId=2345&vodId=15660&version=2 
240902-05:42:57.008511 [mod=T2, lvl=INFO] [tid=4761] TR181_DEVICE_CURRENT_WAN_IFNAME -- erouter0
240902-05:42:57.009054 [mod=T2, lvl=ERROR] [tid=4761] getParameterValue partner id failed
240902-05:42:57.011863 [mod=T2, lvl=INFO] [tid=87032] TR181_DEVICE_CURRENT_WAN_IFNAME ---- erouter0
240902-05:42:58.241263 [mod=T2, lvl=ERROR] [tid=87032] doHttpGet:643, T2:Telemetry XCONF communication Failed with http code : 404 Curl code : 0 
240902-05:42:58.241334 [mod=T2, lvl=ERROR] [tid=87032] doHttpGet : curl_easy_perform failed with error message No error from curl 
240902-05:42:58.247916 [mod=T2, lvl=ERROR] [tid=4761] T2:Curl GET of XCONF data failed
240902-05:42:58.247979 [mod=T2, lvl=WARN] [tid=4761] XConf Telemetry profile not set for this device, uninitProfileList.
240902-09:04:36.480619 [mod=T2, lvl=INFO] [tid=4756] Waiting for timeref or reporting interval for the profile - RDKB-RPI-TEST is started
240902-09:04:36.480624 [mod=T2, lvl=INFO] [tid=59493] CollectAndReportXconf ++in profileName : RDKB-RPI-TEST
240902-09:04:36.481081 [mod=T2, lvl=INFO] [tid=129699] CollectAndReport while Loop -- START 
240902-09:04:36.481111 [mod=T2, lvl=INFO] [tid=129699] CollectAndReport ++in profileName : RDKB_SelfHeal_Profile
240902-09:04:36.482631 [mod=T2, lvl=INFO] [tid=129698] cJSON Report = {"Report":[{"Profile.Name":"RDKB_CCSPWiFi_Profile"},{"Profile.Version":"1"},{"Device.WiFi.Radio.1.Stats.X_COMCAST-COM_NoiseFloor":"-99"},{"UPTIME":"306"}]}
240902-09:04:36.482779 [mod=T2, lvl=INFO] [tid=129698] Report Size = 155
240902-09:04:36.484286 [mod=T2, lvl=INFO] [tid=129699] cJSON Report = {"Report":[{"Profile.Name":"RDKB_SelfHeal_Profile"},{"Profile.Version":"2"},{"UPTIME":"306"},{"Device.DeviceInfo.UpTime":"306"},{"WAN_SSH_STATUS":"false"}]}
240902-09:04:36.484348 [mod=T2, lvl=INFO] [tid=129699] Report Size = 156
240902-09:04:36.486134 [mod=T2, lvl=ERROR] [tid=129698] getParameterValue partner id failed
240902-09:04:36.488540 [mod=T2, lvl=ERROR] [tid=59493] rbus.c:3676 Discover component names failed with error 5 and counts 1/0

240902-09:04:36.488621 [mod=T2, lvl=ERROR] [tid=59493] Failed to retrieve param : Device.DeviceInfo.X_RDKCENTRAL-COM_EnableXDNS
240902-09:04:36.488970 [mod=T2, lvl=ERROR] [tid=129699] getParameterValue partner id failed
240902-09:04:37.332481 [mod=T2, lvl=INFO] [tid=129699] The return status from the child with pid 129706 is CurlStatus : 1
240902-09:04:37.332529 [mod=T2, lvl=INFO] [tid=129699] The return status from the child with pid 129706 SetopCode: No error; ResponseCode : No error; HTTP_CODE : 200; Line Number : 357 
240902-09:04:37.332544 [mod=T2, lvl=INFO] [tid=129699] Report Sent Successfully over HTTP : 200
240902-09:04:37.332569 [mod=T2, lvl=INFO] [tid=129699] Elapsed Time for : RDKB_SelfHeal_Profile = 0.851439692 (Sec.NanoSec)
240902-09:04:37.332588 [mod=T2, lvl=INFO] [tid=129699] CollectAndReport while Loop -- END; wait for restart event
240902-09:04:37.332600 [mod=T2, lvl=INFO] [tid=129699] CollectAndReport --out
240902-09:04:37.332661 [mod=T2, lvl=INFO] [tid=129698] The return status from the child with pid 129704 is CurlStatus : 1
240902-09:04:37.332686 [mod=T2, lvl=INFO] [tid=129698] The return status from the child with pid 129704 SetopCode: No error; ResponseCode : No error; HTTP_CODE : 200; Line Number : 357 
240902-09:04:37.332699 [mod=T2, lvl=INFO] [tid=129698] Report Sent Successfully over HTTP : 200
240902-09:04:37.332717 [mod=T2, lvl=INFO] [tid=129698] Elapsed Time for : RDKB_CCSPWiFi_Profile = 0.852407615 (Sec.NanoSec)
240902-09:04:37.332732 [mod=T2, lvl=INFO] [tid=129698] CollectAndReport while Loop -- END; wait for restart event
240902-09:04:37.332744 [mod=T2, lvl=INFO] [tid=129698] CollectAndReport --out


 Multiprofile MsgPack validation through dmcli

Refer below url to create message pack data

Telemetry 2.0 support for RDKB RPI -User Manual#Telemtry2.0ProfileMsgPack

Code Block
languagebash
titlemsgpack dm
collapsetrue
root@Filogic-GW:/nvram/.t2reportprofiles# dmcli eRT getv Device.X_RDKCENTRAL-COM_T2.
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
Execution succeed.
Parameter    1 name: Device.X_RDKCENTRAL-COM_T2.ReportProfiles
               type:     string,    value:  
Parameter    2 name: Device.X_RDKCENTRAL-COM_T2.ReportProfilesMsgPack
               type:     string,    value: 3wAAAAGocHJvZmlsZXPdAAAAAd8AAAADpG5hbWW0UkRLQl9XSUZJX0RNX1BST0ZJTEWkaGFzaKVoYXNoMaV2YWx1Zd8AAAAKq0Rlc2NyaXB0aW9utFJlcG9ydCB0byBEZXZpY2VJbmZvp1ZlcnNpb26hMqhQcm90b2NvbKRIVFRQrEVuY29kaW5nVHlwZaRKU09OsVJlcG9ydGluZ0ludGVydmFsPK1UaW1lUmVmZXJlbmNltDAwMDEtMDEtMDFUMDA6MDA6MDBasUFjdGl2YXRpb25UaW1lb3V0eKlQYXJhbWV0ZXLdAAAAD98AAAACpHR5cGWpZGF0YU1vZGVsqXJlZmVyZW5jZaxQcm9maWxlLk5hbWXfAAAAAqR0eXBlqWRhdGFNb2RlbKlyZWZlcmVuY2WvUHJvZmlsZS5WZXJzaW9u3wAAAAOkdHlwZalkYXRhTW9kZWykbmFtZaVDbU1hY6lyZWZlcmVuY2XZJkRldmljZS5EZXZpY2VJbmZvLlhfQ09NQ0FTVC1DT01fQ01fTUFD3wAAAAOkdHlwZalkYXRhTW9kZWykbmFtZacyRy1TU0lEqXJlZmVyZW5jZbdEZXZpY2UuV2lGaS5TU0lELjEuU1NJRN8AAAADpHR5cGWpZGF0YU1vZGVspG5hbWWnNUctU1NJRKlyZWZlcmVuY2W3RGV2aWNlLldpRmkuU1NJRC4yLlNTSUTfAAAAA6R0eXBlqWRhdGFNb2RlbKRuYW1lpzJHLU5hbWWpcmVmZXJlbmNluERldmljZS5XaUZpLlJhZGlvLjEuTmFtZd8AAAADpHR5cGWpZGF0YU1vZGVspG5hbWWnNUctTmFtZalyZWZlcmVuY2W4RGV2aWNlLldpRmkuUmFkaW8uMi5OYW1l3wAAAAOkdHlwZalkYXRhTW9kZWykbmFtZaYyRy1QV0SpcmVmZXJlbmNl2TBEZXZpY2UuV2lGaS5BY2Nlc3NQb2ludC4xLlNlY3VyaXR5LktleVBhc3NwaHJhc2XfAAAAA6R0eXBlqWRhdGFNb2RlbKRuYW1lpjVHLVBXRKlyZWZlcmVuY2XZMERldmljZS5XaUZpLkFjY2Vzc1BvaW50LjIuU2VjdXJpdHkuS2V5UGFzc3BocmFzZd8AAAADpHR5cGWpZGF0YU1vZGVspG5hbWWnMkctTW9kZalyZWZlcmVuY2XZLkRldmljZS5XaUZpLkFjY2Vzc1BvaW50LjEuU2VjdXJpdHkuTW9kZUVuYWJsZWTfAAAAA6R0eXBlqWRhdGFNb2RlbKRuYW1lpzVHLU1vZGWpcmVmZXJlbmNl2S5EZXZpY2UuV2lGaS5BY2Nlc3NQb2ludC4yLlNlY3VyaXR5Lk1vZGVFbmFibGVk3wAAAAOkdHlwZalkYXRhTW9kZWykbmFtZatNZW1TdGF0VXNlZKlyZWZlcmVuY2XZI0RldmljZS5EZXZpY2VJbmZvLk1lbW9yeVN0YXR1cy5Vc2Vk3wAAAAOkdHlwZalkYXRhTW9kZWykbmFtZaxGck1lbVRocnNobGSpcmVmZXJlbmNl2UBEZXZpY2UuRGV2aWNlSW5mby5NZW1vcnlTdGF0dXMuWF9SREtDRU5UUkFMLUNPTV9GcmVlTWVtVGhyZXNob2xk3wAAAAOkdHlwZalkYXRhTW9kZWykbmFtZahDcHVVc2FnZalyZWZlcmVuY2XZKERldmljZS5EZXZpY2VJbmZvLlByb2Nlc3NTdGF0dXMuQ1BVVXNhZ2XfAAAAA6R0eXBlqWRhdGFNb2RlbKRuYW1lplVwdGltZalyZWZlcmVuY2W4RGV2aWNlLkRldmljZUluZm8uVXBUaW1lpEhUVFDfAAAABKNVUkzZN2h0dHBzOi8veGNvbmYucmRrY2VudHJhbC5jb20veGNvbmYvdGVsZW1ldHJ5X3VwbG9hZC5waHCrQ29tcHJlc3Npb26kTm9uZaZNZXRob2SkUE9TVLNSZXF1ZXN0VVJJUGFyYW1ldGVy3QAAAALfAAAAAqROYW1lqGRldmljZUlkqVJlZmVyZW5jZdkmRGV2aWNlLkRldmljZUluZm8uWF9DT01DQVNULUNPTV9DTV9NQUPfAAAAAqROYW1lqnJlcG9ydE5hbWWpUmVmZXJlbmNlrFByb2ZpbGUuTmFtZaxKU09ORW5jb2RpbmffAAAAAqxSZXBvcnRGb3JtYXStTmFtZVZhbHVlUGFpcq9SZXBvcnRUaW1lc3RhbXCkTm9uZQ== 
Parameter    3 name: Device.X_RDKCENTRAL-COM_T2.Temp_ReportProfiles
               type:     string,    value:  

root@Filogic-GW:/nvram/.t2reportprofiles# ls
profiles.msgpack
root@Filogic-GW:/nvram/.t2reportprofiles# 
root@Filogic-GW:/nvram/.t2reportprofiles# 
root@Filogic-GW:/nvram/.t2reportprofiles# web
webcfg_decoder  webconfig       webpa           
root@Filogic-GW:/nvram/.t2reportprofiles# web
webcfg_decoder  webconfig       webpa           
root@Filogic-GW:/nvram/.t2reportprofiles# webcfg_decoder -m profiles.msgpack 
rbus_open for component webcfg_decoder
rbus_init is success. ret is 0

msgpack decoded data is:
{"profiles":[{"name":"RDKB_WIFI_DM_PROFILE", "hash":"hash1", "value":{"Description":"Report to DeviceInfo", "Version":"2", "Protocol":"HTTP", "EncodingType":"JSON", "ReportingInterval":60, "TimeReference":"0001-01-01T00:00:00Z", "ActivationTimeout":120, "Parameter":[{"type":"dataModel", "reference":"Profile.Name"}, {"type":"dataModel", "reference":"Profile.Version"}, {"type":"dataModel", "name":"CmMac", "reference":"Device.DeviceInfo.X_COMCAST-COM_CM_MAC"}, {"type":"dataModel", "name":"2G-SSID", "reference":"Device.WiFi.SSID.1.SSID"}, {"type":"dataModel", "name":"5G-SSID", "reference":"Device.WiFi.SSID.2.SSID"}, {"type":"dataModel", "name":"2G-Name", "reference":"Device.WiFi.Radio.1.Name"}, {"type":"dataModel", "name":"5G-Name", "reference":"Device.WiFi.Radio.2.Name"}, {"type":"dataModel", "name":"2G-PWD", "reference":"Device.WiFi.AccessPoint.1.Security.KeyPassphrase"}, {"type":"dataModel", "name":"5G-PWD", "reference":"Device.WiFi.AccessPoint.2.Security.KeyPassphrase"}, {"type":"dataModel", "name":"2G-Mode", "reference":"Device.WiFi.AccessPoint.1.Security.ModeEnabled"}, {"type":"dataModel", "name":"5G-Mode", "reference":"Device.WiFi.AccessPoint.2.Security.ModeEnabled"}, {"type":"dataModel", "name":"MemStatUsed", "reference":"Device.DeviceInfo.MemoryStatus.Used"}, {"type":"dataModel", "name":"FrMemThrshld", "reference":"Device.DeviceInfo.MemoryStatus.X_RDKCENTRAL-COM_FreeMemThreshold"}, {"type":"dataModel", "name":"CpuUsage", "reference":"Device.DeviceInfo.ProcessStatus.CPUUsage"}, {"type":"dataModel", "name":"Uptime", "reference":"Device.DeviceInfo.UpTime"}], "HTTP":{"URL":"https://xconf.rdkcentral.com/xconf/telemetry_upload.php", "Compression":"None", "Method":"POST", "RequestURIParameter":[{"Name":"deviceId", "Reference":"Device.DeviceInfo.X_COMCAST-COM_CM_MAC"}, {"Name":"reportName", "Reference":"Profile.Name"}]}, "JSONEncoding":{"ReportFormat":"NameValuePair", "ReportTimestamp":"None"}}}]}
root@Filogic-GW:/nvram/.t2reportprofiles# 
root@Filogic-GW:/nvram/.t2reportprofiles# 

Logs :

Code Block
languagebash
titleMsgpack Logs
collapsetrue
40902-09:16:45.445976 [mod=T2, lvl=INFO] [tid=296218] rbuscore.c:2326 RBus Enabled

240902-09:17:45.000111 [mod=T2, lvl=INFO] [tid=456847] TIMEOUT for profile - RDKB_WIFI_DM_PROFILE
240902-09:17:45.000161 [mod=T2, lvl=INFO] [tid=456847] ReportProfiles_TimeoutCb ++in
240902-09:17:45.000197 [mod=T2, lvl=INFO] [tid=456847] NotifyTimeout: profile RDKB_WIFI_DM_PROFILE is in Enabled state
240902-09:17:45.000264 [mod=T2, lvl=INFO] [tid=456847] ReportProfiles_TimeoutCb --out
240902-09:17:45.000288 [mod=T2, lvl=INFO] [tid=456847] Waiting for 60 sec for next TIMEOUT for profile as reporting interval is taken - RDKB_WIFI_DM_PROFILE
240902-09:17:45.000311 [mod=T2, lvl=INFO] [tid=456847] Waiting for timeref or reporting interval for the profile - RDKB_WIFI_DM_PROFILE is started
240902-09:17:45.000348 [mod=T2, lvl=INFO] [tid=483383] CollectAndReport while Loop -- START 
240902-09:17:45.000381 [mod=T2, lvl=INFO] [tid=483383] CollectAndReport ++in profileName : RDKB_WIFI_DM_PROFILE
240902-09:17:46.017775 [mod=T2, lvl=INFO] [tid=483383] cJSON Report = {"Report":[{"Profile.Name":"RDKB_WIFI_DM_PROFILE"},{"Profile.Version":"2"},{"CmMac":"ba:78:2f:16:80:e4"},{"2G-SSID":"BPI_RDKB-AP0"},{"5G-SSID":"BPI_RDKB-AP1"},{"2G-Name":"wifi0"},{"5G-Name":"wifi1"},{"2G-PWD":"rdk@1234"},{"5G-PWD":"rdk@1234"},{"2G-Mode":"WPA2-Personal"},{"5G-Mode":"WPA2-Personal"},{"MemStatUsed":"549"},{"FrMemThrshld":"0"},{"CpuUsage":"8"},{"Uptime":"1095"}]}
240902-09:17:46.017835 [mod=T2, lvl=INFO] [tid=483383] Report Size = 378
240902-09:17:46.019320 [mod=T2, lvl=ERROR] [tid=483383] getParameterValue partner id failed
240902-09:17:46.868724 [mod=T2, lvl=INFO] [tid=483383] The return status from the child with pid 483840 is CurlStatus : 1
240902-09:17:46.868784 [mod=T2, lvl=INFO] [tid=483383] The return status from the child with pid 483840 SetopCode: No error; ResponseCode : No error; HTTP_CODE : 200; Line Number : 357 
240902-09:17:46.868812 [mod=T2, lvl=INFO] [tid=483383] Report Sent Successfully over HTTP : 200
240902-09:17:46.868839 [mod=T2, lvl=INFO] [tid=483383] Elapsed Time for : RDKB_WIFI_DM_PROFILE = 1.868437924 (Sec.NanoSec)
240902-09:17:46.868857 [mod=T2, lvl=INFO] [tid=483383] CollectAndReport while Loop -- END; wait for restart event
240902-09:17:46.868868 [mod=T2, lvl=INFO] [tid=483383] CollectAndReport --out

Multiprofile Validation through webconfig

1.Refer below url to configure xconf for T2 profiles

Feature Validation : Xconf Server#FeatureValidation:Telemetry2_0

2. Run the below command 

root@Filogic-GW:/nvram/.t2reportprofiles# dmcli eRT setv Device.X_RDK_WebConfig.ForceSync string telemetry
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
Execution succeed.

root@Filogic-GW:/nvram/.t2reportprofiles# ls profiles.msgpack

Note -  Make sure, Webconfig should be running in your device

3. Logs

Code Block
languagebash
titleT2, webconfig logs
collapsetrue


240903-09:23:21.744803 [mod=T2, lvl=INFO] [tid=269845] rbuscore.c:2326 RBus Enabled

240903-09:23:21.744834 [mod=T2, lvl=INFO] [tid=269845] No data elements present to unregister240903-09:23:21.745615 [mod=T2, lvl=INFO] [tid=269845] Starting TimeoutThread for profile : RDKB_RPI_Wifi_Profile2
240903-09:23:21.746058 [mod=T2, lvl=INFO] [tid=269845] Successfully enabled profile : RDKB_RPI_Wifi_Profile2
240903-09:23:21.746099 [mod=T2, lvl=INFO] [tid=269845] T2ER isn't initialized or dispatch thread is already running
240903-09:23:21.746136 [mod=T2, lvl=INFO] [tid=269847] Waiting for 180 sec for next TIMEOUT for profile as reporting interval is taken - RDKB_RPI_Wifi_Profile2
240903-09:23:21.746263 [mod=T2, lvl=INFO] [tid=269847] Waiting for timeref or reporting interval for the profile - RDKB_RPI_Wifi_Profile2 is started
240903-09:23:21.746750 [mod=T2, lvl=INFO] [tid=269845] Starting TimeoutThread for profile : RDKB_Wifi_Profile1_said
240903-09:23:21.746854 [mod=T2, lvl=INFO] [tid=269845] T2ER isn't initialized or dispatch thread is already running
240903-09:23:21.746873 [mod=T2, lvl=INFO] [tid=269845] Successfully enabled profile : RDKB_Wifi_Profile1_said
240903-09:23:21.746897 [mod=T2, lvl=INFO] [tid=269845] T2ER isn't initialized or dispatch thread is already running
240903-09:23:21.746916 [mod=T2, lvl=INFO] [tid=269849] Waiting for 180 sec for next TIMEOUT for profile as reporting interval is taken - RDKB_Wifi_Profile1_said
240903-09:23:21.746944 [mod=T2, lvl=INFO] [tid=269849] Waiting for timeref or reporting interval for the profile - RDKB_Wifi_Profile1_said is started
240903-09:23:21.747898 [mod=T2, lvl=INFO] [tid=269845] Starting TimeoutThread for profile : RDKB-RPI-BootTime-Logs
240903-09:23:21.747993 [mod=T2, lvl=INFO] [tid=269845] T2ER isn't initialized or dispatch thread is already running
240903-09:23:21.748015 [mod=T2, lvl=INFO] [tid=269845] Successfully enabled profile : RDKB-RPI-BootTime-Logs
240903-09:23:21.748036 [mod=T2, lvl=INFO] [tid=269845] T2ER isn't initialized or dispatch thread is already running
240903-09:23:21.748049 [mod=T2, lvl=INFO] [tid=269850] Waiting for 600 sec for next TIMEOUT for profile as reporting interval is taken - RDKB-RPI-BootTime-Logs
240903-09:23:21.748080 [mod=T2, lvl=INFO] [tid=269850] Waiting for timeref or reporting interval for the profile - RDKB-RPI-BootTime-Logs is started
240903-09:23:21.751228 [mod=T2, lvl=INFO] [tid=269845] rbuscore.c:2326 RBus Enabled

240903-09:26:21.000108 [mod=T2, lvl=INFO] [tid=269849] TIMEOUT for profile - RDKB_Wifi_Profile1_said
240903-09:26:21.000108 [mod=T2, lvl=INFO] [tid=269847] TIMEOUT for profile - RDKB_RPI_Wifi_Profile2
240903-09:26:21.000165 [mod=T2, lvl=INFO] [tid=269849] ReportProfiles_TimeoutCb ++in
240903-09:26:21.000173 [mod=T2, lvl=INFO] [tid=269847] ReportProfiles_TimeoutCb ++in
240903-09:26:21.000225 [mod=T2, lvl=INFO] [tid=269847] NotifyTimeout: profile RDKB_RPI_Wifi_Profile2 is in Enabled state
240903-09:26:21.000228 [mod=T2, lvl=INFO] [tid=269849] NotifyTimeout: profile RDKB_Wifi_Profile1_said is in Enabled state
240903-09:26:21.000303 [mod=T2, lvl=INFO] [tid=269847] ReportProfiles_TimeoutCb --out
240903-09:26:21.000307 [mod=T2, lvl=INFO] [tid=269849] ReportProfiles_TimeoutCb --out
240903-09:26:21.000323 [mod=T2, lvl=INFO] [tid=269847] Waiting for 180 sec for next TIMEOUT for profile as reporting interval is taken - RDKB_RPI_Wifi_Profile2
240903-09:26:21.000325 [mod=T2, lvl=INFO] [tid=269849] Waiting for 180 sec for next TIMEOUT for profile as reporting interval is taken - RDKB_Wifi_Profile1_said
240903-09:26:21.000334 [mod=T2, lvl=INFO] [tid=350542] CollectAndReport while Loop -- START 
240903-09:26:21.000351 [mod=T2, lvl=INFO] [tid=269847] Waiting for timeref or reporting interval for the profile - RDKB_RPI_Wifi_Profile2 is started
240903-09:26:21.000355 [mod=T2, lvl=INFO] [tid=350542] CollectAndReport ++in profileName : RDKB_RPI_Wifi_Profile2
240903-09:26:21.000360 [mod=T2, lvl=INFO] [tid=269849] Waiting for timeref or reporting interval for the profile - RDKB_Wifi_Profile1_said is started
240903-09:26:21.000411 [mod=T2, lvl=INFO] [tid=350543] CollectAndReport while Loop -- START 
240903-09:26:21.000427 [mod=T2, lvl=INFO] [tid=350543] CollectAndReport ++in profileName : RDKB_Wifi_Profile1_said
240903-09:26:21.002869 [mod=T2, lvl=INFO] [tid=350543] cJSON Report = {"Report":[{"Profile.Name":"RDKB_Wifi_Profile1_said"},{"Profile.Version":"1"},{"Device.WiFi.Radio.1.Stats.X_COMCAST-COM_NoiseFloor":"-99"},{"Device.DeviceInfo.UpTime":"799"}]}
240903-09:26:21.002935 [mod=T2, lvl=INFO] [tid=350543] Report Size = 175
240903-09:26:21.003744 [mod=T2, lvl=INFO] [tid=350542] cJSON Report = {"Report":[{"Profile.Name":"RDKB_RPI_Wifi_Profile2"},{"Profile.Version":"2"},{"Device.DeviceInfo.UpTime":"799"},{"Device.DeviceInfo.UpTime":"799"},{"WAN_SSH_STATUS":"false"}]}
240903-09:26:21.003798 [mod=T2, lvl=INFO] [tid=350542] Report Size = 175
240903-09:26:21.005391 [mod=T2, lvl=ERROR] [tid=350542] getParameterValue partner id failed
240903-09:26:21.006528 [mod=T2, lvl=ERROR] [tid=350543] getParameterValue partner id failed
240903-09:26:21.827460 [mod=T2, lvl=INFO] [tid=350543] The return status from the child with pid 350550 is CurlStatus : 1
240903-09:26:21.827536 [mod=T2, lvl=INFO] [tid=350543] The return status from the child with pid 350550 SetopCode: No error; ResponseCode : No error; HTTP_CODE : 200; Line Number : 357 
240903-09:26:21.827554 [mod=T2, lvl=INFO] [tid=350543] Report Sent Successfully over HTTP : 200
240903-09:26:21.827591 [mod=T2, lvl=INFO] [tid=350543] Elapsed Time for : RDKB_Wifi_Profile1_said = 0.827137449 (Sec.NanoSec)
240903-09:26:21.827612 [mod=T2, lvl=INFO] [tid=350543] CollectAndReport while Loop -- END; wait for restart event
240903-09:26:21.827623 [mod=T2, lvl=INFO] [tid=350543] CollectAndReport --out
240903-09:26:21.878112 [mod=T2, lvl=INFO] [tid=350542] The return status from the child with pid 350545 is CurlStatus : 1
240903-09:26:21.878182 [mod=T2, lvl=INFO] [tid=350542] The return status from the child with pid 350545 SetopCode: No error; ResponseCode : No error; HTTP_CODE : 200; Line Number : 357 
240903-09:26:21.878197 [mod=T2, lvl=INFO] [tid=350542] Report Sent Successfully over HTTP : 200
240903-09:26:21.878222 [mod=T2, lvl=INFO] [tid=350542] Elapsed Time for : RDKB_RPI_Wifi_Profile2 = 0.877837901 (Sec.NanoSec)
240903-09:26:21.878243 [mod=T2, lvl=INFO] [tid=350542] CollectAndReport while Loop -- END; wait for restart event
240903-09:26:21.878256 [mod=T2, lvl=INFO] [tid=350542] CollectAndReport --out
240903-09:33:21.000141 [mod=T2, lvl=INFO] [tid=269850] TIMEOUT for profile - RDKB-RPI-BootTime-Logs
240903-09:33:21.000200 [mod=T2, lvl=INFO] [tid=269850] ReportProfiles_TimeoutCb ++in
240903-09:33:21.000242 [mod=T2, lvl=INFO] [tid=269850] NotifyTimeout: profile RDKB-RPI-BootTime-Logs is in Enabled state
240903-09:33:21.000310 [mod=T2, lvl=INFO] [tid=269850] ReportProfiles_TimeoutCb --out
240903-09:33:21.000333 [mod=T2, lvl=INFO] [tid=269850] Waiting for 600 sec for next TIMEOUT for profile as reporting interval is taken - RDKB-RPI-BootTime-Logs
240903-09:33:21.000355 [mod=T2, lvl=INFO] [tid=269850] Waiting for timeref or reporting interval for the profile - RDKB-RPI-BootTime-Logs is started
240903-09:33:21.000405 [mod=T2, lvl=INFO] [tid=538138] CollectAndReport while Loop -- START 
240903-09:33:21.000421 [mod=T2, lvl=INFO] [tid=538138] CollectAndReport ++in profileName : RDKB-RPI-BootTime-Logs
240903-09:33:21.000861 [mod=T2, lvl=ERROR] [tid=538138] rbus.c:3676 Discover component names failed with error 5 and counts 1/0

240903-09:33:21.000890 [mod=T2, lvl=ERROR] [tid=538138] Failed to retrieve param : Device.DeviceInfo.X_RDK.RDKProfileName
240903-09:33:21.003111 [mod=T2, lvl=INFO] [tid=538138] cJSON Report = {"Report":[{"Profile.Name":"RDKB-RPI-BootTime-Logs"},{"Profile.Version":"1"},{"MAC":"8a:97:6b:af:3f:90"},{"UpTime":"1219"},{"bootuptime_Ethernet_split":"=14"},{"bootuptime_wifi_split":"=32"},{"bootuptime_webpa_split":"=40"}]}
240903-09:33:21.003163 [mod=T2, lvl=INFO] [tid=538138] Report Size = 225
240903-09:33:21.004755 [mod=T2, lvl=ERROR] [tid=538138] getParameterValue partner id failed
240903-09:33:21.864598 [mod=T2, lvl=INFO] [tid=538138] The return status from the child with pid 538143 is CurlStatus : 1
240903-09:33:21.864657 [mod=T2, lvl=INFO] [tid=538138] The return status from the child with pid 538143 SetopCode: No error; ResponseCode : No error; HTTP_CODE : 200; Line Number : 357 
240903-09:33:21.864672 [mod=T2, lvl=INFO] [tid=538138] Report Sent Successfully over HTTP : 200
240903-09:33:21.864698 [mod=T2, lvl=INFO] [tid=538138] Elapsed Time for : RDKB-RPI-BootTime-Logs = 0.864261724 (Sec.NanoSec)
240903-09:33:21.864718 [mod=T2, lvl=INFO] [tid=538138] CollectAndReport while Loop -- END; wait for restart event
240903-09:33:21.864729 [mod=T2, lvl=INFO] [tid=538138] CollectAndReport --out

References

Jira
serverJIRA
serverId11deff04-0380-3a3d-a916-0849d4e573f7
keyRDKBACCL-293

 

Log upload onto HTTPS Server

        

Telemetry Version : 2.0.1 - Multiprofile

 

Limitations

                      The above screenshots and test logs are generated in dbus mode because rbus is not supported in rpi.

Also, webconfig support is not available in RPI . So T2 related testing with webconfig are not validated yet.

References

  https://github.com/rdkcentral/xconfserver/blob/main/README.md

  https://wiki.rdkcentral.com/display/RDK/Xconf+Server+-+User+guide+for+configuration+and+feature+validation

  RDKB Telemetry

  WebConfig, XConf & T2