[Letux-kernel] Strange problem with non-LPAE letux-4.20-rc kernels on 4GB Pyra only

H. Nikolaus Schaller hns at goldelico.com
Tue Dec 4 23:00:13 CET 2018


> Am 04.12.2018 um 22:31 schrieb Andreas Kemnade <andreas at kemnade.info>:
> 
> On Tue, 4 Dec 2018 22:20:46 +0100
> "H. Nikolaus Schaller" <hns at goldelico.com> wrote:
> 
>> Hi,
>> 
>>> Am 04.12.2018 um 22:13 schrieb Andreas Kemnade <andreas at kemnade.info>:
>>> 
>>> On Tue, 4 Dec 2018 22:04:36 +0100
>>> Andreas Kemnade <andreas at kemnade.info> wrote:
>>> 
>>>> On Tue, 4 Dec 2018 21:55:56 +0100
>>>> "H. Nikolaus Schaller" <hns at goldelico.com> wrote:
>>>> 
>>>>> Hi,
>>>>> for testing of some new patches I did compile some letux-4.20-rc5
>>>>> in non-lpae mode and tried to boot on the 4GB Pyra.
>>>>> 
>>>>> Boot process ends with:
>>>>> 
>>>>> [    3.544616] input: user-button as /devices/platform/user-button/input/input0
>>>>> [    3.555006] input: pyra-game-buttons as /devices/platform/pyra-game-buttons/input/input1
>>>>> [    3.564689] input: pyra-lid-wakeup as /devices/platform/pyra-lid-wakeup/input/input2
>>>>> [    3.575503] palmas-rtc 48070000.i2c:palmas at 48:rtc: setting system clock to 2000-01-02 10:57:35 UTC (946810655)
>>>>> [    3.586006] sr_init: No PMIC hook to init smartreflex
>>>>> [    3.592186] vmmcsdio_fixed: disabling
>>>>> [    3.597267] ldo3: disabling
>>>>> [    3.600850] ldo8: disabling
>>>>> [    3.604153] modem_vbus_power: disabling
>>>>> [    3.608201] otg_path: disabling
>>>>> [    3.611513] ALSA device list:
>>>>> [    3.614662]   No soundcards found.
>>>>> [    3.618600] Waiting for root device PARTUUID=17b72d7a-02...
>>>>> 
>>>> AFAIK PARTUUID resolution is done by initrd normally?! So I am
>>>> wondering why it ever has worked. Was there somehow a duplicate root=
>>>> parameter, so 4.19 took the one it can process?
>>>> 
>>>> 
>>> ok, did some RTFM... 
>>> I was wrong.  
>> 
>> Ok.
>> 
>> Anyways it is becoming more strange now. I did boot the old Pyra
>> from eMMC. With an 4.19.3 kernel. And it failed as well. But the
>> 4.20-rc5 boots there.
>> 
>> Now I have different boot logs to compare:
>> 4.19.3 on old Pyra fails
>> 4.19.4 on new Pyra boots
>> 4.20-rc5 on new Pyra fails
>> 4.20-rc5 on old Pyra boots
>> 
>> What is the logic behind?
>> 
>> At least I can test the 4.20-rc5 on the old Pyra and try to search for panel enable calls.
>> Well, it does not try to enable the panel.
>> 
> root at letux:~# cat /proc/cmdline 
> root=PARTUUID=7d45bc20-02 rootwait console=ttyO2,115200n8 vram=12M omapfb.vram=0:8M,1:4M omapfb.rotate_type=0 omapdss.def_disp=lcd rootwait twl4030_charger.allow_usb=1 log_buf_len=8M ignore_loglevel earlyprintk

That is essentially the same...

> root at letux:~# uname -a
> Linux letux 4.20.0-rc4-letux+ #3 SMP PREEMPT Fri Nov 30 20:38:05 CET 2018 armv7l GNU/Linux
> root at letux:~# 
> 
> panel enable is called here (my tree).

Did you remove anything? I had tried with and without TILER patches and not seen a difference.

For the non-booting old Pyra I have found that it happens if I try to boot from eMMC only.
U-Boot shows these partitions:

=>part list mmc 1

Partition Map for MMC device 1  --   Partition Type: DOS

Part    Start Sector    Num Sectors     UUID            Type
  1     128             3053561         66b2e4be-01     0c Boot
  2     3053689         58017671        66b2e4be-02     83
