2.5 Milestone 6 Issues

I am sorry, I don’t quite understand what you mean with “a top”!

The command top. You can use it to see what processes are running and hogging the cpu

Replying to my own post. I have downgraded to M5 and the problem is gone. This confirms to me that this is not some problem with my system, but a problem in openhab. I will try to upgrade to M6 tomorrow and see if the problem reappears.

You didn’t mention the media OpenHAB is installed on on your Pi. Is it an SD card? If so, did you install both M5 and M6 on the same SD card? Your issue kind of sounds like maybe the card is going bad. The behaviour you describe is normal when a rule is saved. Is the Pi running on a separate drive? Maybe connection between the Pi and drive? Just guessing here

Hi, thanks. I use a fairly new ssd drive. I installed both M5 and M6 on the same drive, so nothing about the connection changed. I agree that the behaviour is similar to a rule being saved, but there is a differece. If I save a rule, I get the following lines in my log:

2019-12-04 22:25:58.319 [INFO ] [el.core.internal.ModelRepositoryImpl] - Refreshing model ‘blinds.rules’
2019-12-04 22:26:37.195 [INFO ] [ome.model.script.System started Rule] - blinds done

The rules reloading only cause the second line, caused by the system started trigger. For example:

2019-12-04 02:17:25.893 [INFO ] [ome.model.script.System started Rule] - blinds done

I see a similar thing happening if I change an item file. As far as I can tell that causes rules that contain the items in the item file to be restarted. Again I see the log line caused by the system started trigger, but not the refresh line.

Ok. Thank’s!
When I re-enable Hue Dimmer Switch, “java” goes to approx. 380% when issuing the top command! And the log is beginning to spam with hue events again!

1 Like

Same symptom I experienced (180% cpu hog) , but not hue related I think. Had to revert back to M5.

I upgraded yesterday, in general, everything seems fine, but openhab2 process uses all cpu.

ui and rules are, understandably, very slow.

after reverting to m5 everything is fine again.

I upgraded from M5 to M6 on openHABian rpi 3b+. It’s not very stable.

Sometimes it refuses to start:

syslog:

Dec 05 12:33:23 openhab karaf[762]: org.apache.felix.resolver.reason.ReasonException: Unable to resolve root: missing requirement [root] osgi.identity; osgi.identity=openhab-ui-dashboard; type=karaf.feature; version="[2.5.0.M5,2.5.0.M5]"; filter:="(&(osgi.identity=openhab-ui-dashboard)(type=karaf.feature)(version>=2.5.0.M5)(version<=2.5.0.M5))" [caused by: Unable to resolve openhab-ui-dashboard/2.5.0.M5: missing requirement [openhab-ui-dashboard/2.5.0.M5] osgi.identity; osgi.identity=openhab-core-base; type=karaf.feature]
Dec 05 12:33:23 openhab karaf[762]:         at org.apache.felix.resolver.Candidates$MissingRequirementError.toException(Candidates.java:1343)
Dec 05 12:33:23 openhab karaf[762]:         at org.apache.felix.resolver.ResolverImpl.doResolve(ResolverImpl.java:392)
Dec 05 12:33:23 openhab karaf[762]:         at org.apache.felix.resolver.ResolverImpl.resolve(ResolverImpl.java:378)
Dec 05 12:33:23 openhab karaf[762]:         at org.apache.felix.resolver.ResolverImpl.resolve(ResolverImpl.java:332)
Dec 05 12:33:23 openhab karaf[762]:         at org.apache.karaf.features.internal.region.SubsystemResolver.resolve(SubsystemResolver.java:257)
Dec 05 12:33:23 openhab karaf[762]:         at org.apache.karaf.features.internal.service.Deployer.deploy(Deployer.java:393)
Dec 05 12:33:23 openhab karaf[762]:         at org.apache.karaf.features.internal.service.FeaturesServiceImpl.doProvision(FeaturesServiceImpl.java:1062)
Dec 05 12:33:23 openhab karaf[762]:         at org.apache.karaf.features.internal.service.FeaturesServiceImpl.lambda$doProvisionInThread$13(FeaturesServiceImpl.java:998)
Dec 05 12:33:23 openhab karaf[762]:         at java.util.concurrent.FutureTask.run(FutureTask.java:266)
Dec 05 12:33:23 openhab karaf[762]:         at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
Dec 05 12:33:23 openhab karaf[762]:         at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
Dec 05 12:33:23 openhab karaf[762]:         at java.lang.Thread.run(Thread.java:748)
Dec 05 12:33:23 openhab karaf[762]: Caused by: org.apache.felix.resolver.reason.ReasonException: Unable to resolve openhab-ui-dashboard/2.5.0.M5: missing requirement [openhab-ui-dashboard/2.5.0.M5] osgi.identity; osgi.identity=openhab-core-base; type=karaf.feature
Dec 05 12:33:23 openhab karaf[762]:         at org.apache.felix.resolver.Candidates$MissingRequirementError.toException(Candidates.java:1343)
Dec 05 12:33:23 openhab karaf[762]:         ... 12 more

