komische maximallast von perl - kennt das wer?

Wernieman · 14 Juni 2017, 21:44:47

Stichwort: apptime

the ratman · 14 Juni 2017, 21:57:46

ah, thx

da kommt dann:

name                                     function                               max  count    total  average maxDly TS Max call     param Max call 
 WEB_192.168.178.35_40794                 FW_Read                                516     52     2399    46.13      0 14.06. 21:56:48 HASH(WEB_192.168.178.35_40794) 
 WEB_192.168.178.35_40795                 FW_Read                                493     51      959    18.80      0 14.06. 21:56:45 HASH(WEB_192.168.178.35_40795) 
 WEB_192.168.178.35_40793                 FW_Read                                482     48     1429    29.77      0 14.06. 21:56:45 HASH(WEB_192.168.178.35_40793) 
 WEB_192.168.178.35_40796                 FW_Read                                464     51      482     9.45      0 14.06. 21:56:46 HASH(WEB_192.168.178.35_40796) 
 WEB_192.168.178.35_40792                 FW_Read                                462     46      473    10.28      0 14.06. 21:56:50 HASH(WEB_192.168.178.35_40792) 
 WEB_192.168.178.35_40791                 FW_Read                                448     55      464     8.44      0 14.06. 21:56:52 HASH(WEB_192.168.178.35_40791) 
 tmr-MPD_watch_idle                       HASH(0x3f40168)                         45      1       45    45.00    135 14.06. 21:56:53 HASH(Luke7_Stream) 
 tmr-LGTV_WebOS_TimerStatusRequest        HASH(0x3c522d0)                         41      1       41    41.00      1 14.06. 21:56:44 HASH(Fembotter) 
 Fembotter                                LGTV_WebOS_Read                         18      5       57    11.40      0 14.06. 21:56:52 HASH(Fembotter) 
 tmr-DbLog_execmemcache                   HASH(0x13ac990)                         13      1       13    13.00      1 14.06. 21:56:52 HASH(logdb) 
 moRat_Geraetestatus                      readingsGroup_Notify                    11     10       11     1.10      0 14.06. 21:56:46 HASH(moRat_Geraetestatus); HASH(Ping_ratOtab) 
 HMUSB                                    HMLAN_Read                               9      1        9     9.00      0 14.06. 21:56:46 HASH(HMUSB) 
 WEB_192.168.178.30_4747                  FW_Read                                  3      1        3     3.00      0 14.06. 21:56:44 HASH(WEB_192.168.178.30_4747) 
 WEB                                      FW_Read                                  1      1        1     1.00      0 14.06. 21:56:44 HASH(WEB) 
 WEB_192.168.178.26_60304                 FW_Notify                                1     10        1     0.10      0 14.06. 21:56:46 HASH(WEB_192.168.178.26_60304); HASH(moRat_Geraetestatus) 
 WEB_192.168.178.30_4739                  FW_Read                                  1      2        1     0.50      0 14.06. 21:56:44 HASH(WEB_192.168.178.30_4739) 
 tmr-BlockingKill                         HASH(0x148c0a0)                          1      1        1     1.00    298 14.06. 21:56:47 HASH(0x148c0a0) 
 tmr-HMLAN_KeepAlive                      keepAlive:HMUSB                          1      1        1     1.00    472 14.06. 21:56:46 keepAlive:HMUSB 
 tmr-LGTV_WebOS_Get3DStatus               HASH(0x3c522d0)                          1      1        1     1.00     54 14.06. 21:56:50 HASH(Fembotter) 
 tmr-LGTV_WebOS_GetCurrentChannel         HASH(0x3c522d0)                          1      1        1     1.00    241 14.06. 21:56:46 HASH(Fembotter) 
 tmr-LGTV_WebOS_GetExternalInputList      HASH(0x3c522d0)                          1      1        1     1.00      2 14.06. 21:56:52 HASH(Fembotter)

