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  2  0 VAR-SOM-OM44 # VAR-SOM-OM44 # setenv bootargs 'console=ttyO2,115200n8 mem=1G@0x80000000 root=/dev/mmcblk1p2 ro rootwait 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-stk-om44 Sending: Transfer complete - CRC mode, 7(SOH)/3558(STX)/0(CAN) packets, 3 retries ## Total Size = 0x00379a51 = 3643985 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: 3643921 Bytes = 3.5 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] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Initializing cgroup subsys cpuacct [ 0.000000] Linux version 4.3.0-rc4-170972-gc4384a9 (paul@knihy) (gcc version 4.7.2 (Debian 4.7.2-5) ) #1 SMP Fri Oct 23 13:07:59 MDT 2015 [ 0.000000] CPU: ARMv7 Processor [412fc09a] revision 10 (ARMv7), cr=10c5387d [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache [ 0.000000] Machine model: Variscite VAR-STK-OM44 [ 0.000000] debug: ignoring loglevel setting. [ 0.000000] cma: Reserved 16 MiB at 0xbe800000 [ 0.000000] Memory policy: Data cache writealloc [ 0.000000] OMAP4: Map 0xbfe00000 to fe600000 for dram barrier [ 0.000000] On node 0 totalpages: 261632 [ 0.000000] free_area_init_node: node 0, pgdat c09c4280, node_mem_map eeef9000 [ 0.000000] Normal zone: 1710 pages used for memmap [ 0.000000] Normal zone: 0 pages reserved [ 0.000000] Normal zone: 194560 pages, LIFO batch:31 [ 0.000000] HighMem zone: 67072 pages, LIFO batch:15 [ 0.000000] OMAP4460 ES1.1 [ 0.000000] PERCPU: Embedded 14 pages/cpu @eee94000 s25088 r8192 d24064 u57344 [ 0.000000] pcpu-alloc: s25088 r8192 d24064 u57344 alloc=14*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 259922 [ 0.000000] Kernel command line: console=ttyO2,115200n8 mem=1G@0x80000000 root=/dev/mmcblk1p2 ro rootwait 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: 1001372K/1046528K available (6566K kernel code, 744K rwdata, 2228K rodata, 452K init, 8263K bss, 28772K reserved, 16384K cma-reserved, 251904K highmem) [ 0.000000] Virtual kernel memory layout: [ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB) [ 0.000000] fixmap : 0xffc00000 - 0xfff00000 (3072 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 - 0xc089ec78 (8796 kB) [ 0.000000] .init : 0xc089f000 - 0xc0910000 ( 452 kB) [ 0.000000] .data : 0xc0910000 - 0xc09ca218 ( 745 kB) [ 0.000000] .bss : 0xc09cd000 - 0xc11dee78 (8264 kB) [ 0.000000] Running RCU self tests [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU lockdep checking is enabled. [ 0.000000] Build-time adjustment of leaf fanout to 32. [ 0.000000] NR_IRQS:16 nr_irqs:16 16 [ 0.000000] L2C: platform modifies aux control register: 0x0e070000 -> 0x3e470000 [ 0.000000] L2C: DT/platform modifies aux control register: 0x0e070000 -> 0x3e470000 [ 0.000000] L2C-310 enabling early BRESP for Cortex-A9 [ 0.000000] OMAP L2C310: ROM does not support power control setting [ 0.000000] L2C-310 dynamic clock gating disabled, standby mode disabled [ 0.000000] L2C-310 cache controller enabled, 16 ways, 1024 kB [ 0.000000] L2C-310: CACHE_ID 0x410000c7, AUX_CTRL 0x4e470000 [ 0.000000] ti_dt_clocks_register: failed to lookup clock node dss_fck [ 0.000000] ti_dt_clocks_register: failed to lookup clock node dss_fck [ 0.000000] ti_dt_clocks_register: failed to lookup clock node bandgap_fclk [ 0.000000] OMAP clockevent source: timer1 at 32768 Hz [ 0.000000] clocksource: 32k_counter: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 58327039986419 ns [ 0.000000] sched_clock: 32 bits at 32kHz, resolution 30517ns, wraps every 65535999984741ns [ 0.000000] OMAP clocksource: 32k_counter at 32768 Hz [ 0.002105] Console: colour dummy device 80x30 [ 0.002166] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.002166] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.002166] ... MAX_LOCK_DEPTH: 48 [ 0.002197] ... MAX_LOCKDEP_KEYS: 8191 [ 0.002197] ... CLASSHASH_SIZE: 4096 [ 0.002197] ... MAX_LOCKDEP_ENTRIES: 32768 [ 0.002197] ... MAX_LOCKDEP_CHAINS: 65536 [ 0.002227] ... CHAINHASH_SIZE: 32768 [ 0.002227] memory used by lock dependency info: 5167 kB [ 0.002227] per task-struct memory footprint: 1536 bytes [ 0.002258] Calibrating delay loop... 1397.55 BogoMIPS (lpj=6987776) [ 0.080291] pid_max: default: 32768 minimum: 301 [ 0.080688] Security Framework initialized [ 0.080841] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes) [ 0.080871] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes) [ 0.084167] Initializing cgroup subsys io [ 0.084289] Initializing cgroup subsys memory [ 0.084381] Initializing cgroup subsys devices [ 0.084472] Initializing cgroup subsys freezer [ 0.084625] Initializing cgroup subsys perf_event [ 0.084686] CPU: Testing write buffer coherency: ok [ 0.086120] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 [ 0.086212] Setting up static identity map for 0x80008280 - 0x800082f0 [ 0.180297] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 [ 0.181060] Brought up 2 CPUs [ 0.181060] SMP: Total of 2 processors activated (2795.11 BogoMIPS). [ 0.181091] CPU: All CPU(s) started in SVC mode. [ 0.184509] devtmpfs: initialized [ 0.240264] VFP support v0.3: implementor 41 architecture 3 part 30 variant 9 rev 4 [ 0.245269] omap_hwmod: l3_main_3 using broken dt data from ocp [ 0.249847] omap_hwmod: l3_main_2 using broken dt data from ocp [ 0.432464] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns [ 0.435058] pinctrl core: initialized pinctrl subsystem [ 0.440460] NET: Registered protocol family 16 [ 0.445800] DMA: preallocated 256 KiB pool for atomic coherent allocations [ 0.470489] cpuidle: using governor ladder [ 0.500366] cpuidle: using governor menu [ 0.514190] gpiochip_add: registered GPIOs 0 to 31 on device: gpio [ 0.515045] OMAP GPIO hardware version 0.1 [ 0.516296] gpiochip_add: registered GPIOs 32 to 63 on device: gpio [ 0.518249] gpiochip_add: registered GPIOs 64 to 95 on device: gpio [ 0.520141] gpiochip_add: registered GPIOs 96 to 127 on device: gpio [ 0.522094] gpiochip_add: registered GPIOs 128 to 159 on device: gpio [ 0.523986] gpiochip_add: registered GPIOs 160 to 191 on device: gpio [ 0.545288] platform 4b501000.aes: Cannot lookup hwmod 'aes' [ 0.545837] platform 480a5000.des: Cannot lookup hwmod 'des' [ 0.553955] No ATAGs? [ 0.554046] hw-breakpoint: found 5 (+1 reserved) breakpoint and 1 watchpoint registers. [ 0.554077] hw-breakpoint: maximum watchpoint size is 4 bytes. [ 0.557250] OMAP DMA hardware revision 0.0 [ 0.615600] omap-dma-engine 4a056000.dma-controller: OMAP DMA engine driver [ 0.616638] of_get_named_gpiod_flags: can't parse 'gpio' property of node '/fixedregulator-vbat[0]' [ 0.617553] reg-fixed-voltage wl12xx_vmmc: could not find pctldev for node /ocp/l4@4a000000/scm@100000/pinmux@40/pinmux_wl12xx_ctrl_pins, deferring probe [ 0.621826] SCSI subsystem initialized [ 0.622344] libata version 3.00 loaded. [ 0.623077] usb_phy_generic hsusb1_phy: could not find pctldev for node /ocp/l4@4a000000/l4@300000/pinmux@1e040/pinmux_hsusbb1_phy_clk_pins, deferring probe [ 0.623626] omap_i2c 48070000.i2c: could not find pctldev for node /ocp/l4@4a000000/scm@100000/pinmux@40/pinmux_i2c1_pins, deferring probe [ 0.623718] omap_i2c 48060000.i2c: could not find pctldev for node /ocp/l4@4a000000/scm@100000/pinmux@40/pinmux_i2c3_pins, deferring probe [ 0.623840] omap_i2c 48350000.i2c: could not find pctldev for node /ocp/l4@4a000000/scm@100000/pinmux@40/pinmux_i2c4_pins, deferring probe [ 0.624176] pps_core: LinuxPPS API ver. 1 registered [ 0.624206] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.624267] PTP clock support registered [ 0.628570] clocksource: Switched to clocksource 32k_counter [ 0.769989] NET: Registered protocol family 2 [ 0.772125] TCP established hash table entries: 8192 (order: 3, 32768 bytes) [ 0.772308] TCP bind hash table entries: 8192 (order: 6, 294912 bytes) [ 0.774841] TCP: Hash tables configured (established 8192 bind 8192) [ 0.775177] UDP hash table entries: 512 (order: 3, 40960 bytes) [ 0.775512] UDP-Lite hash table entries: 512 (order: 3, 40960 bytes) [ 0.776611] NET: Registered protocol family 1 [ 0.778289] RPC: Registered named UNIX socket transport module. [ 0.778320] RPC: Registered udp transport module. [ 0.778320] RPC: Registered tcp transport module. [ 0.778320] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.783721] hw perfevents: enabled with armv7_cortex_a9 PMU driver, 7 counters available [ 0.789306] futex hash table entries: 512 (order: 3, 32768 bytes) [ 0.789642] audit: initializing netlink subsys (disabled) [ 0.789886] audit: type=2000 audit(0.770:1): initialized [ 0.793670] VFS: Disk quotas dquot_6.6.0 [ 0.793975] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 0.796661] NFS: Registering the id_resolver key type [ 0.797149] Key type id_resolver registered [ 0.797180] Key type id_legacy registered [ 0.797393] jffs2: version 2.2. (NAND) (SUMMARY) © 2001-2006 Red Hat, Inc. [ 0.802917] bounce: pool size: 64 pages [ 0.803039] io scheduler noop registered [ 0.803070] io scheduler deadline registered [ 0.803100] io scheduler cfq registered (default) [ 0.806732] pinctrl-single 4a100040.pinmux: 203 pins at pa fc100040 size 406 [ 0.807464] pinctrl-single 4a31e040.pinmux: 28 pins at pa fc31e040 size 56 [ 0.813934] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 0.820007] omap_uart 4806a000.serial: no wakeirq for uart0 [ 0.820007] of_get_named_gpiod_flags: can't parse 'rts-gpio' property of node '/ocp/serial@4806a000[0]' [ 0.820526] 4806a000.serial: ttyO0 at MMIO 0x4806a000 (irq = 223, base_baud = 3000000) is a OMAP UART0 [ 0.822418] omap_uart 4806c000.serial: no wakeirq for uart1 [ 0.822448] of_get_named_gpiod_flags: can't parse 'rts-gpio' property of node '/ocp/serial@4806c000[0]' [ 0.822692] 4806c000.serial: ttyO1 at MMIO 0x4806c000 (irq = 224, base_baud = 3000000) is a OMAP UART1 [ 0.823852] omap_uart 48020000.serial: no wakeirq for uart2 [ 0.823883] of_get_named_gpiod_flags: can't parse 'rts-gpio' property of node '/ocp/serial@48020000[0]' [ 0.824127] 48020000.serial: ttyO2 at MMIO 0x48020000 (irq = 225, base_baud = 3000000) is a OMAP UART2 [ 1.839355] console [ttyO2] enabled [ 1.876281] brd: module loaded [ 1.901519] loop: module loaded [ 1.907836] mtdoops: mtd device (mtddev=name/number) must be supplied [ 1.921691] of_get_named_gpiod_flags: can't parse 'reset-gpios' property of node '/ocp/spi@48098000/eth@0[0]' [ 1.932128] spi1.0 supply vdd-io not found, using dummy regulator [ 1.939025] spi1.0 supply vdd not found, using dummy regulator [ 1.945281] ks8851 spi1.0: message enable is 0 [ 1.956420] ks8851 spi1.0 eth0: revision 1, MAC c6:a2:3a:75:ab:15, IRQ 202, no EEPROM [ 1.969024] mousedev: PS/2 mouse device common for all mice [ 1.974884] i2c /dev entries driver [ 1.980133] omap_hsmmc 4809c000.mmc: GPIO lookup for consumer cd [ 1.986450] omap_hsmmc 4809c000.mmc: using device tree for GPIO lookup [ 1.993316] of_get_named_gpiod_flags: can't parse 'cd-gpios' property of node '/ocp/mmc@4809c000[0]' [ 2.002899] of_get_named_gpiod_flags: can't parse 'cd-gpio' property of node '/ocp/mmc@4809c000[0]' [ 2.012390] omap_hsmmc 4809c000.mmc: using lookup tables for GPIO lookup [ 2.019592] omap_hsmmc 4809c000.mmc: lookup for GPIO cd failed [ 2.025726] omap_hsmmc 4809c000.mmc: GPIO lookup for consumer wp [ 2.032043] omap_hsmmc 4809c000.mmc: using device tree for GPIO lookup [ 2.038909] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@4809c000[0]' [ 2.048492] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@4809c000[0]' [ 2.057952] omap_hsmmc 4809c000.mmc: using lookup tables for GPIO lookup [ 2.065002] omap_hsmmc 4809c000.mmc: lookup for GPIO wp failed [ 2.100677] omap_hsmmc 480d1000.mmc: GPIO lookup for consumer wp [ 2.106964] omap_hsmmc 480d1000.mmc: using device tree for GPIO lookup [ 2.113830] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@480d1000[0]' [ 2.123443] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@480d1000[0]' [ 2.132934] omap_hsmmc 480d1000.mmc: using lookup tables for GPIO lookup [ 2.139953] omap_hsmmc 480d1000.mmc: lookup for GPIO wp failed [ 2.169006] omap_hsmmc 480d5000.mmc: GPIO lookup for consumer cd [ 2.175323] omap_hsmmc 480d5000.mmc: using device tree for GPIO lookup [ 2.182220] of_get_named_gpiod_flags: parsed 'cd-gpios' property of node '/ocp/mmc@480d5000[0]' - status (0) [ 2.192596] omap_hsmmc 480d5000.mmc: Got CD GPIO [ 2.197448] omap_hsmmc 480d5000.mmc: GPIO lookup for consumer wp [ 2.203765] omap_hsmmc 480d5000.mmc: using device tree for GPIO lookup [ 2.210632] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@480d5000[0]' [ 2.220214] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@480d5000[0]' [ 2.229705] omap_hsmmc 480d5000.mmc: using lookup tables for GPIO lookup [ 2.236724] omap_hsmmc 480d5000.mmc: lookup for GPIO wp failed [ 2.289489] ledtrig-cpu: registered to indicate activity on CPUs [ 2.297058] oprofile: using arm/armv7-ca9 [ 2.302490] Initializing XFRM netlink socket [ 2.307464] NET: Registered protocol family 10 [ 2.315307] sit: IPv6 over IPv4 tunneling driver [ 2.322479] NET: Registered protocol family 17 [ 2.327209] NET: Registered protocol family 15 [ 2.332305] Key type dns_resolver registered [ 2.337066] twl: not initialized [ 2.340484] twl6030_uv_to_vsel:OUT OF RANGE! non mapped vsel for 1375000 Vs max 1316660 [ 2.348907] twl6030_uv_to_vsel:OUT OF RANGE! non mapped vsel for 1375000 Vs max 1316660 [ 2.357299] twl6030_uv_to_vsel:OUT OF RANGE! non mapped vsel for 1375000 Vs max 1316660 [ 2.365722] twl6030_uv_to_vsel:OUT OF RANGE! non mapped vsel for 1375000 Vs max 1316660 [ 2.374145] twl6030_uv_to_vsel:OUT OF RANGE! non mapped vsel for 1375000 Vs max 1316660 [ 2.382537] twl6030_uv_to_vsel:OUT OF RANGE! non mapped vsel for 1375000 Vs max 1316660 [ 2.390960] twl6030_uv_to_vsel:OUT OF RANGE! non mapped vsel for 1410000 Vs max 1316660 [ 2.399383] omap2_set_init_voltage: unable to find boot up OPP for vdd_mpu [ 2.406585] omap2_set_init_voltage: unable to set vdd_mpu [ 2.412292] omap2_set_init_voltage: unable to find boot up OPP for vdd_core [ 2.419586] omap2_set_init_voltage: unable to set vdd_core [ 2.425354] omap2_set_init_voltage: unable to find boot up OPP for vdd_iva [ 2.432586] omap2_set_init_voltage: unable to set vdd_iva [ 2.440521] Power Management for TI OMAP4+ devices. [ 2.445648] OMAP4 PM: u-boot >= v2012.07 is required for full PM support [ 2.453033] ThumbEE CPU extension supported. [ 2.458679] Registering SWP/SWPB emulation handler [ 2.458709] SmartReflex Class3 initialized [ 2.473175] of_get_named_gpiod_flags: parsed 'gpio' property of node '/wl12xx_vmmc[0]' - status (0) [ 2.485198] usb_phy_generic hsusb1_phy: GPIO lookup for consumer reset [ 2.492156] usb_phy_generic hsusb1_phy: using device tree for GPIO lookup [ 2.499328] of_get_named_gpiod_flags: parsed 'reset-gpios' property of node '/hsusb1_phy[0]' - status (0) [ 2.509460] no flags found for reset [ 2.513214] usb_phy_generic hsusb1_phy: GPIO lookup for consumer vbus-detect [ 2.520599] usb_phy_generic hsusb1_phy: using device tree for GPIO lookup [ 2.523834] of_get_named_gpiod_flags: can't parse 'vbus-detect-gpios' property of node '/hsusb1_phy[0]' [ 2.537567] of_get_named_gpiod_flags: can't parse 'vbus-detect-gpio' property of node '/hsusb1_phy[0]' [ 2.547363] usb_phy_generic hsusb1_phy: using lookup tables for GPIO lookup [ 2.554687] usb_phy_generic hsusb1_phy: lookup for GPIO vbus-detect failed [ 2.569488] mmc0: host does not support reading read-only switch, assuming write-enable [ 2.569488] Skipping twl internal clock init and using bootloader value (unknown osc rate) [ 2.587341] hw-breakpoint: Failed to enable monitor mode on CPU 0. [ 2.594726] mmc0: new high speed SDHC card at address b368 [ 2.603363] mmcblk0: mmc0:b368 USD 3.75 GiB [ 2.609405] twl 0-0048: PIH (irq 327) nested IRQs [ 2.641174] mmcblk0: error -84 transferring data, sector 0, nr 8, cmd response 0x900, card status 0x0 [ 2.665039] VUSIM: failed to get the current voltage(-22) [ 2.674743] twl_reg 48070000.i2c:twl@48:regulator-vusim: can't register VUSIM, -22 [ 2.682678] twl_reg: probe of 48070000.i2c:twl@48:regulator-vusim failed with error -22 [ 2.701599] twl6040 0-004b: clk32k is not handled [ 2.713684] of_get_named_gpiod_flags: parsed 'ti,audpwron-gpio' property of node '/ocp/i2c@48070000/twl@4b[0]' - status (0) [ 2.725708] mmc0: tried to reset card [ 2.730590] mmcblk0: p1 p2 [ 2.737365] omap_i2c 48070000.i2c: bus 0 rev0.11 at 400 kHz [ 2.746612] omap_i2c 48060000.i2c: bus 2 rev0.11 at 400 kHz [ 2.755187] omap_i2c 48350000.i2c: bus 3 rev0.11 at 400 kHz [ 2.761291] omap_hsmmc 4809c000.mmc: GPIO lookup for consumer cd [ 2.768310] omap_hsmmc 4809c000.mmc: using device tree for GPIO lookup [ 2.775177] of_get_named_gpiod_flags: can't parse 'cd-gpios' property of node '/ocp/mmc@4809c000[0]' [ 2.784790] of_get_named_gpiod_flags: can't parse 'cd-gpio' property of node '/ocp/mmc@4809c000[0]' [ 2.794281] omap_hsmmc 4809c000.mmc: using lookup tables for GPIO lookup [ 2.801330] omap_hsmmc 4809c000.mmc: lookup for GPIO cd failed [ 2.802734] omap_hsmmc 4809c000.mmc: GPIO lookup for consumer wp [ 2.813751] omap_hsmmc 4809c000.mmc: using device tree for GPIO lookup [ 2.820648] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@4809c000[0]' [ 2.830230] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@4809c000[0]' [ 2.839752] omap_hsmmc 4809c000.mmc: using lookup tables for GPIO lookup [ 2.846771] omap_hsmmc 4809c000.mmc: lookup for GPIO wp failed [ 2.852935] ------------[ cut here ]------------ [ 2.859619] WARNING: CPU: 1 PID: 65 at drivers/regulator/core.c:2104 _regulator_disable+0x140/0x184() [ 2.869293] unbalanced disables for pbias_mmc_omap4 [ 2.874420] Modules linked in: [ 2.874420] CPU: 1 PID: 65 Comm: kworker/u4:1 Not tainted 4.3.0-rc4-170972-gc4384a9 #1 [ 2.885955] Hardware name: Generic OMAP4 (Flattened Device Tree) [ 2.888549] Workqueue: deferwq deferred_probe_work_func [ 2.897796] [] (unwind_backtrace) from [] (show_stack+0x10/0x14) [ 2.905944] [] (show_stack) from [] (dump_stack+0x80/0x9c) [ 2.913574] [] (dump_stack) from [] (warn_slowpath_common+0x78/0xb4) [ 2.922088] [] (warn_slowpath_common) from [] (warn_slowpath_fmt+0x30/0x40) [ 2.931213] [] (warn_slowpath_fmt) from [] (_regulator_disable+0x140/0x184) [ 2.940368] [] (_regulator_disable) from [] (regulator_disable+0x34/0x60) [ 2.949340] [] (regulator_disable) from [] (omap_hsmmc_set_power+0x158/0x1d4) [ 2.958679] [] (omap_hsmmc_set_power) from [] (omap_hsmmc_set_ios+0x204/0x264) [ 2.958679] [] (omap_hsmmc_set_ios) from [] (mmc_set_initial_state+0x48/0x4c) [ 2.977386] [] (mmc_set_initial_state) from [] (mmc_power_up+0x3c/0x104) [ 2.978576] [] (mmc_power_up) from [] (mmc_start_host+0x40/0x6c) [ 2.994384] [] (mmc_start_host) from [] (mmc_add_host+0x5c/0x84) [ 3.002532] [] (mmc_add_host) from [] (omap_hsmmc_probe+0x5cc/0xa10) [ 3.011047] [] (omap_hsmmc_probe) from [] (platform_drv_probe+0x48/0xa4) [ 3.019927] [] (platform_drv_probe) from [] (driver_probe_device+0x1dc/0x2a0) [ 3.029266] [] (driver_probe_device) from [] (bus_for_each_drv+0x44/0x8c) [ 3.037078] [] (bus_for_each_drv) from [] (__device_attach+0xa4/0x108) [ 3.046905] [] (__device_attach) from [] (bus_probe_device+0x88/0x90) [ 3.055511] [] (bus_probe_device) from [] (deferred_probe_work_func+0x60/0x90) [ 3.064941] [] (deferred_probe_work_func) from [] (process_one_work+0x1b4/0x4b0) [ 3.074523] [] (process_one_work) from [] (worker_thread+0x154/0x470) [ 3.083129] [] (worker_thread) from [] (kthread+0xd4/0xf0) [ 3.090728] [] (kthread) from [] (ret_from_fork+0x14/0x24) [ 3.090759] ---[ end trace 5c94e2844367ebc4 ]--- [ 3.103179] omap_hsmmc 4809c000.mmc: pbias reg disable fail [ 3.148712] hw-breakpoint: CPU 0 failed to disable vector catch [ 3.155273] omap_hsmmc 480d1000.mmc: GPIO lookup for consumer wp [ 3.155273] omap_hsmmc 480d1000.mmc: using device tree for GPIO lookup [ 3.169067] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@480d1000[0]' [ 3.178680] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@480d1000[0]' [ 3.188171] omap_hsmmc 480d1000.mmc: using lookup tables for GPIO lookup [ 3.188171] omap_hsmmc 480d1000.mmc: lookup for GPIO wp failed [ 3.236572] mmc1: host does not support reading read-only switch, assuming write-enable [ 3.247375] mmc1: new high speed SDHC card at address 0007 [ 3.254760] mmcblk1: mmc1:0007 SD08G 7.42 GiB [ 3.261810] mmcblk1: p1 p2 [ 3.330627] hctosys: unable to open rtc device (rtc0) [ 3.336303] sr_init: No PMIC hook to init smartreflex [ 3.341674] omap_hsmmc 480d1000.mmc: card claims to support voltages below defined range [ 3.341674] smartreflex smartreflex.0: omap_sr_probe: SmartReflex driver initialized [ 3.342376] smartreflex smartreflex.1: omap_sr_probe: SmartReflex driver initialized [ 3.343200] smartreflex smartreflex.2: omap_sr_probe: SmartReflex driver initialized [ 3.386779] pbias_mmc_omap4: disabling [ 3.391967] VAUX1_6030: disabling [ 3.397979] VMMC: disabling [ 3.401428] mmc2: queuing unknown CIS tuple 0x91 (3 bytes) [ 3.408721] VDAC: disabling [ 3.412719] VANA: disabling [ 3.416717] VUSB: disabling [ 3.421874] mmc2: new SDIO card at address 0001 [ 3.483642] mmcblk1: error -110 sending status command, retrying [ 3.516479] mmcblk1: error -110 sending status command, retrying [ 3.549316] mmcblk1: error -110 sending status command, aborting [ 3.643371] mmc1: tried to reset card [ 3.648681] EXT2-fs (mmcblk1p2): error: couldn't mount because of unsupported optional features (244) [ 3.661132] EXT4-fs (mmcblk1p2): couldn't mount as ext3 due to feature incompatibilities [ 3.694244] EXT4-fs (mmcblk1p2): INFO: recovery required on readonly filesystem [ 3.694244] EXT4-fs (mmcblk1p2): write access will be enabled during recovery [ 7.099578] EXT4-fs (mmcblk1p2): recovery complete [ 7.406982] EXT4-fs (mmcblk1p2): mounted filesystem with ordered data mode. Opts: (null) [ 7.415588] VFS: Mounted root (ext4 filesystem) readonly on device 179:10. [ 7.428192] devtmpfs: mounted [ 7.431793] Freeing unused kernel memory: 452K (c089f000 - c0910000) [ 7.741363] random: init urandom read with 28 bits of entropy available [ 7.761718] init: Failed to create pty - disabling logging for job [ 7.772064] init: Temporary process spawn error: No space left on device [ 7.823089] init: Failed to create pty - disabling logging for job [ 7.830139] init: Temporary process spawn error: No space left on device [ 7.858825] init: Failed to create pty - disabling logging for job [ 7.858825] init: Temporary process spawn error: No space left on device [ 7.878326] init: Failed to create pty - disabling logging for job [ 7.884979] init: Temporary process spawn error: No space left on device [ 7.969635] init: hwclock main process (84) terminated with status 1 [ 8.040435] init: ureadahead main process (85) terminated with status 5 [ 8.243041] init: Failed to create pty - disabling logging for job [ 8.249725] init: Temporary process spawn error: No space left on device [ 8.290924] init: Failed to create pty - disabling logging for job [ 8.297851] init: Temporary process spawn error: No space left on device [ 8.390930] init: Failed to create pty - disabling logging for job [ 8.397644] init: Temporary process spawn error: No space left on device [ 8.928741] udevd[140]: starting version 175 fsck from util-linux 2.20.1 /dev/mmcblk1p2: clean, 177412/963584 files, 2990326/7708672 blocks [ 12.060485] init: udev-fallback-graphics main process (390) terminated with status 1 [ 12.255950] EXT4-fs (mmcblk1p2): re-mounted. Opts: errors=remount-ro [ 12.302185] init: plymouth main process (86) killed by SEGV signal [ 12.326416] init: plymouth-splash main process (408) 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 [ 12.700073] random: nonblocking pool is initialized [ 12.963745] init: plymouth-log main process (489) terminated with status 1 [ 13.003967] init: failsafe main process (491) killed by TERM signal speech-dispatcher disabled; edit /etc/default/speech-dispatcher saned disabled; edit /etc/default/saned [ 13.960845] 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 [ 14.143341] init: alsa-restore main process (550) terminated with status 19 FATAL: Could not load /lib/modules/4.3.0-rc4-170972-gc4384a9/modules.dep: No such file or directory [ 14.620178] init: plymouth-upstart-bridge main process (616) terminated with status 1 [ 14.699371] init: hybrid-gfx main process (621) terminated with status 1 [ 15.441436] init: bluetooth main process (634) terminated with status 1 [ 15.454162] init: bluetooth main process ended, respawning [ 16.056488] init: bluetooth main process (672) terminated with status 1 [ 16.066802] init: bluetooth main process ended, respawning Ubuntu 12.04.1 LTS variscite-desktop ttyO2 variscite-desktop login: [ 16.466094] init: bluetooth main process (699) terminated with status 1 [ 16.508728] init: bluetooth main process ended, respawning [ 16.922393] init: bluetooth main process (730) terminated with status 1 [ 16.939422] init: bluetooth main process ended, respawning [ 16.998107] init: lightdm main process (646) terminated with status 1 [ 17.169525] init: bluetooth main process (749) terminated with status 1 [ 17.180328] init: bluetooth main process ended, respawning [ 17.368530] init: bluetooth main process (766) terminated with status 1 [ 17.377899] 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: [ 17.607604] init: bluetooth main process (783) terminated with status 1 [ 17.619140] init: bluetooth main process ended, respawning root [ 17.802642] init: bluetooth main process (799) terminated with status 1 [ 17.813659] init: bluetooth main process ended, respawning Last login: Thu Jan 1 02:00:17 IST 1970 on ttyO2 [ 18.136505] init: bluetooth main process (824) terminated with status 1 [ 18.149566] init: bluetooth main process ended, respawning [ 18.422393] init: bluetooth main process (863) terminated with status 1 [ 18.438293] init: bluetooth main process ended, respawning [ 18.760223] init: bluetooth main process (903) terminated with status 1 [ 18.769012] init: bluetooth respawning too fast, stopped Welcome to Ubuntu 12.04.1 LTS (GNU/Linux 4.3.0-rc4-170972-gc4384a9 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:~# mkdir -p /sys; 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:~# mkdir -p /debug; 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:~# for u in `ls -1d /sys/bus/platform/drivers/omap_uart/* .serial | paste -s -d' '`; do ls -l $u/power/autosuspend_delay_ms; cat $u/power /autosuspend_delay_ms; done -rw-r--r-- 1 root root 4096 Jan 1 02:00 /sys/bus/platform/drivers/omap_uart/48020000.serial/power/autosuspend_delay_ms -1 -rw-r--r-- 1 root root 4096 Jan 1 02:00 /sys/bus/platform/drivers/omap_uart/4806a000.serial/power/autosuspend_delay_ms -1 -rw-r--r-- 1 root root 4096 Jan 1 02:00 /sys/bus/platform/drivers/omap_uart/4806c000.serial/power/autosuspend_delay_ms -1 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 cefuse_pwrdm (OFF),OFF:2,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0 always_on_core_pwrdm (ON),OFF:354,RET:0,INA:0,ON:355,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:0,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:142,INA:0,ON:143,RET-LOGIC-OFF:130,RET-MEMBANK1-OFF:142,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0 cpu1_pwrdm (ON),OFF:354,RET:0,INA:0,ON:355,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cpu0_pwrdm (ON),OFF:278,RET:0,INA:0,ON:279,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 tesla_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 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 (7) 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:~# for u in `ls -1d /sys/class/tty/ttyO* | paste -s -d' ' `; do echo enabled > $u/power/wakeup; done root@variscite-desktop:~# %% Start retention double suspend/resume UART wakeup test root@variscite-desktop:~# for u in `ls -1d /sys/class/tty/ttyO* | paste -s -d' ' `; do echo auto > $u/power/control; done root@variscite-desktop:~# root@variscite-desktop:~# for u in `ls -1d /sys/class/tty/ttyO* | paste -s -d' ' `; do ls -l $u/power/wakeup; cat $u/power/wakeup; done -rw-r--r-- 1 root root 4096 Jan 1 02:00 /sys/class/tty/ttyO0/power/wakeup enabled -rw-r--r-- 1 root root 4096 Jan 1 02:00 /sys/class/tty/ttyO1/power/wakeup enabled -rw-r--r-- 1 root root 4096 Jan 1 02:00 /sys/class/tty/ttyO2/power/wakeup enabled root@variscite-desktop:~# root@variscite-desktop:~# for u in `ls -1d /sys/class/tty/ttyO* | paste -s -d' ' `; do ls -l $u/power/control; cat $u/power/control; done -rw-r--r-- 1 root root 4096 Jan 1 02:00 /sys/class/tty/ttyO0/power/control auto -rw-r--r-- 1 root root 4096 Jan 1 02:00 /sys/class/tty/ttyO1/power/control auto -rw-r--r-- 1 root root 4096 Jan 1 02:00 /sys/class/tty/ttyO2/power/control auto root@variscite-desktop:~# root@variscite-desktop:~# echo mem > /sys/power/state [ 29.449920] PM: Syncing filesystems ... [ 33.849395] init: failsafe-x main process (744) terminated with status 1 [ 36.936706] done. [ 36.938812] PM: Preparing system for sleep (mem) [ 36.958587] Freezing user space processes ... (elapsed 0.012 seconds) done. [ 36.970825] Freezing remaining freezable tasks ... (elapsed 0.003 seconds) done. [ 36.986480] PM: Suspending system (mem) [ 36.990539] Suspending console(s) (use no_console_suspend to debug) [ 37.013580] PM: suspend of devices complete after 13.122 msecs [ 37.013580] PM: late suspend of devices complete after 0.001 msecs [ 37.029754] omap_hwmod: gpio6: _wait_target_disable failed [ 37.030517] PM: noirq suspend of devices complete after 13.122 msecs [ 37.030517] Disabling non-boot CPUs ... [ 37.040222] [ 37.040222] =============================== [ 37.040222] [ INFO: suspicious RCU usage. ] [ 37.040222] 4.3.0-rc4-170972-gc4384a9 #1 Tainted: G W [ 37.040222] ------------------------------- [ 37.040252] kernel/sched/fair.c:4872 suspicious rcu_dereference_check() usage! [ 37.040252] [ 37.040252] other info that might help us debug this: [ 37.040252] [ 37.040252] [ 37.040252] RCU used illegally from offline CPU! [ 37.040252] rcu_scheduler_active = 1, debug_locks = 0 [ 37.040252] 3 locks held by swapper/1/0: [ 37.040252] #0: ((cpu_died).wait.lock){......}, at: [] complete+0x14/0x44 [ 37.040252] #1: (&p->pi_lock){-.-.-.}, at: [] try_to_wake_up+0x30/0x450 [ 37.040344] #2: (rcu_read_lock){......}, at: [] select_task_rq_fair+0x44/0xb58 [ 37.040344] [ 37.040344] stack backtrace: [ 37.040374] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G W 4.3.0-rc4-170972-gc4384a9 #1 [ 37.040374] Hardware name: Generic OMAP4 (Flattened Device Tree) [ 37.040374] [] (unwind_backtrace) from [] (show_stack+0x10/0x14) [ 37.040374] [] (show_stack) from [] (dump_stack+0x80/0x9c) [ 37.040466] [] (dump_stack) from [] (select_task_rq_fair+0x970/0xb58) [ 37.040466] [] (select_task_rq_fair) from [] (try_to_wake_up+0x13c/0x450) [ 37.040496] [] (try_to_wake_up) from [] (__wake_up_common+0x4c/0x80) [ 37.040496] [] (__wake_up_common) from [] (__wake_up_locked+0x14/0x1c) [ 37.040527] [] (__wake_up_locked) from [] (complete+0x34/0x44) [ 37.040527] [] (complete) from [] (arch_cpu_idle_dead+0x34/0x9c) [ 37.040557] [] (arch_cpu_idle_dead) from [] (cpu_startup_entry+0x32c/0x374) [ 37.040557] [] (cpu_startup_entry) from [<800095ec>] (0x800095ec) [ 37.040557] CPU1: shutdown [ 37.080139] Powerdomain (core_pwrdm) didn't enter target state 1 [ 37.080139] Powerdomain (abe_pwrdm) didn't enter target state 1 [ 37.080139] Powerdomain (mpu_pwrdm) didn't enter target state 1 [ 37.080139] Powerdomain (l4per_pwrdm) didn't enter target state 1 [ 37.080139] Could not enter target state in pm_suspend [ 37.080139] A possible cause could be an old bootloader - try u-boot >= v2012.07 [ 37.080169] Enabling non-boot CPUs ... [ 37.140533] CPU1 is up [ 37.141693] PM: noirq resume of devices complete after 1.159 msecs [ 37.143157] PM: early resume of devices complete after 0.001 msecs [ 37.432708] PM: resume of devices complete after 289.550 msecs [ 37.709991] PM: Finishing wakeup. [ 37.713470] 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:837,RET:0,INA:0,ON:838,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: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:142,INA:0,ON:143,RET-LOGIC-OFF:130,RET-MEMBANK1-OFF:142,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0 cpu1_pwrdm (ON),OFF:837,RET:0,INA:0,ON:838,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cpu0_pwrdm (ON),OFF:643,RET:0,INA:0,ON:644,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 (8) 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.331146] PM: Syncing filesystems ... done. [ 41.862579] PM: Preparing system for sleep (mem) [ 41.869598] Freezing user space processes ... (elapsed 0.002 seconds) done. [ 41.879272] Freezing remaining freezable tasks ... (elapsed 0.007 seconds) done. [ 41.888885] PM: Suspending system (mem) [ 41.888885] Suspending console(s) (use no_console_suspend to debug) [ 41.906707] PM: suspend of devices complete after 6.500 msecs [ 41.906707] PM: late suspend of devices complete after 0.001 msecs [ 41.909973] omap_hwmod: gpio6: _wait_target_disable failed [ 41.916687] PM: noirq suspend of devices complete after 9.979 msecs [ 41.916900] Disabling non-boot CPUs ... [ 41.917938] CPU1: shutdown [ 41.969879] Powerdomain (core_pwrdm) didn't enter target state 1 [ 41.969879] Powerdomain (abe_pwrdm) didn't enter target state 1 [ 41.969879] Powerdomain (mpu_pwrdm) didn't enter target state 1 [ 41.969879] Powerdomain (l4per_pwrdm) didn't enter target state 1 [ 41.969879] Could not enter target state in pm_suspend [ 41.969879] A possible cause could be an old bootloader - try u-boot >= v2012.07 [ 41.969909] Enabling non-boot CPUs ... [ 42.022399] CPU1 is up [ 42.023529] PM: noirq resume of devices complete after 1.129 msecs [ 42.024963] PM: early resume of devices complete after 0.457 msecs [ 42.442321] PM: resume of devices complete after 417.358 msecs [ 42.538940] PM: Finishing wakeup. [ 42.538940] 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:944,RET:0,INA:0,ON:945,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:17,INA:0,ON:17,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:142,INA:0,ON:143,RET-LOGIC-OFF:130,RET-MEMBANK1-OFF:142,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0 cpu1_pwrdm (ON),OFF:944,RET:0,INA:0,ON:945,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cpu0_pwrdm (ON),OFF:726,RET:0,INA:0,ON:727,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 (8) 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:~# for u in `ls -1d /sys/bus/platform/drivers/omap_uart/* .serial | paste -s -d' '`; do ls -l $u/power/autosuspend_delay_ms; cat $u/power /autosuspend_delay_ms; done -rw-r--r-- 1 root root 4096 Jan 1 02:00 /sys/bus/platform/drivers/omap_uart/48020000.serial/power/autosuspend_delay_ms 3000 -rw-r--r-- 1 root root 4096 Jan 1 02:00 /sys/bus/platform/drivers/omap_uart/4806a000.serial/power/autosuspend_delay_ms 3000 -rw-r--r-- 1 root root 4096 Jan 1 02:00 /sys/bus/platform/drivers/omap_uart/4806c000.serial/power/autosuspend_delay_ms 3000 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:1138,RET:0,INA:0,ON:1139,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:19,INA:0,ON:19,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:142,INA:0,ON:143,RET-LOGIC-OFF:130,RET-MEMBANK1-OFF:142,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0 cpu1_pwrdm (ON),OFF:1138,RET:0,INA:0,ON:1139,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cpu0_pwrdm (ON),OFF:892,RET:0,INA:0,ON:893,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 (4) 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:~# for u in `ls -1d /sys/bus/platform/drivers/omap_uart/* .serial | paste -s -d' '`; do ls -l $u/power/autosuspend_delay_ms; cat $u/power /autosuspend_delay_ms; done -rw-r--r-- 1 root root 4096 Jan 1 02:01 /sys/bus/platform/drivers/omap_uart/48020000.serial/power/autosuspend_delay_ms -1 -rw-r--r-- 1 root root 4096 Jan 1 02:01 /sys/bus/platform/drivers/omap_uart/4806a000.serial/power/autosuspend_delay_ms -1 -rw-r--r-- 1 root root 4096 Jan 1 02:01 /sys/bus/platform/drivers/omap_uart/4806c000.serial/power/autosuspend_delay_ms -1 root@variscite-desktop:~# root@variscite-desktop:~# %% End retention dynamic idle UART wakeup test %% End PM consolidated quick test (retention only)