Scribd
Upload
75 views8 pages

$R8764BI

The log file shows the process of discovering and communicating with devices on a DLMS/COSEM network. Two devices, ZIVS004401962 and SAG0221016963, were discovered. For ZIVS004401962, discovery was successful and information about the device such as its type was retrieved. For SAG0221016963, an error occurred during security policy retrieval and the discovery process failed. The log also shows the starting of various services and background processes involved in device communication and data retrieval.

Uploaded by

Li Be R
Copyright
© © All Rights Reserved
We take content rights seriously. If you suspect this is your content, claim it here.
Available Formats
Download as TXT, PDF, TXT or read online on Scribd
75 views8 pages

$R8764BI

The log file shows the process of discovering and communicating with devices on a DLMS/COSEM network. Two devices, ZIVS004401962 and SAG0221016963, were discovered. For ZIVS004401962, discovery was successful and information about the device such as its type was retrieved. For SAG0221016963, an error occurred during security policy retrieval and the discovery process failed. The log also shows the starting of various services and background processes involved in device communication and data retrieval.

Uploaded by

Li Be R
Copyright
© © All Rights Reserved
We take content rights seriously. If you suspect this is your content, claim it here.
Available Formats
Download as TXT, PDF, TXT or read online on Scribd
You are on page 1/ 8

Password:

CCT_Test10008_beta1_MAD /> log all


2023/06/21,13:27:26 cct-test10008-beta1-mad user.debug cct: dm_be_list.c
( 47): dm_be_list: [ZIVS004401962:2] requests finished
2023/06/21,13:27:26 cct-test10008-beta1-mad user.debug cct: dm_req_batch.c
( 80): dm_req_batch: BE Request finished, releasing: 'ZIVS004401962' - result:
[SUCCESS]
2023/06/21,13:27:26 cct-test10008-beta1-mad user.debug cct: dm_be_list.c
( 143): dm_be_list: [ZIVS004401962:2] releasing handler be_db
2023/06/21,13:27:26 cct-test10008-beta1-mad user.debug cct: dm_be_list.c
( 122): dm_be_list: [ZIVS004401962:2] releasing handler dlms
2023/06/21,13:27:26 cct-test10008-beta1-mad user.debug cct: cct_dm_be_dlms.c
(1281): cct_dm_be_dlms: [ZIVS004401962:2] dissassociate request
2023/06/21,13:27:27 cct-test10008-beta1-mad user.info confd: services.cpp
(1157): services: Started "ecct_dyn_conf_gen"
2023/06/21,13:27:27 cct-test10008-beta1-mad user.info confd: services.cpp
(1121): services: Starting "ecct_gpio"
2023/06/21,13:27:27 cct-test10008-beta1-mad user.info confd: services.cpp
(1157): services: Started "ecct_gpio"
2023/06/21,13:27:27 cct-test10008-beta1-mad user.info confd: services.cpp
(1121): services: Starting "ecct_locale"
2023/06/21,13:27:27 cct-test10008-beta1-mad user.info cct: cct_dlms.c (
4249): cct_dlms: SAG0221016967: security policy for client 4: auth + encrypt (3)
2023/06/21,13:27:27 cct-test10008-beta1-mad user.info cct: cct_dlms.c (
4251): cct_dlms: SAG0221016967: client 4 keys: unknown (1)
2023/06/21,13:27:27 cct-test10008-beta1-mad user.err cct: cct_al_reqd.c (
315): cct_al_reqd: Node with sn=SAG0221016967 has not been found
2023/06/21,13:27:27 cct-test10008-beta1-mad user.debug cct: cct_rep_s31.c
( 466): s31: Sending S31: SAG0221016967
2023/06/21,13:27:27 cct-test10008-beta1-mad user.debug cct: cct_stg_ws.c
(1815): STG_WS: orig file = /var/run/ecct/tmp/rep_16999584823641.swp renamed to
/var/run/ecct/tmp/rep_16999584823641.swp.rep
2023/06/21,13:27:27 cct-test10008-beta1-mad user.info cct: cct_stg_ws.c (
1827): STG_WS: <stg 1> <0x9bca30> idpet 0 REPORT idle add to client reqs /var/ru
n/ecct/tmp/rep_16999584823641.swp.rep
2023/06/21,13:27:27 cct-test10008-beta1-mad user.debug cct: cct_dm_discover.c
( 63): cct_dm_discover: Dev SAG0221016967 added to discovery batch
2023/06/21,13:27:27 cct-test10008-beta1-mad user.debug cct: dm_req.c
( 696): dm_req: adding SAG0221016967 to par_id '127.0.0.1:4059'
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_req.c
( 718): dm_req: starting execution
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_req.c
( 731): dm_req: creating 1 req_hdl(s) for '127.0.0.1:4059'
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_req_batch.c
( 92): dm_req_batch: creating handler
2023/06/21,13:27:28 cct-test10008-beta1-mad user.err cct: cct_al_reqd.c (
315): cct_al_reqd: Node with sn=SAG0221016967 has not been found
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: cct_dm_be_dlms.c
(1313): cct_dm_be_dlms: [SAG0221016967:2] associate request
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: cct_dlms_assoc.c
(2508): ASSOC: connected: SAG0221016967
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: cct_dm_be_dlms.c
(3097): cct_dm_be_dlms: [ZIVS004401962:2] dissasociate confirm
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: cct_dm_be_dlms.c
(3279): cct_dm_be_dlms: [ZIVS004401962:2] assoc free
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_req_batch.c
( 68): dm_req_batch: BE Request_release finished: 'ZIVS004401962' - result: 0
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: cct_dm_discover.c
( 188): cct_dm_discover: [DISC]Dev finished ZIVS004401962 with result [SUCCESS]
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: cct_dm_discover.c
( 227): cct_dm_discover: DEV_ID3: 0000 | 73 75 70 65 72 76 69 73 6f 72 44 4c 4d
53 30 31 | supervisorDLMS01
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: cct_dm_discover.c
( 227): cct_dm_discover: DEV_ID3: 0010 | 30 37
| 07
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: cct_dm_discover.c
( 309): cct_dm_discover: ZIVS004401962 discovered: forgetting retry data
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: cct_dm_discover.c
( 324): cct_dm_discover: Dev ZIVS004401962 is of type 'meter_ibd_3ph_supervisor'

