apsystems-ecu.0
	2022-03-26 08:15:28.583	debug	Ecu.trNextCycle() 60sec delay
apsystems-ecu.0
	2022-03-26 08:15:28.583	debug	Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
apsystems-ecu.0
	2022-03-26 08:15:28.583	debug	Ecu.trDisconnect() - done
apsystems-ecu.0
	2022-03-26 08:15:28.583	debug	Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForDisconnected
apsystems-ecu.0
	2022-03-26 08:15:28.583	debug	Ecu.decodeAndProcessInverterSignalLevel() - status=00 - done
apsystems-ecu.0
	2022-03-26 08:15:28.583	debug	prefix=undefined i=5 isl.inverterId[i]=703000015029
apsystems-ecu.0
	2022-03-26 08:15:28.582	debug	prefix=undefined i=4 isl.inverterId[i]=703000014489
apsystems-ecu.0
	2022-03-26 08:15:28.582	debug	prefix=undefined i=3 isl.inverterId[i]=806000056773
apsystems-ecu.0
	2022-03-26 08:15:28.582	debug	prefix=qs1_806000055586 i=2 isl.inverterId[i]=806000055586
apsystems-ecu.0
	2022-03-26 08:15:28.582	debug	prefix=undefined i=1 isl.inverterId[i]=806000055796
apsystems-ecu.0
	2022-03-26 08:15:28.582	debug	prefix=qs1_806000058312 i=0 isl.inverterId[i]=806000058312
apsystems-ecu.0
	2022-03-26 08:15:28.581	debug	Ecu.decodeRsp() 620ms - 41,50,53,31,31,30,30,36,30,30,30,33,30,30,30,80,60,0,5,30,30,30,30,30,30,5,57,96,0,80,60,0,5,55,86,d0,80,60,0,5,67,73,0,70,30,0,1,44,89,b6,70,30,0,1,50,29,d6,45,4e,44
apsystems-ecu.0
	2022-03-26 08:15:27.961	debug	Ecu.trServiceSM2(evRepeatService) stInverterSignalLevel->stPowerOfDay
apsystems-ecu.0
	2022-03-26 08:15:27.961	debug	Ecu.reqService(INVERTER_SIGNAL_LEVEL req:APS1100280030216000xxxxxxEND)
apsystems-ecu.0
	2022-03-26 08:15:27.961	debug	Ecu.trServiceSM2(evRepeatService) stInverterSignalLevel->stInverterSignalLevel
apsystems-ecu.0
	2022-03-26 08:15:27.961	debug	Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
apsystems-ecu.0
	2022-03-26 08:15:27.895	debug	Ecu.trConnect() hide=true, ip=192.168.xxx.xxx port=8899
apsystems-ecu.0
	2022-03-26 08:15:27.895	debug	Ecu.ecuStateMachine(evCycleTimer) stWaitForNextCycle -> stWaitForConnect
apsystems-ecu.0
	2022-03-26 08:14:27.903	debug	ecu.createAndSetInverterObjects(qs1,806000055586) - done
apsystems-ecu.0
	2022-03-26 08:14:27.901	debug	ecu.createAndSetInverterObjects(qs1,806000058312) - done
apsystems-ecu.0
	2022-03-26 08:14:27.892	debug	Ecu.trNextCycle() 60sec delay
apsystems-ecu.0
	2022-03-26 08:14:27.891	debug	Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
apsystems-ecu.0
	2022-03-26 08:14:27.891	debug	Ecu.trDisconnect() - done
apsystems-ecu.0
	2022-03-26 08:14:27.891	debug	Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForDisconnected
apsystems-ecu.0
	2022-03-26 08:14:27.891	error	Ecu.decodeAndProcessRealTimeData() - +++ invalid inverter type:64
apsystems-ecu.0
	2022-03-26 08:14:27.891	debug	ecu.decodeAndProcessRealTimeData() only registered - 0 / 806000056773
apsystems-ecu.0
	2022-03-26 08:14:27.891	debug	ecu.decodeAndProcessRealTimeData() only registered - 0 / 806000055796
apsystems-ecu.0
	2022-03-26 08:14:27.890	debug	Ecu.decodeRsp() 309ms - 41,50,53,31,31,30,31,33,35,30,30,30,32,30,30,30,31,0,6,30,30,30,30,30,30,54,80,60,0,5,83,12,1,30,33,1,f4,0,6b,0,1c,0,de,0,f,0,f,0,1f,80,60,0,5,57,96,0,30,30,80,60,0,5,55,86,0,30,33,0,0,0,0,0,0,0,0,0,0,0,0,0,0,80,60,0,5,67,73,0,30,30,70,30,0,1,44,89,1,30,31,1,f4,0,75,0,19,0,e9,0,12,0,e9,70,30,0,1,50,29,1,30,31,1,f4,0,78,0,21,0,ea,0,79,0,ea,45,4e,44
