eth1 (2.5) vanished: Upgrade to 20.11.3 / 5.9.14-rockchip64

[Zageron]

After upgrade to Armbian 20.11.3 Buster with Linux 5.9.14-rockchip64 eth1 has vanished.

 

❯ sudo ip link show
1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN mode DEFAULT group default qlen 1000
    link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00
2: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000
    link/ether 64:62:66:d0:06:18 brd ff:ff:ff:ff:ff:ff

 

Any ideas?

 

http://ix.io/2I2U

[DBwpg]

Likewise after upgradign to Armbian20.113 Buster eth1 2.5gb network disappeared.

[clostro]

Yeah, that happens once in a while. No idea why. I'm on Armbian_21.02.0-trunk.8_Helios64_buster_current_5.9.12.img

Tried usbreset and device unbind tricks but none of them worked. Maybe I didn't do it right, I don't know. So I wrote a script to reboot when it happens. Just make sure your raid and cache and whatnot gets gracefully suspended before a reboot. This problem may occur at any time.

 

#!/bin/bash
DEVICEFILE="/sys/devices/platform/usb@fe900000/fe900000.usb/xhci-hcd.0.auto/usb4/4-1/4-1.4/4-1.4:1.0"
MISSINGTOKEN="/home/user/eth1_missing"

if test -f "$MISSINGTOKEN"; then
        if [ ! -d "$DEVICEFILE" ]; then
                rm -rf "$MISSINGTOKEN"
                printf "eth1 missing for 20 seconds on %s. \n" "`date`" >> /home/user/eth1missing_reboot_log
                /sbin/reboot
                #echo "rebooting"
        fi
else
        if [ ! -d "$DEVICEFILE" ]; then
                touch "$MISSINGTOKEN"
        fi
fi
if test -d "$DEVICEFILE"; then
        rm -rf "$MISSINGTOKEN"
fi

And added this to crontab of root for every 10 seconds. Saved me from getting up and connecting the usb cable a few times.

 

plz dont 'bash' my if statements, was half asleep when i wrote this.

Edited December 14, 2020 by clostro

[Zageron]

No amount of rebooting is resolving this issue for me.

[aprayoga]

Apparently @Igor removed the driver in this commit.

The driver in mainline kernel, only support RTL8152/R8153

 

Spoiler

module not loaded

root@helios64:~# lsmod | grep r8152
root@helios64:~#

 

modinfo, return built in kernel module

root@helios64:~# modinfo r8152
filename:       /lib/modules/5.9.14-rockchip64/kernel/drivers/net/usb/r8152.ko
version:        v1.11.11
license:        GPL
description:    Realtek RTL8152/RTL8153 Based USB Ethernet Adapters
author:         Realtek linux nic maintainers <nic_swsd@realtek.com>
firmware:       rtl_nic/rtl8153b-2.fw
firmware:       rtl_nic/rtl8153a-4.fw
firmware:       rtl_nic/rtl8153a-3.fw
firmware:       rtl_nic/rtl8153a-2.fw
srcversion:     48B8817DA3B8BFDCEB9CE7C
alias:          usb:v2357p0601d*dc*dsc*dp*ic02isc06ip00in*
alias:          usb:v2357p0601d*dc*dsc*dp*icFFisc*ip*in*
alias:          usb:v0955p09FFd*dc*dsc*dp*ic02isc06ip00in*
alias:          usb:v0955p09FFd*dc*dsc*dp*icFFisc*ip*in*
alias:          usb:v13B1p0041d*dc*dsc*dp*ic02isc06ip00in*
alias:          usb:v13B1p0041d*dc*dsc*dp*icFFisc*ip*in*
alias:          usb:v17EFpA387d*dc*dsc*dp*ic02isc06ip00in*
alias:          usb:v17EFpA387d*dc*dsc*dp*icFFisc*ip*in*
alias:          usb:v17EFp7214d*dc*dsc*dp*ic02isc06ip00in*
alias:          usb:v17EFp7214d*dc*dsc*dp*icFFisc*ip*in*
alias:          usb:v17EFp720Cd*dc*dsc*dp*ic02isc06ip00in*
alias:          usb:v17EFp720Cd*dc*dsc*dp*icFFisc*ip*in*
alias:          usb:v17EFp7205d*dc*dsc*dp*ic02isc06ip00in*
alias:          usb:v17EFp7205d*dc*dsc*dp*icFFisc*ip*in*
alias:          usb:v17EFp3082d*dc*dsc*dp*ic02isc06ip00in*
alias:          usb:v17EFp3082d*dc*dsc*dp*icFFisc*ip*in*
alias:          usb:v17EFp3069d*dc*dsc*dp*ic02isc06ip00in*
alias:          usb:v17EFp3069d*dc*dsc*dp*icFFisc*ip*in*
alias:          usb:v17EFp3062d*dc*dsc*dp*ic02isc06ip00in*
alias:          usb:v17EFp3062d*dc*dsc*dp*icFFisc*ip*in*
alias:          usb:v17EFp304Fd*dc*dsc*dp*ic02isc06ip00in*
alias:          usb:v17EFp304Fd*dc*dsc*dp*icFFisc*ip*in*
alias:          usb:v04E8pA101d*dc*dsc*dp*ic02isc06ip00in*
alias:          usb:v04E8pA101d*dc*dsc*dp*icFFisc*ip*in*
alias:          usb:v045Ep0927d*dc*dsc*dp*ic02isc06ip00in*
alias:          usb:v045Ep0927d*dc*dsc*dp*icFFisc*ip*in*
alias:          usb:v045Ep07C6d*dc*dsc*dp*ic02isc06ip00in*
alias:          usb:v045Ep07C6d*dc*dsc*dp*icFFisc*ip*in*
alias:          usb:v045Ep07ABd*dc*dsc*dp*ic02isc06ip00in*
alias:          usb:v045Ep07ABd*dc*dsc*dp*icFFisc*ip*in*
alias:          usb:v0BDAp8153d*dc*dsc*dp*ic02isc06ip00in*
alias:          usb:v0BDAp8153d*dc*dsc*dp*icFFisc*ip*in*
alias:          usb:v0BDAp8152d*dc*dsc*dp*ic02isc06ip00in*
alias:          usb:v0BDAp8152d*dc*dsc*dp*icFFisc*ip*in*
alias:          usb:v0BDAp8050d*dc*dsc*dp*ic02isc06ip00in*
alias:          usb:v0BDAp8050d*dc*dsc*dp*icFFisc*ip*in*
depends:
intree:         Y
name:           r8152
vermagic:       5.9.14-rockchip64 SMP preempt mod_unload aarch64
sig_id:         PKCS#7
signer:         Build time autogenerated kernel key
sig_key:        6C:BA:7A:89:0A:75:61:DC:2D:05:7A:61:7C:E3:6E:B9:F0:2A:D8:94
sig_hashalgo:   sha1
signature:      AC:70:32:E7:D9:5B:7B:56:07:D9:9D:07:D8:4F:BB:A9:14:10:F3:23:
                62:B0:07:66:F6:A5:51:34:86:D7:8C:C5:D7:57:A0:3D:1E:B4:B1:13:
                F1:69:14:72:B1:15:93:9E:69:6A:84:02:EE:ED:8B:3D:A9:3D:34:5D:
                32:38:3F:A0:51:A7:8F:B1:13:DD:42:4A:F3:08:8C:E5:C1:53:18:D8:
                CC:3F:E2:A7:0B:C3:41:A2:EC:4A:61:5A:A9:CC:26:47:A8:09:EA:8D:
                03:01:D4:0F:90:5A:4C:87:DA:15:3C:65:11:9D:15:61:58:54:C1:68:
                44:39:10:18:47:8D:A4:C2:68:6F:2B:D9:08:29:2B:60:C4:CC:36:6A:
                89:1A:EE:17:56:E9:E5:D6:7B:A3:F4:0A:79:B5:F3:36:64:46:E9:A8:
                F4:93:11:BA:34:E6:73:AA:C1:03:1C:4F:17:2C:D6:9B:C4:C1:8E:73:
                95:2F:41:C5:E8:3A:EA:B2:22:57:02:C0:CD:F4:DE:D1:B2:0E:C4:41:
                40:6B:76:44:21:6A:E3:A5:AC:9D:EF:D8:EA:17:EE:D5:36:7C:E7:56:
                3A:36:67:DB:A3:C7:C0:DD:98:B5:8F:68:4A:3B:4F:2E:8A:08:E1:22:
                64:D0:D0:4D:DA:AE:04:9B:1E:5D:FC:CE:25:94:6B:0A:9E:57:29:2C:
                CD:33:F9:20:25:63:9A:A9:FA:80:7C:38:BF:68:DC:40:49:A2:50:D2:
                D1:08:94:9A:B8:F3:2D:C3:27:CF:E3:91:C8:22:38:63:B0:1B:E4:C5:
                37:F3:5A:84:79:C0:3D:04:53:09:98:9E:6B:E4:31:F4:C8:BA:55:28:
                95:F2:91:EC:1B:BE:B5:3A:17:DD:43:C3:9E:01:51:CA:10:E5:60:1F:
                76:E7:71:D2:D9:98:15:A8:DE:01:41:DA:E9:A2:D7:92:FB:8B:EB:84:
                26:25:B0:D8:A0:F9:82:81:32:BB:B1:C0:67:52:05:34:48:C8:05:28:
                F7:1B:0B:07:A0:24:BE:76:25:27:4D:CA:57:52:F2:AD:D2:02:53:0F:
                0F:2C:E2:BE:98:BC:A1:8B:F3:F8:23:2B:A4:27:C1:E5:3E:C8:7F:4B:
                CC:4D:CB:20:96:2F:BF:8D:FD:36:57:E8:18:C9:B8:49:5B:D8:58:7B:
                7E:1F:1F:2C:D0:CF:5F:41:EE:EB:B8:D0:82:D0:AC:0A:DB:7A:50:39:
                14:5D:E3:E3:C0:02:C7:F6:F1:C9:DF:C0:27:F7:C1:7D:82:27:24:5E:
                A7:4B:D8:8F:53:2E:5D:60:47:EF:9C:9B:71:81:B1:E5:39:CF:DA:AE:
                54:25:54:C6:3D:29:6B:2F:DA:73:84:B8
parm:           ledsel:Override default LED configuration (int)

 

 

[Werner]

Check github

[Igor]

Fix is on the way. Sorry for messing things up 

[toti]

This has been a real pain the last few days. Glad I found this post. Fortunately there is the 1G port as a backup.

1. When is the fix coming?

2. And can it then be installt via the regular apt update & upgrade?

[Werner]

1 hour ago, toti said:

This has been a real pain the last few days. Glad I found this post. Fortunately there is the 1G port as a backup.

1. When is the fix coming?

2. And can it then be installt via the regular apt update & upgrade?

1. Should be there already

2. yes

[gprovost]

Yes new packages with required driver are ready, you can just do the usual apt-get update && apt-get upgrade then reboot.

[Z06Frank]

I can confirm on "5.9.14-rockchip64 #20.11.4 SMP PREEMPT Tue Dec 15 08:52:20 CET 2020 aarch64 GNU/Linux" and checking the ethernet ports via CLI sudo ip link show that both eth0 and eth1 are showing in the output. 

Thanks......

[clostro]

I did a fresh install of Armbian_20.11.4_Helios64_buster_current_5.9.14.img on the sd card and still having the same eth1 missing problem. Any ideas?

 

It was working ok for the most part, but when I did a couple of crystaldisk benchmarks back to back on the helios64 share, everything went blank. Connected the usb cable, did ifconfig, and eth1 went missing.

[TRS-80]

On 12/15/2020 at 8:34 AM, Igor said:

Fix is on the way. Sorry for messing things up

 

Rare mistake by Igor!

 

In few years I been lurking here, this is only time I can recall such thing happening.  Of course everyone make mistakes, and there were probably some I was not aware of, but this is first time I can remember such thing happening.

Edited December 17, 2020 by TRS-80
italicize remember

[gprovost]

13 hours ago, clostro said:

I did a fresh install of Armbian_20.11.4_Helios64_buster_current_5.9.14.img on the sd card and still having the same eth1 missing problem. Any ideas?

 

Are you sure you running the latest image ? Can you share the output of your dmesg command.

[DBwpg]

I'm currently running with the  Armbian_20.11.4_Helios64_buster_current_5.9.14 image.  Running OMV5 and currently rsyncing my media files from my Qnap server.

Seems to be syncing at a sustained rate of 60MB/sec  at the moment via eth1 2.5gb link.  Not sure if the 60MB/sec is optimal does anybody else have any other findings to compare with?  My Qnap 469L is setup with 2 x 1gb ethernet  aggregated to my Zyxel switch where the Helios64 is connected to the same switch on one of its 2.5gb ports.  Looks like the job (6.7TB) will take about 13 hours which is quite a bit quicker than the same sync my Qnap (2x1gb aggregated link)  to my Qnap (100mb) did in about 3-4 days :-)

So far so good.

[DBwpg]

5 hours ago, DBwpg said:

I'm currently running with the  Armbian_20.11.4_Helios64_buster_current_5.9.14 image.  Running OMV5 and currently rsyncing my media files from my Qnap server.

Seems to be syncing at a sustained rate of 60MB/sec  at the moment via eth1 2.5gb link.  Not sure if the 60MB/sec is optimal does anybody else have any other findings to compare with?  My Qnap 469L is setup with 2 x 1gb ethernet  aggregated to my Zyxel switch where the Helios64 is connected to the same switch on one of its 2.5gb ports.  Looks like the job (6.7TB) will take about 13 hours which is quite a bit quicker than the same sync my Qnap (2x1gb aggregated link)  to my Qnap (100mb) did in about 3-4 days :-)

So far so good.

Ok.  I guess I spoke to soon in regards to the status of eth1 2.5gb link.  It appears the link is dropping.  It seemed to have run ok for about 5 hours then failed.   Noticed the link speed dropped to about 2-3MB and rsynch finally failed.  I rebooted the unit and restarted the rsync job.  It seemed to startup ok and ran for a few minutes with speeds hitting 60MB/sec and then failed.  My ssh connection also timed out.  Oh well.  Not sure what my next options are.  For the time being I'm shutting her down :-(

[gprovost]

@DBwpg Do you have some log to share ?

[DBwpg]

[mention=13660]DBwpg[/mention] Do you have some log to share ?

How best create logs?

Sent from my SM-T713 using Tapatalk

[clostro]

16 hours ago, gprovost said:

 

Are you sure you running the latest image ? Can you share the output of your dmesg command.

 

