Versions Compared

Old Version 3

changes.mady.by.user Unknown User (praveen.v)

Saved on

compared with

New Version Current

changes.mady.by.user Unknown User (praveen.v)

Saved on

Key

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


Table of Contents

Why we need notifications?

  • To ensure that the value is set properly and updated in the database.

Module and component

...

RDKB Logger

The

...

RDK logger is

...

a general-purpose logging mechanism used in RDK-B

...

  • By default, the system will look for /etc/debug.ini.
  • rdklogctrl can be used at runtime.

During Boot-up 

...

, utilizing log4c for formatting and supporting multiple log levels for different modules. Each component’s log level is read from the debug.ini configuration file during initialization. Implemented as a shared library, components must link to this library to include logging functionality.

When the unit boots up, each RDK-B component

...

initializes the logger and

...

starts logging into the corresponding log file

...

based on the log level set for the component

...

. This setup enables component-wise logging across RDK-B modules.

Enable/Disable notifications 

...

  • Notifications are enabled by default, and the levels can be referred to in /etc/debug.ini.
  • Using rdklogctrl, we can enable/disable the logs from any module integrated with rdklogger

Notification levels 

  • Files :
    1. ./etc/debug.ini
    2. rdklogctrl <app_name> <module_name> <loglevel>
      rdklogctrl CcspWifiSsp LOG.RDK.WIFI FATAL,ERROR,WARN,NOTICE,INFO,DEBUG,TRACE1-TRACE9
  • The default log levels set for components are FATAL,ERROR,WARN,NOTICE,INFO.
  • Log levels can be controlled independently for each module.

Examples

Changing SSID name

  • Default SSID

...

Log levels and notifications

Loge levelsDescription
RDK_LOG_DEBUGInformation that is diagnostically helpful to people more than just developers.
RDK_LOG_ERRORAny error which is fatal to the operation but not the service (cant open a file, missing data, etc)
RDK_LOG_FATALAny error that is forcing a shutdown of the service or application to prevent data loss (or further data loss), reserve these only for the most heinous errors and situations where there is guaranteed to have been data corruption or loss.
RDK_LOG_INFOGenerally useful information to log (service start/stop, configuration assumptions, etc).
RDK_LOG_NOTICEAnything that largely superfluous for application-level logging.

RDK_LOG_TRACE1,

RDK_LOG_TRACE2,...

Only when it would be "tracing" the code and trying to find one part of a function specifically.
RDK_LOG_WARNAnything that can potentially cause application oddities, but for which the application automatically recovering.

debug.ini

    • Logs from different components can be logged into separate files based on the "SEPARATE.LOGFILE.SUPPORT" variable.

    • It also contains entries for each component log levels. Log levels can be controlled independently for each module.

      Example: LOG.RDK.<component name> = ALL, FATAL, ERROR WARNING, NOTICE, INFO, DEBUG

    • For the modules not having entries in configuration file, log level is set to default log levels. (Currently this is set to LOG.RDK.DEFAULT = ERROR in debug.ini)
    • “rdkb_debug.ini” files are parsed by rdk_logger_init() function for loading all the components entry.

rdklogctrl

  • rdklogctrl <app_name> <module_name> <loglevel>
    1. To add a new log level - rdklogctrl CcspWifiSsp LOG.RDK.WIFI DEBUG
    2. To remove the existing Log level - rdklogctrl CcspWifiSsp LOG.RDK.WIFI ~DEBUG

rdklogctrl usage examples

Changing SSID name

  • Default SSID

root@RaspberryPi-Gateway:~#  dmcli eRT getv Device.WiFi.SSID.1.SSID
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
getv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.SSID.1.SSID
Execution succeed.
Parameter    1 name: Device.WiFi.SSID.1.SSID
               type:     string,    value: RPI_RDKB-AP0

  • Module: Onewifi . By default, the logs are enabled with below log levels

LOG.RDK.WIFI = FATAL ERROR WARNING NOTICE INFO

  • Logs 

 tail -f /rdklogs/logs/WiFilog.txt.0

  • Module : Onewifi . By default the logs are enabled with below configuration
  • /etc/debug.ini

...

LOG.RDK.WIFI = FATAL ERROR WARNING NOTICE INFO

  • Logs 

r

240809-13:51:27.591054 [mod=WIFI, lvl=WARN] [tid=1953]
Subsystem is eRT.
240809-13:51:27.591768 [mod=WIFI, lvl=INFO] [tid=1953] Connect to bus daemon...
240809-13:51:27.591959 [mod=WIFI, lvl=WARN] [tid=1953] RBus is enabled
240809-13:51:27.592057 [mod=WIFI, lvl=INFO] [tid=1953] rbuscore.c:2326 RBus Enabled

240809-13:51:27.592180 [mod=WIFI, lvl=INFO] [tid=1953] connection opened for eRT.com.cisco.spvtg.ccsp.wifi
240809-13:51:27.592388 [mod=WIFI, lvl=INFO] [tid=1953] rbuscore.c:926 Registering method table for object eRT.com.cisco.spvtg.ccsp.wifi

