HMCCU: Version 4.3 verfügbar

zap · 15 September 2019, 17:34:22

Lösche mal in der nicht funktionierenden Config die HMCCURPC Devices. Vorher RPC Server stoppen.
Config speichern, dann fhem und RPC Server neu starten. Dabei werden die HMCCURPC Devices neu angelegt.

mattes66 · 15 September 2019, 18:32:23

Erstmal danke für die rasche Antwort.
Hat leider keine Verbesserung gebracht. Die HMCCUPRC Devices wurden neu angelegt, haben jetzt einen etwas anderen Namen (Teil IP-Adresse im Namen).

Im log steht immer noch zweimal die IP von der CCU2. Wie sollte das denn aussehen?

Code Auswählen

HMCCURPCPROC: [d_rpc188026HmIP_RF] Registering callback http://192.168.188.26:7420/fh2010 of type A with ID CB2010188053188026 at http://192.168.188.26:2010

Code Auswählen

2019.09.15 18:22:36 1: Including fhem.cfg
2019.09.15 18:22:37 3: WEB: port 8083 opened
2019.09.15 18:22:37 3: WEBphone: port 8084 opened
2019.09.15 18:22:37 3: WEBtablet: port 8085 opened
2019.09.15 18:22:37 2: eventTypes: loaded 2897 events from ./log/eventTypes.txt
2019.09.15 18:22:41 1: HMCCU: [d_ccu] Initialized version 4.3.018
2019.09.15 18:22:41 1: HMCCU: [d_ccu] HMCCU: Initializing device
2019.09.15 18:22:44 1: HMCCU: [d_ccu] HMCCU: Read 35 devices with 307 channels from CCU 192.168.188.26
2019.09.15 18:22:44 1: HMCCU: [d_ccu] HMCCU: Read 4 interfaces from CCU 192.168.188.26
2019.09.15 18:22:44 1: HMCCU: [d_ccu] HMCCU: Read 12 programs from CCU 192.168.188.26
2019.09.15 18:22:44 1: HMCCU: [d_ccu] HMCCU: Read 0 virtual groups from CCU 192.168.188.26
2019.09.15 18:22:51 1: Including ./log/fhem.save
2019.09.15 18:22:52 0: HMCCU: Start of RPC server after FHEM initialization in 12 seconds
2019.09.15 18:22:52 0: Featurelevel: 5.9
2019.09.15 18:22:52 0: Server started with 218 defined entities (fhem.pl:20069/2019-08-27 perl:5.024001 os:linux user:fhem pid:1823)
2019.09.15 18:22:52 3: telnetForBlockingFn_1568564572: port 37175 opened
2019.09.15 18:22:52 2: AttrTemplates: got 100 entries
2019.09.15 18:23:04 2: HMCCU: [d_ccu] Get RPC device for interface BidCos-RF
2019.09.15 18:23:04 1: HMCCU: [d_ccu] No RPC device defined for interface BidCos-RF
2019.09.15 18:23:04 1: HMCCU: [d_ccu] Creating new RPC device d_rpc188026BidCos_RF
2019.09.15 18:23:04 1: HMCCURPCPROC: [d_rpc188026BidCos_RF] Initialized version 1.8 for interface BidCos-RF with I/O device d_ccu
2019.09.15 18:23:04 2: HMCCU: [d_ccu] Get RPC device for interface HmIP-RF
2019.09.15 18:23:04 1: HMCCU: [d_ccu] No RPC device defined for interface HmIP-RF
2019.09.15 18:23:04 1: HMCCU: [d_ccu] Creating new RPC device d_rpc188026HmIP_RF
2019.09.15 18:23:04 1: HMCCURPCPROC: [d_rpc188026HmIP_RF] Initialized version 1.8 for interface HmIP-RF with I/O device d_ccu
2019.09.15 18:23:04 1: HMCCU: [d_ccu] Saving FHEM config
2019.09.15 18:23:04 2: HMCCURPCPROC: [d_rpc188026BidCos_RF] RPC server process started for interface BidCos-RF with PID=2155
2019.09.15 18:23:04 2: CCURPC: [d_rpc188026BidCos_RF] Initializing RPC server CB2001188053188026 for interface BidCos-RF
2019.09.15 18:23:04 1: HMCCURPCPROC: [d_rpc188026BidCos_RF] RPC server starting
2019.09.15 18:23:04 2: HMCCURPCPROC: [d_rpc188026HmIP_RF] RPC server process started for interface HmIP-RF with PID=2156
2019.09.15 18:23:04 2: CCURPC: [d_rpc188026HmIP_RF] Initializing RPC server CB2010188053188026 for interface HmIP-RF
2019.09.15 18:23:04 1: HMCCURPCPROC: [d_rpc188026HmIP_RF] RPC server starting
2019.09.15 18:23:04 2: HMCCURPCPROC: [d_rpc188026BidCos_RF] Callback server CB2001188053188026 created. Listening on port 7411
2019.09.15 18:23:04 2: CCURPC: [d_rpc188026BidCos_RF] CB2001188053188026 accepting connections. PID=2155
2019.09.15 18:23:04 2: HMCCURPCPROC: [d_rpc188026BidCos_RF] RPC server CB2001188053188026 enters server loop
2019.09.15 18:23:04 2: HMCCURPCPROC: [d_rpc188026BidCos_RF] Registering callback http://192.168.188.26:7411/fh2001 of type A with ID CB2001188053188026 at http://192.168.188.26:2001
2019.09.15 18:23:04 2: HMCCURPCPROC: [d_rpc188026HmIP_RF] Callback server CB2010188053188026 created. Listening on port 7420
2019.09.15 18:23:04 2: CCURPC: [d_rpc188026HmIP_RF] CB2010188053188026 accepting connections. PID=2156
2019.09.15 18:23:04 1: HMCCURPCPROC: [d_rpc188026BidCos_RF] RPC server CB2001188053188026 running
2019.09.15 18:23:04 1: HMCCURPCPROC: [d_rpc188026BidCos_RF] Scheduled CCU ping every 300 seconds
2019.09.15 18:23:05 2: HMCCURPCPROC: [d_rpc188026HmIP_RF] RPC server CB2010188053188026 enters server loop
2019.09.15 18:23:05 2: HMCCURPCPROC: [d_rpc188026HmIP_RF] Registering callback http://192.168.188.26:7420/fh2010 of type A with ID CB2010188053188026 at http://192.168.188.26:2010
2019.09.15 18:23:05 1: HMCCURPCPROC: [d_rpc188026HmIP_RF] RPC server CB2010188053188026 running
2019.09.15 18:23:05 1: HMCCU: [d_ccu] All RPC servers running
2019.09.15 18:23:05 2: HMCCU: [d_ccu] Updating devices for filter ccudevstate=active,ccuif=BidCos-RF|HmIP-RF
2019.09.15 18:23:05 2: HMCCU: Found 30 client devices matching .*
2019.09.15 18:23:07 2: HMCCU: [d_ccu] Update success=30 failed=0

