LIME2 Rev.L lock-up freeze instability

Started by kimfaint, June 13, 2023, 04:56:47 AM

Previous topic - Next topic

LubOlimex

Did you run apt update and apt upgrade?

Can you provide a full boot log?
Technical support and documentation manager at Olimex

KriszK

#16
Again here...

As I mentioned at 05 September the replacement of Rev.L1 board to Rev.K2 solved our problem. Rev. K2 boards are very stable (no need to restart at all).

We have decided to start new service using this T2-OLinuXino-LIME2-e8Gs16M-IND Rev.L1 board. It is just a SSH server and upload files to public server in every 10 minutes by FTP. It is used in very low loads. OS is the official Olimex image.

This board has same HW configuration as all other Rev. K2 boards (mentioned in previous posts), and one USB port is used for a UPS monitoring.

Uptime is longer... Now it was at least 15 days but today we are not able to ssh to this board and stopped FTP uploading. Following error message repeated on console:

[1376469.276287] rcu: INFO: rcu_sched detected stalls on CPUs/tasks:
[1376469.282400] rcu:   1-...0: (0 ticks this GP) idle=d96/1/0x40000000 softirq=4261683/4261683 fqs=13326
[1376469.291707]        (detected by 0, t=3991267 jiffies, g=8388861, q=898)
[1376469.297978] Sending NMI from CPU 0 to CPUs 1:
[1376479.304249] rcu: rcu_sched kthread starved for 3959453 jiffies! g8388861 f0x2 RCU_GP_WAIT_FQS(5) ->state=0x0 ->cpu=0
[1376479.314938] rcu:   Unless rcu_sched kthread gets sufficient CPU time, OOM is now expected behavior.
[1376479.324065] rcu: RCU grace-period kthread stack dump:
[1376479.329294] task:rcu_sched       state:R  running task     stack:    0 pid:   12 ppid:     2 flags:0x00000000
[1376479.339393] Backtrace:
[1376479.342041] [<c0abc668>] (__schedule) from [<c0abcfb0>] (schedule+0x68/0xe4)
[1376479.349278]  r10:c019f718 r9:ef687540 r8:ef687540 r7:c0f04fc8 r6:c155bee4 r5:c1535400
[1376479.357282]  r4:ffffe000
[1376479.360012] [<c0abcf48>] (schedule) from [<c0ac11ac>] (schedule_timeout+0x1d0/0x384)
[1376479.367932]  r5:c0f03d00 r4:14457886
[1376479.371704] [<c0ac0fdc>] (schedule_timeout) from [<c01a1964>] (rcu_gp_kthread+0x564/0xd88)
[1376479.380152]  r9:ffffe000 r8:00000001 r7:00000000 r6:c0f03d00 r5:00000000 r4:c0f76440
[1376479.388083] [<c01a1400>] (rcu_gp_kthread) from [<c014af18>] (kthread+0x170/0x174)
[1376479.395742]  r7:c155a000
[1376479.398471] [<c014ada8>] (kthread) from [<c0100148>] (ret_from_fork+0x14/0x2c)
[1376479.405869] Exception stack(0xc155bfb0 to 0xc155bff8)
[1376479.411105] bfa0:                                     00000000 00000000 00000000 00000000
[1376479.419465] bfc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
[1376479.427822] bfe0: 00000000 00000000 00000000 00000000 00000013 00000000
[1376479.434624]  r10:00000000 r9:00000000 r8:00000000 r7:00000000 r6:00000000 r5:c014ada8
[1376479.442628]  r4:c1506380
[1376532.293666] rcu: INFO: rcu_sched detected stalls on CPUs/tasks:
[1376532.299779] rcu:   1-...0: (0 ticks this GP) idle=d96/1/0x40000000 softirq=4261683/4261683 fqs=13326
[1376532.309086]        (detected by 0, t=4007022 jiffies, g=8388861, q=898)
[1376532.315358] Sending NMI from CPU 0 to CPUs 1:
[1376542.321630] rcu: rcu_sched kthread starved for 3975208 jiffies! g8388861 f0x2 RCU_GP_WAIT_FQS(5) ->state=0x0 ->cpu=0
[1376542.332320] rcu:   Unless rcu_sched kthread gets sufficient CPU time, OOM is now expected behavior.
[1376542.341447] rcu: RCU grace-period kthread stack dump:
[1376542.346676] task:rcu_sched       state:R  running task     stack:    0 pid:   12 ppid:     2 flags:0x00000000
[1376542.356775] Backtrace:
[1376542.359424] [<c0abc668>] (__schedule) from [<c0abcfb0>] (schedule+0x68/0xe4)
[1376542.366661]  r10:c019f718 r9:ef687540 r8:ef687540 r7:c0f04fc8 r6:c155bee4 r5:c1535400
[1376542.374665]  r4:ffffe000
[1376542.377395] [<c0abcf48>] (schedule) from [<c0ac11ac>] (schedule_timeout+0x1d0/0x384)
[1376542.385315]  r5:c0f03d00 r4:14457886
[1376542.389087] [<c0ac0fdc>] (schedule_timeout) from [<c01a1964>] (rcu_gp_kthread+0x564/0xd88)
[1376542.397536]  r9:ffffe000 r8:00000001 r7:00000000 r6:c0f03d00 r5:00000000 r4:c0f76440
[1376542.405468] [<c01a1400>] (rcu_gp_kthread) from [<c014af18>] (kthread+0x170/0x174)
[1376542.413126]  r7:c155a000
[1376542.415853] [<c014ada8>] (kthread) from [<c0100148>] (ret_from_fork+0x14/0x2c)
[1376542.423252] Exception stack(0xc155bfb0 to 0xc155bff8)
[1376542.428488] bfa0:                                     00000000 00000000 00000000 00000000
[1376542.436848] bfc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
[1376542.445204] bfe0: 00000000 00000000 00000000 00000000 00000013 00000000
[1376542.452004]  r10:00000000 r9:00000000 r8:00000000 r7:00000000 r6:00000000 r5:c014ada8
[1376542.460008]  r4:c1506380

I hope it can help...

LubOlimex

Pretty random 15 days, huh. And only stalls when attempting SSH? Maybe there is relation between the connection and the stall?

Can I have full command line boot log first? From the moment you power the board until login prompt.

Also before the RCU stall that you get what does /proc/interrupts show, is there any device spamming interrupts?

About the error: https://docs.kernel.org/RCU/stallwarn.html - it is interesting that it it set to force kernel panic instead of warning. Maybe that can be changed, there is plenty of info about RCU stalls online. Also this part is interesting (especially combined with the SSH connection timing):


"Booting Linux using a console connection that is too slow to
keep up with the boot-time console-message rate.  For example,
a 115Kbaud serial console can be -way- too slow to keep up
with boot-time message rates, and will frequently result in
RCU CPU stall warning messages.  Especially if you have added
debug printk()s."
Technical support and documentation manager at Olimex

KriszK

