Zitat von: passibe am 04 Juli 2025, 23:12:28Wie sieht das Log aus, wenn du das Neustart-DOIF mal weg lässt? Eigentlich müsste sich alexa-fhem innerhalb von 10 Sekunden neu verbinden:Zitat von: roadghost am 04 Juli 2025, 07:31:36retry in: 10000msec
Das DOIF habe ich nun deaktiviert, und poste Morgen dann das log von heute Nacht. Ich glaube aber, dass alexaFHEM sich nicht neu verbindet.ZitatUnd was war der ursprüngliche Fehler, weshalb die Verbindung beendet wurde?
Also gibt es einen Logeintrag vor dem hier?
Leider in den Zeilen "vor dem Event" nichts auffälliges.
Heute Morgen, nahezu zum exakt identischen Zeitpunkt, ist die SSH Verbindung wieder abgebrochen.
alexaFEM log von Heute Nacht:[5.7.2025, 00:06:10] [FHEM] caching: CurrentTemperature: 23 (as number; from '23.0')
2025-07-05 00:08:04 caching: HWR_Weather-measured-temp: 25.9
[5.7.2025, 00:08:04] [FHEM] caching: CurrentTemperature: 25.9 (as number; from '25.9')
2025-07-05 00:08:37 caching: SZ_Climate-measured-temp: 23.1
[5.7.2025, 00:08:37] [FHEM] caching: CurrentTemperature: 23.1 (as number; from '23.1')
2025-07-05 00:09:22 caching: Aussentemp-humidity: 59
[5.7.2025, 00:09:22] [FHEM] caching: CurrentRelativeHumidity: 59 (as number; from '59')
2025-07-05 00:09:38 caching: Aussentemp-temperature: 18.1
[5.7.2025, 00:09:38] [FHEM] caching: CurrentTemperature: 18.1 (as number; from '18.1')
[5.7.2025, 00:09:54] [FHEM] longpoll ended, reconnect in: 200msec
[5.7.2025, 00:09:55] [FHEM] trying longpoll to listen for fhem events
[5.7.2025, 00:09:55] [FHEM] starting longpoll: http://127.0.0.1:8083/fhem?XHR=1&inform=type=status;addglobal=1;filter=.*;since=1751666992.772;fmt=JSON×tamp=1751666995161
[5.7.2025, 00:09:55] [FHEM] longpoll error: Error: socket hang up, retry in: 10000msec
*** FHEM: connection failed: Error: socket hang up
[5.7.2025, 00:09:55] Got SIGTERM, shutting down alexa-fhem...
[5.7.2025, 00:09:55] Reading alexaFHEM.ProxyConnection set to stopping;; alexa-fhem terminating
[5.7.2025, 00:09:55] [FHEM] executing: http://127.0.0.1:8083/fhem?cmd=%7B%24defs%7B%22alexa%22%7D-%3E%7B%22active%22%7D%20%3D%201%3B%3Bundef%7D%3Bsetreading%20alexa%20alexaFHEM.ProxyConnection%20stopping%3B%3B%20alexa-fhem%20terminating%3B%7B%24defs%7B%22alexa%22%7D-%3E%7B%22active%22%7D%20%3D%200%3B%3Bundef%7D&XHR=1
[5.7.2025, 00:09:55] Stopping SSH ...
[5.7.2025, 00:09:55] Reading alexaFHEM.ProxyConnection set to stopped
[5.7.2025, 00:09:55] [FHEM] executing: http://127.0.0.1:8083/fhem?cmd=%7B%24defs%7B%22alexa%22%7D-%3E%7B%22active%22%7D%20%3D%201%3B%3Bundef%7D%3Bsetreading%20alexa%20alexaFHEM.ProxyConnection%20stopped%3B%7B%24defs%7B%22alexa%22%7D-%3E%7B%22active%22%7D%20%3D%200%3B%3Bundef%7D&XHR=1
[5.7.2025, 00:09:55] *** SSH: exited with 255
[5.7.2025, 00:10:10] using config from ./alexa-fhem.cfg
*** CONFIG: parsed completely
[5.7.2025, 00:10:10] os.homedir()=/opt/fhem
[5.7.2025, 00:10:10] this is alexa-fhem 0.5.65
[5.7.2025, 00:10:10] connecting to FHEM ...
[5.7.2025, 00:10:10] [FHEM] defaults to: will not send proactive events
[5.7.2025, 00:10:10] [FHEM] trying longpoll to listen for fhem events
[5.7.2025, 00:10:10] [FHEM] starting longpoll: http://127.0.0.1:8083/fhem?XHR=1&inform=type=status;addglobal=1;filter=.*;since=null;fmt=JSON×tamp=1751667010639
[5.7.2025, 00:10:10] [FHEM] got csrfToken:
[5.7.2025, 00:10:10] [FHEM] Checking devices and attributes...
[5.7.2025, 00:10:10] [FHEM] executing: http://127.0.0.1:8083/fhem?cmd=%7BAttrVal(%22global%22%2C%22userattr%22%2C%22%22)%7D&XHR=1
[5.7.2025, 00:10:10] [FHEM] executing: http://127.0.0.1:8083/fhem?cmd=jsonlist2%20TYPE%3Dalexa&XHR=1
[5.7.2025, 00:10:10] [FHEM] waiting for events ...
[5.7.2025, 00:10:10] [FHEM] Fetching FHEM devices...
[5.7.2025, 00:10:10] [FHEM] fetching: http://127.0.0.1:8083/fhem?cmd=jsonlist2%20alexaName%3D..*&XHR=1
[5.7.2025, 00:10:10] [FHEM] alexa device is alexa
[5.7.2025, 00:10:10] [FHEM] alexa will not send proactive events
[5.7.2025, 00:10:10] [FHEM] alexa uses ID: 686629b2-f33f-7d7f-86bf-6f059bbcd11d2a50
[5.7.2025, 00:10:10] [FHEM] executing: http://127.0.0.1:8083/fhem?cmd=%7B%24defs%7B%22alexa%22%7D-%3E%7B%22active%22%7D%20%3D%201%3B%3Bundef%7D%3B%7B%24defs%7B%22alexa%22%7D-%3E%7B%22alexa-fhem%20version%22%7D%20%3D%20%220.5.65%22%7D%3B%7B%24defs%7B%22alexa%22%7D-%3E%7B%22active%22%7D%20%3D%200%3B%3Bundef%7D&XHR=1
[5.7.2025, 00:10:10] [FHEM] executing: http://127.0.0.1:8083/fhem?cmd=%7B%24defs%7B%22alexa%22%7D-%3E%7B%22active%22%7D%20%3D%201%3B%3Bundef%7D%3Bget%20alexa%20proxyToken%3B%7B%24defs%7B%22alexa%22%7D-%3E%7B%22active%22%7D%20%3D%200%3B%3Bundef%7D&XHR=1
[5.7.2025, 00:10:10] [FHEM] executing: http://127.0.0.1:8083/fhem?cmd=%7B%24defs%7B%22alexa%22%7D-%3E%7B%22active%22%7D%20%3D%201%3B%3Bundef%7D%3Blist%20alexa%20.eventToken%3B%7B%24defs%7B%22alexa%22%7D-%3E%7B%22active%22%7D%20%3D%200%3B%3Bundef%7D&XHR=1
[5.7.2025, 00:10:10] Server listening on: http://127.0.0.1:33761 for proxy connections
[5.7.2025, 00:10:10] *** SSH: checking proxy configuration
[5.7.2025, 00:10:10] sshautoconf: home=/opt/fhem, spath=/opt/fhem/.alexa, cpath=./alexa-fhem.cfg, sshpath=/opt/fhem/.ssh
[5.7.2025, 00:10:10] 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',
server: Server {
maxHeaderSize: undefined,
insecureHTTPParser: undefined,
requestTimeout: 300000,
headersTimeout: 60000,
keepAliveTimeout: 5000,
connectionsCheckingInterval: 30000,
requireHostHeader: true,
joinDuplicateHeaders: undefined,
rejectNonStandardBodyWrites: false,
_events: [Object: null prototype],
_eventsCount: 4,
_maxListeners: undefined,
_connections: 0,
_handle: [TCP],
_usingWorkers: false,
_workers: [],
_unref: false,
_listeningId: 2,
allowHalfOpen: true,
pauseOnConnect: false,
noDelay: true,
keepAlive: false,
keepAliveInitialDelay: 0,
highWaterMark: 65536,
httpAllowHalfOpen: false,
timeout: 0,
maxHeadersCount: null,
maxRequestsPerSocket: 0,
_connectionKey: '4:127.0.0.1:0',
Symbol(IncomingMessage): [Function: IncomingMessage],
Symbol(ServerResponse): [Function: ServerResponse],
Symbol(shapeMode): false,
Symbol(kCapture): false,
Symbol(async_id_symbol): 116,
Symbol(kUniqueHeaders): null,
Symbol(http.server.connections): ConnectionsList {},
Symbol(http.server.connectionsCheckingInterval): Timeout {
_idleTimeout: 30000,
_idlePrev: [TimersList],
_idleNext: [TimersList],
_idleStart: 426,
_onTimeout: [Function: bound checkConnections],
_timerArgs: undefined,
_repeat: 30000,
_destroyed: false,
Symbol(refed): false,
Symbol(kHasPrimitive): false,
Symbol(asyncId): 118,
Symbol(triggerId): 117,
Symbol(kAsyncContextFrame): undefined
}
}
},
connections: [
{
filter: 'alexaName=..*',
name: 'FHEM',
server: '127.0.0.1',
uid: 998,
webname: 'fhem',
port: 8083
}
]
}
[5.7.2025, 00:10:10] sshautoconf: SSH key seems to exist
[5.7.2025, 00:10:11] sshautoconf: Our SSH key is known at the reverse proxy, good!
[5.7.2025, 00:10:11] [FHEM] executing: http://127.0.0.1:8083/fhem?cmd=%7B%24defs%7B%22alexa%22%7D-%3E%7B%22active%22%7D%20%3D%201%3B%3Bundef%7D%3Bjsonlist2%20alexa%3B%7B%24defs%7B%22alexa%22%7D-%3E%7B%22active%22%7D%20%3D%200%3B%3Bundef%7D&XHR=1
*** FHEM: connectedZitatBei FHEM merkst du sonst nichts? Das DOIF scheint ja zu funktionieren ... Ggfs. auch mal perfmon installieren.
Bei meinem FHEM merke ich sonst nichts, zumindest nicht um 00:09 Uhr, da schlafe ich meist- Das system läuft auf einem i5 NUC, Performance ist also genug da.
ZitatKannst du ansonsten vielleicht mit der Methode deiner Wahl – am besten vielleicht außerhalb von FHEM? – deine Systemauslastung tracken? Ggfs. auch mal über syslog oder journald schauen, ob zu der Zeit was beim FHEM-Prozess nicht stimmt.
Ich muss mich da reinfuchsen, ich gebe rückmeldung.
tl;dr Bitte Log vor dem "longpoll ended"-Eintrag posten (falls vorhanden), Neustart-DOIF ausschalten und Log posten, Erreichbarkeit von FHEMWEB bei Ausfallzeitpunkt prüfen, ggfs. mit perfmon, sowie Systemauslastung überwachen.
Result of data = generic/cpu
----------------------------------------------------------------------
$VAR1 = {
'data' => {
'StatRAMCacheUsed' => '15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15,15',
'StatRAMPhysFree' => '23,23,23,23,22,22,22,22,22,22,23,22,22,22,22,22,23,23,23,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,22,23,23,22,22,22,23,22,22,22,22,22,22,22,22,22,22,22,22,23,22,22,23,22,22,22,22,22,22,22,22,22,22,22,22,22,23,22,22,22,22,22,22,22,22,22,22,22,22,22,23,22,22,22,21,21,21,21,21,21,22,22,22,22,22,22,22,22,21,21,21,21,22,22,23,22,22,22,22,22,23,22,22,21,21,21,21,22,22,22,22,21,22,22,21,21,21,21,21,21,22,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,21,22,23,23,23,23,23,23,22,23,23,23,23,22,22,23,23,23,23,23,23,23,23,23,23,23,23,22,26,23,23,23,24,23,23,23,24,23,23,23,23,23,23,23,23,23,23,23,23,23,23',
'StatCurrentInterval' => '116',
'StatCPU' => '14,11,12,10,10,9,8,9,8,9,10,9,9,9,9,9,9,10,10,9,9,9,9,9,9,12,12,11,9,9,8,9,8,8,9,8,8,9,8,9,8,8,9,8,9,8,8,9,8,9,9,8,8,8,8,8,9,11,9,10,9,9,8,10,10,10,10,9,10,9,8,8,9,8,9,8,8,8,8,9,8,8,8,8,9,8,8,8,8,9,8,9,9,9,9,9,8,9,8,9,9,9,9,8,9,8,8,8,9,9,8,9,9,8,9,8,8,9,8,9,8,8,8,8,9,8,9,9,8,9,9,9,9,9,9,9,8,9,9,9,9,9,10,12,9,10,10,10,9,9,8,9,10,10,8,8,8,8,8,8,8,8,8,8,8,8,8,8,8,8,11,11,12,11,11,12,11,12,12,12,8,8,8,8,8,8,8,8,8,8,9,10,10,9,9,9,9,9,10,9,9,9,10,11,9,11,10,14,17,17,18,15,17,11,17,31,26,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0',
'StatRAMStrictlyUsed' => '62,62,62,62,63,63,63,63,63,63,62,63,63,63,63,63,62,62,62,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,62,62,63,63,63,62,63,63,63,63,63,63,63,63,63,63,63,63,62,63,63,62,63,63,63,63,63,63,63,63,63,63,63,63,63,62,63,63,63,63,63,63,63,63,63,63,63,63,63,62,63,63,63,64,64,64,64,64,64,63,63,63,63,63,63,63,63,64,64,64,64,63,63,62,63,63,63,63,63,62,63,63,64,64,64,64,63,63,63,63,64,63,63,64,64,64,64,64,64,63,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,63,62,62,62,62,62,62,63,62,62,62,62,63,63,62,62,62,62,62,62,62,62,62,62,62,62,63,59,61,61,61,61,61,61,61,61,61,61,61,61,61,61,61,61,61,61,61,61,61,61',
'StatTemperature' => '63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,63,62,62,62,62,62,62,61,62,62,62,62,61,61,61,60,60,60,61,61,61,62,63,63,63,64,64,63,63,63,63,63,63,63,63,64,64,63,63,63,63,63,63,63,63,64,64,64,64,64,64,64,63,64,64,64,64,64,64,64,64,64,63,63,63,63,63,64,64,64,64,64,64,64,64,63,63,63,63,63,63,63,63,63,63,63,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,65,65,65,64,64,63,64,63,63,63,63,63,64,64,64,64,64,65,65,65,65,64,65,64,64,64,63,63,63,63,64,64,64,65,65,65,65,65,65,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,65,64,64,64,64,64,64,64,64,64,64,64,64,64,64,64,63,63,63,63,63,62,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0'
},
'sidNew' => 0,
'sid' => '9bb469aa0a9d4bf5'
};
Result of data = cpu
----------------------------------------------------------------------
ERROR: Bad Request