apsystems-ecu.0
	2022-03-26 08:14:27.581	debug	Ecu.trServiceSM2(evRepeatService) stRealTimeData->stInverterSignalLevel
apsystems-ecu.0
	2022-03-26 08:14:27.581	debug	Ecu.reqService(REAL_TIME_DATA req:APS1100280002216000xxxxxxEND)
apsystems-ecu.0
	2022-03-26 08:14:27.581	debug	Ecu.trServiceSM2(evRepeatService) stRealTimeData->stRealTimeData
apsystems-ecu.0
	2022-03-26 08:14:27.581	debug	Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
apsystems-ecu.0
	2022-03-26 08:14:27.025	debug	Ecu.trConnect() hide=true, ip=192.168.xxx.xxx port=8899
apsystems-ecu.0
	2022-03-26 08:14:27.025	debug	Ecu.ecuStateMachine(evCycleTimer) stWaitForNextCycle -> stWaitForConnect
apsystems-ecu.0
	2022-03-26 08:13:27.025	debug	Ecu.trNextCycle() 60sec delay
apsystems-ecu.0
	2022-03-26 08:13:27.025	debug	Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
apsystems-ecu.0
	2022-03-26 08:13:27.025	debug	Ecu.trDisconnect() - done
apsystems-ecu.0
	2022-03-26 08:13:27.025	debug	Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForDisconnected
apsystems-ecu.0
	2022-03-26 08:13:27.025	debug	Ecu.decodeAndProcessSystemInfo() - version: ECU_R_PRO_2.0.6 - done
apsystems-ecu.0
	2022-03-26 08:13:27.024	debug	Ecu.decodeRsp() 446ms - 41,50,53,31,32,30,31,31,32,30,30,30,31,32,31,36,32,30,30,30,31,33,37,35,33,30,31,0,0,6,50,0,0,1,1e,0,0,0,f,20,22,3,26,8,8,56,0,6,0,3,31,30,30,31,35,45,43,55,5f,52,5f,50,52,4f,5f,32,2e,30,2e,36,30,31,32,45,75,72,6f,70,65,2f,50,61,72,69,73,80,97,1b,2,d0,35,60,c5,a8,7a,22,d5,30,30,0,0,0,0,0,0,0,0,0,0,45,4e,44
apsystems-ecu.0
	2022-03-26 08:13:26.578	debug	Ecu.trServiceSM2(evRepeatService) stSystemInfo->stRealTimeData
apsystems-ecu.0
	2022-03-26 08:13:26.578	debug	Ecu.reqService(SYSTEMINFO req:APS1100160001END)
apsystems-ecu.0
	2022-03-26 08:13:26.578	debug	Ecu.trServiceSM2(evRepeatService/216200013753) stSystemInfo->stSystemInfo
apsystems-ecu.0
	2022-03-26 08:13:26.578	debug	Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
apsystems-ecu.0
	2022-03-26 08:13:26.458	debug	Ecu.trConnect() hide=true, ip=192.168.xxx.xxx port=8899
apsystems-ecu.0
	2022-03-26 08:13:26.457	debug	Ecu.ecuStateMachine(evCycleTimer) stWaitForNextCycle -> stWaitForConnect
apsystems-ecu.0
	2022-03-26 08:12:26.457	debug	Ecu.trNextCycle() 60sec delay
apsystems-ecu.0
	2022-03-26 08:12:26.457	debug	Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
apsystems-ecu.0
	2022-03-26 08:12:26.457	debug	Ecu.trDisconnect() - done
apsystems-ecu.0
	2022-03-26 08:12:26.456	debug	Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForDisconnected
apsystems-ecu.0
	2022-03-26 08:12:26.456	warn	rspWatchDog +++ timeout
apsystems-ecu.0
	2022-03-26 08:12:23.455	debug	Ecu.trServiceSM2(evRepeatService) stEnergyOfYear->stSystemInfo
apsystems-ecu.0
	2022-03-26 08:12:23.455	debug	Ecu.reqService(ENERGY_OF_WMY req:APS1100390004216000xxxxxxEND02END)
apsystems-ecu.0
	2022-03-26 08:12:23.454	debug	Ecu.trServiceSM2(evRepeatService) stEnergyOfYear->stEnergyOfYear
apsystems-ecu.0
	2022-03-26 08:12:23.454	debug	Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
apsystems-ecu.0
	2022-03-26 08:12:23.209	debug	Ecu.trConnect() hide=true, ip=192.168.xxx.xxx port=8899
apsystems-ecu.0
	2022-03-26 08:12:23.209	debug	Ecu.ecuStateMachine(evCycleTimer) stWaitForNextCycle -> stWaitForConnect
apsystems-ecu.0
	2022-03-26 08:11:23.208	debug	Ecu.trNextCycle() 60sec delay
