U-Boot 1.1.4 (Mar 18 2007 - 12:22:00) OMAP2430C-GP revision 3, PRCM #5A TI 2430SDP 1.1 Version + mDDR (Boot NOR) DRAM: 128 MB Flash: 192 MB NAND:64 MB In: serial Out: serial Err: serial Hit any key to stop autoboot: 3  2  1  0 Using MAC Address 08:00:28:01:16:8F BOOTP broadcast 1 DHCP client bound to address 192.168.57.132 TFTP from server 192.168.57.1; our IP address is 192.168.57.132 Filename 'uImage.2430sdp'. Load address: 0x80000000 Loading: *################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# #### done Bytes transferred = 4344232 (4249a8 hex) ## Booting image at 80000000 ... Image Name: Linux-3.9.0-rc4-00013-g53f0d4c9 Image Type: ARM Linux Kernel Image (uncompressed) Data Size: 4344168 Bytes = 4.1 MB Load Address: 80008000 Entry Point: 80008000 Verifying Checksum ... OK OK Starting kernel ... [ 0.000000] Booting Linux on physical CPU 0x0 [ 0.000000] Linux version 3.9.0-rc4-00013-g53f0d4c9 (paul@nozomi) (gcc version 4.5.1 (Sourcery G++ Lite 2010.09-50) ) #1 SMP Sat Mar 30 14:38:32 MDT 2013 [ 0.000000] CPU: ARMv6-compatible processor [4107b366] revision 6 (ARMv6TEJ), cr=00c5387d [ 0.000000] CPU: VIPT aliasing data cache, VIPT aliasing instruction cache [ 0.000000] Machine: OMAP2430 sdp2430 board [ 0.000000] cma: CMA: reserved 16 MiB at 86800000 [ 0.000000] Memory policy: ECC disabled, Data cache writeback [ 0.000000] CPU: All CPU(s) started in SVC mode. [ 0.000000] OMAP2430 [ 0.000000] [ 0.000000] Clocking rate (Crystal/DPLL/MPU): 13.0/532/266 MHz [ 0.000000] PERCPU: Embedded 9 pages/cpu @c0eb0000 s13632 r8192 d15040 u36864 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 32256 [ 0.000000] Kernel command line: console=ttyO0,115200n8 earlyprintk root=/dev/nfs nfsroot=192.168.57.1:/srv/nfs4/rootfs2 nfsrootdebug ip=dhcp init=/bin/sh [ 0.000000] PID hash table entries: 512 (order: -1, 2048 bytes) [ 0.000000] Dentry cache hash table entries: 16384 (order: 4, 65536 bytes) [ 0.000000] Inode-cache hash table entries: 8192 (order: 3, 32768 bytes) [ 0.000000] __ex_table already sorted, skipping sort [ 0.000000] Memory: 127MB = 127MB total [ 0.000000] Memory: 98452k/98452k available, 32620k 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 : 0xc8800000 - 0xff000000 ( 872 MB) [ 0.000000] lowmem : 0xc0000000 - 0xc8000000 ( 128 MB) [ 0.000000] pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB) [ 0.000000] modules : 0xbf000000 - 0xbfe00000 ( 14 MB) [ 0.000000] .text : 0xc0008000 - 0xc075f624 (7518 kB) [ 0.000000] .init : 0xc0760000 - 0xc07b5540 ( 342 kB) [ 0.000000] .data : 0xc07b6000 - 0xc08502e0 ( 617 kB) [ 0.000000] .bss : 0xc08502e0 - 0xc0dab548 (5485 kB) [ 0.000000] hw-breakpoint: CPUID feature registers not supported. Assuming v6 debug is present. [ 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 0xfa0fe000 (revision 3.0) with 96 interrupts [ 0.000000] Total of 96 interrupts on 1 active controller [ 0.000000] OMAP clockevent source: GPTIMER1 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.002716] Calibrating delay loop... 175.51 BogoMIPS (lpj=877568) [ 0.129638] pid_max: default: 32768 minimum: 301 [ 0.131011] Security Framework initialized [ 0.131439] Mount-cache hash table entries: 512 [ 0.142791] CPU: Testing write buffer coherency: ok [ 0.146728] CPU0: thread -1, cpu 0, socket -1, mpidr 4107b366 [ 0.146881] Setting up static identity map for 0xc055ad10 - 0xc055ad80 [ 0.154541] Brought up 1 CPUs [ 0.154602] SMP: Total of 1 processors activated (175.51 BogoMIPS). [ 0.154632] CPU: All CPU(s) started in SVC mode. [ 0.164459] devtmpfs: initialized [ 0.196838] omap_hwmod: usb_otg_hs: cannot be enabled for reset (3) [ 0.222778] pinctrl core: initialized pinctrl subsystem [ 0.240936] regulator-dummy: no parameters [ 0.251617] NET: Registered protocol family 16 [ 0.275573] DMA: preallocated 256 KiB pool for atomic coherent allocations [ 0.278625] omap-gpmc omap-gpmc: GPMC revision 3.0 [ 0.302490] omap_gpio omap_gpio.0: Could not get gpio dbck [ 0.308349] OMAP GPIO hardware version 2.4 [ 0.312042] omap_gpio omap_gpio.1: Could not get gpio dbck [ 0.319030] omap_gpio omap_gpio.2: Could not get gpio dbck [ 0.326110] omap_gpio omap_gpio.3: Could not get gpio dbck [ 0.332580] omap_gpio omap_gpio.4: Could not get gpio dbck [ 0.356384] omap_mux_init: Add partition: #1: core, flags: b [ 0.365478] omap_mux_get_by_name: Could not find signal sys_nirq [ 0.402252] hw-breakpoint: found 6 breakpoint and 1 watchpoint registers. [ 0.402313] hw-breakpoint: maximum watchpoint size is 4 bytes. [ 0.464660] OMAP DMA hardware revision 4.0 [ 0.467864] Serial: AMBA PL011 UART driver [ 0.685852] bio: create slab at 0 [ 0.960052] omap-dma-engine omap-dma-engine: OMAP DMA engine driver [ 0.983673] SCSI subsystem initialized [ 0.992523] usbcore: registered new interface driver usbfs [ 0.994110] usbcore: registered new interface driver hub [ 0.996246] usbcore: registered new device driver usb [ 1.011627] omap_i2c omap_i2c.1: bus 1 rev3.3 at 100 kHz [ 1.057861] twl 2-0048: PIH (irq 23) chaining IRQs 274..282 [ 1.059661] twl 2-0048: power (irq 279) chaining IRQs 282..289 [ 1.068572] twl4030_gpio twl4030_gpio: gpio (irq 274) chaining IRQs 290..307 [ 1.088134] VMMC1: 1850 <--> 3150 mV at 1850 mV normal standby [ 1.091278] omap_i2c omap_i2c.2: bus 2 rev3.3 at 100 kHz [ 1.117126] Switching to clocksource 32k_counter [ 1.511688] NET: Registered protocol family 2 [ 1.517517] TCP established hash table entries: 1024 (order: 1, 8192 bytes) [ 1.518066] TCP bind hash table entries: 1024 (order: 3, 36864 bytes) [ 1.519683] TCP: Hash tables configured (established 1024 bind 1024) [ 1.520324] TCP: reno registered [ 1.520446] UDP hash table entries: 256 (order: 2, 20480 bytes) [ 1.521240] UDP-Lite hash table entries: 256 (order: 2, 20480 bytes) [ 1.524078] NET: Registered protocol family 1 [ 1.528045] RPC: Registered named UNIX socket transport module. [ 1.528106] RPC: Registered udp transport module. [ 1.528167] RPC: Registered tcp transport module. [ 1.528198] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 1.531585] NetWinder Floating Point Emulator V0.97 (double precision) [ 1.532501] CPU PMU: probing PMU on CPU 0 [ 1.532592] hw perfevents: enabled with v6 PMU driver, 3 counters available [ 2.120513] VFS: Disk quotas dquot_6.5.2 [ 2.121307] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 2.129547] NFS: Registering the id_resolver key type [ 2.131011] Key type id_resolver registered [ 2.131103] Key type id_legacy registered [ 2.131530] jffs2: version 2.2. (NAND) (SUMMARY) © 2001-2006 Red Hat, Inc. [ 2.133636] msgmni has been set to 224 [ 2.144409] io scheduler noop registered [ 2.144470] io scheduler deadline registered [ 2.144775] io scheduler cfq registered (default) [ 2.156707] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.179931] omap_uart.0: ttyO0 at MMIO 0x4806a000 (irq = 88) is a OMAP UART0 [ 2.880767] console [ttyO0] enabled [ 2.891662] omap_uart.1: ttyO1 at MMIO 0x4806c000 (irq = 89) is a OMAP UART1 [ 2.904235] omap_uart.2: ttyO2 at MMIO 0x4806e000 (irq = 90) is a OMAP UART2 [ 2.924865] omap_rng omap_rng: OMAP Random Number Generator ver. 50 [ 3.031555] brd: module loaded [ 3.094909] loop: module loaded [ 3.114440] mtdoops: mtd device (mtddev=name/number) must be supplied [ 3.124267] OneNAND driver initializing [ 3.154418] smc91x.c: v1.1, sep 22 2004 by Nicolas Pitre [ 3.171752] eth0: SMC91C94 (rev 9) at c887a300 IRQ 263 [nowait] [ 3.178070] eth0: Ethernet addr: 08:00:28:01:16:8f [ 3.190429] usbcore: registered new interface driver asix [ 3.197662] usbcore: registered new interface driver ax88179_178a [ 3.205841] usbcore: registered new interface driver cdc_ether [ 3.213897] usbcore: registered new interface driver smsc95xx [ 3.221710] usbcore: registered new interface driver net1080 [ 3.229461] usbcore: registered new interface driver cdc_subset [ 3.237243] usbcore: registered new interface driver zaurus [ 3.245147] usbcore: registered new interface driver cdc_ncm [ 3.257629] usbcore: registered new interface driver cdc_wdm [ 3.263824] Initializing USB Mass Storage driver... [ 3.270751] usbcore: registered new interface driver usb-storage [ 3.277099] USB Mass Storage support registered. [ 3.283843] usbcore: registered new interface driver usbtest [ 3.296142] mousedev: PS/2 mouse device common for all mice [ 3.320373] input: twl4030_pwrbutton as /devices/platform/omap_i2c.2/i2c-2/2-004b/twl4030_pwrbutton/input/input0 [ 3.350433] twl_rtc twl_rtc: Power up reset detected. [ 3.356445] twl_rtc twl_rtc: Enabling TWL-RTC [ 3.376403] twl_rtc twl_rtc: rtc core: registered twl_rtc as rtc0 [ 3.387268] i2c /dev entries driver [ 3.401184] Driver for 1-wire Dallas network protocol. [ 3.420227] omap_wdt: OMAP Watchdog Timer Rev 0x22: initial timeout 60 sec [ 3.443145] omap-dma-engine omap-dma-engine: allocating channel for 62 [ 3.450622] omap-dma-engine omap-dma-engine: allocating channel for 61 [ 3.630706] ledtrig-cpu: registered to indicate activity on CPUs [ 3.646942] usbcore: registered new interface driver usbhid [ 3.653167] usbhid: USB HID core driver [ 3.662353] oprofile: using arm/armv6 [ 3.668395] TCP: cubic registered [ 3.672302] Initializing XFRM netlink socket [ 3.677307] NET: Registered protocol family 17 [ 3.682464] NET: Registered protocol family 15 [ 3.688446] Key type dns_resolver registered [ 3.693664] VFP support v0.3: implementor 41 architecture 1 part 20 variant b rev 2 [ 3.702087] mux: Failed to setup hwmod io irq -22 [ 3.724395] Power Management for OMAP2 initializing [ 3.729736] PRCM revision 1.0 [ 3.761291] twl_rtc twl_rtc: setting system clock to 2000-01-01 00:00:00 UTC (946684800) [ 3.777282] eth0: link up [ 3.792724] mmc0: host does not support reading read-only switch. assuming write-enable. [ 3.802154] Sending DHCP requests .[ 3.807647] mmc0: new SDHC card at address e624 ,[ 3.822967] mmcblk0: mmc0:e624 SD04G 3.69 GiB OK [ 3.842163] IP-Config: Got DHCP answer from 192.168.57.1, my address is 192.168.57.132 [ 3.851928] IP-Config: Complete: [ 3.855407] device=eth0, hwaddr=08:00:28:01:16:8f, ipaddr=192.168.57.132, mask=255.255.255.0, gw=255.255.255.255 [ 3.866790] host=192.168.57.132, domain=example.org, nis-domain=(none) [ 3.874267] bootserver=0.0.0.0, rootserver=192.168.57.1, rootpath= [ 3.881195] nameserver0=192.168.57.1[ 3.906311] mmcblk0: p1 [ 3.962860] [ 3.964477] ===================================== [ 3.969665] [ BUG: swapper/0/1 still has locks held! ] [ 3.975097] 3.9.0-rc4-00013-g53f0d4c9 #1 Not tainted [ 3.980438] ------------------------------------- [ 3.985412] 1 lock held by swapper/0/1: [ 3.989562] #0: (&type->s_umount_key#13/1){+.+.+.}, at: [] sget+0x248/0x574 [ 3.998138] [ 3.998138] stack backtrace: [ 4.002929] [] (unwind_backtrace+0x0/0xf0) from [] (rpc_wait_bit_killable+0x98/0xcc) [ 4.013061] [] (rpc_wait_bit_killable+0x98/0xcc) from [] (__wait_on_bit+0x74/0xb8) [ 4.023040] [] (__wait_on_bit+0x74/0xb8) from [] (out_of_line_wait_on_bit+0x6c/0x78) [ 4.033172] [] (out_of_line_wait_on_bit+0x6c/0x78) from [] (__rpc_execute+0xf0/0x360) [ 4.043365] [] (__rpc_execute+0xf0/0x360) from [] (rpc_run_task+0x98/0xa4) [ 4.052551] [] (rpc_run_task+0x98/0xa4) from [] (rpc_call_sync+0x48/0xb4) [ 4.061676] [] (rpc_call_sync+0x48/0xb4) from [] (nfs_proc_get_root+0x70/0x124) [ 4.071319] [] (nfs_proc_get_root+0x70/0x124) from [] (nfs_get_root+0x58/0x190) [ 4.080932] [] (nfs_get_root+0x58/0x190) from [] (nfs_fs_mount_common+0x98/0x158) [ 4.090789] [] (nfs_fs_mount_common+0x98/0x158) from [] (nfs_try_mount+0x144/0x214) [ 4.100799] [] (nfs_try_mount+0x144/0x214) from [] (nfs_fs_mount+0x178/0x850) [ 4.110260] [] (nfs_fs_mount+0x178/0x850) from [] (mount_fs+0x44/0x184) [ 4.119140] [] (mount_fs+0x44/0x184) from [] (vfs_kern_mount+0x4c/0xc0) [ 4.127990] [] (vfs_kern_mount+0x4c/0xc0) from [] (do_mount+0x6d0/0x858) [ 4.136993] [] (do_mount+0x6d0/0x858) from [] (sys_mount+0x84/0xb8) [ 4.145538] [] (sys_mount+0x84/0xb8) from [] (do_mount_root+0x24/0xb0) [ 4.154357] [] (do_mount_root+0x24/0xb0) from [] (mount_root+0x50/0xf8) [ 4.163269] [] (mount_root+0x50/0xf8) from [] (prepare_namespace+0x160/0x1c4) [ 4.172729] [] (prepare_namespace+0x160/0x1c4) from [] (kernel_init_freeable+0x17c/0x1c4) [ 4.183288] [] (kernel_init_freeable+0x17c/0x1c4) from [] (kernel_init+0x8/0xe4) [ 4.193023] [] (kernel_init+0x8/0xe4) from [] (ret_from_fork+0x14/0x24) [ 4.202270] VFS: Mounted root (nfs filesystem) on device 0:12. [ 4.210052] devtmpfs: mounted [ 4.214935] Freeing init memory: 340K /bin/sh: 0: can't access tty; job control turned off # # # %% Start PM dynamic idle test (retention only) %% Preparation # # mount -t sysfs none /sys mount -t debugfs none /debug # # # # # # echo -1 > /sys/devices/platform/omap_uart.0/power/autosuspend_delay_ms # # echo -1 > /sys/devices/platform/omap_uart.1/power/autosuspend_delay_ms # # echo -1 > /sys/devices/platform/omap_uart.2/power/autosuspend_delay_ms # # echo -1 > /sys/devices/platform/omap_uart.3/power/autosuspend_delay_ms /bin/sh: 17: cannot create /sys/devices/platform/omap_uart.3/power/autosuspend_delay_ms: Directory nonexistent # # echo 0 > /debug/pm_debug/enable_off_mode # # %% Baseline pm_debug count dump cat /debug/pm_debug/count mdm_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 core_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0 mpu_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dsp_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 gfx_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dss_clkdm->core_pwrdm (1) core_l4_clkdm->core_pwrdm (37) core_l3_clkdm->core_pwrdm (0) gfx_clkdm->gfx_pwrdm (0) dsp_clkdm->dsp_pwrdm (0) mdm_clkdm->mdm_pwrdm (0) mpu_clkdm->mpu_pwrdm (0) # # # # ./test_rootfs_access_nonexistent_file__ret_susp /bin/sh: 25: ./test_rootfs_access_nonexistent_file__ret_susp: not found # # %% End retention double suspend/resume UART wakeup test %% Start retention dynamic idle UART wakeup test echo 3000 > /sys/devices/platform/omap_uart.0/power/autosuspend_delay_ms # # echo 3000 > /sys/devices/platform/omap_uart.1/power/autosuspend_delay_ms # # echo 3000 > /sys/devices/platform/omap_uart.2/power/autosuspend_delay_ms # # echo 3000 > /sys/devices/platform/omap_uart.3/power/autosuspend_delay_ms /bin/sh: 33: cannot create /sys/devices/platform/omap_uart.3/power/autosuspend_delay_ms: Directory nonexistent # # # # # # cat /debug/pm_debug/count mdm_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 core_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0 mpu_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dsp_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 gfx_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dss_clkdm->core_pwrdm (1) core_l4_clkdm->core_pwrdm (35) core_l3_clkdm->core_pwrdm (0) gfx_clkdm->gfx_pwrdm (0) dsp_clkdm->dsp_pwrdm (0) mdm_clkdm->mdm_pwrdm (0) mpu_clkdm->mpu_pwrdm (0) # # # # ./test_rootfs_access_nonexistent_file__ret_dyn /bin/sh: 43: ./test_rootfs_access_nonexistent_file__ret_dyn: not found # # echo -1 > /sys/devices/platform/omap_uart.0/power/autosuspend_delay_ms # # echo -1 > /sys/devices/platform/omap_uart.1/power/autosuspend_delay_ms # # echo -1 > /sys/devices/platform/omap_uart.2/power/autosuspend_delay_ms # # echo -1 > /sys/devices/platform/omap_uart.3/power/autosuspend_delay_ms /bin/sh: 51: cannot create /sys/devices/platform/omap_uart.3/power/autosuspend_delay_ms: Directory nonexistent # # %% End retention dynamic idle UART wakeup test %% End PM dynamic idle test (retention only)