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 m - CRC mode, 4(SOH)/4210(STX)/0(CAN) packets, 3 retries ## Total Size = 0x0041c89b = 4311195 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: 4311131 Bytes = 4.1 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.14.0-rc5-50686-g0414855 (paul@knihy) (gcc version 4.7.2 (Debian 4.7.2-5) ) #1 SMP Tue Apr 1 15:29:17 MDT 2014 [ 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 model: Variscite OMAP4 SOM [ 0.000000] debug: ignoring loglevel setting. [ 0.000000] cma: CMA: reserved 16 MiB at ae800000 [ 0.000000] Memory policy: Data cache writealloc [ 0.000000] On node 0 totalpages: 261888 [ 0.000000] free_area_init_node: node 0, pgdat c088a300, node_mem_map edff2000 [ 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 @edfb9000 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: 1007596K/1047552K available (5561K kernel code, 654K rwdata, 2128K rodata, 385K init, 5518K bss, 39956K 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 - 0xc078a904 (7691 kB) [ 0.000000] .init : 0xc078b000 - 0xc07eb6c0 ( 386 kB) [ 0.000000] .data : 0xc07ec000 - 0xc088f8d8 ( 655 kB) [ 0.000000] .bss : 0xc088f8d8 - 0xc0df3478 (5519 kB) [ 0.000000] Hierarchical RCU implementation. [ 0.000000] NR_IRQS:16 nr_irqs:16 16 [ 0.000000] ti_dt_clocks_register: failed to lookup clock node div_ts_ck [ 0.000000] ti_dt_clocks_register: failed to lookup clock node bandgap_ts_fclk [ 0.000000] OMAP clockevent source: timer1 at 32768 Hz [ 0.000030] sched_clock: 32 bits at 32kHz, resolution 30517ns, wraps every 65536000000000ns [ 0.000030] OMAP clocksource: 32k_counter at 32768 Hz [ 0.000183] smp_twd: clock not found -2 [ 0.002044] Console: colour dummy device 80x30 [ 0.002136] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.002136] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.002136] ... MAX_LOCK_DEPTH: 48 [ 0.002166] ... MAX_LOCKDEP_KEYS: 8191 [ 0.002166] ... CLASSHASH_SIZE: 4096 [ 0.002166] ... MAX_LOCKDEP_ENTRIES: 16384 [ 0.002166] ... MAX_LOCKDEP_CHAINS: 32768 [ 0.002197] ... CHAINHASH_SIZE: 16384 [ 0.002197] memory used by lock dependency info: 3695 kB [ 0.002197] per task-struct memory footprint: 1152 bytes [ 0.002258] Calibrating local timer... 347.62MHz. [ 0.058715] Calibrating delay loop... 1384.44 BogoMIPS (lpj=6922240) [ 0.148071] pid_max: default: 32768 minimum: 301 [ 0.148620] Security Framework initialized [ 0.148803] Mount-cache hash table entries: 512 [ 0.178161] CPU: Testing write buffer coherency: ok [ 0.179656] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 [ 0.179718] Setting up static identity map for 0x80546060 - 0x805460d0 [ 0.179840] L310 cache controller enabled [ 0.179840] l2x0: 16 ways, CACHE_ID 0x410000c7, AUX_CTRL 0x7e470000, Cache size: 1024 kB [ 0.184783] CPU1: Booted secondary processor [ 0.217620] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 [ 0.218200] Brought up 2 CPUs [ 0.218231] SMP: Total of 2 processors activated. [ 0.218261] CPU: All CPU(s) started in SVC mode. [ 0.220977] devtmpfs: initialized [ 0.230163] VFP support v0.3: implementor 41 architecture 3 part 30 variant 9 rev 4 [ 0.234039] omap_hwmod: l3_main_3 using broken dt data from ocp [ 0.237670] omap_hwmod: l3_main_2 using broken dt data from ocp [ 0.396881] pinctrl core: initialized pinctrl subsystem [ 0.400299] regulator-dummy: no parameters [ 0.403198] NET: Registered protocol family 16 [ 0.410095] DMA: preallocated 256 KiB pool for atomic coherent allocations [ 0.489318] gpiochip_add: registered GPIOs 0 to 31 on device: gpio [ 0.490356] OMAP GPIO hardware version 0.1 [ 0.492126] gpiochip_add: registered GPIOs 32 to 63 on device: gpio [ 0.494354] gpiochip_add: registered GPIOs 64 to 95 on device: gpio [ 0.496643] gpiochip_add: registered GPIOs 96 to 127 on device: gpio [ 0.498901] gpiochip_add: registered GPIOs 128 to 159 on device: gpio [ 0.501129] gpiochip_add: registered GPIOs 160 to 191 on device: gpio [ 0.503082] omap-gpmc 50000000.gpmc: GPMC revision 6.0 [ 0.530212] platform 4b501000.aes: Cannot lookup hwmod 'aes' [ 0.530822] platform 480a5000.des: Cannot lookup hwmod 'des' [ 0.532196] No ATAGs? [ 0.532226] hw-breakpoint: found 5 (+1 reserved) breakpoint and 1 watchpoint registers. [ 0.532257] hw-breakpoint: maximum watchpoint size is 4 bytes. [ 0.536041] OMAP DMA hardware revision 0.0 [ 0.584533] bio: create slab at 0 [ 0.587432] edma-dma-engine edma-dma-engine.0: Can't allocate PaRAM dummy slot [ 0.587463] edma-dma-engine: probe of edma-dma-engine.0 failed with error -5 [ 0.650665] omap-dma-engine 4a056000.dma-controller: OMAP DMA engine driver [ 0.651702] of_get_named_gpiod_flags: can't parse gpios property of node '/fixedregulator@0[0]' [ 0.652557] VDD_ETH: 3300 mV [ 0.659606] SCSI subsystem initialized [ 0.661499] usbcore: registered new interface driver usbfs [ 0.661865] usbcore: registered new interface driver hub [ 0.662353] usbcore: registered new device driver usb [ 0.667480] omap_i2c 48070000.i2c: bus 0 rev0.11 at 400 kHz [ 0.668579] omap_i2c 48072000.i2c: bus 1 rev0.11 at 400 kHz [ 0.670318] omap_i2c 48060000.i2c: bus 2 rev0.11 at 400 kHz [ 0.671234] omap_i2c 48350000.i2c: bus 3 rev0.11 at 400 kHz [ 0.678253] Switched to clocksource 32k_counter [ 0.825103] NET: Registered protocol family 2 [ 0.826843] TCP established hash table entries: 8192 (order: 3, 32768 bytes) [ 0.827087] TCP bind hash table entries: 8192 (order: 6, 294912 bytes) [ 0.829833] TCP: Hash tables configured (established 8192 bind 8192) [ 0.830047] TCP: reno registered [ 0.830108] UDP hash table entries: 512 (order: 3, 40960 bytes) [ 0.830444] UDP-Lite hash table entries: 512 (order: 3, 40960 bytes) [ 0.831817] NET: Registered protocol family 1 [ 0.833190] RPC: Registered named UNIX socket transport module. [ 0.833190] RPC: Registered udp transport module. [ 0.833221] RPC: Registered tcp transport module. [ 0.833221] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.841491] futex hash table entries: 512 (order: 3, 32768 bytes) [ 0.997924] bounce pool size: 64 pages [ 0.999359] VFS: Disk quotas dquot_6.5.2 [ 0.999603] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 1.001708] NFS: Registering the id_resolver key type [ 1.002044] Key type id_resolver registered [ 1.002075] Key type id_legacy registered [ 1.002197] jffs2: version 2.2. (NAND) (SUMMARY) © 2001-2006 Red Hat, Inc. [ 1.002716] msgmni has been set to 1473 [ 1.005828] io scheduler noop registered [ 1.005828] io scheduler deadline registered [ 1.005950] io scheduler cfq registered (default) [ 1.011596] pinctrl-single 4a100040.pinmux: 203 pins at pa fc100040 size 406 [ 1.012054] pinctrl-single 4a31e040.pinmux: 28 pins at pa fc31e040 size 56 [ 1.015624] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 1.022308] omap_uart 4806a000.serial: no wakeirq for uart0 [ 1.022308] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/serial@4806a000[0]' [ 1.023223] 4806a000.serial: ttyO0 at MMIO 0x4806a000 (irq = 104, base_baud = 3000000) is a OMAP UART0 [ 1.024963] omap_uart 4806c000.serial: no wakeirq for uart0 [ 1.024993] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/serial@4806c000[0]' [ 1.025573] 4806c000.serial: ttyO1 at MMIO 0x4806c000 (irq = 105, base_baud = 3000000) is a OMAP UART1 [ 1.026885] omap_uart 48020000.serial: no wakeirq for uart0 [ 1.026916] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/serial@48020000[0]' [ 1.027313] 48020000.serial: ttyO2 at MMIO 0x48020000 (irq = 106, base_baud = 3000000) is a OMAP UART2 [ 1.892791] console [ttyO2] enabled [ 1.897674] omap_uart 4806e000.serial: no wakeirq for uart0 [ 1.903564] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/serial@4806e000[0]' [ 1.913391] 4806e000.serial: ttyO3 at MMIO 0x4806e000 (irq = 102, base_baud = 3000000) is a OMAP UART3 [ 1.951324] brd: module loaded [ 1.970703] loop: module loaded [ 1.976684] Skipping twl internal clock init and using bootloader value (unknown osc rate) [ 1.986816] twl 0-0048: PIH (irq 39) nested IRQs [ 1.994750] VAUX1_6030: 1000 <--> 3000 mV at 2800 mV [ 2.002655] VAUX2_6030: 1200 <--> 2800 mV at 1800 mV [ 2.010070] VAUX3_6030: 1000 <--> 3000 mV at 1200 mV [ 2.017425] VMMC: 1200 <--> 3000 mV at 3000 mV [ 2.024230] VPP: 1800 <--> 2500 mV at 1900 mV [ 2.031066] VUSIM: 1200 <--> 2900 mV [ 2.036682] VDAC: 1800 mV [ 2.041046] VANA: 2100 mV [ 2.045806] VCXIO: 1800 mV [ 2.050231] VUSB: 3300 mV [ 2.054992] V1V8: 1800 mV [ 2.059722] V2V1: 2100 mV [ 2.070556] mtdoops: mtd device (mtddev=name/number) must be supplied [ 2.087280] ks8851 spi1.0: message enable is 0 [ 2.098449] ks8851 spi1.0 eth0: revision 1, MAC b6:a0:c1:b0:b8:c2, IRQ 331, no EEPROM [ 2.110412] usbcore: registered new interface driver asix [ 2.116424] usbcore: registered new interface driver ax88179_178a [ 2.123199] usbcore: registered new interface driver cdc_ether [ 2.129699] usbcore: registered new interface driver r815x [ 2.135864] usbcore: registered new interface driver smsc95xx [ 2.142242] usbcore: registered new interface driver net1080 [ 2.148559] usbcore: registered new interface driver cdc_subset [ 2.155090] usbcore: registered new interface driver zaurus [ 2.161376] usbcore: registered new interface driver cdc_ncm [ 2.169006] usbcore: registered new interface driver cdc_wdm [ 2.175323] usbcore: registered new interface driver usb-storage [ 2.182037] usbcore: registered new interface driver usbtest [ 2.191436] mousedev: PS/2 mouse device common for all mice [ 2.201904] twl_rtc rtc.5: Power up reset detected. [ 2.207977] twl_rtc rtc.5: Enabling TWL-RTC [ 2.216949] twl_rtc rtc.5: rtc core: registered rtc.5 as rtc0 [ 2.223510] i2c /dev entries driver [ 2.230865] Driver for 1-wire Dallas network protocol. [ 2.241119] omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec [ 2.250976] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/mmc@4809c000[0]' [ 2.260131] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/mmc@4809c000[0]' [ 2.270294] 4809c000.mmc supply vmmc_aux not found, using dummy regulator [ 2.277587] omap_hsmmc 4809c000.mmc: pins are not configured from the driver [ 2.318359] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/mmc@480d5000[0]' [ 2.327484] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/mmc@480d5000[0]' [ 2.336944] 480d5000.mmc supply vmmc not found, using dummy regulator [ 2.343933] 480d5000.mmc supply vmmc_aux not found, using dummy regulator [ 2.351318] omap_hsmmc 480d5000.mmc: could not set regulator OCR (-22) [ 2.356170] mmc0: host does not support reading read-only switch. assuming write-enable. [ 2.358428] mmc0: new high speed SDHC card at address 0007 [ 2.361175] mmcblk0: mmc0:0007 SD08G 7.42 GiB [ 2.366882] mmcblk0: p1 p2 [ 2.380035] omap_hsmmc 480d5000.mmc: pins are not configured from the driver [ 2.388000] omap_hsmmc 480d5000.mmc: could not set regulator OCR (-22) [ 2.433197] usbcore: registered new interface driver usbhid [ 2.439147] usbhid: USB HID core driver [ 2.445312] oprofile: no performance counters [ 2.451721] oprofile: using timer interrupt. [ 2.456787] TCP: cubic registered [ 2.460327] Initializing XFRM netlink socket [ 2.464904] NET: Registered protocol family 17 [ 2.469665] NET: Registered protocol family 15 [ 2.474609] Key type dns_resolver registered [ 2.480743] Power Management for TI OMAP4+ devices. [ 2.485931] Power Management for TI OMAP4. [ 2.490325] OMAP4 PM: u-boot >= v2012.07 is required for full PM support [ 2.497528] ThumbEE CPU extension supported. [ 2.506164] VUSB: disabling [ 2.509796] VANA: disabling [ 2.513488] VDAC: disabling [ 2.519042] VAUX1_6030: disabling [ 2.526855] twl_rtc rtc.5: setting system clock to 2000-01-01 00:00:00 UTC (946684800) [ 2.578063] EXT3-fs (mmcblk0p2): error: couldn't mount because of unsupported optional features (240) [ 2.590972] EXT2-fs (mmcblk0p2): error: couldn't mount because of unsupported optional features (244) [ 2.628173] EXT4-fs (mmcblk0p2): INFO: recovery required on readonly filesystem [ 2.638854] EXT4-fs (mmcblk0p2): write access will be enabled during recovery [ 4.760070] EXT4-fs (mmcblk0p2): recovery complete [ 5.072998] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) [ 5.072998] VFS: Mounted root (ext4 filesystem) readonly on device 179:2. [ 5.098602] devtmpfs: mounted [ 5.098602] Freeing unused kernel memory: 384K (c078b000 - c07eb000) [ 5.643463] random: init urandom read with 66 bits of entropy available [ 5.674652] init: Failed to create pty - disabling logging for job [ 5.681213] init: Temporary process spawn error: No space left on device [ 5.749359] init: Failed to create pty - disabling logging for job [ 5.755126] init: Temporary process spawn error: No space left on device [ 5.789306] init: Failed to create pty - disabling logging for job [ 5.789306] init: Temporary process spawn error: No space left on device [ 5.808288] init: Failed to create pty - disabling logging for job [ 5.814697] init: Temporary process spawn error: No space left on device [ 5.990295] init: ureadahead main process (795) terminated with status 5 [ 6.395080] init: Failed to create pty - disabling logging for job [ 6.401947] init: Temporary process spawn error: No space left on device [ 6.441711] init: Failed to create pty - disabling logging for job [ 6.449829] init: Temporary process spawn error: No space left on device [ 6.569152] init: Failed to create pty - disabling logging for job [ 6.576141] init: Temporary process spawn error: No space left on device [ 7.216278] udevd[853]: starting version 175 [ 7.876129] random: nonblocking pool is initialized fsck from util-linux 2.20.1 /dev/mmcblk0p2: clean, 177314/963584 files, 2985404/7708672 blocks [ 10.257568] EXT4-fs (mmcblk0p2): re-mounted. Opts: errors=remount-ro [ 10.506683] init: udev-fallback-graphics main process (1557) terminated with status 1 [ 10.778778] init: plymouth main process (797) killed by SEGV signal [ 10.788543] init: plymouth-splash main process (1567) terminated with status 2 [ 11.093994] init: plymouth-log main process (1614) terminated with status 1 [ 11.156494] init: failsafe main process (1615) killed by TERM signal [ 12.056854] Adding 524232k swap on /SWAP.swap. Priority:-1 extents:13 across:577528k SS [ 12.196563] init: plymouth-upstart-bridge main process (1664) terminated with status 1 speech-dispatcher disabled; edit /etc/default/speech-dispatcher saned disabled; edit /etc/default/saned [ 12.915405] init: alsa-restore main process (1696) terminated with status 19 [ 12.933197] init: hybrid-gfx main process (1714) terminated with status 1 FATAL: Could not load /lib/modules/3.14.0-rc5-50686-g0414855/modules.dep: No such file or directory [ 13.490295] init: bluetooth main process (1683) terminated with status 1 [ 13.498046] init: bluetooth main process ended, respawning [ 14.311309] init: bluetooth main process (1804) terminated with status 1 [ 14.321197] init: bluetooth main process ended, respawning [ 14.522216] init: bluetooth main process (1829) terminated with status 1 [ 14.531524] init: bluetooth main process ended, respawning [ 14.720458] init: bluetooth main process (1857) terminated with status 1 [ 14.730102] init: bluetooth main process ended, respawning [ 14.933624] init: bluetooth main process (1887) terminated with status 1 [ 14.941864] init: bluetooth main process ended, respawning Ubuntu 12.04.1 LTS variscite-desktop ttyO2 variscite-desktop login: [ 15.103515] init: bluetooth main process (1911) terminated with status 1 [ 15.111663] init: bluetooth main process ended, respawning [ 15.271087] init: bluetooth main process (1934) terminated with status 1 [ 15.279907] init: bluetooth main process ended, respawning Ubuntu 12.04.1 LTS variscite-desktop ttyO2 variscite-desktop login: Ubuntu 12.04.1 LTS variscite-desktop ttyO2 variscite-desktop login: [ 15.454376] init: bluetooth main process (1957) terminated with status 1 [ 15.462402] init: bluetooth main process ended, respawning root [ 15.995513] init: bluetooth main process (1983) terminated with status 1 [ 16.003295] init: bluetooth main process ended, respawning [ 16.202178] init: bluetooth main process (2007) terminated with status 1 [ 16.211334] init: bluetooth main process ended, respawning [ 16.411834] init: bluetooth main process (2030) terminated with status 1 [ 16.424377] init: bluetooth respawning too fast, stopped Last login: Sat Jan 1 02:00:18 IST 2000 on ttyO2 [ 17.792480] init: lightdm main process (1743) terminated with status 1 Welcome to Ubuntu 12.04.1 LTS (GNU/Linux 3.14.0-rc5-50686-g0414855 armv7l) * Documentation: https://help.ubuntu.com/ %% Start PM consolidated quick test (retention only) %% Preparation root@variscite-desktop:~# root@variscite-desktop:~# 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 [ 24.356353] pwrdm state mismatch(cam_pwrdm) 3 != 0 [ 24.361419] pwrdm state mismatch(ivahd_pwrdm) 3 != 1 [ 24.366760] pwrdm state mismatch(tesla_pwrdm) 3 != 1 [ 24.372039] 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:9,INA:0,ON:9,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 [ 26.610473] PM: Syncing filesystems ... [ 33.814941] init: failsafe-x main process (2125) terminated with status 1 [ 34.450592] done. [ 34.450714] PM: Preparing system for mem sleep [ 34.475250] Freezing user space processes ... (elapsed 0.006 seconds) done. [ 34.488616] Freezing remaining freezable tasks ... (elapsed 0.007 seconds) done. [ 34.499633] PM: Entering mem sleep [ 34.499633] Suspending console(s) (use no_console_suspend to debug) [ 34.526397] PM: suspend of devices complete after 16.326 msecs [ 34.528259] PM: late suspend of devices complete after 1.861 msecs [ 34.538208] omap_hwmod: gpio6: _wait_target_disable failed [ 34.541076] PM: noirq suspend of devices complete after 12.725 msecs [ 34.541076] Disabling non-boot CPUs ... [ 34.550231] CPU1: shutdown [ 34.552032] Powerdomain (core_pwrdm) didn't enter target state 1 [ 34.552032] Powerdomain (abe_pwrdm) didn't enter target state 1 [ 34.552032] Powerdomain (mpu_pwrdm) didn't enter target state 1 [ 34.552032] Powerdomain (l4per_pwrdm) didn't enter target state 1 [ 34.552032] Powerdomain (core_pwrdm) didn't enter target state 1 [ 34.552032] Powerdomain (abe_pwrdm) didn't enter target state 1 [ 34.552032] Powerdomain (mpu_pwrdm) didn't enter target state 1 [ 34.552032] Powerdomain (l4per_pwrdm) didn't enter target state 1 [ 34.552032] Could not enter target state in pm_suspend [ 34.552032] A possible cause could be an old bootloader - try u-boot >= v2012.07 [ 34.552032] hw-breakpoint: Failed to enable monitor mode on CPU 0. [ 34.552062] Enabling non-boot CPUs ... [ 34.554656] CPU1: Booted secondary processor [ 34.557464] CPU1 is up [ 34.559875] PM: noirq resume of devices complete after 0.946 msecs [ 34.563201] PM: early resume of devices complete after 3.326 msecs [ 34.665527] PM: resume of devices complete after 101.776 msecs [ 34.797058] PM: Finishing wakeup. [ 34.806732] Restarting tasks ... done. [ 34.821014] omap_hsmmc 480d5000.mmc: could not set regulator OCR (-22) 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:11,INA:0,ON:11,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 (10) 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 [ 36.823822] PM: Syncing filesystems ... done. [ 37.796295] PM: Preparing system for mem sleep [ 37.802215] Freezing user space processes ... (elapsed 0.003 seconds) done. [ 37.814147] Freezing remaining freezable tasks ... (elapsed 0.007 seconds) done. [ 37.824493] PM: Entering mem sleep [ 37.828094] Suspending console(s) (use no_console_suspend to debug) [ 37.846801] PM: suspend of devices complete after 8.728 msecs [ 37.846801] PM: late suspend of devices complete after 0.001 msecs [ 37.853851] omap_hwmod: gpio6: _wait_target_disable failed [ 37.860717] PM: noirq suspend of devices complete after 13.916 msecs [ 37.860717] Disabling non-boot CPUs ... [ 37.865020] CPU1: shutdown [ 37.865173] Powerdomain (core_pwrdm) didn't enter target state 1 [ 37.865173] Powerdomain (abe_pwrdm) didn't enter target state 1 [ 37.865173] Powerdomain (mpu_pwrdm) didn't enter target state 1 [ 37.865173] Powerdomain (l4per_pwrdm) didn't enter target state 1 [ 37.865173] Powerdomain (core_pwrdm) didn't enter target state 1 [ 37.865173] Powerdomain (abe_pwrdm) didn't enter target state 1 [ 37.865173] Powerdomain (mpu_pwrdm) didn't enter target state 1 [ 37.865173] Powerdomain (l4per_pwrdm) didn't enter target state 1 [ 37.865173] Could not enter target state in pm_suspend [ 37.865173] A possible cause could be an old bootloader - try u-boot >= v2012.07 [ 37.865173] hw-breakpoint: CPU 0 failed to disable vector catch [ 37.865173] Enabling non-boot CPUs ... [ 37.867431] CPU1: Booted secondary processor [ 37.868103] CPU1 is up [ 37.870422] PM: noirq resume of devices complete after 0.915 msecs [ 37.873901] PM: early resume of devices complete after 1.739 msecs [ 37.962493] PM: resume of devices complete after 88.531 msecs [ 38.098785] PM: Finishing wakeup. [ 38.102294] Restarting tasks ... done. [ 38.112060] omap_hsmmc 480d5000.mmc: could not set regulator OCR (-22) 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:13,INA:0,ON:13,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 (10) 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:15,INA:0,ON:15,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)