I think so, I did a fresh install on the sd card from this file - Armbian_20.11.4_Helios64_buster_current_5.9.14.img.xz

 

Here is the dmesg output from after reboot. Can't access the previous boot records though. This one shows a lot of eth1 errors and warnings, but it hasn't crashed yet.

 

Spoiler

[    0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034]
[    0.000000] Linux version 5.9.14-rockchip64 (root@desktop) (aarch64-linux-gnu-gcc (GNU Toolchain for the A-profile Architecture 8.3-2019.03 (arm-rel-8.36)) 8.3.0, GNU ld (GNU Toolchain for the A-profile Architecture 8.3-2019.03 (arm-rel-8.36)) 2.32.0.20190321) #20.11.4 SMP PREEMPT Tue Dec 15 08:52:20 CET 2020
[    0.000000] Machine model: Helios64
[    0.000000] efi: UEFI not found.
[    0.000000] cma: Reserved 128 MiB at 0x00000000ed000000
[    0.000000] NUMA: No NUMA configuration found
[    0.000000] NUMA: Faking a node at [mem 0x0000000000200000-0x00000000f7ffffff]
[    0.000000] NUMA: NODE_DATA [mem 0xf77d9100-0xf77dafff]
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000000200000-0x000000003fffffff]
[    0.000000]   DMA32    [mem 0x0000000040000000-0x00000000f7ffffff]
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000200000-0x00000000f7ffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000200000-0x00000000f7ffffff]
[    0.000000] On node 0 totalpages: 1015296
[    0.000000]   DMA zone: 4088 pages used for memmap
[    0.000000]   DMA zone: 0 pages reserved
[    0.000000]   DMA zone: 261632 pages, LIFO batch:63
[    0.000000]   DMA32 zone: 11776 pages used for memmap
[    0.000000]   DMA32 zone: 753664 pages, LIFO batch:63
[    0.000000] psci: probing for conduit method from DT.
[    0.000000] psci: PSCIv1.0 detected in firmware.
[    0.000000] psci: Using standard PSCI v0.2 function IDs
[    0.000000] psci: MIGRATE_INFO_TYPE not supported.
[    0.000000] psci: SMC Calling Convention v1.0
[    0.000000] percpu: Embedded 32 pages/cpu s93784 r8192 d29096 u131072
[    0.000000] pcpu-alloc: s93784 r8192 d29096 u131072 alloc=32*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 [0] 4 [0] 5 
[    0.000000] Detected VIPT I-cache on CPU0
[    0.000000] CPU features: detected: ARM erratum 845719
[    0.000000] CPU features: detected: GIC system register CPU interface
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 999432
[    0.000000] Policy zone: DMA32
[    0.000000] Kernel command line: root=UUID=6dbe0821-95ea-44dd-9e73-4bfe0a51dd66 rootwait rootfstype=ext4 console=ttyS2,1500000 console=tty1 consoleblank=0 loglevel=1 ubootpart=de6fa105-01 usb-storage.quirks=0x2537:0x1066:u,0x2537:0x1068:u   cgroup_enable=cpuset cgroup_memory=1 cgroup_enable=memory swapaccount=1
[    0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
[    0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
[    0.000000] mem auto-init: stack:off, heap alloc:on, heap free:off
[    0.000000] software IO TLB: mapped [mem 0x3bfff000-0x3ffff000] (64MB)
[    0.000000] Memory: 3741760K/4061184K available (14464K kernel code, 2094K rwdata, 5980K rodata, 4224K init, 573K bss, 188352K reserved, 131072K cma-reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=6, Nodes=1
[    0.000000] rcu: Preemptible hierarchical RCU implementation.
[    0.000000] rcu: 	RCU event tracing is enabled.
[    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=6.
[    0.000000] 	Trampoline variant of Tasks RCU enabled.
[    0.000000] 	Rude variant of Tasks RCU enabled.
[    0.000000] 	Tracing variant of Tasks RCU enabled.
[    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
[    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=6
[    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[    0.000000] GICv3: GIC: Using split EOI/Deactivate mode
[    0.000000] GICv3: 256 SPIs implemented
[    0.000000] GICv3: 0 Extended SPIs implemented
[    0.000000] GICv3: Distributor has no Range Selector support
[    0.000000] GICv3: 16 PPIs implemented
[    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000fef00000
[    0.000000] ITS [mem 0xfee20000-0xfee3ffff]
[    0.000000] ITS@0x00000000fee20000: allocated 65536 Devices @f6d00000 (flat, esz 8, psz 64K, shr 0)
[    0.000000] ITS: using cache flushing for cmd queue
[    0.000000] GICv3: using LPI property table @0x00000000f6cb0000
[    0.000000] GIC: using cache flushing for LPI property table
[    0.000000] GICv3: CPU0: using allocated LPI pending table @0x00000000f6cc0000
[    0.000000] GICv3: GIC: PPI partition interrupt-partition-0[0] { /cpus/cpu@0[0] /cpus/cpu@1[1] /cpus/cpu@2[2] /cpus/cpu@3[3] }
[    0.000000] GICv3: GIC: PPI partition interrupt-partition-1[1] { /cpus/cpu@100[4] /cpus/cpu@101[5] }
[    0.000000] random: get_random_bytes called from start_kernel+0x698/0x850 with crng_init=0
[    0.000000] arch_timer: cp15 timer(s) running at 24.00MHz (phys).
[    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x588fe9dc0, max_idle_ns: 440795202592 ns
[    0.000007] sched_clock: 56 bits at 24MHz, resolution 41ns, wraps every 4398046511097ns
[    0.001483] Console: colour dummy device 80x25
[    0.001500] printk: console [tty1] enabled
[    0.001628] Calibrating delay loop (skipped), value calculated using timer frequency.. 48.00 BogoMIPS (lpj=96000)
[    0.001642] pid_max: default: 32768 minimum: 301
[    0.001795] LSM: Security Framework initializing
[    0.001838] Yama: becoming mindful.
[    0.001991] AppArmor: AppArmor initialized
[    0.002081] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    0.002112] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    0.005418] rcu: Hierarchical SRCU implementation.
[    0.006609] Platform MSI: interrupt-controller@fee20000 domain created
[    0.007184] PCI/MSI: /interrupt-controller@fee00000/interrupt-controller@fee20000 domain created
[    0.009701] EFI services will not be available.
[    0.010415] smp: Bringing up secondary CPUs ...
[    0.011462] Detected VIPT I-cache on CPU1
[    0.011512] GICv3: CPU1: found redistributor 1 region 0:0x00000000fef20000
[    0.011530] GICv3: CPU1: using allocated LPI pending table @0x00000000f6cd0000
[    0.011587] CPU1: Booted secondary processor 0x0000000001 [0x410fd034]
[    0.013027] Detected VIPT I-cache on CPU2
[    0.013075] GICv3: CPU2: found redistributor 2 region 0:0x00000000fef40000
[    0.013094] GICv3: CPU2: using allocated LPI pending table @0x00000000f6ce0000
[    0.013152] CPU2: Booted secondary processor 0x0000000002 [0x410fd034]
[    0.014515] Detected VIPT I-cache on CPU3
[    0.014562] GICv3: CPU3: found redistributor 3 region 0:0x00000000fef60000
[    0.014580] GICv3: CPU3: using allocated LPI pending table @0x00000000f6cf0000
[    0.014639] CPU3: Booted secondary processor 0x0000000003 [0x410fd034]
[    0.016110] ARM_SMCCC_ARCH_WORKAROUND_1 missing from firmware
[    0.016120] CPU features: detected: ARM errata 1165522, 1319367, or 1530923
[    0.016128] Detected PIPT I-cache on CPU4
[    0.016163] GICv3: CPU4: found redistributor 100 region 0:0x00000000fef80000
[    0.016177] GICv3: CPU4: using allocated LPI pending table @0x00000000f6d80000
[    0.016216] CPU4: Booted secondary processor 0x0000000100 [0x410fd082]
[    0.017421] Detected PIPT I-cache on CPU5
[    0.017459] GICv3: CPU5: found redistributor 101 region 0:0x00000000fefa0000
[    0.017474] GICv3: CPU5: using allocated LPI pending table @0x00000000f6d90000
[    0.017514] CPU5: Booted secondary processor 0x0000000101 [0x410fd082]
[    0.017684] smp: Brought up 1 node, 6 CPUs
[    0.017693] SMP: Total of 6 processors activated.
[    0.017702] CPU features: detected: 32-bit EL0 Support
[    0.017711] CPU features: detected: CRC32 instructions
[    0.017720] CPU features: detected: 32-bit EL1 Support
[    0.044836] CPU: All CPU(s) started at EL2
[    0.044901] alternatives: patching kernel code
[    0.048643] devtmpfs: initialized
[    0.065008] Registered cp15_barrier emulation handler
[    0.065030] Registered setend emulation handler
[    0.065876] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.065945] futex hash table entries: 2048 (order: 5, 131072 bytes, linear)
[    0.069223] xor: measuring software checksum speed
[    0.107932]    8regs     :  2345.000 MB/sec
[    0.148020]    32regs    :  2757.000 MB/sec
[    0.188111]    arm64_neon:  2278.000 MB/sec
[    0.188117] xor: using function: 32regs (2757.000 MB/sec)
[    0.188174] pinctrl core: initialized pinctrl subsystem
[    0.188857] DMI not present or invalid.
[    0.189457] NET: Registered protocol family 16
[    0.192489] DMA: preallocated 2048 KiB GFP_KERNEL pool for atomic allocations
[    0.193966] DMA: preallocated 2048 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
[    0.194741] DMA: preallocated 2048 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
[    0.194845] audit: initializing netlink subsys (disabled)
[    0.195138] audit: type=2000 audit(0.192:1): state=initialized audit_enabled=0 res=1
[    0.196387] thermal_sys: Registered thermal governor 'fair_share'
[    0.196392] thermal_sys: Registered thermal governor 'bang_bang'
[    0.196398] thermal_sys: Registered thermal governor 'step_wise'
[    0.196404] thermal_sys: Registered thermal governor 'user_space'
[    0.196929] cpuidle: using governor menu
[    0.197244] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[    0.197472] ASID allocator initialised with 65536 entries
[    0.198749] Serial: AMBA PL011 UART driver
[    0.266138] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
[    0.266149] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages
[    0.266156] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[    0.266163] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages
[    0.272172] cryptd: max_cpu_qlen set to 1000
[    0.348542] raid6: neonx8   gen()  1667 MB/s
[    0.416706] raid6: neonx8   xor()  1224 MB/s
[    0.484871] raid6: neonx4   gen()  1688 MB/s
[    0.553031] raid6: neonx4   xor()  1267 MB/s
[    0.621193] raid6: neonx2   gen()  1507 MB/s
[    0.689346] raid6: neonx2   xor()  1160 MB/s
[    0.757512] raid6: neonx1   gen()  1177 MB/s
[    0.825674] raid6: neonx1   xor()   933 MB/s
[    0.893863] raid6: int64x8  gen()   997 MB/s
[    0.962006] raid6: int64x8  xor()   575 MB/s
[    1.030166] raid6: int64x4  gen()   991 MB/s
[    1.098323] raid6: int64x4  xor()   589 MB/s
[    1.166485] raid6: int64x2  gen()   927 MB/s
[    1.234630] raid6: int64x2  xor()   522 MB/s
[    1.302810] raid6: int64x1  gen()   724 MB/s
[    1.370941] raid6: int64x1  xor()   389 MB/s
[    1.370947] raid6: using algorithm neonx4 gen() 1688 MB/s
[    1.370952] raid6: .... xor() 1267 MB/s, rmw enabled
[    1.370957] raid6: using neon recovery algorithm
[    1.372558] vcc12v_dcin_bkup: supplied by vcc12v_dcin
[    1.372990] vcc12v_hdd: supplied by vcc12v_dcin_bkup
[    1.386449] vcc5v0_perdev: supplied by vcc12v_dcin_bkup
[    1.386931] pcie_power: supplied by vcc5v0_perdev
[    1.387069] vcc5v0_usb: supplied by vcc5v0_perdev
[    1.387137] vcc5v0_typec: supplied by vcc5v0_usb
[    1.387195] vcc5v0_hdd: supplied by vcc12v_dcin_bkup
[    1.387814] vcc5v0_sys: supplied by vcc12v_dcin_bkup
[    1.388376] vcc3v3_sys_s3: supplied by vcc5v0_sys
[    1.388431] vcc0v9_s3: supplied by vcc3v3_sys_s3
[    1.388514] avdd_1v8_s0: supplied by vcc3v3_sys_s3
[    1.388588] vcc3v0_sd: supplied by vcc3v3_sys_s3
[    1.389584] usblan_power: supplied by vcc5v0_usb
[    1.390164] iommu: Default domain type: Translated 
[    1.393688] vgaarb: loaded
[    1.394236] SCSI subsystem initialized
[    1.394473] libata version 3.00 loaded.
[    1.394741] usbcore: registered new interface driver usbfs
[    1.394786] usbcore: registered new interface driver hub
[    1.394893] usbcore: registered new device driver usb
[    1.395611] pps_core: LinuxPPS API ver. 1 registered
[    1.395617] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    1.395633] PTP clock support registered
[    1.395941] EDAC MC: Ver: 3.0.0
[    1.397180] NetLabel: Initializing
[    1.397186] NetLabel:  domain hash size = 128
[    1.397191] NetLabel:  protocols = UNLABELED CIPSOv4 CALIPSO
[    1.397258] NetLabel:  unlabeled traffic allowed by default
[    1.397747] clocksource: Switched to clocksource arch_sys_counter
[    1.523178] VFS: Disk quotas dquot_6.6.0
[    1.523257] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    1.524122] AppArmor: AppArmor Filesystem Enabled
[    1.534799] NET: Registered protocol family 2
[    1.535652] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
[    1.535828] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
[    1.536361] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear)
[    1.537027] TCP: Hash tables configured (established 32768 bind 32768)
[    1.537212] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
[    1.537375] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
[    1.537795] NET: Registered protocol family 1
[    1.537828] NET: Registered protocol family 44
[    1.537842] PCI: CLS 0 bytes, default 64
[    1.538064] Trying to unpack rootfs image as initramfs...
[    2.572528] Freeing initrd memory: 14072K
[    2.573847] hw perfevents: enabled with armv8_cortex_a53 PMU driver, 7 counters available
[    2.574325] hw perfevents: enabled with armv8_cortex_a72 PMU driver, 7 counters available
[    2.575024] kvm [1]: IPA Size Limit: 40bits
[    2.575811] kvm [1]: vgic-v2@fff20000
[    2.575847] kvm [1]: GIC system register CPU interface enabled
[    2.576092] kvm [1]: vgic interrupt IRQ10
[    2.576394] kvm [1]: Hyp mode initialized successfully
[    2.587795] Initialise system trusted keyrings
[    2.587833] Key type blacklist registered
[    2.588024] workingset: timestamp_bits=44 max_order=20 bucket_order=0
[    2.594630] zbud: loaded
[    2.596248] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    2.597154] fuse: init (API version 7.31)
[    2.598570] integrity: Platform Keyring initialized
[    2.663845] Key type asymmetric registered
[    2.663852] Asymmetric key parser 'x509' registered
[    2.663896] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247)
[    2.664115] io scheduler mq-deadline registered
[    2.664121] io scheduler kyber registered
[    2.664250] io scheduler bfq registered
[    2.682739] rockchip-pcie f8000000.pcie: host bridge /pcie@f8000000 ranges:
[    2.682767] OF: /pcie@f8000000: Missing device_type
[    2.682798] rockchip-pcie f8000000.pcie:      MEM 0x00fa000000..0x00fbdfffff -> 0x00fa000000
[    2.682818] rockchip-pcie f8000000.pcie:       IO 0x00fbe00000..0x00fbefffff -> 0x00fbe00000
[    2.691656] dma-pl330 ff6d0000.dma-controller: Loaded driver for PL330 DMAC-241330
[    2.691668] dma-pl330 ff6d0000.dma-controller: 	DBUFF-32x8bytes Num_Chans-6 Num_Peri-12 Num_Events-12
[    2.693182] dma-pl330 ff6e0000.dma-controller: Loaded driver for PL330 DMAC-241330
[    2.693192] dma-pl330 ff6e0000.dma-controller: 	DBUFF-128x8bytes Num_Chans-8 Num_Peri-20 Num_Events-16
[    2.697718] vdd_log: supplied by regulator-dummy
[    2.699188] Serial: 8250/16550 driver, 8 ports, IRQ sharing disabled
[    2.702393] ff180000.serial: ttyS0 at MMIO 0xff180000 (irq = 36, base_baud = 1500000) is a 16550A
[    2.703413] ff1a0000.serial: ttyS2 at MMIO 0xff1a0000 (irq = 37, base_baud = 1500000) is a 16550A
[    2.703604] printk: console [ttyS2] enabled
[    2.704929] Serial: AMBA driver
[    2.706510] cacheinfo: Unable to detect cache hierarchy for CPU 0
[    2.718612] loop: module loaded
[    2.727438] libphy: Fixed MDIO Bus: probed
[    2.727788] tun: Universal TUN/TAP device driver, 1.6
[    2.728886] thunder_xcv, ver 1.0
[    2.728935] thunder_bgx, ver 1.0
[    2.728976] nicpf, ver 1.0
[    2.730223] e1000e: Intel(R) PRO/1000 Network Driver
[    2.730228] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
[    2.730278] igb: Intel(R) Gigabit Ethernet Network Driver
[    2.730282] igb: Copyright (c) 2007-2014 Intel Corporation.
[    2.730319] igbvf: Intel(R) Gigabit Virtual Function Network Driver
[    2.730324] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
[    2.730628] sky2: driver version 1.30
[    2.731350] VFIO - User Level meta-driver version: 0.3
[    2.749876] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    2.749899] ehci-pci: EHCI PCI platform driver
[    2.749948] ehci-platform: EHCI generic platform driver
[    2.752376] ehci-platform fe380000.usb: EHCI Host Controller
[    2.752402] ehci-platform fe380000.usb: new USB bus registered, assigned bus number 1
[    2.752556] ehci-platform fe380000.usb: irq 30, io mem 0xfe380000
[    2.765770] ehci-platform fe380000.usb: USB 2.0 started, EHCI 1.00
[    2.766024] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.09
[    2.766034] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    2.766042] usb usb1: Product: EHCI Host Controller
[    2.766050] usb usb1: Manufacturer: Linux 5.9.14-rockchip64 ehci_hcd
[    2.766057] usb usb1: SerialNumber: fe380000.usb
[    2.766639] hub 1-0:1.0: USB hub found
[    2.766679] hub 1-0:1.0: 1 port detected
[    2.767460] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    2.767481] ohci-pci: OHCI PCI platform driver
[    2.767536] ohci-platform: OHCI generic platform driver
[    2.767862] ohci-platform fe3a0000.usb: Generic Platform OHCI controller
[    2.767881] ohci-platform fe3a0000.usb: new USB bus registered, assigned bus number 2
[    2.768013] ohci-platform fe3a0000.usb: irq 31, io mem 0xfe3a0000
[    2.830010] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.09
[    2.830019] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    2.830028] usb usb2: Product: Generic Platform OHCI controller
[    2.830036] usb usb2: Manufacturer: Linux 5.9.14-rockchip64 ohci_hcd
[    2.830043] usb usb2: SerialNumber: fe3a0000.usb
[    2.830551] hub 2-0:1.0: USB hub found
[    2.830591] hub 2-0:1.0: 1 port detected
[    2.832160] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller
[    2.832185] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 3
[    2.832363] xhci-hcd xhci-hcd.0.auto: hcc params 0x0220fe64 hci version 0x110 quirks 0x0000000002010010
[    2.832431] xhci-hcd xhci-hcd.0.auto: irq 228, io mem 0xfe900000
[    2.832863] usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.09
[    2.832872] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    2.832881] usb usb3: Product: xHCI Host Controller
[    2.832888] usb usb3: Manufacturer: Linux 5.9.14-rockchip64 xhci-hcd
[    2.832895] usb usb3: SerialNumber: xhci-hcd.0.auto
[    2.833408] hub 3-0:1.0: USB hub found
[    2.833448] hub 3-0:1.0: 1 port detected
[    2.833832] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller
[    2.833855] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 4
[    2.833871] xhci-hcd xhci-hcd.0.auto: Host supports USB 3.0 SuperSpeed
[    2.833954] usb usb4: We don't know the algorithms for LPM for this host, disabling LPM.
[    2.834097] usb usb4: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.09
[    2.834106] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    2.834114] usb usb4: Product: xHCI Host Controller
[    2.834121] usb usb4: Manufacturer: Linux 5.9.14-rockchip64 xhci-hcd
[    2.834128] usb usb4: SerialNumber: xhci-hcd.0.auto
[    2.834620] hub 4-0:1.0: USB hub found
[    2.834657] hub 4-0:1.0: 1 port detected
[    2.835181] usbcore: registered new interface driver usb-storage
[    2.837791] mousedev: PS/2 mouse device common for all mice
[    2.839213] i2c /dev entries driver
[    2.843173] pca953x 2-0020: using no AI
[    2.852873] rk808 0-001b: chip id: 0x0
[    2.856764] rk808-regulator rk808-regulator: there is no dvs0 gpio
[    2.856793] rk808-regulator rk808-regulator: there is no dvs1 gpio
[    2.857973] vdd_center: supplied by vcc5v0_sys
[    2.858619] vdd_cpu_l: supplied by vcc5v0_sys
[    2.858972] vcc_ddr_s3: supplied by vcc5v0_sys
[    2.859632] vcc1v8_sys_s3: supplied by vcc5v0_sys
[    2.860128] vcc1v8_dvp: supplied by vcc5v0_sys
[    2.860642] vcc3v0_touch: supplied by vcc5v0_sys
[    2.862116] vcc1v8_s3: supplied by vcc5v0_sys
[    2.862403] vcc_sdio_s0: Bringing 3300000uV into 3000000-3000000uV
[    2.863569] vcc_sdio_s0: supplied by vcc5v0_sys
[    2.864111] vcca3v0_codec: supplied by vcc5v0_sys
[    2.865298] vcc1v5_s3: supplied by vcc5v0_sys
[    2.865833] vcca1v8_codec: supplied by vcc5v0_sys
[    2.867032] vcc3v0_s3: supplied by vcc5v0_sys
[    2.867178] vcc3v3_sys_s0: failed to get the current voltage(-517)
[    2.867197] vcc3v3_sys_s0: supplied by vcc3v3_sys_s3
[    2.867738] vcc3v3_s0: supplied by vcc3v3_sys_s3
[    2.871456] rk808-rtc rk808-rtc: registered as rtc0
[    2.872022] rk808-rtc rk808-rtc: setting system clock to 2020-12-16T13:47:24 UTC (1608126444)
[    2.875124] fan53555-regulator 0-0040: FAN53555 Option[8] Rev[1] Detected!
[    2.876231] vcc1v8_sys_s0: supplied by vcc1v8_sys_s3
[    2.876322] avdd_0v9_s0: supplied by vcc1v8_sys_s3
[    2.876423] vdd_cpu_b: supplied by vcc5v0_sys
[    2.879498] fan53555-regulator 0-0041: FAN53555 Option[8] Rev[1] Detected!
[    2.880621] vdd_gpu: supplied by vcc5v0_sys
[    2.890060] dw_wdt ff848000.watchdog: No valid TOPs array specified
[    2.891953] sdhci: Secure Digital Host Controller Interface driver
[    2.891959] sdhci: Copyright(c) Pierre Ossman
[    2.891985] Synopsys Designware Multimedia Card Interface Driver
[    2.893672] dwmmc_rockchip fe320000.mmc: IDMAC supports 32-bit address mode.
[    2.893702] dwmmc_rockchip fe320000.mmc: Using internal DMA controller.
[    2.893717] dwmmc_rockchip fe320000.mmc: Version ID is 270a
[    2.893828] dwmmc_rockchip fe320000.mmc: DW MMC controller at irq 28,32 bit host data width,256 deep fifo
[    2.894325] dwmmc_rockchip fe320000.mmc: Got CD GPIO
[    2.907228] mmc_host mmc0: Bus speed (slot 0) = 400000Hz (slot req 400000Hz, actual 400000HZ div = 0)
[    2.920858] sdhci-pltfm: SDHCI platform and OF driver helper
[    2.922747] mmc1: CQHCI version 5.10
[    2.928022] random: fast init done
[    2.946986] mmc1: SDHCI controller on fe330000.sdhci [fe330000.sdhci] using ADMA
[    2.951382] ledtrig-cpu: registered to indicate activity on CPUs
[    2.952573] hid: raw HID events driver (C) Jiri Kosina
[    2.952716] usbcore: registered new interface driver usbhid
[    2.952721] usbhid: USB HID core driver
[    2.958819] drop_monitor: Initializing network drop monitor service
[    2.959710] NET: Registered protocol family 10
[    2.969415] mmc_host mmc0: Bus speed (slot 0) = 148500000Hz (slot req 150000000Hz, actual 148500000HZ div = 0)
[    3.023180] mmc1: Command Queue Engine enabled
[    3.023200] mmc1: new HS200 MMC card at address 0001
[    3.024438] mmcblk1: mmc1:0001 AJTD4R 14.6 GiB 
[    3.024707] mmcblk1boot0: mmc1:0001 AJTD4R partition 1 4.00 MiB
[    3.024853] Segment Routing with IPv6
[    3.024960] mmcblk1boot1: mmc1:0001 AJTD4R partition 2 4.00 MiB
[    3.025030] NET: Registered protocol family 17
[    3.025150] mmcblk1rpmb: mmc1:0001 AJTD4R partition 3 4.00 MiB, chardev (243:0)
[    3.025305] 8021q: 802.1Q VLAN Support v1.8
[    3.025430] Key type dns_resolver registered
[    3.026487] registered taskstats version 1
[    3.026506] Loading compiled-in X.509 certificates
[    3.032278] Loaded X.509 cert 'Build time autogenerated kernel key: dccf44bd6a6a6c80c8ebb43ecbfc03e645b516d0'
[    3.032529] zswap: loaded using pool lzo/zbud
[    3.033015] Key type ._fscrypt registered
[    3.033022] Key type .fscrypt registered
[    3.033027] Key type fscrypt-provisioning registered
[    3.036135] Btrfs loaded, crc32c=crc32c-generic
[    3.062738] Key type encrypted registered
[    3.062757] AppArmor: AppArmor sha1 policy hashing enabled
[    3.113343] rockchip-pcie f8000000.pcie: host bridge /pcie@f8000000 ranges:
[    3.113392] rockchip-pcie f8000000.pcie:      MEM 0x00fa000000..0x00fbdfffff -> 0x00fa000000
[    3.113413] rockchip-pcie f8000000.pcie:       IO 0x00fbe00000..0x00fbefffff -> 0x00fbe00000
[    3.158655] dwmmc_rockchip fe320000.mmc: Successfully tuned phase to 215
[    3.158681] mmc0: new ultra high speed SDR104 SDHC card at address 1234
[    3.159899] mmcblk0: mmc0:1234 SA16G 14.4 GiB 
[    3.162284]  mmcblk0: p1
[    3.165782] usb 3-1: new high-speed USB device number 2 using xhci-hcd
[    3.171089] rockchip-pcie f8000000.pcie: PCI host bridge to bus 0000:00
[    3.171103] pci_bus 0000:00: root bus resource [bus 00-1f]
[    3.171111] pci_bus 0000:00: root bus resource [mem 0xfa000000-0xfbdfffff]
[    3.171122] pci_bus 0000:00: root bus resource [io  0x0000-0xfffff] (bus address [0xfbe00000-0xfbefffff])
[    3.171177] pci 0000:00:00.0: [1d87:0100] type 01 class 0x060400
[    3.171327] pci 0000:00:00.0: supports D1
[    3.171335] pci 0000:00:00.0: PME# supported from D0 D1 D3hot
[    3.176912] pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring
[    3.177170] pci 0000:01:00.0: [197b:0585] type 00 class 0x010601
[    3.177240] pci 0000:01:00.0: reg 0x10: initial BAR value 0x00000000 invalid
[    3.177249] pci 0000:01:00.0: reg 0x10: [io  size 0x0080]
[    3.177285] pci 0000:01:00.0: reg 0x14: initial BAR value 0x00000000 invalid
[    3.177293] pci 0000:01:00.0: reg 0x14: [io  size 0x0080]
[    3.177327] pci 0000:01:00.0: reg 0x18: initial BAR value 0x00000000 invalid
[    3.177334] pci 0000:01:00.0: reg 0x18: [io  size 0x0080]
[    3.177369] pci 0000:01:00.0: reg 0x1c: initial BAR value 0x00000000 invalid
[    3.177376] pci 0000:01:00.0: reg 0x1c: [io  size 0x0080]
[    3.177410] pci 0000:01:00.0: reg 0x20: initial BAR value 0x00000000 invalid
[    3.177417] pci 0000:01:00.0: reg 0x20: [io  size 0x0080]
[    3.177452] pci 0000:01:00.0: reg 0x24: [mem 0x00000000-0x00001fff]
[    3.177487] pci 0000:01:00.0: reg 0x30: [mem 0x00000000-0x0000ffff pref]
[    3.177526] pci 0000:01:00.0: Max Payload Size set to 256 (was 128, max 512)
[    3.177869] pci 0000:01:00.0: PME# supported from D3hot
[    3.178116] pci 0000:01:00.0: 8.000 Gb/s available PCIe bandwidth, limited by 5.0 GT/s PCIe x2 link at 0000:00:00.0 (capable of 15.752 Gb/s with 8.0 GT/s PCIe x2 link)
[    3.183466] pci_bus 0000:01: busn_res: [bus 01-1f] end is updated to 01
[    3.183495] pci 0000:00:00.0: BAR 14: assigned [mem 0xfa000000-0xfa0fffff]
[    3.183518] pci 0000:01:00.0: BAR 6: assigned [mem 0xfa000000-0xfa00ffff pref]
[    3.183528] pci 0000:01:00.0: BAR 5: assigned [mem 0xfa010000-0xfa011fff]
[    3.183548] pci 0000:01:00.0: BAR 0: no space for [io  size 0x0080]
[    3.183556] pci 0000:01:00.0: BAR 0: failed to assign [io  size 0x0080]
[    3.183563] pci 0000:01:00.0: BAR 1: no space for [io  size 0x0080]
[    3.183571] pci 0000:01:00.0: BAR 1: failed to assign [io  size 0x0080]
[    3.183578] pci 0000:01:00.0: BAR 2: no space for [io  size 0x0080]
[    3.183585] pci 0000:01:00.0: BAR 2: failed to assign [io  size 0x0080]
[    3.183592] pci 0000:01:00.0: BAR 3: no space for [io  size 0x0080]
[    3.183599] pci 0000:01:00.0: BAR 3: failed to assign [io  size 0x0080]
[    3.183606] pci 0000:01:00.0: BAR 4: no space for [io  size 0x0080]
[    3.183613] pci 0000:01:00.0: BAR 4: failed to assign [io  size 0x0080]
[    3.183625] pci 0000:00:00.0: PCI bridge to [bus 01]
[    3.183638] pci 0000:00:00.0:   bridge window [mem 0xfa000000-0xfa0fffff]
[    3.183879] pcieport 0000:00:00.0: enabling device (0000 -> 0002)
[    3.184193] pcieport 0000:00:00.0: PME: Signaling with IRQ 239
[    3.184529] pcieport 0000:00:00.0: AER: enabled with IRQ 239
[    3.184900] ahci 0000:01:00.0: version 3.0
[    3.184924] ahci 0000:01:00.0: enabling device (0000 -> 0002)
[    3.185489] ahci 0000:01:00.0: SSS flag set, parallel bus scan disabled
[    3.185589] ahci 0000:01:00.0: AHCI 0001.0301 32 slots 5 ports 6 Gbps 0x1f impl SATA mode
[    3.185601] ahci 0000:01:00.0: flags: 64bit ncq sntf stag pm led clo pmp fbs pio slum part ccc apst boh 
[    3.189459] scsi host0: ahci
[    3.190176] scsi host1: ahci
[    3.190740] scsi host2: ahci
[    3.191289] scsi host3: ahci
[    3.191848] scsi host4: ahci
[    3.192075] ata1: SATA max UDMA/133 abar m8192@0xfa010000 port 0xfa010100 irq 240
[    3.192085] ata2: SATA max UDMA/133 abar m8192@0xfa010000 port 0xfa010180 irq 241
[    3.192093] ata3: SATA max UDMA/133 abar m8192@0xfa010000 port 0xfa010200 irq 242
[    3.192102] ata4: SATA max UDMA/133 abar m8192@0xfa010000 port 0xfa010280 irq 243
[    3.192110] ata5: SATA max UDMA/133 abar m8192@0xfa010000 port 0xfa010300 irq 244
[    3.198524] input: gpio-keys as /devices/platform/gpio-keys/input/input0
[    3.199279] of_cfs_init
[    3.199335] of_cfs_init: OK
[    3.315743] usb 3-1: New USB device found, idVendor=2109, idProduct=2815, bcdDevice= 7.04
[    3.315754] usb 3-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[    3.315762] usb 3-1: Product: USB2.0 Hub             
[    3.315770] usb 3-1: Manufacturer: VIA Labs, Inc.         
[    3.378237] hub 3-1:1.0: USB hub found
[    3.378373] hub 3-1:1.0: 4 ports detected
[    3.442015] usb 4-1: new SuperSpeed Gen 1 USB device number 2 using xhci-hcd
[    3.592997] usb 4-1: New USB device found, idVendor=2109, idProduct=0815, bcdDevice= 7.04
[    3.593009] usb 4-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[    3.593017] usb 4-1: Product: USB3.0 Hub             
[    3.593025] usb 4-1: Manufacturer: VIA Labs, Inc.         
[    3.618251] hub 4-1:1.0: USB hub found
[    3.618455] hub 4-1:1.0: 4 ports detected
[    3.665808] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[    3.677650] ata1.00: ATA-8: SanDisk SDSSDX240GG25, R201, max UDMA/133
[    3.677661] ata1.00: 468862128 sectors, multi 16: LBA48 NCQ (depth 32), AA
[    3.687657] ata1.00: configured for UDMA/133
[    3.688465] scsi 0:0:0:0: Direct-Access     ATA      SanDisk SDSSDX24 R201 PQ: 0 ANSI: 5
[    3.690125] sd 0:0:0:0: [sda] 468862128 512-byte logical blocks: (240 GB/224 GiB)
[    3.690178] sd 0:0:0:0: [sda] Write Protect is off
[    3.690188] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[    3.690270] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    3.694672] sd 0:0:0:0: [sda] Attached SCSI disk
[    4.201773] usb 3-1.4: new high-speed USB device number 3 using xhci-hcd
[    5.013880] usb 4-1.4: new SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[    5.034936] usb 4-1.4: New USB device found, idVendor=0bda, idProduct=8156, bcdDevice=30.00
[    5.034949] usb 4-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=6
[    5.034959] usb 4-1.4: Product: USB 10/100/1G/2.5G LAN
[    5.034969] usb 4-1.4: Manufacturer: Realtek
[    5.034979] usb 4-1.4: SerialNumber: 000000001
[    8.841802] ata2: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[    8.862267] ata2.00: ATA-10: ST4000VN008-2DR166, SC60, max UDMA/133
[    8.862279] ata2.00: 7814037168 sectors, multi 0: LBA48 NCQ (depth 32), AA
[    8.863796] ata2.00: configured for UDMA/133
[    8.864424] scsi 1:0:0:0: Direct-Access     ATA      ST4000VN008-2DR1 SC60 PQ: 0 ANSI: 5
[    8.865909] sd 1:0:0:0: [sdb] 7814037168 512-byte logical blocks: (4.00 TB/3.64 TiB)
[    8.865924] sd 1:0:0:0: [sdb] 4096-byte physical blocks
[    8.866019] sd 1:0:0:0: [sdb] Write Protect is off
[    8.866034] sd 1:0:0:0: [sdb] Mode Sense: 00 3a 00 00
[    8.866188] sd 1:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    8.897056] sd 1:0:0:0: [sdb] Attached SCSI disk
[    9.341782] ata3: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[    9.343538] ata3.00: ATA-10: ST4000VN008-2DR166, SC60, max UDMA/133
[    9.343550] ata3.00: 7814037168 sectors, multi 0: LBA48 NCQ (depth 32), AA
[    9.345106] ata3.00: configured for UDMA/133
[    9.345549] scsi 2:0:0:0: Direct-Access     ATA      ST4000VN008-2DR1 SC60 PQ: 0 ANSI: 5
[    9.346932] sd 2:0:0:0: [sdc] 7814037168 512-byte logical blocks: (4.00 TB/3.64 TiB)
[    9.346946] sd 2:0:0:0: [sdc] 4096-byte physical blocks
[    9.347034] sd 2:0:0:0: [sdc] Write Protect is off
[    9.347049] sd 2:0:0:0: [sdc] Mode Sense: 00 3a 00 00
[    9.347201] sd 2:0:0:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    9.377822] sd 2:0:0:0: [sdc] Attached SCSI disk
[    9.821789] ata4: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[    9.832775] ata4.00: ATA-10: ST4000VN008-2DR166, SC60, max UDMA/133
[    9.832784] ata4.00: 7814037168 sectors, multi 0: LBA48 NCQ (depth 32), AA
[    9.834274] ata4.00: configured for UDMA/133
[    9.834710] scsi 3:0:0:0: Direct-Access     ATA      ST4000VN008-2DR1 SC60 PQ: 0 ANSI: 5
[    9.835839] sd 3:0:0:0: [sdd] 7814037168 512-byte logical blocks: (4.00 TB/3.64 TiB)
[    9.835849] sd 3:0:0:0: [sdd] 4096-byte physical blocks
[    9.835899] sd 3:0:0:0: [sdd] Write Protect is off
[    9.835908] sd 3:0:0:0: [sdd] Mode Sense: 00 3a 00 00
[    9.835989] sd 3:0:0:0: [sdd] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    9.865923] sd 3:0:0:0: [sdd] Attached SCSI disk
[   10.309800] ata5: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[   10.318352] ata5.00: ATA-10: ST4000VN008-2DR166, SC60, max UDMA/133
[   10.318363] ata5.00: 7814037168 sectors, multi 0: LBA48 NCQ (depth 32), AA
[   10.319870] ata5.00: configured for UDMA/133
[   10.320226] scsi 4:0:0:0: Direct-Access     ATA      ST4000VN008-2DR1 SC60 PQ: 0 ANSI: 5
[   10.321103] sd 4:0:0:0: [sde] 7814037168 512-byte logical blocks: (4.00 TB/3.64 TiB)
[   10.321113] sd 4:0:0:0: [sde] 4096-byte physical blocks
[   10.321164] sd 4:0:0:0: [sde] Write Protect is off
[   10.321173] sd 4:0:0:0: [sde] Mode Sense: 00 3a 00 00
[   10.321253] sd 4:0:0:0: [sde] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[   10.346249] sd 4:0:0:0: [sde] Attached SCSI disk
[   10.349128] Freeing unused kernel memory: 4224K
[   10.361885] Run /init as init process
[   10.361895]   with arguments:
[   10.361902]     /init
[   10.361908]   with environment:
[   10.361914]     HOME=/
[   10.361920]     TERM=linux
[   10.361926]     ubootpart=de6fa105-01
[   10.361932]     cgroup_enable=memory
[   10.361938]     cgroup_memory=1
[   10.962083] input: adc-keys as /devices/platform/adc-keys/input/input1
[   11.078356] rk_gmac-dwmac fe300000.ethernet: IRQ eth_wake_irq not found
[   11.078374] rk_gmac-dwmac fe300000.ethernet: IRQ eth_lpi not found
[   11.078610] rk_gmac-dwmac fe300000.ethernet: PTP uses main clock
[   11.079078] rk_gmac-dwmac fe300000.ethernet: clock input or output? (input).
[   11.079098] rk_gmac-dwmac fe300000.ethernet: TX delay(0x28).
[   11.079117] rk_gmac-dwmac fe300000.ethernet: RX delay(0x20).
[   11.079141] rk_gmac-dwmac fe300000.ethernet: integrated PHY? (no).
[   11.079257] rk_gmac-dwmac fe300000.ethernet: cannot get clock clk_mac_speed
[   11.079266] rk_gmac-dwmac fe300000.ethernet: clock input from PHY
[   11.084313] rk_gmac-dwmac fe300000.ethernet: init for RGMII
[   11.085442] rk_gmac-dwmac fe300000.ethernet: User ID: 0x10, Synopsys ID: 0x35
[   11.085567] rk_gmac-dwmac fe300000.ethernet: 	DWMAC1000
[   11.085578] rk_gmac-dwmac fe300000.ethernet: DMA HW capability register supported
[   11.085585] rk_gmac-dwmac fe300000.ethernet: RX Checksum Offload Engine supported
[   11.085593] rk_gmac-dwmac fe300000.ethernet: COE Type 2
[   11.085699] rk_gmac-dwmac fe300000.ethernet: TX Checksum insertion supported
[   11.085706] rk_gmac-dwmac fe300000.ethernet: Wake-Up On Lan supported
[   11.085985] rk_gmac-dwmac fe300000.ethernet: Normal descriptors
[   11.085993] rk_gmac-dwmac fe300000.ethernet: Ring mode enabled
[   11.086000] rk_gmac-dwmac fe300000.ethernet: Enable RX Mitigation via HW Watchdog Timer
[   11.236231] libphy: stmmac: probed
[   11.236260] RTL8211F Gigabit Ethernet stmmac-0:00: attached PHY driver [RTL8211F Gigabit Ethernet] (mii_bus:phy_addr=stmmac-0:00, irq=POLL)
[   11.236277] RTL8211F Gigabit Ethernet stmmac-0:01: attached PHY driver [RTL8211F Gigabit Ethernet] (mii_bus:phy_addr=stmmac-0:01, irq=POLL)
[   11.288426] async_tx: api initialized (async)
[   11.336784] md/raid:md0: device sdd operational as raid disk 2
[   11.336797] md/raid:md0: device sde operational as raid disk 3
[   11.336804] md/raid:md0: device sdc operational as raid disk 1
[   11.336812] md/raid:md0: device sdb operational as raid disk 0
[   11.345878] md/raid:md0: raid level 5 active with 4 out of 4 devices, algorithm 2
[   11.394248] md0: detected capacity change from 0 to 12001955020800
[   11.493573] random: crng init done
[   12.174480] EXT4-fs (mmcblk0p1): mounted filesystem with writeback data mode. Opts: (null)
[   12.817889] systemd[1]: Inserted module 'autofs4'
[   12.860088] systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid)
[   12.861016] systemd[1]: Detected architecture arm64.
[   12.893962] systemd[1]: Set hostname to <helios64>.
[   13.042843] dw-apb-uart ff1a0000.serial: forbid DMA for kernel console
[   13.364223] systemd[1]: /lib/systemd/system/smbd.service:9: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/smbd.pid → /run/samba/smbd.pid; please update the unit file accordingly.
[   13.383429] systemd[1]: /lib/systemd/system/nmbd.service:9: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/nmbd.pid → /run/samba/nmbd.pid; please update the unit file accordingly.
[   13.395772] systemd[1]: /lib/systemd/system/rpc-statd.service:13: PIDFile= references path below legacy directory /var/run/, updating /var/run/rpc.statd.pid → /run/rpc.statd.pid; please update the unit file accordingly.
[   13.438835] systemd[1]: /lib/systemd/system/fancontrol.service:9: PIDFile= references path below legacy directory /var/run/, updating /var/run/fancontrol.pid → /run/fancontrol.pid; please update the unit file accordingly.
[   13.443631] systemd[1]: Configuration file /root/dmsetup_suspend.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   13.457423] systemd[1]: /lib/systemd/system/apcupsd.service:10: PIDFile= references path below legacy directory /var/run/, updating /var/run/apcupsd.pid → /run/apcupsd.pid; please update the unit file accordingly.
[   13.549098] systemd[1]: Listening on Journal Socket (/dev/log).
[   13.703875] lm75 2-004c: hwmon2: sensor 'lm75'
[   13.720946] EXT4-fs (mmcblk0p1): re-mounted. Opts: commit=600,errors=remount-ro
[   13.803796] RPC: Registered named UNIX socket transport module.
[   13.803807] RPC: Registered udp transport module.
[   13.803812] RPC: Registered tcp transport module.
[   13.803819] RPC: Registered tcp NFSv4.1 backchannel transport module.
[   13.910853] Installing knfsd (copyright (C) 1996 okir@monad.swb.de).
[   14.515206] input: beeper as /devices/platform/beeper/input/input2
[   14.598575] sd 0:0:0:0: Attached scsi generic sg0 type 0
[   14.598703] sd 1:0:0:0: Attached scsi generic sg1 type 0
[   14.598815] sd 2:0:0:0: Attached scsi generic sg2 type 0
[   14.598911] sd 3:0:0:0: Attached scsi generic sg3 type 0
[   14.599051] sd 4:0:0:0: Attached scsi generic sg4 type 0
[   14.659869] mc: Linux media interface: v0.10
[   14.709898] videodev: Linux video capture interface: v2.00
[   14.769705] rockchip-vop ff8f0000.vop: Adding to iommu group 2
[   14.772812] rockchip-vop ff900000.vop: Adding to iommu group 3
[   14.781206] panfrost ff9a0000.gpu: clock rate = 500000000
[   14.783385] panfrost ff9a0000.gpu: mali-t860 id 0x860 major 0x2 minor 0x0 status 0x0
[   14.783395] panfrost ff9a0000.gpu: features: 00000000,100e77bf, issues: 00000000,24040400
[   14.783403] panfrost ff9a0000.gpu: Features: L2:0x07120206 Shader:0x00000000 Tiler:0x00000809 Mem:0x1 MMU:0x00002830 AS:0xff JS:0x7
[   14.783411] panfrost ff9a0000.gpu: shader_present=0xf l2_present=0x1
[   14.792846] [drm] Initialized panfrost 1.1.0 20180908 for ff9a0000.gpu on minor 0
[   14.898386] rockchip_vdec: module is from the staging directory, the quality is unknown, you have been warned.
[   14.913334] hantro_vpu: module is from the staging directory, the quality is unknown, you have been warned.
[   14.918332] rkvdec ff660000.video-codec: Adding to iommu group 1
[   14.918682] rockchip-rga ff680000.rga: HW Version: 0x03.02
[   14.919282] rockchip-rga ff680000.rga: Registered rockchip-rga as /dev/video0
[   14.934069] hantro-vpu ff650000.video-codec: Adding to iommu group 0
[   14.936261] OF: graph: no port node found in /i2c@ff3d0000/typec-portc@22
[   14.936672] hantro-vpu ff650000.video-codec: registered rockchip,rk3399-vpu-enc as /dev/video2
[   14.936928] hantro-vpu ff650000.video-codec: registered rockchip,rk3399-vpu-dec as /dev/video3
[   14.946006] rockchip-drm display-subsystem: bound ff8f0000.vop (ops vop_component_ops [rockchipdrm])
[   14.946181] [drm] unsupported AFBC format[3231564e]
[   14.948061] rockchip-drm display-subsystem: bound ff900000.vop (ops vop_component_ops [rockchipdrm])
[   14.948422] rockchip-drm display-subsystem: bound fec00000.dp (ops cdn_dp_component_ops [rockchipdrm])
[   14.954453] rockchip-drm display-subsystem: [drm] Cannot find any crtc or sizes
[   14.955063] [drm] Initialized rockchip 1.0.0 20140818 for display-subsystem on minor 1
[   14.959704] cdn-dp fec00000.dp: [drm:cdn_dp_pd_event_work [rockchipdrm]] Not connected. Disabling cdn
[   14.960677] OF: graph: no port node found in /syscon@ff770000/usb2-phy@e450/otg-port
[   14.962177] xhci-hcd xhci-hcd.3.auto: xHCI Host Controller
[   14.962215] xhci-hcd xhci-hcd.3.auto: new USB bus registered, assigned bus number 5
[   14.962396] xhci-hcd xhci-hcd.3.auto: hcc params 0x0220fe64 hci version 0x110 quirks 0x0000000002010010
[   14.962431] xhci-hcd xhci-hcd.3.auto: irq 227, io mem 0xfe800000
[   14.962931] usb usb5: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.09
[   14.962939] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[   14.962943] usb usb5: Product: xHCI Host Controller
[   14.962948] usb usb5: Manufacturer: Linux 5.9.14-rockchip64 xhci-hcd
[   14.962953] usb usb5: SerialNumber: xhci-hcd.3.auto
[   14.963596] hub 5-0:1.0: USB hub found
[   14.963645] hub 5-0:1.0: 1 port detected
[   14.964053] xhci-hcd xhci-hcd.3.auto: xHCI Host Controller
[   14.964074] xhci-hcd xhci-hcd.3.auto: new USB bus registered, assigned bus number 6
[   14.964099] xhci-hcd xhci-hcd.3.auto: Host supports USB 3.0 SuperSpeed
[   14.964211] usb usb6: We don't know the algorithms for LPM for this host, disabling LPM.
[   14.964353] usb usb6: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.09
[   14.964359] usb usb6: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[   14.964364] usb usb6: Product: xHCI Host Controller
[   14.964368] usb usb6: Manufacturer: Linux 5.9.14-rockchip64 xhci-hcd
[   14.964373] usb usb6: SerialNumber: xhci-hcd.3.auto
[   14.964999] hub 6-0:1.0: USB hub found
[   14.965041] hub 6-0:1.0: 1 port detected
[   15.154779] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[   15.263245] cdn-dp fec00000.dp: [drm:cdn_dp_pd_event_work [rockchipdrm]] Not connected. Disabling cdn
[   15.298249] r8152 4-1.4:1.0 (unnamed net_device) (uninitialized): netif_napi_add() called with weight 256
[   15.313874] r8152 4-1.4:1.0 eth1: v2.14.0 (2020/09/24)
[   15.313880] r8152 4-1.4:1.0 eth1: This product is covered by one or more of the following patents:
               		US6,570,884, US6,115,776, and US6,327,625.

