Hi,
It looks like my openhab installation restarts every night at nearly the same time.
I put a logInfo “System started” into a rule under System started. This entry is then found within openhab.log… I get crazy why…
Since I am not remember myself to implement such, I tried to find the reason but cannot.
It looks like there is no cron job in place…
Is anyone able to put me in the right direction?
Thanks a lot!
BTW: I unfortunately haven´t found anything in searches so far which address this behavior. May I used the wrong phrases.
provide the openhab.log otherwise we have nothing to look at.
sure…
openhab.log
2020-04-24 02:25:48.702 [INFO ] [clipse.smarthome.model.script.System] -
2020-04-24 02:25:55.155 [INFO ] [clipse.smarthome.model.script.System] - System hat rebooted!!!!!
2020-04-24 02:25:55.166 [INFO ] [clipse.smarthome.model.script.System] -
2020-04-24 02:25:55.178 [ERROR] [ntime.internal.engine.RuleEngineImpl] - Error during the execution of startup rule 'heat_init': Could not invoke method: org.eclipse.xtext.xbase.lib.IntegerExtensions.operator_lessEqualsThan(int,int) on instance: null
2020-04-24 02:25:55.185 [INFO ] [lipse.smarthome.io.net.exec.ExecUtil] - executed commandLine '/bin/touch /etc/openhab2/misc/exec.whitelist'
2020-04-24 02:28:48.705 [INFO ] [se.smarthome.model.script.AstroRules] - --> astro init
and the events.log for the same time
2020-04-24 02:24:55.551 [vent.ItemStateChangedEvent] - CPUTEMPRaw changed from 49.173 to 50.147
2020-04-24 02:24:55.563 [vent.ItemStateChangedEvent] - CPUTEMPLastExecution changed from 2020-04-24T02:23:55.498+0200 to 2020-04-24T02:24:55.547+0200
2020-04-24 02:25:18.018 [vent.ItemStateChangedEvent] - CurrentDate changed from 2020-04-24T02:24:17.994+0200 to 2020-04-24T02:25:17.998+0200
2020-04-24 02:25:21.662 [me.event.ThingUpdatedEvent] - Thing 'zwave:device:Razberry1:node5' has been updated.
2020-04-24 02:25:23.162 [me.event.ThingUpdatedEvent] - Thing 'zwave:device:Razberry1:node8' has been updated.
2020-04-24 02:25:26.209 [me.event.ThingUpdatedEvent] - Thing 'zwave:device:Razberry1:node5' has been updated.
2020-04-24 02:25:27.723 [me.event.ThingUpdatedEvent] - Thing 'zwave:device:Razberry1:node8' has been updated.
2020-04-24 02:25:29.244 [me.event.ThingUpdatedEvent] - Thing 'zwave:device:Razberry1:node13' has been updated.
2020-04-24 02:25:40.740 [vent.ItemStateChangedEvent] - Kube4_Humidity changed from 26.7 to 26.8
2020-04-24 02:25:45.710 [me.event.ThingUpdatedEvent] - Thing 'zwave:device:Razberry1:node14' has been updated.
2020-04-24 02:25:45.761 [me.event.ThingUpdatedEvent] - Thing 'zwave:device:Razberry1:node10' has been updated.
2020-04-24 02:25:48.706 [ome.event.ItemCommandEvent] - Item 'Schalter_Heizdeckenautomatik' received command OFF
2020-04-24 02:25:49.837 [ome.event.ItemCommandEvent] - Item 'Global_heat_swi' received command ON
2020-04-24 02:25:49.841 [ome.event.ItemCommandEvent] - Item 'Bad_E_Heat_Auto' received command OFF
2020-04-24 02:25:54.300 [me.event.ThingUpdatedEvent] - Thing 'zwave:device:Razberry1:node4' has been updated.
2020-04-24 02:25:55.168 [ome.event.ItemCommandEvent] - Item 'g_heat_on_man' received command OFF
2020-04-24 02:25:55.174 [ome.event.ItemCommandEvent] - Item 'vS_HeatShower' received command OFF
2020-04-24 02:25:55.177 [ome.event.ItemCommandEvent] - Item 'E1_heat_swi_all' received command ON
2020-04-24 02:25:55.190 [ome.event.ItemCommandEvent] - Item 'vS_HeatHBadE' received command OFF
2020-04-24 02:25:55.215 [ome.event.ItemCommandEvent] - Item 'Bad_heat_on_man' received command OFF
2020-04-24 02:25:55.220 [ome.event.ItemCommandEvent] - Item 'GWZ_heat_on_man' received command OFF
2020-04-24 02:25:55.223 [ome.event.ItemCommandEvent] - Item 'GBad_heat_on_man' received command OFF
2020-04-24 02:25:55.226 [ome.event.ItemCommandEvent] - Item 'GZ_heat_on_man' received command OFF
2020-04-24 02:25:55.232 [ome.event.ItemCommandEvent] - Item 'vS_Shade1OBad' received command Astro
2020-04-24 02:25:55.235 [ome.event.ItemCommandEvent] - Item 'vS_ShadeEGWZgF' received command Astro
2020-04-24 02:25:55.238 [ome.event.ItemCommandEvent] - Item 'vS_Shade2O' received command Astro
2020-04-24 02:25:55.241 [ome.event.ItemCommandEvent] - Item 'vS_ShadeEWWZF' received command Astro
2020-04-24 02:25:55.245 [ome.event.ItemCommandEvent] - Item 'vS_ShadeEWWZT' received command Astro
2020-04-24 02:25:55.248 [ome.event.ItemCommandEvent] - Item 'vS_DayShading' received command ON
2020-04-24 02:25:55.264 [ome.event.ItemCommandEvent] - Item 'Sprinkler_Relais1' received command OFF
2020-04-24 02:25:55.290 [ome.event.ItemCommandEvent] - Item 'Sprinkler_Relais2' received command OFF
2020-04-24 02:25:55.302 [ome.event.ItemCommandEvent] - Item 'Sprinkler_Relais3' received command OFF
2020-04-24 02:25:55.314 [ome.event.ItemCommandEvent] - Item 'Sprinkler_Relais4' received command OFF
2020-04-24 02:25:55.331 [ome.event.ItemCommandEvent] - Item 'Sprinkler_Relais5' received command OFF
2020-04-24 02:25:55.349 [ome.event.ItemCommandEvent] - Item 'Sprinkler_Relais6' received command OFF
2020-04-24 02:25:55.351 [vent.ItemStateChangedEvent] - E1_heat_swi_all changed from OFF to ON
2020-04-24 02:25:55.369 [ome.event.ItemCommandEvent] - Item 'Sprinkler_Relais7' received command OFF
2020-04-24 02:25:55.375 [vent.ItemStateChangedEvent] - vS_HeatHBadE changed from ON to OFF
2020-04-24 02:25:55.399 [ome.event.ItemCommandEvent] - Item 'Sprinkler_Relais8' received command OFF
2020-04-24 02:25:55.406 [nt.ItemStatePredictedEvent] - Sprinkler_Relais1 predicted to become OFF
2020-04-24 02:25:55.415 [nt.ItemStatePredictedEvent] - Sprinkler_Relais2 predicted to become OFF
2020-04-24 02:25:55.436 [nt.ItemStatePredictedEvent] - Sprinkler_Relais3 predicted to become OFF
2020-04-24 02:25:55.443 [nt.ItemStatePredictedEvent] - Sprinkler_Relais4 predicted to become OFF
2020-04-24 02:25:55.466 [nt.ItemStatePredictedEvent] - Sprinkler_Relais5 predicted to become OFF
2020-04-24 02:25:55.474 [nt.ItemStatePredictedEvent] - Sprinkler_Relais6 predicted to become OFF
2020-04-24 02:25:55.485 [nt.ItemStatePredictedEvent] - Sprinkler_Relais7 predicted to become OFF
2020-04-24 02:25:55.498 [nt.ItemStatePredictedEvent] - Sprinkler_Relais8 predicted to become OFF
2020-04-24 02:25:55.592 [vent.ItemStateChangedEvent] - CPUTEMPRaw changed from 50.147 to 54.530
2020-04-24 02:25:55.595 [vent.ItemStateChangedEvent] - CPUTEMPLastExecution changed from 2020-04-24T02:24:55.547+0200 to 2020-04-24T02:25:55.584+0200
2020-04-24 02:26:05.057 [vent.ItemStateChangedEvent] - GBad_Aktuelle_Temperatur changed from 20.01 to 20
2020-04-24 02:26:05.070 [me.event.ThingUpdatedEvent] - Thing 'zwave:device:Razberry1:node10' has been updated.
2020-04-24 02:26:07.110 [me.event.ThingUpdatedEvent] - Thing 'zwave:device:Razberry1:node10' has been updated.
hope that helps, since I do not see any trigger info in here.
Thanks!
the interesting part is 10 minutes before in openhab.log
and correct your title and text as it’s openhab not openhabian
1 Like
It’s the “Thing updates” that fire the System started rule, not an openHAB reboot.
Thing update is about changing the properties of the Thing, not about status e.g.online/offline.
I suspect the zwave nightly heal happens (ends) at this time.
1 Like
@rossko57:
Thanks so far… a good starting point, I never thought about…
To find out if this is the reason, I changed the heal time (which was 2am 
) to 4am.
If the restart now changed as well, well, we identified the problem.
If not, I upload the last 15 min before restart like @HaKuNa asked for.
@mstormi:
Sorry, changed!
Thanks to all so far!
That is finally identified as the trigger for the restart!
Thank you so much to pointing me there.
I finally established the ‘Frames’-Items which I don’t had before to get a better picture on the zwave infrastructure at all.
Sorry to reply so late to this thread, but my understanding of the zwave network heal is that it is unnecessary unless your network topology changes significantly.
I was having issues with sluggish behavior and turning off the heal resolved it. Here is a link to a discussion about it:
If my understanding is correct, and please speak up if I get anything wrong. Battery powered devices do not participate in the heal, as they cannot be “told” to wake up and participate. To conserve battery power, they only wake to send reports. The heal rebuilds routes between the mains powered devices. So, if you have three zwave bulbs (mains) in your living room, for example, your network heal runs nightly and rebuilds the routes between these devices. But think about that. If you have not moved these bulbs, what’s the point of trying to rebuild the routes again? If you move any of those bulbs to another room, then it makes sense to run the network heal. But if you add a battery powered device, I don’t think a network heal would be meaningful. But I could be wrong. My network heal has been disabled for quite some time.