Imx7 booting Linux stuck at "Starting kernel ..."

Hi Kevin,

thanks for the tip.
I’ll give it a try asap.

So far we have experienced the issue on 6 out of 13 modules in one single system (S/N: 07199620, 07199518, 07199458, 07199468, 07199522, 07199523).

Currently we have several systems in the field (often in remote places) and we are quite concerned that it would happen again soon or later.

Regards,
Marco

Hi @kevin.tx ,

as you suggested, I’m trying to run the check within the Toradex Reference Minimal Image but I still get

/dev/mmcblk open error

The steps I did are:

  1. installed Toradex Reference Minimal Image (this)

  2. dropped the “check_package” folder from mx52lm04a11xui_check.zip into the root folder of the module

  3. run ./run_check.sh

What am I doing wrong?

Thanks
Marco

Hello @mortolaniEST,
could you please share the output of dmesg on the module you’re running into problems?
Could you also run this on the same module and post the output (please paste the outputs of these commands as text, not screenshots):

wget https://raw.githubusercontent.com/toradex/tdx-info/master/tdx-info --output-document=tdx-info && sudo sh ./tdx-info

Hi @rafael.tx ,

below the dmesg output:

root@colibri-imx7-emmc-07199522:/check_package# dmesg
[ 0.000000] Booting Linux on physical CPU 0x0
[ 0.000000] Linux version 5.4.193-5.7.2+git.f5d73fd6e9f8 (oe-user@oe-host) (gcc version 9.5.0 (GCC)) #1 SMP Fri Jun 24 10:15:32 UTC 2022
[ 0.000000] CPU: ARMv7 Processor [410fc075] revision 5 (ARMv7), cr=10c5387d
[ 0.000000] CPU: div instructions available: patching division code
[ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[ 0.000000] OF: fdt: Machine model: Toradex Colibri iMX7D 1GB on Colibri Aster Board
[ 0.000000] Memory policy: Data cache writealloc
[ 0.000000] efi: Getting EFI parameters from FDT:
[ 0.000000] efi: UEFI not found.
[ 0.000000] cma: Reserved 64 MiB at 0xbc000000
[ 0.000000] On node 0 totalpages: 262144
[ 0.000000] Normal zone: 1728 pages used for memmap
[ 0.000000] Normal zone: 0 pages reserved
[ 0.000000] Normal zone: 196608 pages, LIFO batch:63
[ 0.000000] HighMem zone: 65536 pages, LIFO batch:15
[ 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: Trusted OS migration not required
[ 0.000000] psci: SMC Calling Convention v1.0
[ 0.000000] percpu: Embedded 20 pages/cpu s51084 r8192 d22644 u81920
[ 0.000000] pcpu-alloc: s51084 r8192 d22644 u81920 alloc=20*4096
[ 0.000000] pcpu-alloc: [0] 0 [0] 1
[ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 260416
[ 0.000000] Kernel command line: root=PARTUUID=9756cbff-02 ro rootwait console=tty1 console=ttymxc0,115200n8 consoleblank=0
[ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
[ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
[ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[ 0.000000] Memory: 953976K/1048576K available (11264K kernel code, 875K rwdata, 4004K rodata, 1024K init, 430K bss, 29064K reserved, 65536K cma-reserved, 196608K highmem)
[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[ 0.000000] rcu: Hierarchical RCU implementation.
[ 0.000000] rcu: RCU event tracing is enabled.
[ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=4 to nr_cpu_ids=2.
[ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
[ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[ 0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[ 0.000000] GIC: Using split EOI/Deactivate mode
[ 0.000000] random: get_random_bytes called from start_kernel+0x314/0x4f0 with crng_init=0
[ 0.000000] arch_timer: cp15 timer(s) running at 8.00MHz (phys).
[ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x1d854df40, max_idle_ns: 440795202120 ns
[ 0.000008] sched_clock: 56 bits at 8MHz, resolution 125ns, wraps every 2199023255500ns
[ 0.000020] Switching to timer-based delay loop, resolution 125ns
[ 0.000500] Switching to timer-based delay loop, resolution 41ns
[ 0.000518] sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 89478484971ns
[ 0.000535] clocksource: mxc_timer1: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 79635851949 ns
[ 0.001987] Console: colour dummy device 80x30
[ 0.002471] printk: console [tty1] enabled
[ 0.002515] Calibrating delay loop (skipped), value calculated using timer frequency… 48.00 BogoMIPS (lpj=240000)
[ 0.002547] pid_max: default: 32768 minimum: 301
[ 0.002762] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[ 0.002797] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[ 0.003842] CPU: Testing write buffer coherency: ok
[ 0.004898] Setting up static identity map for 0x80100000 - 0x80100060
[ 0.005061] rcu: Hierarchical SRCU implementation.
[ 0.008716] EFI services will not be available.
[ 0.009036] smp: Bringing up secondary CPUs …
[ 0.010089] smp: Brought up 1 node, 2 CPUs
[ 0.010117] SMP: Total of 2 processors activated (96.00 BogoMIPS).
[ 0.010134] CPU: All CPU(s) started in HYP mode.
[ 0.010148] CPU: Virtualization extensions available.
[ 0.010776] devtmpfs: initialized
[ 0.021692] VFP support v0.3: implementor 41 architecture 2 part 30 variant 7 rev 5
[ 0.021987] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.022029] futex hash table entries: 512 (order: 3, 32768 bytes, linear)
[ 0.024622] pinctrl core: initialized pinctrl subsystem
[ 0.025892] NET: Registered protocol family 16
[ 0.032575] DMA: preallocated 256 KiB pool for atomic coherent allocations
[ 0.034026] cpuidle: using governor ladder
[ 0.034080] cpuidle: using governor menu
[ 0.034760] No ATAGs?
[ 0.034866] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[ 0.034907] hw-breakpoint: maximum watchpoint size is 8 bytes.
[ 0.035229] Serial: AMBA PL011 UART driver
[ 0.040876] imx7d-pinctrl 302c0000.iomuxc-lpsr: initialized IMX pinctrl driver
[ 0.041568] debugfs: Directory ‘dummy-iomuxc-gpr@30340000’ with parent ‘regmap’ already present!
[ 0.041940] imx7d-pinctrl 30330000.iomuxc: initialized IMX pinctrl driver
[ 0.044067] vdd1p0d: Bringing 0uV into 800000-800000uV
[ 0.044747] vdd1p2: supplied by regulator-dummy
[ 0.065937] cryptd: max_cpu_qlen set to 1000
[ 0.084537] mxs-dma 33000000.dma-apbh: initialized
[ 0.086224] regulator-usbh-vbus GPIO handle specifies active low - ignored
[ 0.086483] VCC_USB[1-4]: supplied by 5V
[ 0.086959] vgaarb: loaded
[ 0.087558] SCSI subsystem initialized
[ 0.087843] libata version 3.00 loaded.
[ 0.088132] usbcore: registered new interface driver usbfs
[ 0.088207] usbcore: registered new interface driver hub
[ 0.088268] usbcore: registered new device driver usb
[ 0.088436] usb_phy_generic usbphynop1: usbphynop1 supply vcc not found, using dummy regulator
[ 0.088685] usb_phy_generic usbphynop3: usbphynop3 supply vcc not found, using dummy regulator
[ 0.089021] usb_phy_generic usbphynop2: usbphynop2 supply vcc not found, using dummy regulator
[ 0.090599] i2c i2c-0: IMX I2C adapter registered
[ 0.091464] i2c i2c-3: IMX I2C adapter registered
[ 0.091771] pps_core: LinuxPPS API ver. 1 registered
[ 0.091793] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti giometti@linux.it
[ 0.091835] PTP clock support registered
[ 0.092136] Advanced Linux Sound Architecture Driver Initialized.
[ 0.093030] Bluetooth: Core ver 2.22
[ 0.093098] NET: Registered protocol family 31
[ 0.093116] Bluetooth: HCI device and connection manager initialized
[ 0.093141] Bluetooth: HCI socket layer initialized
[ 0.093161] Bluetooth: L2CAP socket layer initialized
[ 0.093193] Bluetooth: SCO socket layer initialized
[ 0.093869] clocksource: Switched to clocksource arch_sys_counter
[ 0.665106] VFS: Disk quotas dquot_6.6.0
[ 0.665215] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 0.675417] thermal_sys: Registered thermal governor ‘step_wise’
[ 0.675813] NET: Registered protocol family 2
[ 0.676051] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
[ 0.677329] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear)
[ 0.677393] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
[ 0.677497] TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
[ 0.677656] TCP: Hash tables configured (established 8192 bind 8192)
[ 0.677785] UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
[ 0.677854] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
[ 0.678080] NET: Registered protocol family 1
[ 0.678741] RPC: Registered named UNIX socket transport module.
[ 0.678767] RPC: Registered udp transport module.
[ 0.678783] RPC: Registered tcp transport module.
[ 0.678798] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 0.678824] PCI: CLS 0 bytes, default 64
[ 0.679614] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 5 counters available
[ 0.682585] Initialise system trusted keyrings
[ 0.682814] workingset: timestamp_bits=14 max_order=18 bucket_order=4
[ 0.690929] NFS: Registering the id_resolver key type
[ 0.690986] Key type id_resolver registered
[ 0.691002] Key type id_legacy registered
[ 0.736967] NET: Registered protocol family 38
[ 0.737012] Key type asymmetric registered
[ 0.737030] Asymmetric key parser ‘x509’ registered
[ 0.737119] bounce: pool size: 64 pages
[ 0.737178] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247)
[ 0.737340] io scheduler mq-deadline registered
[ 0.737362] io scheduler kyber registered
[ 0.743850] debugfs: Directory ‘dummy-src@30390000’ with parent ‘regmap’ already present!
[ 0.804899] 30860000.serial: ttymxc0 at MMIO 0x30860000 (irq = 52, base_baud = 1500000) is a IMX
[ 1.572108] printk: console [ttymxc0] enabled
[ 1.577429] 30890000.serial: ttymxc1 at MMIO 0x30890000 (irq = 53, base_baud = 1500000) is a IMX
[ 1.587033] 30880000.serial: ttymxc2 at MMIO 0x30880000 (irq = 54, base_baud = 1500000) is a IMX
[ 1.603199] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[ 1.609887] [drm] No driver support for vblank timestamp query.
[ 1.617114] [drm] Initialized mxsfb-drm 1.0.0 20160824 for 30730000.lcdif on minor 0
[ 1.634236] Console: switching to colour frame buffer device 80x30
[ 1.648150] mxsfb 30730000.lcdif: fb0: mxsfb-drmdrmfb frame buffer device
[ 1.669809] brd: module loaded
[ 1.685957] loop: module loaded
[ 1.712985] pps pps0: new PPS source ptp0
[ 1.724104] fec 30be0000.ethernet eth0: registered PHC device 0
[ 1.733548] ehci_hcd: USB 2.0 ‘Enhanced’ Host Controller (EHCI) Driver
[ 1.743463] ehci-pci: EHCI PCI platform driver
[ 1.751259] ehci-mxc: Freescale On-Chip EHCI Host driver
[ 1.760689] usbcore: registered new interface driver usb-storage
[ 1.770113] usbcore: registered new interface driver usbserial_generic
[ 1.779931] usbserial: USB Serial support registered for generic
[ 1.791013] imx_usb 30b10000.usb: No over current polarity defined
[ 1.800469] imx_usb 30b10000.usb: 30b10000.usb supply vbus not found, using dummy regulator
[ 1.819510] imx_usb 30b20000.usb: No over current polarity defined
[ 1.831827] ci_hdrc ci_hdrc.1: EHCI Host Controller
[ 1.839953] ci_hdrc ci_hdrc.1: new USB bus registered, assigned bus number 1
[ 1.873900] ci_hdrc ci_hdrc.1: USB 2.0 started, EHCI 1.00
[ 1.883244] hub 1-0:1.0: USB hub found
[ 1.889995] hub 1-0:1.0: 1 port detected
[ 1.901161] input: AD7879 Touchscreen as /devices/platform/soc/30800000.aips-bus/30a20000.i2c/i2c-0/0-002c/input/input0
[ 1.920487] snvs_rtc 30370000.snvs:snvs-rtc-lp: registered as rtc0
[ 1.930435] i2c /dev entries driver
[ 1.937360] pps_ldisc: PPS line discipline registered
[ 1.947023] imx2-wdt 30280000.wdog: timeout 60 sec (nowayout=0)
[ 1.956396] /cpus/cpu@0: unsupported enable-method property: psci
[ 1.966000] sdhci: Secure Digital Host Controller Interface driver
[ 1.975173] sdhci: Copyright(c) Pierre Ossman
[ 1.982483] Synopsys Designware Multimedia Card Interface Driver
[ 1.991792] sdhci-pltfm: SDHCI platform and OF driver helper
[ 2.001687] sdhci-esdhc-imx 30b40000.usdhc: Got CD GPIO
[ 2.044303] mmc0: SDHCI controller on 30b40000.usdhc [30b40000.usdhc] using ADMA
[ 2.088179] mmc1: SDHCI controller on 30b60000.usdhc [30b60000.usdhc] using ADMA
[ 2.106918] caam 30900000.caam: device ID = 0x0a16030000000000 (Era 8)
[ 2.116990] caam 30900000.caam: job rings = 3, qi = 0
[ 2.127337] caam_jr 30901000.jr0: failed to flush job ring 0
[ 2.136478] caam_jr: probe of 30901000.jr0 failed with error -5
[ 2.145921] caam_jr 30902000.jr1: failed to flush job ring 1
[ 2.155024] caam_jr: probe of 30902000.jr1 failed with error -5
[ 2.164405] caam_jr 30903000.jr1: failed to flush job ring 2
[ 2.173467] caam_jr: probe of 30903000.jr1 failed with error -5
[ 2.183590] usbcore: registered new interface driver usbhid
[ 2.192520] usbhid: USB HID core driver
[ 2.202687] usbcore: registered new interface driver snd-usb-audio
[ 2.215227] sgtl5000 0-000a: sgtl5000 revision 0x11
[ 2.249189] random: fast init done
[ 2.270070] NET: Registered protocol family 10
[ 2.280253] Segment Routing with IPv6
[ 2.287270] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[ 2.297208] NET: Registered protocol family 17
[ 2.305053] Key type dns_resolver registered
[ 2.313080] imx-cpufreq-dt imx-cpufreq-dt: cpu speed grade 2 mkt segment 1 supported-hw 0x4 0x2
[ 2.330810] Registering SWP/SWPB emulation handler
[ 2.350229] registered taskstats version 1
[ 2.356827] Loading compiled-in X.509 certificates
[ 2.403519] mmc1: new HS200 MMC card at address 0001
[ 2.408791] vdd1p0d: supplied by DCDC3
[ 2.411793] mmcblk1: mmc1:0001 S40004 3.64 GiB
[ 2.419222] imx_thermal tempmon: Extended Commercial CPU temperature grade - max:105C critical:105C passive:95C
[ 2.423613] mmcblk1boot0: mmc1:0001 S40004 partition 1 4.00 MiB
[ 2.443602] input: gpio-keys as /devices/platform/gpio-keys/input/input1
[ 2.446410] mmcblk1boot1: mmc1:0001 S40004 partition 2 4.00 MiB
[ 2.463160] snvs_rtc 30370000.snvs:snvs-rtc-lp: setting system clock to 1970-01-01T00:00:00 UTC (0)
[ 2.477234] mmcblk1rpmb: mmc1:0001 S40004 partition 3 4.00 MiB, chardev (246:0)
[ 2.490713] ALSA device list:
[ 2.496263] No soundcards found.
[ 2.496918] mmcblk1: p1 p2
[ 2.516957] EXT4-fs (mmcblk1p2): INFO: recovery required on readonly filesystem
[ 2.529425] EXT4-fs (mmcblk1p2): write access will be enabled during recovery
[ 2.667333] EXT4-fs (mmcblk1p2): recovery complete
[ 2.677154] EXT4-fs (mmcblk1p2): mounted filesystem with ordered data mode. Opts: (null)
[ 2.691950] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[ 2.702352] devtmpfs: mounted
[ 2.711606] Freeing unused kernel memory: 1024K
[ 2.722105] Run /sbin/init as init process
[ 2.837072] systemd[1]: System time before build time, advancing clock.
[ 2.864266] systemd[1]: systemd 244.5+ 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)
[ 2.897531] systemd[1]: Detected architecture arm.
[ 2.997497] systemd[1]: Set hostname to .
[ 3.550273] random: systemd: uninitialized urandom read (16 bytes read)
[ 3.564373] systemd[1]: Created slice system-getty.slice.
[ 3.604195] random: systemd: uninitialized urandom read (16 bytes read)
[ 3.616888] systemd[1]: Created slice system-serial\x2dgetty.slice.
[ 3.654168] random: systemd: uninitialized urandom read (16 bytes read)
[ 3.666662] systemd[1]: Created slice User and Session Slice.
[ 3.704646] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[ 3.754528] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[ 3.804570] systemd[1]: Reached target Host and Network Name Lookups.
[ 3.844419] systemd[1]: Reached target Paths.
[ 3.884446] systemd[1]: Reached target Remote File Systems.
[ 3.924221] systemd[1]: Reached target Slices.
[ 3.964233] systemd[1]: Reached target Swap.
[ 4.036638] systemd[1]: Listening on RPCbind Server Activation Socket.
[ 4.074591] systemd[1]: Reached target RPC Port Mapper.
[ 4.131664] systemd[1]: Listening on Syslog Socket.
[ 4.174710] systemd[1]: Listening on initctl Compatibility Named Pipe.
[ 4.237975] systemd[1]: Condition check resulted in Journal Audit Socket being skipped.
[ 4.252993] systemd[1]: Listening on Journal Socket (/dev/log).
[ 4.295117] systemd[1]: Listening on Journal Socket.
[ 4.335419] systemd[1]: Listening on Network Service Netlink Socket.
[ 4.375663] systemd[1]: Listening on udev Control Socket.
[ 4.414626] systemd[1]: Listening on udev Kernel Socket.
[ 4.455107] systemd[1]: Condition check resulted in Huge Pages File System being skipped.
[ 4.475379] systemd[1]: Mounting POSIX Message Queue File System…
[ 4.521684] systemd[1]: Mounting Kernel Debug File System…
[ 4.577590] systemd[1]: Mounting Temporary Directory (/tmp)…
[ 4.621783] systemd[1]: Starting Create list of static device nodes for the current kernel…
[ 4.671358] systemd[1]: Starting RPC Bind…
[ 4.709965] systemd[1]: Starting File System Check on Root Device…
[ 4.752986] systemd[1]: Starting Journal Service…
[ 4.771379] systemd[1]: Starting Load Kernel Modules…
[ 4.799661] systemd[1]: Starting udev Coldplug all Devices…
[ 4.820425] systemd[1]: Started RPC Bind.
[ 4.828190] systemd[1]: Mounted POSIX Message Queue File System.
[ 4.839332] systemd[1]: Mounted Kernel Debug File System.
[ 4.848902] systemd[1]: Mounted Temporary Directory (/tmp).
[ 4.862701] systemd[1]: Started Create list of static device nodes for the current kernel.
[ 4.897214] systemd[1]: Started Load Kernel Modules.
[ 4.945102] systemd[1]: Started Journal Service.
[ 5.102420] EXT4-fs (mmcblk1p2): re-mounted. Opts: (null)
[ 5.260804] systemd-journald[148]: Received client request to flush runtime journal.
[ 6.450705] imx-sdma 30bd0000.sdma: loaded firmware 4.5
[ 6.473031] spi_imx 30840000.spi: probed
[ 6.511911] asoc-simple-card sound: sgtl5000 ↔ 308a0000.sai mapping ok
[ 7.990829] FAT-fs (mmcblk1p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
[ 9.803942] crng init done
[ 9.808838] random: 7 urandom warning(s) missed due to ratelimiting
[ 11.714930] Micrel KSZ8041 30be0000.ethernet-1:00: attached PHY driver [Micrel KSZ8041] (mii_bus:phy_addr=30be0000.ethernet-1:00, irq=POLL)

and the one for the other command:

root@colibri-imx7-emmc-07199522:/check_package# wget https://raw.githubuserconte
nt.com/toradex/tdx-info/master/tdx-info --output-document=tdx-info && sudo sh ./
tdx-info
Connecting to raw.githubusercontent.com (185.199.109.133:443)
wget: note: TLS certificate validation not implemented
saving to ‘tdx-info’
tdx-info 100% |********************************| 8977 0:00:00 ETA
‘tdx-info’ saved
-sh: sudo: not found

Regards
Marco

OK, You can remove the sudo on the command:

wget https://raw.githubusercontent.com/toradex/tdx-info/master/tdx-info --output-document=tdx-info && sh ./tdx-info

For running the check script, could you try it manually?
Drop the check_package folder on the module again (if it’s not already there) and run:

$ cd check_package
$ ./MX52LM04A11XUI_check /dev/mmcblk1

Also, do you have the dmesg output of a module that got stuck during boot? Could you get it?

Hi @rafael.tx ,

find below everything you requested.

Output of the command:

root@colibri-imx7-emmc-07199522:~# wget https://raw.githubusercontent.com/toradex/tdx-info/master/tdx-info --output-document=tdx-info && sh
 ./tdx-info
Connecting to raw.githubusercontent.com (185.199.110.133:443)
wget: note: TLS certificate validation not implemented
saving to 'tdx-info'
tdx-info             100% |*******************************************************************************************|  8977  0:00:00 ETA
'tdx-info' saved

Software summary
------------------------------------------------------------
Bootloader:               U-Boot
Kernel version:           5.4.193-5.7.2+git.f5d73fd6e9f8 #1 SMP Fri Jun 24 10:15:32 UTC 2022
Kernel command line:      root=PARTUUID=9756cbff-02 ro rootwait console=tty1 console=ttymxc0,115200n8 consoleblank=0
Distro name:              NAME="TDX Wayland with XWayland Upstream"
Distro version:           VERSION_ID=5.7.2-build.21
Hostname:                 colibri-imx7-emmc-07199522
------------------------------------------------------------

Hardware info
------------------------------------------------------------
HW model:                 Toradex Colibri iMX7D 1GB on Colibri Aster Board
Toradex version:          0039 V1.1B
Serial number:            07199522
Processor arch:           armv7l
------------------------------------------------------------

Output of the check (on the same module, after having run the above command):

root@colibri-imx7-emmc-07199522:/check_package# ./MX52LM04A11XUI_check /dev/mmcblk1
[  654.310296] sdhci-esdhc-imx 30b60000.usdhc: __mmc_blk_ioctl_cmd: data error -110
MXIC eMMC : CMD56 Arg:0x00000011 [  654.318372] sdhci-esdhc-imx 30b60000.usdhc: __mmc_blk_ioctl_cmd: cmd error -110
Rsp0:0x00000900 Rsp1:0x00000000 Rsp2:0x00000000 Rsp3:0x00000000
mxic_emmc_health_command error : -1, arg : 0x00000011
MXIC eMMC : CMD56 Arg:0x0000002[  654.338844] sdhci-esdhc-imx 30b60000.usdhc: __mmc_blk_ioctl_cmd: cmd error -110
1 Rsp0:0x00000000 Rsp1:0x00000000 Rsp2:0x00000000 Rsp3:0x00000000
mxic_emmc_health_command error : -1, arg : 0x00000021
[  654.357735] sdhci-esdhc-imx 30b60000.usdhc: __mmc_blk_ioctl_cmd: cmd error -110
MXIC eMMC : CMD56 Arg:0x00000043 Rsp0:0x00000000 Rsp1:0x00000000 Rsp2:0x00000000 Rsp3:0x00000000
mxic_emmc_health_command error : -1, arg : 0x00000043
ioctl: MMC_SEND_EXT_CSD error : -1
mxic_emmc_read_extcsd Fail.
This eMMC is NOT at risk of Forced Read Only Mode

dmesg from a stuck module:



U-Boot 2019.07-3.0.4+g26d926eda0 (May 22 2023 - 11:48:05 +0000)

CPU:   Freescale i.MX7D rev1.3 1000 MHz (running at 792 MHz)
CPU:   Extended Commercial temperature grade (-20C to 105C) at 28C
Reset cause: POR
DRAM:  1 GiB
PMIC:  RN5T567 LSIVER=0x01 OTPVER=0x0d
MMC:   FSL_SDHC: 1, FSL_SDHC: 0
Loading Environment from MMC... OK
In:    serial
Out:   serial
Err:   serial
Model: Toradex Colibri iMX7 Dual 1GB (eMMC) V1.1B, Serial# 07199518
SEC0: RNG instantiated
Net:   FEC0
Hit any key to stop autoboot:  0
Booting from internal eMMC chip...
322364 bytes read in 61 ms (5 MiB/s)
## Starting auxiliary core stack = 0x00000000, pc = 0x1FFF80BD...
46694 bytes read in 191 ms (238.3 KiB/s)
5937640 bytes read in 351 ms (16.1 MiB/s)
Kernel image @ 0x81000000 [ 0x000000 - 0x5a99e8 ]
## Flattened Device Tree blob at 82000000
   Booting using the fdt blob at 0x82000000
   Using Device Tree in place at 82000000, end 8200e665

Starting kernel ...

Output of the check on the same module that was stuck in the test above (after being flashed with Colibri-iMX7-eMMC_Reference-Minimal-Image-upstream-Tezi_5.7.2+build.21):

root@colibri-imx7-emmc-07199518:/check_package# ./MX52LM04A11XUI_check /dev/mmcblk1
[   89.538748] sdhci-esdhc-imx 30b60000.usdhc: __mmc_blk_ioctl_cmd: data error -110
MXIC eMMC : CMD56 Arg:0x00000011 [   89.546768] sdhci-esdhc-imx 30b60000.usdhc: __mmc_blk_ioctl_cmd: cmd error -110
Rsp0:0x00000900 Rsp1:0x00000000 R[   89.557502] sdhci-esdhc-imx 30b60000.usdhc: __mmc_blk_ioctl_cmd: cmd error -110
sp2:0x00000000 Rsp3:0x00000000
m[   89.567839] sdhci-esdhc-imx 30b60000.usdhc: __mmc_blk_ioctl_cmd: cmd error -110
xic_emmc_health_command error : -1, arg : 0x00000011
MXIC eMMC : CMD56 Arg:0x00000021 Rsp0:0x00000000 Rsp1:0x00000000 Rsp2:0x00000000 Rsp3:0x00000000
mxic_emmc_health_command error : -1, arg : 0x00000021
MXIC eMMC : CMD56 Arg:0x00000043 Rsp0:0x00000000 Rsp1:0x00000000 Rsp2:0x00000000 Rsp3:0x00000000
mxic_emmc_health_command error : -1, arg : 0x00000043
ioctl: MMC_SEND_EXT_CSD error : -1
mxic_emmc_read_extcsd Fail.
This eMMC is NOT at risk of Forced Read Only Mode

Regards,
Marco

@kevin.tx, @rafael.tx,

what can you suggest from the logs above?

I still have 3 more modules stuck if you need me to run more tests.

Thank you,
Marco

It seems the eMMC didn’t respond to the commands necessary to perform the check. I have some other questions:
In this module that you ran the check, can you still flash something to it? Do you get any errors while booting it?
On the stuck modules, are you running a custom image or one of our own? If it’s a custom image, do you have the kernel set to quiet mode on boot, or is it that we would see kernel output if it booted properly?

Hi @rafael.tx,

Yes I’m able to re-flash it with our image and it runs normally.

We are running our own image based on your console-tdx-image.
We don’t set the kernel to quiet mode.
Below the output on the board I’ve just re-flashed with our image after the test:



U-Boot 2019.07-3.0.4+g26d926eda0 (May 22 2023 - 11:48:05 +0000)

CPU:   Freescale i.MX7D rev1.3 1000 MHz (running at 792 MHz)
CPU:   Extended Commercial temperature grade (-20C to 105C) at 28C
Reset cause: POR
DRAM:  1 GiB
PMIC:  RN5T567 LSIVER=0x01 OTPVER=0x0d
MMC:   FSL_SDHC: 1, FSL_SDHC: 0
Loading Environment from MMC... OK
In:    serial
Out:   serial
Err:   serial
Model: Toradex Colibri iMX7 Dual 1GB (eMMC) V1.1B, Serial# 07199518
SEC0: RNG instantiated
Net:   FEC0
Hit any key to stop autoboot:  0
Booting from internal eMMC chip...
25972 bytes read in 12 ms (2.1 MiB/s)
## Starting auxiliary core stack = 0x00000000, pc = 0x1FFF80BD...
46694 bytes read in 9 ms (4.9 MiB/s)
5937640 bytes read in 116 ms (48.8 MiB/s)
Kernel image @ 0x81000000 [ 0x000000 - 0x5a99e8 ]
## Flattened Device Tree blob at 82000000
   Booting using the fdt blob at 0x82000000
   Using Device Tree in place at 82000000, end 8200e665

Starting kernel ...

[    0.000000] Booting Linux on physical CPU 0x0
[    0.000000] Linux version 4.14.170-3.0.4+gbaa6c24240a4 (oe-user@oe-host) (gcc version 8.2.0 (GCC)) #1 SMP Mon Mar 27 12:15:11 UTC 2023
[    0.000000] CPU: ARMv7 Processor [410fc075] revision 5 (ARMv7), cr=10c5387d
[    0.000000] CPU: div instructions available: patching division code
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[    0.000000] OF: fdt: Machine model: Toradex Colibri iMX7D 1GB (eMMC) on Colibri Evaluation Board V3
[    0.000000] Memory policy: Data cache writealloc
[    0.000000] Reserved memory: created CMA memory pool at 0xac000000, size 320 MiB
[    0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
[    0.000000] percpu: Embedded 15 pages/cpu s30924 r8192 d22324 u61440
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 259840
[    0.000000] Kernel command line: ip=off root=PARTUUID=d796f460-02 ro rootfstype=ext4 rootwait console=tty1 console=ttymxc0,115200n8 consoleblank=0
[    0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
[    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: 696876K/1047552K available (8192K kernel code, 353K rwdata, 2432K rodata, 1024K init, 393K bss, 22996K reserved, 327680K cma-reserved)
[    0.000000] Virtual kernel memory layout:
[    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
[    0.000000]     fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
[    0.000000]     vmalloc : 0xc0800000 - 0xff800000   (1008 MB)
[    0.000000]     lowmem  : 0x80000000 - 0xc0000000   (1024 MB)
[    0.000000]     modules : 0x7f000000 - 0x80000000   (  16 MB)
[    0.000000]       .text : 0x80008000 - 0x80900000   (9184 kB)
[    0.000000]       .init : 0x80c00000 - 0x80d00000   (1024 kB)
[    0.000000]       .data : 0x80d00000 - 0x80d58720   ( 354 kB)
[    0.000000]        .bss : 0x80d5a000 - 0x80dbc4d0   ( 394 kB)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[    0.000000] Hierarchical RCU implementation.
[    0.000000]  RCU event tracing is enabled.
[    0.000000]  RCU restricting CPUs from NR_CPUS=4 to nr_cpu_ids=2.
[    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[    0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[    0.000000] arch_timer: cp15 timer(s) running at 8.00MHz (phys).
[    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x1d854df40, max_idle_ns: 440795202120 ns
[    0.000007] sched_clock: 56 bits at 8MHz, resolution 125ns, wraps every 2199023255500ns
[    0.000019] Switching to timer-based delay loop, resolution 125ns
[    0.000342] Ignoring duplicate/late registration of read_current_timer delay
[    0.000360] clocksource: mxc_timer1: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 637086815595 ns
[    0.002034] Console: colour dummy device 80x30
[    0.002478] console [tty1] enabled
[    0.002506] Calibrating delay loop (skipped), value calculated using timer frequency.. 16.00 BogoMIPS (lpj=80000)
[    0.002536] pid_max: default: 32768 minimum: 301
[    0.002678] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.002706] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.003337] CPU: Testing write buffer coherency: ok
[    0.003980] Setting up static identity map for 0x80100000 - 0x80100060
[    0.004127] Hierarchical SRCU implementation.
[    0.004694] smp: Bringing up secondary CPUs ...
[    0.005480] smp: Brought up 1 node, 2 CPUs
[    0.005505] SMP: Total of 2 processors activated (32.00 BogoMIPS).
[    0.005521] CPU: All CPU(s) started in SVC mode.
[    0.006293] devtmpfs: initialized
[    0.015679] random: get_random_u32 called from bucket_table_alloc+0x100/0x230 with crng_init=0
[    0.016128] VFP support v0.3: implementor 41 architecture 2 part 30 variant 7 rev 5
[    0.016395] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.016434] futex hash table entries: 512 (order: 3, 32768 bytes)
[    0.027805] pinctrl core: initialized pinctrl subsystem
[    0.028792] NET: Registered protocol family 16
[    0.034448] DMA: preallocated 256 KiB pool for atomic coherent allocations
[    0.035480] cpuidle: using governor menu
[    0.042216] vdd1p0d: supplied by regulator-dummy
[    0.042710] vdd1p2: supplied by regulator-dummy
[    0.045273] DDR type is DDR3!
[    0.051860] imx7d_enet_clk_sel: fec-18: failed to get enet_out clock, assuming ext. clock source
[    0.051942] imx7d_enet_clk_sel: fec-18: found enet_out clock, assuming internal clock source
[    0.052092] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[    0.052118] hw-breakpoint: maximum watchpoint size is 8 bytes.
[    0.052383] imx7d-pinctrl 302c0000.iomuxc-lpsr: initialized IMX pinctrl driver
[    0.053004] imx7d-pinctrl 30330000.iomuxc: initialized IMX pinctrl driver
[    0.055026] MU is ready for cross core communication!
[    0.055240] platform 30800000.aips-bus: coherent DMA mask is unset
[    0.055766] virtio_rpmsg_bus virtio0: rpmsg host is online
[    0.055973] imx rpmsg driver is registered.
[    0.056825] MU is ready for cross core communication!
[    0.074700] VCC_USB[1-4]: supplied by 5V
[    0.075425] SCSI subsystem initialized
[    0.075641] usbcore: registered new interface driver usbfs
[    0.075717] usbcore: registered new interface driver hub
[    0.075825] usbcore: registered new device driver usb
[    0.076039] usb_phy_generic 30800000.aips-bus:usbphynop1: 30800000.aips-bus:usbphynop1 supply vcc not found, using dummy regulator
[    0.076365] usb_phy_generic 30800000.aips-bus:usbphynop2: 30800000.aips-bus:usbphynop2 supply vcc not found, using dummy regulator
[    0.077553] i2c i2c-0: IMX I2C adapter registered
[    0.077583] i2c i2c-0: can't use DMA, using PIO instead.
[    0.077774] Linux video capture interface: v2.00
[    0.077844] pps_core: LinuxPPS API ver. 1 registered
[    0.077861] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.077899] PTP clock support registered
[    0.078138] Advanced Linux Sound Architecture Driver Initialized.
[    0.079355] clocksource: Switched to clocksource arch_sys_counter
[    0.079489] VFS: Disk quotas dquot_6.6.0
[    0.079559] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    0.087473] NET: Registered protocol family 2
[    0.088100] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[    0.088204] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[    0.088359] TCP: Hash tables configured (established 8192 bind 8192)
[    0.088466] UDP hash table entries: 512 (order: 2, 16384 bytes)
[    0.088531] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[    0.088708] NET: Registered protocol family 1
[    0.089100] RPC: Registered named UNIX socket transport module.
[    0.089123] RPC: Registered udp transport module.
[    0.089138] RPC: Registered tcp transport module.
[    0.089152] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.091014] Bus freq driver module loaded
[    0.092039] workingset: timestamp_bits=30 max_order=18 bucket_order=0
[    0.096704] NFS: Registering the id_resolver key type
[    0.096754] Key type id_resolver registered
[    0.096770] Key type id_legacy registered
[    0.096795] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    0.097308] ntfs: driver 2.1.32 [Flags: R/W].
[    0.097588] fuse init (API version 7.26)
[    0.103829] Key type asymmetric registered
[    0.103884] io scheduler noop registered
[    0.103901] io scheduler deadline registered
[    0.104077] io scheduler cfq registered (default)
[    0.104098] io scheduler mq-deadline registered
[    0.104114] io scheduler kyber registered
[    0.108409] mxs-dma 33000000.dma-apbh: initialized
[    0.110684] 30860000.serial: ttymxc0 at MMIO 0x30860000 (irq = 52, base_baud = 1500000) is a IMX
[    0.828178] console [ttymxc0] enabled
[    0.832518] 30880000.serial: ttymxc2 at MMIO 0x30880000 (irq = 53, base_baud = 1500000) is a IMX
[    0.848881] loop: module loaded
[    0.867581] libphy: Fixed MDIO Bus: probed
[    0.874711] pps pps0: new PPS source ptp0
[    0.880451] libphy: fec_enet_mii_bus: probed
[    0.886078] fec 30be0000.ethernet eth0: registered PHC device 0
[    0.892290] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    0.898836] ehci-mxc: Freescale On-Chip EHCI Host driver
[    0.904351] usbcore: registered new interface driver usb-storage
[    0.910482] usbcore: registered new interface driver usbserial
[    0.916359] usbcore: registered new interface driver usbserial_generic
[    0.922946] usbserial: USB Serial support registered for generic
[    0.928996] usbcore: registered new interface driver cp210x
[    0.934621] usbserial: USB Serial support registered for cp210x
[    0.940620] usbcore: registered new interface driver ftdi_sio
[    0.946402] usbserial: USB Serial support registered for FTDI USB Serial Device
[    0.953801] usbcore: registered new interface driver pl2303
[    0.959426] usbserial: USB Serial support registered for pl2303
[    0.966394] usbmisc_imx 30b10200.usbmisc: 30b10200.usbmisc supply vbus-wakeup not found, using dummy regulator
[    0.976616] usbmisc_imx 30b30200.usbmisc: 30b30200.usbmisc supply vbus-wakeup not found, using dummy regulator
[    0.986844] usbmisc_imx 30b20200.usbmisc: 30b20200.usbmisc supply vbus-wakeup not found, using dummy regulator
[    1.000940] ci_hdrc ci_hdrc.0: EHCI Host Controller
[    1.005878] ci_hdrc ci_hdrc.0: new USB bus registered, assigned bus number 1
[    1.039379] ci_hdrc ci_hdrc.0: USB 2.0 started, EHCI 1.00
[    1.045533] hub 1-0:1.0: USB hub found
[    1.049335] hub 1-0:1.0: 1 port detected
[    1.057310] input: AD7879 Touchscreen as /devices/soc0/soc/30800000.aips-bus/30a20000.i2c/i2c-0/0-002c/input/input0
[    1.068791] snvs_rtc 30370000.snvs:snvs-rtc-lp: registered as rtc1
[    1.075159] i2c /dev entries driver
[    1.079038] IR NEC protocol handler initialized
[    1.083606] IR RC5(x/sz) protocol handler initialized
[    1.088669] IR RC6 protocol handler initialized
[    1.093220] IR JVC protocol handler initialized
[    1.097760] IR Sony protocol handler initialized
[    1.102395] IR SANYO protocol handler initialized
[    1.107109] IR Sharp protocol handler initialized
[    1.111834] IR MCE Keyboard/mouse protocol handler initialized
[    1.117678] IR XMP protocol handler initialized
[    1.124153] imx2-wdt 30280000.wdog: timeout 60 sec (nowayout=0)
[    1.131581] sdhci: Secure Digital Host Controller Interface driver
[    1.137783] sdhci: Copyright(c) Pierre Ossman
[    1.142191] sdhci-pltfm: SDHCI platform and OF driver helper
[    1.209411] mmc0: SDHCI controller on 30b60000.usdhc [30b60000.usdhc] using ADMA
[    1.223009] caam 30900000.caam: ERA source: CCBVID.
[    1.228908] caam 30900000.caam: device ID = 0x0a16030000000000 (Era 8)
[    1.235507] caam 30900000.caam: job rings = 3, qi = 0, dpaa2 = no
[    1.254657] caam algorithms registered in /proc/crypto
[    1.263069] caam_jr 30901000.jr0: registering rng-caam
[    1.268448] caam 30900000.caam: caam pkc algorithms registered in /proc/crypto
[    1.276654] hidraw: raw HID events driver (C) Jiri Kosina
[    1.282294] usbcore: registered new interface driver usbhid
[    1.287906] usbhid: USB HID core driver
[    1.295967] coresight-etm3x 3007c000.etm: ETM 3.5 initialized
[    1.302094] coresight-etm3x 3007d000.etm: ETM 3.5 initialized
[    1.310254] Netfilter messages via NETLINK v0.30.
[    1.314988] nfnl_acct: registering with nfnetlink.
[    1.320017] nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
[    1.326373] nf_tables: (c) 2007-2009 Patrick McHardy <kaber@trash.net>
[    1.333262] ip_tables: (C) 2000-2006 Netfilter Core Team
[    1.340156] NET: Registered protocol family 10
[    1.345501] Segment Routing with IPv6
[    1.349248] ip6_tables: (C) 2000-2006 Netfilter Core Team
[    1.354796] NET: Registered protocol family 17
[    1.359305] Bridge firewalling registered
[    1.363456] 8021q: 802.1Q VLAN Support v1.8
[    1.367811] Key type dns_resolver registered
[    1.378452] Registering SWP/SWPB emulation handler
[    1.383741] registered taskstats version 1
[    1.394650] mmc0: new HS200 MMC card at address 0001
[    1.400537] mmcblk0: mmc0:0001 S40004 3.64 GiB
[    1.405722] mmcblk0boot0: mmc0:0001 S40004 partition 1 4.00 MiB
[    1.412194] mmcblk0boot1: mmc0:0001 S40004 partition 2 4.00 MiB
[    1.418370] mmcblk0rpmb: mmc0:0001 S40004 partition 3 4.00 MiB, chardev (248:0)
[    1.429670] ci_hdrc ci_hdrc.1: EHCI Host Controller
[    1.430216]  mmcblk0: p1 p2
[    1.434587] ci_hdrc ci_hdrc.1: new USB bus registered, assigned bus number 2
[    1.469439] ci_hdrc ci_hdrc.1: USB 2.0 started, EHCI 1.00
[    1.475493] hub 2-0:1.0: USB hub found
[    1.479287] hub 2-0:1.0: 1 port detected
[    1.484388] (NULL device *): hwmon_device_register() is deprecated. Please convert the driver to use hwmon_device_register_with_info().
[    1.496847] imx_thermal 30000000.aips-bus:tempmon: Extended Commercial CPU temperature grade - max:105C critical:105C passive:95C
[    1.510076] hctosys: unable to open rtc device (rtc0)
[    1.526079] 3.3V: disabling
[    1.528902] ALSA device list:
[    1.531900]   No soundcards found.
[    1.545702] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[    1.553921] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[    1.564037] devtmpfs: mounted
[    1.568085] Freeing unused kernel memory: 1024K
[    1.599245] random: fast init done
[    1.664192] systemd[1]: System time before build time, advancing clock.
[    1.678613] systemd[1]: systemd 239 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)
[    1.700441] systemd[1]: Detected architecture arm.

Welcome to TDX Wayland with XWayland 2.6-snapshot-20210915 (thud)!

[    1.742743] systemd[1]: Set hostname to <colibri-imx7-emmc>.
[    2.076644] random: systemd: uninitialized urandom read (16 bytes read)
[    2.084578] systemd[1]: Created slice system-serial\x2dgetty.slice.
[  OK  ] Created slice system-serial\x2dgetty.slice.
[    2.119632] random: systemd: uninitialized urandom read (16 bytes read)
[    2.126564] systemd[1]: Listening on initctl Compatibility Named Pipe.
[  OK  ] Listening on initctl Compatibility Named Pipe.
[    2.159563] random: systemd: uninitialized urandom read (16 bytes read)
[    2.166235] systemd[1]: Reached target Remote File Systems.
[  OK  ] Reached target Remote File Systems.
[    2.199630] systemd[1]: Reached target Swap.
[  OK  ] Reached target Swap.
[    2.230101] systemd[1]: Listening on Journal Socket (/dev/log).
[  OK  ] Listening on Journal Socket (/dev/log).
[    2.260115] systemd[1]: Listening on Journal Socket.
[  OK  ] Listening on Journal Socket.
[    2.292489] systemd[1]: Starting File System Check on Root Device...
         Starting File System Check on Root Device...
         Starting Load Kernel Modules...
         Mounting Temporary Directory (/tmp)...
         Starting Create list of required st…ce nodes for the current kernel...
[  OK  ] Started Forward Password Requests to Wall Directory Watch.
[  OK  ] Created slice system-getty.slice.
[  OK  ] Listening on udev Control Socket.
         Mounting Kernel Debug File System...
[  OK  ] Listening on udev Kernel Socket.
         Starting udev Coldplug all Devices...
[  OK  ] Reached target Host and Network Name Lookups.
[  OK  ] Started Dispatch Password Requests to Console Directory Watch.
[  OK  ] Reached target Paths.
[  OK  ] Listening on Syslog Socket.
         Starting Journal Service...
[  OK  ] Created slice User and Session Slice.
[  OK  ] Reached target Slices.
[    2.557627] random: crng init done Gatherer Daemon.

[    2.561581] random: 7 urandom warning(s) missed due to ratelimiting
[  OK  ] Listening on Network Service Netlink Socket.
[  OK  ] Started Journal Service.
[  OK  ] Started File System Check on Root Device.
[  OK  ] Started Load Kernel Modules.
[  OK  ] Mounted Temporary Directory (/tmp).
[  OK  ] Started Create list of required sta…vice nodes for the current kernel.
[  OK  ] Mounted Kernel Debug File System.
         Starting Apply Kernel Variables...
         Mounting FUSE Control File System...
         Mounting Kernel Configuration File System...
         Starting Remount Root and Kernel File Systems...
[  OK  ] Started Apply Kernel Variables.
[  OK  ] Mounted FUSE Control File System.
[    2.977039] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[  OK  ] Mounted Kernel Configuration File System.
[  OK  ] Started Remount Root and Kernel File Systems.
         Starting Create Static Device Nodes in /dev...
         Starting Flush Journal to Persistent Storage...
[  OK  ] Started udev Coldplug all Devices.
[  OK  ] Started Create Static Device Nodes in /dev.
[    3.185662] systemd-journald[177]: Received request to flush runtime journal from PID 1
[  OK  ] Reached target Local File Systems (Pre).
         Mounting /var/volatile...
[  OK  ] Reached target Containers.
         Starting udev Kernel Device Manager...
[  OK  ] Started Flush Journal to Persistent Storage.
[  OK  ] Started udev Kernel Device Manager.
[  OK  ] Mounted /var/volatile.
         Starting Load/Save Random Seed...
[  OK  ] Reached target Local File Systems.
         Starting Create Volatile Files and Directories...
[  OK  ] Started Load/Save Random Seed.
[  OK  ] Started Create Volatile Files and Directories.
         Starting Network Time Synchronization...
         Starting Update UTMP about System Boot/Shutdown...
[    3.703109] CAN device driver interface
[    3.726445] flexcan 30a00000.can: 30a00000.can supply xceiver not found, using dummy regulator
[  OK  ] Found device /dev/ttymxc0.
[    3.784532] sgtl5000 0-000a: sgtl5000 revision 0x11
[    3.799425] flexcan 30a00000.can: device registered (reg_base=f5a00000, irq=56)
[    3.825356] imx-sdma 30bd0000.sdma: no iram assigned, using external mem
[    3.845420] imx-sdma 30bd0000.sdma: loaded firmware 4.2
[    3.920543] asoc-simple-card sound: sgtl5000 <-> 308a0000.sai mapping ok
[  OK  ] Started Update UTMP about System Boot/Shutdown.
[  OK  ] Started Network Time Synchronization.
[  OK  ] Reached target System Initialization.
[  OK  ] Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
[    4.652026] FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
[  OK  ] Listening on dropbear.socket.
[  OK  ] Started Daily Cleanup of Temporary Directories.
[  OK  ] Reached target Timers.
[  OK  ] Listening on D-Bus System Message Bus Socket.
[  OK  ] Listening on RPCbind Server Activation Socket.
[  OK  ] Reached target Sockets.
[  OK  ] Reached target Basic System.
[  OK  ] Started Power Monitor.
[  OK  ] Started Timestamping service.
         Starting Save/Restore Sound Card State...
[  OK  ] Started Kernel Logging Service.
         Starting Avahi mDNS/DNS-SD Stack...
[  OK  ] Started D-Bus System Message Bus.
         Starting Connection service...
         Starting Telephony service...
         Starting Load default USB gadget schema g1.schema...
[  OK  ] Started System Logging Service.
[    5.224197] Bluetooth: Core ver 2.22
[    5.235777] using random self ethernet address
[    5.240340] using random host ethernet address
         [    5.248938] NET: Registered protocol family 31
Starting Login Service...
[    5.254201] Bluetooth: HCI device and connection manager initialized
[    5.266243] Bluetooth: HCI socket layer initialized
[  OK  ] Started Applic[    5.272493] Bluetooth: L2CAP socket layer initialized
ation Monitor.
         Starting RPC Bind Service...
[    5.287705] Bluetooth: SCO socket layer initialized
[  OK  ] Reached target System Time Synchronized.
[  OK  ] Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
[  OK  ] Started Save/Restore Sound Card State.
[  OK  ] Started RPC Bind Service.
[    5.549552] Micrel KSZ8041 30be0000.ethernet-1:00: attached PHY driver [Micrel KSZ8041] (mii_bus:phy_addr=30be0000.ethernet-1:00, irq=POLL)
[    5.569166] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[    5.695497] usb0: HOST MAC 00:14:2d:ff:ff:fe
[    5.713477] usb0: MAC 00:14:2d:ff:ff:ff
[  OK  ] Started Load default USB gadget schema g1.schema.
         Starting Hostname Service...
         Starting Network Service...
         Starting WPA supplicant...
[  OK  ] Reached target Sound Card.
[    5.913077] IPv6: ADDRCONF(NETDEV_UP): usb0: link is not ready
[  OK  ] Started Network Service.
[  OK  ] Started WPA supplicant.
[  OK  ] Started Connection service.
[  OK  ] Started Login Service.
[  OK  ] Started Avahi mDNS/DNS-SD Stack.
[  OK  ] Started Telephony service.
[  OK  ] Started Hostname Service.
[  OK  ] Reached target Network.
         Starting Network Time Service...
         Starting Permit User Sessions...
         Starting Install MySQL Community Server Database...
         Starting Nginx Server...
[  OK  ] Started NFS status monitor for NFSv2/3 locking..
[  OK  ] Started Network Time Service.
[  OK  ] Started Permit User Sessions.
[  OK  ] Started Install MySQL Community Server Database.
[  OK  ] Started Nginx Server.
         Starting Weston Wayland Compositor (on tty7)...
[  OK  ] Started Serial Getty on ttymxc0.
[  OK  ] Started Getty on tty1.
[  OK  ] Reached target Login Prompts.
[  OK  ] Started Weston Wayland Compositor (on tty7).
         Starting Start a wayland application...
[  OK  ] Created slice User Slice of UID 0.
[  OK  ] Created slice system-user\x2druntime\x2ddir.slice.
[  OK  ] Started /run/user/0 mount wrapper.
         Starting User Manager for UID 0...
[  OK  ] Started Session c1 of user root.
[  OK  ] Started User Manager for UID 0.
         Stopping User Manager for UID 0...
[  OK  ] Stopped User Manager for UID 0.
[  OK  ] Removed slice User Slice of UID 0.
         Stopping /run/user/0 mount wrapper...
[  OK  ] Stopped /run/user/0 mount wrapper.
         Starting Time & Date Service...
[  OK  ] Started Time & Date Service.

[   12.529791] IPv6: ADDRCONF(NETDEV_UP): can0: link is not ready
[   12.536385] IPv6: ADDRCONF(NETDEV_CHANGE): can0: link becomes ready
TDX Wayland with XWayland 2.6-snapshot colibri-imx7-emmc ttymxc0

EST-OCTO-SC_MPU-Image 3.0b4 20231005

Thanks
Marco

Hi @rafael.tx,

can you say anything on what’s going on with these boards?

Thanks
Marco

Hi @rafael.tx, @kevin.tx,

it happened again (SN 07199425) during a simple system reboot.

Can you please support us on this?

Thank you
Marco

@mortolaniEST I created a new thread for your issue, I’m pretty confident it’s not the same issue described in this thread, as this one was reproduced in Colibri iMX7 1.1A only. Here’s the link to the new thread:

I asked more questions there.

@mortolaniEST ,

I don’t see where you answered question about kind of carrier board You re using. Occasional hang up on boot may be caused by to weak power supply, either external one or on board DC-DC.

Hi @Edward,

We use a custom carrier board, this is the answer about the power management towards the Colibri board from our hardware engineer:

The system is powered from 2 separate 24V inputs.
Each 24V input goes into an isolated IRE-24/5-Q12PF-C power supply (24V 100W). The supplies have 44uF each on the output, and around 100uF on its inputs.
The outputs of the 2 power supplies are connected in parallel through Schottky diodes.
This forms the 24V_Sys voltage. This 24V_sys line also powers the contactors and the CAN communication interfaces.
The contactors are 3x LS Electronic GPR-M400-A, which use 0.1875A when on (closed) and 2.1 A during turn-on.
Only one turns on at a time, so peak consumption is 20.1875+12.1=2.475A from the contactors.
Power consumpiotn for the CAN interfaces is minimal.
This 24V_sys voltage is then converted to an isolated 12V using a IRS-12/4.5-Q12PF-C (12V 54W), again with 44uF on the output.
12V is then converted to 5V using a MAX17701 constant current buck regulator, which has a total of 5F of supercapacitors on the output to stabilize the voltage.
The 3.3V needed for the Colibri is generated from the 5V using a LTC3113 buck-boost regulator operating at Fsw = 2Mhz with L = 2.2 uH.
The regulator has an input voltage range of 1.8 to 5.5V. Its output capacitance consists of 2x 47uF of electrolytics, and 25uF of ceramic capacitors.
At the Colibri connector there is another 30uF of ceramic capacitors, and multiple 100nF capacitors.
The datasheet of LTC3113 shows a 200mv (to 3.1V) voltage dip when a 3A load step is applied.

Please let me know if you see weak spots in the design.

Thank you

Regards,
Marco

Hi @mortolaniEST

Perhaps nothing wrong with your approach and your design. I know it may be hard to catch voltage dip, especially if it happens rarely, but indeed possibility of it must be inspected and tested.

In the past NAND version failed to start with depleted RTC battery and low voltage on VCC_BATT. I don’t know if this still the case, we just moved to external RTC and our VCC_BATT is now connected to 3.3V supply.