noch ein 2. mal sicherheitshalber:

Code Auswählen

 name                                     function                               max  count    total  average maxDly TS Max call     param Max call 
 WEB_192.168.178.35_40793                 FW_Read                                503      5      965   193.00      0 14.06. 21:59:03 HASH(WEB_192.168.178.35_40793) 
 WEB_192.168.178.35_40792                 FW_Read                                484      5      948   189.60      0 14.06. 21:59:04 HASH(WEB_192.168.178.35_40792) 
 WEB_192.168.178.35_40794                 FW_Read                                482      3     1408   469.33      0 14.06. 21:59:05 HASH(WEB_192.168.178.35_40794) 
 WEB_192.168.178.35_40795                 FW_Read                                476      5      941   188.20      0 14.06. 21:59:07 HASH(WEB_192.168.178.35_40795) 
 WEB_192.168.178.35_40791                 FW_Read                                466      3      929   309.67      0 14.06. 21:59:04 HASH(WEB_192.168.178.35_40791) 
 WEB_192.168.178.35_40796                 FW_Read                                461      5      464    92.80      0 14.06. 21:59:02 HASH(WEB_192.168.178.35_40796) 
 AMADCommBridge_192.168.178.26_58366      AMAD_CommBridge_Read                    19      1       19    19.00      0 14.06. 21:59:07 HASH(AMADCommBridge_192.168.178.26_58366) 
 tmr-FRITZBOX_Readout_Start               FritzBox.Readout                        11      1       11    11.00     93 14.06. 21:59:03 FritzBox.Readout 
 Fembotter                                LGTV_WebOS_Read                         10      2       10     5.00      0 14.06. 21:59:07 HASH(Fembotter) 
 tmr-BlockingKill                         HASH(0x48ecf20)                          2      1        2     2.00    375 14.06. 21:59:04 HASH(0x48ecf20) 
 telnetForBlockingFn_1497470151_127.0.0.1_52914 telnet_Read                              2      6        2     0.33      0 14.06. 21:59:05 HASH(telnetForBlockingFn_1497470151_127.0.0.1_52914) 
 AMADCommBridge                           AMAD_CommBridge_Read                     1     10        1     0.10      0 14.06. 21:59:04 HASH(AMADCommBridge) 
 DLNASocket-dlnadevices-23                DLNARenderer_Read                        1      2        1     0.50      0 14.06. 21:59:06 HASH(DLNASocket-dlnadevices-23) 
 WEB_192.168.178.30_4766                  FW_Read                                  1      2        1     0.50      0 14.06. 21:59:04 HASH(WEB_192.168.178.30_4766) 
 tmr-BlockingKill                         HASH(0x49375b0)                          1      1        1     1.00    157 14.06. 21:59:05 HASH(0x49375b0) 
 tmr-LGTV_WebOS_Get3DStatus               HASH(0x3c522d0)                          1      1        1     1.00    397 14.06. 21:59:05 HASH(Fembotter) 
 tmr-LGTV_WebOS_GetExternalInputList      HASH(0x3c522d0)                          1      1        1     1.00    311 14.06. 21:59:07 HASH(Fembotter) 
 tmr-LGTV_WebOS_GetForgroundAppInfo       HASH(0x3c522d0)                          1      1        1     1.00    377 14.06. 21:59:03 HASH(Fembotter) 
 AbfallReminder                           DOIF_Notify                              0      8        0     0.00      0 
 Abfallinfo                               ABFALL_Notify                            0      8        0     0.00      0 
 AnrufInfo_DOIF                           DOIF_Notify                              0      8        0     0.00      0

nachtrag:
ich hatte fhem in der nacht aus ... jetzt eben eingeschaltet wieder, morgendliches update gemacht ... rennt wieder.
am abschalten allein kanns ja ned liegen. das hab ich schon x mal gestern gemacht. inkl. raspi restarten und ganz vom strom nehmen.
das problem bringt micht echt um den verstand.

