cw-kid
March 23, 2021, 10:03am
#1
Anyone else noticed recently that they can no longer dim / brighten using the rocker button on your Logitech Harmony remote ?
I can still turn on / off lights using the Home Control buttons on the Harmony remote control handset, but not able to dim / brighten anymore it seems.
Using the Java HA-Bridge version 5.4.0. I can dim the lights fine actually in HA-Bridge web GUI, using the “Test Dim” button.
This is the Vera LUA code used to dim / brighten a light
http://VERA-IP/port_3480/data_request?id=action&output_format=json&DeviceNum=101&serviceId=urn:upnp-org:serviceId:Dimming1&action=SetLoadLevelTarget&newLoadlevelTarget=${intensity.percent}
For those that don’t know, the Java HA-Bridge acts as an emulated Philips Hue bridge which the MyHarmony desktop software is connected to and the Vera devices you have setup in HA-Bridge are then exposed to the Logitech Harmony system and can then be assigned to the Home Control buttons on the the Harmony remote control handsets.
cw-kid
March 23, 2021, 10:54am
#2
This is what I see in the log when using the HA-Bridge web GUI and the “Test Dim” button and when it works OK and the light is dimmed.
JobHandler_LuaUPnP::HandleActionRequest device: 305 service: urn:upnp-org:serviceId:Dimming1 action: SetLoadLevelTarget <0x6c6e7520>
08 03/23/21 10:34:14.765 JobHandler_LuaUPnP::HandleActionRequest argument DeviceNum=305 <0x6c6e7520>
08 03/23/21 10:34:14.766 JobHandler_LuaUPnP::HandleActionRequest argument serviceId=urn:upnp-org:serviceId:Dimming1 <0x6c6e7520>
08 03/23/21 10:34:14.766 JobHandler_LuaUPnP::HandleActionRequest argument action=SetLoadLevelTarget <0x6c6e7520>
08 03/23/21 10:34:14.767 JobHandler_LuaUPnP::HandleActionRequest argument newLoadlevelTarget=45 <0x6c6e7520>
06 03/23/21 10:34:14.778 Device_Variable::m_szValue_set device: 305 service: urn:upnp-org:serviceId:Dimming1 variable: LoadLevelTarget was: 100 now: 45 #hooks: 0 upnp: 0 skip: 0 v:0x10fde08/NONE duplicate:0 <0x6c6e7520>
12 03/23/21 10:34:14.796 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616290958&DataVersion=291354453&Timeout=40&MinimumDelay=0 pMem 0x33f2000/54468608 diff: 42958848 <0x6d2e7520>
12 03/23/21 10:34:14.800 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616290958&DataVersion=291354453&Timeout=40&MinimumDelay=0 pMem 0x33f2000/54468608 diff: 42958848 <0x6bda9520>
12 03/23/21 10:34:14.800 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616290958&DataVersion=291354453&Timeout=40&MinimumDelay=0 pMem 0x33f2000/54468608 diff: 42958848 <0x6c0e7520>
12 03/23/21 10:34:14.936 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616290958&DataVersion=291354453&Timeout=40&MinimumDelay=0 pMem 0x33f2000/54468608 diff: 42958848 <0x6b9a9520>
12 03/23/21 10:34:14.937 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616290958&DataVersion=291354453&Timeout=40&MinimumDelay=0 pMem 0x33f2000/54468608 diff: 42958848 <0x6c4e7520>
12 03/23/21 10:34:14.936 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616290958&DataVersion=291354453&Timeout=40&MinimumDelay=0 pMem 0x33f2000/54468608 diff: 42958848 <0x6d869520>
12 03/23/21 10:34:14.974 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616290958&DataVersion=291354459&Timeout=40&MinimumDelay=0 pMem 0x33f2000/54468608 diff: 42958848 <0x6c2e7520>
12 03/23/21 10:34:15.056 luvd_get_info_data_request starting /data_request?id=lu_status&DataVersion=291354450&MinimumDelay=1000&Timeout=60&LoadTime=1616290958&rand=0.7886275369423175 pMem 0x33f2000/54468608 diff: 42958848 <0x6cae7520>
12 03/23/21 10:34:15.060 luvd_get_info_data_request starting /data_request?id=status&DataVersion=291354455&Timeout=15&MinimumDelay=100&output_format=json&_r=1616495655063 pMem 0x33f2000/54468608 diff: 42958848 <0x6d0e7520>
12 03/23/21 10:34:15.168 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616290958&DataVersion=291354459&Timeout=40&MinimumDelay=0 pMem 0x33f2000/54468608 diff: 42958848 <0x6cee7520>
12 03/23/21 10:34:15.168 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616290958&DataVersion=291354459&Timeout=40&MinimumDelay=0 pMem 0x33f2000/54468608 diff: 42958848 <0x6d669520>
12 03/23/21 10:34:15.264 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616290958&DataVersion=291354459&Timeout=40&MinimumDelay=0 pMem 0x33f2000/54468608 diff: 42958848 <0x6bba9520>
12 03/23/21 10:34:15.374 luvd_get_info_data_request starting /data_request?id=lu_status2&output_format=json&Timeout=60&DataVersion=291354454 pMem 0x33f2000/54468608 diff: 42958848 <0x6c6e7520>
12 03/23/21 10:34:15.422 luvd_get_info_data_request starting /data_request?id=status&DataVersion=291354459&Timeout=15&MinimumDelay=100&output_format=json&_r=1616495655425 pMem 0x33f2000/54468608 diff: 42958848 <0x6d2e7520>
12 03/23/21 10:34:15.584 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616290958&DataVersion=291354459&Timeout=40&MinimumDelay=0 pMem 0x33f2000/54468608 diff: 42958848 <0x6bda9520>
12 03/23/21 10:34:15.584 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616290958&DataVersion=291354459&Timeout=40&MinimumDelay=0 pMem 0x33f2000/54468608 diff: 42958848 <0x6c8e7520>
06 03/23/21 10:34:15.860 Device_Variable::m_szValue_set device: 305 service: urn:upnp-org:serviceId:Dimming1 variable: LoadLevelStatus was: 100 now: 45 #hooks: 2 upnp: 0 skip: 0 v:0x10f04c0/NONE duplicate:0 <0x766da520>
06 03/23/21 10:34:15.861 Device_Variable::m_szValue_set device: 305 service: urn:upnp-org:serviceId:SwitchPower1 variable: Status was: 1 now: 1 #hooks: 0 upnp: 0 skip: 0 v:0x10db580/NONE duplicate:1 <0x766da520>
04 03/23/21 10:34:15.863 <Job ID="8365" Name="Level 45 node 72" Device="305" Created="2021-03-23 10:34:14" Started="2021-03-23 10:34:14" Completed="2021-03-23 10:34:15" Duration="1.81137000" Runtime="1.80058000" Status="Successful" LastNote="SUCCESS! Transmit was OK" Node="72" NodeType="ZWaveMultiEmbedded" NodeDescription="Masterbed Main Light"/> <0x766da520>
12 03/23/21 10:34:15.901
This is what I see in the log when pressing down on the rocker button on the Harmony remote and when it does not work
JobHandler_LuaUPnP::HandleActionRequest device: 305 service: urn:upnp-org:serviceId:SwitchPower1 action: SetTarget <0x6da58520>
08 03/23/21 10:44:44.037 JobHandler_LuaUPnP::HandleActionRequest argument serviceId=urn:upnp-org:serviceId:SwitchPower1 <0x6da58520>
08 03/23/21 10:44:44.037 JobHandler_LuaUPnP::HandleActionRequest argument action=SetTarget <0x6da58520>
08 03/23/21 10:44:44.037 JobHandler_LuaUPnP::HandleActionRequest argument newTargetValue=1 <0x6da58520>
08 03/23/21 10:44:44.037 JobHandler_LuaUPnP::HandleActionRequest argument DeviceNum=305 <0x6da58520>
02 03/23/21 10:44:44.037 JobHandler_LuaUPnP::ConfirmGlobalActionRules replaced binary on with dim 45 <0x6da58520>
06 03/23/21 10:44:44.038 Device_Variable::m_szValue_set device: 305 service: urn:upnp-org:serviceId:Dimming1 variable: LoadLevelTarget was: 45 now: 45 #hooks: 0 upnp: 0 skip: 0 v:0xaade78/NONE duplicate:1 <0x6da58520>
12 03/23/21 10:44:44.047 luvd_get_info_data_request starting /data_request?id=status&DataVersion=496216565&Timeout=15&MinimumDelay=100&output_format=json&_r=1616496284051 pMem 0x2ac1000/44830720 diff: 33816576 <0x6e159520>
12 03/23/21 10:44:44.128 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216565&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6e359520>
12 03/23/21 10:44:44.131 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216565&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d458520>
12 03/23/21 10:44:44.132 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216565&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d258520>
12 03/23/21 10:44:44.143 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216565&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d658520>
12 03/23/21 10:44:44.143 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216565&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d858520>
12 03/23/21 10:44:44.143 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216565&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6cb66520>
12 03/23/21 10:44:44.178 luvd_get_info_data_request starting /data_request?id=action&output_format=json&serviceId=urn:upnp-org:serviceId:SwitchPower1&action=SetTarget&newTargetValue=1&DeviceNum=305 pMem 0x2ac1000/44830720 diff: 33816576 <0x6cf32520>
12 03/23/21 10:44:44.325 luvd_get_info_data_request starting /data_request?id=status&DataVersion=496216569&Timeout=15&MinimumDelay=100&output_format=json&_r=1616496284327 pMem 0x2ac1000/44830720 diff: 33816576 <0x6dc58520>
12 03/23/21 10:44:44.453 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216569&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6da58520>
12 03/23/21 10:44:44.491 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216569&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6c966520>
08 03/23/21 10:44:44.504 JobHandler_LuaUPnP::HandleActionRequest device: 305 service: urn:upnp-org:serviceId:SwitchPower1 action: SetTarget <0x6cf32520>
08 03/23/21 10:44:44.504 JobHandler_LuaUPnP::HandleActionRequest argument serviceId=urn:upnp-org:serviceId:SwitchPower1 <0x6cf32520>
08 03/23/21 10:44:44.504 JobHandler_LuaUPnP::HandleActionRequest argument action=SetTarget <0x6cf32520>
08 03/23/21 10:44:44.505 JobHandler_LuaUPnP::HandleActionRequest argument newTargetValue=1 <0x6cf32520>
08 03/23/21 10:44:44.505 JobHandler_LuaUPnP::HandleActionRequest argument DeviceNum=305 <0x6cf32520>
02 03/23/21 10:44:44.505 JobHandler_LuaUPnP::ConfirmGlobalActionRules replaced binary on with dim 45 <0x6cf32520>
06 03/23/21 10:44:44.505 Device_Variable::m_szValue_set device: 305 service: urn:upnp-org:serviceId:Dimming1 variable: LoadLevelTarget was: 45 now: 45 #hooks: 0 upnp: 0 skip: 0 v:0xaade78/NONE duplicate:1 <0x6cf32520>
12 03/23/21 10:44:44.528 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216569&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6e159520>
01 03/23/21 10:44:44.531 got CAN <0x76284520>
02 03/23/21 10:44:44.531 ZWaveSerial::Send m_iFrameID 170 got a CAN -- Dongle is in a bad state. Wait 1 second before continuing to let it try to recover. <0x76684520>
12 03/23/21 10:44:44.570 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216569&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d858520>
12 03/23/21 10:44:44.609 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216569&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d258520>
12 03/23/21 10:44:44.618 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216569&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d658520>
12 03/23/21 10:44:44.630 luvd_get_info_data_request starting /data_request?id=lu_status2&output_format=json&Timeout=60&DataVersion=496216565 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d458520>
06 03/23/21 10:44:44.917 Device_Variable::m_szValue_set device: 305 service: urn:upnp-org:serviceId:Dimming1 variable: LoadLevelStatus was: 45 now: 45 #hooks: 2 upnp: 0 skip: 0 v:0x10981b8/NONE duplicate:1 <0x76e84520>
06 03/23/21 10:44:44.918 Device_Variable::m_szValue_set device: 305 service: urn:upnp-org:serviceId:SwitchPower1 variable: Status was: 1 now: 1 #hooks: 0 upnp: 0 skip: 0 v:0x1061a18/NONE duplicate:1 <0x76e84520>
04 03/23/21 10:44:44.920 <Job ID="4" Name="Level 45 node 72" Device="305" Created="2021-03-23 10:44:44" Started="2021-03-23 10:44:44" Completed="2021-03-23 10:44:44" Duration="0.880701000" Runtime="0.880174000" Status="Successful" LastNote="SUCCESS! Transmit was OK" Node="72" NodeType="ZWaveMultiEmbedded" NodeDescription="Masterbed Main Light"/> <0x76e84520>
12 03/23/21 10:44:44.937
Or this:
JobHandler_LuaUPnP::HandleActionRequest device: 305 service: urn:upnp-org:serviceId:SwitchPower1 action: SetTarget <0x6cf32520>
08 03/23/21 10:44:44.504 JobHandler_LuaUPnP::HandleActionRequest argument serviceId=urn:upnp-org:serviceId:SwitchPower1 <0x6cf32520>
08 03/23/21 10:44:44.504 JobHandler_LuaUPnP::HandleActionRequest argument action=SetTarget <0x6cf32520>
08 03/23/21 10:44:44.505 JobHandler_LuaUPnP::HandleActionRequest argument newTargetValue=1 <0x6cf32520>
08 03/23/21 10:44:44.505 JobHandler_LuaUPnP::HandleActionRequest argument DeviceNum=305 <0x6cf32520>
02 03/23/21 10:44:44.505 JobHandler_LuaUPnP::ConfirmGlobalActionRules replaced binary on with dim 45 <0x6cf32520>
06 03/23/21 10:44:44.505 Device_Variable::m_szValue_set device: 305 service: urn:upnp-org:serviceId:Dimming1 variable: LoadLevelTarget was: 45 now: 45 #hooks: 0 upnp: 0 skip: 0 v:0xaade78/NONE duplicate:1 <0x6cf32520>
12 03/23/21 10:44:44.528 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216569&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6e159520>
01 03/23/21 10:44:44.531 got CAN <0x76284520>
02 03/23/21 10:44:44.531 ZWaveSerial::Send m_iFrameID 170 got a CAN -- Dongle is in a bad state. Wait 1 second before continuing to let it try to recover. <0x76684520>
12 03/23/21 10:44:44.570 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216569&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d858520>
12 03/23/21 10:44:44.609 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216569&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d258520>
12 03/23/21 10:44:44.618 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216569&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d658520>
12 03/23/21 10:44:44.630 luvd_get_info_data_request starting /data_request?id=lu_status2&output_format=json&Timeout=60&DataVersion=496216565 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d458520>
06 03/23/21 10:44:44.917 Device_Variable::m_szValue_set device: 305 service: urn:upnp-org:serviceId:Dimming1 variable: LoadLevelStatus was: 45 now: 45 #hooks: 2 upnp: 0 skip: 0 v:0x10981b8/NONE duplicate:1 <0x76e84520>
06 03/23/21 10:44:44.918 Device_Variable::m_szValue_set device: 305 service: urn:upnp-org:serviceId:SwitchPower1 variable: Status was: 1 now: 1 #hooks: 0 upnp: 0 skip: 0 v:0x1061a18/NONE duplicate:1 <0x76e84520>
04 03/23/21 10:44:44.920 <Job ID="4" Name="Level 45 node 72" Device="305" Created="2021-03-23 10:44:44" Started="2021-03-23 10:44:44" Completed="2021-03-23 10:44:44" Duration="0.880701000" Runtime="0.880174000" Status="Successful" LastNote="SUCCESS! Transmit was OK" Node="72" NodeType="ZWaveMultiEmbedded" NodeDescription="Masterbed Main Light"/> <0x76e84520>
12 03/23/21 10:44:44.937 luvd_get_info_data_request starting /data_request?id=status&DataVersion=496216571&Timeout=15&MinimumDelay=100&output_format=json&_r=1616496284941 pMem 0x2ac1000/44830720 diff: 33816576 <0x6cb66520>
12 03/23/21 10:44:45.018 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216571&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6cf32520>
12 03/23/21 10:44:45.022 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216571&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6e359520>
12 03/23/21 10:44:45.028 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216571&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d458520>
12 03/23/21 10:44:45.028 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216571&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d658520>
12 03/23/21 10:44:45.031 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216571&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d258520>
12 03/23/21 10:44:45.031 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216571&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6dc58520>
12 03/23/21 10:44:45.133 luvd_get_info_data_request starting /data_request?id=status&DataVersion=496216573&Timeout=15&MinimumDelay=100&output_format=json&_r=1616496285118 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d858520>
12 03/23/21 10:44:45.238 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216573&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6da58520>
06 03/23/21 10:44:45.275 Device_Variable::m_szValue_set device: 679 service: urn:micasaverde-com:serviceId:LightSensor1 variable: CurrentLevel was: 240 now: 220 #hooks: 0 upnp: 0 skip: 0 v:0x12481c8/NONE duplicate:0 <0x76e84520>
12 03/23/21 10:44:45.308 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216573&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6c966520>
12 03/23/21 10:44:45.356 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216573&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6e159520>
12 03/23/21 10:44:45.357 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216573&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6cb66520>
12 03/23/21 10:44:45.371 luvd_get_info_data_request starting /data_request?id=lu_status2&output_format=json&Timeout=60&DataVersion=496216569 pMem 0x2ac1000/44830720 diff: 33816576 <0x6e359520>
12 03/23/21 10:44:45.382 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216573&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d258520>
12 03/23/21 10:44:45.894 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216574&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d458520>
12 03/23/21 10:44:45.998 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216574&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6cf32520>
06 03/23/21 10:44:46.015 Device_Variable::m_szValue_set device: 54 service: urn:futzle-com:serviceId:CurrentCostEnviR1 variable: Time was: 11:01:08 now: 11:01:10 #hooks: 0 upnp: 0 skip: 0 v:0x108e340/NONE duplicate:0 <0x6de58520>
12 03/23/21 10:44:46.048 luvd_get_info_data_request starting /data_request?id=lu_status&DataVersion=496216564&MinimumDelay=1000&Timeout=60&LoadTime=1616496216&rand=0.281841683026375 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d658520>
12 03/23/21 10:44:46.069 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216577&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6da58520>
12 03/23/21 10:44:46.114 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216577&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6cb66520>
12 03/23/21 10:44:46.222 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216578&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d458520>
01 03/23/21 10:44:46.258 got CAN <0x76284520>
01 03/23/21 10:44:46.260 ZWaveSerial::Send m_iFrameID 185 type 0x0 command 0x13 got repeat failure 24 iNumFailedResponse 1 time 71259 start time 70902 wait 2000 m_iSendsWithoutReceive 0 <0x76684520>
12 03/23/21 10:44:46.261 luvd_get_info_data_request starting /data_request?id=status&DataVersion=496216577&Timeout=15&MinimumDelay=100&output_format=json&_r=1616496286264 pMem 0x2ac1000/44830720 diff: 33816576 <0x6c966520>
12 03/23/21 10:44:46.320 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216573&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6e359520>
12 03/23/21 10:44:46.344 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216578&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d258520>
01 03/23/21 10:44:46.488 got CAN <0x76284520>
01 03/23/21 10:44:46.488 ZWaveSerial::Send m_iFrameID 188 type 0x0 command 0x16 got repeat failure 24 iNumFailedResponse 1 time 71488 start time 71274 wait 2000 m_iSendsWithoutReceive 0 <0x76684520>
01 03/23/21 10:44:46.489 ZWaveJobHandler::SendDataAbort failed <0x76684520>
01 03/23/21 10:44:46.489 ZWaveNode::GetNonce node 72 cannot send request, abort (nil) <0x76684520>
01 03/23/21 10:44:46.489 ZWaveNode::EncryptFrame m_iFrameID 184 cannot get nonce node 72 command class 0x26 command 0x1 <0x76684520>
02 03/23/21 10:44:46.489 ZWaveSerial::Send m_iFrameID 184 type 0x0 command 0x13 sent ok - can't encrypt <0x76684520>
01 03/23/21 10:44:46.504 ZWJob_SendData::Run done/fail job job#5 :Level 45 node 72 dev:305 (0x28360f0) N:72 P:35 S:7 Id: 5 took 611 ms method 2 to node 72 command 38/1 failed 5 retries 0 of 5 <0x76684520>
12 03/23/21 10:44:46.509 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216578&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6d858520>
12 03/23/21 10:44:46.573 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216578&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6dc58520>
12 03/23/21 10:44:46.646 luvd_get_info_data_request starting /data_request?id=lu_status2&output_format=json&Timeout=60&DataVersion=496216575 pMem 0x2ac1000/44830720 diff: 33816576 <0x6cf32520>
12 03/23/21 10:44:46.653 luvd_get_info_data_request starting /data_request?id=status2&LoadTime=1616496216&DataVersion=496216581&Timeout=40&MinimumDelay=0 pMem 0x2ac1000/44830720 diff: 33816576 <0x6cb66520>
01 03/23/21 10:44:46.687 got CAN <0x76284520>
01 03/23/21 10:44:46.688 ZWaveSerial::Send m_iFrameID 191 type 0x0 command 0x13 got repeat failure 24 iNumFailedResponse 1 time 71687 start time 71558 wait 2000 m_iSendsWithoutReceive 0 <0x76684520>