apsystems-ecu.0
	2022-03-26 08:11:23.208	debug	Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
apsystems-ecu.0
	2022-03-26 08:11:23.208	debug	Ecu.trDisconnect() - done
apsystems-ecu.0
	2022-03-26 08:11:23.207	debug	Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForDisconnected
apsystems-ecu.0
	2022-03-26 08:11:23.207	warn	rspWatchDog +++ timeout
apsystems-ecu.0
	2022-03-26 08:11:20.207	debug	Ecu.trServiceSM2(evRepeatService) stEnergyOfMonth->stEnergyOfYear
apsystems-ecu.0
	2022-03-26 08:11:20.207	debug	Ecu.reqService(ENERGY_OF_WMY req:APS1100390004216000xxxxxxEND01END)
apsystems-ecu.0
	2022-03-26 08:11:20.207	debug	Ecu.trServiceSM2(evRepeatService) stEnergyOfMonth->stEnergyOfMonth
apsystems-ecu.0
	2022-03-26 08:11:20.207	debug	Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
apsystems-ecu.0
	2022-03-26 08:11:19.946	debug	Ecu.trConnect() hide=true, ip=192.168.xxx.xxx port=8899
apsystems-ecu.0
	2022-03-26 08:11:19.946	debug	Ecu.ecuStateMachine(evCycleTimer) stWaitForNextCycle -> stWaitForConnect
apsystems-ecu.0
	2022-03-26 08:10:19.946	debug	Ecu.trNextCycle() 60sec delay
apsystems-ecu.0
	2022-03-26 08:10:19.946	debug	Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
apsystems-ecu.0
	2022-03-26 08:10:19.946	debug	Ecu.trDisconnect() - done
apsystems-ecu.0
	2022-03-26 08:10:19.946	debug	Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForDisconnected
apsystems-ecu.0
	2022-03-26 08:10:19.946	warn	rspWatchDog +++ timeout
apsystems-ecu.0
	2022-03-26 08:10:16.945	debug	Ecu.trServiceSM2(recursion) stEnergyOfWeek->stEnergyOfMonth
apsystems-ecu.0
	2022-03-26 08:10:16.945	debug	Ecu.reqService(ENERGY_OF_WMY req:APS1100390004216000xxxxxxEND00END)
apsystems-ecu.0
	2022-03-26 08:10:16.945	debug	Ecu.trServiceSM2(recursion) stEnergyOfWeek->stEnergyOfWeek
apsystems-ecu.0
	2022-03-26 08:10:16.945	debug	Ecu.trServiceSM2(evRepeatService) stPowerOfDay->stEnergyOfWeek
apsystems-ecu.0
	2022-03-26 08:10:16.944	debug	Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
apsystems-ecu.0
	2022-03-26 08:10:16.687	debug	Ecu.trConnect() hide=true, ip=192.168.xxx.xxx port=8899
apsystems-ecu.0
	2022-03-26 08:10:16.686	debug	Ecu.ecuStateMachine(evCycleTimer) stWaitForNextCycle -> stWaitForConnect
apsystems-ecu.0
	2022-03-26 08:09:16.686	debug	Ecu.trNextCycle() 60sec delay
apsystems-ecu.0
	2022-03-26 08:09:16.686	debug	Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
apsystems-ecu.0
	2022-03-26 08:09:16.686	debug	Ecu.trDisconnect() - done
apsystems-ecu.0
	2022-03-26 08:09:16.685	debug	Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForDisconnected
apsystems-ecu.0
	2022-03-26 08:09:16.685	debug	Ecu.decodeAndProcessInverterSignalLevel() - status=00 - done
apsystems-ecu.0
	2022-03-26 08:09:16.685	debug	prefix=undefined i=5 isl.inverterId[i]=703000015029
apsystems-ecu.0
	2022-03-26 08:09:16.685	debug	prefix=undefined i=4 isl.inverterId[i]=703000014489
apsystems-ecu.0
	2022-03-26 08:09:16.685	debug	prefix=undefined i=3 isl.inverterId[i]=806000056773
apsystems-ecu.0
	2022-03-26 08:09:16.685	debug	prefix=qs1_806000055586 i=2 isl.inverterId[i]=806000055586
apsystems-ecu.0
	2022-03-26 08:09:16.685	debug	prefix=undefined i=1 isl.inverterId[i]=806000055796
apsystems-ecu.0
	2022-03-26 08:09:16.685	debug	prefix=qs1_806000058312 i=0 isl.inverterId[i]=806000058312
apsystems-ecu.0
	2022-03-26 08:09:16.684	debug	Ecu.decodeRsp() 319ms - 41,50,53,31,31,30,30,36,30,30,30,33,30,30,30,80,60,0,5,30,30,30,30,30,30,5,57,96,0,80,60,0,5,55,86,d0,80,60,0,5,67,73,0,70,30,0,1,44,89,b7,70,30,0,1,50,29,d6,45,4e,44