Why is it asking for openhab-ui-dashboard/2.5.0.M5 on M6? I’ve cleared the cache multiple times

openhab.log:

2019-12-05 12:33:18.566 [ERROR] [ternal.service.BootFeaturesInstaller] - Error installing boot feature repository mvn:org.openhab.distro/distro/2.5.0.M5/xml/features
java.lang.RuntimeException: Error resolving artifact org.openhab.distro:distro:xml:features:2.5.0.M5: [Could not find artifact org.openhab.distro:distro:xml:features:2.5.0.M5 in openhab (https://openhab.jfrog.io/openhab/online-repo-milestone/2.5/), Could not find artifact org.openhab.distro:distro:xml:features:2.5.0.M5 in openhab (https://openhab.jfrog.io/openhab/online-repo-milestone/2.5/)] : mvn:org.openhab.distro/distro/2.5.0.M5/xml/features
        at org.apache.karaf.features.internal.service.RepositoryImpl.load(RepositoryImpl.java:116) ~[bundleFile:?]
        at org.apache.karaf.features.internal.service.RepositoryImpl.<init>(RepositoryImpl.java:50) ~[bundleFile:?]
        at org.apache.karaf.features.internal.service.RepositoryCacheImpl.create(RepositoryCacheImpl.java:51) ~[bundleFile:?]
        at org.apache.karaf.features.internal.service.FeaturesServiceImpl.addRepository(FeaturesServiceImpl.java:380) ~[bundleFile:?]
        at org.apache.karaf.features.internal.service.FeaturesServiceImpl.addRepository(FeaturesServiceImpl.java:375) ~[bundleFile:?]
        at org.apache.karaf.features.internal.service.BootFeaturesInstaller.addRepositories(BootFeaturesInstaller.java:123) [bundleFile:?]
        at org.apache.karaf.features.internal.service.BootFeaturesInstaller.installBootFeatures(BootFeaturesInstaller.java:93) [bundleFile:?]
        at org.apache.karaf.features.internal.service.BootFeaturesInstaller.start(BootFeaturesInstaller.java:87) [bundleFile:?]
        at org.apache.karaf.features.internal.osgi.Activator.doStart(Activator.java:196) [bundleFile:?]
        at org.apache.karaf.util.tracker.BaseActivator.run(BaseActivator.java:312) [bundleFile:?]
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:1.8.0_222]
        at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_222]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_222]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_222]
        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_222]
