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 m - CRC mode, 8(SOH)/3406(STX)/0(CAN) packets, 3 retries ## Total Size = 0x00353b00 = 3488512 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: 3488448 Bytes = 3.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] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Initializing cgroup subsys cpuacct [ 0.000000] Linux version 4.1.0-143712-gb953c0d (paul@knihy) (gcc version 4.7.2 (Debian 4.7.2-5) ) #1 SMP Mon Jun 22 18:22:37 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] On node 0 totalpages: 261888 [ 0.000000] free_area_init_node: node 0, pgdat c095a780, 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: 67328 pages, LIFO batch:15 [ 0.000000] OMAP4460 ES1.1 [ 0.000000] PERCPU: Embedded 13 pages/cpu @eee96000 s22976 r8192 d22080 u53248 [ 0.000000] pcpu-alloc: s22976 r8192 d22080 u53248 alloc=13*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 260178 [ 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: 1002872K/1047552K available (6215K kernel code, 739K rwdata, 2172K rodata, 440K init, 8220K bss, 28296K reserved, 16384K cma-reserved, 252928K 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 - 0xc08390b4 (8389 kB) [ 0.000000] .init : 0xc083a000 - 0xc08a8000 ( 440 kB) [ 0.000000] .data : 0xc08a8000 - 0xc0960dc0 ( 740 kB) [ 0.000000] .bss : 0xc0963000 - 0xc116a350 (8221 kB) [ 0.000000] Running RCU self tests [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU lockdep checking is enabled. [ 0.000000] Additional per-CPU info printed with stalls. [ 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 ID prefetch enabled, offset 1 lines [ 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 0x7e470000 [ 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.000030] OMAP clocksource: 32k_counter at 32768 Hz [ 0.002105] Console: colour dummy device 80x30 [ 0.002136] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.002166] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.002166] ... MAX_LOCK_DEPTH: 48 [ 0.002166] ... MAX_LOCKDEP_KEYS: 8191 [ 0.002197] ... CLASSHASH_SIZE: 4096 [ 0.002197] ... MAX_LOCKDEP_ENTRIES: 32768 [ 0.002197] ... MAX_LOCKDEP_CHAINS: 65536 [ 0.002197] ... CHAINHASH_SIZE: 32768 [ 0.002227] memory used by lock dependency info: 5167 kB [ 0.002227] per task-struct memory footprint: 1152 bytes [ 0.002258] Calibrating delay loop... 1397.55 BogoMIPS (lpj=6987776) [ 0.080352] pid_max: default: 32768 minimum: 301 [ 0.080718] Security Framework initialized [ 0.080871] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes) [ 0.080902] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes) [ 0.084136] Initializing cgroup subsys blkio [ 0.084197] Initializing cgroup subsys memory [ 0.084259] Initializing cgroup subsys devices [ 0.084381] Initializing cgroup subsys freezer [ 0.084503] Initializing cgroup subsys perf_event [ 0.084564] CPU: Testing write buffer coherency: ok [ 0.085998] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 [ 0.086090] Setting up static identity map for 0x80008280 - 0x800082f0 [ 0.180297] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 [ 0.181152] Brought up 2 CPUs [ 0.181182] SMP: Total of 2 processors activated (2795.11 BogoMIPS). [ 0.181182] CPU: All CPU(s) started in SVC mode. [ 0.184661] devtmpfs: initialized [ 0.241302] VFP support v0.3: implementor 41 architecture 3 part 30 variant 9 rev 4 [ 0.246337] omap_hwmod: l3_main_3 using broken dt data from ocp [ 0.251068] omap_hwmod: l3_main_2 using broken dt data from ocp [ 0.435791] clocksource jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns [ 0.438049] pinctrl core: initialized pinctrl subsystem [ 0.443267] NET: Registered protocol family 16 [ 0.448883] DMA: preallocated 256 KiB pool for atomic coherent allocations [ 0.480529] cpuidle: using governor ladder [ 0.510345] cpuidle: using governor menu [ 0.523834] gpiochip_add: registered GPIOs 0 to 31 on device: gpio [ 0.524688] OMAP GPIO hardware version 0.1 [ 0.526031] gpiochip_add: registered GPIOs 32 to 63 on device: gpio [ 0.527984] gpiochip_add: registered GPIOs 64 to 95 on device: gpio [ 0.529846] gpiochip_add: registered GPIOs 96 to 127 on device: gpio [ 0.531860] gpiochip_add: registered GPIOs 128 to 159 on device: gpio [ 0.533721] gpiochip_add: registered GPIOs 160 to 191 on device: gpio [ 0.554840] platform 4b501000.aes: Cannot lookup hwmod 'aes' [ 0.555358] platform 480a5000.des: Cannot lookup hwmod 'des' [ 0.563354] No ATAGs? [ 0.563446] hw-breakpoint: found 5 (+1 reserved) breakpoint and 1 watchpoint registers. [ 0.563476] hw-breakpoint: maximum watchpoint size is 4 bytes. [ 0.566558] OMAP DMA hardware revision 0.0 [ 0.650543] omap-dma-engine 4a056000.dma-controller: OMAP DMA engine driver [ 0.651428] of_get_named_gpiod_flags: can't parse 'gpio' property of node '/fixedregulator-vbat[0]' [ 0.652343] 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.656524] SCSI subsystem initialized [ 0.657073] libata version 3.00 loaded. [ 0.657806] 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.658355] omap_i2c 48070000.i2c: could not find pctldev for node /ocp/l4@4a000000/scm@100000/pinmux@40/pinmux_i2c1_pins, deferring probe [ 0.658477] omap_i2c 48060000.i2c: could not find pctldev for node /ocp/l4@4a000000/scm@100000/pinmux@40/pinmux_i2c3_pins, deferring probe [ 0.658569] omap_i2c 48350000.i2c: could not find pctldev for node /ocp/l4@4a000000/scm@100000/pinmux@40/pinmux_i2c4_pins, deferring probe [ 0.663238] Switched to clocksource 32k_counter [ 0.814239] NET: Registered protocol family 2 [ 0.816436] TCP established hash table entries: 8192 (order: 3, 32768 bytes) [ 0.816680] TCP bind hash table entries: 8192 (order: 6, 294912 bytes) [ 0.819244] TCP: Hash tables configured (established 8192 bind 8192) [ 0.819610] UDP hash table entries: 512 (order: 3, 40960 bytes) [ 0.819976] UDP-Lite hash table entries: 512 (order: 3, 40960 bytes) [ 0.821075] NET: Registered protocol family 1 [ 0.822601] RPC: Registered named UNIX socket transport module. [ 0.822631] RPC: Registered udp transport module. [ 0.822631] RPC: Registered tcp transport module. [ 0.822631] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.827362] CPU PMU: Failed to parse /pmu/interrupt-affinity[0] [ 0.827453] hw perfevents: enabled with armv7_cortex_a9 PMU driver, 7 counters available [ 0.832824] futex hash table entries: 512 (order: 3, 32768 bytes) [ 0.833465] audit: initializing netlink subsys (disabled) [ 0.833740] audit: type=2000 audit(0.820:1): initialized [ 0.838562] VFS: Disk quotas dquot_6.6.0 [ 0.838714] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 0.841430] NFS: Registering the id_resolver key type [ 0.841918] Key type id_resolver registered [ 0.841918] Key type id_legacy registered [ 0.842132] jffs2: version 2.2. (NAND) (SUMMARY) © 2001-2006 Red Hat, Inc. [ 0.847259] bounce: pool size: 64 pages [ 0.847381] io scheduler noop registered [ 0.847412] io scheduler deadline registered [ 0.847473] io scheduler cfq registered (default) [ 0.851104] pinctrl-single 4a100040.pinmux: 203 pins at pa fc100040 size 406 [ 0.851806] pinctrl-single 4a31e040.pinmux: 28 pins at pa fc31e040 size 56 [ 0.857116] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 0.863189] omap_uart 4806a000.serial: no wakeirq for uart0 [ 0.863189] of_get_named_gpiod_flags: can't parse 'rts-gpio' property of node '/ocp/serial@4806a000[0]' [ 0.863739] 4806a000.serial: ttyO0 at MMIO 0x4806a000 (irq = 223, base_baud = 3000000) is a OMAP UART0 [ 0.865722] omap_uart 4806c000.serial: no wakeirq for uart1 [ 0.865753] of_get_named_gpiod_flags: can't parse 'rts-gpio' property of node '/ocp/serial@4806c000[0]' [ 0.866027] 4806c000.serial: ttyO1 at MMIO 0x4806c000 (irq = 224, base_baud = 3000000) is a OMAP UART1 [ 0.867248] omap_uart 48020000.serial: no wakeirq for uart2 [ 0.867248] of_get_named_gpiod_flags: can't parse 'rts-gpio' property of node '/ocp/serial@48020000[0]' [ 0.867553] 48020000.serial: ttyO2 at MMIO 0x48020000 (irq = 225, base_baud = 3000000) is a OMAP UART2 [ 1.868255] console [ttyO2] enabled [ 1.898773] brd: module loaded [ 1.919769] loop: module loaded [ 1.925903] mtdoops: mtd device (mtddev=name/number) must be supplied [ 1.939483] of_get_named_gpiod_flags: can't parse 'reset-gpios' property of node '/ocp/spi@48098000/eth@0[0]' [ 1.949920] spi1.0 supply vdd-io not found, using dummy regulator [ 1.956848] spi1.0 supply vdd not found, using dummy regulator [ 1.963165] ks8851 spi1.0: message enable is 0 [ 1.974273] ks8851 spi1.0 eth0: revision 1, MAC 1a:5b:7b:2b:e4:30, IRQ 202, no EEPROM [ 1.986816] mousedev: PS/2 mouse device common for all mice [ 1.992675] i2c /dev entries driver [ 1.998016] omap_hsmmc 4809c000.mmc: GPIO lookup for consumer cd [ 2.004333] omap_hsmmc 4809c000.mmc: using device tree for GPIO lookup [ 2.011169] of_get_named_gpiod_flags: can't parse 'cd-gpios' property of node '/ocp/mmc@4809c000[0]' [ 2.020751] of_get_named_gpiod_flags: can't parse 'cd-gpio' property of node '/ocp/mmc@4809c000[0]' [ 2.030273] omap_hsmmc 4809c000.mmc: using lookup tables for GPIO lookup [ 2.037445] omap_hsmmc 4809c000.mmc: lookup for GPIO cd failed [ 2.043579] omap_hsmmc 4809c000.mmc: GPIO lookup for consumer wp [ 2.049865] omap_hsmmc 4809c000.mmc: using device tree for GPIO lookup [ 2.056732] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@4809c000[0]' [ 2.066314] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@4809c000[0]' [ 2.075805] omap_hsmmc 4809c000.mmc: using lookup tables for GPIO lookup [ 2.082824] omap_hsmmc 4809c000.mmc: lookup for GPIO wp failed [ 2.089599] omap_hsmmc 4809c000.mmc: unable to get vmmc regulator -517 [ 2.097259] omap_hsmmc 480d1000.mmc: GPIO lookup for consumer wp [ 2.103576] omap_hsmmc 480d1000.mmc: using device tree for GPIO lookup [ 2.110412] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@480d1000[0]' [ 2.119995] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@480d1000[0]' [ 2.129486] omap_hsmmc 480d1000.mmc: using lookup tables for GPIO lookup [ 2.136505] omap_hsmmc 480d1000.mmc: lookup for GPIO wp failed [ 2.143157] omap_hsmmc 480d1000.mmc: unable to get vmmc regulator -517 [ 2.150421] omap_hsmmc 480d5000.mmc: GPIO lookup for consumer cd [ 2.156738] omap_hsmmc 480d5000.mmc: using device tree for GPIO lookup [ 2.163635] of_get_named_gpiod_flags: parsed 'cd-gpios' property of node '/ocp/mmc@480d5000[0]' - status (0) [ 2.173980] omap_hsmmc 480d5000.mmc: Got CD GPIO [ 2.178833] omap_hsmmc 480d5000.mmc: GPIO lookup for consumer wp [ 2.185150] omap_hsmmc 480d5000.mmc: using device tree for GPIO lookup [ 2.191986] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@480d5000[0]' [ 2.201568] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@480d5000[0]' [ 2.211059] omap_hsmmc 480d5000.mmc: using lookup tables for GPIO lookup [ 2.218078] omap_hsmmc 480d5000.mmc: lookup for GPIO wp failed [ 2.264068] ledtrig-cpu: registered to indicate activity on CPUs [ 2.271575] oprofile: using arm/armv7-ca9 [ 2.276672] Initializing XFRM netlink socket [ 2.281280] NET: Registered protocol family 17 [ 2.286102] NET: Registered protocol family 15 [ 2.291198] Key type dns_resolver registered [ 2.295989] twl: not initialized [ 2.299377] twl6030_uv_to_vsel:OUT OF RANGE! non mapped vsel for 1375000 Vs max 1316660 [ 2.307830] twl6030_uv_to_vsel:OUT OF RANGE! non mapped vsel for 1375000 Vs max 1316660 [ 2.316284] twl6030_uv_to_vsel:OUT OF RANGE! non mapped vsel for 1375000 Vs max 1316660 [ 2.324707] twl6030_uv_to_vsel:OUT OF RANGE! non mapped vsel for 1375000 Vs max 1316660 [ 2.333190] twl6030_uv_to_vsel:OUT OF RANGE! non mapped vsel for 1375000 Vs max 1316660 [ 2.341552] twl6030_uv_to_vsel:OUT OF RANGE! non mapped vsel for 1375000 Vs max 1316660 [ 2.349975] twl6030_uv_to_vsel:OUT OF RANGE! non mapped vsel for 1410000 Vs max 1316660 [ 2.358398] omap2_set_init_voltage: unable to find boot up OPP for vdd_mpu [ 2.365631] omap2_set_init_voltage: unable to set vdd_mpu [ 2.371307] omap2_set_init_voltage: unable to find boot up OPP for vdd_core [ 2.378631] omap2_set_init_voltage: unable to set vdd_core [ 2.384429] omap2_set_init_voltage: unable to find boot up OPP for vdd_iva [ 2.391601] omap2_set_init_voltage: unable to set vdd_iva [ 2.399719] Power Management for TI OMAP4+ devices. [ 2.404876] OMAP4 PM: u-boot >= v2012.07 is required for full PM support [ 2.413421] ThumbEE CPU extension supported. [ 2.417938] Registering SWP/SWPB emulation handler [ 2.422973] SmartReflex Class3 initialized [ 2.433227] of_get_named_gpiod_flags: parsed 'gpio' property of node '/wl12xx_vmmc[0]' - status (0) [ 2.444793] usb_phy_generic hsusb1_phy: GPIO lookup for consumer reset [ 2.451629] usb_phy_generic hsusb1_phy: using device tree for GPIO lookup [ 2.458740] of_get_named_gpiod_flags: parsed 'reset-gpios' property of node '/hsusb1_phy[0]' - status (0) [ 2.468872] no flags found for reset [ 2.468872] usb_phy_generic hsusb1_phy: GPIO lookup for consumer vbus-detect [ 2.480010] usb_phy_generic hsusb1_phy: using device tree for GPIO lookup [ 2.483123] of_get_named_gpiod_flags: can't parse 'vbus-detect-gpios' property of node '/hsusb1_phy[0]' [ 2.496978] of_get_named_gpiod_flags: can't parse 'vbus-detect-gpio' property of node '/hsusb1_phy[0]' [ 2.506744] usb_phy_generic hsusb1_phy: using lookup tables for GPIO lookup [ 2.514038] usb_phy_generic hsusb1_phy: lookup for GPIO vbus-detect failed [ 2.526977] Skipping twl internal clock init and using bootloader value (unknown osc rate) [ 2.547241] hw-breakpoint: Failed to enable monitor mode on CPU 0. [ 2.555175] hw-breakpoint: CPU 0 failed to disable vector catch [ 2.562438] twl 0-0048: PIH (irq 327) nested IRQs [ 2.570617] mmc0: host does not support reading read-only switch, assuming write-enable [ 2.581939] mmc0: new high speed SDHC card at address b368 [ 2.590454] mmcblk0: mmc0:b368 USD 3.75 GiB [ 2.626068] mmcblk0: error -84 transferring data, sector 0, nr 8, cmd response 0x900, card status 0xb00 [ 2.644836] VUSIM: failed to get the current voltage(-22) [ 2.653076] twl_reg 48070000.i2c:twl@48:regulator-vusim: can't register VUSIM, -22 [ 2.662353] twl_reg: probe of 48070000.i2c:twl@48:regulator-vusim failed with error -22 [ 2.685943] twl6040 0-004b: clk32k is not handled [ 2.699066] of_get_named_gpiod_flags: parsed 'ti,audpwron-gpio' property of node '/ocp/i2c@48070000/twl@4b[0]' - status (0) [ 2.711059] mmc0: tried to reset card [ 2.715789] mmcblk0: p1 p2 [ 2.717254] omap_i2c 48070000.i2c: bus 0 rev0.11 at 400 kHz [ 2.729766] omap_i2c 48060000.i2c: bus 2 rev0.11 at 400 kHz [ 2.737792] omap_i2c 48350000.i2c: bus 3 rev0.11 at 400 kHz [ 2.743652] omap_hsmmc 4809c000.mmc: GPIO lookup for consumer cd [ 2.748352] omap_hsmmc 4809c000.mmc: using device tree for GPIO lookup [ 2.757476] of_get_named_gpiod_flags: can't parse 'cd-gpios' property of node '/ocp/mmc@4809c000[0]' [ 2.763122] of_get_named_gpiod_flags: can't parse 'cd-gpio' property of node '/ocp/mmc@4809c000[0]' [ 2.776519] omap_hsmmc 4809c000.mmc: using lookup tables for GPIO lookup [ 2.783569] omap_hsmmc 4809c000.mmc: lookup for GPIO cd failed [ 2.783569] omap_hsmmc 4809c000.mmc: GPIO lookup for consumer wp [ 2.795959] omap_hsmmc 4809c000.mmc: using device tree for GPIO lookup [ 2.795959] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@4809c000[0]' [ 2.812377] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@4809c000[0]' [ 2.821868] omap_hsmmc 4809c000.mmc: using lookup tables for GPIO lookup [ 2.823150] omap_hsmmc 4809c000.mmc: lookup for GPIO wp failed [ 2.883697] omap_hsmmc 480d1000.mmc: GPIO lookup for consumer wp [ 2.890197] omap_hsmmc 480d1000.mmc: using device tree for GPIO lookup [ 2.897033] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@480d1000[0]' [ 2.906677] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@480d1000[0]' [ 2.916198] omap_hsmmc 480d1000.mmc: using lookup tables for GPIO lookup [ 2.923217] omap_hsmmc 480d1000.mmc: lookup for GPIO wp failed [ 2.961517] mmc1: host does not support reading read-only switch, assuming write-enable [ 2.972412] mmc1: new high speed SDHC card at address 0007 [ 2.979553] mmcblk1: mmc1:0007 SD08G 7.42 GiB [ 2.986785] mmcblk1: p1 p2 [ 3.045715] hctosys: unable to open rtc device (rtc0) [ 3.045715] sr_init: No PMIC hook to init smartreflex [ 3.056610] smartreflex smartreflex.0: omap_sr_probe: SmartReflex driver initialized [ 3.065429] smartreflex smartreflex.1: omap_sr_probe: SmartReflex driver initialized [ 3.069793] omap_hsmmc 480d1000.mmc: card claims to support voltages below defined range [ 3.082641] smartreflex smartreflex.2: omap_sr_probe: SmartReflex driver initialized [ 3.084106] mmc2: queuing unknown CIS tuple 0x91 (3 bytes) [ 3.087615] mmc2: new SDIO card at address 0001 [ 3.145721] VUSB: disabling [ 3.150024] VANA: disabling [ 3.153839] VDAC: disabling [ 3.159637] VAUX1_6030: disabling [ 3.163360] vwl1271: disabling [ 3.174468] EXT3-fs (mmcblk1p2): error: couldn't mount because of unsupported optional features (240) [ 3.186553] EXT2-fs (mmcblk1p2): error: couldn't mount because of unsupported optional features (244) [ 3.220001] EXT4-fs (mmcblk1p2): INFO: recovery required on readonly filesystem [ 3.229644] EXT4-fs (mmcblk1p2): write access will be enabled during recovery [ 4.958435] EXT4-fs (mmcblk1p2): recovery complete [ 5.265594] EXT4-fs (mmcblk1p2): mounted filesystem with ordered data mode. Opts: (null) [ 5.265594] VFS: Mounted root (ext4 filesystem) readonly on device 179:10. [ 5.288421] devtmpfs: mounted [ 5.288421] Freeing unused kernel memory: 440K (c083a000 - c08a8000) [ 5.611328] random: init urandom read with 26 bits of entropy available [ 5.632019] init: Failed to create pty - disabling logging for job [ 5.640533] init: Temporary process spawn error: No space left on device [ 5.695281] init: Failed to create pty - disabling logging for job [ 5.701904] init: Temporary process spawn error: No space left on device [ 5.727233] init: Failed to create pty - disabling logging for job [ 5.734313] init: Temporary process spawn error: No space left on device [ 5.747192] init: Failed to create pty - disabling logging for job [ 5.753784] init: Temporary process spawn error: No space left on device [ 5.885528] init: ureadahead main process (58) terminated with status 5 [ 6.088989] init: Failed to create pty - disabling logging for job [ 6.097686] init: Temporary process spawn error: No space left on device [ 6.139465] init: Failed to create pty - disabling logging for job [ 6.146484] init: Temporary process spawn error: No space left on device [ 6.243133] init: Failed to create pty - disabling logging for job [ 6.250488] init: Temporary process spawn error: No space left on device [ 6.763000] udevd[113]: starting version 175 fsck from util-linux 2.20.1 /dev/mmcblk1p2: clean, 177378/963584 files, 2987694/7708672 blocks [ 9.794891] EXT4-fs (mmcblk1p2): re-mounted. Opts: errors=remount-ro [ 10.765777] init: udev-fallback-graphics main process (421) terminated with status 1 [ 11.011383] init: plymouth main process (59) killed by SEGV signal [ 11.031890] init: plymouth-splash main process (431) terminated with status 2 [ 11.248840] init: plymouth-log main process (468) terminated with status 1 [ 11.287017] init: failsafe main process (469) killed by TERM signal [ 11.307434] random: nonblocking pool is initialized [ 12.139739] init: plymouth-upstart-bridge main process (519) terminated with status 1 [ 12.297546] Adding 524232k swap on /SWAP.swap. Priority:-1 extents:13 across:577528k SS speech-dispatcher disabled; edit /etc/default/speech-dispatcher saned disabled; edit /etc/default/saned [ 12.994384] init: bluetooth main process (525) terminated with status 1 [ 13.001800] init: bluetooth main process ended, respawning [ 13.186676] init: alsa-restore main process (566) terminated with status 19 [ 13.227905] init: hybrid-gfx main process (584) terminated with status 1 FATAL: Could not load /lib/modules/4.1.0-143712-gb953c0d/modules.dep: No such file or directory [ 14.375640] init: bluetooth main process (668) terminated with status 1 [ 14.407836] init: bluetooth main process ended, respawning [ 14.790039] init: bluetooth main process (700) terminated with status 1 [ 14.800567] init: bluetooth main process ended, respawning Ubuntu 12.04.1 LTS variscite-desktop ttyO2 variscite-desktop login: [ 15.277832] init: bluetooth main process (725) terminated with status 1 [ 15.291442] 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: root [ 15.749877] init: bluetooth main process (764) terminated with status 1 [ 15.767608] init: bluetooth main process ended, respawning Last login: Thu Jan 1 02:00:19 IST 1970 on ttyO2 [ 16.068481] init: bluetooth main process (791) terminated with status 1 [ 16.083343] init: bluetooth main process ended, respawning [ 16.298492] init: lightdm main process (650) terminated with status 1 [ 16.316070] init: bluetooth main process (829) terminated with status 1 [ 16.323669] init: bluetooth main process ended, respawning [ 16.618225] init: bluetooth main process (873) terminated with status 1 [ 16.632690] init: bluetooth main process ended, respawning [ 16.908477] init: bluetooth main process (927) terminated with status 1 [ 16.915802] init: bluetooth main process ended, respawning [ 17.269226] init: bluetooth main process (975) terminated with status 1 [ 17.276336] init: bluetooth main process ended, respawning Welcome to Ubuntu 12.04.1 LTS (GNU/Linux 4.1.0-143712-gb953c0d armv7l) * Documentation: https://help.ubuntu.com/ [ 17.539764] init: bluetooth main process (1015) terminated with status 1 [ 17.553558] init: bluetooth main process ended, respawning [ 17.818908] init: bluetooth main process (1110) terminated with status 1 [ 17.829284] init: bluetooth main process ended, respawning [ 18.055664] init: bluetooth main process (1137) terminated with status 1 [ 18.062896] init: bluetooth main process ended, respawning [ 18.283691] init: bluetooth main process (1163) terminated with status 1 [ 18.295349] init: bluetooth main process ended, respawning [ 18.518890] init: bluetooth main process (1188) terminated with status 1 [ 18.530731] init: bluetooth main process ended, respawning [ 18.755676] init: bluetooth main process (1211) terminated with status 1 [ 18.763458] init: bluetooth main process ended, respawning [ 18.994384] init: bluetooth main process (1237) terminated with status 1 [ 19.007263] init: bluetooth main process ended, respawning [ 19.254730] init: bluetooth main process (1260) terminated with status 1 [ 19.262420] init: bluetooth main process ended, respawning [ 19.487823] init: bluetooth main process (1283) terminated with status 1 [ 19.496917] init: bluetooth main process ended, respawning [ 19.731903] init: bluetooth main process (1306) terminated with status 1 [ 19.739074] init: bluetooth respawning too fast, stopped %% Start PM consolidated quick test (retention only) %% Preparation root@variscite-desktop:~# root@variscite-desktop:~# 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:297,RET:0,INA:0,ON:298,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: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:96,INA:0,ON:97,RET-LOGIC-OFF:92,RET-MEMBANK1-OFF:96,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0 cpu1_pwrdm (ON),OFF:296,RET:0,INA:0,ON:297,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cpu0_pwrdm (ON),OFF:222,RET:0,INA:0,ON:223,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 [ 27.393066] PM: Syncing filesystems ... [ 32.186218] init: failsafe-x main process (859) terminated with status 1 [ 35.987579] done. [ 35.987731] PM: Preparing system for mem sleep [ 36.010345] Freezing user space processes ... (elapsed 0.007 seconds) done. [ 36.024993] Freezing remaining freezable tasks ... (elapsed 0.002 seconds) done. [ 36.033386] PM: Entering mem sleep [ 36.036254] Suspending console(s) (use no_console_suspend to debug) [ 36.064544] PM: suspend of devices complete after 18.005 msecs [ 36.064544] PM: late suspend of devices complete after 0.001 msecs [ 36.076385] omap_hwmod: gpio6: _wait_target_disable failed [ 36.084014] PM: noirq suspend of devices complete after 14.465 msecs [ 36.084167] Disabling non-boot CPUs ... [ 36.095397] [ 36.095397] =============================== [ 36.095397] [ INFO: suspicious RCU usage. ] [ 36.095428] 4.1.0-143712-gb953c0d #1 Not tainted [ 36.095428] ------------------------------- [ 36.095428] kernel/sched/fair.c:4841 suspicious rcu_dereference_check() usage! [ 36.095428] [ 36.095428] other info that might help us debug this: [ 36.095428] [ 36.095428] [ 36.095428] RCU used illegally from offline CPU! [ 36.095428] rcu_scheduler_active = 1, debug_locks = 0 [ 36.095458] 3 locks held by swapper/1/0: [ 36.095458] #0: ((cpu_died).wait.lock){......}, at: [] complete+0x14/0x44 [ 36.095458] #1: (&p->pi_lock){-.-.-.}, at: [] try_to_wake_up+0x2c/0x394 [ 36.095458] #2: (rcu_read_lock){......}, at: [] select_task_rq_fair+0x5c/0xb34 [ 36.095458] [ 36.095458] stack backtrace: [ 36.095458] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 4.1.0-143712-gb953c0d #1 [ 36.095458] Hardware name: Generic OMAP4 (Flattened Device Tree) [ 36.095581] [] (unwind_backtrace) from [] (show_stack+0x10/0x14) [ 36.095611] [] (show_stack) from [] (dump_stack+0x80/0x9c) [ 36.095611] [] (dump_stack) from [] (select_task_rq_fair+0x6f8/0xb34) [ 36.095642] [] (select_task_rq_fair) from [] (try_to_wake_up+0xf8/0x394) [ 36.095642] [] (try_to_wake_up) from [] (__wake_up_common+0x4c/0x80) [ 36.095642] [] (__wake_up_common) from [] (__wake_up_locked+0x14/0x1c) [ 36.095672] [] (__wake_up_locked) from [] (complete+0x34/0x44) [ 36.095672] [] (complete) from [] (cpu_die+0x34/0x9c) [ 36.095703] [] (cpu_die) from [] (cpu_startup_entry+0x3d0/0x43c) [ 36.095703] [] (cpu_startup_entry) from [<8000958c>] (0x8000958c) [ 36.095733] CPU1: shutdown [ 36.123046] Powerdomain (core_pwrdm) didn't enter target state 1 [ 36.123046] Powerdomain (abe_pwrdm) didn't enter target state 1 [ 36.123046] Powerdomain (mpu_pwrdm) didn't enter target state 1 [ 36.123046] Powerdomain (l4per_pwrdm) didn't enter target state 1 [ 36.123046] Could not enter target state in pm_suspend [ 36.123046] A possible cause could be an old bootloader - try u-boot >= v2012.07 [ 36.123046] Enabling non-boot CPUs ... [ 36.152923] CPU1 is up [ 36.155944] PM: noirq resume of devices complete after 2.929 msecs [ 36.155944] PM: early resume of devices complete after 0.001 msecs [ 36.606842] PM: resume of devices complete after 450.897 msecs [ 36.878753] PM: Finishing wakeup. [ 36.882232] 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:830,RET:0,INA:0,ON:831,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: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:96,INA:0,ON:97,RET-LOGIC-OFF:92,RET-MEMBANK1-OFF:96,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0 cpu1_pwrdm (ON),OFF:829,RET:0,INA:0,ON:830,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cpu0_pwrdm (ON),OFF:649,RET:0,INA:0,ON:650,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 [ 39.363403] PM: Syncing filesystems ... done. [ 40.733856] PM: Preparing system for mem sleep [ 40.740203] Freezing user space processes ... (elapsed 0.002 seconds) done. [ 40.747741] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [ 40.757507] PM: Entering mem sleep [ 40.763946] Suspending console(s) (use no_console_suspend to debug) [ 40.777740] PM: suspend of devices complete after 5.767 msecs [ 40.779754] PM: late suspend of devices complete after 2.014 msecs [ 40.781768] omap_hwmod: gpio6: _wait_target_disable failed [ 40.788848] PM: noirq suspend of devices complete after 8.819 msecs [ 40.788848] Disabling non-boot CPUs ... [ 40.789886] CPU1: shutdown [ 40.817169] Powerdomain (core_pwrdm) didn't enter target state 1 [ 40.817169] Powerdomain (abe_pwrdm) didn't enter target state 1 [ 40.817169] Powerdomain (mpu_pwrdm) didn't enter target state 1 [ 40.817169] Powerdomain (l4per_pwrdm) didn't enter target state 1 [ 40.817169] Could not enter target state in pm_suspend [ 40.817169] A possible cause could be an old bootloader - try u-boot >= v2012.07 [ 40.817199] Enabling non-boot CPUs ... [ 40.848999] CPU1 is up [ 40.850463] PM: noirq resume of devices complete after 1.373 msecs [ 40.850463] PM: early resume of devices complete after 0.001 msecs [ 41.206848] PM: resume of devices complete after 354.736 msecs [ 41.303466] PM: Finishing wakeup. [ 41.303466] 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:925,RET:0,INA:0,ON:926,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:21,INA:0,ON:21,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:96,INA:0,ON:97,RET-LOGIC-OFF:92,RET-MEMBANK1-OFF:96,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0 cpu1_pwrdm (ON),OFF:924,RET:0,INA:0,ON:925,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cpu0_pwrdm (ON),OFF:734,RET:0,INA:0,ON:735,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:1146,RET:0,INA:0,ON:1147,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:23,INA:0,ON:23,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:96,INA:0,ON:97,RET-LOGIC-OFF:92,RET-MEMBANK1-OFF:96,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0 cpu1_pwrdm (ON),OFF:1144,RET:0,INA:0,ON:1145,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cpu0_pwrdm (ON),OFF:916,RET:0,INA:0,ON:917,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)