Hello,
I have designed Linux OS for our custom Arria 10 SOC board.
The booting process is successful but sometimes when board is powered on after a while , it gets stuck over :
[ 2.785079] —[ end Kernel panic - not syncing: VFS: Unable to mount root fs on unknown-block(179,2) ]—
Also , after booting is complete there are random warnings displayed over console :
[ 97.344015] random: crng init done
[ 97.347420] random: 7 urandom warning(s) missed due to ratelimiting
The complete log is as follows -
Starting kernel …
[ 0.000000] Booting Linux on physical CPU 0x0
[ 0.000000] Linux version 5.2.0-rc3-00038-gbb626b6 (bmit@bmit-Satellite-C50-A) (gcc version 4.8.3 20140401 (prerelease) (crosstool-NG linaro-1.13.1-4.8-2014.04 - Linaro GCC 4.8-2014.04)) #8 SMP Thu Oct 10 15:50:34 IST 2019
[ 0.000000] CPU: ARMv7 Processor [414fc091] revision 1 (ARMv7), cr=10c5387d
[ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[ 0.000000] OF: fdt: Machine model: Altera SOCFPGA Arria 10
[ 0.000000] Memory policy: Data cache writealloc
[ 0.000000] percpu: Embedded 19 pages/cpu s48704 r8192 d20928 u77824
[ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 522752
[ 0.000000] Kernel command line: console=ttyS0,115200 root=/dev/mmcblk0p2 rw rootwait
[ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.000000] Memory: 2067772K/2097152K available (8192K kernel code, 536K rwdata, 1648K rodata, 1024K init, 136K bss, 29380K reserved, 0K cma-reserved, 1310720K highmem)
[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[ 0.000000] ftrace: allocating 26779 entries in 53 pages
[ 0.000000] rcu: Hierarchical RCU implementation.
[ 0.000000] rcu: RCU event tracing is enabled.
[ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
[ 0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[ 0.000000] L2C-310 erratum 769419 enabled
[ 0.000000] L2C-310 enabling early BRESP for Cortex-A9
[ 0.000000] L2C-310: enabling full line of zeros but not enabled in Cortex-A9
[ 0.000000] L2C-310 ID prefetch enabled, offset 1 lines
[ 0.000000] L2C-310 dynamic clock gating enabled, standby mode enabled
[ 0.000000] L2C-310 cache controller enabled, 8 ways, 512 kB
[ 0.000000] L2C-310: CACHE_ID 0x410030c9, AUX_CTRL 0x76460001
[ 0.000000] random: get_random_bytes called from start_kernel+0x314/0x4ac with crng_init=0
[ 0.000000] GIC: PPI13 is secure or misconfigured
[ 0.000000] GIC: PPI13 is secure or misconfigured
[ 0.000000] clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 38225208935 ns
[ 0.000005] sched_clock: 32 bits at 50MHz, resolution 20ns, wraps every 42949672950ns
[ 0.000016] Switching to timer-based delay loop, resolution 20ns
[ 0.000344] Console: colour dummy device 80x30
[ 0.000377] Calibrating delay loop (skipped), value calculated using timer frequency… 100.00 BogoMIPS (lpj=500000)
[ 0.000390] pid_max: default: 32768 minimum: 301
[ 0.000522] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.000534] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.001022] *** VALIDATE proc ***
[ 0.001156] *** VALIDATE cgroup1 ***
[ 0.001167] *** VALIDATE cgroup2 ***
[ 0.001178] CPU: Testing write buffer coherency: ok
[ 0.001205] CPU0: Spectre v2: using BPIALL workaround
[ 0.001452] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[ 0.002017] Setting up static identity map for 0x100000 - 0x100060
[ 0.002155] rcu: Hierarchical SRCU implementation.
[ 0.002428] smp: Bringing up secondary CPUs …
[ 0.003234] GIC: PPI13 is secure or misconfigured
[ 0.003248] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[ 0.003254] CPU1: Spectre v2: using BPIALL workaround
[ 0.003398] smp: Brought up 1 node, 2 CPUs
[ 0.003410] SMP: Total of 2 processors activated (200.00 BogoMIPS).
[ 0.003417] CPU: All CPU(s) started in SVC mode.
[ 0.004656] devtmpfs: initialized
[ 0.009131] VFP support v0.3: implementor 41 architecture 3 part 30 variant 9 rev 4
[ 0.009313] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.009332] futex hash table entries: 512 (order: 3, 32768 bytes)
[ 0.010296] NET: Registered protocol family 16
[ 0.011125] DMA: preallocated 256 KiB pool for atomic coherent allocations
[ 0.011991] hw-breakpoint: found 5 (+1 reserved) breakpoint and 1 watchpoint registers.
[ 0.012002] hw-breakpoint: maximum watchpoint size is 4 bytes.
[ 0.025219] gpio gpiochip2: (/sopc@0/bridge@0xc0000000/gpio@0x100000030): detected irqchip that is shared with multiple gpiochips: please fix the driver.
[ 0.025607] vgaarb: loaded
[ 0.025875] SCSI subsystem initialized
[ 0.026053] usbcore: registered new interface driver usbfs
[ 0.026093] usbcore: registered new interface driver hub
[ 0.026146] usbcore: registered new device driver usb
[ 0.026304] usb_phy_generic sopc@0:usbphy0: sopc@0:usbphy0 supply vcc not found, using dummy regulator
[ 0.027167] pps_core: LinuxPPS API ver. 1 registered
[ 0.027177] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti giometti@linux.it
[ 0.027194] PTP clock support registered
[ 0.027345] FPGA manager framework
[ 0.028097] clocksource: Switched to clocksource timer
[ 0.402930] NET: Registered protocol family 2
[ 0.403577] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes)
[ 0.403604] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[ 0.403689] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[ 0.403810] TCP: Hash tables configured (established 8192 bind 8192)
[ 0.403917] UDP hash table entries: 512 (order: 2, 16384 bytes)
[ 0.403968] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[ 0.404148] NET: Registered protocol family 1
[ 0.404619] RPC: Registered named UNIX socket transport module.
[ 0.404629] RPC: Registered udp transport module.
[ 0.404634] RPC: Registered tcp transport module.
[ 0.404640] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 0.404654] PCI: CLS 0 bytes, default 64
[ 0.405272] hw perfevents: no interrupt-affinity property for /sopc@0/pmu0, guessing.
[ 0.405490] hw perfevents: enabled with armv7_cortex_a9 PMU driver, 7 counters available
[ 0.406594] workingset: timestamp_bits=30 max_order=19 bucket_order=0
[ 0.413186] NFS: Registering the id_resolver key type
[ 0.413217] Key type id_resolver registered
[ 0.413224] Key type id_legacy registered
[ 0.413239] Installing knfsd (copyright © 1996 okir@monad.swb.de).
[ 0.413819] ntfs: driver 2.1.32 [Flags: R/W].
[ 0.414099] jffs2: version 2.2. (NAND) \A9 2001-2006 Red Hat, Inc.
[ 0.414660] bounce: pool size: 64 pages
[ 0.414677] io scheduler mq-deadline registered
[ 0.414684] io scheduler kyber registered
[ 0.420233] dma-pl330 ffda1000.dma: Loaded driver for PL330 DMAC-341330
[ 0.420250] dma-pl330 ffda1000.dma: DBUFF-512x8bytes Num_Chans-8 Num_Peri-32 Num_Events-8
[ 0.423131] Serial: 8250/16550 driver, 2 ports, IRQ sharing disabled
[ 0.424149] printk: console [ttyS0] disabled
[ 0.424191] ffc02100.serial: ttyS0 at MMIO 0xffc02100 (irq = 30, base_baud = 3125000) is a 16550A
[ 1.037216] printk: console [ttyS0] enabled
[ 1.042884] brd: module loaded
[ 1.053180] loop: module loaded
[ 1.080754] libphy: Fixed MDIO Bus: probed
[ 1.085368] CAN device driver interface
[ 1.089623] socfpga-dwmac ff800000.ethernet: PTP uses main clock
[ 1.095832] socfpga-dwmac ff800000.ethernet: User ID: 0x10, Synopsys ID: 0x37
[ 1.102966] socfpga-dwmac ff800000.ethernet: DWMAC1000
[ 1.108181] socfpga-dwmac ff800000.ethernet: DMA HW capability register supported
[ 1.115632] socfpga-dwmac ff800000.ethernet: RX Checksum Offload Engine supported
[ 1.123090] socfpga-dwmac ff800000.ethernet: COE Type 2
[ 1.128308] socfpga-dwmac ff800000.ethernet: TX Checksum insertion supported
[ 1.135326] socfpga-dwmac ff800000.ethernet: Enhanced/Alternate descriptors
[ 1.142264] socfpga-dwmac ff800000.ethernet: Enabled extended descriptors
[ 1.149030] socfpga-dwmac ff800000.ethernet: Ring mode enabled
[ 1.154837] socfpga-dwmac ff800000.ethernet: Enable RX Mitigation via HW Watchdog Timer
[ 1.170505] libphy: stmmac: probed
[ 1.173907] Micrel KSZ9031 Gigabit PHY stmmac-0:07: attached PHY driver [Micrel KSZ9031 Gigabit PHY] (mii_bus:phy_addr=stmmac-0:07, irq=POLL)
[ 1.187746] dwc2 ffb00000.usb: ffb00000.usb supply vusb_d not found, using dummy regulator
[ 1.196066] dwc2 ffb00000.usb: ffb00000.usb supply vusb_a not found, using dummy regulator
[ 1.204549] dwc2 ffb00000.usb: EPs: 16, dedicated fifos, 8064 entries in SPRAM
[ 1.212247] dwc2 ffb00000.usb: DWC OTG Controller
[ 1.216953] dwc2 ffb00000.usb: new USB bus registered, assigned bus number 1
[ 1.224032] dwc2 ffb00000.usb: irq 34, io mem 0xffb00000
[ 1.230028] hub 1-0:1.0: USB hub found
[ 1.233798] hub 1-0:1.0: 1 port detected
[ 1.238449] usbcore: registered new interface driver usb-storage
[ 1.245094] rtc-ds1307: probe of 0-0068 failed with error -121
[ 1.250974] i2c /dev entries driver
[ 1.255374] Synopsys Designware Multimedia Card Interface Driver
[ 1.261642] dw_mmc ff808000.flash: IDMAC supports 32-bit address mode.
[ 1.268201] dw_mmc ff808000.flash: Using internal DMA controller.
[ 1.274275] dw_mmc ff808000.flash: Version ID is 270a
[ 1.279364] dw_mmc ff808000.flash: DW MMC controller at irq 33,32 bit host data width,1024 deep fifo
[ 1.288575] mmc_host mmc0: card is polling.
[ 1.305385] mmc_host mmc0: Bus speed (slot 0) = 50000000Hz (slot req 400000Hz, actual 396825HZ div = 63)
[ 1.328406] ledtrig-cpu: registered to indicate activity on CPUs
[ 1.334529] usbcore: registered new interface driver usbhid
[ 1.340108] usbhid: USB HID core driver
[ 1.344313] fpga_manager fpga0: SoCFPGA Arria10 FPGA Manager registered
[ 1.351384] oprofile: using arm/armv7-ca9
[ 1.356170] NET: Registered protocol family 10
[ 1.361486] Segment Routing with IPv6
[ 1.365212] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[ 1.371699] NET: Registered protocol family 17
[ 1.376146] NET: Registered protocol family 15
[ 1.380596] can: controller area network core (rev 20170425 abi 9)
[ 1.386804] NET: Registered protocol family 29
[ 1.391261] can: raw protocol (rev 20170425)
[ 1.395513] can: broadcast manager protocol (rev 20170425 t)
[ 1.401164] can: netlink gateway (rev 20170425) max_hops=1
[ 1.406804] 8021q: 802.1Q VLAN Support v1.8
[ 1.411024] Key type dns_resolver registered
[ 1.415352] ThumbEE CPU extension supported.
[ 1.419621] Registering SWP/SWPB emulation handler
[ 1.429260] hctosys: unable to open rtc device (rtc0)
[ 1.434797] ttyS0 - failed to request DMA
[ 1.439042] Waiting for root device /dev/mmcblk0p2…
[ 1.504257] mmc_host mmc0: Bus speed (slot 0) = 50000000Hz (slot req 50000000Hz, actual 50000000HZ div = 0)
[ 1.514026] mmc0: new high speed SDHC card at address aaaa
[ 1.520496] mmcblk0: mmc0:aaaa SS08G 7.40 GiB
[ 1.528028] mmcblk0: p1 p2 p3
[ 1.586128] mmc_host mmc0: Bus speed (slot 0) = 50000000Hz (slot req 400000Hz, actual 396825HZ div = 63)
[ 1.658545] mmc_host mmc0: Bus speed (slot 0) = 50000000Hz (slot req 50000000Hz, actual 50000000HZ div = 0)
[ 1.670384] print_req_error: I/O error, dev mmcblk0, sector 1026051 flags 0
[ 1.677542] EXT4-fs (mmcblk0p2): unable to read superblock
[ 1.701891] mmc_host mmc0: Bus speed (slot 0) = 50000000Hz (slot req 400000Hz, actual 396825HZ div = 63)
[ 1.775180] mmc_host mmc0: Bus speed (slot 0) = 50000000Hz (slot req 50000000Hz, actual 50000000HZ div = 0)
[ 1.788362] print_req_error: I/O error, dev mmcblk0, sector 1026831 flags 80000
[ 1.797756] print_req_error: I/O error, dev mmcblk0, sector 1026832 flags 80000
[ 1.805070] EXT4-fs error (device mmcblk0p2): __ext4_get_inode_loc:4694: inode #8: block 97: comm swapper/0: unable to read itable block
[ 1.805276] print_req_error: I/O error, dev mmcblk0, sector 1026833 flags 80700
[ 1.826901] print_req_error: I/O error, dev mmcblk0, sector 1026835 flags 80700
[ 1.834603] print_req_error: I/O error, dev mmcblk0, sector 1026837 flags 80700
[ 1.843995] print_req_error: I/O error, dev mmcblk0, sector 1026838 flags 80700
[ 1.851502] print_req_error: I/O error, dev mmcblk0, sector 1026839 flags 80700
[ 1.860919] print_req_error: I/O error, dev mmcblk0, sector 1026840 flags 80700
[ 1.868462] print_req_error: I/O error, dev mmcblk0, sector 1026841 flags 80000
[ 1.878807] random: fast init done
[ 1.954633] EXT4-fs (mmcblk0p2): no journal found
[ 1.960855] EXT2-fs (mmcblk0p2): error: unable to read superblock
[ 1.969928] EXT4-fs (mmcblk0p2): mounting ext3 file system using the ext4 subsystem
[ 1.980343] EXT4-fs (mmcblk0p2): INFO: recovery required on readonly filesystem
[ 1.987621] EXT4-fs (mmcblk0p2): write access will be enabled during recovery
[ 2.013784] mmc_host mmc0: Bus speed (slot 0) = 50000000Hz (slot req 400000Hz, actual 396825HZ div = 63)
[ 2.085456] mmc_host mmc0: Bus speed (slot 0) = 50000000Hz (slot req 50000000Hz, actual 50000000HZ div = 0)
[ 2.098745] EXT4-fs error (device mmcblk0p2): __ext4_get_inode_loc:4694: inode #8: block 97: comm swapper/0: unable to read itable block
[ 2.174173] EXT4-fs (mmcblk0p2): no journal found
[ 2.180518] EXT4-fs (mmcblk0p2): INFO: recovery required on readonly filesystem
[ 2.187799] EXT4-fs (mmcblk0p2): write access will be enabled during recovery
[ 2.213457] mmc_host mmc0: Bus speed (slot 0) = 50000000Hz (slot req 400000Hz, actual 396825HZ div = 63)
[ 2.285453] mmc_host mmc0: Bus speed (slot 0) = 50000000Hz (slot req 50000000Hz, actual 50000000HZ div = 0)
[ 2.298666] EXT4-fs error (device mmcblk0p2): __ext4_get_inode_loc:4694: inode #8: block 97: comm swapper/0: unable to read itable block
[ 2.354434] EXT4-fs (mmcblk0p2): no journal found
[ 2.360015] EXT2-fs (mmcblk0p2): error: couldn’t mount because of unsupported optional features (4)
[ 2.371457] List of all partitions:
[ 2.374941] 0100 8192 ram0
[ 2.374943] (driver?)
[ 2.381050] 0101 8192 ram1
[ 2.381053] (driver?)
[ 2.387141] b300 7761920 mmcblk0
[ 2.387144] driver: mmcblk
[ 2.393925] b301 512000 mmcblk0p1 4948cce5-01
[ 2.393927]
[ 2.400709] b302 1536000 mmcblk0p2 4948cce5-02
[ 2.400710]
[ 2.407480] b303 10240 mmcblk0p3 4948cce5-03
[ 2.407482]
[ 2.414259] No filesystem could mount root, tried:
[ 2.414262] ext3
[ 2.419123] ext4
[ 2.421038] ext2
[ 2.422953] vfat
[ 2.424869] ntfs
[ 2.426784]
[ 2.430192] Kernel panic - not syncing: VFS: Unable to mount root fs on unknown-block(179,2)
[ 2.438595] CPU: 1 PID: 1 Comm: swapper/0 Not tainted 5.2.0-rc3-00038-gbb626b6 #8
[ 2.446043] Hardware name: Altera SOCFPGA Arria10
[ 2.450725] Backtrace:
[ 2.453176] [] (dump_backtrace) from [] (show_stack+0x20/0x24)
[ 2.460713] r6:00000000 r5:60000093 r4:c0c76c28 r3:7704a532
[ 2.466357] [] (show_stack) from [] (dump_stack+0x98/0xac)
[ 2.473555] [] (dump_stack) from [] (panic+0x128/0x33c)
[ 2.480486] r6:c09e0d40 r5:00000000 r4:c0c867db r3:00000001
[ 2.486126] [] (panic) from [] (mount_block_root+0x24c/0x2a8)
[ 2.493575] r3:ee8efe64 r2:80000000 r1:ee8efe9c r0:c09e0d40
[ 2.499206] r7:c0b5c85c
[ 2.501732] [] (mount_block_root) from [] (mount_root+0x13c/0x144)
[ 2.509616] r10:c0b5c838 r9:c0c7c6e0 r8:c0c86340 r7:c0b83b3c r6:c0b5c85c r5:0b300002
[ 2.517407] r4:c0c07400
[ 2.519932] [] (mount_root) from [] (prepare_namespace+0x1a0/0x1e4)
[ 2.527902] r8:c0c86340 r7:c0b83b3c r6:c0b5c85c r5:c0b5c871 r4:c0c86370
[ 2.534576] [] (prepare_namespace) from [] (kernel_init_freeable+0x368/0x3c0)
[ 2.543406] r6:c0c86340 r5:00000007 r4:c0c86340
[ 2.548007] [] (kernel_init_freeable) from [] (kernel_init+0x18/0x128)
[ 2.556236] r10:00000000 r9:00000000 r8:00000000 r7:00000000 r6:00000000 r5:c07fc1d8
[ 2.564027] r4:00000000
[ 2.566554] [] (kernel_init) from [] (ret_from_fork+0x14/0x2c)
[ 2.574087] Exception stack(0xee8effb0 to 0xee8efff8)
[ 2.579119] ffa0: 00000000 00000000 00000000 00000000
[ 2.587261] ffc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
[ 2.595402] ffe0: 00000000 00000000 00000000 00000000 00000013 00000000
[ 2.601986] r4:00000000 r3:ffffffff
[ 2.605543] CPU0: stopping
[ 2.608244] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 5.2.0-rc3-00038-gbb626b6 #8
[ 2.615693] Hardware name: Altera SOCFPGA Arria10
[ 2.620374] Backtrace:
[ 2.622820] [] (dump_backtrace) from [] (show_stack+0x20/0x24)
[ 2.630358] r6:00000000 r5:60000193 r4:c0c76c28 r3:7704a532
[ 2.635998] [] (show_stack) from [] (dump_stack+0x98/0xac)
[ 2.643193] [] (dump_stack) from [] (handle_IPI+0x1e8/0x3ac)
[ 2.650557] r6:c0b8ef34 r5:00000000 r4:00000004 r3:c0c0e6e8
[ 2.656195] [] (handle_IPI) from [] (gic_handle_irq+0x9c/0xa0)
[ 2.663734] r10:c0c03c40 r9:f0803100 r8:c0c01ee0 r7:f080210c r6:c0c043a0 r5:c0c4f1d8
[ 2.671527] r4:f0802100
[ 2.674053] [] (gic_handle_irq) from [] (__irq_svc+0x6c/0x90)
[ 2.681501] Exception stack(0xc0c01ee0 to 0xc0c01f28)
[ 2.686535] 1ee0: 00000000 00003374 c0c01f40 c011b420 c0c00000 c0c03ca0 00000001 c0c03c68
[ 2.694679] 1f00: c0c7c2be 00000001 c0c03c40 c0c01f3c c0c01f40 c0c01f30 c0109530 c0109534
[ 2.702817] 1f20: 60000013 ffffffff
[ 2.706295] r9:c0c00000 r8:c0c7c2be r7:c0c01f14 r6:ffffffff r5:60000013 r4:c0109534
[ 2.714013] [] (arch_cpu_idle) from [] (default_idle_call+0x30/0x3c)
[ 2.722073] [] (default_idle_call) from [] (do_idle+0xd0/0x144)
[ 2.729698] [] (do_idle) from [] (cpu_startup_entry+0x28/0x2c)
[ 2.737236] r8:00000035 r7:c0c86340 r6:ffffffff r5:c0c86340 r4:000000cb r3:c0b8427c
[ 2.744947] [] (cpu_startup_entry) from [] (rest_init+0xbc/0xc0)
[ 2.752657] [] (rest_init) from [] (arch_call_rest_init+0x18/0x1c)
[ 2.760541] [] (arch_call_rest_init) from [] (start_kernel+0x494/0x4ac)
[ 2.768857] [] (start_kernel) from [<00000000>] (0x0)
[ 2.774754] r10:10c5387d r9:414fc091 r8:01ff6000 r7:00000000 r6:10c0387d r5:00000051
[ 2.782546] r4:c0b00330
[ 2.785079] —[ end Kernel panic - not syncing: VFS: Unable to mount root fs on unknown-block(179,2) ]—
Can anyone please provide a solution for above error ?
Thanks,
Priya