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-14143-g99d076b (paul@nozomi) (gcc version 4.7.2 (Debian 4.7.2-5) ) #1 SMP Sat Jan 3 14:48:27 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.000030] OMAP clocksource: 32k_counter at 32768 Hz [ 0.001159] Console: colour dummy device 80x30 [ 0.001251] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.001251] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.001251] ... MAX_LOCK_DEPTH: 48 [ 0.001281] ... MAX_LOCKDEP_KEYS: 8191 [ 0.001281] ... CLASSHASH_SIZE: 4096 [ 0.001312] ... MAX_LOCKDEP_ENTRIES: 32768 [ 0.001312] ... MAX_LOCKDEP_CHAINS: 65536 [ 0.001342] ... CHAINHASH_SIZE: 32768 [ 0.001342] memory used by lock dependency info: 5167 kB [ 0.001342] 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.116516] 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.309265] pinctrl core: initialized pinctrl subsystem [ 0.408630] NET: Registered protocol family 16 [ 0.417541] DMA: preallocated 256 KiB pool for atomic coherent allocations [ 0.420471] cpuidle: using governor ladder [ 0.420501] cpuidle: using governor menu [ 0.428924] Reprogramming SDRC clock to 400000000 Hz [ 0.442840] gpiochip_add: registered GPIOs 0 to 31 on device: gpio [ 0.444091] OMAP GPIO hardware version 2.5 [ 0.446014] gpiochip_add: registered GPIOs 32 to 63 on device: gpio [ 0.449218] gpiochip_add: registered GPIOs 64 to 95 on device: gpio [ 0.451934] gpiochip_add: registered GPIOs 96 to 127 on device: gpio [ 0.454620] gpiochip_add: registered GPIOs 128 to 159 on device: gpio [ 0.457427] gpiochip_add: registered GPIOs 160 to 191 on device: gpio [ 0.459045] irq: no irq domain found for /ocp/pinmux@48002030 ! [ 0.459991] irq: no irq domain found for /ocp/pinmux@48002030 ! [ 0.460906] irq: no irq domain found for /ocp/pinmux@48002030 ! [ 0.486328] omap-gpmc 6e000000.gpmc: GPMC revision 5.0 [ 0.491271] platform 48058000.ssi-controller: Cannot lookup hwmod 'ssi' [ 0.499969] No ATAGs? [ 0.500030] hw-breakpoint: debug architecture 0x4 unsupported. [ 0.503723] OMAP DMA hardware revision 5.0 [ 0.593749] omap-dma-engine 48056000.dma-controller: OMAP DMA engine driver [ 0.595031] of_get_named_gpiod_flags: can't parse 'gpio' property of node '/regulator-vddvario[0]' [ 0.596252] of_get_named_gpiod_flags: can't parse 'gpio' property of node '/regulator-vdd33a[0]' [ 0.597503] reg-fixed-voltage wl12xx_vmmc: could not find pctldev for node /ocp/pinmux@48002030/pinmux_wl12xx_gpio, deferring probe [ 0.597564] platform wl12xx_vmmc: Driver reg-fixed-voltage requests probe deferral [ 0.597869] of_get_named_gpiod_flags: parsed 'gpio' property of node '/regulator-lcd-3v3[0]' - status (0) [ 0.604583] SCSI subsystem initialized [ 0.605529] libata version 3.00 loaded. [ 0.606872] usbcore: registered new interface driver usbfs [ 0.607147] usbcore: registered new interface driver hub [ 0.607330] usbcore: registered new device driver usb [ 0.614288] omap_i2c 48070000.i2c: bus 0 rev4.4 at 2600 kHz [ 0.615875] omap_i2c 48072000.i2c: bus 1 rev4.4 at 400 kHz [ 0.619018] omap_i2c 48060000.i2c: bus 2 rev4.4 at 400 kHz [ 0.625122] Switched to clocksource 32k_counter [ 0.841064] NET: Registered protocol family 2 [ 0.843322] TCP established hash table entries: 2048 (order: 1, 8192 bytes) [ 0.843566] TCP bind hash table entries: 2048 (order: 4, 73728 bytes) [ 0.844696] TCP: Hash tables configured (established 2048 bind 2048) [ 0.844940] TCP: reno registered [ 0.845001] UDP hash table entries: 256 (order: 2, 20480 bytes) [ 0.845458] UDP-Lite hash table entries: 256 (order: 2, 20480 bytes) [ 0.847076] NET: Registered protocol family 1 [ 0.849090] RPC: Registered named UNIX socket transport module. [ 0.849121] RPC: Registered udp transport module. [ 0.849121] RPC: Registered tcp transport module. [ 0.849151] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.851165] hw perfevents: enabled with armv7_cortex_a8 PMU driver, 5 counters available [ 0.859313] futex hash table entries: 256 (order: 2, 16384 bytes) [ 0.859649] audit: initializing netlink subsys (disabled) [ 0.859954] audit: type=2000 audit(0.840:1): initialized [ 0.865966] VFS: Disk quotas dquot_6.5.2 [ 0.866180] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 0.869323] NFS: Registering the id_resolver key type [ 0.869781] Key type id_resolver registered [ 0.869812] Key type id_legacy registered [ 0.870056] jffs2: version 2.2. (NAND) (SUMMARY) © 2001-2006 Red Hat, Inc. [ 0.875885] io scheduler noop registered [ 0.875946] io scheduler deadline registered [ 0.876068] io scheduler cfq registered (default) [ 0.880126] pinctrl-single 48002030.pinmux: 284 pins at pa fa002030 size 568 [ 0.880859] pinctrl-single 48002a00.pinmux: 46 pins at pa fa002a00 size 92 [ 0.881988] pinctrl-single 480025a0.pinmux: 46 pins at pa fa0025a0 size 92 [ 0.891571] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 0.900634] of_get_named_gpiod_flags: can't parse 'rts-gpio' property of node '/ocp/serial@4806a000[0]' [ 0.901306] omap_uart 4806a000.serial: ttyO0 at MMIO 0x4806a000 (irq = 224, base_baud = 3000000) is a OMAP UART0 [ 1.782440] console [ttyO0] enabled [ 1.788940] of_get_named_gpiod_flags: can't parse 'rts-gpio' property of node '/ocp/serial@4806c000[0]' [ 1.799346] omap_uart 4806c000.serial: ttyO1 at MMIO 0x4806c000 (irq = 225, base_baud = 3000000) is a OMAP UART1 [ 1.812316] of_get_named_gpiod_flags: can't parse 'rts-gpio' property of node '/ocp/serial@49020000[0]' [ 1.822662] omap_uart 49020000.serial: ttyO2 at MMIO 0x49020000 (irq = 226, base_baud = 3000000) is a OMAP UART2 [ 1.835693] omap_uart 49042000.serial: no wakeirq for uart0 [ 1.841613] of_get_named_gpiod_flags: can't parse 'rts-gpio' property of node '/ocp/serial@49042000[0]' [ 1.851928] omap_uart 49042000.serial: ttyO3 at MMIO 0x49042000 (irq = 260, base_baud = 3000000) is a OMAP UART3 [ 1.896118] brd: module loaded [ 1.918975] loop: module loaded [ 1.951660] twl 0-0048: PIH (irq 297) chaining IRQs 298..306 [ 1.958190] twl 0-0048: power (irq 303) chaining IRQs 306..313 [ 2.022155] twl4030_gpio twl4030-gpio: gpio (irq 298) chaining IRQs 314..331 [ 2.030181] gpiochip_find_base: found new base at 492 [ 2.036285] gpiochip_add: registered GPIOs 492 to 511 on device: twl4030 [ 2.108856] mtdoops: mtd device (mtddev=name/number) must be supplied [ 2.116973] nand: Could not find valid ONFI parameter page; aborting [ 2.123718] nand: device found, Manufacturer ID: 0xad, Chip ID: 0xbc [ 2.130493] nand: Hynix NAND 512MiB 1,8V 16-bit [ 2.135345] nand: 512 MiB, SLC, erase size: 128 KiB, page size: 2048, OOB size: 64 [ 2.143310] nand: using OMAP_ECC_BCH8_CODE_HW_DETECTION_SW [ 2.151977] 5 ofpart partitions found on MTD device omap2-nand.0 [ 2.158386] Creating 5 MTD partitions on "omap2-nand.0": [ 2.164001] 0x000000000000-0x000000080000 : "X-Loader" [ 2.177368] 0x000000080000-0x000000240000 : "U-Boot" [ 2.188537] 0x000000240000-0x000000280000 : "Environment" [ 2.198791] 0x000000280000-0x000000780000 : "Kernel" [ 2.212707] 0x000000780000-0x000020000000 : "Filesystem" [ 2.679290] 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.696563] smsc911x 2c000000.ethernet eth0: MAC Address: 00:50:c2:7e:99:42 [ 2.706176] usbcore: registered new interface driver asix [ 2.712066] usbcore: registered new interface driver ax88179_178a [ 2.718749] usbcore: registered new interface driver cdc_ether [ 2.725250] usbcore: registered new interface driver smsc95xx [ 2.731475] usbcore: registered new interface driver net1080 [ 2.737670] usbcore: registered new interface driver cdc_subset [ 2.744110] usbcore: registered new interface driver zaurus [ 2.750335] usbcore: registered new interface driver cdc_ncm [ 2.757873] usbcore: registered new interface driver cdc_wdm [ 2.764129] usbcore: registered new interface driver usb-storage [ 2.770843] usbcore: registered new interface driver usbtest [ 2.780273] mousedev: PS/2 mouse device common for all mice [ 2.788696] input: TWL4030 Keypad as /devices/platform/68000000.ocp/48070000.i2c/i2c-0/0-0048/48070000.i2c:twl@48:keypad/input/input0 [ 2.809509] input: twl4030_pwrbutton as /devices/platform/68000000.ocp/48070000.i2c/i2c-0/0-0048/48070000.i2c:twl@48:pwrbutton/input/input1 [ 2.826293] twl_rtc 48070000.i2c:twl@48:rtc: Power up reset detected. [ 2.833404] twl_rtc 48070000.i2c:twl@48:rtc: Enabling TWL-RTC [ 2.844482] twl_rtc 48070000.i2c:twl@48:rtc: rtc core: registered 48070000.i2c:twl@48 as rtc0 [ 2.854736] i2c /dev entries driver [ 2.861846] Driver for 1-wire Dallas network protocol. [ 2.871795] omap_wdt: OMAP Watchdog Timer Rev 0x31: initial timeout 60 sec [ 2.881835] Driver 'mmcblk' needs updating - please use bus_type methods [ 2.890716] of_get_named_gpiod_flags: can't parse 'cd-gpios' property of node '/ocp/mmc@4809c000[0]' [ 2.900451] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@4809c000[0]' [ 2.955688] of_get_named_gpiod_flags: can't parse 'cd-gpios' property of node '/ocp/mmc@480b4000[0]' [ 2.965423] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@480b4000[0]' [ 2.975952] omap_hsmmc 480b4000.mmc: unable to get vmmc regulator -517 [ 2.983520] platform 480b4000.mmc: Driver omap_hsmmc requests probe deferral [ 2.992462] of_get_named_gpiod_flags: parsed 'gpios' property of node '/leds/ledb[0]' - status (0) [ 3.009521] ledtrig-cpu: registered to indicate activity on CPUs [ 3.017150] usbcore: registered new interface driver usbhid [ 3.023040] usbhid: USB HID core driver [ 3.029968] oprofile: using arm/armv7 [ 3.034729] TCP: cubic registered [ 3.038360] Initializing XFRM netlink socket [ 3.043029] NET: Registered protocol family 17 [ 3.047943] NET: Registered protocol family 15 [ 3.053100] Key type dns_resolver registered [ 3.058135] 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.071899] omap2_set_init_voltage: unable to find boot up OPP for vdd_core [ 3.079284] omap2_set_init_voltage: unable to set vdd_core [ 3.090026] ThumbEE CPU extension supported. [ 3.094573] Registering SWP/SWPB emulation handler [ 3.099761] SmartReflex Class3 initialized [ 3.116271] of_get_named_gpiod_flags: parsed 'gpio' property of node '/wl12xx_vmmc[0]' - status (0) [ 3.127136] vwl1271: supplied by VMMC2 [ 3.132812] of_get_named_gpiod_flags: can't parse 'cd-gpios' property of node '/ocp/mmc@480b4000[0]' [ 3.142578] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@480b4000[0]' [ 3.280242] twl_rtc 48070000.i2c:twl@48:rtc: setting system clock to 2000-01-01 00:00:00 UTC (946684800) [ 3.290344] sr_init: No PMIC hook to init smartreflex [ 3.296356] smartreflex smartreflex.0: omap_sr_probe: SmartReflex driver initialized [ 3.305572] smartreflex smartreflex.1: omap_sr_probe: SmartReflex driver initialized [ 3.402526] smsc911x 2c000000.ethernet eth0: SMSC911x/921x identified at 0xd087e000, IRQ: 208 [ 5.265258] mmc0: card never left busy state [ 5.269805] mmc0: error -110 whilst initialising SD card [ 5.705261] Sending DHCP requests ., OK [ 5.725738] IP-Config: Got DHCP answer from 192.168.57.1, my address is 192.168.57.131 [ 5.734863] IP-Config: Complete: [ 5.738403] 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.749633] host=192.168.57.131, domain=example.org, nis-domain=(none) [ 5.757019] bootserver=0.0.0.0, rootserver=192.168.57.1, rootpath= [ 5.763824] nameserver0=192.168.57.1 [ 5.768676] vwl1271: disabling [ 5.773071] VUSB3V1: disabling [ 5.779052] lcd_3v3: disabling [ 5.808776] VFS: Mounted root (nfs filesystem) readonly on device 0:14. [ 5.818115] devtmpfs: mounted [ 5.822326] 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:264,INA:0,ON:265,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:264,INA:0,ON:265,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:112,INA:152,ON:265,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:0,RET:112,INA:152,ON:265,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.037078] PM: Syncing filesystems ... done. [ 15.043945] PM: Preparing system for mem sleep [ 15.057250] Freezing user space processes ... (elapsed 0.000 seconds) done. [ 15.064849] Freezing remaining freezable tasks ... (elapsed 0.002 seconds) done. [ 15.075744] PM: Entering mem sleep [ 15.079345] Suspending console(s) (use no_console_suspend to debug) [ 15.111175] PM: suspend of devices complete after 18.646 msecs [ 15.119903] PM: late suspend of devices complete after 8.728 msecs [ 15.129150] PM: noirq suspend of devices complete after 9.216 msecs [ 15.129272] Disabling non-boot CPUs ... [ 15.129272] Successfully put all powerdomains to target state [ 15.134460] PM: noirq resume of devices complete after 5.096 msecs [ 15.134613] In-band Error seen by MPU at address 0 [ 15.134613] ------------[ cut here ]------------ [ 15.134643] WARNING: CPU: 0 PID: 1 at drivers/bus/omap_l3_smx.c:166 omap3_l3_app_irq+0xcc/0x124() [ 15.134674] Modules linked in: [ 15.134674] CPU: 0 PID: 1 Comm: sh Not tainted 3.19.0-rc1-14143-g99d076b #1 [ 15.134704] Hardware name: Generic OMAP36xx (Flattened Device Tree) [ 15.134735] [] (unwind_backtrace) from [] (show_stack+0x10/0x14) [ 15.134765] [] (show_stack) from [] (dump_stack+0x80/0x9c) [ 15.134765] [] (dump_stack) from [] (warn_slowpath_common+0x78/0xb4) [ 15.134796] [] (warn_slowpath_common) from [] (warn_slowpath_null+0x1c/0x24) [ 15.134796] [] (warn_slowpath_null) from [] (omap3_l3_app_irq+0xcc/0x124) [ 15.134826] [] (omap3_l3_app_irq) from [] (handle_irq_event_percpu+0x60/0x1f4) [ 15.134857] [] (handle_irq_event_percpu) from [] (handle_irq_event+0x3c/0x5c) [ 15.134857] [] (handle_irq_event) from [] (handle_level_irq+0xb4/0x13c) [ 15.134887] [] (handle_level_irq) from [] (generic_handle_irq+0x20/0x30) [ 15.134887] [] (generic_handle_irq) from [] (__handle_domain_irq+0x68/0xdc) [ 15.134918] [] (__handle_domain_irq) from [] (omap_intc_handle_irq+0xb4/0xc4) [ 15.134918] [] (omap_intc_handle_irq) from [] (__irq_svc+0x44/0x5c) [ 15.134948] Exception stack(0xce09bdd0 to 0xce09be18) [ 15.134948] bdc0: 00000001 ce099110 00000000 ce098b40 [ 15.134979] bde0: 60000013 ce153860 ce153860 c0921a98 00000000 c0945464 60000013 c09216b0 [ 15.134979] be00: c0ac0218 ce09be18 c008371c c05db5f4 20000013 ffffffff [ 15.135009] [] (__irq_svc) from [] (_raw_spin_unlock_irqrestore+0x34/0x44) [ 15.135009] [] (_raw_spin_unlock_irqrestore) from [] (resume_irqs+0x84/0xdc) [ 15.135040] [] (resume_irqs) from [] (dpm_resume_noirq+0x210/0x2d4) [ 15.135070] [] (dpm_resume_noirq) from [] (suspend_devices_and_enter+0x324/0x600) [ 15.135101] [] (suspend_devices_and_enter) from [] (pm_suspend+0x3fc/0x470) [ 15.135101] [] (pm_suspend) from [] (state_store+0x68/0xb8) [ 15.135131] [] (state_store) from [] (kobj_attr_store+0x14/0x20) [ 15.135162] [] (kobj_attr_store) from [] (sysfs_kf_write+0x4c/0x50) [ 15.135162] [] (sysfs_kf_write) from [] (kernfs_fop_write+0xf0/0x19c) [ 15.135192] [] (kernfs_fop_write) from [] (vfs_write+0xa4/0x1ac) [ 15.135192] [] (vfs_write) from [] (SyS_write+0x40/0x8c) [ 15.135223] [] (SyS_write) from [] (ret_fast_syscall+0x0/0x48) [ 15.135223] ---[ end trace f2bd4718062f5217 ]--- [ 15.141876] PM: early resume of devices complete after 5.523 msecs [ 15.150939] PM: resume of devices complete after 8.941 msecs [ 15.486663] PM: Finishing wakeup. [ 15.490142] Restarting tasks ... done. # # [ 15.699371] mmc0: host does not support reading read-only switch, assuming write-enable # # [ 15.708831] mmc0: new SDHC card at address e624 [ 15.717407] mmcblk0: mmc0:e624 SD08G 7.40 GiB [ 15.740447] mmcblk0: p1 p2 p3 cat /debug/pm_debug/count usbhost_pwrdm (ON),OFF:0,RET:615,INA:0,ON:616,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:615,INA:0,ON:616,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:295,INA:320,ON:616,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:0,RET:295,INA:320,ON:616,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.328857] PM: Syncing filesystems ... done. [ 17.333862] PM: Preparing system for mem sleep [ 17.340850] Freezing user space processes ... (elapsed 0.000 seconds) done. [ 17.348480] Freezing remaining freezable tasks ... (elapsed 0.002 seconds) done. [ 17.358367] PM: Entering mem sleep [ 17.361968] Suspending console(s) (use no_console_suspend to debug) [ 17.392089] PM: suspend of devices complete after 16.937 msecs [ 17.400848] PM: late suspend of devices complete after 8.728 msecs [ 17.409637] PM: noirq suspend of devices complete after 8.728 msecs [ 17.409637] Disabling non-boot CPUs ... [ 17.409667] Successfully put all powerdomains to target state [ 17.414855] PM: noirq resume of devices complete after 5.096 msecs [ 17.414978] In-band Error seen by MPU at address 0 [ 17.414978] ------------[ cut here ]------------ [ 17.415008] WARNING: CPU: 0 PID: 1 at drivers/bus/omap_l3_smx.c:166 omap3_l3_app_irq+0xcc/0x124() [ 17.415039] Modules linked in: [ 17.415039] CPU: 0 PID: 1 Comm: sh Tainted: G W 3.19.0-rc1-14143-g99d076b #1 [ 17.415039] Hardware name: Generic OMAP36xx (Flattened Device Tree) [ 17.415100] [] (unwind_backtrace) from [] (show_stack+0x10/0x14) [ 17.415130] [] (show_stack) from [] (dump_stack+0x80/0x9c) [ 17.415130] [] (dump_stack) from [] (warn_slowpath_common+0x78/0xb4) [ 17.415161] [] (warn_slowpath_common) from [] (warn_slowpath_null+0x1c/0x24) [ 17.415161] [] (warn_slowpath_null) from [] (omap3_l3_app_irq+0xcc/0x124) [ 17.415191] [] (omap3_l3_app_irq) from [] (handle_irq_event_percpu+0x60/0x1f4) [ 17.415222] [] (handle_irq_event_percpu) from [] (handle_irq_event+0x3c/0x5c) [ 17.415222] [] (handle_irq_event) from [] (handle_level_irq+0xb4/0x13c) [ 17.415252] [] (handle_level_irq) from [] (generic_handle_irq+0x20/0x30) [ 17.415252] [] (generic_handle_irq) from [] (__handle_domain_irq+0x68/0xdc) [ 17.415283] [] (__handle_domain_irq) from [] (omap_intc_handle_irq+0xb4/0xc4) [ 17.415283] [] (omap_intc_handle_irq) from [] (__irq_svc+0x44/0x5c) [ 17.415283] Exception stack(0xce09bdd0 to 0xce09be18) [ 17.415313] bdc0: 00000001 ce099110 00000000 ce098b40 [ 17.415313] bde0: 60000013 ce153860 ce153860 c0921a98 00000000 c0945464 60000013 c09216b0 [ 17.415344] be00: c0ac0218 ce09be18 c008371c c05db5f4 20000013 ffffffff [ 17.415374] [] (__irq_svc) from [] (_raw_spin_unlock_irqrestore+0x34/0x44) [ 17.415374] [] (_raw_spin_unlock_irqrestore) from [] (resume_irqs+0x84/0xdc) [ 17.415405] [] (resume_irqs) from [] (dpm_resume_noirq+0x210/0x2d4) [ 17.415435] [] (dpm_resume_noirq) from [] (suspend_devices_and_enter+0x324/0x600) [ 17.415466] [] (suspend_devices_and_enter) from [] (pm_suspend+0x3fc/0x470) [ 17.415466] [] (pm_suspend) from [] (state_store+0x68/0xb8) [ 17.415496] [] (state_store) from [] (kobj_attr_store+0x14/0x20) [ 17.415527] [] (kobj_attr_store) from [] (sysfs_kf_write+0x4c/0x50) [ 17.415527] [] (sysfs_kf_write) from [] (kernfs_fop_write+0xf0/0x19c) [ 17.415557] [] (kernfs_fop_write) from [] (vfs_write+0xa4/0x1ac) [ 17.415557] [] (vfs_write) from [] (SyS_write+0x40/0x8c) [ 17.415588] [] (SyS_write) from [] (ret_fast_syscall+0x0/0x48) [ 17.415588] ---[ end trace f2bd4718062f5218 ]--- [ 17.422180] PM: early resume of devices complete after 5.615 msecs [ 17.617523] PM: resume of devices complete after 195.190 msecs [ 17.954864] PM: Finishing wakeup. [ 17.958374] Restarting tasks ... done. # # # # cat /debug/pm_debug/count usbhost_pwrdm (ON),OFF:0,RET:719,INA:0,ON:720,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:719,INA:0,ON:720,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:394,INA:325,ON:720,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:0,RET:394,INA:325,ON:720,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) # # # # ./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 # # [ 27.965148] random: nonblocking pool is initialized # # cat /debug/pm_debug/count usbhost_pwrdm (ON),OFF:0,RET:966,INA:0,ON:967,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:5,INA:0,ON:6,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 per_pwrdm (ON),OFF:0,RET:165,INA:0,ON:166,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dss_pwrdm (ON),OFF:0,RET:966,INA:0,ON:967,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:548,INA:418,ON:967,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:0,RET:548,INA:418,ON:967,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.402221] PM: Syncing filesystems ... done. [ 39.407623] PM: Preparing system for mem sleep [ 39.414855] Freezing user space processes ... (elapsed 0.000 seconds) done. [ 39.422546] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [ 39.432403] PM: Entering mem sleep [ 39.436096] Suspending console(s) (use no_console_suspend to debug) [ 39.465332] PM: suspend of devices complete after 16.143 msecs [ 39.473876] PM: late suspend of devices complete after 8.544 msecs [ 39.482635] PM: noirq suspend of devices complete after 8.728 msecs [ 39.482666] Disabling non-boot CPUs ... [ 39.482696] Successfully put all powerdomains to target state [ 39.501434] PM: noirq resume of devices complete after 18.676 msecs [ 39.501556] In-band Error seen by MPU at address 0 [ 39.501556] ------------[ cut here ]------------ [ 39.501586] WARNING: CPU: 0 PID: 1 at drivers/bus/omap_l3_smx.c:166 omap3_l3_app_irq+0xcc/0x124() [ 39.501617] Modules linked in: [ 39.501617] CPU: 0 PID: 1 Comm: sh Tainted: G W 3.19.0-rc1-14143-g99d076b #1 [ 39.501647] Hardware name: Generic OMAP36xx (Flattened Device Tree) [ 39.501678] [] (unwind_backtrace) from [] (show_stack+0x10/0x14) [ 39.501708] [] (show_stack) from [] (dump_stack+0x80/0x9c) [ 39.501708] [] (dump_stack) from [] (warn_slowpath_common+0x78/0xb4) [ 39.501739] [] (warn_slowpath_common) from [] (warn_slowpath_null+0x1c/0x24) [ 39.501739] [] (warn_slowpath_null) from [] (omap3_l3_app_irq+0xcc/0x124) [ 39.501770] [] (omap3_l3_app_irq) from [] (handle_irq_event_percpu+0x60/0x1f4) [ 39.501800] [] (handle_irq_event_percpu) from [] (handle_irq_event+0x3c/0x5c) [ 39.501800] [] (handle_irq_event) from [] (handle_level_irq+0xb4/0x13c) [ 39.501831] [] (handle_level_irq) from [] (generic_handle_irq+0x20/0x30) [ 39.501831] [] (generic_handle_irq) from [] (__handle_domain_irq+0x68/0xdc) [ 39.501861] [] (__handle_domain_irq) from [] (omap_intc_handle_irq+0xb4/0xc4) [ 39.501861] [] (omap_intc_handle_irq) from [] (__irq_svc+0x44/0x5c) [ 39.501892] Exception stack(0xce09bdd0 to 0xce09be18) [ 39.501892] bdc0: 00000001 ce099110 00000000 ce098b40 [ 39.501922] bde0: 60000153 ce153860 ce153860 c0921a98 00000000 c0945464 60000153 c09216b0 [ 39.501922] be00: c0ac0218 ce09be18 c008371c c05db5f4 20000153 ffffffff [ 39.501953] [] (__irq_svc) from [] (_raw_spin_unlock_irqrestore+0x34/0x44) [ 39.501953] [] (_raw_spin_unlock_irqrestore) from [] (resume_irqs+0x84/0xdc) [ 39.501983] [] (resume_irqs) from [] (dpm_resume_noirq+0x210/0x2d4) [ 39.502014] [] (dpm_resume_noirq) from [] (suspend_devices_and_enter+0x324/0x600) [ 39.502044] [] (suspend_devices_and_enter) from [] (pm_suspend+0x3fc/0x470) [ 39.502044] [] (pm_suspend) from [] (state_store+0x68/0xb8) [ 39.502075] [] (state_store) from [] (kobj_attr_store+0x14/0x20) [ 39.502105] [] (kobj_attr_store) from [] (sysfs_kf_write+0x4c/0x50) [ 39.502105] [] (sysfs_kf_write) from [] (kernfs_fop_write+0xf0/0x19c) [ 39.502136] [] (kernfs_fop_write) from [] (vfs_write+0xa4/0x1ac) [ 39.502166] [] (vfs_write) from [] (SyS_write+0x40/0x8c) [ 39.502166] [] (SyS_write) from [] (ret_fast_syscall+0x0/0x48) [ 39.502166] ---[ end trace f2bd4718062f5219 ]--- [ 39.508880] PM: early resume of devices complete after 5.706 msecs [ 39.696929] PM: resume of devices complete after 187.927 msecs [ 40.033966] PM: Finishing wakeup. [ 40.037475] Restarting tasks ... done. # # # # cat /debug/pm_debug/count usbhost_pwrdm (ON),OFF:26,RET:1166,INA:0,ON:1193,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:5,INA:0,ON:7,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 per_pwrdm (ON),OFF:1,RET:257,INA:0,ON:259,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dss_pwrdm (ON),OFF:26,RET:1166,INA:0,ON:1193,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:18,RET:687,INA:487,ON:1193,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:18,RET:687,INA:487,ON:1193,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.681152] PM: Syncing filesystems ... done. [ 42.686614] PM: Preparing system for mem sleep [ 42.693481] Freezing user space processes ... (elapsed 0.000 seconds) done. [ 42.701141] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [ 42.711029] PM: Entering mem sleep [ 42.714691] Suspending console(s) (use no_console_suspend to debug) [ 42.743499] PM: suspend of devices complete after 15.686 msecs [ 42.752258] PM: late suspend of devices complete after 8.728 msecs [ 42.761016] PM: noirq suspend of devices complete after 8.728 msecs [ 42.761047] Disabling non-boot CPUs ... [ 42.761047] Successfully put all powerdomains to target state [ 42.779815] PM: noirq resume of devices complete after 18.707 msecs [ 42.779937] In-band Error seen by MPU at address 0 [ 42.779937] ------------[ cut here ]------------ [ 42.779968] WARNING: CPU: 0 PID: 1 at drivers/bus/omap_l3_smx.c:166 omap3_l3_app_irq+0xcc/0x124() [ 42.779998] Modules linked in: [ 42.779998] CPU: 0 PID: 1 Comm: sh Tainted: G W 3.19.0-rc1-14143-g99d076b #1 [ 42.779998] Hardware name: Generic OMAP36xx (Flattened Device Tree) [ 42.780059] [] (unwind_backtrace) from [] (show_stack+0x10/0x14) [ 42.780090] [] (show_stack) from [] (dump_stack+0x80/0x9c) [ 42.780090] [] (dump_stack) from [] (warn_slowpath_common+0x78/0xb4) [ 42.780120] [] (warn_slowpath_common) from [] (warn_slowpath_null+0x1c/0x24) [ 42.780120] [] (warn_slowpath_null) from [] (omap3_l3_app_irq+0xcc/0x124) [ 42.780151] [] (omap3_l3_app_irq) from [] (handle_irq_event_percpu+0x60/0x1f4) [ 42.780181] [] (handle_irq_event_percpu) from [] (handle_irq_event+0x3c/0x5c) [ 42.780181] [] (handle_irq_event) from [] (handle_level_irq+0xb4/0x13c) [ 42.780212] [] (handle_level_irq) from [] (generic_handle_irq+0x20/0x30) [ 42.780212] [] (generic_handle_irq) from [] (__handle_domain_irq+0x68/0xdc) [ 42.780242] [] (__handle_domain_irq) from [] (omap_intc_handle_irq+0xb4/0xc4) [ 42.780242] [] (omap_intc_handle_irq) from [] (__irq_svc+0x44/0x5c) [ 42.780273] Exception stack(0xce09bdd0 to 0xce09be18) [ 42.780273] bdc0: 00000001 ce099110 00000000 ce098b40 [ 42.780303] bde0: 60000153 ce153860 ce153860 c0921a98 00000000 c0945464 60000153 c09216b0 [ 42.780303] be00: c0ac0218 ce09be18 c008371c c05db5f4 20000153 ffffffff [ 42.780334] [] (__irq_svc) from [] (_raw_spin_unlock_irqrestore+0x34/0x44) [ 42.780334] [] (_raw_spin_unlock_irqrestore) from [] (resume_irqs+0x84/0xdc) [ 42.780364] [] (resume_irqs) from [] (dpm_resume_noirq+0x210/0x2d4) [ 42.780395] [] (dpm_resume_noirq) from [] (suspend_devices_and_enter+0x324/0x600) [ 42.780426] [] (suspend_devices_and_enter) from [] (pm_suspend+0x3fc/0x470) [ 42.780426] [] (pm_suspend) from [] (state_store+0x68/0xb8) [ 42.780456] [] (state_store) from [] (kobj_attr_store+0x14/0x20) [ 42.780487] [] (kobj_attr_store) from [] (sysfs_kf_write+0x4c/0x50) [ 42.780487] [] (sysfs_kf_write) from [] (kernfs_fop_write+0xf0/0x19c) [ 42.780517] [] (kernfs_fop_write) from [] (vfs_write+0xa4/0x1ac) [ 42.780548] [] (vfs_write) from [] (SyS_write+0x40/0x8c) [ 42.780548] [] (SyS_write) from [] (ret_fast_syscall+0x0/0x48) [ 42.780548] ---[ end trace f2bd4718062f521a ]--- [ 42.787261] PM: early resume of devices complete after 5.706 msecs [ 42.976776] PM: resume of devices complete after 189.392 msecs [ 43.312042] PM: Finishing wakeup. [ 43.315551] Restarting tasks ... done. # # # # cat /debug/pm_debug/count usbhost_pwrdm (ON),OFF:121,RET:1166,INA:0,ON:1288,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:5,INA:0,ON:8,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 per_pwrdm (ON),OFF:2,RET:257,INA:0,ON:260,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dss_pwrdm (ON),OFF:121,RET:1166,INA:0,ON:1288,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:45,RET:753,INA:489,ON:1288,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:45,RET:753,INA:489,ON:1288,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:369,RET:1166,INA:0,ON:1536,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:11,RET:6,INA:6,ON:24,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0,RET-MEMBANK2-OFF:0 per_pwrdm (ON),OFF:12,RET:409,INA:0,ON:422,RET-LOGIC-OFF:0,RET-MEMBANK1-OFF:0 dss_pwrdm (ON),OFF:369,RET:1166,INA:0,ON:1536,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:127,RET:849,INA:559,ON:1536,RET-LOGIC-OFF:0 mpu_pwrdm (ON),OFF:127,RET:849,INA:559,ON:1536,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