[SOLVED] Update to SNAPSHOT #1597 (and later) partially failed (AllPlay(=SOLVED), AmazonDashButton(=SOLVED), wrapper service(=SOLVED), Z-Wave(=SOLVED))

Tags: #<Tag:0x00007f616fe0e8b8> #<Tag:0x00007f616fe0e700> #<Tag:0x00007f616fe0e598>

No, I did not! It’s still there. I have a complete backup of Snapshot-1674 from after 09.09.2019. At 08.09.2019 we did a further test, with a new version, which was not successful. So, everytime I place old version of org.openhab.binding.amazondashbutton-2.5.0-SNAPSHOT.jar from 01.09.2019 (where it was running fine!) back to addons folder it’s getting installed new. New bundle ID. Then I get an error, when I search in inbox:

18:26:59.975 [WARN ] [ommon.WrappedScheduledExecutorService] - Scheduled runnable ended with an exception:
java.lang.UnsatisfiedLinkError: Unable to load library 'wpcap':
Das angegebene Modul wurde nicht gefunden.

Das angegebene Modul wurde nicht gefunden.

Das angegebene Modul wurde nicht gefunden.

Native library (win32-x86-64/wpcap.dll) not found in resource path (C:\Openhab2\userdata\conf;C:\Openhab2\runtime\bin\..\lib\boot\org.apache.karaf.diagnostic.boot-4.2.6.jar;C:\Openhab2\runtime\bin\..\lib\boot\org.apache.karaf.jaas.boot-4.2.6.jar;C:\Openhab2\runtime\bin\..\lib\boot\org.apache.karaf.main-4.2.6.jar;C:\Openhab2\runtime\bin\..\lib\boot\org.apache.karaf.specs.activator-4.2.6.jar;C:\Openhab2\runtime\bin\..\lib\boot\org.osgi.core-6.0.0.jar)
        at com.sun.jna.NativeLibrary.loadLibrary(NativeLibrary.java:302) ~[?:?]
        at com.sun.jna.NativeLibrary.getInstance(NativeLibrary.java:455) ~[?:?]
        at com.sun.jna.NativeLibrary.getInstance(NativeLibrary.java:397) ~[?:?]
        at com.sun.jna.Function.getFunction(Function.java:102) ~[?:?]
        at org.pcap4j.core.NativeMappings.<clinit>(NativeMappings.java:44) ~[?:?]
        at org.pcap4j.core.Pcaps.findAllDevs(Pcaps.java:56) ~[?:?]
        at org.openhab.binding.amazondashbutton.internal.pcap.PcapUtil.getAllNetworkInterfaces(PcapUtil.java:40) ~[?:?]
        at org.openhab.binding.amazondashbutton.internal.pcap.PcapNetworkInterfaceService.determineBoundNetworkInterfaces(PcapNetworkInterfaceService.java:168) ~[?:?]
        at org.openhab.binding.amazondashbutton.internal.pcap.PcapNetworkInterfaceService.lambda$0(PcapNetworkInterfaceService.java:56) ~[?:?]
        at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) ~[?:?]
        at java.util.concurrent.FutureTask.runAndReset(Unknown Source) ~[?:?]
        at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(Unknown Source) ~[?:?]
        at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(Unknown Source) ~[?:?]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) [?:?]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) [?:?]
        at java.lang.Thread.run(Unknown Source) [?:?]
        Suppressed: java.lang.UnsatisfiedLinkError: Das angegebene Modul wurde nicht gefunden.

                at com.sun.jna.Native.open(Native Method) ~[?:?]
                at com.sun.jna.NativeLibrary.loadLibrary(NativeLibrary.java:191) ~[?:?]
                at com.sun.jna.NativeLibrary.getInstance(NativeLibrary.java:455) ~[?:?]
                at com.sun.jna.NativeLibrary.getInstance(NativeLibrary.java:397) ~[?:?]
                at com.sun.jna.Function.getFunction(Function.java:102) ~[?:?]
                at org.pcap4j.core.NativeMappings.<clinit>(NativeMappings.java:44) ~[?:?]
                at org.pcap4j.core.Pcaps.findAllDevs(Pcaps.java:56) ~[?:?]
                at org.openhab.binding.amazondashbutton.internal.pcap.PcapUtil.getAllNetworkInterfaces(PcapUtil.java:40) ~[?:?]
                at org.openhab.binding.amazondashbutton.internal.pcap.PcapNetworkInterfaceService.determineBoundNetworkInterfaces(PcapNetworkInterfaceService.java:168) ~[?:?]
                at org.openhab.binding.amazondashbutton.internal.pcap.PcapNetworkInterfaceService.lambda$0(PcapNetworkInterfaceService.java:56) ~[?:?]
                at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) ~[?:?]
                at java.util.concurrent.FutureTask.runAndReset(Unknown Source) ~[?:?]
                at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(Unknown Source) ~[?:?]
                at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(Unknown Source) ~[?:?]
                at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) [?:?]
                at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) [?:?]
                at java.lang.Thread.run(Unknown Source) [?:?]
        Suppressed: java.lang.UnsatisfiedLinkError: Das angegebene Modul wurde nicht gefunden.

                at com.sun.jna.Native.open(Native Method) ~[?:?]
                at com.sun.jna.NativeLibrary.loadLibrary(NativeLibrary.java:204) ~[?:?]
                at com.sun.jna.NativeLibrary.getInstance(NativeLibrary.java:455) ~[?:?]
                at com.sun.jna.NativeLibrary.getInstance(NativeLibrary.java:397) ~[?:?]
                at com.sun.jna.Function.getFunction(Function.java:102) ~[?:?]
                at org.pcap4j.core.NativeMappings.<clinit>(NativeMappings.java:44) ~[?:?]
                at org.pcap4j.core.Pcaps.findAllDevs(Pcaps.java:56) ~[?:?]
                at org.openhab.binding.amazondashbutton.internal.pcap.PcapUtil.getAllNetworkInterfaces(PcapUtil.java:40) ~[?:?]
                at org.openhab.binding.amazondashbutton.internal.pcap.PcapNetworkInterfaceService.determineBoundNetworkInterfaces(PcapNetworkInterfaceService.java:168) ~[?:?]
                at org.openhab.binding.amazondashbutton.internal.pcap.PcapNetworkInterfaceService.lambda$0(PcapNetworkInterfaceService.java:56) ~[?:?]
                at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) ~[?:?]
                at java.util.concurrent.FutureTask.runAndReset(Unknown Source) ~[?:?]
                at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(Unknown Source) ~[?:?]
                at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(Unknown Source) ~[?:?]
                at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) [?:?]
                at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) [?:?]
                at java.lang.Thread.run(Unknown Source) [?:?]
        Suppressed: java.lang.UnsatisfiedLinkError: Das angegebene Modul wurde nicht gefunden.

                at com.sun.jna.Native.open(Native Method) ~[?:?]
                at com.sun.jna.NativeLibrary.loadLibrary(NativeLibrary.java:265) ~[?:?]
                at com.sun.jna.NativeLibrary.getInstance(NativeLibrary.java:455) ~[?:?]
                at com.sun.jna.NativeLibrary.getInstance(NativeLibrary.java:397) ~[?:?]
                at com.sun.jna.Function.getFunction(Function.java:102) ~[?:?]
                at org.pcap4j.core.NativeMappings.<clinit>(NativeMappings.java:44) ~[?:?]
                at org.pcap4j.core.Pcaps.findAllDevs(Pcaps.java:56) ~[?:?]
                at org.openhab.binding.amazondashbutton.internal.pcap.PcapUtil.getAllNetworkInterfaces(PcapUtil.java:40) ~[?:?]
                at org.openhab.binding.amazondashbutton.internal.pcap.PcapNetworkInterfaceService.determineBoundNetworkInterfaces(PcapNetworkInterfaceService.java:168) ~[?:?]
                at org.openhab.binding.amazondashbutton.internal.pcap.PcapNetworkInterfaceService.lambda$0(PcapNetworkInterfaceService.java:56) ~[?:?]
                at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) ~[?:?]
                at java.util.concurrent.FutureTask.runAndReset(Unknown Source) ~[?:?]
                at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(Unknown Source) ~[?:?]
                at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(Unknown Source) ~[?:?]
                at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) [?:?]
                at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) [?:?]
                at java.lang.Thread.run(Unknown Source) [?:?]
        Suppressed: java.io.IOException: Native library (win32-x86-64/wpcap.dll) not found in resource path (C:\Openhab2\userdata\conf;C:\Openhab2\runtime\bin\..\lib\boot\org.apache.karaf.diagnostic.boot-4.2.6.jar;C:\Openhab2\runtime\bin\..\lib\boot\org.apache.karaf.jaas.boot-4.2.6.jar;C:\Openhab2\runtime\bin\..\lib\boot\org.apache.karaf.main-4.2.6.jar;C:\Openhab2\runtime\bin\..\lib\boot\org.apache.karaf.specs.activator-4.2.6.jar;C:\Openhab2\runtime\bin\..\lib\boot\org.osgi.core-6.0.0.jar)
                at com.sun.jna.Native.extractFromResourcePath(Native.java:1095) ~[?:?]
                at com.sun.jna.NativeLibrary.loadLibrary(NativeLibrary.java:276) ~[?:?]
                at com.sun.jna.NativeLibrary.getInstance(NativeLibrary.java:455) ~[?:?]
                at com.sun.jna.NativeLibrary.getInstance(NativeLibrary.java:397) ~[?:?]
                at com.sun.jna.Function.getFunction(Function.java:102) ~[?:?]
                at org.pcap4j.core.NativeMappings.<clinit>(NativeMappings.java:44) ~[?:?]
                at org.pcap4j.core.Pcaps.findAllDevs(Pcaps.java:56) ~[?:?]
                at org.openhab.binding.amazondashbutton.internal.pcap.PcapUtil.getAllNetworkInterfaces(PcapUtil.java:40) ~[?:?]
                at org.openhab.binding.amazondashbutton.internal.pcap.PcapNetworkInterfaceService.determineBoundNetworkInterfaces(PcapNetworkInterfaceService.java:168) ~[?:?]
                at org.openhab.binding.amazondashbutton.internal.pcap.PcapNetworkInterfaceService.lambda$0(PcapNetworkInterfaceService.java:56) ~[?:?]
                at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) ~[?:?]
                at java.util.concurrent.FutureTask.runAndReset(Unknown Source) ~[?:?]
                at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(Unknown Source) ~[?:?]
                at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(Unknown Source) ~[?:?]
                at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) [?:?]
                at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) [?:?]
                at java.lang.Thread.run(Unknown Source) [?:?]

