FHEM Forum

FHEM - Hausautomations-Systeme => Unterstützende Dienste => Thema gestartet von: jove01 am 21 Mai 2019, 13:31:46

Titel: AMAD: transmitterERROR AMADBridge
Beitrag von: jove01 am 21 Mai 2019, 13:31:46
Hallo

Ich kann nicht beurteilen, seit wann mein bisherige Tablet-Anbindung nicht mehr funktioniert, auf jeden Fall funktioniert es nicht mehr.

Ich habe im Fhem die Bridge und das Tablet gelöscht. Auf dem Tablet die Amad-Gruppe gelöscht. Dann im Fhem die Bridge angelegt, auf dem Tablet die aktuellste XML importiert, den First-Run durchgeführt. Danach bekomme ich in der Bridge die Meldung transmitterERROR AMADBridge.

Die Bridge

Internals:
   BRIDGE     1
   CFGFN     
   CONNECTS   65
   FD         23
   FUUID      5ce3dd3a-f33f-594c-76f6-3f6c330c1a5d7ca0
   FVERSION   73_AMADCommBridge.pm:0.193530/2019-05-08
   NAME       AMADBridge
   NR         6706
   PORT       8090
   STATE      opened
   TYPE       AMADCommBridge
   VERSIONFLOWSET 4.4.1
   VERSIONMODUL 4.4.1
   Helper:
     DBLOG:
       state:
         myDbLog:
           TIME       1558437178.64093
           VALUE      opened
   READINGS:
     2019-05-21 13:12:58   state           opened
     2019-05-21 13:26:11   transmitterERROR AMADBridge_192.168.178.21_33716 has no correct amad_id
Attributes:
   DbLogExclude .*
   fhemServerIP 192.168.178.107
   room       AMAD


Die Log-Meldung verbose 3