zap · 15 September 2019, 18:41:16

Hinter "Registering callback" muss die Adresse vom FHEM-Rechner stehen. Bei mir sieht das so aus:

Code Auswählen

Registering callback http://192.168.1.13:7411/fh2001 of type A with ID CB2001001013001021 at http://192.168.1.21:2001

1.13 = FHEM IP
1.21 = CCU IP

Laufen bei Dir FHEM und CCU auf getrennten Rechnern? Wie sieht der Define Befehl vom IO-Device (HMCCU) aus?

mattes66 · 15 September 2019, 19:15:32

ja, FHEM auf einem rpi3, Homematic auf der CCU2
Adresse des RPI ist 192.168.188.53
Adresse der CCU2 ist 192.168.188.26 und die steht zweimal drin in dieser log-Zeile.

Define sieht so aus

Code Auswählen

Internals:
   CCUNum     1
   Clients    :HMCCUDEV:HMCCUCHN:HMCCURPC:HMCCURPCPROC:
   DEF        192.168.188.26
   FUUID      5c462311-f33f-7c52-4e15-8dc8a1e5aa07fc4e
   NAME       d_ccu
   NOTIFYDEV  global,TYPE=(HMCCU|HMCCUDEV|HMCCUCHN)
   NR         41
   NTFY_ORDER 50-d_ccu
   RPCState   running
   STATE      running/OK
   TYPE       HMCCU
   ccuaddr    BidCoS-RF
   ccuchannels 307
   ccudevices 35
   ccuif      BidCos-RF
   ccuinterfaces CUxD,VirtualDevices,HmIP-RF,BidCos-RF
   ccuip      192.168.188.26
   ccuname    HM-RCV-50 BidCoS-RF
   ccustate   active
   ccutype    CCU2/3
   host       192.168.188.26
   prot       http
   version    4.3.018

In der frischen Installation ist das auch so wie bei Dir mit der FHEM und der CCU IP.

