HMUARTLGW HMUART_EG can't send due to unknown problem

Kai-Alfonso · 13 Februar 2022, 13:20:19

Moin,

ich habe irgendwie ein komisches Problem. Mein HM-MOD-UART spinnt mit folgender Nachricht im Log

HMUARTLGW HMUART_EG can't send due to unknown problem (no response?)

ich hab baulich nix verändert, nur ein reboot gemacht - das Teil ist als GPIO Header aufgesetzt

Code Auswählen

Internals:
   AssignedPeerCnt 16
   CNT        177
   Clients    :CUL_HM:
   DEF        /dev/ttyAMA0
   DEVCNT     177
   DevState   99
   DevType    UART
   DeviceName /dev/ttyAMA0@115200
   FD         25
   FUUID      5c8fd562-f33f-ce3b-a18c-75d1a827b6912f89
   FVERSION   00_HMUARTLGW.pm:0.252030/2021-11-08
   LastOpen   1644753854.45969
   NAME       HMUART_EG
   NOTIFYDEV  global
   NR         7
   NTFY_ORDER 47-HMUART_EG
   PARTIAL    
   RAWMSG     040209
   STATE      ok
   TYPE       HMUARTLGW
   XmitOpen   1
   model      HM-MOD-UART
   msgLoadCurrent 5
   msgLoadHistory -/-/-/-/-/-/-/-/-/-/-/-
   msgLoadHistoryAbs 0/-/-/-/-/-/-/-/-/-/-/-/-
   owner      0B98D0
   owner_CCU  VCCU
   Helper:
     CreditTimer 9
     FW         66561
     Initialized 1
     SendCnt    32
     AckPending:
     LastSendLen:
       3
       3
     Log:
       IDs:
         all
         sys
     PendingCMD:
     RoundTrip:
       Delay      0.00289392471313477
     loadLvl:
       lastHistory 1644754439.70738
   MatchList:
     1:CUL_HM   ^A......................
   Peers:
     0B4A4F     +0B4A4F,00,00,00
     1D1E9A     +1D1E9A,02,00,00
     3958D0     +3958D0,02,00,00
     4E8B99     +4E8B99,00,00,00
     4F1D52     +4F1D52,00,00,00
     4F1D8D     +4F1D8D,00,00,00
     4F1DA6     +4F1DA6,00,00,00
     4F1DAD     +4F1DAD,00,00,00
     4F1DB4     +4F1DB4,00,00,00
     5E87A8     +5E87A8,00,00,00
     634520     +634520,00,00,00
     84E0C6     +84E0C6,02,00,00
     878783     +878783,00,00,00
     9DDD70     +9DDD70,02,00,00
     A9C06F     +A9C06F,02,00,00
     CC5B90     +CC5B90,02,00,00
   READINGS:
     2022-02-13 13:13:58   D-HMIdAssigned  0B98D0
     2022-02-13 13:13:59   D-HMIdOriginal  6BDED3
     2022-02-13 13:13:59   D-firmware      1.4.1
     2022-02-13 13:13:59   D-serialNr      PEQ2216386
     2022-02-13 13:04:01   D-type          HM-MOD-UART
     2022-02-13 13:14:00   cond            ok
     2022-02-13 13:14:36   load            5
     2022-02-13 13:14:00   loadLvl         low
     2022-02-13 13:04:14   state           opened
   helper:
Attributes:
   group      2. HomeMatic IO
   hmId       0B98D0
   logIDs     all,sys
   room       HomeMatic
   stateFormat cond

Das Device ist natürlich auch verfügbar (logisch, sonst wäre cond ungleich ok)

Im Log taucht auch immer folgendes auf

Code Auswählen