2019.05.21 13:16:13 1: ERROR: empty name in readingsBeginUpdate
2019.05.21 13:16:13 1: stacktrace:
2019.05.21 13:16:13 1:     main::readingsBeginUpdate           called by fhem.pl (4910)
2019.05.21 13:16:13 1:     main::readingsSingleUpdate          called by ./FHEM/74_AMADDevice.pm (501)
2019.05.21 13:16:13 1:     FHEM::AMADDevice::WriteReadings     called by ./FHEM/74_AMADDevice.pm (1000)
2019.05.21 13:16:13 1:     FHEM::AMADDevice::Parse             called by fhem.pl (3945)
2019.05.21 13:16:13 1:     main::Dispatch                      called by ./FHEM/73_AMADCommBridge.pm (1028)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::ResponseProcessing called by ./FHEM/73_AMADCommBridge.pm (910)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::ProcessRead   called by ./FHEM/73_AMADCommBridge.pm (809)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::Read          called by fhem.pl (3749)
2019.05.21 13:16:13 1:     main::CallFn                        called by fhem.pl (748)
2019.05.21 13:16:13 1: readingsUpdate(,state,active) missed to call readingsBeginUpdate first.
2019.05.21 13:16:13 1: stacktrace:
2019.05.21 13:16:13 1:     main::readingsBulkUpdate            called by fhem.pl (4911)
2019.05.21 13:16:13 1:     main::readingsSingleUpdate          called by ./FHEM/74_AMADDevice.pm (501)
2019.05.21 13:16:13 1:     FHEM::AMADDevice::WriteReadings     called by ./FHEM/74_AMADDevice.pm (1000)
2019.05.21 13:16:13 1:     FHEM::AMADDevice::Parse             called by fhem.pl (3945)
2019.05.21 13:16:13 1:     main::Dispatch                      called by ./FHEM/73_AMADCommBridge.pm (1028)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::ResponseProcessing called by ./FHEM/73_AMADCommBridge.pm (910)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::ProcessRead   called by ./FHEM/73_AMADCommBridge.pm (809)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::Read          called by fhem.pl (3749)
2019.05.21 13:16:13 1:     main::CallFn                        called by fhem.pl (748)
2019.05.21 13:16:13 1: ERROR: empty name in readingsBeginUpdate
2019.05.21 13:16:13 1: stacktrace:
2019.05.21 13:16:13 1:     main::readingsBeginUpdate           called by ./FHEM/74_AMADDevice.pm (509)
2019.05.21 13:16:13 1:     FHEM::AMADDevice::WriteReadings     called by ./FHEM/74_AMADDevice.pm (1000)
2019.05.21 13:16:13 1:     FHEM::AMADDevice::Parse             called by fhem.pl (3945)
2019.05.21 13:16:13 1:     main::Dispatch                      called by ./FHEM/73_AMADCommBridge.pm (1028)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::ResponseProcessing called by ./FHEM/73_AMADCommBridge.pm (910)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::ProcessRead   called by ./FHEM/73_AMADCommBridge.pm (809)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::Read          called by fhem.pl (3749)
2019.05.21 13:16:13 1:     main::CallFn                        called by fhem.pl (748)
2019.05.21 13:16:13 1: readingsUpdate(,lastStatusRequestState,statusRequest_done) missed to call readingsBeginUpdate first.
2019.05.21 13:16:13 1: stacktrace:
2019.05.21 13:16:13 1:     main::readingsBulkUpdate            called by fhem.pl (4747)
2019.05.21 13:16:13 1:     main::readingsBulkUpdateIfChanged   called by ./FHEM/74_AMADDevice.pm (554)
2019.05.21 13:16:13 1:     FHEM::AMADDevice::WriteReadings     called by ./FHEM/74_AMADDevice.pm (1000)
2019.05.21 13:16:13 1:     FHEM::AMADDevice::Parse             called by fhem.pl (3945)
2019.05.21 13:16:13 1:     main::Dispatch                      called by ./FHEM/73_AMADCommBridge.pm (1028)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::ResponseProcessing called by ./FHEM/73_AMADCommBridge.pm (910)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::ProcessRead   called by ./FHEM/73_AMADCommBridge.pm (809)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::Read          called by fhem.pl (3749)
2019.05.21 13:16:13 1:     main::CallFn                        called by fhem.pl (748)
2019.05.21 13:16:13 1: readingsUpdate(,mute,off) missed to call readingsBeginUpdate first.
2019.05.21 13:16:13 1: stacktrace:
2019.05.21 13:16:13 1:     main::readingsBulkUpdate            called by fhem.pl (4747)
2019.05.21 13:16:13 1:     main::readingsBulkUpdateIfChanged   called by ./FHEM/74_AMADDevice.pm (557)
2019.05.21 13:16:13 1:     FHEM::AMADDevice::WriteReadings     called by ./FHEM/74_AMADDevice.pm (1000)
2019.05.21 13:16:13 1:     FHEM::AMADDevice::Parse             called by fhem.pl (3945)
2019.05.21 13:16:13 1:     main::Dispatch                      called by ./FHEM/73_AMADCommBridge.pm (1028)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::ResponseProcessing called by ./FHEM/73_AMADCommBridge.pm (910)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::ProcessRead   called by ./FHEM/73_AMADCommBridge.pm (809)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::Read          called by fhem.pl (3749)
2019.05.21 13:16:13 1:     main::CallFn                        called by fhem.pl (748)
2019.05.21 13:16:13 1: ERROR: empty name in readingsBeginUpdate
2019.05.21 13:16:13 1: stacktrace:
2019.05.21 13:16:13 1:     main::readingsBeginUpdate           called by fhem.pl (4910)
2019.05.21 13:16:13 1:     main::readingsSingleUpdate          called by ./FHEM/74_AMADDevice.pm (501)
2019.05.21 13:16:13 1:     FHEM::AMADDevice::WriteReadings     called by ./FHEM/74_AMADDevice.pm (1000)
2019.05.21 13:16:13 1:     FHEM::AMADDevice::Parse             called by fhem.pl (3972)
2019.05.21 13:16:13 1:     main::Dispatch                      called by ./FHEM/73_AMADCommBridge.pm (1028)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::ResponseProcessing called by ./FHEM/73_AMADCommBridge.pm (910)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::ProcessRead   called by ./FHEM/73_AMADCommBridge.pm (809)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::Read          called by fhem.pl (3749)
2019.05.21 13:16:13 1:     main::CallFn                        called by fhem.pl (748)
2019.05.21 13:16:13 1: readingsUpdate(,state,active) missed to call readingsBeginUpdate first.
2019.05.21 13:16:13 1: stacktrace:
2019.05.21 13:16:13 1:     main::readingsBulkUpdate            called by fhem.pl (4911)
2019.05.21 13:16:13 1:     main::readingsSingleUpdate          called by ./FHEM/74_AMADDevice.pm (501)
2019.05.21 13:16:13 1:     FHEM::AMADDevice::WriteReadings     called by ./FHEM/74_AMADDevice.pm (1000)
2019.05.21 13:16:13 1:     FHEM::AMADDevice::Parse             called by fhem.pl (3972)
2019.05.21 13:16:13 1:     main::Dispatch                      called by ./FHEM/73_AMADCommBridge.pm (1028)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::ResponseProcessing called by ./FHEM/73_AMADCommBridge.pm (910)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::ProcessRead   called by ./FHEM/73_AMADCommBridge.pm (809)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::Read          called by fhem.pl (3749)
2019.05.21 13:16:13 1:     main::CallFn                        called by fhem.pl (748)
2019.05.21 13:16:13 1: ERROR: empty name in readingsBeginUpdate
2019.05.21 13:16:13 1: stacktrace:
2019.05.21 13:16:13 1:     main::readingsBeginUpdate           called by ./FHEM/74_AMADDevice.pm (509)
2019.05.21 13:16:13 1:     FHEM::AMADDevice::WriteReadings     called by ./FHEM/74_AMADDevice.pm (1000)
2019.05.21 13:16:13 1:     FHEM::AMADDevice::Parse             called by fhem.pl (3972)
2019.05.21 13:16:13 1:     main::Dispatch                      called by ./FHEM/73_AMADCommBridge.pm (1028)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::ResponseProcessing called by ./FHEM/73_AMADCommBridge.pm (910)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::ProcessRead   called by ./FHEM/73_AMADCommBridge.pm (809)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::Read          called by fhem.pl (3749)
2019.05.21 13:16:13 1:     main::CallFn                        called by fhem.pl (748)
2019.05.21 13:16:13 1: readingsUpdate(,lastStatusRequestState,statusRequest_done) missed to call readingsBeginUpdate first.
2019.05.21 13:16:13 1: stacktrace:
2019.05.21 13:16:13 1:     main::readingsBulkUpdate            called by fhem.pl (4747)
2019.05.21 13:16:13 1:     main::readingsBulkUpdateIfChanged   called by ./FHEM/74_AMADDevice.pm (554)
2019.05.21 13:16:13 1:     FHEM::AMADDevice::WriteReadings     called by ./FHEM/74_AMADDevice.pm (1000)
2019.05.21 13:16:13 1:     FHEM::AMADDevice::Parse             called by fhem.pl (3972)
2019.05.21 13:16:13 1:     main::Dispatch                      called by ./FHEM/73_AMADCommBridge.pm (1028)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::ResponseProcessing called by ./FHEM/73_AMADCommBridge.pm (910)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::ProcessRead   called by ./FHEM/73_AMADCommBridge.pm (809)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::Read          called by fhem.pl (3749)
2019.05.21 13:16:13 1:     main::CallFn                        called by fhem.pl (748)
2019.05.21 13:16:13 1: readingsUpdate(,mute,off) missed to call readingsBeginUpdate first.
2019.05.21 13:16:13 1: stacktrace:
2019.05.21 13:16:13 1:     main::readingsBulkUpdate            called by fhem.pl (4747)
2019.05.21 13:16:13 1:     main::readingsBulkUpdateIfChanged   called by ./FHEM/74_AMADDevice.pm (557)
2019.05.21 13:16:13 1:     FHEM::AMADDevice::WriteReadings     called by ./FHEM/74_AMADDevice.pm (1000)
2019.05.21 13:16:13 1:     FHEM::AMADDevice::Parse             called by fhem.pl (3972)
2019.05.21 13:16:13 1:     main::Dispatch                      called by ./FHEM/73_AMADCommBridge.pm (1028)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::ResponseProcessing called by ./FHEM/73_AMADCommBridge.pm (910)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::ProcessRead   called by ./FHEM/73_AMADCommBridge.pm (809)
2019.05.21 13:16:13 1:     FHEM::AMADCommBridge::Read          called by fhem.pl (3749)
2019.05.21 13:16:13 1:     main::CallFn                        called by fhem.pl (748)


