Coolcam Neo PIR sensor does not show chanels

, , ,
10

You are right, i had the wrong logs! Here the correct one (since adding the found device)

2022-12-09 16:39:03.278 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 11 00 04 00 07 09 71 05 00 00 00 FF 07 08 00 D7 00 B7 
2022-12-09 16:39:03.280 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=7, callback=0, payload=00 07 09 71 05 00 00 00 FF 07 08 00 D7 00 
2022-12-09 16:39:03.281 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=7, callback=0, payload=00 07 09 71 05 00 00 00 FF 07 08 00 D7 00 
2022-12-09 16:39:03.281 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2022-12-09 16:39:03.282 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: Application Command Request (ALIVE:DONE)
2022-12-09 16:39:03.282 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 7: resetResendCount initComplete=true isDead=false
2022-12-09 16:39:03.283 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 7: Incoming command class COMMAND_CLASS_ALARM, endpoint 0
2022-12-09 16:39:03.283 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 7: SECURITY not supported
2022-12-09 16:39:03.284 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 7: Received COMMAND_CLASS_ALARM V8 NOTIFICATION_REPORT
2022-12-09 16:39:03.284 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 7: NOTIFICATION report - 0 = 0, event=8, status=255, plen=0
2022-12-09 16:39:03.285 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 7: Alarm Type = BURGLAR (0)
2022-12-09 16:39:03.285 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: Commands processed 1.
2022-12-09 16:39:03.286 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@50d77487.
2022-12-09 16:39:03.286 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2022-12-09 16:39:03.287 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2022-12-09 16:39:03.287 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-12-09 16:39:03.287 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-12-09 16:39:03.308 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0E 00 04 00 07 06 31 05 05 22 02 7E CF 00 54 
2022-12-09 16:39:03.310 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=7, callback=0, payload=00 07 06 31 05 05 22 02 7E CF 00 
2022-12-09 16:39:03.311 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=7, callback=0, payload=00 07 06 31 05 05 22 02 7E CF 00 
2022-12-09 16:39:03.311 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2022-12-09 16:39:03.312 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: Application Command Request (ALIVE:DONE)
2022-12-09 16:39:03.312 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 7: resetResendCount initComplete=true isDead=false
2022-12-09 16:39:03.313 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 7: Incoming command class COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0
2022-12-09 16:39:03.313 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 7: SECURITY not supported
2022-12-09 16:39:03.313 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 7: Received COMMAND_CLASS_SENSOR_MULTILEVEL V7 SENSOR_MULTILEVEL_REPORT
2022-12-09 16:39:03.314 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 7: Sensor Type = RelativeHumidity(5), Scale = 0
2022-12-09 16:39:03.315 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 7: Sensor Value = 63.8
2022-12-09 16:39:03.315 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: Commands processed 1.
2022-12-09 16:39:03.315 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@3b4cf33a.
2022-12-09 16:39:03.316 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2022-12-09 16:39:03.316 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2022-12-09 16:39:03.317 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-12-09 16:39:03.317 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-12-09 16:39:05.954 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - ZWave discovery: Stop zwave:serial_zstick:7144590b52
2022-12-09 16:39:05.954 [DEBUG] [ve.internal.protocol.ZWaveController] - ZWave inclusion process not running - nothing to do
2022-12-09 16:39:05.955 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - ZWave discovery: Start zwave:serial_zstick:7144590b52
2022-12-09 16:39:05.956 [DEBUG] [ve.internal.protocol.ZWaveController] - ZWave controller start inclusion - mode 2
2022-12-09 16:39:05.957 [DEBUG] [ve.internal.protocol.ZWaveController] - Event listener added.
2022-12-09 16:39:05.957 [DEBUG] [al.protocol.ZWaveInclusionController] - ZWave controller start inclusion
2022-12-09 16:39:05.958 [DEBUG] [ol.serialmessage.AddNodeMessageClass] - Setting controller into INCLUSION mode, highPower:true networkWide:true.
2022-12-09 16:39:05.958 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Added 80 to queue - size 1
2022-12-09 16:39:05.959 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-12-09 16:39:05.959 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 05 00 4A C1 53 22 
2022-12-09 16:39:05.960 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 05 00 4A C1 53 22 
2022-12-09 16:39:05.961 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2022-12-09 16:39:05.961 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 80: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 83
2022-12-09 16:39:05.961 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2022-12-09 16:39:05.962 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-12-09 16:39:05.963 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-12-09 16:39:05.963 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 80: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 83
2022-12-09 16:39:05.963 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2022-12-09 16:39:05.963 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-12-09 16:39:05.964 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2022-12-09 16:39:05.964 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 4A 53 01 00 00 E0 
2022-12-09 16:39:05.968 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=AddNodeToNetwork[74], type=Request[0], dest=1, callback=83, payload=53 01 00 00 
2022-12-09 16:39:05.969 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=AddNodeToNetwork[74], type=Request[0], dest=1, callback=83, payload=53 01 00 00 
2022-12-09 16:39:05.969 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 80: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 83
2022-12-09 16:39:05.969 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2022-12-09 16:39:05.970 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 80: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 83
2022-12-09 16:39:05.970 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 80: (Callback 83)
2022-12-09 16:39:05.970 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2022-12-09 16:39:05.970 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 80: callback 83
2022-12-09 16:39:05.970 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=AddNodeToNetwork[74], type=Request[0], dest=1, callback=83, payload=53 01 00 00 
2022-12-09 16:39:05.971 [DEBUG] [ol.serialmessage.AddNodeMessageClass] - Add Node: Learn ready.
2022-12-09 16:39:05.971 [DEBUG] [al.protocol.ZWaveInclusionController] - Inclusion event: Current state IncludeSent, new event IncludeStart
2022-12-09 16:39:05.971 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 80: Transaction COMPLETED
2022-12-09 16:39:05.972 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Response processed after 11ms
2022-12-09 16:39:05.972 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: TID 80: Transaction completed
2022-12-09 16:39:05.972 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: notifyTransactionResponse TID:80 DONE
2022-12-09 16:39:05.973 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-12-09 16:39:05.973 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-12-09 16:39:07.962 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 2: Device discovery completed
2022-12-09 16:39:07.965 [WARN ] [wave.discovery.ZWaveDiscoveryService] - NODE 2: Device discovery could not resolve to a thingType! Manufacturer data not known.
2022-12-09 16:39:07.973 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'zwave:device:7144590b52:node2' to inbox.
2022-12-09 16:39:07.975 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 5: Device discovery completed
2022-12-09 16:39:07.976 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 5: Device discovery resolved to thingType zwave:shenzhen_coolcampwrplug_00_000
2022-12-09 16:39:07.980 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 7: Device discovery completed
2022-12-09 16:39:07.984 [WARN ] [wave.discovery.ZWaveDiscoveryService] - NODE 7: Device discovery could not resolve to a thingType! 0258:0200:1036::3.6
2022-12-09 16:39:07.987 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'zwave:device:7144590b52:node7' to inbox.
2022-12-09 16:39:12.398 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:7144590b52:node7.
2022-12-09 16:39:12.405 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Checking zwave:coqon_psmz0001_00_000
2022-12-09 16:39:12.406 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Checking zwave:defaro_dad101_00_000