apsystems-ecu.0
	2022-03-26 08:09:16.365	debug	Ecu.trServiceSM2(evRepeatService) stInverterSignalLevel->stPowerOfDay
apsystems-ecu.0
	2022-03-26 08:09:16.365	debug	Ecu.reqService(INVERTER_SIGNAL_LEVEL req:APS1100280030216000xxxxxxEND)
apsystems-ecu.0
	2022-03-26 08:09:16.365	debug	Ecu.trServiceSM2(evRepeatService) stInverterSignalLevel->stInverterSignalLevel
apsystems-ecu.0
	2022-03-26 08:09:16.364	debug	Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
apsystems-ecu.0
	2022-03-26 08:09:16.195	debug	Ecu.trConnect() hide=true, ip=192.168.xxx.xxx port=8899
apsystems-ecu.0
	2022-03-26 08:09:16.195	debug	Ecu.ecuStateMachine(evCycleTimer) stWaitForNextCycle -> stWaitForConnect
apsystems-ecu.0
	2022-03-26 08:08:16.247	debug	ecu.createAndSetInverterObjects(qs1,806000055586) - done
apsystems-ecu.0
	2022-03-26 08:08:16.206	debug	ecu.createAndSetInverterObjects(qs1,806000058312) - done
apsystems-ecu.0
	2022-03-26 08:08:16.194	debug	Ecu.trNextCycle() 60sec delay
apsystems-ecu.0
	2022-03-26 08:08:16.194	debug	Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
apsystems-ecu.0
	2022-03-26 08:08:16.194	debug	Ecu.trDisconnect() - done
apsystems-ecu.0
	2022-03-26 08:08:16.194	debug	Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForDisconnected
apsystems-ecu.0
	2022-03-26 08:08:16.194	error	Ecu.decodeAndProcessRealTimeData() - +++ invalid inverter type:64
apsystems-ecu.0
	2022-03-26 08:08:16.193	debug	ecu.decodeAndProcessRealTimeData() only registered - 0 / 806000056773
apsystems-ecu.0
	2022-03-26 08:08:16.193	debug	ecu.decodeAndProcessRealTimeData() only registered - 0 / 806000055796
apsystems-ecu.0
	2022-03-26 08:08:16.192	debug	Ecu.decodeRsp() 298ms - 41,50,53,31,31,30,31,33,35,30,30,30,32,30,30,30,31,0,6,30,30,30,30,30,30,54,80,60,0,5,83,12,1,30,33,1,f4,0,6b,0,18,0,de,0,e,0,f,0,1b,80,60,0,5,57,96,0,30,30,80,60,0,5,55,86,0,30,33,0,0,0,0,0,0,0,0,0,0,0,0,0,0,80,60,0,5,67,73,0,30,30,70,30,0,1,44,89,1,30,31,1,f4,0,75,0,18,0,e9,0,11,0,e9,70,30,0,1,50,29,1,30,31,1,f4,0,78,0,1f,0,eb,0,6e,0,eb,45,4e,44
apsystems-ecu.0
	2022-03-26 08:08:15.894	debug	Ecu.trServiceSM2(evRepeatService) stRealTimeData->stInverterSignalLevel
apsystems-ecu.0
	2022-03-26 08:08:15.894	debug	Ecu.reqService(REAL_TIME_DATA req:APS1100280002216000xxxxxxEND)
apsystems-ecu.0
	2022-03-26 08:08:15.893	debug	Ecu.trServiceSM2(evRepeatService) stRealTimeData->stRealTimeData
apsystems-ecu.0
	2022-03-26 08:08:15.893	debug	Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
apsystems-ecu.0
	2022-03-26 08:08:15.848	debug	Ecu.trConnect() hide=true, ip=192.168.xxx.xxx port=8899
apsystems-ecu.0
	2022-03-26 08:08:15.848	debug	Ecu.ecuStateMachine(evCycleTimer) stWaitForNextCycle -> stWaitForConnect
apsystems-ecu.0
	2022-03-26 08:07:15.847	debug	Ecu.trNextCycle() 60sec delay
apsystems-ecu.0
	2022-03-26 08:07:15.847	debug	Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
apsystems-ecu.0
	2022-03-26 08:07:15.846	debug	Ecu.trDisconnect() - done
apsystems-ecu.0
	2022-03-26 08:07:15.846	debug	Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForDisconnected
apsystems-ecu.0
	2022-03-26 08:07:15.846	debug	Ecu.decodeAndProcessSystemInfo() - version: ECU_R_PRO_2.0.6 - done