There’s now a #1704 build with a fix so those bundles should no longer remain in the “Waiting” state.

1 Like

@J-N-K

I got it finaly running again with Snapshot 1674. But only with this file:

First version from ‎Sonntag, ‎1. ‎September ‎2019 of this: (see here)

230 │ Active │  80 │ 2.5.0.201909010813    │ openHAB Add-ons :: Bundles :: Amazon Dash Button Binding

https://janessa.me/esh/org.openhab.binding.amazondashbutton-2.5.0-SNAPSHOT.jar
.

But NOT and never again with this combination: https://janessa.me/esh/dashbutton-1.8.2.zip

I wanted to exclude problems due to Windows 10 Updates.

So, now I could try Snapshot 1704…
.
.

EDIT: I’ve tried 1704. Same error:

20:48:15.163 [WARN ] [pcap4j.packet.factory.PacketFactories] - No PacketFactoryBinder is available. All packets will be captured as UnknownPacket.

Same like in 1702, 1703. No DashButton is discovered in inbox while searching!
.
.

@wborn
The other errors = “Waiting” are indeed gone! :slight_smile:

1 Like

.

20:48:15.163 [WARN ] [pcap4j.packet.factory.PacketFactories] - No PacketFactoryBinder is available. All packets will be captured as UnknownPacket.

