i.mx8m-mini : imx6q-pcie 33800000.pcie: PCIe PLL lock timeout

rohit_k · ‎11-20-2020

Hello community,

We are using custom board based on i.mx8m-mini.

Yocto version : Zeus-fsl-5.4.3-mx8mm-v1.1

while booting this error occurs : imx6q-pcie 33800000.pcie: PCIe PLL lock timeout.

Please see log,

U-Boot 2019.04-lf-5.4.y_v2019.04_var01+g74c22e7054 (Oct 04 2020 - 19:00:10 +0000)
CPU:   Freescale i.MX8MMQ rev1.0 1600 MHz (running at 1200 MHz)
CPU:   Industrial temperature grade (-40C to 105C) at 32C
Reset cause: POR
Model: Varicsite DART-MX8MM
DRAM:  2 GiB
MMC:   FSL_SDHC: 1, FSL_SDHC: 2
Loading Environment from MMC... *** Warning - bad CRC, using default environment
In:    serial
Out:   serial
Err:   serial
 BuildInfo:
  - ATF 7b3389d
  - U-Boot 2019.04-lf-5.4.y_v2019.04_var01+g74c22e7054

Part number: VSM-DT8MM-220
Assembly: AS2007153586
Production date: 2020 Sep 22
Serial Number: f8:dc:7a:4d:36:0d
switch to partitions #0, OK
mmc1 is current device
flash target is MMC:1
Net:   eth0: ethernet@30be0000
Fastboot: Normal
Normal Boot
Hit any key to stop autoboot:  0 
switch to partitions #0, OK
mmc1 is current device
5763077 bytes read in 251 ms (21.9 MiB/s)
Uncompressed size: 12328968 = 0xBC2008
Booting from mmc ...
fdt_file=imx8mm-var-dart.dtb
44615 bytes read in 8 ms (5.3 MiB/s)
## Flattened Device Tree blob at 43000000
   Booting using the fdt blob at 0x43000000
   Using Device Tree in place at 0000000043000000, end 000000004300de46