apsystems-ecu.0
	2022-03-26 08:07:15.846	debug	Ecu.decodeRsp() 456ms - 41,50,53,31,32,30,31,31,32,30,30,30,31,32,31,36,32,30,30,30,31,33,37,35,33,30,31,0,0,6,50,0,0,1,6,0,0,0,c,20,22,3,26,8,3,56,0,6,0,3,31,30,30,31,35,45,43,55,5f,52,5f,50,52,4f,5f,32,2e,30,2e,36,30,31,32,45,75,72,6f,70,65,2f,50,61,72,69,73,80,97,1b,2,d0,35,60,c5,a8,7a,22,d5,30,30,0,0,0,0,0,0,0,0,0,0,45,4e,44
apsystems-ecu.0
	2022-03-26 08:07:15.390	debug	Ecu.trServiceSM2(evRepeatService) stSystemInfo->stRealTimeData
apsystems-ecu.0
	2022-03-26 08:07:15.390	debug	Ecu.reqService(SYSTEMINFO req:APS1100160001END)
apsystems-ecu.0
	2022-03-26 08:07:15.390	debug	Ecu.trServiceSM2(evRepeatService/216200013753) stSystemInfo->stSystemInfo
apsystems-ecu.0
	2022-03-26 08:07:15.390	debug	Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
apsystems-ecu.0
	2022-03-26 08:07:15.152	debug	Ecu.trConnect() hide=true, ip=192.168.xxx.xxx port=8899
apsystems-ecu.0
	2022-03-26 08:07:15.152	debug	Ecu.ecuStateMachine(evCycleTimer) stWaitForNextCycle -> stWaitForConnect
apsystems-ecu.0
	2022-03-26 08:06:15.151	debug	Ecu.trNextCycle() 60sec delay
apsystems-ecu.0
	2022-03-26 08:06:15.151	debug	Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
apsystems-ecu.0
	2022-03-26 08:06:15.151	debug	Ecu.trDisconnect() - done
apsystems-ecu.0
	2022-03-26 08:06:15.151	debug	Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForDisconnected
apsystems-ecu.0
	2022-03-26 08:06:15.150	warn	rspWatchDog +++ timeout
apsystems-ecu.0
	2022-03-26 08:06:12.150	debug	Ecu.trServiceSM2(evRepeatService) stEnergyOfYear->stSystemInfo
apsystems-ecu.0
	2022-03-26 08:06:12.150	debug	Ecu.reqService(ENERGY_OF_WMY req:APS1100390004216000xxxxxxEND02END)
apsystems-ecu.0
	2022-03-26 08:06:12.149	debug	Ecu.trServiceSM2(evRepeatService) stEnergyOfYear->stEnergyOfYear
apsystems-ecu.0
	2022-03-26 08:06:12.149	debug	Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
apsystems-ecu.0
	2022-03-26 08:06:12.013	debug	Ecu.trConnect() hide=true, ip=192.168.xxx.xxx port=8899
apsystems-ecu.0
	2022-03-26 08:06:12.013	debug	Ecu.ecuStateMachine(evCycleTimer) stWaitForNextCycle -> stWaitForConnect
apsystems-ecu.0
	2022-03-26 08:05:12.012	debug	Ecu.trNextCycle() 60sec delay
apsystems-ecu.0
	2022-03-26 08:05:12.011	debug	Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
apsystems-ecu.0
	2022-03-26 08:05:12.011	debug	Ecu.trDisconnect() - done
apsystems-ecu.0
	2022-03-26 08:05:12.011	debug	Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForDisconnected
apsystems-ecu.0
	2022-03-26 08:05:12.011	warn	rspWatchDog +++ timeout
apsystems-ecu.0
	2022-03-26 08:05:09.010	debug	Ecu.trServiceSM2(evRepeatService) stEnergyOfMonth->stEnergyOfYear
apsystems-ecu.0
	2022-03-26 08:05:09.010	debug	Ecu.reqService(ENERGY_OF_WMY req:APS1100390004216000xxxxxxEND01END)
apsystems-ecu.0
	2022-03-26 08:05:09.009	debug	Ecu.trServiceSM2(evRepeatService) stEnergyOfMonth->stEnergyOfMonth
apsystems-ecu.0
	2022-03-26 08:05:09.009	debug	Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
apsystems-ecu.0
	2022-03-26 08:05:08.460	debug	Ecu.trConnect() hide=true, ip=192.168.xxx.xxx port=8899
apsystems-ecu.0
	2022-03-26 08:05:08.459	debug	Ecu.ecuStateMachine(evCycleTimer) stWaitForNextCycle -> stWaitForConnect
apsystems-ecu.0
	2022-03-26 08:04:08.458	debug	Ecu.trNextCycle() 60sec delay
apsystems-ecu.0
	2022-03-26 08:04:08.458	debug	Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
apsystems-ecu.0
	2022-03-26 08:04:08.458	debug	Ecu.trDisconnect() - done
apsystems-ecu.0
	2022-03-26 08:04:08.457	debug	Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForDisconnected
apsystems-ecu.0
	2022-03-26 08:04:08.456	warn	rspWatchDog +++ timeout
apsystems-ecu.0
	2022-03-26 08:04:05.456	debug	Ecu.trServiceSM2(evRepeatService) stEnergyOfWeek->stEnergyOfMonth
apsystems-ecu.0
	2022-03-26 08:04:05.456	debug	Ecu.reqService(ENERGY_OF_WMY req:APS1100390004216000xxxxxxEND00END)
apsystems-ecu.0
	2022-03-26 08:04:05.456	debug	Ecu.trServiceSM2(evRepeatService) stEnergyOfWeek->stEnergyOfWeek
apsystems-ecu.0
	2022-03-26 08:04:05.456	debug	Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
apsystems-ecu.0
	2022-03-26 08:04:05.293	debug	Ecu.trConnect() hide=true, ip=192.168.xxx.xxx port=8899
apsystems-ecu.0
	2022-03-26 08:04:05.293	debug	Ecu.ecuStateMachine(evCycleTimer) stWaitForNextCycle -> stWaitForConnect
apsystems-ecu.0
	2022-03-26 08:03:05.296	info	state apsystems-ecu.0.ecu.power_of_day_date changed: 2022-03-26 (ack = true)
apsystems-ecu.0
	2022-03-26 08:03:05.296	info	state apsystems-ecu.0.ecu.cmd_power_of_day changed: false (ack = true)
apsystems-ecu.0
	2022-03-26 08:03:05.293	debug	Ecu.trNextCycle() 60sec delay
apsystems-ecu.0
	2022-03-26 08:03:05.292	debug	Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
apsystems-ecu.0
	2022-03-26 08:03:05.292	debug	Ecu.trDisconnect() - done
apsystems-ecu.0
	2022-03-26 08:03:05.292	debug	Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForDisconnected
apsystems-ecu.0
	2022-03-26 08:03:05.292	debug	Ecu.decodeAndProcessPowerOfDay() - status=00 - done
apsystems-ecu.0
	2022-03-26 08:03:05.291	debug	Ecu.decodeRsp() 316ms - 41,50,53,31,31,30,31,31,30,30,30,30,33,30,30,6,10,0,0,30,30,30,30,30,30,0,0,6,25,0,0,6,30,0,0,6,35,0,0,6,40,0,0,6,45,0,9,6,50,0,13,6,55,0,16,7,0,0,19,7,5,0,1b,7,10,0,24,7,15,0,25,7,20,0,2e,7,25,0,41,7,30,0,4f,7,35,0,57,7,40,0,61,7,45,0,6d,7,50,0,8c,7,55,0,cb,8,0,0,ec,45,4e,44
apsystems-ecu.0
	2022-03-26 08:03:04.975	debug	Ecu.trServiceSM2(evRepeatService) stPowerOfDay->stEnergyOfWeek
apsystems-ecu.0
	2022-03-26 08:03:04.975	debug	Ecu.reqService(POWER_OF_DAY req:APS1100390003216000xxxxxxEND20220326END)
apsystems-ecu.0
	2022-03-26 08:03:04.975	debug	Ecu.trServiceSM2(evRepeatService) stPowerOfDay->stPowerOfDay
apsystems-ecu.0
	2022-03-26 08:03:04.975	debug	Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
apsystems-ecu.0
	2022-03-26 08:03:04.806	debug	Ecu.trConnect() hide=true, ip=192.168.xxx.xxx port=8899
apsystems-ecu.0
	2022-03-26 08:03:04.806	debug	Ecu.ecuStateMachine(evCycleTimer) stWaitForNextCycle -> stWaitForConnect
apsystems-ecu.0
	2022-03-26 08:02:04.806	debug	Ecu.trNextCycle() 60sec delay
apsystems-ecu.0
	2022-03-26 08:02:04.806	debug	Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
apsystems-ecu.0
	2022-03-26 08:02:04.806	debug	Ecu.trDisconnect() - done
apsystems-ecu.0
	2022-03-26 08:02:04.806	debug	Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForDisconnected
apsystems-ecu.0
	2022-03-26 08:02:04.806	debug	Ecu.decodeAndProcessInverterSignalLevel() - status=00 - done
apsystems-ecu.0
	2022-03-26 08:02:04.805	debug	prefix=undefined i=5 isl.inverterId[i]=703000015029
apsystems-ecu.0
	2022-03-26 08:02:04.805	debug	prefix=undefined i=4 isl.inverterId[i]=703000014489
apsystems-ecu.0
	2022-03-26 08:02:04.805	debug	prefix=undefined i=3 isl.inverterId[i]=806000056773
apsystems-ecu.0
	2022-03-26 08:02:04.805	debug	prefix=qs1_806000055586 i=2 isl.inverterId[i]=806000055586
apsystems-ecu.0
	2022-03-26 08:02:04.805	debug	prefix=undefined i=1 isl.inverterId[i]=806000055796