Caused by: java.io.IOException: Error resolving artifact org.openhab.distro:distro:xml:features:2.5.0.M5: [Could not find artifact org.openhab.distro:distro:xml:features:2.5.0.M5 in openhab (https://openhab.jfrog.io/openhab/online-repo-milestone/2.5/), Could not find artifact org.openhab.distro:distro:xml:features:2.5.0.M5 in openhab (https://openhab.jfrog.io/openhab/online-repo-milestone/2.5/)]
        at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.configureIOException(AetherBasedResolver.java:803) ~[?:?]
        at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:774) ~[?:?]
        at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:657) ~[?:?]
        at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:598) ~[?:?]
        at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:565) ~[?:?]
        at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:555) ~[?:?]
        at org.ops4j.pax.url.mvn.internal.Connection.getInputStream(Connection.java:123) ~[?:?]
        at java.net.URL.openStream(URL.java:1057) ~[?:1.8.0_222]
        at org.apache.karaf.features.internal.service.RepositoryImpl.load(RepositoryImpl.java:113) ~[bundleFile:?]
        ... 14 more
        Suppressed: shaded.org.eclipse.aether.transfer.ArtifactNotFoundException: Could not find artifact org.openhab.distro:distro:xml:features:2.5.0.M5 in openhab (https://openhab.jfrog.io/openhab/online-repo-milestone/2.5/)
                at shaded.org.eclipse.aether.connector.basic.ArtifactTransportListener.transferFailed(ArtifactTransportListener.java:48) ~[?:?]
                at shaded.org.eclipse.aether.connector.basic.BasicRepositoryConnector$TaskRunner.run(BasicRepositoryConnector.java:368) ~[?:?]
                at shaded.org.eclipse.aether.util.concurrency.RunnableErrorForwarder$1.run(RunnableErrorForwarder.java:75) ~[?:?]
                at shaded.org.eclipse.aether.connector.basic.BasicRepositoryConnector$DirectExecutor.execute(BasicRepositoryConnector.java:642) ~[?:?]
                at shaded.org.eclipse.aether.connector.basic.BasicRepositoryConnector.get(BasicRepositoryConnector.java:262) ~[?:?]
                at shaded.org.eclipse.aether.internal.impl.DefaultArtifactResolver.performDownloads(DefaultArtifactResolver.java:489) ~[?:?]
                at shaded.org.eclipse.aether.internal.impl.DefaultArtifactResolver.resolve(DefaultArtifactResolver.java:390) ~[?:?]
                at shaded.org.eclipse.aether.internal.impl.DefaultArtifactResolver.resolveArtifacts(DefaultArtifactResolver.java:215) ~[?:?]
                at shaded.org.eclipse.aether.internal.impl.DefaultArtifactResolver.resolveArtifact(DefaultArtifactResolver.java:192) ~[?:?]
                at shaded.org.eclipse.aether.internal.impl.DefaultRepositorySystem.resolveArtifact(DefaultRepositorySystem.java:247) ~[?:?]
                at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:767) ~[?:?]
                at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:657) ~[?:?]
                at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:598) ~[?:?]
                at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:565) ~[?:?]
                at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:555) ~[?:?]
                at org.ops4j.pax.url.mvn.internal.Connection.getInputStream(Connection.java:123) ~[?:?]
                at java.net.URL.openStream(URL.java:1057) ~[?:1.8.0_222]
                at org.apache.karaf.features.internal.service.RepositoryImpl.load(RepositoryImpl.java:113) ~[bundleFile:?]
                at org.apache.karaf.features.internal.service.RepositoryImpl.<init>(RepositoryImpl.java:50) ~[bundleFile:?]
                at org.apache.karaf.features.internal.service.RepositoryCacheImpl.create(RepositoryCacheImpl.java:51) ~[bundleFile:?]
                at org.apache.karaf.features.internal.service.FeaturesServiceImpl.addRepository(FeaturesServiceImpl.java:380) ~[bundleFile:?]
                at org.apache.karaf.features.internal.service.FeaturesServiceImpl.addRepository(FeaturesServiceImpl.java:375) ~[bundleFile:?]
                at org.apache.karaf.features.internal.service.BootFeaturesInstaller.addRepositories(BootFeaturesInstaller.java:123) [bundleFile:?]
                at org.apache.karaf.features.internal.service.BootFeaturesInstaller.installBootFeatures(BootFeaturesInstaller.java:93) [bundleFile:?]
                at org.apache.karaf.features.internal.service.BootFeaturesInstaller.start(BootFeaturesInstaller.java:87) [bundleFile:?]
                at org.apache.karaf.features.internal.osgi.Activator.doStart(Activator.java:196) [bundleFile:?]
                at org.apache.karaf.util.tracker.BaseActivator.run(BaseActivator.java:312) [bundleFile:?]
                at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:1.8.0_222]
                at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_222]
                at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_222]
                at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_222]
                at java.lang.Thread.run(Thread.java:748) [?:1.8.0_222]
        Suppressed: shaded.org.eclipse.aether.transfer.ArtifactNotFoundException: Could not find artifact org.openhab.distro:distro:xml:features:2.5.0.M5 in openhab (https://openhab.jfrog.io/openhab/online-repo-milestone/2.5/)
                at shaded.org.eclipse.aether.connector.basic.ArtifactTransportListener.transferFailed(ArtifactTransportListener.java:48) ~[?:?]
                at shaded.org.eclipse.aether.connector.basic.BasicRepositoryConnector$TaskRunner.run(BasicRepositoryConnector.java:368) ~[?:?]
                at shaded.org.eclipse.aether.util.concurrency.RunnableErrorForwarder$1.run(RunnableErrorForwarder.java:75) ~[?:?]
                at shaded.org.eclipse.aether.connector.basic.BasicRepositoryConnector$DirectExecutor.execute(BasicRepositoryConnector.java:642) ~[?:?]
                at shaded.org.eclipse.aether.connector.basic.BasicRepositoryConnector.get(BasicRepositoryConnector.java:262) ~[?:?]
                at shaded.org.eclipse.aether.internal.impl.DefaultArtifactResolver.performDownloads(DefaultArtifactResolver.java:489) ~[?:?]
                at shaded.org.eclipse.aether.internal.impl.DefaultArtifactResolver.resolve(DefaultArtifactResolver.java:390) ~[?:?]
                at shaded.org.eclipse.aether.internal.impl.DefaultArtifactResolver.resolveArtifacts(DefaultArtifactResolver.java:215) ~[?:?]
                at shaded.org.eclipse.aether.internal.impl.DefaultArtifactResolver.resolveArtifact(DefaultArtifactResolver.java:192) ~[?:?]
                at shaded.org.eclipse.aether.internal.impl.DefaultRepositorySystem.resolveArtifact(DefaultRepositorySystem.java:247) ~[?:?]
                at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:767) ~[?:?]
                at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:657) ~[?:?]
                at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:598) ~[?:?]
                at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:565) ~[?:?]
                at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:555) ~[?:?]
                at org.ops4j.pax.url.mvn.internal.Connection.getInputStream(Connection.java:123) ~[?:?]
                at java.net.URL.openStream(URL.java:1057) ~[?:1.8.0_222]
                at org.apache.karaf.features.internal.service.RepositoryImpl.load(RepositoryImpl.java:113) ~[bundleFile:?]
                at org.apache.karaf.features.internal.service.RepositoryImpl.<init>(RepositoryImpl.java:50) ~[bundleFile:?]
                at org.apache.karaf.features.internal.service.RepositoryCacheImpl.create(RepositoryCacheImpl.java:51) ~[bundleFile:?]
                at org.apache.karaf.features.internal.service.FeaturesServiceImpl.addRepository(FeaturesServiceImpl.java:380) ~[bundleFile:?]
                at org.apache.karaf.features.internal.service.FeaturesServiceImpl.addRepository(FeaturesServiceImpl.java:375) ~[bundleFile:?]
                at org.apache.karaf.features.internal.service.BootFeaturesInstaller.addRepositories(BootFeaturesInstaller.java:123) [bundleFile:?]
                at org.apache.karaf.features.internal.service.BootFeaturesInstaller.installBootFeatures(BootFeaturesInstaller.java:93) [bundleFile:?]
                at org.apache.karaf.features.internal.service.BootFeaturesInstaller.start(BootFeaturesInstaller.java:87) [bundleFile:?]
                at org.apache.karaf.features.internal.osgi.Activator.doStart(Activator.java:196) [bundleFile:?]
                at org.apache.karaf.util.tracker.BaseActivator.run(BaseActivator.java:312) [bundleFile:?]
                at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:1.8.0_222]
                at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_222]
                at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_222]
                at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_222]
                at java.lang.Thread.run(Thread.java:748) [?:1.8.0_222]