Hinweis: Bei den ersten Aktionen in Automgic habe ich für das Tablet eine falsche IP verwendet. In der Bridge steht bei der Meldung die korrekt eingegebene.

Beim Tablet handelt es sich um Acer B3-A30 mit Android 6.0.

Danke

Jürgen
Titel: Antw:AMAD: transmitterERROR AMADBridge
Beitrag von: CoolTux am 21 Mai 2019, 15:56:01
Du musst denke ich noch die ganzen globalen Variablen in Automagic löschen und dann FirstRun noch einmal aus führen.
Titel: Antw:AMAD: transmitterERROR AMADBridge
Beitrag von: jove01 am 21 Mai 2019, 17:25:08
Hallo CoolTux

leider hat das Löschen der globalen Variablen auch nicht geholfen.
Nach dem First Run sind sie dann wieder gefüllt.

Woher kommt in den globalen Variablen die "global_amadid. Hierbei handelt es sich  um eine Nummer mit 979 am Ende sowie sowie aktuelles Datum und Uhrzeit mit 979 am Ende.

Diese 979 scheint sich nicht zu ändern.

Ich hoffe, du hast noch eine Idee.

Danke
Jürgen
Titel: Antw:AMAD: transmitterERROR AMADBridge
Beitrag von: CoolTux am 21 Mai 2019, 17:27:16
Das ist eigentlich eine Zeitangabe in Unixtime. Diese ist ja einmalig so zu sagen.
Ist die Fehlermeldung immer noch die selbe?
Hast Du FHEM mal neugestartet?
Titel: Antw:AMAD: transmitterERROR AMADBridge
Beitrag von: jove01 am 21 Mai 2019, 17:39:32
Alles wieder gelöscht, Fhem neu gestartet
Alles neu angelegt
und wieder