240809-13:51:27.592546 591054 [mod=WIFI, lvl=INFOWARN] [tid=1953] eRT.com.cisco.spvtg.ccsp.wifi start to check eRT.com.cisco.spvtg.ccsp.psm status
240809
Subsystem is eRT.
240809-13:51:27.596322 591768 [mod=WIFI, lvl=INFO] [tid=1953] eRT.com.cisco.spvtg.ccsp.psm is ready, eRT.com.cisco.spvtg.ccsp.wifi continueConnect to bus daemon...
240809-13:51:27.596434 591959 [mod=WIFI, lvl=INFOWARN] [tid=1953] !!! Connected to message bus... bus_handle: 0x0x7f8c018de0 !!!RBus is enabled
240809-13:51:27.592057 [mod=WIFI, lvl=INFO] [tid=1953] rbuscore.c:2326 RBus Enabled

240809-13:51:2827.602883 592180 [mod=WIFI, lvl=INFO] [tid=1953] CcspBaseIf_Register_Event_rbus : rbus_registerEvent called for event: currentSessionIDSignalconnection opened for eRT.com.cisco.spvtg.ccsp.wifi
240809-13:51:2827.620576 592388 [mod=WIFI, lvl=INFO] [tid=1953] rbuscore.c:742 Subscription for _rbus_session_mgr::currentSessionIDSignal is now active.926 Registering method table for object eRT.com.cisco.spvtg.ccsp.wifi

240809-13:51:2827.621396 592546 [mod=WIFI, lvl=WARNINFO] [tid=1953] Register empty object : com. eRT.com.cisco.spvtg.ccsp.wifi start to check eRT.com.cisco.spvtg.ccsp.psm status
240809-13:51:2827.621487 596322 [mod=WIFI, lvl=WARNINFO] [tid=1953] Register empty object : eRT.com.cisco.spvtg.ccsp.psm is ready, eRT.com.cisco.spvtg.ccsp.wifi continue
240809-13:51:2827.621543 596434 [mod=WIFI, lvl=WARNINFO] [tid=1953] Register empty object : com.cisco.spvtg.!!! Connected to message bus... bus_handle: 0x0x7f8c018de0 !!!
240809-13:51:28.621601 602883 [mod=WIFI, lvl=WARNINFO] [tid=1953] Register empty object : com.cisco.spvtg.ccsp.CcspBaseIf_Register_Event_rbus : rbus_registerEvent called for event: currentSessionIDSignal
240809-13:51:28.628362 620576 [mod=WIFI, lvl=WARNINFO] [tid=1953] Data model XML file 1 = TR181-WiFi-USGv2.XMLrbuscore.c:742 Subscription for _rbus_session_mgr::currentSessionIDSignal is now active.

240809-13:51:28.628910 621396 [mod=WIFI, lvl=WARN] [tid=1953] DM Library module name = CCSP Base Data ModelRegister empty object : com.
240809-13:51:28.638364 621487 [mod=WIFI, lvl=WARN] [tid=1953] DM Library module name = COSA_TR181_WiFi_USGv2Register empty object : com.cisco.
240809-13:51:28.638518 621543 [mod=WIFI, lvl=WARN] [tid=1953] Loading DM library libwifi.so..Register empty object : com.cisco.spvtg.
240809-13:51:28.651047 621601 [mod=WIFI, lvl=WARN] [tid=1953]  RDKB_SYSTEM_BOOT_UP_LOG : CosaWifiInitialize - WiFi initializeRegister empty object : com.cisco.spvtg.ccsp.
240809-13:51:2928.296945 628362 [mod=WIFI, lvl=INFOWARN] [tid=1953] rbus.c:2771 rbus open for component: WebconfigDMLData model XML file 1 = TR181-WiFi-USGv2.XML
240809-13:51:2928.297285 628910 [mod=WIFI, lvl=INFOWARN] [tid=1953] rbus.c:2847  rbus open (WebconfigDML) successDM Library module name = CCSP Base Data Model
240809-13:51:2928.298751 638364 [mod=WIFI, lvl=INFOWARN] [tid=1621] rbus.c:1018 Consumer=rbus.OneWifi.INBOX.1555 SUBSCRIBED to event=Device.WiFi.WebConfig.Data.Subdoc.North240809-13:51:29.300330 1953] DM Library module name = COSA_TR181_WiFi_USGv2
240809-13:51:28.638518 [mod=WIFI, lvl=INFOWARN] [tid=1953] rbuscore.c:742 Subscription for Device.WiFi.WebConfig.Data.Subdoc.North::Device.WiFi.WebConfig.Data.Subdoc.North is now active.Loading DM library libwifi.so...
240809-13:51:2928.300482 651047 [mod=WIFI, lvl=INFOWARN] [tid=1953] rbus.c:4786 Device.WiFi.WebConfig.Data.Subdoc.North subscribe retries succeeded RDKB_SYSTEM_BOOT_UP_LOG : CosaWifiInitialize - WiFi initialize.
240809-13:51:29.301349 296945 [mod=WIFI, lvl=INFO] [tid=16211953] rbus.c:1018 Consumer=rbus.OneWifi.INBOX.1555 SUBSCRIBED to event=Device.WiFi.WebConfig.Data.Init_dml2771 rbus open for component: WebconfigDML