Caused by: shaded.org.eclipse.aether.resolution.ArtifactResolutionException: Error resolving artifact org.openhab.distro:distro:xml:features:2.5.0.M5
        at shaded.org.eclipse.aether.internal.impl.DefaultArtifactResolver.resolve(DefaultArtifactResolver.java:413) ~[?:?]
        at shaded.org.eclipse.aether.internal.impl.DefaultArtifactResolver.resolveArtifacts(DefaultArtifactResolver.java:215) ~[?:?]
        at shaded.org.eclipse.aether.internal.impl.DefaultArtifactResolver.resolveArtifact(DefaultArtifactResolver.java:192) ~[?:?]
        at shaded.org.eclipse.aether.internal.impl.DefaultRepositorySystem.resolveArtifact(DefaultRepositorySystem.java:247) ~[?:?]
        at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:767) ~[?:?]
        at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:657) ~[?:?]
        at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:598) ~[?:?]
        at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:565) ~[?:?]
        at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:555) ~[?:?]
        at org.ops4j.pax.url.mvn.internal.Connection.getInputStream(Connection.java:123) ~[?:?]
        at java.net.URL.openStream(URL.java:1057) ~[?:1.8.0_222]
        at org.apache.karaf.features.internal.service.RepositoryImpl.load(RepositoryImpl.java:113) ~[bundleFile:?]
        ... 14 more
