[Solved] Homematic communicator: Read timed out with CCU1

Hi
running openHAB version 1.8.0 on Raspberry Pi 2 Model B (raspbian jessie)
Trying binding to HomeMatic CCU1 (Firmware 1.519)

Homematic binding is running into a read time out. After that even the Homematic CCU1 is frozen with no response from homematic web UI.

attached the openhab log file with homemativ binding in TRACE mode:

2016-01-17 11:18:29.027 [INFO ] [.o.core.internal.CoreActivator] - openHAB runtime has been started (v1.8.0).
2016-01-17 11:18:33.821 [INFO ] [o.o.i.s.i.DiscoveryServiceImpl] - mDNS service has been started
2016-01-17 11:18:34.014 [INFO ] [o.o.i.s.i.DiscoveryServiceImpl] - Service Discovery initialization completed.
2016-01-17 11:18:42.335 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'default.sitemap’
2016-01-17 11:18:43.082 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'kili.sitemap’
2016-01-17 11:18:43.382 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'logging.persist’
2016-01-17 11:18:43.509 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'db4o.persist’
2016-01-17 11:18:43.537 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'mysql.persist’
2016-01-17 11:18:43.561 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'exec.persist’
2016-01-17 11:18:43.576 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'rrd4j.persist’
2016-01-17 11:18:43.602 [INFO ] [penhab.io.rest.RESTApplication] - Started REST API at /rest
2016-01-17 11:18:44.185 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'default.items’
2016-01-17 11:18:44.284 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'kili.items’
2016-01-17 11:18:49.591 [INFO ] [.o.u.w.i.servlet.WebAppServlet] - Started Classic UI at /classicui/openhab.app
2016-01-17 11:18:55.272 [DEBUG] [o.b.h.i.bus.HomematicActivator] - Homematic binding has been started.
2016-01-17 11:18:55.428 [DEBUG] [omematicGenericBindingProvider] - Adding item Temp_OUT with DatapointConfig[address=JEQ0149196,channel=1,parameter=TEMPERATURE]
2016-01-17 11:18:55.432 [DEBUG] [omematicGenericBindingProvider] - Adding item Temp_WZ with DatapointConfig[address=HEQ0509056,channel=1,parameter=TEMPERATURE]
2016-01-17 11:18:55.435 [DEBUG] [omematicGenericBindingProvider] - Adding item Temp_SZ with DatapointConfig[address=IEQ0151523,channel=1,parameter=TEMPERATURE]
2016-01-17 11:18:55.438 [DEBUG] [omematicGenericBindingProvider] - Adding item Temp_ZO with DatapointConfig[address=IEQ0150704,channel=1,parameter=TEMPERATURE]
2016-01-17 11:18:55.441 [DEBUG] [omematicGenericBindingProvider] - Adding item Temp_ZU with DatapointConfig[address=IEQ0151203,channel=1,parameter=TEMPERATURE]
2016-01-17 11:18:55.444 [DEBUG] [omematicGenericBindingProvider] - Adding item Temp_BAD with DatapointConfig[address=IEQ0151370,channel=1,parameter=TEMPERATURE]
2016-01-17 11:18:55.447 [DEBUG] [omematicGenericBindingProvider] - Adding item Hum_OUT with DatapointConfig[address=JEQ0149196,channel=1,parameter=HUMIDITY]
2016-01-17 11:18:55.450 [DEBUG] [omematicGenericBindingProvider] - Adding item Hum_WZ with DatapointConfig[address=HEQ0509056,channel=1,parameter=HUMIDITY]
2016-01-17 11:18:55.453 [DEBUG] [omematicGenericBindingProvider] - Adding item Hum_SZ with DatapointConfig[address=IEQ0151523,channel=1,parameter=HUMIDITY]
2016-01-17 11:18:55.457 [DEBUG] [omematicGenericBindingProvider] - Adding item Hum_ZO with DatapointConfig[address=IEQ0150704,channel=1,parameter=HUMIDITY]
2016-01-17 11:18:55.460 [DEBUG] [omematicGenericBindingProvider] - Adding item Hum_ZU with DatapointConfig[address=IEQ0151203,channel=1,parameter=HUMIDITY]
2016-01-17 11:18:55.463 [DEBUG] [omematicGenericBindingProvider] - Adding item Hum_BAD with DatapointConfig[address=IEQ0151370,channel=1,parameter=HUMIDITY]
2016-01-17 11:18:55.466 [DEBUG] [omematicGenericBindingProvider] - Adding item WZ_Licht1 with DatapointConfig[address=IEQ0006232,channel=1,parameter=STATE]
2016-01-17 11:18:55.469 [DEBUG] [omematicGenericBindingProvider] - Adding item WZ_Licht2 with DatapointConfig[address=IEQ0007194,channel=1,parameter=STATE]
2016-01-17 11:18:55.472 [DEBUG] [omematicGenericBindingProvider] - Adding item WZ_TV with DatapointConfig[address=IEQ0074628,channel=1,parameter=STATE]
2016-01-17 11:18:55.475 [DEBUG] [omematicGenericBindingProvider] - Adding item WZ_TVALL with DatapointConfig[address=IEQ0378017,channel=1,parameter=STATE]
2016-01-17 11:18:55.478 [DEBUG] [omematicGenericBindingProvider] - Adding item WZ_ROUTER with DatapointConfig[address=IEQ0074589,channel=1,parameter=STATE]
2016-01-17 11:18:55.481 [DEBUG] [omematicGenericBindingProvider] - Adding item ZO_TV with DatapointConfig[address=IEQ0378018,channel=1,parameter=STATE]
2016-01-17 11:18:55.484 [DEBUG] [omematicGenericBindingProvider] - Adding item BU_DRUCK with DatapointConfig[address=IEQ0521979,channel=1,parameter=STATE]
2016-01-17 11:18:55.487 [DEBUG] [omematicGenericBindingProvider] - Adding item PC_UG with DatapointConfig[address=IEQ0522021,channel=1,parameter=STATE]
2016-01-17 11:18:55.490 [DEBUG] [omematicGenericBindingProvider] - Adding item Heizung_ZU with DatapointConfig[address=IEQ0151203,channel=2,parameter=SETPOINT]
2016-01-17 11:18:55.493 [DEBUG] [omematicGenericBindingProvider] - Adding item Heizung_WZ with DatapointConfig[address=HEQ0509056,channel=2,parameter=SETPOINT]
2016-01-17 11:18:55.496 [DEBUG] [omematicGenericBindingProvider] - Adding item Heizung_ZO with DatapointConfig[address=IEQ0150704,channel=2,parameter=SETPOINT]
2016-01-17 11:18:55.499 [DEBUG] [omematicGenericBindingProvider] - Adding item Heizung_BAD with DatapointConfig[address=IEQ0151370,channel=2,parameter=SETPOINT]
2016-01-17 11:18:55.502 [DEBUG] [omematicGenericBindingProvider] - Adding item Heizung_SZ with DatapointConfig[address=IEQ0151523,channel=2,parameter=SETPOINT]
2016-01-17 11:18:55.505 [DEBUG] [omematicGenericBindingProvider] - Adding item BUR_Fen with DatapointConfig[address=IEQ0032375,channel=1,parameter=STATE]
2016-01-17 11:18:55.508 [DEBUG] [omematicGenericBindingProvider] - Adding item ZU_Fen with DatapointConfig[address=HEQ0364148,channel=1,parameter=STATE]
2016-01-17 11:18:55.511 [DEBUG] [omematicGenericBindingProvider] - Adding item ZU1_Tuer with DatapointConfig[address=HEQ0363827,channel=1,parameter=STATE]
2016-01-17 11:18:55.513 [DEBUG] [omematicGenericBindingProvider] - Adding item ZU2_Tuer with DatapointConfig[address=IEQ0029091,channel=1,parameter=STATE]
2016-01-17 11:18:55.515 [DEBUG] [omematicGenericBindingProvider] - Adding item WZ_Tuer with DatapointConfig[address=IEQ0029545,channel=1,parameter=STATE]
2016-01-17 11:18:55.518 [DEBUG] [omematicGenericBindingProvider] - Adding item GWC_Fen with DatapointConfig[address=HEQ0363480,channel=1,parameter=STATE]
2016-01-17 11:18:55.521 [DEBUG] [omematicGenericBindingProvider] - Adding item Haus_Tuer with DatapointConfig[address=HEQ0364025,channel=1,parameter=STATE]
2016-01-17 11:18:55.523 [DEBUG] [omematicGenericBindingProvider] - Adding item KUC_Fen with DatapointConfig[address=HEQ0363098,channel=1,parameter=STATE]
2016-01-17 11:18:55.527 [DEBUG] [omematicGenericBindingProvider] - Adding item BAD_Tuer with DatapointConfig[address=HEQ0363250,channel=1,parameter=STATE]
2016-01-17 11:18:55.529 [DEBUG] [omematicGenericBindingProvider] - Adding item BAD_Fen with DatapointConfig[address=HEQ0363022,channel=1,parameter=STATE]
2016-01-17 11:18:55.532 [DEBUG] [omematicGenericBindingProvider] - Adding item SZ_Fen with DatapointConfig[address=HEQ0363467,channel=1,parameter=STATE]
2016-01-17 11:18:55.535 [DEBUG] [omematicGenericBindingProvider] - Adding item ZO1_Fen with DatapointConfig[address=IEQ0032538,channel=1,parameter=STATE]
2016-01-17 11:18:55.538 [DEBUG] [omematicGenericBindingProvider] - Adding item ZO2_Fen with DatapointConfig[address=HEQ0362998,channel=1,parameter=STATE]
2016-01-17 11:18:55.540 [DEBUG] [omematicGenericBindingProvider] - Adding item AL_Wasser with DatapointConfig[address=HEQ0031687,channel=1,parameter=STATE]
2016-01-17 11:18:55.543 [DEBUG] [omematicGenericBindingProvider] - Adding item AL_Rauch1 with DatapointConfig[address=IEQ0011996,channel=1,parameter=STATE]
2016-01-17 11:18:55.545 [DEBUG] [omematicGenericBindingProvider] - Adding item AL_Rauch2 with DatapointConfig[address=IEQ0011492,channel=1,parameter=STATE]
2016-01-17 11:18:55.548 [DEBUG] [omematicGenericBindingProvider] - Adding item AL_Rauch3 with DatapointConfig[address=IEQ0011388,channel=1,parameter=STATE]
2016-01-17 11:18:55.550 [DEBUG] [omematicGenericBindingProvider] - Adding item AL_Rauch with DatapointConfig[address=IEQ0011492,channel=1,parameter=STATE]
2016-01-17 11:18:55.553 [DEBUG] [omematicGenericBindingProvider] - Adding item WZ_Licht_aus with DatapointConfig[address=HEQ0403380,channel=1,parameter=PRESS_SHORT]
2016-01-17 11:18:55.556 [DEBUG] [omematicGenericBindingProvider] - Adding item WZ_Licht_an with DatapointConfig[address=HEQ0403380,channel=2,parameter=PRESS_SHORT]
2016-01-17 11:18:55.559 [DEBUG] [omematicGenericBindingProvider] - Adding item WZ_AutoL_aus with DatapointConfig[address=HEQ0403380,channel=1,parameter=PRESS_LONG]
2016-01-17 11:18:55.562 [DEBUG] [omematicGenericBindingProvider] - Adding item WZ_AutoL_an with DatapointConfig[address=HEQ0403380,channel=2,parameter=PRESS_LONG]
2016-01-17 11:18:55.565 [DEBUG] [omematicGenericBindingProvider] - Adding item WZ_TV_aus with DatapointConfig[address=HEQ0403380,channel=3,parameter=PRESS_SHORT]
2016-01-17 11:18:55.568 [DEBUG] [omematicGenericBindingProvider] - Adding item WZ_TV_an with DatapointConfig[address=HEQ0403380,channel=4,parameter=PRESS_SHORT]
2016-01-17 11:18:55.571 [DEBUG] [omematicGenericBindingProvider] - Adding item WZ_TV_All with DatapointConfig[address=HEQ0403380,channel=3,parameter=PRESS_LONG]
2016-01-17 11:18:55.574 [DEBUG] [omematicGenericBindingProvider] - Adding item WZ_PC_aus with DatapointConfig[address=HEQ0403380,channel=5,parameter=PRESS_SHORT]
2016-01-17 11:18:55.577 [DEBUG] [omematicGenericBindingProvider] - Adding item WZ_PC_an with DatapointConfig[address=HEQ0403380,channel=6,parameter=PRESS_SHORT]
2016-01-17 11:18:55.579 [DEBUG] [omematicGenericBindingProvider] - Adding item WZ_Party_aus with DatapointConfig[address=HEQ0403380,channel=9,parameter=PRESS_SHORT]
2016-01-17 11:18:55.582 [DEBUG] [omematicGenericBindingProvider] - Adding item WZ_Party_an with DatapointConfig[address=HEQ0403380,channel=1,parameter=PRESS_SHORT]
2016-01-17 11:18:55.585 [DEBUG] [omematicGenericBindingProvider] - Adding item Abwesend with DatapointConfig[address=HEQ0403380,channel=9,parameter=PRESS_LONG]
2016-01-17 11:18:55.592 [DEBUG] [omematicGenericBindingProvider] - Adding item Anwesend with DatapointConfig[address=HEQ0403380,channel=10,parameter=PRESS_LONG]
2016-01-17 11:18:55.598 [DEBUG] [omematicGenericBindingProvider] - Adding item Reload_Variables with DatapointConfig[address=BidCoS-RF,channel=40,parameter=PRESS_SHORT,action=RELOAD_VARIABLES]
2016-01-17 11:18:55.602 [DEBUG] [omematicGenericBindingProvider] - Adding item VAR_Fenster_offen with VariableConfig[name=VAR: Fenster offen]
2016-01-17 11:18:55.604 [DEBUG] [omematicGenericBindingProvider] - Adding item VAR_Fenster_Schlafzimmer with VariableConfig[name=VAR: Fenster Schlafzimmer]
2016-01-17 11:18:55.606 [DEBUG] [omematicGenericBindingProvider] - Adding item VAR_Fenster_Wohnzimmer with VariableConfig[name=VAR: Fenster Wohnzimmer]
2016-01-17 11:18:55.608 [DEBUG] [omematicGenericBindingProvider] - Adding item VAR_Fenster_Zimmer_oben with VariableConfig[name=VAR: Fenster Zimmer oben]
2016-01-17 11:18:55.611 [DEBUG] [omematicGenericBindingProvider] - Adding item VAR_Fenster_Zimmer_unten with VariableConfig[name=VAR: Fenster Zimmer unten]
2016-01-17 11:18:55.614 [DEBUG] [omematicGenericBindingProvider] - Adding item VAR_Fenster_Bad with VariableConfig[name=VAR: Fenster Bad]
2016-01-17 11:18:55.616 [DEBUG] [omematicGenericBindingProvider] - Adding item VAR_Tageszeit with VariableConfig[name=VAR: Tageszeit]
2016-01-17 11:18:55.618 [DEBUG] [omematicGenericBindingProvider] - Adding item VAR_Feiertag with VariableConfig[name=VAR: Feiertag]
2016-01-17 11:18:55.620 [DEBUG] [omematicGenericBindingProvider] - Adding item VAR_Heizung with VariableConfig[name=VAR: Heizung]
2016-01-17 11:18:55.622 [DEBUG] [omematicGenericBindingProvider] - Adding item VAR_Hzg_Idx with VariableConfig[name=VAR: Heizung]
2016-01-17 11:18:55.625 [DEBUG] [omematicGenericBindingProvider] - Adding item VAR_HzgTemp_WZ with VariableConfig[name=VAR: HzgTemp WZ]
2016-01-17 11:18:55.627 [DEBUG] [omematicGenericBindingProvider] - Adding item VAR_Licht_an with VariableConfig[name=VAR: Licht an]
2016-01-17 11:18:55.629 [DEBUG] [omematicGenericBindingProvider] - Adding item VAR_Auto_Licht with VariableConfig[name=VAR: Auto Licht]
2016-01-17 11:18:55.631 [DEBUG] [omematicGenericBindingProvider] - Adding item ALR_Batterie_schwach with VariableConfig[name=ALR: Batterie schwach]
2016-01-17 11:18:55.633 [DEBUG] [omematicGenericBindingProvider] - Adding item ALR_Einbruch with VariableConfig[name=ALR: Einbruch]
2016-01-17 11:18:55.635 [DEBUG] [omematicGenericBindingProvider] - Adding item ALR_Rauch_Alarm with VariableConfig[name=ALR: Rauch Alarm]
2016-01-17 11:18:55.637 [DEBUG] [omematicGenericBindingProvider] - Adding item ALR_Stromausfall with VariableConfig[name=ALR: Stromausfall]
2016-01-17 11:18:55.639 [DEBUG] [omematicGenericBindingProvider] - Adding item ALR_Wasser_Alarm with VariableConfig[name=ALR: Wasser Alarm]
2016-01-17 11:18:55.642 [DEBUG] [omematicGenericBindingProvider] - Adding item PRG_Anwesend with ProgramConfig[name=PRG: Anwesend]
2016-01-17 11:18:55.645 [DEBUG] [omematicGenericBindingProvider] - Adding item PRG_Abwesend with ProgramConfig[name=PRG: Abwesend]
2016-01-17 11:18:55.647 [DEBUG] [omematicGenericBindingProvider] - Adding item PRG_Alles_Strom_aus with ProgramConfig[name=PRG: Alles Strom aus]
2016-01-17 11:18:55.649 [DEBUG] [omematicGenericBindingProvider] - Adding item PRG_Auto_Licht_aus with ProgramConfig[name=PRG: Auto Licht aus]
2016-01-17 11:18:55.650 [DEBUG] [omematicGenericBindingProvider] - Adding item PRG_Auto_Licht_ein with ProgramConfig[name=PRG: Auto Licht ein]
2016-01-17 11:18:55.652 [DEBUG] [omematicGenericBindingProvider] - Adding item PRG_Batterie_Status with ProgramConfig[name=PRG: Batterie Status]
2016-01-17 11:18:55.654 [DEBUG] [omematicGenericBindingProvider] - Adding item PRG_Comming_Home with ProgramConfig[name=PRG: Comming Home]
2016-01-17 11:18:55.656 [DEBUG] [omematicGenericBindingProvider] - Adding item PRG_Licht_WZ_an with ProgramConfig[name=PRG: Licht WZ an]
2016-01-17 11:18:55.659 [DEBUG] [omematicGenericBindingProvider] - Adding item PRG_Licht_WZ_aus with ProgramConfig[name=PRG: Licht WZ aus]
2016-01-17 11:18:55.661 [DEBUG] [omematicGenericBindingProvider] - Adding item PRG_Party_off with ProgramConfig[name=PRG: Party off]
2016-01-17 11:18:55.664 [DEBUG] [omematicGenericBindingProvider] - Adding item PRG_Party_on with ProgramConfig[name=PRG: Party on]
2016-01-17 11:18:55.759 [INFO ] [o.o.b.h.i.bus.HomematicBinding] - HomematicConfig[host=192.168.0.160,timeout=15,callbackHost=192.168.0.40,callbackPort=9123,aliveInterval=300,reconnectInterval=disabled]
2016-01-17 11:18:55.761 [INFO ] [.b.h.i.c.HomematicCommunicator] - Starting Homematic communicator
2016-01-17 11:18:55.771 [DEBUG] [.h.i.communicator.ItemDisabler] - Starting ItemDisabler
2016-01-17 11:18:55.799 [TRACE] [.o.b.h.i.c.client.BinRpcClient] - Client BinRpcRequest BinRpcRequest[methodName=getDeviceDescription,args={BidCoS-RF}]
2016-01-17 11:18:55.836 [INFO ] [.service.AbstractActiveService] - HTTP Refresh Service has been started
2016-01-17 11:18:55.857 [TRACE] [.o.b.h.i.c.client.BinRpcClient] - Client BinRpcResponse: {
ADDRESS=BidCoS-RF
CHILDREN=
[
BidCoS-RF:0
BidCoS-RF:1
BidCoS-RF:2
BidCoS-RF:3
BidCoS-RF:4
BidCoS-RF:5
BidCoS-RF:6
BidCoS-RF:7
BidCoS-RF:8
BidCoS-RF:9
BidCoS-RF:10
BidCoS-RF:11
BidCoS-RF:12
BidCoS-RF:13
BidCoS-RF:14
BidCoS-RF:15
BidCoS-RF:16
BidCoS-RF:17
BidCoS-RF:18
BidCoS-RF:19
BidCoS-RF:20
BidCoS-RF:21
BidCoS-RF:22
BidCoS-RF:23
BidCoS-RF:24
BidCoS-RF:25
BidCoS-RF:26
BidCoS-RF:27
BidCoS-RF:28
BidCoS-RF:29
BidCoS-RF:30
BidCoS-RF:31
BidCoS-RF:32
BidCoS-RF:33
BidCoS-RF:34
BidCoS-RF:35
BidCoS-RF:36
BidCoS-RF:37
BidCoS-RF:38
BidCoS-RF:39
BidCoS-RF:40
BidCoS-RF:41
BidCoS-RF:42
BidCoS-RF:43
BidCoS-RF:44
BidCoS-RF:45
BidCoS-RF:46
BidCoS-RF:47
BidCoS-RF:48
BidCoS-RF:49
BidCoS-RF:50
]
FIRMWARE=1.519
FLAGS=9
INTERFACE=IEQ0005797
PARAMSETS=
[
MASTER
]
PARENT=
RF_ADDRESS=1366841
ROAMING=0
TYPE=HM-RCV-50
VERSION=6
}

