Versions Compared

Key

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

...

Code Block
languagebash
themeDJango
titlePAM logs
collapsetrue
240423-06:06:16.537008 [mod=PAM, lvl=WARN] [tid=1463] base64 decoded data contains 194 bytes
240423-06:06:16.537072 [mod=PAM, lvl=WARN] [tid=1463] Base64 decode Elapsed time : 0 ms
240423-06:06:16.537135 [mod=PAM, lvl=WARN] [tid=1463] MSGPACK_UNPACK_SUCCESS :2
240423-06:06:16.537222 [mod=PAM, lvl=WARN] [tid=1463] pLanInfo->entries_count is 1
240423-06:06:16.537279 [mod=PAM, lvl=WARN] [tid=1463] pLanInfo->subdoc_name is lan
240423-06:06:16.537335 [mod=PAM, lvl=WARN] [tid=1463] pLanInfo->version is 627376240
240423-06:06:16.537391 [mod=PAM, lvl=WARN] [tid=1463] pLanInfo->transaction_id is 8517
240423-06:06:16.537446 [mod=PAM, lvl=WARN] [tid=1463] Lan configuration received
240423-06:06:16.537508 [mod=PAM, lvl=INFO] [tid=1463] PushBlobRequest : subdoc_name lan , txid 8517, version 627376240 , entries 1
240423-06:06:16.537581 [mod=PAM, lvl=INFO] [tid=1463] Inside FUNC checkNewVersionUpdateRequired LINE 1244 
240423-06:06:16.537645 [mod=PAM, lvl=INFO] [tid=1463] checkIfVersionExecInQueue : Queue Empty
240423-06:06:16.537707 [mod=PAM, lvl=INFO] [tid=1463] New version available , prcessing new Blob request
240423-06:06:16.537785 [mod=PAM, lvl=INFO] [tid=1463] calculateTimeout is NULL , using default timeout routine
240423-06:06:16.537843 [mod=PAM, lvl=INFO] [tid=1463] PushBlobRequest timeout received from calcTimeout is 13
240423-06:06:16.537902 [mod=PAM, lvl=INFO] [tid=1463] getPendingQueueTimeout : Queue Empty
240423-06:06:16.537962 [mod=PAM, lvl=INFO] [tid=1463] PushBlobRequest : Send received request ACK , timeout is 13
240423-06:06:16.538023 [mod=PAM, lvl=INFO] [tid=1463] send_ACK : doc name lan , doc version 627376240, txid is 8517  timeout is 13
240423-06:06:16.538083 [mod=PAM, lvl=INFO] [tid=1463] isWebCfgRbusEnabled: rbus enabled is 1 
240423-06:06:16.538139 [mod=PAM, lvl=INFO] [tid=1463] sendWebConfigSignal : rbus_set :: event_name : webconfigSignal :: 
240423-06:06:16.539767 [mod=PAM, lvl=WARN] [tid=1463] PushBlobRequest complete
240423-06:06:16.539854 [mod=PAM, lvl=WARN] [tid=1463] Before committing:Device.DHCPv4.Server.
240423-06:06:16.539979 [mod=PAM, lvl=WARN] [tid=1463] After committing:Device.DHCPv4.Server.:0
240423-06:06:16.540003 [mod=PAM, lvl=INFO] [tid=1716] Received event
240423-06:06:16.540284 [mod=PAM, lvl=INFO] [tid=24223] Inside FUNC execute_request LINE 854 
240423-06:06:16.544687 [mod=PAM, lvl=WARN] [tid=24223]  Dhcpv4_Reset_Cache done 
240423-06:06:16.544767 [mod=PAM, lvl=WARN] [tid=24223] CheckIpIsValid:IpAddressReceivedIs:10.0.0.1
240423-06:06:16.544829 [mod=PAM, lvl=WARN] [tid=24223] CheckIpIsValid:IpAddressReceivedIs:10.0.0.8
240423-06:06:16.544887 [mod=PAM, lvl=WARN] [tid=24223] CheckIpIsValid:IpAddressReceivedIs:10.0.0.240
240423-06:06:16.544952 [mod=PAM, lvl=WARN] [tid=24223] Dhcpv4_Lan_Ip_IsInPrivate_Blocked_AddrRange:addr:a000001
240423-06:06:16.545015 [mod=PAM, lvl=WARN] [tid=24223]  Entering Dhcpv4_Lan_BackupFromDb 
240423-06:06:16.551077 [mod=PAM, lvl=WARN] [tid=24223]  Dhcpv4_Cache_ApplyAllToDb line.no 328 numOfParam 6
240423-06:06:16.556649 [mod=PAM, lvl=WARN] [tid=24223]  Dhcpv4_Cache_ApplyAllToDb line.no 344 Success 
240423-06:06:16.557618 [mod=PAM, lvl=NOTICE] [tid=24223] CosaDmlDhcpsGetPool: ulIndex = 0
240423-06:06:16.559081 [mod=PAM, lvl=WARN] [tid=24223] Process_Lan_WebConfigRequest: setting lan-restart
240423-06:06:16.573772 [mod=PAM, lvl=WARN] [tid=1463] CosaNTPInitJournal : Partner = RDKM 
240423-06:06:16.577499 [mod=PAM, lvl=WARN] [tid=1463] CosaNTPInitJournal : Partner = RDKM 
240423-06:06:16.635650 [mod=PAM, lvl=INFO] [tid=1716] messageQueueProcessing : Execution success , sending completed ACK
240423-06:06:16.640807 [mod=PAM, lvl=INFO] [tid=1716] send_ACK : doc name lan , doc version 627376240, txid is 8517  timeout is 0
240423-06:06:16.640906 [mod=PAM, lvl=INFO] [tid=1716] isWebCfgRbusEnabled: rbus enabled is 1 
240423-06:06:16.640956 [mod=PAM, lvl=INFO] [tid=1716] sendWebConfigSignal : rbus_set :: event_name : webconfigSignal :: 
240423-06:06:16.646741 [mod=PAM, lvl=WARN] [tid=1716]  Entering FreeResources_Lan 