[   15.313973] usbcore: registered new interface driver r8152
[   15.456169] device-mapper: uevent: version 1.0.3
[   15.456545] device-mapper: ioctl: 4.42.0-ioctl (2020-02-27) initialised: dm-devel@redhat.com
[   15.514003] cdn-dp fec00000.dp: [drm:cdn_dp_pd_event_work [rockchipdrm]] Not connected. Disabling cdn
[   15.871608] zram: Added device: zram0
[   15.872087] zram: Added device: zram1
[   15.872664] zram: Added device: zram2
[   15.935912] zram1: detected capacity change from 0 to 1992257536
[   15.969900] rockchip-drm display-subsystem: [drm] Cannot find any crtc or sizes
[   16.081867] Adding 1945560k swap on /dev/zram1.  Priority:5 extents:1 across:1945560k SSFS
[   16.244152] zram0: detected capacity change from 0 to 52428800
[   16.372359] EXT4-fs (zram0): mounted filesystem without journal. Opts: discard
[   16.372394] ext4 filesystem being mounted at /var/log supports timestamps until 2038 (0x7fffffff)
[   16.441908] cdn-dp fec00000.dp: [drm:cdn_dp_pd_event_work [rockchipdrm]] Not connected. Disabling cdn
[   19.785695] systemd[1]: Started Armbian memory supported logging.
[   19.793446] systemd[1]: Starting Journal Service...
[   19.956463] systemd[1]: Started Journal Service.
[   20.013935] systemd-journald[761]: Received request to flush runtime journal from PID 1
[   25.517531] capability: warning: `zerotier-one' uses 32-bit capabilities (legacy support in use)
[   26.546417] rk_gmac-dwmac fe300000.ethernet eth0: PHY [stmmac-0:00] driver [RTL8211F Gigabit Ethernet] (irq=POLL)
[   26.557798] rk_gmac-dwmac fe300000.ethernet eth0: No Safety Features support found
[   26.557818] rk_gmac-dwmac fe300000.ethernet eth0: PTP not supported by HW
[   26.558387] rk_gmac-dwmac fe300000.ethernet eth0: configuring for phy/rgmii link mode
[   26.771057] IPv6: ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready
[   26.771315] r8152 4-1.4:1.0 eth1: carrier on
[   27.054585] device-mapper: cache: Origin device (md0) discard unsupported: Disabling discard passdown.
[   27.654701] EXT4-fs (dm-2): mounted filesystem with ordered data mode. Opts: (null)
[   31.966589] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
[   31.977374] Bridge firewalling registered
[   32.669227] 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.
[   32.698657] NFSD: Using UMH upcall client tracking operations.
[   32.698670] NFSD: starting 90-second grace period (net f00000a1)
[   32.883937] Initializing XFRM netlink socket
[   33.761681] vcc5v0_typec: disabling
[  499.791454] ------------[ cut here ]------------
[  499.791502] NETDEV WATCHDOG: eth1 (r8152): transmit queue 0 timed out
[  499.791610] WARNING: CPU: 4 PID: 0 at net/sched/sch_generic.c:443 dev_watchdog+0x3a4/0x3b0
[  499.791618] Modules linked in: xt_MASQUERADE nf_conntrack_netlink xfrm_user xfrm_algo xt_addrtype br_netfilter bridge nf_conntrack_netbios_ns nf_conntrack_broadcast xt_CT xt_tcpudp ip6t_rpfilter ip6t_REJECT nf_reject_ipv6 ipt_REJECT nf_reject_ipv4 xt_conntrack nft_counter nft_chain_nat nf_nat nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 dm_cache_smq dm_cache dm_persistent_data dm_bio_prison dm_bufio governor_performance rfkill ip6_tables nft_compat nf_tables nfnetlink zstd zram dm_multipath dm_mod snd_soc_hdmi_codec r8152 hantro_vpu(C) snd_soc_rockchip_i2s fusb302 rockchip_vdec(C) rockchip_rga snd_soc_core tcpm v4l2_h264 snd_pcm_dmaengine leds_pwm videobuf2_dma_contig typec videobuf2_vmalloc v4l2_mem2mem pwm_fan videobuf2_dma_sg snd_pcm gpio_charger panfrost snd_timer rockchipdrm videobuf2_memops snd gpu_sched videobuf2_v4l2 dw_mipi_dsi videobuf2_common dw_hdmi analogix_dp videodev soundcore drm_kms_helper mc cec rc_core sg drm drm_panel_orientation_quirks gpio_beeper cpufreq_dt nfsd
[  499.791838]  auth_rpcgss nfs_acl lockd grace sunrpc ledtrig_netdev lm75 ip_tables x_tables autofs4 raid10 raid1 raid0 multipath linear raid456 async_raid6_recov async_memcpy async_pq async_xor async_tx realtek md_mod dwmac_rk stmmac_platform stmmac mdio_xpcs adc_keys
[  499.791922] CPU: 4 PID: 0 Comm: swapper/4 Tainted: G         C        5.9.14-rockchip64 #20.11.4
[  499.791929] Hardware name: Helios64 (DT)
[  499.791942] pstate: 80000005 (Nzcv daif -PAN -UAO BTYPE=--)
[  499.791957] pc : dev_watchdog+0x3a4/0x3b0
[  499.791969] lr : dev_watchdog+0x3a4/0x3b0
[  499.791976] sp : ffff800011afbd50
[  499.791983] x29: ffff800011afbd50 x28: ffff0000e5399c80 
[  499.791996] x27: 0000000000000004 x26: 0000000000000140 
[  499.792008] x25: 00000000ffffffff x24: 0000000000000004 
[  499.792019] x23: ffff800011837000 x22: ffff0000e511f41c 
[  499.792030] x21: ffff0000e511f000 x20: ffff0000e511f4c0 
[  499.792040] x19: 0000000000000000 x18: ffff80001185e000 
[  499.792050] x17: 0000000000000000 x16: 0000000000000000 
[  499.792060] x15: 00000000fffffff0 x14: ffff800011a481fa 
[  499.792070] x13: 0000000000000000 x12: ffff800011a47000 
[  499.792080] x11: ffff80001185e000 x10: ffff800011a47840 
[  499.792091] x9 : 0000000000000000 x8 : 0000000000000001 
[  499.792101] x7 : 00000000000002a5 x6 : 0000000000000003 
[  499.792111] x5 : 0000000000000000 x4 : 0000000000000000 
[  499.792121] x3 : 0000000000000103 x2 : 0000000000000102 
[  499.792131] x1 : 80ea77f8a2bb5b00 x0 : 0000000000000000 
[  499.792143] Call trace:
[  499.792157]  dev_watchdog+0x3a4/0x3b0
[  499.792176]  call_timer_fn+0x30/0x1f0
[  499.792188]  run_timer_softirq+0x288/0x530
[  499.792200]  efi_header_end+0x160/0x3f4
[  499.792213]  irq_exit+0xb8/0xd8
[  499.792226]  __handle_domain_irq+0x98/0x108
[  499.792241]  gic_handle_irq+0xc8/0x170
[  499.792251]  el1_irq+0xb8/0x180
[  499.792265]  arch_cpu_idle+0x14/0x20
[  499.792277]  do_idle+0x1fc/0x270
[  499.792289]  cpu_startup_entry+0x24/0x60
[  499.792304]  secondary_start_kernel+0x16c/0x180
[  499.792312] ---[ end trace 4f600d2e827c80b3 ]---
[  499.792336] r8152 4-1.4:1.0 eth1: Tx timeout
[  499.795155] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16744648 in event trb
[  499.795222] r8152 4-1.4:1.0 eth1: Tx status -2
[  499.795408] r8152 4-1.4:1.0 eth1: Tx status -2
[  499.795674] r8152 4-1.4:1.0 eth1: Tx status -2
[  499.795916] r8152 4-1.4:1.0 eth1: Tx status -2
[  501.970527] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[ 1005.888048] r8152 4-1.4:1.0 eth1: Tx timeout
[ 1005.890955] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16740552 in event trb
[ 1005.891140] r8152 4-1.4:1.0 eth1: Tx status -2
[ 1005.891311] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16740552 in event trb
[ 1005.891356] r8152 4-1.4:1.0 eth1: Tx status -2
[ 1005.891524] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16740552 in event trb
[ 1005.891587] r8152 4-1.4:1.0 eth1: Tx status -2
[ 1005.891723] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16740552 in event trb
[ 1005.891770] r8152 4-1.4:1.0 eth1: Tx status -2
[ 1008.018532] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[ 1107.772955] r8152 4-1.4:1.0 eth1: Tx timeout
[ 1107.775819] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16721096 in event trb
[ 1107.775885] r8152 4-1.4:1.0 eth1: Tx status -2
[ 1107.776067] r8152 4-1.4:1.0 eth1: Tx status -2
[ 1107.776282] r8152 4-1.4:1.0 eth1: Tx status -2
[ 1107.776437] r8152 4-1.4:1.0 eth1: Tx status -2
[ 1109.869763] r8152 4-1.4:1.0 eth1: get_registers -71
[ 1109.869879] r8152 4-1.4:1.0 eth1: get_registers -71
[ 1109.869989] r8152 4-1.4:1.0 eth1: get_registers -71
[ 1109.970529] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[ 1747.753501] r8152 4-1.4:1.0 eth1: Tx timeout
[ 1747.755940] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[ 1747.755980] r8152 4-1.4:1.0 eth1: Tx status -2
[ 1747.756042] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[ 1747.756059] r8152 4-1.4:1.0 eth1: Tx status -2
[ 1747.756142] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[ 1747.756170] r8152 4-1.4:1.0 eth1: Tx status -2
[ 1747.756218] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[ 1747.756232] r8152 4-1.4:1.0 eth1: Tx status -2
[ 1749.906512] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[ 1896.742174] r8152 4-1.4:1.0 eth1: Tx timeout
[ 1896.745023] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16725408 in event trb
[ 1896.745104] r8152 4-1.4:1.0 eth1: Tx status -2
[ 1896.745307] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16725408 in event trb
[ 1896.745362] r8152 4-1.4:1.0 eth1: Tx status -2
[ 1896.745577] r8152 4-1.4:1.0 eth1: Tx status -2
[ 1896.745816] r8152 4-1.4:1.0 eth1: Tx status -2
[ 1898.930590] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[ 2067.745288] r8152 4-1.4:1.0 eth1: Tx timeout
[ 2067.748216] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16752840 in event trb
[ 2067.748392] r8152 4-1.4:1.0 eth1: Tx status -2
[ 2067.748559] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16752840 in event trb
[ 2067.748606] r8152 4-1.4:1.0 eth1: Tx status -2
[ 2067.748758] r8152 4-1.4:1.0 eth1: Tx status -2
[ 2067.748926] r8152 4-1.4:1.0 eth1: Tx status -2
[ 2069.839672] r8152 4-1.4:1.0 eth1: get_registers -71
[ 2069.839767] r8152 4-1.4:1.0 eth1: get_registers -71
[ 2069.938511] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[ 7815.571217] nfsd: last server has exited, flushing export cache
[ 7816.835261] NFSD: Using UMH upcall client tracking operations.
[ 7816.835278] NFSD: starting 90-second grace period (net f00000a1)
[ 9459.522074] r8152 4-1.4:1.0 eth1: Tx timeout
[ 9459.524590] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16742600 in event trb
[ 9459.524617] r8152 4-1.4:1.0 eth1: Tx status -2
[ 9459.524684] r8152 4-1.4:1.0 eth1: Tx status -2
[ 9459.524752] r8152 4-1.4:1.0 eth1: Tx status -2
[ 9459.524797] r8152 4-1.4:1.0 eth1: Tx status -2
[ 9461.650367] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[ 9613.629441] r8152 4-1.4:1.0 eth1: Tx timeout
[ 9613.631842] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16741576 in event trb
[ 9613.631871] r8152 4-1.4:1.0 eth1: Tx status -2
[ 9613.631935] r8152 4-1.4:1.0 eth1: Tx status -2
[ 9613.632016] r8152 4-1.4:1.0 eth1: Tx status -2
[ 9613.632124] r8152 4-1.4:1.0 eth1: Tx status -2
[ 9615.794083] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[ 9794.616020] r8152 4-1.4:1.0 eth1: Tx timeout
[ 9794.618433] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16739540 in event trb
[ 9794.618530] r8152 4-1.4:1.0 eth1: Tx status -2
[ 9794.618576] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16739540 in event trb
[ 9794.618606] r8152 4-1.4:1.0 eth1: Tx status -2
[ 9794.618658] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16739540 in event trb
[ 9794.618673] r8152 4-1.4:1.0 eth1: Tx status -2
[ 9794.618756] r8152 4-1.4:1.0 eth1: Tx status -2
[ 9796.786078] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[10234.113888] xhci-hcd xhci-hcd.0.auto: WARN Successful completion on short TX
[10234.113919] xhci-hcd xhci-hcd.0.auto: WARN Successful completion on short TX
[10234.113971] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 3 comp_code 1
[10234.113976] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e415bd30 trb-start 00000000e415bf00 trb-end 0000000000000000 seg-start 00000000e415b000 seg-end 00000000e415bff0
[10234.113979] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e415bd30 trb-start 00000000e4177000 trb-end 00000000e41770a0 seg-start 00000000e4177000 seg-end 00000000e4177ff0
[10242.602585] r8152 4-1.4:1.0 eth1: Tx timeout
[10242.604502] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16755622 in event trb
[10242.604587] r8152 4-1.4:1.0 eth1: Tx status -2
[10242.604651] r8152 4-1.4:1.0 eth1: Tx status -2
[10242.604731] r8152 4-1.4:1.0 eth1: Tx status -2
[10242.604777] r8152 4-1.4:1.0 eth1: Tx status -2
[10244.786079] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[10365.478928] r8152 4-1.4:1.0 eth1: Tx timeout
[10365.483403] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[10365.483465] r8152 4-1.4:1.0 eth1: Tx status -2
[10365.483544] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[10365.483616] r8152 4-1.4:1.0 eth1: Tx status -2
[10365.483809] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[10365.483866] r8152 4-1.4:1.0 eth1: Tx status -2
[10365.484148] r8152 4-1.4:1.0 eth1: Tx status -2
[10367.634072] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[11800.315724] r8152 4-1.4:1.0 eth1: Tx timeout
[11800.318219] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[11800.318303] r8152 4-1.4:1.0 eth1: Tx status -2
[11800.318368] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[11800.318387] r8152 4-1.4:1.0 eth1: Tx status -2
[11800.318440] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[11800.318469] r8152 4-1.4:1.0 eth1: Tx status -2
[11800.318520] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[11800.318534] r8152 4-1.4:1.0 eth1: Tx status -2
[11802.450068] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[11816.443256] r8152 4-1.4:1.0 eth1: Tx timeout
[11816.445942] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16742600 in event trb
[11816.445974] r8152 4-1.4:1.0 eth1: Tx status -2
[11816.446009] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16742600 in event trb
[11816.446037] r8152 4-1.4:1.0 eth1: Tx status -2
[11816.446083] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16742600 in event trb
[11816.446102] r8152 4-1.4:1.0 eth1: Tx status -2
[11816.446149] r8152 4-1.4:1.0 eth1: Tx status -2
[11818.578307] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[12738.527425] r8152 4-1.4:1.0 eth1: Tx timeout
[12738.529907] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16735432 in event trb
[12738.529933] r8152 4-1.4:1.0 eth1: Tx status -2
[12738.530054] r8152 4-1.4:1.0 eth1: Tx status -2
[12738.530095] r8152 4-1.4:1.0 eth1: Tx status -2
[12738.530137] r8152 4-1.4:1.0 eth1: Tx status -2
[12740.577717] r8152 4-1.4:1.0 eth1: get_registers -71
[12740.577849] r8152 4-1.4:1.0 eth1: get_registers -71
[12740.577975] r8152 4-1.4:1.0 eth1: get_registers -71
[12740.578101] r8152 4-1.4:1.0 eth1: get_registers -71
[12740.578218] r8152 4-1.4:1.0 eth1: get_registers -71
[12740.580079] r8152 4-1.4:1.0 eth1: get_registers -71
[12740.580201] r8152 4-1.4:1.0 eth1: get_registers -71
[12740.580320] r8152 4-1.4:1.0 eth1: get_registers -71
[12740.580432] r8152 4-1.4:1.0 eth1: get_registers -71
[12740.580555] r8152 4-1.4:1.0 eth1: get_registers -71
[12740.580681] r8152 4-1.4:1.0 eth1: get_registers -71
[12740.580806] r8152 4-1.4:1.0 eth1: get_registers -71
[12740.580936] r8152 4-1.4:1.0 eth1: get_registers -71
[12740.658486] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[13314.510082] r8152 4-1.4:1.0 eth1: Tx timeout
[13314.512482] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16737480 in event trb
[13314.512507] r8152 4-1.4:1.0 eth1: Tx status -2
[13314.512576] r8152 4-1.4:1.0 eth1: Tx status -2
[13314.512656] r8152 4-1.4:1.0 eth1: Tx status -2
[13314.512703] r8152 4-1.4:1.0 eth1: Tx status -2
[13316.690101] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[14003.385406] r8152 4-1.4:1.0 eth1: Tx timeout
[14003.388132] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16722120 in event trb
[14003.388287] r8152 4-1.4:1.0 eth1: Tx status -2
[14003.388398] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16722120 in event trb
[14003.388448] r8152 4-1.4:1.0 eth1: Tx status -2
[14003.388584] r8152 4-1.4:1.0 eth1: Tx status -2
[14003.388687] r8152 4-1.4:1.0 eth1: Tx status -2
[14005.586470] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[16424.304689] r8152 4-1.4:1.0 eth1: Tx timeout
[16424.307092] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16763080 in event trb
[16424.307118] r8152 4-1.4:1.0 eth1: Tx status -2
[16424.307151] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16763080 in event trb
[16424.307180] r8152 4-1.4:1.0 eth1: Tx status -2
[16424.307261] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16763080 in event trb
[16424.307278] r8152 4-1.4:1.0 eth1: Tx status -2
[16424.307312] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16763080 in event trb
[16424.307327] r8152 4-1.4:1.0 eth1: Tx status -2
[16426.482501] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[17304.150205] r8152 4-1.4:1.0 eth1: Tx timeout
[17304.152615] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16741576 in event trb
[17304.152645] r8152 4-1.4:1.0 eth1: Tx status -2
[17304.152685] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16741576 in event trb
[17304.152713] r8152 4-1.4:1.0 eth1: Tx status -2
[17304.152772] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16741576 in event trb
[17304.152786] r8152 4-1.4:1.0 eth1: Tx status -2
[17304.152870] r8152 4-1.4:1.0 eth1: Tx status -2
[17306.290551] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[17453.393722] r8152 4-1.4:1.0 eth1: Tx timeout
[17453.396195] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[17453.396291] r8152 4-1.4:1.0 eth1: Tx status -2
[17453.396348] r8152 4-1.4:1.0 eth1: Tx status -2
[17453.396428] r8152 4-1.4:1.0 eth1: Tx status -2
[17453.396468] r8152 4-1.4:1.0 eth1: Tx status -2
[17455.538465] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[17570.382239] r8152 4-1.4:1.0 eth1: Tx timeout
[17570.385212] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[17570.385418] r8152 4-1.4:1.0 eth1: Tx status -2
[17570.385636] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[17570.385708] r8152 4-1.4:1.0 eth1: Tx status -2
[17570.385853] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[17570.385909] r8152 4-1.4:1.0 eth1: Tx status -2
[17570.386096] r8152 4-1.4:1.0 eth1: Tx status -2
[17572.530534] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[18184.251741] r8152 4-1.4:1.0 eth1: Tx timeout
[18184.254967] r8152 4-1.4:1.0 eth1: Tx status -2
[18184.255004] r8152 4-1.4:1.0 eth1: Tx status -2
[18184.255045] r8152 4-1.4:1.0 eth1: Tx status -2
[18184.255086] r8152 4-1.4:1.0 eth1: Tx status -2
[18186.418229] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[18856.231542] r8152 4-1.4:1.0 eth1: Tx timeout
[18856.234400] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16744352 in event trb
[18856.234562] r8152 4-1.4:1.0 eth1: Tx status -2
[18856.234722] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16744352 in event trb
[18856.234785] r8152 4-1.4:1.0 eth1: Tx status -2
[18856.234958] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16744352 in event trb
[18856.235003] r8152 4-1.4:1.0 eth1: Tx status -2
[18856.235127] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16744352 in event trb
[18856.235180] r8152 4-1.4:1.0 eth1: Tx status -2
[18858.418457] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[18931.237277] r8152 4-1.4:1.0 eth1: Tx timeout
[18931.240277] r8152 4-1.4:1.0 eth1: Tx status -2
[18931.240416] r8152 4-1.4:1.0 eth1: Tx status -2
[18931.240620] r8152 4-1.4:1.0 eth1: Tx status -2
[18931.240877] r8152 4-1.4:1.0 eth1: Tx status -2
[18933.426490] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[19074.336972] r8152 4-1.4:1.0 eth1: Tx timeout
[19074.339918] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16713940 in event trb
[19074.340110] r8152 4-1.4:1.0 eth1: Tx status -2
[19074.340269] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16713940 in event trb
[19074.340315] r8152 4-1.4:1.0 eth1: Tx status -2
[19074.340473] r8152 4-1.4:1.0 eth1: Tx status -2
[19074.340723] r8152 4-1.4:1.0 eth1: Tx status -2
[19076.498049] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[19549.202652] r8152 4-1.4:1.0 eth1: Tx timeout
[19549.205057] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743636 in event trb
[19549.205143] r8152 4-1.4:1.0 eth1: Tx status -2
[19549.205207] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743636 in event trb
[19549.205225] r8152 4-1.4:1.0 eth1: Tx status -2
[19549.205262] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743636 in event trb
[19549.205290] r8152 4-1.4:1.0 eth1: Tx status -2
[19549.205353] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743636 in event trb
[19549.205367] r8152 4-1.4:1.0 eth1: Tx status -2
[19551.346505] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[19661.327279] r8152 4-1.4:1.0 eth1: Tx timeout
[19661.329791] r8152 4-1.4:1.0 eth1: Tx status -2
[19661.329881] r8152 4-1.4:1.0 eth1: Tx status -2
[19661.329938] r8152 4-1.4:1.0 eth1: Tx status -2
[19661.330020] r8152 4-1.4:1.0 eth1: Tx status -2
[19663.474046] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[19800.075133] r8152 4-1.4:1.0 eth1: Tx timeout
[19800.078147] r8152 4-1.4:1.0 eth1: Tx status -2
[19800.078242] r8152 4-1.4:1.0 eth1: Tx status -2
[19800.078331] r8152 4-1.4:1.0 eth1: Tx status -2
[19800.078564] r8152 4-1.4:1.0 eth1: Tx status -2
[19802.226085] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[19997.189196] r8152 4-1.4:1.0 eth1: Tx timeout
[19997.191733] r8152 4-1.4:1.0 eth1: Tx status -2
[19997.191812] r8152 4-1.4:1.0 eth1: Tx status -2
[19997.191863] r8152 4-1.4:1.0 eth1: Tx status -2
[19997.191920] r8152 4-1.4:1.0 eth1: Tx status -2
[19999.346446] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[20031.681867] xhci-hcd xhci-hcd.0.auto: WARN Successful completion on short TX
[20031.681896] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 3 comp_code 1
[20031.681901] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e415b6f0 trb-start 00000000e415b8c0 trb-end 00000000e415bcb0 seg-start 00000000e415b000 seg-end 00000000e415bff0
[20031.682017] xhci-hcd xhci-hcd.0.auto: WARN Successful completion on short TX
[20031.682090] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 3 comp_code 1
[20031.682093] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e415bcb0 trb-start 00000000e415bcc0 trb-end 0000000000000000 seg-start 00000000e415b000 seg-end 00000000e415bff0
[20031.682097] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e415bcb0 trb-start 00000000e4177000 trb-end 00000000e4177020 seg-start 00000000e4177000 seg-end 00000000e4177ff0
[20056.067402] r8152 4-1.4:1.0 eth1: Tx timeout
[20056.069896] r8152 4-1.4:1.0 eth1: Tx status -2
[20056.069933] r8152 4-1.4:1.0 eth1: Tx status -2
[20056.069974] r8152 4-1.4:1.0 eth1: Tx status -2
[20056.070018] r8152 4-1.4:1.0 eth1: Tx status -2
[20058.194452] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[20069.777866] xhci-hcd xhci-hcd.0.auto: WARN Successful completion on short TX
[20069.777880] xhci-hcd xhci-hcd.0.auto: WARN Successful completion on short TX
[20069.777946] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 3 comp_code 1
[20069.777951] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e415b860 trb-start 00000000e415ba30 trb-end 00000000e415bbe0 seg-start 00000000e415b000 seg-end 00000000e415bff0
[20069.778067] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 3 comp_code 1
[20069.778071] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e415bc60 trb-start 00000000e415ba30 trb-end 00000000e415bbe0 seg-start 00000000e415b000 seg-end 00000000e415bff0
[20069.778202] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 3 comp_code 1
[20069.778205] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e415bfe0 trb-start 00000000e415ba30 trb-end 00000000e415bbe0 seg-start 00000000e415b000 seg-end 00000000e415bff0
[20069.778423] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 3 comp_code 1
[20069.778427] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e41773e0 trb-start 00000000e415ba30 trb-end 00000000e415bbe0 seg-start 00000000e415b000 seg-end 00000000e415bff0
[20069.778731] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 3 comp_code 1
[20069.778733] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e4177770 trb-start 00000000e415ba30 trb-end 00000000e415bbe0 seg-start 00000000e415b000 seg-end 00000000e415bff0
[20093.186289] r8152 4-1.4:1.0 eth1: Tx timeout
[20093.188823] r8152 4-1.4:1.0 eth1: Tx status -2
[20093.188890] r8152 4-1.4:1.0 eth1: Tx status -2
[20093.188964] r8152 4-1.4:1.0 eth1: Tx status -2
[20093.189031] r8152 4-1.4:1.0 eth1: Tx status -2
[20095.314555] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[20179.199698] r8152 4-1.4:1.0 eth1: Tx timeout
[20179.202177] r8152 4-1.4:1.0 eth1: Tx status -2
[20179.202248] r8152 4-1.4:1.0 eth1: Tx status -2
[20179.202312] r8152 4-1.4:1.0 eth1: Tx status -2
[20179.202358] r8152 4-1.4:1.0 eth1: Tx status -2
[20181.330446] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[20211.198759] r8152 4-1.4:1.0 eth1: Tx timeout
[20211.201673] r8152 4-1.4:1.0 eth1: Tx status -2
[20211.201847] r8152 4-1.4:1.0 eth1: Tx status -2
[20211.202047] r8152 4-1.4:1.0 eth1: Tx status -2
[20211.202183] r8152 4-1.4:1.0 eth1: Tx status -2
[20213.330452] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[20669.168959] r8152 4-1.4:1.0 eth1: Tx timeout
[20669.171386] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[20669.171467] r8152 4-1.4:1.0 eth1: Tx status -2
[20669.171548] r8152 4-1.4:1.0 eth1: Tx status -2
[20669.171635] r8152 4-1.4:1.0 eth1: Tx status -2
[20669.171718] r8152 4-1.4:1.0 eth1: Tx status -2
[20671.216547] r8152 4-1.4:1.0 eth1: get_registers -71
[20671.216687] r8152 4-1.4:1.0 eth1: get_registers -71
[20671.216820] r8152 4-1.4:1.0 eth1: get_registers -71
[20671.217067] r8152 4-1.4:1.0 eth1: get_registers -71
[20671.217207] r8152 4-1.4:1.0 eth1: get_registers -71
[20671.314492] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[21011.174689] r8152 4-1.4:1.0 eth1: Tx timeout
[21011.176792] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16714964 in event trb
[21011.176893] r8152 4-1.4:1.0 eth1: Tx status -2
[21011.177053] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16714964 in event trb
[21011.177103] r8152 4-1.4:1.0 eth1: Tx status -2
[21011.177269] r8152 4-1.4:1.0 eth1: Tx status -2
[21011.177565] r8152 4-1.4:1.0 eth1: Tx status -2
[21013.298039] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[21395.163139] r8152 4-1.4:1.0 eth1: Tx timeout
[21395.166191] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16739528 in event trb
[21395.166243] r8152 4-1.4:1.0 eth1: Tx status -2
[21395.166358] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16739528 in event trb
[21395.166420] r8152 4-1.4:1.0 eth1: Tx status -2
[21395.166556] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16739528 in event trb
[21395.166598] r8152 4-1.4:1.0 eth1: Tx status -2
[21395.166723] r8152 4-1.4:1.0 eth1: Tx status -2
[21397.362442] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[21406.641858] xhci-hcd xhci-hcd.0.auto: WARN Successful completion on short TX
[21406.641888] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 3 comp_code 1
[21406.641892] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e4177d30 trb-start 00000000e4177cc0 trb-end 00000000e4177ce0 seg-start 00000000e4177000 seg-end 00000000e4177ff0
[21406.673527] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 3 comp_code 1
[21406.673534] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e415b0e0 trb-start 00000000e4177cc0 trb-end 00000000e4177ce0 seg-start 00000000e4177000 seg-end 00000000e4177ff0
[21406.673537] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 3 comp_code 1
[21406.673540] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e415b120 trb-start 00000000e4177cc0 trb-end 00000000e4177ce0 seg-start 00000000e4177000 seg-end 00000000e4177ff0
[21406.675504] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 3 comp_code 1
[21406.675510] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e415b510 trb-start 00000000e4177cc0 trb-end 00000000e4177ce0 seg-start 00000000e4177000 seg-end 00000000e4177ff0
[21432.026005] r8152 4-1.4:1.0 eth1: Tx timeout
[21432.028571] r8152 4-1.4:1.0 eth1: Tx status -2
[21432.028636] r8152 4-1.4:1.0 eth1: Tx status -2
[21432.028696] r8152 4-1.4:1.0 eth1: Tx status -2
[21432.028769] r8152 4-1.4:1.0 eth1: Tx status -2
[21434.194044] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[21651.041857] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 3 comp_code 1
[21651.041865] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e4178090 trb-start 00000000e4177f80 trb-end 0000000000000000 seg-start 00000000e4177000 seg-end 00000000e4177ff0
[21651.041868] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e4178090 trb-start 00000000e415b000 trb-end 00000000e415b370 seg-start 00000000e415b000 seg-end 00000000e415bff0
[21651.041886] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 3 comp_code 1
[21651.041890] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e41781b0 trb-start 00000000e4177f80 trb-end 0000000000000000 seg-start 00000000e4177000 seg-end 00000000e4177ff0
[21651.041892] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e41781b0 trb-start 00000000e415b000 trb-end 00000000e415b370 seg-start 00000000e415b000 seg-end 00000000e415bff0
[21661.139135] r8152 4-1.4:1.0 eth1: Tx timeout
[21661.142193] r8152 4-1.4:1.0 eth1: Tx status -2
[21661.142408] r8152 4-1.4:1.0 eth1: Tx status -2
[21661.142597] r8152 4-1.4:1.0 eth1: Tx status -2
[21661.142763] r8152 4-1.4:1.0 eth1: Tx status -2
[21663.346451] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[21837.261828] r8152 4-1.4:1.0 eth1: Tx timeout
[21837.264673] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[21837.264738] r8152 4-1.4:1.0 eth1: Tx status -2
[21837.264868] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[21837.264930] r8152 4-1.4:1.0 eth1: Tx status -2
[21837.265104] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[21837.265151] r8152 4-1.4:1.0 eth1: Tx status -2
[21837.265323] r8152 4-1.4:1.0 eth1: Tx status -2
[21839.442435] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[23437.213727] r8152 4-1.4:1.0 eth1: Tx timeout
[23437.216643] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[23437.216697] r8152 4-1.4:1.0 eth1: Tx status -2
[23437.216838] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[23437.216900] r8152 4-1.4:1.0 eth1: Tx status -2
[23437.217056] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[23437.217117] r8152 4-1.4:1.0 eth1: Tx status -2
[23437.217264] r8152 4-1.4:1.0 eth1: Tx status -2
[23439.346040] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[24040.075606] r8152 4-1.4:1.0 eth1: Tx timeout
[24040.078037] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[24040.078076] r8152 4-1.4:1.0 eth1: Tx status -2
[24040.078138] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[24040.078154] r8152 4-1.4:1.0 eth1: Tx status -2
[24040.078259] r8152 4-1.4:1.0 eth1: Tx status -2
[24040.078338] r8152 4-1.4:1.0 eth1: Tx status -2
[24042.194030] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[24275.076578] r8152 4-1.4:1.0 eth1: Tx timeout
[24275.079484] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16728264 in event trb
[24275.079548] r8152 4-1.4:1.0 eth1: Tx status -2
[24275.079683] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16728264 in event trb
[24275.079746] r8152 4-1.4:1.0 eth1: Tx status -2
[24275.080031] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16728264 in event trb
[24275.080081] r8152 4-1.4:1.0 eth1: Tx status -2
[24275.080221] r8152 4-1.4:1.0 eth1: Tx status -2
[24277.234024] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[24595.066928] r8152 4-1.4:1.0 eth1: Tx timeout
[24595.070159] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[24595.070191] r8152 4-1.4:1.0 eth1: Tx status -2
[24595.070230] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[24595.070258] r8152 4-1.4:1.0 eth1: Tx status -2
[24595.070367] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[24595.070383] r8152 4-1.4:1.0 eth1: Tx status -2
[24595.070463] r8152 4-1.4:1.0 eth1: Tx status -2
[24597.234025] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[25395.042881] r8152 4-1.4:1.0 eth1: Tx timeout
[25395.045721] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[25395.045785] r8152 4-1.4:1.0 eth1: Tx status -2
[25395.046028] r8152 4-1.4:1.0 eth1: Tx status -2
[25395.046206] r8152 4-1.4:1.0 eth1: Tx status -2
[25395.046337] r8152 4-1.4:1.0 eth1: Tx status -2
[25397.234259] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[28519.940881] r8152 4-1.4:1.0 eth1: Tx timeout
[28519.943303] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[28519.943329] r8152 4-1.4:1.0 eth1: Tx status -2
[28519.943366] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[28519.943385] r8152 4-1.4:1.0 eth1: Tx status -2
[28519.943430] r8152 4-1.4:1.0 eth1: Tx status -2
[28519.943478] r8152 4-1.4:1.0 eth1: Tx status -2
[28522.098240] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[28534.817830] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 3 comp_code 1
[28534.817837] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e4177570 trb-start 00000000e4177460 trb-end 00000000e4177470 seg-start 00000000e4177000 seg-end 00000000e4177ff0
[28534.817862] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 3 comp_code 1
[28534.817865] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e4177690 trb-start 00000000e4177460 trb-end 00000000e4177470 seg-start 00000000e4177000 seg-end 00000000e4177ff0
[28534.817869] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 3 comp_code 1
[28534.817872] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e41776b0 trb-start 00000000e4177460 trb-end 00000000e4177470 seg-start 00000000e4177000 seg-end 00000000e4177ff0
[28534.817903] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 3 comp_code 1
[28534.817906] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e4177820 trb-start 00000000e4177460 trb-end 00000000e4177470 seg-start 00000000e4177000 seg-end 00000000e4177ff0
[28534.818063] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 3 comp_code 1
[28534.818066] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000e4177b80 trb-start 00000000e4177460 trb-end 00000000e4177470 seg-start 00000000e4177000 seg-end 00000000e4177ff0
[28540.932229] r8152 4-1.4:1.0 eth1: Tx timeout
[28540.934684] r8152 4-1.4:1.0 eth1: Tx status -2
[28540.934725] r8152 4-1.4:1.0 eth1: Tx status -2
[28540.934816] r8152 4-1.4:1.0 eth1: Tx status -2
[28540.934874] r8152 4-1.4:1.0 eth1: Tx status -2
[28543.090018] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[28636.929342] r8152 4-1.4:1.0 eth1: Tx timeout
[28636.931827] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[28636.931853] r8152 4-1.4:1.0 eth1: Tx status -2
[28636.931920] r8152 4-1.4:1.0 eth1: Tx status -2
[28636.932034] r8152 4-1.4:1.0 eth1: Tx status -2
[28636.932116] r8152 4-1.4:1.0 eth1: Tx status -2
[28639.090050] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[29229.039559] r8152 4-1.4:1.0 eth1: Tx timeout
[29229.043311] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16739528 in event trb
[29229.043366] r8152 4-1.4:1.0 eth1: Tx status -2
[29229.043474] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16739528 in event trb
[29229.043509] r8152 4-1.4:1.0 eth1: Tx status -2
[29229.043714] r8152 4-1.4:1.0 eth1: Tx status -2
[29229.043840] r8152 4-1.4:1.0 eth1: Tx status -2
[29231.218252] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
[29335.788367] r8152 4-1.4:1.0 eth1: Tx timeout
[29335.791245] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[29335.791405] r8152 4-1.4:1.0 eth1: Tx status -2
[29335.791591] xhci-hcd xhci-hcd.0.auto: bad transfer trb length 16743624 in event trb
[29335.791642] r8152 4-1.4:1.0 eth1: Tx status -2
[29335.791786] r8152 4-1.4:1.0 eth1: Tx status -2
[29335.791963] r8152 4-1.4:1.0 eth1: Tx status -2
[29337.938019] usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd

 

 

I tried to put the output in both spoiler and code. Hope it works.

[DBwpg]

9 hours ago, DBwpg said:

How best create logs?

Sent from my SM-T713 using Tapatalk
 

Ok.  I've rebooted my Helios64 and restarted the rsync job.  Currently running for about 30mins.  Will monitor.  I'm assuming I should have a look at either the messages and kern.log when the job fails?

[gprovost]

8 hours ago, DBwpg said:

Ok.  I've rebooted my Helios64 and restarted the rsync job.  Currently running for about 30mins.  Will monitor.  I'm assuming I should have a look at either the messages and kern.log when the job fails?

 

Ideally you have serial console opened with dmesg -w command running in order to catch any exception in case system freeze.

[DBwpg]

1 hour ago, gprovost said:

 

Ideally you have serial console opened with dmesg -w command running in order to catch any exception in case system freeze.

Thanks.  I've setup a putty serial connection and setup dmesq-w running.  Will see what happens.  The re-established rsync session has been running for the last 14hrs without a hitch so far.  The job is now 44% complete.  Will sit tight to see whether it completes and if not hopefully find something in the logs.

[DBwpg]

2 hours ago, DBwpg said:

Thanks.  I've setup a putty serial connection and setup dmesq-w running.  Will see what happens.  The re-established rsync session has been running for the last 14hrs without a hitch so far.  The job is now 44% complete.  Will sit tight to see whether it completes and if not hopefully find something in the logs.

Ok.  Synch job failed after about 16hrs.  My Qnap reported:

Type    Date    Time    Users    Source IP    Computer name    Content    
Error    2020/12/18    01:42:14    System    127.0.0.1    localhost    [Hybrid Backup Sync] Failed to complete Sync job: "One-way Sync 1". Remote host does not exist.    

 

Have attached dmesg log from Helios64 .  Not sure what to make of it.

dmesg-w output.txt

[clostro]

usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
r8152 4-1.4:1.0 eth1: Tx status -2
r8152 4-1.4:1.0 eth1: Tx timeout

 

I am getting a lot of these in the logs. Sometimes 5 or 6 times in a row. Entire network activity pauses for a few seconds when I get one of these.

Could it be because of a bad cable or something? Helios64 is connected to a Zyxel XGS1010-12 switch on its 2.5gbps ports via a CAT5E 26AWG cable. Cable has metal jacket jacks and everything. I read somewhere that this could be caused by a cable, but this cable was working ok before.

[DBwpg]

On 12/18/2020 at 2:03 AM, DBwpg said:

Ok.  Synch job failed after about 16hrs.  My Qnap reported:

Type    Date    Time    Users    Source IP    Computer name    Content    
Error    2020/12/18    01:42:14    System    127.0.0.1    localhost    [Hybrid Backup Sync] Failed to complete Sync job: "One-way Sync 1". Remote host does not exist.    

 

Have attached dmesg log from Helios64 .  Not sure what to make of it.

dmesg-w output.txt 22.56 kB · 8 downloads

I was able to complete my media file copy from my Qnap server yesterday but thought I would try copy files from the Qnap server to the Helios64 today via Qnap's FileStation service (smb file copy) to the Helios64.  It was an attempt to copy directory structure of approx 95gb.  It appeared to be working but failed halfway thru causing the Helios64 to reboot.  I've included the dmesq-w output.  Not sure what's happening.  Looks like I'll have to consider delaying my migration to the Helios64 until there is a more stable firmware unless someone has some other ideas as to what I should be doing in the way of troubleshooting these issues.

dmesq-w.txt

[DBwpg]

6 hours ago, DBwpg said:

I was able to complete my media file copy from my Qnap server yesterday but thought I would try copy files from the Qnap server to the Helios64 today via Qnap's FileStation service (smb file copy) to the Helios64.  It was an attempt to copy directory structure of approx 95gb.  It appeared to be working but failed halfway thru causing the Helios64 to reboot.  I've included the dmesq-w output.  Not sure what's happening.  Looks like I'll have to consider delaying my migration to the Helios64 until there is a more stable firmware unless someone has some other ideas as to what I should be doing in the way of troubleshooting these issues.

dmesq-w.txt 6.33 kB · 4 downloads

Ok.  Thought I would include the latest dmesq-w log .  Helios64 appeared to reboot and I wasn't able to access the serial/usb console or via ssh.  Had to hard reboot the unit.  I've shut it down for now.  Will wait to see what transpires over the next few firmware updates.

[yay]

I've been having the same issue of eth1 just not working right on a 2.5Gbps link on kernel 5.9.x. The same applies for a self-built 5.10.1 kernel and also when going back to r8152 2.13.0 instead of the default 2.14.0 (by adapting the revision in build/lib/compilation-prepare.sh). With a 1Gbps connection, everything is perfectly fine. This connection speed was "forced" by running "ethtool -s enp6s0 advertise 0x3f" on the desktop side, taking 2.5Gbps out of the advertised speeds for autonegotiation. I have a direct 5m Cat6 connection from my Helios64 to my desktop machine. The latter has a 2.5Gbps RTL8125 on the mainboard, using the vanilla kernel's r8169 module. MTUs were kept on 1500 for all tests.

 

Running the Helios64 on kernel 4.4.213 (via Armbian_20.11.4_Helios64_buster_legacy_4.4.213.img.xz), I was able to transfer 4TiB back and forth in parallel without any issue: Helios64 -> desktop was running with ~1.7Gbps; desktop -> Helios64 was running at ~2.1Gbps. 1.7Gbps aren't great, but ok enough with tx offload disabled - certainly better than "just" 1Gbps (~933, realistically).

 

One surefire way to kill the Helios64's eth1 is to just start a simple iperf3 run with it sending data to my desktop: "iperf -c <desktop-ip> -t 600". After a few seconds, the speed goes down to 0, the kernel watchdog resets the USB device (as per r8152.c's rtl8152_tx_timeout), it recovers for a few more seconds, and then eth1 is absolutely dead until I reboot the entire NAS. No ping, no more connection, nothing.

 

Here's what I can see via journalctl -f from a parallel connection when such a crash happens:

Spoiler

Dec 23 14:04:40 helios64 kernel: ------------[ cut here ]------------
Dec 23 14:04:40 helios64 kernel: NETDEV WATCHDOG: eth1 (r8152): transmit queue 0 timed out
Dec 23 14:04:40 helios64 kernel: WARNING: CPU: 2 PID: 0 at net/sched/sch_generic.c:443 dev_watchdog+0x3a4/0x3b0
Dec 23 14:04:40 helios64 kernel: Modules linked in: rfkill governor_performance zstd r8152 snd_soc_hdmi_codec snd_soc_rockchip_i2s leds_pwm snd_soc_core gpio_charger snd_pcm_dmaengine snd_pcm pwm_fan panfrost snd_timer fusb302 hantro_vpu
(C) snd rockchip_rga tcpm gpu_sched soundcore videobuf2_dma_sg rockchip_vdec(C) typec v4l2_h264 videobuf2_dma_contig videobuf2_vmalloc v4l2_mem2mem videobuf2_memops videobuf2_v4l2 videobuf2_common rockchipdrm videodev dw_mipi_dsi mc dw_h
dmi analogix_dp drm_kms_helper cec rc_core drm drm_panel_orientation_quirks gpio_beeper cpufreq_dt zram lm75 ip_tables x_tables autofs4 raid10 raid456 async_raid6_recov async_memcpy async_pq async_xor async_tx raid1 raid0 multipath linea
r md_mod realtek dwmac_rk stmmac_platform stmmac mdio_xpcs adc_keys
Dec 23 14:04:40 helios64 kernel: CPU: 2 PID: 0 Comm: swapper/2 Tainted: G         C        5.9.14-rockchip64 #20.11.4
Dec 23 14:04:40 helios64 kernel: Hardware name: Helios64 (DT)
Dec 23 14:04:40 helios64 kernel: pstate: 80000005 (Nzcv daif -PAN -UAO BTYPE=--)
Dec 23 14:04:40 helios64 kernel: pc : dev_watchdog+0x3a4/0x3b0
Dec 23 14:04:40 helios64 kernel: lr : dev_watchdog+0x3a4/0x3b0
Dec 23 14:04:40 helios64 kernel: sp : ffff800011aebd50
Dec 23 14:04:40 helios64 kernel: x29: ffff800011aebd50 x28: ffff0000e416ce80  
Dec 23 14:04:40 helios64 kernel: x27: 0000000000000004 x26: 0000000000000140  
Dec 23 14:04:40 helios64 kernel: x25: 00000000ffffffff x24: 0000000000000002  
Dec 23 14:04:40 helios64 kernel: x23: ffff800011837000 x22: ffff0000e518341c  
Dec 23 14:04:40 helios64 kernel: x21: ffff0000e5183000 x20: ffff0000e51834c0  
Dec 23 14:04:40 helios64 kernel: x19: 0000000000000000 x18: ffff80001185e000  
Dec 23 14:04:40 helios64 kernel: x17: 0000000000000000 x16: 0000000000000000  
Dec 23 14:04:40 helios64 kernel: x15: 00000000fffffff0 x14: ffff800011a481fa  
Dec 23 14:04:40 helios64 kernel: x13: 0000000000000000 x12: ffff800011a47000  
Dec 23 14:04:40 helios64 kernel: x11: ffff80001185e000 x10: ffff800011a47840  
Dec 23 14:04:40 helios64 kernel: x9 : 0000000000000000 x8 : 0000000000000001  
Dec 23 14:04:40 helios64 kernel: x7 : 000000000000025f x6 : 0000000000000003  
Dec 23 14:04:40 helios64 kernel: x5 : 0000000000000000 x4 : 0000000000000000  
Dec 23 14:04:40 helios64 kernel: x3 : 0000000000000103 x2 : 0000000000000102  
Dec 23 14:04:40 helios64 kernel: x1 : a4a5cc1e1e74e600 x0 : 0000000000000000  
Dec 23 14:04:40 helios64 kernel: Call trace:
Dec 23 14:04:40 helios64 kernel:  dev_watchdog+0x3a4/0x3b0
Dec 23 14:04:40 helios64 kernel:  call_timer_fn+0x30/0x1f0
Dec 23 14:04:40 helios64 kernel:  run_timer_softirq+0x288/0x530
Dec 23 14:04:40 helios64 kernel:  efi_header_end+0x160/0x3f4
Dec 23 14:04:40 helios64 kernel:  irq_exit+0xb8/0xd8
Dec 23 14:04:40 helios64 kernel:  __handle_domain_irq+0x98/0x108
Dec 23 14:04:40 helios64 kernel:  gic_handle_irq+0xc8/0x170
Dec 23 14:04:40 helios64 kernel:  el1_irq+0xb8/0x180
Dec 23 14:04:40 helios64 kernel:  arch_cpu_idle+0x14/0x20
Dec 23 14:04:40 helios64 kernel:  do_idle+0x1fc/0x270
Dec 23 14:04:40 helios64 kernel:  cpu_startup_entry+0x28/0x60
Dec 23 14:04:40 helios64 kernel:  secondary_start_kernel+0x16c/0x180
Dec 23 14:04:40 helios64 kernel: ---[ end trace acf8e3657d519935 ]---
Dec 23 14:04:40 helios64 kernel: r8152 4-1.4:1.0 eth1: Tx timeout
Dec 23 14:04:40 helios64 kernel: r8152 4-1.4:1.0 eth1: Tx status -2
Dec 23 14:04:40 helios64 kernel: r8152 4-1.4:1.0 eth1: Tx status -2
Dec 23 14:04:40 helios64 kernel: r8152 4-1.4:1.0 eth1: Tx status -2
Dec 23 14:04:40 helios64 kernel: r8152 4-1.4:1.0 eth1: Tx status -2
Dec 23 14:04:42 helios64 kernel: usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd

 

If there are any more logs you'd need or software changes to try and apply, I'd be eager to dig deeper.

[clostro]

On 12/19/2020 at 7:20 PM, clostro said:

usb 4-1.4: reset SuperSpeed Gen 1 USB device number 3 using xhci-hcd
r8152 4-1.4:1.0 eth1: Tx status -2
r8152 4-1.4:1.0 eth1: Tx timeout

 

I am getting a lot of these in the logs. Sometimes 5 or 6 times in a row. Entire network activity pauses for a few seconds when I get one of these.

Could it be because of a bad cable or something? Helios64 is connected to a Zyxel XGS1010-12 switch on its 2.5gbps ports via a CAT5E 26AWG cable. Cable has metal jacket jacks and everything. I read somewhere that this could be caused by a cable, but this cable was working ok before.

 

user@helios64:~$ uname -a
Linux helios64 5.9.14-rockchip64 #20.11.4 SMP PREEMPT Tue Dec 15 08:52:20 CET 2020 aarch64 GNU/Linux

Well it isn't the cable... tried over the network disk benchmark again with a new cable (the supplied short black network cable, no metal jacket), and temporarily lost eth1 during the test again. Excuse my ignorance for I'm not an expert at any rate but could this behavior be due to any overheating of RTL8156 or VL815 chips? Could be that the thermal paste/pad isn't making enough contact on some units, which would be a very easy fix. 

It only starts happening under heavy load and not right away.

 

Unless I'm way off base and the devs have already figured it out as a software issue.

 

 

edit: upon further testing i can say that temporary disconnects appear to happen less often with the new cable. i don't know what to think anymore

 

 

Edited December 25, 2020 by clostro

[heri410]

I have the same Problem but only under heavy load.

[Zageron]

fwiw I've stopped using the 2.5gbe interface until this disconnection issue is resolved.

[clostro]

Well I did a fresh install of Armbian_20.11.6_Helios64_buster_current_5.9.14.img (didn't try to update) and hammered the disks and 2.5g network for about a day now and no tx resets or timeouts happened at all. No disconnects or hang ups.