Texas Instruments X-Loader 1.47 (Jan 14 2011 - 15:43:28) Starting X-loader on MMC Reading boot sector 212836 Bytes Read from MMC Starting OS Bootloader from MMC... Starting OS Bootloader... U-Boot 2010.06 (Jan 14 2011 - 15:43:45) OMAP34xx/35xx-GP ES2.1, CPU-OPP2 L3-165MHz OMAP3 EVM board + LPDDR/NAND I2C: ready DRAM: 256 MiB NAND: 512 MiB In: serial Out: serial Err: serial Read back SMSC id 0x92200000 Die ID #368000229ff80000016071640902c013 Net: smc911x-0 Hit any key to stop autoboot: 3  2  1  0 smc911x: detected LAN9220 controller smc911x: phy initialized smc911x: MAC 00:50:c2:7e:99:42 BOOTP broadcast 1 DHCP client bound to address 192.168.57.131 Using smc911x-0 device TFTP from server 192.168.57.1; our IP address is 192.168.57.131 Filename 'uImage.37xevm'. Load address: 0x82000000 Loading: *################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ############################### done Bytes transferred = 4149600 (3f5160 hex) ## Booting kernel from Legacy Image at 82000000 ... Image Name: Linux-3.7.0-rc4-00754-g3d70f8c Image Type: ARM Linux Kernel Image (uncompressed) Data Size: 4149536 Bytes = 4 MiB Load Address: 80008000 Entry Point: 80008000 Verifying Checksum ... OK Loading Kernel Image ... OK OK Starting kernel ... Uncompressing Linux... done, booting the kernel. [ 0.000000] Booting Linux on physical CPU 0 [ 0.000000] Linux version 3.7.0-rc4-00754-g3d70f8c (paul@nozomi) (gcc version 4.5.1 (Sourcery G++ Lite 2010.09-50) ) #1 SMP Sun Nov 4 14:31:34 MST 2012 [ 0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c53c7d [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache [ 0.000000] Machine: OMAP3 EVM [ 0.000000] Memory policy: ECC disabled, Data cache writeback [ 0.000000] OMAP3630 ES1.2 (l2cache iva sgx neon isp 192mhz_clk ) [ 0.000000] Clocking rate (Crystal/Core/MPU): 26.0/400/600 MHz [ 0.000000] PERCPU: Embedded 9 pages/cpu @c0f42000 s12928 r8192 d15744 u36864 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64768 [ 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: 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: 255MB = 255MB total [ 0.000000] Memory: 245256k/245256k available, 16888k 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 - 0xc0703830 (7151 kB) [ 0.000000] .init : 0xc0704000 - 0xc0754280 ( 321 kB) [ 0.000000] .data : 0xc0756000 - 0xc07e15e0 ( 558 kB) [ 0.000000] .bss : 0xc07e1604 - 0xc0d3bfac (5483 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] 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.000915] Calibrating delay loop... 397.57 BogoMIPS (lpj=1554432) [ 0.109374] pid_max: default: 32768 minimum: 301 [ 0.109985] Security Framework initialized [ 0.110168] Mount-cache hash table entries: 512 [ 0.114837] CPU: Testing write buffer coherency: ok [ 0.115692] CPU0: thread -1, cpu 0, socket -1, mpidr 0 [ 0.115783] Setting up static identity map for 0x8051ef18 - 0x8051ef88 [ 0.118560] Brought up 1 CPUs [ 0.118591] SMP: Total of 1 processors activated (397.57 BogoMIPS). [ 0.136962] pinctrl core: initialized pinctrl subsystem [ 0.143493] regulator-dummy: no parameters [ 0.145660] NET: Registered protocol family 16 [ 0.146423] DMA: preallocated 256 KiB pool for atomic coherent allocations [ 0.148345] omap-gpmc omap-gpmc: GPMC revision 5.0 [ 0.161437] OMAP GPIO hardware version 2.5 [ 0.182159] omap_mux_init: Add partition: #1: core, flags: 0 [ 0.198028] _omap_mux_get_by_name: Could not find signal uart4_rx.uart4_rx [ 0.206665] Reprogramming SDRC clock to 400000000 Hz [ 0.206695] dpll3_m2_clk rate change failed: -22 [ 0.207824] Found NAND on CS0 [ 0.207824] Registering NAND on CS0 [ 0.209899] hw-breakpoint: debug architecture 0x4 unsupported. [ 0.225921] omap-mcbsp.2: alias fck already exists [ 0.227142] omap-mcbsp.3: alias fck already exists [ 0.231140] OMAP DMA hardware revision 5.0 [ 0.236419] arm-pmu: alias fck already exists [ 0.307067] bio: create slab at 0 [ 0.405303] omap-dma-engine omap-dma-engine: OMAP DMA engine driver [ 0.407592] fixed-dummy: no parameters [ 0.413635] SCSI subsystem initialized [ 0.416839] usbcore: registered new interface driver usbfs [ 0.417419] usbcore: registered new interface driver hub [ 0.418304] usbcore: registered new device driver usb [ 0.434753] twl 1-0048: PIH (irq 23) chaining IRQs 338..346 [ 0.435455] twl 1-0048: power (irq 343) chaining IRQs 346..353 [ 0.439178] twl4030_gpio twl4030_gpio: gpio (irq 338) chaining IRQs 354..371 [ 0.452545] VIO: 1800 mV normal standby [ 0.455535] vdd_mpu_iva: 600 <--> 1450 mV normal [ 0.457977] vdd_core: 600 <--> 1450 mV normal [ 0.460571] VMMC1: 1850 <--> 3150 mV at 3000 mV normal standby [ 0.464263] VDAC: 1800 mV normal standby [ 0.467498] VAUX2_4030: 2800 mV normal standby [ 0.471069] VPLL2: 1800 mV normal standby [ 0.473937] VSIM: 1800 <--> 3000 mV at 1800 mV normal standby [ 0.474914] omap_i2c omap_i2c.1: bus 1 rev1.4.0 at 2600 kHz [ 0.476440] omap_i2c omap_i2c.2: bus 2 rev1.4.0 at 400 kHz [ 0.493865] omap_i2c omap_i2c.3: bus 3 rev1.4.0 at 400 kHz [ 0.502105] Switching to clocksource 32k_counter [ 0.641113] NET: Registered protocol family 2 [ 0.643432] TCP established hash table entries: 8192 (order: 4, 65536 bytes) [ 0.643890] TCP bind hash table entries: 8192 (order: 6, 294912 bytes) [ 0.648406] TCP: Hash tables configured (established 8192 bind 8192) [ 0.648651] TCP: reno registered [ 0.648681] UDP hash table entries: 256 (order: 2, 20480 bytes) [ 0.649017] UDP-Lite hash table entries: 256 (order: 2, 20480 bytes) [ 0.649993] NET: Registered protocol family 1 [ 0.651824] RPC: Registered named UNIX socket transport module. [ 0.651855] RPC: Registered udp transport module. [ 0.651855] RPC: Registered tcp transport module. [ 0.651885] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.653015] NetWinder Floating Point Emulator V0.97 (double precision) [ 0.653381] CPU PMU: probing PMU on CPU 0 [ 0.653564] hw perfevents: enabled with ARMv7 Cortex-A8 PMU driver, 5 counters available [ 0.836273] VFS: Disk quotas dquot_6.5.2 [ 0.836578] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 0.839843] NFS: Registering the id_resolver key type [ 0.840393] Key type id_resolver registered [ 0.840423] Key type id_legacy registered [ 0.840576] jffs2: version 2.2. (NAND) (SUMMARY) © 2001-2006 Red Hat, Inc. [ 0.841247] msgmni has been set to 479 [ 0.845062] io scheduler noop registered [ 0.845092] io scheduler deadline registered [ 0.845184] io scheduler cfq registered (default) [ 0.848754] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 0.856384] omap_uart.0: ttyO0 at MMIO 0x4806a000 (irq = 88) is a OMAP UART0 [ 1.548797] console [ttyO0] enabled [ 1.554718] omap_uart.1: ttyO1 at MMIO 0x4806c000 (irq = 89) is a OMAP UART1 [ 1.564086] omap_uart.2: ttyO2 at MMIO 0x49020000 (irq = 90) is a OMAP UART2 [ 1.573303] omap_uart.3: ttyO3 at MMIO 0x49042000 (irq = 96) is a OMAP UART3 [ 1.618072] brd: module loaded [ 1.642822] loop: module loaded [ 1.654724] mtdoops: mtd device (mtddev=name/number) must be supplied [ 1.662506] NAND device: Manufacturer ID: 0xad, Chip ID: 0xbc (Hynix NAND 512MiB 1,8V 16-bit), page size: 2048, OOB size: 64 [ 1.674499] Creating 5 MTD partitions on "omap2-nand.0": [ 1.680114] 0x000000000000-0x000000080000 : "X-Loader" [ 1.693145] 0x000000080000-0x000000240000 : "U-Boot" [ 1.704620] 0x000000240000-0x000000280000 : "U-Boot Env" [ 1.715576] 0x000000280000-0x000000780000 : "Kernel" [ 1.730407] 0x000000780000-0x000020000000 : "File system" [ 2.181854] OneNAND driver initializing [ 2.189086] omap-dma-engine omap-dma-engine: allocating channel for 36 [ 2.196136] omap-dma-engine omap-dma-engine: allocating channel for 35 [ 2.213714] smsc911x: Driver version 2008-10-21 [ 2.227020] libphy: smsc911x-mdio: probed [ 2.231597] smsc911x smsc911x.0 eth0: attached PHY driver [SMSC LAN8700] (mii_bus:phy_addr=smsc911x-0:01, irq=-1) [ 2.242767] smsc911x smsc911x.0 eth0: MAC Address: 00:50:c2:7e:99:42 [ 2.250823] usbcore: registered new interface driver asix [ 2.257171] usbcore: registered new interface driver cdc_ether [ 2.264007] usbcore: registered new interface driver smsc95xx [ 2.270660] usbcore: registered new interface driver net1080 [ 2.277221] usbcore: registered new interface driver cdc_subset [ 2.284057] usbcore: registered new interface driver zaurus [ 2.290557] usbcore: registered new interface driver cdc_ncm [ 2.298858] usbcore: registered new interface driver cdc_wdm [ 2.304901] Initializing USB Mass Storage driver... [ 2.310760] usbcore: registered new interface driver usb-storage [ 2.317138] USB Mass Storage support registered. [ 2.322631] usbcore: registered new interface driver usbtest [ 2.330566] mousedev: PS/2 mouse device common for all mice [ 2.339233] input: TWL4030 Keypad as /devices/platform/omap_i2c.1/i2c-1/1-004a/twl4030_keypad/input/input0 [ 2.357666] ads7846 spi1.0: touchscreen, irq 289 [ 2.365417] input: ADS7846 Touchscreen as /devices/platform/omap2_mcspi.1/spi_master/spi1/spi1.0/input/input1 [ 2.382202] input: twl4030_pwrbutton as /devices/platform/omap_i2c.1/i2c-1/1-0049/twl4030_pwrbutton/input/input2 [ 2.395355] twl_rtc twl_rtc: Power up reset detected. [ 2.400878] twl_rtc twl_rtc: Enabling TWL-RTC [ 2.410644] twl_rtc twl_rtc: rtc core: registered twl_rtc as rtc0 [ 2.418823] i2c /dev entries driver [ 2.426635] Driver for 1-wire Dallas network protocol. [ 2.435821] omap_wdt: OMAP Watchdog Timer Rev 0x31: initial timeout 60 sec [ 2.444549] twl4030_wdt twl4030_wdt: Failed to register misc device [ 2.451354] twl4030_wdt: probe of twl4030_wdt failed with error -16 [ 2.462066] omap_hsmmc omap_hsmmc.0: Failed to get debounce clk [ 2.468627] omap-dma-engine omap-dma-engine: allocating channel for 62 [ 2.475616] omap-dma-engine omap-dma-engine: allocating channel for 61 [ 2.862518] usbcore: registered new interface driver usbhid [ 2.868438] usbhid: USB HID core driver [ 2.874389] oprofile: using arm/armv7 [ 2.879180] TCP: cubic registered [ 2.882690] Initializing XFRM netlink socket [ 2.887390] NET: Registered protocol family 17 [ 2.892211] NET: Registered protocol family 15 [ 2.897369] Key type dns_resolver registered [ 2.902069] VFP support v0.3: implementor 41 architecture 3 part 30 variant c rev 3 [ 2.921539] ThumbEE CPU extension supported. [ 2.986450] clock: disabling unused clocks to save power [ 3.006072] twl_rtc twl_rtc: setting system clock to 2000-01-01 00:00:00 UTC (946684800) [ 3.020660] smsc911x smsc911x.0 eth0: SMSC911x/921x identified at 0xd085a000, IRQ: 290 [ 3.049957] Sending DHCP requests .[ 3.180480] mmc0: new SDHC card at address e624 [ 3.188476] mmcblk0: mmc0:e624 SD08G 7.40 GiB [ 3.209716] mmcblk0: p1 p2 p3 .., OK [ 8.761199] IP-Config: Got DHCP answer from 0.0.0.0, my address is 192.168.57.131 [ 8.769653] IP-Config: Complete: [ 8.773071] device=eth0, addr=192.168.57.131, mask=255.255.255.0, gw=255.255.255.255 [ 8.781768] host=192.168.57.131, domain=example.org, nis-domain=(none) [ 8.789184] bootserver=0.0.0.0, rootserver=192.168.57.1, rootpath= [ 8.795989] nameserver0=192.168.57.1[ 8.823272] VFS: Mounted root (nfs filesystem) on device 0:11. [ 8.830017] Freeing init memory: 320K /bin/sh: 0: can't access tty; job control turned off # %% Start PM consolidated quick test %% 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 # # echo 0 > /debug/pm_debug/enable_off_mode # # %% Baseline pm_debug count dump cat /debug/pm_debug/count usbhost_pwrdm (ON),OFF:0,RET:955,INA:0,ON:956,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 sgx_pwrdm (OFF),OFF:1,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 per_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dss_pwrdm (ON),OFF:0,RET:955,INA:0,ON:956,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cam_pwrdm (RET),OFF:0,RET:1,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 neon_pwrdm (ON),OFF:0,RET:955,INA:0,ON:956,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:0,RET:955,INA:0,ON:956,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 iva2_pwrdm (RET),OFF:0,RET:1,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0,RET-MEMBANK4-OFF:0 usbhost_clkdm->usbhost_pwrdm (1) sgx_clkdm->sgx_pwrdm (0) per_clkdm->per_pwrdm (20) cam_clkdm->cam_pwrdm (0) dss_clkdm->dss_pwrdm (1) d2d_clkdm->core_pwrdm (0) iva2_clkdm->iva2_pwrdm (0) mpu_clkdm->mpu_pwrdm (0) core_l4_clkdm->core_pwrdm (24) core_l3_clkdm->core_pwrdm (4) neon_clkdm->neon_pwrdm (0) # # echo enabled > /sys/devices/platform/omap_uart.2/tty/ttyO2/power/wakeup # %% Start retention double suspend/resume UART wakeup test # echo mem > /sys/power/state [ 19.172821] PM: Syncing filesystems ... done. [ 19.188964] Freezing user space processes ... (elapsed 0.00 seconds) done. [ 19.196624] Freezing remaining freezable tasks ... (elapsed 0.02 seconds) done. [ 19.224731] Suspending console(s) (use no_console_suspend to debug) [ 19.361694] PM: suspend of devices complete after 125.152 msecs [ 19.365966] PM: late suspend of devices complete after 4.272 msecs [ 19.372070] PM: noirq suspend of devices complete after 6.042 msecs [ 19.372131] Disabling non-boot CPUs ... [ 22.960418] Successfully put all powerdomains to target state [ 22.963897] PM: noirq resume of devices complete after 3.265 msecs [ 22.967864] PM: early resume of devices complete after 2.838 msecs [ 22.973602] [sched_delayed] sched: RT throttling activated [ 23.966033] omap_i2c omap_i2c.1: controller timed out [ 23.981781] twl: i2c_write failed to transfer all messages [ 23.981811] twl4030: twl4030_sih_bus_sync_unlock, write --> -110 [ 24.981597] omap_i2c omap_i2c.1: controller timed out [ 24.997283] twl: i2c_read failed to transfer all messages [ 24.997314] omap_hsmmc omap_hsmmc.0: could not set regulator OCR (-110) [ 25.158599] mmc0: error -110 during resume (card was removed?) [ 25.597229] PM: resume of devices complete after 2629.211 msecs [ 25.700500] Restarting tasks ... done. # # [ 25.708618] mmc0: card e624 removed [ 25.735076] ------------[ cut here ]------------ [ 25.740173] WARNING: at drivers/regulator/core.c:1591 _regulator_disable+0x1c8/0x26c() [ 25.748565] unbalanced disables for VSIM [ 25.752685] Modules linked in: [ 25.756011] [] (unwind_backtrace+0x0/0xf0) from [] (warn_slowpath_common+0x4c/0x64) [ 25.766021] [] (warn_slowpath_common+0x4c/0x64) from [] (warn_slowpath_fmt+0x30/0x40) [ 25.776153] [] (warn_slowpath_fmt+0x30/0x40) from [] (_regulator_disable+0x1c8/0x26c) [ 25.786285] [] (_regulator_disable+0x1c8/0x26c) from [] (regulator_disable+0x34/0x60) [ 25.796417] [] (regulator_disable+0x34/0x60) from [] (omap_hsmmc_set_power+0x94/0x11c) [ 25.806640] [] (omap_hsmmc_set_power+0x94/0x11c) from [] (omap_hsmmc_set_ios+0x60/0x30c) [ 25.817047] [] (omap_hsmmc_set_ios+0x60/0x30c) from [] (mmc_power_off+0x70/0x90) [ 25.826721] [] (mmc_power_off+0x70/0x90) from [] (mmc_sd_detect+0x60/0x74) [ 25.835845] [] (mmc_sd_detect+0x60/0x74) from [] (mmc_rescan+0x174/0x4a8) [ 25.844848] [] (mmc_rescan+0x174/0x4a8) from [] (process_one_work+0x1a8/0x560) [ 25.854339] [] (process_one_work+0x1a8/0x560) from [] (worker_thread+0x170/0x4c0) [ 25.864105] [] (worker_thread+0x170/0x4c0) from [] (kthread+0xb0/0xbc) [ 25.872863] [] (kthread+0xb0/0xbc) from [] (ret_from_fork+0x14/0x24) [ 25.881439] ---[ end trace ebb3ac888ad8e6e7 ]--- # # cat /debug/pm_debug/count [ 26.331573] mmc0: new SDHC card at address e624 [ 26.338226] mmcblk0: mmc0:e624 SD08G 7.40 GiB [ 26.357177] mmcblk0: p1 p2 p3 usbhost_pwrdm (ON),OFF:0,RET:1118,INA:0,ON:1119,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 sgx_pwrdm (OFF),OFF:1,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 core_pwrdm (ON),OFF:0,RET:1,INA:0,ON:2,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 per_pwrdm (ON),OFF:0,RET:1,INA:0,ON:2,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dss_pwrdm (ON),OFF:0,RET:1118,INA:0,ON:1119,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cam_pwrdm (RET),OFF:0,RET:1,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 neon_pwrdm (ON),OFF:0,RET:1118,INA:0,ON:1119,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:0,RET:1118,INA:0,ON:1119,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 iva2_pwrdm (RET),OFF:0,RET:1,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0,RET-MEMBANK4-OFF:0 usbhost_clkdm->usbhost_pwrdm (1) sgx_clkdm->sgx_pwrdm (0) per_clkdm->per_pwrdm (20) cam_clkdm->cam_pwrdm (0) dss_clkdm->dss_pwrdm (1) d2d_clkdm->core_pwrdm (0) iva2_clkdm->iva2_pwrdm (0) mpu_clkdm->mpu_pwrdm (0) core_l4_clkdm->core_pwrdm (24) core_l3_clkdm->core_pwrdm (4) neon_clkdm->neon_pwrdm (0) # # # # echo mem > /sys/power/state [ 28.272918] PM: Syncing filesystems ... done. [ 28.280364] Freezing user space processes ... (elapsed 0.00 seconds) done. [ 28.287902] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. [ 28.312774] Suspending console(s) (use no_console_suspend to debug) [ 28.449218] PM: suspend of devices complete after 124.694 msecs [ 28.453399] PM: late suspend of devices complete after 4.150 msecs [ 28.459075] PM: noirq suspend of devices complete after 5.676 msecs [ 28.459106] Disabling non-boot CPUs ... [ 31.960571] Successfully put all powerdomains to target state [ 31.963989] PM: noirq resume of devices complete after 3.234 msecs [ 31.967956] PM: early resume of devices complete after 2.838 msecs [ 32.967376] omap_i2c omap_i2c.1: controller timed out [ 32.983032] twl: i2c_write failed to transfer all messages [ 32.983032] twl4030: twl4030_sih_bus_sync_unlock, write --> -110 [ 33.983184] omap_i2c omap_i2c.1: controller timed out [ 33.998657] twl: i2c_read failed to transfer all messages [ 33.998687] omap_hsmmc omap_hsmmc.0: could not set regulator OCR (-110) [ 34.159973] mmc0: error -110 during resume (card was removed?) [ 34.165557] PM: resume of devices complete after 2197.479 msecs [ 34.262603] Restarting tasks ... done. # # [ 34.269836] mmc0: card e624 removed [ 34.281188] ------------[ cut here ]------------ [ 34.286071] WARNING: at drivers/regulator/core.c:1591 _regulator_disable+0x1c8/0x26c() [ 34.294525] unbalanced disables for VSIM [ 34.298706] Modules linked in: [ 34.301971] [] (unwind_backtrace+0x0/0xf0) from [] (warn_slowpath_common+0x4c/0x64) [ 34.311920] [] (warn_slowpath_common+0x4c/0x64) from [] (warn_slowpath_fmt+0x30/0x40) [ 34.322052] [] (warn_slowpath_fmt+0x30/0x40) from [] (_regulator_disable+0x1c8/0x26c) [ 34.332183] [] (_regulator_disable+0x1c8/0x26c) from [] (regulator_disable+0x34/0x60) [ 34.342346] [] (regulator_disable+0x34/0x60) from [] (omap_hsmmc_set_power+0x94/0x11c) [ 34.352569] [] (omap_hsmmc_set_power+0x94/0x11c) from [] (omap_hsmmc_set_ios+0x60/0x30c) [ 34.362976] [] (omap_hsmmc_set_ios+0x60/0x30c) from [] (mmc_power_off+0x70/0x90) [ 34.372650] [] (mmc_power_off+0x70/0x90) from [] (mmc_sd_detect+0x60/0x74) [ 34.381774] [] (mmc_sd_detect+0x60/0x74) from [] (mmc_rescan+0x174/0x4a8) [ 34.390808] [] (mmc_rescan+0x174/0x4a8) from [] (process_one_work+0x1a8/0x560) [ 34.400299] [] (process_one_work+0x1a8/0x560) from [] (worker_thread+0x170/0x4c0) [ 34.410064] [] (worker_thread+0x170/0x4c0) from [] (kthread+0xb0/0xbc) [ 34.418823] [] (kthread+0xb0/0xbc) from [] (ret_from_fork+0x14/0x24) [ 34.427398] ---[ end trace ebb3ac888ad8e6e8 ]--- # # cat /debug/pm_debug/count [ 34.879760] mmc0: new SDHC card at address e624 [ 34.886413] mmcblk0: mmc0:e624 SD08G 7.40 GiB [ 34.904998] mmcblk0: p1 p2 p3 usbhost_pwrdm (ON),OFF:0,RET:1278,INA:0,ON:1279,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 sgx_pwrdm (OFF),OFF:1,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 core_pwrdm (ON),OFF:0,RET:2,INA:0,ON:3,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 per_pwrdm (ON),OFF:0,RET:2,INA:0,ON:3,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dss_pwrdm (ON),OFF:0,RET:1278,INA:0,ON:1279,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cam_pwrdm (RET),OFF:0,RET:1,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 neon_pwrdm (ON),OFF:0,RET:1278,INA:0,ON:1279,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:0,RET:1278,INA:0,ON:1279,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 iva2_pwrdm (RET),OFF:0,RET:1,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0,RET-MEMBANK4-OFF:0 usbhost_clkdm->usbhost_pwrdm (1) sgx_clkdm->sgx_pwrdm (0) per_clkdm->per_pwrdm (20) cam_clkdm->cam_pwrdm (0) dss_clkdm->dss_pwrdm (1) d2d_clkdm->core_pwrdm (0) iva2_clkdm->iva2_pwrdm (0) mpu_clkdm->mpu_pwrdm (0) core_l4_clkdm->core_pwrdm (24) core_l3_clkdm->core_pwrdm (4) neon_clkdm->neon_pwrdm (0) # # # # ./test_rootfs_access_nonexistent_file__ret_susp /bin/sh: 39: ./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 # # # # cat /debug/pm_debug/count usbhost_pwrdm (ON),OFF:0,RET:1413,INA:0,ON:1414,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 sgx_pwrdm (OFF),OFF:1,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 core_pwrdm (ON),OFF:0,RET:7,INA:0,ON:8,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 per_pwrdm (ON),OFF:0,RET:27,INA:0,ON:28,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dss_pwrdm (ON),OFF:0,RET:1413,INA:0,ON:1414,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cam_pwrdm (RET),OFF:0,RET:1,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 neon_pwrdm (ON),OFF:0,RET:1413,INA:0,ON:1414,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:0,RET:1413,INA:0,ON:1414,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 iva2_pwrdm (RET),OFF:0,RET:1,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0,RET-MEMBANK4-OFF:0 usbhost_clkdm->usbhost_pwrdm (1) sgx_clkdm->sgx_pwrdm (0) per_clkdm->per_pwrdm (17) cam_clkdm->cam_pwrdm (0) dss_clkdm->dss_pwrdm (1) d2d_clkdm->core_pwrdm (0) iva2_clkdm->iva2_pwrdm (0) mpu_clkdm->mpu_pwrdm (0) core_l4_clkdm->core_pwrdm (23) core_l3_clkdm->core_pwrdm (4) neon_clkdm->neon_pwrdm (0) # # # # ./test_rootfs_access_nonexistent_file__ret_dyn /bin/sh: 55: ./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 # # %% End retention dynamic idle UART wakeup test %% Start off-mode double suspend UART wakeup test echo 1 > /debug/pm_debug/enable_off_mode # # echo mem > /sys/power/state [ 56.964050] PM: Syncing filesystems ... done. [ 56.971801] Freezing user space processes ... (elapsed 0.00 seconds) done. [ 56.979339] Freezing remaining freezable tasks ... (elapsed 0.02 seconds) done. [ 57.009857] Suspending console(s) (use no_console_suspend to debug) [ 57.145874] PM: suspend of devices complete after 124.267 msecs [ 57.150024] PM: late suspend of devices complete after 4.150 msecs [ 57.155731] PM: noirq suspend of devices complete after 5.645 msecs [ 57.155731] Disabling non-boot CPUs ... [ 60.962005] Successfully put all powerdomains to target state [ 60.965728] PM: noirq resume of devices complete after 3.417 msecs [ 60.969665] PM: early resume of devices complete after 2.838 msecs [ 61.969116] omap_i2c omap_i2c.1: controller timed out [ 61.984588] twl: i2c_write failed to transfer all messages [ 61.984588] twl4030: twl4030_sih_bus_sync_unlock, write --> -110 [ 62.984466] omap_i2c omap_i2c.1: controller timed out [ 63.000152] twl: i2c_read failed to transfer all messages [ 63.000152] omap_hsmmc omap_hsmmc.0: could not set regulator OCR (-110) [ 63.161499] mmc0: error -110 during resume (card was removed?) [ 64.156616] omap_i2c omap_i2c.1: controller timed out [ 64.172119] twl: i2c_write failed to transfer all messages [ 64.172119] twl_rtc: Could not write TWLregister F - error -110 [ 64.899719] PM: resume of devices complete after 3929.962 msecs [ 65.013702] Restarting tasks ... done. # # [ 65.021423] mmc0: card e624 removed # # cat /debug/pm_debug/count usbhost_pwrdm (ON),OFF:26,RET:1527,INA:0,ON:1554[ 66.192138] ------------[ cut here ]------------ ,RET-LOGIC-OFF:0[ 66.197174] WARNING: at drivers/regulator/core.c:1591 _regulator_disable+0x1c8/0x26c() ,RET-MEMBANK1-OF[ 66.206756] unbalanced disables for VSIM F:0 sgx_pwrdm ([ 66.212341] Modules linked in:OFF),OFF:1,RET:0 ,INA:0,ON:1,RET-[ 66.218383] [] (unwind_backtrace+0x0/0xf0) from [] (warn_slowpath_common+0x4c/0x64) LOGIC-OFF:0,RET-[ 66.229705] [] (warn_slowpath_common+0x4c/0x64) from [] (warn_slowpath_fmt+0x30/0x40) MEMBANK1-OFF:0 [ 66.241180] [] (warn_slowpath_fmt+0x30/0x40) from [] (_regulator_disable+0x1c8/0x26c) core_pwrdm (ON),[ 66.252685] [] (_regulator_disable+0x1c8/0x26c) from [] (regulator_disable+0x34/0x60) OFF:1,RET:7,INA:[ 66.264160] [] (regulator_disable+0x34/0x60) from [] (omap_hsmmc_set_power+0x94/0x11c) 0,ON:9,RET-LOGIC[ 66.275756] [] (omap_hsmmc_set_power+0x94/0x11c) from [] (omap_hsmmc_set_ios+0x60/0x30c) -OFF:0,RET-MEMBA[ 66.287506] [] (omap_hsmmc_set_ios+0x60/0x30c) from [] (mmc_power_off+0x70/0x90) NK1-OFF:0,RET-ME[ 66.298553] [] (mmc_power_off+0x70/0x90) from [] (mmc_sd_detect+0x60/0x74) MBANK2-OFF:0 pe[ 66.309020] [] (mmc_sd_detect+0x60/0x74) from [] (mmc_rescan+0x174/0x4a8) r_pwrdm (ON),OFF[ 66.319366] [] (mmc_rescan+0x174/0x4a8) from [] (process_one_work+0x1a8/0x560) :1,RET:129,INA:0[ 66.330169] [] (process_one_work+0x1a8/0x560) from [] (worker_thread+0x170/0x4c0) ,ON:131,RET-LOGI[ 66.341247] [] (worker_thread+0x170/0x4c0) from [] (kthread+0xb0/0xbc) C-OFF:0,RET-MEMB[ 66.351348] [] (kthread+0xb0/0xbc) from [] (ret_from_fork+0x14/0x24) ANK1-OFF:0 dss_[ 66.361206] ---[ end trace ebb3ac888ad8e6e9 ]--- pwrdm (ON),OFF:26,RET:1527,INA:0,ON:1554,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cam_pwrdm (OFF),OFF:1,RET:1,INA:0,ON:2,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 neon_pwrdm (ON),OFF:26,RET:1527,INA:0,ON:1554,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:26,RET:1527,INA:0,ON:1554,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 iva2_pwrdm (OFF),OFF:1,RET:1,INA:0,ON:2,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0,RET-MEMBANK4-OFF:0 usbhost_clkdm->usbhost_pwrdm (1) sgx_clkdm->sgx_pwrdm (0) per_clkdm->per_pwrdm (20) cam_clkdm->cam_pwrdm (0) dss_clkdm->dss_pwrdm (1) d2d_clkdm->core_pwrdm (0) iva2_clkdm->iva2_pwrdm (0) mpu_clkdm->mpu_pwrdm (0) core_l4_clkdm->core_pwrdm (24) core_l3_clkdm->core_pwrdm (4) neon_clkdm->neon_pwrdm (0) # # [ 66.829650] mmc0: new SDHC card at address e624 [ 66.836364] mmcblk0: mmc0:e624 SD08G 7.40 GiB [ 66.855010] mmcblk0: p1 p2 p3 # # echo mem > /sys/power/state [ 67.165649] PM: Syncing filesystems ... done. [ 67.173431] Freezing user space processes ... (elapsed 0.00 seconds) done. [ 67.180969] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. [ 67.206634] Suspending console(s) (use no_console_suspend to debug) [ 67.342773] PM: suspend of devices complete after 124.359 msecs [ 67.346954] PM: late suspend of devices complete after 4.150 msecs [ 67.352661] PM: noirq suspend of devices complete after 5.676 msecs [ 67.352661] Disabling non-boot CPUs ... [ 70.962188] Successfully put all powerdomains to target state [ 70.965911] PM: noirq resume of devices complete after 3.417 msecs [ 70.969848] PM: early resume of devices complete after 2.838 msecs [ 71.968963] omap_i2c omap_i2c.1: controller timed out [ 71.969055] twl: i2c_write failed to transfer all messages [ 71.969085] twl4030: twl4030_sih_bus_sync_unlock, write --> -110 [ 72.969268] omap_i2c omap_i2c.1: controller timed out [ 72.984619] twl: i2c_read failed to transfer all messages [ 72.984649] omap_hsmmc omap_hsmmc.0: could not set regulator OCR (-110) [ 73.145935] mmc0: error -110 during resume (card was removed?) [ 73.513275] PM: resume of devices complete after 2543.334 msecs [ 73.610137] Restarting tasks ... done. # # [ 73.617980] mmc0: card e624 removed [ 73.629089] ------------[ cut here ]------------ [ 73.634124] WARNING: at drivers/regulator/core.c:1591 _regulator_disable+0x1c8/0x26c() [ 73.642517] unbalanced disables for VSIM [ 73.646636] Modules linked in: [ 73.649963] [] (unwind_backtrace+0x0/0xf0) from [] (warn_slowpath_common+0x4c/0x64) [ 73.659881] [] (warn_slowpath_common+0x4c/0x64) from [] (warn_slowpath_fmt+0x30/0x40) [ 73.670013] [] (warn_slowpath_fmt+0x30/0x40) from [] (_regulator_disable+0x1c8/0x26c) [ 73.680114] [] (_regulator_disable+0x1c8/0x26c) from [] (regulator_disable+0x34/0x60) [ 73.690246] [] (regulator_disable+0x34/0x60) from [] (omap_hsmmc_set_power+0x94/0x11c) [ 73.700439] [] (omap_hsmmc_set_power+0x94/0x11c) from [] (omap_hsmmc_set_ios+0x60/0x30c) [ 73.710876] [] (omap_hsmmc_set_ios+0x60/0x30c) from [] (mmc_power_off+0x70/0x90) [ 73.720550] [] (mmc_power_off+0x70/0x90) from [] (mmc_sd_detect+0x60/0x74) [ 73.729675] [] (mmc_sd_detect+0x60/0x74) from [] (mmc_rescan+0x174/0x4a8) [ 73.738708] [] (mmc_rescan+0x174/0x4a8) from [] (process_one_work+0x1a8/0x560) [ 73.748199] [] (process_one_work+0x1a8/0x560) from [] (worker_thread+0x170/0x4c0) [ 73.757934] [] (worker_thread+0x170/0x4c0) from [] (kthread+0xb0/0xbc) [ 73.766754] [] (kthread+0xb0/0xbc) from [] (ret_from_fork+0x14/0x24) [ 73.775299] ---[ end trace ebb3ac888ad8e6ea ]--- # # cat /debug/pm_debug/count [ 74.237030] mmc0: new SDHC card at address e624 [ 74.243682] mmcblk0: mmc0:e624 SD08G 7.40 GiB [ 74.262664] mmcblk0: p1 p2 p3 usbhost_pwrdm (ON),OFF:154,RET:1527,INA:0,ON:1682,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 sgx_pwrdm (OFF),OFF:1,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 core_pwrdm (ON),OFF:2,RET:7,INA:0,ON:10,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 per_pwrdm (ON),OFF:2,RET:129,INA:0,ON:132,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dss_pwrdm (ON),OFF:154,RET:1527,INA:0,ON:1682,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cam_pwrdm (OFF),OFF:1,RET:1,INA:0,ON:2,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 neon_pwrdm (ON),OFF:154,RET:1527,INA:0,ON:1682,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:154,RET:1527,INA:0,ON:1682,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 iva2_pwrdm (OFF),OFF:1,RET:1,INA:0,ON:2,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0,RET-MEMBANK4-OFF:0 usbhost_clkdm->usbhost_pwrdm (1) sgx_clkdm->sgx_pwrdm (0) per_clkdm->per_pwrdm (20) cam_clkdm->cam_pwrdm (0) dss_clkdm->dss_pwrdm (1) d2d_clkdm->core_pwrdm (0) iva2_clkdm->iva2_pwrdm (0) mpu_clkdm->mpu_pwrdm (0) core_l4_clkdm->core_pwrdm (24) core_l3_clkdm->core_pwrdm (4) neon_clkdm->neon_pwrdm (0) # # # # ./test_rootfs_access_nonexistent_file__off_susp /bin/sh: 83: ./test_rootfs_access_nonexistent_file__off_susp: not found # # %% End off-mode double suspend UART wakeup test %% Start off-mode 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 # # # # cat /debug/pm_debug/count usbhost_pwrdm (ON),OFF:278,RET:1527,INA:0,ON:1806,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 sgx_pwrdm (OFF),OFF:1,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 core_pwrdm (ON),OFF:5,RET:7,INA:0,ON:13,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 per_pwrdm (ON),OFF:27,RET:129,INA:0,ON:157,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dss_pwrdm (ON),OFF:278,RET:1527,INA:0,ON:1806,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cam_pwrdm (OFF),OFF:1,RET:1,INA:0,ON:2,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 neon_pwrdm (ON),OFF:278,RET:1527,INA:0,ON:1806,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:278,RET:1527,INA:0,ON:1806,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 iva2_pwrdm (OFF),OFF:1,RET:1,INA:0,ON:2,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0,RET-MEMBANK4-OFF:0 usbhost_clkdm->usbhost_pwrdm (1) sgx_clkdm->sgx_pwrdm (0) per_clkdm->per_pwrdm (17) cam_clkdm->cam_pwrdm (0) dss_clkdm->dss_pwrdm (1) d2d_clkdm->core_pwrdm (0) iva2_clkdm->iva2_pwrdm (0) mpu_clkdm->mpu_pwrdm (0) core_l4_clkdm->core_pwrdm (23) core_l3_clkdm->core_pwrdm (4) neon_clkdm->neon_pwrdm (0) # # # # ./test_rootfs_access_nonexistent_file__off_dyn /bin/sh: 99: ./test_rootfs_access_nonexistent_file__off_dyn: not found # # %% End off-mode dynamic idle UART wakeup test %% End PM consolidated quick test