All ZWave things suddenly show ERROR:BRIDGE

justinwilczek · July 2, 2025, 5:28pm

I have an Openhabian installation running with a ZWave serial stick for a rather long time now. Recently all of my zwave automations quit working, which has happened randomly before but usually could be resolved by replugging the stick and restarting openhab.

Recently things quit working again, and now I am stuck with all of my zwave things showing “ERROR:BRIDGE”. Checking the thing for the stick, it shows the same as all of the rest of the things…

I have double checked that nothing changed with the serial port device name.

[47810.001646] usb 1-1.4: new full-speed USB device number 6 using dwc_otg
[47810.149636] usb 1-1.4: New USB device found, idVendor=10c4, idProduct=ea60, bcdDevice= 1.00
[47810.161039] usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[47810.170214] usb 1-1.4: Product: CP2102 USB to UART Bridge Controller
[47810.178498] usb 1-1.4: Manufacturer: Silicon Labs
[47810.185368] usb 1-1.4: SerialNumber: 0001
[47810.210754] cp210x 1-1.4:1.0: cp210x converter detected
[47810.230195] usb 1-1.4: cp210x converter now attached to ttyUSB0

I enabled TRACE logging on the zwave binding to see if I could get any more detailed clues by disabling and re-enabling the serial stick, but not much revealing there. No warnings or errors or anything.

openhab> log:get org.openhab.binding.zwave
TRACE

2025-07-02 11:36:53.455 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 22: Handler disposed. Unregistering listener.
2025-07-02 11:36:53.504 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 29: Handler disposed. Unregistering listener.
2025-07-02 11:36:53.556 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 28: Handler disposed. Unregistering listener.
2025-07-02 11:36:53.607 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Handler disposed. Unregistering listener.
2025-07-02 11:36:53.658 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 26: Handler disposed. Unregistering listener.
2025-07-02 11:36:53.713 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 14: Handler disposed. Unregistering listener.
2025-07-02 11:36:53.761 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Handler disposed. Unregistering listener.
2025-07-02 11:36:53.810 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 11: Handler disposed. Unregistering listener.
2025-07-02 11:36:53.860 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 10: Handler disposed. Unregistering listener.
2025-07-02 11:36:53.910 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 19: Handler disposed. Unregistering listener.
2025-07-02 11:36:53.970 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 17: Handler disposed. Unregistering listener.
2025-07-02 11:36:54.020 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 16: Handler disposed. Unregistering listener.
2025-07-02 11:36:54.070 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: Handler disposed. Unregistering listener.
2025-07-02 11:36:54.116 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Disposing receive thread
2025-07-02 11:36:54.118 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Receive thread dispose
2025-07-02 11:36:54.120 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Disposing serial connection
2025-07-02 11:36:54.122 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Serial connection disposed
2025-07-02 11:36:54.123 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Stopped ZWave serial handler
2025-07-02 11:36:54.134 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - ZWave discovery: Deactivate zwave:serial_zstick:497f3296
2025-07-02 11:37:02.191 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - Creating ZWave discovery service for zwave:serial_zstick:497f3296 with scan time of 60
2025-07-02 11:37:02.194 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - ZWave discovery: Active zwave:serial_zstick:497f3296
2025-07-02 11:37:02.196 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Attempting to add listener when controller is null
2025-07-02 11:37:02.273 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Initializing ZWave serial controller.
2025-07-02 11:37:02.275 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Initializing ZWave Controller zwave:serial_zstick:497f3296.
2025-07-02 11:37:02.374 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node24.
2025-07-02 11:37:02.390 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node5.
2025-07-02 11:37:02.395 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node9.
2025-07-02 11:37:02.459 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node3.
2025-07-02 11:37:02.486 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node12.
2025-07-02 11:37:02.495 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node23.
2025-07-02 11:37:02.507 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node2.
2025-07-02 11:37:02.526 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node22.
2025-07-02 11:37:02.573 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node11.
2025-07-02 11:37:02.586 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node31.
2025-07-02 11:37:02.659 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node32.
2025-07-02 11:37:02.666 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node29.
2025-07-02 11:37:02.676 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node10.
2025-07-02 11:37:02.687 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node30.
2025-07-02 11:37:02.698 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node19.
2025-07-02 11:37:02.756 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node28.
2025-07-02 11:37:02.788 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node17.
2025-07-02 11:37:02.822 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node27.
2025-07-02 11:37:02.829 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node15.
2025-07-02 11:37:02.834 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: MANUFACTURER not set
2025-07-02 11:37:02.836 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node26.
2025-07-02 11:37:02.847 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node16.
2025-07-02 11:37:02.900 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node25.
2025-07-02 11:37:02.952 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node14.

Thing code for the stick, if it is of any interest…

UID: zwave:serial_zstick:497f3296
label: Z-Wave Serial Controller
thingTypeUID: zwave:serial_zstick
configuration:
  controller_softreset: false
  security_networkkey: RE DA CT ED
  security_inclusionmode: 0
  controller_suc: false
  controller_sisnode: 1
  controller_maxawakeperiod: 10
  controller_sync: false
  controller_master: true
  inclusion_mode: 2
  port: /dev/ttyUSB0
  controller_wakeupperiod: 3600
  controller_exclude: false
  heal_time: 4
  controller_inclusiontimeout: 30
  controller_hardreset: false
channels:
  - id: serial_sof
    channelTypeUID: zwave:serial_sof
    configuration: {}
  - id: serial_ack
    channelTypeUID: zwave:serial_ack
    configuration: {}
  - id: serial_nak
    channelTypeUID: zwave:serial_nak
    configuration: {}
  - id: serial_can
    channelTypeUID: zwave:serial_can
    configuration: {}
  - id: serial_oof
    channelTypeUID: zwave:serial_oof
    configuration: {}

Any hints on where else to look?

apella12 · July 2, 2025, 8:13pm

This doesn’t look like mine. What version of OH are you running? Have you done any updates to the 700 stick firmware? The relevant log information will be at the Debug level during the controller startup (not disable/enable). You could try to remove the ZW binding after setting the log level to debug and then reinstall. Do you have access to the simplicity studio?

justinwilczek · July 3, 2025, 8:12pm

This is openHAB 4.3.5.

I restarted the openhab service with zwave TRACE logging enabled.

Here’s all of the log output from zwave:

2025-07-03 14:38:36.917 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : BundleComponentActivator : ComponentHolder created.
2025-07-03 14:38:36.928 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : BundleComponentActivator : ComponentHolder created.
2025-07-03 14:38:36.943 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Dependency Manager created ConfigDescriptionRegistryinterface=org.openhab.core.config.core.ConfigDescriptionRegistry, filter=null, policy=static, cardinality=1..1, bind=setConfigDescriptionRegistry, unbind=unsetConfigDescriptionRegistry, updated=null, field=null, field-option=null, collection-type=null, parameter=null
2025-07-03 14:38:36.947 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Dependency Manager created ThingRegistryinterface=org.openhab.core.thing.ThingRegistry, filter=null, policy=static, cardinality=1..1, bind=setThingRegistry, unbind=unsetThingRegistry, updated=null, field=null, field-option=null, collection-type=null, parameter=null
2025-07-03 14:38:36.951 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Dependency Manager created ThingTypeRegistryinterface=org.openhab.core.thing.type.ThingTypeRegistry, filter=null, policy=static, cardinality=1..1, bind=setThingTypeRegistry, unbind=unsetThingTypeRegistry, updated=null, field=null, field-option=null, collection-type=null, parameter=null
2025-07-03 14:38:36.954 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Dependency Manager created osgi.ds.satisfying.conditioninterface=org.osgi.service.condition.Condition, filter=(osgi.condition.id=true), policy=dynamic, cardinality=1..1, bind=null, unbind=null, updated=null, field=null, field-option=null, collection-type=null, parameter=null
2025-07-03 14:38:36.959 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Component created: DS=DS13, implementation=org.openhab.binding.zwave.internal.ZWaveConfigProvider, immediate=true, default-enabled=true, factory=null, configuration-policy=optional, activate=activate, deactivate=deactivate, modified=null configuration-pid=[org.openhab.binding.zwave.internal.ZWaveConfigProvider]
2025-07-03 14:38:36.963 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Component Services: scope=singleton, services=[org.openhab.core.config.core.ConfigDescriptionProvider, org.openhab.core.config.core.ConfigOptionProvider]
2025-07-03 14:38:36.967 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Component Properties: {osgi.ds.satisfying.condition.target=(osgi.condition.id=true)}
2025-07-03 14:38:36.971 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Querying state disabled
2025-07-03 14:38:36.974 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Querying state disabled
2025-07-03 14:38:36.978 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Component can not be activated since it is in state disabled
2025-07-03 14:38:36.981 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Querying state disabled
2025-07-03 14:38:36.985 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Updating target filters
2025-07-03 14:38:36.988 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : No change in target property for dependency ConfigDescriptionRegistry: currently registered: false
2025-07-03 14:38:36.993 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] :  No existing service listener to unregister for dependency ConfigDescriptionRegistry
2025-07-03 14:38:36.996 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Setting target property for dependency ConfigDescriptionRegistry to null
2025-07-03 14:38:37.000 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : New service tracker for ConfigDescriptionRegistry, initial active: false, previous references: {}, classFilter: (objectClass=org.openhab.core.config.core.ConfigDescriptionRegistry), initialReferenceFilter (objectClass=org.openhab.core.config.core.ConfigDescriptionRegistry)
2025-07-03 14:38:37.004 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : dm ConfigDescriptionRegistry tracker reset (closed)
2025-07-03 14:38:37.009 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : dm ConfigDescriptionRegistry tracking 1 SingleStatic added {org.openhab.core.config.core.ConfigDescriptionRegistry}={service.id=260, service.bundleid=168, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.config.core.ConfigDescriptionRegistry, component.id=128} (enter)
2025-07-03 14:38:37.013 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : dm ConfigDescriptionRegistry tracking 1 SingleStatic active: false trackerOpened: false optional: false
2025-07-03 14:38:37.018 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : dm ConfigDescriptionRegistry tracking 1 SingleStatic added {org.openhab.core.config.core.ConfigDescriptionRegistry}={service.id=260, service.bundleid=168, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.config.core.ConfigDescriptionRegistry, component.id=128} (exit)
2025-07-03 14:38:37.022 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : dm ConfigDescriptionRegistry tracker opened
2025-07-03 14:38:37.026 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : registering service listener for dependency ConfigDescriptionRegistry
2025-07-03 14:38:37.029 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : No change in target property for dependency ThingRegistry: currently registered: false
2025-07-03 14:38:37.033 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] :  No existing service listener to unregister for dependency ThingRegistry
2025-07-03 14:38:37.036 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Setting target property for dependency ThingRegistry to null
2025-07-03 14:38:37.040 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : New service tracker for ThingRegistry, initial active: false, previous references: {}, classFilter: (objectClass=org.openhab.core.thing.ThingRegistry), initialReferenceFilter (objectClass=org.openhab.core.thing.ThingRegistry)
2025-07-03 14:38:37.043 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : dm ThingRegistry tracker reset (closed)
2025-07-03 14:38:37.048 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : dm ThingRegistry tracking 2 SingleStatic added {org.openhab.core.thing.ThingRegistry}={service.id=419, service.bundleid=221, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.thing.internal.ThingRegistryImpl, component.id=282} (enter)
2025-07-03 14:38:37.052 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : dm ThingRegistry tracking 2 SingleStatic active: false trackerOpened: false optional: false
2025-07-03 14:38:37.056 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : dm ThingRegistry tracking 2 SingleStatic added {org.openhab.core.thing.ThingRegistry}={service.id=419, service.bundleid=221, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.thing.internal.ThingRegistryImpl, component.id=282} (exit)
2025-07-03 14:38:37.059 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : dm ThingRegistry tracker opened
2025-07-03 14:38:37.063 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : registering service listener for dependency ThingRegistry
2025-07-03 14:38:37.066 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : No change in target property for dependency ThingTypeRegistry: currently registered: false
2025-07-03 14:38:37.070 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] :  No existing service listener to unregister for dependency ThingTypeRegistry
2025-07-03 14:38:37.073 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Setting target property for dependency ThingTypeRegistry to null
2025-07-03 14:38:37.077 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : New service tracker for ThingTypeRegistry, initial active: false, previous references: {}, classFilter: (objectClass=org.openhab.core.thing.type.ThingTypeRegistry), initialReferenceFilter (objectClass=org.openhab.core.thing.type.ThingTypeRegistry)
2025-07-03 14:38:37.080 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : dm ThingTypeRegistry tracker reset (closed)
2025-07-03 14:38:37.085 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : dm ThingTypeRegistry tracking 3 SingleStatic added {org.openhab.core.thing.type.ThingTypeRegistry}={service.id=461, service.bundleid=221, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.thing.type.ThingTypeRegistry, component.id=298} (enter)
2025-07-03 14:38:37.089 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : dm ThingTypeRegistry tracking 3 SingleStatic active: false trackerOpened: false optional: false
2025-07-03 14:38:37.094 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : dm ThingTypeRegistry tracking 3 SingleStatic added {org.openhab.core.thing.type.ThingTypeRegistry}={service.id=461, service.bundleid=221, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.thing.type.ThingTypeRegistry, component.id=298} (exit)
2025-07-03 14:38:37.098 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : dm ThingTypeRegistry tracker opened
2025-07-03 14:38:37.102 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : registering service listener for dependency ThingTypeRegistry
2025-07-03 14:38:37.105 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] :  No existing service listener to unregister for dependency osgi.ds.satisfying.condition
2025-07-03 14:38:37.109 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Setting target property for dependency osgi.ds.satisfying.condition to (osgi.condition.id=true)
2025-07-03 14:38:37.112 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : New service tracker for osgi.ds.satisfying.condition, initial active: false, previous references: {}, classFilter: (objectClass=org.osgi.service.condition.Condition), initialReferenceFilter (&(objectClass=org.osgi.service.condition.Condition)(osgi.condition.id=true))
2025-07-03 14:38:37.116 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : dm osgi.ds.satisfying.condition tracker reset (closed)
2025-07-03 14:38:37.121 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : dm osgi.ds.satisfying.condition tracking 4 SingleDynamic added {org.osgi.service.condition.Condition}={service.id=6, service.bundleid=0, service.scope=singleton, service.pid=0.org.osgi.service.condition.ConditionImpl, osgi.condition.id=true} (enter)
2025-07-03 14:38:37.126 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : dm osgi.ds.satisfying.condition tracking 4 SingleDynamic added {org.osgi.service.condition.Condition}={service.id=6, service.bundleid=0, service.scope=singleton, service.pid=0.org.osgi.service.condition.ConditionImpl, osgi.condition.id=true} (exit)
2025-07-03 14:38:37.131 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : dm osgi.ds.satisfying.condition tracker opened
2025-07-03 14:38:37.136 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : registering service listener for dependency osgi.ds.satisfying.condition
2025-07-03 14:38:37.140 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Changed state from disabled to unsatisfiedReference
2025-07-03 14:38:37.144 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Component enabled
2025-07-03 14:38:37.146 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : ActivateInternal
2025-07-03 14:38:37.150 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Querying state unsatisfiedReference
2025-07-03 14:38:37.153 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Querying state unsatisfiedReference
2025-07-03 14:38:37.157 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Activating component from state unsatisfiedReference
2025-07-03 14:38:37.161 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Querying state unsatisfiedReference
2025-07-03 14:38:37.165 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Querying state unsatisfiedReference
2025-07-03 14:38:37.168 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Changed state from unsatisfiedReference to satisfied
2025-07-03 14:38:37.172 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : registration change queue [registered]
2025-07-03 14:38:37.199 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Checking constructor public org.openhab.binding.zwave.internal.ZWaveConfigProvider()
2025-07-03 14:38:37.203 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Found constructor with 0 arguments : public org.openhab.binding.zwave.internal.ZWaveConfigProvider()
2025-07-03 14:38:37.208 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : getting bind: setConfigDescriptionRegistry
2025-07-03 14:38:37.213 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Locating method setConfigDescriptionRegistry in class org.openhab.binding.zwave.internal.ZWaveConfigProvider
2025-07-03 14:38:37.217 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : doFindMethod: Looking for method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setConfigDescriptionRegistry
2025-07-03 14:38:37.245 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setConfigDescriptionRegistry([interface org.osgi.framework.ServiceReference]) not found
2025-07-03 14:38:37.250 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setConfigDescriptionRegistry([interface org.osgi.service.component.ComponentServiceObjects]) not found
2025-07-03 14:38:37.254 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : getClassFromComponentClassLoader: Looking for interface class org.openhab.core.config.core.ConfigDescriptionRegistry through loader of org.openhab.binding.zwave.internal.ZWaveConfigProvider
2025-07-03 14:38:37.259 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : getClassFromComponentClassLoader: Found class org.openhab.core.config.core.ConfigDescriptionRegistry
2025-07-03 14:38:37.263 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : doFindMethod: No method taking ServiceReference found, checking method taking org.openhab.core.config.core.ConfigDescriptionRegistry
2025-07-03 14:38:37.267 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : doFindMethod: Found Method protected void org.openhab.binding.zwave.internal.ZWaveConfigProvider.setConfigDescriptionRegistry(org.openhab.core.config.core.ConfigDescriptionRegistry)
2025-07-03 14:38:37.272 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Found bind method: protected void org.openhab.binding.zwave.internal.ZWaveConfigProvider.setConfigDescriptionRegistry(org.openhab.core.config.core.ConfigDescriptionRegistry)
2025-07-03 14:38:37.277 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : getting bind: setThingRegistry
2025-07-03 14:38:37.281 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Locating method setThingRegistry in class org.openhab.binding.zwave.internal.ZWaveConfigProvider
2025-07-03 14:38:37.285 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : doFindMethod: Looking for method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingRegistry
2025-07-03 14:38:37.289 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingRegistry([interface org.osgi.framework.ServiceReference]) not found
2025-07-03 14:38:37.294 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingRegistry([interface org.osgi.service.component.ComponentServiceObjects]) not found
2025-07-03 14:38:37.298 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : getClassFromComponentClassLoader: Looking for interface class org.openhab.core.thing.ThingRegistry through loader of org.openhab.binding.zwave.internal.ZWaveConfigProvider
2025-07-03 14:38:37.302 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : getClassFromComponentClassLoader: Found class org.openhab.core.thing.ThingRegistry
2025-07-03 14:38:37.306 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : doFindMethod: No method taking ServiceReference found, checking method taking org.openhab.core.thing.ThingRegistry
2025-07-03 14:38:37.311 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : doFindMethod: Found Method protected void org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingRegistry(org.openhab.core.thing.ThingRegistry)
2025-07-03 14:38:37.315 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Found bind method: protected void org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingRegistry(org.openhab.core.thing.ThingRegistry)
2025-07-03 14:38:37.320 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : getting bind: setThingTypeRegistry
2025-07-03 14:38:37.324 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Locating method setThingTypeRegistry in class org.openhab.binding.zwave.internal.ZWaveConfigProvider
2025-07-03 14:38:37.328 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : doFindMethod: Looking for method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingTypeRegistry
2025-07-03 14:38:37.332 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingTypeRegistry([interface org.osgi.framework.ServiceReference]) not found
2025-07-03 14:38:37.336 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingTypeRegistry([interface org.osgi.service.component.ComponentServiceObjects]) not found
2025-07-03 14:38:37.340 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : getClassFromComponentClassLoader: Looking for interface class org.openhab.core.thing.type.ThingTypeRegistry through loader of org.openhab.binding.zwave.internal.ZWaveConfigProvider
2025-07-03 14:38:37.345 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : getClassFromComponentClassLoader: Found class org.openhab.core.thing.type.ThingTypeRegistry
2025-07-03 14:38:37.348 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : doFindMethod: No method taking ServiceReference found, checking method taking org.openhab.core.thing.type.ThingTypeRegistry
2025-07-03 14:38:37.352 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : doFindMethod: Found Method protected void org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingTypeRegistry(org.openhab.core.thing.type.ThingTypeRegistry)
2025-07-03 14:38:37.357 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Found bind method: protected void org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingTypeRegistry(org.openhab.core.thing.type.ThingTypeRegistry)
2025-07-03 14:38:37.361 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : This thread collected dependencies
2025-07-03 14:38:37.365 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : getService (single component manager) dependencies collected.
2025-07-03 14:38:37.369 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Querying state satisfied
2025-07-03 14:38:37.373 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Querying state satisfied
2025-07-03 14:38:37.378 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : For dependency ConfigDescriptionRegistry, optional: false; to bind: [[RefPair: ref: [{org.openhab.core.config.core.ConfigDescriptionRegistry}={service.id=260, service.bundleid=168, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.config.core.ConfigDescriptionRegistry, component.id=128}] service: [org.openhab.core.config.core.ConfigDescriptionRegistry@11114b5]]]
2025-07-03 14:38:37.383 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : For dependency ThingRegistry, optional: false; to bind: [[RefPair: ref: [{org.openhab.core.thing.ThingRegistry}={service.id=419, service.bundleid=221, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.thing.internal.ThingRegistryImpl, component.id=282}] service: [org.openhab.core.thing.internal.ThingRegistryImpl@671bb8]]]
2025-07-03 14:38:37.387 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : For dependency ThingTypeRegistry, optional: false; to bind: [[RefPair: ref: [{org.openhab.core.thing.type.ThingTypeRegistry}={service.id=461, service.bundleid=221, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.thing.type.ThingTypeRegistry, component.id=298}] service: [org.openhab.core.thing.type.ThingTypeRegistry@d83698]]]
2025-07-03 14:38:37.392 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : For dependency osgi.ds.satisfying.condition, optional: false; to bind: [[RefPair: ref: [{org.osgi.service.condition.Condition}={service.id=6, service.bundleid=0, service.scope=singleton, service.pid=0.org.osgi.service.condition.ConditionImpl, osgi.condition.id=true}] service: [null]]]
2025-07-03 14:38:37.666 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : invoking bind: setConfigDescriptionRegistry: parameters [org.openhab.core.config.core.ConfigDescriptionRegistry]
2025-07-03 14:38:37.670 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : invoked bind: setConfigDescriptionRegistry
2025-07-03 14:38:37.674 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : invoking bind: setThingRegistry: parameters [org.openhab.core.thing.internal.ThingRegistryImpl]
2025-07-03 14:38:37.679 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : invoked bind: setThingRegistry
2025-07-03 14:38:37.683 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : invoking bind: setThingTypeRegistry: parameters [org.openhab.core.thing.type.ThingTypeRegistry]
2025-07-03 14:38:37.688 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : invoked bind: setThingTypeRegistry
2025-07-03 14:38:37.692 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : getting activate: activate
2025-07-03 14:38:37.696 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Locating method activate in class org.openhab.binding.zwave.internal.ZWaveConfigProvider
2025-07-03 14:38:37.701 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.activate([interface org.osgi.service.component.ComponentContext]) not found
2025-07-03 14:38:37.705 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Locating method activate in class java.lang.Object
2025-07-03 14:38:37.709 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Declared Method java.lang.Object.activate([interface org.osgi.service.component.ComponentContext]) not found
2025-07-03 14:38:37.713 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : activate method [activate] not found, ignoring
2025-07-03 14:38:37.717 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Set implementation object for component
2025-07-03 14:38:37.722 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(375)] : Changed state from satisfied to active
2025-07-03 14:38:37.729 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Dependency Manager created SerialPortManagerinterface=org.openhab.core.io.transport.serial.SerialPortManager, filter=null, policy=static, cardinality=1..1, bind=setSerialPortManager, unbind=unsetSerialPortManager, updated=null, field=null, field-option=null, collection-type=null, parameter=null
2025-07-03 14:38:37.734 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Dependency Manager created osgi.ds.satisfying.conditioninterface=org.osgi.service.condition.Condition, filter=(osgi.condition.id=true), policy=dynamic, cardinality=1..1, bind=null, unbind=null, updated=null, field=null, field-option=null, collection-type=null, parameter=null
2025-07-03 14:38:37.738 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Component created: DS=DS13, implementation=org.openhab.binding.zwave.internal.ZWaveHandlerFactory, immediate=false, default-enabled=true, factory=null, configuration-policy=optional, activate=activate, deactivate=deactivate, modified=null configuration-pid=[org.openhab.binding.zwave.internal.ZWaveHandlerFactory]
2025-07-03 14:38:37.743 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Component Services: scope=singleton, services=[org.openhab.core.thing.binding.ThingHandlerFactory]
2025-07-03 14:38:37.747 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Component Properties: {osgi.ds.satisfying.condition.target=(osgi.condition.id=true)}
2025-07-03 14:38:37.751 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Querying state disabled
2025-07-03 14:38:37.755 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Querying state disabled
2025-07-03 14:38:37.759 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Component can not be activated since it is in state disabled
2025-07-03 14:38:37.763 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Querying state disabled
2025-07-03 14:38:37.767 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Updating target filters
2025-07-03 14:38:37.771 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : No change in target property for dependency SerialPortManager: currently registered: false
2025-07-03 14:38:37.775 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] :  No existing service listener to unregister for dependency SerialPortManager
2025-07-03 14:38:37.779 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Setting target property for dependency SerialPortManager to null
2025-07-03 14:38:37.918 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : New service tracker for SerialPortManager, initial active: false, previous references: {}, classFilter: (objectClass=org.openhab.core.io.transport.serial.SerialPortManager), initialReferenceFilter (objectClass=org.openhab.core.io.transport.serial.SerialPortManager)
2025-07-03 14:38:37.926 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : dm SerialPortManager tracker reset (closed)
2025-07-03 14:38:37.930 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : dm SerialPortManager tracker opened
2025-07-03 14:38:37.934 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : registering service listener for dependency SerialPortManager
2025-07-03 14:38:37.937 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] :  No existing service listener to unregister for dependency osgi.ds.satisfying.condition
2025-07-03 14:38:37.941 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Setting target property for dependency osgi.ds.satisfying.condition to (osgi.condition.id=true)
2025-07-03 14:38:37.945 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : New service tracker for osgi.ds.satisfying.condition, initial active: false, previous references: {}, classFilter: (objectClass=org.osgi.service.condition.Condition), initialReferenceFilter (&(objectClass=org.osgi.service.condition.Condition)(osgi.condition.id=true))
2025-07-03 14:38:37.949 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : dm osgi.ds.satisfying.condition tracker reset (closed)
2025-07-03 14:38:37.953 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : dm osgi.ds.satisfying.condition tracking 1 SingleDynamic added {org.osgi.service.condition.Condition}={service.id=6, service.bundleid=0, service.scope=singleton, service.pid=0.org.osgi.service.condition.ConditionImpl, osgi.condition.id=true} (enter)
2025-07-03 14:38:37.959 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : dm osgi.ds.satisfying.condition tracking 1 SingleDynamic added {org.osgi.service.condition.Condition}={service.id=6, service.bundleid=0, service.scope=singleton, service.pid=0.org.osgi.service.condition.ConditionImpl, osgi.condition.id=true} (exit)
2025-07-03 14:38:37.962 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : dm osgi.ds.satisfying.condition tracker opened
2025-07-03 14:38:37.966 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : registering service listener for dependency osgi.ds.satisfying.condition
2025-07-03 14:38:37.969 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Changed state from disabled to unsatisfiedReference
2025-07-03 14:38:37.973 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Component enabled
2025-07-03 14:38:37.976 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : ActivateInternal
2025-07-03 14:38:37.980 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Querying state unsatisfiedReference
2025-07-03 14:38:37.984 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Querying state unsatisfiedReference
2025-07-03 14:38:37.988 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Activating component from state unsatisfiedReference
2025-07-03 14:38:37.991 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Querying state unsatisfiedReference
2025-07-03 14:38:37.995 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Querying state unsatisfiedReference
2025-07-03 14:38:37.998 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Dependency not satisfied: SerialPortManager
2025-07-03 14:38:38.002 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Not all dependencies satisfied, cannot activate
2025-07-03 14:38:40.050 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : dm SerialPortManager tracking 2 SingleStatic added {org.openhab.core.io.transport.serial.SerialPortManager}={service.id=593, service.bundleid=308, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.io.transport.serial.internal.SerialPortManagerImpl, component.id=385} (enter)
2025-07-03 14:38:40.054 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : ActivateInternal
2025-07-03 14:38:40.058 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Querying state unsatisfiedReference
2025-07-03 14:38:40.063 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Querying state unsatisfiedReference
2025-07-03 14:38:40.067 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Activating component from state unsatisfiedReference
2025-07-03 14:38:40.076 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Querying state unsatisfiedReference
2025-07-03 14:38:40.083 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Querying state unsatisfiedReference
2025-07-03 14:38:40.088 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Changed state from unsatisfiedReference to satisfied
2025-07-03 14:38:40.093 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : registration change queue [registered]
2025-07-03 14:38:40.161 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Checking constructor public org.openhab.binding.zwave.internal.ZWaveHandlerFactory()
2025-07-03 14:38:40.174 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Found constructor with 0 arguments : public org.openhab.binding.zwave.internal.ZWaveHandlerFactory()
2025-07-03 14:38:40.177 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : getting bind: setSerialPortManager
2025-07-03 14:38:40.188 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Locating method setSerialPortManager in class org.openhab.binding.zwave.internal.ZWaveHandlerFactory
2025-07-03 14:38:40.210 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : doFindMethod: Looking for method org.openhab.binding.zwave.internal.ZWaveHandlerFactory.setSerialPortManager
2025-07-03 14:38:40.225 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Declared Method org.openhab.binding.zwave.internal.ZWaveHandlerFactory.setSerialPortManager([interface org.osgi.framework.ServiceReference]) not found
2025-07-03 14:38:40.229 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Declared Method org.openhab.binding.zwave.internal.ZWaveHandlerFactory.setSerialPortManager([interface org.osgi.service.component.ComponentServiceObjects]) not found
2025-07-03 14:38:40.243 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : getClassFromComponentClassLoader: Looking for interface class org.openhab.core.io.transport.serial.SerialPortManager through loader of org.openhab.binding.zwave.internal.ZWaveHandlerFactory
2025-07-03 14:38:40.247 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : getClassFromComponentClassLoader: Found class org.openhab.core.io.transport.serial.SerialPortManager
2025-07-03 14:38:40.258 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : doFindMethod: No method taking ServiceReference found, checking method taking org.openhab.core.io.transport.serial.SerialPortManager
2025-07-03 14:38:40.262 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : doFindMethod: Found Method protected void org.openhab.binding.zwave.internal.ZWaveHandlerFactory.setSerialPortManager(org.openhab.core.io.transport.serial.SerialPortManager)
2025-07-03 14:38:40.283 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Found bind method: protected void org.openhab.binding.zwave.internal.ZWaveHandlerFactory.setSerialPortManager(org.openhab.core.io.transport.serial.SerialPortManager)
2025-07-03 14:38:40.287 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : This thread collected dependencies
2025-07-03 14:38:40.297 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : getService (single component manager) dependencies collected.
2025-07-03 14:38:40.308 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Querying state satisfied
2025-07-03 14:38:40.317 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Querying state satisfied
2025-07-03 14:38:40.321 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : For dependency SerialPortManager, optional: false; to bind: [[RefPair: ref: [{org.openhab.core.io.transport.serial.SerialPortManager}={service.id=593, service.bundleid=308, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.io.transport.serial.internal.SerialPortManagerImpl, component.id=385}] service: [org.openhab.core.io.transport.serial.internal.SerialPortManagerImpl@d3d3a7]]]
2025-07-03 14:38:40.326 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : For dependency osgi.ds.satisfying.condition, optional: false; to bind: [[RefPair: ref: [{org.osgi.service.condition.Condition}={service.id=6, service.bundleid=0, service.scope=singleton, service.pid=0.org.osgi.service.condition.ConditionImpl, osgi.condition.id=true}] service: [null]]]
2025-07-03 14:38:40.348 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : invoking bind: setSerialPortManager: parameters [org.openhab.core.io.transport.serial.internal.SerialPortManagerImpl]
2025-07-03 14:38:40.357 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : invoked bind: setSerialPortManager
2025-07-03 14:38:40.361 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : getting activate: activate
2025-07-03 14:38:40.366 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Locating method activate in class org.openhab.binding.zwave.internal.ZWaveHandlerFactory
2025-07-03 14:38:40.370 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Declared Method org.openhab.binding.zwave.internal.ZWaveHandlerFactory.activate([interface org.osgi.service.component.ComponentContext]) not found
2025-07-03 14:38:40.394 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Locating method activate in class org.openhab.core.thing.binding.BaseThingHandlerFactory
2025-07-03 14:38:40.397 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Found activate method: protected void org.openhab.core.thing.binding.BaseThingHandlerFactory.activate(org.osgi.service.component.ComponentContext)
2025-07-03 14:38:40.412 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : invoking activate: activate: parameters [org.apache.felix.scr.impl.manager.ComponentContextImpl]
2025-07-03 14:38:40.417 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : invoked activate: activate
2025-07-03 14:38:40.423 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Set implementation object for component
2025-07-03 14:38:40.427 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : Changed state from satisfied to active
2025-07-03 14:38:40.618 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.3.5 (299)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(376)] : dm SerialPortManager tracking 2 SingleStatic added {org.openhab.core.io.transport.serial.SerialPortManager}={service.id=593, service.bundleid=308, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.core.io.transport.serial.internal.SerialPortManagerImpl, component.id=385} (exit)
2025-07-03 14:39:25.480 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - Creating ZWave discovery service for zwave:serial_zstick:497f3296 with scan time of 60
2025-07-03 14:39:25.485 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - ZWave discovery: Active zwave:serial_zstick:497f3296
2025-07-03 14:39:25.488 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Attempting to add listener when controller is null
2025-07-03 14:39:25.595 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Initializing ZWave serial controller.
2025-07-03 14:39:25.598 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Initializing ZWave Controller zwave:serial_zstick:497f3296.
2025-07-03 14:39:25.744 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node9.
2025-07-03 14:39:25.810 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node12.
2025-07-03 14:39:25.817 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node2.
2025-07-03 14:39:25.820 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node5.
2025-07-03 14:39:25.825 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node24.
2025-07-03 14:39:25.893 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node3.
2025-07-03 14:39:25.899 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node22.
2025-07-03 14:39:25.908 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node23.
2025-07-03 14:39:26.017 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node27.
2025-07-03 14:39:26.075 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node28.
2025-07-03 14:39:26.085 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node26.
2025-07-03 14:39:26.096 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node29.
2025-07-03 14:39:26.108 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node11.
2025-07-03 14:39:26.169 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node25.
2025-07-03 14:39:26.207 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node10.
2025-07-03 14:39:26.301 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node19.
2025-07-03 14:39:26.399 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node17.
2025-07-03 14:39:26.494 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node16.
2025-07-03 14:39:26.575 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node15.
2025-07-03 14:39:26.679 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: MANUFACTURER not set
2025-07-03 14:39:26.835 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node14.
2025-07-03 14:39:27.242 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node32.
2025-07-03 14:39:27.321 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node31.
2025-07-03 14:39:27.481 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:497f3296:node30.
2025-07-03 14:39:30.702 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Connecting to serial port '/dev/ttyUSB0'
2025-07-03 14:39:30.735 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Stopping ZWave network
2025-07-03 14:39:30.739 [DEBUG] [zwave.handler.ZWaveControllerHandler] - ZWave network stopped
2025-07-03 14:39:30.743 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Disposing receive thread
2025-07-03 14:39:30.746 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Receive thread dispose
2025-07-03 14:39:30.750 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Disposing serial connection
2025-07-03 14:39:30.753 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Serial connection disposed

