Re: (EXT) RE: [PATCH v8 00/13] add ecspi ERR009165 for i.mx6/7 soc family

[Matthias Schiffer <matthias.schiffer@ew.tq-group.com>]

[-- Attachment #1: Type: text/plain, Size: 4792 bytes --]

On Fri, 2020-06-05 at 02:45 +0000, Robin Gong wrote:
> On 2020/06/03 Matthias Schiffer <matthias.schiffer@ew.tq-group.com>
> wrote:
> > On Wed, 2020-06-03 at 09:50 +0000, Robin Gong wrote:
> > > On 2020/06/03 Matthias Schiffer <
> > > matthias.schiffer@ew.tq-group.com>
> > > wrote:
> > >  > On Thu, 2020-05-21 at 04:34 +0800, Robin Gong wrote:
> > > > > There is ecspi ERR009165 on i.mx6/7 soc family, which cause
> > > > > FIFO
> > > > > transfer to be send twice in DMA mode. Please get more
> > > > > information
> > > > > from:
> > > > > 
> > 
> > 
https://eur01.safelinks.protection.outlook.com/?url=https%3A%2F%2Fwww
> > > > > .
> > > > > 
> > > > 
> > > > 
> > 
> > nxp.com%2Fdocs%2Fen%2Ferrata%2FIMX6DQCE.pdf&amp;data=02%7C01%7C
> > > > yibin.g
> > > > > 
> > > > 
> > > > 
> > 
> > ong%40nxp.com%7C4621358b9be04a79d2d508d80798835b%7C686ea1d3bc2b
> > > > 4c6fa92
> > > > > 
> > > > 
> > > > 
> > 
> > cd99c5c301635%7C0%7C1%7C637267698912634476&amp;sdata=hR66H1hP%
> > > > 2Fqb6OXe
> > > > > w9wpXizY8DiNfZZ1KLwu3Kty87jc%3D&amp;reserved=0. The
> > > > > workaround
> > 
> > is
> > > > > adding new sdma ram script which works in XCH  mode as PIO
> > > > > inside
> > > > > sdma instead of SMC mode, meanwhile, 'TX_THRESHOLD' should be
> > > > > 0.
> > > > > The issue
> > > > 
> > > > should be exist on all legacy i.mx6/7 soc family before
> > > > i.mx6ul.
> > > > > NXP fix this design issue from i.mx6ul, so newer chips
> > > > > including
> > > > > i.mx6ul/ 6ull/6sll do not need this workaroud anymore. All
> > > > > other
> > > > > i.mx6/7/8 chips still need this workaroud. This patch set add
> > > > > new
> > > > > 'fsl,imx6ul-ecspi'
> > > > > for ecspi driver and 'ecspi_fixed' in sdma driver to choose
> > > > > if
> > > > > need errata or not.
> > > > > The first two reverted patches should be the same issue,
> > > > > though,
> > > > > it seems 'fixed' by changing to other shp script. Hope Sean
> > > > > or
> > > > > Sascha could have the chance to test this patch set if could
> > > > > fix
> > > > > their issues.
> > > > > Besides, enable sdma support for i.mx8mm/8mq and fix ecspi1
> > > > > not
> > > > > work on i.mx8mm because the event id is zero.
> > > > > 
> > > > > PS:
> > > > >    Please get sdma firmware from below linux-firmware and
> > > > > copy it
> > > > > to your local rootfs /lib/firmware/imx/sdma.
> > > > 
> > > > 
> > > > Hello Robin,
> > > > 
> > > > we have tried out this series, and there seems to be an issue
> > > > with
> > > > the
> > > > PIO fallback. We are testing on an i.MX6Q board, and our kernel
> > > > is
> > > > a
> > > > mostly-unmodified 5.4, on which we backported all SDMA patches
> > > > from
> > > > next-20200602 (imx-sdma.c is identical to next-20200602
> > > > version),
> > > > and
> > > > then applied this whole series.
> > > > 
> > > > We build the SDMA driver as a kernel module, which is loaded by
> > > > udev,
> > > > so the root filesystem is ready and the SDMA firmware can be
> > > > loaded.
> > > > The behaviour we're seeing is the following:
> > > > 
> > > > 1. As long as the SDMA driver is not loaded, initializing
> > > > spi_imx
> > > > will
> > > > be deferred
> > > > 2. imx_sdma is loaded. The SDMA firmware is not yet loaded at
> > > > this
> > > > point
> > > > 3. spi_imx is initialized and an SPI-NOR flash is probed. To
> > > > load
> > > > the
> > > > BFPT, the driver will attempt to use DMA; this will fail with
> > > > EINVAL as
> > > > long as the SDMA firmware is not ready, so the fallback to PIO
> > > > happens
> > > > (4. SDMA firmware is ready, subsequent SPI transfers use DMA)
> > > > 
> > > > The problem happens in step 3: Whenever the driver falls back
> > > > to
> > > > PIO,
> > > > the received data is corrupt. The behaviour is specific to the
> > > > fallback: When I disable DMA completely via spi_imx.use_dma, or
> > > > when
> > > > the timing is lucky and the SDMA firmware gets loaded before
> > > > the
> > > > flash
> > > > is probed, no corruption can be observed.
> > > 
> > > Thanks Matthias, would you like post log?
> > > 
> > 
> > I have attached the following log files:
> > - pio.log: DMA disabled via module parameter
> > - dma.log: "lucky" timing, SDMA firmware loaded before SPI-NOR
> > probe
> > - fallback.log: DMA->PIO fallback
> > 
> > The logs include some additional log messages:
> > - Return value of spi_imx_dma_transfer() before PIO fallback
> > - SPI-NOR SFPT dump
> > 
> > It can be seen that the BFPT data is identical in pio.log and
> > dma.log,
> > and differs almost completely in fallback.log. The corrupted data
> > seems
> > to be random, or uninitialized memory; it differs with every boot.
> 
> Would you please have a try with the attached patch? Thanks.


Thank you, this fixes the issue we're seeing.

Kind regards,
Matthias

[-- Attachment #2: fixed.log --]
[-- Type: text/x-log, Size: 33368 bytes --]

[    0.000000] Booting Linux on physical CPU 0x0
[    0.000000] Linux version 5.4.39 (oe-user@oe-host) (gcc version 9.2.0 (GCC)) #1 SMP PREEMPT Fri Jun 5 07:23:40 UTC 2020
[    0.000000] CPU: ARMv7 Processor [412fc09a] revision 10 (ARMv7), cr=10c5387d
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[    0.000000] OF: fdt: Machine model: TQ TQMa6Q on MBa6x
[    0.000000] Memory policy: Data cache writealloc
[    0.000000] cma: Reserved 160 MiB at 0x46000000
[    0.000000] On node 0 totalpages: 262144
[    0.000000]   Normal zone: 2048 pages used for memmap
[    0.000000]   Normal zone: 0 pages reserved
[    0.000000]   Normal zone: 262144 pages, LIFO batch:63
[    0.000000] percpu: Embedded 20 pages/cpu s50664 r8192 d23064 u81920
[    0.000000] pcpu-alloc: s50664 r8192 d23064 u81920 alloc=20*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 260096
[    0.000000] Kernel command line: root=/dev/mmcblk1p2 ro rootwait console=ttymxc1,115200 spi_imx.dyndbg=+p consoleblank=0 cma=160M
[    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: 850004K/1048576K available (12288K kernel code, 942K rwdata, 3656K rodata, 1024K init, 6554K bss, 34732K reserved, 163840K cma-reserved, 0K highmem)
[    0.000000] random: get_random_u32 called from __kmem_cache_create+0x20/0x2b8 with crng_init=0
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] ftrace: allocating 34625 entries in 68 pages
[    0.000000] Running RCU self tests
[    0.000000] rcu: Preemptible hierarchical RCU implementation.
[    0.000000] rcu: 	RCU lockdep checking is enabled.
[    0.000000] 	Tasks RCU 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 errata 752271 769419 enabled
[    0.000000] L2C-310 enabling early BRESP for Cortex-A9
[    0.000000] L2C-310 full line of zeros enabled for Cortex-A9
[    0.000000] L2C-310 ID prefetch enabled, offset 16 lines
[    0.000000] L2C-310 dynamic clock gating enabled, standby mode enabled
[    0.000000] L2C-310 cache controller enabled, 16 ways, 1024 kB
[    0.000000] L2C-310: CACHE_ID 0x410000c7, AUX_CTRL 0x76470001
[    0.000000] Switching to timer-based delay loop, resolution 333ns
[    0.000009] sched_clock: 32 bits at 3000kHz, resolution 333ns, wraps every 715827882841ns
[    0.000040] clocksource: mxc_timer1: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 637086815595 ns
[    0.001629] Console: colour dummy device 80x30
[    0.001665] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[    0.001687] ... MAX_LOCKDEP_SUBCLASSES:  8
[    0.001711] ... MAX_LOCK_DEPTH:          48
[    0.001731] ... MAX_LOCKDEP_KEYS:        8192
[    0.001753] ... CLASSHASH_SIZE:          4096
[    0.001774] ... MAX_LOCKDEP_ENTRIES:     32768
[    0.001795] ... MAX_LOCKDEP_CHAINS:      65536
[    0.001816] ... CHAINHASH_SIZE:          32768
[    0.001836]  memory used by lock dependency info: 3997 kB
[    0.001856]  memory used for stack traces: 2112 kB
[    0.001878]  per task-struct memory footprint: 1536 bytes
[    0.001953] Calibrating delay loop (skipped), value calculated using timer frequency.. 6.00 BogoMIPS (lpj=30000)
[    0.001988] pid_max: default: 32768 minimum: 301
[    0.002526] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[    0.002572] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[    0.005083] CPU: Testing write buffer coherency: ok
[    0.005169] CPU0: Spectre v2: using BPIALL workaround
[    0.006459] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[    0.059678] Setting up static identity map for 0x10100000 - 0x10100060
[    0.079539] rcu: Hierarchical SRCU implementation.
[    0.129550] smp: Bringing up secondary CPUs ...
[    0.210001] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[    0.210016] CPU1: Spectre v2: using BPIALL workaround
[    0.289894] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
[    0.289910] CPU2: Spectre v2: using BPIALL workaround
[    0.369888] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
[    0.369903] CPU3: Spectre v2: using BPIALL workaround
[    0.370513] smp: Brought up 1 node, 4 CPUs
[    0.370547] SMP: Total of 4 processors activated (24.00 BogoMIPS).
[    0.370573] CPU: All CPU(s) started in SVC mode.
[    0.372564] devtmpfs: initialized
[    0.411117] VFP support v0.3: implementor 41 architecture 3 part 30 variant 9 rev 4
[    0.413270] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.413334] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
[    0.421673] pinctrl core: initialized pinctrl subsystem
[    0.426412] NET: Registered protocol family 16
[    0.433920] DMA: preallocated 256 KiB pool for atomic coherent allocations
[    0.437726] cpuidle: using governor ladder
[    0.438009] CPU identified as i.MX6Q, silicon rev 1.5
[    0.471621] vdd1p1: supplied by regulator-dummy
[    0.473787] vdd3p0: supplied by regulator-dummy
[    0.475680] vdd2p5: supplied by regulator-dummy
[    0.477536] vddarm: supplied by regulator-dummy
[    0.479670] vddpu: supplied by regulator-dummy
[    0.481530] vddsoc: supplied by regulator-dummy
[    0.521081] hw-breakpoint: found 5 (+1 reserved) breakpoint and 1 watchpoint registers.
[    0.521146] hw-breakpoint: maximum watchpoint size is 4 bytes.
[    0.524299] imx6q-pinctrl 20e0000.iomuxc: initialized IMX pinctrl driver
[    0.644216] mxs-dma 110000.dma-apbh: initialized
[    0.653222] vgaarb: loaded
[    0.654666] SCSI subsystem initialized
[    0.655483] libata version 3.00 loaded.
[    0.656501] usbcore: registered new interface driver usbfs
[    0.656737] usbcore: registered new interface driver hub
[    0.657080] usbcore: registered new device driver usb
[    0.657588] usb_phy_generic usbphynop1: usbphynop1 supply vcc not found, using dummy regulator
[    0.658449] usb_phy_generic usbphynop2: usbphynop2 supply vcc not found, using dummy regulator
[    0.665470] i2c i2c-0: IMX I2C adapter registered
[    0.666320] pps_core: LinuxPPS API ver. 1 registered
[    0.666349] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.666430] PTP clock support registered
[    0.674652] clocksource: Switched to clocksource mxc_timer1
[    1.740208] thermal_sys: Registered thermal governor 'fair_share'
[    1.740222] thermal_sys: Registered thermal governor 'step_wise'
[    1.740260] thermal_sys: Registered thermal governor 'user_space'
[    1.741160] NET: Registered protocol family 2
[    1.743061] tcp_listen_portaddr_hash hash table entries: 512 (order: 2, 20480 bytes, linear)
[    1.743196] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
[    1.743432] TCP bind hash table entries: 8192 (order: 6, 294912 bytes, linear)
[    1.744897] TCP: Hash tables configured (established 8192 bind 8192)
[    1.745528] UDP hash table entries: 512 (order: 3, 40960 bytes, linear)
[    1.745768] UDP-Lite hash table entries: 512 (order: 3, 40960 bytes, linear)
[    1.746564] NET: Registered protocol family 1
[    1.748943] RPC: Registered named UNIX socket transport module.
[    1.749009] RPC: Registered udp transport module.
[    1.749037] RPC: Registered tcp transport module.
[    1.749064] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    1.760424] PCI: CLS 0 bytes, default 64
[    1.761389] hw perfevents: no interrupt-affinity property for /pmu, guessing.
[    1.762261] hw perfevents: enabled with armv7_cortex_a9 PMU driver, 7 counters available
[    1.768318] Initialise system trusted keyrings
[    1.769028] workingset: timestamp_bits=30 max_order=18 bucket_order=0
[    1.792661] NFS: Registering the id_resolver key type
[    1.792800] Key type id_resolver registered
[    1.792870] Key type id_legacy registered
[    1.792932] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    1.793719] fuse: init (API version 7.31)
[    1.796020] NILFS version 2 loaded
[    1.838986] Key type asymmetric registered
[    1.839100] Asymmetric key parser 'x509' registered
[    1.839275] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
[    1.839367] io scheduler mq-deadline registered
[    1.839401] io scheduler kyber registered
[    1.847454] imx6q-pcie 1ffc000.pcie: host bridge /soc/pcie@1ffc000 ranges:
[    1.847675] imx6q-pcie 1ffc000.pcie:    IO 0x01f80000..0x01f8ffff -> 0x00000000
[    1.847866] imx6q-pcie 1ffc000.pcie:   MEM 0x01000000..0x01efffff -> 0x01000000
[    1.859118] pfuze100-regulator 0-0008: Full layer: 2, Metal layer: 1
[    1.860092] pfuze100-regulator 0-0008: FAB: 0, FIN: 0
[    1.860126] pfuze100-regulator 0-0008: pfuze100 found.
[    1.891216] 21e8000.serial: ttymxc1 at MMIO 0x21e8000 (irq = 66, base_baud = 5000000) is a IMX
[    2.678656] printk: console [ttymxc1] enabled
[    2.685153] 21ec000.serial: ttymxc2 at MMIO 0x21ec000 (irq = 67, base_baud = 5000000) is a IMX
[    2.695707] 21f0000.serial: ttymxc3 at MMIO 0x21f0000 (irq = 68, base_baud = 5000000) is a IMX
[    2.706224] 21f4000.serial: ttymxc4 at MMIO 0x21f4000 (irq = 69, base_baud = 5000000) is a IMX
[    2.739808] etnaviv etnaviv: bound 130000.gpu (ops gpu_ops)
[    2.746264] etnaviv etnaviv: bound 134000.gpu (ops gpu_ops)
[    2.752620] etnaviv etnaviv: bound 2204000.gpu (ops gpu_ops)
[    2.758410] etnaviv-gpu 130000.gpu: model: GC2000, revision: 5108
[    2.765556] etnaviv-gpu 134000.gpu: model: GC320, revision: 5007
[    2.771816] etnaviv-gpu 2204000.gpu: model: GC355, revision: 1215
[    2.778030] etnaviv-gpu 2204000.gpu: Ignoring GPU with VG and FE2.0
[    2.787199] [drm] Initialized etnaviv 1.3.0 20151214 for etnaviv on minor 0
[    2.799546] imx-ipuv3 2400000.ipu: IPUv3H probed
[    2.807632] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[    2.814322] [drm] No driver support for vblank timestamp query.
[    2.821418] imx-drm display-subsystem: bound imx-ipuv3-crtc.2 (ops ipu_crtc_ops)
[    2.829349] imx-drm display-subsystem: bound imx-ipuv3-crtc.3 (ops ipu_crtc_ops)
[    2.837354] imx-drm display-subsystem: bound imx-ipuv3-crtc.6 (ops ipu_crtc_ops)
[    2.845276] imx-drm display-subsystem: bound imx-ipuv3-crtc.7 (ops ipu_crtc_ops)
[    2.854389] [drm] Initialized imx-drm 1.0.0 20120507 for display-subsystem on minor 1
[    2.862675] imx-ipuv3 2800000.ipu: IPUv3H probed
[    2.912586] loop: module loaded
[    2.918439] at24 0-0050: 8192 byte 24c64 EEPROM, writable, 32 bytes/write
[    2.927616] at24 0-0057: 8192 byte 24c64 EEPROM, writable, 32 bytes/write
[    2.937469] ahci-imx 2200000.sata: fsl,transmit-level-mV not specified, using 00000024
[    2.945500] ahci-imx 2200000.sata: fsl,transmit-boost-mdB not specified, using 00000480
[    2.953544] ahci-imx 2200000.sata: fsl,transmit-atten-16ths not specified, using 00002000
[    2.961821] ahci-imx 2200000.sata: fsl,receive-eq-mdB not specified, using 05000000
[    2.969862] ahci-imx 2200000.sata: 2200000.sata supply ahci not found, using dummy regulator
[    2.974678] imx6q-pcie 1ffc000.pcie: Phy link never came up
[    2.978838] ahci-imx 2200000.sata: 2200000.sata supply phy not found, using dummy regulator
[    2.987906] imx6q-pcie 1ffc000.pcie: PCI host bridge to bus 0000:00
[    2.993159] ahci-imx 2200000.sata: 2200000.sata supply target not found, using dummy regulator
[    2.998671] pci_bus 0000:00: root bus resource [bus 00-ff]
[    2.998699] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
[    3.011182] ahci-imx 2200000.sata: SSS flag set, parallel bus scan disabled
[    3.012881] pci_bus 0000:00: root bus resource [mem 0x01000000-0x01efffff]
[    3.019183] ahci-imx 2200000.sata: AHCI 0001.0300 32 slots 1 ports 3 Gbps 0x1 impl platform mode
[    3.026411] pci 0000:00:00.0: [16c3:abcd] type 01 class 0x060400
[    3.033056] ahci-imx 2200000.sata: flags: ncq sntf stag pm led clo only pmp pio slum part ccc apst 
[    3.041992] pci 0000:00:00.0: reg 0x10: [mem 0x00000000-0x000fffff]
[    3.063650] pci 0000:00:00.0: reg 0x38: [mem 0x00000000-0x0000ffff pref]
[    3.067674] scsi host0: ahci-imx
[    3.070548] pci 0000:00:00.0: Limiting cfg_size to 512
[    3.075295] ata1: SATA max UDMA/133 mmio [mem 0x02200000-0x02203fff] port 0x100 irq 72
[    3.079130] pci 0000:00:00.0: supports D1
[    3.089282] spi_imx 2008000.spi: can't get the TX DMA channel, error -517!
[    3.090799] pci 0000:00:00.0: PME# supported from D0 D1 D3hot D3cold
[    3.092133] spi_imx 2018000.spi: can't get the TX DMA channel, error -517!
[    3.099384] libphy: Fixed MDIO Bus: probed
[    3.102695] PCI: bus0: Fast back to back transfers disabled
[    3.105356] CAN device driver interface
[    3.113649] PCI: bus1: Fast back to back transfers enabled
[    3.114285] flexcan 2090000.flexcan: 2090000.flexcan supply xceiver not found, using dummy regulator
[    3.119291] pci 0000:00:00.0: BAR 0: assigned [mem 0x01000000-0x010fffff]
[    3.131705] flexcan 2094000.flexcan: 2094000.flexcan supply xceiver not found, using dummy regulator
[    3.135310] pci 0000:00:00.0: BAR 6: assigned [mem 0x01100000-0x0110ffff pref]
[    3.151786] pci 0000:00:00.0: PCI bridge to [bus 01-ff]
[    3.153541] pps pps0: new PPS source ptp0
[    3.159151] pcieport 0000:00:00.0: PME: Signaling with IRQ 306
[    3.168741] pcieport 0000:00:00.0: AER: enabled with IRQ 306
[    3.169048] libphy: fec_enet_mii_bus: probed
[    3.183769] fec 2188000.ethernet eth0: registered PHC device 0
[    3.190548] usbcore: registered new interface driver cdc_ether
[    3.196665] usbcore: registered new interface driver smsc95xx
[    3.202461] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    3.209144] ehci-pci: EHCI PCI platform driver
[    3.219204] imx_usb 2184000.usb: No over current polarity defined
[    3.230025] ci_hdrc ci_hdrc.0: EHCI Host Controller
[    3.235495] ci_hdrc ci_hdrc.0: new USB bus registered, assigned bus number 1
[    3.264720] ci_hdrc ci_hdrc.0: USB 2.0 started, EHCI 1.00
[    3.271845] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.04
[    3.280322] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    3.287654] usb usb1: Product: EHCI Host Controller
[    3.292565] usb usb1: Manufacturer: Linux 5.4.39 ehci_hcd
[    3.298056] usb usb1: SerialNumber: ci_hdrc.0
[    3.305485] hub 1-0:1.0: USB hub found
[    3.309555] hub 1-0:1.0: 1 port detected
[    3.317484] imx_usb 2184200.usb: 2184200.usb supply vbus not found, using dummy regulator
[    3.330416] ci_hdrc ci_hdrc.1: EHCI Host Controller
[    3.335501] ci_hdrc ci_hdrc.1: new USB bus registered, assigned bus number 2
[    3.364702] ci_hdrc ci_hdrc.1: USB 2.0 started, EHCI 1.00
[    3.371209] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.04
[    3.379600] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    3.386918] usb usb2: Product: EHCI Host Controller
[    3.391831] usb usb2: Manufacturer: Linux 5.4.39 ehci_hcd
[    3.397322] usb usb2: SerialNumber: ci_hdrc.1
[    3.403588] hub 2-0:1.0: USB hub found
[    3.407620] hub 2-0:1.0: 1 port detected
[    3.416582] mousedev: PS/2 mouse device common for all mice
[    3.426923] ata1: SATA link down (SStatus 0 SControl 300)
[    3.432599] ahci-imx 2200000.sata: no device found, disabling link.
[    3.434404] rtc-ds1307 0-0068: registered as rtc0
[    3.438995] ahci-imx 2200000.sata: pass ahci_imx..hotplug=1 to enable hotplug
[    3.445882] i2c /dev entries driver
[    3.455954] IR NEC protocol handler initialized
[    3.460526] IR RC5(x/sz) protocol handler initialized
[    3.465704] IR RC6 protocol handler initialized
[    3.470272] IR JVC protocol handler initialized
[    3.474914] IR Sony protocol handler initialized
[    3.479565] IR SANYO protocol handler initialized
[    3.484300] IR Sharp protocol handler initialized
[    3.489093] IR MCE Keyboard/mouse protocol handler initialized
[    3.495017] IR XMP protocol handler initialized
[    3.506346] lm75 0-0048: hwmon0: sensor 'lm75'
[    3.513239] lm75 0-0049: hwmon1: sensor 'lm75'
[    3.523672] imx2-wdt 20bc000.wdog: timeout 60 sec (nowayout=0)
[    3.532392] sdhci: Secure Digital Host Controller Interface driver
[    3.538672] sdhci: Copyright(c) Pierre Ossman
[    3.543062] sdhci-pltfm: SDHCI platform and OF driver helper
[    3.550780] sdhci-esdhc-imx 2194000.usdhc: Got CD GPIO
[    3.556135] sdhci-esdhc-imx 2194000.usdhc: Got WP GPIO
[    3.598990] mmc1: SDHCI controller on 2194000.usdhc [2194000.usdhc] using ADMA
[    3.651070] mmc1: new high speed SD card at address 1234
[    3.657883] mmc0: SDHCI controller on 2198000.usdhc [2198000.usdhc] using ADMA
[    3.670288] ledtrig-cpu: registered to indicate activity on CPUs
[    3.671305] mmcblk1: mmc1:1234 SA02G 1.84 GiB 
[    3.681554] caam 2100000.caam: Entropy delay = 3200
[    3.703274]  mmcblk1: p1 p2
[    3.747319] caam 2100000.caam: Instantiated RNG4 SH0
[    3.774779] usb 2-1: new high-speed USB device number 2 using ci_hdrc
[    3.787144] mmc0: new DDR MMC card at address 0001
[    3.794197] mmcblk0: mmc0:0001 MMC04G 3.52 GiB 
[    3.799884] mmcblk0boot0: mmc0:0001 MMC04G partition 1 16.0 MiB
[    3.806963] mmcblk0boot1: mmc0:0001 MMC04G partition 2 16.0 MiB
[    3.808082] caam 2100000.caam: Instantiated RNG4 SH1
[    3.813829] mmcblk0rpmb: mmc0:0001 MMC04G partition 3 128 KiB, chardev (248:0)
[    3.817956] caam 2100000.caam: device ID = 0x0a16010000000000 (Era 4)
[    3.817974] caam 2100000.caam: job rings = 2, qi = 0
[    3.892098] caam algorithms registered in /proc/crypto
[    3.912582] caam_jr 2101000.jr0: registering rng-caam
[    3.919891] hidraw: raw HID events driver (C) Jiri Kosina
[    3.930853] NET: Registered protocol family 10
[    3.939894] Segment Routing with IPv6
[    3.943729] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[    3.952463] NET: Registered protocol family 17
[    3.957050] can: controller area network core (rev 20170425 abi 9)
[    3.963506] NET: Registered protocol family 29
[    3.968053] can: raw protocol (rev 20170425)
[    3.972458] can: broadcast manager protocol (rev 20170425 t)
[    3.975864] usb 2-1: New USB device found, idVendor=0424, idProduct=2517, bcdDevice= 0.02
[    3.978267] can: netlink gateway (rev 20190810) max_hops=1
[    3.986497] usb 2-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[    3.992533] Key type dns_resolver registered
[    4.001775] hub 2-1:1.0: USB hub found
[    4.007726] hub 2-1:1.0: 7 ports detected
[    4.019922] Registering SWP/SWPB emulation handler
[    4.026940] Loading compiled-in X.509 certificates
[    4.033765] Key type ._fscrypt registered
[    4.038061] Key type .fscrypt registered
[    4.197921] spi_imx 2008000.spi: can't get the TX DMA channel, error -517!
[    4.199984] spi_imx 2018000.spi: can't get the TX DMA channel, error -517!
[    4.203694] imx_thermal tempmon: Industrial CPU temperature grade - max:105C critical:100C passive:95C
[    4.215406] spi_imx 2008000.spi: can't get the TX DMA channel, error -517!
[    4.217246] spi_imx 2018000.spi: can't get the TX DMA channel, error -517!
[    4.219297] spi_imx 2008000.spi: can't get the TX DMA channel, error -517!
[    4.221081] spi_imx 2018000.spi: can't get the TX DMA channel, error -517!
[    4.225245] random: fast init done
[    4.229248] rtc-ds1307 0-0068: setting system clock to 2000-01-01T00:01:08 UTC (946684868)
[    4.238084] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[    4.258979] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[    4.267092] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
[    4.276176] cfg80211: failed to load regulatory.db
[    4.301827] EXT4-fs (mmcblk1p2): INFO: recovery required on readonly filesystem
[    4.309472] EXT4-fs (mmcblk1p2): write access will be enabled during recovery
[    4.334800] usb 2-1.1: new high-speed USB device number 3 using ci_hdrc
[    4.496212] usb 2-1.1: New USB device found, idVendor=0424, idProduct=9e00, bcdDevice= 3.00
[    4.504886] usb 2-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[    4.517379] smsc95xx v1.0.6
[    4.648480] smsc95xx 2-1.1:1.0 eth1: register 'smsc95xx' at usb-ci_hdrc.1-1.1, smsc95xx USB 2.0 Ethernet, f2:78:83:43:d1:7b
[    4.662389] spi_imx 2008000.spi: can't get the TX DMA channel, error -517!
[    4.664256] spi_imx 2018000.spi: can't get the TX DMA channel, error -517!
[    4.967482] EXT4-fs (mmcblk1p2): recovery complete
[    4.986706] EXT4-fs (mmcblk1p2): mounted filesystem with ordered data mode. Opts: (null)
[    4.996436] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[    5.007139] devtmpfs: mounted
[    5.028362] Freeing unused kernel memory: 1024K
[    5.034564] Run /sbin/init as init process
[    5.606188] systemd[1]: System time before build time, advancing clock.
[    5.710605] systemd[1]: systemd 243.2+ 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)
[    5.736335] systemd[1]: Detected architecture arm.
[    5.799308] systemd[1]: Set hostname to <tqma6q-mba6x>.
[    6.675645] systemd[1]: /lib/systemd/system/dbus.socket:5: ListenStream= references a path below legacy directory /var/run/, updating /var/run/dbus/system_bus_socket \xe2\x86\x92 /run/dbus/system_bus_socket; please update the unit file accordingly.
[    7.024418] systemd[1]: /lib/systemd/system/rpcbind.socket:5: ListenStream= references a path below legacy directory /var/run/, updating /var/run/rpcbind.sock \xe2\x86\x92 /run/rpcbind.sock; please update the unit file accordingly.
[    7.088772] random: systemd: uninitialized urandom read (16 bytes read)
[    7.100144] systemd[1]: Created slice system-getty.slice.
[    7.135611] random: systemd: uninitialized urandom read (16 bytes read)
[    7.146536] systemd[1]: Created slice system-serial\x2dgetty.slice.
[    7.195582] random: systemd: uninitialized urandom read (16 bytes read)
[    7.206267] systemd[1]: Created slice User and Session Slice.
[    7.247801] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[    7.287818] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[    8.148199] random: crng init done
[    8.151661] random: 7 urandom warning(s) missed due to ratelimiting
[    8.613147] EXT4-fs (mmcblk1p2): re-mounted. Opts: (null)
[    8.619572] ext4 filesystem being remounted at / supports timestamps until 2038 (0x7fffffff)
[    9.101979] systemd[297]: systemd-udevd.service: ProtectHostname=yes is configured, but the kernel does not support UTS namespaces, ignoring namespace setup.
[    9.267307] systemd-journald[279]: Received client request to flush runtime journal.
[   11.123314] input: gpio-buttons as /devices/soc0/gpio-buttons/input/input0
[   11.127794] input: gpio-beeper as /devices/soc0/gpio-beeper/input/input1
[   11.157434] mc: Linux media interface: v0.10
[   11.172601] spi_imx 2008000.spi: can't get the TX DMA channel, error -517!
[   11.174915] spi_imx 2018000.spi: can't get the TX DMA channel, error -517!
[   11.176776] spi_imx 2008000.spi: can't get the TX DMA channel, error -517!
[   11.178815] spi_imx 2018000.spi: can't get the TX DMA channel, error -517!
[   11.219686] videodev: Linux video capture interface: v2.00
[   11.401520] imx_media_common: module is from the staging directory, the quality is unknown, you have been warned.
[   11.457916] spi_imx 2008000.spi: can't get the TX DMA channel, error -517!
[   11.460009] spi_imx 2018000.spi: can't get the TX DMA channel, error -517!
[   11.470667] imx6_media: module is from the staging directory, the quality is unknown, you have been warned.
[   11.650219] fsl-ssi-dai 2028000.ssi: No cache defaults, reading back from HW
[   11.860185] spi_imx 2008000.spi: can't get the TX DMA channel, error -517!
[   11.869667] spi_imx 2018000.spi: can't get the TX DMA channel, error -517!
[   11.871503] fsl-ssi-dai 2028000.ssi: No cache defaults, reading back from HW
[   11.968879] spi spi0.0: spi_imx_setup: mode 0, 8 bpw, 50000000 hz
[   11.972130] spi_imx 2008000.spi: mx51_ecspi_clkdiv: fin: 60000000, fspi: 50000000, post: 0, pre: 1
[   11.972637] spi_imx 2008000.spi: mx51_ecspi_clkdiv: fin: 60000000, fspi: 50000000, post: 0, pre: 1
[   12.016379] spi-nor spi0.0: n25q128a13
[   12.020443] spi-nor spi0.0: spi_nor_info_init_params: 03
[   12.035872] spi_imx 2008000.spi: mx51_ecspi_clkdiv: fin: 60000000, fspi: 50000000, post: 0, pre: 1
[   12.035951] spi_imx 2008000.spi: mx51_ecspi_clkdiv: fin: 60000000, fspi: 50000000, post: 0, pre: 1
[   12.036037] spi_imx 2008000.spi: mx51_ecspi_clkdiv: fin: 60000000, fspi: 50000000, post: 0, pre: 1
[   12.036102] spi_imx 2008000.spi: mx51_ecspi_clkdiv: fin: 60000000, fspi: 50000000, post: 0, pre: 1
[   12.036459] spi-nor spi0.0: Header: 53
[   12.040355] spi-nor spi0.0: Header: 46
[   12.044198] spi-nor spi0.0: Header: 44
[   12.073621] spi-nor spi0.0: Header: 50
[   12.077592] spi-nor spi0.0: Header: 05
[   12.081414] spi-nor spi0.0: Header: 01
[   12.112231] spi-nor spi0.0: Header: 01
[   12.134785] spi-nor spi0.0: Header: ff
[   12.139506] spi-nor spi0.0: Header: 00
[   12.143317] spi-nor spi0.0: Header: 05
[   12.159246] spi-nor spi0.0: Header: 01
[   12.163108] spi-nor spi0.0: Header: 10
[   12.184776] spi-nor spi0.0: Header: 30
[   12.188615] spi-nor spi0.0: Header: 00
[   12.221040] spi-nor spi0.0: Header: 00
[   12.244702] spi-nor spi0.0: Header: ff
[   12.266541] spi_imx 2008000.spi: mx51_ecspi_clkdiv: fin: 60000000, fspi: 50000000, post: 0, pre: 1
[   12.266706] spi_imx 2008000.spi: mx51_ecspi_clkdiv: fin: 60000000, fspi: 50000000, post: 0, pre: 1
[   12.266788] spi_imx 2008000.spi: mx51_ecspi_clkdiv: fin: 60000000, fspi: 50000000, post: 0, pre: 1
[   12.266866] spi_imx 2008000.spi: mx51_ecspi_clkdiv: fin: 60000000, fspi: 50000000, post: 0, pre: 1
[   12.267190] spi-nor spi0.0: bfpt addr=30 len=40
[   12.285142] spi_imx 2008000.spi: mx51_ecspi_clkdiv: fin: 60000000, fspi: 50000000, post: 0, pre: 1
[   12.285246] spi_imx 2008000.spi: mx51_ecspi_clkdiv: fin: 60000000, fspi: 50000000, post: 0, pre: 1
[   12.285534] spi_imx 2008000.spi: mx51_ecspi_clkdiv: fin: 60000000, fspi: 50000000, post: 0, pre: 1
[   12.285658] spi_imx 2008000.spi: mx51_ecspi_clkdiv: fin: 60000000, fspi: 50000000, post: 0, pre: 1
[   12.286591] spi-nor spi0.0: DMA transfer: -22
[   12.286630] spi-nor spi0.0: Fallback to PIO mode
[   12.296534] spi-nor spi0.0: bfpt: e5
[   12.314782] spi-nor spi0.0: bfpt: 20
[   12.344792] spi-nor spi0.0: bfpt: f1
[   12.348426] spi-nor spi0.0: bfpt: ff
[   12.352037] spi-nor spi0.0: bfpt: ff
[   12.397380] spi-nor spi0.0: bfpt: ff
[   12.416917] spi-nor spi0.0: bfpt: ff
[   12.420597] spi-nor spi0.0: bfpt: 07
[   12.424267] spi-nor spi0.0: bfpt: 29
[   12.442571] spi-nor spi0.0: bfpt: eb
[   12.458160] spi-nor spi0.0: bfpt: 27
[   12.462405] Micrel KSZ9031 Gigabit PHY 2188000.ethernet-1:03: attached PHY driver [Micrel KSZ9031 Gigabit PHY] (mii_bus:phy_addr=2188000.ethernet-1:03, irq=104)
[   12.467943] spi-nor spi0.0: bfpt: 6b
[   12.510726] spi-nor spi0.0: bfpt: 27
[   12.514394] spi-nor spi0.0: bfpt: 3b
[   12.518667] spi-nor spi0.0: bfpt: 27
[   12.534799] spi-nor spi0.0: bfpt: bb
[   12.538425] spi-nor spi0.0: bfpt: ff
[   12.542035] spi-nor spi0.0: bfpt: ff
[   12.550887] imx6_media_csi: module is from the staging directory, the quality is unknown, you have been warned.
[   12.554781] spi-nor spi0.0: bfpt: ff
[   12.561370] imx6_media_csi: module is from the staging directory, the quality is unknown, you have been warned.
[   12.574772] spi-nor spi0.0: bfpt: ff
[   12.578560] spi-nor spi0.0: bfpt: ff
[   12.582176] spi-nor spi0.0: bfpt: ff
[   12.583566] imx6_media_csi: module is from the staging directory, the quality is unknown, you have been warned.
[   12.585889] spi-nor spi0.0: bfpt: 27
[   12.585908] spi-nor spi0.0: bfpt: bb
[   12.585923] spi-nor spi0.0: bfpt: ff
[   12.585938] spi-nor spi0.0: bfpt: ff
[   12.585953] spi-nor spi0.0: bfpt: 29
[   12.626081] imx6_media_csi: module is from the staging directory, the quality is unknown, you have been warned.
[   12.656095] ipu1_csi0: Registered ipu1_csi0 capture as /dev/video0
[   12.675198] ipu1_ic_prpenc: Registered ipu1_ic_prpenc capture as /dev/video1
[   12.683695] spi-nor spi0.0: bfpt: eb
[   12.687574] spi-nor spi0.0: bfpt: 0c
[   12.691231] spi-nor spi0.0: bfpt: 20
[   12.705004] ipu1_ic_prpvf: Registered ipu1_ic_prpvf capture as /dev/video2
[   12.712086] imx-media: ipu1_csi0:1 -> ipu1_ic_prp:0
[   12.717491] spi-nor spi0.0: bfpt: 10
[   12.721154] spi-nor spi0.0: bfpt: d8
[   12.734691] spi-nor spi0.0: bfpt: 00
[   12.738348] spi-nor spi0.0: bfpt: 00
[   12.741995] spi-nor spi0.0: bfpt: 00
[   12.745946] imx-media: ipu1_csi0:1 -> ipu1_vdic:0
[   12.750739] imx-media: ipu1_vdic:2 -> ipu1_ic_prp:0
[   12.764770] spi-nor spi0.0: bfpt: 00
[   12.768433] spi-nor spi0.0: bfpt: 35
[   12.772076] spi-nor spi0.0: bfpt: 8a
[   12.775953] imx-media: ipu1_ic_prp:1 -> ipu1_ic_prpenc:0
[   12.781355] imx-media: ipu1_ic_prp:2 -> ipu1_ic_prpvf:0
[   12.804725] spi-nor spi0.0: bfpt: 01
[   12.808484] spi-nor spi0.0: bfpt: 00
[   12.812131] spi-nor spi0.0: bfpt: 82
[   12.816051] imx-media: subdev ipu1_csi0 bound
[   12.822311] ipu1_csi1: Registered ipu1_csi1 capture as /dev/video3
[   12.844770] spi-nor spi0.0: bfpt: a3
[   12.848570] imx-media: ipu1_csi1:1 -> ipu1_ic_prp:0
[   12.853600] imx-media: ipu1_csi1:1 -> ipu1_vdic:0
[   12.858512] spi-nor spi0.0: bfpt: 03
[   12.862158] spi-nor spi0.0: bfpt: cb
[   12.865986] spi-nor spi0.0: bfpt: ac
[   12.869667] spi-nor spi0.0: bfpt: c1
[   12.873309] spi-nor spi0.0: bfpt: 04
[   12.877400] imx-media: subdev ipu1_csi1 bound
[   12.894954] ipu2_csi0: Registered ipu2_csi0 capture as /dev/video4
[   12.902306] spi-nor spi0.0: bfpt: 2e
[   12.906067] spi-nor spi0.0: bfpt: 7a
[   12.909718] spi-nor spi0.0: bfpt: 75
[   12.913391] spi-nor spi0.0: bfpt: 7a
[   12.922719] ipu2_ic_prpenc: Registered ipu2_ic_prpenc capture as /dev/video5
[   12.936367] ipu2_ic_prpvf: Registered ipu2_ic_prpvf capture as /dev/video6
[   12.943584] imx-media: ipu2_csi0:1 -> ipu2_ic_prp:0
[   12.954793] spi-nor spi0.0: bfpt: 75
[   12.958625] spi-nor spi0.0: bfpt: fb
[   12.962308] spi-nor spi0.0: bfpt: 00
[   12.974773] imx-media: ipu2_csi0:1 -> ipu2_vdic:0
[   12.994794] spi-nor spi0.0: bfpt: 00
[   12.998462] spi-nor spi0.0: bfpt: 80
[   13.002103] spi-nor spi0.0: bfpt: 08
[   13.006025] imx-media: ipu2_vdic:2 -> ipu2_ic_prp:0
[   13.010994] imx-media: ipu2_ic_prp:1 -> ipu2_ic_prpenc:0
[   13.016510] spi-nor spi0.0: bfpt: 0f
[   13.020173] spi-nor spi0.0: bfpt: 82
[   13.023833] spi-nor spi0.0: bfpt: ff
[   13.027699] imx-media: ipu2_ic_prp:2 -> ipu2_ic_prpvf:0
[   13.032998] imx-media: subdev ipu2_csi0 bound
[   13.054705] spi-nor spi0.0: bfpt: 81
[   13.058330] spi-nor spi0.0: bfpt: 3d
[   13.064247] ipu2_csi1: Registered ipu2_csi1 capture as /dev/video7
[   13.071092] spi-nor spi0.0: bfpt: 00
[   13.084715] imx-media: ipu2_csi1:1 -> ipu2_ic_prp:0
[   13.089898] spi-nor spi0.0: bfpt: 00
[   13.093519] spi-nor spi0.0: spi_nor_parse_bfpt: 03
[   13.098731] imx-media: ipu2_csi1:1 -> ipu2_vdic:0
[   13.103489] imx-media: subdev ipu2_csi1 bound
[   13.114805] spi-nor spi0.0: spi_nor_parse_bfpt: 0c
[   13.121796] spi-nor spi0.0: param headers: 03
[   13.132542] spi-nor spi0.0: param headers: 00
[   13.148607] spi-nor spi0.0: param headers: 01
[   13.153245] spi-nor spi0.0: param headers: 02
[   13.174355] spi-nor spi0.0: param headers: 00
[   13.178882] spi-nor spi0.0: param headers: 01
[   13.183279] spi-nor spi0.0: param headers: 00
[   13.204795] spi-nor spi0.0: param headers: ff
[   13.224825] spi-nor spi0.0: has uniform erase
[   13.229237] spi-nor spi0.0: spi_nor_select_erase: 08
[   13.234241] spi-nor spi0.0: n25q128a13 (16384 Kbytes)
[   13.316374] coda 2040000.vpu: Direct firmware load for vpu_fw_imx6q.bin failed with error -2
[   13.331434] imx-sdma 20ec000.sdma: loaded firmware 3.5
[   13.355143] coda 2040000.vpu: Using fallback firmware vpu/vpu_fw_imx6q.bin
[   13.383312] spi spi0.1: spi_imx_setup: mode 0, 8 bpw, 1000000 hz
[   13.414032] spi_imx 2008000.spi: probed
[   13.514940] spi spi4.0: spi_imx_setup: mode 0, 8 bpw, 1000000 hz
[   13.517232] spi_imx 2018000.spi: probed
[   13.680184] imx-tlv320aic32x4 sound: tlv320aic32x4-hifi <-> 2028000.ssi mapping ok
[   13.693001] coda 2040000.vpu: Firmware code revision: 570363
[   13.715442] coda 2040000.vpu: Initialized CODA960.
[   13.720303] coda 2040000.vpu: Firmware version: 3.1.1
[   13.746657] coda 2040000.vpu: encoder registered as video8
[   13.757458] coda 2040000.vpu: decoder registered as video9
[   14.365520] IPv6: ADDRCONF(NETDEV_CHANGE): can0: link becomes ready
[   14.373301] IPv6: ADDRCONF(NETDEV_CHANGE): can1: link becomes ready
[   14.473634] smsc95xx 2-1.1:1.0 eth1: link up, 100Mbps, full-duplex, lpa 0xC5E1

[-- Attachment #3: Type: text/plain, Size: 176 bytes --]

_______________________________________________
linux-arm-kernel mailing list
linux-arm-kernel@lists.infradead.org
http://lists.infradead.org/mailman/listinfo/linux-arm-kernel