Error “-100 No answer from device”


#1

Like some others I started receiving the error “-100 No answer from device” after updating Homegear from an unfortunately unknown version to 0.7.30-1900 with Openhab 2.3 on a Raspberry Pi 3.

Here is my setup consisting of 4 MAX! thermostats:

ID │ Name │ Address │ Serial Number │ Type │ Type String │ Firmware │ Unreach
─────────┼───────────────────────────┼─────────┼───────────────┼──────┼───────────────────────────┼──────────┼────────
│ │ │ │ │ │ │
1 │ Office │ 15CD5F │ NEQ0651877 │ 01A0 │ BC-RT-TRX-CyG-3 │ 1.0 │ No
2 │ LivingRoom │ 16348A │ NEQ0666650 │ 01A0 │ BC-RT-TRX-CyG-3 │ 1.0 │ No
3 │ Bedroom │ 163468 │ NEQ0666621 │ 01A0 │ BC-RT-TRX-CyG-3 │ 1.0 │ No
4 │ Kitchen │ 1634BA │ NEQ0666673 │ 01A0 │ BC-RT-TRX-CyG-3 │ 1.0 │ No
─────────┴───────────────────────────┴─────────┴───────────────┴──────┴───────────────────────────┴──────────┴────────

Here is the log from Openhab:

12:21:28.775 [INFO ] [smarthome.event.ItemCommandEvent     ] - Item 'Max_Office_Manu_Mode' received command 18
12:21:28.824 [INFO ] [smarthome.event.ItemStateChangedEvent] - Max_Office_Manu_Mode changed from NULL to 18
12:21:48.951 [ERROR] [mematic.handler.HomematicThingHandler] - -100 No answer from device. (sending setValue()
NEQ0651877:1
MANU_MODE
18.0
)
java.io.IOException: -100 No answer from device. (sending setValue()
NEQ0651877:1
MANU_MODE
18.0
)
        at org.openhab.binding.homematic.internal.communicator.parser.RpcResponseParser.parse(RpcResponseParser.java:47) [223:org.openhab.binding.homematic:2.3.0]
        at org.openhab.binding.homematic.internal.communicator.client.BinRpcClient.sendMessage(BinRpcClient.java:78) [223:org.openhab.binding.homematic:2.3.0]
        at org.openhab.binding.homematic.internal.communicator.client.BinRpcClient.sendMessage(BinRpcClient.java:90) [223:org.openhab.binding.homematic:2.3.0]
        at org.openhab.binding.homematic.internal.communicator.client.BinRpcClient.sendMessage(BinRpcClient.java:66) [223:org.openhab.binding.homematic:2.3.0]
        at org.openhab.binding.homematic.internal.communicator.client.RpcClient.setDatapointValue(RpcClient.java:298) [223:org.openhab.binding.homematic:2.3.0]
        at org.openhab.binding.homematic.internal.communicator.AbstractHomematicGateway$1.execute(AbstractHomematicGateway.java:672) [223:org.openhab.binding.homematic:2.3.0]
        at org.openhab.binding.homematic.internal.misc.DelayedExecuter.start(DelayedExecuter.java:61) [223:org.openhab.binding.homematic:2.3.0]
        at org.openhab.binding.homematic.internal.communicator.AbstractHomematicGateway.sendDatapoint(AbstractHomematicGateway.java:651) [223:org.openhab.binding.homematic:2.3.0]
        at org.openhab.binding.homematic.internal.communicator.AbstractHomematicGateway.sendDatapoint(AbstractHomematicGateway.java:630) [223:org.openhab.binding.homematic:2.3.0]
        at org.openhab.binding.homematic.handler.HomematicThingHandler.handleCommand(HomematicThingHandler.java:276) [223:org.openhab.binding.homematic:2.3.0]
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:?]
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:?]
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:?]
        at java.lang.reflect.Method.invoke(Method.java:498) ~[?:?]
        at org.eclipse.smarthome.core.internal.common.AbstractInvocationHandler.invokeDirect(AbstractInvocationHandler.java:153) [101:org.eclipse.smarthome.core:0.10.0.oh230]
        at org.eclipse.smarthome.core.internal.common.InvocationHandlerSync.invoke(InvocationHandlerSync.java:59) [101:org.eclipse.smarthome.core:0.10.0.oh230]
        at com.sun.proxy.$Proxy158.handleCommand(Unknown Source) [223:org.openhab.binding.homematic:2.3.0]
        at org.eclipse.smarthome.core.thing.internal.profiles.ProfileCallbackImpl.handleCommand(ProfileCallbackImpl.java:75) [108:org.eclipse.smarthome.core.thing:0.10.0.oh230]
        at org.eclipse.smarthome.core.thing.internal.profiles.SystemDefaultProfile.onCommandFromItem(SystemDefaultProfile.java:49) [108:org.eclipse.smarthome.core.thing:0.10.0.oh230]
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:?]
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:?]
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:?]
        at java.lang.reflect.Method.invoke(Method.java:498) ~[?:?]
        at org.eclipse.smarthome.core.internal.common.AbstractInvocationHandler.invokeDirect(AbstractInvocationHandler.java:153) [101:org.eclipse.smarthome.core:0.10.0.oh230]
        at org.eclipse.smarthome.core.internal.common.Invocation.call(Invocation.java:53) [101:org.eclipse.smarthome.core:0.10.0.oh230]
        at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:?]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:?]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:?]
        at java.lang.Thread.run(Thread.java:748) [?:?]

