leodesigner / powmr_comm

PowMr Inverter serial communication protocol reverse engineering
MIT License
69 stars 6 forks source link

Modbus CRC Check failed! #16

Closed Paxy closed 4 days ago

Paxy commented 4 days ago

Getting CRC failed on POW-HVM2H-12V-N.


[16:54:06][V][modbus_controller:042]: Sending next modbus command to device 5 register 0x1399 count 1
[16:54:06][V][modbus:222]: Modbus write: 05.03.13.99.00.01.51.25 (8)
[16:54:06][V][modbus_controller:565]: Command sent 3 0x1399 1 send_count: 4
[16:54:06][D][uart_debug:114]: >>> 05:03:13:99:00:01:51:25
[16:54:06][W][modbus:124]: Modbus CRC Check failed! 5A65!=FE99
[16:54:06][V][modbus:026]: Clearing buffer of 5 bytes - parse failed
[16:54:06][V][modbus:035]: Clearing buffer of 3 bytes - timeout
[16:54:06][V][sensor:043]: 'Load Current': Received new state nan
[16:54:06][D][sensor:094]: 'Load Current': Sending state nan A with 3 decimals of accuracy
[16:54:06][D][uart_debug:114]: <<< E5:F3:D3:99:FE:F9:59:B5
[16:54:06][V][modbus:042]: Stop waiting for response from 5
[16:54:06][V][sensor:043]: 'Battery Power': Received new state nan
[16:54:06][D][sensor:094]: 'Battery Power': Sending state nan W with 0 decimals of accuracy
[16:54:07][V][modbus_controller:042]: Sending next modbus command to device 5 register 0x1399 count 1
[16:54:07][V][modbus:222]: Modbus write: 05.03.13.99.00.01.51.25 (8)
[16:54:07][V][modbus_controller:565]: Command sent 3 0x1399 1 send_count: 5
[16:54:07][D][uart_debug:114]: >>> 05:03:13:99:00:01:51:25
[16:54:07][W][modbus:124]: Modbus CRC Check failed! 5A65!=FE99
[16:54:07][V][modbus:026]: Clearing buffer of 5 bytes - parse failed
[16:54:07][V][modbus:035]: Clearing buffer of 3 bytes - timeout
[16:54:07][D][uart_debug:114]: <<< E5:F3:D3:99:FE:F9:5D:A5
[16:54:07][V][modbus:042]: Stop waiting for response from 5
[16:54:08][D][sensor:094]: 'Battery Current': Sending state nan A with 1 decimals of accuracy
[16:54:08][W][modbus_controller:027]: Modbus device=5 set offline
[16:54:08][D][modbus_controller:038]: Modbus command to device=5 register=0x1399 no response received - removed from send queue
[16:54:08][V][modbus_controller:042]: Sending next modbus command to device 5 register 0x1196 count 37
[16:54:08][V][modbus:222]: Modbus write: 05.03.11.96.00.25.60.85 (8)
[16:54:08][V][modbus_controller:565]: Command sent 3 0x1196 37 send_count: 1
[16:54:08][D][uart_debug:114]: >>> 05:03:11:96:00:25:60:85
[16:54:08][W][modbus:124]: Modbus CRC Check failed! 5DE5!=FE96
[16:54:08][V][modbus:026]: Clearing buffer of 5 bytes - parse failed
[16:54:08][V][sensor:043]: 'Load Power Factor': Received new state nan
[16:54:08][D][sensor:094]: 'Load Power Factor': Sending state nan  with 2 decimals of accuracy
[16:54:08][V][modbus:035]: Clearing buffer of 3 bytes - timeout
[16:54:08][V][sensor:043]: 'Load Power': Received new state nan
[16:54:08][D][sensor:094]: 'Load Power': Sending state nan W with 0 decimals of accuracy
[16:54:08][D][uart_debug:114]: <<< E5:F3:D9:96:FE:A5:7E:F5
[16:54:08][V][modbus:042]: Stop waiting for response from 5
[16:54:09][V][modbus_controller:042]: Sending next modbus command to device 5 register 0x1196 count 37
[16:54:09][V][modbus:222]: Modbus write: 05.03.11.96.00.25.60.85 (8)
[16:54:09][V][modbus_controller:565]: Command sent 3 0x1196 37 send_count: 2
[16:54:09][D][uart_debug:114]: >>> 05:03:11:96:00:25:60:85
[16:54:09][W][modbus:124]: Modbus CRC Check failed! 5DE5!=FE96
[16:54:09][V][modbus:026]: Clearing buffer of 5 bytes - parse failed
[16:54:09][V][modbus:035]: Clearing buffer of 3 bytes - timeout
[16:54:09][D][uart_debug:114]: <<< E5:F3:D9:96:FE:A5:7E:E5
[16:54:09][V][modbus:042]: Stop waiting for response from 5
[16:54:10][V][modbus_controller:042]: Sending next modbus command to device 5 register 0x1196 count 37
[16:54:10][V][modbus:222]: Modbus write: 05.03.11.96.00.25.60.85 (8)
[16:54:10][V][modbus_controller:565]: Command sent 3 0x1196 37 send_count: 3
[16:54:10][D][uart_debug:114]: >>> 05:03:11:96:00:25:60:85
[16:54:10][W][modbus:124]: Modbus CRC Check failed! 5DE5!=FE96
[16:54:10][V][modbus:026]: Clearing buffer of 5 bytes - parse failed
[16:54:10][V][modbus:035]: Clearing buffer of 3 bytes - timeout
[16:54:10][D][uart_debug:114]: <<< E5:F3:D9:96:FE:A5:7E:E5
[16:54:10][V][modbus:042]: Stop waiting for response from 5
[16:54:11][V][modbus_controller:226]: 3 modbus commands already in queue
[16:54:11][V][modbus_controller:195]: Range : 1399 Size: 1 (3) skip: 100
[16:54:11][V][modbus_controller:195]: Range : 1196 Size: 25 (3) skip: 100
[16:54:11][V][modbus_controller:195]: Range : 11C9 Size: 3 (3) skip: 100
[16:54:11][V][modbus_controller:195]: Range : 139A Size: 1 (3) skip: 100
[16:54:11][V][modbus_controller:042]: Sending next modbus command to device 5 register 0x1196 count 37
[16:54:11][V][modbus:222]: Modbus write: 05.03.11.96.00.25.60.85 (8)
[16:54:11][V][modbus_controller:565]: Command sent 3 0x1196 37 send_count: 4
[16:54:11][D][uart_debug:114]: >>> 05:03:11:96:00:25:60:85
[16:54:11][W][modbus:124]: Modbus CRC Check failed! 5DE5!=FE96
[16:54:11][V][modbus:026]: Clearing buffer of 5 bytes - parse failed
[16:54:11][V][modbus:035]: Clearing buffer of 3 bytes - timeout
[16:54:11][D][uart_debug:114]: <<< E5:F3:D9:96:FE:A5:7E:E5
[16:54:11][V][modbus:042]: Stop waiting for response from 5
[16:54:12][V][modbus_controller:042]: Sending next modbus command to device 5 register 0x1196 count 37
[16:54:12][V][modbus:222]: Modbus write: 05.03.11.96.00.25.60.85 (8)
[16:54:12][V][modbus_controller:565]: Command sent 3 0x1196 37 send_count: 5
[16:54:12][D][uart_debug:114]: >>> 05:03:11:96:00:25:60:85
[16:54:12][W][modbus:124]: Modbus CRC Check failed! 5DE5!=FE96
[16:54:12][V][modbus:026]: Clearing buffer of 5 bytes - parse failed
[16:54:12][V][modbus:035]: Clearing buffer of 3 bytes - timeout
[16:54:12][D][uart_debug:114]: <<< E5:F3:D9:96:FE:A5:7E:E5
[16:54:12][V][modbus:042]: Stop waiting for response from 5
[16:54:13][D][modbus_controller:038]: Modbus command to device=5 register=0x1196 no response received - removed from send queue
[16:54:13][V][modbus_controller:042]: Sending next modbus command to device 5 register 0x11C9 count 3
[16:54:13][V][modbus:222]: Modbus write: 05.03.11.C9.00.03.D1.4D (8)
[16:54:13][V][modbus_controller:565]: Command sent 3 0x11C9 3 send_count: 1
[16:54:13][D][uart_debug:114]: >>> 05:03:11:C9:00:03:D1:4D
[16:54:13][W][modbus:124]: Modbus CRC Check failed! 5DE5!=FEE9
[16:54:13][V][modbus:026]: Clearing buffer of 5 bytes - parse failed
[16:54:13][V][modbus:035]: Clearing buffer of 3 bytes - timeout
[16:54:13][D][uart_debug:114]: <<< E5:F3:D9:E9:FE:F3:D9:4D
[16:54:13][V][modbus:042]: Stop waiting for response from 5
[16:54:14][V][modbus_controller:042]: Sending next modbus command to device 5 register 0x11C9 count 3
[16:54:14][V][modbus:222]: Modbus write: 05.03.11.C9.00.03.D1.4D (8)
[16:54:14][V][modbus_controller:565]: Command sent 3 0x11C9 3 send_count: 2
[16:54:14][D][uart_debug:114]: >>> 05:03:11:C9:00:03:D1:4D
[16:54:14][W][modbus:124]: Modbus CRC Check failed! 5DE5!=FEE9
[16:54:14][V][modbus:026]: Clearing buffer of 5 bytes - parse failed
[16:54:14][V][modbus:035]: Clearing buffer of 3 bytes - timeout
[16:54:14][D][uart_debug:114]: <<< E5:F3:D9:E9:FE:F3:D9:4D
[16:54:14][V][sensor:043]: 'Battery Current': Received new state nan
[16:54:14][V][modbus:042]: Stop waiting for response from 5
[16:54:15][V][modbus_controller:042]: Sending next modbus command to device 5 register 0x11C9 count 3
[16:54:15][V][modbus:222]: Modbus write: 05.03.11.C9.00.03.D1.4D (8)
[16:54:15][V][modbus_controller:565]: Command sent 3 0x11C9 3 send_count: 3
[16:54:15][D][uart_debug:114]: >>> 05:03:11:C9:00:03:D1:4D
[16:54:15][W][modbus:124]: Modbus CRC Check failed! 98E4!=FEE9
[16:54:15][V][modbus:026]: Clearing buffer of 5 bytes - parse failed
[16:54:15][V][modbus:035]: Clearing buffer of 3 bytes - timeout
[16:54:15][D][uart_debug:114]: <<< F5:F3:D9:E9:FE:F3:D9:4D
[16:54:16][V][modbus:042]: Stop waiting for response from 5
[16:54:16][V][sensor:043]: 'Load Current': Received new state nan
[16:54:16][D][sensor:094]: 'Load Current': Sending state nan A with 3 decimals of accuracy
[16:54:16][V][modbus_controller:042]: Sending next modbus command to device 5 register 0x11C9 count 3
[16:54:16][V][modbus:222]: Modbus write: 05.03.11.C9.00.03.D1.4D (8)
[16:54:16][V][modbus_controller:565]: Command sent 3 0x11C9 3 send_count: 4
[16:54:16][D][uart_debug:114]: >>> 05:03:11:C9:00:03:D1:4D
[16:54:16][W][modbus:124]: Modbus CRC Check failed! 5DE5!=FEED
[16:54:16][V][modbus:026]: Clearing buffer of 5 bytes - parse failed
[16:54:16][V][modbus:035]: Clearing buffer of 3 bytes - timeout
[16:54:16][D][uart_debug:114]: <<< E5:F3:D9:ED:FE:F3:D9:4D
[16:54:16][V][sensor:043]: 'Battery Power': Received new state nan
[16:54:17][D][sensor:094]: 'Battery Power': Sending state nan W with 0 decimals of accuracy
[16:54:17][V][modbus:042]: Stop waiting for response from 5
[16:54:17][V][modbus_controller:042]: Sending next modbus command to device 5 register 0x11C9 count 3
[16:54:17][V][modbus:222]: Modbus write: 05.03.11.C9.00.03.D1.4D (8)
[16:54:17][V][modbus_controller:565]: Command sent 3 0x11C9 3 send_count: 5
[16:54:17][D][uart_debug:114]: >>> 05:03:11:C9:00:03:D1:4D
[16:54:17][W][modbus:124]: Modbus CRC Check failed! 5DE5!=FEE9
[16:54:17][V][modbus:026]: Clearing buffer of 5 bytes - parse failed
[16:54:17][V][modbus:035]: Clearing buffer of 3 bytes - timeout
[16:54:18][D][uart_debug:114]: <<< E5:F3:D9:E9:FE:F3:D9:4D
[16:54:18][V][modbus:042]: Stop waiting for response from 5
[16:54:18][D][sensor:094]: 'Battery Current': Sending state nan A with 1 decimals of accuracy
[16:54:18][V][sensor:043]: 'Load Power Factor': Received new state nan
[16:54:18][D][sensor:094]: 'Load Power Factor': Sending state nan  with 2 decimals of accuracy
[16:54:18][V][sensor:043]: 'Load Power': Received new state nan
[16:54:18][D][sensor:094]: 'Load Power': Sending state nan W with 0 decimals of accuracy
[16:54:18][D][modbus_controller:038]: Modbus command to device=5 register=0x11C9 no response received - removed from send queue
[16:54:18][V][modbus_controller:042]: Sending next modbus command to device 5 register 0x139A count 1
[16:54:18][V][modbus:222]: Modbus write: 05.03.13.9A.00.01.A1.25 (8)
[16:54:18][V][modbus_controller:565]: Command sent 3 0x139A 1 send_count: 1
[16:54:18][D][uart_debug:114]: >>> 05:03:13:9A:00:01:A1:25
[16:54:18][W][modbus:124]: Modbus CRC Check failed! 9F64!=FE9A
[16:54:18][V][modbus:026]: Clearing buffer of 5 bytes - parse failed
[16:54:19][V][modbus:035]: Clearing buffer of 3 bytes - timeout
[16:54:19][D][uart_debug:114]: <<< F5:F3:D3:9A:FE:F9:B9:A5
[16:54:19][V][modbus:042]: Stop waiting for response from 5
[16:54:19][V][modbus_controller:042]: Sending next modbus command to device 5 register 0x139A count 1
[16:54:19][V][modbus:222]: Modbus write: 05.03.13.9A.00.01.A1.25 (8)
[16:54:19][V][modbus_controller:565]: Command sent 3 0x139A 1 send_count: 2
[16:54:20][D][uart_debug:114]: >>> 05:03:13:9A:00:01:A1:25
[16:54:20][W][modbus:124]: Modbus CRC Check failed! 5A65!=FE9A
[16:54:20][V][modbus:026]: Clearing buffer of 5 bytes - parse failed
[16:54:20][V][modbus:035]: Clearing buffer of 3 bytes - timeout
[16:54:20][D][uart_debug:114]: <<< E5:F3:D3:9A:FE:F9:B9:B5
[16:54:20][V][modbus:042]: Stop waiting for response from 5
[16:54:21][V][modbus_controller:042]: Sending next modbus command to device 5 register 0x139A count 1
[16:54:21][V][modbus:222]: Modbus write: 05.03.13.9A.00.01.A1.25 (8)
[16:54:21][V][modbus_controller:565]: Command sent 3 0x139A 1 send_count: 3
[16:54:21][D][uart_debug:114]: >>> 05:03:13:9A:00:01:A1:25
[16:54:21][W][modbus:124]: Modbus CRC Check failed! 9F64!=FE9A
[16:54:21][V][modbus:026]: Clearing buffer of 5 bytes - parse failed
[16:54:21][V][modbus_controller:226]: 1 modbus commands already in queue
[16:54:21][V][modbus_controller:195]: Range : 1399 Size: 1 (3) skip: 99
[16:54:21][V][modbus_controller:195]: Range : 1196 Size: 25 (3) skip: 99
[16:54:21][V][modbus_controller:195]: Range : 11C9 Size: 3 (3) skip: 99
[16:54:21][V][modbus_controller:195]: Range : 139A Size: 1 (3) skip: 99
[16:54:21][V][modbus:035]: Clearing buffer of 3 bytes - timeout
[16:54:21][D][uart_debug:114]: <<< F5:F3:D3:9A:FE:F9:B9:A5
[16:54:21][V][modbus:042]: Stop waiting for response from 5
[16:54:21][V][sensor:043]: 'Uptime': Received new state 51.904999
[16:54:21][D][sensor:094]: 'Uptime': Sending state 51.90500 s with 0 decimals of accuracy
[16:54:22][V][modbus_controller:042]: Sending next modbus command to device 5 register 0x139A count 1
[16:54:22][V][modbus:222]: Modbus write: 05.03.13.9A.00.01.A1.25 (8)
[16:54:22][V][modbus_controller:565]: Command sent 3 0x139A 1 send_count: 4
[16:54:22][D][uart_debug:114]: >>> 05:03:13:9A:00:01:A1:25
[16:54:22][W][modbus:124]: Modbus CRC Check failed! 9F64!=FE9A
[16:54:22][V][modbus:026]: Clearing buffer of 5 bytes - parse failed
[16:54:22][V][modbus:035]: Clearing buffer of 3 bytes - timeout
[16:54:22][D][uart_debug:114]: <<< F5:F3:D3:9A:FE:F9:B9:A5
[16:54:22][V][modbus:042]: Stop waiting for response from 5
[16:54:23][V][modbus_controller:042]: Sending next modbus command to device 5 register 0x139A count 1
[16:54:23][V][modbus:222]: Modbus write: 05.03.13.9A.00.01.A1.25 (8)
[16:54:23][V][modbus_controller:565]: Command sent 3 0x139A 1 send_count: 5
[16:54:23][D][uart_debug:114]: >>> 05:03:13:9A:00:01:A1:25
[16:54:23][W][modbus:124]: Modbus CRC Check failed! 9F64!=FE9A
[16:54:23][V][modbus:026]: Clearing buffer of 5 bytes - parse failed
[16:54:23][V][modbus:035]: Clearing buffer of 3 bytes - timeout
[16:54:23][D][uart_debug:114]: <<< F5:F3:D3:9A:FE:F9:BD:A5
[16:54:23][V][modbus:042]: Stop waiting for response from 5
[16:54:24][D][modbus_controller:038]: Modbus command to device=5 register=0x139A no response received - removed from send queue

I have tried to change stop_bits: 1, but no change.