[ +to Eduardo Valentin, Fabio Estevam ] On 09/02/2015 03:54 AM, oe5hpm wrote: > 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" Forwarded to author of said patch. Regards, Peter Hurley > 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 > -- 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