[OH 2.4.0 M6] Testing Results

yphyph01 · November 23, 2018, 4:54pm

Hello,
I’ve get a try to the M6 milestones. Good work from the team as always

Here are some findings after the lauch of openHAB (or simply I miss a steop??)

17:46:08.433 [WARN ] [.internal.service.FeaturesServiceImpl] - Can’t load features repository mvn:org.openhab.distro/distro/2.4.0-SNAPSHOT/xml/features
java.lang.RuntimeException: Error resolving artifact org.openhab.distro:distro:xml:features:2.4.0-SNAPSHOT: [Could not find artifact org.openhab.distro:distro:xml:features:2.4.0-SNAPSHOT in openhab (https://openhab.jfrog.io/openhab/online-repo-snapshot/2.4/)] : mvn:org.openhab.distro/distro/2.4.0-SNAPSHOT/xml/features
at org.apache.karaf.features.internal.service.RepositoryImpl.load(RepositoryImpl.java:116) ~[?:?]
at org.apache.karaf.features.internal.service.RepositoryImpl.(RepositoryImpl.java:50) ~[?:?]
at org.apache.karaf.features.internal.service.RepositoryCacheImpl.create(RepositoryCacheImpl.java:51) ~[?:?]
at org.apache.karaf.features.internal.service.FeaturesServiceImpl.getFeatureCache(FeaturesServiceImpl.java:593) ~[?:?]
at org.apache.karaf.features.internal.service.FeaturesServiceImpl.listInstalledFeatures(FeaturesServiceImpl.java:643) ~[?:?]
at org.openhab.core.karaf.internal.FeatureInstaller.installFeature(FeatureInstaller.java:450) ~[?:?]
at org.openhab.core.karaf.internal.FeatureInstaller.installPackage(FeatureInstaller.java:491) ~[?:?]
at org.openhab.core.karaf.internal.FeatureInstaller.lambda$2(FeatureInstaller.java:163) ~[?:?]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:?]
at java.lang.Thread.run(Thread.java:748) [?:?]
Caused by: java.io.IOException: Error resolving artifact org.openhab.distro:distro:xml:features:2.4.0-SNAPSHOT: [Could not find artifact org.openhab.distro:distro:xml:features:2.4.0-SNAPSHOT in openhab (https://openhab.jfrog.io/openhab/online-repo-snapshot/2.4/)]
at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:720) ~[?:?]
at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:659) ~[?:?]
at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:600) ~[?:?]
at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:567) ~[?:?]
at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:557) ~[?:?]
at org.ops4j.pax.url.mvn.internal.Connection.getInputStream(Connection.java:123) ~[?:?]
at java.net.URL.openStream(URL.java:1045) ~[?:?]
at org.apache.karaf.features.internal.service.RepositoryImpl.load(RepositoryImpl.java:113) ~[?:?]
… 10 more
Suppressed: shaded.org.eclipse.aether.transfer.ArtifactNotFoundException: Could not find artifact org.openhab.distro:distro:xml:features:2.4.0-SNAPSHOT in openhab (https://openhab.jfrog.io/openhab/online-repo-snapshot/2.4/)
at shaded.org.eclipse.aether.connector.basic.ArtifactTransportListener.transferFailed(ArtifactTransportListener.java:39) ~[?:?]
at shaded.org.eclipse.aether.connector.basic.BasicRepositoryConnector$TaskRunner.run(BasicRepositoryConnector.java:355) ~[?:?]
at shaded.org.eclipse.aether.util.concurrency.RunnableErrorForwarder$1.run(RunnableErrorForwarder.java:67) ~[?:?]
at shaded.org.eclipse.aether.connector.basic.BasicRepositoryConnector$DirectExecutor.execute(BasicRepositoryConnector.java:581) ~[?:?]
at shaded.org.eclipse.aether.connector.basic.BasicRepositoryConnector.get(BasicRepositoryConnector.java:249) ~[?:?]
at shaded.org.eclipse.aether.internal.impl.DefaultArtifactResolver.performDownloads(DefaultArtifactResolver.java:520) ~[?:?]
at shaded.org.eclipse.aether.internal.impl.DefaultArtifactResolver.resolve(DefaultArtifactResolver.java:421) ~[?:?]
at shaded.org.eclipse.aether.internal.impl.DefaultArtifactResolver.resolveArtifacts(DefaultArtifactResolver.java:246) ~[?:?]
at shaded.org.eclipse.aether.internal.impl.DefaultArtifactResolver.resolveArtifact(DefaultArtifactResolver.java:223) ~[?:?]
at shaded.org.eclipse.aether.internal.impl.DefaultRepositorySystem.resolveArtifact(DefaultRepositorySystem.java:294) ~[?:?]
at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:705) ~[?:?]
at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:659) ~[?:?]
at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:600) ~[?:?]
at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:567) ~[?:?]
at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:557) ~[?:?]
at org.ops4j.pax.url.mvn.internal.Connection.getInputStream(Connection.java:123) ~[?:?]
at java.net.URL.openStream(URL.java:1045) ~[?:?]
at org.apache.karaf.features.internal.service.RepositoryImpl.load(RepositoryImpl.java:113) ~[?:?]
at org.apache.karaf.features.internal.service.RepositoryImpl.(RepositoryImpl.java:50) ~[?:?]
at org.apache.karaf.features.internal.service.RepositoryCacheImpl.create(RepositoryCacheImpl.java:51) ~[?:?]
at org.apache.karaf.features.internal.service.FeaturesServiceImpl.getFeatureCache(FeaturesServiceImpl.java:593) ~[?:?]
at org.apache.karaf.features.internal.service.FeaturesServiceImpl.listInstalledFeatures(FeaturesServiceImpl.java:643) ~[?:?]
at org.openhab.core.karaf.internal.FeatureInstaller.installFeature(FeatureInstaller.java:450) ~[?:?]
at org.openhab.core.karaf.internal.FeatureInstaller.installPackage(FeatureInstaller.java:491) ~[?:?]
at org.openhab.core.karaf.internal.FeatureInstaller.lambda$2(FeatureInstaller.java:163) ~[?:?]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:?]
at java.lang.Thread.run(Thread.java:748) [?:?]
Caused by: shaded.org.eclipse.aether.resolution.ArtifactResolutionException: Error resolving artifact org.openhab.distro:distro:xml:features:2.4.0-SNAPSHOT
at shaded.org.eclipse.aether.internal.impl.DefaultArtifactResolver.resolve(DefaultArtifactResolver.java:444) ~[?:?]
at shaded.org.eclipse.aether.internal.impl.DefaultArtifactResolver.resolveArtifacts(DefaultArtifactResolver.java:246) ~[?:?]
at shaded.org.eclipse.aether.internal.impl.DefaultArtifactResolver.resolveArtifact(DefaultArtifactResolver.java:223) ~[?:?]
at shaded.org.eclipse.aether.internal.impl.DefaultRepositorySystem.resolveArtifact(DefaultRepositorySystem.java:294) ~[?:?]
at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:705) ~[?:?]
at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:659) ~[?:?]
at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:600) ~[?:?]
at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:567) ~[?:?]
at org.ops4j.pax.url.mvn.internal.AetherBasedResolver.resolve(AetherBasedResolver.java:557) ~[?:?]
at org.ops4j.pax.url.mvn.internal.Connection.getInputStream(Connection.java:123) ~[?:?]
at java.net.URL.openStream(URL.java:1045) ~[?:?]
at org.apache.karaf.features.internal.service.RepositoryImpl.load(RepositoryImpl.java:113) ~[?:?]
… 10 more
17:46:08.537 [ERROR] [.core.karaf.internal.FeatureInstaller] - Failed installing ‘openhab-package-expert’: No matching features for openhab-package-expert/0