transmitterERROR
   
AMADBridge_192.168.178.21_33630 has no correct amad_id
Titel: Antw:AMAD: transmitterERROR AMADBridge
Beitrag von: CoolTux am 21 Mai 2019, 17:54:26
Zeige mal bitte ein Screen Deine globalen Variablen.
Titel: Antw:AMAD: transmitterERROR AMADBridge
Beitrag von: jove01 am 21 Mai 2019, 18:09:46
ging leider nur über Handyphto (auf dem Acer k.A. wie ein screenshot erstellt wird und kein Mail.)

Titel: Antw:AMAD: transmitterERROR AMADBridge
Beitrag von: CoolTux am 21 Mai 2019, 18:30:01
Versuch mal von Hand an zu legen


define TABLETNAME AMADDevice TABLETIP AMADID Automagic


Bei der amadid nimmst nur die oberen Zahlen also die 8 Stellungen oder wie viele das auch sind.
Titel: Antw:AMAD: transmitterERROR AMADBridge
Beitrag von: jove01 am 21 Mai 2019, 19:21:26
Hallo CoolTux

das hat wohl etwas geholfen, jedoch bleibt in der Bridge der Fehler transmitterERROR vorhanden.

Im Device funktioniert der statusRequest

jedoch sonstige Sets erzeugen einen setCmd_error. In Automagic bleibt der Flow SetCommands rot. Im Log steht


