Cubietruck abstürze durch fhem.service bzw. Perl Speicherverbrauch

Begonnen von Tommy82, 11 November 2020, 04:54:44

Vorheriges Thema - Nächstes Thema

Tommy82

Hallo,
ich habe seit ca. Anfang Oktober plötzlich alle paar Tage das sich mein Cubietruck "aufhängt", es hilft nur noch denn Stecker ziehen. Bis dahin lief er sehr lange ohne jegliche Problem.

Nach ein bisschen logs lesen bin ich in denn linux logs des Cubies (armbian) auf diese beiden Meldungen kurz vor dem "hängen" bleiben gestossen

In /usr/log/messages
Nov 11 00:33:48 localhost kernel: [454680.731222] [  19841]  1000 19841   453513   438156  1810432        0             0 perl
Nov 11 00:33:48 localhost kernel: [454680.731231] [  19933]  1000 19933    40085     4942   178176        0             0 node /usr/local
Nov 11 00:33:48 localhost kernel: [454680.731240] [  20030]  1000 20030     2722      127    20480        0             0 ssh
Nov 11 00:33:48 localhost kernel: [454680.731255] [  10072]  1000 10072   453404   437922  1810432        0             0 perl
Nov 11 00:33:48 localhost kernel: [454680.731263] [  10095]  1000 10095   453513   438041  1810432        0             0 perl
Nov 11 00:33:48 localhost kernel: [454680.731272] [  10100]  1000 10100   453513   438041  1808384        0             0 perl
Nov 11 00:33:48 localhost kernel: [454680.731277] oom-kill:constraint=CONSTRAINT_NONE,nodemask=(null),cpuset=/,mems_allowed=0,global_oom,task_memcg=/system.slice/fhem.service,task=perl,pid=19841,uid=1000
Nov 11 00:33:49 localhost kernel: [454681.241335] oom_reaper: reaped process 19841 (perl), now anon-rss:0kB, file-rss:0kB, shmem-rss:0kB
Nov 11 04:17:35 localhost rsyslogd: action '*' treated as ':omusrmsg:*' - please use ':omusrmsg:*' syntax instead, '*' will not be supported in the future [v8.1901.0 try https://www.rsyslog.com/e/2184 ]
Nov 11 04:17:35 localhost rsyslogd: imuxsock: Acquired UNIX socket '/run/systemd/journal/syslog' (fd 3) from systemd.  [v8.1901.0]
Nov 11 04:17:35 localhost rsyslogd:  [origin software="rsyslogd" swVersion="8.1901.0" x-pid="473" x-info="https://www.rsyslog.com"] start
Nov 11 04:17:35 localhost rsyslogd: action 'action-10-builtin:ompipe' suspended (module 'builtin:ompipe'), retry 0. There should be messages before this one giving the reason for suspension. [v8.1901.0 try https://www.rsyslog.com/e/2007 ]
Nov 11 04:17:35 localhost rsyslogd: action 'action-10-builtin:ompipe' suspended (module 'builtin:ompipe'), next retry is Wed Nov 11 04:18:05 2020, retry nbr 0. There should be messages before this one giving the reason for suspension. [v8.1901.0 try https://www.rsyslog.com/e/2007 ]


und in /user/log/syslog

Nov 11 00:33:48 localhost kernel: [454680.731277] oom-kill:constraint=CONSTRAINT_NONE,nodemask=(null),cpuset=/,mems_allowed=0,global_oom,task_memcg=/system.slice/fhem.service,task=perl,pid=19841,uid=1000
Nov 11 00:33:48 localhost kernel: [454680.731359] Out of memory: Killed process 19841 (perl) total-vm:1814052kB, anon-rss:1752172kB, file-rss:452kB, shmem-rss:0kB, UID:1000 pgtables:1768kB oom_score_adj:0
Nov 11 00:33:49 localhost kernel: [454681.241335] oom_reaper: reaped process 19841 (perl), now anon-rss:0kB, file-rss:0kB, shmem-rss:0kB
Nov 11 00:33:49 localhost systemd[1]: fhem.service: Main process exited, code=killed, status=9/KILL
Nov 11 00:33:58 localhost systemd[1]: fhem.service: Failed with result 'signal'.
Nov 11 00:33:59 localhost systemd[1]: fhem.service: Service RestartSec=100ms expired, scheduling restart.
Nov 11 00:33:59 localhost systemd[1]: fhem.service: Scheduled restart job, restart counter is at 9.
Nov 11 00:33:59 localhost systemd[1]: Stopped FHEM Home Automation.
Nov 11 00:33:59 localhost systemd[1]: Starting FHEM Home Automation...
Nov 11 00:34:00 localhost systemd[1]: Started FHEM Home Automation.
Nov 11 00:34:29 localhost hmland[604]: usb-transfer took more than 100ms (134ms), this may lead to timing problems!
Nov 11 00:34:38 localhost hmland[604]: usb-transfer took more than 100ms (131ms), this may lead to timing problems!
Nov 11 00:35:01 localhost CRON[10325]: (root) CMD (command -v debian-sa1 > /dev/null && debian-sa1 1 1)
Nov 11 04:17:35 localhost fake-hwclock[235]: Current system time: 2020-11-11 03:17:28
Nov 11 04:17:35 localhost fake-hwclock[235]: fake-hwclock saved clock information is in the past: 2020-11-01 13:48:10
Nov 11 04:17:35 localhost fake-hwclock[235]: To set system time to this saved clock anyway, use "force"
Nov 11 04:17:35 localhost systemd-remount-fs[245]: mount: /etc/fstab: parse error at line 3 -- ignored


Nach dem fhem.service kommt auf einmal out of mermory.

Was mir erst garnicht aufgefallen ist, ich dann aber im Fhem log auch gesehen habe ist, das fhem plötzlich immer mal wieder Neustartet ohne erkennbaren grund. In diesem Fall um 00:34 und um 00:32 gibt es ein DbLog Problem so wie es aussieht

2020.11.11 00:32:59.885 2: DbLog myDbLog -> DbLog_PushAsync Process died prematurely
2020.11.11 00:34:00.608 1: Including fhem.cfg
2020.11.11 00:34:00.717 3: telnetPort: port 7072 opened
2020.11.11 00:34:01.838 3: WEB: port 8083 opened
2020.11.11 00:34:01.893 3: WEBphone: port 8084 opened


Was könnte das Problem verursachen?

Danke
Fhem Cubitruck  Armbian Buster with Linux 5.3.9-sunxi
HM-CC_RT-DN, HM-Sec-RHS,HM-Sec-SD, HM-Sec-SCo,IT1500,1xIT GRR-3500 Fritz!Dect200,Powerline546E,Enigma2 Modul mit 3 Vu+,Wol Modul für WinServer2016 und WinServer 2019,FB6590
Allnetl Wandtablett mit FTUI

Wernieman

messages
1. 00:33:48: dort ist ein Kern.Dump. Könntest Du uns den Anfang des Dumpes + 2 Zeilen davor geben?
2. 04:17:35  syslog hat ein Problem ...

syslog
1. Siehe gleiche Zeiten wie oben
2. 00:33:49 Zum obengenannten Kern. Dump kommt ein oom-Kill von FHEM. Ob Symptom oder Ursache ... s.o.

Also:
Entweder hast Du ein HardwareProblem, ein Memory-Verbrauch oder .... der Cubi hat doch auch eine SDCard?
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

Tommy82

Hallo,
hier der gewünschte
Log Bereich

Nov 11 00:32:51 localhost kernel: [454623.580814] oom-kill:constraint=CONSTRAINT_NONE,nodemask=(null),cpuset=/,mems_allowed=0,global_oom,task_memcg=/system.slice/fhem.service,task=perl,pid=9922,uid=1000
Nov 11 00:32:52 localhost kernel: [454624.358596] oom_reaper: reaped process 9922 (perl), now anon-rss:0kB, file-rss:0kB, shmem-rss:0kB
Nov 11 00:33:48 localhost kernel: [454680.730475] perl invoked oom-killer: gfp_mask=0x400dc2(GFP_KERNEL_ACCOUNT|__GFP_HIGHMEM|__GFP_ZERO), order=0, oom_score_adj=0
Nov 11 00:33:48 localhost kernel: [454680.730496] CPU: 1 PID: 10072 Comm: perl Tainted: G         C  E     5.8.16-sunxi #20.08.14
Nov 11 00:33:48 localhost kernel: [454680.730500] Hardware name: Allwinner sun7i (A20) Family
Nov 11 00:33:48 localhost kernel: [454680.730537] [<c010d6cd>] (unwind_backtrace) from [<c0109a7d>] (show_stack+0x11/0x14)
Nov 11 00:33:48 localhost kernel: [454680.730555] [<c0109a7d>] (show_stack) from [<c056e1c9>] (dump_stack+0x75/0x84)
Nov 11 00:33:48 localhost kernel: [454680.730572] [<c056e1c9>] (dump_stack) from [<c020d70b>] (dump_header+0x43/0x16a)
Nov 11 00:33:48 localhost kernel: [454680.730587] [<c020d70b>] (dump_header) from [<c020ce73>] (oom_kill_process+0x123/0x12c)
Nov 11 00:33:48 localhost kernel: [454680.730597] [<c020ce73>] (oom_kill_process) from [<c020d59f>] (out_of_memory+0x19b/0x260)
Nov 11 00:33:48 localhost kernel: [454680.730613] [<c020d59f>] (out_of_memory) from [<c0243c63>] (__alloc_pages_nodemask+0x913/0xc40)
Nov 11 00:33:48 localhost kernel: [454680.730627] [<c0243c63>] (__alloc_pages_nodemask) from [<c0230273>] (__pte_alloc+0x1f/0x118)
Nov 11 00:33:48 localhost kernel: [454680.730639] [<c0230273>] (__pte_alloc) from [<c0230d7d>] (copy_page_range+0x455/0x554)
Nov 11 00:33:48 localhost kernel: [454680.730655] [<c0230d7d>] (copy_page_range) from [<c011949b>] (dup_mm+0x21f/0x340)
Nov 11 00:33:48 localhost kernel: [454680.730667] [<c011949b>] (dup_mm) from [<c011a759>] (copy_process+0xf75/0x1218)
Nov 11 00:33:48 localhost kernel: [454680.730679] [<c011a759>] (copy_process) from [<c011ab5f>] (_do_fork+0x63/0x344)
Nov 11 00:33:48 localhost kernel: [454680.730692] [<c011ab5f>] (_do_fork) from [<c011b07f>] (sys_clone+0x5b/0x74)
Nov 11 00:33:48 localhost kernel: [454680.730704] [<c011b07f>] (sys_clone) from [<c0100061>] (ret_fast_syscall+0x1/0x62)
Nov 11 00:33:48 localhost kernel: [454680.730710] Exception stack(0xed05ffa8 to 0xed05fff0)
Nov 11 00:33:48 localhost kernel: [454680.730720] ffa0:                   b6f69078 b6f694d0 01200011 00000000 00000000 00000000
Nov 11 00:33:48 localhost kernel: [454680.730730] ffc0: b6f69078 b6f694d0 00000000 00000078 00000000 00000000 b6f69010 00000001
Nov 11 00:33:48 localhost kernel: [454680.730737] ffe0: 00000078 bea008d8 b6e15253 b6db7746
Nov 11 00:33:48 localhost kernel: [454680.730742] Mem-Info:
Nov 11 00:33:48 localhost kernel: [454680.730761] active_anon:459843 inactive_anon:5141 isolated_anon:0
Nov 11 00:33:48 localhost kernel: [454680.730761]  active_file:268 inactive_file:308 isolated_file:32
Nov 11 00:33:48 localhost kernel: [454680.730761]  unevictable:4 dirty:0 writeback:0
Nov 11 00:33:48 localhost kernel: [454680.730761]  slab_reclaimable:3671 slab_unreclaimable:7421
Nov 11 00:33:48 localhost kernel: [454680.730761]  mapped:1636 shmem:5228 pagetables:4752 bounce:0
Nov 11 00:33:48 localhost kernel: [454680.730761]  free:21875 free_pcp:0 free_cma:10211
Nov 11 00:33:48 localhost kernel: [454680.730774] Node 0 active_anon:1839372kB inactive_anon:20564kB active_file:1072kB inactive_file:1232kB unevictable:16kB isolated(anon):0kB isolated(file):128kB mapped:6544kB dirty:0kB writeback:0kB shmem:20912kB writeback_tmp:0kB all_unreclaimable? no
Nov 11 00:33:48 localhost kernel: [454680.730793] Normal free:83348kB min:3436kB low:4292kB high:5148kB reserved_highatomic:0KB active_anon:571240kB inactive_anon:5144kB active_file:120kB inactive_file:560kB unevictable:0kB writepending:0kB present:786432kB managed:749504kB mlocked:0kB kernel_stack:1168kB pagetables:5592kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:40844kB
Nov 11 00:33:48 localhost kernel: [454680.730795] lowmem_reserve[]: 0 10216 0
Nov 11 00:33:48 localhost kernel: [454680.730816] HighMem free:4152kB min:5840kB low:7360kB high:8880kB reserved_highatomic:0KB active_anon:1268132kB inactive_anon:15420kB active_file:1000kB inactive_file:1232kB unevictable:16kB writepending:0kB present:1307648kB managed:1307648kB mlocked:16kB kernel_stack:0kB pagetables:13416kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
Nov 11 00:33:48 localhost kernel: [454680.730818] lowmem_reserve[]: 0 0 0
Nov 11 00:33:48 localhost kernel: [454680.730825] Normal: 855*4kB (UMEC) 416*8kB (UMEC) 669*16kB (UMEC) 283*32kB (MEC) 145*64kB (UMEC) 46*128kB (UMEC) 20*256kB (UMEC) 11*512kB (UEC) 4*1024kB (UC) 1*2048kB (E) 6*4096kB (C) = 83148kB
Nov 11 00:33:48 localhost kernel: [454680.730864] HighMem: 875*4kB (UM) 123*8kB (UM) 1*16kB (U) 0*32kB 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 4500kB
Nov 11 00:33:48 localhost kernel: [454680.730891] 5810 total pagecache pages
Nov 11 00:33:48 localhost kernel: [454680.730897] 0 pages in swap cache
Nov 11 00:33:48 localhost kernel: [454680.730901] Swap cache stats: add 0, delete 0, find 0/0
Nov 11 00:33:48 localhost kernel: [454680.730904] Free swap  = 0kB
Nov 11 00:33:48 localhost kernel: [454680.730907] Total swap = 0kB
Nov 11 00:33:48 localhost kernel: [454680.730910] 523520 pages RAM
Nov 11 00:33:48 localhost kernel: [454680.730913] 326912 pages HighMem/MovableOnly
Nov 11 00:33:48 localhost kernel: [454680.730916] 9232 pages reserved
Nov 11 00:33:48 localhost kernel: [454680.730919] 24576 pages cma reserved
Nov 11 00:33:48 localhost kernel: [454680.730923] Tasks state (memory values in pages):
Nov 11 00:33:48 localhost kernel: [454680.730926] [  pid  ]   uid  tgid total_vm      rss pgtables_bytes swapents oom_score_adj name
Nov 11 00:33:48 localhost kernel: [454680.730954] [    247]     0   247     8052      869    63488        0             0 systemd-journal
Nov 11 00:33:48 localhost kernel: [454680.730963] [    279]     0   279     4114      155    18432        0         -1000 systemd-udevd
Nov 11 00:33:48 localhost kernel: [454680.730975] [    391]     0   391     1812      767    14336        0             0 haveged
Nov 11 00:33:48 localhost kernel: [454680.730984] [    392]   108   392     1344       80    14336        0             0 rpcbind
Nov 11 00:33:48 localhost kernel: [454680.730993] [    443]     0   443      742       50    12288        0             0 alsactl
Nov 11 00:33:48 localhost kernel: [454680.731003] [    454]   104   454     1386      152    14336        0          -900 dbus-daemon
Nov 11 00:33:48 localhost kernel: [454680.731011] [    463]     0   463     6796       34    18432        0             0 rngd
Nov 11 00:33:48 localhost kernel: [454680.731019] [    468]     0   468     2243      176    16384        0             0 wpa_supplicant
Nov 11 00:33:48 localhost kernel: [454680.731028] [    473]     0   473     2658      166    20480        0             0 systemd-logind
Nov 11 00:33:48 localhost kernel: [454680.731036] [    480]     0   480     6117      230    24576        0             0 rsyslogd
Nov 11 00:33:48 localhost kernel: [454680.731044] [    483]     0   483     5687     1234    28672        0             0 networkd-dispat
Nov 11 00:33:48 localhost kernel: [454680.731052] [    490]     0   490     1914       51    16384        0             0 cron
Nov 11 00:33:48 localhost kernel: [454680.731061] [    491]     0   491    17360      476    47104        0             0 NetworkManager
Nov 11 00:33:48 localhost kernel: [454680.731069] [    596]     0   596     8819     1266    36864        0             0 unattended-upgr
Nov 11 00:33:48 localhost kernel: [454680.731077] [    604]     0   604     2537       68    12288        0             0 hmland
Nov 11 00:33:48 localhost kernel: [454680.731085] [    628]     0   628     2220      137    18432        0         -1000 sshd
Nov 11 00:33:48 localhost kernel: [454680.731094] [    638]   105   638     2753       65    12288        0             0 chronyd
Nov 11 00:33:48 localhost kernel: [454680.731103] [    643]   105   643      806       59    12288        0             0 chronyd
Nov 11 00:33:48 localhost kernel: [454680.731112] [    706]     0   706    49871     1598    55296        0             0 apache2
Nov 11 00:33:48 localhost kernel: [454680.731120] [    757]    33   757    49881     1015    47104        0             0 apache2
Nov 11 00:33:48 localhost kernel: [454680.731129] [    759]    33   759    49881     1015    47104        0             0 apache2
Nov 11 00:33:48 localhost kernel: [454680.731138] [    762]    33   762    49881     1015    47104        0             0 apache2
Nov 11 00:33:48 localhost kernel: [454680.731147] [    763]    33   763    49881     1015    47104        0             0 apache2
Nov 11 00:33:48 localhost kernel: [454680.731155] [    764]    33   764    49877      996    47104        0             0 apache2
Nov 11 00:33:48 localhost kernel: [454680.731163] [    806]     0   806     8986      159    26624        0             0 polkitd
Nov 11 00:33:48 localhost kernel: [454680.731171] [    973]     0   973     1560      212    14336        0             0 dhclient
Nov 11 00:33:48 localhost kernel: [454680.731180] [   1032]     0  1032      959       20    12288        0             0 agetty
Nov 11 00:33:48 localhost kernel: [454680.731189] [   1034]     0  1034     1620       23    14336        0             0 agetty
Nov 11 00:33:48 localhost kernel: [454680.731197] [   1062]     0  1062     1374       64    12288        0             0 oscam.armel
Nov 11 00:33:48 localhost kernel: [454680.731206] [   1064]     0  1064     6627      344    22528        0             0 oscam.armel
Nov 11 00:33:48 localhost kernel: [454680.731214] [   1078]     0  1078      482       59     8192        0             0 osemu.armel


Der Cubie hat eine SD, darauf ist das System installiert
Fhem Cubitruck  Armbian Buster with Linux 5.3.9-sunxi
HM-CC_RT-DN, HM-Sec-RHS,HM-Sec-SD, HM-Sec-SCo,IT1500,1xIT GRR-3500 Fritz!Dect200,Powerline546E,Enigma2 Modul mit 3 Vu+,Wol Modul für WinServer2016 und WinServer 2019,FB6590
Allnetl Wandtablett mit FTUI

Wernieman

Gucke mal, was der Speicher im laufenden Betrieb so macht, Stichwort "free"

Aber (s.o.) es könnte auch ein Fehler auf der SD Card sein
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

Tommy82

#4
Im Moment sagt free
free -h
              total        used        free      shared  buff/cache   available
Mem:          2,0Gi       1,8Gi       130Mi       7,0Mi        86Mi       149Mi
Swap:            0B          0B          0B


htop zeigt dazu
Fhem Cubitruck  Armbian Buster with Linux 5.3.9-sunxi
HM-CC_RT-DN, HM-Sec-RHS,HM-Sec-SD, HM-Sec-SCo,IT1500,1xIT GRR-3500 Fritz!Dect200,Powerline546E,Enigma2 Modul mit 3 Vu+,Wol Modul für WinServer2016 und WinServer 2019,FB6590
Allnetl Wandtablett mit FTUI

Wernieman

1. Welches System
2. Läuft dort nur FHEM oder auch mehr?
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

Tommy82

#6
Armbian
Linux cubietruck 5.8.16-sunxi #20.08.14 SMP Tue Oct 20 22:15:32 CEST 2020 armv7l GNU/Linux

nur das was zu fhem gehört und oscam, das wars

Die "top" Prozesse gehören ja zum User fhem
Fhem Cubitruck  Armbian Buster with Linux 5.3.9-sunxi
HM-CC_RT-DN, HM-Sec-RHS,HM-Sec-SD, HM-Sec-SCo,IT1500,1xIT GRR-3500 Fritz!Dect200,Powerline546E,Enigma2 Modul mit 3 Vu+,Wol Modul für WinServer2016 und WinServer 2019,FB6590
Allnetl Wandtablett mit FTUI

Wernieman

Welche Perl-Version?

Also das FHEM so viel Speicher braucht ist sehr ungewöhnlich ..

Laut Deinem TOP läuft FHEM seit 3 Minuten und braucht schon 83% Speicher und 33% CPU ... das ist zu viel ...
Das htop zeigt Ähnliches Verhalten, aber da lief fhem seit einer reichlichen Stunde.

Hattest Du das Betriebsystem upgedatet und dabei ein perl-Update? Das würde den Speicherverbrauch erklähren, aber nicht die CPU last ... oder hast Du so viele Geräte/Bedingungen?
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

Tommy82

Hallo,
die perl Version
perl -v

This is perl 5, version 28, subversion 1 (v5.28.1) built for arm-linux-gnueabihf-thread-multi-64int


Das System ist aktuell, ob ich kurz bevor die Probleme anfingen ein update gemacht habe kann ich leider nicht mehr sagen.
grade war der Speicherverbrauch insgesamt deutlich nidrieger, allerdings hat Fhem heute nachmittag wieder ohne erkennbaren Grund neugestartet, das restliche System läuft aber ohne Probleme aktuell.....
Fhem Cubitruck  Armbian Buster with Linux 5.3.9-sunxi
HM-CC_RT-DN, HM-Sec-RHS,HM-Sec-SD, HM-Sec-SCo,IT1500,1xIT GRR-3500 Fritz!Dect200,Powerline546E,Enigma2 Modul mit 3 Vu+,Wol Modul für WinServer2016 und WinServer 2019,FB6590
Allnetl Wandtablett mit FTUI

Wernieman

Naja .. wenn der Speicher gegen Null geht (bzw. die Eingestellte Reserve), schlägt der OOM-Killer des Betriebsystems zu. OOM = OutOfMemory.

Da bei Dir praktisch nur FHEM läuft, betrifft es (meistens) fhem, das zwangsbeendet wird. Systemd ist normalerweise so eingestellt, das er abgestürzte Programme automatisch startet ....

- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

Tommy82

Zitat von: Wernieman am 12 November 2020, 20:33:42
Naja .. wenn der Speicher gegen Null geht (bzw. die Eingestellte Reserve), schlägt der OOM-Killer des Betriebsystems zu. OOM = OutOfMemory.

Da bei Dir praktisch nur FHEM läuft, betrifft es (meistens) fhem, das zwangsbeendet wird. Systemd ist normalerweise so eingestellt, das er abgestürzte Programme automatisch startet ....

Naja der Neustart klappt ja dann auch bei Fhem, zumindest etwas......

Aber der Grund und vor allem die Lösung wären schon interessant zu finden

Kann man denn Perl Prozess noch weiter eingrenzen, bzw. erkennen was Fhem dann genau macht?
Fhem Cubitruck  Armbian Buster with Linux 5.3.9-sunxi
HM-CC_RT-DN, HM-Sec-RHS,HM-Sec-SD, HM-Sec-SCo,IT1500,1xIT GRR-3500 Fritz!Dect200,Powerline546E,Enigma2 Modul mit 3 Vu+,Wol Modul für WinServer2016 und WinServer 2019,FB6590
Allnetl Wandtablett mit FTUI

Wernieman

Da müsstest Du bei den "Egschberden" nachfragen .. so tief bin ich beim Debuggen nicht drin.

Tipp: Kannst Du den Betreff des ersten Post Ändern?

Ansonsten .. bezüglich Perl und Speicherverbrauch FHEM gibt es schon mehr als ein Post im Forum ....
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

Tommy82

#12
Vielleicht liest ja ein experte mit, eben wieder ein absturz gehabt mit gleichen symthomen....

Kommte eine swap Datei/partition eine verbesserung bringen?
Fhem Cubitruck  Armbian Buster with Linux 5.3.9-sunxi
HM-CC_RT-DN, HM-Sec-RHS,HM-Sec-SD, HM-Sec-SCo,IT1500,1xIT GRR-3500 Fritz!Dect200,Powerline546E,Enigma2 Modul mit 3 Vu+,Wol Modul für WinServer2016 und WinServer 2019,FB6590
Allnetl Wandtablett mit FTUI

Wernieman

Nein .. das verschiebt das Problem nur "nach hinten" ...

Wobei ich persöhnlich grundsätzlich Unix-Rechner mit Swap-Partitionen einrichte, sofern die Automatik nicht eine Swap-Datei gemacht hat ...
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

Tommy82

Hatte ja auch von verbesserung, nicht lösung gesprochen :-) , lösung wäre mir auch lieber.

Ich hab im LOg plötzlich so eine komische Meldung mit der ich nicht wirklich was anfangen kann, ob das hier im Zusammenhang steht weiss ich allerdings nicht
2020.11.13 18:54:24.603 3: Login denied for user >Thomas< via WEB_127.0.0.1_51904
2020.11.13 18:54:25.063 3: Login denied for user >Thomas< via WEB_127.0.0.1_51906
2020.11.13 18:54:25.076 3: Login denied for user >Thomas< via WEB_127.0.0.1_51908
Fhem Cubitruck  Armbian Buster with Linux 5.3.9-sunxi
HM-CC_RT-DN, HM-Sec-RHS,HM-Sec-SD, HM-Sec-SCo,IT1500,1xIT GRR-3500 Fritz!Dect200,Powerline546E,Enigma2 Modul mit 3 Vu+,Wol Modul für WinServer2016 und WinServer 2019,FB6590
Allnetl Wandtablett mit FTUI

Wernieman

Hängt Dein FHEM im I-Netz??

Es sind vergebliche Loginversuche .. .. wundert mich aber, das sie über localhost kommen ...

Btw:
Hast Du ein grafisches System drauf?
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

Tommy82

Was meinst du mit iNet? Hangt natürlich hinter dem Router, allerdings gibt es von außen nur einen Zugriff über VPN, der rest ist nicht offen.

Auf dem Cubie läuft kein Grafisches System, gibt ein Tablett was FTUI darstellt, allerdings auch auf Port 8085 und nicht vom Localhost
Fhem Cubitruck  Armbian Buster with Linux 5.3.9-sunxi
HM-CC_RT-DN, HM-Sec-RHS,HM-Sec-SD, HM-Sec-SCo,IT1500,1xIT GRR-3500 Fritz!Dect200,Powerline546E,Enigma2 Modul mit 3 Vu+,Wol Modul für WinServer2016 und WinServer 2019,FB6590
Allnetl Wandtablett mit FTUI

MadMax-FHEM

#17
Hast du alexa-fhem o.ä. laufen?

Das greift ja, wenn es auf dem selben System läuft per "localhost" zu.

EDIT: ja hast du ;) Siehe anderer Thread...

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)