2. For DMZ subdoc

  1. Enter the below info in WebConfig UI

subdoc_name: wan

subdoc_data : 

Code Block
languagebash
themeDJango
titledmz_blob_schema
collapsetrue
{

"Enable" : true, 

"InternalIP" : "10.0.0.17"

}   


TR-181 DM : Device.NAT.X_CISCO_COM_DMZ.Data

MAC : CPE_MAC (Ex : d83add3c5cc3)

2. In CPE , trigger root as ForceSync

3. Using dmcli to check the DM,

Code Block
languagebash
themeDJango
titledmz-dmcli
collapsetrue
root@RaspberryPi-Gateway:/usr/www2# dmcli eRT getv Device.NAT.X_CISCO_COM_DMZ.Enable
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
getv from/to component(eRT.com.cisco.spvtg.ccsp.pam): Device.NAT.X_CISCO_COM_DMZ.Enable
Execution succeed.
Parameter    1 name: Device.NAT.X_CISCO_COM_DMZ.Enable
               type:       bool,    value: true

root@RaspberryPi-Gateway:/usr/www2# dmcli eRT getv Device.NAT.X_CISCO_COM_DMZ.InternalIP
CR component name is: eRT.com.cisco.spvtg.ccsp.CR
subsystem_prefix eRT.
getv from/to component(eRT.com.cisco.spvtg.ccsp.pam): Device.NAT.X_CISCO_COM_DMZ.InternalIP
Execution succeed.
Parameter    1 name: Device.NAT.X_CISCO_COM_DMZ.InternalIP
               type:     string,    value: 10.0.0.17 


4. Success Logs