Wernieman · 15 Juni 2017, 08:55:45

Sorry aber da müssen Spezialisten ran.

Könntest Du das "Gelost" im Threadtitel löschen?

frank · 15 Juni 2017, 10:48:13

das letzte problem mit rc_dot_svg hast du doch bestens gelöst. das prinzip hat sich also bewähert.
gab es nun nicht wieder entsprechende logmeldungen über irgendwas?

the ratman · 15 Juni 2017, 11:23:12

ja, nur das rc-dot wars wohl nicht wirklich, muß damals zufall gewesen sein, ich hatte gestern alle 3 rg's, die die gfx verwenden brutal gelöscht und fhem neu gestartet - war dem ding egal. ich nehm mal an, damals hatte ich die starseite von fhem offen und da stehen genau die 3 rg's, damit ich auf einen blick batteriestände und gerätezustände sehen kann.
im fhem log gibts überhaupt nix. das tut so, als ob alles bestens wäre.
was beim strace auffällt: das schaut im "normalbetrieb" nicht viel anders aus, als wenns spinnt. allerdings rennen die infos da eher schubweise durch, wenns spinnt scheinen das wesentlich mehr meldungen als normal zu sein und alles rennt in affenartiger geschwindigkeit, wie wenn fhem keine rückmeldungen kriegen würd und deswegen immer permanent die devices abfragt. das nur als beschreibung, falls das verhalten wer kennt.
was halt lustig ist - nach ner zeit hört der spuk scheinbar von selber auf. die ersten beiden male nach 2 oder 3 stunden, diesmal halt beim neu anstarten in der früh. dumm is halt, dass ich keine zeit sagen kann, wanns passier ...

beim nächsten mal kopier ich mal meine config weg und nehm die demo.cfg. dann weiß ich wenigstens, obs an mir oder was anderem liegt.

Wernieman · 15 Juni 2017, 15:26:02

... hast DU eigentlich eine RTC?

the ratman · 15 Juni 2017, 15:55:19

meinste ne echtzeituhr?

du sagst da was ... ich hatte mal kurzfristig eine s.usv. hab ich dann aber zurückgegeben. ich glaub die hatte ne echtzeituhr.
kanns sein?

aber wenn - wie kann ichs richten?
und wenn - warum spinnt das blöde ding ned immer beim rebooten oder so?

Wernieman · 15 Juni 2017, 15:57:51

Die Frage ist, ob Du JETZT eine hast, die hätte ich mal testweise entfernt ...

Bekannt ist, das FHEM Probleme hat, wenn Die Uhrzeit spinnt .... bzw. DU könntest, wenn DU Probleme hast, gucken was die Uhrzeit macht ...

the ratman · 15 Juni 2017, 16:04:20

ein raspi hat von haus aus keine, meines wissens nach.
somit hat mein raspi auch keine drinnen.
wie gesagt: die s.usv hatte eine - und ich kann mich nicht erinnern, irgendwelche sachen nach dem entfernen der s.usv umgestellt zu haben. drum auch meine vorherige vermutung, dass ich da noch altlasten haben könnte.

ich weiß jetzt nur, dass auch div. zeitabfragen beim "spinnen" aufgetaucht sind
hatte ich hier schon nebenher gepostet - ich wiederhole (ist zwar vom vorletzten mal, aber gestern auch wieder gekommen):

Code Auswählen