Gibt es einen Trick, die Konfiguration "richtig" zurückzusetzen ohne die HM devices wieder neu anzulegen?

Ich habe die HM devices teilweise in FHEM umbenannt, teilweise auf der CCU, leider nicht sehr systematisch. Die Namen sind in ReadingsGroup und Funktionen verarbeitet. Wäre dann viel Arbeit, das wieder glatt zu ziehen.

mattes66 · 15 September 2019, 19:58:28

Hurra, es läuft wieder.

- rpcserver gestoppt
- HMCCURPCPROC Devices gelöscht
- HMCCU device gelöscht
- HMCCU device neu angelegt
- fhem.cfg speichern
- fhem server stoppen
- fhem.cfg von Hand editieren und das device HMCCU wieder an die alte Stelle schieben (sonst ist FHEM abgestürzt)
- fhem neu starten

Jetzt sieht es im log wieder so aus und die icons reagieren wieder:

Code Auswählen

2019.09.15 19:51:54 2: HMCCURPCPROC: [d_rpc188026BidCos_RF] Registering callback http://192.168.188.53:7411/fh2001 of type A with ID CB2001188053188026 at http://192.168.188.26:2001

zap · 15 September 2019, 20:32:36

In dem Fall ist Editieren der fhem.cfg ausnahmsweise erlaubt

Leider werden die Devices in diesem Fall nicht korrekt sortiert in die fhem.cfg geschrieben.

ToM_ToM · 24 September 2019, 19:16:56

Hi zap,

nach dem Umstieg auf Bust und aktueller Perl-Verison wird mein Log ein wenig zugeballert.
Kannst du dir das mal bitte anschauen?

Code Auswählen


2019.09.24 19:12:19 1: PERL WARNING: Unescaped left brace in regex is deprecated here (and will be fatal in Perl 5.30), passed through in regex; marked by <-- HERE in m/1.${ <-- HERE sysVarRainYesterday}/ at /opt/fhem/FHEM/88_HMCCU.pm line 2912.
2019.09.24 19:12:19 1: stacktrace:
2019.09.24 19:12:19 1:     main::__ANON__                      called by /opt/fhem/FHEM/88_HMCCU.pm (2912)
2019.09.24 19:12:19 1:     main::HMCCU_SubstVariables          called by /opt/fhem/FHEM/88_HMCCU.pm (7504)
2019.09.24 19:12:19 1:     main::HMCCU_GetHMState              called by /opt/fhem/FHEM/88_HMCCU.pm (3411)
2019.09.24 19:12:19 1:     main::HMCCU_UpdateSingleDevice      called by /opt/fhem/FHEM/88_HMCCU.pm (3471)
2019.09.24 19:12:19 1:     main::HMCCU_UpdateMultipleDevices   called by /opt/fhem/FHEM/88_HMCCURPCPROC.pm (734)
2019.09.24 19:12:19 1:     main::HMCCURPCPROC_Read             called by fhem.pl (3752)
2019.09.24 19:12:19 1:     main::CallFn                        called by fhem.pl (750)

Viele Grüße

Thomas

kotaro · 25 September 2019, 06:30:19

Hallo,

Ich habe das Problem, das mit den Standartparametern kein pct oder control reading in meiner HmIP-FROLL Aktor. Ist etwas falsch eingerichtet?

Code Auswählen


