Latest 10.3 snapshot won't boot on CUBOX

Mon Feb 22 01:11:54 UTC 2016

Got word that the latest version of the armv6 code was supposed to 
be much improved, and maybe even activate video, on the CUBOX. Was 
eager to try it. I first tried the 10.3 snapshot from the end of 
January (r294913), because if 10.3 worked I could have an actual 
release version by early March.

As it turned out, the 10.3 snapshot didn't have video code in it, 
but I hoped it would at least boot. But it didn't. A serial 
terminal showed the following:

U-Boot SPL 2013.10-rc4 (Jan 27 2016 - 19:59:00)
Boot Device: SD1
spl: error reading image u-boot.img, err - -1
Load image from RAW...

U-Boot 2013.10-rc4 (Jan 27 2016 - 19:59:00)

CPU:   Freescale i.MX6Q rev1.2 at 792 MHz
Reset cause: POR
Board: MX6-CuBox-i
DRAM:  1 GiB
MMC:   FSL_SDHC: 0
*** Warning - bad CRC, using default environment

In:    serial
Out:   serial
Err:   serial
Net:   FEC [PRIME]
** Unable to read file uEnv.txt **
Hit any key to stop autoboot:  0
Booting from: mmc 0 ubldr
257003 bytes read in 26 ms (9.4 MiB/s)
## Starting application at 0x12000054 ...
Consoles: U-Boot console
Compatible U-Boot API signature found @4f7708a8

FreeBSD/armv6 U-Boot loader, Revision 1.2
(root at releng1.nyi.freebsd.org, Wed Jan 27 20:08:17 UTC 2016)

DRAM: 1024MB
Number of U-Boot devices: 2
U-Boot env: loaderdev='mmc 0'
Found U-Boot device: disk
   Checking unit=0 slice=<auto> partition=<auto>... good.
Booting from disk0s2a:
/boot/kernel/kernel data=0x5a7d90+0x30270 syms=[0x4+0x6f620+0x4+0x584c2]

Hit [Enter] to boot immediately, or any other key for command prompt.
Booting [/boot/kernel/kernel]...
Loaded DTB from file 'imx6q-cubox-i.dtb'.
Kernel entry at 0x12200100...
Kernel args: (null)
KDB: debugger backends: ddb
KDB: current backend: ddb
Copyright (c) 1992-2016 The FreeBSD Project.
Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
         The Regents of the University of California. All rights reserved.
FreeBSD is a registered trademark of The FreeBSD Foundation.
FreeBSD 10.3-PRERELEASE #0 r294913: Wed Jan 27 20:11:59 UTC 2016
     root at releng1.nyi.freebsd.org:/usr/obj/arm.armv6/usr/src/sys/IMX6 arm
FreeBSD clang version 3.4.1 (tags/RELEASE_34/dot1-final 208032) 20140512
CPU: Cortex A9-r2 rev 10 (Cortex-A core)
  Supported features: ARM_ISA THUMB2 JAZELLE THUMBEE ARMv4 Security_Ext
  WB disabled EABT branch prediction enabled
LoUU:2 LoC:2 LoUIS:2
Cache level 1:
  32KB/32B 4-way data cache WB Read-Alloc Write-Alloc
  32KB/32B 4-way instruction cache Read-Alloc
