2022-02-12 12:57:58.686  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evCycleTimer) stWaitForNextCycle -> stWaitForConnect
2022-02-12 12:57:58.687  - debug: apsystems-ecu.0 (720) Ecu.trConnect() hide=false, ip=10.0.0.178 port=8899
2022-02-12 12:57:58.694  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
2022-02-12 12:57:58.694  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evRepeatService/216000054025) stSystemInfo->stSystemInfo
2022-02-12 12:57:58.695  - debug: apsystems-ecu.0 (720) Ecu.reqService(SYSTEMINFO req:APS1100160001END)
2022-02-12 12:57:58.715  - debug: apsystems-ecu.0 (720) Ecu.decodeRsp() 19ms - 41,50,53,31,31,30,30,39,34,30,30,30,31,32,31,36,30,30,30,30,35,34,30,32,35,30,31,0,0,50,25,0,0,2,b,0,0,0,9d,d0,d0,d0,d0,d0,d0,d0,0,4,0,4,31,30,30,31,32,45,43,55,5f,52,5f,31,2e,32,2e,31,39,30,30,39,45,74,63,2f,47,4d,54,2d,38,80,97,1b,1,cc,b2,0,0,0,0,0,0,45,4e,44
2022-02-12 12:57:58.716  - debug: apsystems-ecu.0 (720) Ecu.decodeAndProcessSystemInfo() - done
2022-02-12 12:57:58.716  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForResponse
2022-02-12 12:57:58.716  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evNextService) stSystemInfo->stRealTimeData
2022-02-12 12:57:58.717  - debug: apsystems-ecu.0 (720) Ecu.reqService(REAL_TIME_DATA req:APS1100280002216000054025END)
2022-02-12 12:57:58.775  - debug: apsystems-ecu.0 (720) Ecu.decodeRsp() 55ms - 41,50,53,31,31,30,31,31,33,30,30,30,32,30,30,30,31,0,4,20,22,2,12,12,53,49,40,80,0,8,98,23,1,30,31,1,f4,0,6a,0,52,0,e8,0,1d,0,e8,40,80,0,9,50,33,1,30,31,1,f4,0,71,0,83,0,e8,0,81,0,e8,40,80,0,9,47,6,1,30,31,1,f4,0,6c,0,31,0,e7,0,2a,0,e7,40,80,0,12,16,99,1,30,31,1,f4,0,69,0,22,0,e7,0,1b,0,e7,45,4e,44
2022-02-12 12:57:58.778  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForResponse
2022-02-12 12:57:58.778  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evNextService) stRealTimeData->stInverterSignalLevel
2022-02-12 12:57:58.779  - debug: apsystems-ecu.0 (720) Ecu.reqService(INVERTER_SIGNAL_LEVEL req:APS1100280030216000054025END)
2022-02-12 12:57:58.797  - debug: apsystems-ecu.0 (720) Ecu.decodeRsp() 19ms - 41,50,53,31,31,30,30,34,36,30,30,33,30,30,30,40,80,0,8,98,23,b7,40,80,0,9,50,33,bc,40,80,0,9,47,6,bb,40,80,0,12,16,99,b1,45,4e,44
2022-02-12 12:57:58.798  - debug: apsystems-ecu.0 (720) prefix=yc600_408000089823 i=0 isl.inverterId[i]=408000089823
2022-02-12 12:57:58.799  - debug: apsystems-ecu.0 (720) prefix=yc600_408000095033 i=1 isl.inverterId[i]=408000095033
2022-02-12 12:57:58.799  - debug: apsystems-ecu.0 (720) prefix=yc600_408000094706 i=2 isl.inverterId[i]=408000094706
2022-02-12 12:57:58.800  - debug: apsystems-ecu.0 (720) prefix=yc600_408000121699 i=3 isl.inverterId[i]=408000121699
2022-02-12 12:57:58.800  - debug: apsystems-ecu.0 (720) Ecu.decodeAndProcessInverterSignalLevel() - status=00 - done
2022-02-12 12:57:58.801  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForResponse
2022-02-12 12:57:58.802  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evNextService) stInverterSignalLevel->stEnergyOfWeek - recursion
2022-02-12 12:57:58.802  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evRepeatService) stEnergyOfWeek->stEnergyOfYear - recursion
2022-02-12 12:57:58.802  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evNoNextService) stWaitForResponse -> stWaitForDisconnected
2022-02-12 12:57:58.803  - debug: apsystems-ecu.0 (720) Ecu.trDisconnect() - done
2022-02-12 12:57:58.803  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evRepeatService) stEnergyOfYear->stSystemInfo
2022-02-12 12:57:58.806  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
2022-02-12 12:57:58.806  - debug: apsystems-ecu.0 (720) Ecu.trNextCycle() 60sec delay
2022-02-12 12:57:58.995  - debug: apsystems-ecu.0 (720) ecu.createAndSetInverterObjects(yc600,408000089823) - done
2022-02-12 12:57:59.000  - debug: apsystems-ecu.0 (720) ecu.createAndSetInverterObjects(yc600,408000095033) - done
2022-02-12 12:57:59.004  - debug: apsystems-ecu.0 (720) ecu.createAndSetInverterObjects(yc600,408000094706) - done
2022-02-12 12:57:59.054  - debug: apsystems-ecu.0 (720) ecu.createAndSetInverterObjects(yc600,408000121699) - done