Titel: Antw:AMAD: transmitterERROR AMADBridge
Beitrag von: CoolTux am 21 Mai 2019, 19:28:40
Versuch mal die amadid auf dem Tablet so zu stellen das nur die 13 Stellingen Zahl da ist.
Titel: Antw:AMAD: transmitterERROR AMADBridge
Beitrag von: jove01 am 21 Mai 2019, 20:00:23
Der Fehler in der Bridge wird weiterhin angezeigt, scheint aber keine Auswirkung zu haben.

In Autommagic bleibt der Flow SetCommands weiterihn rot, dass Ausführungsdatum ändert sich nicht.

In Fhem wird in den Readings aktiv/inaktiv korrekt (mit Verspätung) angezeigt.

In Automagic habe ich im Flow die Option "Parallele Ausführung ..." gesetzt. In der Folge ändert sich die Zeitangabe im Flow.

Titel: Antw:AMAD: transmitterERROR AMADBridge
Beitrag von: CoolTux am 21 Mai 2019, 20:04:08
Zitat von: jove01 am 21 Mai 2019, 20:00:23
Der Fehler in der Bridge wird weiterhin angezeigt, scheint aber keine Auswirkung zu haben.

In Autommagic bleibt der Flow SetCommands weiterihn rot, dass Ausführungsdatum ändert sich nicht.

In Fhem wird in den Readings aktiv/inaktiv korrekt (mit Verspätung) angezeigt.

In Automagic habe ich im Flow die Option "Parallele Ausführung ..." gesetzt. In der Folge ändert sich die Zeitangabe im Flow.

Was bedeutet weiterhin angezeigt? Ändert sich denn der Timestamp bei dem Reading oder bleibt der.
Kannst Du nun Befehle senden? Gib mal bitte ein list vom Device und von der Bridge
Titel: Antw:AMAD: transmitterERROR AMADBridge
Beitrag von: jove01 am 21 Mai 2019, 20:27:06
Zuerst die List