Code Block
languagebash
themeDJango
titlewebconfig logs
collapsetrue
240423-06:14:24.589883 [mod=WEBCONFIG, lvl=INFO] [tid=3692] WEBCONFIG: doc wan is updated to version 3808881139 status pending error_details none error_code 0 trans_id 0 temp->retry_count 0
240423-06:14:24.590358 [mod=WEBCONFIG, lvl=INFO] [tid=3692] WEBCONFIG: subdoc_name: wan, version: 3808881139, transaction_id: 5016
240423-06:14:24.590448 [mod=WEBCONFIG, lvl=INFO] [tid=3692] WEBCONFIG: doc wan is updated to version 3808881139 status pending error_details none error_code 0 trans_id 5016 temp->retry_count 0
240423-06:14:24.590494 [mod=WEBCONFIG, lvl=INFO] [tid=3692] WEBCONFIG: Request:> param[0].name = Device.NAT.X_CISCO_COM_DMZ.Data, type = 5
240423-06:14:24.593472 [mod=WEBCONFIG, lvl=INFO] [tid=2793] WEBCONFIG: Received msg wan,5016,3808881139,ACK,10 from topic webconfigSignal
240423-06:14:24.593540 [mod=WEBCONFIG, lvl=INFO] [tid=2793] WEBCONFIG: Received webconfig event signal Info wan,5016,3808881139,ACK,10
240423-06:14:24.593638 [mod=WEBCONFIG, lvl=INFO] [tid=3699] WEBCONFIG: TIMEOUT EVENT: wan,5016,3808881139,ACK,10 (doc apply need time)
240423-06:14:24.593688 [mod=WEBCONFIG, lvl=INFO] [tid=3699] WEBCONFIG: doc apply need time, start timer.
240423-06:14:24.593749 [mod=WEBCONFIG, lvl=INFO] [tid=3699] WEBCONFIG: Timer list is empty
240423-06:14:24.593796 [mod=WEBCONFIG, lvl=INFO] [tid=3699] WEBCONFIG: new_node->subdoc_name wan new_node->txid 5016 new_node->timeout 10 status 1 added to list
240423-06:14:24.593834 [mod=WEBCONFIG, lvl=INFO] [tid=3699] WEBCONFIG: startWebcfgTimer success
240423-06:14:24.593973 [mod=WEBCONFIG, lvl=INFO] [tid=3693] WEBCONFIG: dest is event:subdoc-report/wan/mac:d83add3c5cc3/ack
240423-06:14:24.594023 [mod=WEBCONFIG, lvl=INFO] [tid=3693] WEBCONFIG: stringifiedNotifyPayload is {"device_id":"mac:d83add3c5cc3","namespace":"wan","application_status":"pending","timeout":10,"transaction_uuid":"ae7952f3-1886-47aa-9427-dfca584a1f2d","version":"3808881139"}
240423-06:14:24.594147 [mod=WEBCONFIG, lvl=INFO] [tid=3693] WEBCONFIG: Notification successfully sent to Webconfig.Upstream
240423-06:14:24.595800 [mod=WEBCONFIG, lvl=INFO] [tid=3692] WEBCONFIG: The ret status for rbus_setMulti is 0
240423-06:14:24.595864 [mod=WEBCONFIG, lvl=INFO] [tid=3692] WEBCONFIG: ccspRetStatus is 100
240423-06:14:24.595912 [mod=WEBCONFIG, lvl=INFO] [tid=3692] WEBCONFIG: setValues success. ccspStatus : 100