.

I’ve never ever had this message before. And with this message, no DashButtons are running! Should I provide a TRACE log?

.
Maybe you mix it up with:

19:24:03.271 [WARN ] [pcap4j.packet.factory.PacketFactories] - java.lang.NoClassDefFoundError:org/pcap4j/packet/factory/PacketFactoryBinder

See also this post.

But this seems to be different…?

@J-N-K

I’ve now tried Snapshot 1705, same issue:

.

19:23:18.268 [WARN ] [pcap4j.packet.factory.PacketFactories] - No PacketFactoryBinder is available. All packets will be captured as UnknownPacket.

.
.
Then I’ve put your version 2.5.0.201909010813 (from 01.09.2019) into addons folder:

212 │ Active │  80 │ 2.5.0.201909010813    │ openHAB Add-ons :: Bundles :: Amazon Dash Button Binding

.
.
Dashbutton is running! :slight_smile:

@J-N-K

19:23:18.268 [WARN ][pcap4j.packet.factory.PacketFactories] - No PacketFactoryBinder is available. All packets will be captured as UnknownPacket.

Are you still willing to solve this error? If there are any further information neccessary then please let me know! Thanks a lot! :slight_smile:

same here with the Astro binding.

@J-N-K

A simple “NO, BECAUSE…” or “YES, BUT…” would be enough as a first reply. Thanks a lot! :slight_smile:

I appreciate your help very much and I know that all contributions are made voluntarily and in leisure. Nevertheless a short answer would be very polite. :slight_smile:

I have enough patience and I still can wait. Mainly the error will be solved later sometime.

It may be that I was on holiday.

1 Like

@J-N-K

I want kindly ask you if you had time to resolve the problem or when you will have time to do this? :slight_smile:

I’ll try to check this weekend.

1 Like

Just to keep you updated: I did start, but not sure what the real problem is.

Thank you very much for information. If this would help, I could provide a TRACE log. It seems to be that Raw 802.11 Packet Capture is not running.

Here the search inbox / capturing with old binding, running:

14:57:41.821 [WARN ] [org.pcap4j.util.PropertiesLoader     ] - [org/pcap4j/pcap4j.properties] Could not get value by org.pcap4j.af.inet, use default value: null
14:57:41.823 [WARN ] [org.pcap4j.util.PropertiesLoader     ] - [org/pcap4j/pcap4j.properties] Could not get value by org.pcap4j.af.inet6, use default value: null
14:57:41.824 [WARN ] [org.pcap4j.util.PropertiesLoader     ] - [org/pcap4j/pcap4j.properties] Could not get value by org.pcap4j.af.packet, use default value: null
14:57:41.829 [WARN ] [org.pcap4j.util.PropertiesLoader     ] - [org/pcap4j/pcap4j.properties] Could not get value by org.pcap4j.af.link, use default value: null
14:57:41.851 [WARN ] [org.pcap4j.util.PropertiesLoader     ] - [org/pcap4j/pcap4j.properties] Could not get value by org.pcap4j.dlt.raw, use default value: null
14:57:41.873 [DEBUG] [rnal.capturing.PacketCapturingService] - Started capturing ARP and BOOTP requests for network device \Device\NPF_{51EB6D2C-7C1A-49CC-882F-E6BF6936D570}.
14:57:41.874 [DEBUG] [very.AmazonDashButtonDiscoveryService] - Started capturing for \Device\NPF_{51EB6D2C-7C1A-49CC-882F-E6BF6936D570}.
14:57:53.353 [DEBUG] [very.AmazonDashButtonDiscoveryService] - Captured a packet from ac:63:be:xx:xx:xx which seems to be sent from an Amazon Dash Button device.
14:57:53.356 [INFO ] [ig.discovery.internal.PersistentInbox] - Added new thing 'amazondashbutton:dashbutton:ac-63-be-XX-XX-XX' to inbox.
14:57:53.356 [INFO ] [smarthome.event.InboxAddedEvent      ] - Discovery Result with UID 'amazondashbutton:dashbutton:ac-63-be-XX-XX-XX' has been added.
14:57:53.357 [DEBUG] [very.AmazonDashButtonDiscoveryService] - Captured a packet from ac:63:be:xx:xx:xx which seems to be sent from an Amazon Dash Button device.
14:58:11.168 [DEBUG] [rnal.capturing.PacketCapturingService] - Stopped capturing ARP and BOOTP requests for network device \Device\NPF_{51EB6D2C-7C1A-49CC-882F-E6BF6936D570}.
14:58:11.172 [DEBUG] [very.AmazonDashButtonDiscoveryService] - Stopped capturing for \Device\NPF_{51EB6D2C-7C1A-49CC-882F-E6BF6936D570}.

And here with the new binding, not running:

15:04:24.990 [DEBUG] [rnal.capturing.PacketCapturingService] - Started capturing ARP and BOOTP requests for network device \Device\NPF_{51EB6D2C-7C1A-49CC-882F-E6BF6936D570}.
15:04:24.991 [DEBUG] [very.AmazonDashButtonDiscoveryService] - Started capturing for \Device\NPF_{51EB6D2C-7C1A-49CC-882F-E6BF6936D570}.
15:04:25.737 [WARN ] [pcap4j.packet.factory.PacketFactories] - No PacketFactoryBinder is available. All packets will be captured as UnknownPacket.
15:04:54.573 [DEBUG] [rnal.capturing.PacketCapturingService] - Stopped capturing ARP and BOOTP requests for network device \Device\NPF_{51EB6D2C-7C1A-49CC-882F-E6BF6936D570}.
15:04:54.576 [DEBUG] [very.AmazonDashButtonDiscoveryService] - Stopped capturing for \Device\NPF_{51EB6D2C-7C1A-49CC-882F-E6BF6936D570}.

