I have updated the code. But now facing other issue.
If you see the logs below, I have highlighted required lines. All bulbs are off initially. I set dimmer value to 1. It automatically starts the switch also. Dimmable lights also shown intensity 1. And then it again goes off.
Can you please help me to understand this.
06 09/25/18 10:49:00.101 Device_Variable::m_szValue_set device: 82 service: urn:spectrumkingled-com:serviceId:SpectrumLEDController variable: isOnTimerRunning was: 0 now: 1 #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x75d23520>
50 09/25/18 10:49:00.101 luup_log:82: *******************************************SPECTRUMLEDCONTROLLER: onTimer: final totalSeconds: 300 intervalSeconds: 6 intensity: 50 <0x75d23520>
50 09/25/18 10:49:00.102 luup_log:82: *******************************************SPECTRUMLEDCONTROLLER: onTimer: starting timer for devices: 25 <0x75d23520>
50 09/25/18 10:49:00.103 luup_log:82: *******************************************SPECTRUMLEDCONTROLLER: onTimer: starting timer for devices: 21 <0x75d23520>
50 09/25/18 10:49:01.100 luup_log:82: *******************************************SPECTRUMLEDCONTROLLER: childOnTimer intensity: 1,10:49:00,25 enablePlugin: 1 <0x75d23520>
50 09/25/18 10:49:01.101 luup_log:82: *******************************************SPECTRUMLEDCONTROLLER: setDimmer: deviceId : 25 newLoadLevelTarget:1 <0x75d23520>
08 09/25/18 10:49:01.102 JobHandler_LuaUPnP::HandleActionRequest device: 25 service: urn:upnp-org:serviceId:Dimming1 action: SetLoadLevelTarget <0x75d23520>
08 09/25/18 10:49:01.102 JobHandler_LuaUPnP::HandleActionRequest argument newLoadlevelTarget=1 <0x75d23520>
06 09/25/18 10:49:01.102 Device_Variable::m_szValue_set device: 25 service: urn:upnp-org:serviceId:Dimming1 variable: LoadLevelTarget was: 0 now: 1 #hooks: 0 upnp: 0 skip: 0 v:0x7e7760/NONE duplicate:0 <0x75d23520>
50 09/25/18 10:49:01.104 luup_log:82: *******************************************SPECTRUMLEDCONTROLLER: childOnTimer : deviceId: 25 resultCode: 0 resultString: job: 106 arguments: { “JobID”: “106” } <0x75d23520>
50 09/25/18 10:49:01.105 luup_log:82: *******************************************SPECTRUMLEDCONTROLLER: childOnTimer : deviceId: 25 resultCode: 0 resultString: job: 106 arguments: { “JobID”: “106” } <0x75d23520>
06 09/25/18 10:49:01.380 Device_Variable::m_szValue_set device: 25 service: urn:upnp-org:serviceId:Dimming1 variable: LoadLevelStatus was: 0 now: 1 #hooks: 0 upnp: 0 skip: 0 v:0x7e77c8/NONE duplicate:0 <0x76923520>
06 09/25/18 10:49:01.381 Device_Variable::m_szValue_set device: 25 service: urn:upnp-org:serviceId:SwitchPower1 variable: Status was: 0 now: 1 #hooks: 0 upnp: 0 skip: 0 v:0x7e6ea0/NONE duplicate:0 <0x76923520>
04 09/25/18 10:49:01.382 <0x76923520>
50 09/25/18 10:49:01.407 luup_log:82: *******************************************SPECTRUMLEDCONTROLLER: setOnTimer intensity: 1,10:49:00,25 enablePlugin: 1 <0x75d23520>
50 09/25/18 10:49:01.408 luup_log:82: *******************************************SPECTRUMLEDCONTROLLER: setOnTimer: final totalSeconds: 300 intervalSeconds: 4 intensity: 1 currentDimmerValue: 0 <0x75d23520>
50 09/25/18 10:49:01.408 luup_log:82: *******************************************SPECTRUMLEDCONTROLLER: childOnTimer intensity: 1,10:49:00,21 enablePlugin: 1 <0x75d23520>
50 09/25/18 10:49:01.409 luup_log:82: *******************************************SPECTRUMLEDCONTROLLER: setDimmer: deviceId : 21 newLoadLevelTarget:1 <0x75d23520>
08 09/25/18 10:49:01.409 JobHandler_LuaUPnP::HandleActionRequest device: 21 service: urn:upnp-org:serviceId:Dimming1 action: SetLoadLevelTarget <0x75d23520>
08 09/25/18 10:49:01.420 JobHandler_LuaUPnP::HandleActionRequest argument newLoadlevelTarget=1 <0x75d23520>
06 09/25/18 10:49:01.420 Device_Variable::m_szValue_set device: 21 service: urn:upnp-org:serviceId:Dimming1 variable: LoadLevelTarget was: 0 now: 1 #hooks: 0 upnp: 0 skip: 0 v:0x7e7760/NONE duplicate:0 <0x75d23520>
50 09/25/18 10:49:01.423 luup_log:82: *******************************************SPECTRUMLEDCONTROLLER: childOnTimer : deviceId: 21 resultCode: 0 resultString: job: 107 arguments: { “JobID”: “107” } <0x75d23520>
50 09/25/18 10:49:01.424 luup_log:82: *******************************************SPECTRUMLEDCONTROLLER: childOnTimer : deviceId: 21 resultCode: 0 resultString: job: 107 arguments: { “JobID”: “107” } <0x75d23520>
01 09/25/18 10:49:01.481 got CAN <0x75f23520>
02 09/25/18 10:49:01.481 ZWaveSerial::Send m_iFrameID 958 got a CAN – Dongle is in a bad state. Wait 1 second before continuing to let it try to recover. <0x76323520>
02 09/25/18 10:49:01.920 ZWaveNode::HandlePollUpdate_Basic_Set node 12 device 21 unhandled <0x76923520>
06 09/25/18 10:49:01.980 Device_Variable::m_szValue_set device: 21 service: urn:upnp-org:serviceId:Dimming1 variable: LoadLevelStatus was: 0 now: 1 #hooks: 0 upnp: 0 skip: 0 v:0x7e77c8/NONE duplicate:0 <0x76923520>
06 09/25/18 10:49:01.981 Device_Variable::m_szValue_set device: 21 service: urn:upnp-org:serviceId:SwitchPower1 variable: Status was: 0 now: 1 #hooks: 0 upnp: 0 skip: 0 v:0x7e6ea0/NONE duplicate:0 <0x76923520>
04 09/25/18 10:49:01.982 <0x76923520>
50 09/25/18 10:49:01.983 luup_log:82: *******************************************SPECTRUMLEDCONTROLLER: setOnTimer intensity: 1,10:49:00,21 enablePlugin: 1 <0x75d23520>
50 09/25/18 10:49:01.984 luup_log:82: *******************************************SPECTRUMLEDCONTROLLER: setOnTimer: final totalSeconds: 300 intervalSeconds: 4 intensity: 1 currentDimmerValue: 0 <0x75d23520>
02 09/25/18 10:49:02.101 ZWaveNode::HandlePollUpdate_Basic_Set node 15 device 25 unhandled <0x76923520>
02 09/25/18 10:49:02.510 ZWaveNode::HandlePollUpdate_Basic_Set node 15 device 25 unhandled <0x76923520>
02 09/25/18 10:49:02.780 ZWaveNode::HandlePollUpdate_Basic_Set node 12 device 21 unhandled <0x76923520>
06 09/25/18 10:49:03.300 Device_Variable::m_szValue_set device: 25 service: urn:upnp-org:serviceId:SwitchPower1 variable: Status was: 1 now: 0 #hooks: 0 upnp: 0 skip: 0 v:0x7e6ea0/NONE duplicate:0 <0x76923520>
06 09/25/18 10:49:03.301 Device_Variable::m_szValue_set device: 25 service: urn:upnp-org:serviceId:Dimming1 variable: LoadLevelStatus was: 1 now: 0 #hooks: 0 upnp: 0 skip: 0 v:0x7e77c8/NONE duplicate:0 <0x76923520>
06 09/25/18 10:49:03.570 Device_Variable::m_szValue_set device: 21 service: urn:upnp-org:serviceId:SwitchPower1 variable: Status was: 1 now: 0 #hooks: 0 upnp: 0 skip: 0 v:0x7e6ea0/NONE duplicate:0 <0x76923520>
06 09/25/18 10:49:03.571 Device_Variable::m_szValue_set device: 21 service: urn:upnp-org:serviceId:Dimming1 variable: LoadLevelStatus was: 1 now: 0 #hooks: 0 upnp: 0 skip: 0 v:0x7e77c8/NONE duplicate:0 <0x76923520>
50 09/25/18 10:49:05.101 luup_log:82: *******************************************SPECTRUMLEDCONTROLLER: childOnTimer intensity: 2,10:49:00,25 enablePlugin: 1 <0x75d23520>
50 09/25/18 10:49:05.101 luup_log:82: *******************************************SPECTRUMLEDCONTROLLER: setDimmer: deviceId : 25 newLoadLevelTarget:2 <0x75d23520>
08 09/25/18 10:49:05.102 JobHandler_LuaUPnP::HandleActionRequest device: 25 service: urn:upnp-org:serviceId:Dimming1 action: SetLoadLevelTarget <0x75d23520>
08 09/25/18 10:49:05.102 JobHandler_LuaUPnP::HandleActionRequest argument newLoadlevelTarget=2 <0x75d23520>
06 09/25/18 10:49:05.103 Device_Variable::m_szValue_set device: 25 service: urn:upnp-org:serviceId:Dimming1 variable: LoadLevelTarget was: 1 now: 2 #hooks: 0 upnp: 0 skip: 0 v:0x7e7760/NONE duplicate:0 <0x75d23520>
50 09/25/18 10:49:05.115 luup_log:82: *******************************************SPECTRUMLEDCONTROLLER: childOnTimer : deviceId: 25 resultCode: 0 resultString: job: 108 arguments: { “JobID”: “108” } <0x75d23520>
50 09/25/18 10:49:05.115 luup_log:82: *******************************************SPECTRUMLEDCONTROLLER: childOnTimer : deviceId: 25 resultCode: 0 resultString: job: 108 arguments: { “JobID”: “108” } <0x75d23520>