Code Block
languagebash
themeDJango
titlePAM logs
collapsetrue
240423-06:14:24.592125 [mod=PAM, lvl=WARN] [tid=1463] base64 decoded data contains 82 bytes
240423-06:14:24.592168 [mod=PAM, lvl=WARN] [tid=1463] Base64 decode Elapsed time : 0 ms
240423-06:14:24.592212 [mod=PAM, lvl=WARN] [tid=1463] MSGPACK_UNPACK_SUCCESS :2
240423-06:14:24.592259 [mod=PAM, lvl=WARN] [tid=1463] rpm->subdoc_name is wan
240423-06:14:24.592300 [mod=PAM, lvl=WARN] [tid=1463] rpm->version is 3808881139
240423-06:14:24.592339 [mod=PAM, lvl=WARN] [tid=1463] rpm->transaction_id is 5016
240423-06:14:24.592377 [mod=PAM, lvl=WARN] [tid=1463] DMZ/wan  configuration received
240423-06:14:24.592421 [mod=PAM, lvl=INFO] [tid=1463] PushBlobRequest : subdoc_name wan , txid 5016, version 3808881139 , entries 0
240423-06:14:24.592462 [mod=PAM, lvl=INFO] [tid=1463] Inside FUNC checkNewVersionUpdateRequired LINE 1244 
240423-06:14:24.592519 [mod=PAM, lvl=INFO] [tid=1463] checkIfVersionExecInQueue : Queue Empty
240423-06:14:24.592559 [mod=PAM, lvl=INFO] [tid=1463] New version available , prcessing new Blob request
240423-06:14:24.592616 [mod=PAM, lvl=INFO] [tid=1463] calculateTimeout is NULL , using default timeout routine
240423-06:14:24.592657 [mod=PAM, lvl=INFO] [tid=1463] PushBlobRequest timeout received from calcTimeout is 10
240423-06:14:24.592696 [mod=PAM, lvl=INFO] [tid=1463] getPendingQueueTimeout : Queue Empty
240423-06:14:24.592738 [mod=PAM, lvl=INFO] [tid=1463] PushBlobRequest : Send received request ACK , timeout is 10
240423-06:14:24.592780 [mod=PAM, lvl=INFO] [tid=1463] send_ACK : doc name wan , doc version 3808881139, txid is 5016  timeout is 10
240423-06:14:24.592825 [mod=PAM, lvl=INFO] [tid=1463] isWebCfgRbusEnabled: rbus enabled is 1 
240423-06:14:24.592867 [mod=PAM, lvl=INFO] [tid=1463] sendWebConfigSignal : rbus_set :: event_name : webconfigSignal :: 
240423-06:14:24.594806 [mod=PAM, lvl=WARN] [tid=1463] PushBlobRequest complete
240423-06:14:24.594940 [mod=PAM, lvl=WARN] [tid=1463] Before committing:Device.NAT.X_CISCO_COM_DMZ.
240423-06:14:24.595028 [mod=PAM, lvl=WARN] [tid=1463] !!!!!! in X_CISCO_COM_DMZ_Commit pDmz->InternalIP: 0.0.0.0 !!!!!!
240423-06:14:24.595118 [mod=PAM, lvl=INFO] [tid=1716] Received event
240423-06:14:24.595157 [mod=PAM, lvl=WARN] [tid=1463] After committing:Device.NAT.X_CISCO_COM_DMZ.:0
240423-06:14:24.595385 [mod=PAM, lvl=INFO] [tid=32256] Inside FUNC execute_request LINE 854 
240423-06:14:24.595454 [mod=PAM, lvl=WARN] [tid=32256] DMZ configurartion recieved!!!!!!
240423-06:14:24.595508 [mod=PAM, lvl=WARN] [tid=32256] dmz_cache backup [0].cmd - dmz_enabled
240423-06:14:24.595551 [mod=PAM, lvl=WARN] [tid=32256] dmz_cache backup [0].val - 
240423-06:14:24.595604 [mod=PAM, lvl=WARN] [tid=32256] dmz_cache backup [1].cmd - dmz_dst_ip_addr
240423-06:14:24.595646 [mod=PAM, lvl=WARN] [tid=32256] dmz_cache backup [1].val - 
240423-06:14:24.607573 [mod=PAM, lvl=INFO] [tid=32256] CheckIfIpIsValid:IpAddressReceivedIs:10.0.0.17
240423-06:14:24.608313 [mod=PAM, lvl=WARN] [tid=32256] dmz_cache apply to DB [0].cmd - dmz_enabled
240423-06:14:24.608395 [mod=PAM, lvl=WARN] [tid=32256] dmz_cache apply to DB [0].val - 1
240423-06:14:24.608448 [mod=PAM, lvl=WARN] [tid=32256] dmz_cache apply to DB [1].cmd - dmz_dst_ip_addr
240423-06:14:24.608490 [mod=PAM, lvl=WARN] [tid=32256] dmz_cache apply to DB [1].val - 10.0.0.17
240423-06:14:24.613281 [mod=PAM, lvl=WARN] [tid=32256] DMZ configurartion applied!!!!!!!!
240423-06:14:24.613371 [mod=PAM, lvl=NOTICE] [tid=32256] DMZ_split:Feature Switch DMZ 1
240423-06:14:24.618447 [mod=PAM, lvl=WARN] [tid=1463] CosaNTPInitJournal : Partner = RDKM 
240423-06:14:24.628410 [mod=PAM, lvl=WARN] [tid=1463] CosaNTPInitJournal : Partner = RDKM 
240423-06:14:24.649677 [mod=PAM, lvl=WARN] [tid=32256] DMZ configurartion applied to DML layer!!!!!!!!
240423-06:14:24.649780 [mod=PAM, lvl=WARN] [tid=32256] rpm->param[0].Enable true
240423-06:14:24.649826 [mod=PAM, lvl=WARN] [tid=32256] rpm->entries[0].internal_ip 10.0.0.17
240423-06:14:24.650282 [mod=PAM, lvl=INFO] [tid=1716] messageQueueProcessing : Execution success , sending completed ACK
240423-06:14:24.655732 [mod=PAM, lvl=INFO] [tid=1716] send_ACK : doc name wan , doc version 3808881139, txid is 5016  timeout is 0
240423-06:14:24.655818 [mod=PAM, lvl=INFO] [tid=1716] isWebCfgRbusEnabled: rbus enabled is 1 
240423-06:14:24.655866 [mod=PAM, lvl=INFO] [tid=1716] sendWebConfigSignal : rbus_set :: event_name : webconfigSignal :: 
240423-06:14:24.667342 [mod=PAM, lvl=INFO] [tid=1716]  Entering freeResources_dmz 


References

Jira
serverJIRA
columnIdsissuekey,summary,issuetype,created,updated,duedate,assignee,reporter,priority,status,resolution
columnskey,summary,type,created,updated,due,assignee,reporter,priority,status,resolution
serverId11deff04-0380-3a3d-a916-0849d4e573f7
keyREFPLTB-1851

...