240809-13:51:29.302305 297285 [mod=WIFI, lvl=INFO] [tid=1953] rbuscorerbus.c:742 Subscription for Device.WiFi.WebConfig.Data.Init_dml::Device.WiFi.WebConfig.Data.Init_dml is now active.2847  rbus open (WebconfigDML) success

240809-13:51:29.302440 298751 [mod=WIFI, lvl=INFO] [tid=19531621] rbus.c:4786 1018 Consumer=rbus.OneWifi.INBOX.1555 SUBSCRIBED to event=Device.WiFi.WebConfig.Data.Init_dml subscribe retries succeededSubdoc.North

240809-13:51:29.493276 300330 [mod=WIFI, lvl=WARNINFO] [tid=1953]  RDKB_SYSTEM_BOOT_UP_LOG : CosaWifiInitialize - WiFi initialization completerbuscore.c:742 Subscription for Device.WiFi.WebConfig.Data.Subdoc.North::Device.WiFi.WebConfig.Data.Subdoc.North is now active.

240809-13:51:29.493495 300482 [mod=WIFI, lvl=INFO] [tid=1953] rbuscorerbus.c:2326 RBus Enabled4786 Device.WiFi.WebConfig.Data.Subdoc.North subscribe retries succeeded

240809-13:51:29.493567 301349 [mod=WIFI, lvl=INFO] [tid=19531621] rbus.c:2771 rbus open for component: t2_lib_ccsp-wifi-agent1018 Consumer=rbus.OneWifi.INBOX.1555 SUBSCRIBED to event=Device.WiFi.WebConfig.Data.Init_dml

240809-13:51:29.493853 302305 [mod=WIFI, lvl=INFO] [tid=1953] rbusrbuscore.c:2847  rbus open (t2_lib_ccsp-wifi-agent) success240809-13:742 Subscription for Device.WiFi.WebConfig.Data.Init_dml::Device.WiFi.WebConfig.Data.Init_dml is now active.

240809-13:51:29.302440 51:29.496362 [mod=WIFI, lvl=ERRORINFO] [tid=1953] rbus.c:3317 get by t2_lib_ccsp-wifi-agent failed; Received error 17 from RBUS Daemon for the object Telemetry.ReportProfiles.ccsp-wifi-agent.EventMarkerList

  • Changing the SSID

...

root@RaspberryPi-Gateway:~# dmcli eRT setv Device.WiFi.SSID.1.SSID string RPI_RdkB

CR component name is: eRT.com.cisco.spvtg.ccsp.CR

subsystem_prefix eRT.

setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.SSID.1.SSID

Execution succeed.

  • Logs:

4786 Device.WiFi.WebConfig.Data.Init_dml subscribe retries succeeded

240809-13:51:29.493276 [mod=WIFI, lvl=WARN] [tid=1953]  RDKB_SYSTEM_BOOT_UP_LOG : CosaWifiInitialize - WiFi initialization complete.
240809-13:51:29.493495 [mod=WIFI, lvl=INFO] [tid=1953] rbuscore.c:2326 RBus Enabled

240809-13:51:3829.446402 493567 [mod=WIFI, lvl=INFO] [tid=15551953] rbus.c:4786 Device.DeviceInfo.X_RDKCENTRAL-COM_xOpsDeviceMgmt.Mesh.Enable subscribe retries succeeded2771 rbus open for component: t2_lib_ccsp-wifi-agent

240809-13:51:4629.478663 493853 [mod=WIFI, lvl=INFO] [tid=17091953] subscribeSubdocForceReset: [Device.X_RDK_WebConfig.webcfgSubdocForceReset] Component foundrbus.c:2847  rbus open (t2_lib_ccsp-wifi-agent) success

240809-13:51:4629.478765 496362 [mod=WIFI, lvl=INFOERROR] [tid=17091953] rbus.c:3317 get by t2_lib_ccsp-wifi-agent failed; Received error 17 from RBUS Daemon for the object Telemetry.ReportProfiles.ccsp-wifi-agent.EventMarkerList

  • Changing the SSID

root@RaspberryPi-Gateway:~# dmcli eRT setv Device.WiFi.SSID.1.SSID string RPI_RdkB

CR component name is: eRT.com.cisco.spvtg.ccsp.CR

subsystem_prefix eRT.

setv from/to component(eRT.com.cisco.spvtg.ccsp.wifi): Device.WiFi.SSID.1.SSID

Execution succeed.

  • Logs:

240809-13:51:38.446402 [mod= subscribeSubdocForceReset: subscribing to event Device.X_RDK_WebConfig.webcfgSubdocForceReset
240809-13:51:46.480941 [mod=WIFI, lvl=INFO] [tid=1709] rbuscore.c:742 Subscription for Device.X_RDK_WebConfig.webcfgSubdocForceReset::Device.X_RDK_WebConfig.webcfgSubdocForceReset is now active.240809-13:51:46.481080 [mod=WIFI, lvl=INFO] [tid=17091555] rbus.c:4786 Device.DeviceInfo.X_RDK_WebConfig.webcfgSubdocForceReset RDKCENTRAL-COM_xOpsDeviceMgmt.Mesh.Enable subscribe retries succeeded

240809-13:51:46.481150 478663 [mod=WIFI, lvl=INFO] [tid=1709] subscribeSubdocForceReset: subscribed to event [Device.X_RDK_WebConfig.webcfgSubdocForceReset] Component found
240809-13:51:46.481230 478765 [mod=WIFI, lvl=INFO] [tid=1709] subscribeSubdocForceReset: job donesubscribing to event Device.X_RDK_WebConfig.webcfgSubdocForceReset
240809-13:5551:0046.879242 480941 [mod=WIFI, lvl=WARNINFO] [tid=1621] << DslhWmpdoMpaSetParameterValues sending Notification str Device.WiFi.SSID.1.SSID,16,RPI_RdkB,RPI_RDKB-AP0,2 >>1709] rbuscore.c:742 Subscription for Device.X_RDK_WebConfig.webcfgSubdocForceReset::Device.X_RDK_WebConfig.webcfgSubdocForceReset is now active.

240809-13:5551:0046.879371 481080 [mod=WIFI, lvl=WARNINFO] [tid=1621] << DslhWmpdoMpaSetParameterValues sending Notification Device.WiFi.SSID.1.SSID,16,RPI_RdkB,RPI_RDKB-AP0,2 >>1709] rbus.c:4786 Device.X_RDK_WebConfig.webcfgSubdocForceReset subscribe retries succeeded

240809-13:5551:0046.879419 481150 [mod=WIFI, lvl=WARNINFO] [tid=1621] << DslhWmpdoMpaSetParameterValues sending Notification ulArraySize 1 >>
240809-13:55:00.879476 1709] subscribeSubdocForceReset: subscribed to event Device.X_RDK_WebConfig.webcfgSubdocForceReset
240809-13:51:46.481230 [mod=WIFI, lvl=WARNINFO] [tid=16211709] DslhObjcoValidate: SSID, bsUpdate = 3subscribeSubdocForceReset: job done
240809-13:55:00.879575 879242 [mod=WIFI, lvl=WARN] [tid=1621] Send all pending notifications 1<< DslhWmpdoMpaSetParameterValues sending Notification str Device.WiFi.SSID.1.SSID,16,RPI_RdkB,RPI_RDKB-AP0,2 >>
240809-13:55:00.879791 879371 [mod=WIFI, lvl=WARN] [tid=1621] Before committing:<< DslhWmpdoMpaSetParameterValues sending Notification Device.WiFi.SSID.1.SSID,16,RPI_RdkB,RPI_RDKB-AP0,2 >>
240809-13:55:00.879819 879419 [mod=WIFI, lvl=WARN] [tid=9545]  Send_Notification_Thread_Func paramCount 11621] << DslhWmpdoMpaSetParameterValues sending Notification ulArraySize 1 >>
240809-13:55:00.879846 879476 [mod=WIFI, lvl=WARN] [tid=1621] After committing:Device.WiFi.SSID.1.:0DslhObjcoValidate: SSID, bsUpdate = 3

240809-13:55:00.879896 879575 [mod=WIFI, lvl=WARN] [tid=95451621] << Send_Notification_Thread_Func i 0 >>
240809Send all pending notifications 1
240809-13:55:00.879985 879791 [mod=WIFI, lvl=WARN] [tid=9545] << str[i] 1621] Before committing:Device.WiFi.SSID.1.SSID,16,RPI_RdkB,RPI_RDKB-AP0,2 >>
240809-13:55:00.883654 879819 [mod=WIFI, lvl=WARN] [tid=9545] << Send Send_Notification_Thread_Func , now g_isBusy  is not anymore busy, we have notify>>

  • Flow :
    DslhObjcoCommit() -> SSID_Commit() -> CosaDmlWiFiSsidSetCfg() -> wifi_setSSIDName() -> wifi_hostapdWrite() -> cfgChange = TRUE

Change the log level during runtime

...