and also

17:46:21.221 [ERROR] [.core.karaf.internal.FeatureInstaller] - Failed installing ‘openhab-misc-restdocs’: Unable to resolve root: missing requirement [root] osgi.identity; osgi.identity=openhab-runtime-base; type=karaf.feature; version=“[2.4.0.SNAPSHOT,2.4.0.SNAPSHOT]”; filter:=“(&(osgi.identity=openhab-runtime-base)(type=karaf.feature)(version>=2.4.0.SNAPSHOT)(version<=2.4.0.SNAPSHOT))”
17:46:22.808 [WARN ] [ome.core.internal.events.EventHandler] - Dispatching event to subscriber ‘org.eclipse.smarthome.io.monitor.internal.EventLogger@231e47de’ takes more than 5000ms.

my system info:

openhab> info
Karaf
Karaf version 4.2.1
Karaf home /volume1/@appstore/openHAB/runtime
Karaf base /volume1/public/openHAB/userdata
OSGi Framework org.eclipse.osgi-3.12.100.v20180210-1608

JVM
  Java Virtual Machine        Java HotSpot(TM) 64-Bit Server VM version 25.191-b12
  Version                     1.8.0_191
  Vendor                      Oracle Corporation
  Pid                         11016
  Uptime                      22 minutes
  Process CPU time            7 minutes
  Process CPU load            0.04
  System CPU load             0.31
  Open file descriptors       268
  Max file descriptors        4,096
  Total compile time          4 minutes