Internals:
   CHANGED    
   DEF        00115A498E0282
   FUUID      5d6f9511-f33f-787c-8a43-fd367b13f162e40c
   IODev      d_ccu
   NAME       Rollladen_WZ_Doppelfenster
   NR         234
   STATE      5
   TYPE       HMCCUDEV
   ccuaddr    00115A498E0282
   ccudevstate active
   ccuif      HmIP-RF
   ccuname    WZ_Rollladen_Doppelfenster
   ccutype    HmIP-FROLL
   channels   8
   firmware   1.2.0
   statevals  devstate
   READINGS:
     2019-09-25 05:48:53   0.ACTUAL_TEMPERATURE 25.0
     2019-09-25 05:48:53   0.ACTUAL_TEMPERATURE_STATUS normal
     2019-09-25 05:48:53   0.ERROR_CODE    0
     2019-09-25 05:48:53   0.ERROR_OVERHEAT no
     2019-09-25 05:48:53   3.ACTIVITY_STATE stop
     2019-09-25 05:48:53   3.LEVEL         5
     2019-09-25 05:48:53   3.LEVEL_STATUS  0
     2019-09-25 05:48:53   4.ACTIVITY_STATE stop
     2019-09-25 05:48:53   5.ACTIVITY_STATE stop
     2019-09-25 05:48:53   6.ACTIVITY_STATE stop
     2019-09-23 16:58:30   ASC_Enable      on
     2019-09-24 10:17:36   ASC_ShuttersLastDrive manual
     2019-09-24 19:36:42   ASC_Time_DriveDown 25.09.2019 - 19:36
     2019-09-24 19:36:42   ASC_Time_DriveUp 25.09.2019 - 06:30
     2019-09-23 20:44:26   associatedWith  AutoShuttersControl
     2019-09-25 05:48:53   hmstate         5
     2019-09-25 05:48:53   state           5
   hmccu:
     devspec    00115A498E0282
     dp:
       0.ACTUAL_TEMPERATURE:
         OSVAL      25.0
         OVAL       25.0
         SVAL       25.0
         VAL        25.0
       0.ACTUAL_TEMPERATURE_STATUS:
         OSVAL      normal
         OVAL       0
         SVAL       normal
         VAL        0
       0.CONFIG_PENDING:
         OVAL       0
         VAL        0
       0.DUTY_CYCLE:
         OVAL       0
         VAL        0
       0.ERROR_CODE:
         OSVAL      0
         OVAL       0
         SVAL       0
         VAL        0
       0.ERROR_OVERHEAT:
         OSVAL      no
         OVAL       0
         SVAL       no
         VAL        0
       0.INSTALL_TEST:
         OVAL       true
         VAL        true
       0.OPERATING_VOLTAGE:
         OVAL       0.000000
         VAL        0.000000
       0.OPERATING_VOLTAGE_STATUS:
         OVAL       0
         VAL        0
       0.RSSI_DEVICE:
         OVAL       -72
         VAL        -74
       0.RSSI_PEER:
         OVAL       -72
         VAL        -71
       0.UNREACH:
         OVAL       0
         VAL        0
       0.UPDATE_PENDING:
         OVAL       false
         VAL        false
       3.ACTIVITY_STATE:
         OSVAL      stop
         OVAL       3
         SVAL       stop
         VAL        3
       3.LEVEL:
         OSVAL      5
         OVAL       0.05
         SVAL       5
         VAL        0.05
       3.LEVEL_STATUS:
         OSVAL      0
         OVAL       0
         SVAL       0
         VAL        0
       3.PROCESS:
         OVAL       0
         VAL        0
       3.SECTION:
         OVAL       15
         VAL        15
       3.SECTION_STATUS:
         OVAL       0
         VAL        0
       4.ACTIVITY_STATE:
         OSVAL      stop
         OVAL       3
         SVAL       stop
         VAL        3
       4.LEVEL:
         OVAL       0.05
         VAL        0.05
       4.LEVEL_STATUS:
         OVAL       0
         VAL        0
       4.PROCESS:
         OVAL       0
         VAL        0
       4.SECTION:
         OVAL       4
         VAL        4
       4.SECTION_STATUS:
         OVAL       0
         VAL        0
       5.ACTIVITY_STATE:
         OSVAL      stop
         OVAL       3
         SVAL       stop
         VAL        3
       5.LEVEL:
         OVAL       0.0
         VAL        0.0
       5.LEVEL_STATUS:
         OVAL       0
         VAL        0
       5.PROCESS:
         OVAL       0
         VAL        0
       5.SECTION:
         OVAL       0
         VAL        0
       5.SECTION_STATUS:
         OVAL       0
         VAL        0
       6.ACTIVITY_STATE:
         OSVAL      stop
         OVAL       3
         SVAL       stop
         VAL        3
       6.LEVEL:
         OVAL       0.0
         VAL        0.0
       6.LEVEL_STATUS:
         OVAL       0
         VAL        0
       6.PROCESS:
         OVAL       0
         VAL        0
       6.SECTION:
         OVAL       0
         VAL        0
       6.SECTION_STATUS:
         OVAL       0
         VAL        0
       7.WEEK_PROGRAM_CHANNEL_LOCKS:
         OVAL       0
         VAL        0
Attributes:
   ASC        2
   ASC_ComfortOpen_Pos 35
   ASC_Pos_Reading pct
   ASC_PrivacyDown_Pos 30
   ASC_Shading_Direction 70
   ASC_Shading_Pos 30
   ASC_Time_Up_Early 06:30
   ASC_Time_Up_Late 08:00
   ASC_Time_Up_WE_Holiday 08:00
   DbLogExclude .*
   IODev      d_ccu
   ccureadingfilter 3.LEVEL;(ERROR_CODE|ERROR_OVERHEAT|ACTUAL_TEMPERATURE|ACTIVITY_STATE|SELF_CALIBRATION_RESULT)
   ccureadingname 3.LEVEL 