paramCount 1
240809-13:55:00.879846 [mod=WIFI, lvl=WARN] [tid=1621] After committing:Device.WiFi.SSID.1.:0
240809-13:55:00.879896 [mod=WIFI, lvl=WARN] [tid=9545] << Send_Notification_Thread_Func i 0 >>
240809-13:55:00.879985 [mod=WIFI, lvl=WARN] [tid=9545] << str[i] Device.WiFi.SSID.1.SSID,16,RPI_RdkB,RPI_RDKB-AP0,2 >>
240809-13:55:00.883654 [mod=WIFI, lvl=WARN] [tid=9545] << Send_Notification_Thread_Func, now g_isBusy  is not anymore busy, we have notify>>


  • Change the log level during runtime
root@RaspberryPi-Gateway:~# rdklogctrl OneWifi LOG.RDK.WIFI DEBUG
Sent message to update log level of LOG.RDK.WIFI for OneWifi process


  • Log

root@RaspberryPi-Gateway:~# tail -f /rdklogs/logs/WiFilog.txt.0
241009-12:25:46.278437 [mod=WIFI, lvl=DEBUG] [tid=1597] rbus_asyncsubscribe.c:306 waked up

241009-12:25:46.278706 [mod=WIFI, lvl=DEBUG] [tid=1597] rbus_asyncsubscribe.c:117 now=00:27:47.704640

241009-12:25:46.278817 [mod=WIFI, lvl=DEBUG] [tid=1597] rbus_asyncsubscribe.c:296 timedwait until 00:28:48.704640

  • Removing Loglevel runtime
root@RaspberryPi-Gateway:~# rdklogctrl OneWifi LOG.RDK.WIFI ~DEBUG
Sent message to update log level of LOG.RDK.WIFI for OneWifi process

Changing lan mode (PAM)

  • Module: PAM. By default, the logs are enabled with below log levels

LOG.RDK.PAM = FATAL ERROR WARNING NOTICE INFO

  • Checking the current Lan mode

dmcli eRT getv Device.X_CISCO_COM_DeviceControl.LanManagementEntry.1.LanMode

CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
getv from/to component(eRT.com.cisco.spvtg.ccsp.pam): Device.X_CISCO_COM_DeviceControl.LanManagementEntry.1.LanMode
Execution succeed.
Parameter    1 name: Device.X_CISCO_COM_DeviceControl.LanManagementEntry.1.LanMode
               type:     string,    value: router

  • Changing the lan mode to bridge-static

root@RaspberryPi-Gateway:~# dmcli eRT setv Device.X_CISCO_COM_DeviceControl.LanManagementEntry.1.LanMode string bridge-static

CR component name is: eRT.com.cisco.spvtg.ccsp.CR

subsystem_prefix eRT.

setv from/to component(eRT.com.cisco.spvtg.ccsp.pam): Device.X_CISCO_COM_DeviceControl.LanManagementEntry.1.LanMode

Execution succeed.

  • Logs:

241009-06:53:25.578466 [mod=PAM, lvl=WARN] [tid=964] << DslhWmpdoMpaSetParameterValues sending Notification str Device.X_CISCO_COM_DeviceControl.LanManagementEntry.1.LanMode,16,bridge-static,router,2 >>
241009-06:53:25.578587 [mod=PAM, lvl=WARN] [tid=964] << DslhWmpdoMpaSetParameterValues sending Notification Device.X_CISCO_COM_DeviceControl.LanManagementEntry.1.LanMode,16,bridge-static,router,2 >>
241009-06:53:25.578636 [mod=PAM, lvl=WARN] [tid=964] << DslhWmpdoMpaSetParameterValues sending Notification ulArraySize 1 >>
241009-06:53:25.578717 [mod=PAM, lvl=WARN] [tid=964] DslhObjcoValidate: LanMode, bsUpdate = 3

241009-06:53:25.578896 [mod=PAM, lvl=WARN] [tid=964] RDKB_LAN_CONFIG_CHANGED: Setting new LanMode value (bridge-dhcp(1),bridge-static(2),router(3),full-bridge-static(4)) as (2)...
241009-06:53:25.579518 [mod=PAM, lvl=WARN] [tid=964] Send all pending notifications 1
241009-06:53:25.579762 [mod=PAM, lvl=WARN] [tid=964] Before committing

 Changing lan mode (PAM)

  • Enabling Logger and Log level

...

LOG.RDK.PAM = FATAL ERROR WARNING NOTICE INFO

  • Checking the current Lan mode

dmcli eRT getv Device.X_CISCO_COM_DeviceControl.LanManagementEntry.1.LanMode

CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
getv from/to component(eRT.com.cisco.spvtg.ccsp.pam)

:Device.X_CISCO_COM_DeviceControl.LanManagementEntry.1.

LanMode
Execution succeed.
Parameter    1 name: Device.X_CISCO_COM_DeviceControl.LanManagementEntry.1.LanMode
               type:     string,    value: router
  • Changing the lan mode to bridge-static


241009-06:53:25.579784 [mod=PAM, lvl=WARN] [tid=31227]  Send_Notification_Thread_Func paramCount 1
241009-06:53:25.579889 [mod=PAM, lvl=WARN] [tid=31227] << Send_Notification_Thread_Func i 0 >>
241009-06:53:25.579967 [mod=PAM, lvl=WARN] [tid=31227] << str[i]