Threads
  Live threads                181
  Daemon threads              91
  Peak                        232
  Total started               1851
Memory
  Current heap size           88,614 kbytes
  Maximum heap size           2,023,424 kbytes
  Committed heap size         126,976 kbytes
  Pending objects             0
  Garbage collector           Name = 'G1 Young Generation', Collections = 222, Time = 5.294 seconds
  Garbage collector           Name = 'G1 Old Generation', Collections = 0, Time = 0.000 seconds
Classes
  Current classes loaded      18,354
  Total classes loaded        18,405
  Total classes unloaded      51
Operating system
  Name                        Linux version 3.10.105
  Architecture                amd64
  Processors                  4

Hope this could help
Regards

Dim · November 23, 2018, 4:57pm

this is the second time that I see this and I am getting worried (because I can’t understand where it’s coming from)…

how did you upgrade your OH2.4.0S# (Snapshot #?) to OH2.4.0M6 ? using apt?

Somehow the upgrade process leaves some configs not updated and your OH2 keeps looking at the wrong repo…

yphyph01 · November 23, 2018, 5:01pm

Not really … I’ve used the relesed package 2.3.0.5
Open and edit the file “installer.sh” within the “scripts” directory to update:

DOWNLOAD_PATH=“JFrog”
DOWNLOAD_FILE1=“openhab-2.4.0.M6.zip”

… Save the new zip and go …
Same procedure I usually use

Dim · November 23, 2018, 5:09pm

oh… you are on DSM6 and using a custom script… How to update OH2 on Synology? - #2 by yphyph01

you need to dig into the dirs to see what is going on. Maybe some snapshot stuff were left over.

yphyph01 · November 23, 2018, 5:12pm

Custom … not really
I’m using the following package: https://github.com/openhab/openhab-syno-spk/releases

Dim · November 23, 2018, 5:14pm

that package is 2.3.0.5
there is no M6 spk (yet)
this: script looks like custom made to me

anyway… you need to double check your dirs for various “left-overs” from previous snapshot upgrade attempts.

Dim · November 23, 2018, 5:37pm

the third time I see this (1 time on regular Linux host, 2 times on DSM)

For the DSM users: you guys need to check the files in userdata to see why there are old configs there pointing to snapshot repos.

It seems that following 2.3.0.5 you deployed 2.4 snapshots using various methods since the spk packages were not being renewed.

Now, you are trying to use the same methods to deploy 2.4.0.M6 (understandable, since you want the latest and greatest and can’t wait for an “official” release) but I don’t know what could have gone wrong during the upgrade process… I don’t own a Synology NAS to test this stuff out )