2016-01-17 11:18:55.863 [INFO ] [.b.h.i.c.HomematicCommunicator] - Homematic ServerId[name=CCU,version=1.519,address=IEQ0005797]
2016-01-17 11:18:55.881 [INFO ] [o.o.b.h.i.c.client.CcuClient ] - Starting CcuClient
2016-01-17 11:18:55.883 [DEBUG] [.o.b.h.i.c.client.BinRpcClient] - Starting BinRpcClient
2016-01-17 11:18:55.985 [INFO ] [.p.rrd4j.internal.RRD4jService] - Removing invalid defintion component = null heartbeat = 0 min/max = 0.0/0.0 step = 0 0 archives(s) = [] 0 items(s) = []
2016-01-17 11:18:56.056 [INFO ] [b.h.i.communicator.StateHolder] - Loading Homematic datapoints
2016-01-17 11:18:56.076 [TRACE] [o.o.b.h.i.c.client.CcuClient ] - TclRegaScript: string dev_id;
string channel_id;
string dp_id;
string extraDatapoints = “BOOT\tWORKING\tDIRECTION\tINSTALL_TEST\tPRESS_LONG_RELEASE\t”;
extraDatapoints = extraDatapoints # “PRESS_CONT\tHUMIDITYF\tLAST_TICKS\tUNITSPTURN\t”;
string extraDatapointName;

