Onkyo AVR schreibt Logfile voll

Begonnen von blade-of-fire, 27 Januar 2015, 22:01:18

Vorheriges Thema - Nächstes Thema

blade-of-fire

Hallo zusammen,

ich habe ein Problem mit meinem Onkyo AVR. Der AVR wird alle 60 Sekunden über seinen Status abgefragt. Bei jeder Abfrage kommt immer zuerst die Meldung, dass er nicht erreichbar ist, danach unmittelbar die Meldung, dass er erreichbar ist. Somit wird das Logfile vollgeschrieben:
ONKYO_AVR device Wohnzimmer_Hifi_AVR_Onkyo is unavailable
2015.01.27 21:49:16 3: ONKYO_AVR device Wohnzimmer_Hifi_AVR_Onkyo is available
2015.01.27 21:50:15 3: ONKYO_AVR device Wohnzimmer_Hifi_AVR_Onkyo is unavailable
2015.01.27 21:50:15 3: ONKYO_AVR device Wohnzimmer_Hifi_AVR_Onkyo is available
2015.01.27 21:51:16 3: ONKYO_AVR device Wohnzimmer_Hifi_AVR_Onkyo is unavailable
2015.01.27 21:51:16 3: ONKYO_AVR device Wohnzimmer_Hifi_AVR_Onkyo is available
2015.01.27 21:52:16 3: ONKYO_AVR device Wohnzimmer_Hifi_AVR_Onkyo is unavailable
2015.01.27 21:52:16 3: ONKYO_AVR device Wohnzimmer_Hifi_AVR_Onkyo is available
2015.01.27 21:53:15 3: ONKYO_AVR device Wohnzimmer_Hifi_AVR_Onkyo is unavailable
2015.01.27 21:53:16 3: ONKYO_AVR device Wohnzimmer_Hifi_AVR_Onkyo is available


Der AVR wurde wie folgt definiert:
define Wohnzimmer_Hifi_AVR_Onkyo ONKYO_AVR 192.168.178.24 pre2013 main 60
attr Wohnzimmer_Hifi_AVR_Onkyo devStateIcon on:rc_GREEN:off off:rc_STOP:on absent:rc_RED
attr Wohnzimmer_Hifi_AVR_Onkyo fp_Grundriss 300,250,2,
attr Wohnzimmer_Hifi_AVR_Onkyo model pre2013
attr Wohnzimmer_Hifi_AVR_Onkyo room Wohnzimmer
attr Wohnzimmer_Hifi_AVR_Onkyo webCmd volume:mute:input


Kann mir jemand sagen, woran das Togglen des Status' liegt, wie ich es beseitigen oder unterdrücken kann?
Ansonsten funktioniert der AVR ohne Probleme.

Danke :)
VM mit Ubuntu und FHEM-Instanz (Hauptinstanz)
FHEM2FHEM
Raspberry Pi 3 B+ mit Eigenbau-Platine + Relais-Platine + Cul-Stick + FHEMDuino

Loredo

Schau bitte mal in das Logfile, nachdem du das Attribut verbose auf 5 gesetzt hast. Daraus dürfte dir ziemlich schnell ersichtlich sein, weshalb der Status sofort wieder auf unavailable wechselt.


Vermutung: Nachdem der Receiver als available erkannt wurde, werden eine Reihe von weiteren Abfragen losgetreten, um den Gesamtstatus zu erfassen. Eine dieser Abfragen beantwortet der Receiver nicht, falsch oder nicht in der angemessenen Zeit, wodurch der Receiver dann wieder als unavailable eingestuft wird.
Hat meine Arbeit dir geholfen? ⟹ https://paypal.me/pools/c/8gDLrIWrG9

Maintainer:
FHEM-Docker Image, https://github.com/fhem, Astro(Co-Maintainer), ENIGMA2, GEOFANCY, GUEST, HP1000, Installer, LaMetric2, MSG, msgConfig, npmjs, PET, PHTV, Pushover, RESIDENTS, ROOMMATE, search, THINKINGCLEANER

blade-of-fire

Ich habe das Logging auf Verbose 5 gestellt und folgende Meldungen erhalten
ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo: called function ONKYO_AVR_GetStatus()
2015.01.27 22:46:01 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo: called function ONKYO_AVR_SendCommand()
2015.01.27 22:46:01 4: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): power -> query (PWRQSTN)
[...]
2015.01.27 22:46:01 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): 192.168.178.24:60128 snd 49534350000000100000000a0100000021315057525153544e0d ISCP............!1PWRQSTN.
[...]
2015.01.27 22:46:01 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): 192.168.178.24:60128 rcv 49534350000000100000000a01000000213150575230311a0d0a ISCP............!1PWR01...
2015.01.27 22:46:01 4: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): PWRQSTN return value '01' converted through VALUE from HASH table to 'on'
2015.01.27 22:46:01 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo: called function ONKYO_AVR_SendCommand()
2015.01.27 22:46:01 4: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): mute -> query (AMTQSTN)
2015.01.27 22:46:01 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): 192.168.178.24:60128 snd 49534350000000100000000a010000002131414d545153544e0d ISCP............!1AMTQSTN.
[...]
2015.01.27 22:46:01 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): 192.168.178.24:60128 rcv 49534350000000100000000a010000002131414d5430301a0d0a ISCP............!1AMT00...
2015.01.27 22:46:01 4: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): AMTQSTN return value '00' converted through VALUE from HASH table to 'off'
2015.01.27 22:46:01 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo: called function ONKYO_AVR_SendCommand()
2015.01.27 22:46:01 5: in ack loop
[...]
2015.01.27 22:46:01 4: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): volume -> query (MVLQSTN)
[...]
2015.01.27 22:46:01 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): 192.168.178.24:60128 snd 49534350000000100000000a0100000021314d564c5153544e0d ISCP............!1MVLQSTN.
[...]
2015.01.27 22:46:01 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): 192.168.178.24:60128 rcv 49534350000000100000000a0100000021314d564c30381a0d0a ISCP............!1MVL08...
2015.01.27 22:46:01 4: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): MVLQSTN return value '08' converted from HEX to DEC
2015.01.27 22:46:01 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo: called function ONKYO_AVR_SendCommand()
2015.01.27 22:46:01 4: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): sleep -> query (SLPQSTN)
2015.01.27 22:46:01 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): 192.168.178.24:60128 snd 49534350000000100000000a010000002131534c505153544e0d ISCP............!1SLPQSTN.
2015.01.27 22:46:01 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): 192.168.178.24:60128 rcv 49534350000000100000000a010000002131534c5030301a0d0a ISCP............!1SLP00...
2015.01.27 22:46:01 4: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): SLPQSTN return value '00' converted through VALUE from HASH table to 'off'
2015.01.27 22:46:01 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo: called function ONKYO_AVR_SendCommand()
2015.01.27 22:46:01 4: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): input -> query (SLIQSTN)
2015.01.27 22:46:01 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): 192.168.178.24:60128 snd 49534350000000100000000a010000002131534c495153544e0d ISCP............!1SLIQSTN.
[...]
2015.01.27 22:46:02 5: in ack loop
[...]
2015.01.27 22:46:02 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): 192.168.178.24:60128 rcv 49534350000000100000000a010000002131534c4930301a0d0a ISCP............!1SLI00...
2015.01.27 22:46:02 4: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): SLIQSTN return value '00' converted through ARRAY from HASH table to 'video1'
2015.01.27 22:46:02 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo: called function ONKYO_AVR_SendCommand()
2015.01.27 22:46:02 4: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): video-information -> query (IFVQSTN)
2015.01.27 22:46:02 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): 192.168.178.24:60128 snd 49534350000000100000000a0100000021314946565153544e0d ISCP............!1IFVQSTN.
[...]
2015.01.27 22:46:06 3: ONKYO_AVR device Wohnzimmer_Hifi_AVR_Onkyo is unavailable
2015.01.27 22:46:06 5: Triggering Wohnzimmer_Hifi_AVR_Onkyo (1 changes)
2015.01.27 22:46:06 5: Notify loop for Wohnzimmer_Hifi_AVR_Onkyo presence: absent
2015.01.27 22:46:06 5: Device_MilightBridge_Notify: Triggered by Wohnzimmer_Hifi_AVR_Onkyo; presence: absent
2015.01.27 22:46:06 4: eventTypes: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo presence: absent -> presence: absent
2015.01.27 22:46:06 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo: called function ONKYO_AVR_SendCommand()
2015.01.27 22:46:06 4: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): audio-information -> query (IFAQSTN)
2015.01.27 22:46:06 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): 192.168.178.24:60128 snd 49534350000000100000000a0100000021314946415153544e0d ISCP............!1IFAQSTN.
2015.01.27 22:46:06 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): 192.168.178.24:60128 rcv 49534350000000100000003a01000000213149464148444d4920322c50434d2c3438206b487a2c322e302063682c446f6c627920504c494978204d6f7669652c372e312063682c1a0d0a ISCP.......:....!1IFAHDMI 2,PCM,48 kHz,2.0 ch,Dolby PLIIx Movie,7.1 ch,...
2015.01.27 22:46:06 3: ONKYO_AVR device Wohnzimmer_Hifi_AVR_Onkyo is available
2015.01.27 22:46:06 4: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): IFAQSTN unconverted return of value 'HDMI 2,PCM,48 kHz,2.0 ch,Dolby PLIIx Movie,7.1 ch,'
2015.01.27 22:46:06 5: Triggering Wohnzimmer_Hifi_AVR_Onkyo (1 changes)
2015.01.27 22:46:06 5: Notify loop for Wohnzimmer_Hifi_AVR_Onkyo presence: present
2015.01.27 22:46:06 5: Device_MilightBridge_Notify: Triggered by Wohnzimmer_Hifi_AVR_Onkyo; presence: present
2015.01.27 22:46:06 4: eventTypes: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo presence: present -> presence: present
2015.01.27 22:46:06 4: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo: on
[...]


Leider kann ich mit den Informationen nicht viel anfangen  ::)
VM mit Ubuntu und FHEM-Instanz (Hauptinstanz)
FHEM2FHEM
Raspberry Pi 3 B+ mit Eigenbau-Platine + Relais-Platine + Cul-Stick + FHEMDuino

Loredo

Kann es sein, dass das kein AV Receiver ist, sondern nur ein normaler Verstärker?
Der Receiver antwortet nicht auf die Anfrage, wie der Status seiner Bildschirmausgabe ist


Zitat von: blade-of-fire am 27 Januar 2015, 22:56:16
2015.01.27 22:46:02 4: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): video-information -> query (IFVQSTN)
2015.01.27 22:46:02 5: ONKYO_AVR Wohnzimmer_Hifi_AVR_Onkyo(main): 192.168.178.24:60128 snd 49534350000000100000000a0100000021314946565153544e0d ISCP............!1IFVQSTN.
[...]
2015.01.27 22:46:06 3: ONKYO_AVR device Wohnzimmer_Hifi_AVR_Onkyo is unavailable
Hat meine Arbeit dir geholfen? ⟹ https://paypal.me/pools/c/8gDLrIWrG9

Maintainer:
FHEM-Docker Image, https://github.com/fhem, Astro(Co-Maintainer), ENIGMA2, GEOFANCY, GUEST, HP1000, Installer, LaMetric2, MSG, msgConfig, npmjs, PET, PHTV, Pushover, RESIDENTS, ROOMMATE, search, THINKINGCLEANER

blade-of-fire

Doch, es ist ein Onkyo TX NR 509
(http://bilder.hifi-forum.de/medium/442322/onkyo-tx-nr-509_58007.jpg)
mit HDMI und grafischer Ausgabe am TV. Diese ist für heutige Verhältnisse zwar sehr spartanisch, aber tut ihren Zweck (Anzeige von Lautstärkeänderung und Konfiguration)
VM mit Ubuntu und FHEM-Instanz (Hauptinstanz)
FHEM2FHEM
Raspberry Pi 3 B+ mit Eigenbau-Platine + Relais-Platine + Cul-Stick + FHEMDuino

Loredo

Zitat von: blade-of-fire am 27 Januar 2015, 23:08:56
Doch, es ist ein Onkyo TX NR 509


Nutzt halt nix, wenn er auf das Kommando IFVQSTN nicht richtig antwortet...
Hat meine Arbeit dir geholfen? ⟹ https://paypal.me/pools/c/8gDLrIWrG9

Maintainer:
FHEM-Docker Image, https://github.com/fhem, Astro(Co-Maintainer), ENIGMA2, GEOFANCY, GUEST, HP1000, Installer, LaMetric2, MSG, msgConfig, npmjs, PET, PHTV, Pushover, RESIDENTS, ROOMMATE, search, THINKINGCLEANER

blade-of-fire

So, ich habe die Zeile im Onkyo Modul jetzt mal auskommentiert:

#            $states->{video} =
#              ONKYO_AVR_SendCommand( $hash, "video-information", "query" )
#              if ( $zone eq "main" );


Bisher kommt keine der oben genannten Meldungen mehr. Alle Informationen (natürlich abgesehen von den VIdeo-Infos) werden angezeigt. Mal sehen, ob das nun auf längere Sicht zu keinen Problemen führt.

Ich nehme an, dass mein Onkyo diese Informationen einfach noch nicht zur Verfügung stellen kann (ist ja nicht mehr der Jüngste). Aber wenn es so funktiuoniert, dann bin ich doch super zufrieden.

Vielen Dank für die Mühe  ;D
VM mit Ubuntu und FHEM-Instanz (Hauptinstanz)
FHEM2FHEM
Raspberry Pi 3 B+ mit Eigenbau-Platine + Relais-Platine + Cul-Stick + FHEMDuino

breti

Hi,

ich kann das Problem bestätigen. Mein TX-NR509 verhält sich genauso, flutet das Logfile regelrecht... Firmware ist die aktuellste.

Werde nun mal deinen Patch probieren :-).

Viele Grüße,
Jens
FHEM dev. auf RasPi, HM-CFG-USB mit HMLAND

breti

FHEM dev. auf RasPi, HM-CFG-USB mit HMLAND

Loredo

Ich kenne das Protokoll aus der entsprechenden Spezifikation von ONKYO, sonst gäbe es das Modul nicht  ;)
Hat meine Arbeit dir geholfen? ⟹ https://paypal.me/pools/c/8gDLrIWrG9

Maintainer:
FHEM-Docker Image, https://github.com/fhem, Astro(Co-Maintainer), ENIGMA2, GEOFANCY, GUEST, HP1000, Installer, LaMetric2, MSG, msgConfig, npmjs, PET, PHTV, Pushover, RESIDENTS, ROOMMATE, search, THINKINGCLEANER

breti

Verstehe - hinter dem Link in der Liste steht aber auch, welches Gerät welche Befehle unterstützt, falls die Onkyo Doku das nicht hergibt.

Auf jeden Fall vielen Dank für deine Arbeit!
FHEM dev. auf RasPi, HM-CFG-USB mit HMLAND