Tommy82

Fhem Cubitruck  Armbian Buster with Linux 5.3.9-sunxi
HM-CC_RT-DN, HM-Sec-RHS,HM-Sec-SD, HM-Sec-SCo,IT1500,1xIT GRR-3500 Fritz!Dect200,Powerline546E,Enigma2 Modul mit 3 Vu+,Wol Modul für WinServer2016 und WinServer 2019,FB6590
Allnetl Wandtablett mit FTUI

Tommy82

Jetzt lief der Cubie einige Tage ohne Probleme, und heute ist er dann plötzlich wieder hängen geblieben...

Im Fhem Log kann man leider nicht viel dazu erkennen, genauso wenig im syslog... Zumindest für mich

2020.11.18 07:46:14.951 1: [Freezemon] myFreezemon: possible freeze starting at 07:46:12, delay is 2.946 possibly caused by: fn-NotifyFn(Wetter) fn-NotifyFn(rd_Batterie) fn-NotifyFn(rd_Batterie_Level) tmr-Weather_GetUpdate(YahooWetter)
2020.11.18 17:53:50.437 1: Including fhem.cfg


[code]Nov 18 00:00:01 localhost CRON[28090]: (root) CMD (/usr/lib/armbian/armbian-truncate-logs)
Nov 18 00:00:36 localhost systemd[1]: Starting Rotate log files...
Nov 18 00:00:36 localhost systemd[1]: Starting Daily man-db regeneration...
Nov 18 00:00:36 localhost armbian-ramlog[28188]: Mi 18. Nov 00:00:36 CET 2020: Syncing logs to storage
Nov 18 00:00:37 localhost armbian-ramlog[28188]: sending incremental file list
Nov 18 00:00:37 localhost armbian-ramlog[28188]: alternatives.log
Nov 18 00:00:37 localhost armbian-ramlog[28188]: aptitude
Nov 18 00:00:37 localhost armbian-ramlog[28188]: armbian-hardware-monitor.log
Nov 18 00:00:37 localhost armbian-ramlog[28188]: auth.log
Nov 18 00:00:37 localhost armbian-ramlog[28188]: bootstrap.log
Nov 18 00:00:37 localhost armbian-ramlog[28188]: btmp
Nov 18 00:00:37 localhost armbian-ramlog[28188]: daemon.log
Nov 18 00:00:37 localhost armbian-ramlog[28188]: debug
Nov 18 00:00:37 localhost armbian-ramlog[28188]: dpkg.log
Nov 18 00:00:37 localhost armbian-ramlog[28188]: faillog
Nov 18 00:00:37 localhost armbian-ramlog[28188]: kern.log
Nov 18 00:00:37 localhost armbian-ramlog[28188]: lastlog
Nov 18 17:53:42 localhost systemd-udevd[295]: Using default interface naming scheme 'v240'.
Nov 18 17:53:42 localhost systemd-udevd[295]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Nov 18 17:53:42 localhost systemd-udevd[295]: link_config: could not get ethtool features for eth0
Nov 18 17:53:42 localhost fake-hwclock[224]: Current system time: 2020-11-18 16:53:27
Nov 18 17:53:42 localhost fake-hwclock[224]: fake-hwclock saved clock information is in the past: 2020-11-13 17:52:33
Nov 18 17:53:42 localhost fake-hwclock[224]: To set system time to this saved clock anyway, use "force"
Nov 18 17:53:42 localhost systemd-udevd[295]: Could not set offload features of eth0: Device or resource busy
Nov 18 17:53:42 localhost systemd-udevd[292]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Nov 18 17:53:42 localhost systemd-udevd[296]: Using default interface naming scheme 'v240'.
Nov 18 17:53:42 localhost systemd-udevd[296]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Nov 18 17:53:42 localhost systemd[1]: Starting Flush Journal to Persistent Storage...
Nov 18 17:53:42 localhost systemd-remount-fs[235]: mount: /etc/fstab: parse error at line 3 -- ignored
Nov 18 17:53:42 localhost resolvconf[246]: /etc/resolvconf/update.d/libc: Warning: /etc/resolv.conf is not a symbolic link to /etc/resolvconf/run/resolv.conf
Nov 18 17:53:42 localhost armbian-zram-config[370]: Setting up swapspace version 1, size = 1004,5 MiB (1053257728 bytes)
Nov 18 17:53:42 localhost armbian-zram-config[370]: no label, UUID=c16f78da-d665-4661-a22a-93ef733f9f77
Nov 18 17:53:42 localhost armbian-zram-config[370]: mke2fs 1.44.5 (15-Dec-2018)
Nov 18 17:53:42 localhost armbian-zram-config[370]: Discarding device blocks:  4096/12800#010#010#010#010#010#010#010#010#010#010#010           #010#010#010#010#010#010#010#010#010#010#010done
Nov 18 17:53:42 localhost armbian-zram-config[370]: Creating filesystem with 12800 4k blocks and 12800 inodes
Nov 18 17:53:42 localhost armbian-zram-config[370]: Allocating group tables: 0/1#010#010#010   #010#010#010done
Nov 18 17:53:42 localhost armbian-zram-config[370]: Writing inode tables: 0/1#010#010#010   #010#010#010done
Nov 18 17:53:42 localhost armbian-zram-config[370]: Writing superblocks and filesystem accounting information: 0/1#010#010#010   #010#010#010done
Nov 18 17:53:42 localhost armbian-ramlog[480]: Mounting /dev/zram0 as /var/log/
Nov 18 17:53:42 localhost armbian-ramlog[480]: Mi 18. Nov 17:53:36 CET 2020: Loading logs from storage
Nov 18 17:53:42 localhost armbian-ramlog[480]: sending incremental file list
Nov 18 17:53:42 localhost armbian-ramlog[480]: ./
Nov 18 17:53:42 localhost armbian-ramlog[480]: alternatives.log
Nov 18 17:53:42 localhost armbian-ramlog[480]: aptitude
Nov 18 17:53:42 localhost armbian-ramlog[480]: armbian-hardware-monitor.log
Nov 18 17:53:42 localhost armbian-ramlog[480]: auth.log
Nov 18 17:53:42 localhost armbian-ramlog[480]: bootstrap.log
Nov 18 17:53:42 localhost armbian-ramlog[480]: btmp
Nov 18 17:53:42 localhost armbian-ramlog[480]: daemon.log
Nov 18 17:53:42 localhost armbian-ramlog[480]: debug
Nov 18 17:53:42 localhost armbian-ramlog[480]: dpkg.log
Nov 18 17:53:42 localhost armbian-ramlog[480]: faillog
Nov 18 17:53:42 localhost armbian-ramlog[480]: kern.log
Nov 18 17:53:42 localhost armbian-ramlog[480]: lastlog
Nov 18 17:53:42 localhost armbian-ramlog[480]: messages
Nov 18 17:53:42 localhost armbian-ramlog[480]: syslog
Nov 18 17:53:42 localhost armbian-ramlog[480]: user.log
Nov 18 17:53:42 localhost armbian-ramlog[480]: wtmp
Nov 18 17:53:42 localhost armbian-ramlog[480]: apache2/
Nov 18 17:53:42 localhost armbian-ramlog[480]: apache2/access.log
Nov 18 17:53:42 localhost armbian-ramlog[480]: apache2/error.log
Nov 18 17:53:42 localhost kernel: [    0.000000] Booting Linux on physical CPU 0x0
Nov 18 17:53:42 localhost kernel: [    0.000000] Linux version 5.8.16-sunxi (root@xeon) (arm-none-linux-gnueabihf-gcc (GNU Toolchain for the A-profile Architecture 9.2-2019.12 (arm-9.10)) 9.2.1 20191025, GNU ld (GNU Toolchain for the A-profile Architecture 9.2-2019.12 (arm-9.10)) 2.33.1.20191209) #20.08.14 SMP Tue Oct 20 22:15:32 CEST 2020
Nov 18 17:53:42 localhost kernel: [    0.000000] CPU: ARMv7 Processor [410fc074] revision 4 (ARMv7), cr=50c5387d
Nov 18 17:53:42 localhost kernel: [    0.000000] CPU: div instructions available: patching division code
Nov 18 17:53:42 localhost kernel: [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
Nov 18 17:53:42 localhost kernel: [    0.000000] OF: fdt: Machine model: Cubietech Cubietruck
Nov 18 17:53:42 localhost kernel: [    0.000000] Memory policy: Data cache writealloc
Nov 18 17:53:42 localhost kernel: [    0.000000] Reserved memory: created CMA memory pool at 0x4a000000, size 96 MiB
Nov 18 17:53:42 localhost kernel: [    0.000000] OF: reserved mem: initialized node default-pool, compatible id shared-dma-pool
Nov 18 17:53:42 localhost kernel: [    0.000000] Zone ranges:
Nov 18 17:53:42 localhost kernel: [    0.000000]   Normal   [mem 0x0000000040000000-0x000000006fffffff]
Nov 18 17:53:42 localhost kernel: [    0.000000]   HighMem  [mem 0x0000000070000000-0x00000000bfcfffff]
Nov 18 17:53:42 localhost kernel: [    0.000000] Movable zone start for each node
Nov 18 17:53:42 localhost kernel: [    0.000000] Early memory node ranges
Nov 18 17:53:42 localhost kernel: [    0.000000]   node   0: [mem 0x0000000040000000-0x00000000bfcfffff]
Nov 18 17:53:42 localhost kernel: [    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfcfffff]
Nov 18 17:53:42 localhost kernel: [    0.000000] On node 0 totalpages: 523520
Nov 18 17:53:42 localhost kernel: [    0.000000]   Normal zone: 1728 pages used for memmap
Nov 18 17:53:42 localhost kernel: [    0.000000]   Normal zone: 0 pages reserved
Nov 18 17:53:42 localhost kernel: [    0.000000]   Normal zone: 196608 pages, LIFO batch:63
Nov 18 17:53:42 localhost kernel: [    0.000000]   HighMem zone: 326912 pages, LIFO batch:63
Nov 18 17:53:42 localhost kernel: [    0.000000] psci: probing for conduit method from DT.
Nov 18 17:53:42 localhost kernel: [    0.000000] psci: Using PSCI v0.1 Function IDs from DT
Nov 18 17:53:42 localhost kernel: [    0.000000] percpu: Embedded 20 pages/cpu s50444 r8192 d23284 u81920
Nov 18 17:53:42 localhost kernel: [    0.000000] pcpu-alloc: s50444 r8192 d23284 u81920 alloc=20*4096
Nov 18 17:53:42 localhost kernel: [    0.000000] pcpu-alloc:
  • 0
  • 1
    Nov 18 17:53:42 localhost kernel: [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 521792
    Nov 18 17:53:42 localhost kernel: [    0.000000] Kernel command line: root=UUID=19cf2f1d-1a31-4890-bc04-a2f1c4e4e021 rootwait rootfstype=ext4 console=ttyS0,115200 console=tty1 hdmi.audio=EDID:0 disp.screen0_output_mode=1920x1080p60 panic=10 consoleblank=0 loglevel=1 ubootpart=ba110a34-01 ubootsource=mmc usb-storage.quirks=0x2537:0x1066:u,0x2537:0x1068:u   sunxi_ve_mem_reserve=0 sunxi_g2d_mem_reserve=0 sunxi_fb_mem_reserve=16 cgroup_enable=memory swapaccount=1
    Nov 18 17:53:42 localhost kernel: [    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
    Nov 18 17:53:42 localhost kernel: [    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
    Nov 18 17:53:42 localhost kernel: [    0.000000] allocated 2098176 bytes of page_ext
    Nov 18 17:53:42 localhost kernel: [    0.000000] mem auto-init: stack:off, heap alloc:on, heap free:off
    Nov 18 17:53:42 localhost kernel: [    0.000000] Memory: 1948168K/2094080K available (9216K kernel code, 1028K rwdata, 3240K rodata, 1024K init, 328K bss, 47608K reserved, 98304K cma-reserved, 1307648K highmem)
    Nov 18 17:53:42 localhost kernel: [    0.000000] random: get_random_u32 called from __kmem_cache_create+0x2f/0x368 with crng_init=0
    Nov 18 17:53:42 localhost kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
    Nov 18 17:53:42 localhost kernel: [    0.000000] ftrace: allocating 39966 entries in 79 pages
    Nov 18 17:53:42 localhost kernel: [    0.000000] ftrace: allocated 79 pages with 5 groups
    Nov 18 17:53:42 localhost kernel: [    0.000000] rcu: Hierarchical RCU implementation.
    Nov 18 17:53:42 localhost kernel: [    0.000000] rcu:    RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=2.
    Nov 18 17:53:42 localhost kernel: [    0.000000]    Rude variant of Tasks RCU enabled.
    Nov 18 17:53:42 localhost kernel: [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
    Nov 18 17:53:42 localhost kernel: [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
    Nov 18 17:53:42 localhost kernel: [    0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
    Nov 18 17:53:42 localhost kernel: [    0.000000] GIC: Using split EOI/Deactivate mode
    Nov 18 17:53:42 localhost kernel: [    0.000000] arch_timer: cp15 timer(s) running at 24.00MHz (phys).
    Nov 18 17:53:42 localhost kernel: [    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x588fe9dc0, max_idle_ns: 440795202592 ns
    Nov 18 17:53:42 localhost kernel: [    0.000007] sched_clock: 56 bits at 24MHz, resolution 41ns, wraps every 4398046511097ns
    Nov 18 17:53:42 localhost kernel: [    0.000017] Switching to timer-based delay loop, resolution 41ns
    Nov 18 17:53:42 localhost kernel: [    0.000552] clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 79635851949 ns
    Nov 18 17:53:42 localhost kernel: [    0.000890] clocksource: hstimer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 6370868154 ns
    Nov 18 17:53:42 localhost kernel: [    0.001248] Console: colour dummy device 80x30
    Nov 18 17:53:42 localhost kernel: [    0.001266] printk: console [tty1] enabled
    Nov 18 17:53:42 localhost kernel: [    0.001332] Calibrating delay loop (skipped), value calculated using timer frequency.. 48.00 BogoMIPS (lpj=96000)
    Nov 18 17:53:42 localhost kernel: [    0.001344] pid_max: default: 32768 minimum: 301
    Nov 18 17:53:42 localhost kernel: [    0.001588] LSM: Security Framework initializing
    Nov 18 17:53:42 localhost kernel: [    0.001651] Yama: becoming mindful.
    Nov 18 17:53:42 localhost kernel: [    0.001857] AppArmor: AppArmor initialized
    Nov 18 17:53:42 localhost kernel: [    0.001949] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
    Nov 18 17:53:42 localhost kernel: [    0.001964] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
    Nov 18 17:53:42 localhost kernel: [    0.003190] CPU: Testing write buffer coherency: ok
    Nov 18 17:53:42 localhost kernel: [    0.003650] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
    Nov 18 17:53:42 localhost kernel: [    0.004486] Setting up static identity map for 0x40100000 - 0x40100054
    Nov 18 17:53:42 localhost kernel: [    0.004651] rcu: Hierarchical SRCU implementation.
    Nov 18 17:53:42 localhost kernel: [    0.008469] smp: Bringing up secondary CPUs ...
    Nov 18 17:53:42 localhost kernel: [    0.019383] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
    Nov 18 17:53:42 localhost kernel: [    0.019558] smp: Brought up 1 node, 2 CPUs
    Nov 18 17:53:42 localhost kernel: [    0.019570] SMP: Total of 2 processors activated (96.00 BogoMIPS).
    Nov 18 17:53:42 localhost kernel: [    0.019574] CPU: All CPU(s) started in HYP mode.
    Nov 18 17:53:42 localhost kernel: [    0.019577] CPU: Virtualization extensions available.
    Nov 18 17:53:42 localhost kernel: [    0.020908] devtmpfs: initialized
    Nov 18 17:53:42 localhost kernel: [    0.031085] VFP support v0.3: implementor 41 architecture 2 part 30 variant 7 rev 4
    Nov 18 17:53:42 localhost kernel: [    0.031609] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
    Nov 18 17:53:42 localhost kernel: [    0.031653] futex hash table entries: 512 (order: 3, 32768 bytes, linear)
    Nov 18 17:53:42 localhost kernel: [    0.035821] xor: measuring software checksum speed
    Nov 18 17:53:42 localhost kernel: [    0.075399]    arm4regs  :  1136.000 MB/sec
    Nov 18 17:53:42 localhost kernel: [    0.115450]    8regs     :   791.000 MB/sec
    Nov 18 17:53:42 localhost kernel: [    0.155502]    32regs    :   747.000 MB/sec
    Nov 18 17:53:42 localhost kernel: [    0.195564]    neon      :  1150.000 MB/sec
    Nov 18 17:53:42 localhost kernel: [    0.195569] xor: using function: neon (1150.000 MB/sec)
    Nov 18 17:53:42 localhost kernel: [    0.195664] pinctrl core: initialized pinctrl subsystem
    Nov 18 17:53:42 localhost kernel: [    0.196343] thermal_sys: Registered thermal governor 'fair_share'
    Nov 18 17:53:42 localhost kernel: [    0.196350] thermal_sys: Registered thermal governor 'bang_bang'
    Nov 18 17:53:42 localhost kernel: [    0.196356] thermal_sys: Registered thermal governor 'step_wise'
    Nov 18 17:53:42 localhost kernel: [    0.197388] NET: Registered protocol family 16
    Nov 18 17:53:42 localhost kernel: [    0.199307] DMA: preallocated 256 KiB pool for atomic coherent allocations
    Nov 18 17:53:42 localhost kernel: [    0.199937] audit: initializing netlink subsys (disabled)
    Nov 18 17:53:42 localhost kernel: [    0.200269] audit: type=2000 audit(0.192:1): state=initialized audit_enabled=0 res=1
    Nov 18 17:53:42 localhost kernel: [    0.200915] cpuidle: using governor ladder
    Nov 18 17:53:42 localhost kernel: [    0.200946] cpuidle: using governor menu
    Nov 18 17:53:42 localhost kernel: [    0.201514] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
    Nov 18 17:53:42 localhost kernel: [    0.201520] hw-breakpoint: maximum watchpoint size is 8 bytes.
    Nov 18 17:53:42 localhost kernel: [    0.228905] cryptd: max_cpu_qlen set to 1000
    Nov 18 17:53:42 localhost kernel: [    0.300198] raid6: neonx8   gen()   699 MB/s
    Nov 18 17:53:42 localhost kernel: [    0.368333] raid6: neonx8   xor()   524 MB/s
    Nov 18 17:53:42 localhost kernel: [    0.436463] raid6: neonx4   gen()   752 MB/s
    Nov 18 17:53:42 localhost kernel: [    0.504595] raid6: neonx4   xor()   569 MB/s
    Nov 18 17:53:42 localhost kernel: [    0.572728] raid6: neonx2   gen()   827 MB/s
    Nov 18 17:53:42 localhost kernel: [    0.640846] raid6: neonx2   xor()   590 MB/s
    Nov 18 17:53:42 localhost kernel: [    0.709006] raid6: neonx1   gen()   738 MB/s
    Nov 18 17:53:42 localhost kernel: [    0.777131] raid6: neonx1   xor()   511 MB/s
    Nov 18 17:53:42 localhost kernel: [    0.845248] raid6: int32x8  gen()   273 MB/s
    Nov 18 17:53:42 localhost kernel: [    0.913414] raid6: int32x8  xor()   160 MB/s
    Nov 18 17:53:42 localhost kernel: [    0.981592] raid6: int32x4  gen()   323 MB/s
    Nov 18 17:53:42 localhost kernel: [    1.049709] raid6: int32x4  xor()   186 MB/s
    Nov 18 17:53:42 localhost kernel: [    1.117853] raid6: int32x2  gen()   361 MB/s
    Nov 18 17:53:42 localhost kernel: [    1.185955] raid6: int32x2  xor()   192 MB/s
    Nov 18 17:53:42 localhost kernel: [    1.254140] raid6: int32x1  gen()   365 MB/s
    Nov 18 17:53:42 localhost kernel: [    1.322249] raid6: int32x1  xor()   173 MB/s
    Nov 18 17:53:42 localhost kernel: [    1.322254] raid6: using algorithm neonx2 gen() 827 MB/s
    Nov 18 17:53:42 localhost kernel: [    1.322257] raid6: .... xor() 590 MB/s, rmw enabled
    Nov 18 17:53:42 localhost kernel: [    1.322262] raid6: using neon recovery algorithm
    Nov 18 17:53:42 localhost kernel: [    1.324264] iommu: Default domain type: Translated
    Nov 18 17:53:42 localhost kernel: [    1.324714] SCSI subsystem initialized
    Nov 18 17:53:42 localhost kernel: [    1.325090] libata version 3.00 loaded.
    Nov 18 17:53:42 localhost kernel: [    1.325366] usbcore: registered new interface driver usbfs
    Nov 18 17:53:42 localhost kernel: [    1.325425] usbcore: registered new interface driver hub
    Nov 18 17:53:42 localhost armbian-ramlog[480]: apache2/other_vhosts_access.log
    Nov 18 17:53:42 localhost armbian-ramlog[480]: apt/
    Nov 18 17:53:42 localhost armbian-ramlog[480]: apt/history.log
    Nov 18 17:53:42 localhost armbian-ramlog[480]: apt/term.log
    Nov 18 17:53:42 localhost armbian-ramlog[480]: chrony/
    Nov 18 17:53:42 localhost armbian-ramlog[480]: ipc/
    Nov 18 17:53:42 localhost armbian-ramlog[480]: ipc/CCcam-bcommands.log
    Nov 18 17:53:42 localhost armbian-ramlog[480]: ipc/CCcam-changes.log
    Nov 18 17:53:42 localhost armbian-ramlog[480]: ipc/CCcam-iusers.log
    Nov 18 17:53:42 localhost armbian-ramlog[480]: ipc/NewCS-watchdog.log
    Nov 18 17:53:42 localhost armbian-ramlog[480]: ipc/OSEmu.log
    Nov 18 17:53:42 localhost armbian-ramlog[480]: ipc/OScam.log
    Nov 18 17:53:42 localhost armbian-ramlog[480]: ipc/gbox-watchdog.log
    Nov 18 17:53:42 localhost armbian-ramlog[480]: ipc/sBox-watchdog.log
    Nov 18 17:53:42 localhost armbian-ramlog[480]: private/
    Nov 18 17:53:42 localhost armbian-ramlog[480]: sysstat/
    Nov 18 17:53:42 localhost armbian-ramlog[480]: unattended-upgrades/
    Nov 18 17:53:42 localhost armbian-ramlog[480]: unattended-upgrades/unattended-upgrades-shutdown.log
    Nov 18 17:53:42 localhost armbian-ramlog[480]: sent 1,343,120 bytes  received 621 bytes  895,827.33 bytes/sec
    Nov 18 17:53:42 localhost kernel: [    1.325499] usbcore: registered new device driver usb
    Nov 18 17:53:42 localhost armbian-ramlog[480]: total size is 1,340,587  speedup is 1.00
    Nov 18 17:53:42 localhost systemd[1]: Started Flush Journal to Persistent Storage.
    Nov 18 17:53:42 localhost kernel: [    1.325606] mc: Linux media interface: v0.10
    Nov 18 17:53:42 localhost kernel: [    1.325638] videodev: Linux video capture interface: v2.00
    Nov 18 17:53:42 localhost kernel: [    1.325796] pps_core: LinuxPPS API ver. 1 registered
    Nov 18 17:53:42 localhost systemd[1]: Starting Create Volatile Files and Directories...
    Nov 18 17:53:42 localhost kernel: [    1.325801] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
    Nov 18 17:53:42 localhost kernel: [    1.325825] PTP clock support registered
    Nov 18 17:53:42 localhost kernel: [    1.326470] Advanced Linux Sound Architecture Driver Initialized.
    Nov 18 17:53:42 localhost systemd[1]: Started Create Volatile Files and Directories.
    Nov 18 17:53:42 localhost systemd[1]: Starting RPC bind portmap service...
    Nov 18 17:53:42 localhost systemd[1]: Started Entropy daemon using the HAVEGE algorithm.
    Nov 18 17:53:42 localhost systemd[1]: Condition check resulted in Network Time Synchronization being skipped.
    Nov 18 17:53:42 localhost systemd[1]: Starting Update UTMP about System Boot/Shutdown...
    Nov 18 17:53:42 localhost systemd[1]: Started RPC bind portmap service.
    Nov 18 17:53:42 localhost systemd[1]: Started Update UTMP about System Boot/Shutdown.
    Nov 18 17:53:42 localhost systemd[1]: Reached target System Initialization.
    Nov 18 17:53:42 localhost systemd[1]: Starting Armbian hardware optimization...
    Nov 18 17:53:42 localhost systemd[1]: Listening on D-Bus System Message Bus Socket.
    Nov 18 17:53:42 localhost systemd[1]: Starting Armbian hardware monitoring...
    Nov 18 17:53:42 localhost systemd[1]: Started Daily Cleanup of Temporary Directories.
    Nov 18 17:53:42 localhost systemd[1]: Started Daily apt download activities.
    Nov 18 17:53:42 localhost systemd[1]: Started Daily apt upgrade and clean activities.
    Nov 18 17:53:42 localhost systemd[1]: Started Daily man-db regeneration.
    Nov 18 17:53:42 localhost systemd[1]: Listening on PC/SC Smart Card Daemon Activation Socket.
    Nov 18 17:53:42 localhost systemd[1]: Reached target Sockets.
    Nov 18 17:53:42 localhost systemd[1]: Started Clean PHP session files every 30 mins.
    Nov 18 17:53:42 localhost systemd[1]: Started Daily rotation of log files.
    Nov 18 17:53:42 localhost systemd[1]: Reached target Timers.
    Nov 18 17:53:42 localhost systemd[1]: Reached target RPC Port Mapper.
    Nov 18 17:53:42 localhost systemd[1]: Reached target Remote File Systems (Pre).
    Nov 18 17:53:42 localhost systemd[1]: Reached target Remote File Systems.
    Nov 18 17:53:42 localhost systemd[1]: Started Armbian hardware monitoring.
    Nov 18 17:53:42 localhost systemd[1]: Started Armbian hardware optimization.
    Nov 18 17:53:42 localhost systemd[1]: Reached target Basic System.
    Nov 18 17:53:42 localhost systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped.
    Nov 18 17:53:42 localhost systemd[1]: Starting rng-tools.service...
    Nov 18 17:53:42 localhost systemd[1]: Starting Dispatcher daemon for systemd-networkd...
    Nov 18 17:53:42 localhost systemd[1]: Started Manage Sound Card State (restore and store).
    Nov 18 17:53:42 localhost systemd[1]: Started Swapspace, a dynamic swap space manager.
    Nov 18 17:53:42 localhost rng-tools[548]: Starting Hardware RNG entropy gatherer daemon: rngd.
    Nov 18 17:53:42 localhost systemd[1]: Starting System Logging Service...
    Nov 18 17:53:42 localhost alsactl[551]: alsactl 1.1.8 daemon started
    Nov 18 17:53:42 localhost rngd[556]: rngd 2-unofficial-mt.14 starting up...
    Nov 18 17:53:42 localhost rngd[556]: entropy feed to the kernel ready
    Nov 18 17:53:42 localhost systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling...
    Nov 18 17:53:42 localhost systemd[1]: Started Regular background program processing daemon.
    Nov 18 17:53:42 localhost systemd[1]: Starting Resets System Activity Data Collector...
    Nov 18 17:53:42 localhost systemd[1]: Starting Initialize hardware monitoring sensors...
    Nov 18 17:53:42 localhost systemd[1]: Started D-Bus System Message Bus.
    Nov 18 17:53:42 localhost cron[563]: (CRON) INFO (pidfile fd = 3)
    Nov 18 17:53:42 localhost cron[563]: (*system*) WRONG FILE OWNER (/etc/crontab)
    Nov 18 17:53:42 localhost rsyslogd: action '*' treated as ':omusrmsg:*' - please use ':omusrmsg:*' syntax instead, '*' will not be supported in the future [v8.1901.0 try https://www.rsyslog.com/e/2184 ]
    Nov 18 17:53:42 localhost rsyslogd: error during parsing file /etc/rsyslog.conf, on or before line 94: warnings occured in file '/etc/rsyslog.conf' around line 94 [v8.1901.0 try https://www.rsyslog.com/e/2207 ]
    Nov 18 17:53:42 localhost rsyslogd: imuxsock: Acquired UNIX socket '/run/systemd/journal/syslog' (fd 3) from systemd.  [v8.1901.0]
    Nov 18 17:53:42 localhost rsyslogd:  [origin software="rsyslogd" swVersion="8.1901.0" x-pid="557" x-info="https://www.rsyslog.com"] start
    Nov 18 17:53:42 localhost cron[563]: (CRON) INFO (Running @reboot jobs)
    Nov 18 17:53:42 localhost rsyslogd: Could not open output pipe '/dev/xconsole':: No such file or directory [v8.1901.0 try https://www.rsyslog.com/e/2039 ]
    Nov 18 17:53:42 localhost rsyslogd: action 'action-10-builtin:ompipe' suspended (module 'builtin:ompipe'), retry 0. There should be messages before this one giving the reason for suspension. [v8.1901.0 try https://www.rsyslog.com/e/2007 ]
    Nov 18 17:53:42 localhost rsyslogd: action 'action-10-builtin:ompipe' suspended (module 'builtin:ompipe'), next retry is Wed Nov 18 17:54:12 2020, retry nbr 0. There should be messages before this one giving the reason for suspension. [v8.1901.0 try https://www.rsyslog.com/e/2007 ]
    Nov 18 17:53:42 localhost kernel: [    1.327254] NetLabel: Initializing
    Nov 18 17:53:42 localhost kernel: [    1.327261] NetLabel:  domain hash size = 128
    Nov 18 17:53:42 localhost kernel: [    1.327264] NetLabel:  protocols = UNLABELED CIPSOv4 CALIPSO
    Nov 18 17:53:42 localhost kernel: [    1.327350] NetLabel:  unlabeled traffic allowed by default
    Nov 18 17:53:42 localhost kernel: [    1.328149] clocksource: Switched to clocksource arch_sys_counter
    Nov 18 17:53:42 localhost kernel: [    1.434133] VFS: Disk quotas dquot_6.6.0
    Nov 18 17:53:42 localhost kernel: [    1.434243] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
    Nov 18 17:53:42 localhost kernel: [    1.434945] AppArmor: AppArmor Filesystem Enabled
    Nov 18 17:53:42 localhost kernel: [    1.435990] simple-framebuffer bfd00000.framebuffer: framebuffer at 0xbfd00000, 0x300000 bytes, mapped to 0x(ptrval)
    Nov 18 17:53:42 localhost kernel: [    1.436005] simple-framebuffer bfd00000.framebuffer: format=x8r8g8b8, mode=1024x768x32, linelength=4096
    Nov 18 17:53:42 localhost kernel: [    1.437485] Console: switching to colour frame buffer device 128x48
    Nov 18 17:53:42 localhost kernel: [    1.451586] simple-framebuffer bfd00000.framebuffer: fb0: simplefb registered!
    Nov 18 17:53:42 localhost kernel: [    1.460782] NET: Registered protocol family 2
    Nov 18 17:53:42 localhost kernel: [    1.461701] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear)
    Nov 18 17:53:42 localhost kernel: [    1.461759] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
    Nov 18 17:53:42 localhost kernel: [    1.461871] TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
    Nov 18 17:53:42 localhost kernel: [    1.461994] TCP: Hash tables configured (established 8192 bind 8192)
    Nov 18 17:53:42 localhost kernel: [    1.462184] UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
    Nov 18 17:53:42 localhost kernel: [    1.462248] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
    Nov 18 17:53:42 localhost kernel: [    1.462581] NET: Registered protocol family 1
    Nov 18 17:53:42 localhost kernel: [    1.463099] Trying to unpack rootfs image as initramfs...
    Nov 18 17:53:42 localhost kernel: [    2.241538] Freeing initrd memory: 9656K
    Nov 18 17:53:42 localhost kernel: [    2.242326] hw perfevents: no interrupt-affinity property for /pmu, guessing.
    Nov 18 17:53:42 localhost kernel: [    2.242689] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 5 counters available
    Nov 18 17:53:42 localhost kernel: [    2.244381] Initialise system trusted keyrings
    Nov 18 17:53:42 localhost kernel: [    2.244448] Key type blacklist registered
    Nov 18 17:53:42 localhost kernel: [    2.244801] workingset: timestamp_bits=14 max_order=19 bucket_order=5
    Nov 18 17:53:42 localhost kernel: [    2.250821] zbud: loaded
    Nov 18 17:53:42 localhost kernel: [    2.252737] squashfs: version 4.0 (2009/01/31) Phillip Lougher
    Nov 18 17:53:42 localhost kernel: [    2.253978] fuse: init (API version 7.31)
    Nov 18 17:53:42 localhost kernel: [    2.257322] integrity: Platform Keyring initialized
    Nov 18 17:53:42 localhost kernel: [    2.374772] Key type asymmetric registered
    Nov 18 17:53:42 localhost kernel: [    2.374783] Asymmetric key parser 'x509' registered
    Nov 18 17:53:42 localhost kernel: [    2.374997] bounce: pool size: 64 pages
    Nov 18 17:53:42 localhost kernel: [    2.375089] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 246)
    Nov 18 17:53:42 localhost kernel: [    2.375386] io scheduler mq-deadline registered
    Nov 18 17:53:42 localhost kernel: [    2.375395] io scheduler kyber registered
    Nov 18 17:53:42 localhost kernel: [    2.375606] io scheduler bfq registered
    Nov 18 17:53:42 localhost kernel: [    2.379470] sun4i-pinctrl 1c20800.pinctrl: supply vcc-pi not found, using dummy regulator
    Nov 18 17:53:42 localhost kernel: [    2.381565] sun4i-pinctrl 1c20800.pinctrl: initialized sunXi PIO driver
    Nov 18 17:53:42 localhost kernel: [    2.394399] Serial: 8250/16550 driver, 8 ports, IRQ sharing disabled
    Nov 18 17:53:42 localhost kernel: [    2.397492] sun4i-pinctrl 1c20800.pinctrl: supply vcc-pb not found, using dummy regulator
    Nov 18 17:53:42 localhost kernel: [    2.398089] printk: console [ttyS0] disabled
    Nov 18 17:53:42 localhost kernel: [    2.398192] 1c28000.serial: ttyS0 at MMIO 0x1c28000 (irq = 50, base_baud = 1500000) is a 16550A
    Nov 18 17:53:42 localhost kernel: [    2.398285] printk: console [ttyS0] enabled
    Nov 18 17:53:42 localhost kernel: [    2.399411] 1c28800.serial: ttyS2 at MMIO 0x1c28800 (irq = 51, base_baud = 1500000) is a 16550A
    Nov 18 17:53:42 localhost kernel: [    2.399629] serial serial0: tty port ttyS2 registered
    Nov 18 17:53:42 localhost kernel: [    2.410240] brd: module loaded
    Nov 18 17:53:42 localhost kernel: [    2.419172] loop: module loaded
    Nov 18 17:53:42 localhost kernel: [    2.420448] ahci-sunxi 1c18000.sata: supply ahci not found, using dummy regulator
    Nov 18 17:53:42 localhost kernel: [    2.420591] ahci-sunxi 1c18000.sata: supply phy not found, using dummy regulator
    Nov 18 17:53:42 localhost kernel: [    2.422524] libphy: Fixed MDIO Bus: probed
    Nov 18 17:53:42 localhost kernel: [    2.423193] sun4i-pinctrl 1c20800.pinctrl: supply vcc-pa not found, using dummy regulator
    Nov 18 17:53:42 localhost kernel: [    2.423401] sun7i-dwmac 1c50000.ethernet: IRQ eth_wake_irq not found
    Nov 18 17:53:42 localhost kernel: [    2.423410] sun7i-dwmac 1c50000.ethernet: IRQ eth_lpi not found
    Nov 18 17:53:42 localhost kernel: [    2.423555] sun7i-dwmac 1c50000.ethernet: PTP uses main clock
    Nov 18 17:53:42 localhost kernel: [    2.423567] sun7i-dwmac 1c50000.ethernet: no reset control found
    Nov 18 17:53:42 localhost kernel: [    2.423597] sun7i-dwmac 1c50000.ethernet: no regulator found
    Nov 18 17:53:42 localhost kernel: [    2.423981] sun7i-dwmac 1c50000.ethernet: Version ID not available
    Nov 18 17:53:42 localhost kernel: [    2.423994] sun7i-dwmac 1c50000.ethernet:    DWMAC1000
    Nov 18 17:53:42 localhost kernel: [    2.424003] sun7i-dwmac 1c50000.ethernet: DMA HW capability register supported
    Nov 18 17:53:42 localhost kernel: [    2.424012] sun7i-dwmac 1c50000.ethernet: Normal descriptors
    Nov 18 17:53:42 localhost kernel: [    2.424018] sun7i-dwmac 1c50000.ethernet: Ring mode enabled
    Nov 18 17:53:42 localhost kernel: [    2.424832] libphy: stmmac: probed
    Nov 18 17:53:42 localhost kernel: [    2.439878] realtek: module verification failed: signature and/or required key missing - tainting kernel
    Nov 18 17:53:42 localhost kernel: [    2.450090] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
    Nov 18 17:53:42 localhost kernel: [    2.450126] ehci-platform: EHCI generic platform driver
    Nov 18 17:53:42 localhost kernel: [    2.450709] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
    Nov 18 17:53:42 localhost kernel: [    2.450741] ohci-platform: OHCI generic platform driver
    Nov 18 17:53:42 localhost kernel: [    2.451708] usbcore: registered new interface driver usb-storage
    Nov 18 17:53:42 localhost kernel: [    2.452985] sunxi-rtc 1c20d00.rtc: registered as rtc0
    Nov 18 17:53:42 localhost kernel: [    2.453040] sunxi-rtc 1c20d00.rtc: setting system clock to 2020-11-18T16:53:22 UTC (1605718402)
    Nov 18 17:53:42 localhost kernel: [    2.453242] i2c /dev entries driver
    Nov 18 17:53:42 localhost kernel: [    2.454575] axp20x-i2c 0-0034: AXP20x variant AXP209 found
    Nov 18 17:53:42 localhost kernel: [    2.462184] input: axp20x-pek as /devices/platform/soc/1c2ac00.i2c/i2c-0/0-0034/axp20x-pek/input/input0
    Nov 18 17:53:42 localhost kernel: [    2.471082] ldo1: supplied by regulator-dummy
    Nov 18 17:53:42 localhost kernel: [    2.471478] ldo2: supplied by regulator-dummy
    Nov 18 17:53:42 localhost kernel: [    2.472637] ldo3: supplied by regulator-dummy
    Nov 18 17:53:42 localhost kernel: [    2.473360] ldo4: supplied by regulator-dummy
    Nov 18 17:53:42 localhost kernel: [    2.473590] ldo5: supplied by regulator-dummy
    Nov 18 17:53:42 localhost kernel: [    2.474285] dcdc2: supplied by regulator-dummy
    Nov 18 17:53:42 localhost kernel: [    2.474988] dcdc3: supplied by regulator-dummy
    Nov 18 17:53:42 localhost kernel: [    2.480255] random: fast init done
    Nov 18 17:53:42 localhost kernel: [    2.480460] axp20x-i2c 0-0034: Backup (RTC) battery charging is enabled
    Nov 18 17:53:42 localhost kernel: [    2.480606] axp20x-i2c 0-0034: AXP20X driver loaded
    Nov 18 17:53:42 localhost kernel: [    2.484525] sunxi-wdt 1c20c90.watchdog: Watchdog enabled (timeout=16 sec, nowayout=0)
    Nov 18 17:53:42 localhost kernel: [    2.485341] sun4i-pinctrl 1c20800.pinctrl: supply vcc-pf not found, using dummy regulator
    Nov 18 17:53:42 localhost kernel: [    2.486633] sun4i-pinctrl 1c20800.pinctrl: supply vcc-ph not found, using dummy regulator
    Nov 18 17:53:42 localhost kernel: [    2.486782] sunxi-mmc 1c0f000.mmc: Got CD GPIO
    Nov 18 17:53:42 localhost kernel: [    2.512485] sunxi-mmc 1c0f000.mmc: initialized, max. request size: 16384 KB
    Nov 18 17:53:42 localhost kernel: [    2.516289] ledtrig-cpu: registered to indicate activity on CPUs
    Nov 18 17:53:42 localhost kernel: [    2.516390] hid: raw HID events driver (C) Jiri Kosina
    Nov 18 17:53:42 localhost kernel: [    2.516560] usbcore: registered new interface driver usbhid
    Nov 18 17:53:42 localhost kernel: [    2.516564] usbhid: USB HID core driver
    Nov 18 17:53:42 localhost kernel: [    2.520015] debugfs: Directory '1c22c00.codec' with parent 'sun4i-codec' already present!
    Nov 18 17:53:42 localhost kernel: [    2.521572] sun4i-codec 1c22c00.codec: Codec <-> 1c22c00.codec mapping ok
    Nov 18 17:53:42 localhost kernel: [    2.525086] Initializing XFRM netlink socket
    Nov 18 17:53:42 localhost kernel: [    2.525759] NET: Registered protocol family 10
    Nov 18 17:53:42 localhost kernel: [    2.561850] mmc0: host does not support reading read-only switch, assuming write-enable
    Nov 18 17:53:42 localhost kernel: [    2.565057] mmc0: new high speed SDHC card at address e624
    Nov 18 17:53:42 localhost kernel: [    2.567017] mmcblk0: mmc0:e624 SU08G 7.40 GiB
    Nov 18 17:53:42 localhost kernel: [    2.574317]  mmcblk0: p1
    Nov 18 17:53:42 localhost kernel: [    2.587847] Segment Routing with IPv6
    Nov 18 17:53:42 localhost kernel: [    2.587983] NET: Registered protocol family 17
    Nov 18 17:53:42 localhost kernel: [    2.588027] NET: Registered protocol family 15
    Nov 18 17:53:42 localhost kernel: [    2.588198] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
    Nov 18 17:53:42 localhost kernel: [    2.588413] 8021q: 802.1Q VLAN Support v1.8
    Nov 18 17:53:42 localhost kernel: [    2.588490] Key type dns_resolver registered
    Nov 18 17:53:42 localhost kernel: [    2.588976] Registering SWP/SWPB emulation handler
    Nov 18 17:53:42 localhost kernel: [    2.589418] registered taskstats version 1
    Nov 18 17:53:42 localhost kernel: [    2.589428] Loading compiled-in X.509 certificates
    Nov 18 17:53:42 localhost kernel: [    2.597208] Loaded X.509 cert 'Build time autogenerated kernel key: 1db26793b2098835541128330c1baea0c341ef90'
    Nov 18 17:53:42 localhost kernel: [    2.597403] zswap: loaded using pool lzo/zbud
    Nov 18 17:53:42 localhost kernel: [    2.598240] Key type ._fscrypt registered
    Nov 18 17:53:42 localhost kernel: [    2.598249] Key type .fscrypt registered
    Nov 18 17:53:42 localhost kernel: [    2.598253] Key type fscrypt-provisioning registered
    Nov 18 17:53:42 localhost kernel: [    2.604949] Btrfs loaded, crc32c=crc32c-generic
    Nov 18 17:53:42 localhost kernel: [    2.632798] Key type encrypted registered
    Nov 18 17:53:42 localhost kernel: [    2.632823] AppArmor: AppArmor sha1 policy hashing enabled
    Nov 18 17:53:42 localhost kernel: [    2.651154] ahci-sunxi 1c18000.sata: supply ahci not found, using dummy regulator
    Nov 18 17:53:42 localhost kernel: [    2.651267] ahci-sunxi 1c18000.sata: supply phy not found, using dummy regulator
    Nov 18 17:53:42 localhost kernel: [    2.708190] ahci-sunxi 1c18000.sata: controller can't do PMP, turning off CAP_PMP
    Nov 18 17:53:42 localhost kernel: [    2.708235] ahci-sunxi 1c18000.sata: SSS flag set, parallel bus scan disabled
    Nov 18 17:53:42 localhost kernel: [    2.708265] ahci-sunxi 1c18000.sata: AHCI 0001.0100 32 slots 1 ports 3 Gbps 0x1 impl platform mode
    Nov 18 17:53:42 localhost kernel: [    2.708280] ahci-sunxi 1c18000.sata: flags: ncq sntf stag pm led clo only pio slum part ccc
    Nov 18 17:53:42 localhost kernel: [    2.709476] scsi host0: ahci-sunxi
    Nov 18 17:53:42 localhost kernel: [    2.709949] ata1: SATA max UDMA/133 mmio [mem 0x01c18000-0x01c18fff] port 0x100 irq 37
    Nov 18 17:53:42 localhost kernel: [    2.721832] of_cfs_init
    Nov 18 17:53:42 localhost kernel: [    2.721984] of_cfs_init: OK
    Nov 18 17:53:42 localhost kernel: [    2.722193] ALSA device list:
    Nov 18 17:53:42 localhost kernel: [    2.722202]   #0: sun4i-codec
    Nov 18 17:53:42 localhost kernel: [    3.022605] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
    Nov 18 17:53:42 localhost kernel: [    3.024549] ata1.00: supports DRM functions and may not be fully accessible
    Nov 18 17:53:42 localhost kernel: [    3.024563] ata1.00: ATA-9: Samsung SSD 840 EVO 120GB, EXT0BB6Q, max UDMA/133
    Nov 18 17:53:42 localhost kernel: [    3.024570] ata1.00: 234441648 sectors, multi 1: LBA48 NCQ (depth 32)
    Nov 18 17:53:42 localhost kernel: [    3.025236] ata1.00: supports DRM functions and may not be fully accessible
    Nov 18 17:53:42 localhost kernel: [    3.025676] ata1.00: configured for UDMA/133
    Nov 18 17:53:42 localhost kernel: [    3.026322] scsi 0:0:0:0: Direct-Access     ATA      Samsung SSD 840  BB6Q PQ: 0 ANSI: 5
    Nov 18 17:53:42 localhost kernel: [    3.027314] scsi 0:0:0:0: Attached scsi generic sg0 type 0
    Nov 18 17:53:42 localhost kernel: [    3.028078] sd 0:0:0:0: [sda] 234441648 512-byte logical blocks: (120 GB/112 GiB)
    Nov 18 17:53:42 localhost kernel: [    3.028258] sd 0:0:0:0: [sda] Write Protect is off
    Nov 18 17:53:42 localhost kernel: [    3.028271] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
    Nov 18 17:53:42 localhost kernel: [    3.028399] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
    Nov 18 17:53:42 localhost kernel: [    3.030379]  sda: sda1
    Nov 18 17:53:42 localhost kernel: [    3.031824] sd 0:0:0:0: [sda] Attached SCSI disk
    Nov 18 17:53:42 localhost kernel: [    3.036291] Freeing unused kernel memory: 1024K
    Nov 18 17:53:42 localhost kernel: [    3.048473] Run /init as init process
    Nov 18 17:53:42 localhost kernel: [    3.048484]   with arguments:
    Nov 18 17:53:42 localhost kernel: [    3.048490]     /init
    Nov 18 17:53:42 localhost kernel: [    3.048494]   with environment:
    Nov 18 17:53:42 localhost kernel: [    3.048498]     HOME=/
    Nov 18 17:53:42 localhost kernel: [    3.048501]     TERM=linux
    Nov 18 17:53:42 localhost kernel: [    3.048505]     ubootpart=ba110a34-01
    Nov 18 17:53:42 localhost kernel: [    3.048508]     ubootsource=mmc
    Nov 18 17:53:42 localhost kernel: [    3.048512]     sunxi_ve_mem_reserve=0
    Nov 18 17:53:42 localhost kernel: [    3.048516]     sunxi_g2d_mem_reserve=0
    Nov 18 17:53:42 localhost kernel: [    3.048519]     sunxi_fb_mem_reserve=16
    Nov 18 17:53:42 localhost kernel: [    3.048523]     cgroup_enable=memory
    Nov 18 17:53:42 localhost kernel: [    3.049054] process '/usr/bin/sh' started with executable stack
    Nov 18 17:53:42 localhost kernel: [    3.748277] sunxi-mmc 1c12000.mmc: allocated mmc-pwrseq
    Nov 18 17:53:42 localhost kernel: [    3.780248] sunxi-mmc 1c12000.mmc: initialized, max. request size: 16384 KB
    Nov 18 17:53:42 localhost kernel: [    3.802372] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
    Nov 18 17:53:42 localhost kernel: [    3.803974] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
    Nov 18 17:53:42 localhost kernel: [    3.805589] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
    Nov 18 17:53:42 localhost kernel: [    3.808586] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
    Nov 18 17:53:42 localhost kernel: [    3.825106] mmc1: new high speed SDIO card at address 0001
    Nov 18 17:53:42 localhost kernel: [    4.002352] axp20x-gpio axp20x-gpio: DMA mask not set
    Nov 18 17:53:42 localhost kernel: [    4.010700] axp20x-gpio axp20x-gpio: AXP209 pinctrl and GPIO driver loaded
    Nov 18 17:53:42 localhost kernel: [    4.085803] axp20x-usb-power-supply axp20x-usb-power-supply: DMA mask not set
    Nov 18 17:53:42 localhost kernel: [    4.930834] EXT4-fs (mmcblk0p1): mounted filesystem with writeback data mode. Opts: (null)
    Nov 18 17:53:42 localhost kernel: [    7.036242] random: systemd: uninitialized urandom read (16 bytes read)
    Nov 18 17:53:42 localhost kernel: [    7.053500] random: systemd: uninitialized urandom read (16 bytes read)
    Nov 18 17:53:42 localhost kernel: [    7.055776] random: systemd: uninitialized urandom read (16 bytes read)
    Nov 18 17:53:42 localhost kernel: [    7.537425] RPC: Registered named UNIX socket transport module.
    Nov 18 17:53:42 localhost kernel: [    7.537435] RPC: Registered udp transport module.
    Nov 18 17:53:42 localhost kernel: [    7.537439] RPC: Registered tcp transport module.
    Nov 18 17:53:42 localhost kernel: [    7.537442] RPC: Registered tcp NFSv4.1 backchannel transport module.
    Nov 18 17:53:42 localhost kernel: [    7.621677] EXT4-fs (mmcblk0p1): re-mounted. Opts: commit=600,errors=remount-ro
    Nov 18 17:53:42 localhost kernel: [    9.398316] sunxi_cedrus: module is from the staging directory, the quality is unknown, you have been warned.
    Nov 18 17:53:42 localhost kernel: [    9.406426] cedrus 1c0e000.video-codec: Device registered as /dev/video0
    Nov 18 17:53:42 localhost kernel: [    9.506487] sun4i-ss 1c15000.crypto-engine: Die ID 0
    Nov 18 17:53:42 localhost kernel: [    9.605905] sun4i-drm display-engine: bound 1e00000.display-frontend (ops 0xc0a97330)
    Nov 18 17:53:42 localhost kernel: [    9.606086] sun4i-drm display-engine: bound 1e20000.display-frontend (ops 0xc0a97330)
    Nov 18 17:53:42 localhost kernel: [    9.606604] sun4i-drm display-engine: bound 1e60000.display-backend (ops 0xc0a96b74)
    Nov 18 17:53:42 localhost kernel: [    9.607010] sun4i-drm display-engine: bound 1e40000.display-backend (ops 0xc0a96b74)
    Nov 18 17:53:42 localhost kernel: [    9.607851] sun4i-drm display-engine: No panel or bridge found... RGB output disabled
    Nov 18 17:53:42 localhost kernel: [    9.607885] sun4i-drm display-engine: bound 1c0c000.lcd-controller (ops 0xc0a95600)
    Nov 18 17:53:42 localhost kernel: [    9.608812] sun4i-drm display-engine: No panel or bridge found... RGB output disabled
    Nov 18 17:53:42 localhost kernel: [    9.608843] sun4i-drm display-engine: bound 1c0d000.lcd-controller (ops 0xc0a95600)
    Nov 18 17:53:42 localhost kernel: [    9.641763] sun4i-drm display-engine: bound 1c16000.hdmi (ops sun4i_hdmi_ops [sun4i_drm_hdmi])
    Nov 18 17:53:42 localhost kernel: [    9.641787] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
    Nov 18 17:53:42 localhost kernel: [    9.641800] checking generic (bfd00000 300000) vs hw (0 ffffffff)
    Nov 18 17:53:42 localhost kernel: [    9.641807] fb0: switching to sun4i-drm-fb from simple
    Nov 18 17:53:42 localhost kernel: [    9.660761] Console: switching to colour dummy device 80x30
    Nov 18 17:53:42 localhost kernel: [    9.662310] [drm] Initialized sun4i-drm 1.0.0 20150629 for display-engine on minor 0
    Nov 18 17:53:42 localhost kernel: [    9.662411] sun4i-drm display-engine: [drm] Cannot find any crtc or sizes
    Nov 18 17:53:42 localhost kernel: [    9.718797] Registered IR keymap rc-empty
    Nov 18 17:53:42 localhost kernel: [    9.718947] rc rc0: sunxi-ir as /devices/platform/soc/1c21800.ir/rc/rc0
    Nov 18 17:53:42 localhost kernel: [    9.757655] rc rc0: lirc_dev: driver sunxi-ir registered at minor = 0, raw IR receiver, no transmitter
    Nov 18 17:53:42 localhost kernel: [    9.757924] input: sunxi-ir as /devices/platform/soc/1c21800.ir/rc/rc0/input1
    Nov 18 17:53:42 localhost kernel: [    9.780519] sunxi-ir 1c21800.ir: initialized sunXi IR driver
    Nov 18 17:53:42 localhost kernel: [   10.064999] axp20x-adc axp20x-adc: DMA mask not set
    Nov 18 17:53:42 localhost kernel: [   10.149498] cfg80211: Loading compiled-in X.509 certificates for regulatory database
    Nov 18 17:53:42 localhost kernel: [   10.151461] axp20x-battery-power-supply axp20x-battery-power-supply: DMA mask not set
    Nov 18 17:53:42 localhost kernel: [   10.155108] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
    Nov 18 17:53:42 localhost kernel: [   10.167145] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
    Nov 18 17:53:42 localhost kernel: [   10.167161] platform regulatory.0: Falling back to sysfs fallback for: regulatory.db
    Nov 18 17:53:42 localhost kernel: [   10.173659] ehci-platform 1c14000.usb: EHCI Host Controller
    Nov 18 17:53:42 localhost kernel: [   10.173704] ehci-platform 1c14000.usb: new USB bus registered, assigned bus number 1
    Nov 18 17:53:42 localhost kernel: [   10.251639] lima 1c40000.gpu: gp - mali400 version major 1 minor 1
    Nov 18 17:53:42 localhost kernel: [   10.251714] lima 1c40000.gpu: pp0 - mali400 version major 1 minor 1
    Nov 18 17:53:42 localhost kernel: [   10.251772] lima 1c40000.gpu: pp1 - mali400 version major 1 minor 1
    Nov 18 17:53:42 localhost kernel: [   10.251820] lima 1c40000.gpu: l2 cache 64K, 4-way, 64byte cache line, 64bit external bus
    Nov 18 17:53:42 localhost kernel: [   10.252577] ehci-platform 1c14000.usb: irq 33, io mem 0x01c14000
    Nov 18 17:53:42 localhost kernel: [   10.276052] ehci-platform 1c14000.usb: USB 2.0 started, EHCI 1.00
    Nov 18 17:53:42 localhost kernel: [   10.276593] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.08
    Nov 18 17:53:42 localhost kernel: [   10.276606] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    Nov 18 17:53:42 localhost kernel: [   10.276614] usb usb1: Product: EHCI Host Controller
    Nov 18 17:53:42 localhost kernel: [   10.276621] usb usb1: Manufacturer: Linux 5.8.16-sunxi ehci_hcd
    Nov 18 17:53:42 localhost kernel: [   10.276627] usb usb1: SerialNumber: 1c14000.usb
    Nov 18 17:53:42 localhost kernel: [   10.277576] hub 1-0:1.0: USB hub found
    Nov 18 17:53:42 localhost kernel: [   10.277642] hub 1-0:1.0: 1 port detected
    Nov 18 17:53:42 localhost kernel: [   10.278976] ehci-platform 1c1c000.usb: EHCI Host Controller
    Nov 18 17:53:42 localhost kernel: [   10.279036] ehci-platform 1c1c000.usb: new USB bus registered, assigned bus number 2
    Nov 18 17:53:42 localhost kernel: [   10.281111] lima 1c40000.gpu: bus rate = 300000000
    Nov 18 17:53:42 localhost kernel: [   10.281125] lima 1c40000.gpu: mod rate = 384000000
    Nov 18 17:53:42 localhost kernel: [   10.281975] [drm] Initialized lima 1.1.0 20191231 for 1c40000.gpu on minor 1
    Nov 18 17:53:42 localhost kernel: [   10.323617] ehci-platform 1c1c000.usb: irq 38, io mem 0x01c1c000
    Nov 18 17:53:42 localhost kernel: [   10.336288] ehci-platform 1c1c000.usb: USB 2.0 started, EHCI 1.00
    Nov 18 17:53:42 localhost kernel: [   10.336680] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.08
    Nov 18 17:53:42 localhost kernel: [   10.336690] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    Nov 18 17:53:42 localhost kernel: [   10.336697] usb usb2: Product: EHCI Host Controller
    Nov 18 17:53:42 localhost kernel: [   10.336704] usb usb2: Manufacturer: Linux 5.8.16-sunxi ehci_hcd
    Nov 18 17:53:42 localhost kernel: [   10.336710] usb usb2: SerialNumber: 1c1c000.usb
    Nov 18 17:53:42 localhost kernel: [   10.337739] hub 2-0:1.0: USB hub found
    Nov 18 17:53:42 localhost kernel: [   10.337815] hub 2-0:1.0: 1 port detected
    Nov 18 17:53:42 localhost kernel: [   10.339096] ohci-platform 1c14400.usb: Generic Platform OHCI controller
    Nov 18 17:53:42 localhost kernel: [   10.339138] ohci-platform 1c14400.usb: new USB bus registered, assigned bus number 3
    Nov 18 17:53:42 localhost kernel: [   10.339614] ohci-platform 1c14400.usb: irq 34, io mem 0x01c14400
    Nov 18 17:53:42 localhost kernel: [   10.370077] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43362-sdio for chip BCM43362/1
    Nov 18 17:53:42 localhost kernel: [   10.410177] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.08
    Nov 18 17:53:42 localhost kernel: [   10.410191] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    Nov 18 17:53:42 localhost kernel: [   10.410199] usb usb3: Product: Generic Platform OHCI controller
    Nov 18 17:53:42 localhost kernel: [   10.410206] usb usb3: Manufacturer: Linux 5.8.16-sunxi ohci_hcd
    Nov 18 17:53:42 localhost kernel: [   10.410213] usb usb3: SerialNumber: 1c14400.usb
    Nov 18 17:53:42 localhost kernel: [   10.411619] hub 3-0:1.0: USB hub found
    Nov 18 17:53:42 localhost kernel: [   10.411813] hub 3-0:1.0: 1 port detected
    Nov 18 17:53:42 localhost kernel: [   10.413347] ohci-platform 1c1c400.usb: Generic Platform OHCI controller
    Nov 18 17:53:42 localhost kernel: [   10.413406] ohci-platform 1c1c400.usb: new USB bus registered, assigned bus number 4
    Nov 18 17:53:42 localhost kernel: [   10.417787] ohci-platform 1c1c400.usb: irq 39, io mem 0x01c1c400
    Nov 18 17:53:42 localhost kernel: [   10.485019] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.08
    Nov 18 17:53:42 localhost kernel: [   10.485045] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    Nov 18 17:53:42 localhost kernel: [   10.485052] usb usb4: Product: Generic Platform OHCI controller
    Nov 18 17:53:42 localhost kernel: [   10.485060] usb usb4: Manufacturer: Linux 5.8.16-sunxi ohci_hcd
    Nov 18 17:53:42 localhost kernel: [   10.485066] usb usb4: SerialNumber: 1c1c400.usb
    Nov 18 17:53:42 localhost kernel: [   10.488719] hub 4-0:1.0: USB hub found
    Nov 18 17:53:42 localhost kernel: [   10.488798] hub 4-0:1.0: 1 port detected
    Nov 18 17:53:42 localhost kernel: [   10.490748] usb_phy_generic usb_phy_generic.0.auto: supply vcc not found, using dummy regulator
    Nov 18 17:53:42 localhost kernel: [   10.492231] musb-hdrc musb-hdrc.1.auto: MUSB HDRC host driver
    Nov 18 17:53:42 localhost kernel: [   10.492270] musb-hdrc musb-hdrc.1.auto: new USB bus registered, assigned bus number 5
    Nov 18 17:53:42 localhost kernel: [   10.492413] phy id_det change to device
    Nov 18 17:53:42 localhost kernel: [   10.492652] usb usb5: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.08
    Nov 18 17:53:42 localhost kernel: [   10.492662] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    Nov 18 17:53:42 localhost kernel: [   10.492668] usb usb5: Product: MUSB HDRC host driver
    Nov 18 17:53:42 localhost kernel: [   10.492675] usb usb5: Manufacturer: Linux 5.8.16-sunxi musb-hcd
    Nov 18 17:53:42 localhost kernel: [   10.492682] usb usb5: SerialNumber: musb-hdrc.1.auto
    Nov 18 17:53:42 localhost kernel: [   10.493616] hub 5-0:1.0: USB hub found
    Nov 18 17:53:42 localhost kernel: [   10.493690] hub 5-0:1.0: 1 port detected
    Nov 18 17:53:42 localhost kernel: [   10.497070] asoc-simple-card sound: dit-hifi <-> 1c21000.spdif mapping ok
    Nov 18 17:53:42 localhost kernel: [   10.516495] Bluetooth: Core ver 2.22
    Nov 18 17:53:42 localhost kernel: [   10.516673] NET: Registered protocol family 31
    Nov 18 17:53:42 localhost kernel: [   10.516679] Bluetooth: HCI device and connection manager initialized
    Nov 18 17:53:42 localhost kernel: [   10.516708] Bluetooth: HCI socket layer initialized
    Nov 18 17:53:42 localhost kernel: [   10.516719] Bluetooth: L2CAP socket layer initialized
    Nov 18 17:53:42 localhost kernel: [   10.516753] Bluetooth: SCO socket layer initialized
    Nov 18 17:53:42 localhost kernel: [   10.680281] usb 2-1: new high-speed USB device number 2 using ehci-platform
    Nov 18 17:53:42 localhost kernel: [   10.695312] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43362-sdio for chip BCM43362/1
    Nov 18 17:53:42 localhost kernel: [   10.759515] Bluetooth: HCI UART driver ver 2.3
    Nov 18 17:53:42 localhost kernel: [   10.759529] Bluetooth: HCI UART protocol H4 registered
    Nov 18 17:53:42 localhost kernel: [   10.759534] Bluetooth: HCI UART protocol BCSP registered
    Nov 18 17:53:42 localhost kernel: [   10.759706] Bluetooth: HCI UART protocol LL registered
    Nov 18 17:53:42 localhost kernel: [   10.759712] Bluetooth: HCI UART protocol ATH3K registered
    Nov 18 17:53:42 localhost kernel: [   10.759776] Bluetooth: HCI UART protocol Three-wire (H5) registered
    Nov 18 17:53:42 localhost kernel: [   10.760287] Bluetooth: HCI UART protocol Broadcom registered
    Nov 18 17:53:42 localhost kernel: [   10.760512] hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator
    Nov 18 17:53:42 localhost kernel: [   10.760649] hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator
    Nov 18 17:53:42 localhost kernel: [   10.837076] usb 2-1: New USB device found, idVendor=1a40, idProduct=0101, bcdDevice= 1.11
    Nov 18 17:53:42 localhost kernel: [   10.837090] usb 2-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
    Nov 18 17:53:42 localhost kernel: [   10.837097] usb 2-1: Product: USB 2.0 Hub
    Nov 18 17:53:42 localhost kernel: [   10.838246] hub 2-1:1.0: USB hub found
    Nov 18 17:53:42 localhost kernel: [   10.838456] hub 2-1:1.0: 4 ports detected
    Nov 18 17:53:42 localhost kernel: [   10.944267] usb 3-1: new full-speed USB device number 2 using ohci-platform
    Nov 18 17:53:42 localhost kernel: [   10.981799] cfg80211: failed to load regulatory.db
    Nov 18 17:53:42 localhost kernel: [   11.145360] Bluetooth: hci0: BCM: chip id 63
    Nov 18 17:53:42 localhost kernel: [   11.147981] Bluetooth: hci0: BCM: features 0x07
    Nov 18 17:53:42 localhost kernel: [   11.171842] brcmfmac: brcmf_c_process_clm_blob: no clm_blob available (err=-11), device may have limited channels available
    Nov 18 17:53:42 localhost kernel: [   11.172345] Bluetooth: hci0: BCM20702A
    Nov 18 17:53:42 localhost kernel: [   11.172360] Bluetooth: hci0: BCM20702A1 (001.002.014) build 0000
    Nov 18 17:53:42 localhost kernel: [   11.176844] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM43362/1 wl0: Apr 22 2013 14:50:00 version 5.90.195.89.6 FWID 01-b30a427d
    Nov 18 17:53:42 localhost kernel: [   11.186421] usb 3-1: New USB device found, idVendor=0403, idProduct=6001, bcdDevice= 6.00
    Nov 18 17:53:42 localhost kernel: [   11.186453] usb 3-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
    Nov 18 17:53:42 localhost kernel: [   11.186472] usb 3-1: Product: FT232R USB UART
    Nov 18 17:53:42 localhost kernel: [   11.186479] usb 3-1: Manufacturer: FTDI
    Nov 18 17:53:42 localhost kernel: [   11.186494] usb 3-1: SerialNumber: A7031FBC
    Nov 18 17:53:42 localhost kernel: [   11.244304] usb 2-1.2: new full-speed USB device number 3 using ehci-platform
    Nov 18 17:53:42 localhost kernel: [   11.303763] Bluetooth: hci0: BCM: firmware Patch file not found, tried:
    Nov 18 17:53:42 localhost kernel: [   11.303774] Bluetooth: hci0: BCM: 'brcm/BCM20702A1.hcd'
    Nov 18 17:53:42 localhost kernel: [   11.303778] Bluetooth: hci0: BCM: 'brcm/BCM.hcd'
    Nov 18 17:53:42 localhost kernel: [   11.393206] usbcore: registered new interface driver usbserial_generic
    Nov 18 17:53:42 localhost kernel: [   11.393288] usbserial: USB Serial support registered for generic
    Nov 18 17:53:42 localhost kernel: [   11.446026] usbcore: registered new interface driver ftdi_sio
    Nov 18 17:53:42 localhost kernel: [   11.446100] usbserial: USB Serial support registered for FTDI USB Serial Device
    Nov 18 17:53:42 localhost kernel: [   11.446465] ftdi_sio 3-1:1.0: FTDI USB Serial Device converter detected
    Nov 18 17:53:42 localhost kernel: [   11.446705] usb 3-1: Detected FT232RL
    Nov 18 17:53:42 localhost kernel: [   11.454182] usb 3-1: FTDI USB Serial Device converter now attached to ttyUSB0
    Nov 18 17:53:42 localhost kernel: [   11.474645] usb 2-1.2: New USB device found, idVendor=03eb, idProduct=204b, bcdDevice= 0.00
    Nov 18 17:53:42 localhost kernel: [   11.474660] usb 2-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=0
    Nov 18 17:53:42 localhost kernel: [   11.474667] usb 2-1.2: Product: CUL433
    Nov 18 17:53:42 localhost kernel: [   11.474674] usb 2-1.2: Manufacturer: busware.de
    Nov 18 17:53:42 localhost kernel: [   11.676258] usb 2-1.4: new full-speed USB device number 4 using ehci-platform
    Nov 18 17:53:42 localhost kernel: [   11.894199] usb 2-1.4: New USB device found, idVendor=1b1f, idProduct=c00f, bcdDevice= 9.67
    Nov 18 17:53:42 localhost kernel: [   11.894213] usb 2-1.4: New USB device strings: Mfr=4, Product=14, SerialNumber=36
    Nov 18 17:53:42 localhost kernel: [   11.894221] usb 2-1.4: Product: HM-CFG-USB
    Nov 18 17:53:42 localhost kernel: [   11.894227] usb 2-1.4: Manufacturer: eQ-3
    Nov 18 17:53:42 localhost kernel: [   11.894234] usb 2-1.4: SerialNumber: MEQ0232057
    Nov 18 17:53:42 localhost kernel: [   11.899648] hid-generic 0003:1B1F:C00F.0001: hiddev0,hidraw0: USB HID v1.10 Device [eQ-3 HM-CFG-USB] on usb-1c1c000.usb-1.4/input0
    Nov 18 17:53:42 localhost kernel: [   12.029291] cdc_acm 2-1.2:1.0: ttyACM0: USB ACM device
    Nov 18 17:53:42 localhost kernel: [   12.031857] usbcore: registered new interface driver cdc_acm
    Nov 18 17:53:42 localhost kernel: [   12.031867] cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters
    Nov 18 17:53:42 localhost kernel: [   12.153894] EXT4-fs (sda1): recovery complete
    Nov 18 17:53:42 localhost kernel: [   12.171345] EXT4-fs
Fhem Cubitruck  Armbian Buster with Linux 5.3.9-sunxi
HM-CC_RT-DN, HM-Sec-RHS,HM-Sec-SD, HM-Sec-SCo,IT1500,1xIT GRR-3500 Fritz!Dect200,Powerline546E,Enigma2 Modul mit 3 Vu+,Wol Modul für WinServer2016 und WinServer 2019,FB6590
Allnetl Wandtablett mit FTUI

Wernieman

Er hat rebootet .. und vorher irgendwas mit "RAM-Log" ....  hast Du ein "Log ins RAM" implementiert????
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

Tommy82

zRAM läuft auf dem Cubie, müßte ich dann nochmal deaktivieren
Fhem Cubitruck  Armbian Buster with Linux 5.3.9-sunxi
HM-CC_RT-DN, HM-Sec-RHS,HM-Sec-SD, HM-Sec-SCo,IT1500,1xIT GRR-3500 Fritz!Dect200,Powerline546E,Enigma2 Modul mit 3 Vu+,Wol Modul für WinServer2016 und WinServer 2019,FB6590
Allnetl Wandtablett mit FTUI

Wernieman

#22
Da wir von einem Problem reden, was nur durch Kaltstart lösbar ist und genau dann die Logfiles mehr als Interessant ... würde ich es als notwendig erachten. Da Logfiles im RAM ....
Zusätzlich Braucht Speicher (Stickwort oom-killer)

Was mir dazu einfällt, hat Dein kern.log i/o-Probleme?
grep -i i/o /var/log/kern.log
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

Tommy82

Hi,
ich habe zram logging mal wieder deaktiviert, allerdings gab es heute auch keine Probleme.
Deine
Zitatgrep -i i/o /var/log/kern.log
liefert nichts zurück
Fhem Cubitruck  Armbian Buster with Linux 5.3.9-sunxi
HM-CC_RT-DN, HM-Sec-RHS,HM-Sec-SD, HM-Sec-SCo,IT1500,1xIT GRR-3500 Fritz!Dect200,Powerline546E,Enigma2 Modul mit 3 Vu+,Wol Modul für WinServer2016 und WinServer 2019,FB6590
Allnetl Wandtablett mit FTUI

Wernieman

Hatte ich auch nicht erwartet ... habe meinen letzten Beitrag korrigiert. War "falsch geschrieben"
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

Tommy82

Fhem Cubitruck  Armbian Buster with Linux 5.3.9-sunxi
HM-CC_RT-DN, HM-Sec-RHS,HM-Sec-SD, HM-Sec-SCo,IT1500,1xIT GRR-3500 Fritz!Dect200,Powerline546E,Enigma2 Modul mit 3 Vu+,Wol Modul für WinServer2016 und WinServer 2019,FB6590
Allnetl Wandtablett mit FTUI

Klaus.A

Ganz anderer Gedanke - ich hatte auch völlig unerklärliche Hänger mit dem Cubietruck:

Ist der Systemtakt fest oder dynamisch eingestellt? Diese dynamische ("nach Bedarf") geregelte Taktung kann zu den wildesten Fehlersituationen führen, die auch völlig irre führend sind.

Seit ich den Takt fix eingestellt habe läuft mein System mehr als 90 Tage ohne Hänger, Reboot, Watchdog-Aktionen...

Keine Garantie das es hilft, wäre aber ein Ansatz mit wenig Aufwand. Kommt natürlich aufs OS an wo und wie das eingestellt wird. Ich weiß nur aus Erfahrung das die Cubietrucks etwas empfindlich sind was den Systemtakt angeht.

Gruß, Klaus

2 x CubieTruck mit 1) FHEM 5.9 und 2) IOBroker-mit Echo-Dot/Alexa und Homekit-/Siri-Integration. 1 x HMLAN, 3 x HM-LGW-O-TW-W-EU-2, mehr als 90 HomeMatic Sensoren und Aktoren, Velux-Fenster-IF, Fibaro ZWave-Sensoren und Aktoren, Philips Hue Bridge, IRTrans IR-Konverter, AutoMower via API

Tommy82

#27
Ohna das ich etwas gemacht habe und ohne das ich es erklären kann, läuft er jetzt seit 14 Tagen ohne Probleme.
Nur der Load erschreckt mich etwas
login as: root
root@192.168.188.47's password:
  ____      _     _      _                   _
/ ___|   _| |__ (_) ___| |_ _ __ _   _  ___| | __
| |  | | | | '_ \| |/ _ \ __| '__| | | |/ __| |/ /
| |__| |_| | |_) | |  __/ |_| |  | |_| | (__|   <
\____\__,_|_.__/|_|\___|\__|_|   \__,_|\___|_|\_\

Welcome to Armbian 20.08.17 Buster with Linux 5.8.16-sunxi

System load:   241%             Up time:       14 days 1:13
Memory usage:  13% of 1.96G     IP:            192.168.188.47
CPU temp:      42°C             Usage of /:    47% of 7.2G      storage/:      1% of 110G

Last login: Thu Nov 19 19:33:50 2020 from 192.168.188.52


dmesg liefert ein paar rote eintröge
[   11.147981] Bluetooth: hci0: BCM: features 0x07
[   11.171842] brcmfmac: brcmf_c_process_clm_blob: no clm_blob available (err=-1                                                                                                                     1), device may have limited channels available
[   11.172345] Bluetooth: hci0: BCM20702A
[   11.172360] Bluetooth: hci0: BCM20702A1 (001.002.014) build 0000
[   11.176844] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM43362/1 wl0: Apr 22                                                                                                                      2013 14:50:00 version 5.90.195.89.6 FWID 01-b30a427d
[   11.186421] usb 3-1: New USB device found, idVendor=0403, idProduct=6001, bcd                                                                                                                     Device= 6.00
[   11.186453] usb 3-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[   11.186472] usb 3-1: Product: FT232R USB UART
[   11.186479] usb 3-1: Manufacturer: FTDI
[   11.186494] usb 3-1: SerialNumber: A7031FBC
[   11.244304] usb 2-1.2: new full-speed USB device number 3 using ehci-platform
[   11.303763] Bluetooth: hci0: BCM: firmware Patch file not found, tried:
[   11.303774] Bluetooth: hci0: BCM: 'brcm/BCM20702A1.hcd'
[   11.303778] Bluetooth: hci0: BCM: 'brcm/BCM.hcd'
[   11.393206] usbcore: registered new interface driver usbserial_generic
[   11.393288] usbserial: USB Serial support registered for generic
[   11.446026] usbcore: registered new interface driver ftdi_sio
[   11.446100] usbserial: USB Serial support registered for FTDI USB Serial Devi                                                                                                                     ce
[   11.446465] ftdi_sio 3-1:1.0: FTDI USB Serial Device converter detected
[   11.446705] usb 3-1: Detected FT232RL
[   11.454182] usb 3-1: FTDI USB Serial Device converter now attached to ttyUSB0
[   11.474645] usb 2-1.2: New USB device found, idVendor=03eb, idProduct=204b, b                                                                                                                     cdDevice= 0.00
[   11.474660] usb 2-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber                                                                                                                     =0
[   11.474667] usb 2-1.2: Product: CUL433


[   21.103211] systemd[1]: Started Armbian memory supported logging.
[   21.116526] systemd[1]: Starting Journal Service...
[   21.547262] systemd[1]: Started Journal Service.
[   21.663334] systemd-journald[525]: Received request to flush runtime journal                                                                                                                      from PID 1
[   22.413392] random: crng init done
[   22.413409] random: 7 urandom warning(s) missed due to ratelimiting
[   28.650370] sun7i-dwmac 1c50000.ethernet eth0: PHY [stmmac-0:01] driver [RTL8                                                                                                                     211E Gigabit Ethernet] (irq=POLL)
[   28.658233] sun7i-dwmac 1c50000.ethernet eth0: No Safety Features support fou                                                                                                                     nd
[   28.658252] sun7i-dwmac 1c50000.ethernet eth0: RX IPC Checksum Offload disabl                                                                                                                     ed
[   28.658265] sun7i-dwmac 1c50000.ethernet eth0: No MAC Management Counters ava                                                                                                                     ilable
[   28.658275] sun7i-dwmac 1c50000.ethernet eth0: PTP not supported by HW
[   28.658293] sun7i-dwmac 1c50000.ethernet eth0: configuring for phy/rgmii link                                                                                                                      mode
[   31.368246] ieee80211 phy0: brcmf_p2p_create_p2pdev: timeout occurred
[   31.368273] ieee80211 phy0: brcmf_cfg80211_add_iface: add iface p2p-dev-wlan0                                                                                                                      type 10 failed: err=-5
[   31.753708] sun7i-dwmac 1c50000.ethernet eth0: Link is Up - 1Gbps/Full - flow                                                                                                                      control rx/tx
[   31.753764] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   33.768178] vcc3v0: disabling
[   33.768195] vcc5v0: disabling
[   33.768223] usb0-vbus: disabling
[1120462.079020] 8<--- cut here ---
[1120462.079036] Unable to handle kernel paging request at virtual address 00e94                                                                                                                     f20
[1120462.079046] pgd = f29bac8c
[1120462.079049] [00e94f20] *pgd=00000000
[1120462.079062] Internal error: Oops: 5 [#1] SMP THUMB2
[1120462.084136] Modules linked in: zram cdc_acm ftdi_sio usbserial hci_uart btr                                                                                                                     tl btbcm bluetooth snd_soc_spdif_tx brcmfmac ecdh_generic evdev brcmutil ecc axp                                                                                                                     20x_battery lima axp20x_adc cfg80211 gpu_sched sun4i_gpadc_iio sun4i_ts sunxi_ci                                                                                                                     r pwm_sun4i sun4i_drm_hdmi rfkill sun4i_ss sunxi_cedrus(C) uio_pdrv_genirq uio d                                                                                                                     isplay_connector cpufreq_dt sunrpc ip_tables x_tables autofs4 axp20x_usb_power i                                                                                                                     ndustrialio pinctrl_axp209 sunxi sun4i_gpadc phy_generic pwrseq_simple realtek(E                                                                                                                     )


10c)
[1120462.443185] [<c0135b07>] (kthread) from [<c0100159>] (ret_from_fork+0x11/0x                                                                                                                     38)
[1120462.450588] Exception stack(0xed4b5fb0 to 0xed4b5ff8)
[1120462.455821] 5fa0:                                     00000000 00000000 000                                                                                                                     00000 00000000
[1120462.464184] 5fc0: 00000000 00000000 00000000 00000000 00000000 00000000 000                                                                                                                     00000 00000000
[1120462.472545] 5fe0: 00000000 00000000 00000000 00000000 00000013 00000000
[1120462.479344] Code: 9a01 4629 9b00 4630 (6a25) 69e6
[1120462.484508] ---[ end trace 18598cd5734e3bd7 ]---
[1120582.613729] ieee80211 phy0: brcmf_escan_timeout: timer expired


vmstat
vmstat
procs -----------memory---------- ---swap-- -----io---- -system-- ------cpu-----
r  b   swpd   free   buff  cache   si   so    bi    bo   in   cs us sy id wa st
0  0      0 182060 162756 1439764    0    0     0    13   11    1  5  7 88  0  0


Tasks: 116 total,   1 running, 114 sleeping,   0 stopped,   1 zombie
%Cpu(s):  0,3 us,  5,5 sy,  0,0 ni, 94,2 id,  0,0 wa,  0,0 hi,  0,0 si,  0,0 st
MiB Mem :   2008,9 total,    178,3 free,    265,1 used,   1565,5 buff/cache
MiB Swap:   1004,5 total,   1004,5 free,      0,0 used.   1661,7 avail Mem

  PID USER      PR  NI    VIRT    RES    SHR S  %CPU  %MEM     TIME+ COMMAND
3599 root      20   0       0      0      0 I   9,9   0,0   0:42.40 kworker/0:2-events_freezable_power_
4953 root      20   0    9372   2564   2048 R   1,3   0,1   0:00.39 top
1149 root      19  -1   26600   4500   2796 S   0,7   0,2 135:05.87 oscam.armel
3084 fhem      20   0  165124 125888   9936 S   0,7   6,1 265:19.25 perl
3560 root      20   0   10228   5240   4464 S   0,3   0,3   0:00.81 sshd
    1 root      20   0   32216   6976   5148 S   0,0   0,3   2:49.55 systemd
    2 root      20   0       0      0      0 S   0,0   0,0   0:02.26 kthreadd
Fhem Cubitruck  Armbian Buster with Linux 5.3.9-sunxi
HM-CC_RT-DN, HM-Sec-RHS,HM-Sec-SD, HM-Sec-SCo,IT1500,1xIT GRR-3500 Fritz!Dect200,Powerline546E,Enigma2 Modul mit 3 Vu+,Wol Modul für WinServer2016 und WinServer 2019,FB6590
Allnetl Wandtablett mit FTUI