2019-12-05 12:33:23.370 [ERROR] [ternal.service.BootFeaturesInstaller] - Error installing boot features
org.apache.felix.resolver.reason.ReasonException: Unable to resolve root: missing requirement [root] osgi.identity; osgi.identity=openhab-ui-dashboard; type=karaf.feature; version="[2.5.0.M5,2.5.0.M5]"; filter:="(&(osgi.identity=openhab-ui-dashboard)(type=karaf.feature)(version>=2.5.0.M5)(version<=2.5.0.M5))" [caused by: Unable to resolve openhab-ui-dashboard/2.5.0.M5: missing requirement [openhab-ui-dashboard/2.5.0.M5] osgi.identity; osgi.identity=openhab-core-base; type=karaf.feature]
        at org.apache.felix.resolver.Candidates$MissingRequirementError.toException(Candidates.java:1343) ~[org.eclipse.osgi-3.12.100.jar:?]
        at org.apache.felix.resolver.ResolverImpl.doResolve(ResolverImpl.java:392) ~[org.eclipse.osgi-3.12.100.jar:?]
        at org.apache.felix.resolver.ResolverImpl.resolve(ResolverImpl.java:378) ~[org.eclipse.osgi-3.12.100.jar:?]
        at org.apache.felix.resolver.ResolverImpl.resolve(ResolverImpl.java:332) ~[org.eclipse.osgi-3.12.100.jar:?]
        at org.apache.karaf.features.internal.region.SubsystemResolver.resolve(SubsystemResolver.java:257) ~[?:?]
        at org.apache.karaf.features.internal.service.Deployer.deploy(Deployer.java:393) ~[?:?]
        at org.apache.karaf.features.internal.service.FeaturesServiceImpl.doProvision(FeaturesServiceImpl.java:1062) ~[?:?]
        at org.apache.karaf.features.internal.service.FeaturesServiceImpl.lambda$doProvisionInThread$13(FeaturesServiceImpl.java:998) ~[?:?]
        at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_222]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_222]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_222]
        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_222]
Caused by: org.apache.felix.resolver.reason.ReasonException: Unable to resolve openhab-ui-dashboard/2.5.0.M5: missing requirement [openhab-ui-dashboard/2.5.0.M5] osgi.identity; osgi.identity=openhab-core-base; type=karaf.feature
        at org.apache.felix.resolver.Candidates$MissingRequirementError.toException(Candidates.java:1343) ~[org.eclipse.osgi-3.12.100.jar:?]
        ... 12 more
2019-12-05 12:33:43.827 [WARN ] [org.apache.felix.fileinstall        ] - Error while starting bundle: file:/usr/share/openhab2/addons/org.openhab.binding.espmilighthub-2.5.0-SNAPSHOT.jar
org.osgi.framework.BundleException: Could not resolve module: org.openhab.binding.espmilighthub [13]
  Unresolved requirement: Import-Package: org.apache.commons.io; version="2.2.0"

        at org.eclipse.osgi.container.Module.start(Module.java:444) ~[org.eclipse.osgi-3.12.100.jar:?]
        at org.eclipse.osgi.internal.framework.EquinoxBundle.start(EquinoxBundle.java:383) ~[org.eclipse.osgi-3.12.100.jar:?]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.startBundle(DirectoryWatcher.java:1260) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.startBundles(DirectoryWatcher.java:1233) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.startAllBundles(DirectoryWatcher.java:1221) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.doProcess(DirectoryWatcher.java:515) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.process(DirectoryWatcher.java:365) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.run(DirectoryWatcher.java:316) [bundleFile:3.6.4]
