Hi, I'm seeing odd clock behavior with Beagle, booting with DT. I'm using v3.11-rc7 + DSS DT patches. It looks to me that when setting the rate of a clock, its child clock's rate is not updated correctly. Here's pieces of boot log (full log attached): Here my code prints the current clocks. This looks ok: dpll4_m4_ck's divider is 2 (432000000/2 = 216000000), and dpll4_m4x2_ck, which is a fixed x2 multiplier, is two times dpll4_m4_ck. [ 1.592132] before: [ 1.592163] dpll4_ck: 432000000 [ 1.592193] dpll4_m4_ck: 216000000 [ 1.592224] dpll4_m4x2_ck: 432000000 [ 1.592254] dss1_alwon_fck_3430es2: 432000000 Here DSS driver sets dpll4_m4_ck's rate [ 1.592254] setting rate 86400000 Here we see the clocks after the clk_set_rate. dpll4_m4_ck is as supposed, but the dpll4_m4x2_ck is not x2, resulting in wrong clock for dss1_alwon_fck_3430es2. The rate of dpll4_m4x2_ck does get updated, though, but not for the correct x2 rate, but x1. [ 1.592315] after: [ 1.592315] dpll4_ck: 432000000 [ 1.592346] dpll4_m4_ck: 86400000 [ 1.592376] dpll4_m4x2_ck: 86400000 [ 1.592407] dss1_alwon_fck_3430es2: 86400000 After that the DSS probe is deferred, as there's a missing regulator. A bit later, the driver is probed again: Here the clocks are still wrong, as nothing has changed them [ 3.196868] before: [ 3.199340] dpll4_ck: 432000000 [ 3.202667] dpll4_m4_ck: 86400000 [ 3.206207] dpll4_m4x2_ck: 86400000 [ 3.209991] dss1_alwon_fck_3430es2: 86400000 [ 3.214508] setting rate 72000000 But after this clk_set_rate, the dpll4_m4x2_ck is correct. [ 3.218048] after: [ 3.220275] dpll4_ck: 432000000 [ 3.223602] dpll4_m4_ck: 72000000 [ 3.227142] dpll4_m4x2_ck: 144000000 [ 3.230987] dss1_alwon_fck_3430es2: 144000000 So, for some reason, the first clk_set_rate goes wrong. Any ideas? Tomi
boot reading uImage 4338021 bytes read reading ramdisk.uboot 2990586 bytes read ## Booting kernel from Legacy Image at 81000000 ... Image Name: Linux Image Type: ARM Linux Kernel Image (uncompressed) Data Size: 4337957 Bytes = 4.1 MiB Load Address: 80008000 Entry Point: 80008000 Verifying Checksum ... OK ## Loading init Ramdisk from Legacy Image at 82000000 ... Image Name: Image Type: ARM Linux RAMDisk Image (gzip compressed) Data Size: 2990522 Bytes = 2.9 MiB Load Address: 00000000 Entry Point: 00000000 Verifying Checksum ... OK Loading Kernel Image ... OK OK Starting kernel ... [ 0.000000] Booting Linux on physical CPU 0x0 [ 0.000000] Linux version 3.11.0-rc7-00023-gf6a7f7c-dirty (tomba@deskari) (gcc version 4.7.3 (Ubuntu/Linaro 4.7.3-1ubuntu1) ) #40 SMP Wed Aug 28 12:03:28 EEST 2013 [ 0.000000] CPU: ARMv7 Processor [411fc083] revision 3 (ARMv7), cr=10c53c7d [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT nonaliasing instruction cache [ 0.000000] Machine: Generic OMAP3-GP (Flattened Device Tree), model: TI OMAP3 BeagleBoard [ 0.000000] cma: CMA: reserved 32 MiB at 8d800000 [ 0.000000] Memory policy: ECC disabled, Data cache writeback [ 0.000000] CPU: All CPU(s) started in SVC mode. [ 0.000000] OMAP3430/3530 ES3.0 (l2cache iva sgx neon isp ) [ 0.000000] PERCPU: Embedded 9 pages/cpu @c103f000 s14272 r8192 d14400 u36864 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64768 [ 0.000000] Kernel command line: console=ttyO2,115200 [ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes) [ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes) [ 0.000000] Memory: 208484K/261120K available (5679K kernel code, 672K rwdata, 2208K rodata, 401K init, 5526K bss, 52636K reserved, 0K highmem) [ 0.000000] Virtual kernel memory layout: [ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB) [ 0.000000] fixmap : 0xfff00000 - 0xfffe0000 ( 896 kB) [ 0.000000] vmalloc : 0xd0800000 - 0xff000000 ( 744 MB) [ 0.000000] lowmem : 0xc0000000 - 0xd0000000 ( 256 MB) [ 0.000000] pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB) [ 0.000000] modules : 0xbf000000 - 0xbfe00000 ( 14 MB) [ 0.000000] .text : 0xc0008000 - 0xc07bbf2c (7888 kB) [ 0.000000] .init : 0xc07bc000 - 0xc08207c0 ( 402 kB) [ 0.000000] .data : 0xc0822000 - 0xc08ca300 ( 673 kB) [ 0.000000] .bss : 0xc08ca300 - 0xc0e2fdd0 (5527 kB) [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU restricting CPUs from NR_CPUS=2 to nr_cpu_ids=1. [ 0.000000] NR_IRQS:16 nr_irqs:16 16 [ 0.000000] IRQ: Found an INTC at 0xfa200000 (revision 4.0) with 96 interrupts [ 0.000000] Total of 96 interrupts on 1 active controller [ 0.000000] Clocking rate (Crystal/Core/MPU): 26.0/332/600 MHz [ 0.000000] OMAP clockevent source: timer12 at 32768 Hz [ 0.000000] sched_clock: 32 bits at 32kHz, resolution 30517ns, wraps every 131071999ms [ 0.000000] OMAP clocksource: 32k_counter at 32768 Hz [ 0.000000] Console: colour dummy device 80x30 [ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.000000] ... MAX_LOCK_DEPTH: 48 [ 0.000000] ... MAX_LOCKDEP_KEYS: 8191 [ 0.000000] ... CLASSHASH_SIZE: 4096 [ 0.000000] ... MAX_LOCKDEP_ENTRIES: 16384 [ 0.000000] ... MAX_LOCKDEP_CHAINS: 32768 [ 0.000000] ... CHAINHASH_SIZE: 16384 [ 0.000000] memory used by lock dependency info: 3695 kB [ 0.000000] per task-struct memory footprint: 1152 bytes [ 0.001251] Calibrating delay loop... 383.38 BogoMIPS (lpj=1916928) [ 0.048248] pid_max: default: 32768 minimum: 301 [ 0.048858] Security Framework initialized [ 0.049102] Mount-cache hash table entries: 512 [ 0.066223] CPU: Testing write buffer coherency: ok [ 0.067779] CPU0: thread -1, cpu 0, socket -1, mpidr 0 [ 0.067901] Setting up static identity map for 0xc0591940 - 0xc05919b0 [ 0.076507] Brought up 1 CPUs [ 0.076568] SMP: Total of 1 processors activated (383.38 BogoMIPS). [ 0.076568] CPU: All CPU(s) started in SVC mode. [ 0.080291] devtmpfs: initialized [ 0.161651] pinctrl core: initialized pinctrl subsystem [ 0.167449] regulator-dummy: no parameters [ 0.173004] NET: Registered protocol family 16 [ 0.184082] DMA: preallocated 256 KiB pool for atomic coherent allocations [ 0.205902] Reprogramming SDRC clock to 332000000 Hz [ 0.217712] omap_gpio 48310000.gpio: could not find pctldev for node /ocp/pinmux@0x48002a00/pinmux_gpio1_pins, deferring probe [ 0.217803] platform 48310000.gpio: Driver omap_gpio requests probe deferral [ 0.223022] OMAP GPIO hardware version 2.5 [ 0.259246] platform 49022000.mcbsp: alias fck already exists [ 0.260955] platform 49024000.mcbsp: alias fck already exists [ 0.283477] omap-gpmc 6e000000.gpmc: GPMC revision 5.0 [ 0.302062] No ATAGs? [ 0.302093] hw-breakpoint: debug architecture 0x4 unsupported. [ 0.309997] OMAP DMA hardware revision 4.0 [ 0.420410] bio: create slab <bio-0> at 0 [ 0.427001] edma-dma-engine edma-dma-engine.0: Can't allocate PaRAM dummy slot [ 0.427093] edma-dma-engine: probe of edma-dma-engine.0 failed with error -5 [ 0.546600] omap-dma-engine 48056000.dma-controller: OMAP DMA engine driver [ 0.550231] hsusb2_reset: 3300 mV [ 0.550994] platform hsusb2_power_reg.21: Driver reg-fixed-voltage requests probe deferral [ 0.562499] SCSI subsystem initialized [ 0.566589] usbcore: registered new interface driver usbfs [ 0.567382] usbcore: registered new interface driver hub [ 0.568511] usbcore: registered new device driver usb [ 0.569335] platform hsusb2_phy.22: Driver nop_usb_xceiv requests probe deferral [ 0.579284] omap_i2c i2c.8: did not get pins for i2c error: -19 [ 0.581451] omap_i2c i2c.8: bus 0 rev3.3 at 2600 kHz [ 0.584106] omap_i2c i2c.9: did not get pins for i2c error: -19 [ 0.586486] omap_i2c i2c.9: bus 1 rev3.3 at 100 kHz [ 0.586853] omap_i2c i2c.10: did not get pins for i2c error: -19 [ 0.588623] omap_i2c i2c.10: bus 2 rev3.3 at 100 kHz [ 0.598876] Switched to clocksource 32k_counter [ 0.810302] NET: Registered protocol family 2 [ 0.812805] TCP established hash table entries: 2048 (order: 2, 16384 bytes) [ 0.813110] TCP bind hash table entries: 2048 (order: 4, 73728 bytes) [ 0.814361] TCP: Hash tables configured (established 2048 bind 2048) [ 0.814636] TCP: reno registered [ 0.814666] UDP hash table entries: 256 (order: 2, 20480 bytes) [ 0.815032] UDP-Lite hash table entries: 256 (order: 2, 20480 bytes) [ 0.816741] NET: Registered protocol family 1 [ 0.819091] RPC: Registered named UNIX socket transport module. [ 0.819122] RPC: Registered udp transport module. [ 0.819152] RPC: Registered tcp transport module. [ 0.819152] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.826629] Trying to unpack rootfs image as initramfs... [ 1.275085] Freeing initrd memory: 2916K (c2001000 - c22da000) [ 1.275177] NetWinder Floating Point Emulator V0.97 (double precision) [ 1.275665] hw perfevents: enabled with ARMv7 Cortex-A8 PMU driver, 5 counters available [ 1.523284] VFS: Disk quotas dquot_6.5.2 [ 1.523681] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 1.527465] NFS: Registering the id_resolver key type [ 1.527923] Key type id_resolver registered [ 1.527954] Key type id_legacy registered [ 1.528137] jffs2: version 2.2. (NAND) (SUMMARY) © 2001-2006 Red Hat, Inc. [ 1.529083] msgmni has been set to 476 [ 1.575012] io scheduler noop registered [ 1.575073] io scheduler deadline registered [ 1.575195] io scheduler cfq registered (default) [ 1.580718] pinctrl-single 48002030.pinmux: 742 pins at pa fa002030 size 1484 [ 1.581665] pinctrl-single 48002a00.pinmux: 46 pins at pa fa002a00 size 92 [ 1.589172] usbcore: registered new interface driver udlfb [ 1.592132] before: [ 1.592163] dpll4_ck: 432000000 [ 1.592193] dpll4_m4_ck: 216000000 [ 1.592224] dpll4_m4x2_ck: 432000000 [ 1.592254] dss1_alwon_fck_3430es2: 432000000 [ 1.592254] setting rate 86400000 [ 1.592315] after: [ 1.592315] dpll4_ck: 432000000 [ 1.592346] dpll4_m4_ck: 86400000 [ 1.592376] dpll4_m4x2_ck: 86400000 [ 1.592407] dss1_alwon_fck_3430es2: 86400000 [ 1.592590] OMAP DSS rev 2.0 [ 1.619293] omapdss DPI error: can't get VDDS_DSI regulator [ 1.619354] omapfb omapfb: failed to connect default display [ 1.619354] omapfb omapfb: failed to init overlay connections [ 1.621887] omapfb omapfb: failed to setup omapfb [ 1.621948] platform omapfb: Driver omapfb requests probe deferral [ 1.626739] uvesafb: failed to execute /sbin/v86d [ 1.626770] uvesafb: make sure that the v86d helper is installed and executable [ 1.626800] uvesafb: Getting VBE info block failed (eax=0x4f00, err=-2) [ 1.626800] uvesafb: vbe_init() failed with -22 [ 1.626861] uvesafb: probe of uvesafb.0 failed with error -22 [ 1.628295] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 1.638641] omap_uart serial.5: did not get pins for uart0 error: -19 [ 1.640258] serial.5: ttyO0 at MMIO 0x4806a000 (irq = 88) is a OMAP UART0 [ 1.643646] omap_uart serial.6: did not get pins for uart1 error: -19 [ 1.644378] serial.6: ttyO1 at MMIO 0x4806c000 (irq = 89) is a OMAP UART1 [ 1.647216] serial.7: ttyO2 at MMIO 0x49020000 (irq = 90) is a OMAP UART2 [ 2.504791] console [ttyO2] enabled [ 2.562103] brd: module loaded [ 2.593719] loop: module loaded [ 2.613403] twl 0-0048: PIH (irq 23) chaining IRQs 306..314 [ 2.620117] twl 0-0048: power (irq 311) chaining IRQs 314..321 [ 2.634368] VDD1: 600 <--> 1450 mV at 1200 mV [ 2.643798] VDAC: 1800 mV [ 2.651306] VPLL2: 1800 mV [ 2.657989] VMMC1: 1850 <--> 3150 mV at 3150 mV [ 2.667022] VMMC2: 1850 <--> 3150 mV at 2600 mV [ 2.675720] VUSB1V5: 1500 mV [ 2.682373] VUSB1V8: 1800 mV [ 2.689056] VUSB3V1: 3100 mV [ 2.695648] VSIM: 1800 <--> 3000 mV at 1800 mV [ 2.704772] twl4030_gpio gpio.38: gpio (irq 306) chaining IRQs 322..339 [ 2.721588] twl4030_usb twl4030-usb.39: Initialized TWL4030 USB module [ 2.744140] mtdoops: mtd device (mtddev=name/number) must be supplied [ 2.774627] usbcore: registered new interface driver asix [ 2.781951] usbcore: registered new interface driver ax88179_178a [ 2.789581] usbcore: registered new interface driver cdc_ether [ 2.796478] usbcore: registered new interface driver r815x [ 2.803466] usbcore: registered new interface driver smsc95xx [ 2.810638] usbcore: registered new interface driver net1080 [ 2.817321] usbcore: registered new interface driver cdc_subset [ 2.824523] usbcore: registered new interface driver zaurus [ 2.831481] usbcore: registered new interface driver cdc_ncm [ 2.840087] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 2.847015] ehci-omap: OMAP-EHCI Host Controller driver [ 2.853576] ehci-omap 48064800.ehci: Can't get PHY device for port 1: -517 [ 2.861053] platform 48064800.ehci: Driver ehci-omap requests probe deferral [ 2.870391] usbcore: registered new interface driver cdc_wdm [ 2.877166] usbcore: registered new interface driver usbtest [ 2.886657] HS USB OTG: no transceiver configured [ 2.891906] musb-hdrc musb-hdrc.0.auto: musb_init_controller failed with status -517 [ 2.900329] platform musb-hdrc.0.auto: Driver musb-hdrc requests probe deferral [ 2.913513] mousedev: PS/2 mouse device common for all mice [ 2.928741] twl_rtc rtc.27: Power up reset detected. [ 2.934631] twl_rtc rtc.27: Enabling TWL-RTC [ 2.945434] twl_rtc rtc.27: rtc core: registered rtc.27 as rtc0 [ 2.954559] i2c /dev entries driver [ 2.964172] Driver for 1-wire Dallas network protocol. [ 2.978027] omap_wdt: OMAP Watchdog Timer Rev 0x31: initial timeout 60 sec [ 3.000061] ledtrig-cpu: registered to indicate activity on CPUs [ 3.009094] usbcore: registered new interface driver usbhid [ 3.015014] usbhid: USB HID core driver [ 3.021972] oprofile: using arm/armv7 [ 3.026855] TCP: cubic registered [ 3.031158] Initializing XFRM netlink socket [ 3.035888] NET: Registered protocol family 17 [ 3.040802] NET: Registered protocol family 15 [ 3.046020] Key type dns_resolver registered [ 3.050720] VFP support v0.3: implementor 41 architecture 3 part 30 variant c rev 1 [ 3.061676] PM: no software I/O chain control; some wakeups may be lost [ 3.069519] ThumbEE CPU extension supported. [ 3.082122] VMMC1: disabling [ 3.085998] VPLL2: disabling [ 3.090118] VDAC: disabling [ 3.105041] hsusb2_vbus: 3300 mV [ 3.196868] before: [ 3.199340] dpll4_ck: 432000000 [ 3.202667] dpll4_m4_ck: 86400000 [ 3.206207] dpll4_m4x2_ck: 86400000 [ 3.209991] dss1_alwon_fck_3430es2: 86400000 [ 3.214508] setting rate 72000000 [ 3.218048] after: [ 3.220275] dpll4_ck: 432000000 [ 3.223602] dpll4_m4_ck: 72000000 [ 3.227142] dpll4_m4x2_ck: 144000000 [ 3.230987] dss1_alwon_fck_3430es2: 144000000 [ 3.235626] omapdss DPI: Could not find exact pixel clock. Requested 154012 kHz, got 144000 kHz [ 3.385040] ehci-omap 48064800.ehci: EHCI Host Controller [ 3.394989] ehci-omap 48064800.ehci: new USB bus registered, assigned bus number 1 [ 3.406158] ehci-omap 48064800.ehci: irq 93, io mem 0x48064800 [ 3.429199] ehci-omap 48064800.ehci: USB 2.0 started, EHCI 1.00 [ 3.436431] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 3.443786] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 3.451568] usb usb1: Product: EHCI Host Controller [ 3.456756] usb usb1: Manufacturer: Linux 3.11.0-rc7-00023-gf6a7f7c-dirty ehci_hcd [ 3.464843] usb usb1: SerialNumber: 48064800.ehci [ 3.477020] hub 1-0:1.0: USB hub found [ 3.481445] hub 1-0:1.0: 3 ports detected [ 3.489349] HS USB OTG: no transceiver configured [ 3.494384] musb-hdrc musb-hdrc.0.auto: musb_init_controller failed with status -517 [ 3.502777] platform musb-hdrc.0.auto: Driver musb-hdrc requests probe deferral [ 3.518096] input: gpio_keys.23 as /devices/gpio_keys.23/input/input0 [ 3.529876] HS USB OTG: no transceiver configured [ 3.534912] musb-hdrc musb-hdrc.0.auto: musb_init_controller failed with status -517 [ 3.543457] platform musb-hdrc.0.auto: Driver musb-hdrc requests probe deferral [ 3.554138] twl_rtc rtc.27: setting system clock to 2000-01-01 00:00:00 UTC (946684800) [ 3.636413] Freeing unused kernel memory: 400K (c07bc000 - c0820000) Starting logging: OK Initializing random number generator... done. Starting network... Welcome to Buildroot buildroot login:
Attachment:
signature.asc
Description: OpenPGP digital signature