brk(0x56ab000)                          = 0x56ab000
brk(0x564c000)                          = 0x564c000
read(9, "E461363,0000,0003BB0C,FF,FFCD,4B"..., 4096) = 58
gettimeofday({1497185015, 975057}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 975381}, NULL) = 0
gettimeofday({1497185015, 975583}, NULL) = 0
gettimeofday({1497185015, 976009}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 976467}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 976702}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 977361}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 979764}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 980654}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 981715}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 982036}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 983188}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 983959}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 984742}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 985123}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 986911}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 987352}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 990521}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 991217}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 991739}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 992117}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 995018}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 995683}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 996209}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 996560}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 998325}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185015, 998775}, NULL) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185016, 497}, NULL)   = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185016, 949}, NULL)   = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185016, 3099}, NULL)  = 0
gettimeofday({1497185016, 3515}, NULL)  = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185016, 3781}, NULL)  = 0
gettimeofday({1497185016, 4414}, NULL)  = 0
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2211, ...}) = 0
gettimeofday({1497185016, 4902}, NULL)  = 0

sonst kann ich dazu nur sagen, dass die uhrzeit zumindest auf der grafischen oberfläche gepasst hat, als er gestern gesponnen hat.

Wernieman · 15 Juni 2017, 16:15:29

"grafischen oberfläche" ... liebe ich auf einem Server .... Sorry für die Ironie

Wir reden hier von Millisekunden, das siehst Du grafisch nicht.

Code Auswählen

date "+%H:%M:%S-%N"
Allerdings kann man manuell es auch schlecht sehen ;o)

Was mir noch einfäööt, hast Du einen Zeitabgleich per ntpdate ins Internet? Also nicht ntpd sondern per cron?

the ratman · 15 Juni 2017, 16:21:11

ich hab zumindest keinen cronjob dafür angelegt. alles standard raspi quasi.

und ja, ich weiß, dass grafische oberflächen nicht die freunde von admins sind.
allerdings ist das meine einzige möglichkeit, tatsächlich ein paar infos zusammen zu tragen. mir nützt ja keine console was, wenn ich ned weiß, was ich reintippen soll. bei mir is die console nur für copy&paste da, damit helfende wie du infos kriegen.

brauchtest du das?

Code Auswählen

pi@ratOhaus:~ $ date "+%H:%M:%S-%N"
16:20:41-998440212

Wernieman · 15 Juni 2017, 16:32:03

Naja .. Du solltest bei Problemen damit gucken, was die Uhrzeit so sagt.

Nur um sicherzugehen:

Code Auswählen

grep -r ntp /etc/cron* /var/spool/cron
ps aux | grep ntp

the ratman · 15 Juni 2017, 16:37:16

ah, ok

deine 2 neuen mit sudo, weil er sonst wegen rechten jammert:

Code Auswählen

pi@ratOhaus:~ $ sudo grep -r ntp /etc/cron* /var/spool/cron
/etc/cron.daily/ntp:# The default Debian ntp.conf enables logging of various statistics to
/etc/cron.daily/ntp:# the /var/log/ntpstats directory.  The daemon automatically changes
/etc/cron.daily/ntp:statsdir=$(cat /etc/ntp.conf | grep -v '^#' | sed -n 's/statsdir \([^ ][^ ]*\)/\1/p')
pi@ratOhaus:~ $ sudo ps aux | grep ntp
ntp        881  0.0  0.4   5776  3824 ?        Ss   Jun14   0:06 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /var/lib/ntp/ntp.conf.dhcp -u 106:111
pi       18775  0.0  0.2   4300  2016 pts/1    S+   16:36   0:00 grep --color=auto ntp
pi@ratOhaus:~ $

Wernieman · 15 Juni 2017, 17:29:00

1. Du hast keinen Timecron
2. Du hast einen echten ntpd laufen

Um es einfach Mal auszuprobieren, könntest Du den ntpd runterfahren und Testen?

the ratman · 15 Juni 2017, 18:19:46

mein taskmanager lässt mich nicht und console - wie immer - weiß ich ned wie.

btw - wenn du mir sagst, wie ich den abstell, dann bitte auch gleich sagen, wie der wieder an geht - so spielchen wie gestern kosten mir immer 5 min meines lebens. das brauch ich ned jeden tag, sonst hast du bald keinen mehr, der dir auf die nerven gehen kann *g*.
btw - erst mal ein fettes danke für deine zeit, gelle!