=> run bootcmd
Letux OMAP5 bootcmd
Card did not respond to voltage select!
Card did not respond to voltage select!
Card did not respond to voltage select!
Card did not respond to voltage select!
switch to partitions #0, OK
mmc1(part 0) is current device
SD/MMC found on device 1
reading uEnv.txt
85 bytes read in 2 ms (41 KiB/s)
Loaded environment from uEnv.txt
Importing environment from mmc1 ...
reading //uImage
4976416 bytes read in 252 ms (18.8 MiB/s)
reading //omap5-letux-cortex15-v5.1+pyra-v5.1.dtb
65399 bytes read in 10 ms (6.2 MiB/s)
Booting from mmc1 ...
uuid of mmc 1:2 = 66b2e4be-02
## Booting kernel from Legacy Image at 82000000 ...
   Image Name:   Linux-4.19.3-letux+
   Image Type:   ARM Linux Kernel Image (uncompressed)
   Data Size:    4976352 Bytes = 4.7 MiB
   Load Address: 80008000
   Entry Point:  80008000
   Verifying Checksum ... OK
## Flattened Device Tree blob at 88000000
   Booting using the fdt blob at 0x88000000
   Loading Kernel Image ... OK
   Loading Device Tree to 8ffed000, end 8fffff76 ... OK

Starting kernel ...

