Page 1 of 1

Bug or programming fault?

Posted: Saturday 05 August 2017 10:34
by tlpeter
Today suddenly some of my zwave devices turn on suddenly.
This is what i see in the log:

Code: Select all

2017-08-05 10:25:52.961 (Zwave USB) Light/Switch (Woonkamer)
2017-08-05 10:25:53.011 EventSystem: Event triggered: TV_2
2017-08-05 10:25:53.041 OpenZWave: Domoticz has send a Switch command! NodeID: 6 (0x06)
2017-08-05 10:25:53.044 (Zwave USB) Usage (Unknown)
2017-08-05 10:25:53.058 (Zwave USB) General/kWh (Verbruik TV boven)
2017-08-05 10:25:53.071 (Zwave USB) Light/Switch (TV boven)
2017-08-05 10:25:53.335 (Youless) YouLess Meter (Electriciteit Youless)
2017-08-05 10:25:53.522 (Zwave USB) Light/Switch (Eettafel)
2017-08-05 10:25:54.778 (Zwave USB) Light/Switch (Overlooplicht)
2017-08-05 10:25:54.948 dzVents: Info: Handling events for: "Overlooplicht", value: "On"
2017-08-05 10:25:54.948 dzVents: Info: ------ Start internal script: OverloopLichtdz: Device: "Overlooplicht (Zwave USB)", Index: 2217
2017-08-05 10:25:54.948 dzVents: Info: ------ Finished OverloopLichtdz
2017-08-05 10:25:54.950 EventSystem: Script event triggered: /home/pi/domoticz/scripts/dzVents/runtime/dzVents.lua
2017-08-05 10:25:55.424 (Zwave USB) Usage (Unknown)
2017-08-05 10:25:55.434 (Zwave USB) General/kWh (Zonnescherm)
2017-08-05 10:25:55.507 (Zwave USB) General/kWh (kWh Meter)
2017-08-05 10:25:55.534 (Zwave USB) Usage (Unknown)
2017-08-05 10:25:55.545 (Zwave USB) General/kWh (Zonnescherm)
2017-08-05 10:25:55.621 (Zwave USB) Usage (Unknown)
2017-08-05 10:25:55.633 (Zwave USB) General/kWh (Zonnescherm)
2017-08-05 10:25:55.746 (Zwave USB) Usage (Unknown)
2017-08-05 10:25:55.759 (Zwave USB) General/kWh (Zonnescherm)
2017-08-05 10:25:56.126 (Zwave USB) Usage (Unknown)
2017-08-05 10:25:56.138 (Zwave USB) General/kWh (Zonnescherm)
2017-08-05 10:25:58.780 User: Admin initiated a switch command (2209/Zonnescherm/Off)
2017-08-05 10:25:58.781 OpenZWave: Domoticz has send a Switch command!, Level: 0, NodeID: 2 (0x02)
2017-08-05 10:25:58.784 (Zwave USB) Usage (Unknown)
I noticed an event TV_2 which i do not have and all kind of switches turn off while domoticz shows them on.
I am a bit scared of this strange behaviour.
Some switche actions are not even in the log!!
For now i turned on debbugging so that i have more info when it happens again.

Re: Bug or programming fault?

Posted: Saturday 05 August 2017 10:47
by tlpeter
Here is a log with debug on.
It starts when it apparently sees the "overloop" script which is running for several days.
Then it starts to turn on all other zwave devices

Code: Select all