-+control,+pct
   ccuscaleval LEVEL:0:1:0:100
   cmdIcon    up:fts_shutter_up stop:fts_shutter_manual down:fts_shutter_down
   controldatapoint 4.LEVEL
   event-on-change-reading .*
   eventMap   /datapoint 4.STOP true:stop/datapoint 4.LEVEL 0:down/datapoint 4.LEVEL 100:up/datapoint 3.SELF_CALIBRATION 0:stopCalibration/datapoint 3.SELF_CALIBRATION 1:startCalibration/
   gassistantName Orchideenfenster
   genericDeviceType blind
   group      Rollladen
   hmstatevals ACTUAL_TEMPERATURE_STATUS!2:tempOverflow,3:tempUnderflow;ERROR_OVERHEAT!(1|true):overheat
   realRoom   Wohnzimmer
   room       11_Wohnzimmer,GoogleAssistant,Homekit,Homematic
   statedatapoint 3.LEVEL
   stripnumber 1
   substexcl  control|pct
   substitute LEVEL!#0-0:closed,#100-100:open;ACTIVITY_STATE!0:unknown,1:up,2:down,3:stop;ERROR_OVERHEAT!(0|false):no,(1|true):yes;ACTUAL_TEMPERATURE_STATUS!0:normal,1:unknown,2:overflow,3:underflow;SELF_CALIBRATION_RESULT!(0|false):failed,(1|true):ok
   userattr   ASC_Antifreeze:off,soft,hard,am,pm ASC_Antifreeze_Pos:5,10,15,20,25,30,35,40,45,50,55,60,65,70,75,80,85,90,95,100 ASC_AutoAstroModeEvening:REAL,CIVIL,NAUTIC,ASTRONOMIC,HORIZON ASC_AutoAstroModeEveningHorizon:-9,-8,-7,-6,-5,-4,-3,-2,-1,0,1,2,3,4,5,6,7,8,9 ASC_AutoAstroModeMorning:REAL,CIVIL,NAUTIC,ASTRONOMIC,HORIZON ASC_AutoAstroModeMorningHorizon:-9,-8,-7,-6,-5,-4,-3,-2,-1,0,1,2,3,4,5,6,7,8,9 ASC_BlockingTime_afterManual ASC_BlockingTime_beforDayOpen ASC_BlockingTime_beforNightClose ASC_BrightnessSensor ASC_Closed_Pos:0,10,20,30,40,50,60,70,80,90,100 ASC_ComfortOpen_Pos:0,10,20,30,40,50,60,70,80,90,100 ASC_Down:time,astro,brightness,roommate ASC_DriveUpMaxDuration ASC_Drive_Offset ASC_Drive_OffsetStart ASC_GuestRoom:on,off ASC_LockOut:soft,hard,off ASC_LockOut_Cmd:inhibit,blocked,protection ASC_Mode_Down:absent,always,off,home ASC_Mode_Up:absent,always,off,home ASC_Open_Pos:0,10,20,30,40,50,60,70,80,90,100 ASC_Partymode:on,off ASC_Pos_Reading ASC_PrivacyDownTime_beforNightClose ASC_PrivacyDown_Pos ASC_RainProtection:on,off ASC_Roommate_Device ASC_Roommate_Reading ASC_Self_Defense_AbsentDelay ASC_Self_Defense_Exclude:on,off ASC_Self_Defense_Mode:absent,gone ASC_Shading_Angle_Left ASC_Shading_Angle_Right ASC_Shading_Direction ASC_Shading_MinMax_Elevation ASC_Shading_Min_OutsideTemperature ASC_Shading_Mode:absent,always,off,home ASC_Shading_Pos:10,20,30,40,50,60,70,80,90,100 ASC_Shading_StateChange_Cloudy ASC_Shading_StateChange_Sunny ASC_Shading_WaitingPeriod ASC_ShuttersPlace:window,terrace ASC_TempSensor ASC_Time_Down_Early ASC_Time_Down_Late ASC_Time_Up_Early ASC_Time_Up_Late ASC_Time_Up_WE_Holiday ASC_Up:time,astro,brightness,roommate ASC_Ventilate_Pos:10,20,30,40,50,60,70,80,90,100 ASC_Ventilate_Window_Open:on,off ASC_WiggleValue ASC_WindParameters ASC_WindProtection:on,off ASC_WindowRec ASC_WindowRec_PosAfterDayClosed:open,lastManual ASC_WindowRec_subType:twostate,threestate
   webCmd     control:up:stop:down
   widgetOverride control:slider,0,10,100