root@RaspberryPi-Gateway:~# dmcli eRT setv

Device.X_CISCO_COM_DeviceControl.LanManagementEntry.1.LanMode

string

,16,bridge-static

CR component name is: eRT.com.cisco.spvtg.ccsp.CR

subsystem_prefix eRT.

setv from/to component(eRT.com.cisco.spvtg.ccsp.pam): Device.X_CISCO_COM_DeviceControl.LanManagementEntry.1.LanMode

Execution succeed.

  • Logs:

,router,2 >>
241009-06:53:25.580847 [mod=PAM, lvl=INFO] [tid=964] LanMode:Adv_Bridge_Mode_selected
241009-06:53:25.582140 [mod=PAM, lvl=WARN] [tid=31227] << Send_Notification_Thread_Func, now g_isBusy  is not anymore busy, we have notify>>
241009-06:53:25.

578466

590738 [mod=PAM, lvl=WARN] [tid=964]

<< DslhWmpdoMpaSetParameterValues sending Notification str Device.X_CISCO_COM_DeviceControl.LanManagementEntry.1.LanMode,16,bridge-static,router,2 >>

--------- LanMngm_Commit CosaDmlDcResetBr0 1.0.0.254,0.255.255.255>>
241009-06:53:25.

578587

594950 [mod=PAM, lvl=WARN] [tid=964]

<< DslhWmpdoMpaSetParameterValues sending Notification Device.X_CISCO_COM_DeviceControl.LanManagementEntry.1.LanMode,16,bridge-static,router,2 >>

--------- LanMngm_Commit CosaDmlDcResetBr0 <<
241009-06:53:25.

578636

595116 [mod=PAM, lvl=WARN] [tid=964]

<< DslhWmpdoMpaSetParameterValues sending Notification ulArraySize 1 >>

After committing:Device.X_CISCO_COM_DeviceControl.LanManagementEntry.1.:0
241009-06:53:25.

578717

656529 [mod=PAM, lvl=WARN] [tid=964]

DslhObjcoValidate: LanMode, bsUpdate = 3

-----DeviceControl_GetParamBoolValue,Trying to get parameter 'ErouterEnable'
241009-06:53:25.

578896

656698 [mod=PAM, lvl=WARN] [tid=964]

RDKB_LAN_CONFIG_CHANGED: Setting new LanMode value (bridge-dhcp(1),bridge-static(2),router(3),full-bridge-static(4)) as (2)...

DslhObjcoValidate: ErouterEnable, bsUpdate = 3

241009-06:53:25.

579518

658429 [mod=PAM, lvl=WARN] [tid=964]

Send all pending notifications 1

DslhObjcoValidate: Enable, bsUpdate = 3

241009-06:53:25.

579762

659793 [mod=PAM, lvl=WARN] [tid=964] Before committing:Device.

X_CISCO_COM_DeviceControl.LanManagementEntry

Bridging.Bridge.1.Port.9.
241009-06:53:25.

579784

659920 [mod=PAM, lvl=

WARN

NOTICE] [tid=

31227]  Send_Notification_Thread_Func paramCount 1

964] <HL>SWBrConfirmStructureUpdate port remove member Inx=dmsb.l2net.1.Members.Eth, Val=lbr0
241009-06:53:25.

579889

659970 [mod=PAM, lvl=

WARN

NOTICE] [tid=

31227

964]

<< Send

<HL> _

Notification_Thread_Func i 0 >>

COSA_RemoveBPortMember path=dmsb.l2net.1.Members.Eth name=lbr0
241009-06:53:25.

579967

660059 [mod=PAM, lvl=

WARN

NOTICE] [tid=

31227] << str[i] Device.X_CISCO_COM_DeviceControl.LanManagementEntry.1.LanMode,16,bridge-static,router,2 >>

964] <HL> _Psm_GetBPortMemberList path=dmsb.l2net.1.Members.Eth value=NULL
241009-06:53:25.

580847

661407 [mod=PAM, lvl=

INFO

NOTICE] [tid=964]

LanMode:Adv

_

Bridge_Mode_selected

Psm_GetBPortMemberList: retPsmGet == CCSP_SUCCESS reading dmsb.l2net.1.Members.Eth=
241009-06:53:25.

582140

661509 [mod=PAM, lvl=

WARN

NOTICE] [tid=

31227

964]

<< Send

<HL> _

Notification_Thread_Func, now g_isBusy  is not anymore busy, we have notify>>

COSA_DelToken str= token=lbr0
241009-06:53:25.

590738

661554 [mod=PAM, lvl=

WARN

NOTICE] [tid=964]

--------- LanMngm_Commit CosaDmlDcResetBr0 1.0.0.254,0.255.255.255>>

<HL> _COSA_DelToken Not Found token in Buffer=
241009-06:53:25.

594950

661622 [mod=PAM, lvl=

WARN

NOTICE] [tid=964]

