[FS#1200] ar71xx/mikrotik: RB951G-2HnD boot loop

Thu Nov 30 14:18:04 PST 2017

A new Flyspray task has been opened.  Details are below. 

User who did this - João Chainho (joaochainho) 

Attached to Project - LEDE Project
Summary - ar71xx/mikrotik: RB951G-2HnD boot loop
Task Type - Bug Report
Category - Kernel
Status - Unconfirmed
Assigned To - 
Operating System - All
Severity - High
Priority - Very Low
Reported Version - Trunk
Due in Version - Undecided
Due Date - Undecided
Details - MikroTik RB951G-2HnD enters in boot loop with recent snapshots. Tested with 2017-11-30 snapshot.
I remember that the router was running fine already with kernel 4.9 builds.
Also tested a custom build (r5442-b0b289e) but switched back to kernel 4.4, was it works fine.
Maybe it is worth mentioning that the same build/snapshot works fine with other MikroTik routers (RB951Ui-2nD).

OpenWrt kernel loader for AR7XXX/AR9XXX
Copyright (C) 2011 Gabor Juhos 
Decompressing kernel... done!
Starting kernel at 80060000...

[    0.000000] Linux version 4.9.65 (buildbot at builds) (gcc version 5.5.0 (LEDE GCC 5.5.0 r5387-370ce1f) ) #0 Fri Nov 24 12:09:11 2017
[    0.000000] bootconsole [early0] enabled
[    0.000000] CPU0 revision is: 0001974c (MIPS 74Kc)
[    0.000000] SoC: Atheros AR9344 rev 2
[    0.000000] Determined physical RAM map:
[    0.000000]  memory: 08000000 @ 00000000 (usable)
[    0.000000] User-defined physical RAM map:
[    0.000000]  memory: 08000000 @ 00000000 (usable)
[    0.000000] Initrd not found or empty - disabling initrd
[    0.000000] OF: fdt:No valid device tree found, continuing without
[    0.000000] Primary instruction cache 64kB, VIPT, 4-way, linesize 32 bytes.
[    0.000000] Primary data cache 32kB, 4-way, VIPT, cache aliases, linesize 32 bytes
[    0.000000] Zone ranges:
[    0.000000]   Normal   [mem 0x0000000000000000-0x0000000007ffffff]
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000000000-0x0000000007ffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x0000000007ffffff]
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 32512
[    0.000000] Kernel command line: no-uart parts=1 boot_part_size=4194304 gpio=216619 HZ=300000000 mem=128M kmac=D4:CA:6D:93:00:98 board=951G boot=0 mlc=4 console=ttyS0,115200 rootfstype=squashfs noinitrd
[    0.000000] PID hash table entries: 512 (order: -1, 2048 bytes)
[    0.000000] Dentry cache hash table entries: 16384 (order: 4, 65536 bytes)
[    0.000000] Inode-cache hash table entries: 8192 (order: 3, 32768 bytes)
[    0.000000] Writing ErrCtl register=00000000
[    0.000000] Readback ErrCtl register=00000000
[    0.000000] Memory: 122432K/131072K available (3732K kernel code, 164K rwdata, 896K rodata, 2048K init, 222K bss, 8640K reserved, 0K cma-reserved)
[    0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.000000] NR_IRQS:51
[    0.000000] Clocks: CPU:600.000MHz, DDR:450.000MHz, AHB:200.000MHz, Ref:25.000MHz
[    0.000000] clocksource: MIPS: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 6370868154 ns
[    0.000008] sched_clock: 32 bits at 300MHz, resolution 3ns, wraps every 7158278654ns
[    0.008860] Calibrating delay loop... 299.82 BogoMIPS (lpj=1499136)
[    0.081948] pid_max: default: 32768 minimum: 301
[    0.087288] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.094803] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.105267] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.116453] futex hash table entries: 256 (order: -1, 3072 bytes)
[    0.124482] NET: Registered protocol family 16
[    0.131083] MIPS: machine is MikroTik RouterBOARD 951G-2HnD
[    0.400011] clocksource: Switched to clocksource MIPS
[    0.406754] NET: Registered protocol family 2
[    0.412588] TCP established hash table entries: 1024 (order: 0, 4096 bytes)
[    0.420546] TCP bind hash table entries: 1024 (order: 0, 4096 bytes)
[    0.427766] TCP: Hash tables configured (established 1024 bind 1024)
[    0.435076] UDP hash table entries: 256 (order: 0, 4096 bytes)
[    0.441747] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
[    0.449094] NET: Registered protocol family 1
[    2.570025] random: fast init done
[    2.738294] Crashlog allocated RAM at address 0x3f00000
[    2.745294] workingset: timestamp_bits=30 max_order=15 bucket_order=0
[    2.759509] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    2.766172] jffs2: version 2.2 (NAND) (SUMMARY) (LZMA) (RTIME) (CMODE_PRIORITY) (c) 2001-2006 Red Hat, Inc.
[    2.859440] io scheduler noop registered
[    2.863936] io scheduler deadline registered (default)
[    2.870299] Serial: 8250/16550 driver, 16 ports, IRQ sharing enabled
[    2.880093] console [ttyS0] disabled
[    2.904290] serial8250.0: ttyS0 at MMIO 0x18020000 (irq = 11, base_baud = 1562500) is a 16550A
[    2.914093] console [ttyS0] enabled
[    2.914093] console [ttyS0] enabled
[    2.921652] bootconsole [early0] disabled
[    2.921652] bootconsole [early0] disabled
[    2.936160] nand: device found, Manufacturer ID: 0x98, Chip ID: 0xf1
[    2.942768] nand: Toshiba NAND 128MiB 3,3V 8-bit
[    2.947537] nand: 128 MiB, SLC, erase size: 128 KiB, page size: 2048, OOB size: 64
[    2.955396] CPU 0 Unable to handle kernel paging request at virtual address 0000022c, epc == 80062b64, ra == 8029ac70
[    2.966364] Oops[#1]:
[    2.968721] CPU: 0 PID: 1 Comm: swapper Not tainted 4.9.65 #0
[    2.974658] task: 87c2c000 task.stack: 87c30000
[    2.979330] $ 0   : 00000000 80710000 00000200 00000000
[    2.984760] $ 4   : 871b0810 00000800 00000000 00000000
[    2.990190] $ 8   : 00000000 8020db30 00000003 2073697a
[    2.995619] $12   : 6f756e64 00010018 00000000 2c204d61
[    3.001049] $16   : 871b0810 00000000 804f1220 00000000
[    3.006478] $20   : 807122d0 804f1210 805102ec 80710000
[    3.011908] $24   : 00000001 802382b0                  
[    3.017338] $28   : 87c30000 87c31d10 80710000 8029ac70
[    3.022768] Hi    : 00000000
[    3.025743] Lo    : 00000040
[    3.028740] epc   : 80062b64 rb95x_nand_scan_fixup+0x20/0x2c
[    3.034597] ra    : 8029ac70 ar934x_nfc_probe+0x4b4/0x598
[    3.040168] Status: 1100c403	KERNEL EXL IE 
[    3.044515] Cause : 0080000c (ExcCode 03)
[    3.048654] BadVA : 0000022c
[    3.051630] PrId  : 0001974c (MIPS 74Kc)
[    3.055678] Modules linked in:
[    3.058838] Process swapper (pid: 1, threadinfo=87c30000, task=87c2c000, tls=00000000)
[    3.067003] Stack : 00000001 00000001 805102ec 80710000 80491764 871b0810 80740000 8009a358
[    3.075694]         871b6600 804f1220 80502c3c 80502c3c 80740000 80740000 00000000 80277bb4
[    3.084384]         871b6600 87c0e4b0 87c35488 80176f2c 804f1220 804f1220 804f1254 802761b4
[    3.093077]         00000000 80500000 00000000 871b6600 871b6600 804f1220 804f1254 80502c3c
[    3.101768]         80500c50 00000000 80541324 80276388 80500c50 80274524 804c48a0 871b6600
[    3.110458]         ...
[    3.112996] Call Trace:
[    3.115529] [] rb95x_nand_scan_fixup+0x20/0x2c
[    3.121015] [] ar934x_nfc_probe+0x4b4/0x598
[    3.126250] [] platform_drv_probe+0x40/0x88
[    3.131471] [] driver_probe_device+0x130/0x278
[    3.136963] [] __driver_attach+0x8c/0xc4
[    3.141907] [] bus_for_each_dev+0x9c/0xac
[    3.146944] [] bus_add_driver+0xe8/0x200
[    3.151889] [] driver_register+0xa8/0xf8
[    3.156835] [] do_one_initcall+0xdc/0x1a4
[    3.161897] [] kernel_init_freeable+0x168/0x220
[    3.167472] [] kernel_init+0x10/0x104
[    3.172160] [] ret_from_kernel_thread+0x14/0x1c
[    3.177734] Code: 244273e0  ac820040  24020200  03e00008  00001025  27bdffe8  14800005  afbf0014 
[    3.187873] 
[    3.189436] ---[ end trace da7c2d7f9f8c0b9f ]---
[    3.195058] Kernel panic - not syncing: Fatal exception
[    3.201252] Rebooting in 1 seconds..

More information can be found at the following URL:
https://bugs.lede-project.org/index.php?do=details&task_id=1200