U-Boot SPL 2012.07-00012-g391a28d (Dec 30 2012 - 17:40:39) OMAP4460 ES1.1 OMAP SD/MMC: 0 reading u-boot.img reading u-boot.bin mkimage signature not found - ih_magic = ea000014 reading u-boot.bin U-Boot 2012.07-00012-g391a28d (Dec 30 2012 - 17:40:39) CPU : OMAP4460 ES1.1 Board: OMAP4 Variscite SOM I2C: ready DRAM: 1 GiB MMC: OMAP SD/MMC: 0 Using default environment In: serial Out: serial Err: serial Net: Net Initialization Skipped No ethernet found. checking for preEnv.txt reading preEnv.txt 0 bytes read Loaded environment from preEnv.txt Importing preboot environment from mmc ... Hit any key to stop autoboot: 3  0 VAR-SOM-OM44 # VAR-SOM-OM44 # setenv bootargs 'console=ttyO2,115200n8 mem=1G@0x80000000 root=/dev/mmcblk0p2 ro earlyprintk ignore_loglevel fixrtc phy.smsc.gb_enable=false video=HDMI-A-1:1920x1080@60' VAR-SOM-OM44 # loady 0x81000000 ## Ready for binary (ymodem) download to 0x81000000 at 115200 bps... CSending: uImage-dtb.omap4-var-som Sending: Transfer complete - CRC mode, 3(SOH)/4434(STX)/0(CAN) packets, 3 retries ## Total Size = 0x00454830 = 4540464 Bytes VAR-SOM-OM44 # bootm 0x81000000 ## Booting kernel from Legacy Image at 81000000 ... Image Name: Linux- Image Type: ARM Linux Kernel Image (uncompressed) Data Size: 4540400 Bytes = 4.3 MiB Load Address: 80008000 Entry Point: 80008000 Verifying Checksum ... OK Loading Kernel Image ... OK OK Starting kernel ... [ 0.000000] Booting Linux on physical CPU 0x0 [ 0.000000] Linux version 3.12.0-24693-g5e01dc7 (paul@knihy) (gcc version 4.5.1 (Sourcery G++ Lite 2010.09-50) ) #1 SMP Tue Nov 5 12:31:20 MST 2013 [ 0.000000] CPU: ARMv7 Processor [412fc09a] revision 10 (ARMv7), cr=10c53c7d [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache [ 0.000000] Machine: Generic OMAP4 (Flattened Device Tree), model: Variscite OMAP4 SOM [ 0.000000] debug: ignoring loglevel setting. [ 0.000000] cma: CMA: reserved 16 MiB at ae800000 [ 0.000000] Memory policy: ECC disabled, Data cache writealloc [ 0.000000] On node 0 totalpages: 261888 [ 0.000000] free_area_init_node: node 0, pgdat c08b9440, node_mem_map c0e28000 [ 0.000000] Normal zone: 1520 pages used for memmap [ 0.000000] Normal zone: 0 pages reserved [ 0.000000] Normal zone: 194560 pages, LIFO batch:31 [ 0.000000] HighMem zone: 528 pages used for memmap [ 0.000000] HighMem zone: 67328 pages, LIFO batch:15 [ 0.000000] OMAP4460 ES1.1 [ 0.000000] PERCPU: Embedded 9 pages/cpu @c1640000 s14016 r8192 d14656 u36864 [ 0.000000] pcpu-alloc: s14016 r8192 d14656 u36864 alloc=9*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 260368 [ 0.000000] Kernel command line: console=ttyO2,115200n8 mem=1G@0x80000000 root=/dev/mmcblk0p2 ro earlyprintk ignore_loglevel fixrtc phy.smsc.gb_enable=false video=HDMI-A-1:1920x1080@60 [ 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: 1007484K/1047552K available (5783K kernel code, 657K rwdata, 2080K rodata, 393K init, 5522K bss, 40068K reserved, 269312K highmem) [ 0.000000] Virtual kernel memory layout: [ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB) [ 0.000000] fixmap : 0xfff00000 - 0xfffe0000 ( 896 kB) [ 0.000000] vmalloc : 0xf0000000 - 0xff000000 ( 240 MB) [ 0.000000] lowmem : 0xc0000000 - 0xef800000 ( 760 MB) [ 0.000000] pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB) [ 0.000000] modules : 0xbf000000 - 0xbfe00000 ( 14 MB) [ 0.000000] .text : 0xc0008000 - 0xc07b60d8 (7865 kB) [ 0.000000] .init : 0xc07b7000 - 0xc08196c0 ( 394 kB) [ 0.000000] .data : 0xc081a000 - 0xc08be548 ( 658 kB) [ 0.000000] .bss : 0xc08be548 - 0xc0e23020 (5523 kB) [ 0.000000] Hierarchical RCU implementation. [ 0.000000] NR_IRQS:16 nr_irqs:16 16 [ 0.000000] OMAP clockevent source: timer1 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] smp_twd: clock not found -2 [ 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.000000] Calibrating local timer... 348.16MHz. [ 0.059814] Calibrating delay loop... 1384.44 BogoMIPS (lpj=6922240) [ 0.149353] pid_max: default: 32768 minimum: 301 [ 0.149902] Security Framework initialized [ 0.150054] Mount-cache hash table entries: 512 [ 0.161529] CPU: Testing write buffer coherency: ok [ 0.163024] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 [ 0.163085] Setting up static identity map for 0xc057fe38 - 0xc057fea8 [ 0.163208] L310 cache controller enabled [ 0.163208] l2x0: 16 ways, CACHE_ID 0x410000c7, AUX_CTRL 0x7e470000, Cache size: 1024 kB [ 0.167907] CPU1: Booted secondary processor [ 0.248840] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 [ 0.249359] Brought up 2 CPUs [ 0.249389] SMP: Total of 2 processors activated. [ 0.249389] CPU: All CPU(s) started in SVC mode. [ 0.251922] devtmpfs: initialized [ 0.261322] VFP support v0.3: implementor 41 architecture 3 part 30 variant 9 rev 4 [ 0.330627] pinctrl core: initialized pinctrl subsystem [ 0.333831] regulator-dummy: no parameters [ 0.336608] NET: Registered protocol family 16 [ 0.343505] DMA: preallocated 256 KiB pool for atomic coherent allocations [ 0.422637] gpiochip_add: registered GPIOs 0 to 31 on device: gpio [ 0.423767] OMAP GPIO hardware version 0.1 [ 0.425506] gpiochip_add: registered GPIOs 32 to 63 on device: gpio [ 0.428070] gpiochip_add: registered GPIOs 64 to 95 on device: gpio [ 0.430297] gpiochip_add: registered GPIOs 96 to 127 on device: gpio [ 0.432464] gpiochip_add: registered GPIOs 128 to 159 on device: gpio [ 0.434692] gpiochip_add: registered GPIOs 160 to 191 on device: gpio [ 0.436401] omap-gpmc 50000000.gpmc: GPMC revision 6.0 [ 0.462738] No ATAGs? [ 0.462768] hw-breakpoint: found 5 (+1 reserved) breakpoint and 1 watchpoint registers. [ 0.462768] hw-breakpoint: maximum watchpoint size is 4 bytes. [ 0.466644] OMAP DMA hardware revision 0.0 [ 0.514862] bio: create slab at 0 [ 0.518493] edma-dma-engine edma-dma-engine.0: Can't allocate PaRAM dummy slot [ 0.518524] edma-dma-engine: probe of edma-dma-engine.0 failed with error -5 [ 0.576141] omap-dma-engine 4a056000.dma-controller: OMAP DMA engine driver [ 0.577117] of_get_named_gpio_flags: can't parse gpios property of node '/fixedregulator@0[0]' [ 0.577789] VDD_ETH: 3300 mV [ 0.583526] SCSI subsystem initialized [ 0.585144] usbcore: registered new interface driver usbfs [ 0.585510] usbcore: registered new interface driver hub [ 0.585968] usbcore: registered new device driver usb [ 0.590179] omap_i2c 48070000.i2c: bus 0 rev0.11 at 400 kHz [ 0.591217] omap_i2c 48072000.i2c: bus 1 rev0.11 at 400 kHz [ 0.592864] omap_i2c 48060000.i2c: bus 2 rev0.11 at 400 kHz [ 0.593719] omap_i2c 48350000.i2c: bus 3 rev0.11 at 400 kHz [ 0.599945] Switched to clocksource 32k_counter [ 0.721527] NET: Registered protocol family 2 [ 0.723266] TCP established hash table entries: 8192 (order: 4, 65536 bytes) [ 0.723571] TCP bind hash table entries: 8192 (order: 6, 294912 bytes) [ 0.726287] TCP: Hash tables configured (established 8192 bind 8192) [ 0.726531] TCP: reno registered [ 0.726562] UDP hash table entries: 512 (order: 3, 40960 bytes) [ 0.726928] UDP-Lite hash table entries: 512 (order: 3, 40960 bytes) [ 0.728271] NET: Registered protocol family 1 [ 0.729370] RPC: Registered named UNIX socket transport module. [ 0.729400] RPC: Registered udp transport module. [ 0.729400] RPC: Registered tcp transport module. [ 0.729431] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.730407] NetWinder Floating Point Emulator V0.97 (double precision) [ 0.906555] bounce pool size: 64 pages [ 0.907165] VFS: Disk quotas dquot_6.5.2 [ 0.907379] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 0.909637] NFS: Registering the id_resolver key type [ 0.910156] Key type id_resolver registered [ 0.910156] Key type id_legacy registered [ 0.910278] jffs2: version 2.2. (NAND) (SUMMARY) © 2001-2006 Red Hat, Inc. [ 0.910827] msgmni has been set to 1473 [ 0.913848] io scheduler noop registered [ 0.913879] io scheduler deadline registered [ 0.913970] io scheduler cfq registered (default) [ 0.915161] pinctrl-single 4a100040.pinmux: 203 pins at pa fc100040 size 406 [ 0.915649] pinctrl-single 4a31e040.pinmux: 28 pins at pa fc31e040 size 56 [ 0.918853] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 0.923828] of_get_named_gpio_flags: can't parse gpios property of node '/ocp/serial@4806a000[0]' [ 0.924713] 4806a000.serial: ttyO0 at MMIO 0x4806a000 (irq = 104, base_baud = 3000000) is a OMAP UART0 [ 0.926361] of_get_named_gpio_flags: can't parse gpios property of node '/ocp/serial@4806c000[0]' [ 0.926727] 4806c000.serial: ttyO1 at MMIO 0x4806c000 (irq = 105, base_baud = 3000000) is a OMAP UART1 [ 0.927734] of_get_named_gpio_flags: can't parse gpios property of node '/ocp/serial@48020000[0]' [ 0.928100] 48020000.serial: ttyO2 at MMIO 0x48020000 (irq = 106, base_baud = 3000000) is a OMAP UART2 [ 1.746551] console [ttyO2] enabled [ 1.751373] of_get_named_gpio_flags: can't parse gpios property of node '/ocp/serial@4806e000[0]' [ 1.761138] 4806e000.serial: ttyO3 at MMIO 0x4806e000 (irq = 102, base_baud = 3000000) is a OMAP UART3 [ 1.794128] brd: module loaded [ 1.810516] loop: module loaded [ 1.816314] Skipping twl internal clock init and using bootloader value (unknown osc rate) [ 1.826721] twl 0-0048: PIH (irq 39) nested IRQs [ 1.834411] VAUX1_6030: 1000 <--> 3000 mV at 2800 mV [ 1.842102] VAUX2_6030: 1200 <--> 2800 mV at 1800 mV [ 1.849334] VAUX3_6030: 1000 <--> 3000 mV at 1200 mV [ 1.856597] VMMC: 1200 <--> 3000 mV at 3000 mV [ 1.863342] VPP: 1800 <--> 2500 mV at 1900 mV [ 1.870025] VUSIM: 1200 <--> 2900 mV [ 1.875518] VDAC: 1800 mV [ 1.879699] VANA: 2100 mV [ 1.884277] VCXIO: 1800 mV [ 1.888610] VUSB: 3300 mV [ 1.893249] V1V8: 1800 mV [ 1.897827] V2V1: 2100 mV [ 1.908020] mtdoops: mtd device (mtddev=name/number) must be supplied [ 1.917968] omap-dma-engine 4a056000.dma-controller: allocating channel for 36 [ 1.925720] omap-dma-engine 4a056000.dma-controller: allocating channel for 35 [ 1.939483] ks8851 spi1.0: message enable is 0 [ 1.950897] ks8851 spi1.0 eth0: revision 1, MAC a2:7a:a4:00:dd:32, IRQ 331, no EEPROM [ 1.962005] usbcore: registered new interface driver asix [ 1.968017] usbcore: registered new interface driver ax88179_178a [ 1.974792] usbcore: registered new interface driver cdc_ether [ 1.981292] usbcore: registered new interface driver r815x [ 1.987426] usbcore: registered new interface driver smsc95xx [ 1.993835] usbcore: registered new interface driver net1080 [ 2.000488] usbcore: registered new interface driver cdc_subset [ 2.007049] usbcore: registered new interface driver zaurus [ 2.013336] usbcore: registered new interface driver cdc_ncm [ 2.020690] usbcore: registered new interface driver cdc_wdm [ 2.027038] usbcore: registered new interface driver usb-storage [ 2.033966] usbcore: registered new interface driver usbtest [ 2.041473] mousedev: PS/2 mouse device common for all mice [ 2.051635] twl_rtc rtc.5: Power up reset detected. [ 2.057678] twl_rtc rtc.5: Enabling TWL-RTC [ 2.066497] twl_rtc rtc.5: rtc core: registered rtc.5 as rtc0 [ 2.073059] i2c /dev entries driver [ 2.080047] Driver for 1-wire Dallas network protocol. [ 2.086822] ti-soc-thermal 4a002260.bandgap: failed to request fclock reference [ 2.094604] ti-soc-thermal: probe of 4a002260.bandgap failed with error -2 [ 2.104644] omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec [ 2.114196] of_get_named_gpio_flags: can't parse gpios property of node '/ocp/mmc@4809c000[0]' [ 2.123352] of_get_named_gpio_flags: can't parse gpios property of node '/ocp/mmc@4809c000[0]' [ 2.132781] omap-dma-engine 4a056000.dma-controller: allocating channel for 62 [ 2.140502] omap-dma-engine 4a056000.dma-controller: allocating channel for 61 [ 2.148681] omap_hsmmc 4809c000.mmc: pins are not configured from the driver [ 2.190093] of_get_named_gpio_flags: can't parse gpios property of node '/ocp/mmc@480d5000[0]' [ 2.199188] of_get_named_gpio_flags: can't parse gpios property of node '/ocp/mmc@480d5000[0]' [ 2.208496] omap-dma-engine 4a056000.dma-controller: allocating channel for 60 [ 2.216217] omap-dma-engine 4a056000.dma-controller: allocating channel for 59 [ 2.223937] omap_hsmmc 480d5000.mmc: vmmc regulator missing [ 2.230133] omap-dma-engine 4a056000.dma-controller: freeing channel for 59 [ 2.237487] omap-dma-engine 4a056000.dma-controller: freeing channel for 60 [ 2.237915] mmc0: host does not support reading read-only switch. assuming write-enable. [ 2.240173] mmc0: new high speed SDHC card at address 0007 [ 2.260925] ledtrig-cpu: registered to indicate activity on CPUs [ 2.260955] mmcblk0: mmc0:0007 SD08G 7.42 GiB [ 2.273376] usbcore: registered new interface driver usbhid [ 2.279296] usbhid: USB HID core driver [ 2.283996] mmcblk0: p1 p2 [ 2.284545] oprofile: no performance counters [ 2.286346] oprofile: using timer interrupt. [ 2.296691] TCP: cubic registered [ 2.300231] Initializing XFRM netlink socket [ 2.304870] NET: Registered protocol family 17 [ 2.309631] NET: Registered protocol family 15 [ 2.314636] Key type dns_resolver registered [ 2.320465] Power Management for TI OMAP4+ devices. [ 2.325683] Power Management for TI OMAP4. [ 2.330078] OMAP4 PM: u-boot >= v2012.07 is required for full PM support [ 2.337310] ThumbEE CPU extension supported. [ 2.345306] VUSB: disabling [ 2.348937] VANA: disabling [ 2.352600] VDAC: disabling [ 2.358093] VAUX1_6030: disabling [ 2.366027] twl_rtc rtc.5: setting system clock to 2000-01-01 00:00:00 UTC (946684800) [ 2.381469] EXT3-fs (mmcblk0p2): error: couldn't mount because of unsupported optional features (240) [ 2.394256] EXT2-fs (mmcblk0p2): error: couldn't mount because of unsupported optional features (244) [ 2.430511] EXT4-fs (mmcblk0p2): INFO: recovery required on readonly filesystem [ 2.443115] EXT4-fs (mmcblk0p2): write access will be enabled during recovery [ 5.511627] EXT4-fs (mmcblk0p2): recovery complete [ 5.532104] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) [ 5.540832] VFS: Mounted root (ext4 filesystem) readonly on device 179:2. [ 5.558044] devtmpfs: mounted [ 5.558044] Freeing unused kernel memory: 392K (c07b7000 - c0819000) [ 6.131042] init: Failed to create pty - disabling logging for job [ 6.131042] init: Temporary process spawn error: No space left on device [ 6.207092] init: Failed to create pty - disabling logging for job [ 6.214019] init: Temporary process spawn error: No space left on device [ 6.249816] init: Failed to create pty - disabling logging for job [ 6.257080] init: Temporary process spawn error: No space left on device [ 6.269165] init: Failed to create pty - disabling logging for job [ 6.275787] init: Temporary process spawn error: No space left on device [ 6.409606] init: ureadahead main process (772) terminated with status 5 [ 6.876464] init: Failed to create pty - disabling logging for job [ 6.876831] init: Temporary process spawn error: No space left on device [ 6.929443] init: Failed to create pty - disabling logging for job [ 6.936218] init: Temporary process spawn error: No space left on device [ 7.059539] init: Failed to create pty - disabling logging for job [ 7.066101] init: Temporary process spawn error: No space left on device [ 7.808929] udevd[829]: starting version 175 fsck from util-linux 2.20.1 /dev/mmcblk0p2: clean, 177178/963584 files, 2983853/7708672 blocks [ 10.921630] init: udev-fallback-graphics main process (1508) terminated with status 1 [ 11.014343] EXT4-fs (mmcblk0p2): re-mounted. Opts: errors=remount-ro [ 11.213195] init: plymouth main process (773) killed by SEGV signal [ 11.229064] init: plymouth-splash main process (1515) terminated with status 2 mountall: Plymouth command failed mountall: Plymouth command failed mountall: Plymouth command failed mountall: Plymouth command failed mountall: Plymouth command failed mountall: Plymouth command failed [ 11.628967] init: plymouth-log main process (1566) terminated with status 1 [ 11.707733] init: failsafe main process (1569) killed by TERM signal [ 12.569946] Adding 524232k swap on /SWAP.swap. Priority:-1 extents:13 across:577528k SS mountall: Plymouth command failed mountall: Plymouth command failed mountall: Plymouth command failed mountall: Plymouth command failed mountall: Disconnected from Plymouth [ 13.270874] init: plymouth-upstart-bridge main process (1612) terminated with status 1 speech-dispatcher disabled; edit /etc/default/speech-dispatcher saned disabled; edit /etc/default/saned [ 15.058319] init: bluetooth main process (1640) terminated with status 1 [ 15.065948] init: bluetooth main process ended, respawning [ 15.074432] init: alsa-restore main process (1660) terminated with status 19 [ 15.083587] init: hybrid-gfx main process (1683) terminated with status 1 FATAL: Could not load /lib/modules/3.12.0-24693-g5e01dc7/modules.dep: No such file or directory [ 15.776794] init: bluetooth main process (1753) terminated with status 1 [ 15.784912] init: bluetooth main process ended, respawning [ 15.995819] init: bluetooth main process (1780) terminated with status 1 [ 16.006256] init: bluetooth main process ended, respawning [ 16.660095] init: bluetooth main process (1817) terminated with status 1 [ 16.670013] init: bluetooth main process ended, respawning [ 16.861724] init: bluetooth main process (1842) terminated with status 1 [ 16.870574] init: bluetooth main process ended, respawning [ 17.067932] init: bluetooth main process (1867) terminated with status 1 [ 17.075866] init: bluetooth main process ended, respawning [ 17.286590] init: bluetooth main process (1890) terminated with status 1 [ 17.294128] init: bluetooth main process ended, respawning [ 17.451965] init: bluetooth main process (1921) terminated with status 1 [ 17.461517] init: bluetooth main process ended, respawning Ubuntu 12.04.1 LTS variscite-desktop ttyO2 variscite-desktop login: [ 17.618621] init: bluetooth main process (1944) terminated with status 1 [ 17.626708] init: bluetooth main process ended, respawning [ 17.882904] init: bluetooth main process (1967) terminated with status 1 [ 17.899993] init: bluetooth main process ended, respawning [ 18.112609] init: bluetooth main process (1993) terminated with status 1 [ 18.124084] init: bluetooth respawning too fast, stopped Ubuntu 12.04.1 LTS variscite-desktop ttyO2 variscite-desktop login: Ubuntu 12.04.1 LTS variscite-desktop ttyO2 variscite-desktop login: root Last login: Sat Jan 1 02:00:15 IST 2000 on ttyO2 [ 18.983673] init: lightdm main process (1716) terminated with status 1 Welcome to Ubuntu 12.04.1 LTS (GNU/Linux 3.12.0-24693-g5e01dc7 armv7l) * Documentation: https://help.ubuntu.com/ root@variscite-desktop:~# root@variscite-desktop:~# %% Start PM consolidated quick test (retention only) %% Preparation root@variscite-desktop:~# root@variscite-desktop:~# mount -t sysfs none /sys mount: none already mounted or /sys busy mount: according to mtab, none is already mounted on /sys root@variscite-desktop:~# root@variscite-desktop:~# mount -t debugfs none /debug root@variscite-desktop:~# root@variscite-desktop:~# root@variscite-desktop:~# root@variscite-desktop:~# for u in `ls -1d /sys/bus/platform/drivers/omap_uart/* .serial | paste -s -d' '`; do echo -1 > $u/power/autosuspend_delay_ms; done root@variscite-desktop:~# root@variscite-desktop:~# echo 0 > /debug/pm_debug/enable_off_mode root@variscite-desktop:~# root@variscite-desktop:~# %% Baseline pm_debug count dump cat /debug/pm_debug/count [ 27.319885] pwrdm state mismatch(cam_pwrdm) 3 != 0 [ 27.326263] pwrdm state mismatch(ivahd_pwrdm) 3 != 1 [ 27.331604] pwrdm state mismatch(tesla_pwrdm) 3 != 1 [ 27.336914] pwrdm state mismatch(dss_pwrdm) 3 != 1 cefuse_pwrdm (OFF),OFF:2,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0 always_on_core_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0 l4per_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 l3init_pwrdm (RET),OFF:0,RET:8,INA:0,ON:8,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cam_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 ivahd_pwrdm (ON),OFF:1,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0,RET-MEMBANK4-OFF:0 mpu_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 cpu1_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cpu0_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 tesla_pwrdm (ON),OFF:1,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0 dss_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 abe_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 gfx_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,RET-MEMBANK3-OFF:0,RET-MEMBANK4-OFF:0,RET-MEMBANK5-OFF:0 l3_dma_clkdm->core_pwrdm (0) emu_sys_clkdm->emu_pwrdm (0) l4_wkup_clkdm->wkup_pwrdm (2) l3_dss_clkdm->dss_pwrdm (0) iss_clkdm->cam_pwrdm (0) l3_1_clkdm->core_pwrdm (0) l3_2_clkdm->core_pwrdm (1) mpuss_clkdm->mpu_pwrdm (1) ducati_clkdm->core_pwrdm (0) l4_ao_clkdm->always_on_core_pwrdm (0) l3_emif_clkdm->core_pwrdm (2) mpu1_clkdm->cpu1_pwrdm (0) mpu0_clkdm->cpu0_pwrdm (0) d2d_clkdm->core_pwrdm (0) l3_init_clkdm->l3init_pwrdm (0) l3_instr_clkdm->core_pwrdm (0) abe_clkdm->abe_pwrdm (0) l4_per_clkdm->l4per_pwrdm (6) l4_secure_clkdm->l4per_pwrdm (0) ivahd_clkdm->ivahd_pwrdm (0) l3_gfx_clkdm->gfx_pwrdm (0) tesla_clkdm->tesla_pwrdm (0) l4_cfg_clkdm->core_pwrdm (0) l4_cefuse_clkdm->cefuse_pwrdm (0) root@variscite-desktop:~# root@variscite-desktop:~# echo enabled > /sys/devices/44000000.ocp/48020000.seri al/tty/ttyO2/power/wakeup root@variscite-desktop:~# %% Start retention double suspend/resume UART wakeup test echo mem > /sys/power/state [ 29.590148] PM: Syncing filesystems ... [ 35.482360] init: failsafe-x main process (2032) terminated with status 1 done. [ 37.800323] PM: Preparing system for mem sleep [ 37.818572] Freezing user space processes ... (elapsed 0.004 seconds) done. [ 37.830017] Freezing remaining freezable tasks ... (elapsed 0.003 seconds) done. [ 37.841857] PM: Entering mem sleep [ 37.846191] Suspending console(s) (use no_console_suspend to debug) [ 37.871032] PM: suspend of devices complete after 18.188 msecs [ 37.871063] PM: late suspend of devices complete after 0.001 msecs [ 37.880706] omap_hwmod: gpio6: _wait_target_disable failed [ 37.885925] PM: noirq suspend of devices complete after 14.862 msecs [ 37.886077] Disabling non-boot CPUs ... [ 37.895111] CPU1: shutdown [ 37.896606] Powerdomain (core_pwrdm) didn't enter target state 1 [ 37.896606] Powerdomain (abe_pwrdm) didn't enter target state 1 [ 37.896606] Powerdomain (mpu_pwrdm) didn't enter target state 1 [ 37.896606] Powerdomain (l4per_pwrdm) didn't enter target state 1 [ 37.896606] Powerdomain (core_pwrdm) didn't enter target state 1 [ 37.896606] Powerdomain (abe_pwrdm) didn't enter target state 1 [ 37.896606] Powerdomain (mpu_pwrdm) didn't enter target state 1 [ 37.896606] Powerdomain (l4per_pwrdm) didn't enter target state 1 [ 37.896606] Could not enter target state in pm_suspend [ 37.896606] A possible cause could be an old bootloader - try u-boot >= v2012.07 [ 37.896606] hw-breakpoint: Failed to enable monitor mode on CPU 0. [ 37.897125] Enabling non-boot CPUs ... [ 37.899902] CPU1: Booted secondary processor [ 37.901733] CPU1 is up [ 37.902648] PM: noirq resume of devices complete after 0.885 msecs [ 37.908203] PM: early resume of devices complete after 1.037 msecs [ 38.021942] PM: resume of devices complete after 113.739 msecs [ 38.139282] PM: Finishing wakeup. [ 38.139282] Restarting tasks ... done. root@variscite-desktop:~# root@variscite-desktop:~# root@variscite-desktop:~# root@variscite-desktop:~# cat /debug/pm_debug/count cefuse_pwrdm (OFF),OFF:2,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0 always_on_core_pwrdm (ON),OFF:1,RET:0,INA:0,ON:2,RET-LOGIC-OFF:0 l4per_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 l3init_pwrdm (RET),OFF:0,RET:10,INA:0,ON:10,RET-LOGIC-OFF:1,RET-MEMBANK1-OFF:0 cam_pwrdm (OFF),OFF:1,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 ivahd_pwrdm (RET),OFF:1,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 mpu_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 cpu1_pwrdm (ON),OFF:1,RET:0,INA:0,ON:2,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cpu0_pwrdm (ON),OFF:1,RET:0,INA:0,ON:2,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 tesla_pwrdm (RET),OFF:1,RET:1,INA:0,ON:1,RET-LOGIC-OFF:1,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0 dss_pwrdm (RET),OFF:0,RET:1,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 abe_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 gfx_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,RET-MEMBANK3-OFF:0,RET-MEMBANK4-OFF:0,RET-MEMBANK5-OFF:0 l3_dma_clkdm->core_pwrdm (0) emu_sys_clkdm->emu_pwrdm (0) l4_wkup_clkdm->wkup_pwrdm (2) l3_dss_clkdm->dss_pwrdm (0) iss_clkdm->cam_pwrdm (0) l3_1_clkdm->core_pwrdm (0) l3_2_clkdm->core_pwrdm (1) mpuss_clkdm->mpu_pwrdm (1) ducati_clkdm->core_pwrdm (0) l4_ao_clkdm->always_on_core_pwrdm (0) l3_emif_clkdm->core_pwrdm (2) mpu1_clkdm->cpu1_pwrdm (0) mpu0_clkdm->cpu0_pwrdm (0) d2d_clkdm->core_pwrdm (0) l3_init_clkdm->l3init_pwrdm (0) l3_instr_clkdm->core_pwrdm (0) abe_clkdm->abe_pwrdm (0) l4_per_clkdm->l4per_pwrdm (5) l4_secure_clkdm->l4per_pwrdm (0) ivahd_clkdm->ivahd_pwrdm (0) l3_gfx_clkdm->gfx_pwrdm (0) tesla_clkdm->tesla_pwrdm (0) l4_cfg_clkdm->core_pwrdm (0) l4_cefuse_clkdm->cefuse_pwrdm (0) root@variscite-desktop:~# root@variscite-desktop:~# root@variscite-desktop:~# root@variscite-desktop:~# echo mem > /sys/power/state [ 40.178405] PM: Syncing filesystems ... done. [ 41.306304] PM: Preparing system for mem sleep [ 41.313507] Freezing user space processes ... (elapsed 0.006 seconds) done. [ 41.327606] Freezing remaining freezable tasks ... (elapsed 0.006 seconds) done. [ 41.337493] PM: Entering mem sleep [ 41.337493] Suspending console(s) (use no_console_suspend to debug) [ 41.362274] PM: suspend of devices complete after 13.702 msecs [ 41.366027] PM: late suspend of devices complete after 0.001 msecs [ 41.370056] omap_hwmod: gpio6: _wait_target_disable failed [ 41.377014] PM: noirq suspend of devices complete after 10.894 msecs [ 41.377014] Disabling non-boot CPUs ... [ 41.380859] CPU1: shutdown [ 41.381164] Powerdomain (core_pwrdm) didn't enter target state 1 [ 41.381164] Powerdomain (abe_pwrdm) didn't enter target state 1 [ 41.381164] Powerdomain (mpu_pwrdm) didn't enter target state 1 [ 41.381164] Powerdomain (l4per_pwrdm) didn't enter target state 1 [ 41.381164] Powerdomain (core_pwrdm) didn't enter target state 1 [ 41.381164] Powerdomain (abe_pwrdm) didn't enter target state 1 [ 41.381164] Powerdomain (mpu_pwrdm) didn't enter target state 1 [ 41.381164] Powerdomain (l4per_pwrdm) didn't enter target state 1 [ 41.381164] Could not enter target state in pm_suspend [ 41.381164] A possible cause could be an old bootloader - try u-boot >= v2012.07 [ 41.381164] hw-breakpoint: CPU 0 failed to disable vector catch [ 41.381195] Enabling non-boot CPUs ... [ 41.383728] CPU1: Booted secondary processor [ 41.384887] CPU1 is up [ 41.387359] PM: noirq resume of devices complete after 0.946 msecs [ 41.391113] PM: early resume of devices complete after 3.753 msecs [ 41.460205] PM: resume of devices complete after 69.091 msecs [ 41.597961] PM: Finishing wakeup. [ 41.601470] Restarting tasks ... done. root@variscite-desktop:~# root@variscite-desktop:~# root@variscite-desktop:~# root@variscite-desktop:~# cat /debug/pm_debug/count cefuse_pwrdm (OFF),OFF:2,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0 always_on_core_pwrdm (ON),OFF:2,RET:0,INA:0,ON:3,RET-LOGIC-OFF:0 l4per_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 l3init_pwrdm (RET),OFF:0,RET:12,INA:0,ON:12,RET-LOGIC-OFF:2,RET-MEMBANK1-OFF:0 cam_pwrdm (OFF),OFF:1,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 ivahd_pwrdm (RET),OFF:1,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 mpu_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 cpu1_pwrdm (ON),OFF:2,RET:0,INA:0,ON:3,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cpu0_pwrdm (ON),OFF:2,RET:0,INA:0,ON:3,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 tesla_pwrdm (RET),OFF:1,RET:1,INA:0,ON:1,RET-LOGIC-OFF:2,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0 dss_pwrdm (RET),OFF:0,RET:1,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 abe_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 gfx_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,RET-MEMBANK3-OFF:0,RET-MEMBANK4-OFF:0,RET-MEMBANK5-OFF:0 l3_dma_clkdm->core_pwrdm (0) emu_sys_clkdm->emu_pwrdm (0) l4_wkup_clkdm->wkup_pwrdm (2) l3_dss_clkdm->dss_pwrdm (0) iss_clkdm->cam_pwrdm (0) l3_1_clkdm->core_pwrdm (0) l3_2_clkdm->core_pwrdm (1) mpuss_clkdm->mpu_pwrdm (1) ducati_clkdm->core_pwrdm (0) l4_ao_clkdm->always_on_core_pwrdm (0) l3_emif_clkdm->core_pwrdm (2) mpu1_clkdm->cpu1_pwrdm (0) mpu0_clkdm->cpu0_pwrdm (0) d2d_clkdm->core_pwrdm (0) l3_init_clkdm->l3init_pwrdm (0) l3_instr_clkdm->core_pwrdm (0) abe_clkdm->abe_pwrdm (0) l4_per_clkdm->l4per_pwrdm (5) l4_secure_clkdm->l4per_pwrdm (0) ivahd_clkdm->ivahd_pwrdm (0) l3_gfx_clkdm->gfx_pwrdm (0) tesla_clkdm->tesla_pwrdm (0) l4_cfg_clkdm->core_pwrdm (0) l4_cefuse_clkdm->cefuse_pwrdm (0) root@variscite-desktop:~# root@variscite-desktop:~# root@variscite-desktop:~# root@variscite-desktop:~# ./test_rootfs_access_nonexistent_file__ret_susp -bash: ./test_rootfs_access_nonexistent_file__ret_susp: No such file or directory root@variscite-desktop:~# root@variscite-desktop:~# %% End retention double suspend/resume UART wakeup test %% Start retention dynamic idle UART wakeup test for u in `ls -1d /sys/bus/platform/drivers/omap_uart/* .serial | paste -s -d' '`; do echo 3000 > $u/power/autosuspend_delay_ms; done root@variscite-desktop:~# root@variscite-desktop:~# root@variscite-desktop:~# root@variscite-desktop:~# cat /debug/pm_debug/count cefuse_pwrdm (OFF),OFF:2,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0 always_on_core_pwrdm (ON),OFF:2,RET:0,INA:0,ON:3,RET-LOGIC-OFF:0 l4per_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 l3init_pwrdm (RET),OFF:0,RET:14,INA:0,ON:14,RET-LOGIC-OFF:2,RET-MEMBANK1-OFF:0 cam_pwrdm (OFF),OFF:1,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 ivahd_pwrdm (RET),OFF:1,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 mpu_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 cpu1_pwrdm (ON),OFF:2,RET:0,INA:0,ON:3,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cpu0_pwrdm (ON),OFF:2,RET:0,INA:0,ON:3,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 tesla_pwrdm (RET),OFF:1,RET:1,INA:0,ON:1,RET-LOGIC-OFF:2,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0 dss_pwrdm (RET),OFF:0,RET:1,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 abe_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 gfx_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,RET-MEMBANK3-OFF:0,RET-MEMBANK4-OFF:0,RET-MEMBANK5-OFF:0 l3_dma_clkdm->core_pwrdm (0) emu_sys_clkdm->emu_pwrdm (0) l4_wkup_clkdm->wkup_pwrdm (2) l3_dss_clkdm->dss_pwrdm (0) iss_clkdm->cam_pwrdm (0) l3_1_clkdm->core_pwrdm (0) l3_2_clkdm->core_pwrdm (1) mpuss_clkdm->mpu_pwrdm (1) ducati_clkdm->core_pwrdm (0) l4_ao_clkdm->always_on_core_pwrdm (0) l3_emif_clkdm->core_pwrdm (2) mpu1_clkdm->cpu1_pwrdm (0) mpu0_clkdm->cpu0_pwrdm (0) d2d_clkdm->core_pwrdm (0) l3_init_clkdm->l3init_pwrdm (0) l3_instr_clkdm->core_pwrdm (0) abe_clkdm->abe_pwrdm (0) l4_per_clkdm->l4per_pwrdm (2) l4_secure_clkdm->l4per_pwrdm (0) ivahd_clkdm->ivahd_pwrdm (0) l3_gfx_clkdm->gfx_pwrdm (0) tesla_clkdm->tesla_pwrdm (0) l4_cfg_clkdm->core_pwrdm (0) l4_cefuse_clkdm->cefuse_pwrdm (0) root@variscite-desktop:~# root@variscite-desktop:~# root@variscite-desktop:~# root@variscite-desktop:~# ./test_rootfs_access_nonexistent_file__ret_dyn -bash: ./test_rootfs_access_nonexistent_file__ret_dyn: No such file or directory root@variscite-desktop:~# root@variscite-desktop:~# for u in `ls -1d /sys/bus/platform/drivers/omap_uart/* .serial | paste -s -d' '`; do echo -1 > $u/power/autosuspend_delay_ms; done root@variscite-desktop:~# root@variscite-desktop:~# %% End retention dynamic idle UART wakeup test %% End PM consolidated quick test (retention only)