Hi Folks,
i've been running into trouble while try to boot most recent vanilla
kernel on my Freescale i.mx6 board. There went something wrong with
the serial imx driver.
I did bisect the trouble down to commit id
9e7b399d6528eac33a6fbfceb2b92af209c3454d : "serial: imx: remove
unbalanced clk_prepare"
I tried to revert this commit and everything works fine.
Have a look to console during bootup.
Did anyone else observe something like this?
best regards,
Hannes
Starting kernel ...
[ 0.000000] Booting Linux on physical CPU 0x0
[ 0.000000] Linux version 4.2.0-04295-gac9c539-dirty
(schmelzerh@hannes-werkstatt) (gcc version 4.9.2 20140904 (prerelease)
(crosstool-NG linaro-1.13.1-4.9-2014.09 - Linaro GCC 4.9-2014.09) )
#37 SMP PREEMPT Wed Sep 2 09:36:11 CEST 25
[ 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] Machine model: breval i.mx6 Board
[ 0.000000] cma: Reserved 16 MiB at 0x4f000000
[ 0.000000] Memory policy: Data cache writealloc
[ 0.000000] PERCPU: Embedded 11 pages/cpu @7e7ae000 s14784 r8192
d22080 u45056
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on.
Total pages: 260096
[ 0.000000] Kernel command line: console=ttymxc2,115200n8
root=/dev/mmcblk0p1 rootfstype=ext4
[ 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: 1007984K/1048576K available (4663K kernel code,
187K rwdata, 1496K rodata, 228K init, 8261K bss, 24208K reserved,
16384K cma-reserved, 0K highmem)
[ 0.000000] Virtual kernel memory layout:
[ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB)
[ 0.000000] fixmap : 0xffc00000 - 0xfff00000 (3072 kB)
[ 0.000000] vmalloc : 0x80800000 - 0xff000000 (2024 MB)
[ 0.000000] lowmem : 0x40000000 - 0x80000000 (1024 MB)
[ 0.000000] pkmap : 0x3fe00000 - 0x40000000 ( 2 MB)
[ 0.000000] modules : 0x3f000000 - 0x3fe00000 ( 14 MB)
[ 0.000000] .text : 0x40008000 - 0x4060c08c (6161 kB)
[ 0.000000] .init : 0x4060d000 - 0x40646000 ( 228 kB)
[ 0.000000] .data : 0x40646000 - 0x40674c20 ( 188 kB)
[ 0.000000] .bss : 0x40677000 - 0x40e88650 (8262 kB)
[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[ 0.000000] Running RCU self tests
[ 0.000000] Preemptible hierarchical RCU implementation.
[ 0.000000] RCU lockdep checking is enabled.
[ 0.000000] Build-time adjustment of leaf fanout to 32.
[ 0.000000] RCU restricting CPUs from NR_CPUS=4 to nr_cpu_ids=2.
[ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=32, nr_cpu_ids=2
[ 0.000000] NR_IRQS:16 nr_irqs:16 16
[ 0.000000] L2C-310 erratum 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 1 lines
[ 0.000000] L2C-310 dynamic clock gating enabled, standby mode enabled
[ 0.000000] L2C-310 cache controller enabled, 16 ways, 512 kB
[ 0.000000] L2C-310: CACHE_ID 0x410000c8, AUX_CTRL 0x76450001
[ 0.000000] Switching to timer-based delay loop, resolution 333ns
[ 0.000008] sched_clock: 32 bits at 3000kHz, resolution 333ns,
wraps every 715827882841ns
[ 0.000042] clocksource: mxc_timer1: mask: 0xffffffff max_cycles:
0xffffffff, max_idle_ns: 637086815595 ns
[ 0.001508] Console: colour dummy device 80x30
[ 0.001540] Lock dependency validator: Copyright (c) 2006 Red Hat,
Inc., Ingo Molnar
[ 0.001551] ... MAX_LOCKDEP_SUBCLASSES: 8
[ 0.001562] ... MAX_LOCK_DEPTH: 48
[ 0.001570] ... MAX_LOCKDEP_KEYS: 8191
[ 0.001579] ... CLASSHASH_SIZE: 4096
[ 0.001589] ... MAX_LOCKDEP_ENTRIES: 32768
[ 0.001597] ... MAX_LOCKDEP_CHAINS: 65536
[ 0.001605] ... CHAINHASH_SIZE: 32768
[ 0.001614] memory used by lock dependency info: 5167 kB
[ 0.001624] per task-struct memory footprint: 1536 bytes
[ 0.001652] Calibrating delay loop (skipped), value calculated
using timer frequency.. 6.00 BogoMIPS (lpj=30000)
[ 0.001672] pid_max: default: 32768 minimum: 301
[ 0.001887] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.001907] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.003372] CPU: Testing write buffer coherency: ok
[ 0.004224] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[ 0.004322] Setting up static identity map for 0x10008280 - 0x100082b4
[ 0.079982] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[ 0.080424] Brought up 2 CPUs
[ 0.080450] SMP: Total of 2 processors activated (12.00 BogoMIPS).
[ 0.080463] CPU: All CPU(s) started in SVC mode.
[ 0.082400] devtmpfs: initialized
[ 0.117839] VFP support v0.3: implementor 41 architecture 3 part 30
variant 9 rev 4
[ 0.118391] clocksource: jiffies: mask: 0xffffffff max_cycles:
0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.120092] pinctrl core: initialized pinctrl subsystem
[ 0.123356] NET: Registered protocol family 16
[ 0.127313] DMA: preallocated 256 KiB pool for atomic coherent allocations
[ 0.129428] CPU identified as i.MX6DL, silicon rev 1.1
[ 0.176107] hw-breakpoint: found 5 (+1 reserved) breakpoint and 1
watchpoint registers.
[ 0.176126] hw-breakpoint: maximum watchpoint size is 4 bytes.
[ 0.179036] imx6dl-pinctrl 20e0000.iomuxc: initialized IMX pinctrl driver
[ 0.235182] mxs-dma 110000.dma-apbh: initialized
[ 0.241238] SCSI subsystem initialized
[ 0.242081] usbcore: registered new interface driver usbfs
[ 0.242286] usbcore: registered new interface driver hub
[ 0.242573] usbcore: registered new device driver usb
[ 0.244432] i2c i2c-1: IMX I2C adapter registered
[ 0.244465] i2c i2c-1: can't use DMA
[ 0.245433] i2c i2c-2: IMX I2C adapter registered
[ 0.245464] i2c i2c-2: can't use DMA
[ 0.245754] pps_core: LinuxPPS API ver. 1 registered
[ 0.245770] pps_core: Software ver. 5.3.6 - Copyright 2005-2007
Rodolfo Giometti <giometti@xxxxxxxx>
[ 0.245840] PTP clock support registered
[ 0.246547] Advanced Linux Sound Architecture Driver Initialized.
[ 0.249207] clocksource: Switched to clocksource mxc_timer1
[ 0.277126] NET: Registered protocol family 2
[ 0.279219] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[ 0.279388] TCP bind hash table entries: 8192 (order: 6, 294912 bytes)
[ 0.281933] TCP: Hash tables configured (established 8192 bind 8192)
[ 0.282165] UDP hash table entries: 512 (order: 3, 40960 bytes)
[ 0.282522] UDP-Lite hash table entries: 512 (order: 3, 40960 bytes)
[ 0.283600] NET: Registered protocol family 1
[ 0.284830] RPC: Registered named UNIX socket transport module.
[ 0.284850] RPC: Registered udp transport module.
[ 0.284862] RPC: Registered tcp transport module.
[ 0.284876] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 0.287916] futex hash table entries: 512 (order: 3, 32768 bytes)
[ 0.315660] NFS: Registering the id_resolver key type
[ 0.315883] Key type id_resolver registered
[ 0.315900] Key type id_legacy registered
[ 0.316808] fuse init (API version 7.23)
[ 0.324738] io scheduler noop registered
[ 0.324773] io scheduler deadline registered
[ 0.324879] io scheduler cfq registered (default)
[ 0.431821] imx6q-pcie 1ffc000.pcie: PCI host bridge to bus 0000:00
[ 0.431848] pci_bus 0000:00: root bus resource [io 0x1000-0xffff]
[ 0.431868] pci_bus 0000:00: root bus resource [mem 0x01000000-0x01efffff]
[ 0.431893] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 0.433137] PCI: bus0: Fast back to back transfers disabled
[ 0.433495] pci 0000:00:00.0: PCI bridge to [bus 01-ff]
[ 0.435036] PCI: bus1: Fast back to back transfers disabled
[ 0.435413] pci 0000:00:00.0: BAR 0: assigned [mem 0x01000000-0x010fffff]
[ 0.435447] pci 0000:00:00.0: BAR 8: no space for [mem size 0x01000000]
[ 0.435465] pci 0000:00:00.0: BAR 8: failed to assign [mem size 0x01000000]
[ 0.435485] pci 0000:00:00.0: BAR 9: assigned [mem
0x01100000-0x011fffff pref]
[ 0.435506] pci 0000:00:00.0: BAR 6: assigned [mem
0x01200000-0x0120ffff pref]
[ 0.435525] pci 0000:00:00.0: BAR 7: assigned [io 0x1000-0x1fff]
[ 0.435553] pci 0000:01:00.0: BAR 2: no space for [mem size 0x00200000]
[ 0.435569] pci 0000:01:00.0: BAR 2: failed to assign [mem size 0x00200000]
[ 0.435585] pci 0000:01:00.0: BAR 1: no space for [mem size 0x00004000]
[ 0.435601] pci 0000:01:00.0: BAR 1: failed to assign [mem size 0x00004000]
[ 0.435616] pci 0000:01:00.0: BAR 0: no space for [mem size 0x00000100]
[ 0.435631] pci 0000:01:00.0: BAR 0: failed to assign [mem size 0x00000100]
[ 0.435651] pci 0000:00:00.0: PCI bridge to [bus 01]
[ 0.435669] pci 0000:00:00.0: bridge window [io 0x1000-0x1fff]
[ 0.435698] pci 0000:00:00.0: bridge window [mem
0x01100000-0x011fffff pref]
[ 0.438751] imx-sdma 20ec000.sdma: Direct firmware load for
imx/sdma/sdma-imx6q.bin failed with error -2
[ 0.438782] imx-sdma 20ec000.sdma: external firmware not found,
using ROM firmware
[ 0.444631] imx-sdma 20ec000.sdma: initialized
[ 0.446717] 21e8000.serial: ttymxc1 at MMIO 0x21e8000 (irq = 290,
base_baud = 5000000) is a IMX
[ 0.448316] 21ec000.serial: ttymxc2 at MMIO 0x21ec000 (irq = 291,
base_baud = 5000000) is a IMX
[ 1.335637] console [ttymxc2] enabled
[ 1.335661] BUG: scheduling while atomic: swapper/0/1/0x00000002
[ 1.335667] 4 locks held by swapper/0/1:
[ 1.335700] #0: (&dev->mutex){......}, at: [<402debd0>]
__driver_attach+0x50/0xac
[ 1.335719] #1: (&dev->mutex){......}, at: [<402debe0>]
__driver_attach+0x60/0xac
[ 1.335743] #2: (port_mutex){+.+.+.}, at: [<402cfa74>]
uart_add_one_port+0x70/0x4b4
[ 1.335762] #3: (&port->mutex){+.+.+.}, at: [<402cfa80>]
uart_add_one_port+0x7c/0x4b4
[ 1.335768] Modules linked in:
[ 1.335772] irq event stamp: 176401
[ 1.335784] hardirqs last enabled at (176401): [<400706e8>]
vprintk_emit+0x24c/0x62c
[ 1.335794] hardirqs last disabled at (176400): [<400704fc>]
vprintk_emit+0x60/0x62c
[ 1.335807] softirqs last enabled at (176376): [<4002732c>]
__do_softirq+0x25c/0x2e0
[ 1.335816] softirqs last disabled at (176369): [<4002770c>]
irq_exit+0xe0/0x11c
[ 1.335826] Preemption disabled at:[<40070c28>] vprintk_default+0x28/0x30
[ 1.335829]
[ 1.335841] CPU: 0 PID: 1 Comm: swapper/0 Not tainted
4.2.0-04295-gac9c539-dirty #37
[ 1.335845] Hardware name: Freescale i.MX6 Quad/DualLite (Device Tree)
[ 1.335851] Backtrace:
[ 1.335872] [<40013444>] (dump_backtrace) from [<40013640>]
(show_stack+0x18/0x1c)
[ 1.335888] r7:4064863c r6:40659eb0 r5:40659eb0 r4:00000000
[ 1.335903] [<40013628>] (show_stack) from [<4048d2ac>]
(dump_stack+0x8c/0xcc)
[ 1.335921] [<4048d220>] (dump_stack) from [<400463cc>]
(__schedule_bug+0x80/0xdc)
[ 1.335938] r7:4064863c r6:40643d40 r5:7e068000 r4:7e068000
[ 1.335950] [<4004634c>] (__schedule_bug) from [<4048e2a0>]
(__schedule+0x494/0x614)
[ 1.335961] r5:7e068000 r4:7e7b0d40
[ 1.335970] [<4048de0c>] (__schedule) from [<4048e4dc>] (schedule+0x4c/0xac)
[ 1.335992] r10:40e64ea8 r9:40495bf8 r8:0006ddd0 r7:0006ddd0
r6:00000001 r5:00000000
[ 1.335998] r4:7e070000
[ 1.336013] [<4048e490>] (schedule) from [<404932d8>]
(schedule_hrtimeout_range_clock+0xac/0x120)
[ 1.336022] r5:00000000 r4:0007a120
[ 1.336033] [<4049322c>] (schedule_hrtimeout_range_clock) from
[<40493360>] (schedule_hrtimeout_range+0x14/0x18)
[ 1.336052] r9:40495bf8 r8:00000029 r7:7e1ba080 r6:ffff8b55
r5:7e00c2c0 r4:40648100
[ 1.336064] [<4049334c>] (schedule_hrtimeout_range) from
[<40492e84>] (usleep_range+0x64/0x6c)
[ 1.336081] [<40492e20>] (usleep_range) from [<4037ed28>]
(clk_pllv3_wait_lock+0x80/0xb4)
[ 1.336090] [<4037eca8>] (clk_pllv3_wait_lock) from [<4037ed88>]
(clk_pllv3_prepare+0x2c/0x30)
[ 1.336106] r7:7e1ba080 r6:00000029 r5:40e24a80 r4:7e007800
[ 1.336120] [<4037ed5c>] (clk_pllv3_prepare) from [<40378d7c>]
(clk_core_prepare+0xa0/0xc4)
** 40 printk messages dropped ** [ 1.336607] r9:4060d5ec
r8:00000097 r7:00000000 r6:7e15be44 r5:40660004 r4:7e15be10
** 96 printk messages dropped ** [ 1.341584] r9:4060d5ec
r8:00000097 r7:00000000 r6:7e15be44 r5:40660004 r4:7e15be10
--
To unsubscribe from this list: send the line "unsubscribe linux-serial" in
the body of a message to majordomo@xxxxxxxxxxxxxxx
More majordomo info at http://vger.kernel.org/majordomo-info.html