2022.02.13 13:17:57.596 0: HMUARTLGW HMUART_EG GetSet Ack: 02, state 98
2022.02.13 13:17:57.597 0: HMUARTLGW HMUART_EG roundtrip delay: 0.0029
2022.02.13 13:18:12.595 0: HMUARTLGW HMUART_EG send: 00 08
2022.02.13 13:18:12.599 0: HMUARTLGW HMUART_EG recv: 00 040209, state 98
2022.02.13 13:18:12.599 0: HMUARTLGW HMUART_EG GetSet Ack: 02, state 98
2022.02.13 13:18:12.599 0: HMUARTLGW HMUART_EG roundtrip delay: 0.0029
2022.02.13 13:18:27.599 0: HMUARTLGW HMUART_EG send: 00 08
2022.02.13 13:18:27.603 0: HMUARTLGW HMUART_EG recv: 00 040209, state 98
2022.02.13 13:18:27.604 0: HMUARTLGW HMUART_EG GetSet Ack: 02, state 98
2022.02.13 13:18:27.604 0: HMUARTLGW HMUART_EG roundtrip delay: 0.0030
2022.02.13 13:18:42.602 0: HMUARTLGW HMUART_EG send: 00 08
2022.02.13 13:18:42.606 0: HMUARTLGW HMUART_EG recv: 00 040209, state 98
2022.02.13 13:18:42.606 0: HMUARTLGW HMUART_EG GetSet Ack: 02, state 98
2022.02.13 13:18:42.607 0: HMUARTLGW HMUART_EG roundtrip delay: 0.0028
2022.02.13 13:18:57.606 0: HMUARTLGW HMUART_EG send: 00 08
2022.02.13 13:18:57.612 0: HMUARTLGW HMUART_EG recv: 00 04020B, state 98
2022.02.13 13:18:57.613 0: HMUARTLGW HMUART_EG GetSet Ack: 02, state 98
2022.02.13 13:18:57.613 0: HMUARTLGW HMUART_EG roundtrip delay: 0.0053
2022.02.13 13:19:12.609 0: HMUARTLGW HMUART_EG send: 00 08
2022.02.13 13:19:12.612 0: HMUARTLGW HMUART_EG recv: 00 04020B, state 98
2022.02.13 13:19:12.613 0: HMUARTLGW HMUART_EG GetSet Ack: 02, state 98
2022.02.13 13:19:12.613 0: HMUARTLGW HMUART_EG roundtrip delay: 0.0029

frank · 13 Februar 2022, 13:30:44

ZitatIm Log taucht auch immer folgendes auf

das hast du ja auch so eingestellt:

Code Auswählen

logIDs all,sys

Code Auswählen

HMUARTLGW HMUART_EG can't send due to unknown problem (no response?)
mit dem gesetzten logIDs sollte da mehr zu sehen sein, oder?

Kai-Alfonso · 13 Februar 2022, 13:42:03

Zitat von: frank am 13 Februar 2022, 13:30:44
das hast du ja auch so eingestellt:
Code Auswählen Erweitern
logIDs all,sys

Ja, das war mir schon klar - wollte ja ordentliche Logs haben um zu sehen, wieso das nicht geht

Sorry, hab mal ein HM Device geschaltet, dann kommt natürlich mehr

Code Auswählen

022.02.13 13:40:44.613 0: HMUARTLGW HMUART_EG send: 01 02 00 00 00 msg: 2A A0 11 0B98D0 4F1DA6 0201C8
2022.02.13 13:40:45.517 0: HMUARTLGW HMUART_EG recv: 01 0404, state 100
2022.02.13 13:40:45.518 0: HMUARTLGW HMUART_EG can't send due to unknown problem (no response?)
2022.02.13 13:40:45.734 0: HMUARTLGW HMUART_EG send: 00 08
2022.02.13 13:40:45.738 0: HMUARTLGW HMUART_EG recv: 00 040212, state 98
2022.02.13 13:40:45.738 0: HMUARTLGW HMUART_EG GetSet Ack: 02, state 98
2022.02.13 13:40:45.739 0: HMUARTLGW HMUART_EG roundtrip delay: 0.0028
2022.02.13 13:40:50.183 0: HMUARTLGW HMUART_EG send: 01 02 00 00 00 msg: 2A A0 11 0B98D0 4F1DA6 0201C8
2022.02.13 13:40:51.093 0: HMUARTLGW HMUART_EG recv: 01 0404, state 100
2022.02.13 13:40:51.094 0: HMUARTLGW HMUART_EG can't send due to unknown problem (no response?)
2022.02.13 13:40:54.276 0: HMUARTLGW HMUART_EG send: 01 02 00 00 00 msg: 2A A0 11 0B98D0 4F1DA6 0201C8
2022.02.13 13:40:55.164 0: HMUARTLGW HMUART_EG recv: 01 0404, state 100
2022.02.13 13:40:55.165 0: HMUARTLGW HMUART_EG can't send due to unknown problem (no response?)
2022.02.13 13:40:59.315 0: HMUARTLGW HMUART_EG send: 01 02 00 00 00 msg: 2A A0 11 0B98D0 4F1DA6 0201C8
2022.02.13 13:41:00.194 0: HMUARTLGW HMUART_EG recv: 01 0404, state 100
2022.02.13 13:41:00.194 0: HMUARTLGW HMUART_EG can't send due to unknown problem (no response?)
2022.02.13 13:41:00.738 0: HMUARTLGW HMUART_EG send: 00 08
2022.02.13 13:41:00.741 0: HMUARTLGW HMUART_EG recv: 00 040213, state 98
2022.02.13 13:41:00.742 0: HMUARTLGW HMUART_EG GetSet Ack: 02, state 98
2022.02.13 13:41:00.743 0: HMUARTLGW HMUART_EG roundtrip delay: 0.0028