2022-02-12 12:58:58.807  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evCycleTimer) stWaitForNextCycle -> stWaitForConnect
2022-02-12 12:58:58.808  - debug: apsystems-ecu.0 (720) Ecu.trConnect() hide=false, ip=10.0.0.178 port=8899
2022-02-12 12:58:58.816  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
2022-02-12 12:58:58.817  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evRepeatService/216000054025) stSystemInfo->stSystemInfo
2022-02-12 12:58:58.817  - debug: apsystems-ecu.0 (720) Ecu.reqService(SYSTEMINFO req:APS1100160001END)
2022-02-12 12:58:58.839  - debug: apsystems-ecu.0 (720) Ecu.decodeRsp() 21ms - 41,50,53,31,31,30,30,39,34,30,30,30,31,32,31,36,30,30,30,30,35,34,30,32,35,30,31,0,0,50,25,0,0,2,b,0,0,0,9d,d0,d0,d0,d0,d0,d0,d0,0,4,0,4,31,30,30,31,32,45,43,55,5f,52,5f,31,2e,32,2e,31,39,30,30,39,45,74,63,2f,47,4d,54,2d,38,80,97,1b,1,cc,b2,0,0,0,0,0,0,45,4e,44
2022-02-12 12:58:58.840  - debug: apsystems-ecu.0 (720) Ecu.decodeAndProcessSystemInfo() - done
2022-02-12 12:58:58.840  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForResponse
2022-02-12 12:58:58.840  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evNextService) stSystemInfo->stRealTimeData
2022-02-12 12:58:58.841  - debug: apsystems-ecu.0 (720) Ecu.reqService(REAL_TIME_DATA req:APS1100280002216000054025END)
2022-02-12 12:58:58.898  - debug: apsystems-ecu.0 (720) Ecu.decodeRsp() 56ms - 41,50,53,31,31,30,31,31,33,30,30,30,32,30,30,30,31,0,4,20,22,2,12,12,53,49,40,80,0,8,98,23,1,30,31,1,f4,0,6a,0,52,0,e8,0,1d,0,e8,40,80,0,9,50,33,1,30,31,1,f4,0,71,0,83,0,e8,0,81,0,e8,40,80,0,9,47,6,1,30,31,1,f4,0,6c,0,31,0,e7,0,2a,0,e7,40,80,0,12,16,99,1,30,31,1,f4,0,69,0,22,0,e7,0,1b,0,e7,45,4e,44
2022-02-12 12:58:58.905  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForResponse
2022-02-12 12:58:58.908  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evNextService) stRealTimeData->stInverterSignalLevel
2022-02-12 12:58:58.910  - debug: apsystems-ecu.0 (720) Ecu.reqService(INVERTER_SIGNAL_LEVEL req:APS1100280030216000054025END)
2022-02-12 12:58:58.927  - debug: apsystems-ecu.0 (720) Ecu.decodeRsp() 18ms - 41,50,53,31,31,30,30,34,36,30,30,33,30,30,30,40,80,0,8,98,23,b7,40,80,0,9,50,33,bc,40,80,0,9,47,6,bb,40,80,0,12,16,99,b1,45,4e,44
2022-02-12 12:58:58.929  - debug: apsystems-ecu.0 (720) prefix=yc600_408000089823 i=0 isl.inverterId[i]=408000089823
2022-02-12 12:58:58.930  - debug: apsystems-ecu.0 (720) prefix=yc600_408000095033 i=1 isl.inverterId[i]=408000095033
2022-02-12 12:58:58.931  - debug: apsystems-ecu.0 (720) prefix=yc600_408000094706 i=2 isl.inverterId[i]=408000094706
2022-02-12 12:58:58.931  - debug: apsystems-ecu.0 (720) prefix=yc600_408000121699 i=3 isl.inverterId[i]=408000121699
2022-02-12 12:58:58.932  - debug: apsystems-ecu.0 (720) Ecu.decodeAndProcessInverterSignalLevel() - status=00 - done
2022-02-12 12:58:58.932  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForResponse
2022-02-12 12:58:58.933  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evNextService) stInverterSignalLevel->stEnergyOfWeek - recursion
2022-02-12 12:58:58.933  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evRepeatService) stEnergyOfWeek->stEnergyOfYear - recursion
2022-02-12 12:58:58.934  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evNoNextService) stWaitForResponse -> stWaitForDisconnected
2022-02-12 12:58:58.934  - debug: apsystems-ecu.0 (720) Ecu.trDisconnect() - done
2022-02-12 12:58:58.935  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evRepeatService) stEnergyOfYear->stSystemInfo
2022-02-12 12:58:58.938  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
2022-02-12 12:58:58.939  - debug: apsystems-ecu.0 (720) Ecu.trNextCycle() 60sec delay
2022-02-12 12:58:59.213  - debug: apsystems-ecu.0 (720) ecu.createAndSetInverterObjects(yc600,408000089823) - done
2022-02-12 12:58:59.217  - debug: apsystems-ecu.0 (720) ecu.createAndSetInverterObjects(yc600,408000095033) - done
2022-02-12 12:58:59.251  - debug: apsystems-ecu.0 (720) ecu.createAndSetInverterObjects(yc600,408000094706) - done
2022-02-12 12:58:59.261  - debug: apsystems-ecu.0 (720) ecu.createAndSetInverterObjects(yc600,408000121699) - done

