I have a rule which is being executed when the system is started. However I notice that the rule is executed several times. Therefor a rule depending on this (“system initialisation”) is also fired several times.
A bug? i’m using Beta 5 of OH2 ion a Raspberry Pi3
rule:
rule “System started”
when
System started
then
var Timer waitTimer = nulllogDebug("startup", "Rule System starting started")
Initializing.postUpdate(ON)
SystemStarting.postUpdate(ON)
logDebug(“startup”, "Initializing = " + Initializing.state.toString() + " & SystemStarting = " + Initializing.state.toString())
waitTimer = createTimer(now.plusMinutes(2)) [|
Initializing.postUpdate(OFF)
logDebug(“startup”, "Initializing = " + Initializing.state.toString() + " & SystemStarting = " + Initializing.state.toString())
logDebug(“startup”, “Openhab initialized, all bindings have been loaded. I am ready to sync initial Nikobus states with Vera”)
logDebug(“startup”, “Rule System starting ended”)
]
end
Log:
2017-01-11 10:03:10.536 [INFO ] [ore.internal.i18n.LocaleProviderImpl] - Locale set to en_GB
2017-01-11 10:03:12.586 [INFO ] [rihome.internal.ImperiHomeApiServlet] - Started ImperiHome integration service at /imperihome/iss
2017-01-11 10:03:20.089 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model ‘default.items’
2017-01-11 10:03:22.384 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model ‘logging.persist’
2017-01-11 10:03:22.482 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model ‘mqtt.persist’
2017-01-11 10:03:22.534 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model ‘gcal.persist’
2017-01-11 10:03:22.562 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model ‘rrd4j.persist’
2017-01-11 10:03:22.583 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model ‘mapdb.persist’
2017-01-11 10:03:22.606 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model ‘exec.persist’
2017-01-11 10:03:27.420 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model ‘sync.rules’
2017-01-11 10:03:29.517 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model ‘automation.rules’
2017-01-11 10:03:29.713 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model ‘tts.rules’
2017-01-11 10:03:29.757 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model ‘startup.rules’
2017-01-11 10:03:33.727 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model ‘default.sitemap’
2017-01-11 10:03:36.353 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model ‘default.things’
2017-01-11 10:03:42.148 [INFO ] [.dashboard.internal.DashboardService] - Started dashboard at /start
2017-01-11 10:03:42.428 [INFO ] [arthome.ui.paper.internal.PaperUIApp] - Started Paper UI at /ui
2017-01-11 10:03:45.119 [INFO ] [basic.internal.servlet.WebAppServlet] - Started Basic UI at /basicui/app
2017-01-11 10:03:45.638 [INFO ] [ui.habmin.internal.servlet.HABminApp] - Started HABmin servlet at /habmin
2017-01-11 10:03:46.012 [INFO ] [panel.internal.HABPanelDashboardTile] - Started HABPanel at /habpanel
2017-01-11 10:03:51.458 [INFO ] [ding.astro.handler.AstroThingHandler] - Scheduled astro job-daily-sun at midnight for thing astro:sun:local
2017-01-11 10:03:51.459 [INFO ] [ding.astro.handler.AstroThingHandler] - Scheduled astro job-daily-moon at midnight for thing astro:moon:local
2017-01-11 10:03:51.507 [INFO ] [ding.astro.handler.AstroThingHandler] - Scheduled astro job-positional with interval of 60 seconds for thing astro:moon:local
2017-01-11 10:03:51.508 [INFO ] [ding.astro.handler.AstroThingHandler] - Scheduled astro job-positional with interval of 60 seconds for thing astro:sun:local
2017-01-11 10:04:21.615 [DEBUG] [lipse.smarthome.model.script.startup] - Rule System starting started
2017-01-11 10:04:21.651 [DEBUG] [lipse.smarthome.model.script.startup] - Initializing = ON & SystemStarting = ON
2017-01-11 10:04:23.603 [INFO ] [.astro.internal.job.AbstractDailyJob] - Scheduled astro event-jobs for thing astro:moon:local
2017-01-11 10:04:23.620 [INFO ] [.astro.internal.job.AbstractDailyJob] - Scheduled astro event-jobs for thing astro:sun:local
2017-01-11 10:04:26.498 [INFO ] [b.core.service.AbstractActiveService] - HTTP Refresh Service has been started
2017-01-11 10:04:27.213 [INFO ] [kobus.internal.core.NikobusInterface] - Connected to serial port ‘/dev/ttyUSB0’
2017-01-11 10:04:27.422 [INFO ] [kobus.internal.core.NikobusInterface] - Connected to Nikobus
2017-01-11 10:04:27.469 [ERROR] [platform.linux.LinuxCentralProcessor] - Couldn’t find physical processor count. Assuming 1.
2017-01-11 10:04:29.139 [INFO ] [ternal.scheduler.WeatherJobScheduler] - Starting and scheduling weatherJob-Brussel with interval of 60 minutes
2017-01-11 10:04:29.724 [INFO ] [b.core.service.AbstractActiveService] - Google Calender Event-Downloader has been started
2017-01-11 10:04:29.734 [INFO ] [penhab.io.transport.mqtt.MqttService] - MQTT Service initialization completed.
2017-01-11 10:04:29.746 [INFO ] [t.mqtt.internal.MqttBrokerConnection] - Starting MQTT broker connection ‘server’
2017-01-11 10:04:31.093 [WARN ] [ore.internal.events.OSGiEventManager] - Dispatching event to subscriber ‘org.eclipse.smarthome.core.thing.link.ThingLinkManager@1cfa0aa’ takes more than 5000ms.
2017-01-11 10:04:35.225 [WARN ] [ore.internal.events.OSGiEventManager] - Dispatching event to subscriber ‘org.eclipse.smarthome.core.thing.link.ThingLinkManager@1cfa0aa’ takes more than 5000ms.
2017-01-11 10:04:40.556 [WARN ] [ore.internal.events.OSGiEventManager] - Dispatching event to subscriber ‘org.eclipse.smarthome.core.thing.link.ThingLinkManager@1cfa0aa’ takes more than 5000ms.
2017-01-11 10:05:39.656 [DEBUG] [lipse.smarthome.model.script.startup] - Rule System starting started
2017-01-11 10:05:39.744 [DEBUG] [lipse.smarthome.model.script.startup] - Initializing = ON & SystemStarting = ON
2017-01-11 10:06:24.027 [DEBUG] [lipse.smarthome.model.script.startup] - Initializing = OFF & SystemStarting = OFF
2017-01-11 10:06:24.039 [DEBUG] [lipse.smarthome.model.script.startup] - Openhab initialized, all bindings have been loaded. I am ready to sync initial Nikobus states with Vera
2017-01-11 10:06:24.043 [DEBUG] [lipse.smarthome.model.script.startup] - Rule System starting ended
2017-01-11 10:06:52.845 [DEBUG] [lipse.smarthome.model.script.startup] - Rule System starting started
2017-01-11 10:06:52.882 [DEBUG] [lipse.smarthome.model.script.startup] - Rule System initialisation started
2017-01-11 10:06:52.888 [DEBUG] [lipse.smarthome.model.script.startup] - Initializing = ON & SystemStarting = ON
2017-01-11 10:06:52.920 [DEBUG] [lipse.smarthome.model.script.startup] - Initializing = ON & SystemStarting = ON
2017-01-11 10:06:58.461 [DEBUG] [lipse.smarthome.model.script.startup] - Rule System initialisation ended
2017-01-11 10:06:58.464 [DEBUG] [lipse.smarthome.model.script.startup] - Systeem is gereed!
2017-01-11 10:07:13.469 [DEBUG] [lipse.smarthome.model.script.startup] - Initializing = ON & SystemStarting = ON
2017-01-11 10:07:13.488 [DEBUG] [lipse.smarthome.model.script.startup] - LichtenUit = OFF & LichtenAan = OFF & Sfeerlicht = OFF
2017-01-11 10:07:39.770 [DEBUG] [lipse.smarthome.model.script.startup] - Initializing = OFF & SystemStarting = OFF
2017-01-11 10:07:39.773 [DEBUG] [lipse.smarthome.model.script.startup] - Openhab initialized, all bindings have been loaded. I am ready to sync initial Nikobus states with Vera
2017-01-11 10:07:39.776 [DEBUG] [lipse.smarthome.model.script.startup] - Rule System starting ended
2017-01-11 10:07:39.782 [DEBUG] [lipse.smarthome.model.script.startup] - Rule System initialisation started
2017-01-11 10:07:39.793 [DEBUG] [lipse.smarthome.model.script.startup] - Initializing = OFF & SystemStarting = OFF
2017-01-11 10:07:44.657 [DEBUG] [lipse.smarthome.model.script.startup] - Rule System initialisation ended
2017-01-11 10:07:44.661 [DEBUG] [lipse.smarthome.model.script.startup] - Systeem is gereed!
2017-01-11 10:07:59.678 [DEBUG] [lipse.smarthome.model.script.startup] - Initializing = OFF & SystemStarting = OFF
2017-01-11 10:07:59.690 [DEBUG] [lipse.smarthome.model.script.startup] - LichtenUit = OFF & LichtenAan = OFF & Sfeerlicht = OFF
2017-01-11 10:08:52.913 [DEBUG] [lipse.smarthome.model.script.startup] - Initializing = OFF & SystemStarting = OFF
2017-01-11 10:08:52.918 [DEBUG] [lipse.smarthome.model.script.startup] - Openhab initialized, all bindings have been loaded. I am ready to sync initial Nikobus states with Vera
2017-01-11 10:08:52.922 [DEBUG] [lipse.smarthome.model.script.startup] - Rule System starting ended