chris:
This will show what’s happening a bit better
this generates a lot more logging
11:35:24.047 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'LIGHT1_dimmer' received command 43
11:35:24.048 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: MoveToLevelWithOnOffCommand [Level Control: 0/0 -> 7626/1, cluster=0008, TID=7D, level=109, transitionTime=10]
11:35:24.068 [INFO ] [marthome.event.ItemStateChangedEvent] - LIGHT1_dimmer changed from 0 to 43
11:35:24.060 [DEBUG] [31.network.impl.CommandInterfaceImpl] - -> AF_DATA_REQUEST (Packet: subsystem=null, length=16, apiId=24 01, data=FE 10 24 01 CA 1D 01 01 08 00 7D 30 1F 06 01 7D 04 6D 0A 00 A1, checksum=A1, error=false)
11:35:24.113 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <- AF_DATA_SRSP (FE 01 64 01 00 64)
11:35:24.146 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 03 45 C4 CA 1D 00 55)
11:35:24.162 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=3, apiId=45 C4, data=FE 03 45 C4 CA 1D 00 55, checksum=55, error=false
11:35:24.169 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45c4
11:35:24.178 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 03 45 C4 CA 1D 00 55)
11:35:24.184 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=3, apiId=45 C4, data=FE 03 45 C4 CA 1D 00 55, checksum=55, error=false
11:35:24.191 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45c4
11:35:24.199 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- AF_DATA_CONFIRM (FE 03 44 80 00 01 7D BB)
11:35:24.251 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: AF_DATA_CONFIRM(Endpoint=1, Status=SUCCESS(0), TransID=125)
11:35:24.263 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- AF_INCOMING_MSG (FE 19 44 81 00 00 08 00 CA 1D 01 01 00 22 00 F0 E3 20 00 00 05 08 7D 0B 04 00 CA 1D 1D A7)
11:35:24.270 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=25, apiId=44 81, data=FE 19 44 81 00 00 08 00 CA 1D 01 01 00 22 00 F0 E3 20 00 00 05 08 7D 0B 04 00 CA 1D 1D A7, checksum=A7, error=false
11:35:24.281 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: DefaultResponse [Level Control: 7626/1 -> 0/1, cluster=0008, TID=7D, commandIdentifier=4, statusCode=0]
11:35:28.824 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'LIGHT1_color' received command 119,36,32
11:35:28.827 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: MoveToHueAndSaturationCommand [Color control: 0/0 -> 7626/1, cluster=0300, TID=7E, hue=84, saturation=91, transitionTime=10]
11:35:28.839 [DEBUG] [31.network.impl.CommandInterfaceImpl] - -> AF_DATA_REQUEST (Packet: subsystem=null, length=17, apiId=24 01, data=FE 11 24 01 CA 1D 01 01 00 03 7E 30 1F 07 01 7E 06 54 5B 0A 00 CA, checksum=CA, error=false)
11:35:28.883 [INFO ] [marthome.event.ItemStateChangedEvent] - LIGHT1_color changed from 271,36,32 to 119,36,32
11:35:28.889 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <- AF_DATA_SRSP (FE 01 64 01 00 64)
11:35:28.913 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 03 45 C4 CA 1D 00 55)
11:35:28.917 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=3, apiId=45 C4, data=FE 03 45 C4 CA 1D 00 55, checksum=55, error=false
11:35:28.935 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45c4
11:35:28.943 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 03 45 C4 CA 1D 00 55)
11:35:28.950 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=3, apiId=45 C4, data=FE 03 45 C4 CA 1D 00 55, checksum=55, error=false
11:35:28.957 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45c4
11:35:28.970 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- AF_DATA_CONFIRM (FE 03 44 80 00 01 7E B8)
11:35:28.976 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: AF_DATA_CONFIRM(Endpoint=1, Status=SUCCESS(0), TransID=126)
11:35:28.988 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- AF_INCOMING_MSG (FE 19 44 81 00 00 00 03 CA 1D 01 01 00 22 00 3C 1E 21 00 00 05 08 7E 0B 06 81 CA 1D 1D 1C)
11:35:28.994 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=25, apiId=44 81, data=FE 19 44 81 00 00 00 03 CA 1D 01 01 00 22 00 3C 1E 21 00 00 05 08 7E 0B 06 81 CA 1D 1D 1C, checksum=1C, error=false
11:35:29.002 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: DefaultResponse [Color control: 7626/1 -> 0/1, cluster=0300, TID=7E, commandIdentifier=6, statusCode=129]
11:35:29.022 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: MoveToSaturationCommand [Color control: 0/0 -> 7626/1, cluster=0300, TID=7F, saturation=91, transitionTime=10]
11:35:29.032 [DEBUG] [31.network.impl.CommandInterfaceImpl] - -> AF_DATA_REQUEST (Packet: subsystem=null, length=16, apiId=24 01, data=FE 10 24 01 CA 1D 01 01 00 03 7F 30 1F 06 01 7F 03 5B 0A 00 9B, checksum=9B, error=false)
11:35:29.064 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <- AF_DATA_SRSP (FE 01 64 01 00 64)
11:35:29.090 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 03 45 C4 CA 1D 00 55)
11:35:29.096 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=3, apiId=45 C4, data=FE 03 45 C4 CA 1D 00 55, checksum=55, error=false
11:35:29.102 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45c4
11:35:29.110 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 03 45 C4 CA 1D 00 55)
11:35:29.115 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=3, apiId=45 C4, data=FE 03 45 C4 CA 1D 00 55, checksum=55, error=false
11:35:29.122 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45c4
11:35:29.150 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- AF_DATA_CONFIRM (FE 03 44 80 00 01 7F B9)
11:35:29.155 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: AF_DATA_CONFIRM(Endpoint=1, Status=SUCCESS(0), TransID=127)
11:35:29.169 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- AF_INCOMING_MSG (FE 19 44 81 00 00 00 03 CA 1D 01 01 00 1F 00 6A 20 21 00 00 05 08 7F 0B 03 81 CA 1D 1D 4D)
11:35:29.175 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=25, apiId=44 81, data=FE 19 44 81 00 00 00 03 CA 1D 01 01 00 1F 00 6A 20 21 00 00 05 08 7F 0B 03 81 CA 1D 1D 4D, checksum=4D, error=false
11:35:29.182 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: DefaultResponse [Color control: 7626/1 -> 0/1, cluster=0300, TID=7F, commandIdentifier=3, statusCode=129]
11:35:29.199 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: MoveToLevelWithOnOffCommand [Level Control: 0/0 -> 7626/1, cluster=0008, TID=80, level=81, transitionTime=10]
11:35:29.207 [DEBUG] [31.network.impl.CommandInterfaceImpl] - -> AF_DATA_REQUEST (Packet: subsystem=null, length=16, apiId=24 01, data=FE 10 24 01 CA 1D 01 01 08 00 80 30 1F 06 01 80 04 51 0A 00 9D, checksum=9D, error=false)
11:35:29.234 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <- AF_DATA_SRSP (FE 01 64 01 00 64)
11:35:29.262 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 03 45 C4 CA 1D 00 55)
11:35:29.270 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=3, apiId=45 C4, data=FE 03 45 C4 CA 1D 00 55, checksum=55, error=false
11:35:29.279 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45c4
11:35:29.291 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 03 45 C4 CA 1D 00 55)
11:35:29.304 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=3, apiId=45 C4, data=FE 03 45 C4 CA 1D 00 55, checksum=55, error=false
11:35:29.311 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45c4
11:35:29.318 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- AF_DATA_CONFIRM (FE 03 44 80 00 01 80 46)
11:35:29.325 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: AF_DATA_CONFIRM(Endpoint=1, Status=SUCCESS(0), TransID=128)
11:35:29.336 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- AF_INCOMING_MSG (FE 19 44 81 00 00 08 00 CA 1D 01 01 00 22 00 7D 22 21 00 00 05 08 80 0B 04 00 CA 1D 1D 17)
11:35:29.344 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=25, apiId=44 81, data=FE 19 44 81 00 00 08 00 CA 1D 01 01 00 22 00 7D 22 21 00 00 05 08 80 0B 04 00 CA 1D 1D 17, checksum=17, error=false
11:35:29.352 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: DefaultResponse [Level Control: 7626/1 -> 0/1, cluster=0008, TID=80, commandIdentifier=4, statusCode=0]
11:35:34.645 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'LIGHT1_color' received command 309,36,32
11:35:34.650 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: MoveToHueAndSaturationCommand [Color control: 0/0 -> 7626/1, cluster=0300, TID=81, hue=218, saturation=91, transitionTime=10]
11:35:34.677 [INFO ] [marthome.event.ItemStateChangedEvent] - LIGHT1_color changed from 119,36,32 to 309,36,32
11:35:34.679 [DEBUG] [31.network.impl.CommandInterfaceImpl] - -> AF_DATA_REQUEST (Packet: subsystem=null, length=17, apiId=24 01, data=FE 11 24 01 CA 1D 01 01 00 03 81 30 1F 07 01 81 06 DA 5B 0A 00 44, checksum=44, error=false)
11:35:34.714 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <- AF_DATA_SRSP (FE 01 64 01 00 64)
11:35:34.734 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 03 45 C4 CA 1D 00 55)
11:35:34.756 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=3, apiId=45 C4, data=FE 03 45 C4 CA 1D 00 55, checksum=55, error=false
11:35:34.760 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45c4
11:35:34.784 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 03 45 C4 CA 1D 00 55)
11:35:34.797 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=3, apiId=45 C4, data=FE 03 45 C4 CA 1D 00 55, checksum=55, error=false
11:35:34.803 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45c4
11:35:34.809 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- AF_DATA_CONFIRM (FE 03 44 80 00 01 81 47)
11:35:34.813 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: AF_DATA_CONFIRM(Endpoint=1, Status=SUCCESS(0), TransID=129)
11:35:34.827 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- AF_INCOMING_MSG (FE 19 44 81 00 00 00 03 CA 1D 01 01 00 1F 00 4A 65 21 00 00 05 08 81 0B 06 81 CA 1D 1D D3)
11:35:34.834 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=25, apiId=44 81, data=FE 19 44 81 00 00 00 03 CA 1D 01 01 00 1F 00 4A 65 21 00 00 05 08 81 0B 06 81 CA 1D 1D D3, checksum=D3, error=false
11:35:34.839 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: DefaultResponse [Color control: 7626/1 -> 0/1, cluster=0300, TID=81, commandIdentifier=6, statusCode=129]
11:35:34.857 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: MoveToSaturationCommand [Color control: 0/0 -> 7626/1, cluster=0300, TID=82, saturation=91, transitionTime=10]
11:35:34.869 [DEBUG] [31.network.impl.CommandInterfaceImpl] - -> AF_DATA_REQUEST (Packet: subsystem=null, length=16, apiId=24 01, data=FE 10 24 01 CA 1D 01 01 00 03 82 30 1F 06 01 82 03 5B 0A 00 9B, checksum=9B, error=false)
11:35:34.912 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <- AF_DATA_SRSP (FE 01 64 01 00 64)
11:35:34.950 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 03 45 C4 CA 1D 00 55)
11:35:34.954 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=3, apiId=45 C4, data=FE 03 45 C4 CA 1D 00 55, checksum=55, error=false
11:35:34.958 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45c4
11:35:34.964 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 03 45 C4 CA 1D 00 55)
11:35:34.969 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=3, apiId=45 C4, data=FE 03 45 C4 CA 1D 00 55, checksum=55, error=false
11:35:34.973 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45c4
11:35:34.994 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- AF_DATA_CONFIRM (FE 03 44 80 00 01 82 44)
11:35:34.999 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: AF_DATA_CONFIRM(Endpoint=1, Status=SUCCESS(0), TransID=130)
11:35:35.008 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- AF_INCOMING_MSG (FE 19 44 81 00 00 00 03 CA 1D 01 01 00 22 00 C6 67 21 00 00 05 08 82 0B 03 81 CA 1D 1D 66)
11:35:35.013 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=25, apiId=44 81, data=FE 19 44 81 00 00 00 03 CA 1D 01 01 00 22 00 C6 67 21 00 00 05 08 82 0B 03 81 CA 1D 1D 66, checksum=66, error=false
11:35:35.018 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: DefaultResponse [Color control: 7626/1 -> 0/1, cluster=0300, TID=82, commandIdentifier=3, statusCode=129]
11:35:35.037 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: MoveToLevelWithOnOffCommand [Level Control: 0/0 -> 7626/1, cluster=0008, TID=83, level=81, transitionTime=10]
11:35:35.056 [DEBUG] [31.network.impl.CommandInterfaceImpl] - -> AF_DATA_REQUEST (Packet: subsystem=null, length=16, apiId=24 01, data=FE 10 24 01 CA 1D 01 01 08 00 83 30 1F 06 01 83 04 51 0A 00 9D, checksum=9D, error=false)
11:35:35.100 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <- AF_DATA_SRSP (FE 01 64 01 00 64)
11:35:35.121 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 03 45 C4 CA 1D 00 55)
11:35:35.125 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=3, apiId=45 C4, data=FE 03 45 C4 CA 1D 00 55, checksum=55, error=false
11:35:35.129 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45c4
11:35:35.134 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- ZToolPacket (FE 03 45 C4 CA 1D 00 55)
11:35:35.139 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=3, apiId=45 C4, data=FE 03 45 C4 CA 1D 00 55, checksum=55, error=false
11:35:35.143 [DEBUG] [e.dongle.cc2531.ZigBeeDongleTiCc2531] - Unhandled ZToolPacket type 0x45c4
11:35:35.186 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- AF_DATA_CONFIRM (FE 03 44 80 00 01 83 45)
11:35:35.194 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: AF_DATA_CONFIRM(Endpoint=1, Status=SUCCESS(0), TransID=131)
11:35:35.204 [DEBUG] [31.network.impl.CommandInterfaceImpl] - <-- AF_INCOMING_MSG (FE 19 44 81 00 00 08 00 CA 1D 01 01 00 1F 00 09 6A 21 00 00 05 08 83 0B 04 00 CA 1D 1D 15)
11:35:35.208 [DEBUG] [31.network.impl.CommandInterfaceImpl] - Received Async Cmd: Packet: subsystem=null, length=25, apiId=44 81, data=FE 19 44 81 00 00 08 00 CA 1D 01 01 00 1F 00 09 6A 21 00 00 05 08 83 0B 04 00 CA 1D 1D 15, checksum=15, error=false
11:35:35.213 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: DefaultResponse [Level Control: 7626/1 -> 0/1, cluster=0008, TID=83, commandIdentifier=4, statusCode=0]