.........
.........
.........
.........
2022-12-09 16:39:12.617 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Checking zwave:yale_ycl1_00_000
2022-12-09 16:39:12.617 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Checking zwave:yale_ycl1_00_000
2022-12-09 16:39:12.617 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Checking zwave:yale_yrl256_01_078
2022-12-09 16:39:12.618 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Checking zwave:yale_yrd216_00_000
2022-12-09 16:39:12.618 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Checking zwave:yale_yrl220_00_000
2022-12-09 16:39:12.618 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Checking zwave:yale_yrl220_00_000
2022-12-09 16:39:12.618 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Checking zwave:yale_yrl220_00_000
2022-12-09 16:39:12.619 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Checking zwave:yale_yrl220_00_000
2022-12-09 16:39:12.619 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Checking zwave:logic_zdb5100_00_000
2022-12-09 16:39:12.619 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Checking zwave:homeseer_hsws100_00_000
2022-12-09 16:39:12.619 [DEBUG] 
[ding.zwave.handler.ZWaveThingHandler] - Checking zwave:homeseer_hswx300_00_000
2022-12-09 16:39:12.962 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Checking zwave:ge_28167_00_000
2022-12-09 16:39:12.963 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Checking zwave:ge_28167_00_000
2022-12-09 16:39:12.963 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Checking zwave:ge_ultrapro39348_00_000
2022-12-09 16:39:12.963 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Checking zwave:hank_acc01_00_000
2022-12-09 16:39:12.963 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Checking zwave:hank_swes01_00_000
2022-12-09 16:39:12.963 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Checking zwave:hank_hkzwms01_00_000
2022-12-09 16:39:12.964 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Checking zwave:hank_scn04_00_000
2022-12-09 16:39:12.964 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Checking zwave:hank_scn04_00_000
2022-12-09 16:39:12.964 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 7: Unable to find thing type (0258:0200:1036:3.6)
2022-12-09 16:39:12.964 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 7: Controller status changed to ONLINE.
2022-12-09 16:39:12.965 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 7: Controller is ONLINE. Starting device initialisation.
2022-12-09 16:39:12.967 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 7: Updating node properties.
2022-12-09 16:39:12.969 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 7: Updating node properties. MAN=600
2022-12-09 16:39:12.970 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 7: Updating node properties. MAN=600. SET. Was 600
2022-12-09 16:39:12.970 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 7: Properties synchronised
2022-12-09 16:39:12.972 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 7: Update ASSOCIATION group_ZWaveAssociationGroup [index=1, name=Lifeline, profile1=0, profile2=1, associations=[node_1]]: Adding Controller (node_1)
2022-12-09 16:39:12.973 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 7: Configuration synchronised
2022-12-09 16:39:12.976 [DEBUG] [ve.internal.protocol.ZWaveController] - Event listener added.
2022-12-09 16:39:12.977 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 7: Initialising Thing Node...
2022-12-09 16:39:12.977 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 7: Polling initialised at 86400 seconds - start in 72662400 milliseconds.
2022-12-09 16:39:12.978 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 7: Device initialisation complete.
2022-12-09 16:39:29.946 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0A 00 04 10 07 02 84 07 CA 00 AD 
2022-12-09 16:39:29.947 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=7, callback=16, payload=10 07 02 84 07 CA 00 
2022-12-09 16:39:29.948 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=7, callback=16, payload=10 07 02 84 07 CA 00 
2022-12-09 16:39:29.949 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2022-12-09 16:39:29.950 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: Application Command Request (ALIVE:DONE)
2022-12-09 16:39:29.950 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 7: resetResendCount initComplete=true isDead=false
2022-12-09 16:39:29.951 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 7: Is awake with 0 messages in the queue, state DONE
2022-12-09 16:39:29.952 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - awakeMax for this Timer Task 20 in 0.5 second intervals
2022-12-09 16:39:29.953 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 7: Start sleep timer with 500ms interval
2022-12-09 16:39:29.954 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 7: Got an event from Z-Wave network: ZWaveNodeStatusEvent
2022-12-09 16:39:29.958 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 7: Node Status event - Node is AWAKE
2022-12-09 16:39:29.959 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: Commands processed 1.
2022-12-09 16:39:29.960 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@3816d925.
2022-12-09 16:39:29.961 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2022-12-09 16:39:29.962 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2022-12-09 16:39:29.962 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-12-09 16:39:29.963 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-12-09 16:39:30.454 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 7: WakeupTimerTask 0 Messages waiting, state DONE count 1
2022-12-09 16:39:30.454 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 7: Go back to sleep, state DONE, count 1 messages 0
2022-12-09 16:39:30.455 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 7: Creating new message for application command WAKE_UP_NO_MORE_INFORMATION
2022-12-09 16:39:30.455 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 7: SECURITY not supported
2022-12-09 16:39:30.455 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 7: Command Class COMMAND_CLASS_WAKE_UP is NOT required to be secured
2022-12-09 16:39:30.455 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: sendTransaction org.openhab.binding.zwave.internal.protocol.transaction.ZWaveCommandClassTransactionPayload@37ffd531
2022-12-09 16:39:30.456 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: Bump transaction 81 priority from Immediate to Immediate
2022-12-09 16:39:30.457 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: Adding to device queue
2022-12-09 16:39:30.460 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: Added 81 to queue - size 2
2022-12-09 16:39:30.461 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-12-09 16:39:30.462 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 07 02 84 08 25 54 1D 
2022-12-09 16:39:30.463 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 7: Sending REQUEST Message = 01 09 00 13 07 02 84 08 25 54 1D 
2022-12-09 16:39:30.464 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2022-12-09 16:39:30.465 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 81: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 84
2022-12-09 16:39:30.465 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2022-12-09 16:39:30.465 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-12-09 16:39:30.466 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-12-09 16:39:30.466 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 81: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 84
2022-12-09 16:39:30.467 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2022-12-09 16:39:30.467 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-12-09 16:39:30.468 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2022-12-09 16:39:30.471 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2022-12-09 16:39:30.472 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2022-12-09 16:39:30.472 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2022-12-09 16:39:30.473 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 81: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 84
2022-12-09 16:39:30.473 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2022-12-09 16:39:30.473 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 81: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 84
2022-12-09 16:39:30.474 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2022-12-09 16:39:30.474 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 7: sentData successfully placed on stack.
2022-12-09 16:39:30.475 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 81: Advanced to WAIT_REQUEST
2022-12-09 16:39:30.475 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: TID 81: Transaction not completed
2022-12-09 16:39:30.476 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-12-09 16:39:30.476 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2022-12-09 16:39:30.495 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 18 00 13 54 00 00 02 00 D0 7F 7F 7F 7F 01 01 03 00 00 00 00 02 01 00 00 72 
2022-12-09 16:39:30.496 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=84, payload=54 00 00 02 00 D0 7F 7F 7F 7F 01 01 03 00 00 00 00 02 01 00 00 
2022-12-09 16:39:30.497 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=84, payload=54 00 00 02 00 D0 7F 7F 7F 7F 01 01 03 00 00 00 00 02 01 00 00 
2022-12-09 16:39:30.497 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 81: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 84
2022-12-09 16:39:30.498 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2022-12-09 16:39:30.499 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 81: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 84
2022-12-09 16:39:30.499 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 81: (Callback 84)
2022-12-09 16:39:30.500 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2022-12-09 16:39:30.501 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 81: callback 84
2022-12-09 16:39:30.502 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=84, payload=54 00 00 02 00 D0 7F 7F 7F 7F 01 01 03 00 00 00 00 02 01 00 00 
2022-12-09 16:39:30.503 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 7: SendData Request. CallBack ID = 84, Status = Transmission complete and ACK received(0)
2022-12-09 16:39:30.503 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 7: resetResendCount initComplete=true isDead=false
2022-12-09 16:39:30.504 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 81: Transaction COMPLETED
2022-12-09 16:39:30.505 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: Response processed after 41ms
2022-12-09 16:39:30.506 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: TID 81: Transaction completed
2022-12-09 16:39:30.506 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: notifyTransactionResponse TID:81 DONE
2022-12-09 16:39:30.508 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 7: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2022-12-09 16:39:30.508 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 81: Transaction event listener: DONE: DONE -> UNINTIALIZED
2022-12-09 16:39:30.509 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 7: Went to sleep COMPLETE
2022-12-09 16:39:30.509 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-12-09 16:39:30.510 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-12-09 16:39:39.420 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 5: ZWaveCommandClassTransactionPayload - send to node
2022-12-09 16:39:39.421 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 5: SECURITY doesn't encrypt PING
2022-12-09 16:39:39.422 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 5: Command Class COMMAND_CLASS_NO_OPERATION is NOT required to be secured
2022-12-09 16:39:39.422 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 5: sendTransaction org.openhab.binding.zwave.internal.protocol.transaction.ZWaveCommandClassTransactionPayload@496ac01a
2022-12-09 16:39:39.423 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 5: Adding to device queue
2022-12-09 16:39:39.425 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 5: Added 82 to queue - size 2
2022-12-09 16:39:39.426 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-12-09 16:39:39.427 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 08 00 13 05 01 00 25 55 90 
2022-12-09 16:39:39.428 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 5: Sending REQUEST Message = 01 08 00 13 05 01 00 25 55 90 
2022-12-09 16:39:39.429 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2022-12-09 16:39:39.430 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 82: [WAIT_RESPONSE] priority=Poll, requiresResponse=true, callback: 85
2022-12-09 16:39:39.431 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2022-12-09 16:39:39.431 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-12-09 16:39:39.432 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-12-09 16:39:39.433 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 82: [WAIT_RESPONSE] priority=Poll, requiresResponse=true, callback: 85
2022-12-09 16:39:39.433 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2022-12-09 16:39:39.434 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-12-09 16:39:39.434 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2022-12-09 16:39:39.441 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2022-12-09 16:39:39.442 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2022-12-09 16:39:39.442 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2022-12-09 16:39:39.443 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 82: [WAIT_RESPONSE] priority=Poll, requiresResponse=true, callback: 85
2022-12-09 16:39:39.443 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2022-12-09 16:39:39.444 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 82: [WAIT_RESPONSE] priority=Poll, requiresResponse=true, callback: 85
2022-12-09 16:39:39.445 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2022-12-09 16:39:39.445 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 5: sentData successfully placed on stack.
2022-12-09 16:39:39.446 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 82: Advanced to WAIT_REQUEST
2022-12-09 16:39:39.447 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 5: TID 82: Transaction not completed
2022-12-09 16:39:39.447 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-12-09 16:39:39.448 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2022-12-09 16:39:43.684 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 18 00 13 55 01 01 A9 00 7F 7F 7F 7F 7F 01 01 07 00 00 00 00 02 07 00 00 75 
2022-12-09 16:39:43.685 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=1, callback=85, payload=55 01 01 A9 00 7F 7F 7F 7F 7F 01 01 07 00 00 00 00 02 07 00 00 
2022-12-09 16:39:43.686 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=1, callback=85, payload=55 01 01 A9 00 7F 7F 7F 7F 7F 01 01 07 00 00 00 00 02 07 00 00 
2022-12-09 16:39:43.687 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 82: [WAIT_REQUEST] priority=Poll, requiresResponse=true, callback: 85
2022-12-09 16:39:43.687 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2022-12-09 16:39:43.688 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 82: [WAIT_REQUEST] priority=Poll, requiresResponse=true, callback: 85
2022-12-09 16:39:43.689 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 82: (Callback 85)
2022-12-09 16:39:43.690 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2022-12-09 16:39:43.691 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 82: callback 85
2022-12-09 16:39:43.691 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=1, callback=85, payload=55 01 01 A9 00 7F 7F 7F 7F 7F 01 01 07 00 00 00 00 02 07 00 00 
2022-12-09 16:39:43.692 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 5: SendData Request. CallBack ID = 85, Status = Transmission complete, no ACK received(1)
2022-12-09 16:39:43.693 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 82: Transaction CANCELLED
2022-12-09 16:39:43.693 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 5: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2022-12-09 16:39:43.694 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 5: CANCEL while sending message. Requeueing - 2 attempts left!
2022-12-09 16:39:43.695 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 82: Transaction RESET with 2 retries remaining.
2022-12-09 16:39:43.695 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 5: Adding to device queue
2022-12-09 16:39:43.696 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 5: Added 82 to queue - size 2
2022-12-09 16:39:43.696 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-12-09 16:39:43.697 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 08 00 13 05 01 00 25 56 93 
2022-12-09 16:39:43.698 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 5: Sending REQUEST Message = 01 08 00 13 05 01 00 25 56 93 
2022-12-09 16:39:43.699 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2022-12-09 16:39:43.699 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 82: [WAIT_RESPONSE] priority=Poll, requiresResponse=true, callback: 86
2022-12-09 16:39:43.700 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2022-12-09 16:39:43.700 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 5: TID 82: Transaction not completed
2022-12-09 16:39:43.701 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-12-09 16:39:43.701 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-12-09 16:39:43.701 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2022-12-09 16:39:43.702 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-12-09 16:39:43.703 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 82: [WAIT_RESPONSE] priority=Poll, requiresResponse=true, callback: 86
2022-12-09 16:39:43.703 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2022-12-09 16:39:43.703 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-12-09 16:39:43.704 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2022-12-09 16:39:43.710 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2022-12-09 16:39:43.711 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2022-12-09 16:39:43.712 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2022-12-09 16:39:43.713 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 82: [WAIT_RESPONSE] priority=Poll, requiresResponse=true, callback: 86
2022-12-09 16:39:43.713 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2022-12-09 16:39:43.713 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 82: [WAIT_RESPONSE] priority=Poll, requiresResponse=true, callback: 86
2022-12-09 16:39:43.714 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2022-12-09 16:39:43.714 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 5: sentData successfully placed on stack.
2022-12-09 16:39:43.715 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 82: Advanced to WAIT_REQUEST
2022-12-09 16:39:43.715 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 5: TID 82: Transaction not completed
2022-12-09 16:39:43.716 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-12-09 16:39:43.716 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2022-12-09 16:39:47.924 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 18 00 13 56 01 01 A6 00 7F 7F 7F 7F 7F 01 01 07 00 00 00 00 02 07 00 00 79 
2022-12-09 16:39:47.926 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=1, callback=86, payload=56 01 01 A6 00 7F 7F 7F 7F 7F 01 01 07 00 00 00 00 02 07 00 00 
2022-12-09 16:39:47.927 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=1, callback=86, payload=56 01 01 A6 00 7F 7F 7F 7F 7F 01 01 07 00 00 00 00 02 07 00 00 
2022-12-09 16:39:47.927 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 82: [WAIT_REQUEST] priority=Poll, requiresResponse=true, callback: 86
2022-12-09 16:39:47.928 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2022-12-09 16:39:47.928 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 82: [WAIT_REQUEST] priority=Poll, requiresResponse=true, callback: 86
2022-12-09 16:39:47.929 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 82: (Callback 86)
2022-12-09 16:39:47.929 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2022-12-09 16:39:47.930 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 82: callback 86
2022-12-09 16:39:47.930 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=1, callback=86, payload=56 01 01 A6 00 7F 7F 7F 7F 7F 01 01 07 00 00 00 00 02 07 00 00 
2022-12-09 16:39:47.931 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 5: SendData Request. CallBack ID = 86, Status = Transmission complete, no ACK received(1)
2022-12-09 16:39:47.931 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 82: Transaction CANCELLED
2022-12-09 16:39:47.932 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 5: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2022-12-09 16:39:47.933 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 5: CANCEL while sending message. Requeueing - 1 attempts left!
2022-12-09 16:39:47.933 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 82: Transaction RESET with 1 retries remaining.
2022-12-09 16:39:47.934 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 5: Adding to device queue
2022-12-09 16:39:47.934 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 5: Added 82 to queue - size 2
2022-12-09 16:39:47.935 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-12-09 16:39:47.936 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 08 00 13 05 01 00 25 57 92 
2022-12-09 16:39:47.936 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 5: Sending REQUEST Message = 01 08 00 13 05 01 00 25 57 92 
2022-12-09 16:39:47.937 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2022-12-09 16:39:47.938 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 82: [WAIT_RESPONSE] priority=Poll, requiresResponse=true, callback: 87
2022-12-09 16:39:47.938 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2022-12-09 16:39:47.939 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 5: TID 82: Transaction not completed
2022-12-09 16:39:47.939 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-12-09 16:39:47.939 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-12-09 16:39:47.939 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2022-12-09 16:39:47.940 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-12-09 16:39:47.941 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 82: [WAIT_RESPONSE] priority=Poll, requiresResponse=true, callback: 87
2022-12-09 16:39:47.941 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2022-12-09 16:39:47.942 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-12-09 16:39:47.943 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2022-12-09 16:39:47.949 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2022-12-09 16:39:47.950 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2022-12-09 16:39:47.950 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2022-12-09 16:39:47.951 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 82: [WAIT_RESPONSE] priority=Poll, requiresResponse=true, callback: 87
2022-12-09 16:39:47.952 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2022-12-09 16:39:47.952 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 82: [WAIT_RESPONSE] priority=Poll, requiresResponse=true, callback: 87
2022-12-09 16:39:47.953 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2022-12-09 16:39:47.954 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 5: sentData successfully placed on stack.
2022-12-09 16:39:47.955 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 82: Advanced to WAIT_REQUEST
2022-12-09 16:39:47.955 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 5: TID 82: Transaction not completed
2022-12-09 16:39:47.956 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-12-09 16:39:47.956 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2022-12-09 16:39:52.193 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 18 00 13 57 01 01 A9 00 7F 7F 7F 7F 7F 01 01 07 00 00 00 00 02 07 00 00 77 
2022-12-09 16:39:52.194 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=1, callback=87, payload=57 01 01 A9 00 7F 7F 7F 7F 7F 01 01 07 00 00 00 00 02 07 00 00 
2022-12-09 16:39:52.194 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=1, callback=87, payload=57 01 01 A9 00 7F 7F 7F 7F 7F 01 01 07 00 00 00 00 02 07 00 00 
2022-12-09 16:39:52.194 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 82: [WAIT_REQUEST] priority=Poll, requiresResponse=true, callback: 87
2022-12-09 16:39:52.195 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2022-12-09 16:39:52.195 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 82: [WAIT_REQUEST] priority=Poll, requiresResponse=true, callback: 87
2022-12-09 16:39:52.195 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 82: (Callback 87)
2022-12-09 16:39:52.195 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2022-12-09 16:39:52.196 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 82: callback 87
2022-12-09 16:39:52.196 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=1, callback=87, payload=57 01 01 A9 00 7F 7F 7F 7F 7F 01 01 07 00 00 00 00 02 07 00 00 
2022-12-09 16:39:52.196 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 5: SendData Request. CallBack ID = 87, Status = Transmission complete, no ACK received(1)
2022-12-09 16:39:52.196 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 82: Transaction CANCELLED
2022-12-09 16:39:52.197 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 5: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2022-12-09 16:39:52.197 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 5: Retry count exceeded. Discarding message: TID 82: [CANCELLED] priority=Poll, requiresResponse=true, callback: 87
2022-12-09 16:39:52.197 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 5: TID 82: Transaction completed
2022-12-09 16:39:52.197 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 5: notifyTransactionResponse TID:82 CANCELLED
2022-12-09 16:39:52.198 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 5: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2022-12-09 16:39:52.198 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 82: Transaction event listener: DONE: CANCELLED -> WAIT_REQUEST
2022-12-09 16:39:52.198 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-12-09 16:39:52.198 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 5: Node Init response (0) org.openhab.binding.zwave.internal.protocol.ZWaveTransactionResponse@2d0be2b9
2022-12-09 16:39:52.199 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-12-09 16:40:02.027 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 12 00 04 10 07 0A 71 05 00 00 00 FF 07 00 01 08 D0 00 A1 
2022-12-09 16:40:02.029 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=7, callback=16, payload=10 07 0A 71 05 00 00 00 FF 07 00 01 08 D0 00 
2022-12-09 16:40:02.030 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=7, callback=16, payload=10 07 0A 71 05 00 00 00 FF 07 00 01 08 D0 00 
2022-12-09 16:40:02.031 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2022-12-09 16:40:02.031 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: Application Command Request (ALIVE:DONE)
2022-12-09 16:40:02.032 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 7: resetResendCount initComplete=true isDead=false
2022-12-09 16:40:02.033 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 7: Incoming command class COMMAND_CLASS_ALARM, endpoint 0
2022-12-09 16:40:02.034 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 7: SECURITY not supported
2022-12-09 16:40:02.034 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 7: Received COMMAND_CLASS_ALARM V8 NOTIFICATION_REPORT
2022-12-09 16:40:02.035 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 7: NOTIFICATION report - 0 = 0, event=0, status=255, plen=1
2022-12-09 16:40:02.036 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 7: Alarm Type = BURGLAR (0)
2022-12-09 16:40:02.037 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 7: Got an event from Z-Wave network: ZWaveAlarmValueEvent
2022-12-09 16:40:02.038 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 7: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_ALARM, value=255
2022-12-09 16:40:02.040 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: Commands processed 1.
2022-12-09 16:40:02.040 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@75494b8d.
2022-12-09 16:40:02.041 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2022-12-09 16:40:02.042 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2022-12-09 16:40:02.042 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-12-09 16:40:02.043 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

I placed a non-powered USB-hub (as i still dont have a powered one, will get one this weekend). With the hub i find the PIR device twice, once as NODE2 and once as NODE7. Node 7 looks already better, it has more device properties, including a zwave_lastwakeup which is updated when i press the button on the PIR.

image
image1259×1134 86 KB

I also have alle the options which i should have according to this thready here

image
image1290×339 17.3 KB

Unfortunately i still have no chanels

image
image1338×308 13.3 KB

I also think i have the device ID which is needed to check if the device is in the database but i’m not sure about this:

image
image1291×482 49.3 KB