Last report of input voltage of UPS received at okt 26, 2023, 5:10AM. From this time no any report and the board has similar freezing symptom as before used this board for controller of Zigbee network. In that case 1 or 2 days was enough to reach this state. The Zigbee USB stick (https://electrolama.com/projects/zig-a-zig-ah/) traffic is more heavy that the APC UPS Data Port can serve.

I think no any relation between SSH attempt and stall. SSH connection attempt was made about 9:00AM

I will preserve full log of booting later and I will check syslog as well.

KriszK

Freezing happened at Oct 26 05:09:28

kern.log:
Oct 26 05:09:28 18087 kernel: [1360505.178265] BPF interpreter: unknown opcode 20
Oct 26 05:09:28 18087 kernel: [1360505.178315] ------------[ cut here ]------------
Oct 26 05:09:28 18087 kernel: [1360505.183134] kernel BUG at kernel/bpf/core.c:1687!
Oct 26 05:09:28 18087 kernel: [1360505.188017] Internal error: Oops - BUG: 0 [#1] SMP ARM
Oct 26 05:09:28 18087 kernel: [1360505.193333] Modules linked in: ipt_REJECT nf_reject_ipv4 xt_multiport rfkill xt_recent nft_limit xt_limit xt_tcpudp xt_state xt_conntrack nft_compat nft_counter nf_conntrack_ftp nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 nf_tables nfnetlink evdev axp20x_ac_power axp20x_battery axp20x_adc industrialio at24 panel_olimex_lcd_olinuxino lima sun4i_can gpu_sched can_dev sun4i_codec sun4i_ss libdes sun4i_drm_hdmi sunxi_cedrus(C) v4l2_mem2mem videobuf2_dma_contig videobuf2_memops videobuf2_v4l2 videobuf2_common videodev mc uio_pdrv_genirq uio cpufreq_dt sun4i_ts hwmon usb_f_acm u_serial g_serial libcomposite fuse ip_tables x_tables pinctrl_axp209 pwm_sun4i spidev pwm_bl
Oct 26 05:09:28 18087 kernel: [1360505.252514] CPU: 0 PID: 22150 Comm: sshd Tainted: G         C        5.10.180-olimex #092646
Oct 26 05:09:28 18087 kernel: [1360505.261122] Hardware name: Allwinner sun7i (A20) Family
Oct 26 05:09:28 18087 kernel: [1360505.266546] PC is at ___bpf_prog_run+0x1f18/0x1f1c
Oct 26 05:09:28 18087 kernel: [1360505.271520] LR is at __irq_work_queue_local+0x40/0x74
Oct 26 05:09:28 18087 kernel: [1360505.276749] pc : [<c0234c9c>]    lr : [<c022fe1c>]    psr: 600f0013
Oct 26 05:09:28 18087 kernel: [1360505.283191] sp : c25ebdb0  ip : c25ebcc0  fp : c25ebe14
Oct 26 05:09:28 18087 kernel: [1360505.288592] r10: 00000000  r9 : c3a0df80  r8 : 7fff0000
Oct 26 05:09:28 18087 kernel: [1360505.293995] r7 : c0230674  r6 : c0b11ae8  r5 : c25ebe38  r4 : f086a248
Oct 26 05:09:28 18087 kernel: [1360505.300698] r3 : 43246c48  r2 : 43246c48  r1 : ef683414  r0 : 00000022
Oct 26 05:09:28 18087 kernel: [1360505.307404] Flags: nZCv  IRQs on  FIQs on  Mode SVC_32  ISA ARM  Segment none
Oct 26 05:09:28 18087 kernel: [1360505.314716] Control: 10c5387d  Table: 4548006a  DAC: 00000051
Oct 26 05:09:28 18087 kernel: [1360505.320646] Process sshd (pid: 22150, stack limit = 0x93f32093)
Oct 26 05:09:28 18087 kernel: [1360505.326745] Stack: (0xc25ebdb0 to 0xc25ec000)
Oct 26 05:09:28 18087 kernel: [1360505.331287] bda0:                                     c25ebe04 c25ebe04 c0f04fc8 02cb5a98
Oct 26 05:09:28 18087 kernel: [1360505.339646] bdc0: 00000000 02cb5a98 00000004 00000000 00000004 c0340128 c0ac23fc 00000005
Oct 26 05:09:28 18087 kernel: [1360505.348005] bde0: 00000051 00000000 c08e36d4 c0f04fc8 c3a0df80 f086a000 00000004 7fff0000
Oct 26 05:09:28 18087 kernel: [1360505.356363] be00: c3a0df80 c25ebef0 c25ebeb4 c25ebe18 c0235b78 c0232d90 00000000 c25ebe28
Oct 26 05:09:28 18087 kernel: [1360505.364722] be20: c09eff04 c09b5e50 c25ebe60 c9cd8780 00000000 00000000 00000003 00000000
Oct 26 05:09:28 18087 kernel: [1360505.373081] be40: c25ebef0 00000000 c25ebee0 c0f04fc8 c25ebec4 c25ebe60 c0f04fc8 00000000
Oct 26 05:09:28 18087 kernel: [1360505.381439] be60: 00000001 00000000 c25ebef0 00000000 00000000 00000000 00000000 00000000
Oct 26 05:09:28 18087 kernel: [1360505.389798] be80: 00000000 00000000 c25ebe38 00000000 00000000 43246c48 c25ebf2c 43246c48
Oct 26 05:09:28 18087 kernel: [1360505.398156] bea0: 00000420 7fff0000 c25ebf64 c25ebeb8 c01fc85c c0235b38 00000000 00000003
Oct 26 05:09:28 18087 kernel: [1360505.406515] bec0: c0f04fc8 ffff0000 00000000 00000000 00000000 befe230c 00002000 00000000
Oct 26 05:09:28 18087 kernel: [1360505.414873] bee0: 02cc10f0 befe2310 00000000 c25ebee0 00000003 40000028 b304c7e6 00000000
Oct 26 05:09:28 18087 kernel: [1360505.423231] bf00: 00000004 00000000 befe230c 00000000 00002000 00000000 00000000 00000000
Oct 26 05:09:28 18087 kernel: [1360505.431590] bf20: 02cc10f0 00000000 befe2310 00000000 c03402c4 43246c48 00000000 ffffe000
Oct 26 05:09:28 18087 kernel: [1360505.439949] bf40: c25ebfb0 b2cc84d0 00000003 c01002c4 c25ea000 00800000 c25ebf74 c25ebf68
Oct 26 05:09:28 18087 kernel: [1360505.448308] bf60: c01fdad0 c01fc7cc c25ebfa4 c25ebf78 c010a690 c01fda8c c25ea000 0000008e
Oct 26 05:09:28 18087 kernel: [1360505.456668] bf80: c25ebfa4 02cc10f0 befe2310 b2cc84d0 00000003 c01002c4 00000000 c25ebfa8
Oct 26 05:09:28 18087 kernel: [1360505.465027] bfa0: c0100260 c010a5f4 02cc10f0 befe2310 00000004 befe230c 00002000 00000000
Oct 26 05:09:28 18087 kernel: [1360505.473386] bfc0: 02cc10f0 befe2310 b2cc84d0 00000003 befe2304 befe22fc 02cc5690 befe4347
Oct 26 05:09:28 18087 kernel: [1360505.481744] bfe0: 00000003 befe22c8 b30c5d17 b304c7e6 a00f0030 00000004 00000000 00000000
Oct 26 05:09:28 18087 kernel: [1360505.490090] Backtrace:
Oct 26 05:09:28 18087 kernel: [1360505.492740] [<c0232d84>] (___bpf_prog_run) from [<c0235b78>] (__bpf_prog_run32+0x4c/0x68)
Oct 26 05:09:28 18087 kernel: [1360505.501102]  r10:c25ebef0 r9:c3a0df80 r8:7fff0000 r7:00000004 r6:f086a000 r5:c3a0df80
Oct 26 05:09:28 18087 kernel: [1360505.509105]  r4:c0f04fc8
Oct 26 05:09:28 18087 kernel: [1360505.511837] [<c0235b2c>] (__bpf_prog_run32) from [<c01fc85c>] (__seccomp_filter+0x9c/0x7b8)
Oct 26 05:09:28 18087 kernel: [1360505.520360]  r4:7fff0000
Oct 26 05:09:28 18087 kernel: [1360505.523090] [<c01fc7c0>] (__seccomp_filter) from [<c01fdad0>] (__secure_computing+0x50/0xac)
Oct 26 05:09:28 18087 kernel: [1360505.531711]  r10:00800000 r9:c25ea000 r8:c01002c4 r7:00000003 r6:b2cc84d0 r5:c25ebfb0
Oct 26 05:09:28 18087 kernel: [1360505.539714]  r4:ffffe000
Oct 26 05:09:28 18087 kernel: [1360505.542443] [<c01fda80>] (__secure_computing) from [<c010a690>] (syscall_trace_enter+0xa8/0x1e8)
Oct 26 05:09:28 18087 kernel: [1360505.551410] [<c010a5e8>] (syscall_trace_enter) from [<c0100260>] (__sys_trace+0xc/0x40)
Oct 26 05:09:28 18087 kernel: [1360505.559588] Exception stack(0xc25ebfa8 to 0xc25ebff0)
Oct 26 05:09:28 18087 kernel: [1360505.564824] bfa0:                   02cc10f0 befe2310 00000004 befe230c 00002000 00000000
Oct 26 05:09:28 18087 kernel: [1360505.573183] bfc0: 02cc10f0 befe2310 b2cc84d0 00000003 befe2304 befe22fc 02cc5690 befe4347
Oct 26 05:09:28 18087 kernel: [1360505.581537] bfe0: 00000003 befe22c8 b30c5d17 b304c7e6
Oct 26 05:09:28 18087 kernel: [1360505.586774]  r8:c01002c4 r7:00000003 r6:b2cc84d0 r5:befe2310 r4:02cc10f0
Oct 26 05:09:28 18087 kernel: [1360505.593660] Code: e593f2e0 e30c013c e34c00c6 eb21f780 (e7f001f2)
Oct 26 05:09:28 18087 kernel: [1360505.599938] ---[ end trace 3d87cb241d68725c ]---
Oct 26 05:09:59 18087 kernel: [1360525.881145] rcu: INFO: rcu_sched detected stalls on CPUs/tasks:
Oct 26 05:09:59 18087 kernel: [1360525.887305] rcu:     1-...0: (0 ticks this GP) idle=d96/1/0x40000000 softirq=4261683/4261683 fqs=2572
Oct 26 05:09:59 18087 kernel: [1360525.896528]  (detected by 0, t=5252 jiffies, g=8388861, q=168)
Oct 26 05:09:59 18087 kernel: [1360525.902547] Sending NMI from CPU 0 to CPUs 1:

KriszK

boot.log:
U-Boot SPL 2021.04+olimex-1-20230515.123927 (May 15 2023 - 12:40:34 +0000)
DRAM: 1024 MiB
CPU: 912000000Hz, AXI/AHB/APB: 3/2/2
Loading configuration from EEPROM: OK

Trying to boot from sunxi SPI


U-Boot 2021.04+olimex-1-20230515.123927 (May 15 2023 - 12:40:34 +0000) Allwinner Technology

CPU:   Allwinner A20 (SUN7I)
ID:    T2-OLinuXino-LIME2-e8Gs16M-IND Rev.L
SN:    000137A4
MAC:   30:1F:9A:D0:9B:A1
I2C:   ready
DRAM:  1 GiB
SF: Detected w25q128 with page size 256 Bytes, erase size 4 KiB, total 16 MiB
MMC:   mmc@1c0f000: 0, mmc@1c11000: 1
Loading Environment from EXT4...
** Unable to use mmc 1:auto for loading the env **
Loading Environment from FAT... ** No device specified **
In:    serial
Out:   serial
Err:   serial
Allwinner mUSB OTG (Peripheral)
Net:   eth0: ethernet@1c50000, eth1: usb_ether
starting USB...

Bus usb@1c14400: USB OHCI 1.0
Bus usb@1c1c000: USB EHCI 1.00
Bus usb@1c1c400: USB OHCI 1.0
scanning bus usb@1c14000 for devices... 1 USB Device(s) found
scanning bus usb@1c14400 for devices... 1 USB Device(s) found
scanning bus usb@1c1c000 for devices... 1 USB Device(s) found
scanning bus usb@1c1c400 for devices... 1 USB Device(s) found
       scanning usb for storage devices... 0 Storage Device(s) found
Hit any key to stop autoboot:  0
switch to partitions #0, OK
mmc1(part 0) is current device
** No partition table - mmc 1 **
Card did not respond to voltage select! : -110
scanning bus for devices...
Target spinup took 0 ms.
AHCI 0001.0100 32 slots 1 ports 3 Gbps 0x1 impl SATA mode
flags: ncq stag pm led clo only pmp pio slum part ccc apst
  Device 0: (0:0) Vendor: ATA Prod.: KINGSTON SA400S3 Rev: 0309
            Type: Hard Disk
            Capacity: 228936.5 MB = 223.5 GB (468862128 x 512)
timeout exit!
            Type: Hard Disk
            Capacity: 228936.5 MB = 223.5 GB (468862128 x 512)
... is now current device
Scanning scsi 0:1...
Found U-Boot script /boot/boot.scr
2274 bytes read in 7 ms (316.4 KiB/s)
## Executing script at 43100000
Boot script loaded from scsi
Checking for /uEnv.txt...
Checking for /boot/uEnv.txt...
1156 bytes read in 7 ms (161.1 KiB/s)
Loaded environment from /boot/uEnv.txt
Loading FIT image...
16233071 bytes read in 259 ms (59.8 MiB/s)
## Loading kernel from FIT Image at 58000000 ...
   Using 'config-9243' configuration
   Trying 'kernel-1' kernel subimage
     Description:  Linux kernel 5.10.180-olimex
     Type:         Kernel Image
     Compression:  uncompressed
     Data Start:   0x580000d4
     Data Size:    6571752 Bytes = 6.3 MiB
     OS:           Linux
     Load Address: 0x40080000
     Entry Point:  0x40080000
     Hash algo:    crc32
     Hash value:   ab9ddc5e
     Hash algo:    sha1
     Hash value:   987115694f4ebc9b887060eecd13d520820f53c4
   Verifying Hash Integrity ... crc32+ sha1+ OK
## Loading ramdisk from FIT Image at 58000000 ...
   Using 'config-9243' configuration
   Trying 'ramdisk-1' ramdisk subimage
     Description:  Ramdisk for kernel 5.10.180-olimex
     Type:         RAMDisk Image
     Compression:  Unknown Compression
     Data Start:   0x586448f0
     Data Size:    9205098 Bytes = 8.8 MiB
     Architecture: ARM
     OS:           Linux
     Load Address: 0x4fe00000
     Entry Point:  0x4fe00000
     Hash algo:    crc32
     Hash value:   16dc6c13
     Hash value:   55c2de970a4d25f7de75e1d2b2adc458e9cee983
   Verifying Hash Integrity ... crc32+ sha1+ OK
   Loading ramdisk from 0x586448f0 to 0x4fe00000
WARNING: 'compression' nodes for ramdisks are deprecated, please fix your .its file!
## Loading fdt from FIT Image at 58000000 ...
   Using 'config-9243' configuration
   Trying 'fdt-4' fdt subimage
     Description:  unavailable
     Type:         Flat Device Tree
     Compression:  uncompressed
     Data Start:   0x58f2bc14
     Data Size:    43643 Bytes = 42.6 KiB
     Architecture: ARM
     Load Address: 0x4fa00000
     Hash algo:    crc32
     Hash value:   36a64574
     Hash algo:    sha1
     Hash value:   16c904b58520be6ecf47b5482c59376f4aba068f
   Verifying Hash Integrity ... crc32+ sha1+ OK
   Loading fdt from 0x58f2bc14 to 0x4fa00000
## Loading fdt from FIT Image at 58000000 ...
   Trying 'overlay-1' fdt subimage
     Type:         Flat Device Tree
     Compression:  uncompressed
     Data Start:   0x58f77660
     Data Size:    1001 Bytes = 1001 Bytes
     Architecture: ARM
     Load Address: 0x4fa10000
     Hash algo:    crc32
     Hash value:   d1d51f29
     Hash algo:    sha1
     Hash value:   fa0c14efb55dbe4bdf8aa7241a3e600b486e3ef6
   Verifying Hash Integrity ... crc32+ sha1+ OK
   Loading fdt from 0x58f77660 to 0x4fa10000
## Loading fdt from FIT Image at 58000000 ...
   Trying 'overlay-2' fdt subimage
     Description:  unavailable
     Type:         Flat Device Tree
     Compression:  uncompressed
     Data Start:   0x58f77b2c
     Data Size:    436 Bytes = 436 Bytes
     Architecture: ARM
     Load Address: 0x4fa20000
     Hash algo:    crc32
     Hash algo:    sha1
     Hash value:   efa518e1ffcc7c09a7d8010de6a7b363f1345b30
   Verifying Hash Integrity ... crc32+ sha1+ OK
   Loading fdt from 0x58f77b2c to 0x4fa20000
   Booting using the fdt blob at 0x4fa00000
EHCI failed to shut down host controller.
   Loading Kernel Image
   Loading Ramdisk to 49738000, end 49fff56a ... OK
   Loading Device Tree to 4972a000, end 49737c59 ... OK
Applying overlay: '/usr/lib/olinuxino-overlays/sun7i-a20/spi1-spidev.dtbo'...
408 bytes read in 19 ms (20.5 KiB/s)
Applying overlay: '/usr/lib/olinuxino-overlays/sun7i-a20/spi2-spidev.dtbo'...
408 bytes read in 21 ms (18.6 KiB/s)
Applying overlay: '/usr/lib/olinuxino-overlays/sun7i-a20/sun7i-a20-i2c2.dtbo'...
726 bytes read in 22 ms (32.2 KiB/s)
Applying overlay: '/usr/lib/olinuxino-overlays/sun7i-a20/sun7i-a20-spi0.dtbo'...
1001 bytes read in 30 ms (32.2 KiB/s)
Applying overlay: '/usr/lib/olinuxino-overlays/sun7i-a20/sun7i-a20-spi1.dtbo'...
1005 bytes read in 21 ms (45.9 KiB/s)
Applying overlay: '/usr/lib/olinuxino-overlays/sun7i-a20/sun7i-a20-spi2.dtbo'...
1005 bytes read in 21 ms (45.9 KiB/s)
Applying overlay: '/usr/lib/olinuxino-overlays/sun7i-a20/sun7i-a20-uart3.dtbo'...
Applying overlay: '/usr/lib/olinuxino-overlays/sun7i-a20/sun7i-a20-uart4.dtbo'...
867 bytes read in 21 ms (40 KiB/s)
Applying overlay: '/usr/lib/olinuxino-overlays/sun7i-a20/sun7i-a20-uart5.dtbo'...
867 bytes read in 21 ms (40 KiB/s)
Applying overlay: '/usr/lib/olinuxino-overlays/sun7i-a20/sun7i-a20-uart6.dtbo'...
867 bytes read in 22 ms (38.1 KiB/s)
Applying overlay: '/usr/lib/olinuxino-overlays/sun7i-a20/sun7i-a20-uart7.dtbo'...
867 bytes read in 22 ms (38.1 KiB/s)
Applying overlay: '/usr/lib/olinuxino-overlays/sun7i-a20/sun7i-a20-can.dtbo'...
732 bytes read in 21 ms (33.2 KiB/s)
Applying overlay: '/usr/lib/olinuxino-overlays/sun7i-a20/lime2-lcd-olinuxino.dtbo'...
2225 bytes read in 17 ms (127 KiB/s)

Starting kernel ...

[    0.005833] /cpus/cpu@0 missing clock-frequency property
[    0.005878] /cpus/cpu@1 missing clock-frequency property
[    1.027202] sun4i-usb-phy 1c13400.phy: Couldn't request ID GPIO
Loading, please wait...
Starting version 247.3-7+deb11u4
Begin: Loading essential drivers ... done.
Begin: Running /scripts/init-premount ... done.
Begin: Running /scripts/local-premount ... done.
Begin: Will now check root file system ... fsck from util-linux 2.36.1
[/sbin/fsck.ext4 (1) -- /dev/sda1] fsck.ext4 -a -C0 /dev/sda1
/dev/sda1: recovering journal
/dev/sda1: Clearing orphaned inode 10485764 (uid=0, gid=0, mode=0100600, size=0)
/dev/sda1: Clearing orphaned inode 13107388 (uid=0, gid=0, mode=0100644, size=387384)
/dev/sda1: clean, 41741/14655488 files, 4228145/58607510 blocks
done.
done.
Begin: Running /scripts/local-bottom ... done.
Begin: Running /scripts/init-bottom ... done.

Welcome to Debian GNU/Linux 11 (bullseye)!

[  OK  ] Created slice system-getty.slice.
[  OK  ] Created slice system-modprobe.slice.
[  OK  ] Created slice system-serial\x2dgetty.slice.
[  OK  ] Created slice User and Session Slice.
[  OK  ] Started Dispatch Password ...ts to Console Directory Watch.
[  OK  ] Started Forward Password R...uests to Wall Directory Watch.
[  OK  ] Set up automount Arbitrary...s File System Automount Point.
[  OK  ] Reached target Local Encrypted Volumes.
[  OK  ] Reached target Remote File Systems.
[  OK  ] Reached target Slices.
[  OK  ] Reached target Swap.
[  OK  ] Listening on Syslog Socket.
[  OK  ] Listening on fsck to fsckd communication Socket.
[  OK  ] Listening on initctl Compatibility Named Pipe.
[  OK  ] Listening on Journal Audit Socket.
[  OK  ] Listening on Journal Socket (/dev/log).
[  OK  ] Listening on Journal Socket.
[  OK  ] Listening on udev Control Socket.
[  OK  ] Listening on udev Kernel Socket.
         Mounting POSIX Message Queue File System...
         Mounting Kernel Debug File System...
         Mounting Kernel Trace File System...
         Starting Restore / save the current clock...
         Starting Set the console keyboard layout...
         Starting Create list of st...odes for the current kernel...
         Starting Load Kernel Module configfs...
         Starting Load Kernel Module drm...
         Starting Load Kernel Module fuse...
[  OK  ] Started Nameserver information manager.
[  OK  ] Reached target Network (Pre).
         Starting Load Kernel Modules...
         Starting Remount Root and Kernel File Systems...
         Starting Coldplug All udev Devices...
[  OK  ] Mounted POSIX Message Queue File System.
[  OK  ] Mounted Kernel Debug File System.
[  OK  ] Mounted Kernel Trace File System.
[  OK  ] Finished Restore / save the current clock.
[  OK  ] Finished Create list of st... nodes for the current kernel.
[  OK  ] Finished Load Kernel Module configfs.
[  OK  ] Finished Load Kernel Module drm.
[  OK  ] Finished Load Kernel Module fuse.
[  OK  ] Finished Load Kernel Modules.
[  OK  ] Finished Remount Root and Kernel File Systems.
         Mounting FUSE Control File System...
         Mounting Kernel Configuration File System...
         Starting Load/Save Random Seed...
         Starting Apply Kernel Variables...
         Starting Create System Users...
[  OK  ] Mounted FUSE Control File System.
[  OK  ] Mounted Kernel Configuration File System.
[  OK  ] Finished Apply Kernel Variables.
[  OK  ] Finished Create System Users.
[  OK  ] Finished Set the console keyboard layout.
[  OK  ] Finished Create Static Device Nodes in /dev.
[  OK  ] Started Journal Service.
[  OK  ] Reached target Local File Systems (Pre).
[  OK  ] Reached target Local File Systems.
         Starting Set console font and keymap...
         Starting Flush Journal to Persistent Storage...
         Starting Rule-based Manage...for Device Events and Files...
[  OK  ] Finished Set console font and keymap.
[  OK  ] Finished Load/Save Random Seed.
[  OK  ] Finished Flush Journal to Persistent Storage.
         Starting Create Volatile Files and Directories...
[  OK  ] Finished Create Volatile Files and Directories.
         Starting Update UTMP about System Boot/Shutdown...
[  OK  ] Finished Update UTMP about System Boot/Shutdown.
[  OK  ] Started Rule-based Manager for Device Events and Files.
[  OK  ] Found device /dev/ttyGS0.
[  OK  ] Finished Coldplug All udev Devices.
         Starting Helper to synchronize boot up for ifupdown...
         Starting Wait for udev To ...plete Device Initialization...
[  OK  ] Created slice system-systemd\x2dbacklight.slice.
         Starting Load/Save Screen ...ness of backlight:backlight...
[  OK  ] Finished Load/Save Screen ...htness of backlight:backlight.
[   18.650521] debugfs: Directory '1c22c00.codec' with parent 'sun4i-codec' already present!
[   18.994161] lcd_olinuxino 2-0050: error reading from device at 00
[  OK  ] Found device /dev/ttyS0.
[*     ] (1 of 2) A start job is running for...vice Initialization (7s / 3min 3s)
[**    ] (1 of 2) A start job is running for...vice Initialization (7s / 3min 3s)
[***   ] (1 of 2) A start job is running for...vice Initialization (7s / 3min 3s)
[  OK  ] Finished Helper to synchronize boot up for ifupdown.
[  OK  ] Finished Wait for udev To Complete Device Initialization.
         Starting Raise network interfaces...
[  OK  ] Reached target System Initialization.
[  OK  ] Started Daily apt download activities.
[  OK  ] Started Daily apt upgrade and clean activities.
[  OK  ] Started Periodic ext4 Onli...ata Check for All Filesystems.
[  OK  ] Started Discard unused blocks once a week.
[  OK  ] Started Daily rotation of log files.
[  OK  ] Started Daily man-db regeneration.
[  OK  ] Started Run system activit...ounting tool every 10 minutes.
[  OK  ] Started Generate summary o...esterday's process accounting.
[  OK  ] Started Daily Cleanup of Temporary Directories.
[  OK  ] Reached target Timers.
[  OK  ] Listening on D-Bus System Message Bus Socket.
[  OK  ] Reached target Basic System.
         Starting Save/Restore Sound Card State...
[  OK  ] Started Regular background program processing daemon.
[  OK  ] Started D-Bus System Message Bus.
         Starting Network Manager...
         Starting Remove Stale Onli...t4 Metadata Check Snapshots...
         Starting Initialize hardware monitoring sensors...
         Starting LSB: Load kernel ...d to enable cpufreq scaling...
[  OK  ] Started MiniDLNA lightweight DLNA/UPnP-AV server.
[  OK  ] Started Realtek H5 bluetooth support.
         Starting LCD-OLinuXino RTP calibrabion...
         Starting Authorization Manager...
         Starting System Logging Service...
         Starting Resets System Activity Logs...
         Starting User Login Management...
         Starting WPA supplicant...
[  OK  ] Started System Logging Service.
[  OK  ] Finished Save/Restore Sound Card State.
[  OK  ] Finished Resets System Activity Logs.
[  OK  ] Finished Initialize hardware monitoring sensors.
[  OK  ] Started Authorization Manager.
[  OK  ] Started WPA supplicant.
[  OK  ] Reached target Sound Card.
         Starting Modem Manager...
         Starting Hostname Service...
[  OK  ] Finished LCD-OLinuXino RTP calibrabion.
[  OK  ] Started User Login Management.
[  OK  ] Started LSB: Load kernel m...ded to enable cpufreq scaling.
         Starting LSB: set CPUFreq kernel parameters...
[  OK  ] Started Modem Manager.
[  OK  ] Started Hostname Service.
[  OK  ] Started LSB: set CPUFreq kernel parameters.
[  OK  ] Listening on Load/Save RF ...itch Status /dev/rfkill Watch.
         Starting LSB: Set sysfs variables from /etc/sysfs.conf...
         Starting Network Manager Script Dispatcher Service...
[  OK  ] Started LSB: Set sysfs variables from /etc/sysfs.conf.
[  OK  ] Started Network Manager Script Dispatcher Service.
[  OK  ] Finished Raise network interfaces.
[  OK  ] Reached target Network.
         Starting Fail2Ban Service...
         Starting A high performanc... and a reverse proxy server...
         Starting Network Time Service...
         Starting Network UPS Tools...er device driver controller...
         Starting OpenBSD Secure Shell server...
[  OK  ] Finished Remove Stale Onli...ext4 Metadata Check Snapshots.
[  OK  ] Started Fail2Ban Service.
[  OK  ] Finished Permit User Sessions.
[  OK  ] Created slice User Slice of UID 1001.
[  OK  ] Started Getty on tty1.
[  OK  ] Started Serial Getty on ttyGS0.
[  OK  ] Started Serial Getty on ttyS0.
[  OK  ] Reached target Login Prompts.
         Starting User Runtime Directory /run/user/1001...
[  OK  ] Started Network Time Service.
[  OK  ] Started Network UPS Tools ...ower device driver controller.
[  OK  ] Started A high performance...er and a reverse proxy server.
[  OK  ] Finished User Runtime Directory /run/user/1001.
         Starting Network UPS Tools... devices information server...
         Starting User Manager for UID 1001...
[  OK  ] Started OpenBSD Secure Shell server.
[  OK  ] Started Network UPS Tools ...er devices information server.
[  OK  ] Reached target Multi-User System.
[  OK  ] Reached target Graphical Interface.
         Starting Update UTMP about System Runlevel Changes...
[  OK  ] Finished Update UTMP about System Runlevel Changes.
[  OK  ] Created slice User Slice of UID 1001.
[  OK  ] Started LSB: set CPUF.
[  OK  ] Listening on Load/Save RF ...itch Status /dev/rfkill Watch.
         Starting LSB: Set sysfs variables from /etc/sysfs.conf...
       ] Reached target Login Prompts.
[  OK  ] Started LSB: Set sysfs variables from /etc/sysfs.conf
[  OK  ] Started Network Manager Script Dispatcher Service.
[  OK  ] Finished Raise network interfaces.
[  OK  ] Reached target Networkance...er and a reverse proxy server.
         Starting Fail2Ban Service...
         Starting A high performanc... and a reverse proxy server...
         Starting User Manager for UID 1001...
         Starting Network UPS Tools...er device driver controlle
         Starting OpenBSD Secure Shell server...
         Starting Permit User Sessions...
[  OK  ] Finished Remove Stphical Interface.
[  OK  ] Started Fail2Ban Service.
[  OK  ] Finished Permit User Sessions.


KriszK

/var/log/messages:
Oct 22 00:10:07 18087 rsyslogd: [origin software="rsyslogd" swVersion="8.2102.0" x-pid="350" x-info="https://www.rsyslog.com"] rsyslogd was HUPed
Oct 26 05:09:28 18087 kernel: [1360505.178265] BPF interpreter: unknown opcode 20
Oct 26 05:09:28 18087 kernel: [1360505.178315] ------------[ cut here ]------------
Oct 26 05:09:28 18087 kernel: [1360505.193333] Modules linked in: ipt_REJECT nf_reject_ipv4 xt_multiport rfkill xt_recent nft_limit xt_limit xt_tcpudp xt_state xt_conntrack nft_compat nft_counter nf_conntrack_ftp nf_conntrack nf_defrag_i
pv6 nf_defrag_ipv4 nf_tables nfnetlink evdev axp20x_ac_power axp20x_battery axp20x_adc industrialio at24 panel_olimex_lcd_olinuxino lima sun4i_can gpu_sched can_dev sun4i_codec sun4i_ss libdes sun4i_drm_hdmi sunxi_cedrus(C) v4l2_mem2mem
videobuf2_dma_contig videobuf2_memops videobuf2_v4l2 videobuf2_common videodev mc uio_pdrv_genirq uio cpufreq_dt sun4i_ts hwmon usb_f_acm u_serial g_serial libcomposite fuse ip_tables x_tables pinctrl_axp209 pwm_sun4i spidev pwm_bl
Oct 26 05:09:28 18087 kernel: [1360505.252514] CPU: 0 PID: 22150 Comm: sshd Tainted: G         C        5.10.180-olimex #092646
Oct 26 05:09:28 18087 kernel: [1360505.261122] Hardware name: Allwinner sun7i (A20) Family
Oct 26 05:09:28 18087 kernel: [1360505.266546] PC is at ___bpf_prog_run+0x1f18/0x1f1c
Oct 26 05:09:28 18087 kernel: [1360505.271520] LR is at __irq_work_queue_local+0x40/0x74
Oct 26 05:09:28 18087 kernel: [1360505.276749] pc : [<c0234c9c>]    lr : [<c022fe1c>]    psr: 600f0013
Oct 26 05:09:28 18087 kernel: [1360505.283191] sp : c25ebdb0  ip : c25ebcc0  fp : c25ebe14
Oct 26 05:09:28 18087 kernel: [1360505.288592] r10: 00000000  r9 : c3a0df80  r8 : 7fff0000
Oct 26 05:09:28 18087 kernel: [1360505.293995] r7 : c0230674  r6 : c0b11ae8  r5 : c25ebe38  r4 : f086a248
Oct 26 05:09:28 18087 kernel: [1360505.300698] r3 : 43246c48  r2 : 43246c48  r1 : ef683414  r0 : 00000022
Oct 26 05:09:28 18087 kernel: [1360505.307404] Flags: nZCv  IRQs on  FIQs on  Mode SVC_32  ISA ARM  Segment none
Oct 26 05:09:28 18087 kernel: [1360505.314716] Control: 10c5387d  Table: 4548006a  DAC: 00000051
Oct 26 05:09:28 18087 kernel: [1360505.599938] ---[ end trace 3d87cb241d68725c ]---
Oct 26 05:09:59 18087 kernel: [1360525.896528]     (detected by 0, t=5252 jiffies, g=8388861, q=168)
Oct 26 05:09:59 18087 kernel: [1360525.902547] Sending NMI from CPU 0 to CPUs 1:
Oct 26 04:17:11 18087 kernel: [    0.000000] Booting Linux on physical CPU 0x0
Oct 26 04:17:11 18087 kernel: [    0.000000] Linux version 5.10.180-olimex (root@runner-cpbkaozn-project-1-concurrent-0) (arm-linux-gnueabihf-gcc (Debian 8.3.0-2) 8.3.0, GNU ld (GNU Binutils for Debian) 2.31.1) #092646 SMP Tue Jul 25 09:
28:23 UTC 2023
Oct 26 04:17:11 18087 kernel: [    0.000000] CPU: ARMv7 Processor [410fc074] revision 4 (ARMv7), cr=10c5387d
Oct 26 04:17:11 18087 kernel: [    0.000000] CPU: div instructions available: patching division code
Oct 26 04:17:11 18087 kernel: [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
Oct 26 04:17:11 18087 kernel: [    0.000000] OF: fdt: Machine model: Olimex A20-OLinuXino-LIME2-eMMC
Oct 26 04:17:11 18087 kernel: [    0.000000] Memory policy: Data cache writealloc
Oct 26 04:17:11 18087 kernel: [    0.000000] Reserved memory: created CMA memory pool at 0x4a000000, size 96 MiB
Oct 26 04:17:11 18087 kernel: [    0.000000] OF: reserved mem: initialized node default-pool, compatible id shared-dma-pool
Oct 26 04:17:11 18087 kernel: [    0.000000] Zone ranges:
Oct 26 04:17:11 18087 kernel: [    0.000000]   Normal   [mem 0x0000000040000000-0x000000006fffffff]
Oct 26 04:17:11 18087 kernel: [    0.000000]   HighMem  [mem 0x0000000070000000-0x000000007fffffff]
Oct 26 04:17:11 18087 kernel: [    0.000000] Movable zone start for each node
Oct 26 04:17:11 18087 kernel: [    0.000000] Early memory node ranges
Oct 26 04:17:11 18087 kernel: [    0.000000]   node   0: [mem 0x0000000040000000-0x000000007fffffff]
Oct 26 04:17:11 18087 kernel: [    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]
Oct 26 04:17:11 18087 kernel: [    0.000000] psci: probing for conduit method from DT.
Oct 26 04:17:11 18087 kernel: [    0.000000] psci: Using PSCI v0.1 Function IDs from DT
Oct 26 04:17:11 18087 kernel: [    0.000000] percpu: Embedded 20 pages/cpu s50636 r8192 d23092 u81920
Oct 26 04:17:11 18087 kernel: [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 260416
Oct 26 04:17:11 18087 kernel: [    0.000000] Kernel command line: root=PARTUUID=8c578e38-01 rootwait console=ttyS0,115200 panic=10 loglevel=4
Oct 26 04:17:11 18087 kernel: [    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
Oct 26 04:17:11 18087 kernel: [    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
Oct 26 04:17:11 18087 kernel: [    0.000000] allocated 1048576 bytes of page_ext
Oct 26 04:17:11 18087 kernel: [    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
Oct 26 04:17:11 18087 kernel: [    0.000000] Memory: 913868K/1048576K available (10240K kernel code, 1215K rwdata, 2428K rodata, 1024K init, 290K bss, 36404K reserved, 98304K cma-reserved, 262144K highmem)
Oct 26 04:17:11 18087 kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
Oct 26 04:17:11 18087 kernel: [    0.000000] ftrace: allocating 35965 entries in 106 pages
Oct 26 04:17:11 18087 kernel: [    0.000000] ftrace: allocated 106 pages with 4 groups
Oct 26 04:17:11 18087 kernel: [    0.000000] rcu: Hierarchical RCU implementation.
Oct 26 04:17:11 18087 kernel: [    0.000000] rcu:     RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=2.
Oct 26 04:17:11 18087 kernel: [    0.000000]     Rude variant of Tasks RCU enabled.
Oct 26 04:17:11 18087 kernel: [    0.000000]     Tracing variant of Tasks RCU enabled.
Oct 26 04:17:11 18087 kernel: [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
Oct 26 04:17:11 18087 kernel: [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
Oct 26 04:17:11 18087 kernel: [    0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
Oct 26 04:17:11 18087 kernel: [    0.000000] GIC: Using split EOI/Deactivate mode
Oct 26 04:17:11 18087 kernel: [    0.000000] arch_timer: cp15 timer(s) running at 24.00MHz (phys).
Oct 26 04:17:11 18087 kernel: [    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x588fe9dc0, max_idle_ns: 440795202592 ns
Oct 26 04:17:11 18087 kernel: [    0.000010] sched_clock: 56 bits at 24MHz, resolution 41ns, wraps every 4398046511097ns
Oct 26 04:17:11 18087 kernel: [    0.000025] Switching to timer-based delay loop, resolution 41ns
Oct 26 04:17:11 18087 kernel: [    0.000673] clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 79635851949 ns
Oct 26 04:17:11 18087 kernel: [    0.001085] clocksource: hstimer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 6370868154 ns
Oct 26 04:17:11 18087 kernel: [    0.001593] Console: colour dummy device 80x30
Oct 26 04:17:11 18087 kernel: [    0.001677] Calibrating delay loop (skipped), value calculated using timer frequency.. 48.00 BogoMIPS (lpj=96000)
Oct 26 04:17:11 18087 kernel: [    0.001701] pid_max: default: 32768 minimum: 301
Oct 26 04:17:11 18087 kernel: [    0.002500] LSM: Security Framework initializing
Oct 26 04:17:11 18087 kernel: [    0.002878] AppArmor: AppArmor initialized
Oct 26 04:17:11 18087 kernel: [    0.003140] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Oct 26 04:17:11 18087 kernel: [    0.003161] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Oct 26 04:17:11 18087 kernel: [    0.005137] CPU: Testing write buffer coherency: ok
Oct 26 04:17:11 18087 kernel: [    0.005895] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
Oct 26 04:17:11 18087 kernel: [    0.007206] Setting up static identity map for 0x40100000 - 0x40100060
Oct 26 04:17:11 18087 kernel: [    0.007464] rcu: Hierarchical SRCU implementation.
Oct 26 04:17:11 18087 kernel: [    0.008637] smp: Bringing up secondary CPUs ...
Oct 26 04:17:11 18087 kernel: [    0.019899] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
Oct 26 04:17:11 18087 kernel: [    0.020131] smp: Brought up 1 node, 2 CPUs
Oct 26 04:17:11 18087 kernel: [    0.020150] SMP: Total of 2 processors activated (96.00 BogoMIPS).
Oct 26 04:17:11 18087 kernel: [    0.020157] CPU: All CPU(s) started in HYP mode.
Oct 26 04:17:11 18087 kernel: [    0.020163] CPU: Virtualization extensions available.
Oct 26 04:17:11 18087 kernel: [    0.021665] devtmpfs: initialized
Oct 26 04:17:11 18087 kernel: [    0.035519] VFP support v0.3: implementor 41 architecture 2 part 30 variant 7 rev 4
Oct 26 04:17:11 18087 kernel: [    0.036052] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
Oct 26 04:17:11 18087 kernel: [    0.036089] futex hash table entries: 512 (order: 3, 32768 bytes, linear)
Oct 26 04:17:11 18087 kernel: [    0.040825] pinctrl core: initialized pinctrl subsystem
Oct 26 04:17:11 18087 kernel: [    0.043263] NET: Registered protocol family 16
Oct 26 04:17:11 18087 kernel: [    0.045357] DMA: preallocated 256 KiB pool for atomic coherent allocations
Oct 26 04:17:11 18087 kernel: [    0.046329] audit: initializing netlink subsys (disabled)
Oct 26 04:17:11 18087 kernel: [    0.046899] audit: type=2000 audit(0.036:1): state=initialized audit_enabled=0 res=1
Oct 26 04:17:11 18087 kernel: [    0.047760] thermal_sys: Registered thermal governor 'fair_share'
Oct 26 04:17:11 18087 kernel: [    0.047774] thermal_sys: Registered thermal governor 'bang_bang'
Oct 26 04:17:11 18087 kernel: [    0.047782] thermal_sys: Registered thermal governor 'step_wise'
Oct 26 04:17:11 18087 kernel: [    0.048291] cpuidle: using governor ladder
Oct 26 04:17:11 18087 kernel: [    0.048335] cpuidle: using governor menu
Oct 26 04:17:11 18087 kernel: [    0.048675] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
Oct 26 04:17:11 18087 kernel: [    0.048687] hw-breakpoint: maximum watchpoint size is 8 bytes.
Oct 26 04:17:11 18087 kernel: [    0.100548] iommu: Default domain type: Translated
Oct 26 04:17:11 18087 kernel: [    0.101257] SCSI subsystem initialized
Oct 26 04:17:11 18087 kernel: [    0.102045] usbcore: registered new interface driver usbfs
Oct 26 04:17:11 18087 kernel: [    0.102157] usbcore: registered new interface driver hub
Oct 26 04:17:11 18087 kernel: [    0.102249] usbcore: registered new device driver usb
Oct 26 04:17:11 18087 kernel: [    0.102752] pps_core: LinuxPPS API ver. 1 registered
Oct 26 04:17:11 18087 kernel: [    0.102764] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
Oct 26 04:17:11 18087 kernel: [    0.102791] PTP clock support registered
Oct 26 04:17:11 18087 kernel: [    0.103850] Advanced Linux Sound Architecture Driver Initialized.
Oct 26 04:17:11 18087 kernel: [    0.105931] clocksource: Switched to clocksource arch_sys_counter
Oct 26 04:17:11 18087 kernel: [    0.183705] VFS: Disk quotas dquot_6.6.0
Oct 26 04:17:11 18087 kernel: [    0.183874] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Oct 26 04:17:11 18087 kernel: [    0.184810] AppArmor: AppArmor Filesystem Enabled
Oct 26 04:17:11 18087 kernel: [    0.197885] NET: Registered protocol family 2
Oct 26 04:17:11 18087 kernel: [    0.198347] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
Oct 26 04:17:11 18087 kernel: [    0.200214] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear)
Oct 26 04:17:11 18087 kernel: [    0.200343] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
Oct 26 04:17:11 18087 kernel: [    0.200432] TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
Oct 26 04:17:11 18087 kernel: [    0.200560] TCP: Hash tables configured (established 8192 bind 8192)
Oct 26 04:17:11 18087 kernel: [    0.200759] UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
Oct 26 04:17:11 18087 kernel: [    0.200872] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
Oct 26 04:17:11 18087 kernel: [    0.201277] NET: Registered protocol family 1
Oct 26 04:17:11 18087 kernel: [    0.202245] Trying to unpack rootfs image as initramfs...
Oct 26 04:17:11 18087 kernel: [    0.890470] Freeing initrd memory: 8992K
Oct 26 04:17:11 18087 kernel: [    0.891021] hw perfevents: no interrupt-affinity property for /pmu, guessing.
Oct 26 04:17:11 18087 kernel: [    0.891485] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 5 counters available
Oct 26 04:17:11 18087 kernel: [    0.893472] Initialise system trusted keyrings
Oct 26 04:17:11 18087 kernel: [    0.894176] workingset: timestamp_bits=14 max_order=18 bucket_order=4
Oct 26 04:17:11 18087 kernel: [    0.902066] zbud: loaded
Oct 26 04:17:11 18087 kernel: [    1.023995] Key type asymmetric registered
Oct 26 04:17:11 18087 kernel: [    1.024020] Asymmetric key parser 'x509' registered
Oct 26 04:17:11 18087 kernel: [    1.024164] bounce: pool size: 64 pages
Oct 26 04:17:11 18087 kernel: [    1.024284] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)
Oct 26 04:17:11 18087 kernel: [    1.024604] io scheduler mq-deadline registered
Oct 26 04:17:11 18087 kernel: [    1.024617] io scheduler kyber registered
Oct 26 04:17:11 18087 kernel: [    1.025102] io scheduler bfq registered
Oct 26 04:17:11 18087 kernel: [    1.032176] sun4i-pinctrl 1c20800.pinctrl: initialized sunXi PIO driver
Oct 26 04:17:11 18087 kernel: [    1.124856] Serial: 8250/16550 driver, 8 ports, IRQ sharing disabled
Oct 26 04:17:11 18087 kernel: [    1.128167] sun4i-pinctrl 1c20800.pinctrl: supply vcc-pb not found, using dummy regulator
Oct 26 04:17:11 18087 kernel: [    1.129470] printk: console [ttyS0] disabled
Oct 26 04:17:11 18087 kernel: [    1.129606] 1c28000.serial: ttyS0 at MMIO 0x1c28000 (irq = 59, base_baud = 1500000) is a 16550A
Oct 26 04:17:11 18087 kernel: [    1.146455] printk: console [ttyS0] enabled
Oct 26 04:17:11 18087 kernel: [    1.147431] sun4i-pinctrl 1c20800.pinctrl: supply vcc-pg not found, using dummy regulator
Oct 26 04:17:11 18087 kernel: [    1.149063] 1c28c00.serial: ttyS1 at MMIO 0x1c28c00 (irq = 60, base_baud = 1500000) is a 16550A
Oct 26 04:17:11 18087 kernel: [    1.151160] 1c29000.serial: ttyS2 at MMIO 0x1c29000 (irq = 61, base_baud = 1500000) is a 16550A
Oct 26 04:17:11 18087 rsyslogd: imuxsock: Acquired UNIX socket '/run/systemd/journal/syslog' (fd 3) from systemd.  [v8.2102.0]
Oct 26 04:17:11 18087 rsyslogd: [origin software="rsyslogd" swVersion="8.2102.0" x-pid="361" x-info="https://www.rsyslog.com"] start
Oct 26 04:17:11 18087 kernel: [    1.152153] sun4i-pinctrl 1c20800.pinctrl: supply vcc-pi not found, using dummy regulator
Oct 26 04:17:11 18087 kernel: [    1.153436] 1c29400.serial: ttyS3 at MMIO 0x1c29400 (irq = 62, base_baud = 1500000) is a 16550A
Oct 26 04:17:11 18087 kernel: [    1.155478] 1c29800.serial: ttyS4 at MMIO 0x1c29800 (irq = 63, base_baud = 1500000) is a 16550A
Oct 26 04:17:11 18087 kernel: [    1.157223] 1c29c00.serial: ttyS5 at MMIO 0x1c29c00 (irq = 64, base_baud = 1500000) is a 16550A
Oct 26 04:17:11 18087 kernel: [    1.158787] STM32 USART driver initialized
Oct 26 04:17:11 18087 kernel: [    1.171269] brd: module loaded
Oct 26 04:17:11 18087 kernel: [    1.301986] loop: module loaded
Oct 26 04:17:11 18087 kernel: [    1.303669] ahci-sunxi 1c18000.sata: supply ahci not found, using dummy regulator
Oct 26 04:17:11 18087 kernel: [    1.304036] ahci-sunxi 1c18000.sata: supply phy not found, using dummy regulator
Oct 26 04:17:11 18087 kernel: [    1.307459] spi-nor spi0.0: w25q128 (16384 Kbytes)
Oct 26 04:17:11 18087 kernel: [    1.315750] sun7i-dwmac 1c50000.ethernet: IRQ eth_wake_irq not found
Oct 26 04:17:11 18087 kernel: [    1.315774] sun7i-dwmac 1c50000.ethernet: IRQ eth_lpi not found
Oct 26 04:17:11 18087 kernel: [    1.315984] sun7i-dwmac 1c50000.ethernet: PTP uses main clock
Oct 26 04:17:11 18087 kernel: [    1.316000] sun7i-dwmac 1c50000.ethernet: no reset control found
Oct 26 04:17:11 18087 kernel: [    1.316045] sun7i-dwmac 1c50000.ethernet: no regulator found
Oct 26 04:17:11 18087 kernel: [    1.316527] sun7i-dwmac 1c50000.ethernet: Version ID not available
Oct 26 04:17:11 18087 kernel: [    1.316556] sun7i-dwmac 1c50000.ethernet:     DWMAC1000
Oct 26 04:17:11 18087 kernel: [    1.316569] sun7i-dwmac 1c50000.ethernet: No HW DMA feature register supported
Oct 26 04:17:11 18087 kernel: [    1.316580] sun7i-dwmac 1c50000.ethernet: TX Checksum insertion supported
Oct 26 04:17:11 18087 kernel: [    1.316590] sun7i-dwmac 1c50000.ethernet: Normal descriptors
Oct 26 04:17:11 18087 kernel: [    1.316600] sun7i-dwmac 1c50000.ethernet: Ring mode enabled
Oct 26 04:17:11 18087 kernel: [    1.337006] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
Oct 26 04:17:11 18087 kernel: [    1.337029] ehci-platform: EHCI generic platform driver
Oct 26 04:17:11 18087 kernel: [    1.337968] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
Oct 26 04:17:11 18087 kernel: [    1.338026] ohci-platform: OHCI generic platform driver
Oct 26 04:17:11 18087 kernel: [    1.339249] usbcore: registered new interface driver usb-storage
Oct 26 04:17:11 18087 kernel: [    1.341396] sunxi-rtc 1c20d00.rtc: registered as rtc0
Oct 26 04:17:11 18087 kernel: [    1.341494] sunxi-rtc 1c20d00.rtc: setting system clock to 1970-01-01T00:01:11 UTC (71)
Oct 26 04:17:11 18087 kernel: [    1.341774] i2c /dev entries driver
Oct 26 04:17:11 18087 kernel: [    1.343669] axp20x-i2c 0-0034: AXP20x variant AXP209 found
Oct 26 04:17:11 18087 kernel: [    1.352050] input: axp20x-pek as /devices/platform/soc/1c2ac00.i2c/i2c-0/0-0034/axp20x-pek/input/input0
Oct 26 04:17:11 18087 kernel: [    1.361265] vdd-rtc: supplied by regulator-dummy
Oct 26 04:17:11 18087 kernel: [    1.362227] avcc: supplied by regulator-dummy
Oct 26 04:17:11 18087 kernel: [    1.363552] vddio-csi0: Bringing 2800000uV into 3300000-3300000uV
Oct 26 04:17:11 18087 kernel: [    1.364976] vddio-csi0: supplied by regulator-dummy
Oct 26 04:17:11 18087 kernel: [    1.365449] vddio-csi1: supplied by regulator-dummy
Oct 26 04:17:11 18087 kernel: [    1.366485] ldo5: supplied by regulator-dummy
Oct 26 04:17:11 18087 kernel: [    1.367136] vdd-cpu: supplied by regulator-dummy
Oct 26 04:17:11 18087 kernel: [    1.368065] vdd-int-dll: supplied by regulator-dummy
Oct 26 04:17:11 18087 kernel: [    1.370028] axp20x-i2c 0-0034: AXP20X driver loaded
Oct 26 04:17:11 18087 kernel: [    1.376201] sunxi-wdt 1c20c90.watchdog: Watchdog enabled (timeout=16 sec, nowayout=0)
Oct 26 04:17:11 18087 kernel: [    1.377473] sdhci: Secure Digital Host Controller Interface driver
Oct 26 04:17:11 18087 kernel: [    1.377487] sdhci: Copyright(c) Pierre Ossman
Oct 26 04:17:11 18087 kernel: [    1.377494] Synopsys Designware Multimedia Card Interface Driver
Oct 26 04:17:11 18087 kernel: [    1.378740] sdhci-pltfm: SDHCI platform and OF driver helper
Oct 26 04:17:11 18087 kernel: [    1.380781] sun4i-pinctrl 1c20800.pinctrl: supply vcc-ph not found, using dummy regulator
Oct 26 04:17:11 18087 kernel: [    1.382485] sunxi-mmc 1c0f000.mmc: Got CD GPIO
Oct 26 04:17:11 18087 kernel: [    1.382917] ledtrig-cpu: registered to indicate activity on CPUs
Oct 26 04:17:11 18087 kernel: [    1.383053] hid: raw HID events driver (C) Jiri Kosina
Oct 26 04:17:11 18087 kernel: [    1.383270] usbcore: registered new interface driver usbhid
Oct 26 04:17:11 18087 kernel: [    1.383282] usbhid: USB HID core driver

KriszK

/var/log/mssages part2:
Oct 26 04:17:11 18087 kernel: [    1.383578] sunxi-mmc 1c11000.mmc: allocated mmc-pwrseq
Oct 26 04:17:11 18087 kernel: [    1.387099] Initializing XFRM netlink socket
Oct 26 04:17:11 18087 kernel: [    1.388075] NET: Registered protocol family 10
Oct 26 04:17:11 18087 kernel: [    1.406419] sunxi-mmc 1c11000.mmc: initialized, max. request size: 16384 KB
Oct 26 04:17:11 18087 kernel: [    1.407822] sunxi-mmc 1c0f000.mmc: initialized, max. request size: 16384 KB
Oct 26 04:17:11 18087 kernel: [    1.451571] Segment Routing with IPv6
Oct 26 04:17:11 18087 kernel: [    1.451723] NET: Registered protocol family 17
Oct 26 04:17:11 18087 kernel: [    1.451771] NET: Registered protocol family 15
Oct 26 04:17:11 18087 kernel: [    1.452081] 8021q: 802.1Q VLAN Support v1.8
Oct 26 04:17:11 18087 kernel: [    1.452251] Key type dns_resolver registered
Oct 26 04:17:11 18087 kernel: [    1.452410] Registering SWP/SWPB emulation handler
Oct 26 04:17:11 18087 kernel: [    1.452978] registered taskstats version 1
Oct 26 04:17:11 18087 kernel: [    1.453004] Loading compiled-in X.509 certificates
Oct 26 04:17:11 18087 kernel: [    1.453171] zswap: loaded using pool lzo/zbud
Oct 26 04:17:11 18087 kernel: [    1.454474] Key type .fscrypt registered
Oct 26 04:17:11 18087 kernel: [    1.454491] Key type fscrypt-provisioning registered
Oct 26 04:17:11 18087 kernel: [    1.468761] mmc1: new DDR MMC card at address 0001
Oct 26 04:17:11 18087 kernel: [    1.470840] mmcblk1: mmc1:0001 Q2J55L 7.09 GiB
Oct 26 04:17:11 18087 kernel: [    1.471833] mmcblk1boot0: mmc1:0001 Q2J55L partition 1 16.0 MiB
Oct 26 04:17:11 18087 kernel: [    1.472789] mmcblk1boot1: mmc1:0001 Q2J55L partition 2 16.0 MiB
Oct 26 04:17:11 18087 kernel: [    1.491286] Key type encrypted registered
Oct 26 04:17:11 18087 kernel: [    1.491322] AppArmor: AppArmor sha1 policy hashing enabled
Oct 26 04:17:11 18087 kernel: [    1.518821] ahci-sunxi 1c18000.sata: supply ahci not found, using dummy regulator
Oct 26 04:17:11 18087 kernel: [    1.519195] ahci-sunxi 1c18000.sata: supply phy not found, using dummy regulator
Oct 26 04:17:11 18087 kernel: [    1.573999] ahci-sunxi 1c18000.sata: controller can't do PMP, turning off CAP_PMP
Oct 26 04:17:11 18087 kernel: [    1.574066] ahci-sunxi 1c18000.sata: SSS flag set, parallel bus scan disabled
Oct 26 04:17:11 18087 kernel: [    1.574103] ahci-sunxi 1c18000.sata: AHCI 0001.0100 32 slots 1 ports 3 Gbps 0x1 impl platform mode
Oct 26 04:17:11 18087 kernel: [    1.574122] ahci-sunxi 1c18000.sata: flags: ncq sntf stag pm led clo only pio slum part ccc
Oct 26 04:17:11 18087 kernel: [    1.575801] scsi host0: ahci-sunxi
Oct 26 04:17:11 18087 kernel: [    1.576391] ata1: SATA max UDMA/133 mmio [mem 0x01c18000-0x01c18fff] port 0x100 irq 48
Oct 26 04:17:11 18087 kernel: [    1.577535] ehci-platform 1c14000.usb: EHCI Host Controller
Oct 26 04:17:11 18087 kernel: [    1.577584] ehci-platform 1c14000.usb: new USB bus registered, assigned bus number 1
Oct 26 04:17:11 18087 kernel: [    1.578251] ehci-platform 1c14000.usb: irq 43, io mem 0x01c14000
Oct 26 04:17:11 18087 kernel: [    1.593968] ehci-platform 1c14000.usb: USB 2.0 started, EHCI 1.00
Oct 26 04:17:11 18087 kernel: [    1.594389] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
Oct 26 04:17:11 18087 kernel: [    1.594403] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Oct 26 04:17:11 18087 kernel: [    1.594413] usb usb1: Product: EHCI Host Controller
Oct 26 04:17:11 18087 kernel: [    1.594422] usb usb1: Manufacturer: Linux 5.10.180-olimex ehci_hcd
Oct 26 04:17:11 18087 kernel: [    1.594430] usb usb1: SerialNumber: 1c14000.usb
Oct 26 04:17:11 18087 kernel: [    1.595475] hub 1-0:1.0: USB hub found
Oct 26 04:17:11 18087 kernel: [    1.595551] hub 1-0:1.0: 1 port detected
Oct 26 04:17:11 18087 kernel: [    1.597182] ehci-platform 1c1c000.usb: EHCI Host Controller
Oct 26 04:17:11 18087 kernel: [    1.597228] ehci-platform 1c1c000.usb: new USB bus registered, assigned bus number 2
Oct 26 04:17:11 18087 kernel: [    1.597769] ehci-platform 1c1c000.usb: irq 49, io mem 0x01c1c000
Oct 26 04:17:11 18087 kernel: [    1.610028] ehci-platform 1c1c000.usb: USB 2.0 started, EHCI 1.00
Oct 26 04:17:11 18087 kernel: [    1.610346] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
Oct 26 04:17:11 18087 kernel: [    1.610361] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Oct 26 04:17:11 18087 kernel: [    1.610371] usb usb2: Product: EHCI Host Controller
Oct 26 04:17:11 18087 kernel: [    1.610379] usb usb2: Manufacturer: Linux 5.10.180-olimex ehci_hcd
Oct 26 04:17:11 18087 kernel: [    1.610388] usb usb2: SerialNumber: 1c1c000.usb
Oct 26 04:17:11 18087 kernel: [    1.611424] hub 2-0:1.0: USB hub found
Oct 26 04:17:11 18087 kernel: [    1.611498] hub 2-0:1.0: 1 port detected
Oct 26 04:17:11 18087 kernel: [    1.613074] ohci-platform 1c14400.usb: Generic Platform OHCI controller
Oct 26 04:17:11 18087 kernel: [    1.613118] ohci-platform 1c14400.usb: new USB bus registered, assigned bus number 3
Oct 26 04:17:11 18087 kernel: [    1.613680] ohci-platform 1c14400.usb: irq 44, io mem 0x01c14400
Oct 26 04:17:11 18087 kernel: [    1.674205] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.10
Oct 26 04:17:11 18087 kernel: [    1.674226] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Oct 26 04:17:11 18087 kernel: [    1.674236] usb usb3: Product: Generic Platform OHCI controller
Oct 26 04:17:11 18087 kernel: [    1.674245] usb usb3: Manufacturer: Linux 5.10.180-olimex ohci_hcd
Oct 26 04:17:11 18087 kernel: [    1.674254] usb usb3: SerialNumber: 1c14400.usb
Oct 26 04:17:11 18087 kernel: [    1.675259] hub 3-0:1.0: USB hub found
Oct 26 04:17:11 18087 kernel: [    1.675342] hub 3-0:1.0: 1 port detected
Oct 26 04:17:11 18087 kernel: [    1.676877] ohci-platform 1c1c400.usb: Generic Platform OHCI controller
Oct 26 04:17:11 18087 kernel: [    1.676922] ohci-platform 1c1c400.usb: new USB bus registered, assigned bus number 4
Oct 26 04:17:11 18087 kernel: [    1.677393] ohci-platform 1c1c400.usb: irq 50, io mem 0x01c1c400
Oct 26 04:17:11 18087 kernel: [    1.738304] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.10
Oct 26 04:17:11 18087 kernel: [    1.738323] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Oct 26 04:17:11 18087 kernel: [    1.738333] usb usb4: Product: Generic Platform OHCI controller
Oct 26 04:17:11 18087 kernel: [    1.738342] usb usb4: Manufacturer: Linux 5.10.180-olimex ohci_hcd
Oct 26 04:17:11 18087 kernel: [    1.738351] usb usb4: SerialNumber: 1c1c400.usb
Oct 26 04:17:11 18087 kernel: [    1.739352] hub 4-0:1.0: USB hub found
Oct 26 04:17:11 18087 kernel: [    1.739426] hub 4-0:1.0: 1 port detected
Oct 26 04:17:11 18087 kernel: [    1.741167] usb_phy_generic usb_phy_generic.0.auto: supply vcc not found, using dummy regulator
Oct 26 04:17:11 18087 kernel: [    1.741447] usb_phy_generic usb_phy_generic.0.auto: dummy supplies not allowed for exclusive requests
Oct 26 04:17:11 18087 kernel: [    1.742749] musb-hdrc musb-hdrc.1.auto: MUSB HDRC host driver
Oct 26 04:17:11 18087 kernel: [    1.742793] musb-hdrc musb-hdrc.1.auto: new USB bus registered, assigned bus number 5
Oct 26 04:17:11 18087 kernel: [    1.743264] usb usb5: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
Oct 26 04:17:11 18087 kernel: [    1.743280] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Oct 26 04:17:11 18087 kernel: [    1.743290] usb usb5: Product: MUSB HDRC host driver
Oct 26 04:17:11 18087 kernel: [    1.743299] usb usb5: Manufacturer: Linux 5.10.180-olimex musb-hcd
Oct 26 04:17:11 18087 kernel: [    1.743307] usb usb5: SerialNumber: musb-hdrc.1.auto
Oct 26 04:17:11 18087 kernel: [    1.744298] hub 5-0:1.0: USB hub found
Oct 26 04:17:11 18087 kernel: [    1.744382] hub 5-0:1.0: 1 port detected
Oct 26 04:17:11 18087 kernel: [    1.762442] ALSA device list:
Oct 26 04:17:11 18087 kernel: [    1.762463]   No soundcards found.
Oct 26 04:17:11 18087 kernel: [    1.892450] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
Oct 26 04:17:11 18087 kernel: [    1.892715] ata1.00: ATA-10: KINGSTON SA400S37240G, 03090004, max UDMA/133
Oct 26 04:17:11 18087 kernel: [    1.892730] ata1.00: 468862128 sectors, multi 1: LBA48 NCQ (depth 32)
Oct 26 04:17:11 18087 kernel: [    1.898188] ata1.00: configured for UDMA/133
Oct 26 04:17:11 18087 kernel: [    1.899119] scsi 0:0:0:0: Direct-Access     ATA      KINGSTON SA400S3 0004 PQ: 0 ANSI: 5
Oct 26 04:17:11 18087 kernel: [    1.900547] sd 0:0:0:0: Attached scsi generic sg0 type 0
Oct 26 04:17:11 18087 kernel: [    1.901010] sd 0:0:0:0: [sda] 468862128 512-byte logical blocks: (240 GB/224 GiB)
Oct 26 04:17:11 18087 kernel: [    1.901141] sd 0:0:0:0: [sda] Write Protect is off
Oct 26 04:17:11 18087 kernel: [    1.901351] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Oct 26 04:17:11 18087 kernel: [    1.904108]  sda: sda1
Oct 26 04:17:11 18087 kernel: [    1.923090] sd 0:0:0:0: [sda] Attached SCSI disk
Oct 26 04:17:11 18087 kernel: [    1.928753] Freeing unused kernel memory: 1024K
Oct 26 04:17:11 18087 kernel: [    1.942216] Run /init as init process
Oct 26 04:17:11 18087 kernel: [    3.093100] pwm-backlight backlight: supply power not found, using dummy regulator
Oct 26 04:17:11 18087 kernel: [    3.194518] usb 3-1: new low-speed USB device number 2 using ohci-platform
Oct 26 04:17:11 18087 kernel: [    3.256860] pwm-backlight backlight: supply power not found, using dummy regulator
Oct 26 04:17:11 18087 kernel: [    3.259868] pwm-backlight backlight: supply power not found, using dummy regulator
Oct 26 04:17:11 18087 kernel: [    3.451735] pwm-backlight backlight: supply power not found, using dummy regulator
Oct 26 04:17:11 18087 kernel: [    3.464276] usb 3-1: New USB device found, idVendor=051d, idProduct=0002, bcdDevice= 0.06
Oct 26 04:17:11 18087 kernel: [    3.464304] usb 3-1: New USB device strings: Mfr=3, Product=1, SerialNumber=2
Oct 26 04:17:11 18087 kernel: [    3.464315] usb 3-1: Product: Back-UPS CS 500 FW:808.q14 .I USB FW:q14
Oct 26 04:17:11 18087 kernel: [    3.464324] usb 3-1: Manufacturer: American Power Conversion
Oct 26 04:17:11 18087 kernel: [    3.464332] usb 3-1: SerialNumber: 4B2214P01999 
Oct 26 04:17:11 18087 kernel: [    3.533888] axp20x-gpio axp20x-gpio: DMA mask not set
Oct 26 04:17:11 18087 kernel: [    3.542760] axp20x-gpio axp20x-gpio: AXP209 pinctrl and GPIO driver loaded
Oct 26 04:17:11 18087 kernel: [    3.697014] hid-generic 0003:051D:0002.0001: hiddev96,hidraw0: USB HID v1.10 Device [American Power Conversion Back-UPS CS 500 FW:808.q14 .I USB FW:q14 ] on usb-1c14400.usb-1/input0
Oct 26 04:17:11 18087 kernel: [   12.496052] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null)
Oct 26 04:17:11 18087 kernel: [   13.968256] random: systemd: uninitialized urandom read (16 bytes read)
Oct 26 04:17:11 18087 kernel: [   13.990470] random: systemd: uninitialized urandom read (16 bytes read)
Oct 26 04:17:11 18087 kernel: [   14.010317] random: systemd: uninitialized urandom read (16 bytes read)
Oct 26 04:17:11 18087 kernel: [   14.581785] fuse: init (API version 7.32)
Oct 26 04:17:11 18087 kernel: [   14.918139] EXT4-fs (sda1): re-mounted. Opts: commit=600,errors=remount-ro
Oct 26 04:17:11 18087 kernel: [   14.932785] g_serial gadget: Gadget Serial v2.4
Oct 26 04:17:11 18087 kernel: [   14.932814] g_serial gadget: g_serial ready
Oct 26 04:17:11 18087 kernel: [   14.980888] random: systemd-journal: uninitialized urandom read (16 bytes read)
Oct 26 04:17:11 18087 kernel: [   15.049325] random: systemd: uninitialized urandom read (16 bytes read)
Oct 26 04:17:11 18087 kernel: [   15.071609] random: systemd: uninitialized urandom read (16 bytes read)
Oct 26 04:17:11 18087 kernel: [   15.874090] random: crng init done
Oct 26 04:17:11 18087 kernel: [   15.874120] random: 65 urandom warning(s) missed due to ratelimiting
Oct 26 04:17:11 18087 kernel: [   18.000217] mc: Linux media interface: v0.10
Oct 26 04:17:11 18087 kernel: [   18.102985] videodev: Linux video capture interface: v2.00
Oct 26 04:17:11 18087 kernel: [   18.248274] sun4i-ss 1c15000.crypto-engine: Die ID 0
Oct 26 04:17:11 18087 kernel: [   18.259799] sunxi_cedrus: module is from the staging directory, the quality is unknown, you have been warned.
Oct 26 04:17:11 18087 kernel: [   18.286857] cedrus 1c0e000.video-codec: Device registered as /dev/video0
Oct 26 04:17:11 18087 kernel: [   18.846042] CAN device driver interface
Oct 26 04:17:11 18087 kernel: [   18.860584] sun4i_can 1c2bc00.can: device registered (base=170a165e, irq=68)
Oct 26 04:17:11 18087 kernel: [   18.912255] lima 1c40000.gpu: gp - mali400 version major 1 minor 1
Oct 26 04:17:11 18087 kernel: [   18.912356] lima 1c40000.gpu: pp0 - mali400 version major 1 minor 1
Oct 26 04:17:11 18087 kernel: [   18.912425] lima 1c40000.gpu: pp1 - mali400 version major 1 minor 1
Oct 26 04:17:11 18087 kernel: [   18.912483] lima 1c40000.gpu: l2 cache 64K, 4-way, 64byte cache line, 64bit external bus
Oct 26 04:17:11 18087 kernel: [   18.948431] lima 1c40000.gpu: bus rate = 300000000
Oct 26 04:17:11 18087 kernel: [   18.948459] lima 1c40000.gpu: mod rate = 384000000
Oct 26 04:17:11 18087 kernel: [   18.949497] [drm] Initialized lima 1.1.0 20191231 for 1c40000.gpu on minor 0
Oct 26 04:17:11 18087 kernel: [   18.967633] at24 1-0050: supply vcc not found, using dummy regulator
Oct 26 04:17:11 18087 kernel: [   18.975765] sun4i-pinctrl 1c20800.pinctrl: supply vcc-pd not found, using dummy regulator
Oct 26 04:17:11 18087 kernel: [   18.986112] at24 1-0050: 2048 byte 24c16 EEPROM, writable, 16 bytes/write
Oct 26 04:17:11 18087 kernel: [   19.057776] axp20x-adc axp20x-adc: DMA mask not set
Oct 26 04:17:11 18087 kernel: [   19.087998] axp20x-battery-power-supply axp20x-battery-power-supply: DMA mask not set
Oct 26 04:17:11 18087 kernel: [   19.089753] axp20x-ac-power-supply axp20x-ac-power-supply: DMA mask not set
Oct 26 04:17:13 18087 kernel: [   26.995396] sun7i-dwmac 1c50000.ethernet eth0: PHY [stmmac-0:01] driver [Micrel KSZ9031 Gigabit PHY] (irq=POLL)
Oct 26 04:17:13 18087 kernel: [   26.996975] sun7i-dwmac 1c50000.ethernet eth0: No Safety Features support found
Oct 26 04:17:13 18087 kernel: [   26.996996] sun7i-dwmac 1c50000.ethernet eth0: RX IPC Checksum Offload disabled
Oct 26 04:17:13 18087 kernel: [   26.997012] sun7i-dwmac 1c50000.ethernet eth0: No MAC Management Counters available
Oct 26 04:17:13 18087 kernel: [   26.997026] sun7i-dwmac 1c50000.ethernet eth0: PTP not supported by HW
Oct 26 04:17:13 18087 kernel: [   27.014535] sun7i-dwmac 1c50000.ethernet eth0: configuring for phy/rgmii-id link mode
Oct 26 04:17:16 18087 kernel: [   30.087068] sun7i-dwmac 1c50000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx
Oct 26 04:17:16 18087 kernel: [   30.087141] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
Oct 26 04:17:20 18087 kernel: [   33.766207] vcc3v0: disabling
Oct 26 04:17:20 18087 kernel: [   33.766302] vcc5v0: disabling
Oct 27 19:30:05 18087 kernel: [  201.918486] nf_conntrack: default automatic helper assignment has been turned off for security reasons and CT-based  firewall rule not found. Use the iptables CT target to attach helpers instead.
Oct 27 19:32:17 18087 autossh[645]: port set to 0, monitoring disabled
Oct 27 19:32:17 18087 autossh[799]: starting ssh (count 1)
Oct 27 19:32:17 18087 autossh[799]: ssh child pid is 800
Oct 27 19:37:41 18087 rsyslogd: [origin software="rsyslogd" swVersion="8.2102.0" x-pid="361" x-info="https://www.rsyslog.com"] rsyslogd was HUPed


LubOlimex

Looking at the logs stablity can probably be improved by trying different settings of scaling governor and max frequency for the main chip.

echo performance > /sys/devices/system/cpu/cpu0/cpufreq/scaling_governor

then if the issue persists first test with

echo 960000 > /sys/devices/system/cpu/cpu0/cpufreq/scaling_max_freq
echo 960000 > /sys/devices/system/cpu/cpu0/cpufreq/scaling_min_freq

then maybe with

echo 816000 > /sys/devices/system/cpu/cpu0/cpufreq/scaling_max_freq
echo 816000 > /sys/devices/system/cpu/cpu0/cpufreq/scaling_min_freq

You should also check here:

https://linux-sunxi.org/Cpufreq
Technical support and documentation manager at Olimex

Daniele Zanini

Hello, I've been facing same issues of hanging and freezing. the events are random, can be days or half an hour between the freeze. Is there any update on this?

i've tried to lock the frequency by setting the governor to performance but nothing helps..

thanks

LubOlimex

Do you get some kernel panic in the command line? Or any message of error or maybe shutdown behavior messages?
Technical support and documentation manager at Olimex

Daniele Zanini

I have checked multiple logs, system, messages, kernel, cpu usage history, but nothing that stands out.
Could it be a power issue of the integrated power manager AXP209 on the olimex board?

LubOlimex

It is usually easy to determine if it is related to powering - just place a li-po battery temporarily and see if hangs persist. If they go away, then the problem is in the powering. Li-po backup would take care of situations where main power supply has problems.

Be careful with the polarity of the Li-Po battery, make sure that it fits the connector (there are batteries with mirrored + and - that might damage the board).

If hangs persist with li-po battery attached, then the problem is likely elsewhere.

You are using the power jack to provide power to the board, right?
Technical support and documentation manager at Olimex

mbosschaert

I've been struggling with this phenomena (random freezes without any logging) as well and had some conversations on this forum in the past (https://www.olimex.com/forum/index.php?topic=9124.msg37702#msg37702) but the problems have not been solved. The common condition for all boards I have is that additional devices are connected (SATA-disk or USB-devices). Even using power supplies up to 35W through the power-jack does not keep the freezes away. Have not tested separate power for the USB-devices, but even if that would solve the problem, it would still be present for the 2.5" HD's. Looking forward if this thread will lead to the final answer...

KriszK

Hi,

It seems the

"echo performance > /sys/devices/system/cpu/cpu0/cpufreq/scaling_governor"

solved my freezing problem on T2-OLinuXino-LIME2-e8Gs16M-IND Rev.L1 board when using it as a light load SSH server.

Thanks the great support.