--------- LanMngm_Commit CosaDmlDcResetBr0 <<

<HL>SWBrConfirmStructureUpdate port add member Inx=dmsb.l2net.1.Members.Eth, Val=lbr0
241009-06:53:25.

595116

661670 [mod=PAM, lvl=

WARN

NOTICE] [tid=964]

After committing:Device.X_CISCO_COM_DeviceControl.LanManagementEntry.1.:0

<HL> _COSA_AddBPortMember path=dmsb.l2net.1.Members.Eth name=lbr0
241009-06:53:25.

656529

661713 [mod=PAM, lvl=

WARN

NOTICE] [tid=964]

-----DeviceControl_GetParamBoolValue,Trying to get parameter 'ErouterEnable'

<HL> _Psm_GetBPortMemberList path=dmsb.l2net.1.Members.Eth value=NULL
241009-06:53:25.

656698

663032 [mod=PAM, lvl=

WARN

NOTICE] [tid=964]

DslhObjcoValidate: ErouterEnable, bsUpdate = 3

_Psm_GetBPortMemberList: retPsmGet == CCSP_SUCCESS reading dmsb.l2net.1.Members.Eth=
241009-06:53:25.

658429

663137 [mod=PAM, lvl=

WARN

NOTICE] [tid=964]

DslhObjcoValidate: Enable, bsUpdate = 3

<HL> _COSA_AddToken new Str=lbr0 after add:lbr0
241009-06:53:25.

659793

663181 [mod=PAM, lvl=

WARN

NOTICE] [tid=964]

Before committing:Device.Bridging.Bridge.1.Port.9.

<HL> _Psm_SetBPortMemberList path=dmsb.l2net.1.Members.Eth value=lbr0
241009-06:53:25.

659920

664380 [mod=PAM, lvl=NOTICE] [tid=964]

<HL>SWBrConfirmStructureUpdate port remove member Inx=

_Psm_SetBPortMemberList: retPsmSet == CCSP_SUCCESS writing dmsb.l2net.1.Members.Eth

, Val

=lbr0
241009-06:53:25.

659970

664465 [mod=PAM, lvl=NOTICE] [tid=964] <HL> _COSA_

RemoveBPortMember

AddBPortMember new path=dmsb.l2net.1.Members.Eth name=lbr0
241009-06:53:25.

660059

664527 [mod=PAM, lvl=NOTICE] [tid=964] <HL> _Psm_

GetBPortMemberList path

AddLinkMembers param_name=dmsb.l2net.1.Members.

Eth value=NULL

Link
241009-06:53:25.

661407

665632 [mod=PAM, lvl=NOTICE] [tid=964] _Psm_

GetBPortMemberList

AddLinkMembers: retPsmGet == CCSP_SUCCESS reading dmsb.l2net.1.Members.

Eth=

Link
241009-06:53:25.

661509

701156 [mod=PAM, lvl=NOTICE] [tid=964]

<HL> _COSA_DelToken str= token=lbr0

lanBrPCtlSetEnabled: ioctl(SIOCGIFFLAGS) failed (errno: 19): No such device
241009-06:53:25.

661554

713424 [mod=PAM, lvl=NOTICE] [tid=964] <HL> _COSA_

DelToken Not Found token in Buffer=

GetInterfaceTypeStr
241009-06:53:25.

661622

713585 [mod=PAM, lvl=NOTICE] [tid=964]

<HL>SWBrConfirmStructureUpdate port add member Inx=dmsb.l2net.1.Members.Eth, Val=lbr0

_Psm_SetBPort linkType=Ethernet port->linkType=1
241009-06:53:25.

661670

721470 [mod=PAM, lvl=

NOTICE

WARN] [tid=964]

<HL> _COSA_AddBPortMember path=dmsb.l2net

After committing:Device.Bridging.Bridge.1.

Members.Eth name=lbr0

Port.9.:0
241009-06:53:25.

661713

721574 [mod=PAM, lvl=NOTICE] [tid=964]

<HL> _Psm_GetBPortMemberList path=dmsb.l2net.1.Members.Eth value=NULL

The notification = 0
241009-06:53:25.

663032

722793 [mod=PAM, lvl=

NOTICE

WARN] [tid=964]

_Psm_GetBPortMemberList: retPsmGet == CCSP_SUCCESS reading dmsb.l2net.1.Members.Eth=

Before committing:Device.X_CISCO_COM_DeviceControl.
241009-06:53:25.

663137

722809 [mod=PAM, lvl=

NOTICE

INFO] [tid=

964] <HL> _COSA_AddToken new Str=lbr0 after add:lbr0

31281] bridge_mode_wifi_notifier_thread - Mode:2 Radio:true SSID:false
241009-06:53:25.

663181

722917 [mod=PAM, lvl=

NOTICE

WARN] [tid=964] After committing:Device.X_CISCO_COM_DeviceControl.:0


  • Change the log level during runtime