.
A TRACE does not bring any further information.

Ok. There seems to be a problem with OSGi and the java service loader. Can you install the latest version from snapshot and then bundle:update <number> https://janessa.me/esh/org.openhab.binding.amazondashbutton-fsl.jar, bundle:restart <number> and see if it works? At least in my test setup I do not see the No PacketFactoryBinder is available. any longer.

1 Like

@J-N-K

before update:

290 │ Active │  80 │ 5.4.0                 │ jna
291 │ Active │  80 │ 2.5.0.201911150329    │ openHAB Add-ons :: Bundles :: Amazon Dash Button Binding 

after update:

290 │ Active │  80 │ 5.4.0                 │ jna
291 │ Active │  80 │ 2.5.0.201911160912    │ openHAB Add-ons :: Bundles :: Amazon Dash Button Binding

.

logging while searching inbox for Amazon Dash Buttons:

14:19:36.688 [INFO ] [very.AmazonDashButtonDiscoveryService] - starting capture
14:19:52.320 [INFO ] [ig.discovery.internal.PersistentInbox] - Added new thing 'amazondashbutton:dashbutton:ac-63-be-xx-xx-xx' to inbox.
14:19:52.320 [INFO ] [smarthome.event.InboxAddedEvent      ] - Discovery Result with UID 'amazondashbutton:dashbutton:ac-63-be-xx-xx-xx' has been added.
14:20:02.304 [INFO ] [smarthome.event.InboxAddedEvent      ] - Discovery Result with UID 'amazondashbutton:dashbutton:6c-56-97-xx-xx-xx' has been added.
14:20:02.304 [INFO ] [ig.discovery.internal.PersistentInbox] - Added new thing 'amazondashbutton:dashbutton:6c-56-97-xx-xx-xx' to inbox.
14:20:07.274 [INFO ] [smarthome.event.InboxRemovedEvent    ] - Discovery Result with UID 'amazondashbutton:dashbutton:ac-63-be-xx-xx-xx' has been removed.
14:20:07.295 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'amazondashbutton:dashbutton:ac-63-be-xx-xx-xx' changed from UNINITIALIZED to INITIALIZING
14:20:07.700 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'amazondashbutton:dashbutton:ac-63-be-xx-xx-xx' changed from INITIALIZING to ONLINE

.

.
And event is also detected again:

14:43:56.476 [INFO ] [smarthome.event.ChannelTriggeredEvent] - amazondashbutton:dashbutton:ac-63-be-xx-xx-xx:press triggered PRESSED

.
.

NO ERRORS. :slight_smile:

This seems to be OK now! Thanks a lot! :slight_smile:

I’ve tested it on two different Windows machines!
:
But one thing is strange. Now the binding also finds Amazon Echos (or something else),

beginning with MAC-Address: 6c-56-97 and beginning with 40-b4-cd

Maybe you have to put it on the “exclusion list”? EDIT: They are on the “inclusion list”, see next post!

When is it expected that this solution will be integrated into a snapshot? Please let me know. Thanks again.

Is there an exclusion list? I‘ll check that. I didn‘t touch any code, just added missing bundle headers, so I‘m a little bit astonished that this did not happen before.

Edit: There is only an inclusion list. And that contains these prefixes, so they were added by intention. I’m not sure if it is a good idea to remove them.

@J-N-K

Better an “inclusion list”… :wink:


.
.

OK. My Echos seems to begin with an allowed MAC-Prefix. Forget abot that!
So it is SOLVED now!!! :heart:

Regarding your other question: when https://github.com/openhab/openhab2-addons/pull/6404 is merged.

1 Like

@J-N-K

I saw that PR 6404 was merged.

I’ve installed latest snapshot of binding from here:

bundle:update 291 https://openhab.jfrog.io/openhab/libs-pullrequest-local/org/openhab/addons/bundles/org.openhab.binding.amazondashbutton/2.5.0-SNAPSHOT/org.openhab.binding.amazondashbutton-2.5.0-SNAPSHOT.jar 

.
.
IT IS RUNNING! :slight_smile:

Thank you very much! Well done! :heart: