Guten Abend Zusammen :)
Ich habe seit einigen Wochen alle paar Sekunden folgenden Text in meinem Logfile:
2018.07.21 18:45:25 1: devspec2array (.*,(.*: Unmatched ( in regex; marked by <-- HERE in m/^( <-- HERE (.*)$/ at fhem.pl line 1288
Hat jemand eine Idee für mich wie ich der Sache auf dem Grund gehen kann um herauszufinden wo mein Fehler ist?
Hier nochmal ein längerer Auszug aus dem Logfile:
2018.07.21 18:45:25 1: devspec2array (.*,(.*: Unmatched ( in regex; marked by <-- HERE in m/^( <-- HERE (.*)$/ at fhem.pl line 1288.
2018.07.21 18:45:25 1: stacktrace:
2018.07.21 18:45:25 1: main::devspec2array called by fhem.pl (4923)
2018.07.21 18:45:25 1: main::createNtfyHash called by fhem.pl (3499)
2018.07.21 18:45:25 1: main::DoTrigger called by fhem.pl (4531)
2018.07.21 18:45:25 1: main::readingsEndUpdate called by /opt/fhem/FHEM/88_HMCCU.pm (2841)
2018.07.21 18:45:25 1: main::HMCCU_UpdateSingleDevice called by /opt/fhem/FHEM/88_HMCCU.pm (2871)
2018.07.21 18:45:25 1: main::HMCCU_UpdateMultipleDevices called by /opt/fhem/FHEM/88_HMCCU.pm (5057)
2018.07.21 18:45:25 1: main::HMCCU_ReadRPCQueue called by fhem.pl (3127)
2018.07.21 18:45:25 1: main::HandleTimeout called by fhem.pl (646)
2018.07.21 18:45:25 1: devspec2array (.*\.UNREACH,(.*\.UNREACH: Unmatched ( in regex; marked by <-- HERE in m/^( <-- HERE (.*\.UNREACH)$/ at fhem.pl line 1288.
2018.07.21 18:45:25 1: stacktrace:
2018.07.21 18:45:25 1: main::devspec2array called by fhem.pl (4923)
2018.07.21 18:45:25 1: main::createNtfyHash called by fhem.pl (3499)
2018.07.21 18:45:25 1: main::DoTrigger called by fhem.pl (4531)
2018.07.21 18:45:25 1: main::readingsEndUpdate called by /opt/fhem/FHEM/88_HMCCU.pm (2841)
2018.07.21 18:45:25 1: main::HMCCU_UpdateSingleDevice called by /opt/fhem/FHEM/88_HMCCU.pm (2871)
2018.07.21 18:45:25 1: main::HMCCU_UpdateMultipleDevices called by /opt/fhem/FHEM/88_HMCCU.pm (5057)
2018.07.21 18:45:25 1: main::HMCCU_ReadRPCQueue called by fhem.pl (3127)
2018.07.21 18:45:25 1: main::HandleTimeout called by fhem.pl (646)
ping: icmp open socket: Operation not permitted
2018.07.21 18:45:52 1: devspec2array (.*,(.*: Unmatched ( in regex; marked by <-- HERE in m/^( <-- HERE (.*)$/ at fhem.pl line 1288.
2018.07.21 18:45:52 1: stacktrace:
2018.07.21 18:45:52 1: main::devspec2array called by fhem.pl (4923)
2018.07.21 18:45:52 1: main::createNtfyHash called by fhem.pl (3499)
2018.07.21 18:45:52 1: main::DoTrigger called by fhem.pl (4531)
2018.07.21 18:45:52 1: main::readingsEndUpdate called by fhem.pl (4713)
2018.07.21 18:45:52 1: main::readingsSingleUpdate called by /opt/fhem/FHEM/91_notify.pm (58)
2018.07.21 18:45:52 1: main::notify_Define called by fhem.pl (3584)
2018.07.21 18:45:52 1: main::CallFn called by fhem.pl (2016)
2018.07.21 18:45:52 1: main::CommandModify called by fhem.pl (1209)
2018.07.21 18:45:52 1: main::AnalyzeCommand called by /opt/fhem/FHEM/01_FHEMWEB.pm (2576)
2018.07.21 18:45:52 1: main::FW_fC called by /opt/fhem/FHEM/01_FHEMWEB.pm (859)
2018.07.21 18:45:52 1: main::FW_answerCall called by /opt/fhem/FHEM/01_FHEMWEB.pm (532)
2018.07.21 18:45:52 1: main::FW_Read called by fhem.pl (3584)
2018.07.21 18:45:52 1: main::CallFn called by fhem.pl (723)
2018.07.21 18:45:52 1: devspec2array (.*\.UNREACH,(.*\.UNREACH: Unmatched ( in regex; marked by <-- HERE in m/^( <-- HERE (.*\.UNREACH)$/ at fhem.pl line 1288.
2018.07.21 18:45:52 1: stacktrace:
2018.07.21 18:45:52 1: main::devspec2array called by fhem.pl (4923)
2018.07.21 18:45:52 1: main::createNtfyHash called by fhem.pl (3499)
2018.07.21 18:45:52 1: main::DoTrigger called by fhem.pl (4531)
2018.07.21 18:45:52 1: main::readingsEndUpdate called by fhem.pl (4713)
2018.07.21 18:45:52 1: main::readingsSingleUpdate called by /opt/fhem/FHEM/91_notify.pm (58)
2018.07.21 18:45:52 1: main::notify_Define called by fhem.pl (3584)
2018.07.21 18:45:52 1: main::CallFn called by fhem.pl (2016)
2018.07.21 18:45:52 1: main::CommandModify called by fhem.pl (1209)
2018.07.21 18:45:52 1: main::AnalyzeCommand called by /opt/fhem/FHEM/01_FHEMWEB.pm (2576)
2018.07.21 18:45:52 1: main::FW_fC called by /opt/fhem/FHEM/01_FHEMWEB.pm (859)
2018.07.21 18:45:52 1: main::FW_answerCall called by /opt/fhem/FHEM/01_FHEMWEB.pm (532)
2018.07.21 18:45:52 1: main::FW_Read called by fhem.pl (3584)
2018.07.21 18:45:52 1: main::CallFn called by fhem.pl (723)
2018.07.21 18:45:52 1: devspec2array (.*,(.*: Unmatched ( in regex; marked by <-- HERE in m/^( <-- HERE (.*)$/ at fhem.pl line 1288.
2018.07.21 18:45:52 1: stacktrace:
2018.07.21 18:45:52 1: main::devspec2array called by fhem.pl (4923)
2018.07.21 18:45:52 1: main::createNtfyHash called by fhem.pl (3499)
2018.07.21 18:45:52 1: main::DoTrigger called by fhem.pl (4531)
2018.07.21 18:45:52 1: main::readingsEndUpdate called by fhem.pl (4713)
2018.07.21 18:45:52 1: main::readingsSingleUpdate called by /opt/fhem/FHEM/00_MQTT.pm (522)
2018.07.21 18:45:52 1: MQTT::__ANON__ called by FHEM/GPUtils.pm (48)
2018.07.21 18:45:52 1: GPUtils::GP_ForallClients called by /opt/fhem/FHEM/00_MQTT.pm (534)
2018.07.21 18:45:52 1: MQTT::Read called by fhem.pl (3584)
2018.07.21 18:45:52 1: main::CallFn called by fhem.pl (723)
2018.07.21 18:45:52 1: devspec2array (.*\.UNREACH,(.*\.UNREACH: Unmatched ( in regex; marked by <-- HERE in m/^( <-- HERE (.*\.UNREACH)$/ at fhem.pl line 1288.
2018.07.21 18:45:52 1: stacktrace:
2018.07.21 18:45:52 1: main::devspec2array called by fhem.pl (4923)
2018.07.21 18:45:52 1: main::createNtfyHash called by fhem.pl (3499)
2018.07.21 18:45:52 1: main::DoTrigger called by fhem.pl (4531)
2018.07.21 18:45:52 1: main::readingsEndUpdate called by fhem.pl (4713)
2018.07.21 18:45:52 1: main::readingsSingleUpdate called by /opt/fhem/FHEM/00_MQTT.pm (522)
2018.07.21 18:45:52 1: MQTT::__ANON__ called by FHEM/GPUtils.pm (48)
2018.07.21 18:45:52 1: GPUtils::GP_ForallClients called by /opt/fhem/FHEM/00_MQTT.pm (534)
2018.07.21 18:45:52 1: MQTT::Read called by fhem.pl (3584)
2018.07.21 18:45:52 1: main::CallFn called by fhem.pl (723)
ping: icmp open socket: Operation not permitted
2018.07.21 18:46:08 1: devspec2array (.*,(.*: Unmatched ( in regex; marked by <-- HERE in m/^( <-- HERE (.*)$/ at fhem.pl line 1288.
2018.07.21 18:46:08 1: stacktrace:
2018.07.21 18:46:08 1: main::devspec2array called by fhem.pl (4923)
2018.07.21 18:46:08 1: main::createNtfyHash called by fhem.pl (3499)
2018.07.21 18:46:08 1: main::DoTrigger called by fhem.pl (4531)
2018.07.21 18:46:08 1: main::readingsEndUpdate called by /opt/fhem/FHEM/88_HMCCU.pm (2841)
2018.07.21 18:46:08 1: main::HMCCU_UpdateSingleDevice called by /opt/fhem/FHEM/88_HMCCU.pm (2871)
2018.07.21 18:46:08 1: main::HMCCU_UpdateMultipleDevices called by /opt/fhem/FHEM/88_HMCCU.pm (5057)
2018.07.21 18:46:08 1: main::HMCCU_ReadRPCQueue called by fhem.pl (3127)
2018.07.21 18:46:08 1: main::HandleTimeout called by fhem.pl (646)
2018.07.21 18:46:08 1: devspec2array (.*\.UNREACH,(.*\.UNREACH: Unmatched ( in regex; marked by <-- HERE in m/^( <-- HERE (.*\.UNREACH)$/ at fhem.pl line 1288.
2018.07.21 18:46:08 1: stacktrace:
2018.07.21 18:46:08 1: main::devspec2array called by fhem.pl (4923)
2018.07.21 18:46:08 1: main::createNtfyHash called by fhem.pl (3499)
2018.07.21 18:46:08 1: main::DoTrigger called by fhem.pl (4531)
2018.07.21 18:46:08 1: main::readingsEndUpdate called by /opt/fhem/FHEM/88_HMCCU.pm (2841)
2018.07.21 18:46:08 1: main::HMCCU_UpdateSingleDevice called by /opt/fhem/FHEM/88_HMCCU.pm (2871)
2018.07.21 18:46:08 1: main::HMCCU_UpdateMultipleDevices called by /opt/fhem/FHEM/88_HMCCU.pm (5057)
2018.07.21 18:46:08 1: main::HMCCU_ReadRPCQueue called by fhem.pl (3127)
2018.07.21 18:46:08 1: main::HandleTimeout called by fhem.pl (646)
2018.07.21 18:46:19 1: devspec2array (.*,(.*: Unmatched ( in regex; marked by <-- HERE in m/^( <-- HERE (.*)$/ at fhem.pl line 1288.
2018.07.21 18:46:19 1: stacktrace:
2018.07.21 18:46:19 1: main::devspec2array called by fhem.pl (4923)
2018.07.21 18:46:19 1: main::createNtfyHash called by fhem.pl (3499)
2018.07.21 18:46:19 1: main::DoTrigger called by fhem.pl (4531)
2018.07.21 18:46:19 1: main::readingsEndUpdate called by /opt/fhem/FHEM/88_HMCCU.pm (2841)
2018.07.21 18:46:19 1: main::HMCCU_UpdateSingleDevice called by /opt/fhem/FHEM/88_HMCCU.pm (2871)
2018.07.21 18:46:19 1: main::HMCCU_UpdateMultipleDevices called by /opt/fhem/FHEM/88_HMCCU.pm (5057)
2018.07.21 18:46:19 1: main::HMCCU_ReadRPCQueue called by fhem.pl (3127)
2018.07.21 18:46:19 1: main::HandleTimeout called by fhem.pl (646)
2018.07.21 18:46:19 1: devspec2array (.*\.UNREACH,(.*\.UNREACH: Unmatched ( in regex; marked by <-- HERE in m/^( <-- HERE (.*\.UNREACH)$/ at fhem.pl line 1288.
2018.07.21 18:46:19 1: stacktrace:
2018.07.21 18:46:19 1: main::devspec2array called by fhem.pl (4923)
2018.07.21 18:46:19 1: main::createNtfyHash called by fhem.pl (3499)
2018.07.21 18:46:19 1: main::DoTrigger called by fhem.pl (4531)
2018.07.21 18:46:19 1: main::readingsEndUpdate called by /opt/fhem/FHEM/88_HMCCU.pm (2841)
2018.07.21 18:46:19 1: main::HMCCU_UpdateSingleDevice called by /opt/fhem/FHEM/88_HMCCU.pm (2871)
2018.07.21 18:46:19 1: main::HMCCU_UpdateMultipleDevices called by /opt/fhem/FHEM/88_HMCCU.pm (5057)
2018.07.21 18:46:19 1: main::HMCCU_ReadRPCQueue called by fhem.pl (3127)
2018.07.21 18:46:19 1: main::HandleTimeout called by fhem.pl (646)
ping: icmp open socket: Operation not permitted
2018.07.21 18:46:52 1: devspec2array (.*,(.*: Unmatched ( in regex; marked by <-- HERE in m/^( <-- HERE (.*)$/ at fhem.pl line 1288.
2018.07.21 18:46:52 1: stacktrace:
2018.07.21 18:46:52 1: main::devspec2array called by fhem.pl (4923)
2018.07.21 18:46:52 1: main::createNtfyHash called by fhem.pl (3499)
2018.07.21 18:46:52 1: main::DoTrigger called by fhem.pl (4531)
2018.07.21 18:46:52 1: main::readingsEndUpdate called by fhem.pl (4713)
2018.07.21 18:46:52 1: main::readingsSingleUpdate called by /opt/fhem/FHEM/00_MQTT.pm (522)
2018.07.21 18:46:52 1: MQTT::__ANON__ called by FHEM/GPUtils.pm (48)
2018.07.21 18:46:52 1: GPUtils::GP_ForallClients called by /opt/fhem/FHEM/00_MQTT.pm (534)
2018.07.21 18:46:52 1: MQTT::Read called by fhem.pl (3584)
2018.07.21 18:46:52 1: main::CallFn called by fhem.pl (723)
2018.07.21 18:46:52 1: devspec2array (.*\.UNREACH,(.*\.UNREACH: Unmatched ( in regex; marked by <-- HERE in m/^( <-- HERE (.*\.UNREACH)$/ at fhem.pl line 1288.
2018.07.21 18:46:52 1: stacktrace:
2018.07.21 18:46:52 1: main::devspec2array called by fhem.pl (4923)
2018.07.21 18:46:52 1: main::createNtfyHash called by fhem.pl (3499)
2018.07.21 18:46:52 1: main::DoTrigger called by fhem.pl (4531)
2018.07.21 18:46:52 1: main::readingsEndUpdate called by fhem.pl (4713)
2018.07.21 18:46:52 1: main::readingsSingleUpdate called by /opt/fhem/FHEM/00_MQTT.pm (522)
2018.07.21 18:46:52 1: MQTT::__ANON__ called by FHEM/GPUtils.pm (48)
2018.07.21 18:46:52 1: GPUtils::GP_ForallClients called by /opt/fhem/FHEM/00_MQTT.pm (534)
2018.07.21 18:46:52 1: MQTT::Read called by fhem.pl (3584)
2018.07.21 18:46:52 1: main::CallFn called by fhem.pl (723)
2018.07.21 18:47:01 1: devspec2array (.*,(.*: Unmatched ( in regex; marked by <-- HERE in m/^( <-- HERE (.*)$/ at fhem.pl line 1288.
2018.07.21 18:47:01 1: stacktrace:
2018.07.21 18:47:01 1: main::devspec2array called by fhem.pl (4923)
2018.07.21 18:47:01 1: main::createNtfyHash called by fhem.pl (3499)
2018.07.21 18:47:01 1: main::DoTrigger called by fhem.pl (4531)
2018.07.21 18:47:01 1: main::readingsEndUpdate called by /opt/fhem/FHEM/89_FULLY.pm (567)
2018.07.21 18:47:01 1: main::FULLY_UpdateReadings called by /opt/fhem/FHEM/89_FULLY.pm (489)
2018.07.21 18:47:01 1: main::FULLY_GotDeviceInfo called by (eval 283395) (1)
2018.07.21 18:47:01 1: (eval) called by fhem.pl (1112)
2018.07.21 18:47:01 1: main::AnalyzePerlCommand called by fhem.pl (1135)
2018.07.21 18:47:01 1: main::AnalyzeCommand called by fhem.pl (1059)
2018.07.21 18:47:01 1: main::AnalyzeCommandChain called by /opt/fhem/FHEM/98_telnet.pm (241)
2018.07.21 18:47:01 1: main::telnet_Read called by fhem.pl (3584)
2018.07.21 18:47:01 1: main::CallFn called by fhem.pl (723)
2018.07.21 18:47:01 1: devspec2array (.*\.UNREACH,(.*\.UNREACH: Unmatched ( in regex; marked by <-- HERE in m/^( <-- HERE (.*\.UNREACH)$/ at fhem.pl line 1288.
2018.07.21 18:47:01 1: stacktrace:
2018.07.21 18:47:01 1: main::devspec2array called by fhem.pl (4923)
2018.07.21 18:47:01 1: main::createNtfyHash called by fhem.pl (3499)
2018.07.21 18:47:01 1: main::DoTrigger called by fhem.pl (4531)
2018.07.21 18:47:01 1: main::readingsEndUpdate called by /opt/fhem/FHEM/89_FULLY.pm (567)
2018.07.21 18:47:01 1: main::FULLY_UpdateReadings called by /opt/fhem/FHEM/89_FULLY.pm (489)
2018.07.21 18:47:01 1: main::FULLY_GotDeviceInfo called by (eval 283395) (1)
2018.07.21 18:47:01 1: (eval) called by fhem.pl (1112)
2018.07.21 18:47:01 1: main::AnalyzePerlCommand called by fhem.pl (1135)
2018.07.21 18:47:01 1: main::AnalyzeCommand called by fhem.pl (1059)
2018.07.21 18:47:01 1: main::AnalyzeCommandChain called by /opt/fhem/FHEM/98_telnet.pm (241)
2018.07.21 18:47:01 1: main::telnet_Read called by fhem.pl (3584)
2018.07.21 18:47:01 1: main::CallFn called by fhem.pl (723)
ping: icmp open socket: Operation not permitted
2018.07.21 18:47:32 1: devspec2array (.*,(.*: Unmatched ( in regex; marked by <-- HERE in m/^( <-- HERE (.*)$/ at fhem.pl line 1288.
2018.07.21 18:47:32 1: stacktrace:
2018.07.21 18:47:32 1: main::devspec2array called by fhem.pl (4923)
2018.07.21 18:47:32 1: main::createNtfyHash called by fhem.pl (3499)
2018.07.21 18:47:32 1: main::DoTrigger called by fhem.pl (4531)
2018.07.21 18:47:32 1: main::readingsEndUpdate called by fhem.pl (4713)
2018.07.21 18:47:32 1: main::readingsSingleUpdate called by /opt/fhem/FHEM/00_MQTT.pm (522)
2018.07.21 18:47:32 1: MQTT::__ANON__ called by FHEM/GPUtils.pm (48)
2018.07.21 18:47:32 1: GPUtils::GP_ForallClients called by /opt/fhem/FHEM/00_MQTT.pm (534)
2018.07.21 18:47:32 1: MQTT::Read called by fhem.pl (3584)
2018.07.21 18:47:32 1: main::CallFn called by fhem.pl (723)
2018.07.21 18:47:32 1: devspec2array (.*\.UNREACH,(.*\.UNREACH: Unmatched ( in regex; marked by <-- HERE in m/^( <-- HERE (.*\.UNREACH)$/ at fhem.pl line 1288.
2018.07.21 18:47:32 1: stacktrace:
2018.07.21 18:47:32 1: main::devspec2array called by fhem.pl (4923)
2018.07.21 18:47:32 1: main::createNtfyHash called by fhem.pl (3499)
2018.07.21 18:47:32 1: main::DoTrigger called by fhem.pl (4531)
2018.07.21 18:47:32 1: main::readingsEndUpdate called by fhem.pl (4713)
2018.07.21 18:47:32 1: main::readingsSingleUpdate called by /opt/fhem/FHEM/00_MQTT.pm (522)
2018.07.21 18:47:32 1: MQTT::__ANON__ called by FHEM/GPUtils.pm (48)
2018.07.21 18:47:32 1: GPUtils::GP_ForallClients called by /opt/fhem/FHEM/00_MQTT.pm (534)
2018.07.21 18:47:32 1: MQTT::Read called by fhem.pl (3584)
2018.07.21 18:47:32 1: main::CallFn called by fhem.pl (723)
ping: icmp open socket: Operation not permitted
2018.07.21 18:47:57 1: devspec2array (.*,(.*: Unmatched ( in regex; marked by <-- HERE in m/^( <-- HERE (.*)$/ at fhem.pl line 1288.
VG, Thomas
Kannst du bitte in fhem.pl, vor der Zeile 4293 (nach dem else) folgende Zeile einfuegen:Log 1, "$d:$ndl";
und die Ausgabe hier anhaengen?
Da gibt's bei mir gar kein else.
Aber ich denke, du meinst vor dem normalen return?
Wenn ich es dort einfüge, startet FHEM nicht mehr und das Log spuckt folgendes aus:
2018.07.25 17:15:52 1: update finished, "shutdown restart" is needed to activate the changes.
2018.07.25 17:15:52 1:
2018.07.25 17:15:52 1: Please consider using the global attribute sendStatistics
ping: icmp open socket: Operation not permitted
ping: icmp open socket: Operation not permitted
2018.07.25 17:17:04 0: Server shutdown
2018.07.25 17:17:04 2: HMCCURPCPROC: [d_rpcBidCos_RF] Found no running processes. Cleaning up ...
2018.07.25 17:17:04 1: HMCCURPCPROC: [d_rpcBidCos_RF] Housekeeping called. Cleaning up RPC environment
2018.07.25 17:17:04 2: HMCCURPCPROC: [d_rpcBidCos_Wired] Found no running processes. Cleaning up ...
2018.07.25 17:17:04 1: HMCCURPCPROC: [d_rpcBidCos_Wired] Housekeeping called. Cleaning up RPC environment
2018.07.25 17:17:04 1: PERL WARNING: Use of uninitialized value $rpcdev in string eq at /opt/fhem/FHEM/88_HMCCU.pm line 3236.
2018.07.25 17:17:04 1: stacktrace:
2018.07.25 17:17:04 1: main::__ANON__ called by /opt/fhem/FHEM/88_HMCCU.pm (3236)
2018.07.25 17:17:04 1: main::HMCCU_StopExtRPCServer called by /opt/fhem/FHEM/88_HMCCU.pm (1131)
2018.07.25 17:17:04 1: main::HMCCU_Shutdown called by fhem.pl (3584)
2018.07.25 17:17:04 1: main::CallFn called by fhem.pl (1705)
2018.07.25 17:17:04 1: main::CommandShutdown called by fhem.pl (1209)
2018.07.25 17:17:04 1: main::AnalyzeCommand called by fhem.pl (1059)
2018.07.25 17:17:04 1: main::AnalyzeCommandChain called by /opt/fhem/FHEM/01_FHEMWEB.pm (2578)
2018.07.25 17:17:04 1: main::FW_fC called by /opt/fhem/FHEM/01_FHEMWEB.pm (859)
2018.07.25 17:17:04 1: main::FW_answerCall called by /opt/fhem/FHEM/01_FHEMWEB.pm (532)
2018.07.25 17:17:04 1: main::FW_Read called by fhem.pl (3584)
2018.07.25 17:17:04 1: main::CallFn called by fhem.pl (723)
2018.07.25 17:17:04 0: HMCCU: Can't find RPC device
2018.07.25 17:17:04 1: Shutdown executed
2018.07.25 17:17:06 2: HMCCURPCPROC: [d_rpcBidCos_RF] Found no running processes. Cleaning up ...
2018.07.25 17:17:06 1: HMCCURPCPROC: [d_rpcBidCos_RF] Housekeeping called. Cleaning up RPC environment
2018.07.25 17:17:06 2: HMCCURPCPROC: [d_rpcBidCos_Wired] Found no running processes. Cleaning up ...
2018.07.25 17:17:06 1: HMCCURPCPROC: [d_rpcBidCos_Wired] Housekeeping called. Cleaning up RPC environment
Global symbol "$d" requires explicit package name at fhem.pl line 4291.
Global symbol "$ndl" requires explicit package name at fhem.pl line 4291.
BEGIN not safe after errors--compilation aborted at fhem.pl line 4888.
VG, Thomas
Sorry, mein Fehler, ich meinte die Zeile 4923, so wie in deinem ersten Stacktrace erwaehnt wurde, in der Funktion createNtfyHash
Guten Morgen.
Anbei ein neuer Auszug aus dem Logfile nach dem Einfügen der Zeile und einem Restart:
EDIT: Mussste es anhängen da es zu viel für den Thread-Eintrag ist.
VG, Thomas
Da ist wohl einiges schief, Folgendes faellt mir auf:
- der Perl-Interpreter beschwert sich ueber unachtsame Programmierung in 99_myRaumfeld.pm
- HUEDevice* hat kein I/O device
- 192.168.20.21 ist nicht erreichbar
- viele nicht mehr zulaessige ReadingNamen in HTTPMOD
- CUL: Can't open /dev/ttyS0: Keine Berechtigung
- CUL: Can't open /dev/ttyS10: Eingabe-/Ausgabefehler (ich wuerde initialUsbCheck abschalten)
Das eigentliche Problem scheint mit den *monitoring Geraeten zu tun haben (Batterie_monitoring, DeviceReachable_monitoring), kannst du bitte deren Definition hier zeigen?
Das mit der Erreichbarkeit ist ein Problem da wir einen Wasserschaden hatten und dadurch einige Geräte defekt sind. Das kann ich leider erst wieder beheben wenn ich vor Ort bin.
initialUSBCheck habe ich deaktiviert und die myRaumfeld rausgeschmissen da ich die aktuell nicht mehr verwende.
Die HTTPMOD muss ich mir gleich mal anschauen was da nicht mehr zulässig ist.
Hier meine monitoring devices:
DeviceReachable_monitoring
defmod DeviceReachable_monitoring monitoring (.*\.UNREACH:.1|.*\.UNREACH:.yes|.*\.UNREACH:.true) (.*\.UNREACH:.0|.*\.UNREACH:.no|.*\.UNREACH:.false)
attr DeviceReachable_monitoring errorReturn {return unless(@errors);;\
$_ = AttrVal($_, "alias", $_) foreach(@errors);;\
return("Das Gerät \"$errors[0]\" ist schon länger nicht mehr erreichbar.") if(int(@errors) == 1);;\
@errors = sort {lc($a) cmp lc($b)} @errors;;\
return(join("\n - ", "Die folgenden ".@errors." Geräte sind schon länger nicht mehr erreichbar:", @errors))\
}
attr DeviceReachable_monitoring errorWait 60*60*24
attr DeviceReachable_monitoring group Monitoring
attr DeviceReachable_monitoring room Allgemein
attr DeviceReachable_monitoring userReadings warning_count:warning.+ {split(",", ReadingsVal($name, "warning", ""))}, \
error_count:error.+ {split(",", ReadingsVal($name, "error", ""))}, \
all_count:(warning.+|error.+) {split(",", ReadingsVal($name, "warning", "")) + split(",", ReadingsVal($name, "error", ""))}
attr DeviceReachable_monitoring warningReturn {return unless(@warnings);;\
$_ = AttrVal($_, "alias", $_) foreach(@warnings);;\
return("Das Gerät \"$warnings[0]\" ist schon länger nicht mehr erreichbar.") if(int(@warnings) == 1);;\
@warnings = sort {lc($a) cmp lc($b)} @warnings;;\
return(join("\n - ", "Die folgenden ".@warnings." Geräte sind schon länger nicht mehr erreichbar:", @warnings))\
}
Batterie_monitoring
defmod Batterie_monitoring monitoring (.*:battery:.low|.*LOWBAT:.yes|.*LOWBAT:.true) (.*:battery:.ok|.*LOWBAT:.no|.*LOWBAT:.false)
attr Batterie_monitoring errorReturn {return unless(@errors);;\
$_ = AttrVal($_, "alias", $_) foreach(@errors);;\
return("Bei dem Gerät \"$errors[0]\" ist die Batterie leer und muss gewechselt werden.") if(int(@errors) == 1);;\
@errors = sort {lc($a) cmp lc($b)} @errors;;\
return(join("\n - ", "Bei den ".@errors." Geräten sind die Batterien leer und müssen gewechselt werden:", @errors))\
}
attr Batterie_monitoring errorWait 60*60*24*14
attr Batterie_monitoring group Monitoring
attr Batterie_monitoring room Allgemein
attr Batterie_monitoring userReadings warning_count:warning.+ {split(",", ReadingsVal($name, "warning", ""))}, \
error_count:error.+ {split(",", ReadingsVal($name, "error", ""))}, \
all_count:(warning.+|error.+) {split(",", ReadingsVal($name, "warning", "")) + split(",", ReadingsVal($name, "error", ""))}
attr Batterie_monitoring warningReturn {return unless(@warnings);;\
$_ = AttrVal($_, "alias", $_) foreach(@warnings);;\
return("Bei dem Gerät \"$warnings[0]\" muss die Batterie demnächst gewechselt werden.") if(int(@warnings) == 1);;\
@warnings = sort {lc($a) cmp lc($b)} @warnings;;\
return(join("\n - ", "Bei folgenden ".@warnings." Geräten muss die Batterie demnächst gewechselt werden:", @warnings))\
}
attr Batterie_monitoring warningWait 60*60*5
Das Modul 98_monitoring.pm setzt NOTIFYDEV selbst, und erzeugt dabei einen falschen Regexp.
Der empfohlene Weg ist die vom FHEM Framework bereitgestellte notifyRegexpChanged Funktion zu verwenden.
Bitte Modul-Maintainer benachrichtigen mit Hinweis auf diese Diskussion, z.Bsp. durch neues Thema im Forums-Abschnitt Automatisierung, mit passenden Betreff.
Okay, mache ich.
Vielen Dank für deine Unterstützung. :)
VG, Thomas
Hi Rudolf,
habe es an den Entwickler weitergegeben und er ist schon dran.
Zusätzlich habe ich vorübergehend die monitoring Devices aus meinem System rausgeschmissen um zu testen ob es dann mit dem notify funktioniert.
Leider besteht mein Problem mit dem notify weiterhin. Wenn ich die vereinfachte Form verwende, wird das erste setreading ausgeführt und das zweite ignoriert als wäre es gar nicht da.
Das reading EnergyTodayFormatted sollte hier auf 5W gesetzt werden, es passiert aber nichts. Das reading EnergyToday hingegen wird korrekt gefüllt.
HM_GN_Solarstrom_[\w]+[\s:]?2\.EnergyToday:.* {
my $woodshedEnergyToday = ReadingsVal("HM_GN_Solarstrom_Woodshed","EnergyToday",0);
my $carportEnergyToday = ReadingsVal("HM_GN_Solarstrom_Carport","EnergyToday",0);
my $energyTodayTotal = ($woodshedEnergyToday + $carportEnergyToday);
fhem("setreading Solarstrom_Total EnergyToday $energyTodayTotal");
fhem("setreading Solarstrom_Total EnergyTodayFormatted 5W");
}
EDIT: Ich habe jetzt einfach mal die Reihenfolge der beiden setreading - Befehle getauscht.
Und es wird weiterhin das folgende ignoriert:
fhem("setreading Solarstrom_Total EnergyTodayFormatted 5W");
Reihenfolge kann also nicht mehr das Thema sein.
Aber das verstehe ich nicht. Wenn ich folgendes in der Kommandozeile eingebe, wird der Wert korrekt auf 5W geändert:
setreading Solarstrom_Total EnergyTodayFormatted 5W
Hast du noch eine Idee?
Nachdem Du nun schon einiges geändert hast, wäre es vielleicht hilfreich, die aktuell noch auftretende Meldung im Logfile zu sehen.
Die Klammern bei Deiner Addition kannst Du übrigens weglassen. (hat aber nix mit Deinem "Problem" zu tun)
Hallo betateilchen,
das mit der Klammer habe ich wegen der besseren Lesbarkeit. :)
Anbei ein Auszug aus dem aktuellen Log:
ping: icmp open socket: Operation not permitted
2018.07.29 18:37:23 1: PERL WARNING: 400-URL-Absolute-Error! Location: "192.168.178.46", Content: "400 URL must be absolute
" at /opt/fhem/FHEM/98_DLNARenderer.pm line 249.
2018.07.29 18:37:23 1: stacktrace:
2018.07.29 18:37:23 1: main::__ANON__ called by /usr/local/share/perl/5.20.2/Carp.pm (169)
2018.07.29 18:37:23 1: Carp::carp called by FHEM/lib/UPnP/ControlPoint.pm (368)
2018.07.29 18:37:23 1: UPnP::ControlPoint::_createDevice called by FHEM/lib/UPnP/ControlPoint.pm (400)
2018.07.29 18:37:23 1: UPnP::ControlPoint::_getDeviceFromHeaders called by FHEM/lib/UPnP/ControlPoint.pm (524)
2018.07.29 18:37:23 1: UPnP::ControlPoint::_receiveSSDPEvent called by FHEM/lib/UPnP/ControlPoint.pm (225)
2018.07.29 18:37:23 1: UPnP::ControlPoint::handleOnce called by /opt/fhem/FHEM/98_DLNARenderer.pm (249)
2018.07.29 18:37:23 1: (eval) called by /opt/fhem/FHEM/98_DLNARenderer.pm (248)
2018.07.29 18:37:23 1: main::DLNARenderer_Read called by fhem.pl (3584)
2018.07.29 18:37:23 1: main::CallFn called by fhem.pl (723)
2018.07.29 18:37:23 1: PERL WARNING: Loading device description failed with error: 400 URL must be absolute (Location: 192.168.178.46) at /opt/fhem/FHEM/98_DLNARenderer.pm line 249.
2018.07.29 18:37:23 1: stacktrace:
2018.07.29 18:37:23 1: main::__ANON__ called by /usr/local/share/perl/5.20.2/Carp.pm (169)
2018.07.29 18:37:23 1: Carp::carp called by FHEM/lib/UPnP/ControlPoint.pm (369)
2018.07.29 18:37:23 1: UPnP::ControlPoint::_createDevice called by FHEM/lib/UPnP/ControlPoint.pm (400)
2018.07.29 18:37:23 1: UPnP::ControlPoint::_getDeviceFromHeaders called by FHEM/lib/UPnP/ControlPoint.pm (524)
2018.07.29 18:37:23 1: UPnP::ControlPoint::_receiveSSDPEvent called by FHEM/lib/UPnP/ControlPoint.pm (225)
2018.07.29 18:37:23 1: UPnP::ControlPoint::handleOnce called by /opt/fhem/FHEM/98_DLNARenderer.pm (249)
2018.07.29 18:37:23 1: (eval) called by /opt/fhem/FHEM/98_DLNARenderer.pm (248)
2018.07.29 18:37:23 1: main::DLNARenderer_Read called by fhem.pl (3584)
2018.07.29 18:37:23 1: main::CallFn called by fhem.pl (723)
2018.07.29 18:37:23 1: PERL WARNING: 400-URL-Absolute-Error! Location: "192.168.178.46", Content: "400 URL must be absolute
" at /opt/fhem/FHEM/98_DLNARenderer.pm line 249.
2018.07.29 18:37:23 1: stacktrace:
2018.07.29 18:37:23 1: main::__ANON__ called by /usr/local/share/perl/5.20.2/Carp.pm (169)
2018.07.29 18:37:23 1: Carp::carp called by FHEM/lib/UPnP/ControlPoint.pm (368)
2018.07.29 18:37:23 1: UPnP::ControlPoint::_createDevice called by FHEM/lib/UPnP/ControlPoint.pm (400)
2018.07.29 18:37:23 1: UPnP::ControlPoint::_getDeviceFromHeaders called by FHEM/lib/UPnP/ControlPoint.pm (524)
2018.07.29 18:37:23 1: UPnP::ControlPoint::_receiveSSDPEvent called by FHEM/lib/UPnP/ControlPoint.pm (225)
2018.07.29 18:37:23 1: UPnP::ControlPoint::handleOnce called by /opt/fhem/FHEM/98_DLNARenderer.pm (249)
2018.07.29 18:37:23 1: (eval) called by /opt/fhem/FHEM/98_DLNARenderer.pm (248)
2018.07.29 18:37:23 1: main::DLNARenderer_Read called by fhem.pl (3584)
2018.07.29 18:37:23 1: main::CallFn called by fhem.pl (723)
2018.07.29 18:37:23 1: PERL WARNING: Loading device description failed with error: 400 URL must be absolute (Location: 192.168.178.46) at /opt/fhem/FHEM/98_DLNARenderer.pm line 249.
2018.07.29 18:37:23 1: stacktrace:
2018.07.29 18:37:23 1: main::__ANON__ called by /usr/local/share/perl/5.20.2/Carp.pm (169)
2018.07.29 18:37:23 1: Carp::carp called by FHEM/lib/UPnP/ControlPoint.pm (369)
2018.07.29 18:37:23 1: UPnP::ControlPoint::_createDevice called by FHEM/lib/UPnP/ControlPoint.pm (400)
2018.07.29 18:37:23 1: UPnP::ControlPoint::_getDeviceFromHeaders called by FHEM/lib/UPnP/ControlPoint.pm (524)
2018.07.29 18:37:23 1: UPnP::ControlPoint::_receiveSSDPEvent called by FHEM/lib/UPnP/ControlPoint.pm (225)
2018.07.29 18:37:23 1: UPnP::ControlPoint::handleOnce called by /opt/fhem/FHEM/98_DLNARenderer.pm (249)
2018.07.29 18:37:23 1: (eval) called by /opt/fhem/FHEM/98_DLNARenderer.pm (248)
2018.07.29 18:37:23 1: main::DLNARenderer_Read called by fhem.pl (3584)
2018.07.29 18:37:23 1: main::CallFn called by fhem.pl (723)
2018.07.29 18:37:23 1: PERL WARNING: 400-URL-Absolute-Error! Location: "192.168.178.46", Content: "400 URL must be absolute
" at /opt/fhem/FHEM/98_DLNARenderer.pm line 249.
2018.07.29 18:37:23 1: stacktrace:
2018.07.29 18:37:23 1: main::__ANON__ called by /usr/local/share/perl/5.20.2/Carp.pm (169)
2018.07.29 18:37:23 1: Carp::carp called by FHEM/lib/UPnP/ControlPoint.pm (368)
2018.07.29 18:37:23 1: UPnP::ControlPoint::_createDevice called by FHEM/lib/UPnP/ControlPoint.pm (400)
2018.07.29 18:37:23 1: UPnP::ControlPoint::_getDeviceFromHeaders called by FHEM/lib/UPnP/ControlPoint.pm (524)
2018.07.29 18:37:23 1: UPnP::ControlPoint::_receiveSSDPEvent called by FHEM/lib/UPnP/ControlPoint.pm (225)
2018.07.29 18:37:23 1: UPnP::ControlPoint::handleOnce called by /opt/fhem/FHEM/98_DLNARenderer.pm (249)
2018.07.29 18:37:23 1: (eval) called by /opt/fhem/FHEM/98_DLNARenderer.pm (248)
2018.07.29 18:37:23 1: main::DLNARenderer_Read called by fhem.pl (3584)
2018.07.29 18:37:23 1: main::CallFn called by fhem.pl (723)
2018.07.29 18:37:23 1: PERL WARNING: Loading device description failed with error: 400 URL must be absolute (Location: 192.168.178.46) at /opt/fhem/FHEM/98_DLNARenderer.pm line 249.
2018.07.29 18:37:23 1: stacktrace:
2018.07.29 18:37:23 1: main::__ANON__ called by /usr/local/share/perl/5.20.2/Carp.pm (169)
2018.07.29 18:37:23 1: Carp::carp called by FHEM/lib/UPnP/ControlPoint.pm (369)
2018.07.29 18:37:23 1: UPnP::ControlPoint::_createDevice called by FHEM/lib/UPnP/ControlPoint.pm (400)
2018.07.29 18:37:23 1: UPnP::ControlPoint::_getDeviceFromHeaders called by FHEM/lib/UPnP/ControlPoint.pm (524)
2018.07.29 18:37:23 1: UPnP::ControlPoint::_receiveSSDPEvent called by FHEM/lib/UPnP/ControlPoint.pm (225)
2018.07.29 18:37:23 1: UPnP::ControlPoint::handleOnce called by /opt/fhem/FHEM/98_DLNARenderer.pm (249)
2018.07.29 18:37:23 1: (eval) called by /opt/fhem/FHEM/98_DLNARenderer.pm (248)
2018.07.29 18:37:23 1: main::DLNARenderer_Read called by fhem.pl (3584)
2018.07.29 18:37:23 1: main::CallFn called by fhem.pl (723)
ping: icmp open socket: Operation not permitted
Die alten Fehlermeldungen sind durch das löschen der monitoring devices verschwunden.
Fehlermeldungen die jetzt noch im Log sind, weisen noch auf die Geräte hin die aufgrund von Wasserschaden aktuell noch außer Betrieb sind.
Bitte diese Diskussion nicht hier weiterfuehren, es hat doch nichts mit dem Betreff zu tun.
Und: bitte ein "attr global verbose 5" Log-Mitschnitt nach dem Eintreffen des entsprechenden Events im anderen Thread anhaengen.