And here is the Homegear log:

10/03/18 12:21:28.784 RPC Server (Port 2001): Debug: Packet received: 42696E00000000410000000873657456616C756500000003000000030000000C4E4551303635313837373A3100000003000000094D414E555F4D4F4445000000042400000000000005
10/03/18 12:21:28.784 RPC Server (Port 2001): Info: Client number 8 is calling RPC method: setValue (2) Parameters:
(String) NEQ0651877:1
(String) MANU_MODE
(Float) 18
10/03/18 12:21:28.785 Module MAX: Debug: MANU_MODE of peer 1 with serial number NEQ0651877:1 was set to 24.
10/03/18 12:21:28.785 Module MAX: Creating SAVEPOINT PacketQueue1428831_0
10/03/18 12:21:28.926 UPnP Server: Debug: Discovery packet received from 239.255.255.250:1900
10/03/18 12:21:28.947 Debug: Sleeping 429ms before sending response.
10/03/18 12:21:29.376 UPnP Server: Debug: Sending discovery response packets to 239.255.255.250 on port 1900
10/03/18 12:21:29.476 UPnP Server: Debug: Sending notify packets.
10/03/18 12:21:29.477 UPnP Server: Debug: Discovery packet received from 239.255.255.250:1900
10/03/18 12:21:29.497 Debug: Sleeping 3422ms before sending response.
10/03/18 12:21:31.879 Module MAX: Sending from resend thread 0 of queue 0.
10/03/18 12:21:32.919 UPnP Server: Debug: Sending discovery response packets to 239.255.255.250 on port 1900
10/03/18 12:21:33.020 UPnP Server: Debug: Sending notify packets.
10/03/18 12:21:34.880 Module MAX: Sending from resend thread 1 of queue 0.
10/03/18 12:21:38.852 RPC Server (Port 2001): Response:
(Struct length=2)
{
[faultCode]
{
(Integer) -100
}
[faultString]
{
(String) No answer from device.
}
}
10/03/18 12:21:38.852 RPC Server (Port 2001): Response binary:
42696EFF0000004A0000010100000002000000096661756C74436F646500000001FFFFFF9C0000000B6661756C74537472696E6700000003000000164E6F20616E737765722066726F6D206465766963652E
10/03/18 12:21:38.859 RPC Server (Port 2001): Debug: Connection to client number 8 closed (3).
10/03/18 12:21:38.860 RPC Server (Port 2001): Info: Connection from ::ffff:127.0.0.1:45180 accepted. Client number: 11
10/03/18 12:21:38.860 RPC Server (Port 2001): Info: RPC server client id for client number 11 is: 3
10/03/18 12:21:38.861 RPC Server (Port 2001): Listening for incoming packets from client number 11.
10/03/18 12:21:38.861 RPC Server (Port 2001): Debug: Packet received: 42696E00000000410000000873657456616C756500000003000000030000000C4E4551303635313837373A3100000003000000094D414E555F4D4F4445000000042400000000000005
10/03/18 12:21:38.861 RPC Server (Port 2001): Info: Client number 11 is calling RPC method: setValue (2) Parameters:
(String) NEQ0651877:1
(String) MANU_MODE
(Float) 18
10/03/18 12:21:38.861 Module MAX: Debug: MANU_MODE of peer 1 with serial number NEQ0651877:1 was set to 24.
10/03/18 12:21:38.927 UPnP Server: Debug: Discovery packet received from 239.255.255.250:1900
10/03/18 12:21:38.947 Debug: Sleeping 503ms before sending response.
10/03/18 12:21:39.450 UPnP Server: Debug: Sending discovery response packets to 239.255.255.250 on port 1900
10/03/18 12:21:39.551 UPnP Server: Debug: Sending notify packets.
10/03/18 12:21:39.552 UPnP Server: Debug: Discovery packet received from 239.255.255.250:1900
10/03/18 12:21:39.572 Debug: Sleeping 196ms before sending response.
10/03/18 12:21:39.768 UPnP Server: Debug: Sending discovery response packets to 239.255.255.250 on port 1900
10/03/18 12:21:39.869 UPnP Server: Debug: Sending notify packets.
10/03/18 12:21:40.909 Module MAX: Debug: Postponing deletion of queue 0 for peer with address 0x15CD5F, because it is still in use (2 referring objects).

Here is the complete log: homegear.log (156.7 KB)

And by the way I also switched to Raspbian Stretch.

Unfortunately, I can’t help myself any further, can anyone help me?


"100 No answer from device" - Befehle werden verzögert umgesetzt
#2

Anyone any ideas?


#3

Hello @bluebird11,

there is an error in your max.conf the head above the communication module definition is missing or commented (the line starting with [). Please post the configuration file and I can correct the error for you.

Cheers,

Sathya


#4

Thank you, sathya, you’re a lifesaver! That cost me several hours :slight_smile:


#5