[    0.000000] Booting Linux on physical CPU 0x0
[    0.000000] Linux version 4.19.3-letux+ (hns at iMac.fritz.box) (gcc version 4.9.2 (GCC)) #2944 SMP PREEMPT Thu Nov 22 05:25:33 CET 2018
[    0.000000] CPU: ARMv7 Processor [412fc0f2] revision 2 (ARMv7), cr=10c5387d
[    0.000000] CPU: div instructions available: patching division code
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache
[    0.000000] OF: fdt: Machine model: Pyra-Handheld-V5.1.2ff
[    0.000000] Malformed early option 'console'
[    0.000000] debug: ignoring loglevel setting.
[    0.000000] Memory policy: Data cache writealloc
[    0.000000] cma: Reserved 16 MiB at 0xfd800000
[    0.000000] OMAP4: Map 0xfee00000 to (ptrval) for dram barrier
[    0.000000] On node 0 totalpages: 519680
[    0.000000]   Normal zone: 1536 pages used for memmap
[    0.000000]   Normal zone: 0 pages reserved
[    0.000000]   Normal zone: 196608 pages, LIFO batch:63
[    0.000000]   HighMem zone: 323072 pages, LIFO batch:63
[    0.000000] OMAP5432 ES2.0
[    0.000000] random: get_random_bytes called from start_kernel+0x80/0x474 with crng_init=0
[    0.000000] percpu: Embedded 17 pages/cpu @(ptrval) s40704 r8192 d20736 u69632
[    0.000000] pcpu-alloc: s40704 r8192 d20736 u69632 alloc=17*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 518144
[    0.000000] Kernel command line: console= root=PARTUUID=66b2e4be-02 rw rootfstype=ext4 rootwait console=ttyO2,115200n8 vram=12M omapfb.vram=0:8M,1:4M omapfb.rotate_type=0 omapdss.def_disp=lcd rootwait twl4030_charger.allow_usb=1 log_buf_len=8M ignore_loglevel earlyprintk
[    0.000000] log_buf_len: 8388608 bytes
[    0.000000] early log buf free: 63828(97%)
[    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: 2025552K/2078720K available (6928K kernel code, 664K rwdata, 1860K rodata, 1024K init, 222K bss, 36784K reserved, 16384K cma-reserved, 1275904K highmem)
[    0.000000] Virtual kernel memory layout:
[    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
[    0.000000]     fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
[    0.000000]     vmalloc : 0xf0800000 - 0xff800000   ( 240 MB)
[    0.000000]     lowmem  : 0xc0000000 - 0xf0000000   ( 768 MB)
[    0.000000]     pkmap   : 0xbfe00000 - 0xc0000000   (   2 MB)
[    0.000000]     modules : 0xbf000000 - 0xbfe00000   (  14 MB)
[    0.000000]       .text : 0x(ptrval) - 0x(ptrval)   (7921 kB)
[    0.000000]       .init : 0x(ptrval) - 0x(ptrval)   (1024 kB)
[    0.000000]       .data : 0x(ptrval) - 0x(ptrval)   ( 665 kB)
[    0.000000]        .bss : 0x(ptrval) - 0x(ptrval)   ( 223 kB)
[    0.000000] rcu: Preemptible hierarchical RCU implementation.
[    0.000000] rcu:     RCU restricting CPUs from NR_CPUS=4 to nr_cpu_ids=2.
[    0.000000]  Tasks RCU enabled.
[    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] OMAP clockevent source: timer1 at 32768 Hz
[    0.000000] arch_timer: cp15 timer(s) running at 6.14MHz (phys).
[    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x16ac02862, max_idle_ns: 440795202218 ns
[    0.000004] sched_clock: 56 bits at 6MHz, resolution 162ns, wraps every 4398046511085ns
[    0.000016] Switching to timer-based delay loop, resolution 162ns
[    0.000827] clocksource: 32k_counter: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 58327039986419 ns
[    0.000836] OMAP clocksource: 32k_counter at 32768 Hz
[    0.002213] Console: colour dummy device 80x30
[    0.002237] Calibrating delay loop (skipped), value calculated using timer frequency.. 12.28 BogoMIPS (lpj=61440)
[    0.002253] pid_max: default: 32768 minimum: 301
[    0.002346] Security Framework initialized
[    0.002397] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.002410] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.002834] CPU: Testing write buffer coherency: ok
[    0.002869] CPU0: Spectre v2: firmware did not set auxiliary control register IBE bit, system vulnerable
[    0.003046] /cpus/cpu at 0 missing clock-frequency property
[    0.003062] /cpus/cpu at 1 missing clock-frequency property
[    0.003073] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[    0.059967] Setting up static identity map for 0x80100000 - 0x80100060
[    0.079964] rcu: Hierarchical SRCU implementation.
[    0.120016] smp: Bringing up secondary CPUs ...
[    0.200349] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[    0.200356] CPU1: Spectre v2: using ICIALLU workaround
[    0.200450] smp: Brought up 1 node, 2 CPUs
[    0.200461] SMP: Total of 2 processors activated (24.57 BogoMIPS).
[    0.200469] CPU: All CPU(s) started in HYP mode.
[    0.200476] CPU: Virtualization extensions available.
[    0.201515] devtmpfs: initialized
[    0.220401] VFP support v0.3: implementor 41 architecture 4 part 30 variant f rev 0
[    0.220754] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.220770] futex hash table entries: 512 (order: 3, 32768 bytes)
[    0.221167] pinctrl core: initialized pinctrl subsystem
[    0.221813] NET: Registered protocol family 16
[    0.224051] DMA: preallocated 256 KiB pool for atomic coherent allocations
[    0.224780] omap_hwmod: l3_main_3 using broken dt data from ocp
[    0.225406] omap_hwmod: l3_main_2 using broken dt data from ocp
[    0.286626] audit: initializing netlink subsys (disabled)
[    0.287177] (NULL device *): Failed to create dummy-scm_conf at 0 debugfs directory
[    0.287407] cpuidle: using governor menu
[    0.288508] audit: type=2000 audit(0.280:1): state=initialized audit_enabled=0 res=1
[    0.294349] OMAP GPIO hardware version 0.1
[    0.298136] GPIO line 234 (gpio8_234/msecure) hogged as output/high
[    0.298579] platform 50000000.gpmc: Cannot lookup hwmod 'gpmc'
[    0.298689] omap-gpmc 50000000.gpmc: _od_fail_runtime_resume: FIXME: missing hwmod/omap_dev info
[    0.298702] omap-gpmc 50000000.gpmc: GPMC revision 6.0
[    0.312870] No ATAGs?
[    0.312948] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[    0.312963] hw-breakpoint: maximum watchpoint size is 8 bytes.
[    0.313383] OMAP DMA hardware revision 0.0
[    0.342717] omap-dma-engine 4a056000.dma-controller: OMAP DMA engine driver (LinkedList1/2/3 supported)
[    0.343683] vsys_cobra: supplied by vmain
[    0.348591] omap-iommu 4a066000.mmu: 4a066000.mmu registered
[    0.348873] omap-iommu 55082000.mmu: 55082000.mmu registered
[    0.350110] vgaarb: loaded
[    0.350694] SCSI subsystem initialized
[    0.360507] libata version 3.00 loaded.
[    0.360722] usbcore: registered new interface driver usbfs
[    0.360769] usbcore: registered new interface driver hub
[    0.360822] usbcore: registered new device driver usb
[    0.361110] usb_phy_generic hsusb2_phy: hsusb2_phy supply vcc not found, using dummy regulator
[    0.361175] usb_phy_generic hsusb2_phy: Linked as a consumer to regulator.0
[    0.362258] Advanced Linux Sound Architecture Driver Initialized.
[    0.363490] clocksource: Switched to clocksource arch_sys_counter
[    0.408186] VFS: Disk quotas dquot_6.6.0
[    0.408251] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    0.416100] NET: Registered protocol family 2
[    0.416912] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes)
[    0.416935] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[    0.417008] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[    0.417139] TCP: Hash tables configured (established 8192 bind 8192)
[    0.417228] UDP hash table entries: 512 (order: 2, 16384 bytes)
[    0.417263] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[    0.417426] NET: Registered protocol family 1
[    0.417452] PCI: CLS 0 bytes, default 64
[    0.469547] hw perfevents: no interrupt-affinity property for /pmu, guessing.
[    0.469713] hw perfevents: enabled with armv7_cortex_a15 PMU driver, 7 counters available
[    0.472992] Initialise system trusted keyrings
[    0.473286] workingset: timestamp_bits=30 max_order=19 bucket_order=0
[    0.473615] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.475284] Key type asymmetric registered
[    0.475294] Asymmetric key parser 'x509' registered
[    0.475347] bounce: pool size: 64 pages
[    0.475387] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
[    0.475400] io scheduler noop registered
[    0.475409] io scheduler deadline registered
[    0.475437] io scheduler cfq registered (default)
[    0.475448] io scheduler mq-deadline registered
[    0.475457] io scheduler kyber registered
[    0.478447] ti-pipe3 4a096000.phy: can't get syscon-pllreset, sata dpll won't idle
[    0.479105] pinctrl-single 4a002840.pinmux: 219 pins, size 438
[    0.479524] pinctrl-single 4ae0c840.pinmux: 30 pins, size 60
[    0.486944] omap_uart 4806c000.serial: no wakeirq for uart1
[    0.487045] 4806c000.serial: ttyO1 at MMIO 0x4806c000 (irq = 46, base_baud = 3000000) is a OMAP UART1
[    0.487181] serial serial0: tty port ttyO1 registered
[    0.487394] 48020000.serial: ttyO2 at MMIO 0x48020000 (irq = 47, base_baud = 3000000) is a OMAP UART2
[    1.363391] console [ttyO2] enabled
[    1.367399] omap_uart 4806e000.serial: no wakeirq for uart3
[    1.373298] 4806e000.serial: ttyO3 at MMIO 0x4806e000 (irq = 48, base_baud = 3000000) is a OMAP UART3
[    1.383286] omap_uart 48068000.serial: no wakeirq for uart5
[    1.389209] 48068000.serial: ttyO5 at MMIO 0x48068000 (irq = 49, base_baud = 3000000) is a OMAP UART5
[    1.405900] brd: module loaded
[    1.413067] loop: module loaded
[    1.417710] ahci 4a140000.sata: SSS flag set, parallel bus scan disabled
[    1.424772] ahci 4a140000.sata: AHCI 0001.0300 32 slots 1 ports 3 Gbps 0x1 impl platform mode
[    1.433712] ahci 4a140000.sata: flags: 64bit ncq sntf stag pm led clo only pmp pio slum part ccc apst 
[    1.444243] scsi host0: ahci
[    1.447433] ata1: SATA max UDMA/133 mmio [mem 0x4a140000-0x4a1410ff] port 0x100 irq 79
[    1.456578] mtdoops: mtd device (mtddev=name/number) must be supplied
[    1.465571] libphy: Fixed MDIO Bus: probed
[    1.472341] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    1.479252] ehci-pci: EHCI PCI platform driver
[    1.484000] usbcore: registered new interface driver usb-storage
[    1.490479] mousedev: PS/2 mouse device common for all mice
[    1.497086] i2c /dev entries driver
[    1.500999] IR NEC protocol handler initialized
[    1.505760] IR RC5(x/sz) protocol handler initialized
[    1.511042] IR RC6 protocol handler initialized
[    1.515799] IR JVC protocol handler initialized
[    1.520532] IR Sony protocol handler initialized
[    1.525380] IR SANYO protocol handler initialized
[    1.530295] IR Sharp protocol handler initialized
[    1.535223] IR MCE Keyboard/mouse protocol handler initialized
[    1.541314] IR XMP protocol handler initialized
[    1.546056] Driver for 1-wire Dallas network protocol.
[    1.554973] omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec
[    1.564347] sdhci: Secure Digital Host Controller Interface driver
[    1.570815] sdhci: Copyright(c) Pierre Ossman
[    1.576452] omap_hsmmc 480b4000.mmc: Linked as a consumer to regulator.4
[    1.609318] omap_gpio 48057000.gpio: Could not set line 13 debounce to 200000 microseconds (-22)
[    1.618580] omap_hsmmc 480d1000.mmc: Got CD GPIO
[    1.623450] omap_hsmmc 480d1000.mmc: Got WP GPIO
[    1.629082] sdhci-pltfm: SDHCI platform and OF driver helper
[    1.635859] txs02612 txs02612: probe
[    1.639668] device_find_by_node: parent=c0b68e38 of=ef00b04c - /ocp/mmc at 480b4000:180
[    1.648033] find_by_node: found :)
[    1.651639] devm_mmc_get_mmc_by_phandle: node /ocp/mmc at 480b4000:180 -> dev = edb28610
[    1.659891] txs02612 txs02612: could not get access to host port, using manual mode
[    1.693106] txs02612_request: current=1 client=0
[    1.718243] txs02612 txs02612: probed
[    1.722079] txs02612_request: current=0 client=1
[    1.726965] ledtrig-cpu: registered to indicate activity on CPUs
[    1.735471] usbcore: registered new interface driver usbhid
[    1.741294] usbhid: USB HID core driver
[    1.745534] ashmem: initialized
[    1.751478] oprofile: using timer interrupt.
[    1.756163] Initializing XFRM netlink socket
[    1.760648] NET: Registered protocol family 17
[    1.765328] NET: Registered protocol family 15
[    1.769991] Key type dns_resolver registered
[    1.774709] ThumbEE CPU extension supported.
[    1.779185] Registering SWP/SWPB emulation handler
[    1.784252] omap_vc_init_channel: No PMIC info for vdd_core
[    1.790076] omap_vp_init: No PMIC info for vdd_core
[    1.795203] omap_vc_init_channel: No PMIC info for vdd_mm
[    1.797870] ata1: SATA link down (SStatus 0 SControl 300)
[    1.800847] omap_vp_init: No PMIC info for vdd_mm
[    1.811444] omap_vc_init_channel: No PMIC info for vdd_mpu
[    1.817197] omap_vp_init: No PMIC info for vdd_mpu
[    1.822216] Power Management for TI OMAP4+ devices.
[    1.827591] SmartReflex Class3 initialized
[    1.832531] Loading compiled-in X.509 certificates
[    1.854406] ------------[ cut here ]------------
[    1.859256] WARNING: CPU: 1 PID: 37 at drivers/irqchip/irq-gic.c:1016 gic_irq_domain_translate+0xb4/0xcc
[    1.869246] Modules linked in:
[    1.872458] CPU: 1 PID: 37 Comm: kworker/1:1 Not tainted 4.19.3-letux+ #2944
[    1.879838] Hardware name: Generic OMAP5 (Flattened Device Tree)
[    1.886146] Workqueue: events deferred_probe_work_func
[    1.891551] [<c01110a0>] (unwind_backtrace) from [<c010c554>] (show_stack+0x10/0x14)
[    1.899680] [<c010c554>] (show_stack) from [<c07a9c74>] (dump_stack+0x7c/0x9c)
[    1.907281] [<c07a9c74>] (dump_stack) from [<c0132df0>] (__warn+0xd8/0x108)
[    1.914586] [<c0132df0>] (__warn) from [<c0132f30>] (warn_slowpath_null+0x38/0x44)
[    1.922517] [<c0132f30>] (warn_slowpath_null) from [<c044edf8>] (gic_irq_domain_translate+0xb4/0xcc)
[    1.932094] [<c044edf8>] (gic_irq_domain_translate) from [<c044f108>] (gic_irq_domain_alloc+0x38/0x94)
[    1.941867] [<c044f108>] (gic_irq_domain_alloc) from [<c012410c>] (wakeupgen_domain_alloc+0xb8/0xe4)
[    1.951439] [<c012410c>] (wakeupgen_domain_alloc) from [<c0183148>] (__irq_domain_alloc_irqs+0x148/0x200)
[    1.961465] [<c0183148>] (__irq_domain_alloc_irqs) from [<c0183644>] (irq_create_fwspec_mapping+0x284/0x350)
[    1.971771] [<c0183644>] (irq_create_fwspec_mapping) from [<c018376c>] (irq_create_of_mapping+0x5c/0x7c)
[    1.981711] [<c018376c>] (irq_create_of_mapping) from [<c0683068>] (of_irq_get+0x68/0xc0)
[    1.990286] [<c0683068>] (of_irq_get) from [<c061b048>] (i2c_device_probe+0xb8/0x258)
[    1.998489] [<c061b048>] (i2c_device_probe) from [<c050dee0>] (really_probe+0x148/0x2ac)
[    2.006972] [<c050dee0>] (really_probe) from [<c050e298>] (driver_probe_device+0x110/0x158)
[    2.015738] [<c050e298>] (driver_probe_device) from [<c050c530>] (bus_for_each_drv+0x90/0xb8)
[    2.024677] [<c050c530>] (bus_for_each_drv) from [<c050e0d8>] (__device_attach+0x94/0x120)
[    2.033335] [<c050e0d8>] (__device_attach) from [<c050d270>] (bus_probe_device+0x28/0x80)
[    2.041908] [<c050d270>] (bus_probe_device) from [<c050b448>] (device_add+0x300/0x578)
[    2.050210] [<c050b448>] (device_add) from [<c061b4f0>] (i2c_new_device+0x244/0x2b4)
[    2.058336] [<c061b4f0>] (i2c_new_device) from [<c061f010>] (of_i2c_register_device+0x40/0x80)
[    2.067374] [<c061f010>] (of_i2c_register_device) from [<c061f318>] (of_i2c_register_devices+0x70/0xbc)
[    2.077218] [<c061f318>] (of_i2c_register_devices) from [<c061bfd8>] (i2c_register_adapter+0x298/0x3b0)
[    2.087069] [<c061bfd8>] (i2c_register_adapter) from [<c0622bcc>] (omap_i2c_probe+0x588/0x69c)
[    2.096105] [<c0622bcc>] (omap_i2c_probe) from [<c050fd74>] (platform_drv_probe+0x48/0x98)
[    2.104773] [<c050fd74>] (platform_drv_probe) from [<c050dee0>] (really_probe+0x148/0x2ac)
[    2.113439] [<c050dee0>] (really_probe) from [<c050e298>] (driver_probe_device+0x110/0x158)
[    2.122224] [<c050e298>] (driver_probe_device) from [<c050c530>] (bus_for_each_drv+0x90/0xb8)
[    2.131155] [<c050c530>] (bus_for_each_drv) from [<c050e0d8>] (__device_attach+0x94/0x120)
[    2.139816] [<c050e0d8>] (__device_attach) from [<c050d270>] (bus_probe_device+0x28/0x80)
[    2.148397] [<c050d270>] (bus_probe_device) from [<c050d6ec>] (deferred_probe_work_func+0x58/0x7c)
[    2.157784] [<c050d6ec>] (deferred_probe_work_func) from [<c014bee0>] (process_one_work+0x258/0x474)
[    2.167351] [<c014bee0>] (process_one_work) from [<c014c124>] (process_scheduled_works+0x28/0x30)
[    2.176648] [<c014c124>] (process_scheduled_works) from [<c014c6e0>] (worker_thread+0x2e0/0x3d8)
[    2.185865] [<c014c6e0>] (worker_thread) from [<c0150950>] (kthread+0x134/0x150)
[    2.193623] [<c0150950>] (kthread) from [<c01010e8>] (ret_from_fork+0x14/0x2c)
[    2.201202] Exception stack(0xeda5ffb0 to 0xeda5fff8)
[    2.206487] ffa0:                                     00000000 00000000 00000000 00000000
[    2.215057] ffc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
[    2.223610] ffe0: 00000000 00000000 00000000 00000000 00000013 00000000
[    2.230583] ---[ end trace 1f0303d2cc1b2509 ]---
[    2.235478] palmas 0-0048: Irq flag is 0x00000000
[    2.266824] palmas 0-0048: Muxing GPIO 3, PWM 0, LED 0
[    2.280191] palmas-rtc 48070000.i2c:palmas at 48:rtc: rtc core: registered 48070000.i2c:palmas at 48:rtc as rtc0
[    2.293955] SMPS123: supplied by regulator-dummy
[    2.300424] random: fast init done
[    2.304057] SMPS45: supplied by regulator-dummy
[    2.310456] SMPS6: supplied by vsys_cobra
[    2.316197] SMPS7: supplied by vsys_cobra
[    2.321903] SMPS8: supplied by vsys_cobra
[    2.327719] SMPS9: supplied by vsys_cobra
[    2.332241] smps9: Bringing 0uV into 2100000-2100000uV
[    2.339043] SMPS10_OUT2: supplied by regulator-dummy
[    2.345612] SMPS10_OUT1: supplied by regulator-dummy
[    2.351720] LDO1: supplied by vsys_cobra
[    2.356507] ldo1: Bringing 0uV into 1800000-1800000uV
[    2.363066] LDO2: supplied by vsys_cobra
[    2.370075] ldo4: Bringing 0uV into 1800000-1800000uV
[    2.377020] LDO5: supplied by vsys_cobra
[    2.385867] LDO7: supplied by vsys_cobra
[    2.390301] ldo7: Bringing 0uV into 2000000-2000000uV
[    2.397018] LDO8: supplied by vsys_cobra
[    2.402835] LDO9: supplied by vmmcsd_fixed
[    2.409505] LDOLN: supplied by vsys_cobra
[    2.415630] LDOUSB: supplied by vsys_cobra
[    2.424043] ------------[ cut here ]------------
[    2.428890] WARNING: CPU: 1 PID: 37 at drivers/irqchip/irq-gic.c:1016 gic_irq_domain_translate+0xb4/0xcc
[    2.438860] Modules linked in:
[    2.442083] CPU: 1 PID: 37 Comm: kworker/1:1 Tainted: G        W         4.19.3-letux+ #2944
[    2.450920] Hardware name: Generic OMAP5 (Flattened Device Tree)
[    2.457215] Workqueue: events deferred_probe_work_func
[    2.462617] [<c01110a0>] (unwind_backtrace) from [<c010c554>] (show_stack+0x10/0x14)
[    2.470732] [<c010c554>] (show_stack) from [<c07a9c74>] (dump_stack+0x7c/0x9c)
[    2.478303] [<c07a9c74>] (dump_stack) from [<c0132df0>] (__warn+0xd8/0x108)
[    2.485601] [<c0132df0>] (__warn) from [<c0132f30>] (warn_slowpath_null+0x38/0x44)
[    2.493539] [<c0132f30>] (warn_slowpath_null) from [<c044edf8>] (gic_irq_domain_translate+0xb4/0xcc)
[    2.503117] [<c044edf8>] (gic_irq_domain_translate) from [<c044f108>] (gic_irq_domain_alloc+0x38/0x94)
[    2.512890] [<c044f108>] (gic_irq_domain_alloc) from [<c012410c>] (wakeupgen_domain_alloc+0xb8/0xe4)
[    2.522470] [<c012410c>] (wakeupgen_domain_alloc) from [<c0183148>] (__irq_domain_alloc_irqs+0x148/0x200)
[    2.532492] [<c0183148>] (__irq_domain_alloc_irqs) from [<c0183644>] (irq_create_fwspec_mapping+0x284/0x350)
[    2.542786] [<c0183644>] (irq_create_fwspec_mapping) from [<c018376c>] (irq_create_of_mapping+0x5c/0x7c)
[    2.552727] [<c018376c>] (irq_create_of_mapping) from [<c0683068>] (of_irq_get+0x68/0xc0)
[    2.561300] [<c0683068>] (of_irq_get) from [<c061b048>] (i2c_device_probe+0xb8/0x258)
[    2.569510] [<c061b048>] (i2c_device_probe) from [<c050dee0>] (really_probe+0x148/0x2ac)
[    2.577980] [<c050dee0>] (really_probe) from [<c050e298>] (driver_probe_device+0x110/0x158)
[    2.586738] [<c050e298>] (driver_probe_device) from [<c050c530>] (bus_for_each_drv+0x90/0xb8)
[    2.595669] [<c050c530>] (bus_for_each_drv) from [<c050e0d8>] (__device_attach+0x94/0x120)
[    2.604349] [<c050e0d8>] (__device_attach) from [<c050d270>] (bus_probe_device+0x28/0x80)
[    2.612918] [<c050d270>] (bus_probe_device) from [<c050b448>] (device_add+0x300/0x578)
[    2.621217] [<c050b448>] (device_add) from [<c061b4f0>] (i2c_new_device+0x244/0x2b4)
[    2.629338] [<c061b4f0>] (i2c_new_device) from [<c061f010>] (of_i2c_register_device+0x40/0x80)
[    2.638364] [<c061f010>] (of_i2c_register_device) from [<c061f318>] (of_i2c_register_devices+0x70/0xbc)
[    2.648212] [<c061f318>] (of_i2c_register_devices) from [<c061bfd8>] (i2c_register_adapter+0x298/0x3b0)
[    2.658054] [<c061bfd8>] (i2c_register_adapter) from [<c0622bcc>] (omap_i2c_probe+0x588/0x69c)
[    2.667091] [<c0622bcc>] (omap_i2c_probe) from [<c050fd74>] (platform_drv_probe+0x48/0x98)
[    2.675761] [<c050fd74>] (platform_drv_probe) from [<c050dee0>] (really_probe+0x148/0x2ac)
[    2.684421] [<c050dee0>] (really_probe) from [<c050e298>] (driver_probe_device+0x110/0x158)
[    2.693168] [<c050e298>] (driver_probe_device) from [<c050c530>] (bus_for_each_drv+0x90/0xb8)
[    2.702099] [<c050c530>] (bus_for_each_drv) from [<c050e0d8>] (__device_attach+0x94/0x120)
[    2.710770] [<c050e0d8>] (__device_attach) from [<c050d270>] (bus_probe_device+0x28/0x80)
[    2.719340] [<c050d270>] (bus_probe_device) from [<c050d6ec>] (deferred_probe_work_func+0x58/0x7c)
[    2.728742] [<c050d6ec>] (deferred_probe_work_func) from [<c014bee0>] (process_one_work+0x258/0x474)
[    2.738314] [<c014bee0>] (process_one_work) from [<c014c124>] (process_scheduled_works+0x28/0x30)
[    2.747610] [<c014c124>] (process_scheduled_works) from [<c014c6e0>] (worker_thread+0x2e0/0x3d8)
[    2.756845] [<c014c6e0>] (worker_thread) from [<c0150950>] (kthread+0x134/0x150)
[    2.764607] [<c0150950>] (kthread) from [<c01010e8>] (ret_from_fork+0x14/0x2c)
[    2.772174] Exception stack(0xeda5ffb0 to 0xeda5fff8)
[    2.777489] ffa0:                                     00000000 00000000 00000000 00000000
[    2.786058] ffc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
[    2.794624] ffe0: 00000000 00000000 00000000 00000000 00000013 00000000
[    2.801576] ---[ end trace 1f0303d2cc1b250a ]---
[    2.806962] twl6040 0-004b: Linked as a consumer to regulator.12
[    2.813314] twl6040 0-004b: Linked as a consumer to regulator.14
[    2.822698] omap_i2c 48070000.i2c: bus 0 rev0.12 at 400 kHz
[    2.830401] omap_i2c 48072000.i2c: bus 1 rev0.12 at 400 kHz
[    2.837969] omap_i2c 48060000.i2c: bus 2 rev0.12 at 400 kHz
[    2.845279] omap_i2c 4807a000.i2c: bus 3 rev0.12 at 400 kHz
[    2.852083] vdds_1v8_main: supplied by smps7
[    2.856996] pca953x 4-0022: Linked as a consumer to regulator.3
[    2.886920] omap_i2c 4807c000.i2c: bus 4 rev0.12 at 400 kHz
[    2.893258] cpu cpu0: Linked as a consumer to regulator.9
[    2.899020] cpu cpu0: Dropping the link to regulator.9
[    2.905079] cpu cpu0: Linked as a consumer to regulator.9
[    2.912619] omap_hsmmc 4809c000.mmc: Linked as a consumer to regulator.25
[    2.919907] omap_hsmmc 4809c000.mmc: Linked as a consumer to regulator.5
[    2.955752] omap_hsmmc 480ad000.mmc: allocated mmc-pwrseq
[    2.962402] omap_hsmmc 480ad000.mmc: Linked as a consumer to regulator.8
[    3.081795] omap_gpio 48057000.gpio: Could not set line 13 debounce to 200000 microseconds (-22)
[    3.091343] omap_hsmmc 480d1000.mmc: Got CD GPIO
[    3.096486] omap_hsmmc 480d1000.mmc: Got WP GPIO
[    3.102201] omap_hsmmc 480d1000.mmc: Linked as a consumer to regulator.18
[    3.116398] omap_hsmmc 480ad000.mmc: card claims to support voltages below defined range
[    3.142742] mmc4: new high speed SDIO card at address 0001
[    3.234557] ldo3: supplied by vdds_1v8_main
[    3.239891] ldo4: supplied by vdds_1v8_main
[    3.247015] ldo6: supplied by vdds_1v8_main
[    3.444021] input: user-button as /devices/platform/user-button/input/input0
[    3.458294] input: pyra-game-buttons as /devices/platform/pyra-game-buttons/input/input1
[    3.467761] input: pyra-lid-wakeup as /devices/platform/pyra-lid-wakeup/input/input2
[    3.477633] palmas-rtc 48070000.i2c:palmas at 48:rtc: setting system clock to 2018-12-04 21:38:57 UTC (1543959537)
[    3.488224] sr_init: No PMIC hook to init smartreflex
[    3.494794] vmmcsdio_fixed: disabling
[    3.500201] ldo3: disabling
[    3.503837] ldo8: disabling
[    3.507172] modem_vbus_power: disabling
[    3.511189] otg_path: disabling
[    3.514527] ALSA device list:
[    3.517627]   No soundcards found.
[    3.521709] Waiting for root device PARTUUID=66b2e4be-02...
[  104.823918] random: crng init done

--- hangs ---

This kernel binary was compiled Thu Nov 22 05:25:33

So something is broken in the mmc subsystem and sometimes works and sometimes doesn't
Most likely depending on the month number reported by RTC.

Next I'll try to install the same Nov 22 binary on the SD card.
If that works then we have some problem with SD card power up/down...

BR,
Nikolaus



More information about the Letux-kernel mailing list