frank · 13 Februar 2022, 13:50:55

welchen cmd hast du ausgelöst?
dann zeig mal ein list von 4F1DA6.

Kai-Alfonso · 13 Februar 2022, 13:59:42

Zitat von: frank am 13 Februar 2022, 13:50:55
welchen cmd hast du ausgelöst?
dann zeig mal ein list von 4F1DA6.

Also das ist nicht gerätespezifisch - in dem Fall habe ich Rolllade_Kinderzimmer bewegt. Also ein set Rollllade_Kinderzimmer pct 60 zum Beispiel

Code Auswählen

Internals:
   DEF        4F1DA6
   FUUID      5c97ae9a-f33f-ce3b-a83a-fac3b4201c5f5a24
   FVERSION   10_CUL_HM.pm:0.252980/2021-12-05
   IODev      HMUART_EG
   NAME       Rolllade_Kinderzimmer
   NR         121
   NTFY_ORDER 48-Rolllade_Kinderzimmer
   STATE      0
   TYPE       CUL_HM
   chanNo     01
   disableNotifyFn 1
   protCmdDel 3
   protResnd  9 last_at:2022-02-13 13:44:33
   protResndFail 3 last_at:2022-02-13 13:44:39
   protSnd    3 last_at:2022-02-13 13:44:19
   protState  CMDs_done_Errors:1
   READINGS:
     2021-04-28 22:47:19   ASC_Enable      on
     2021-06-14 15:36:12   ASC_ShadingMessage <html> WARN:  global shading active but ASC_Shading_Mode attribut is not set or off </html>
     2022-02-12 18:07:35   ASC_ShuttersLastDrive minimum brightness threshold fell below
     2022-02-13 13:13:56   ASC_Time_DriveDown 13.02.2022 - 18:30
     2022-02-13 13:13:56   ASC_Time_DriveUp 14.02.2022 - 08:30
     2022-02-13 13:13:55   Activity        alive
     2022-02-12 18:07:00   CommandAccepted yes
     2021-04-28 22:45:35   D-firmware      2.11
     2021-04-28 22:45:35   D-serialNr      NEQ1215071
     2022-02-13 13:44:19   IODev           HMUART_EG
     2021-04-28 22:47:33   PairedTo        0x0B98D0
     2021-04-28 22:47:34   R-driveDown     30.1 s
     2021-04-28 22:47:34   R-driveTurn     1 s
     2021-04-28 22:47:34   R-driveUp       31.5 s
     2021-04-28 22:47:33   R-pairCentral   0x0B98D0
     2021-04-28 22:47:34   R-sign          off
     2021-04-28 22:47:33   RegL_00.        00:00 02:01 0A:0B 0B:98 0C:D0 15:FF 18:00
     2021-04-28 22:47:34   RegL_01.        00:00 08:00 09:00 0A:00 0B:01 0C:2D 0D:01 0E:3B 0F:0A 10:00 30:06 56:00 57:24
     2022-02-13 13:13:52   associatedWith  AutoShuttersControl
     2022-02-13 11:19:11   cfgState        ok
     2022-02-13 13:44:39   commState       CMDs_done_Errors:1
     2022-02-12 18:07:34   deviceMsg       off (to VCCU)
     2022-02-13 13:40:44   level           set_100
     2022-02-12 18:07:34   motor           stop:off
     2022-02-12 18:07:34   pct             0
     2022-02-12 18:07:34   recentStateType info
     2022-02-13 13:44:39   state           unreachable
     2022-02-12 18:07:34   timedOn         off
     2022-02-13 13:40:44   trigLast        fhem:02
   helper:
     HM_CMDNR   43
     cSnd       110B98D04F1DA60201C8,010B98D04F1DA6010E
     dlvlCmd    ++A0110B98D04F1DA60201C8
     mId        0005
     peerFriend peerSens,peerVirt
     peerIDsState complete
     peerOpt    3:blindActuator
     regLst     0,1,3p
     rxType     1
     cmds:
       TmplKey    :no:1644754426.93742
       TmplTs     1644754426.93742
       cmdKey     1:1:0::Rolllade_Kinderzimmer:0005:01:
       cmdLst:
         assignHmKey noArg
         clear      [({msgErrors}|msgEvents|rssi|attack|trigger|register|oldRegs|readings|all)]
         deviceRename -newName-
         down       'change:'[(0..100;1|{10})] [(-ontime-|{})] [(-ramptime-|{})]
         fwUpdate   -filename- [-bootTime-]
         getConfig  noArg
         getDevInfo noArg
         getRegRaw  (List0|List1|List2|List3|List4|List5|List6|List7) [-peerChn-]
         getVersion noArg
         inhibit    [(on|{off})]
         off        noArg
         on         noArg
         pair       noArg
         pct        -value- [-ontime-]
         peerBulk   -peer1,peer2,...- [({set}|unset)]
         peerIODev  [IO] -btn- [({set}|unset)] 'not for future use'
         peerSmart  -peerOpt-
         press      [(long|{short})] [(-peer-|{self01})] [(-repCount-|{0})] [(-repDelay-|{0.25})]
         raw        -data- [...]
         regBulk    -list-.-peerChn- -addr1:data1- [-addr2:data2-]...
         regSet     [(prep|{exec})] -regName- -value- [-peerChn-]
         reset      noArg
         sign       [(on|{off})]
         statusRequest noArg
         stop       noArg
         toggle     noArg
         toggleDir  noArg
         tplDel     -tplDel-
         tplSet_0   -tplChan-
         unpair     noArg
         up         'change:'[(0..100;1|{10})] [(-ontime-|{})] [(-ramptime-|{})]
       lst:
         condition  slider,0,1,255
         peer       
         peerOpt    Bewegungsmelder_Arbeitszimmer,Bewegungsmelder_Haustuer,Fenster_Arbeitszimmer,Fenster_Badezimmer,Fenster_GaesteWC,Fenster_Kinderzimmer,Fenster_Kueche,Fenster_Schlafzimmer_Links,Fenster_Schlafzimmer_Rechts
         tplChan    
         tplDel     
         tplPeer    
       rtrvLst:
         cmdList    [({short}|long)]
         deviceInfo [({short}|long)]
         list       [({normal}|full)]
         param      -param-
         reg        -addr- -list- [-peerChn-]
         regList    noArg
         regTable   noArg
         regVal     -addr- -list- [-peerChn-]
         saveConfig [-filename-]
         tplInfo    noArg
     expert:
       def        1
       det        0
       raw        1
       tpl        0
     io:
       flgs       0
       newChn     +4F1DA6,00,00,00
       rxt        0
       vccu       VCCU
       p:
         4F1DA6
         00
         00
         00
       prefIO:
     mRssi:
       mNo        
       io:
         HMUART_EG:
         HMUART_OG:
     peerIDsH:
       00000000   broadcast
     prt:
       bErr       0
       sProc      0
     q:
       qReqConf   
       qReqStat   
     role:
       chn        1
       dev        1
       prs        1
     rssi:
     shadowReg:
     tmpl:
Attributes:
   ASC        2
   ASC_Antifreeze soft
   ASC_Antifreeze_Pos 15
   ASC_AutoAstroModeEvening none
   ASC_AutoAstroModeEveningHorizon none
   ASC_AutoAstroModeMorning none
   ASC_AutoAstroModeMorningHorizon none
   ASC_BlockingTime_afterManual 1200
   ASC_BlockingTime_beforeDayOpen 3600
   ASC_BlockingTime_beforeNightClose 3600
   ASC_BrightnessSensor Umgebungssensor_Fassade_SuedSeite
   ASC_Closed_Pos 0
   ASC_ComfortOpen_Pos 100
   ASC_Down   brightness
   ASC_Drive_Delay -1
   ASC_Drive_DelayStart -1
   ASC_GuestRoom none
   ASC_LockOut off
   ASC_LockOut_Cmd none
   ASC_Mode_Down always
   ASC_Mode_Up always
   ASC_Open_Pos 100
   ASC_Partymode off
   ASC_Pos_Reading pct
   ASC_Roommate_Device none
   ASC_Roommate_Reading state
   ASC_Self_Defense_AbsentDelay 600
   ASC_Self_Defense_Mode gone
   ASC_Shading_InOutAzimuth -40:130
   ASC_Shading_MinMax_Elevation 25
   ASC_Shading_Min_OutsideTemperature 28
   ASC_Shading_Mode off
   ASC_Shading_Pos 0
   ASC_Shading_StateChange_SunnyCloudy 35000:20000
   ASC_Shading_WaitingPeriod 1200
   ASC_Sleep_Pos 0
   ASC_TempSensor Umgebungssensor_Fassade_NordSeite:temperature
   ASC_Time_Down_Early 17:00
   ASC_Time_Down_Late 18:30
   ASC_Time_Up_Early 08:00
   ASC_Time_Up_Late 08:30
   ASC_Time_Up_WE_Holiday 08:00
   ASC_Up     brightness
   ASC_Ventilate_Pos 30
   ASC_Ventilate_Window_Open off
   ASC_WiggleValue 5
   ASC_WindowRec Fenster_Kinderzimmer
   ASC_WindowRec_subType threestate
   IOgrp      VCCU
   actCycle   028:00
   actStatus  alive
   autoReadReg 4_reqStatus
   cmdIcon    up:fts_shutter_up stop:fts_shutter_manual down:fts_shutter_down
   devStateIcon (0).*:fts_shutter_100 (8$|9$|1[0-8]$).*:fts_shutter_90 (18|19|2[0-8]).*:fts_shutter_80 (28|29|3[0-8]).*:fts_shutter_70 (38|39|4[0-8]).*:fts_shutter_60 (48|49|5[0-8]).*:fts_shutter_50 (58|59|6[0-8]).*:fts_shutter_40 (68|69|7[0-8]).*:fts_shutter_30 (78|79|8[0-8]).*:fts_shutter_20 (88|89|9[0-8]).*:fts_shutter_10 (100):fts_shutter_0
   event-on-change-reading pct
   eventMap   on:100% off:0%
   expert     defReg,rawReg
   firmware   2.11
   group      Rollladen
   icon       fts_shutter_updown
   model      HM-LC-BL1PBU-FM
   peerIDs    00000000
   room       HomeMatic,Rollladen
   serialNr   NEQ1215071
   stateFormat pct
   subType    blindActuator
   userattr   ASC_Adv:on,off 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_beforeDayOpen ASC_BlockingTime_beforeNightClose 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_CommandTemplate ASC_Down:time,astro,brightness,roommate ASC_DriveUpMaxDuration ASC_Drive_Delay ASC_Drive_DelayStart ASC_ExternalTrigger 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_PrivacyDownValue_beforeNightClose ASC_PrivacyDown_Pos ASC_PrivacyUpValue_beforeDayOpen ASC_PrivacyUp_Pos ASC_RainProtection:on,off ASC_Roommate_Device ASC_Roommate_Reading ASC_Self_Defense_AbsentDelay ASC_Self_Defense_Mode:absent,gone,off ASC_Shading_BetweenTheTime ASC_Shading_InOutAzimuth 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_SunnyCloudy ASC_Shading_WaitingPeriod ASC_Shutter_IdleDetection ASC_ShuttersPlace:window,terrace,awning,EG_window ASC_SlatPosCmd_SlatDevice ASC_Sleep_Pos:0,10,20,30,40,50,60,70,80,90,100 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 room_map structexclude
   webCmd     pct:up:stop:down