apsystems-ecu.0
	2022-03-26 08:02:04.805	debug	prefix=qs1_806000058312 i=0 isl.inverterId[i]=806000058312
apsystems-ecu.0
	2022-03-26 08:02:04.804	debug	Ecu.decodeRsp() 318ms - 41,50,53,31,31,30,30,36,30,30,30,33,30,30,30,80,60,0,5,30,30,30,30,30,30,5,57,96,0,80,60,0,5,55,86,d0,80,60,0,5,67,73,0,70,30,0,1,44,89,d7,70,30,0,1,50,29,d7,45,4e,44
apsystems-ecu.0
	2022-03-26 08:02:04.486	debug	Ecu.trServiceSM2(evRepeatService) stInverterSignalLevel->stPowerOfDay
apsystems-ecu.0
	2022-03-26 08:02:04.486	debug	Ecu.reqService(INVERTER_SIGNAL_LEVEL req:APS1100280030216000xxxxxxEND)
apsystems-ecu.0
	2022-03-26 08:02:04.486	debug	Ecu.trServiceSM2(evRepeatService) stInverterSignalLevel->stInverterSignalLevel
apsystems-ecu.0
	2022-03-26 08:02:04.485	debug	Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
apsystems-ecu.0
	2022-03-26 08:02:04.328	debug	Ecu.trConnect() hide=true, ip=192.168.xxx.xxx port=8899
apsystems-ecu.0
	2022-03-26 08:02:04.328	debug	Ecu.ecuStateMachine(evCycleTimer) stWaitForNextCycle -> stWaitForConnect
apsystems-ecu.0
	2022-03-26 08:01:04.344	debug	ecu.createAndSetInverterObjects(qs1,806000055586) - done
apsystems-ecu.0
	2022-03-26 08:01:04.338	debug	ecu.createAndSetInverterObjects(qs1,806000058312) - done
apsystems-ecu.0
	2022-03-26 08:01:04.327	debug	Ecu.trNextCycle() 60sec delay
apsystems-ecu.0
	2022-03-26 08:01:04.327	debug	Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
apsystems-ecu.0
	2022-03-26 08:01:04.327	debug	Ecu.trDisconnect() - done
apsystems-ecu.0
	2022-03-26 08:01:04.327	debug	Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForDisconnected
apsystems-ecu.0
	2022-03-26 08:01:04.327	error	Ecu.decodeAndProcessRealTimeData() - +++ invalid inverter type:64
apsystems-ecu.0
	2022-03-26 08:01:04.326	debug	ecu.decodeAndProcessRealTimeData() only registered - 0 / 806000056773
apsystems-ecu.0
	2022-03-26 08:01:04.326	debug	ecu.decodeAndProcessRealTimeData() only registered - 0 / 806000055796
apsystems-ecu.0
	2022-03-26 08:01:04.324	debug	Ecu.decodeRsp() 321ms - 41,50,53,31,31,30,31,33,35,30,30,30,32,30,30,30,31,0,6,30,30,30,30,30,30,54,80,60,0,5,83,12,1,30,33,1,f4,0,6a,0,14,0,da,0,c,0,c,0,1d,80,60,0,5,57,96,0,30,30,80,60,0,5,55,86,0,30,33,0,0,0,0,0,0,0,0,0,0,0,0,0,0,80,60,0,5,67,73,0,30,30,70,30,0,1,44,89,1,30,31,1,f4,0,74,0,13,0,e5,0,f,0,e5,70,30,0,1,50,29,1,30,31,1,f4,0,76,0,13,0,e5,0,4d,0,e5,45,4e,44
apsystems-ecu.0
	2022-03-26 08:01:04.003	debug	Ecu.trServiceSM2(evRepeatService) stRealTimeData->stInverterSignalLevel
apsystems-ecu.0
	2022-03-26 08:01:04.003	debug	Ecu.reqService(REAL_TIME_DATA req:APS1100280002216000xxxxxxEND)
apsystems-ecu.0
	2022-03-26 08:01:04.003	debug	Ecu.trServiceSM2(evRepeatService) stRealTimeData->stRealTimeData
apsystems-ecu.0
	2022-03-26 08:01:04.002	debug	Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
apsystems-ecu.0
	2022-03-26 08:01:03.423	debug	Ecu.trConnect() hide=true, ip=192.168.xxx.xxx port=8899
apsystems-ecu.0
	2022-03-26 08:01:03.422	debug	Ecu.ecuStateMachine(evCycleTimer) stWaitForNextCycle -> stWaitForConnect
apsystems-ecu.0
	2022-03-26 08:00:03.422	debug	Ecu.trNextCycle() 60sec delay
apsystems-ecu.0
	2022-03-26 08:00:03.421	debug	Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
apsystems-ecu.0
	2022-03-26 08:00:03.421	debug	Ecu.trDisconnect() - done