Internals:
   AMADBridge_MSGCNT 288
   AMADBridge_TIME 2019-05-21 20:16:51
   AMAD_ID    1558457251129
   CHANGED   
   DEF        192.168.178.21 1558457251129 Automagic
   FUUID      5ce42d2a-f33f-594c-720a-26ed2d5cf2317270
   FVERSION   74_AMADDevice.pm:0.193570/2019-05-09
   HOST       192.168.178.21
   IODev      AMADBridge
   LASTInputDev AMADBridge
   MODEL      Automagic
   MSGCNT     288
   NAME       Fhem_Tab_WZ
   NOTIFYDEV  global,Fhem_Tab_WZ,AMADBridge
   NR         881
   NTFY_ORDER 50-Fhem_Tab_WZ
   PORT       8090
   STATE      active
   TYPE       AMADDevice
   VERSIONFLOWSET 4.4.1
   VERSIONMODUL 4.4.1
   READINGS:
     2019-05-21 18:54:03   airplanemode    off
     2019-05-21 18:54:03   androidVersion  6.0 Marshmallow
     2019-05-21 18:54:03   batteryHealth   2
     2019-05-21 20:09:49   batteryPercent  40
     2019-05-21 19:40:29   batteryTemperature 29.0
     2019-05-21 18:54:03   bluetooth       off
     2019-05-21 18:54:50   checkActiveTask 0
     2019-05-21 18:54:03   connectedBTdevices none
     2019-05-21 18:54:03   connectedBTdevicesMAC none
     2019-05-21 18:54:06   currentMusicAlbum no player active
     2019-05-21 18:54:06   currentMusicApp no player active
     2019-05-21 18:54:06   currentMusicArtist no player active
     2019-05-21 18:54:06   currentMusicIcon no player active
     2019-05-21 18:54:06   currentMusicTrack no player active
     2019-05-21 19:41:18   deviceState     online
     2019-05-21 18:54:05   doNotDisturb    always
     2019-05-21 18:54:03   dockingState    undocked
     2019-05-21 19:46:51   flow_SetCommands aktiv
     2019-05-21 18:54:03   flow_informations aktiv
     2019-05-21 18:54:03   flowsetVersionAtDevice 4.4.1
     2019-05-21 18:54:05   keyguardSet     0
     2019-05-21 19:34:23   lastSetCommandError
     2019-05-21 20:06:48   lastSetCommandState setCmd_done
     2019-05-21 20:06:50   lastStatusRequestState statusRequest_done
     2019-05-21 18:54:03   mute            off
     2019-05-21 18:54:03   nextAlarmDay    off
     2019-05-21 18:54:03   nextAlarmTime   off
     2019-05-21 18:54:03   powerPlugged    0
     2019-05-21 18:54:06   screen          on unlocked
     2019-05-21 19:52:57   screenBrightness 31
     2019-05-21 19:53:13   screenOrientation portrait
     2019-05-21 18:54:06   screenOrientationMode auto
     2019-05-21 19:54:51   state           active
     2019-05-21 18:54:03   volume          15
     2019-05-21 18:54:03   volumeNotification 7
     2019-05-21 18:54:03   wiredHeadsetPlugged 0
   helper:
     deviceStateErrorCounter 0
     infoErrorCounter 0
     setCmdErrorCounter 0
Attributes:
   DbLogExclude .*
   IODev      AMADBridge
   remoteServer Automagic
   room       AMAD


Parallel dazu das Foto von Automagic.


Internals:
   BRIDGE     1
   CONNECTS   678
   FD         16
   FUUID      5ce42b37-f33f-594c-f1df-1a146f3b3b3d3193
   FVERSION   73_AMADCommBridge.pm:0.193530/2019-05-08
   NAME       AMADBridge
   NR         880
   PORT       8090
   STATE      opened
   TYPE       AMADCommBridge
   VERSIONFLOWSET 4.4.1
   VERSIONMODUL 4.4.1
   READINGS:
     2019-05-21 19:06:48   state           opened
     2019-05-21 18:52:50   transmitterERROR AMADBridge_192.168.178.21_50673 has no correct amad_id
Attributes:
   DbLogExclude .*
   fhemServerIP 192.168.178.107
   room       AMAD


Ein Screen set off/on hat jetzt funktioniert mit der Option "parallel .." Die Anzeige des Flows bleibt rot.

Wenn du das als nicht kritisch ansiehst, würde ich vorerst so belassen und nur weiter beobachten.
Titel: Antw:AMAD: transmitterERROR AMADBridge
Beitrag von: CoolTux am 21 Mai 2019, 20:35:35
Öffne mal bitte den Flow und schaue wo er hängt.
Ausserdem stimmt die amadid nicht mit dem Foto von oben. Hast du wahrscheinlich noch mal geändert?
Der Timestamp vom Reading transmitterERROR scheint jedenfalls älter.

Parallel ist schlecht. Bitte wieder zurück stellen.
Titel: [gelöst] Antw:AMAD: transmitterERROR AMADBridge
Beitrag von: jove01 am 21 Mai 2019, 20:36:03
Hallo CoolTux

mit einem Restart des Tablets wird der Flow jetzt auch korrekt angezeigt.

Vielen Dank für die tolle Unterstützung.

Gruß
Jürgen
Titel: Antw:AMAD: transmitterERROR AMADBridge
Beitrag von: CoolTux am 21 Mai 2019, 20:36:56
Super. Hoffe das läuft nun stabil.


Grüße