Starting kernel ...
[    0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034]
[    0.000000] Linux version 5.4.3-imx8mm+g9447bf00ed07 (oe-user@oe-host) (gcc version 9.2.0 (GCC)) #1 SMP PREEMPT Fri Oct 30 09:20:29 UTC 2020
[    0.000000] Machine model: Variscite DART-MX8MM
[    0.000000] earlycon: ec_imx6q0 at MMIO 0x0000000030860000 (options '115200')
[    0.000000] printk: bootconsole [ec_imx6q0] enabled
[    0.000000] Reserved memory: created CMA memory pool at 0x0000000078000000, size 640 MiB
[    0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
[    0.000000] NUMA: No NUMA configuration found
[    0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x00000000bfffffff]
[    0.000000] NUMA: NODE_DATA [mem 0xbfbc7800-0xbfbc8fff]
[    0.000000] Zone ranges:
[    0.000000]   DMA32    [mem 0x0000000040000000-0x00000000bfffffff]
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000040000000-0x00000000bfffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfffffff]
[    0.000000] psci: probing for conduit method from DT.
[    0.000000] psci: PSCIv1.1 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.1
[    0.000000] percpu: Embedded 21 pages/cpu s48664 r8192 d29160 u86016
[    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] Speculative Store Bypass Disable mitigation not required
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 516096
[    0.000000] Policy zone: DMA32
[    0.000000] Kernel command line: console=ttymxc0,115200 earlycon=ec_imx6q,0x30860000,115200 root=/dev/mmcblk1p1 rootwait rw cma=640M@1376M
[    0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
[    0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
[    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[    0.000000] Memory: 1388816K/2097152K available (7934K kernel code, 584K rwdata, 2972K rodata, 512K init, 365K bss, 52976K reserved, 655360K cma-reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] rcu: Preemptible hierarchical RCU implementation.
[    0.000000] rcu:     RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4.
[    0.000000]  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=4
[    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[    0.000000] GICv3: GIC: Using split EOI/Deactivate mode
[    0.000000] GICv3: 128 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: no VLPI support, no direct LPI support
[    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x0000000038880000
[    0.000000] ITS: No ITS available, not enabling LPIs
[    0.000000] random: get_random_bytes called from start_kernel+0x2b4/0x434 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.000003] sched_clock: 56 bits at 8MHz, resolution 125ns, wraps every 2199023255500ns
[    0.008384] Console: colour dummy device 80x25
[    0.012575] Calibrating delay loop (skipped), value calculated using timer frequency.. 16.00 BogoMIPS (lpj=32000)
[    0.022843] pid_max: default: 32768 minimum: 301
[    0.027564] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
[    0.034923] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
[    0.066859] ASID allocator initialised with 32768 entries
[    0.074853] rcu: Hierarchical SRCU implementation.
[    0.094885] smp: Bringing up secondary CPUs ...
[    0.127008] Detected VIPT I-cache on CPU1
[    0.127032] GICv3: CPU1: found redistributor 1 region 0:0x00000000388a0000
[    0.127065] CPU1: Booted secondary processor 0x0000000001 [0x410fd034]
[    0.159037] Detected VIPT I-cache on CPU2
[    0.159054] GICv3: CPU2: found redistributor 2 region 0:0x00000000388c0000
[    0.159072] CPU2: Booted secondary processor 0x0000000002 [0x410fd034]
[    0.191084] Detected VIPT I-cache on CPU3
[    0.191098] GICv3: CPU3: found redistributor 3 region 0:0x00000000388e0000
[    0.191115] CPU3: Booted secondary processor 0x0000000003 [0x410fd034]
[    0.191171] smp: Brought up 1 node, 4 CPUs
[    0.244923] SMP: Total of 4 processors activated.
[    0.249645] CPU features: detected: 32-bit EL0 Support
[    0.254816] CPU features: detected: CRC32 instructions
[    0.264086] CPU: All CPU(s) started at EL2
[    0.265338] alternatives: patching kernel code
[    0.270899] devtmpfs: initialized
[    0.278558] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.285499] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
[    0.306874] pinctrl core: initialized pinctrl subsystem
[    0.310031] NET: Registered protocol family 16
[    0.322791] DMA: preallocated 256 KiB pool for atomic allocations
[    0.326448] cpuidle: using governor menu
[    0.330166] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[    0.337008] imx mu driver is registered.
[    0.340762] imx rpmsg driver is registered.
[    0.348932] imx8mm-pinctrl 30330000.pinctrl: initialized IMX pinctrl driver
[    0.364415] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
[    0.368295] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages
[    0.375026] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[    0.381763] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages
[    0.392987] iommu: Default domain type: Translated 
[    0.395145] vgaarb: loaded
[    0.398737] mc: Linux media interface: v0.10
[    0.402056] videodev: Linux video capture interface: v2.00
[    0.407594] pps_core: LinuxPPS API ver. 1 registered
[    0.412522] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.421717] PTP clock support registered
[    0.426860] clocksource: Switched to clocksource arch_sys_counter
[    0.436923] thermal_sys: Registered thermal governor 'step_wise'
[    0.436927] thermal_sys: Registered thermal governor 'power_allocator'
[    0.440413] NET: Registered protocol family 2
[    0.451411] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)
[    0.459648] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)
[    0.467695] TCP bind hash table entries: 16384 (order: 6, 262144 bytes, linear)
[    0.475154] TCP: Hash tables configured (established 16384 bind 16384)
[    0.481567] UDP hash table entries: 1024 (order: 3, 32768 bytes, linear)
[    0.488267] UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear)
[    0.495532] NET: Registered protocol family 1
[    0.500123] RPC: Registered named UNIX socket transport module.
[    0.505737] RPC: Registered udp transport module.
[    0.510469] RPC: Registered tcp transport module.
[    0.515177] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.521657] PCI: CLS 0 bytes, default 64
[    0.526129] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 counters available
[    0.534424] Initialise system trusted keyrings
[    0.537964] workingset: timestamp_bits=44 max_order=19 bucket_order=0
[    0.548326] NFS: Registering the id_resolver key type
[    0.550547] Key type id_resolver registered
[    0.554743] Key type id_legacy registered
[    0.558770] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    0.565762] Key type asymmetric registered
[    0.569622] Asymmetric key parser 'x509' registered
[    0.574539] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 246)
[    0.582057] io scheduler mq-deadline registered
[    0.586504] io scheduler kyber registered
[    0.591834] pwm-backlight backlight: backlight supply power not found, using dummy regulator
[    0.603490] mxs-dma 33000000.dma-controller: initialized
[    0.606468] Bus freq driver module loaded
[    0.612116] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[    0.617815] 30860000.serial: ttymxc0 at MMIO 0x30860000 (irq = 31, base_baud = 1500000) is a IMX
[    0.625175] printk: console [ttymxc0] enabled
[    0.625175] printk: console [ttymxc0] enabled
[    0.633821] printk: bootconsole [ec_imx6q0] disabled
[    0.633821] printk: bootconsole [ec_imx6q0] disabled
[    0.644125] 30880000.serial: ttymxc2 at MMIO 0x30880000 (irq = 32, base_baud = 1500000) is a IMX
[    0.655705] 30890000.serial: ttymxc1 at MMIO 0x30890000 (irq = 33, base_baud = 1500000) is a IMX
[    0.664948] 30a60000.serial: ttymxc3 at MMIO 0x30a60000 (irq = 39, base_baud = 5000000) is a IMX
[    0.676396] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[    0.683027] [drm] No driver support for vblank timestamp query.
[    0.689022] imx-drm soc@0:bus@32c00000:display-subsystem: bound imx-lcdif-crtc.0 (ops lcdif_crtc_ops)
[    0.698427] [drm] Initialized imx-drm 1.0.0 20120507 for soc@0:bus@32c00000:display-subsystem on minor 0
[    0.709466] libphy: Fixed MDIO Bus: probed
[    0.713886] input: 30370000.snvs:snvs-powerkey as /devices/platform/soc@0/soc@0:bus@30000000/30370000.snvs/30370000.snvs:snvs-powerkey/input/input0
[    0.727733] i2c /dev entries driver
[    0.731422] mx6s-csi 32e20000.csi1_bridge: initialising
[    0.737104] mxc_mipi-csi 32e30000.mipi_csi: 32e30000.mipi_csi supply mipi-phy not found, using dummy regulator
[    0.747275] mxc_mipi-csi 32e30000.mipi_csi: mipi csi v4l2 device registered
[    0.754247] CSI: Registered sensor subdevice: mxc_mipi-csi.0
[    0.759926] mxc_mipi-csi 32e30000.mipi_csi: lanes: 2, hs_settle: 13, clk_settle: 2, wclk: 1, freq: 333000000
[    0.772931] imx2-wdt 30280000.watchdog: timeout 60 sec (nowayout=0)
[    0.780071] sdhci: Secure Digital Host Controller Interface driver
[    0.786263] sdhci: Copyright(c) Pierre Ossman
[    0.790624] sdhci-pltfm: SDHCI platform and OF driver helper
[    0.796848] mmc0: CQHCI version 5.10
[    0.832238] mmc0: SDHCI controller on 30b40000.mmc [30b40000.mmc] using ADMA
[    0.839717] mmc1: CQHCI version 5.10
[    0.843800] mmc2: CQHCI version 5.10
[    0.879491] mmc2: SDHCI controller on 30b60000.mmc [30b60000.mmc] using ADMA
[    0.888183] ledtrig-cpu: registered to indicate activity on CPUs
[    0.895307] caam 30900000.crypto: device ID = 0x0a16040100000000 (Era 9)
[    0.902075] caam 30900000.crypto: job rings = 3, qi = 0
[    0.933083] caam algorithms registered in /proc/crypto
[    0.941941] caam 30900000.crypto: caam pkc algorithms registered in /proc/crypto
[    0.951765] caam_jr 30901000.jr0: registering rng-caam
[    0.963549] caam-snvs 30370000.caam-snvs: can't get snvs clock
[    0.969462] caam-snvs 30370000.caam-snvs: violation handlers armed - non-secure state
[    0.977757] hidraw: raw HID events driver (C) Jiri Kosina
[    0.985895] NET: Registered protocol family 17
[    0.990519] 8021q: 802.1Q VLAN Support v1.8
[    0.994884] Key type dns_resolver registered
[    1.000860] Loading compiled-in X.509 certificates
[    1.030367] mmc2: Command Queue Engine enabled
[    1.031520] regulator-eth-phy GPIO handle specifies active low - ignored
[    1.034849] mmc2: new HS400 MMC card at address 0001
[    1.041913] gpio-142 (scl): enforced open drain please flag it properly in DT/ACPI DSDT/board file
[    1.047427] mmcblk2: mmc2:0001 S0J56X 14.8 GiB 
[    1.060144] mmcblk2boot0: mmc2:0001 S0J56X partition 1 31.5 MiB
[    1.066203] mmcblk2boot1: mmc2:0001 S0J56X partition 2 31.5 MiB
[    1.072851] mmcblk2rpmb: mmc2:0001 S0J56X partition 3 4.00 MiB, chardev (243:0)
[    1.115251] random: fast init done
[    1.115263] LDO5: Bringing 3300000uV into 1800000-1800000uV
[    1.126859] ldo6: supplied by regulator-dummy
[    1.134549] i2c i2c-0: IMX I2C adapter registered
[    1.139681] gpio-144 (scl): enforced open drain please flag it properly in DT/ACPI DSDT/board file
[    1.480200] edt_ft5x06 1-0038: touchscreen probe failed
[    1.485783] ov5640_mipi 1-003c: 1-003c supply DOVDD not found, using dummy regulator
[    1.493594] ov5640_mipi 1-003c: 1-003c supply DVDD not found, using dummy regulator
[    1.501290] ov5640_mipi 1-003c: 1-003c supply AVDD not found, using dummy regulator
[    1.580178] ov5640_mipi 1-003c: Read reg error: reg=300a
[    1.585499] ov5640_mipi 1-003c: Camera is not found
[    1.591639] i2c i2c-1: IMX I2C adapter registered
[    1.596711] gpio-146 (scl): enforced open drain please flag it properly in DT/ACPI DSDT/board file
[    1.606255] i2c i2c-2: IMX I2C adapter registered
[    1.611291] gpio-148 (scl): enforced open drain please flag it properly in DT/ACPI DSDT/board file
[    1.620708] i2c i2c-3: IMX I2C adapter registered
[    1.626022] pwm-backlight backlight: backlight supply power not found, using dummy regulator
[    1.626468] imx6q-pcie 33800000.pcie: 33800000.pcie supply epdev_on not found, using dummy regulator
[    1.634690] imx-cpufreq-dt imx-cpufreq-dt: cpu speed grade 2 mkt segment 2 supported-hw 0x4 0x4
[    1.643872] imx6q-pcie 33800000.pcie: host bridge /soc@0/pcie@33800000 ranges:
[    1.655253] mmc1: CQHCI version 5.10
[    1.659561] imx6q-pcie 33800000.pcie:    IO 0x1ff80000..0x1ff8ffff -> 0x00000000
[    1.663157] sdhci-esdhc-imx 30b50000.mmc: Got CD GPIO
[    1.670547] imx6q-pcie 33800000.pcie:   MEM 0x18000000..0x1fefffff -> 0x18000000
[    1.683057] imx6q-pcie 33800000.pcie: EXT REF_CLK is used!.
[    1.709049] mmc1: SDHCI controller on 30b50000.mmc [30b50000.mmc] using ADMA
[    1.718224] input: gpio-keys as /devices/platform/gpio-keys/input/input2
[    1.729074] input: bd718xx-pwrkey as /devices/platform/soc@0/soc@0:bus@30800000/30a20000.i2c/i2c-0/0-004b/gpio-keys.0.auto/input/input3
[    1.741666] hctosys: unable to open rtc device (rtc0)
[    1.816124] imx6q-pcie 33800000.pcie: PCIe PLL lock timeout

What will be reason for this error?

Any suggestion for this will be helpful.

Thank you!

Best regards,

Rohit

divyeshmarne0 · ‎11-01-2021

Hi Rohit,

Are you still facing this issue?

If not, Can you provide the fix for it?

igorpadykov · ‎11-20-2020

Hi Rohit

in general PLL lock timeout can be caused by quality or reference clock

one can consider sect.3.9. PCIE connectivity i.MX 8M Mini Hardware Developer’s Guide

Best regards
igor