Texas Instruments X-Loader 1.47 (Jan 14 2011 - 15:43:28) Starting X-loader on MMC Reading boot sector 212836 Bytes Read from MMC Starting OS Bootloader from MMC... Starting OS Bootloader... U-Boot 2010.06 (Jan 14 2011 - 15:43:45) OMAP34xx/35xx-GP ES2.1, CPU-OPP2 L3-165MHz OMAP3 EVM board + LPDDR/NAND I2C: ready DRAM: 256 MiB NAND: 512 MiB In: serial Out: serial Err: serial Read back SMSC id 0x92200000 Die ID #368000229ff80000016071640902c013 Net: smc911x-0 Hit any key to stop autoboot: 3  0 OMAP3_EVM # OMAP3_EVM # setenv bootfile uImage-dtb.omap3-evm-37xx OMAP3_EVM # OMAP3_EVM # dhcp smc911x: detected LAN9220 controller smc911x: phy initialized smc911x: MAC 00:50:c2:7e:99:42 BOOTP broadcast 1 DHCP client bound to address 192.168.57.131 Using smc911x-0 device TFTP from server 192.168.57.1; our IP address is 192.168.57.131 Filename 'uImage-dtb.omap3-evm-37xx'. Load address: 0x82000000 Loading: *################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ########################## done Bytes transferred = 4787405 (490ccd hex) OMAP3_EVM # setenv bootargs console=ttyO0,115200n8 ignore_loglevel earlyprintk root=/dev/nfs nfsroot=192.168.57.1:/srv/nfs4/rootfs2 nfsrootdebug ip=dhcp init=/bin/sh OMAP3_EVM # OMAP3_EVM # bootm ## Booting kernel from Legacy Image at 82000000 ... Image Name: Linux- Image Type: ARM Linux Kernel Image (uncompressed) Data Size: 4787341 Bytes = 4.6 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 3.19.0-rc1-14140-g97bf6af (paul@nozomi) (gcc version 4.7.2 (Debian 4.7.2-5) ) #1 SMP Fri Jan 2 15:21:31 MST 2015 [ 0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c5387d [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache [ 0.000000] Machine model: TI OMAP37XX EVM (TMDSEVM3730) [ 0.000000] debug: ignoring loglevel setting. [ 0.000000] cma: Reserved 16 MiB at 0x8e800000 [ 0.000000] Memory policy: Data cache writeback [ 0.000000] On node 0 totalpages: 65280 [ 0.000000] free_area_init_node: node 0, pgdat c096ecc0, node_mem_map cfcb1000 [ 0.000000] Normal zone: 576 pages used for memmap [ 0.000000] Normal zone: 0 pages reserved [ 0.000000] Normal zone: 65280 pages, LIFO batch:15 [ 0.000000] CPU: All CPU(s) started in SVC mode. [ 0.000000] OMAP3630 ES1.2 (l2cache iva sgx neon isp 192mhz_clk ) [ 0.000000] PERCPU: Embedded 11 pages/cpu @cfc3b000 s14912 r8192 d21952 u45056 [ 0.000000] pcpu-alloc: s14912 r8192 d21952 u45056 alloc=11*4096 [ 0.000000] pcpu-alloc: [0] 0 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64704 [ 0.000000] Kernel command line: console=ttyO0,115200n8 ignore_loglevel earlyprintk root=/dev/nfs nfsroot=192.168.57.1:/srv/nfs4/rootfs2 nfsrootdebug ip=dhcp init=/bin/sh [ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes) [ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes) [ 0.000000] Memory: 223752K/261120K available (6190K kernel code, 674K rwdata, 2356K rodata, 428K init, 8221K bss, 20984K reserved, 16384K cma-reserved, 0K highmem) [ 0.000000] Virtual kernel memory layout: [ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB) [ 0.000000] fixmap : 0xffc00000 - 0xfff00000 (3072 kB) [ 0.000000] vmalloc : 0xd0800000 - 0xff000000 ( 744 MB) [ 0.000000] lowmem : 0xc0000000 - 0xd0000000 ( 256 MB) [ 0.000000] pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB) [ 0.000000] modules : 0xbf000000 - 0xbfe00000 ( 14 MB) [ 0.000000] .text : 0xc0008000 - 0xc0860d40 (8548 kB) [ 0.000000] .init : 0xc0861000 - 0xc08cc000 ( 428 kB) [ 0.000000] .data : 0xc08cc000 - 0xc0974ae8 ( 675 kB) [ 0.000000] .bss : 0xc0974ae8 - 0xc117c250 (8222 kB) [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU restricting CPUs from NR_CPUS=2 to nr_cpu_ids=1. [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 [ 0.000000] NR_IRQS:16 nr_irqs:16 16 [ 0.000000] IRQ: Found an INTC at 0xfa200000 (revision 4.0) with 96 interrupts [ 0.000000] Clocking rate (Crystal/Core/MPU): 26.0/400/600 MHz [ 0.000000] OMAP clockevent source: timer1 at 32768 Hz [ 0.000030] sched_clock: 32 bits at 32kHz, resolution 30517ns, wraps every 65536000000000ns [ 0.000061] OMAP clocksource: 32k_counter at 32768 Hz [ 0.001190] Console: colour dummy device 80x30 [ 0.001251] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.001281] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.001281] ... MAX_LOCK_DEPTH: 48 [ 0.001312] ... MAX_LOCKDEP_KEYS: 8191 [ 0.001312] ... CLASSHASH_SIZE: 4096 [ 0.001312] ... MAX_LOCKDEP_ENTRIES: 32768 [ 0.001342] ... MAX_LOCKDEP_CHAINS: 65536 [ 0.001342] ... CHAINHASH_SIZE: 32768 [ 0.001373] memory used by lock dependency info: 5167 kB [ 0.001373] per task-struct memory footprint: 1152 bytes [ 0.001403] Calibrating delay loop... 594.73 BogoMIPS (lpj=2973696) [ 0.097595] pid_max: default: 32768 minimum: 301 [ 0.098083] Security Framework initialized [ 0.098327] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes) [ 0.098358] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes) [ 0.102478] Initializing cgroup subsys memory [ 0.102569] Initializing cgroup subsys devices [ 0.102691] Initializing cgroup subsys freezer [ 0.102813] Initializing cgroup subsys blkio [ 0.102905] Initializing cgroup subsys perf_event [ 0.103027] CPU: Testing write buffer coherency: ok [ 0.104675] CPU0: thread -1, cpu 0, socket -1, mpidr 0 [ 0.104827] Setting up static identity map for 0x805dd8d0 - 0x805dd940 [ 0.109558] Brought up 1 CPUs [ 0.109588] CPU: All CPU(s) started in SVC mode. [ 0.113555] devtmpfs: initialized [ 0.116485] VFP support v0.3: implementor 41 architecture 3 part 30 variant c rev 3 [ 0.198394] omap_hwmod: mcbsp2_sidetone using broken dt data from mcbsp [ 0.200744] omap_hwmod: mcbsp3_sidetone using broken dt data from mcbsp [ 0.309326] pinctrl core: initialized pinctrl subsystem [ 0.408691] NET: Registered protocol family 16 [ 0.417572] DMA: preallocated 256 KiB pool for atomic coherent allocations [ 0.420471] cpuidle: using governor ladder [ 0.420532] cpuidle: using governor menu [ 0.428955] Reprogramming SDRC clock to 400000000 Hz [ 0.442810] gpiochip_add: registered GPIOs 0 to 31 on device: gpio [ 0.444061] OMAP GPIO hardware version 2.5 [ 0.445983] gpiochip_add: registered GPIOs 32 to 63 on device: gpio [ 0.449188] gpiochip_add: registered GPIOs 64 to 95 on device: gpio [ 0.451904] gpiochip_add: registered GPIOs 96 to 127 on device: gpio [ 0.454620] gpiochip_add: registered GPIOs 128 to 159 on device: gpio [ 0.457397] gpiochip_add: registered GPIOs 160 to 191 on device: gpio [ 0.459014] irq: no irq domain found for /ocp/pinmux@48002030 ! [ 0.459991] irq: no irq domain found for /ocp/pinmux@48002030 ! [ 0.460876] irq: no irq domain found for /ocp/pinmux@48002030 ! [ 0.486297] omap-gpmc 6e000000.gpmc: GPMC revision 5.0 [ 0.491241] platform 48058000.ssi-controller: Cannot lookup hwmod 'ssi' [ 0.499969] No ATAGs? [ 0.499999] hw-breakpoint: debug architecture 0x4 unsupported. [ 0.503692] OMAP DMA hardware revision 5.0 [ 0.593658] omap-dma-engine 48056000.dma-controller: OMAP DMA engine driver [ 0.594940] of_get_named_gpiod_flags: can't parse 'gpio' property of node '/regulator-vddvario[0]' [ 0.596160] of_get_named_gpiod_flags: can't parse 'gpio' property of node '/regulator-vdd33a[0]' [ 0.597412] reg-fixed-voltage wl12xx_vmmc: could not find pctldev for node /ocp/pinmux@48002030/pinmux_wl12xx_gpio, deferring probe [ 0.597473] platform wl12xx_vmmc: Driver reg-fixed-voltage requests probe deferral [ 0.597778] of_get_named_gpiod_flags: parsed 'gpio' property of node '/regulator-lcd-3v3[0]' - status (0) [ 0.604492] SCSI subsystem initialized [ 0.605407] libata version 3.00 loaded. [ 0.606506] usbcore: registered new interface driver usbfs [ 0.607025] usbcore: registered new interface driver hub [ 0.607208] usbcore: registered new device driver usb [ 0.614166] omap_i2c 48070000.i2c: bus 0 rev4.4 at 2600 kHz [ 0.615753] omap_i2c 48072000.i2c: bus 1 rev4.4 at 400 kHz [ 0.618927] omap_i2c 48060000.i2c: bus 2 rev4.4 at 400 kHz [ 0.625061] Switched to clocksource 32k_counter [ 0.840972] NET: Registered protocol family 2 [ 0.843261] TCP established hash table entries: 2048 (order: 1, 8192 bytes) [ 0.843505] TCP bind hash table entries: 2048 (order: 4, 73728 bytes) [ 0.844635] TCP: Hash tables configured (established 2048 bind 2048) [ 0.844879] TCP: reno registered [ 0.844909] UDP hash table entries: 256 (order: 2, 20480 bytes) [ 0.845367] UDP-Lite hash table entries: 256 (order: 2, 20480 bytes) [ 0.847015] NET: Registered protocol family 1 [ 0.848999] RPC: Registered named UNIX socket transport module. [ 0.849029] RPC: Registered udp transport module. [ 0.849060] RPC: Registered tcp transport module. [ 0.849060] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.851074] hw perfevents: enabled with armv7_cortex_a8 PMU driver, 5 counters available [ 0.859222] futex hash table entries: 256 (order: 2, 16384 bytes) [ 0.859558] audit: initializing netlink subsys (disabled) [ 0.859863] audit: type=2000 audit(0.840:1): initialized [ 0.865875] VFS: Disk quotas dquot_6.5.2 [ 0.866088] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 0.869262] NFS: Registering the id_resolver key type [ 0.869750] Key type id_resolver registered [ 0.869781] Key type id_legacy registered [ 0.869995] jffs2: version 2.2. (NAND) (SUMMARY) © 2001-2006 Red Hat, Inc. [ 0.875854] io scheduler noop registered [ 0.875915] io scheduler deadline registered [ 0.876037] io scheduler cfq registered (default) [ 0.880065] pinctrl-single 48002030.pinmux: 284 pins at pa fa002030 size 568 [ 0.880828] pinctrl-single 48002a00.pinmux: 46 pins at pa fa002a00 size 92 [ 0.881927] pinctrl-single 480025a0.pinmux: 46 pins at pa fa0025a0 size 92 [ 0.891479] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 0.900573] of_get_named_gpiod_flags: can't parse 'rts-gpio' property of node '/ocp/serial@4806a000[0]' [ 0.901214] omap_uart 4806a000.serial: ttyO0 at MMIO 0x4806a000 (irq = 224, base_baud = 3000000) is a OMAP UART0 [ 1.781951] console [ttyO0] enabled [ 1.788482] of_get_named_gpiod_flags: can't parse 'rts-gpio' property of node '/ocp/serial@4806c000[0]' [ 1.798889] omap_uart 4806c000.serial: ttyO1 at MMIO 0x4806c000 (irq = 225, base_baud = 3000000) is a OMAP UART1 [ 1.811859] of_get_named_gpiod_flags: can't parse 'rts-gpio' property of node '/ocp/serial@49020000[0]' [ 1.822204] omap_uart 49020000.serial: ttyO2 at MMIO 0x49020000 (irq = 226, base_baud = 3000000) is a OMAP UART2 [ 1.835235] omap_uart 49042000.serial: no wakeirq for uart0 [ 1.841156] of_get_named_gpiod_flags: can't parse 'rts-gpio' property of node '/ocp/serial@49042000[0]' [ 1.851440] omap_uart 49042000.serial: ttyO3 at MMIO 0x49042000 (irq = 260, base_baud = 3000000) is a OMAP UART3 [ 1.895721] brd: module loaded [ 1.918518] loop: module loaded [ 1.951599] twl 0-0048: PIH (irq 297) chaining IRQs 298..306 [ 1.958129] twl 0-0048: power (irq 303) chaining IRQs 306..313 [ 2.021850] twl4030_gpio twl4030-gpio: gpio (irq 298) chaining IRQs 314..331 [ 2.029876] gpiochip_find_base: found new base at 492 [ 2.036010] gpiochip_add: registered GPIOs 492 to 511 on device: twl4030 [ 2.108642] mtdoops: mtd device (mtddev=name/number) must be supplied [ 2.116790] nand: Could not find valid ONFI parameter page; aborting [ 2.123535] nand: device found, Manufacturer ID: 0xad, Chip ID: 0xbc [ 2.130340] nand: Hynix NAND 512MiB 1,8V 16-bit [ 2.135162] nand: 512 MiB, SLC, erase size: 128 KiB, page size: 2048, OOB size: 64 [ 2.143127] nand: using OMAP_ECC_BCH8_CODE_HW_DETECTION_SW [ 2.151794] 5 ofpart partitions found on MTD device omap2-nand.0 [ 2.158203] Creating 5 MTD partitions on "omap2-nand.0": [ 2.163818] 0x000000000000-0x000000080000 : "X-Loader" [ 2.177215] 0x000000080000-0x000000240000 : "U-Boot" [ 2.188385] 0x000000240000-0x000000280000 : "Environment" [ 2.198638] 0x000000280000-0x000000780000 : "Kernel" [ 2.212554] 0x000000780000-0x000020000000 : "Filesystem" [ 2.679321] libphy: smsc911x-mdio: probed [ 2.684051] smsc911x 2c000000.ethernet eth0: attached PHY driver [SMSC LAN8700] (mii_bus:phy_addr=2c000000.etherne:01, irq=-1) [ 2.696441] smsc911x 2c000000.ethernet eth0: MAC Address: 00:50:c2:7e:99:42 [ 2.706024] usbcore: registered new interface driver asix [ 2.711914] usbcore: registered new interface driver ax88179_178a [ 2.718597] usbcore: registered new interface driver cdc_ether [ 2.725097] usbcore: registered new interface driver smsc95xx [ 2.731323] usbcore: registered new interface driver net1080 [ 2.737518] usbcore: registered new interface driver cdc_subset [ 2.743957] usbcore: registered new interface driver zaurus [ 2.750183] usbcore: registered new interface driver cdc_ncm [ 2.757720] usbcore: registered new interface driver cdc_wdm [ 2.763977] usbcore: registered new interface driver usb-storage [ 2.770690] usbcore: registered new interface driver usbtest [ 2.780151] mousedev: PS/2 mouse device common for all mice [ 2.788574] input: TWL4030 Keypad as /devices/platform/68000000.ocp/48070000.i2c/i2c-0/0-0048/48070000.i2c:twl@48:keypad/input/input0 [ 2.809448] input: twl4030_pwrbutton as /devices/platform/68000000.ocp/48070000.i2c/i2c-0/0-0048/48070000.i2c:twl@48:pwrbutton/input/input1 [ 2.826202] twl_rtc 48070000.i2c:twl@48:rtc: Power up reset detected. [ 2.833221] twl_rtc 48070000.i2c:twl@48:rtc: Enabling TWL-RTC [ 2.844329] twl_rtc 48070000.i2c:twl@48:rtc: rtc core: registered 48070000.i2c:twl@48 as rtc0 [ 2.854614] i2c /dev entries driver [ 2.861724] Driver for 1-wire Dallas network protocol. [ 2.871673] omap_wdt: OMAP Watchdog Timer Rev 0x31: initial timeout 60 sec [ 2.881683] Driver 'mmcblk' needs updating - please use bus_type methods [ 2.890655] of_get_named_gpiod_flags: can't parse 'cd-gpios' property of node '/ocp/mmc@4809c000[0]' [ 2.900390] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@4809c000[0]' [ 2.955627] of_get_named_gpiod_flags: can't parse 'cd-gpios' property of node '/ocp/mmc@480b4000[0]' [ 2.965362] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@480b4000[0]' [ 2.975891] omap_hsmmc 480b4000.mmc: unable to get vmmc regulator -517 [ 2.983459] platform 480b4000.mmc: Driver omap_hsmmc requests probe deferral [ 2.992401] of_get_named_gpiod_flags: parsed 'gpios' property of node '/leds/ledb[0]' - status (0) [ 3.009460] ledtrig-cpu: registered to indicate activity on CPUs [ 3.017089] usbcore: registered new interface driver usbhid [ 3.022979] usbhid: USB HID core driver [ 3.029907] oprofile: using arm/armv7 [ 3.034667] TCP: cubic registered [ 3.038330] Initializing XFRM netlink socket [ 3.043029] NET: Registered protocol family 17 [ 3.047912] NET: Registered protocol family 15 [ 3.053070] Key type dns_resolver registered [ 3.058105] omap2_set_init_voltage: unable to find boot up OPP for vdd_mpu_iva [ 3.065795] omap2_set_init_voltage: unable to set vdd_mpu_iva [ 3.071868] omap2_set_init_voltage: unable to find boot up OPP for vdd_core [ 3.079254] omap2_set_init_voltage: unable to set vdd_core [ 3.089996] ThumbEE CPU extension supported. [ 3.094573] Registering SWP/SWPB emulation handler [ 3.099731] SmartReflex Class3 initialized [ 3.116363] of_get_named_gpiod_flags: parsed 'gpio' property of node '/wl12xx_vmmc[0]' - status (0) [ 3.127258] vwl1271: supplied by VMMC2 [ 3.132934] of_get_named_gpiod_flags: can't parse 'cd-gpios' property of node '/ocp/mmc@480b4000[0]' [ 3.142700] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@480b4000[0]' [ 3.280151] twl_rtc 48070000.i2c:twl@48:rtc: setting system clock to 2000-01-01 00:00:00 UTC (946684800) [ 3.290252] sr_init: No PMIC hook to init smartreflex [ 3.296264] smartreflex smartreflex.0: omap_sr_probe: SmartReflex driver initialized [ 3.305480] smartreflex smartreflex.1: omap_sr_probe: SmartReflex driver initialized [ 3.402374] smsc911x 2c000000.ethernet eth0: SMSC911x/921x identified at 0xd087e000, IRQ: 208 [ 5.265167] mmc0: card never left busy state [ 5.269714] mmc0: error -110 whilst initialising SD card [ 5.705169] Sending DHCP requests ., OK [ 5.725677] IP-Config: Got DHCP answer from 192.168.57.1, my address is 192.168.57.131 [ 5.734802] IP-Config: Complete: [ 5.738342] device=eth0, hwaddr=00:50:c2:7e:99:42, ipaddr=192.168.57.131, mask=255.255.255.0, gw=255.255.255.255 [ 5.749572] host=192.168.57.131, domain=example.org, nis-domain=(none) [ 5.756958] bootserver=0.0.0.0, rootserver=192.168.57.1, rootpath= [ 5.763732] nameserver0=192.168.57.1 [ 5.768585] vwl1271: disabling [ 5.772979] VUSB3V1: disabling [ 5.778930] lcd_3v3: disabling [ 5.807891] VFS: Mounted root (nfs filesystem) readonly on device 0:14. [ 5.817169] devtmpfs: mounted [ 5.821380] Freeing unused kernel memory: 428K (c0861000 - c08cc000) /bin/sh: 0: can't access tty; job control turned off # %% Start PM consolidated quick test %% Preparation # # mkdir -p /sys; mount -t sysfs none /sys # # mkdir -p /debug; mount -t debugfs none /debug # # # # for u in `ls -1d /sys/bus/platform/drivers/omap_uart/*.serial | paste -s -d' '`; do echo -1 > $u/power/autosuspend_delay_ms; done # # 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 00:00 /sys/bus/platform/drivers/omap_uart/4806a000.serial/power/autosuspend_delay_ms -1 -rw-r--r-- 1 root root 4096 Jan 1 00:00 /sys/bus/platform/drivers/omap_uart/4806c000.serial/power/autosuspend_delay_ms -1 -rw-r--r-- 1 root root 4096 Jan 1 00:00 /sys/bus/platform/drivers/omap_uart/49020000.serial/power/autosuspend_delay_ms -1 -rw-r--r-- 1 root root 4096 Jan 1 00:00 /sys/bus/platform/drivers/omap_uart/49042000.serial/power/autosuspend_delay_ms -1 # # echo 0 > /debug/pm_debug/enable_off_mode # # %% Baseline pm_debug count dump cat /debug/pm_debug/count usbhost_pwrdm (ON),OFF:0,RET:201,INA:0,ON:202,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 sgx_pwrdm (OFF),OFF:1,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 core_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 per_pwrdm (ON),OFF:0,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dss_pwrdm (ON),OFF:0,RET:201,INA:0,ON:202,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cam_pwrdm (RET),OFF:0,RET:1,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 neon_pwrdm (ON),OFF:0,RET:104,INA:97,ON:202,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:0,RET:104,INA:97,ON:202,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 iva2_pwrdm (RET),OFF:0,RET:1,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0,RET-MEMBANK4-OFF:0 usbhost_clkdm->usbhost_pwrdm (1) sgx_clkdm->sgx_pwrdm (0) per_clkdm->per_pwrdm (15) cam_clkdm->cam_pwrdm (0) dss_clkdm->dss_pwrdm (1) d2d_clkdm->core_pwrdm (0) iva2_clkdm->iva2_pwrdm (0) mpu_clkdm->mpu_pwrdm (0) core_l4_clkdm->core_pwrdm (22) core_l3_clkdm->core_pwrdm (1) neon_clkdm->neon_pwrdm (0) # # for u in `ls -1d /sys/class/tty/ttyO* | paste -s -d' '`; do echo enabled > $u/power/wakeup; done # %% Start retention double suspend/resume UART wakeup test # for u in `ls -1d /sys/class/tty/ttyO* | paste -s -d' '`; do echo auto > $u/power/control; done # # 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 00:00 /sys/class/tty/ttyO0/power/wakeup enabled -rw-r--r-- 1 root root 4096 Jan 1 00:00 /sys/class/tty/ttyO1/power/wakeup enabled 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 00:00 /sys/class/tty/ttyO2/power/wakeup enabled -rw-r--r-- 1 root root 4096 Jan 1 00:00 /sys/class/tty/ttyO3/power/wakeup enabled # # echo mem > /sys/power/state -rw-r--r-- 1 root root 4096 Jan 1 00:00 /sys/class/tty/ttyO0/power/control auto -rw-r--r-- 1 root root 4096 Jan 1 00:00 /sys/class/tty/ttyO1/power/control auto -rw-r--r-- 1 root root 4096 Jan 1 00:00 /sys/class/tty/ttyO2/power/control auto -rw-r--r-- 1 root root 4096 Jan 1 00:00 /sys/class/tty/ttyO3/power/control auto # # [ 15.019256] PM: Syncing filesystems ... done. [ 15.026489] PM: Preparing system for mem sleep [ 15.039581] Freezing user space processes ... (elapsed 0.000 seconds) done. [ 15.047363] Freezing remaining freezable tasks ... (elapsed 0.002 seconds) done. [ 15.058258] PM: Entering mem sleep [ 15.061859] Suspending console(s) (use no_console_suspend to debug) [ 15.093627] PM: suspend of devices complete after 18.432 msecs [ 15.102355] PM: late suspend of devices complete after 8.697 msecs [ 15.111602] PM: noirq suspend of devices complete after 9.216 msecs [ 15.111694] Disabling non-boot CPUs ... [ 15.111724] Successfully put all powerdomains to target state [ 15.117034] PM: noirq resume of devices complete after 5.249 msecs [ 15.117218] In-band Error seen by MPU at address 0 [ 15.117218] ------------[ cut here ]------------ [ 15.117248] WARNING: CPU: 0 PID: 1 at drivers/bus/omap_l3_smx.c:166 omap3_l3_app_irq+0xcc/0x124() [ 15.117279] Modules linked in: [ 15.117279] CPU: 0 PID: 1 Comm: sh Not tainted 3.19.0-rc1-14140-g97bf6af #1 [ 15.117279] Hardware name: Generic OMAP36xx (Flattened Device Tree) [ 15.117340] [] (unwind_backtrace) from [] (show_stack+0x10/0x14) [ 15.117370] [] (show_stack) from [] (dump_stack+0x80/0x9c) [ 15.117370] [] (dump_stack) from [] (warn_slowpath_common+0x78/0xb4) [ 15.117401] [] (warn_slowpath_common) from [] (warn_slowpath_null+0x1c/0x24) [ 15.117401] [] (warn_slowpath_null) from [] (omap3_l3_app_irq+0xcc/0x124) [ 15.117431] [] (omap3_l3_app_irq) from [] (handle_irq_event_percpu+0x60/0x1f4) [ 15.117431] [] (handle_irq_event_percpu) from [] (handle_irq_event+0x3c/0x5c) [ 15.117462] [] (handle_irq_event) from [] (handle_level_irq+0xb4/0x13c) [ 15.117492] [] (handle_level_irq) from [] (generic_handle_irq+0x20/0x30) [ 15.117492] [] (generic_handle_irq) from [] (__handle_domain_irq+0x68/0xdc) [ 15.117523] [] (__handle_domain_irq) from [] (omap_intc_handle_irq+0xb4/0xc4) [ 15.117523] [] (omap_intc_handle_irq) from [] (__irq_svc+0x44/0x5c) [ 15.117523] Exception stack(0xce09bdd0 to 0xce09be18) [ 15.117553] bdc0: 00000001 ce099110 00000000 ce098b40 [ 15.117553] bde0: 60000013 ce153860 ce153860 c0921a98 00000000 c0945464 60000013 c09216b0 [ 15.117584] be00: c0ac0218 ce09be18 c008371c c05db5f4 20000013 ffffffff [ 15.117584] [] (__irq_svc) from [] (_raw_spin_unlock_irqrestore+0x34/0x44) [ 15.117614] [] (_raw_spin_unlock_irqrestore) from [] (resume_irqs+0x84/0xdc) [ 15.117645] [] (resume_irqs) from [] (dpm_resume_noirq+0x210/0x2d4) [ 15.117675] [] (dpm_resume_noirq) from [] (suspend_devices_and_enter+0x324/0x600) [ 15.117675] [] (suspend_devices_and_enter) from [] (pm_suspend+0x3fc/0x470) [ 15.117706] [] (pm_suspend) from [] (state_store+0x68/0xb8) [ 15.117736] [] (state_store) from [] (kobj_attr_store+0x14/0x20) [ 15.117767] [] (kobj_attr_store) from [] (sysfs_kf_write+0x4c/0x50) [ 15.117767] [] (sysfs_kf_write) from [] (kernfs_fop_write+0xf0/0x19c) [ 15.117797] [] (kernfs_fop_write) from [] (vfs_write+0xa4/0x1ac) [ 15.117797] [] (vfs_write) from [] (SyS_write+0x40/0x8c) [ 15.117828] [] (SyS_write) from [] (ret_fast_syscall+0x0/0x48) [ 15.117828] ---[ end trace bdef08769742757b ]--- [ 15.124359] PM: early resume of devices complete after 5.523 msecs [ 15.133361] PM: resume of devices complete after 8.880 msecs [ 15.466369] PM: Finishing wakeup. [ 15.469848] Restarting tasks ... done. # # [ 15.679260] mmc0: host does not support reading read-only switch, assuming write-enable # # [ 15.688720] mmc0: new SDHC card at address e624 [ 15.697296] mmcblk0: mmc0:e624 SD08G 7.40 GiB [ 15.720306] mmcblk0: p1 p2 p3 cat /debug/pm_debug/count usbhost_pwrdm (ON),OFF:0,RET:496,INA:0,ON:497,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 sgx_pwrdm (OFF),OFF:1,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 core_pwrdm (ON),OFF:0,RET:1,INA:0,ON:2,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 per_pwrdm (ON),OFF:0,RET:1,INA:0,ON:2,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dss_pwrdm (ON),OFF:0,RET:496,INA:0,ON:497,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cam_pwrdm (RET),OFF:0,RET:1,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 neon_pwrdm (ON),OFF:0,RET:283,INA:213,ON:497,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:0,RET:283,INA:213,ON:497,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 iva2_pwrdm (RET),OFF:0,RET:1,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0,RET-MEMBANK4-OFF:0 usbhost_clkdm->usbhost_pwrdm (1) sgx_clkdm->sgx_pwrdm (0) per_clkdm->per_pwrdm (15) cam_clkdm->cam_pwrdm (0) dss_clkdm->dss_pwrdm (1) d2d_clkdm->core_pwrdm (0) iva2_clkdm->iva2_pwrdm (0) mpu_clkdm->mpu_pwrdm (0) core_l4_clkdm->core_pwrdm (27) core_l3_clkdm->core_pwrdm (1) neon_clkdm->neon_pwrdm (0) # # # # echo mem > /sys/power/state [ 17.310668] PM: Syncing filesystems ... done. [ 17.315704] PM: Preparing system for mem sleep [ 17.322631] Freezing user space processes ... (elapsed 0.000 seconds) done. [ 17.330261] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [ 17.340148] PM: Entering mem sleep [ 17.343719] Suspending console(s) (use no_console_suspend to debug) [ 17.373779] PM: suspend of devices complete after 16.937 msecs [ 17.382537] PM: late suspend of devices complete after 8.728 msecs [ 17.391326] PM: noirq suspend of devices complete after 8.758 msecs [ 17.391326] Disabling non-boot CPUs ... [ 17.391357] Successfully put all powerdomains to target state [ 17.396545] PM: noirq resume of devices complete after 5.096 msecs [ 17.396667] In-band Error seen by MPU at address 0 [ 17.396667] ------------[ cut here ]------------ [ 17.396697] WARNING: CPU: 0 PID: 1 at drivers/bus/omap_l3_smx.c:166 omap3_l3_app_irq+0xcc/0x124() [ 17.396728] Modules linked in: [ 17.396728] CPU: 0 PID: 1 Comm: sh Tainted: G W 3.19.0-rc1-14140-g97bf6af #1 [ 17.396759] Hardware name: Generic OMAP36xx (Flattened Device Tree) [ 17.396789] [] (unwind_backtrace) from [] (show_stack+0x10/0x14) [ 17.396820] [] (show_stack) from [] (dump_stack+0x80/0x9c) [ 17.396850] [] (dump_stack) from [] (warn_slowpath_common+0x78/0xb4) [ 17.396850] [] (warn_slowpath_common) from [] (warn_slowpath_null+0x1c/0x24) [ 17.396881] [] (warn_slowpath_null) from [] (omap3_l3_app_irq+0xcc/0x124) [ 17.396881] [] (omap3_l3_app_irq) from [] (handle_irq_event_percpu+0x60/0x1f4) [ 17.396911] [] (handle_irq_event_percpu) from [] (handle_irq_event+0x3c/0x5c) [ 17.396911] [] (handle_irq_event) from [] (handle_level_irq+0xb4/0x13c) [ 17.396942] [] (handle_level_irq) from [] (generic_handle_irq+0x20/0x30) [ 17.396942] [] (generic_handle_irq) from [] (__handle_domain_irq+0x68/0xdc) [ 17.396972] [] (__handle_domain_irq) from [] (omap_intc_handle_irq+0xb4/0xc4) [ 17.396972] [] (omap_intc_handle_irq) from [] (__irq_svc+0x44/0x5c) [ 17.397003] Exception stack(0xce09bdd0 to 0xce09be18) [ 17.397003] bdc0: 00000001 ce099110 00000000 ce098b40 [ 17.397033] bde0: 60000013 ce153860 ce153860 c0921a98 00000000 c0945464 60000013 c09216b0 [ 17.397033] be00: c0ac0218 ce09be18 c008371c c05db5f4 20000013 ffffffff [ 17.397064] [] (__irq_svc) from [] (_raw_spin_unlock_irqrestore+0x34/0x44) [ 17.397064] [] (_raw_spin_unlock_irqrestore) from [] (resume_irqs+0x84/0xdc) [ 17.397094] [] (resume_irqs) from [] (dpm_resume_noirq+0x210/0x2d4) [ 17.397125] [] (dpm_resume_noirq) from [] (suspend_devices_and_enter+0x324/0x600) [ 17.397155] [] (suspend_devices_and_enter) from [] (pm_suspend+0x3fc/0x470) [ 17.397155] [] (pm_suspend) from [] (state_store+0x68/0xb8) [ 17.397186] [] (state_store) from [] (kobj_attr_store+0x14/0x20) [ 17.397216] [] (kobj_attr_store) from [] (sysfs_kf_write+0x4c/0x50) [ 17.397216] [] (sysfs_kf_write) from [] (kernfs_fop_write+0xf0/0x19c) [ 17.397247] [] (kernfs_fop_write) from [] (vfs_write+0xa4/0x1ac) [ 17.397277] [] (vfs_write) from [] (SyS_write+0x40/0x8c) [ 17.397277] [] (SyS_write) from [] (ret_fast_syscall+0x0/0x48) [ 17.397277] ---[ end trace bdef08769742757c ]--- [ 17.403869] PM: early resume of devices complete after 5.615 msecs [ 17.597442] PM: resume of devices complete after 193.420 msecs [ 17.934783] PM: Finishing wakeup. [ 17.938293] Restarting tasks ... done. # # # # cat /debug/pm_debug/count usbhost_pwrdm (ON),OFF:0,RET:600,INA:0,ON:601,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 sgx_pwrdm (OFF),OFF:1,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 core_pwrdm (ON),OFF:0,RET:2,INA:0,ON:3,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 per_pwrdm (ON),OFF:0,RET:2,INA:0,ON:3,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dss_pwrdm (ON),OFF:0,RET:600,INA:0,ON:601,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cam_pwrdm (RET),OFF:0,RET:1,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 neon_pwrdm (ON),OFF:0,RET:383,INA:217,ON:601,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:0,RET:383,INA:217,ON:601,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 iva2_pwrdm (RET),OFF:0,RET:1,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0,RET-MEMBANK4-OFF:0 usbhost_clkdm->usbhost_pwrdm (1) sgx_clkdm->sgx_pwrdm (0) per_clkdm->per_pwrdm (15) cam_clkdm->cam_pwrdm (0) dss_clkdm->dss_pwrdm (1) d2d_clkdm->core_pwrdm (0) iva2_clkdm->iva2_pwrdm (0) mpu_clkdm->mpu_pwrdm (0) core_l4_clkdm->core_pwrdm (26) core_l3_clkdm->core_pwrdm (1) neon_clkdm->neon_pwrdm (0) # # # # ./test_rootfs_access_nonexistent_file__ret_susp /bin/sh: 41: ./test_rootfs_access_nonexistent_file__ret_susp: not found # # %% 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 # # 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 00:00 /sys/bus/platform/drivers/omap_uart/4806a000.serial/power/autosuspend_delay_ms 3000 -rw-r--r-- 1 root root 4096 Jan 1 00:00 /sys/bus/platform/drivers/omap_uart/4806c000.serial/power/autosuspend_delay_ms 3000 -rw-r--r-- 1 root root 4096 Jan 1 00:00 /sys/bus/platform/drivers/omap_uart/49020000.serial/power/autosuspend_delay_ms 3000 -rw-r--r-- 1 root root 4096 Jan 1 00:00 /sys/bus/platform/drivers/omap_uart/49042000.serial/power/autosuspend_delay_ms 3000 # # [ 33.045013] random: nonblocking pool is initialized # # cat /debug/pm_debug/count usbhost_pwrdm (ON),OFF:0,RET:791,INA:0,ON:792,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 sgx_pwrdm (OFF),OFF:1,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 core_pwrdm (ON),OFF:0,RET:13,INA:3,ON:17,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 per_pwrdm (ON),OFF:0,RET:110,INA:0,ON:111,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dss_pwrdm (ON),OFF:0,RET:791,INA:0,ON:792,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cam_pwrdm (RET),OFF:0,RET:1,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 neon_pwrdm (ON),OFF:0,RET:519,INA:272,ON:792,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:0,RET:519,INA:272,ON:792,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 iva2_pwrdm (RET),OFF:0,RET:1,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0,RET-MEMBANK4-OFF:0 usbhost_clkdm->usbhost_pwrdm (1) sgx_clkdm->sgx_pwrdm (0) per_clkdm->per_pwrdm (13) cam_clkdm->cam_pwrdm (0) dss_clkdm->dss_pwrdm (1) d2d_clkdm->core_pwrdm (0) iva2_clkdm->iva2_pwrdm (0) mpu_clkdm->mpu_pwrdm (0) core_l4_clkdm->core_pwrdm (21) core_l3_clkdm->core_pwrdm (1) neon_clkdm->neon_pwrdm (0) # # # # ./test_rootfs_access_nonexistent_file__ret_dyn /bin/sh: 53: ./test_rootfs_access_nonexistent_file__ret_dyn: not found # # for u in `ls -1d /sys/bus/platform/drivers/omap_uart/*.serial | paste -s -d' '`; do echo -1 > $u/power/autosuspend_delay_ms; done # # 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 00:00 /sys/bus/platform/drivers/omap_uart/4806a000.serial/power/autosuspend_delay_ms -1 -rw-r--r-- 1 root root 4096 Jan 1 00:00 /sys/bus/platform/drivers/omap_uart/4806c000.serial/power/autosuspend_delay_ms -1 -rw-r--r-- 1 root root 4096 Jan 1 00:00 /sys/bus/platform/drivers/omap_uart/49020000.serial/power/autosuspend_delay_ms -1 -rw-r--r-- 1 root root 4096 Jan 1 00:00 /sys/bus/platform/drivers/omap_uart/49042000.serial/power/autosuspend_delay_ms -1 # # %% End retention dynamic idle UART wakeup test %% Start off-mode double suspend UART wakeup test echo 1 > /debug/pm_debug/enable_off_mode # # echo mem > /sys/power/state [ 39.383911] PM: Syncing filesystems ... done. [ 39.389312] PM: Preparing system for mem sleep [ 39.396575] Freezing user space processes ... (elapsed 0.000 seconds) done. [ 39.404144] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [ 39.414031] PM: Entering mem sleep [ 39.417694] Suspending console(s) (use no_console_suspend to debug) [ 39.446594] PM: suspend of devices complete after 15.808 msecs [ 39.455291] PM: late suspend of devices complete after 8.666 msecs [ 39.463928] PM: noirq suspend of devices complete after 8.605 msecs [ 39.463958] Disabling non-boot CPUs ... [ 39.463958] Successfully put all powerdomains to target state [ 39.482788] PM: noirq resume of devices complete after 18.768 msecs [ 39.482910] In-band Error seen by MPU at address 0 [ 39.482910] ------------[ cut here ]------------ [ 39.482940] WARNING: CPU: 0 PID: 1 at drivers/bus/omap_l3_smx.c:166 omap3_l3_app_irq+0xcc/0x124() [ 39.482971] Modules linked in: [ 39.482971] CPU: 0 PID: 1 Comm: sh Tainted: G W 3.19.0-rc1-14140-g97bf6af #1 [ 39.482971] Hardware name: Generic OMAP36xx (Flattened Device Tree) [ 39.483032] [] (unwind_backtrace) from [] (show_stack+0x10/0x14) [ 39.483062] [] (show_stack) from [] (dump_stack+0x80/0x9c) [ 39.483062] [] (dump_stack) from [] (warn_slowpath_common+0x78/0xb4) [ 39.483093] [] (warn_slowpath_common) from [] (warn_slowpath_null+0x1c/0x24) [ 39.483093] [] (warn_slowpath_null) from [] (omap3_l3_app_irq+0xcc/0x124) [ 39.483123] [] (omap3_l3_app_irq) from [] (handle_irq_event_percpu+0x60/0x1f4) [ 39.483154] [] (handle_irq_event_percpu) from [] (handle_irq_event+0x3c/0x5c) [ 39.483154] [] (handle_irq_event) from [] (handle_level_irq+0xb4/0x13c) [ 39.483184] [] (handle_level_irq) from [] (generic_handle_irq+0x20/0x30) [ 39.483184] [] (generic_handle_irq) from [] (__handle_domain_irq+0x68/0xdc) [ 39.483215] [] (__handle_domain_irq) from [] (omap_intc_handle_irq+0xb4/0xc4) [ 39.483215] [] (omap_intc_handle_irq) from [] (__irq_svc+0x44/0x5c) [ 39.483245] Exception stack(0xce09bdd0 to 0xce09be18) [ 39.483245] bdc0: 00000001 ce099110 00000000 ce098b40 [ 39.483245] bde0: 60000153 ce153860 ce153860 c0921a98 00000000 c0945464 60000153 c09216b0 [ 39.483276] be00: c0ac0218 ce09be18 c008371c c05db5f4 20000153 ffffffff [ 39.483306] [] (__irq_svc) from [] (_raw_spin_unlock_irqrestore+0x34/0x44) [ 39.483306] [] (_raw_spin_unlock_irqrestore) from [] (resume_irqs+0x84/0xdc) [ 39.483337] [] (resume_irqs) from [] (dpm_resume_noirq+0x210/0x2d4) [ 39.483367] [] (dpm_resume_noirq) from [] (suspend_devices_and_enter+0x324/0x600) [ 39.483398] [] (suspend_devices_and_enter) from [] (pm_suspend+0x3fc/0x470) [ 39.483398] [] (pm_suspend) from [] (state_store+0x68/0xb8) [ 39.483428] [] (state_store) from [] (kobj_attr_store+0x14/0x20) [ 39.483459] [] (kobj_attr_store) from [] (sysfs_kf_write+0x4c/0x50) [ 39.483459] [] (sysfs_kf_write) from [] (kernfs_fop_write+0xf0/0x19c) [ 39.483489] [] (kernfs_fop_write) from [] (vfs_write+0xa4/0x1ac) [ 39.483489] [] (vfs_write) from [] (SyS_write+0x40/0x8c) [ 39.483520] [] (SyS_write) from [] (ret_fast_syscall+0x0/0x48) [ 39.483520] ---[ end trace bdef08769742757d ]--- [ 39.490203] PM: early resume of devices complete after 5.615 msecs [ 39.676849] PM: resume of devices complete after 186.492 msecs [ 40.013854] PM: Finishing wakeup. [ 40.017395] Restarting tasks ... done. # # # # cat /debug/pm_debug/count usbhost_pwrdm (ON),OFF:26,RET:954,INA:0,ON:981,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 sgx_pwrdm (OFF),OFF:1,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 core_pwrdm (ON),OFF:1,RET:13,INA:3,ON:18,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 per_pwrdm (ON),OFF:1,RET:204,INA:0,ON:206,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dss_pwrdm (ON),OFF:26,RET:954,INA:0,ON:981,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cam_pwrdm (OFF),OFF:1,RET:1,INA:0,ON:2,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 neon_pwrdm (ON),OFF:20,RET:630,INA:330,ON:981,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:20,RET:630,INA:330,ON:981,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 iva2_pwrdm (OFF),OFF:1,RET:1,INA:0,ON:2,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0,RET-MEMBANK4-OFF:0 usbhost_clkdm->usbhost_pwrdm (1) sgx_clkdm->sgx_pwrdm (0) per_clkdm->per_pwrdm (15) cam_clkdm->cam_pwrdm (0) dss_clkdm->dss_pwrdm (1) d2d_clkdm->core_pwrdm (0) iva2_clkdm->iva2_pwrdm (0) mpu_clkdm->mpu_pwrdm (0) core_l4_clkdm->core_pwrdm (27) core_l3_clkdm->core_pwrdm (1) neon_clkdm->neon_pwrdm (0) # # # # echo mem > /sys/power/state [ 42.662292] PM: Syncing filesystems ... done. [ 42.667724] PM: Preparing system for mem sleep [ 42.674713] Freezing user space processes ... (elapsed 0.000 seconds) done. [ 42.682281] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [ 42.692169] PM: Entering mem sleep [ 42.695831] Suspending console(s) (use no_console_suspend to debug) [ 42.724853] PM: suspend of devices complete after 15.930 msecs [ 42.733398] PM: late suspend of devices complete after 8.514 msecs [ 42.742156] PM: noirq suspend of devices complete after 8.728 msecs [ 42.742187] Disabling non-boot CPUs ... [ 42.742187] Successfully put all powerdomains to target state [ 42.760925] PM: noirq resume of devices complete after 18.676 msecs [ 42.761047] In-band Error seen by MPU at address 0 [ 42.761047] ------------[ cut here ]------------ [ 42.761077] WARNING: CPU: 0 PID: 1 at drivers/bus/omap_l3_smx.c:166 omap3_l3_app_irq+0xcc/0x124() [ 42.761108] Modules linked in: [ 42.761108] CPU: 0 PID: 1 Comm: sh Tainted: G W 3.19.0-rc1-14140-g97bf6af #1 [ 42.761108] Hardware name: Generic OMAP36xx (Flattened Device Tree) [ 42.761169] [] (unwind_backtrace) from [] (show_stack+0x10/0x14) [ 42.761199] [] (show_stack) from [] (dump_stack+0x80/0x9c) [ 42.761199] [] (dump_stack) from [] (warn_slowpath_common+0x78/0xb4) [ 42.761230] [] (warn_slowpath_common) from [] (warn_slowpath_null+0x1c/0x24) [ 42.761230] [] (warn_slowpath_null) from [] (omap3_l3_app_irq+0xcc/0x124) [ 42.761260] [] (omap3_l3_app_irq) from [] (handle_irq_event_percpu+0x60/0x1f4) [ 42.761291] [] (handle_irq_event_percpu) from [] (handle_irq_event+0x3c/0x5c) [ 42.761291] [] (handle_irq_event) from [] (handle_level_irq+0xb4/0x13c) [ 42.761322] [] (handle_level_irq) from [] (generic_handle_irq+0x20/0x30) [ 42.761322] [] (generic_handle_irq) from [] (__handle_domain_irq+0x68/0xdc) [ 42.761352] [] (__handle_domain_irq) from [] (omap_intc_handle_irq+0xb4/0xc4) [ 42.761352] [] (omap_intc_handle_irq) from [] (__irq_svc+0x44/0x5c) [ 42.761383] Exception stack(0xce09bdd0 to 0xce09be18) [ 42.761383] bdc0: 00000001 ce099110 00000000 ce098b40 [ 42.761383] bde0: 60000153 ce153860 ce153860 c0921a98 00000000 c0945464 60000153 c09216b0 [ 42.761413] be00: c0ac0218 ce09be18 c008371c c05db5f4 20000153 ffffffff [ 42.761444] [] (__irq_svc) from [] (_raw_spin_unlock_irqrestore+0x34/0x44) [ 42.761444] [] (_raw_spin_unlock_irqrestore) from [] (resume_irqs+0x84/0xdc) [ 42.761474] [] (resume_irqs) from [] (dpm_resume_noirq+0x210/0x2d4) [ 42.761505] [] (dpm_resume_noirq) from [] (suspend_devices_and_enter+0x324/0x600) [ 42.761535] [] (suspend_devices_and_enter) from [] (pm_suspend+0x3fc/0x470) [ 42.761535] [] (pm_suspend) from [] (state_store+0x68/0xb8) [ 42.761566] [] (state_store) from [] (kobj_attr_store+0x14/0x20) [ 42.761596] [] (kobj_attr_store) from [] (sysfs_kf_write+0x4c/0x50) [ 42.761596] [] (sysfs_kf_write) from [] (kernfs_fop_write+0xf0/0x19c) [ 42.761627] [] (kernfs_fop_write) from [] (vfs_write+0xa4/0x1ac) [ 42.761627] [] (vfs_write) from [] (SyS_write+0x40/0x8c) [ 42.761657] [] (SyS_write) from [] (ret_fast_syscall+0x0/0x48) [ 42.761657] ---[ end trace bdef08769742757e ]--- [ 42.768371] PM: early resume of devices complete after 5.706 msecs [ 42.956695] PM: resume of devices complete after 188.201 msecs [ 43.292297] PM: Finishing wakeup. [ 43.295806] Restarting tasks ... done. # # # # cat /debug/pm_debug/count usbhost_pwrdm (ON),OFF:115,RET:954,INA:0,ON:1070,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 sgx_pwrdm (OFF),OFF:1,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 core_pwrdm (ON),OFF:2,RET:13,INA:3,ON:19,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 per_pwrdm (ON),OFF:2,RET:204,INA:0,ON:207,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dss_pwrdm (ON),OFF:115,RET:954,INA:0,ON:1070,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cam_pwrdm (OFF),OFF:1,RET:1,INA:0,ON:2,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 neon_pwrdm (ON),OFF:44,RET:694,INA:331,ON:1070,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:44,RET:694,INA:331,ON:1070,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 iva2_pwrdm (OFF),OFF:1,RET:1,INA:0,ON:2,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0,RET-MEMBANK4-OFF:0 usbhost_clkdm->usbhost_pwrdm (1) sgx_clkdm->sgx_pwrdm (0) per_clkdm->per_pwrdm (15) cam_clkdm->cam_pwrdm (0) dss_clkdm->dss_pwrdm (1) d2d_clkdm->core_pwrdm (0) iva2_clkdm->iva2_pwrdm (0) mpu_clkdm->mpu_pwrdm (0) core_l4_clkdm->core_pwrdm (27) core_l3_clkdm->core_pwrdm (1) neon_clkdm->neon_pwrdm (0) # # # # ./test_rootfs_access_nonexistent_file__off_susp /bin/sh: 77: ./test_rootfs_access_nonexistent_file__off_susp: not found # # %% End off-mode double suspend UART wakeup test %% Start off-mode dynamic idle UART wakeup test for u in `ls -1d /sys/bus/platform/drivers/omap_uart/*.serial | paste -s -d' '`; do echo 3000 > $u/power/autosuspend_delay_ms; done # # 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 00:00 /sys/bus/platform/drivers/omap_uart/4806a000.serial/power/autosuspend_delay_ms 3000 -rw-r--r-- 1 root root 4096 Jan 1 00:00 /sys/bus/platform/drivers/omap_uart/4806c000.serial/power/autosuspend_delay_ms 3000 -rw-r--r-- 1 root root 4096 Jan 1 00:00 /sys/bus/platform/drivers/omap_uart/49020000.serial/power/autosuspend_delay_ms 3000 -rw-r--r-- 1 root root 4096 Jan 1 00:00 /sys/bus/platform/drivers/omap_uart/49042000.serial/power/autosuspend_delay_ms 3000 # # # # cat /debug/pm_debug/count usbhost_pwrdm (ON),OFF:317,RET:954,INA:0,ON:1272,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 sgx_pwrdm (OFF),OFF:1,RET:0,INA:0,ON:1,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 core_pwrdm (ON),OFF:12,RET:13,INA:3,ON:29,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 per_pwrdm (ON),OFF:12,RET:308,INA:0,ON:321,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dss_pwrdm (ON),OFF:317,RET:954,INA:0,ON:1272,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 cam_pwrdm (OFF),OFF:1,RET:1,INA:0,ON:2,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 neon_pwrdm (ON),OFF:98,RET:781,INA:392,ON:1272,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:98,RET:781,INA:392,ON:1272,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 iva2_pwrdm (OFF),OFF:1,RET:1,INA:0,ON:2,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0,RET-MEMBANK3-OFF:0,RET-MEMBANK4-OFF:0 usbhost_clkdm->usbhost_pwrdm (1) sgx_clkdm->sgx_pwrdm (0) per_clkdm->per_pwrdm (13) cam_clkdm->cam_pwrdm (0) dss_clkdm->dss_pwrdm (1) d2d_clkdm->core_pwrdm (0) iva2_clkdm->iva2_pwrdm (0) mpu_clkdm->mpu_pwrdm (0) core_l4_clkdm->core_pwrdm (21) core_l3_clkdm->core_pwrdm (1) neon_clkdm->neon_pwrdm (0) # # # # ./test_rootfs_access_nonexistent_file__off_dyn /bin/sh: 89: ./test_rootfs_access_nonexistent_file__off_dyn: not found # # %% End off-mode dynamic idle UART wakeup test %% End PM consolidated quick test