jsChris · 25 September 2019, 08:35:14

Hi,

ich habe hier für einen HmIP-BROLL (sollte ja ähnlich sein):

Code Auswählen


   ccureadingfilter ^(ERROR_CODE|ERROR_OVERHEAT|ACTUAL_TEMPERATURE|LEVEL|ACTIVITY_STATE|SELF_CALIBRATION_RESULT)$
   ccureadingname 3.LEVEL:+pct
   ccuscaleval LEVEL:0:1:0:100
   cmdIcon    up:fts_shutter_up stop:fts_shutter_manual down:fts_shutter_down
   controldatapoint 4.LEVEL
   event-on-change-reading .*
   eventMap   /datapoint 4.STOP true:stop/datapoint 4.LEVEL 0:down/datapoint 4.LEVEL 100:up/datapoint 3.SELF_CALIBRATION 0:stopCalibration/datapoint 3.SELF_CALIBRATION 1:startCalibration/
   genericDeviceType blind
   group      Rolladen
   hmstatevals ACTUAL_TEMPERATURE_STATUS!2:tempOverflow,3:tempUnderflow;ERROR_OVERHEAT!(1|true):overheat
   icon       fts_shutter
   room       Homematic,Wohnzimmer
   statedatapoint 4.LEVEL
   stripnumber 1
   substexcl  control|pct
   substitute LEVEL!#0-0:closed,#100-100:open;ACTIVITY_STATE!0:unknown,1:up,2:down,3:stop;ERROR_OVERHEAT!(0|false):no,(1|true):yes;ACTUAL_TEMPERATURE_STATUS!0:normal,1:unknown,2:overflow,3:underflow;SELF_CALIBRATION_RESULT!(0|false):failed,(1|true):ok
   webCmd     control:up:stop:down
   widgetOverride control:slider,0,10,100

lg
Chris

kotaro · 25 September 2019, 17:31:06

Danke.

Tatsächlich war mein Attribute ccureadingname falsch. Es war so:

Code Auswählen

ccureadingname 3.LEVEL
-+control,+pct

Aber es hätte so sein müssen

Code Auswählen

ccureadingname 3.LEVEL+control:+pct

Wolle02 · 30 September 2019, 18:41:21

Hallo Zap,

bei meinen HM-Devices, die noch über CUL_HM laufen erscheint bei Schaltvorgängen ein Log 3 Eintrag im global Logfile. Daran hab ich mir ehrlich gesagt etwas gewöhnt und finde es schade, dass dies bei den HM-Devices, die über HMCCU laufen nicht der Fall ist.
Könntest du hier eventuell auch ein Logfileprotokoll einbauen? Wenn das dann jemand stören sollte, könnte er dies ja mit Erniedrigung des Verbose Levels auf z.B. 2 wieder abschalten. Alternativ könnte man auch andersherum den Standard Verbose Level auf 2 oder weniger setzen, so dass ich die Protokollierung im Log erhalte, wenn ich den Verbose Level auf 3 erhöhe. Bei Verbose 4 oder 5 kommt schon wieder zu viel.

Gruß
Wolle

Simon74 · 30 September 2019, 19:41:32

Hallo zap,

stelle gerade fest das es mit 2 Schaltbefehlen in selber Sekunde immer noch Timeouts gibt.

Code Auswählen

2019.09.30 19:01:14 1: LED-KU: Ein (doif.pr.wz_led.ku)
2019.09.30 19:01:14 1: LED-WZ: Ein (doif.pr.wz_led.wz)
2019.09.30 19:01:18 2: HMCCUDEV: [HM_sd_ku_led] Error during CCU request. timed out

Ausgewirkt hat es sich so das der Lichtaktor in 1. Zeile nicht eingeschaltet hat.
Eine Queue wär schön

zap · 01 Oktober 2019, 07:37:25

Es gibt mittlerweile einen set datapoint Befehl im IO Device, mit dem man mehrere Devices vom Typ HMCCUCHN und HMCCUDEV in einem CCU Request schalten kann. Wenn also beide Schaltbefehle aus dem gleichen DOIF resultieren, solltest du das mal probieren.