rdklogctrl CcspPandMSsp LOG.RDK.PAM DEBUG
  • Logs
<HL> _Psm_SetBPortMemberList path=dmsb.l2net.1.Members.Eth value=lbr0
241009-06:53:25.664380 NOTICE964] _Psm_SetBPortMemberList: retPsmSet == CCSP_SUCCESS writing dmsb.l2net.1.Members.Eth=lbr0
241009-06:53:25.664465 NOTICE964 <HL> _COSA_AddBPortMember new path=dmsb.l2net.1.Members.Eth name=lbr0
241009-06:53:25.664527 NOTICE964] <HL> _Psm_AddLinkMembers param_name=dmsb.l2net.1.Members.Link
241009-06:53:25.665632 NOTICE964Psm_AddLinkMembers: retPsmGet == CCSP_SUCCESS reading dmsb.l2net.1.Members.Link
241009-06:53:25.701156 NOTICE964] lanBrPCtlSetEnabled: ioctl(SIOCGIFFLAGS) failed (errno: 19): No such device
241009-06:53:25.713424 NOTICE964] <HL> _COSA_GetInterfaceTypeStr065325713585 NOTICE964Psm_SetBPort linkType=Ethernet port->linkType=1065325721470 WARN964] After committing:Device.Bridging.Bridge.1.Port.9.:0
241009-06:53:25.721574 NOTICE964] The notification = 0065325722793 WARN964] Before committing:Device.X_CISCO_COM_DeviceControl.
241009-06:53:25.722809 INFO31281 bridge_mode_wifi_notifier_thread - Mode:2 Radio:true SSID:false
241009-06:53:25.722917 WARN964] After committing:Device.X_CISCO_COM_DeviceControl.:0

Y.CliStatList
241009-12:39:34.501255

[mod=PAM, lvl=

DEBUG] [tid=

1599] rbusValueChange_GetParameterValue Device.DeviceInfo.X_RDKCENTRAL-COM_WIFI_TELEMETRY.TxRxRateList success 1,2
241009-12:39:34.501323 [mod=PAM, lvl=

DEBUG] [tid=

1599]

rbusValueChange_pollingThreadFunc: value change not detected for Device.DeviceInfo.X_RDKCENTRAL-COM_WIFI_TELEMETRY.TxRxRateList
241009-12:39:35.501613 [mod=PAM, lvl=

DEBUG] [tid=

1599] rbusValueChange_GetParameterValue Device.DeviceInfo.X_RDKCENTRAL-COM_WIFI_TELEMETRY.NormalizedRssiList success 1,2
241009-12:39:35.501742 [mod=PAM, lvl=

DEBUG] [tid=

1599] rbusValueChange_

pollingThreadFunc: value change not detected for Device.DeviceInfo.X_RDKCENTRAL-COM_WIFI_TELEMETRY.NormalizedRssiList
241009-12:39:35.501854 [mod=PAM, lvl=

DEBUG] [tid=

1599] rbusValueChange_GetParameterValue Device.DeviceInfo.X_RDKCENTRAL-COM_WIFI_TELEMETRY.SNRList success 1,2
241009-12:39:35.501924 [mod=PAM, lvl=

DEBUG] [tid=

1599] rbusValueChange_pollingThreadFunc: value change not detected for Device.DeviceInfo.X_RDKCENTRAL-COM_WIFI_TELEMETRY.SNRList
241009-

12:

39:

35.

502156 [mod=PAM, lvl=

DEBUG] [tid=

1599] rbusValueChange_

GetParameterValue Device.X_COMCAST-COM_GRE.Tunnel.1.TunnelStatus success
241009-

12:

39:

35.

502236 [mod=PAM, lvl=

DEBUG] [tid=

1599] rbusValueChange_pollingThreadFunc: value change not detected for Device.X_COMCAST-COM_GRE.Tunnel.1.TunnelStatus
241009-12:39:35.502339 [mod=PAM, lvl=

DEBUG] [tid=

1599] rbusValueChange_GetParameterValue Device.DeviceInfo.X_RDKCENTRAL-COM_WIFI_TELEMETRY.CliStatList success 1,2
241009-

12:

39:

35.

502407 [mod=PAM, lvl=

DEBUG] [tid=

1599] rbusValueChange_pollingThreadFunc: value change not detected for Device.DeviceInfo.X_RDKCENTRAL-COM_WIFI_TELEMETRY.CliStatList
241009-12:39:35.502509 [mod=PAM, lvl=

DEBUG] [tid=

1599]

rbusValueChange_GetParameterValue Device.DeviceInfo.X_RDKCENTRAL-COM_WIFI_TELEMETRY.TxRxRateList success 1,2
241009-12:39:35.502578 [mod=PAM, lvl=

DEBUG] [tid=

1599] rbusValueChange_pollingThreadFunc: value change not detected for Device.DeviceInfo.X_RDKCENTRAL-COM_WIFI_TELEMETRY.TxRxRateList