2022-02-12 12:59:58.940  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evCycleTimer) stWaitForNextCycle -> stWaitForConnect
2022-02-12 12:59:58.941  - debug: apsystems-ecu.0 (720) Ecu.trConnect() hide=false, ip=10.0.0.178 port=8899
2022-02-12 12:59:58.945  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
2022-02-12 12:59:58.945  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evRepeatService/216000054025) stSystemInfo->stSystemInfo
2022-02-12 12:59:58.946  - debug: apsystems-ecu.0 (720) Ecu.reqService(SYSTEMINFO req:APS1100160001END)
2022-02-12 12:59:58.978  - debug: apsystems-ecu.0 (720) Ecu.decodeRsp() 32ms - 41,50,53,31,31,30,30,39,34,30,30,30,31,32,31,36,30,30,30,30,35,34,30,32,35,30,31,0,0,50,26,0,0,2,10,0,0,0,a1,d0,d0,d0,d0,d0,d0,d0,0,4,0,4,31,30,30,31,32,45,43,55,5f,52,5f,31,2e,32,2e,31,39,30,30,39,45,74,63,2f,47,4d,54,2d,38,80,97,1b,1,cc,b2,0,0,0,0,0,0,45,4e,44
2022-02-12 12:59:58.979  - debug: apsystems-ecu.0 (720) Ecu.decodeAndProcessSystemInfo() - done
2022-02-12 12:59:58.979  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForResponse
2022-02-12 12:59:58.979  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evNextService) stSystemInfo->stRealTimeData
2022-02-12 12:59:58.980  - debug: apsystems-ecu.0 (720) Ecu.reqService(REAL_TIME_DATA req:APS1100280002216000054025END)
2022-02-12 12:59:59.041  - debug: apsystems-ecu.0 (720) Ecu.decodeRsp() 60ms - 41,50,53,31,31,30,31,31,33,30,30,30,32,30,30,30,31,0,4,20,22,2,12,12,58,49,40,80,0,8,98,23,1,30,31,1,f4,0,6b,0,59,0,ea,0,1d,0,ea,40,80,0,9,50,33,1,30,31,1,f4,0,71,0,84,0,ea,0,82,0,ea,40,80,0,9,47,6,1,30,31,1,f4,0,6c,0,30,0,e9,0,29,0,e9,40,80,0,12,16,99,1,30,31,1,f4,0,6a,0,21,0,e9,0,1a,0,e9,45,4e,44
2022-02-12 12:59:59.045  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForResponse
2022-02-12 12:59:59.046  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evNextService) stRealTimeData->stInverterSignalLevel
2022-02-12 12:59:59.047  - debug: apsystems-ecu.0 (720) Ecu.reqService(INVERTER_SIGNAL_LEVEL req:APS1100280030216000054025END)
2022-02-12 12:59:59.067  - debug: apsystems-ecu.0 (720) Ecu.decodeRsp() 19ms - 41,50,53,31,31,30,30,34,36,30,30,33,30,30,30,40,80,0,8,98,23,b7,40,80,0,9,50,33,bd,40,80,0,9,47,6,bb,40,80,0,12,16,99,b1,45,4e,44
2022-02-12 12:59:59.068  - debug: apsystems-ecu.0 (720) prefix=yc600_408000089823 i=0 isl.inverterId[i]=408000089823
2022-02-12 12:59:59.068  - debug: apsystems-ecu.0 (720) prefix=yc600_408000095033 i=1 isl.inverterId[i]=408000095033
2022-02-12 12:59:59.069  - debug: apsystems-ecu.0 (720) prefix=yc600_408000094706 i=2 isl.inverterId[i]=408000094706
2022-02-12 12:59:59.070  - debug: apsystems-ecu.0 (720) prefix=yc600_408000121699 i=3 isl.inverterId[i]=408000121699
2022-02-12 12:59:59.070  - debug: apsystems-ecu.0 (720) Ecu.decodeAndProcessInverterSignalLevel() - status=00 - done
2022-02-12 12:59:59.071  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForResponse
2022-02-12 12:59:59.071  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evNextService) stInverterSignalLevel->stEnergyOfWeek - recursion
2022-02-12 12:59:59.071  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evRepeatService) stEnergyOfWeek->stEnergyOfYear - recursion
2022-02-12 12:59:59.071  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evNoNextService) stWaitForResponse -> stWaitForDisconnected
2022-02-12 12:59:59.072  - debug: apsystems-ecu.0 (720) Ecu.trDisconnect() - done
2022-02-12 12:59:59.072  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evRepeatService) stEnergyOfYear->stSystemInfo
2022-02-12 12:59:59.074  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
2022-02-12 12:59:59.074  - debug: apsystems-ecu.0 (720) Ecu.trNextCycle() 60sec delay
2022-02-12 12:59:59.305  - debug: apsystems-ecu.0 (720) ecu.createAndSetInverterObjects(yc600,408000089823) - done
2022-02-12 12:59:59.368  - debug: apsystems-ecu.0 (720) ecu.createAndSetInverterObjects(yc600,408000095033) - done
2022-02-12 12:59:59.370  - debug: apsystems-ecu.0 (720) ecu.createAndSetInverterObjects(yc600,408000094706) - done
2022-02-12 12:59:59.372  - debug: apsystems-ecu.0 (720) ecu.createAndSetInverterObjects(yc600,408000121699) - done

