Problem with ThermostatController

Discussions about RaZberry - Z-Wave board for Raspberry computer
Post Reply
AlphaX2
Posts: 110
Joined: 25 Jul 2015 15:03

Problem with ThermostatController

Post by AlphaX2 »

Hi,

since a few days I have a problem with my heating schedule. It's using "ThermostatController" app and was working for many weeks without any problems, but now it switches the setpoints on the UI, but it seems the signal is never send to the thermostats.

Maybe it's related to the BaseModule update, some days ago? :?:

Because the event view showed an error message I also grabbed the log output:

Code: Select all

[2017-02-16 07:15:00.144] [I] [core] [ThermostatControl-99] Calculating setpoints due to [object Object]
[2017-02-16 07:15:00.190] [I] [core] [ThermostatControl-99] Changing zone 0 to 21
[2017-02-16 07:15:00.193] [I] [core] [ThermostatControl-99] Setting Heizung: Bad to 21
[2017-02-16 07:15:00.223] [I] [core] ---  ZWayVDev_zway_37-0-67-1 performCommand processing: {"0":"exact","1":{"level":21}}
[2017-02-16 07:15:00.224] [D] [zway] SETDATA devices.37.instances.0.commandClasses.67.data.1.setVal = 21.000000
[2017-02-16 07:15:00.224] [D] [zway] Job 0x13 (ThermostatSetPoint Set): removing duplicate
[2017-02-16 07:15:00.224] [D] [zway] Job 0x13 (ThermostatSetPoint Get): removing duplicate
[2017-02-16 07:15:00.227] [I] [core] [ThermostatControl-99] Match Thu Feb 16 2017 07:15:00 GMT+0100 (CET)-Thu Feb 16 2017 14:30:00 GMT+0100 (CET)
[2017-02-16 07:15:00.228] [I] [core] [ThermostatControl-99] Changing zone 1 to 16
[2017-02-16 07:15:00.229] [I] [core] [ThermostatControl-99] Setting Heizung: Marius to 16
[2017-02-16 07:15:00.253] [I] [core] ---  ZWayVDev_zway_46-0-67-1 performCommand processing: {"0":"exact","1":{"level":16}}
[2017-02-16 07:15:00.254] [D] [zway] SETDATA devices.46.instances.0.commandClasses.67.data.1.setVal = 16.000000
[2017-02-16 07:15:00.254] [I] [zway] Adding job: ThermostatSetPoint Set
[2017-02-16 07:15:00.254] [D] [zway] Job 0x13 (ThermostatSetPoint Get): removing duplicate
[2017-02-16 07:15:00.255] [I] [core] [ThermostatControl-99] Setting Heizung: Schreibtisch to 16
[2017-02-16 07:15:00.277] [I] [core] ---  ZWayVDev_zway_18-0-67-1 performCommand processing: {"0":"exact","1":{"level":16}}
[2017-02-16 07:15:00.278] [D] [zway] SETDATA devices.18.instances.0.commandClasses.67.data.1.setVal = 16.000000
[2017-02-16 07:15:00.278] [I] [zway] Adding job: ThermostatSetPoint Set
[2017-02-16 07:15:00.278] [D] [zway] Job 0x13 (ThermostatSetPoint Get): removing duplicate
[2017-02-16 07:15:00.279] [D] [zway] Job 0x13 (ThermostatMode Set): removing duplicate
[2017-02-16 07:15:00.279] [D] [zway] Job 0x13 (ThermostatMode Get): removing duplicate

[2017-02-16 07:15:00.280] [I] [core] [ThermostatControl-99] Changing zone 2 to 21
[2017-02-16 07:15:00.280] [I] [core] [ThermostatControl-99] Setting Heizung: Wohnzimmer to 21
[2017-02-16 07:15:00.325] [I] [core] ---  ZWayVDev_zway_19-0-67-1 performCommand processing: {"0":"exact","1":{"level":21}}
[2017-02-16 07:15:00.325] [D] [zway] SETDATA devices.19.instances.0.commandClasses.67.data.1.setVal = 21.000000
[2017-02-16 07:15:00.325] [D] [zway] Job 0x13 (ThermostatSetPoint Set): removing duplicate
[2017-02-16 07:15:00.325] [D] [zway] Job 0x13 (ThermostatSetPoint Get): removing duplicate
[2017-02-16 07:15:00.326] [I] [zway] Node 19:0 CC ThermostatMode: Thermostat Mode 1 is not supported by device (modemask 0x0)
[2017-02-16 07:15:00.330] [I] [core] Notification: error (module): Error during perform command execution: Error: Invalid argument
[2017-02-16 07:15:00.344] [I] [core] Error: Invalid argument
    at Error (native)
    at t_vDev.(anonymous function).self.controller.devices.create.handler (automation/modules/ZWave/index.js:3356:61)
    at _.extend.performCommand (automation/classes/VirtualDevice.js:295:37)
    at automation/userModules/ThermostatControl/index.js:281:30
    at automation/userModules/BaseModule/index.js:186:9
    at Function._.each._.forEach (automation/lib/underscore.js:144:17)
    at ThermostatControl.BaseModule.processDeviceList (automation/userModules/BaseModule/index.js:174:7)
    at automation/userModules/ThermostatControl/index.js:278:18
    at Function._.each._.forEach (automation/lib/underscore.js:144:17)
    at ThermostatControl.calculateSetpoint (automation/userModules/ThermostatControl/index.js:257:7)
[2017-02-16 07:15:00.370] [I] [core] HK: updated ZWayVDev_zway_37-0-67-1
[2017-02-16 07:15:00.395] [I] [core] HK: updated ZWayVDev_zway_46-0-67-1
[2017-02-16 07:15:00.399] [I] [core] Notification: device-info (device-status): {"dev":"Heizung: Marius","l":"16 °C"}
[2017-02-16 07:15:00.637] [I] [core] HK: updated ZWayVDev_zway_18-0-67-1
[2017-02-16 07:15:00.639] [I] [core] Notification: device-info (device-status): {"dev":"Heizung: Schreibtisch","l":"16 °C"}
[2017-02-16 07:15:00.665] [I] [core] HK: updated ZWayVDev_zway_19-0-67-1
[2017-02-16 07:15:00.709] [I] [core] [BaseModule-144] Set lastLevel to 16 for ZWayVDev_zway_46-0-67-1 (was 21)
[2017-02-16 07:15:00.756] [I] [core] [BaseModule-144] Set lastLevel to 16 for ZWayVDev_zway_18-0-67-1 (was 21)
I hope someone (the app dev) can help?

Thanks in advance.
AlphaX2
Posts: 110
Joined: 25 Jul 2015 15:03

Re: Problem with ThermostatController

Post by AlphaX2 »

FYI: reinstallation of BaseModule und ThermostatController fixed the problem.
AlphaX2
Posts: 110
Joined: 25 Jul 2015 15:03

Re: Problem with ThermostatController

Post by AlphaX2 »

Hi again,

it's a pitty, but I got new problems, but to be sure not clear if it's depending on the ThermostatController app. :?

The thing is: it's switching my modes (e.g. day/night) as it should, also it's changing the values shown on the Z-Way webui AND it's queued, if I'm watching on the expert UI, BUT: it's not executed. For example 8pm day/night switch happend (based on Presence Module). The thermostats were set to 16°C as they should on the UI, but even ~11:30pm they have not changed there values! And strange thing: I can even wake up them (DC13 - button push), but it's not changing the value.

But if I switch the values on the UI it takes normal amount of time to change them, funny thing is: using the day/night switch manually works also as it should. And even more fun: After queued automatically, it sometimes helps to change one thermostat value manually and all queued tasks are executed in the next few min, also worked in today, as should be seen in the log.

This is a part of the log:

Code: Select all

[2017-03-04 20:00:00.368] [I] [core] [Presence-96] Switching on night
[2017-03-04 20:00:00.380] [I] [core] HK: updated Presence_night_96
[2017-03-04 20:00:00.385] [I] [core] Notification: device-info (device-OnOff): {"dev":"Nacht Anwesend","l":"on"}
[2017-03-04 20:00:00.461] [I] [core] [Presence-96] Setting new mode to night (was home)
[2017-03-04 20:00:01.283] [I] [core] [ThermostatControl-148] Calculating setpoints due to night
[2017-03-04 20:00:01.332] [I] [core] [ThermostatControl-148] Changing global setpoint to undefined
[2017-03-04 20:00:01.371] [I] [core] [ThermostatControl-148] Changing zone 0 to 16
[2017-03-04 20:00:01.376] [I] [core] [ThermostatControl-148] Setting Heizung: Marius to 16
[2017-03-04 20:00:01.410] [I] [core] ---  ZWayVDev_zway_46-0-67-1 performCommand processing: {"0":"exact","1":{"level":16}}
[2017-03-04 20:00:01.411] [D] [zway] SETDATA devices.46.instances.0.commandClasses.67.data.1.setVal = 16.000000
[2017-03-04 20:00:01.411] [I] [zway] Adding job: ThermostatSetPoint Set
[2017-03-04 20:00:01.412] [I] [zway] Adding job: ThermostatSetPoint Get
[2017-03-04 20:00:01.413] [I] [core] [ThermostatControl-148] Setting Heizung: Schreibtisch to 16
[2017-03-04 20:00:01.447] [I] [core] ---  ZWayVDev_zway_18-0-67-1 performCommand processing: {"0":"exact","1":{"level":16}}
[2017-03-04 20:00:01.448] [D] [zway] SETDATA devices.18.instances.0.commandClasses.67.data.1.setVal = 16.000000
[2017-03-04 20:00:01.449] [I] [zway] Adding job: ThermostatSetPoint Set
[2017-03-04 20:00:01.449] [I] [zway] Adding job: ThermostatSetPoint Get
[2017-03-04 20:00:01.449] [I] [zway] Adding job: ThermostatMode Set
[2017-03-04 20:00:01.449] [I] [zway] Adding job: ThermostatMode Get
[2017-03-04 20:00:01.451] [I] [core] [ThermostatControl-148] Changing zone 1 to 16
[2017-03-04 20:00:01.452] [I] [core] [ThermostatControl-148] Setting Heizung: Wohnzimmer to 16
[2017-03-04 20:00:01.771] [I] [core] ---  ZWayVDev_zway_19-0-67-1 performCommand processing: {"0":"exact","1":{"level":16}}
[2017-03-04 20:00:01.772] [D] [zway] SETDATA devices.19.instances.0.commandClasses.67.data.1.setVal = 16.000000
[2017-03-04 20:00:01.772] [I] [zway] Adding job: ThermostatSetPoint Set
[2017-03-04 20:00:01.772] [I] [zway] Adding job: ThermostatSetPoint Get
[2017-03-04 20:00:01.773] [I] [core] [ThermostatControl-148] Setting Heizung: Bad to 16
[2017-03-04 20:00:01.805] [I] [core] ---  ZWayVDev_zway_37-0-67-1 performCommand processing: {"0":"exact","1":{"level":16}}
[2017-03-04 20:00:01.806] [D] [zway] SETDATA devices.37.instances.0.commandClasses.67.data.1.setVal = 16.000000
[2017-03-04 20:00:01.806] [I] [zway] Job 0x13 (Wakeup Sleep): Cancelling job: Wakeup Sleep
[2017-03-04 20:00:01.806] [I] [zway] Removing job: Wakeup Sleep
[2017-03-04 20:00:01.807] [I] [zway] Adding job: ThermostatSetPoint Set
[2017-03-04 20:00:01.807] [I] [zway] Adding job: ThermostatSetPoint Get
[2017-03-04 20:00:01.884] [I] [core] ---  histories polled
[2017-03-04 20:00:03.342] [I] [core] [BaseModule-147] Set lastLevel to on for Presence_night_96 (was off)
[2017-03-04 20:00:05.041] [I] [core] HK: updated ZWayVDev_zway_46-0-67-1
[2017-03-04 20:00:05.048] [I] [core] Notification: device-info (device-status): {"dev":"Heizung: Marius","l":"16 °C"}
[2017-03-04 20:00:05.083] [I] [core] HK: updated ZWayVDev_zway_18-0-67-1
[2017-03-04 20:00:05.085] [I] [core] Notification: device-info (device-status): {"dev":"Heizung: Schreibtisch","l":"16 °C"}
[2017-03-04 20:00:05.121] [I] [core] HK: updated ZWayVDev_zway_19-0-67-1
[2017-03-04 20:00:05.123] [I] [core] Notification: device-info (device-status): {"dev":"Heizung: Wohnzimmer","l":"16 °C"}
[2017-03-04 20:00:05.157] [I] [core] HK: updated ZWayVDev_zway_37-0-67-1
[2017-03-04 20:00:05.159] [I] [core] Notification: device-info (device-status): {"dev":"Heizung: Bad","l":"16 °C"}
[2017-03-04 20:00:05.224] [I] [core] [BaseModule-147] Set lastLevel to 16 for ZWayVDev_zway_46-0-67-1 (was 21)
[2017-03-04 20:00:05.288] [I] [core] [BaseModule-147] Set lastLevel to 16 for ZWayVDev_zway_18-0-67-1 (was 21)
[2017-03-04 20:00:05.772] [I] [core] [BaseModule-147] Set lastLevel to 16 for ZWayVDev_zway_19-0-67-1 (was 21)
[2017-03-04 20:00:06.095] [I] [core] [BaseModule-147] Set lastLevel to 16 for ZWayVDev_zway_37-0-67-1 (was 21)
[2017-03-04 20:00:22.121] [D] [zway] Job 0x13: deleted from queue
[2017-03-04 20:05:00.685] [I] [core] ---  histories polled
[2017-03-04 20:10:00.828] [I] [core] ---  histories polled
[2017-03-04 20:15:00.998] [I] [core] ---  histories polled
[2017-03-04 20:20:00.138] [I] [core] ---  histories polled
[2017-03-04 20:25:00.308] [I] [core] ---  histories polled
[2017-03-04 20:30:00.502] [I] [core] ---  histories polled
[2017-03-04 20:35:00.698] [I] [core] ---  histories polled
[2017-03-04 20:40:00.867] [I] [core] ---  histories polled
[2017-03-04 20:42:38.922] [I] [core] HK: updated OpenWeather_140
[2017-03-04 20:45:01.036] [I] [core] ---  histories polled
[2017-03-04 20:50:00.362] [I] [core] ---  histories polled
[2017-03-04 20:55:00.560] [I] [core] ---  histories polled
[2017-03-04 21:00:00.702] [I] [core] ---  histories polled
[2017-03-04 21:05:00.857] [I] [core] ---  histories polled
[2017-03-04 21:10:01.044] [I] [core] ---  histories polled
[2017-03-04 21:15:00.231] [I] [core] ---  histories polled
[2017-03-04 21:20:00.418] [I] [core] ---  histories polled
[2017-03-04 21:25:00.545] [I] [core] ---  histories polled
[2017-03-04 21:30:00.698] [I] [core] ---  histories polled
[2017-03-04 21:35:00.890] [I] [core] ---  histories polled
[2017-03-04 21:40:01.064] [I] [core] ---  histories polled
[2017-03-04 21:42:38.918] [I] [core] HK: updated OpenWeather_140
[2017-03-04 21:42:38.923] [I] [core] Notification: device-info (device-temperature): {"dev":"Dresden","l":"11.3 °C"}
[2017-03-04 21:42:39.898] [I] [core] [BaseModule-147] Set lastLevel to 11.3 for OpenWeather_140 (was 12)
[2017-03-04 21:45:00.189] [I] [core] ---  histories polled
[2017-03-04 21:50:00.313] [I] [core] ---  histories polled
[2017-03-04 21:55:00.477] [I] [core] ---  histories polled
[2017-03-04 22:00:00.639] [I] [core] ---  histories polled
[2017-03-04 22:05:00.829] [I] [core] ---  histories polled
[2017-03-04 22:10:00.964] [I] [core] ---  histories polled
[2017-03-04 22:15:00.123] [I] [core] ---  histories polled
[2017-03-04 22:20:00.280] [I] [core] ---  histories polled
[2017-03-04 22:25:00.437] [I] [core] ---  histories polled
[2017-03-04 22:30:00.646] [I] [core] ---  histories polled
[2017-03-04 22:35:00.776] [I] [core] ---  histories polled
[2017-03-04 22:40:00.932] [I] [core] ---  histories polled
[2017-03-04 22:42:38.986] [I] [core] HK: updated OpenWeather_140
[2017-03-04 22:42:38.990] [I] [core] Notification: device-info (device-temperature): {"dev":"Dresden","l":"10.3 °C"}
[2017-03-04 22:42:39.795] [I] [core] [BaseModule-147] Set lastLevel to 10.3 for OpenWeather_140 (was 11.3)
[2017-03-04 22:45:00.123] [I] [core] ---  histories polled
[2017-03-04 22:50:00.372] [I] [core] ---  histories polled
[2017-03-04 22:55:00.525] [I] [core] ---  histories polled
[2017-03-04 23:00:00.699] [I] [core] ---  histories polled
[2017-03-04 23:05:00.862] [I] [core] ---  histories polled
[2017-03-04 23:10:01.032] [I] [core] ---  histories polled
[2017-03-04 23:15:00.183] [I] [core] ---  histories polled
[2017-03-04 23:20:00.495] [I] [core] ---  histories polled
[2017-03-04 23:25:00.693] [I] [core] ---  histories polled
[2017-03-04 23:26:44.000] [I] [core] ---  ZWayVDev_zway_37-0-67-1 performCommand processing: {"0":"exact","1":{"level":"15"}}
[2017-03-04 23:26:44.001] [D] [zway] SETDATA devices.37.instances.0.commandClasses.67.data.1.setVal = 15.000000
[2017-03-04 23:26:44.001] [I] [zway] Adding job: ThermostatSetPoint Set
[2017-03-04 23:26:44.001] [D] [zway] Job 0x13 (ThermostatSetPoint Get): removing duplicate
[2017-03-04 23:26:44.011] [I] [core] HK: updated ZWayVDev_zway_37-0-67-1
[2017-03-04 23:26:44.016] [I] [core] Notification: device-info (device-status): {"dev":"Heizung: Bad","l":"15 °C"}
[2017-03-04 23:26:44.066] [I] [core] [BaseModule-147] Set lastLevel to 15 for ZWayVDev_zway_37-0-67-1 (was 16)
[2017-03-04 23:26:44.535] [I] [core] ---  ZWayVDev_zway_37-0-67-1 performCommand processing: {"0":"exact","1":{"level":"15.5"}}
[2017-03-04 23:26:44.536] [D] [zway] SETDATA devices.37.instances.0.commandClasses.67.data.1.setVal = 15.500000
[2017-03-04 23:26:44.537] [I] [zway] Adding job: ThermostatSetPoint Set
[2017-03-04 23:26:44.537] [D] [zway] Job 0x13 (ThermostatSetPoint Get): removing duplicate
[2017-03-04 23:26:44.542] [I] [core] HK: updated ZWayVDev_zway_37-0-67-1
[2017-03-04 23:26:44.546] [I] [core] Notification: device-info (device-status): {"dev":"Heizung: Bad","l":"15.5 °C"}
[2017-03-04 23:26:44.925] [I] [core] [BaseModule-147] Set lastLevel to 15.5 for ZWayVDev_zway_37-0-67-1 (was 15)
[2017-03-04 23:26:45.622] [I] [core] ---  ZWayVDev_zway_37-0-67-1 performCommand processing: {"0":"exact","1":{"level":"16"}}
[2017-03-04 23:26:45.622] [D] [zway] SETDATA devices.37.instances.0.commandClasses.67.data.1.setVal = 16.000000
[2017-03-04 23:26:45.623] [D] [zway] Job 0x13 (ThermostatSetPoint Set): removing duplicate
[2017-03-04 23:26:45.623] [D] [zway] Job 0x13 (ThermostatSetPoint Get): removing duplicate
[2017-03-04 23:26:45.627] [I] [core] HK: updated ZWayVDev_zway_37-0-67-1
[2017-03-04 23:26:45.629] [I] [core] Notification: device-info (device-status): {"dev":"Heizung: Bad","l":"16 °C"}
[2017-03-04 23:26:45.686] [I] [core] [BaseModule-147] Set lastLevel to 16 for ZWayVDev_zway_37-0-67-1 (was 15.5)
[2017-03-04 23:26:53.686] [I] [core] ---  ZWayVDev_zway_18-0-67-1 performCommand processing: {"0":"exact","1":{"level":"20"}}
[2017-03-04 23:26:53.687] [D] [zway] SETDATA devices.18.instances.0.commandClasses.67.data.1.setVal = 20.000000
[2017-03-04 23:26:53.688] [I] [zway] Adding job: ThermostatSetPoint Set
[2017-03-04 23:26:53.688] [D] [zway] Job 0x13 (ThermostatSetPoint Get): removing duplicate
[2017-03-04 23:26:53.689] [D] [zway] Job 0x13 (ThermostatMode Set): removing duplicate
[2017-03-04 23:26:53.689] [D] [zway] Job 0x13 (ThermostatMode Get): removing duplicate
[2017-03-04 23:26:53.725] [I] [core] HK: updated ZWayVDev_zway_18-0-67-1
[2017-03-04 23:26:53.730] [I] [core] Notification: device-info (device-status): {"dev":"Heizung: Schreibtisch","l":"20 °C"}
[2017-03-04 23:26:53.806] [I] [core] [BaseModule-147] Set lastLevel to 20 for ZWayVDev_zway_18-0-67-1 (was 16)
[2017-03-04 23:26:53.890] [I] [core] ---  ZWayVDev_zway_18-0-67-1 performCommand processing: {"0":"exact","1":{"level":"14"}}
[2017-03-04 23:26:53.890] [D] [zway] SETDATA devices.18.instances.0.commandClasses.67.data.1.setVal = 14.000000
[2017-03-04 23:26:53.891] [I] [zway] Adding job: ThermostatSetPoint Set
[2017-03-04 23:26:53.891] [D] [zway] Job 0x13 (ThermostatSetPoint Get): removing duplicate
[2017-03-04 23:26:53.892] [D] [zway] Job 0x13 (ThermostatMode Set): removing duplicate
[2017-03-04 23:26:53.892] [D] [zway] Job 0x13 (ThermostatMode Get): removing duplicate
[2017-03-04 23:26:53.910] [I] [core] HK: updated ZWayVDev_zway_18-0-67-1
[2017-03-04 23:26:53.914] [I] [core] Notification: device-info (device-status): {"dev":"Heizung: Schreibtisch","l":"14 °C"}
[2017-03-04 23:26:53.971] [I] [core] [BaseModule-147] Set lastLevel to 14 for ZWayVDev_zway_18-0-67-1 (was 20)
[2017-03-04 23:26:54.761] [I] [core] ---  ZWayVDev_zway_18-0-67-1 performCommand processing: {"0":"exact","1":{"level":"15"}}
[2017-03-04 23:26:54.763] [D] [zway] SETDATA devices.18.instances.0.commandClasses.67.data.1.setVal = 15.000000
[2017-03-04 23:26:54.763] [I] [zway] Adding job: ThermostatSetPoint Set
[2017-03-04 23:26:54.763] [D] [zway] Job 0x13 (ThermostatSetPoint Get): removing duplicate
[2017-03-04 23:26:54.764] [D] [zway] Job 0x13 (ThermostatMode Set): removing duplicate
[2017-03-04 23:26:54.764] [D] [zway] Job 0x13 (ThermostatMode Get): removing duplicate
[2017-03-04 23:26:54.767] [I] [core] HK: updated ZWayVDev_zway_18-0-67-1
[2017-03-04 23:26:54.769] [I] [core] Notification: device-info (device-status): {"dev":"Heizung: Schreibtisch","l":"15 °C"}
[2017-03-04 23:26:54.826] [I] [core] [BaseModule-147] Set lastLevel to 15 for ZWayVDev_zway_18-0-67-1 (was 14)
[2017-03-04 23:26:56.404] [I] [core] ---  ZWayVDev_zway_18-0-67-1 performCommand processing: {"0":"exact","1":{"level":"16"}}
[2017-03-04 23:26:56.405] [D] [zway] SETDATA devices.18.instances.0.commandClasses.67.data.1.setVal = 16.000000
[2017-03-04 23:26:56.405] [D] [zway] Job 0x13 (ThermostatSetPoint Set): removing duplicate
[2017-03-04 23:26:56.406] [D] [zway] Job 0x13 (ThermostatSetPoint Get): removing duplicate
[2017-03-04 23:26:56.406] [D] [zway] Job 0x13 (ThermostatMode Set): removing duplicate
[2017-03-04 23:26:56.407] [D] [zway] Job 0x13 (ThermostatMode Get): removing duplicate
[2017-03-04 23:26:56.410] [I] [core] HK: updated ZWayVDev_zway_18-0-67-1
[2017-03-04 23:26:56.420] [I] [core] Notification: device-info (device-status): {"dev":"Heizung: Schreibtisch","l":"16 °C"}
[2017-03-04 23:26:56.473] [I] [core] [BaseModule-147] Set lastLevel to 16 for ZWayVDev_zway_18-0-67-1 (was 15)
[2017-03-04 23:27:32.853] [I] [core] ---  ZWayVDev_zway_47-0-37 performCommand processing: {"0":"on","1":{}}
[2017-03-04 23:27:32.853] [I] [zway] Adding job: SwitchBinary Set
[2017-03-04 23:27:32.854] [I] [zway] Adding job: SwitchBinary Get
[2017-03-04 23:27:32.855] [D] [zway] SENDING (cb 0x20): ( 01 0E 00 13 2F 07 56 01 25 01 FF 1F 3A 25 20 66 )
[2017-03-04 23:27:32.857] [D] [zway] RECEIVED ACK
[2017-03-04 23:27:32.861] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2017-03-04 23:27:32.861] [D] [zway] SENT ACK
[2017-03-04 23:27:32.861] [D] [zway] Delivered to Z-Wave stack
[2017-03-04 23:27:32.865] [D] [zway] RECEIVED: ( 01 08 00 04 00 29 02 84 07 5B )
[2017-03-04 23:27:32.865] [D] [zway] SENT ACK
[2017-03-04 23:27:32.865] [D] [zway] SETDATA devices.41.data.lastReceived = 0 (0x00000000)
[2017-03-04 23:27:32.865] [I] [zway] Node 41:0 CC Wakeup: Wakeup notification
[2017-03-04 23:27:32.866] [D] [zway] SETDATA devices.41.instances.0.commandClasses.132.data.lastWakeup = 1488666452 (0x58bb3f54)
[2017-03-04 23:27:32.866] [D] [zway] SETDATA devices.41.data.isAwake = True
[2017-03-04 23:27:32.866] [D] [zway] SETDATA devices.41.data.lastSend = 3002834 (0x002dd1d2)
[2017-03-04 23:27:32.866] [D] [zway] SETDATA devices.41.data.lastNonceGet = 3001834 (0x002dcdea)
[2017-03-04 23:27:32.866] [D] [zway] Running wakeup handler for node 41
[2017-03-04 23:27:32.866] [D] [zway] SETDATA devices.41.instances.0.commandClasses.132.data.lastSleep = 1488666452 (0x58bb3f54)
[2017-03-04 23:27:32.866] [I] [zway] Node 41:0 CC Wakeup: Send node to sleep
[2017-03-04 23:27:32.866] [I] [zway] Adding job: Wakeup Sleep
[2017-03-04 23:27:32.875] [D] [zway] RECEIVED: ( 01 08 00 04 00 06 02 98 40 2F )
[2017-03-04 23:27:32.875] [D] [zway] SENT ACK
[2017-03-04 23:27:32.875] [D] [zway] SETDATA devices.6.data.lastReceived = 0 (0x00000000)
[2017-03-04 23:27:32.876] [I] [zway] Node 6:0 CC Security: sending Nonce Report
[2017-03-04 23:27:32.876] [I] [zway] Adding job: Nonce Report
[2017-03-04 23:27:32.885] [D] [zway] RECEIVED: ( 01 22 00 04 00 25 1C 8F 01 06 03 80 03 56 06 43 03 01 42 08 34 04 46 08 00 7F 02 81 05 02 46 04 02 84 07 F5 )
[2017-03-04 23:27:32.885] [D] [zway] SENT ACK
[2017-03-04 23:27:32.886] [D] [zway] SETDATA devices.37.data.lastReceived = 0 (0x00000000)
[2017-03-04 23:27:32.886] [D] [zway] SETDATA devices.37.instances.0.commandClasses.128.data.history.86 = 1488666452 (0x58bb3f54)
[2017-03-04 23:27:32.886] [D] [zway] SETDATA devices.37.instances.0.commandClasses.128.data.last = 86 (0x00000056)
[2017-03-04 23:27:32.886] [D] [zway] SETDATA devices.37.instances.0.commandClasses.67.data.1.size = **********
[2017-03-04 23:27:32.886] [D] [zway] SETDATA devices.37.instances.0.commandClasses.67.data.1.precision = **********
[2017-03-04 23:27:32.886] [D] [zway] SETDATA devices.37.instances.0.commandClasses.67.data.1.deviceScale = 0 (0x00000000)
[2017-03-04 23:27:32.886] [D] [zway] SETDATA devices.37.instances.0.commandClasses.67.data.1.deviceScaleString = "°C"
[2017-03-04 23:27:32.887] [D] [zway] SETDATA devices.37.instances.0.commandClasses.67.data.1.val = 21.000000
[2017-03-04 23:27:32.887] [D] [zway] SETDATA devices.37.instances.0.commandClasses.67.data.1.setVal = 21.000000
[2017-03-04 23:27:32.887] [D] [zway] SETDATA devices.37.instances.0.commandClasses.67.data.1 = Empty
[2017-03-04 23:27:32.887] [D] [zway] SETDATA devices.37.instances.0.commandClasses.70.data.overrideType = 0 (0x00000000)
[2017-03-04 23:27:32.887] [D] [zway] SETDATA devices.37.instances.0.commandClasses.70.data.overrideState = 127 (0x0000007f)
[2017-03-04 23:27:32.887] [D] [zway] SETDATA devices.37.data.isAwake = True
[2017-03-04 23:27:32.887] [I] [zway] Adding job: Clock Report
[2017-03-04 23:27:32.888] [I] [zway] Adding job: Schedule Change Report (schedule change mechanism disabled)
[2017-03-04 23:27:32.888] [I] [zway] Node 37:0 CC Wakeup: Wakeup notification
[2017-03-04 23:27:32.888] [D] [zway] SETDATA devices.37.instances.0.commandClasses.132.data.lastWakeup = 1488666452 (0x58bb3f54)
[2017-03-04 23:27:32.888] [D] [zway] SETDATA devices.37.data.lastSend = 3002836 (0x002dd1d4)
[2017-03-04 23:27:32.888] [D] [zway] SETDATA devices.37.data.lastNonceGet = 3001836 (0x002dcdec)
[2017-03-04 23:27:32.888] [D] [zway] Running wakeup handler for node 37
[2017-03-04 23:27:32.888] [D] [zway] SETDATA devices.37.instances.0.commandClasses.132.data.lastSleep = 1488666452 (0x58bb3f54)
[2017-03-04 23:27:32.888] [I] [zway] Node 37:0 CC Wakeup: Send node to sleep
[2017-03-04 23:27:32.888] [I] [zway] Adding job: Wakeup Sleep
[2017-03-04 23:27:32.898] [I] [core] HK: updated ZWayVDev_zway_37-0-128
[2017-03-04 23:27:32.908] [I] [core] HK: updated BatteryPolling_14
[2017-03-04 23:27:32.925] [D] [zway] RECEIVED: ( 01 07 00 13 20 00 00 06 CD )
[2017-03-04 23:27:32.926] [D] [zway] SENT ACK
[2017-03-04 23:27:32.926] [I] [zway] Job 0x13 (SwitchBinary Set): Delivered
[2017-03-04 23:27:32.926] [D] [zway] SendData Response with callback 0x20 received: received by recipient
[2017-03-04 23:27:32.926] [D] [zway] SETDATA devices.47.data.lastSend = 3002840 (0x002dd1d8)
[2017-03-04 23:27:32.926] [D] [zway] Job 0x13 (SwitchBinary Set): success
[2017-03-04 23:27:32.926] [I] [zway] Removing job: SwitchBinary Set
[2017-03-04 23:27:32.927] [D] [zway] SENDING (cb 0x21): ( 01 11 00 13 06 0A 98 80 89 3A A1 D5 96 7D 05 9C 25 21 58 )
[2017-03-04 23:27:32.935] [D] [zway] RECEIVED ACK
[2017-03-04 23:27:32.935] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2017-03-04 23:27:32.935] [D] [zway] SENT ACK
[2017-03-04 23:27:32.936] [D] [zway] Delivered to Z-Wave stack
[2017-03-04 23:27:32.955] [D] [zway] RECEIVED: ( 01 07 00 13 21 00 00 02 C8 )
[2017-03-04 23:27:32.955] [D] [zway] SENT ACK
[2017-03-04 23:27:32.955] [I] [zway] Job 0x13 (Nonce Report): Delivered
[2017-03-04 23:27:32.955] [D] [zway] SendData Response with callback 0x21 received: received by recipient
[2017-03-04 23:27:32.956] [D] [zway] SETDATA devices.6.data.lastSend = 3002843 (0x002dd1db)
[2017-03-04 23:27:32.956] [D] [zway] Job 0x13 (Nonce Report): success
[2017-03-04 23:27:32.956] [I] [zway] Removing job: Nonce Report
[2017-03-04 23:27:32.956] [I] [zway] Job 0x13 (Wakeup Sleep): Cancelling job: Wakeup Sleep
[2017-03-04 23:27:32.956] [I] [zway] Removing job: Wakeup Sleep
[2017-03-04 23:27:32.956] [I] [zway] Adding job: MultiCmd, ThermostatSetPoint Set, ThermostatSetPoint Set, ThermostatSetPoint Set
[2017-03-04 23:27:32.956] [D] [zway] SETDATA devices.37.instances.0.commandClasses.132.data.lastSleep = 1488666452 (0x58bb3f54)
[2017-03-04 23:27:32.956] [I] [zway] Node 37:0 CC Wakeup: Send node to sleep
[2017-03-04 23:27:32.956] [I] [zway] Adding job: Wakeup Sleep
[2017-03-04 23:27:32.956] [D] [zway] SENDING (cb 0x22): ( 01 1F 00 13 25 18 8F 01 03 06 43 01 01 42 05 DC 06 43 01 01 42 06 0E 06 43 01 01 42 06 40 05 22 F4 )
[2017-03-04 23:27:32.966] [D] [zway] RECEIVED ACK
[2017-03-04 23:27:32.966] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2017-03-04 23:27:32.966] [D] [zway] SENT ACK
[2017-03-04 23:27:32.966] [I] [zway] Job 0x13 (MultiCmd, ThermostatSetPoint Set, ThermostatSetPoint Set, ThermostatSetPoint Set): Response received - transfered to encapsulated jobs
[2017-03-04 23:27:32.966] [D] [zway] Delivered to Z-Wave stack
[2017-03-04 23:27:32.966] [D] [zway] Delivered to Z-Wave stack
[2017-03-04 23:27:32.967] [D] [zway] Delivered to Z-Wave stack
[2017-03-04 23:27:32.967] [D] [zway] Delivered to Z-Wave stack
[2017-03-04 23:27:32.969] [I] [core] HK: updated ZWayVDev_zway_37-0-67-1
[2017-03-04 23:27:32.971] [I] [core] Notification: device-info (device-status): {"dev":"Heizung: Bad","l":"21 °C"}
[2017-03-04 23:27:33.048] [D] [zway] RECEIVED: ( 01 0D 00 04 00 2F 07 25 01 FF 1F 3A 7F 02 5D )
[2017-03-04 23:27:33.049] [D] [zway] SENT ACK
[2017-03-04 23:27:33.049] [D] [zway] SETDATA devices.47.data.lastReceived = 0 (0x00000000)
[2017-03-04 23:27:33.049] [D] [zway] SETDATA devices.1.instances.0.commandClasses.37.data.srcNodeId = 47 (0x0000002f)
[2017-03-04 23:27:33.049] [D] [zway] SETDATA devices.1.instances.0.commandClasses.37.data.srcInstanceId = 0 (0x00000000)
[2017-03-04 23:27:33.049] [D] [zway] SETDATA devices.1.instances.0.commandClasses.37.data.level = True
[2017-03-04 23:27:33.385] [I] [core] [BaseModule-147] Set lastLevel to 21 for ZWayVDev_zway_37-0-67-1 (was 16)
[2017-03-04 23:27:33.649] [D] [zway] RECEIVED: ( 01 0D 00 04 10 2F 07 25 01 FF 1F 3A 7F 02 4D )
[2017-03-04 23:27:33.649] [D] [zway] SENT ACK
[2017-03-04 23:27:33.649] [D] [zway] SETDATA devices.47.data.lastReceived = 0 (0x00000000)
[2017-03-04 23:27:33.649] [D] [zway] SETDATA devices.1.instances.0.commandClasses.37.data.srcNodeId = 47 (0x0000002f)
[2017-03-04 23:27:33.649] [D] [zway] SETDATA devices.1.instances.0.commandClasses.37.data.srcInstanceId = 0 (0x00000000)
[2017-03-04 23:27:33.650] [D] [zway] SETDATA devices.1.instances.0.commandClasses.37.data.level = True
[2017-03-04 23:27:33.781] [D] [zway] RECEIVED: ( 01 0D 00 04 10 2F 07 25 01 FF 1F 3A 7F 02 4D )
[2017-03-04 23:27:33.781] [D] [zway] SENT ACK
[2017-03-04 23:27:33.781] [D] [zway] SETDATA devices.47.data.lastReceived = 0 (0x00000000)
[2017-03-04 23:27:33.782] [D] [zway] SETDATA devices.1.instances.0.commandClasses.37.data.srcNodeId = 47 (0x0000002f)
[2017-03-04 23:27:33.782] [D] [zway] SETDATA devices.1.instances.0.commandClasses.37.data.srcInstanceId = 0 (0x00000000)
[2017-03-04 23:27:33.782] [D] [zway] SETDATA devices.1.instances.0.commandClasses.37.data.level = True
[2017-03-04 23:27:35.310] [D] [zway] RECEIVED: ( 01 07 00 13 22 01 00 EA 22 )
[2017-03-04 23:27:35.311] [D] [zway] SENT ACK
[2017-03-04 23:27:35.311] [I] [zway] Job 0x13 (MultiCmd, ThermostatSetPoint Set, ThermostatSetPoint Set, ThermostatSetPoint Set): Callback received - transfered to encapsulated jobs
[2017-03-04 23:27:35.311] [I] [zway] Job 0x13 (ThermostatSetPoint Set): Not delivered to recipient
[2017-03-04 23:27:35.311] [I] [zway] Job 0x13 (ThermostatSetPoint Set): Not delivered to recipient
[2017-03-04 23:27:35.311] [I] [zway] Job 0x13 (ThermostatSetPoint Set): Not delivered to recipient
[2017-03-04 23:27:35.311] [I] [zway] Job 0x13 (MultiCmd, ThermostatSetPoint Set, ThermostatSetPoint Set, ThermostatSetPoint Set): Not delivered to recipient
[2017-03-04 23:27:35.312] [D] [zway] SETDATA devices.37.data.isAwake = False
[2017-03-04 23:27:35.312] [D] [zway] Sending the queue for node 37 into sleep
[2017-03-04 23:27:35.312] [D] [zway] SENDING (cb 0x23): ( 01 0D 00 13 2F 06 56 01 25 02 B2 D3 25 23 DF )
[2017-03-04 23:27:35.320] [D] [zway] RECEIVED ACK
[2017-03-04 23:27:35.320] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2017-03-04 23:27:35.321] [D] [zway] SENT ACK
[2017-03-04 23:27:35.321] [D] [zway] Delivered to Z-Wave stack
[2017-03-04 23:27:35.433] [D] [zway] RECEIVED: ( 01 07 00 13 23 00 00 0B C3 )
The major problem here is: I'm not sure whats wrong with my RaZBerry/Z-Way Combo - there are a few things^^. At the moment I was facing regular crashes around 3am in the morning - see other thread, with atm unclear cause. I also upgraded the Firmware to 5.07 some days ago. But got also the problem with SDK-Version showing up.

Maybe someone comes up with any idea?! :D
Post Reply