dlms-cosem
dlms-cosem copied to clipboard
Published
20 hours ago •
u9n
u9n
HDLC frame could not be parsed when switching clients
For my application I need to switch between a public and management client and something strange happens when I do. Here is part of my code:
class task:
def connectM():
ser = serial.Serial(Port)
ser.baudrate = Baud
ser.write(b'\x7E\xA0\x0A\x00\x02\xFE\xFD\x41\x53\x3C\x94\x7E')
ser.close()
time.sleep(1)
management.connect()
management.associate()
def disconnectM():
management.release_association()
management.disconnect()
def connectC():
client.connect()
client.associate()
def disconnectC():
client.release_association()
client.disconnect()
def connectM2():
management.connect()
management.associate()
task.connectM()
print("\n\n\n DISCONNECTING MANAGEMENT\n\n\n")
task.disconnectM()
print("\n\n\n CONNECTING CLIENT\n\n\n")
task.connectC()
print("\n\n\n DISCONNECTING CLIENT\n\n\n")
task.disconnectC()
print("\n\n\n CONNECTING MANAGEMENT\n\n\n")
task.connectM2()
I am using ser.write(b'\x7E\xA0\x0A\x00\x02\xFE\xFD\x41\x53\x3C\x94\x7E') to release all the associations from the meter before the first connection because it can refuse a new association if the old one hasn't been released. I mentioned this in #74
The problem im encountering is that I connect as a management client no problem, and I also after that connect as a public client and get my data and finish everything I need as a public client and then when I want to again return to a management client then I encounter a problem. I have tried using just the management.connect() and management.associate() and that basically did nothing.
Here is the console output:
2024-03-21 12:13:17 [debug ] HDLC state transitioned new_state=AWAITING_CONNECTION old_state=NOT_CONNECTED
2024-03-21 12:13:17 [debug ] Sending data data=bytearray(b'~\xa0\n\x00\x02,)\x03\x93\x86\n~') transport=HdlcTransport(client_logical_address=1, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93fd48040, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=True), client_ssn=0, client_rsn=0, server_ssn=0, server_rsn=0, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_CONNECTION), buffer=bytearray(b''), buffer_search_position=1), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:17 [debug ] Received data data=b'~\xa0#\x03\x00\x02,)s(\x13\x81\x80\x14\x05\x02\x00\xf2\x06\x02\x00\xf2\x07\x04\x00\x00\x00\x01\x08\x04\x00\x00\x00\x01\x0c\xf7~' transport=HdlcTransport(client_logical_address=1, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93fd48040, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=True), client_ssn=0, client_rsn=0, server_ssn=0, server_rsn=0, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_CONNECTION), buffer=bytearray(b''), buffer_search_position=1), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:17 [debug ] Added data to buffer data=b'~\xa0#\x03\x00\x02,)s(\x13\x81\x80\x14\x05\x02\x00\xf2\x06\x02\x00\xf2\x07\x04\x00\x00\x00\x01\x08\x04\x00\x00\x00\x01\x0c\xf7~'
2024-03-21 12:13:17 [debug ] Received HDLC frame frame=UnNumberedAcknowledgmentFrame(destination_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=False), source_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), payload=bytearray(b'\x81\x80\x14\x05\x02\x00\xf2\x06\x02\x00\xf2\x07\x04\x00\x00\x00\x01\x08\x04\x00\x00\x00\x01'), segmented=False, final=True)
2024-03-21 12:13:17 [debug ] HDLC state transitioned new_state=IDLE old_state=AWAITING_CONNECTION
2024-03-21 12:13:17 [debug ] DLMS state transitioned new_state=AWAITING_ASSOCIATION_RESPONSE old_state=NO_ASSOCIATION
2024-03-21 12:13:17 [debug ] Preparing to send DLMS Request request=ApplicationAssociationRequest(user_information=UserInformation(content=InitiateRequest(proposed_conformance=Conformance(general_protection=False, general_block_transfer=True, delta_value_encoding=False, attribute_0_supported_with_set=False, priority_management_supported=True, attribute_0_supported_with_get=False, block_transfer_with_get_or_read=True, block_transfer_with_set_or_write=False, block_transfer_with_action=False, multiple_references=True, data_notification=False, access=True, get=True, set=True, selective_access=True, event_notification=True, action=True), proposed_quality_of_service=None, client_max_receive_pdu_size=65535, proposed_dlms_version_number=6, response_allowed=True, dedicated_key=None)), system_title=b'uti\xc8.\x8c7\x84', public_cert=None, authentication=<AuthenticationMechanism.LLS: 1>, ciphered=False, authentication_value=b'12345678', calling_ae_invocation_identifier=None, called_ap_title=None, called_ae_qualifier=None, called_ap_invocation_identifier=None, called_ae_invocation_identifier=None, calling_ap_invocation_identifier=None, implementation_information=None)
2024-03-21 12:13:17 [info ] Sending DLMS Request request=ApplicationAssociationRequest(user_information=UserInformation(content=InitiateRequest(proposed_conformance=Conformance(general_protection=False, general_block_transfer=True, delta_value_encoding=False, attribute_0_supported_with_set=False, priority_management_supported=True, attribute_0_supported_with_get=False, block_transfer_with_get_or_read=True, block_transfer_with_set_or_write=False, block_transfer_with_action=False, multiple_references=True, data_notification=False, access=True, get=True, set=True, selective_access=True, event_notification=True, action=True), proposed_quality_of_service=None, client_max_receive_pdu_size=65535, proposed_dlms_version_number=6, response_allowed=True, dedicated_key=None)), system_title=b'uti\xc8.\x8c7\x84', public_cert=None, authentication=<AuthenticationMechanism.LLS: 1>, ciphered=False, authentication_value=b'12345678', calling_ae_invocation_identifier=None, called_ap_title=None, called_ae_qualifier=None, called_ap_invocation_identifier=None, called_ae_invocation_identifier=None, calling_ap_invocation_identifier=None, implementation_information=None)
2024-03-21 12:13:17 [info ] Sending HDLC frame frame=InformationFrame(destination_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), source_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=True), payload=bytearray(b'\xe6\xe6\x00`B\xa1\t\x06\x07`\x85t\x05\x08\x01\x01\xa6\n\x04\x08uti\xc8.\x8c7\x84\x8a\x02\x07\x80\x8b\x07`\x85t\x05\x08\x02\x01\xac\n\x80\x0812345678\xbe\x10\x04\x0e\x01\x00\x00\x00\x06_\x1f\x04\x00 R_\xff\xff'), segmented=False, final=True, send_sequence_number=0, receive_sequence_number=0)
2024-03-21 12:13:17 [debug ] HDLC state transitioned new_state=AWAITING_RESPONSE old_state=IDLE
2024-03-21 12:13:17 [debug ] Sending data data=b'~\xa0S\x00\x02,)\x03\x10\xe3\x8f\xe6\xe6\x00`B\xa1\t\x06\x07`\x85t\x05\x08\x01\x01\xa6\n\x04\x08uti\xc8.\x8c7\x84\x8a\x02\x07\x80\x8b\x07`\x85t\x05\x08\x02\x01\xac\n\x80\x0812345678\xbe\x10\x04\x0e\x01\x00\x00\x00\x06_\x1f\x04\x00 R_\xff\xff\xa7\x13~' transport=HdlcTransport(client_logical_address=1, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93fd48040, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=True), client_ssn=0, client_rsn=1, server_ssn=1, server_rsn=0, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_RESPONSE), buffer=bytearray(b''), buffer_search_position=1), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:17 [debug ] Received data data=b'~\xa0:\x03\x00\x02,)0G\x97\xe6\xe7\x00a)\xa1\t\x06\x07`\x85t\x05\x08\x01\x01\xa2\x03\x02\x01\x00\xa3\x05\xa1\x03\x02\x01\x00\xbe\x10\x04\x0e\x08\x00\x06_\x1f\x04\x00\x00R\x1d\x00\xef\x00\x07O\xa4~' transport=HdlcTransport(client_logical_address=1, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93fd48040, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=True), client_ssn=0, client_rsn=1, server_ssn=1, server_rsn=0, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_RESPONSE), buffer=bytearray(b''), buffer_search_position=1), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:17 [debug ] Added data to buffer data=b'~\xa0:\x03\x00\x02,)0G\x97\xe6\xe7\x00a)\xa1\t\x06\x07`\x85t\x05\x08\x01\x01\xa2\x03\x02\x01\x00\xa3\x05\xa1\x03\x02\x01\x00\xbe\x10\x04\x0e\x08\x00\x06_\x1f\x04\x00\x00R\x1d\x00\xef\x00\x07O\xa4~'
2024-03-21 12:13:17 [debug ] Received HDLC frame frame=InformationFrame(destination_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=False), source_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), payload=bytearray(b'\xe6\xe7\x00a)\xa1\t\x06\x07`\x85t\x05\x08\x01\x01\xa2\x03\x02\x01\x00\xa3\x05\xa1\x03\x02\x01\x00\xbe\x10\x04\x0e\x08\x00\x06_\x1f\x04\x00\x00R\x1d\x00\xef\x00\x07'), segmented=False, final=True, send_sequence_number=0, receive_sequence_number=1)
2024-03-21 12:13:17 [debug ] HDLC state transitioned new_state=IDLE old_state=AWAITING_RESPONSE
2024-03-21 12:13:17 [debug ] Adding data to buffer data=bytearray(b'a)\xa1\t\x06\x07`\x85t\x05\x08\x01\x01\xa2\x03\x02\x01\x00\xa3\x05\xa1\x03\x02\x01\x00\xbe\x10\x04\x0e\x08\x00\x06_\x1f\x04\x00\x00R\x1d\x00\xef\x00\x07')
2024-03-21 12:13:17 [info ] Received DLMS Response response=ApplicationAssociationResponse(result=<AssociationResult.ACCEPTED: 0>, result_source_diagnostics=<AcseServiceUserDiagnostics.NULL: 0>, ciphered=False, authentication=None, system_title=None, public_cert=None, authentication_value=None, user_information=UserInformation(content=InitiateResponse(negotiated_conformance=Conformance(general_protection=False, general_block_transfer=False, delta_value_encoding=False, attribute_0_supported_with_set=False, priority_management_supported=True, attribute_0_supported_with_get=False, block_transfer_with_get_or_read=True, block_transfer_with_set_or_write=False, block_transfer_with_action=False, multiple_references=True, data_notification=False, access=False, get=True, set=True, selective_access=True, event_notification=False, action=True), server_max_receive_pdu_size=239, negotiated_dlms_version_number=6, negotiated_quality_of_service=0)), implementation_information=None, responding_ap_invocation_id=None, responding_ae_invocation_id=None)
2024-03-21 12:13:17 [debug ] DLMS state transitioned new_state=READY old_state=AWAITING_ASSOCIATION_RESPONSE
DISCONNECTING MANAGEMENT
2024-03-21 12:13:17 [debug ] DLMS state transitioned new_state=AWAITING_RELEASE_RESPONSE old_state=READY
2024-03-21 12:13:17 [debug ] Preparing to send DLMS Request request=ReleaseRequest(reason=<ReleaseRequestReason.NORMAL: 0>, user_information=UserInformation(content=InitiateRequest(proposed_conformance=Conformance(general_protection=False, general_block_transfer=False, delta_value_encoding=False, attribute_0_supported_with_set=False, priority_management_supported=True, attribute_0_supported_with_get=False, block_transfer_with_get_or_read=True, block_transfer_with_set_or_write=False, block_transfer_with_action=False, multiple_references=True, data_notification=False, access=False, get=True, set=True, selective_access=True, event_notification=False, action=True), proposed_quality_of_service=None, client_max_receive_pdu_size=239, proposed_dlms_version_number=6, response_allowed=True, dedicated_key=None)))
2024-03-21 12:13:17 [info ] Sending DLMS Request request=ReleaseRequest(reason=<ReleaseRequestReason.NORMAL: 0>, user_information=UserInformation(content=InitiateRequest(proposed_conformance=Conformance(general_protection=False, general_block_transfer=False, delta_value_encoding=False, attribute_0_supported_with_set=False, priority_management_supported=True, attribute_0_supported_with_get=False, block_transfer_with_get_or_read=True, block_transfer_with_set_or_write=False, block_transfer_with_action=False, multiple_references=True, data_notification=False, access=False, get=True, set=True, selective_access=True, event_notification=False, action=True), proposed_quality_of_service=None, client_max_receive_pdu_size=239, proposed_dlms_version_number=6, response_allowed=True, dedicated_key=None)))
2024-03-21 12:13:17 [info ] Sending HDLC frame frame=InformationFrame(destination_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), source_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=True), payload=bytearray(b'\xe6\xe6\x00b\x15\x80\x01\x00\xbe\x10\x04\x0e\x01\x00\x00\x00\x06_\x1f\x04\x00\x00R\x1d\x00\xef'), segmented=False, final=True, send_sequence_number=1, receive_sequence_number=1)
2024-03-21 12:13:17 [debug ] HDLC state transitioned new_state=AWAITING_RESPONSE old_state=IDLE
2024-03-21 12:13:17 [debug ] Sending data data=b'~\xa0&\x00\x02,)\x032\x1cl\xe6\xe6\x00b\x15\x80\x01\x00\xbe\x10\x04\x0e\x01\x00\x00\x00\x06_\x1f\x04\x00\x00R\x1d\x00\xefV"~' transport=HdlcTransport(client_logical_address=1, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93fd48040, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=True), client_ssn=1, client_rsn=2, server_ssn=2, server_rsn=1, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_RESPONSE), buffer=bytearray(b''), buffer_search_position=1), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:17 [debug ] Received data data=b'~\xa0&\x03\x00\x02,)R\x00\xd3\xe6\xe7\x00c\x15\x80\x01\x00\xbe\x10\x04\x0e\x08\x00\x06_\x1f\x04\x00\x00R\x1d\x00\xef\x00\x07\xdf\x05~' transport=HdlcTransport(client_logical_address=1, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93fd48040, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=True), client_ssn=1, client_rsn=2, server_ssn=2, server_rsn=1, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_RESPONSE), buffer=bytearray(b''), buffer_search_position=1), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:17 [debug ] Added data to buffer data=b'~\xa0&\x03\x00\x02,)R\x00\xd3\xe6\xe7\x00c\x15\x80\x01\x00\xbe\x10\x04\x0e\x08\x00\x06_\x1f\x04\x00\x00R\x1d\x00\xef\x00\x07\xdf\x05~'
2024-03-21 12:13:17 [debug ] Received HDLC frame frame=InformationFrame(destination_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=False), source_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), payload=bytearray(b'\xe6\xe7\x00c\x15\x80\x01\x00\xbe\x10\x04\x0e\x08\x00\x06_\x1f\x04\x00\x00R\x1d\x00\xef\x00\x07'), segmented=False, final=True, send_sequence_number=1, receive_sequence_number=2)
2024-03-21 12:13:17 [debug ] HDLC state transitioned new_state=IDLE old_state=AWAITING_RESPONSE
2024-03-21 12:13:17 [debug ] Adding data to buffer data=bytearray(b'c\x15\x80\x01\x00\xbe\x10\x04\x0e\x08\x00\x06_\x1f\x04\x00\x00R\x1d\x00\xef\x00\x07')
2024-03-21 12:13:17 [info ] Received DLMS Response response=ReleaseResponse(reason=<ReleaseResponseReason.NORMAL: 0>, user_information=UserInformation(content=InitiateResponse(negotiated_conformance=Conformance(general_protection=False, general_block_transfer=False, delta_value_encoding=False, attribute_0_supported_with_set=False, priority_management_supported=True, attribute_0_supported_with_get=False, block_transfer_with_get_or_read=True, block_transfer_with_set_or_write=False, block_transfer_with_action=False, multiple_references=True, data_notification=False, access=False, get=True, set=True, selective_access=True, event_notification=False, action=True), server_max_receive_pdu_size=239, negotiated_dlms_version_number=6, negotiated_quality_of_service=0)))
2024-03-21 12:13:17 [debug ] DLMS state transitioned new_state=NO_ASSOCIATION old_state=AWAITING_RELEASE_RESPONSE
2024-03-21 12:13:17 [debug ] HDLC state transitioned new_state=AWAITING_DISCONNECT old_state=IDLE
2024-03-21 12:13:17 [debug ] Sending data data=bytearray(b'~\xa0\n\x00\x02,)\x03S\x8a\xcc~') transport=HdlcTransport(client_logical_address=1, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93fd48040, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=True), client_ssn=2, client_rsn=2, server_ssn=2, server_rsn=2, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_DISCONNECT), buffer=bytearray(b''), buffer_search_position=1), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:18 [debug ] Received data data=b'~\xa0\n\x03\x00\x02,)s\x921~' transport=HdlcTransport(client_logical_address=1, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93fd48040, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=True), client_ssn=2, client_rsn=2, server_ssn=2, server_rsn=2, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_DISCONNECT), buffer=bytearray(b''), buffer_search_position=1), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:18 [debug ] Added data to buffer data=b'~\xa0\n\x03\x00\x02,)s\x921~'
2024-03-21 12:13:18 [debug ] Received HDLC frame frame=UnNumberedAcknowledgmentFrame(destination_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=False), source_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), payload=bytearray(b''), segmented=False, final=True)
2024-03-21 12:13:18 [debug ] HDLC state transitioned new_state=NOT_CONNECTED old_state=AWAITING_DISCONNECT
CONNECTING CLIENT
2024-03-21 12:13:18 [debug ] HDLC state transitioned new_state=AWAITING_CONNECTION old_state=NOT_CONNECTED
2024-03-21 12:13:18 [debug ] Sending data data=bytearray(b'~\xa0\n\x00\x02,)!\x93\x05\x1a~') transport=HdlcTransport(client_logical_address=16, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93f8478b0, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=16, physical_address=None, address_type='client', extended_addressing=True), client_ssn=0, client_rsn=0, server_ssn=0, server_rsn=0, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_CONNECTION), buffer=bytearray(b''), buffer_search_position=1), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:18 [debug ] Received data data=b'~\xa0#!\x00\x02,)s\x1e\x9e\x81\x80\x14\x05\x02\x00\xf2\x06\x02\x00\xf2\x07\x04\x00\x00\x00\x01\x08\x04\x00\x00\x00\x01\x0c\xf7~' transport=HdlcTransport(client_logical_address=16, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93f8478b0, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=16, physical_address=None, address_type='client', extended_addressing=True), client_ssn=0, client_rsn=0, server_ssn=0, server_rsn=0, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_CONNECTION), buffer=bytearray(b''), buffer_search_position=1), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:18 [debug ] Added data to buffer data=b'~\xa0#!\x00\x02,)s\x1e\x9e\x81\x80\x14\x05\x02\x00\xf2\x06\x02\x00\xf2\x07\x04\x00\x00\x00\x01\x08\x04\x00\x00\x00\x01\x0c\xf7~'
2024-03-21 12:13:18 [debug ] Received HDLC frame frame=UnNumberedAcknowledgmentFrame(destination_address=HdlcAddress(logical_address=16, physical_address=None, address_type='client', extended_addressing=False), source_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), payload=bytearray(b'\x81\x80\x14\x05\x02\x00\xf2\x06\x02\x00\xf2\x07\x04\x00\x00\x00\x01\x08\x04\x00\x00\x00\x01'), segmented=False, final=True)
2024-03-21 12:13:18 [debug ] HDLC state transitioned new_state=IDLE old_state=AWAITING_CONNECTION
2024-03-21 12:13:18 [debug ] DLMS state transitioned new_state=AWAITING_ASSOCIATION_RESPONSE old_state=NO_ASSOCIATION
2024-03-21 12:13:18 [debug ] Preparing to send DLMS Request request=ApplicationAssociationRequest(user_information=UserInformation(content=InitiateRequest(proposed_conformance=Conformance(general_protection=False, general_block_transfer=True, delta_value_encoding=False, attribute_0_supported_with_set=False, priority_management_supported=True, attribute_0_supported_with_get=False, block_transfer_with_get_or_read=True, block_transfer_with_set_or_write=False, block_transfer_with_action=False, multiple_references=True, data_notification=False, access=True, get=True, set=True, selective_access=True, event_notification=True, action=True), proposed_quality_of_service=None, client_max_receive_pdu_size=65535, proposed_dlms_version_number=6, response_allowed=True, dedicated_key=None)), system_title=b'utif\xab\\\xeby', public_cert=None, authentication=<AuthenticationMechanism.NONE: 0>, ciphered=False, authentication_value=None, calling_ae_invocation_identifier=None, called_ap_title=None, called_ae_qualifier=None, called_ap_invocation_identifier=None, called_ae_invocation_identifier=None, calling_ap_invocation_identifier=None, implementation_information=None)
2024-03-21 12:13:18 [info ] Sending DLMS Request request=ApplicationAssociationRequest(user_information=UserInformation(content=InitiateRequest(proposed_conformance=Conformance(general_protection=False, general_block_transfer=True, delta_value_encoding=False, attribute_0_supported_with_set=False, priority_management_supported=True, attribute_0_supported_with_get=False, block_transfer_with_get_or_read=True, block_transfer_with_set_or_write=False, block_transfer_with_action=False, multiple_references=True, data_notification=False, access=True, get=True, set=True, selective_access=True, event_notification=True, action=True), proposed_quality_of_service=None, client_max_receive_pdu_size=65535, proposed_dlms_version_number=6, response_allowed=True, dedicated_key=None)), system_title=b'utif\xab\\\xeby', public_cert=None, authentication=<AuthenticationMechanism.NONE: 0>, ciphered=False, authentication_value=None, calling_ae_invocation_identifier=None, called_ap_title=None, called_ae_qualifier=None, called_ap_invocation_identifier=None, called_ae_invocation_identifier=None, calling_ap_invocation_identifier=None, implementation_information=None)
2024-03-21 12:13:18 [info ] Sending HDLC frame frame=InformationFrame(destination_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), source_address=HdlcAddress(logical_address=16, physical_address=None, address_type='client', extended_addressing=True), payload=bytearray(b'\xe6\xe6\x00`)\xa1\t\x06\x07`\x85t\x05\x08\x01\x01\xa6\n\x04\x08utif\xab\\\xeby\xbe\x10\x04\x0e\x01\x00\x00\x00\x06_\x1f\x04\x00 R_\xff\xff'), segmented=False, final=True, send_sequence_number=0, receive_sequence_number=0)
2024-03-21 12:13:18 [debug ] HDLC state transitioned new_state=AWAITING_RESPONSE old_state=IDLE
2024-03-21 12:13:18 [debug ] Sending data data=b'~\xa0:\x00\x02,)!\x10\xdcz\xe6\xe6\x00`)\xa1\t\x06\x07`\x85t\x05\x08\x01\x01\xa6\n\x04\x08utif\xab\\\xeby\xbe\x10\x04\x0e\x01\x00\x00\x00\x06_\x1f\x04\x00 R_\xff\xff2a~' transport=HdlcTransport(client_logical_address=16, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93f8478b0, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=16, physical_address=None, address_type='client', extended_addressing=True), client_ssn=0, client_rsn=1, server_ssn=1, server_rsn=0, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_RESPONSE), buffer=bytearray(b''), buffer_search_position=1), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:18 [debug ] Received data data=b'~\xa0:!\x00\x02,)0q\x1a\xe6\xe7\x00a)\xa1\t\x06\x07`\x85t\x05\x08\x01\x01\xa2\x03\x02\x01\x00\xa3\x05\xa1\x03\x02\x01\x00\xbe\x10\x04\x0e\x08\x00\x06_\x1f\x04\x00\x00R\x14\x00\xef\x00\x07+\xf5~' transport=HdlcTransport(client_logical_address=16, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93f8478b0, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=16, physical_address=None, address_type='client', extended_addressing=True), client_ssn=0, client_rsn=1, server_ssn=1, server_rsn=0, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_RESPONSE), buffer=bytearray(b''), buffer_search_position=1), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:18 [debug ] Added data to buffer data=b'~\xa0:!\x00\x02,)0q\x1a\xe6\xe7\x00a)\xa1\t\x06\x07`\x85t\x05\x08\x01\x01\xa2\x03\x02\x01\x00\xa3\x05\xa1\x03\x02\x01\x00\xbe\x10\x04\x0e\x08\x00\x06_\x1f\x04\x00\x00R\x14\x00\xef\x00\x07+\xf5~'
2024-03-21 12:13:18 [debug ] Received HDLC frame frame=InformationFrame(destination_address=HdlcAddress(logical_address=16, physical_address=None, address_type='client', extended_addressing=False), source_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), payload=bytearray(b'\xe6\xe7\x00a)\xa1\t\x06\x07`\x85t\x05\x08\x01\x01\xa2\x03\x02\x01\x00\xa3\x05\xa1\x03\x02\x01\x00\xbe\x10\x04\x0e\x08\x00\x06_\x1f\x04\x00\x00R\x14\x00\xef\x00\x07'), segmented=False, final=True, send_sequence_number=0, receive_sequence_number=1)
2024-03-21 12:13:18 [debug ] HDLC state transitioned new_state=IDLE old_state=AWAITING_RESPONSE
2024-03-21 12:13:18 [debug ] Adding data to buffer data=bytearray(b'a)\xa1\t\x06\x07`\x85t\x05\x08\x01\x01\xa2\x03\x02\x01\x00\xa3\x05\xa1\x03\x02\x01\x00\xbe\x10\x04\x0e\x08\x00\x06_\x1f\x04\x00\x00R\x14\x00\xef\x00\x07')
2024-03-21 12:13:18 [info ] Received DLMS Response response=ApplicationAssociationResponse(result=<AssociationResult.ACCEPTED: 0>, result_source_diagnostics=<AcseServiceUserDiagnostics.NULL: 0>, ciphered=False, authentication=None, system_title=None, public_cert=None, authentication_value=None, user_information=UserInformation(content=InitiateResponse(negotiated_conformance=Conformance(general_protection=False, general_block_transfer=False, delta_value_encoding=False, attribute_0_supported_with_set=False, priority_management_supported=True, attribute_0_supported_with_get=False, block_transfer_with_get_or_read=True, block_transfer_with_set_or_write=False, block_transfer_with_action=False, multiple_references=True, data_notification=False, access=False, get=True, set=False, selective_access=True, event_notification=False, action=False), server_max_receive_pdu_size=239, negotiated_dlms_version_number=6, negotiated_quality_of_service=0)), implementation_information=None, responding_ap_invocation_id=None, responding_ae_invocation_id=None)
2024-03-21 12:13:18 [debug ] DLMS state transitioned new_state=READY old_state=AWAITING_ASSOCIATION_RESPONSE
DISCONNECTING CLIENT
2024-03-21 12:13:18 [debug ] DLMS state transitioned new_state=AWAITING_RELEASE_RESPONSE old_state=READY
2024-03-21 12:13:18 [debug ] Preparing to send DLMS Request request=ReleaseRequest(reason=<ReleaseRequestReason.NORMAL: 0>, user_information=UserInformation(content=InitiateRequest(proposed_conformance=Conformance(general_protection=False, general_block_transfer=False, delta_value_encoding=False, attribute_0_supported_with_set=False, priority_management_supported=True, attribute_0_supported_with_get=False, block_transfer_with_get_or_read=True, block_transfer_with_set_or_write=False, block_transfer_with_action=False, multiple_references=True, data_notification=False, access=False, get=True, set=False, selective_access=True, event_notification=False, action=False), proposed_quality_of_service=None, client_max_receive_pdu_size=239, proposed_dlms_version_number=6, response_allowed=True, dedicated_key=None)))
2024-03-21 12:13:18 [info ] Sending DLMS Request request=ReleaseRequest(reason=<ReleaseRequestReason.NORMAL: 0>, user_information=UserInformation(content=InitiateRequest(proposed_conformance=Conformance(general_protection=False, general_block_transfer=False, delta_value_encoding=False, attribute_0_supported_with_set=False, priority_management_supported=True, attribute_0_supported_with_get=False, block_transfer_with_get_or_read=True, block_transfer_with_set_or_write=False, block_transfer_with_action=False, multiple_references=True, data_notification=False, access=False, get=True, set=False, selective_access=True, event_notification=False, action=False), proposed_quality_of_service=None, client_max_receive_pdu_size=239, proposed_dlms_version_number=6, response_allowed=True, dedicated_key=None)))
2024-03-21 12:13:18 [info ] Sending HDLC frame frame=InformationFrame(destination_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), source_address=HdlcAddress(logical_address=16, physical_address=None, address_type='client', extended_addressing=True), payload=bytearray(b'\xe6\xe6\x00b\x15\x80\x01\x00\xbe\x10\x04\x0e\x01\x00\x00\x00\x06_\x1f\x04\x00\x00R\x14\x00\xef'), segmented=False, final=True, send_sequence_number=1, receive_sequence_number=1)
2024-03-21 12:13:18 [debug ] HDLC state transitioned new_state=AWAITING_RESPONSE old_state=IDLE
2024-03-21 12:13:18 [debug ] Sending data data=b'~\xa0&\x00\x02,)!2\x9f|\xe6\xe6\x00b\x15\x80\x01\x00\xbe\x10\x04\x0e\x01\x00\x00\x00\x06_\x1f\x04\x00\x00R\x14\x00\xefH\xbe~' transport=HdlcTransport(client_logical_address=16, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93f8478b0, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=16, physical_address=None, address_type='client', extended_addressing=True), client_ssn=1, client_rsn=2, server_ssn=2, server_rsn=1, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_RESPONSE), buffer=bytearray(b''), buffer_search_position=1), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:18 [debug ] Received data data=b'~\xa0&!\x00\x02,)R6^\xe6\xe7\x00c\x15\x80\x01\x00\xbe\x10\x04\x0e\x08\x00\x06_\x1f\x04\x00\x00R\x14\x00\xef\x00\x07\xbbT~' transport=HdlcTransport(client_logical_address=16, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93f8478b0, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=16, physical_address=None, address_type='client', extended_addressing=True), client_ssn=1, client_rsn=2, server_ssn=2, server_rsn=1, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_RESPONSE), buffer=bytearray(b''), buffer_search_position=1), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:18 [debug ] Added data to buffer data=b'~\xa0&!\x00\x02,)R6^\xe6\xe7\x00c\x15\x80\x01\x00\xbe\x10\x04\x0e\x08\x00\x06_\x1f\x04\x00\x00R\x14\x00\xef\x00\x07\xbbT~'
2024-03-21 12:13:18 [debug ] Received HDLC frame frame=InformationFrame(destination_address=HdlcAddress(logical_address=16, physical_address=None, address_type='client', extended_addressing=False), source_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), payload=bytearray(b'\xe6\xe7\x00c\x15\x80\x01\x00\xbe\x10\x04\x0e\x08\x00\x06_\x1f\x04\x00\x00R\x14\x00\xef\x00\x07'), segmented=False, final=True, send_sequence_number=1, receive_sequence_number=2)
2024-03-21 12:13:18 [debug ] HDLC state transitioned new_state=IDLE old_state=AWAITING_RESPONSE
2024-03-21 12:13:18 [debug ] Adding data to buffer data=bytearray(b'c\x15\x80\x01\x00\xbe\x10\x04\x0e\x08\x00\x06_\x1f\x04\x00\x00R\x14\x00\xef\x00\x07')
2024-03-21 12:13:18 [info ] Received DLMS Response response=ReleaseResponse(reason=<ReleaseResponseReason.NORMAL: 0>, user_information=UserInformation(content=InitiateResponse(negotiated_conformance=Conformance(general_protection=False, general_block_transfer=False, delta_value_encoding=False, attribute_0_supported_with_set=False, priority_management_supported=True, attribute_0_supported_with_get=False, block_transfer_with_get_or_read=True, block_transfer_with_set_or_write=False, block_transfer_with_action=False, multiple_references=True, data_notification=False, access=False, get=True, set=False, selective_access=True, event_notification=False, action=False), server_max_receive_pdu_size=239, negotiated_dlms_version_number=6, negotiated_quality_of_service=0)))
2024-03-21 12:13:18 [debug ] DLMS state transitioned new_state=NO_ASSOCIATION old_state=AWAITING_RELEASE_RESPONSE
2024-03-21 12:13:18 [debug ] HDLC state transitioned new_state=AWAITING_DISCONNECT old_state=IDLE
2024-03-21 12:13:18 [debug ] Sending data data=bytearray(b'~\xa0\n\x00\x02,)!S\t\xdc~') transport=HdlcTransport(client_logical_address=16, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93f8478b0, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=16, physical_address=None, address_type='client', extended_addressing=True), client_ssn=2, client_rsn=2, server_ssn=2, server_rsn=2, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_DISCONNECT), buffer=bytearray(b''), buffer_search_position=1), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:18 [debug ] Received data data=b'~\xa0\n!\x00\x02,)s\xa4\xbc~' transport=HdlcTransport(client_logical_address=16, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93f8478b0, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=16, physical_address=None, address_type='client', extended_addressing=True), client_ssn=2, client_rsn=2, server_ssn=2, server_rsn=2, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_DISCONNECT), buffer=bytearray(b''), buffer_search_position=1), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:18 [debug ] Added data to buffer data=b'~\xa0\n!\x00\x02,)s\xa4\xbc~'
2024-03-21 12:13:18 [debug ] Received HDLC frame frame=UnNumberedAcknowledgmentFrame(destination_address=HdlcAddress(logical_address=16, physical_address=None, address_type='client', extended_addressing=False), source_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), payload=bytearray(b''), segmented=False, final=True)
2024-03-21 12:13:18 [debug ] HDLC state transitioned new_state=NOT_CONNECTED old_state=AWAITING_DISCONNECT
CONNECTING MANAGEMENT
2024-03-21 12:13:18 [debug ] HDLC state transitioned new_state=AWAITING_CONNECTION old_state=NOT_CONNECTED
2024-03-21 12:13:18 [debug ] Sending data data=bytearray(b'~\xa0\n\x00\x02,)\x03\x93\x86\n~') transport=HdlcTransport(client_logical_address=1, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93f97e950, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=True), client_ssn=2, client_rsn=2, server_ssn=2, server_rsn=2, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_CONNECTION), buffer=bytearray(b''), buffer_search_position=1), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:18 [debug ] Received data data=b'~\xa0#\x03\x00\x02,)s(\x13\x81\x80\x14\x05\x02\x00\xf2\x06\x02\x00\xf2\x07\x04\x00\x00\x00\x01\x08\x04\x00\x00\x00\x01\x0c\xf7~' transport=HdlcTransport(client_logical_address=1, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93f97e950, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=True), client_ssn=2, client_rsn=2, server_ssn=2, server_rsn=2, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_CONNECTION), buffer=bytearray(b''), buffer_search_position=1), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:18 [debug ] Added data to buffer data=b'~\xa0#\x03\x00\x02,)s(\x13\x81\x80\x14\x05\x02\x00\xf2\x06\x02\x00\xf2\x07\x04\x00\x00\x00\x01\x08\x04\x00\x00\x00\x01\x0c\xf7~'
2024-03-21 12:13:18 [debug ] Received HDLC frame frame=UnNumberedAcknowledgmentFrame(destination_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=False), source_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), payload=bytearray(b'\x81\x80\x14\x05\x02\x00\xf2\x06\x02\x00\xf2\x07\x04\x00\x00\x00\x01\x08\x04\x00\x00\x00\x01'), segmented=False, final=True)
2024-03-21 12:13:18 [debug ] HDLC state transitioned new_state=IDLE old_state=AWAITING_CONNECTION
2024-03-21 12:13:18 [debug ] DLMS state transitioned new_state=AWAITING_ASSOCIATION_RESPONSE old_state=NO_ASSOCIATION
2024-03-21 12:13:18 [debug ] Preparing to send DLMS Request request=ApplicationAssociationRequest(user_information=UserInformation(content=InitiateRequest(proposed_conformance=Conformance(general_protection=False, general_block_transfer=False, delta_value_encoding=False, attribute_0_supported_with_set=False, priority_management_supported=True, attribute_0_supported_with_get=False, block_transfer_with_get_or_read=True, block_transfer_with_set_or_write=False, block_transfer_with_action=False, multiple_references=True, data_notification=False, access=False, get=True, set=True, selective_access=True, event_notification=False, action=True), proposed_quality_of_service=None, client_max_receive_pdu_size=239, proposed_dlms_version_number=6, response_allowed=True, dedicated_key=None)), system_title=b'uti\xc8.\x8c7\x84', public_cert=None, authentication=<AuthenticationMechanism.LLS: 1>, ciphered=False, authentication_value=b'12345678', calling_ae_invocation_identifier=None, called_ap_title=None, called_ae_qualifier=None, called_ap_invocation_identifier=None, called_ae_invocation_identifier=None, calling_ap_invocation_identifier=None, implementation_information=None)
2024-03-21 12:13:18 [info ] Sending DLMS Request request=ApplicationAssociationRequest(user_information=UserInformation(content=InitiateRequest(proposed_conformance=Conformance(general_protection=False, general_block_transfer=False, delta_value_encoding=False, attribute_0_supported_with_set=False, priority_management_supported=True, attribute_0_supported_with_get=False, block_transfer_with_get_or_read=True, block_transfer_with_set_or_write=False, block_transfer_with_action=False, multiple_references=True, data_notification=False, access=False, get=True, set=True, selective_access=True, event_notification=False, action=True), proposed_quality_of_service=None, client_max_receive_pdu_size=239, proposed_dlms_version_number=6, response_allowed=True, dedicated_key=None)), system_title=b'uti\xc8.\x8c7\x84', public_cert=None, authentication=<AuthenticationMechanism.LLS: 1>, ciphered=False, authentication_value=b'12345678', calling_ae_invocation_identifier=None, called_ap_title=None, called_ae_qualifier=None, called_ap_invocation_identifier=None, called_ae_invocation_identifier=None, calling_ap_invocation_identifier=None, implementation_information=None)
2024-03-21 12:13:18 [info ] Sending HDLC frame frame=InformationFrame(destination_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), source_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=True), payload=bytearray(b'\xe6\xe6\x00`B\xa1\t\x06\x07`\x85t\x05\x08\x01\x01\xa6\n\x04\x08uti\xc8.\x8c7\x84\x8a\x02\x07\x80\x8b\x07`\x85t\x05\x08\x02\x01\xac\n\x80\x0812345678\xbe\x10\x04\x0e\x01\x00\x00\x00\x06_\x1f\x04\x00\x00R\x1d\x00\xef'), segmented=False, final=True, send_sequence_number=2, receive_sequence_number=2)
2024-03-21 12:13:18 [debug ] HDLC state transitioned new_state=AWAITING_RESPONSE old_state=IDLE
2024-03-21 12:13:18 [debug ] Sending data data=b'~\xa0S\x00\x02,)\x03T\xc3\x8b\xe6\xe6\x00`B\xa1\t\x06\x07`\x85t\x05\x08\x01\x01\xa6\n\x04\x08uti\xc8.\x8c7\x84\x8a\x02\x07\x80\x8b\x07`\x85t\x05\x08\x02\x01\xac\n\x80\x0812345678\xbe\x10\x04\x0e\x01\x00\x00\x00\x06_\x1f\x04\x00\x00R\x1d\x00\xef\xb9/~' transport=HdlcTransport(client_logical_address=1, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93f97e950, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=True), client_ssn=2, client_rsn=3, server_ssn=3, server_rsn=2, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_RESPONSE), buffer=bytearray(b''), buffer_search_position=1), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:18 [debug ] Received data data=b'~\xa0\x0f\x03\x00\x02,)\x97\x1b`T\x00\x10t?~' transport=HdlcTransport(client_logical_address=1, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93f97e950, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=True), client_ssn=2, client_rsn=3, server_ssn=3, server_rsn=2, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_RESPONSE), buffer=bytearray(b''), buffer_search_position=1), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:18 [debug ] Added data to buffer data=b'~\xa0\x0f\x03\x00\x02,)\x97\x1b`T\x00\x10t?~'
2024-03-21 12:13:18 [debug ] HDLC frame could not be parsed. Need more data
2024-03-21 12:13:19 [debug ] Received data data=b'' transport=HdlcTransport(client_logical_address=1, server_logical_address=1, io=SerialIO(port_name='COM8', baud_rate=9600, timeout=1, serial_port=Serial<id=0x1a93f97e950, open=True>(port='COM8', baudrate=9600, bytesize=8, parity='N', stopbits=1, timeout=1, xonxoff=False, rtscts=False, dsrdtr=False)), server_physical_address=2836, client_physical_address=None, extended_addressing=True, timeout=1, hdlc_connection=HdlcConnection(client_address=HdlcAddress(logical_address=1, physical_address=2836, address_type='server', extended_addressing=True), server_address=HdlcAddress(logical_address=1, physical_address=None, address_type='client', extended_addressing=True), client_ssn=2, client_rsn=3, server_ssn=3, server_rsn=2, max_data_size=128, state=HdlcConnectionState(current_state=AWAITING_RESPONSE), buffer=bytearray(b'~\xa0\x0f\x03\x00\x02,)\x97\x1b`T\x00\x10t?~'), buffer_search_position=17), _send_buffer=[], out_buffer=bytearray(b''), in_buffer=bytearray(b''))
2024-03-21 12:13:20 [debug ] Received data data=b''