Aber alle anderen Rollladen haben auch das Problem, das ich sie nicht fahren kann und das pct reading nicht stimmt.

Mache ich ein set HMUART_EG close, dann kann ich die Rollladen rudimentär dank VCCU und alternativen IO fahren (rudimentär nur, weil meine zweite IO per WLAN angebunden ist und die meisten Devices nur schlecht empfängt)

frank · 13 Februar 2022, 14:42:26

also hast du 2 io.
da es im device kein internal LASTInputDev gibt, hat seit fhem restart kein io vom device etwas gehört.

ZitatAlso das ist nicht gerätespezifisch

dann sendet vermutlich HMUART_EG nichts mehr, oder so leise, so dass kein rollo davon etwas hört.
=> defekt, antennenproblem, störfelder, ....

ich würde mal das 2. io in die nähe des anderen io bringen, ebenfalls attr logIDs setzen, und den cmd erneut auslösen.
wenn das defekte io sendet, dann müssten die raw messages vom 2. io empfangen werden und im log auftauchen.

Kai-Alfonso · 13 Februar 2022, 18:12:00

Nachdem ich, wie du gesagt hast, mein zweites IO in die Nähe des ersten IO gebracht hatte, hab ich erstmal andere Sachen gemacht - jetzt bin ich wieder zu Hause und plötzlich geht das erste IO auch wieder. Wirklich komisch, aber ich seh es jetzt bei LastInputDevice und die Aktoren haben wieder ein gefülltes HMUART_EG_RSSI Reading.

Echt merkwürdig - aber ich würde erstmal sagen, das es erledigt ist. Danke für Deine Hilfe