2019-12-05 12:33:43.827 [WARN ] [org.apache.felix.fileinstall        ] - Error while starting bundle: file:/usr/share/openhab2/addons/org.openhab.binding.espmilighthub-2.5.0-SNAPSHOT.jar
org.osgi.framework.BundleException: Could not resolve module: org.openhab.binding.espmilighthub [13]
  Unresolved requirement: Import-Package: org.apache.commons.io; version="2.2.0"

        at org.eclipse.osgi.container.Module.start(Module.java:444) ~[org.eclipse.osgi-3.12.100.jar:?]
        at org.eclipse.osgi.internal.framework.EquinoxBundle.start(EquinoxBundle.java:383) ~[org.eclipse.osgi-3.12.100.jar:?]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.startBundle(DirectoryWatcher.java:1260) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.startBundles(DirectoryWatcher.java:1233) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.startAllBundles(DirectoryWatcher.java:1221) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.doProcess(DirectoryWatcher.java:515) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.process(DirectoryWatcher.java:365) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.run(DirectoryWatcher.java:316) [bundleFile:3.6.4]
2019-12-05 12:33:43.841 [WARN ] [org.apache.felix.fileinstall        ] - Error while starting bundle: file:/usr/share/openhab2/addons/org.openhab.binding.espmilighthub-2.5.0-SNAPSHOT.jar
org.osgi.framework.BundleException: Could not resolve module: org.openhab.binding.espmilighthub [13]
  Unresolved requirement: Import-Package: org.apache.commons.io; version="2.2.0"

        at org.eclipse.osgi.container.Module.start(Module.java:444) ~[org.eclipse.osgi-3.12.100.jar:?]
        at org.eclipse.osgi.internal.framework.EquinoxBundle.start(EquinoxBundle.java:383) ~[org.eclipse.osgi-3.12.100.jar:?]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.startBundle(DirectoryWatcher.java:1260) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.startBundles(DirectoryWatcher.java:1233) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.doProcess(DirectoryWatcher.java:520) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.process(DirectoryWatcher.java:365) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.run(DirectoryWatcher.java:316) [bundleFile:3.6.4]
2019-12-05 12:33:43.841 [WARN ] [org.apache.felix.fileinstall        ] - Error while starting bundle: file:/usr/share/openhab2/addons/org.openhab.binding.espmilighthub-2.5.0-SNAPSHOT.jar
org.osgi.framework.BundleException: Could not resolve module: org.openhab.binding.espmilighthub [13]
  Unresolved requirement: Import-Package: org.apache.commons.io; version="2.2.0"

        at org.eclipse.osgi.container.Module.start(Module.java:444) ~[org.eclipse.osgi-3.12.100.jar:?]
        at org.eclipse.osgi.internal.framework.EquinoxBundle.start(EquinoxBundle.java:383) ~[org.eclipse.osgi-3.12.100.jar:?]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.startBundle(DirectoryWatcher.java:1260) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.startBundles(DirectoryWatcher.java:1233) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.doProcess(DirectoryWatcher.java:520) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.process(DirectoryWatcher.java:365) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.run(DirectoryWatcher.java:316) [bundleFile:3.6.4]
2019-12-05 12:33:43.852 [WARN ] [org.apache.felix.fileinstall        ] - Error while starting bundle: file:/usr/share/openhab2/addons/org.openhab.binding.homeconnect-2.5.0.201911080823.jar
org.osgi.framework.BundleException: Could not resolve module: org.openhab.binding.homeconnect [15]
  Unresolved requirement: Import-Package: org.eclipse.smarthome.config.core

        at org.eclipse.osgi.container.Module.start(Module.java:444) ~[org.eclipse.osgi-3.12.100.jar:?]
        at org.eclipse.osgi.internal.framework.EquinoxBundle.start(EquinoxBundle.java:383) ~[org.eclipse.osgi-3.12.100.jar:?]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.startBundle(DirectoryWatcher.java:1260) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.startBundles(DirectoryWatcher.java:1233) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.doProcess(DirectoryWatcher.java:520) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.process(DirectoryWatcher.java:365) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.run(DirectoryWatcher.java:316) [bundleFile:3.6.4]
