39_alexa -> Fehler in alexaFHEM.ProxyConnection

Begonnen von erdnar, 05 Juli 2020, 20:12:44

Vorheriges Thema - Nächstes Thema

erdnar

Hallo,
sporadisch funktioniert "die Alexa" nicht.
Auf Schalt-Befehle kommt dann nur "Gerät reagiert gerade nicht".

Im Reading alexaFHEM.ProxyConnection steht dann:
error; Reverse Proxy replied with neither registered nor unregistered status: out:  err:ssh: connect to host fhem-va.fhem.de port 58824: Connection refused
Nach einem Restart von Fhem (nicht der Server), funktioniert es wieder.
In o.g. Reading steht dann wieder:
running; SSH connected
Wo sollte ich suchen?

Danke
ErdnaR

amenomade

Hast Du schon in der alexaFHEM-Log geguckt, was die vor und nach diesem Fehler sagt?
Pi 3B, Alexa, CUL868+Selbstbau 1/2λ-Dipol-Antenne, USB Optolink / Vitotronic, Debmatic und HM / HmIP Komponenten, Rademacher Duofern Jalousien, Fritz!Dect Thermostaten, Proteus

erdnar

Moin,
ich schaue da rein wie die Sau in die Alexa ...
2020-07-05 00:00:25 caching: d_Flur.Licht-state: 1
[2020-7-5 0:00:25] [FHEM]     caching: On: 1 (as number; from '1')
  2020-07-05 00:00:25 caching: MQ_233_Shelly-state: ON
[2020-7-5 0:00:25] [FHEM]     caching: On: 1 (as number; from 'ON')
[2020-7-5 0:00:58] using config from ./alexa-fhem.cfg
*** CONFIG: parsed completely
[2020-7-5 0:00:58] os.homedir()=/opt/fhem
[2020-7-5 0:00:58] this is alexa-fhem 0.5.48
[2020-7-5 0:00:58] connecting to FHEM ...
[2020-7-5 0:00:58] [FHEM] defaults to: will not send proactive events
[2020-7-5 0:00:59] [FHEM] trying longpoll to listen for fhem events
[2020-7-5 0:00:59] [FHEM] starting longpoll: http://127.0.0.1:8083/fhem?XHR=1&inform=type=status;addglobal=1;filter=.*;since=null;fmt=JSON×tamp=1593900050815
[2020-7-5 0:01:05] [FHEM] got csrfToken: csrf_963466942750815
[2020-7-5 0:01:05] [FHEM] Checking devices and attributes...
[2020-7-5 0:01:05] [FHEM]   executing: http://127.0.0.1:8083/fhem?cmd=%7BAttrVal(%22global%22%2C%22userattr%22%2C%22%22)%7D&fwcsrf=csrf_963466942750815&XHR=1
[2020-7-5 0:01:05] [FHEM]   executing: http://127.0.0.1:8083/fhem?cmd=jsonlist2%20TYPE%3Dalexa&fwcsrf=csrf_963466942750815&XHR=1
[2020-7-5 0:01:05] [FHEM] waiting for events ...
[2020-7-5 0:01:05] [FHEM] Fetching FHEM devices...
[2020-7-5 0:01:05] [FHEM] fetching: http://127.0.0.1:8083/fhem?cmd=jsonlist2%20alexaName=..*&fwcsrf=csrf_963466942750815&XHR=1
[2020-7-5 0:01:06] [FHEM]   error processing event data: TypeError: Cannot read property 'Name' of undefined
[2020-7-5 0:01:06] [FHEM]   error processing event data: TypeError: Cannot read property 'Name' of undefined
[2020-7-5 0:01:06] [FHEM]   error processing event data: TypeError: Cannot read property 'Name' of undefined
[2020-7-5 0:01:06] [FHEM]   error processing event data: TypeError: Cannot read property 'Name' of undefined
[2020-7-5 0:01:07] [FHEM] alexa device is alexa
[2020-7-5 0:01:07] [FHEM] alexa will not send proactive events
[2020-7-5 0:01:07] [FHEM] alexa uses ID: 5d4727a8-f33f-50f1-bb36-d4876e229aa50815
[2020-7-5 0:01:07] [FHEM]   executing: http://127.0.0.1:8083/fhem?cmd=%7B%24defs%7Balexa%7D-%3E%7B%22active%22%7D%20%3D%201%3B%3Bundef%7D%3B%7B%24defs%7Balexa%7D-%3E%7B%22alexa-fhem%20version%22%7D%20%3D%20%220.5.48%22%7D%3B%7B%24defs%7Balexa%7D-%3E%7B%22active%22%7D%20%3D%200%3B%3Bundef%7D&fwcsrf=csrf_963466942750815&XHR=1
[2020-7-5 0:01:07] [FHEM]   executing: http://127.0.0.1:8083/fhem?cmd=%7B%24defs%7Balexa%7D-%3E%7B%22active%22%7D%20%3D%201%3B%3Bundef%7D%3Bget%20alexa%20proxyToken%3B%7B%24defs%7Balexa%7D-%3E%7B%22active%22%7D%20%3D%200%3B%3Bundef%7D&fwcsrf=csrf_963466942750815&XHR=1
[2020-7-5 0:01:07] [FHEM]   executing: http://127.0.0.1:8083/fhem?cmd=%7B%24defs%7Balexa%7D-%3E%7B%22active%22%7D%20%3D%201%3B%3Bundef%7D%3Blist%20alexa%20.eventToken%3B%7B%24defs%7Balexa%7D-%3E%7B%22active%22%7D%20%3D%200%3B%3Bundef%7D&fwcsrf=csrf_963466942750815&XHR=1
[2020-7-5 0:01:07] Server listening on: http://127.0.0.1:39723 for proxy connections
[2020-7-5 0:01:07] *** SSH: checking proxy configuration
[2020-7-5 0:01:07] sshautoconf: home=/opt/fhem, spath=/opt/fhem/.alexa, cpath=./alexa-fhem.cfg, sshpath=/opt/fhem/.ssh
[2020-7-5 0:01:07] Passed config: {"sshproxy":{"ssh":"/usr/bin/ssh","description":"FHEM Connector","options":["-i","/opt/fhem/.ssh/id_rsa","-p",58824,"fhem-va.fhem.de"],"bind-ip":"127.0.0.1","port":39723},"connections":[{"port":"8083","webname":"fhem","name":"FHEM","filter":"alexaName=..*","server":"127.0.0.1","uid":999}]}
[2020-7-5 0:01:07] sshautoconf: SSH key seems to exist
[2020-7-5 0:01:07] sshautoconf: aborted with Reverse Proxy replied with neither registered nor unregistered status: out:  err:ssh: connect to host fhem-va.fhem.de port 58824: Connection refused
[2020-7-5 0:01:07] *** SSH: proxy configuration failed: Reverse Proxy replied with neither registered nor unregistered status: out:  err:ssh: connect to host fhem-va.fhem.de port 58824: Connection refused
*** FHEM: connected
[2020-7-5 0:01:07] [FHEM] got: 64 results
[2020-7-5 0:01:07] [FHEM] Alexa.ArbeitszimmerRollo is blind ...

... jetzt kommen alle möglichen Geräte und dann wieder ...
[2020-7-5 0:01:08] Reading alexaFHEM.ProxyConnection set to error;; Reverse Proxy replied with neither registered nor unregistered status: out:  err:ssh: connect to host fhem-va.fhem.de port 58824: Connection refused

[2020-7-5 0:01:08] [FHEM]   executing: http://127.0.0.1:8083/fhem?cmd=%7B%24defs%7Balexa%7D-%3E%7B%22active%22%7D%20%3D%201%3B%3Bundef%7D%3Bsetreading%20alexa%20alexaFHEM.ProxyConnection%20error%3B%3B%20Reverse%20Proxy%20replied%20with%20neither%20registered%20nor%20unregistered%20status%3A%20out%3A%20%20err%3Assh%3A%20connect%20to%20host%20fhem-va.fhem.de%20port%2058824%3A%20Connection%20refused%0D%0A%3B%7B%24defs%7Balexa%7D-%3E%7B%22active%22%7D%20%3D%200%3B%3Bundef%7D&fwcsrf=csrf_963466942750815&XHR=1
[2020-7-5 0:01:12] BearerToken '...F5F4E' read from alexa
[2020-7-5 0:01:12] [FHEM] got .eventToken
[2020-7-5 0:01:12] refreshing token
[2020-7-5 0:01:12] failed to refresh token: Error: connect ECONNREFUSED 87.65.43.212:443
  2020-07-05 00:02:54 caching: d_Flur.Licht-state: 0
[2020-7-5 0:02:54] [FHEM]     caching: On: 1 (as number; from '0')


Seit dem Restart am 5.7. läuft es im Moment fehlerfrei.
Danke.
ER

MadMax-FHEM

Zitat von: erdnar am 07 Juli 2020, 16:09:31

Seit dem Restart am 5.7. läuft es im Moment fehlerfrei.
Danke.
ER

Trotzdem solltest du mal updaten (und zwar alexa-fhem! NICHT [naja gut sieht man nicht ;) ] fhem bzw. geht ein alexa-fhem Update NICHT über den fhem Update-Mechanismus!):

Zitat
[2020-7-5 0:00:58] this is alexa-fhem 0.5.48

https://wiki.fhem.de/wiki/FHEM_Connector_f%C3%BCr_Amazon_Alexa#alexa-fhem_Updaten_bzw._.22Upgraden.22

Dann wären (verm.) auch die "undefined ..." Fehler weg...
...und vielleicht auch das Proxy-Connect-Problem...

Gruß, Joachim
FHEM PI3B+ Bullseye: HM-CFG-USB, 40x HM, ZWave-USB, 13x ZWave, EnOcean-PI, 15x EnOcean, HUE/deCONZ, CO2, ESP-Multisensor, Shelly, alexa-fhem, ...
FHEM PI2 Buster: HM-CFG-USB, 25x HM, ZWave-USB, 4x ZWave, EnOcean-PI, 3x EnOcean, Shelly, ha-bridge, ...
FHEM PI3 Buster (Test)

erdnar

OK Joachim, vielen Dank.
Irgendwie habe ich mich schon zu sehr auf die ganzen Autoupdates verlassen. ::)
Ich habe das Update gemacht und werde wieder beobachten.
Nochmal Danke
ErdnaR

MadMax-FHEM

Autoupdates!!!?

Also ich lasse mich MAXIMAL "erinnern", dass Updates da sind/wären...
...ich will bei Updates DABEI SEIN! ;)

Es gibt ja Module die das tun:

Apt2Date
npmjs
installhelper (oder so ähnlich)

Damit kann man auch aus fhem heraus Updates von npm und OS Modulen machen (lassen)...
...und auch Unterstützung bzgl. notwendiger OS Module für fhem Module bekommen...

Dann drücke ich mal die Daumen!

Gruß, Joachim
FHEM PI3B+ Bullseye: HM-CFG-USB, 40x HM, ZWave-USB, 13x ZWave, EnOcean-PI, 15x EnOcean, HUE/deCONZ, CO2, ESP-Multisensor, Shelly, alexa-fhem, ...
FHEM PI2 Buster: HM-CFG-USB, 25x HM, ZWave-USB, 4x ZWave, EnOcean-PI, 3x EnOcean, Shelly, ha-bridge, ...
FHEM PI3 Buster (Test)

erdnar

Naja, ganz so meinte ich das nicht.
Aber wenn immer (fast) alles einigermaßen läuft wird man eben träge.
ER

erdnar

#7
Zu früh gefreut, der Fehler ist wieder da:
[2020-7-8 0:01:01] Reading alexaFHEM.ProxyConnection set to running;; stderr=packet_write_wait: Connection to 2a01:4f8:10a:806::f2 port 58824: Broken pipe 
[2020-7-8 0:01:01] [FHEM]   executing: http://127.0.0.1:8083/fhem?cmd=%7B%24defs%7Balexa%7D-%3E%7B%22active%22%7D%20%3D%201%3B%3Bundef%7D%3Bsetreading%20alexa%20alexaFHEM.ProxyConnection%20running%3B%3B%20stderr%3Dpacket_write_wait%3A%20Connection%20to%202a01%3A4f8%3A10a%3A806%3A%3Af2%20port%2058824%3A%20Broken%20pipe%20%20%3B%7B%24defs%7Balexa%7D-%3E%7B%22active%22%7D%20%3D%200%3B%3Bundef%7D&fwcsrf=csrf_259030561260855&XHR=1
[2020-7-8 0:01:01] *** SSH: stderr: packet_write_wait: Connection to 2a01:4f8:10a:806::f2 port 58824: Broken pipe 
[2020-7-8 0:01:01] SSH: exited with 255 - will restart in 85.21511442580855 seconds
[2020-7-8 0:01:01] Reading alexaFHEM.ProxyConnection set to stopped;; Terminated with packet_write_wait: Connection to 2a01:4f8:10a:806::f2 port 58824: Broken pipe  , ssh will restart at 00:02:26
[2020-7-8 0:01:01] [FHEM]   executing: http://127.0.0.1:8083/fhem?cmd=%7B%24defs%7Balexa%7D-%3E%7B%22active%22%7D%20%3D%201%3B%3Bundef%7D%3Bsetreading%20alexa%20alexaFHEM.ProxyConnection%20stopped%3B%3B%20Terminated%20with%20packet_write_wait%3A%20Connection%20to%202a01%3A4f8%3A10a%3A806%3A%3Af2%20port%2058824%3A%20Broken%20pipe%20%20%2C%20ssh%20will%20restart%20at%2000%3A02%3A26%3B%7B%24defs%7Balexa%7D-%3E%7B%22active%22%7D%20%3D%200%3B%3Bundef%7D&fwcsrf=csrf_259030561260855&XHR=1
[2020-7-8 0:01:26] using config from ./alexa-fhem.cfg
*** CONFIG: parsed completely
[2020-7-8 0:01:26] os.homedir()=/opt/fhem
[2020-7-8 0:01:26] this is alexa-fhem 0.5.55
[2020-7-8 0:01:26] connecting to FHEM ...
[2020-7-8 0:01:26] [FHEM] defaults to: will not send proactive events
[2020-7-8 0:01:27] [FHEM] trying longpoll to listen for fhem events
[2020-7-8 0:01:27] [FHEM] starting longpoll: http://127.0.0.1:8083/fhem?XHR=1&inform=type=status;addglobal=1;filter=.*;since=null;fmt=JSON×tamp=1594159280881
[2020-7-8 0:01:34] [FHEM] got csrfToken: csrf_517749946250854
[2020-7-8 0:01:34] [FHEM] Checking devices and attributes...
[2020-7-8 0:01:34] [FHEM]   executing: http://127.0.0.1:8083/fhem?cmd=%7BAttrVal(%22global%22%2C%22userattr%22%2C%22%22)%7D&fwcsrf=csrf_517749946250854&XHR=1
[2020-7-8 0:01:34] [FHEM]   executing: http://127.0.0.1:8083/fhem?cmd=jsonlist2%20TYPE%3Dalexa&fwcsrf=csrf_517749946250854&XHR=1
[2020-7-8 0:01:34] [FHEM] waiting for events ...
[2020-7-8 0:01:34] [FHEM] Fetching FHEM devices...
[2020-7-8 0:01:34] [FHEM] fetching: http://127.0.0.1:8083/fhem?cmd=jsonlist2%20alexaName=..*&fwcsrf=csrf_517749946250854&XHR=1
[2020-7-8 0:01:35] [FHEM] alexa device is alexa
[2020-7-8 0:01:35] [FHEM] alexa will not send proactive events
[2020-7-8 0:01:35] [FHEM] alexa uses ID: 5d4727a8-f33f-50f1-bb36-d4876e208aa5da04
[2020-7-8 0:01:35] [FHEM]   executing: http://127.0.0.1:8083/fhem?cmd=%7B%24defs%7Balexa%7D-%3E%7B%22active%22%7D%20%3D%201%3B%3Bundef%7D%3B%7B%24defs%7Balexa%7D-%3E%7B%22alexa-fhem%20version%22%7D%20%3D%20%220.5.55%22%7D%3B%7B%24defs%7Balexa%7D-%3E%7B%22active%22%7D%20%3D%200%3B%3Bundef%7D&fwcsrf=csrf_517749946257554&XHR=1
[2020-7-8 0:01:35] [FHEM]   executing: http://127.0.0.1:8083/fhem?cmd=%7B%24defs%7Balexa%7D-%3E%7B%22active%22%7D%20%3D%201%3B%3Bundef%7D%3Bget%20alexa%20proxyToken%3B%7B%24defs%7Balexa%7D-%3E%7B%22active%22%7D%20%3D%200%3B%3Bundef%7D&fwcsrf=csrf_517749946257554&XHR=1
[2020-7-8 0:01:35] [FHEM]   executing: http://127.0.0.1:8083/fhem?cmd=%7B%24defs%7Balexa%7D-%3E%7B%22active%22%7D%20%3D%201%3B%3Bundef%7D%3Blist%20alexa%20.eventToken%3B%7B%24defs%7Balexa%7D-%3E%7B%22active%22%7D%20%3D%200%3B%3Bundef%7D&fwcsrf=csrf_517749946250854&XHR=1
[2020-7-8 0:01:35] Server listening on: http://127.0.0.1:43589 for proxy connections
[2020-7-8 0:01:35] *** SSH: checking proxy configuration
[2020-7-8 0:01:35] sshautoconf: home=/opt/fhem, spath=/opt/fhem/.alexa, cpath=./alexa-fhem.cfg, sshpath=/opt/fhem/.ssh
[2020-7-8 0:01:35] Passed config: {"sshproxy":{"ssh":"/usr/bin/ssh","description":"FHEM Connector","options":["-i","/opt/fhem/.ssh/id_rsa","-p",58824,"fhem-va.fhem.de"],"bind-ip":"127.0.0.1","port":43589},"connections":[{"port":"8083","webname":"fhem","name":"FHEM","filter":"alexaName=..*","server":"127.0.0.1","uid":999}]}
[2020-7-8 0:01:35] sshautoconf: SSH key seems to exist
[2020-7-8 0:01:35] sshautoconf: aborted with Reverse Proxy replied with neither registered nor unregistered status: out:  err:ssh: connect to host fhem-va.fhem.de port 58824: Connection refused

[2020-7-8 0:01:35] *** SSH: proxy configuration failed: Reverse Proxy replied with neither registered nor unregistered status: out:  err:ssh: connect to host fhem-va.fhem.de port 58824: Connection refused

[2020-7-8 0:01:36] Reading alexaFHEM.ProxyConnection set to error;; Reverse Proxy replied with neither registered nor unregistered status: out:  err:ssh: connect to host fhem-va.fhem.de port 58824: Connection refused

[2020-7-8 0:01:36] [FHEM]   executing: http://127.0.0.1:8083/fhem?cmd=%7B%24defs%7Balexa%7D-%3E%7B%22active%22%7D%20%3D%201%3B%3Bundef%7D%3Bsetreading%20alexa%20alexaFHEM.ProxyConnection%20error%3B%3B%20Reverse%20Proxy%20replied%20with%20neither%20registered%20nor%20unregistered%20status%3A%20out%3A%20%20err%3Assh%3A%20connect%20to%20host%20fhem-va.fhem.de%20port%2058824%3A%20Connection%20refused%0D%0A%3B%7B%24defs%7Balexa%7D-%3E%7B%22active%22%7D%20%3D%200%3B%3Bundef%7D&fwcsrf=csrf_517749946250854&XHR=1
*** FHEM: connected
[2020-7-8 0:01:38] [FHEM] got: 64 results
[2020-7-8 0:01:38] [FHEM] Alexa.ArbeitszimmerRollo is blind
[2020-7-8 0:01:38] [FHEM] Alexa.ArbeitszimmerRollo has


Sogar fast zur gleichen Tageszeit, am 6. und 7.7. war aber alles OK.

Etwas später kommt noch ein Fehler mit dem Token:

  2020-07-08 00:01:38 caching: d_wohnzimmer_reinigen-state: off
[2020-7-8 0:01:40] BearerToken '...F5F4E' read from alexa
[2020-7-8 0:01:40] [FHEM] got .eventToken
[2020-7-8 0:01:40] refreshing token
[2020-7-8 0:01:40] failed to refresh token: Error: connect ECONNREFUSED 88.08.31.202:443
  2020-07-08 00:02:46 caching: XMI_158d0002b6dabc-temperature: 16.92
[2020-7-8 0:02:46] [FHEM]     caching: CurrentTemperature: 16.92 (as number; from '16.92')


Ich kann es natürlich über ein DOIF auffangen und bei Fehler einfach alexa-fhem neu starten set alexa start

Aber die Ursache zu finden wäre schon interessant.
Neue Ideen?

Danke
ErdnaR

amenomade

"Broken pipe" ???  :o
Irgendwie wird die SSH Sitzung unterbrochen.

Was hast Du für ein Betriebssystem? Irgendwas, was im tiefen Schlafmodus geht?
Irgendein Netzwerk Problem?

Wie ist der Status des ssh Tunnels, wenn alexa nicht funktioniert?

Schlimmsten Fall würde ich die Registrierung zurücksetzen, und das Skill mit dem neuen Schlüssel wieder verbinden. Oder Du findest jemanden, der seitens fhem-va Server analysieren kann.


https://wiki.fhem.de/wiki/FHEM_Connector_f%C3%BCr_Amazon_Alexa#Registrierungskey_vergessen.2C_Registrierung_zur.C3.BCcksetzen

EDIT: passiert das immer so um Mitternacht?
Pi 3B, Alexa, CUL868+Selbstbau 1/2λ-Dipol-Antenne, USB Optolink / Vitotronic, Debmatic und HM / HmIP Komponenten, Rademacher Duofern Jalousien, Fritz!Dect Thermostaten, Proteus

MadMax-FHEM

Aber wenigstens sind (wie angekündigt ;) ) die "cannot...uninitialized" Fehler weg :)

Gruß, Joachim
FHEM PI3B+ Bullseye: HM-CFG-USB, 40x HM, ZWave-USB, 13x ZWave, EnOcean-PI, 15x EnOcean, HUE/deCONZ, CO2, ESP-Multisensor, Shelly, alexa-fhem, ...
FHEM PI2 Buster: HM-CFG-USB, 25x HM, ZWave-USB, 4x ZWave, EnOcean-PI, 3x EnOcean, Shelly, ha-bridge, ...
FHEM PI3 Buster (Test)