apsystems-ecu.0
	2022-03-26 08:00:03.421	debug	Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForDisconnected
apsystems-ecu.0
	2022-03-26 08:00:03.420	debug	Ecu.decodeAndProcessSystemInfo() - version: ECU_R_PRO_2.0.6 - done
apsystems-ecu.0
	2022-03-26 08:00:03.420	debug	Ecu.decodeRsp() 515ms - 41,50,53,31,32,30,31,31,32,30,30,30,31,32,31,36,32,30,30,30,31,33,37,35,33,30,31,0,0,6,50,0,0,0,cb,0,0,0,8,20,22,3,26,7,58,55,0,6,0,3,31,30,30,31,35,45,43,55,5f,52,5f,50,52,4f,5f,32,2e,30,2e,36,30,31,32,45,75,72,6f,70,65,2f,50,61,72,69,73,80,97,1b,2,d0,35,60,c5,a8,7a,22,d5,30,30,0,0,0,0,0,0,0,0,0,0,45,4e,44
apsystems-ecu.0
	2022-03-26 08:00:02.904	debug	Ecu.trServiceSM2(evRepeatService) stSystemInfo->stRealTimeData
apsystems-ecu.0
	2022-03-26 08:00:02.904	debug	Ecu.reqService(SYSTEMINFO req:APS1100160001END)
apsystems-ecu.0
	2022-03-26 08:00:02.904	debug	Ecu.trServiceSM2(evRepeatService/null) stSystemInfo->stSystemInfo
apsystems-ecu.0
	2022-03-26 08:00:02.903	debug	Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
apsystems-ecu.0
	2022-03-26 08:00:02.366	info	state apsystems-ecu.0.ecu.cmd_start_stop changed: true (ack = true)
apsystems-ecu.0
	2022-03-26 08:00:02.364	info	state apsystems-ecu.0.ecu.cmd_start_stop changed: true (ack = false)
apsystems-ecu.0
	2022-03-26 08:00:02.362	info	state apsystems-ecu.0.ecu.power_of_day_date changed: 2022-03-26 (ack = true)
apsystems-ecu.0
	2022-03-26 08:00:02.361	debug	Ecu.trConnect() hide=true, ip=192.168.xxx.xxx port=8899
apsystems-ecu.0
	2022-03-26 08:00:02.361	debug	Ecu.ecuStateMachine(evInit) stWaitForInit -> stWaitForConnect
apsystems-ecu.0
	2022-03-26 08:00:02.360	debug	Ecu.init() - done
apsystems-ecu.0
	2022-03-26 08:00:02.359	info	state apsystems-ecu.0.ecu.cmd_power_of_day changed: true (ack = false)
apsystems-ecu.0
	2022-03-26 08:00:02.358	info	state apsystems-ecu.0.ecu.cmd_energy_of_year changed: true (ack = false)
apsystems-ecu.0
	2022-03-26 08:00:02.356	info	state apsystems-ecu.0.ecu.cmd_energy_of_month changed: true (ack = false)
apsystems-ecu.0
	2022-03-26 08:00:02.353	info	state apsystems-ecu.0.ecu.cmd_energy_of_week changed: true (ack = false)
apsystems-ecu.0
	2022-03-26 08:00:02.343	debug	new scheduleSunSetSunrise() at Sat Mar 26 2022 08:00:02 GMT+0100 (Mitteleuropäische Normalzeit)
apsystems-ecu.0
	2022-03-26 08:00:02.340	debug	sunset at {"hour":18,"minute":51}
apsystems-ecu.0
	2022-03-26 08:00:02.336	debug	sunrise at {"hour":6,"minute":16}
apsystems-ecu.0
	2022-03-26 08:00:02.334	debug	Ecu.createStaticObjects() - done
apsystems-ecu.0
	2022-03-26 08:00:02.261	debug	Schedule restart: */20 4-22 * * *
apsystems-ecu.0
	2022-03-26 08:00:02.252	info	starting. Version 0.2.5 in /opt/iobroker/node_modules/iobroker.apsystems-ecu, node: v14.18.3, js-controller: 3.3.22
apsystems-ecu.0
	2022-03-26 08:00:00.032	info	Terminated (START_IMMEDIATELY_AFTER_STOP): Without reason
apsystems-ecu.0
	2022-03-26 08:00:00.032	info	terminating
apsystems-ecu.0
	2022-03-26 08:00:00.028	debug	Ecu.unload() - done
apsystems-ecu.0
	2022-03-26 08:00:00.028	debug	Ecu.trDisconnect() - done
apsystems-ecu.0
	2022-03-26 08:00:00.028	debug	Ecu.ecuStateMachine(evUnload) stWaitForNextCycle -> stUnload
apsystems-ecu.0
	2022-03-26 08:00:00.027	info	Scheduled restart.