2019-12-05 12:33:43.852 [WARN ] [org.apache.felix.fileinstall        ] - Error while starting bundle: file:/usr/share/openhab2/addons/org.openhab.binding.homeconnect-2.5.0.201911080823.jar
org.osgi.framework.BundleException: Could not resolve module: org.openhab.binding.homeconnect [15]
  Unresolved requirement: Import-Package: org.eclipse.smarthome.config.core

        at org.eclipse.osgi.container.Module.start(Module.java:444) ~[org.eclipse.osgi-3.12.100.jar:?]
        at org.eclipse.osgi.internal.framework.EquinoxBundle.start(EquinoxBundle.java:383) ~[org.eclipse.osgi-3.12.100.jar:?]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.startBundle(DirectoryWatcher.java:1260) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.startBundles(DirectoryWatcher.java:1233) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.doProcess(DirectoryWatcher.java:520) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.process(DirectoryWatcher.java:365) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.run(DirectoryWatcher.java:316) [bundleFile:3.6.4]

Only solution is to reinstall openhab. I did that twice in the past 2 days. For now I’m back at M5. Lets see if it occurs again.

I grabbed 3 heap dumps while turning off various bindings (Onkyo, Network, Harmony Hub, Plex and Sonos). In the end I only had the Deconz, Hue, TP-Link and z-wave bindings. I’ve been throwing the dumps into heaphero.io to try and discern patterns and am still working on it. I had to roll back to 2.4 stable for now as I will be traveling and unable to keep an eye on the system for the next 4 days. I still intend to open an issue in GitHub, looking at the other thread about “Openhab filling up Memory and Swap” I realized it need to go into the Core issue tracker and will work to do that.

I suspect my problem is going to boil down to the Hue or z-wave bindings since those 2 are the predominant hits in the logs.

I watched HTOP after the removal of the bindings and using the Kara service restart options. With M6, the memory instantly jumps to 200M at start, gets to 300+M within the first 30-40 seconds and over 400M after the first minute and a half. From that point on it does primarily 1-2M jumps up with the occasional backtrack back down 1M. the system is over 700M by the time the first hour is approaching and continues from there. It varies on how long it takes to fully consume but it’s anywhere from 1-2.5 hours before it exhausts memory and becomes unresponsive. After rolling back it makes it’s away to 370-390 and has been there for 12 hours now.

On previous updates this java entry helped me:

Furthermore I am using the moverules approach to rename the rules before startup and move them back in after a few minutes ramp up time.

Just in case you wanna try this.

After the upgrade of OH to M6 the “say” command doesn’t work anymore

“Error saying ‘Alarm ausgeschaltet’: No TTS service can be found for voice voicerss:deDE”

The VoiceRSS account is tested and works. For me it looks like the language setting itself is wrong - “deDE” - for the test via http-url I use “de-de” and it works, if I use “deDE” I get the mssage “ERROR: The language does not support!”.

many thanks
Christian

@stfn82
What does the following Karaf command output? On my M6 box if just returns the prompt. There should be NO Milestone 5 bundles ionsgtalled. You may need to delete some bundles from the cli.

openhab> bundle:list | grep M5

what is ‘blinds done’?
is that a log statement in one of your rules? I would look at that rule if so, delete the rule or that rules file or whatever temporarily and test again maybe?

I think under the current situation with testing this milestone, everyone reporting problems please list the bindings you are using also because the memory usage issue seems specific to certain bindings or binding

And as Bruce mentioned a java version being an issue please also tell us your version of java. I believe something like this on the command line works in linux

java -version

It is a log statement in my rules. I don’t think the problem is with my rules. (The problems disappear when I downgrade to M5 and in trying to diagnose the problem, I have often moved the rules outside the rule directory.) I have 55 rule files and I think I counted 47 of them reloading. These include really simple rule files. For example this rule file reloads.

rule "System started Rule plug slaapkamer"
when
        System started 
then
       	logInfo("System started Rule", "Plug slaapkamer done")
	plug_slaapkamer_RulesActivated.postUpdate(ON)
end

rule "Change plug"
when
	Item Presence changed
	or
	Item Slaapkamer_Occupied changed
	or
	Item InBed changed
then
	if (Presence.state == ON && Slaapkamer_Occupied.state == ON && InBed.state == OFF){
		sendCommand(PlugSlaapkamer_OnOff, ON)
	}
	else{
		sendCommand(PlugSlaapkamer_OnOff, OFF)
	}
end

Bindings that I’m using:

  • Astro
  • Buienradar
  • Chromecast
  • Enocean
  • Exec
  • Http
  • Hunter Douglas Powerview
  • Max!
  • MQTT
  • Network
  • Openweathermap
  • Samsung TV
  • Squeezebox
  • Systeminfo
  • Wifi led
  • Z-wave