real memory  = 1073741824 (1024 MB)
avail memory = 1040691200 (992 MB)
FreeBSD/SMP: Multiprocessor System Detected: 2 CPUs
random device not loaded; using insecure entropy
random: <Software, Yarrow> initialized
ofwbus0: <Open Firmware Device Tree>
simplebus0: <Flattened device tree simple bus> on ofwbus0
simplebus1: <Flattened device tree simple bus> mem 
0x2000000-0x20fffff on simplebus0
simplebus2: <Flattened device tree simple bus> mem 
0x2000000-0x203ffff on simplebus1
imx6_anatop0: <Freescale i.MX6 Analog PLLs and Power> mem 
0x20c8000-0x20c8fff irq 81,86,159 on simplebus1
simplebus3: <Flattened device tree simple bus> on simplebus1
simplebus4: <Flattened device tree simple bus> mem 
0x2100000-0x21fffff on simplebus0
ocotp0: <Freescale On-Chip One-Time-Programmable Memory> mem 
0x21bc000-0x21bffff on simplebus4
ccm0: <Freescale i.MX6 Clock Control Module> mem 
0x20c4000-0x20c7fff irq 119,120 on simplebus1
l2cache0: <PL310 L2 cache controller> mem 0xa02000-0xa02fff irq 124 
on simplebus0
l2cache0: Part number: 0x3, release: 0x7
l2cache0: L2 Cache enabled: 1024KB/32B 16 ways
imx_iomux0: <Freescale i.MX pin configuration> mem 
0x20e0000-0x20e3fff on simplebus1
gic0: <ARM Generic Interrupt Controller> mem 
0xa01000-0xa01fff,0xa00100-0xa001ff on ofwbus0
gic0: pn 0x390, arch 0x1, rev 0x2, implementer 0x43b irqs 160
imx_gpt0: <Freescale i.MX GPT timer> mem 0x2098000-0x209bfff irq 87 
on simplebus1
Event timer "iMXGPT" frequency 66000000 Hz quality 800
Timecounter "iMXGPT" frequency 66000000 Hz quality 1000
mp_tmr0: <ARM MPCore Timers> mem 0xa00600-0xa0061f irq 29 on simplebus0
Event timer "MPCore" frequency 492000000 Hz quality 1000
uart0: <Freescale i.MX UART> mem 0x2020000-0x2023fff irq 58 on simplebus2
uart0: console (115200,n,8,1)
gpio0: <Freescale i.MX GPIO Controller> mem 0x209c000-0x209ffff irq 
98,99 on simplebus1
gpioc0: <GPIO controller> on gpio0
gpiobus0: <GPIO bus> on gpio0
gpio1: <Freescale i.MX GPIO Controller> mem 0x20a0000-0x20a3fff irq 
100,101 on simplebus1
gpioc1: <GPIO controller> on gpio1
gpiobus1: <GPIO bus> on gpio1
gpio2: <Freescale i.MX GPIO Controller> mem 0x20a4000-0x20a7fff irq 
102,103 on simplebus1
gpioc2: <GPIO controller> on gpio2
gpiobus2: <GPIO bus> on gpio2
gpio3: <Freescale i.MX GPIO Controller> mem 0x20a8000-0x20abfff irq 
104,105 on simplebus1
gpioc3: <GPIO controller> on gpio3
gpiobus3: <GPIO bus> on gpio3
gpio4: <Freescale i.MX GPIO Controller> mem 0x20ac000-0x20affff irq 
106,107 on simplebus1
gpioc4: <GPIO controller> on gpio4
gpiobus4: <GPIO bus> on gpio4
gpio5: <Freescale i.MX GPIO Controller> mem 0x20b0000-0x20b3fff irq 
108,109 on simplebus1
gpioc5: <GPIO controller> on gpio5
gpiobus5: <GPIO bus> on gpio5
gpio6: <Freescale i.MX GPIO Controller> mem 0x20b4000-0x20b7fff irq 
110,111 on simplebus1
gpioc6: <GPIO controller> on gpio6
gpiobus6: <GPIO bus> on gpio6
imx_wdog0: <Freescale i.MX Watchdog> mem 0x20bc000-0x20bffff irq 
112 on simplebus1
usbphy0: <Freescale i.MX6 USB PHY> mem 0x20c9000-0x20c9fff irq 76 on simplebus1
usbphy1: <Freescale i.MX6 USB PHY> mem 0x20ca000-0x20cafff irq 77 on simplebus1
ehci0: <Freescale i.MX integrated USB controller> mem 
0x2184000-0x21841ff irq 75 on simplebus4
ehci0: [GIANT-LOCKED]
usbus0: EHCI version 1.0
usbus0 on ehci0
ehci1: <Freescale i.MX integrated USB controller> mem 
0x2184200-0x21843ff irq 72 on simplebus4
ehci1: [GIANT-LOCKED]
usbus1: EHCI version 1.0
usbus1 on ehci1
ffec0: <Freescale Gigabit Ethernet Controller> mem 
0x2188000-0x218bfff irq 150,151 on simplebus4
miibus0: <MII bus> on ffec0
atphy0: <Atheros F1 10/100/1000 PHY> PHY 0 on miibus0
atphy0:  none, 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, 
1000baseSX-FDX, 1000baseT-FDX, 1000baseT-FDX-master, auto
ffec0: Ethernet address: d0:63:b4:00:18:99
sdhci_imx0: <Freescale uSDHC controller> mem 0x2194000-0x2197fff 
irq 55 on simplebus4
mmc0: <MMC/SD bus> on sdhci_imx0
iichb0: <Freescale i.MX I2C> mem 0x21a4000-0x21a7fff irq 69 on simplebus4
iicbus0: <OFW I2C bus> on iichb0
iic0: <I2C generic I/O> on iicbus0
iichb1: <Freescale i.MX I2C> mem 0x21a8000-0x21abfff irq 70 on simplebus4
iicbus1: <OFW I2C bus> on iichb1
iic1: <I2C generic I/O> on iicbus1
iicbus1: <unknown card> at addr 0xd0
Timecounters tick every 2.000 msec
random: unblusbus0: 480Mbps High Speed USB v2.0
usbus1: 480Mbps High Speed USB v2.0
ocking device.
ugen0.1: <Freescale> at usbus0
uhub0: <Freescale EHCI root HUB, class 9/0, rev 2.00/1.00, addr 1> on usbus0
ugen1.1: <Freescale> at usbus1
uhub1: <Freescale EHCI root HUB, class 9/0, rev 2.00/1.00, addr 1> on usbus1
mmcsd0: 32GB <SDHC SL32G 8.0 SN 59E70EE2 MFG 12/2015 by 3 SD> at 
mmc0 50.0MHz/4bit/65535-block
Release APs
uhub0: 1 port with 1 removable, self powered
uhub1: 1 port with 1 removable, self powered
Trying to mount root from ufs:/dev/ufs/rootfs [rw]...
warning: no time-of-day clock registered, system time will not be 
set accurately
Growing root partition to fill device
GEOM_PART: mmcsd0s2 was automatically resized.
   Use `gpart commit mmcsd0s2` to save changes or `gpart undo 
mmcsd0s2` to revert them.
mmcsd0s2 resized
mmcsd0s2a resized
super-block backups (for fsck_ffs -b #) at:
  864448, 1080512, 1296576, 1512640, 1728704, 1944768, 2160832, 2376896,
  2592960, 2809024, 3025088,sdhci_imx0-slot0:  Controller timeout
sdhci_imx0-slot0: ============== REGISTER DUMP ==============
sdhci_imx0-slot0: Sys addr: 0x1205e700 | Version:  0x00000002
sdhci_imx0-slot0: Blk size: 0x00000200 | Blk cnt:  0x00000006
sdhci_imx0-slot0: Argument: 0x00334580 | Trn mode: 0x00000026
sdhci_imx0-slot0: Present:  0x00f90506 | Host ctl: 0x00000003
sdhci_imx0-slot0: Power:    0x0000000d | Blk gap:  0x00000080
sdhci_imx0-slot0: Wake-up:  0x00000000 | Clock:    0x00000207
sdhci_imx0-slot0: Timeout:  0x0000000d | Int stat: 0x00000010
sdhci_imx0-slot0: Int enab: 0x017f00fb | Sig enab: 0x017f00fb
sdhci_imx0-slot0: AC12 err: 0x00000000 | Slot int: 0x00000001
sdhci_imx0-slot0: Caps:     0x0377c800 | Max curr: 0x80000026
sdhci_imx0-slot0: ===========================================
mmcsd0: Error indicated: 1 Timeout
growfs: mmcsd0: Error indicated: 1 Timeout
gSpurious interrupt detected
_Spurious interrupt detected
vfs_done():ufs/rootfs[READ(offset=33560576Spurious interrupt detected
0, length=4096)]error = 5
wtfs: write error: 32412mmcsd0: Error indicated: 1 Timeout
gSpurious interrupt detected
_vfs_done():ufs/rootfs[READ(offset=335605760, length=4096)]error = 5
16: Input/output error
mmcsd0: Error indicated: 1 Timeout
mmcsd0: Error indicated: 1 Timeout
g_vfs_done():ufs/rootfs[READ(offset=201781248, length=4096)]error = 5
g_vfs_done():ufs/rootfs[READ(offset=120750080, length=6144)]error = 5
vnode_pager_getpages: I/O read error
g_vfs_done():ufs/rootfs[READ(offset=335605760, length=4096)]error = 5
g_vfs_done():ufs/rootfs[READ(offset=335605760, length=4096)]error = 5
eval: kenv: Input/output error
gSpurious interrupt detected
_vfs_done():ufs/rootfs[READ(offset=121135104, length=5632)]error = 5
vnode_pager_getpages: I/O read error
g_vfs_done():ufs/rootfs[READ(offset=335605760, length=4096)]error = 5
g_vfs_done():ufs/rootfs[READ(offset=335605760, length=4096)]error = 5
eval: uuidgen: Input/output error
g_vfs_done():ufs/rootfs[READ(offset=357892096, length=13312)]error = 5
vnode_pager_getpages: I/O read error
eval: /sbin/md5: Input/output error
Setting hostuuid: .
Setting hostid: 0x.
sysctl: invalid unsigned long integer '0x'
Entropy harvesting: interrupts ethernet point_to_point swi.
g_vfs_done():ufs/rootfs[READ(offset=116224000, length=4096)]error = 5
g_vfs_done():ufs/rootfs[READ(offset=335605760, length=4096)]error = 5
g_vfs_done():ufs/rootfs[READ(offset=335605760, length=4096)]error = 5
read: read error: Input/output error
g_vfs_done():ufs/rootfs[READ(offset=364118016, length=17408)]error = 5
vnode_pager_getpages: I/O read error
g_vfs_done():ufs/rootfs[READ(offset=335605760, length=4096)]error = 5
g_vfs_done():ufs/rootfs[READ(offset=335605760, length=4096)]error = 5
eval: /sbin/swapon: Input/output error
Starting file system chegSpurious interrupt detected
_vfs_done():ufs/rootfs[READ(offset=357433344, length=16384)]error = 5
vnode_pager_getpages: I/O read error
cks:
g_vfs_done():ufs/rootfs[READ(offset=335605760, length=4096)]error = 5
g_vfs_done():ufs/rootfs[READ(offset=335605760, length=4096)]error = 5
eval: fsck: Input/output error
Unknown error; hg_vfs_done():ufs/rootfs[READ(offset=335605760, 
length=4096)]error = 5
elp!
ERROR: ABORTING BOg_vfs_done():ufs/rootfs[READ(offset=335605760, 
length=4096)]error = 5
OT (sending SIGTERM to 
pg_vfs_done():ufs/rootfs[READ(offset=361951232, length=65536)]error = 5
vnode_pager_getpages: I/O read error
vm_fault: pager read error, pid 1 (init)
arent)!
(S_pvufrsi_oduosn ei(n)t:eurfrsu/prto odteftse[cRtEeAdD
)ofSfpsuerti=o3u6s1 9i8n4t0e0r0r,u plte ndgetthe=c4t0e9d6
  ]error = 5
vSpurious interrupt detected
nSpurious interrupt detected
ode_pager_getpages: I/O read error
vm_fault: pager read error, pid 1 (init)
g_vfs_done():ufs/rootfs[READ(offset=361984000, length=4096)]error = 5
vnode_pager_getpages: I/O read error
vm_fault: pager read error, pid 1 (init)
g_vfs_done():ufs/rootfs[READ(offset=361984000, length=4096)]error = 5
vnode_pager_getpages: I/O read error
vm_fault: pager read error, pid 1 (init)
g_vfs_done():ufs/rootfs[READ(offset=361984000, length=4096)]error = 5
vnode_pager_getpages: I/O read error
vm_fault: pager read error, pid 1 (init)
g_vfs_done():ufs/rootfs[READ(offset=361984000, length=4096)]error = 5
vnode_pager_getpages: I/O read error
vm_fault: pager read error, pid 1 (init)

...and so on, ad infinitum. Not sure what is wrong here, but the SD 
card tests fine so it appears to be a software issue.

--Brett Glass