2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: cct_dm_discover.c


( 63): cct_dm_discover: Dev ZIVS004401962 added to discovery batch
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_req.c
( 696): dm_req: adding ZIVS004401962 to par_id '127.0.0.1:40059'
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_req.c
( 718): dm_req: starting execution
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_req.c
( 731): dm_req: creating 1 req_hdl(s) for '127.0.0.1:40059'
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_req_batch.c
( 92): dm_req_batch: creating handler
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_req.c
( 568): dm_req: Req finished ZIVS004401962 ('127.0.0.1:40059')
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_req.c
( 270): dm_req: hdl available for '127.0.0.1:40059' (0)
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_req.c
( 276): dm_req: No more devices releasing handler '127.0.0.1:40059'
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_req_batch.c
( 107): dm_req_batch: releasing handler
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: cct_dlms_assoc.c
(2508): ASSOC: connected: SAG0221016963
2023/06/21,13:27:28 cct-test10008-beta1-mad user.info confd: services.cpp
(1157): services: Started "ecct_locale"
2023/06/21,13:27:28 cct-test10008-beta1-mad user.info confd: services.cpp
(1121): services: Starting "ecct_log_options"
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_req.c
( 270): dm_req: hdl available for '127.0.0.1:40059' (0)
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_req.c
( 300): dm_req: Executing ZIVS004401962
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_be_list.c
( 177): dm_be_list: creating handler for be_db
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_be_list.c
( 177): dm_be_list: creating handler for dlms
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_req_batch.c
( 124): dm_req_batch: dev_request: 'ZIVS004401962', err:[SUCCESS]
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: cct_dm_discover.c
( 146): cct_dm_discover: Started discover of dev ZIVS004401962
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_req_batch.c
( 174): dm_req_batch: Requesting to BE: 'ZIVS004401962'
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_req.c
( 766): dm_req: req range: 0.000000000W:0.000000000W
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_be_list.c
( 92): dm_be_list: [ZIVS004401962:2] requesting be_db
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_be_list.c
( 56): dm_be_list: [ZIVS004401962:2] requesting dlms
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: cct_dm_be_dlms.c
(1550): cct_dm_be_dlms: Not need to request DLMS
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: cct_dm_be_dlms.c
(3075): cct_dm_be_dlms: [SAG0221016967:2] associate confirm [SUCCESS]
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: cct_dm_be_dlms.c
( 375): cct_dm_be_dlms: [SAG0221016967:2] get request
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_be_list.c
( 47): dm_be_list: [ZIVS004401962:2] requests finished
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_req_batch.c
( 80): dm_req_batch: BE Request finished, releasing: 'ZIVS004401962' - result:
[SUCCESS]
2023/06/21,13:27:28 cct-test10008-beta1-mad user.debug cct: dm_be_list.c
( 143): dm_be_list: [ZIVS004401962:2] releasing handler be_db
2023/06/21,13:27:29 cct-test10008-beta1-mad user.info confd: services.cpp
(1157): services: Started "ecct_log_options"
2023/06/21,13:27:29 cct-test10008-beta1-mad user.info confd: services.cpp
(1157): services: Started "ecct_all"
2023/06/21,13:27:30 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
749): tr_tcp: : Error receiving data from socket.
2023/06/21,13:27:33 cct-test10008-beta1-mad user.info cct: cct_dlms.c (
4249): cct_dlms: SAG0221016963: security policy for client 4: nothing (0)
2023/06/21,13:27:33 cct-test10008-beta1-mad user.info cct: cct_dlms.c (
4251): cct_dlms: SAG0221016963: client 4 keys: reset (0)
2023/06/21,13:27:33 cct-test10008-beta1-mad user.err cct: cct_al_reqd.c (
315): cct_al_reqd: Node with sn=SAG0221016963 has not been found
2023/06/21,13:27:33 cct-test10008-beta1-mad user.info cct: cct_stg_ws.c (
1827): STG_WS: <stg 1> <0x9bcae4> idpet 0 REPORT idle add to client reqs /var/ru
n/ecct/tmp/rep_17053967553642.swp.rep
2023/06/21,13:27:33 cct-test10008-beta1-mad user.err cct: cct_al_reqd.c (
315): cct_al_reqd: Node with sn=SAG0221016963 has not been found
2023/06/21,13:27:34 cct-test10008-beta1-mad user.err meterapp: Dlms_AL.c
(4514): COSEM object does not exist
2023/06/21,13:27:34 cct-test10008-beta1-mad user.err cct: cct_dev_discover.c (
471): cct_dev_discover: security_policy GET ERROR: [DLMS](PERM) Data-access: obj
ect-class-inconsistent
2023/06/21,13:27:36 cct-test10008-beta1-mad user.info cct: cct_rep_mtr_ex.c (
3893): MTR_EX: Schedule: id_pet=0, id_req=S20, priority=0,
2023/06/21,13:27:36 cct-test10008-beta1-mad user.info cct: cct_dlms.c (
4249): cct_dlms: ZIVS004401962: security policy for client 4: not applied (255)
2023/06/21,13:27:36 cct-test10008-beta1-mad user.info cct: cct_dlms.c (
4251): cct_dlms: ZIVS004401962: client 4 keys: ok (255)
2023/06/21,13:27:36 cct-test10008-beta1-mad user.warn cct: cct_dm_db.c (
557): cct_dm_db: ZIVS004401962: Error reading secure information: setting defau
lts
2023/06/21,13:27:38 cct-test10008-beta1-mad user.notice watchdogd: events.cpp
( 435): event: 5, 1, Meter event: New meter: ZIVS004401962
2023/06/21,13:27:38 cct-test10008-beta1-mad user.info cct: cct_rep_mtr_ex.c (
3267): MTR_EX: End: id_pet=0, id_req=S20, priority=0,
2023/06/21,13:27:39 cct-test10008-beta1-mad user.info cct: cct_stg_ws.c (
1827): STG_WS: <stg 1> <0x9bcb98> idpet 0 REPORT idle add to client reqs /var/ru
n/ecct/tmp/rep_17115684303644.swp_stg1.rep
2023/06/21,13:27:39 cct-test10008-beta1-mad user.info cct: cct_stg_ws.c (
1736): STG_WS: STG2 not min configured or not in stg_spont_dest
2023/06/21,13:27:39 cct-test10008-beta1-mad user.info cct: cct_stg_ws.c (
1736): STG_WS: STG3 not min configured or not in stg_spont_dest
2023/06/21,13:27:39 cct-test10008-beta1-mad user.err meterapp: Dlms_AL.c
(4514): COSEM object does not exist
2023/06/21,13:27:40 cct-test10008-beta1-mad user.warn cct: cct_al_imm.c (
298): Last item result 0
2023/06/21,13:27:40 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
749): tr_tcp: : Error receiving data from socket.
2023/06/21,13:27:40 cct-test10008-beta1-mad user.warn cct: cct_dm_db.c (
557): cct_dm_db: ZIVS004401962: Error reading secure information: setting defau
lts
2023/06/21,13:27:50 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
740): tr_tcp: : Socket has been closed.
2023/06/21,13:27:56 cct-test10008-beta1-mad user.err cct: cct_ws_client.c (1
650): WS_CLIENT: <cl 0x999414> <req 0x696d30> Error while trying to send
2023/06/21,13:28:00 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
740): tr_tcp: : Socket has been closed.
2023/06/21,13:28:10 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
740): tr_tcp: : Socket has been closed.
2023/06/21,13:28:21 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
740): tr_tcp: : Socket has been closed.
2023/06/21,13:28:26 cct-test10008-beta1-mad user.err cct: cct_ws_client.c (1
650): WS_CLIENT: <cl 0x999414> <req 0x696d30> Error while trying to send
2023/06/21,13:28:31 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
749): tr_tcp: : Error receiving data from socket.
2023/06/21,13:28:41 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
740): tr_tcp: : Socket has been closed.
2023/06/21,13:28:51 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
740): tr_tcp: : Socket has been closed.
2023/06/21,13:28:54 cct-test10008-beta1-mad authpriv.err login[1498]: PAM _pam_i
nit_handlers: no default config /etc/pam.d/other
2023/06/21,13:28:57 cct-test10008-beta1-mad user.err cct: cct_ws_client.c (1
650): WS_CLIENT: <cl 0x999414> <req 0x696d30> Error while trying to send
2023/06/21,13:28:57 cct-test10008-beta1-mad user.err cct: cct_ws_client.c (1
650): WS_CLIENT: <cl 0x999414> <req 0x39ef84> Error while trying to send
2023/06/21,13:28:58 cct-test10008-beta1-mad authpriv.info login[1498]: pam_unix_
session(telnet:session): session opened for user admin by (uid=0)
2023/06/21,13:28:59 cct-test10008-beta1-mad user.notice watchdogd: events.cpp
( 435): event: 2, 1, Access event: User remote login: admin;telnet_write;
on pts/0 from 192.168.1.10
2023/06/21,13:29:00 cct-test10008-beta1-mad user.info cct: cct_stg_ws.c (
1827): STG_WS: <stg 1> <0x9bc97c> idpet 0 REPORT idle add to client reqs /var/ru
n/ecct/tmp/rep_17921126173645.swp_stg1.rep
2023/06/21,13:29:00 cct-test10008-beta1-mad user.info cct: cct_stg_ws.c (
1736): STG_WS: STG2 not min configured or not in stg_spont_dest
2023/06/21,13:29:00 cct-test10008-beta1-mad user.info cct: cct_stg_ws.c (
1736): STG_WS: STG3 not min configured or not in stg_spont_dest
2023/06/21,13:29:01 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
749): tr_tcp: : Error receiving data from socket.
2023/06/21,13:29:11 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
740): tr_tcp: : Socket has been closed.
2023/06/21,13:29:21 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
740): tr_tcp: : Socket has been closed.
2023/06/21,13:29:32 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
749): tr_tcp: : Error receiving data from socket.
2023/06/21,13:29:35 cct-test10008-beta1-mad user.debug syslog: prm_mac_base.c
( 343): node = 50:0f:59:d9:5a:76/0:10366 state_mac = demoting(6)
2023/06/21,13:29:35 cct-test10008-beta1-mad user.debug syslog: prm_mac_pro_base.
c ( 30): TX: PRO_DEM_B: node = 50:0f:59:d9:5a:76/0:10366 nsid = 2
2023/06/21,13:29:35 cct-test10008-beta1-mad user.debug syslog: prm_mac_base_sm.c
( 717): RX: PRO_DEM_S: node = 50:0f:59:d9:5a:76/0:10366 nsid = 2
2023/06/21,13:29:35 cct-test10008-beta1-mad user.debug syslog: prm_mac_base.c
( 343): node = 50:0f:59:d9:5a:76/0:10366 state_mac = terminal(4)
2023/06/21,13:29:42 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
749): tr_tcp: : Error receiving data from socket.
2023/06/21,13:29:52 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
740): tr_tcp: : Socket has been closed.
2023/06/21,13:30:02 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
749): tr_tcp: : Error receiving data from socket.
2023/06/21,13:30:12 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
740): tr_tcp: : Socket has been closed.
2023/06/21,13:30:22 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
740): tr_tcp: : Socket has been closed.
2023/06/21,13:30:32 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
749): tr_tcp: : Error receiving data from socket.
2023/06/21,13:30:43 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
740): tr_tcp: : Socket has been closed.
2023/06/21,13:30:46 cct-test10008-beta1-mad user.info cct: cct_ws_server.c (
290): WS_SERVER: <sock 0x39e238> new request from IP= 192.168.1.10 192.168.1.1
0
2023/06/21,13:30:46 cct-test10008-beta1-mad user.warn cct: cct_ws_server.c (
402): WS_SERVER: <sock 0x39e238> Realloc needed previous size 1024 new size 164
6
2023/06/21,13:30:46 cct-test10008-beta1-mad user.info cct: cct_ws_server.c (
644): WS_SERVER: <sock 0x39e238> 192.168.1.10 ws_order WS_PROCESS
2023/06/21,13:30:46 cct-test10008-beta1-mad user.info cct: cct_rep_creator.c (
526): cct_rep_creator: Execution: id_pet=1, id_req=B32,
2023/06/21,13:30:47 cct-test10008-beta1-mad user.err cct: cct_dlms_assoc.c (1
234): ASSOC: AARE unsuccessful: 0x0301010D
2023/06/21,13:30:48 cct-test10008-beta1-mad user.warn cct: cct_dlms_frm.c (
338): err: ciphered xDLMS in a non ciphering context
2023/06/21,13:30:48 cct-test10008-beta1-mad user.warn cct: cct_dlms_frm.c (
555): Wrong xDLMS user information of the aare
2023/06/21,13:30:48 cct-test10008-beta1-mad user.err cct: cct_al_imm.c (
252): cct_al_imm: Association rejected [CCT](PERM) : parse-error
2023/06/21,13:30:48 cct-test10008-beta1-mad user.info cct: cct_order_b32.c (
1537): b32: SAG0221016963: Association Permanent error
2023/06/21,13:30:48 cct-test10008-beta1-mad user.info cct: cct_order_b32.c (
2144): b32: b32 order finished
2023/06/21,13:30:53 cct-test10008-beta1-mad user.err cct: cct_tr_tcp.c (
740): tr_tcp: : Socket has been closed.

You might also like