2022-02-12 13:00:59.076  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evCycleTimer) stWaitForNextCycle -> stWaitForConnect
2022-02-12 13:00:59.077  - debug: apsystems-ecu.0 (720) Ecu.trConnect() hide=false, ip=10.0.0.178 port=8899
2022-02-12 13:00:59.081  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
2022-02-12 13:00:59.082  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evRepeatService/216000054025) stSystemInfo->stSystemInfo
2022-02-12 13:00:59.083  - debug: apsystems-ecu.0 (720) Ecu.reqService(SYSTEMINFO req:APS1100160001END)
2022-02-12 13:00:59.102  - debug: apsystems-ecu.0 (720) Ecu.decodeRsp() 20ms - 41,50,53,31,31,30,30,39,34,30,30,30,31,32,31,36,30,30,30,30,35,34,30,32,35,30,31,0,0,50,26,0,0,2,10,0,0,0,a1,d0,d0,d0,d0,d0,d0,d0,0,4,0,4,31,30,30,31,32,45,43,55,5f,52,5f,31,2e,32,2e,31,39,30,30,39,45,74,63,2f,47,4d,54,2d,38,80,97,1b,1,cc,b2,0,0,0,0,0,0,45,4e,44
2022-02-12 13:00:59.104  - debug: apsystems-ecu.0 (720) Ecu.decodeAndProcessSystemInfo() - done
2022-02-12 13:00:59.104  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForResponse
2022-02-12 13:00:59.105  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evNextService) stSystemInfo->stRealTimeData
2022-02-12 13:00:59.106  - debug: apsystems-ecu.0 (720) Ecu.reqService(REAL_TIME_DATA req:APS1100280002216000054025END)
2022-02-12 13:00:59.168  - debug: apsystems-ecu.0 (720) Ecu.decodeRsp() 62ms - 41,50,53,31,31,30,31,31,33,30,30,30,32,30,30,30,31,0,4,20,22,2,12,12,58,49,40,80,0,8,98,23,1,30,31,1,f4,0,6b,0,59,0,ea,0,1d,0,ea,40,80,0,9,50,33,1,30,31,1,f4,0,71,0,84,0,ea,0,82,0,ea,40,80,0,9,47,6,1,30,31,1,f4,0,6c,0,30,0,e9,0,29,0,e9,40,80,0,12,16,99,1,30,31,1,f4,0,6a,0,21,0,e9,0,1a,0,e9,45,4e,44
2022-02-12 13:00:59.176  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForResponse
2022-02-12 13:00:59.176  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evNextService) stRealTimeData->stInverterSignalLevel
2022-02-12 13:00:59.177  - debug: apsystems-ecu.0 (720) Ecu.reqService(INVERTER_SIGNAL_LEVEL req:APS1100280030216000054025END)
2022-02-12 13:00:59.194  - debug: apsystems-ecu.0 (720) Ecu.decodeRsp() 16ms - 41,50,53,31,31,30,30,34,36,30,30,33,30,30,30,40,80,0,8,98,23,b7,40,80,0,9,50,33,bd,40,80,0,9,47,6,bb,40,80,0,12,16,99,b1,45,4e,44
2022-02-12 13:00:59.196  - debug: apsystems-ecu.0 (720) prefix=yc600_408000089823 i=0 isl.inverterId[i]=408000089823
2022-02-12 13:00:59.197  - debug: apsystems-ecu.0 (720) prefix=yc600_408000095033 i=1 isl.inverterId[i]=408000095033
2022-02-12 13:00:59.197  - debug: apsystems-ecu.0 (720) prefix=yc600_408000094706 i=2 isl.inverterId[i]=408000094706
2022-02-12 13:00:59.197  - debug: apsystems-ecu.0 (720) prefix=yc600_408000121699 i=3 isl.inverterId[i]=408000121699
2022-02-12 13:00:59.205  - debug: apsystems-ecu.0 (720) Ecu.decodeAndProcessInverterSignalLevel() - status=00 - done
2022-02-12 13:00:59.206  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForResponse
2022-02-12 13:00:59.206  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evNextService) stInverterSignalLevel->stEnergyOfWeek - recursion
2022-02-12 13:00:59.206  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evRepeatService) stEnergyOfWeek->stEnergyOfYear - recursion
2022-02-12 13:00:59.207  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evNoNextService) stWaitForResponse -> stWaitForDisconnected
2022-02-12 13:00:59.207  - debug: apsystems-ecu.0 (720) Ecu.trDisconnect() - done
2022-02-12 13:00:59.207  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evRepeatService) stEnergyOfYear->stSystemInfo
2022-02-12 13:00:59.208  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
2022-02-12 13:00:59.212  - debug: apsystems-ecu.0 (720) Ecu.trNextCycle() 60sec delay
2022-02-12 13:00:59.467  - debug: apsystems-ecu.0 (720) ecu.createAndSetInverterObjects(yc600,408000089823) - done
2022-02-12 13:00:59.470  - debug: apsystems-ecu.0 (720) ecu.createAndSetInverterObjects(yc600,408000095033) - done
2022-02-12 13:00:59.578  - debug: apsystems-ecu.0 (720) ecu.createAndSetInverterObjects(yc600,408000094706) - done
2022-02-12 13:00:59.581  - debug: apsystems-ecu.0 (720) ecu.createAndSetInverterObjects(yc600,408000121699) - done

