I’m a bit late to this but have unexpectedly found some spare time for non-Christmas stuff. I followed the steps and upon restarting OH (a brand new installation of OH 2.5 on a brand new Ubuntu 19.10 VM) this was output in the log:
2019-12-22 17:03:50.020 [DEBUG] [.AutomationResourceBundlesEventQueue] - Process bundle event 2, for automation bundle 'org.openhab.core.automation'
2019-12-22 17:03:50.031 [DEBUG] [.AutomationResourceBundlesEventQueue] - Process bundle event 32, for automation bundle 'org.openhab.core.automation.module.script.rulesupport'
2019-12-22 17:03:50.075 [DEBUG] [vider.AbstractResourceBundleProvider] - Parse rules from bundle 'org.openhab.core.automation'
2019-12-22 17:03:50.075 [DEBUG] [vider.AbstractResourceBundleProvider] - Parse rules from bundle 'org.openhab.core.automation.module.script.rulesupport'
2019-12-22 17:03:50.144 [DEBUG] [e.automation.internal.RuleEngineImpl] - ModuleHandlerFactory added CoreModuleHandlerFactory
2019-12-22 17:03:50.144 [DEBUG] [e.automation.internal.RuleEngineImpl] - ModuleHandlerFactory added EphemerisModuleHandlerFactory
2019-12-22 17:03:50.144 [DEBUG] [e.automation.internal.RuleEngineImpl] - ModuleHandlerFactory added TimerModuleHandlerFactory
2019-12-22 17:03:50.145 [DEBUG] [e.automation.internal.RuleEngineImpl] - ModuleHandlerFactory added AnnotatedActionModuleTypeProvider
2019-12-22 17:03:50.165 [DEBUG] [e.automation.internal.RuleEngineImpl] - ModuleHandlerFactory added AnnotatedThingActionModuleTypeProvider
2019-12-22 17:03:50.184 [DEBUG] [e.automation.internal.RuleEngineImpl] - ModuleHandlerFactory added MediaModuleHandlerFactory
2019-12-22 17:03:53.015 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Initialized a custom ScriptEngineFactory for jython (2.7.0): supports python (2.7) with file extensions [py], names [python, jython], and mimetypes [text/python, application/python, text/x-python, application/x-python]
2019-12-22 17:03:53.293 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Initialized a generic ScriptEngineFactory for Oracle Nashorn (1.8.0_232-b18): supports ECMAScript (ECMA - 262 Edition 5.1) with file extensions [js], names [nashorn, Nashorn, js, JS, JavaScript, javascript, ECMAScript, ecmascript], and mimetypes [application/javascript, application/ecmascript, text/javascri
pt, text/ecmascript]
2019-12-22 17:03:53.302 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Initialized a custom ScriptEngineFactory for Oracle Nashorn (1.8.0_232-b18): supports ECMAScript (ECMA - 262 Edition 5.1) with file extensions [js], names [nashorn, Nashorn, js, JS, JavaScript, javascript, ECMAScript, ecmascript], and mimetypes [application/javascript, application/ecmascript, text/javascrip
t, text/ecmascript]
2019-12-22 17:03:53.303 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Removed JythonScriptEngineFactory
2019-12-22 17:03:53.304 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Removed GenericScriptEngineFactory
2019-12-22 17:03:53.304 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Removed NashornScriptEngineFactory
2019-12-22 17:03:53.312 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Initialized a custom ScriptEngineFactory for jython (2.7.0): supports python (2.7) with file extensions [py], names [python, jython], and mimetypes [text/python, application/python, text/x-python, application/x-python]
2019-12-22 17:03:53.315 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Initialized a generic ScriptEngineFactory for Oracle Nashorn (1.8.0_232-b18): supports ECMAScript (ECMA - 262 Edition 5.1) with file extensions [js], names [nashorn, Nashorn, js, JS, JavaScript, javascript, ECMAScript, ecmascript], and mimetypes [application/javascript, application/ecmascript, text/javascri
pt, text/ecmascript]
2019-12-22 17:03:53.319 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Initialized a custom ScriptEngineFactory for Oracle Nashorn (1.8.0_232-b18): supports ECMAScript (ECMA - 262 Edition 5.1) with file extensions [js], names [nashorn, Nashorn, js, JS, JavaScript, javascript, ECMAScript, ecmascript], and mimetypes [application/javascript, application/ecmascript, text/javascrip
t, text/ecmascript]
2019-12-22 17:03:53.320 [DEBUG] [e.automation.internal.RuleEngineImpl] - ModuleHandlerFactory added ScriptModuleHandlerFactory
2019-12-22 17:03:53.341 [DEBUG] [e.automation.internal.RuleEngineImpl] - ModuleHandlerFactory added ScriptedCustomModuleHandlerFactory
2019-12-22 17:03:53.343 [DEBUG] [e.automation.internal.RuleEngineImpl] - ModuleHandlerFactory added ScriptedPrivateModuleHandlerFactory
2019-12-22 17:04:18.352 [INFO ] [me.core.service.AbstractWatchService] - Loading script 'javascript/core/000_startup_delay.js'
2019-12-22 17:04:18.497 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Added ScriptEngine for language 'js' with identifier: file:/etc/openhab2/automation/jsr223/javascript/core/000_startup_delay.js
2019-12-22 17:04:18.526 [INFO ] [jsr223.javascript.core.startup_delay] - Checking for initialized context
2019-12-22 17:04:18.537 [INFO ] [jsr223.javascript.core.startup_delay] - Context initialized... waiting 30s before allowing scripts to load
2019-12-22 17:04:48.547 [INFO ] [jsr223.javascript.core.startup_delay] - Complete
2019-12-22 17:04:48.548 [INFO ] [me.core.service.AbstractWatchService] - Loading script 'python/core/000_startup_delay.py'
2019-12-22 17:04:48.549 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Added ScriptEngine for language 'py' with identifier: file:/etc/openhab2/automation/jsr223/python/core/000_startup_delay.py
2019-12-22 17:04:48.576 [INFO ] [jsr223.jython.core.startup_delay ] - Checking for initialized context
2019-12-22 17:04:48.577 [INFO ] [jsr223.jython.core.startup_delay ] - Context initialized... waiting 30s before allowing scripts to load
2019-12-22 17:05:18.578 [INFO ] [jsr223.jython.core.startup_delay ] - Complete
2019-12-22 17:05:18.578 [INFO ] [me.core.service.AbstractWatchService] - Loading script 'python/core/components/100_DirectoryTrigger.py'
2019-12-22 17:05:18.579 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Added ScriptEngine for language 'py' with identifier: file:/etc/openhab2/automation/jsr223/python/core/components/100_DirectoryTrigger.py
2019-12-22 17:05:18.995 [INFO ] [23.jython.core.DirectoryEventTrigger] - TriggerHandler added [jsr223.DirectoryTrigger]
2019-12-22 17:05:18.997 [INFO ] [23.jython.core.DirectoryEventTrigger] - TriggerType added [jsr223.DirectoryTrigger]
2019-12-22 17:05:18.998 [INFO ] [me.core.service.AbstractWatchService] - Loading script 'python/core/components/100_OsgiEventTrigger.py'
2019-12-22 17:05:18.998 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Added ScriptEngine for language 'py' with identifier: file:/etc/openhab2/automation/jsr223/python/core/components/100_OsgiEventTrigger.py
2019-12-22 17:05:19.128 [INFO ] [jsr223.jython.core.OsgiEventTrigger ] - TriggerHandler added [jsr223.OsgiEventTrigger]
2019-12-22 17:05:19.129 [INFO ] [jsr223.jython.core.OsgiEventTrigger ] - TriggerType added [jsr223.OsgiEventTrigger]
2019-12-22 17:05:19.135 [INFO ] [me.core.service.AbstractWatchService] - Loading script 'python/core/components/100_StartupTrigger.py'
2019-12-22 17:05:19.136 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Added ScriptEngine for language 'py' with identifier: file:/etc/openhab2/automation/jsr223/python/core/components/100_StartupTrigger.py
2019-12-22 17:05:19.151 [INFO ] [jsr223.jython.core.StartupTrigger ] - TriggerHandler added [jsr223.StartupTrigger]
2019-12-22 17:05:19.152 [INFO ] [jsr223.jython.core.StartupTrigger ] - TriggerType added [jsr223.StartupTrigger]
2019-12-22 17:05:19.153 [INFO ] [me.core.service.AbstractWatchService] - Loading script 'python/core/components/200_JythonBindingInfoProvider.py'
2019-12-22 17:05:19.153 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Added ScriptEngine for language 'py' with identifier: file:/etc/openhab2/automation/jsr223/python/core/components/200_JythonBindingInfoProvider.py
2019-12-22 17:05:19.199 [DEBUG] [thonBindingInfoProvider.scriptLoaded] - Registered service
2019-12-22 17:05:19.200 [INFO ] [me.core.service.AbstractWatchService] - Loading script 'python/core/components/200_JythonExtensionProvider.py'
2019-12-22 17:05:19.201 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Added ScriptEngine for language 'py' with identifier: file:/etc/openhab2/automation/jsr223/python/core/components/200_JythonExtensionProvider.py
2019-12-22 17:05:19.435 [DEBUG] [.jython.core.JythonExtensionProvider] - Start init
2019-12-22 17:05:19.444 [DEBUG] [.jython.core.JythonExtensionProvider] - End init
2019-12-22 17:05:19.446 [DEBUG] [JythonExtensionProvider.scriptLoaded] - Registered service
2019-12-22 17:05:19.447 [INFO ] [me.core.service.AbstractWatchService] - Loading script 'python/core/components/200_JythonItemChannelLinkProvider.py'
2019-12-22 17:05:19.448 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Added ScriptEngine for language 'py' with identifier: file:/etc/openhab2/automation/jsr223/python/core/components/200_JythonItemChannelLinkProvider.py
2019-12-22 17:05:19.470 [DEBUG] [ItemChannelLinkProvider.scriptLoaded] - Registered service
2019-12-22 17:05:19.471 [INFO ] [me.core.service.AbstractWatchService] - Loading script 'python/core/components/200_JythonItemProvider.py'
2019-12-22 17:05:19.471 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Added ScriptEngine for language 'py' with identifier: file:/etc/openhab2/automation/jsr223/python/core/components/200_JythonItemProvider.py
2019-12-22 17:05:19.498 [DEBUG] [core.JythonItemProvider.scriptLoaded] - Registered service
2019-12-22 17:05:19.499 [INFO ] [me.core.service.AbstractWatchService] - Loading script 'python/core/components/200_JythonThingProvider.py'
2019-12-22 17:05:19.499 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Added ScriptEngine for language 'py' with identifier: file:/etc/openhab2/automation/jsr223/python/core/components/200_JythonThingProvider.py
2019-12-22 17:05:19.521 [DEBUG] [ore.JythonThingProvider.scriptLoaded] - Registered service
2019-12-22 17:05:19.523 [INFO ] [me.core.service.AbstractWatchService] - Loading script 'python/core/components/200_JythonThingTypeProvider.py'
2019-12-22 17:05:19.523 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Added ScriptEngine for language 'py' with identifier: file:/etc/openhab2/automation/jsr223/python/core/components/200_JythonThingTypeProvider.py
2019-12-22 17:05:19.545 [DEBUG] [JythonThingTypeProvider.scriptLoaded] - Registered service
2019-12-22 17:05:19.545 [INFO ] [me.core.service.AbstractWatchService] - Loading script 'python/core/components/200_JythonTransform.py'
2019-12-22 17:05:19.546 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Added ScriptEngine for language 'py' with identifier: file:/etc/openhab2/automation/jsr223/python/core/components/200_JythonTransform.py
2019-12-22 17:05:19.569 [DEBUG] [onTransformationService.scriptLoaded] - Registered service
2019-12-22 17:05:19.570 [INFO ] [me.core.service.AbstractWatchService] - Loading script 'python/personal/hello_world.py'
2019-12-22 17:05:19.570 [DEBUG] [ipt.internal.ScriptEngineManagerImpl] - Added ScriptEngine for language 'py' with identifier: file:/etc/openhab2/automation/jsr223/python/personal/hello_world.py
2019-12-22 17:05:20.274 [DEBUG] [jsr223.jython.core.triggers ] - when: target=[Time cron 0/10 * * * * ?], target_type=Time, trigger_target=cron, trigger_type=0/10 * * * * ?, old_state=None, new_state=None
2019-12-22 17:05:20.740 [DEBUG] [jsr223.jython.core.triggers ] - when: Created cron_trigger: [Time_cron_0_10_3c19af2e24dd11ea80933bce3edefe29]
2019-12-22 17:05:20.742 [DEBUG] [jsr223.jython.core.rules ] - Added rule [Jython Hello World (cron decorators)]
2019-12-22 17:05:20.794 [DEBUG] [le.handler.GenericCronTriggerHandler] - Scheduled cron job '0/10 * * * * ?' for trigger 'Time_cron_0_10_3c19af2e24dd11ea80933bce3edefe29_3c5cf9c024dd11eaa3953bce3edefe29'.
2019-12-22 17:05:30.786 [DEBUG] [e.automation.internal.RuleEngineImpl] - The trigger 'Time_cron_0_10_3c19af2e24dd11ea80933bce3edefe29_3c5cf9c024dd11eaa3953bce3edefe29' of rule '44c72662-ad6a-4865-a30d-f5d1b2b24ed9' is triggered.
2019-12-22 17:05:30.796 [INFO ] [Jython Hello World (cron decorators)] - Hello World!
2019-12-22 17:05:30.797 [DEBUG] [e.automation.internal.RuleEngineImpl] - The rule '44c72662-ad6a-4865-a30d-f5d1b2b24ed9' is executed.
2019-12-22 17:05:40.788 [DEBUG] [e.automation.internal.RuleEngineImpl] - The trigger 'Time_cron_0_10_3c19af2e24dd11ea80933bce3edefe29_3c5cf9c024dd11eaa3953bce3edefe29' of rule '44c72662-ad6a-4865-a30d-f5d1b2b24ed9' is triggered.
2019-12-22 17:05:40.788 [INFO ] [Jython Hello World (cron decorators)] - Hello World!
2019-12-22 17:05:40.789 [DEBUG] [e.automation.internal.RuleEngineImpl] - The rule '44c72662-ad6a-4865-a30d-f5d1b2b24ed9' is executed.
2019-12-22 17:05:50.789 [DEBUG] [e.automation.internal.RuleEngineImpl] - The trigger 'Time_cron_0_10_3c19af2e24dd11ea80933bce3edefe29_3c5cf9c024dd11eaa3953bce3edefe29' of rule '44c72662-ad6a-4865-a30d-f5d1b2b24ed9' is triggered.
2019-12-22 17:05:50.790 [INFO ] [Jython Hello World (cron decorators)] - Hello World!
2019-12-22 17:05:50.790 [DEBUG] [e.automation.internal.RuleEngineImpl] - The rule '44c72662-ad6a-4865-a30d-f5d1b2b24ed9' is executed.
2019-12-22 17:06:00.789 [DEBUG] [e.automation.internal.RuleEngineImpl] - The trigger 'Time_cron_0_10_3c19af2e24dd11ea80933bce3edefe29_3c5cf9c024dd11eaa3953bce3edefe29' of rule '44c72662-ad6a-4865-a30d-f5d1b2b24ed9' is triggered.
2019-12-22 17:06:00.790 [INFO ] [Jython Hello World (cron decorators)] - Hello World!
2019-12-22 17:06:00.790 [DEBUG] [e.automation.internal.RuleEngineImpl] - The rule '44c72662-ad6a-4865-a30d-f5d1b2b24ed9' is executed.
2019-12-22 17:06:10.790 [DEBUG] [e.automation.internal.RuleEngineImpl] - The trigger 'Time_cron_0_10_3c19af2e24dd11ea80933bce3edefe29_3c5cf9c024dd11eaa3953bce3edefe29' of rule '44c72662-ad6a-4865-a30d-f5d1b2b24ed9' is triggered.
2019-12-22 17:06:10.791 [INFO ] [Jython Hello World (cron decorators)] - Hello World!
2019-12-22 17:06:10.791 [DEBUG] [e.automation.internal.RuleEngineImpl] - The rule '44c72662-ad6a-4865-a30d-f5d1b2b24ed9' is executed.
2019-12-22 17:06:20.790 [DEBUG] [e.automation.internal.RuleEngineImpl] - The trigger 'Time_cron_0_10_3c19af2e24dd11ea80933bce3edefe29_3c5cf9c024dd11eaa3953bce3edefe29' of rule '44c72662-ad6a-4865-a30d-f5d1b2b24ed9' is triggered.
2019-12-22 17:06:20.791 [INFO ] [Jython Hello World (cron decorators)] - Hello World!
2019-12-22 17:06:20.791 [DEBUG] [e.automation.internal.RuleEngineImpl] - The rule '44c72662-ad6a-4865-a30d-f5d1b2b24ed9' is executed.
2019-12-22 17:06:30.790 [DEBUG] [e.automation.internal.RuleEngineImpl] - The trigger 'Time_cron_0_10_3c19af2e24dd11ea80933bce3edefe29_3c5cf9c024dd11eaa3953bce3edefe29' of rule '44c72662-ad6a-4865-a30d-f5d1b2b24ed9' is triggered.
2019-12-22 17:06:30.792 [INFO ] [Jython Hello World (cron decorators)] - Hello World!
2019-12-22 17:06:30.793 [DEBUG] [e.automation.internal.RuleEngineImpl] - The rule '44c72662-ad6a-4865-a30d-f5d1b2b24ed9' is executed.
2019-12-22 17:06:40.791 [DEBUG] [e.automation.internal.RuleEngineImpl] - The trigger 'Time_cron_0_10_3c19af2e24dd11ea80933bce3edefe29_3c5cf9c024dd11eaa3953bce3edefe29' of rule '44c72662-ad6a-4865-a30d-f5d1b2b24ed9' is triggered.
2019-12-22 17:06:40.792 [INFO ] [Jython Hello World (cron decorators)] - Hello World!
2019-12-22 17:06:40.793 [DEBUG] [e.automation.internal.RuleEngineImpl] - The rule '44c72662-ad6a-4865-a30d-f5d1b2b24ed9' is executed.
2019-12-22 17:06:50.791 [DEBUG] [e.automation.internal.RuleEngineImpl] - The trigger 'Time_cron_0_10_3c19af2e24dd11ea80933bce3edefe29_3c5cf9c024dd11eaa3953bce3edefe29' of rule '44c72662-ad6a-4865-a30d-f5d1b2b24ed9' is triggered.
2019-12-22 17:06:50.792 [INFO ] [Jython Hello World (cron decorators)] - Hello World!
2019-12-22 17:06:50.792 [DEBUG] [e.automation.internal.RuleEngineImpl] - The rule '44c72662-ad6a-4865-a30d-f5d1b2b24ed9' is executed.
All looks good to me, this is awesome, thanks!