I would try to clean up as much as possible the userdata subfolders and re-deploy 2.4.0M6

backup your stuff before you go wild !

yphyph01 · November 23, 2018, 6:32pm

@Dim
Any suggestions where to find the link to those ‘old’ configs? in which file to look at?

job · November 23, 2018, 8:45pm

@ptweety, do these types of definition still work with M6?

Color WZWL_COLOR "Wand" { channel="hue:0210:0017884f6873:1:color,hue:0210:0017884f6873:37:color" }
Switch F2WL_TOGGLE "Flur 2.OG Ein/Aus" {channel="hue:0100:0017884f6873:6:brightness", expire="10m,command=OFF"}

Dim · November 23, 2018, 10:39pm

In Linux (/var/lib/openhab2 = userdata) , you may find some old reference in this file: /var/lib/openhab2/config/org/apache/karaf/features.config

for example, an older 2.4.0.M5 installation which was upgraded to M6 had left behind this entry:

featuresRepositories="mvn:org.openhab.distro/distro/2.4.0.M5/xml/features,\ mvn:org.openhab.distro/openhab-addons/2.4.0.M5/xml/features,\ mvn:org.apache.karaf.features/framework/4.2.1/xml/features,\ mvn:org.apache.karaf.features/standard/4.2.1/xml/features"

I would do the following (use caution!)

Backup everything wrt OH2.x on my DSM
delete everything (but not the directory itself) within userdata except jsondb and persistence and zwave (if used)
delete everything (but not the directory itself) within runtime dir
keep conf
unzip the 2.4.0.M6 contents (only need userdata and runtime)

I don’t know exactly which are the full paths on DSM of ${OH_FOLDER}/addons & ${OH_FOLDER}/userdata. It depends where is your public folder located.

hilbrand · November 23, 2018, 10:51pm

Matthias,

I tried to reproduce your problem But I can’t reproduce it. It might be specific to hue, but can’t test that. I suspect the context this messages are given doesn’t result in any problems. It looks like it wants to register the channel as metadata. Metadata should have an unique key, so the message seems correct. But I don’t think it should do something with channel. But I don’t know why it does. Therefor can you give some more feedback:

Did you upgrade from another openHAB version and if so, which one?
If you upgraded can you clear your cache and restart to see if this message persists.
If the message keeps showing when starting or I guess when reloading the items page, can you enable trace log level org.eclipse.smarthome.core and provide me the log.

Maybe this will give some more inside into why this happens.

Dim · November 23, 2018, 11:57pm

added JVM info on the OP

Dim · November 24, 2018, 10:24am

fast implementation! Love it (off topic for M6 since I am running Snapshot also)

Setting up openhab2 (2.4.0~S1442-1) ...

root@homer:/var/log/openhab2# apt-get upgrade
Reading package lists... Done
Building dependency tree       
Reading state information... Done
Calculating upgrade... Done
The following packages will be upgraded:
  openhab2
1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
Need to get 73.5 MB of archives.
After this operation, 0 B of additional disk space will be used.
Do you want to continue? [Y/n] y
Get:1 https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main openhab2 all 2.4.0~S1442-1 [73.5 MB]
Fetched 73.5 MB in 7s (9,788 kB/s)                                                                                                                                         
Reading changelogs... Done
(Reading database ... 65897 files and directories currently installed.)
Preparing to unpack .../openhab2_2.4.0~S1442-1_all.deb ...
Unpacking openhab2 (2.4.0~S1442-1) over (2.4.0~S1441-1) ...
Processing triggers for systemd (215-17+deb8u8) ...
Setting up openhab2 (2.4.0~S1442-1) ...

Listing important changes for version 2.4.0:
  Warning:  Astro Binding: The 'kilometer' and 'miles' channels have been replaced by a new 'distance' channel
  Warning:  Jeelink Binding: The 'currentWatt' and 'maxWatt' channels have been replaced with 'currentPower' and 'maxPower' channels
  Warning:  WeatherUnderground Binding: A bridge has been added on top of the current things, you need to add a bridge containing your api-key.
  Warning:  ZWave Binding: Major changes have been merged to support features such as security. All things must be deleted and re-added. Refer to https://community.openhab.org/t/zwave-binding-updates/51080 for further information.
  Warning:  Synop Binding is now using UoM. 'wind-speed-ms' and 'wind-speed-knots' channels have been replaced by a single 'wind-speed' channel.