2022-02-12 13:01:59.214  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evCycleTimer) stWaitForNextCycle -> stWaitForConnect
2022-02-12 13:01:59.215  - debug: apsystems-ecu.0 (720) Ecu.trConnect() hide=false, ip=10.0.0.178 port=8899
2022-02-12 13:01:59.219  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evConnected) stWaitForConnect -> stWaitForResponse
2022-02-12 13:01:59.219  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evRepeatService/216000054025) stSystemInfo->stSystemInfo
2022-02-12 13:01:59.220  - debug: apsystems-ecu.0 (720) Ecu.reqService(SYSTEMINFO req:APS1100160001END)
2022-02-12 13:01:59.241  - debug: apsystems-ecu.0 (720) Ecu.decodeRsp() 20ms - 41,50,53,31,31,30,30,39,34,30,30,30,31,32,31,36,30,30,30,30,35,34,30,32,35,30,31,0,0,50,26,0,0,2,10,0,0,0,a1,d0,d0,d0,d0,d0,d0,d0,0,4,0,4,31,30,30,31,32,45,43,55,5f,52,5f,31,2e,32,2e,31,39,30,30,39,45,74,63,2f,47,4d,54,2d,38,80,97,1b,1,cc,b2,0,0,0,0,0,0,45,4e,44
2022-02-12 13:01:59.243  - debug: apsystems-ecu.0 (720) Ecu.decodeAndProcessSystemInfo() - done
2022-02-12 13:01:59.243  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForResponse
2022-02-12 13:01:59.244  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evNextService) stSystemInfo->stRealTimeData
2022-02-12 13:01:59.244  - debug: apsystems-ecu.0 (720) Ecu.reqService(REAL_TIME_DATA req:APS1100280002216000054025END)
2022-02-12 13:01:59.306  - debug: apsystems-ecu.0 (720) Ecu.decodeRsp() 61ms - 41,50,53,31,31,30,31,31,33,30,30,30,32,30,30,30,31,0,4,20,22,2,12,12,58,49,40,80,0,8,98,23,1,30,31,1,f4,0,6b,0,59,0,ea,0,1d,0,ea,40,80,0,9,50,33,1,30,31,1,f4,0,71,0,84,0,ea,0,82,0,ea,40,80,0,9,47,6,1,30,31,1,f4,0,6c,0,30,0,e9,0,29,0,e9,40,80,0,12,16,99,1,30,31,1,f4,0,6a,0,21,0,e9,0,1a,0,e9,45,4e,44
2022-02-12 13:01:59.310  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForResponse
2022-02-12 13:01:59.311  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evNextService) stRealTimeData->stInverterSignalLevel
2022-02-12 13:01:59.312  - debug: apsystems-ecu.0 (720) Ecu.reqService(INVERTER_SIGNAL_LEVEL req:APS1100280030216000054025END)
2022-02-12 13:01:59.331  - debug: apsystems-ecu.0 (720) Ecu.decodeRsp() 19ms - 41,50,53,31,31,30,30,34,36,30,30,33,30,30,30,40,80,0,8,98,23,b7,40,80,0,9,50,33,bd,40,80,0,9,47,6,bb,40,80,0,12,16,99,b1,45,4e,44
2022-02-12 13:01:59.332  - debug: apsystems-ecu.0 (720) prefix=yc600_408000089823 i=0 isl.inverterId[i]=408000089823
2022-02-12 13:01:59.333  - debug: apsystems-ecu.0 (720) prefix=yc600_408000095033 i=1 isl.inverterId[i]=408000095033
2022-02-12 13:01:59.334  - debug: apsystems-ecu.0 (720) prefix=yc600_408000094706 i=2 isl.inverterId[i]=408000094706
2022-02-12 13:01:59.334  - debug: apsystems-ecu.0 (720) prefix=yc600_408000121699 i=3 isl.inverterId[i]=408000121699
2022-02-12 13:01:59.335  - debug: apsystems-ecu.0 (720) Ecu.decodeAndProcessInverterSignalLevel() - status=00 - done
2022-02-12 13:01:59.335  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evResponseOk) stWaitForResponse -> stWaitForResponse
2022-02-12 13:01:59.336  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evNextService) stInverterSignalLevel->stEnergyOfWeek - recursion
2022-02-12 13:01:59.336  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evRepeatService) stEnergyOfWeek->stEnergyOfYear - recursion
2022-02-12 13:01:59.337  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evNoNextService) stWaitForResponse -> stWaitForDisconnected
2022-02-12 13:01:59.337  - debug: apsystems-ecu.0 (720) Ecu.trDisconnect() - done
2022-02-12 13:01:59.338  - debug: apsystems-ecu.0 (720) Ecu.trServiceSM(evRepeatService) stEnergyOfYear->stSystemInfo
2022-02-12 13:01:59.338  - debug: apsystems-ecu.0 (720) Ecu.ecuStateMachine(evDisconnected) stWaitForDisconnected -> stWaitForNextCycle
2022-02-12 13:01:59.339  - debug: apsystems-ecu.0 (720) Ecu.trNextCycle() 60sec delay
2022-02-12 13:01:59.537  - debug: apsystems-ecu.0 (720) ecu.createAndSetInverterObjects(yc600,408000089823) - done
2022-02-12 13:01:59.539  - debug: apsystems-ecu.0 (720) ecu.createAndSetInverterObjects(yc600,408000095033) - done
2022-02-12 13:01:59.593  - debug: apsystems-ecu.0 (720) ecu.createAndSetInverterObjects(yc600,408000094706) - done
2022-02-12 13:01:59.613  - debug: apsystems-ecu.0 (720) ecu.createAndSetInverterObjects(yc600,408000121699) - done