Write(’<?xml version="1.0" encoding="ISO-8859-1" standalone="yes"?>\n’);
Write("\n");
foreach (dev_id, root.Devices().EnumUsedIDs()) {
object dev_obj = dom.GetObject(dev_id);
string dev_interface= dev_obj.Interface();
string interface_name = dom.GetObject(dev_interface).Name();
boolean is_ready = dev_obj.ReadyConfig();
boolean isChannelFourPartyDevice = (dev_obj.HssType() == “HM-CC-RT-DN”) || (dev_obj.HssType() == “HM-CC-RT-DN-BoM”);
boolean isChannelTwoPartyDevice = (dev_obj.HssType() == “HM-TC-IT-WM-W-EU”);
boolean isSmokeDevice = (dev_obj.HssType() == “HM-Sec-SD”);

if(is_ready &&
(dev_obj.HssType() != “HMW-RCV-50”)) {

Write("  <device");
Write(" address='"); WriteXML(dev_obj.Address());
Write("' interface='"); WriteXML(interface_name);
Write("' type='"); WriteXML(dev_obj.HssType());
Write("'>\n");
foreach(channel_id, dev_obj.Channels()) {
  object channel_obj = dom.GetObject(channel_id);
  string channel_number = channel_obj.Address().StrValueByIndex(":",1).ToString();
  boolean isChannelFour = channel_number == "4";
  boolean isChannelTwo = channel_number == "2";
  boolean isChannelOne = channel_number == "1";

  Write("    <channel");
  Write(" number='"); WriteXML(channel_number);
  Write("'>\n");
  
  foreach (extraDatapointName, extraDatapoints) {
    object edp = channel_obj.DPByHssDP(extraDatapointName);
    if (edp) {
      Write("      <datapoint");
      Write(" name='" # extraDatapointName);
      Write("' value='"); 
      if (edp.ValueType() == 2) {
        Write("false");
      }
      else {
        WriteXML(edp.Value());
      }
      Write("' valueType='" # edp.ValueType());
      if (edp.ValueType() == 16) {
        Write("' subType='"); WriteXML(edp.ValueSubType());
        Write("' valueList='" # edp.ValueList());
      }
      if ((edp.ValueType() != 2) && (edp.ValueType() != 20)) {
        Write("' min='" # edp.ValueMin());
        Write("' max='" # edp.ValueMax());
      }
      Write("' writeable='false'");
      Write(" />\n");
    }
  }
  
  foreach(dp_id, channel_obj.DPs().EnumUsedIDs()) {
    object dp_obj = dom.GetObject(dp_id);
    if(dp_obj) {
      string name = dp_obj.Name().StrValueByIndex(".",2);
      if (name != "") {
        Write("      <datapoint");
        Write(" name='"); WriteXML(name);
        Write("' value='"); WriteXML(dp_obj.Value());
        Write("' valueType='" # dp_obj.ValueType());
        if (dp_obj.ValueType() == 16) {
          Write("' subType='"); WriteXML(dp_obj.ValueSubType());
          Write("' valueList='" # dp_obj.ValueList());
        }
        if ((dp_obj.ValueType() != 2) && (dp_obj.ValueType() != 20)) {
          Write("' min='" # dp_obj.ValueMin());
          Write("' max='" # dp_obj.ValueMax());
        }
        Write("' writeable='");
        integer dp_operations = dp_obj.Operations();
        boolean writeable = dp_operations & OPERATION_WRITE;
        if (writeable) {
          Write("true");
        }
        else {
          Write("false");
        }
        Write("' />\n");
      }
    }
  }
  
  if ((isChannelFour && isChannelFourPartyDevice) || (isChannelTwo && isChannelTwoPartyDevice)) {
    Write("      <datapoint name='PARTY_TEMPERATURE' value='5.0' valueType='4' min='5.0' max='30.0' writeable='true' />\n");
    Write("      <datapoint name='PARTY_START_TIME' value='0' valueType='8' min='0' max='1410' writeable='true' />\n");
    Write("      <datapoint name='PARTY_START_DAY' value='1' valueType='8' min='1' max='31' writeable='true' />\n");
    Write("      <datapoint name='PARTY_START_MONTH' value='1' valueType='8' min='1' max='12' writeable='true' />\n");
    Write("      <datapoint name='PARTY_START_YEAR' value='12' valueType='8' min='0' max='99' writeable='true' />\n");
    Write("      <datapoint name='PARTY_STOP_TIME' value='0' valueType='8' min='0' max='1410' writeable='true' />\n");
    Write("      <datapoint name='PARTY_STOP_DAY' value='1' valueType='8' min='1' max='31' writeable='true' />\n");
    Write("      <datapoint name='PARTY_STOP_MONTH' value='1' valueType='8' min='1' max='12' writeable='true' />\n");
    Write("      <datapoint name='PARTY_STOP_YEAR' value='12' valueType='8' min='0' max='99' writeable='true' />\n");
  }
  
  if (isChannelOne && isSmokeDevice) {
    Write("      <datapoint name='STATE' value='false' valueType='2' writeable='false' />\n");
  }

  Write("    </channel>\n");
}
Write("  </device>\n");

}
}
Write("");
2016-01-17 11:18:57.447 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = XXXXX, local base URL = http://localhost:8080)
2016-01-17 11:18:58.573 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘Malvenstr1’.
2016-01-17 11:18:58.579 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘Untergeschoss’.
2016-01-17 11:18:58.585 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘Erdgeschoss’.
2016-01-17 11:18:58.595 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘Obergeschoss’.
2016-01-17 11:18:58.602 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘Aussen’.
2016-01-17 11:18:58.607 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘Schalter’.
2016-01-17 11:18:58.612 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘Klima’.
2016-01-17 11:18:58.618 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘Heizung’.
2016-01-17 11:18:58.623 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘Licht’.
2016-01-17 11:18:58.629 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘Status’.
2016-01-17 11:18:58.652 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘Phone’.
2016-01-17 11:18:58.696 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘Alarm’.
2016-01-17 11:18:58.702 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘Test’.
2016-01-17 11:18:58.707 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘Variable’.
2016-01-17 11:18:58.732 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘Temperatur’.
2016-01-17 11:18:58.737 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘Feuchtigkeit’.
2016-01-17 11:18:58.744 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘EG_Wohn’.
2016-01-17 11:18:59.074 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘UG_Keller’.
2016-01-17 11:18:59.080 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘UG_Buero’.
2016-01-17 11:18:59.102 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘UG_Kind’.
2016-01-17 11:18:59.118 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘OG_Schlaf’.
2016-01-17 11:18:59.123 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘OG_Bad’.
2016-01-17 11:18:59.131 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘OG_Kind’.
2016-01-17 11:18:59.136 [ERROR] [.p.m.i.MysqlPersistenceService] - mySQL: Unable to find table for query ‘A_Garten’.
2016-01-17 11:19:11.508 [ERROR] [.b.h.i.c.HomematicCommunicator] - Could not start Homematic communicator: Read timed out
org.openhab.binding.homematic.internal.communicator.client.HomematicClientException: Read timed out
at org.openhab.binding.homematic.internal.communicator.client.CcuClient.sendScript(CcuClient.java:322) ~[bundlefile:na]
at org.openhab.binding.homematic.internal.communicator.client.CcuClient.sendScriptByName(CcuClient.java:254) ~[bundlefile:na]
at org.openhab.binding.homematic.internal.communicator.client.CcuClient.iterateAllDatapoints(CcuClient.java:126) ~[bundlefile:na]
at org.openhab.binding.homematic.internal.communicator.StateHolder.loadDatapoints(StateHolder.java:84) ~[bundlefile:na]
at org.openhab.binding.homematic.internal.communicator.HomematicCommunicator.start(HomematicCommunicator.java:93) ~[bundlefile:na]
at org.openhab.binding.homematic.internal.bus.HomematicBinding.updated(HomematicBinding.java:95) [bundlefile:na]
at org.eclipse.equinox.internal.cm.ManagedServiceTracker$1.run(ManagedServiceTracker.java:183) [org.eclipse.equinox.cm_1.0.400.v20120522-1841.jar:na]
at org.eclipse.equinox.internal.cm.SerializedTaskQueue$1.run(SerializedTaskQueue.java:36) [org.eclipse.equinox.cm_1.0.400.v20120522-1841.jar:na]
Caused by: java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method) ~[na:1.8.0]
at java.net.SocketInputStream.read(SocketInputStream.java:150) ~[na:1.8.0]
at java.net.SocketInputStream.read(SocketInputStream.java:121) ~[na:1.8.0]
at java.io.BufferedInputStream.fill(BufferedInputStream.java:246) ~[na:1.8.0]
at java.io.BufferedInputStream.read(BufferedInputStream.java:265) ~[na:1.8.0]
at org.apache.commons.httpclient.HttpParser.readRawLine(HttpParser.java:78) ~[org.apache.commons.httpclient_3.1.0.v201012070820.jar:na]
at org.apache.commons.httpclient.HttpParser.readLine(HttpParser.java:106) ~[org.apache.commons.httpclient_3.1.0.v201012070820.jar:na]
at org.apache.commons.httpclient.HttpConnection.readLine(HttpConnection.java:1116) ~[org.apache.commons.httpclient_3.1.0.v201012070820.jar:na]
at org.apache.commons.httpclient.HttpMethodBase.readStatusLine(HttpMethodBase.java:1973) ~[org.apache.commons.httpclient_3.1.0.v201012070820.jar:na]
at org.apache.commons.httpclient.HttpMethodBase.readResponse(HttpMethodBase.java:1735) ~[org.apache.commons.httpclient_3.1.0.v201012070820.jar:na]
at org.apache.commons.httpclient.HttpMethodBase.execute(HttpMethodBase.java:1098) ~[org.apache.commons.httpclient_3.1.0.v201012070820.jar:na]
at org.apache.commons.httpclient.HttpMethodDirector.executeWithRetry(HttpMethodDirector.java:398) ~[org.apache.commons.httpclient_3.1.0.v201012070820.jar:na]
at org.apache.commons.httpclient.HttpMethodDirector.executeMethod(HttpMethodDirector.java:171) ~[org.apache.commons.httpclient_3.1.0.v201012070820.jar:na]
at org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:397) ~[org.apache.commons.httpclient_3.1.0.v201012070820.jar:na]
at org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:323) ~[org.apache.commons.httpclient_3.1.0.v201012070820.jar:na]
at org.openhab.binding.homematic.internal.communicator.client.CcuClient.sendScript(CcuClient.java:310) ~[bundlefile:na]
… 7 common frames omitted
2016-01-17 11:19:11.513 [INFO ] [.b.h.i.c.HomematicCommunicator] - Shutting down Homematic communicator
2016-01-17 11:19:11.515 [DEBUG] [b.h.i.c.s.BinRpcCallbackServer] - Shutting down BinRpcCallbackServer
2016-01-17 11:19:11.517 [TRACE] [.o.b.h.i.c.client.BinRpcClient] - Client BinRpcRequest BinRpcRequest[methodName=init,args={binary://192.168.0.40:9123}]
2016-01-17 11:19:11.524 [TRACE] [.o.b.h.i.c.client.BinRpcClient] - Client BinRpcResponse:

2016-01-17 11:19:11.526 [TRACE] [.o.b.h.i.c.client.BinRpcClient] - Client BinRpcRequest BinRpcRequest[methodName=init,args={binary://192.168.0.40:9123}]
2016-01-17 11:19:11.533 [TRACE] [.o.b.h.i.c.client.BinRpcClient] - Client BinRpcResponse:

2016-01-17 11:19:11.535 [TRACE] [.o.b.h.i.c.client.BinRpcClient] - Client BinRpcRequest BinRpcRequest[methodName=init,args={binary://192.168.0.40:9123}]
2016-01-17 11:19:11.539 [INFO ] [.o.b.h.i.c.client.BinRpcClient] - Interface CUxD not available, disabling support.
2016-01-17 11:19:11.540 [DEBUG] [.h.i.communicator.ItemDisabler] - Stopping ItemDisabler
2016-01-17 11:19:11.545 [INFO ] [.service.AbstractActiveService] - Homematic server connection tracker has been started
2016-01-17 11:19:11.660 [INFO ] [.service.AbstractActiveService] - NTP Refresh Service has been started
2016-01-17 11:19:14.659 [WARN ] [.b.h.i.c.HomematicCommunicator] - Can’t find DatapointConfig[address=IEQ0032538,channel=1,parameter=STATE], value is not published to openHAB!
2016-01-17 11:19:14.661 [WARN ] [.b.h.i.c.HomematicCommunicator] - Can’t find DatapointConfig[address=HEQ0403380,channel=2,parameter=PRESS_SHORT], value is not published to openHAB!
2016-01-17 11:19:14.663 [WARN ] [.b.h.i.c.HomematicCommunicator] - Can’t find DatapointConfig[address=IEQ0151523,channel=1,parameter=HUMIDITY], value is not published to openHAB!
2016-01-17 11:19:14.664 [WARN ] [.b.h.i.c.HomematicCommunicator] - Can’t find DatapointConfig[address=HEQ0509056,channel=1,parameter=HUMIDITY], value is not published to openHAB!

The TclRegaScript seems to be the problem.
When I run the script int the TCL test script box from CCU web UI the CCU is frozen. CCU does not execute commands from remote control. After closing the script text box in CCU web UI the CCU works like excpected.

Script execution takes more then 15 sec.

2016-01-17 11:18:55.759 [INFO ] [o.o.b.h.i.bus.HomematicBinding] - HomematicConfig[host=192.168.0.160,timeout=15,callbackHost=192.168.0.40,callbackPort=9123,aliveInterval=300,reconnectInterval=disabled]

Is there a way to modify the 15 sec timeout?

Any ideas?

I have the similar with CCU2 running v2.17.4. openHAB connects, reads the version and serial number and times out 15 seconds later.

As I didn’t see any migration information I just copied the new archive content over my installation, which worked fine. Just after I stopped and replaced the binding files to 1.8, CCU2 timed out. Other bindings work fine.

OK, found the solution on github

Added the line
homematic:host.timeout=60
to my homematic bindig configuration.

Problem is solved.

Thanx for your investigation. Can confirm that it helps. Remains the question: Why did someone set such a short timout in the 1.8 bindíng.