Außerdem habe ich in HMCCUCHN und HMCCUDEV den Befehl set rpcparameter eingebaut. Der setzt Datenpunkte über die RPC Schnittstelle unter Umgehung der CCU Rega. Das kann auch bei Timeout Problemen helfen.

Ralli · 02 Oktober 2019, 12:57:13

Hallo zap,

mit der neuen Firmware der CCU2 fällt mir auf, dass die aktuelle Version von HMCCU immer wieder nach einem Neustart von fhem die Devices nicht richtig geupdatet bekommt:

Code Auswählen


2019.10.02 12:51:08.209 1: Including fhem.cfg
2019.10.02 12:51:08.387 3: telnetPort: port 7072 opened
2019.10.02 12:51:09.853 3: WEB: port 8083 opened
2019.10.02 12:51:09.854 3: WEBphone: port 8084 opened
2019.10.02 12:51:09.854 3: WEBtablet: port 8085 opened
2019.10.02 12:51:10.097 2: eventTypes: loaded 3874 events from log/eventTypes.txt
2019.10.02 12:51:14.753 1: HMCCU: [CCU2] Initialized version 4.3.018
2019.10.02 12:51:14.754 1: HMCCU: [CCU2] HMCCU: Initializing device
2019.10.02 12:51:18.104 1: HMCCU: [CCU2] HMCCU: Read 111 devices with 548 channels from CCU 10.0.0.20
2019.10.02 12:51:18.104 1: HMCCU: [CCU2] HMCCU: Read 4 interfaces from CCU 10.0.0.20
2019.10.02 12:51:18.104 1: HMCCU: [CCU2] HMCCU: Read 68 programs from CCU 10.0.0.20
2019.10.02 12:51:18.104 1: HMCCU: [CCU2] HMCCU: Read 0 virtual groups from CCU 10.0.0.20
2019.10.02 12:51:24.637 1: HMCCURPCPROC: [d_rpcBidCos_RF] Initialized version 1.8 for interface BidCos-RF with I/O device CCU2
2019.10.02 12:51:24.638 1: HMCCURPCPROC: [d_rpcBidCos_Wired] Initialized version 1.8 for interface BidCos-Wired with I/O device CCU2
2019.10.02 12:51:24.640 1: HMCCURPCPROC: [d_rpcHmIP_RF] Initialized version 1.8 for interface HmIP-RF with I/O device CCU2
2019.10.02 12:51:24.907 1: Including ./log/fhem.save
2019.10.02 12:51:25.001 0: HMCCU: Start of RPC server after FHEM initialization in 12 seconds
2019.10.02 12:51:25.090 0: Featurelevel: 5.9
2019.10.02 12:51:25.090 0: Server started with 298 defined entities (fhem.pl:20069/2019-08-27 perl:5.026001 os:linux user:fhem pid:2059)
2019.10.02 12:51:37.003 2: HMCCU: [CCU2] Get RPC device for interface BidCos-RF
2019.10.02 12:51:37.003 2: HMCCU: [CCU2] Get RPC device for interface BidCos-Wired
2019.10.02 12:51:37.003 2: HMCCU: [CCU2] Get RPC device for interface HmIP-RF
2019.10.02 12:51:37.004 2: HMCCURPCPROC: [d_rpcBidCos_RF] RPC server process started for interface BidCos-RF with PID=2149
2019.10.02 12:51:37.010 1: HMCCURPCPROC: [d_rpcBidCos_RF] RPC server starting
2019.10.02 12:51:37.014 2: CCURPC: [d_rpcBidCos_RF] Initializing RPC server CB2001000030000020 for interface BidCos-RF
2019.10.02 12:51:37.018 2: HMCCURPCPROC: [d_rpcBidCos_Wired] RPC server process started for interface BidCos-Wired with PID=2150
2019.10.02 12:51:37.024 2: CCURPC: [d_rpcBidCos_Wired] Initializing RPC server CB2000000030000020 for interface BidCos-Wired
2019.10.02 12:51:37.029 1: HMCCURPCPROC: [d_rpcBidCos_Wired] RPC server starting
2019.10.02 12:51:37.035 2: HMCCURPCPROC: [d_rpcHmIP_RF] RPC server process started for interface HmIP-RF with PID=2151
2019.10.02 12:51:37.041 2: CCURPC: [d_rpcHmIP_RF] Initializing RPC server CB2010000030000020 for interface HmIP-RF
2019.10.02 12:51:37.044 1: HMCCURPCPROC: [d_rpcHmIP_RF] RPC server starting
2019.10.02 12:51:37.124 2: HMCCURPCPROC: [d_rpcBidCos_RF] Callback server CB2001000030000020 created. Listening on port 7411
2019.10.02 12:51:37.125 2: HMCCURPCPROC: [d_rpcBidCos_RF] RPC server CB2001000030000020 enters server loop
2019.10.02 12:51:37.125 2: HMCCURPCPROC: [d_rpcBidCos_RF] Registering callback http://10.0.0.30:7411/fh2001 of type A with ID CB2001000030000020 at http://10.0.0.20:2001
2019.10.02 12:51:37.131 2: HMCCURPCPROC: [d_rpcBidCos_Wired] Callback server CB2000000030000020 created. Listening on port 7410
2019.10.02 12:51:37.132 2: CCURPC: [d_rpcBidCos_Wired] CB2000000030000020 accepting connections. PID=2150
2019.10.02 12:51:37.135 2: CCURPC: [d_rpcBidCos_RF] CB2001000030000020 accepting connections. PID=2149
2019.10.02 12:51:37.136 2: HMCCURPCPROC: [d_rpcHmIP_RF] Callback server CB2010000030000020 created. Listening on port 7420
2019.10.02 12:51:37.137 2: CCURPC: [d_rpcHmIP_RF] CB2010000030000020 accepting connections. PID=2151
2019.10.02 12:51:37.824 1: HMCCURPCPROC: [d_rpcBidCos_RF] RPC server CB2001000030000020 running
2019.10.02 12:51:37.827 1: HMCCURPCPROC: [d_rpcBidCos_RF] Scheduled CCU ping every 300 seconds
2019.10.02 12:51:37.832 2: HMCCURPCPROC: [d_rpcBidCos_Wired] RPC server CB2000000030000020 enters server loop
2019.10.02 12:51:37.833 2: HMCCURPCPROC: [d_rpcBidCos_Wired] Registering callback http://10.0.0.30:7410/fh2000 of type A with ID CB2000000030000020 at http://10.0.0.20:2000
2019.10.02 12:51:38.116 1: HMCCURPCPROC: [d_rpcBidCos_Wired] RPC server CB2000000030000020 running
2019.10.02 12:51:38.305 2: CCURPC: [d_rpcBidCos_Wired] CB2000000030000020 NewDevice received 94 device and channel specifications
2019.10.02 12:51:38.645 2: HMCCURPCPROC: [d_rpcHmIP_RF] RPC server CB2010000030000020 enters server loop
2019.10.02 12:51:38.646 2: HMCCURPCPROC: [d_rpcHmIP_RF] Registering callback http://10.0.0.30:7420/fh2010 of type A with ID CB2010000030000020 at http://10.0.0.20:2010
2019.10.02 12:51:38.664 2: CCURPC: [d_rpcBidCos_RF] CB2001000030000020 NewDevice received 461 device and channel specifications
2019.10.02 12:51:38.714 1: HMCCURPCPROC: [d_rpcHmIP_RF] RPC server CB2010000030000020 running
2019.10.02 12:51:38.715 1: HMCCU: [CCU2] All RPC servers running
2019.10.02 12:51:38.716 2: HMCCU: [CCU2] Updating devices for filter ccudevstate=active,ccuif=BidCos-RF|BidCos-Wired|HmIP-RF
2019.10.02 12:51:38.720 2: HMCCU: Found 125 client devices matching .*
2019.10.02 12:51:39.543 2: CCURPC: [d_rpcHmIP_RF] CB2010000030000020 NewDevice received 92 device and channel specifications

Die Erfolgsmeldung

Code Auswählen


2019.10.02 12:54:32.932 2: HMCCU: [CCU2] Update success=125 failed=0

bleibt aus, entsprechend werden Devices erst dann nach und nach geupdatet, wenn Events über die RPC-Schnittstelle herein kommen. Nach einem weiteren "shutdown restart" von fhem klappt es dann meist. Ich kann leider keine Fehlermeldung erkennen.

zap · 02 Oktober 2019, 18:19:05

Ich werde morgen mal auf meiner CCU (allerdings eine CCU3) die aktuelle Firmware installieren. Mal sehen, wie sich das bei mir verhält. Mittlerweile passiert das globale Update nach dem Start der RPC Prozesse komplett Non-Blocking. Fehlermeldung sollte allerdings trotzdem kommen, wenn das nicht funktioniert.

Ich nehme an, Du hast das "noInitialUpdate" Flag nicht gesetzt (in den HMCCURPCPROC Devices oder dem HMCCU Device)?