Still looking through this to see if I can find anything of interest… Weird at the end that it just decides to stop immediately after it opens the serial connection…

justinwilczek · July 3, 2025, 8:22pm

All of these “Declared Method … not found” messages seem suspicious…

Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setConfigDescriptionRegistry([interface org.osgi.framework.ServiceReference]) not found
Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setConfigDescriptionRegistry([interface org.osgi.service.component.ComponentServiceObjects]) not found
Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingRegistry([interface org.osgi.framework.ServiceReference]) not found
Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingRegistry([interface org.osgi.service.component.ComponentServiceObjects]) not found
Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingTypeRegistry([interface org.osgi.framework.ServiceReference]) not found
Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingTypeRegistry([interface org.osgi.service.component.ComponentServiceObjects]) not found
Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.activate([interface org.osgi.service.component.ComponentContext]) not found
Declared Method java.lang.Object.activate([interface org.osgi.service.component.ComponentContext]) not found
Declared Method org.openhab.binding.zwave.internal.ZWaveHandlerFactory.setSerialPortManager([interface org.osgi.framework.ServiceReference]) not found
Declared Method org.openhab.binding.zwave.internal.ZWaveHandlerFactory.setSerialPortManager([interface org.osgi.service.component.ComponentServiceObjects]) not found
Declared Method org.openhab.binding.zwave.internal.ZWaveHandlerFactory.activate([interface org.osgi.service.component.ComponentContext]) not found

apella12 · July 3, 2025, 10:58pm

I agree. Unfortunately, that is beyond my knowledge I’ve never dealt with that part. Did you remove the binding using the UI and then reinstall? The only thing I can guess is that maybe something happened to feature:install openhab-transport-serial and removing the binding and reinstalling might fix it. The only other thing I can offer is a historical working log from my collection.

2023-02-11 10:15:00.586 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : BundleComponentActivator : ComponentHolder created.
2023-02-11 10:15:00.587 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : BundleComponentActivator : ComponentHolder created.
2023-02-11 10:15:00.587 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Dependency Manager created ConfigDescriptionRegistryinterface=org.openhab.core.config.core.ConfigDescriptionRegistry, filter=null, policy=static, cardinality=1..1, bind=setConfigDescriptionRegistry, unbind=unsetConfigDescriptionRegistry, updated=null, field=null, field-option=null, collection-type=null, parameter=null
2023-02-11 10:15:00.588 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Dependency Manager created ThingRegistryinterface=org.openhab.core.thing.ThingRegistry, filter=null, policy=static, cardinality=1..1, bind=setThingRegistry, unbind=unsetThingRegistry, updated=null, field=null, field-option=null, collection-type=null, parameter=null
2023-02-11 10:15:00.588 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Dependency Manager created ThingTypeRegistryinterface=org.openhab.core.thing.type.ThingTypeRegistry, filter=null, policy=static, cardinality=1..1, bind=setThingTypeRegistry, unbind=unsetThingTypeRegistry, updated=null, field=null, field-option=null, collection-type=null, parameter=null
2023-02-11 10:15:00.588 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Component created: DS=DS13, implementation=org.openhab.binding.zwave.internal.ZWaveConfigProvider, immediate=true, default-enabled=true, factory=null, configuration-policy=optional, activate=activate, deactivate=deactivate, modified=null configuration-pid=[org.openhab.binding.zwave.internal.ZWaveConfigProvider]
2023-02-11 10:15:00.588 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Component Services: scope=singleton, services=[org.openhab.core.config.core.ConfigDescriptionProvider, org.openhab.core.config.core.ConfigOptionProvider]
2023-02-11 10:15:00.588 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Component Properties: {}
2023-02-11 10:15:00.588 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Querying state disabled
2023-02-11 10:15:00.588 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Querying state disabled
2023-02-11 10:15:00.588 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Component can not be activated since it is in state disabled
2023-02-11 10:15:00.588 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Querying state disabled
2023-02-11 10:15:00.589 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Updating target filters
2023-02-11 10:15:00.589 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : No change in target property for dependency ConfigDescriptionRegistry: currently registered: false
2023-02-11 10:15:00.589 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] :  No existing service listener to unregister for dependency ConfigDescriptionRegistry
2023-02-11 10:15:00.589 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Setting target property for dependency ConfigDescriptionRegistry to null
2023-02-11 10:15:00.589 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : New service tracker for ConfigDescriptionRegistry, initial active: false, previous references: {}, classFilter: (objectClass=org.openhab.core.config.core.ConfigDescriptionRegistry), initialReferenceFilter (objectClass=org.openhab.core.config.core.ConfigDescriptionRegistry)
2023-02-11 10:15:00.589 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : dm ConfigDescriptionRegistry tracker reset (closed)
2023-02-11 10:15:00.590 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : dm ConfigDescriptionRegistry tracking 1 SingleStatic added {org.openhab.core.config.core.ConfigDescriptionRegistry}={service.id=226, service.bundleid=161, service.scope=bundle, component.name=org.openhab.core.config.core.ConfigDescriptionRegistry, component.id=107} (enter)
2023-02-11 10:15:00.590 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : dm ConfigDescriptionRegistry tracking 1 SingleStatic active: false trackerOpened: false optional: false
2023-02-11 10:15:00.590 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : dm ConfigDescriptionRegistry tracking 1 SingleStatic added {org.openhab.core.config.core.ConfigDescriptionRegistry}={service.id=226, service.bundleid=161, service.scope=bundle, component.name=org.openhab.core.config.core.ConfigDescriptionRegistry, component.id=107} (exit)
2023-02-11 10:15:00.590 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : dm ConfigDescriptionRegistry tracker opened
2023-02-11 10:15:00.590 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : registering service listener for dependency ConfigDescriptionRegistry
2023-02-11 10:15:00.591 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : No change in target property for dependency ThingRegistry: currently registered: false
2023-02-11 10:15:00.591 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] :  No existing service listener to unregister for dependency ThingRegistry
2023-02-11 10:15:00.591 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Setting target property for dependency ThingRegistry to null
2023-02-11 10:15:00.591 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : New service tracker for ThingRegistry, initial active: false, previous references: {}, classFilter: (objectClass=org.openhab.core.thing.ThingRegistry), initialReferenceFilter (objectClass=org.openhab.core.thing.ThingRegistry)
2023-02-11 10:15:00.591 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : dm ThingRegistry tracker reset (closed)
2023-02-11 10:15:00.591 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : dm ThingRegistry tracking 2 SingleStatic added {org.openhab.core.thing.ThingRegistry}={service.id=360, service.bundleid=212, service.scope=bundle, component.name=org.openhab.core.thing.internal.ThingRegistryImpl, component.id=244} (enter)
2023-02-11 10:15:00.592 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : dm ThingRegistry tracking 2 SingleStatic active: false trackerOpened: false optional: false
2023-02-11 10:15:00.592 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : dm ThingRegistry tracking 2 SingleStatic added {org.openhab.core.thing.ThingRegistry}={service.id=360, service.bundleid=212, service.scope=bundle, component.name=org.openhab.core.thing.internal.ThingRegistryImpl, component.id=244} (exit)
2023-02-11 10:15:00.592 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : dm ThingRegistry tracker opened
2023-02-11 10:15:00.592 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : registering service listener for dependency ThingRegistry
2023-02-11 10:15:00.592 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : No change in target property for dependency ThingTypeRegistry: currently registered: false
2023-02-11 10:15:00.592 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] :  No existing service listener to unregister for dependency ThingTypeRegistry
2023-02-11 10:15:00.592 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Setting target property for dependency ThingTypeRegistry to null
2023-02-11 10:15:00.593 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : New service tracker for ThingTypeRegistry, initial active: false, previous references: {}, classFilter: (objectClass=org.openhab.core.thing.type.ThingTypeRegistry), initialReferenceFilter (objectClass=org.openhab.core.thing.type.ThingTypeRegistry)
2023-02-11 10:15:00.593 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : dm ThingTypeRegistry tracker reset (closed)
2023-02-11 10:15:00.593 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : dm ThingTypeRegistry tracking 3 SingleStatic added {org.openhab.core.thing.type.ThingTypeRegistry}={service.id=394, service.bundleid=212, service.scope=bundle, component.name=org.openhab.core.thing.type.ThingTypeRegistry, component.id=259} (enter)
2023-02-11 10:15:00.593 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : dm ThingTypeRegistry tracking 3 SingleStatic active: false trackerOpened: false optional: false
2023-02-11 10:15:00.593 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : dm ThingTypeRegistry tracking 3 SingleStatic added {org.openhab.core.thing.type.ThingTypeRegistry}={service.id=394, service.bundleid=212, service.scope=bundle, component.name=org.openhab.core.thing.type.ThingTypeRegistry, component.id=259} (exit)
2023-02-11 10:15:00.594 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : dm ThingTypeRegistry tracker opened
2023-02-11 10:15:00.594 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : registering service listener for dependency ThingTypeRegistry
2023-02-11 10:15:00.594 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Changed state from disabled to unsatisfiedReference
2023-02-11 10:15:00.594 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Component enabled
2023-02-11 10:15:00.594 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : ActivateInternal
2023-02-11 10:15:00.594 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Querying state unsatisfiedReference
2023-02-11 10:15:00.594 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Querying state unsatisfiedReference
2023-02-11 10:15:00.594 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Activating component from state unsatisfiedReference
2023-02-11 10:15:00.594 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Querying state unsatisfiedReference
2023-02-11 10:15:00.595 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Querying state unsatisfiedReference
2023-02-11 10:15:00.595 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Changed state from unsatisfiedReference to satisfied
2023-02-11 10:15:00.595 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : registration change queue [registered]
2023-02-11 10:15:00.596 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Checking constructor public org.openhab.binding.zwave.internal.ZWaveConfigProvider()
2023-02-11 10:15:00.596 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Found constructor with 0 arguments : public org.openhab.binding.zwave.internal.ZWaveConfigProvider()
2023-02-11 10:15:00.596 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : getting bind: setConfigDescriptionRegistry
2023-02-11 10:15:00.597 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Locating method setConfigDescriptionRegistry in class org.openhab.binding.zwave.internal.ZWaveConfigProvider
2023-02-11 10:15:00.597 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : doFindMethod: Looking for method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setConfigDescriptionRegistry
2023-02-11 10:15:00.598 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setConfigDescriptionRegistry([interface org.osgi.framework.ServiceReference]) not found
2023-02-11 10:15:00.598 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setConfigDescriptionRegistry([interface org.osgi.service.component.ComponentServiceObjects]) not found
2023-02-11 10:15:00.598 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : getReferenceClass: Looking for interface class org.openhab.core.config.core.ConfigDescriptionRegistry through loader of org.openhab.binding.zwave.internal.ZWaveConfigProvider
2023-02-11 10:15:00.598 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : getParameterClass: Found class org.openhab.core.config.core.ConfigDescriptionRegistry
2023-02-11 10:15:00.598 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : doFindMethod: No method taking ServiceReference found, checking method taking org.openhab.core.config.core.ConfigDescriptionRegistry
2023-02-11 10:15:00.598 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : doFindMethod: Found Method protected void org.openhab.binding.zwave.internal.ZWaveConfigProvider.setConfigDescriptionRegistry(org.openhab.core.config.core.ConfigDescriptionRegistry)
2023-02-11 10:15:00.598 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Found bind method: protected void org.openhab.binding.zwave.internal.ZWaveConfigProvider.setConfigDescriptionRegistry(org.openhab.core.config.core.ConfigDescriptionRegistry)
2023-02-11 10:15:00.598 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : getting bind: setThingRegistry
2023-02-11 10:15:00.599 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Locating method setThingRegistry in class org.openhab.binding.zwave.internal.ZWaveConfigProvider
2023-02-11 10:15:00.599 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : doFindMethod: Looking for method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingRegistry
2023-02-11 10:15:00.599 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingRegistry([interface org.osgi.framework.ServiceReference]) not found
2023-02-11 10:15:00.599 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingRegistry([interface org.osgi.service.component.ComponentServiceObjects]) not found
2023-02-11 10:15:00.599 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : getReferenceClass: Looking for interface class org.openhab.core.thing.ThingRegistry through loader of org.openhab.binding.zwave.internal.ZWaveConfigProvider
2023-02-11 10:15:00.599 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : getParameterClass: Found class org.openhab.core.thing.ThingRegistry
2023-02-11 10:15:00.600 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : doFindMethod: No method taking ServiceReference found, checking method taking org.openhab.core.thing.ThingRegistry
2023-02-11 10:15:00.600 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : doFindMethod: Found Method protected void org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingRegistry(org.openhab.core.thing.ThingRegistry)
2023-02-11 10:15:00.600 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Found bind method: protected void org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingRegistry(org.openhab.core.thing.ThingRegistry)
2023-02-11 10:15:00.600 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : getting bind: setThingTypeRegistry
2023-02-11 10:15:00.600 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Locating method setThingTypeRegistry in class org.openhab.binding.zwave.internal.ZWaveConfigProvider
2023-02-11 10:15:00.600 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : doFindMethod: Looking for method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingTypeRegistry
2023-02-11 10:15:00.600 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingTypeRegistry([interface org.osgi.framework.ServiceReference]) not found
2023-02-11 10:15:00.601 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingTypeRegistry([interface org.osgi.service.component.ComponentServiceObjects]) not found
2023-02-11 10:15:00.601 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : getReferenceClass: Looking for interface class org.openhab.core.thing.type.ThingTypeRegistry through loader of org.openhab.binding.zwave.internal.ZWaveConfigProvider
2023-02-11 10:15:00.601 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : getParameterClass: Found class org.openhab.core.thing.type.ThingTypeRegistry
2023-02-11 10:15:00.601 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : doFindMethod: No method taking ServiceReference found, checking method taking org.openhab.core.thing.type.ThingTypeRegistry
2023-02-11 10:15:00.601 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : doFindMethod: Found Method protected void org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingTypeRegistry(org.openhab.core.thing.type.ThingTypeRegistry)
2023-02-11 10:15:00.601 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Found bind method: protected void org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingTypeRegistry(org.openhab.core.thing.type.ThingTypeRegistry)
2023-02-11 10:15:00.601 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : This thread collected dependencies
2023-02-11 10:15:00.601 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : getService (single component manager) dependencies collected.
2023-02-11 10:15:00.601 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Querying state satisfied
2023-02-11 10:15:00.601 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Querying state satisfied
2023-02-11 10:15:00.602 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : For dependency ConfigDescriptionRegistry, optional: false; to bind: [[RefPair: ref: [{org.openhab.core.config.core.ConfigDescriptionRegistry}={service.id=226, service.bundleid=161, service.scope=bundle, component.name=org.openhab.core.config.core.ConfigDescriptionRegistry, component.id=107}] service: [org.openhab.core.config.core.ConfigDescriptionRegistry@a721022]]]
2023-02-11 10:15:00.602 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : For dependency ThingRegistry, optional: false; to bind: [[RefPair: ref: [{org.openhab.core.thing.ThingRegistry}={service.id=360, service.bundleid=212, service.scope=bundle, component.name=org.openhab.core.thing.internal.ThingRegistryImpl, component.id=244}] service: [org.openhab.core.thing.internal.ThingRegistryImpl@7ce2822c]]]
2023-02-11 10:15:00.602 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : For dependency ThingTypeRegistry, optional: false; to bind: [[RefPair: ref: [{org.openhab.core.thing.type.ThingTypeRegistry}={service.id=394, service.bundleid=212, service.scope=bundle, component.name=org.openhab.core.thing.type.ThingTypeRegistry, component.id=259}] service: [org.openhab.core.thing.type.ThingTypeRegistry@155ce6db]]]
2023-02-11 10:15:00.611 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : invoking bind: setConfigDescriptionRegistry: parameters [org.openhab.core.config.core.ConfigDescriptionRegistry]
2023-02-11 10:15:00.611 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : invoked bind: setConfigDescriptionRegistry
2023-02-11 10:15:00.611 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : invoking bind: setThingRegistry: parameters [org.openhab.core.thing.internal.ThingRegistryImpl]
2023-02-11 10:15:00.611 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : invoked bind: setThingRegistry
2023-02-11 10:15:00.612 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : invoking bind: setThingTypeRegistry: parameters [org.openhab.core.thing.type.ThingTypeRegistry]
2023-02-11 10:15:00.612 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : invoked bind: setThingTypeRegistry
2023-02-11 10:15:00.612 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : getting activate: activate
2023-02-11 10:15:00.612 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Locating method activate in class org.openhab.binding.zwave.internal.ZWaveConfigProvider
2023-02-11 10:15:00.612 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.activate([interface org.osgi.service.component.ComponentContext]) not found
2023-02-11 10:15:00.612 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Locating method activate in class java.lang.Object
2023-02-11 10:15:00.612 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Declared Method java.lang.Object.activate([interface org.osgi.service.component.ComponentContext]) not found
2023-02-11 10:15:00.612 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : activate method [activate] not found, ignoring
2023-02-11 10:15:00.612 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Set implementation object for component
2023-02-11 10:15:00.613 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Changed state from satisfied to active
2023-02-11 10:15:00.613 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Dependency Manager created SerialPortManagerinterface=org.openhab.core.io.transport.serial.SerialPortManager, filter=null, policy=static, cardinality=1..1, bind=setSerialPortManager, unbind=unsetSerialPortManager, updated=null, field=null, field-option=null, collection-type=null, parameter=null
2023-02-11 10:15:00.613 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Component created: DS=DS13, implementation=org.openhab.binding.zwave.internal.ZWaveHandlerFactory, immediate=false, default-enabled=true, factory=null, configuration-policy=optional, activate=activate, deactivate=deactivate, modified=null configuration-pid=[org.openhab.binding.zwave.internal.ZWaveHandlerFactory]
2023-02-11 10:15:00.613 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Component Services: scope=singleton, services=[org.openhab.core.thing.binding.ThingHandlerFactory]
2023-02-11 10:15:00.613 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Component Properties: {}
2023-02-11 10:15:00.614 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Querying state disabled
2023-02-11 10:15:00.614 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Querying state disabled
2023-02-11 10:15:00.614 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Component can not be activated since it is in state disabled
2023-02-11 10:15:00.614 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Querying state disabled
2023-02-11 10:15:00.614 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Updating target filters
2023-02-11 10:15:00.614 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : No change in target property for dependency SerialPortManager: currently registered: false
2023-02-11 10:15:00.614 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] :  No existing service listener to unregister for dependency SerialPortManager
2023-02-11 10:15:00.614 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Setting target property for dependency SerialPortManager to null
2023-02-11 10:15:00.615 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : New service tracker for SerialPortManager, initial active: false, previous references: {}, classFilter: (objectClass=org.openhab.core.io.transport.serial.SerialPortManager), initialReferenceFilter (objectClass=org.openhab.core.io.transport.serial.SerialPortManager)
2023-02-11 10:15:00.615 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : dm SerialPortManager tracker reset (closed)
2023-02-11 10:15:00.615 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : dm SerialPortManager tracking 1 SingleStatic added {org.openhab.core.io.transport.serial.SerialPortManager}={service.id=476, service.bundleid=257, service.scope=bundle, component.name=org.openhab.core.io.transport.serial.internal.SerialPortManagerImpl, component.id=312} (enter)
2023-02-11 10:15:00.615 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : dm SerialPortManager tracking 1 SingleStatic active: false trackerOpened: false optional: false
2023-02-11 10:15:00.616 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : dm SerialPortManager tracking 1 SingleStatic added {org.openhab.core.io.transport.serial.SerialPortManager}={service.id=476, service.bundleid=257, service.scope=bundle, component.name=org.openhab.core.io.transport.serial.internal.SerialPortManagerImpl, component.id=312} (exit)
2023-02-11 10:15:00.616 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : dm SerialPortManager tracker opened
2023-02-11 10:15:00.616 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : registering service listener for dependency SerialPortManager
2023-02-11 10:15:00.616 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Changed state from disabled to unsatisfiedReference
2023-02-11 10:15:00.616 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Component enabled
2023-02-11 10:15:00.616 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : ActivateInternal
2023-02-11 10:15:00.616 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Querying state unsatisfiedReference
2023-02-11 10:15:00.616 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Querying state unsatisfiedReference
2023-02-11 10:15:00.616 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Activating component from state unsatisfiedReference
2023-02-11 10:15:00.616 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Querying state unsatisfiedReference
2023-02-11 10:15:00.616 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Querying state unsatisfiedReference
2023-02-11 10:15:00.617 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Changed state from unsatisfiedReference to satisfied
2023-02-11 10:15:00.617 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : registration change queue [registered]
2023-02-11 10:15:00.619 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Checking constructor public org.openhab.binding.zwave.internal.ZWaveHandlerFactory()
2023-02-11 10:15:00.619 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Found constructor with 0 arguments : public org.openhab.binding.zwave.internal.ZWaveHandlerFactory()
2023-02-11 10:15:00.619 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : getting bind: setSerialPortManager
2023-02-11 10:15:00.619 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Locating method setSerialPortManager in class org.openhab.binding.zwave.internal.ZWaveHandlerFactory
2023-02-11 10:15:00.619 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : doFindMethod: Looking for method org.openhab.binding.zwave.internal.ZWaveHandlerFactory.setSerialPortManager
2023-02-11 10:15:00.620 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Declared Method org.openhab.binding.zwave.internal.ZWaveHandlerFactory.setSerialPortManager([interface org.osgi.framework.ServiceReference]) not found
2023-02-11 10:15:00.620 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Declared Method org.openhab.binding.zwave.internal.ZWaveHandlerFactory.setSerialPortManager([interface org.osgi.service.component.ComponentServiceObjects]) not found
2023-02-11 10:15:00.620 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : getReferenceClass: Looking for interface class org.openhab.core.io.transport.serial.SerialPortManager through loader of org.openhab.binding.zwave.internal.ZWaveHandlerFactory
2023-02-11 10:15:00.620 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : getParameterClass: Found class org.openhab.core.io.transport.serial.SerialPortManager
2023-02-11 10:15:00.620 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : doFindMethod: No method taking ServiceReference found, checking method taking org.openhab.core.io.transport.serial.SerialPortManager
2023-02-11 10:15:00.620 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : doFindMethod: Found Method protected void org.openhab.binding.zwave.internal.ZWaveHandlerFactory.setSerialPortManager(org.openhab.core.io.transport.serial.SerialPortManager)
2023-02-11 10:15:00.620 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Found bind method: protected void org.openhab.binding.zwave.internal.ZWaveHandlerFactory.setSerialPortManager(org.openhab.core.io.transport.serial.SerialPortManager)
2023-02-11 10:15:00.620 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : This thread collected dependencies
2023-02-11 10:15:00.621 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : getService (single component manager) dependencies collected.
2023-02-11 10:15:00.621 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Querying state satisfied
2023-02-11 10:15:00.621 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Querying state satisfied
2023-02-11 10:15:00.621 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : For dependency SerialPortManager, optional: false; to bind: [[RefPair: ref: [{org.openhab.core.io.transport.serial.SerialPortManager}={service.id=476, service.bundleid=257, service.scope=bundle, component.name=org.openhab.core.io.transport.serial.internal.SerialPortManagerImpl, component.id=312}] service: [org.openhab.core.io.transport.serial.internal.SerialPortManagerImpl@7a35a657]]]
2023-02-11 10:15:00.621 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : invoking bind: setSerialPortManager: parameters [org.openhab.core.io.transport.serial.internal.SerialPortManagerImpl]
2023-02-11 10:15:00.621 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : invoked bind: setSerialPortManager
2023-02-11 10:15:00.621 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : getting activate: activate
2023-02-11 10:15:00.621 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Locating method activate in class org.openhab.binding.zwave.internal.ZWaveHandlerFactory
2023-02-11 10:15:00.622 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Declared Method org.openhab.binding.zwave.internal.ZWaveHandlerFactory.activate([interface org.osgi.service.component.ComponentContext]) not found
2023-02-11 10:15:00.622 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Locating method activate in class org.openhab.core.thing.binding.BaseThingHandlerFactory
2023-02-11 10:15:00.622 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Found activate method: protected void org.openhab.core.thing.binding.BaseThingHandlerFactory.activate(org.osgi.service.component.ComponentContext)
2023-02-11 10:15:00.622 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : invoking activate: activate: parameters [org.apache.felix.scr.impl.manager.ComponentContextImpl]
2023-02-11 10:15:00.622 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : invoked activate: activate
2023-02-11 10:15:00.622 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Set implementation object for component
2023-02-11 10:15:00.622 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Changed state from satisfied to active
2023-02-11 10:15:01.107 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - Creating ZWave discovery service for zwave:serial_zstick:fa3f8e64fd with scan time of 60
2023-02-11 10:15:01.107 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - ZWave discovery: Active zwave:serial_zstick:fa3f8e64fd
2023-02-11 10:15:01.107 [INFO ] [zwave.handler.ZWaveControllerHandler] - Attempting to add listener when controller is null
2023-02-11 10:15:01.112 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Initializing ZWave serial controller.
2023-02-11 10:15:01.112 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Initializing ZWave Controller zwave:serial_zstick:fa3f8e64fd.
2023-02-11 10:15:01.120 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:fa3f8e64fd:node2.
2023-02-11 10:15:14.285 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(320)] : Querying state active
2023-02-11 10:15:14.286 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:4.0.0.202302102312 (260)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(319)] : Querying state active
2023-02-11 10:16:36.132 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Connecting to serial port '/dev/ttyACM0'
2023-02-11 10:16:36.145 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Starting receive thread
2023-02-11 10:16:36.149 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Starting ZWave thread: Receive
2023-02-11 10:16:36.149 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Serial port is initialized
2023-02-11 10:16:36.149 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Initialising ZWave controller
2023-02-11 10:16:36.167 [INFO ] [ve.internal.protocol.ZWaveController] - Starting ZWave controller
2023-02-11 10:16:36.167 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-02-11 10:16:36.167 [INFO ] [ve.internal.protocol.ZWaveController] - ZWave timeout is set to 5000ms. Soft reset is false.
2023-02-11 10:16:36.168 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-02-11 10:16:36.168 [DEBUG] [ve.internal.protocol.ZWaveController] - Event listener added.
2023-02-11 10:16:36.168 [DEBUG] [ve.internal.protocol.ZWaveController] - Event listener added.
2023-02-11 10:16:36.169 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Scheduling network mesh heal for 16 hours time.
2023-02-11 10:16:39.169 [DEBUG] [.ZWaveController$InitializeDelayTask] - Initialising network

justaoldman · July 4, 2025, 3:29am

Hi,
If I was trouble shooting this based on what you have stated i.e. not made any changes no upgrades or any other activities like that then I would start looking at a possible hardware issue.
Either your stick/controller is failing /failed or you have a failing sd card.
If it was me, I would try the cheapest easy way first and that is get a fresh sd card do a fresh load of openhabian on it and pop the stick in and see if it works.
Since all your devices and such are saved on the controller if the stick is fine it should come back up and find all your devices if that works pop the old card back in and do a back-up if you do not already have one then restore the back up onto the clean openhabian build.
This approach will quickly show where your issue is and what the next best step may be.