2017-08-05 10:36:24.205 dzVents: Debug: Dumping domoticz data to /home/pi/domoticz/scripts/dzVents//domoticzData.lua
2017-08-05 10:36:24.254 (Zwave USB) Light/Switch (Woonkamer)
2017-08-05 10:36:24.300 (Zwave USB) Usage (Unknown)
2017-08-05 10:36:24.308 (Zwave USB) General/kWh (Zonnescherm)
2017-08-05 10:36:24.365 dzVents: Debug: Event trigger type: device
2017-08-05 10:36:24.410 dzVents: Debug: Found module in /home/pi/domoticz/scripts/dzVents/generated_scripts folder: Keukendz
2017-08-05 10:36:24.410 dzVents: Debug: Found module in /home/pi/domoticz/scripts/dzVents/generated_scripts folder: OverloopLichtdz
2017-08-05 10:36:24.442 dzVents: Debug: Device-adapter found for Overlooplicht: Switch device adapter
2017-08-05 10:36:24.455 dzVents: Debug: Processing device-adapter for Overlooplicht: Switch device adapter
2017-08-05 10:36:24.455 dzVents: Debug: Device-event for: Overlooplicht value: On
2017-08-05 10:36:24.455 dzVents: Debug: Searching for scripts for changed item: Overlooplicht
2017-08-05 10:36:24.455 dzVents: Info: Handling events for: "Overlooplicht", value: "On"
2017-08-05 10:36:24.456 dzVents: Info: ------ Start internal script: OverloopLichtdz: Device: "Overlooplicht (Zwave USB)", Index: 2217
2017-08-05 10:36:24.456 dzVents: Debug: Constructed timed-command: Off
2017-08-05 10:36:24.456 dzVents: Debug: Constructed timed-command: Off AFTER 180
2017-08-05 10:36:24.456 dzVents: Info: ------ Finished OverloopLichtdz
2017-08-05 10:36:24.456 dzVents: Debug: [1] = Overlooplicht: Off AFTER 180
2017-08-05 10:36:24.457 dzVents: Debug: =====================================================
2017-08-05 10:36:24.458 EventSystem: Script event triggered: /home/pi/domoticz/scripts/dzVents/runtime/dzVents.lua
2017-08-05 10:36:24.550 dzVents: Debug: Dumping domoticz data to /home/pi/domoticz/scripts/dzVents//domoticzData.lua
2017-08-05 10:36:24.709 dzVents: Debug: Event trigger type: device
2017-08-05 10:36:24.753 dzVents: Debug: Found module in /home/pi/domoticz/scripts/dzVents/generated_scripts folder: Keukendz
2017-08-05 10:36:24.754 dzVents: Debug: Found module in /home/pi/domoticz/scripts/dzVents/generated_scripts folder: OverloopLichtdz
2017-08-05 10:36:24.787 dzVents: Debug: Device-adapter found for Eettafel: Switch device adapter
2017-08-05 10:36:24.799 dzVents: Debug: Processing device-adapter for Eettafel: Switch device adapter
2017-08-05 10:36:24.799 dzVents: Debug: Device-event for: Eettafel value: On
2017-08-05 10:36:24.799 dzVents: Debug: Searching for scripts for changed item: Eettafel
2017-08-05 10:36:24.890 dzVents: Debug: Dumping domoticz data to /home/pi/domoticz/scripts/dzVents//domoticzData.lua
2017-08-05 10:36:25.049 dzVents: Debug: Event trigger type: device
2017-08-05 10:36:25.091 dzVents: Debug: Found module in /home/pi/domoticz/scripts/dzVents/generated_scripts folder: Keukendz
2017-08-05 10:36:25.091 dzVents: Debug: Found module in /home/pi/domoticz/scripts/dzVents/generated_scripts folder: OverloopLichtdz
2017-08-05 10:36:25.138 dzVents: Debug: Device-event for: Electriciteit Youless value: 110822282;451
2017-08-05 10:36:25.138 dzVents: Debug: Searching for scripts for changed item: Electriciteit Youless
2017-08-05 10:36:26.089 dzVents: Debug: Event trigger type: device
2017-08-05 10:36:26.132 dzVents: Debug: Found module in /home/pi/domoticz/scripts/dzVents/generated_scripts folder: Keukendz
2017-08-05 10:36:26.133 dzVents: Debug: Found module in /home/pi/domoticz/scripts/dzVents/generated_scripts folder: OverloopLichtdz
2017-08-05 10:36:26.168 dzVents: Debug: Device-adapter found for TV boven: Switch device adapter
2017-08-05 10:36:26.182 dzVents: Debug: Processing device-adapter for TV boven: Switch device adapter
2017-08-05 10:36:26.182 dzVents: Debug: Device-event for: TV boven value: Off
2017-08-05 10:36:26.182 dzVents: Debug: Searching for scripts for changed item: TV boven
2017-08-05 10:36:26.187 (Zwave USB) General/kWh (Verbruik aquarium verwarming Peter)
2017-08-05 10:36:26.246 (Zwave USB) Usage (Unknown)
2017-08-05 10:36:26.255 (Zwave USB) General/kWh (Verbruik aquarium verwarming Peter)
2017-08-05 10:36:26.286 dzVents: Debug: Dumping domoticz data to /home/pi/domoticz/scripts/dzVents//domoticzData.lua
2017-08-05 10:36:26.288 (Zwave USB) Usage (Unknown)
2017-08-05 10:36:26.296 (Zwave USB) General/kWh (Verbruik aquarium verwarming Peter)
2017-08-05 10:36:26.442 dzVents: Debug: Event trigger type: device
2017-08-05 10:36:26.485 dzVents: Debug: Found module in /home/pi/domoticz/scripts/dzVents/generated_scripts folder: Keukendz
2017-08-05 10:36:26.485 dzVents: Debug: Found module in /home/pi/domoticz/scripts/dzVents/generated_scripts folder: OverloopLichtdz
2017-08-05 10:36:26.517 dzVents: Debug: Device-adapter found for Woonkamer: Switch device adapter
2017-08-05 10:36:26.530 dzVents: Debug: Processing device-adapter for Woonkamer: Switch device adapter
2017-08-05 10:36:26.530 dzVents: Debug: Device-event for: Woonkamer value: On
2017-08-05 10:36:26.530 dzVents: Debug: Searching for scripts for changed item: Woonkamer
2017-08-05 10:36:26.622 dzVents: Debug: Dumping domoticz data to /home/pi/domoticz/scripts/dzVents//domoticzData.lua
2017-08-05 10:36:26.779 dzVents: Debug: Event trigger type: device
2017-08-05 10:36:26.825 dzVents: Debug: Found module in /home/pi/domoticz/scripts/dzVents/generated_scripts folder: Keukendz
2017-08-05 10:36:26.825 dzVents: Debug: Found module in /home/pi/domoticz/scripts/dzVents/generated_scripts folder: OverloopLichtdz
2017-08-05 10:36:26.846 dzVents: Debug: Device-adapter found for Zonnescherm: kWh device adapter
2017-08-05 10:36:26.872 dzVents: Debug: Processing device-adapter for Zonnescherm: kWh device adapter
2017-08-05 10:36:26.872 dzVents: Debug: Device-event for: Zonnescherm value: Open
2017-08-05 10:36:26.872 dzVents: Debug: Searching for scripts for changed item: Zonnescherm
2017-08-05 10:36:26.963 dzVents: Debug: Dumping domoticz data to /home/pi/domoticz/scripts/dzVents//domoticzData.lua
2017-08-05 10:36:27.120 dzVents: Debug: Event trigger type: device
2017-08-05 10:36:27.163 dzVents: Debug: Found module in /home/pi/domoticz/scripts/dzVents/generated_scripts folder: Keukendz

Re: Bug or programming fault?

Posted: Saturday 05 August 2017 11:07
by tlpeter
Ok, this is not a bug in dzVents for sure although it looked like that :mrgreen:
Somehow within zwave these switches where added to the lifeline of a smoke detector which i pulled the battery from last night as it was acting like it had a dead battery. this smoke detector was still ying around and somehow this morning it triggered this lifeline and turned on all the switches that where in that lifeline.