There was at least one case where the issue was using an old version of Zulu Java 8.

1 Like

Thank you, I will give this a shot. Been reading about adjusting heap size via XMS and XMX. When doing my heap dumps yesterday and analyzing them, I see the bulk of the items are in garbage collection and Heaphero won’t show me what those are, not sure if other tools would or not.

I don’t have any rules built up to move or rename. There was 1 rule in there I was testing as a coworker also playing around with OH was looking for more schedule based functions. I removed that rule completely and there was no difference. I primarily us OH as the gateway/gathering hub of devices and then automate using HomeKit out of personal preference.

I hope to be able to test the heap settings back on M6 on Sunday. I’ll let you know. Thank you again.

1 Like

When I’m feeling adventurous this weekend I’ll upgrade to M6 again and let you known.

For the remainder of the week I’d like a house that just works.

I’m on:

openjdk version "1.8.0_222"
OpenJDK Runtime Environment (Zulu8.40.0.178-CA-linux_aarch32hf) (build 1.8.0_222-b178)
OpenJDK Client VM (Zulu8.40.0.178-CA-linux_aarch32hf) (build 25.222-b178, mixed mode, Evaluation)

Addons:

204 │ Active   │  80 │ 2.5.0.201904111020      │ EspMilightHub Binding
206 │ Active   │  80 │ 2.5.0.201911080823      │ openHAB Add-ons :: Bundles :: Home Connect Binding
210 │ Active   │  80 │ 1.1.2                   │ hivemq-mqtt-client
231 │ Active   │  80 │ 1.3.5.0                 │ MariaDB JDBC Client
232 │ Active   │  80 │ 1.14.0.M5               │ openHAB Mail Action
233 │ Active   │  80 │ 1.14.0.M5               │ openHAB Mqtt Action
234 │ Active   │  80 │ 1.14.0.M5               │ openHAB XBMC Action
235 │ Active   │  80 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: Airquality Binding
236 │ Active   │  80 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: Astro Binding
237 │ Active   │  80 │ 1.14.0.M5               │ openHAB ComfoAir Binding
238 │ Active   │  80 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: DSMR Binding
239 │ Active   │  80 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: Exec Binding
240 │ Active   │  80 │ 1.14.0.M5               │ openHAB Expire Binding
241 │ Active   │  80 │ 1.14.0.M5               │ openHAB HTTP Binding
242 │ Active   │  80 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: Kodi Binding
243 │ Active   │  80 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: Log Reader Binding
244 │ Active   │  80 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: Xiaomi Mi IO Binding
245 │ Active   │  80 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: MQTT Broker Binding
246 │ Active   │  81 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: MQTT Things and Channels
247 │ Active   │  82 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: MQTT HomeAssistant Convention
248 │ Active   │  82 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: MQTT Homie Convention
249 │ Active   │  80 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: Network Binding
250 │ Active   │  80 │ 1.14.0.M5               │ openHAB NetworkUpsTools Binding
251 │ Active   │  80 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: NTP Binding
252 │ Active   │  80 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: Onkyo Binding
253 │ Active   │  80 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: OpenUV Binding
254 │ Active   │  80 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: OpenWeatherMap Binding
255 │ Active   │  80 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: SolarEdge Binding
256 │ Active   │  80 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: ZWave Binding
267 │ Active   │  80 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: Extension Service :: Eclipse IoT Marketplace
268 │ Active   │  80 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: IO :: Java Sound Support
269 │ Active   │  80 │ 1.14.0.M5               │ openHAB MQTT Transport Bundle
270 │ Active   │  80 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: IO :: Web Audio Support
275 │ Active   │  75 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: Transformation Service :: JSonPath
276 │ Active   │  75 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: Transformation Service :: Map
277 │ Active   │  75 │ 2.5.0.M5                │ openHAB Add-ons :: Bundles :: Transformation Service :: RegEx
286 │ Active   │  80 │ 1.1.6                   │ org.sputnikdev:org.eclipse.smarthome.binding.bluetooth
287 │ Active   │  80 │ 1.1.3                   │ org.sputnikdev:org.eclipse.smarthome.binding.bluetooth.transport.tinyb
1 Like