root@homer:/var/log/openhab2# apt-cache madison openhab2
  openhab2 | 2.4.0~S1442-1 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
  openhab2 | 2.4.0~S1441-1 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
  openhab2 | 2.4.0~S1440-1 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
  openhab2 | 2.4.0~20181122162220-1 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
  openhab2 | 2.4.0~20181122141057-1 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
  openhab2 | 2.4.0~20181122121219-1 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
  openhab2 | 2.4.0~20181122105226-1 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
  openhab2 | 2.4.0~20181122034436-1 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
  openhab2 | 2.4.0~20181121231425-1 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
  openhab2 | 2.4.0~20181121003414-1 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
  openhab2 | 2.4.0~20181119183855-1 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
  openhab2 | 2.4.0~20181118113913-1 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
  openhab2 | 2.4.0~20181117214013-1 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
  openhab2 | 2.4.0~20181117181319-1 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
  openhab2 | 2.4.0~20181117002418-1 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
  openhab2 | 2.4.0~20181115123158-1 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
  openhab2 |    2.3.0-1 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
  openhab2 | 2.3.0~RC2-1 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
  openhab2 | 2.3.0~RC1-1 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
  openhab2 |    2.2.0-1 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
  openhab2 |    2.1.0-2 | https://openhab.jfrog.io/openhab/openhab-linuxpkg/ unstable/main amd64 Packages
root@homer:/var/log/openhab2#

Ps: @Benjy why keep the old stuff from 2.1, 2.2 and 2.3 RC in the unstable repo ?

Master79 · November 24, 2018, 3:12pm

Hi to all.
I hope i can ask this here.
After changing from openhab 2.3 stable to 2.4 M5, I got this error and a crash:

org.openhab.io.net.http.HttpUtil ] - Fatal transport error: java.net.SocketException: Too many open files 2018-11-04 02:08:31.717 [ERROR] [ab.binding.http.internal.HttpBinding] - No response received from:.

I am happy that i could downgrade again and 2.3 runs great. But i am very interested in some new options.
Now the question is, was there a change in the http binding or error, which is now fixed with M6?
Thanks for help and greetings,
Markus.

Dim · November 24, 2018, 9:42pm

what is your java -version ?

Is this error related to a specific binding? (for example: Hue)

Master79 · November 24, 2018, 11:01pm

Hi Dim.
Yes, the first error comes from a hue bridge. This one has motion sensors.
Java version is Runtime Enviroment (zulu 8.33.0.1-linux64) (build 1.8.0_192-b01)

Dim · November 24, 2018, 11:08pm

if this is your Item config:

Switch   HueMotion1           "HueMotion1"               {http="<[http://192.168.1.118/api/***/sensors/11:750:JS(getHueMotion.js)]"}

… you are killing your system with 750 milliseconds refresh time on the http call

increase it

Master79 · November 24, 2018, 11:11pm

But with 2.3 stable it runs. And i tested it with 2500ms. Nothing changes. Could it be a problem that Java is zulu linux64?

Dim · November 24, 2018, 11:15pm

No, I don’t think that JVM is the problem… you have the latest Zulu
you could try the 32bit one to see if things improve
in general, this is Java +O/S issue (too many open files)
you will find several discussions around this on google

You are calling every 0,75 seconds an HTTP Call + a JS transformation sitting on a file… that’s overkill

that’s like putting Motorhead to optimize your openHAB installation

Master79 · November 24, 2018, 11:20pm

Okay. I understand. But i need this for the motion sensors. If i take a time of 5000ms, I am at the end of the room and the lights are still off. And why does it run under OH 2.3. without problems?