system will auto sleep when booting and console can't work

[wangtsungli]

Hi Community,

I'm working on i.MX6 Quad sabre-SD platform and build Android 6 with android_M6.0.1_2.1.0_source source code.

The most important thing is that there is no PMIC on my hardware design.

Here is the situation.

System will get into sleep mode when init start even I disabled auto sleep in kernel driver.

Below is whole log from init start to get in sleep mode.

I found that some place will send mem to power state and I do not know why did it do that?

usb_otg_vbus: disabling
ALSA device list:
#0: imx-hdmi-soc
Freeing unused kernel memory: 1024K (c1000000 - c1100000)
init: init started!
init: init second stage started!
init: waitpid failed: No child processes
init: property_set("ro.zygote", "zygote32") failed
init: (Loading properties from /default.prop took 0.00s.)
init: (Parsing /init.environ.rc took 0.00s.)
init: (Parsing /init.usb.rc took 0.00s.)
init: (Parsing init.FX100.usb.rc took 0.00s.)
init: (Parsing init.FX100.i.MX6Q.rc took 0.00s.)
init: (Parsing /init.FX100.rc took 0.01s.)
init: (Parsing /init.usb.configfs.rc took 0.00s.)
init: (Parsing /init.zygote32.rc took 0.00s.)
init: (Parsing /init.trace.rc took 0.00s.)
init: (Parsing /init.rc took 0.04s.)
init: Starting service 'ueventd'...
init: Waiting for /dev/.coldboot_done...
ueventd: ueventd started!
ueventd: Coldboot took 0.15s.
init: Waiting for /dev/.coldboot_done took 0.16s.
init: write_file: Unable to open '/proc/sys/kernel/sched_compat_yield': No such file or directory
init: write_file: Unable to write to '/dev/cpuctl/cpu.shares': Invalid argument
init: write_file: Unable to open '/proc/sys/abi/swp': No such file or directory
init: Starting service 'watchdogd'...
Console: switching to colour dummy device 80x30
watchdogd: watchdogd started (interval 10, margin 20)!
EXT4-fs (mmcblk3p5): mounted filesystem with ordered data mode. Opts: barrier=1
fs_mgr: __mount(source=/dev/block/mmcblk3p5,target=/system,type=ext4)=0
EXT4-fs (mmcblk3p4): Ignoring removed nomblk_io_submit option
EXT4-fs (mmcblk3p4): mounted filesystem with ordered data mode. Opts: nomblk_io_submit,noauto_da_alloc,errors=panic
fs_mgr: __mount(source=/dev/block/mmcblk3p4,target=/data,type=ext4)=0
EXT4-fs (mmcblk3p6): Ignoring removed nomblk_io_submit option
EXT4-fs (mmcblk3p6): mounted filesystem with ordered data mode. Opts: nomblk_io_submit
fs_mgr: __mount(source=/dev/block/mmcblk3p6,target=/cache,type=ext4)=0
EXT4-fs (mmcblk3p7): mounted filesystem with ordered data mode. Opts: (null)
fs_mgr: __mount(source=/dev/block/mmcblk3p7,target=/device,type=ext4)=0
file system registered
init: Starting service 'logd'...
zram0: detected capacity change from 0 to 314572800
Adding 307196k swap on /dev/block/zram0. Priority:-1 extents:1 across:307196k SS
init: (Loading properties from /system/build.prop took 0.01s.)
logd.auditd: start
init: (Loading properties from /vendor/build.prop took 0.00s.)
init: (Loading properties from /factory/factory.prop took 0.00s.)
init: Starting service 'vold'...
init: Not bootcharting.
init: Failed to reload policy
init: Starting service 'exec 0 (/system/bin/tzdatacheck)'...
init: Service 'exec 0 (/system/bin/tzdatacheck)' (pid 202) exited with status 0
init: Starting service 'logd-reinit'...
init: Starting service 'healthd'...
init: Starting service 'console'...
init: Starti>嶵?笓_init: Starting service 'servicemanager'...
init: Starting service 'surfaceflinger'...
init: write_file: Unable to open '/sys/block/mmcblk0/queue/read_ahead_kb': No such file or directory
logd.daemon: reinit
init: Service 'logd-reinit' (pid 203) exited with status 0
init: write_file: Unable to open '/sys/block/mmcblk1/queue/read_ahead_kb': No such file or directory
init: write_file: Unable to open '/sys/class/rfkill/rfkill0/state': No such file or directory
random: init urandom read with 15 bits of entropy available
init: property_set("ro.ril.wake_lock_timeout", "300") failed
init: Starting service 'netd'...
init: Starting service 'debuggerd'...
init: cannot find '/system/bin/debuggerd64', disabling 'debuggerd64'
init: Starting service 'drm'...
init: Starting service 'media'...
init: Starting service 'installd'...
init: cannot find '/system/bin/install-recovery.sh', disabling 'flash_recovery'
init: Starting service 'keystore'...
init: Starting service 'ril-daemon'...
init: Starting service 'zygote'...
init: Starting service 'gatekeeperd'...
init: cannot find '/system/xbin/perfprofd', disabling 'perfprofd'
init: Starting service 'magd'...
root@FX100:/ # init: Service 'magd' (pid 223) exited with status 255
healthd: No charger supplies found
healthd: No battery devices found
init: Starting service 'bootanim'...
imx-hdmi-audio imx-hdmi-audio: HDMI Video is not ready!
imx-hdmi-audio imx-hdmi-audio: ASoC: can't open platform imx-hdmi-audio: -22
imx-hdmi-audio imx-hdmi-audio: HDMI Video is not ready!
imx-hdmi-audio imx-hdmi-audio: ASoC: can't open platform imx-hdmi-audio: -22
capability: warning: `main' uses 32-bit capabilities (legacy support in use)
zram: 518 (system_server) Attribute mem_used_total (and others) will be removed. See zram documentation.
forenex victor debug main.c suspend on
PM: forenex victor suspend.
random: nonblocking pool is initialized
lowmemorykiller: lowmem_shrink: convert oom_adj to oom_score_adj:
lowmemorykiller: oom_adj 0 => oom_score_adj 0
lowmemorykiller: oom_adj 1 => oom_score_adj 58
lowmemorykiller: oom_adj 2 => oom_score_adj 117
lowmemorykiller: oom_adj 3 => oom_score_adj 176
lowmemorykiller: oom_adj 9 => oom_score_adj 529
lowmemorykiller: oom_adj 15 => oom_score_adj 1000
acc_open
acc_release
fec 2188000.ethernet eth0: Freescale FEC PHY driver [Generic PHY] (mii_bus:phy_addr=2188000.ethernet:01, irq=-1)
IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
usb 1-1: reset high-speed USB device number 2 using ci_hdrc
usb 1-1: USB disconnect, device number 2
usb 1-1: new high-speed USB device number 3 using ci_hdrc
usb 1-1: New USB device found, idVendor=0424, idProduct=2514
usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
hub 1-1:1.0: USB hub found
hub 1-1:1.0: config failed, can't read hub descriptor (err -22)
usb 1-1: reset high-speed USB device number 3 using ci_hdrc
usb 1-1: USB disconnect, device number 3
usb 1-1: new high-speed USB device number 4 using ci_hdrc
usb 1-1: unable to read config index 0 descriptor/start: -32
usb 1-1: chopping to 0 config(s)
usb 1-1: New USB device found, idVendor=0424, idProduct=2514
usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
usb 1-1: no configuration chosen from 0 choices
init: Service 'bootanim' (pid 287) exited with status 0
init: write_file: Unable to open '/sys/devices/system/cpu/cpu0/cpufreq/scaling_governor': No such file or directory
init: write_file: Unable to open '/sys/devices/system/cpu/cpufreq/interactive/timer_rate': No such file or directory
init: write_file: Unable to open '/sys/devices/system/cpu/cpufreq/interactive/min_sample_time': No such file or directory
init: write_file: Unable to open '/sys/devices/system/cpu/cpufreq/interactive/go_hispeed_load': No such file or directory
init: write_file: Unable to open '/sys/devices/system/cpu/cpufreq/interactive/hispeed_freq': No such file or directory
last active wakeup source: eventpoll
forenex victor debug main.c suspend mem
PM: forenex victor suspend.
PM: suspend entry 1970-01-01 00:01:47.677712345 UTC
PM: Syncing filesystems ... done.
Freezing user space processes ...
PM: Wakeup pending, aborting suspend
last active wakeup source: eventpoll

Freezing of tasks aborted after 0.007 seconds
Restarting tasks ... done.
PM: suspend exit 1970-01-01 00:01:47.720592679 UTC
forenex victor debug main.c suspend mem
PM: forenex victor suspend.
PM: suspend entry 1970-01-01 00:01:47.831435012 UTC
PM: Syncing filesystems ... done.
Freezing user space processes ... (elapsed 0.001 seconds) done.
Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
PM: suspend of devices complete after 73.919 msecs
PM: suspend devices took 0.080 seconds
PM: late suspend of devices complete after 1.165 msecs
PM: noirq suspend of devices complete after 1.212 msecs
Disabling non-boot CPUs ...
CPU1: shutdown
CPU2: shutdown
CPU3: shutdown
Resume caused by IRQ 51
Enabling non-boot CPUs ...
CPU1 is up
CPU2 is up
CPU3 is up
PM: noirq resume of devices complete after 1.055 msecs
PM: early resume of devices complete after 0.772 msecs
usb 1-1: reset high-speed USB device number 4 using ci_hdrc
usb 1-1: device firmware changed
PM: resume of devices complete after 338.612 msecs
PM: resume devices took 0.340 seconds
Restarting tasks ...
usb 1-1: USB disconnect, device number 4
done.
PM: suspend exit 1970-01-01 00:01:51.343757000 UTC
forenex victor debug main.c suspend mem
PM: forenex victor suspend.
PM: suspend entry 1970-01-01 00:01:51.455651000 UTC
PM: Syncing filesystems ... usb 1-1: new high-speed USB device number 5 using ci_hdrc

done.
Freezing user space processes ... (elapsed 0.002 seconds) done.
Freezing remaining freezable tasks ...
usb 1-1: New USB device found, idVendor=0424, idProduct=2514
usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
hub 1-1:1.0: USB hub found
PM: Wakeup pending, aborting suspend
active wakeup source: NETLINK

Freezing of tasks aborted after 0.132 seconds
Restarting kernel threads ... done.
Restarting tasks ... done.
PM: suspend exit 1970-01-01 00:01:51.644411333 UTC
hub 1-1:1.0: config failed, can't read hub descriptor (err -22)
forenex victor debug main.c suspend mem
PM: forenex victor suspend.
PM: suspend entry 1970-01-01 00:01:51.760287667 UTC
PM: Syncing filesystems ... done.
Freezing user space processes ...
usb 1-1: reset high-speed USB device number 5 using ci_hdrc
usb 1-1: USB disconnect, device number 5
(elapsed 0.253 seconds) done.
Freezing remaining freezable tasks ...
PM: Wakeup pending, aborting suspend
active wakeup source: NETLINK

Freezing of tasks aborted after 0.006 seconds
Restarting kernel threads ... done.
Restarting tasks ... done.
PM: suspend exit 1970-01-01 00:01:52.067327000 UTC
usb 1-1: new high-speed USB device number 6 using ci_hdrc
forenex victor debug main.c suspend mem
PM: forenex victor suspend.
PM: suspend entry 1970-01-01 00:01:52.178177333 UTC
PM: Syncing filesystems ... done.
Freezing user space processes ... (elapsed 0.016 seconds) done.
Freezing remaining freezable tasks ...
usb 1-1: New USB device found, idVendor=0424, idProduct=2514
usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
PM: Wakeup pending, aborting suspend
hub 1-1:1.0: USB hub found
active wakeup source: NETLINK

Freezing of tasks aborted after 0.130 secondshub 1-1:1.0: config failed, can't read hub descriptor (err -22)

Restarting kernel threads ... done.
Restarting tasks ... done.
PM: suspend exit 1970-01-01 00:01:52.372575000 UTC
forenex victor debug main.c suspend mem
PM: forenex victor suspend.
PM: suspend entry 1970-01-01 00:01:52.483468333 UTC
PM: Syncing filesystems ... done.
Freezing user space processes ... (elapsed 0.002 seconds) done.
Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
PM: suspend of devices complete after 87.889 msecs
PM: suspend devices took 0.090 seconds
PM: late suspend of devices complete after 1.156 msecs
PM: noirq suspend of devices complete after 1.211 msecs
Disabling non-boot CPUs ...
CPU1: shutdown
CPU2: shutdown
CPU3: shutdown
Resume caused by IRQ 51
Enabling non-boot CPUs ...
CPU1 is up
CPU2 is up
CPU3 is up
PM: noirq resume of devices complete after 0.996 msecs
PM: early resume of devices complete after 0.698 msecs
usb 1-1: reset high-speed USB device number 6 using ci_hdrc
dpm_run_callback(): usb_dev_resume+0x0/0x10 returns -71
PM: Device 1-1 failed to resume async: error -71
PM: resume of devices complete after 359.796 msecs
PM: resume devices took 0.360 seconds
Restarting tasks ...
usb 1-1: USB disconnect, device number 6
done.
PM: suspend exit 1970-01-01 00:01:56.369800000 UTC
forenex victor debug main.c suspend mem
PM: forenex victor suspend.
PM: suspend entry 1970-01-01 00:01:56.482093333 UTC
usb 1-1: new high-speed USB device number 7 using ci_hdrc
PM: Syncing filesystems ... done.
Freezing user space processes ... (elapsed 0.001 seconds) done.
Freezing remaining freezable tasks ...
usb 1-1: New USB device found, idVendor=0424, idProduct=2514
usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
hub 1-1:1.0: USB hub found
PM: Wakeup pending, aborting suspend
active wakeup source: NETLINK

Freezing of tasks aborted after 0.141 seconds
Restarting kernel threads ... done.
Restarting tasks ... done.
PM: suspend exit 1970-01-01 00:01:56.676347667 UTC
hub 1-1:1.0: config failed, can't read hub descriptor (err -22)
forenex victor debug main.c suspend mem
PM: forenex victor suspend.
PM: suspend entry 1970-01-01 00:01:56.787358333 UTC
PM: Syncing filesystems ... done.
Freezing user space processes ... (elapsed 0.002 seconds) done.
Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
PM: suspend of devices complete after 86.195 msecs
PM: suspend devices took 0.090 seconds
PM: late suspend of devices complete after 1.148 msecs
PM: noirq suspend of devices complete after 1.172 msecs
Disabling non-boot CPUs ...
CPU1: shutdown
CPU2: shutdown
CPU3: shutdown
Resume caused by IRQ 51
Resume caused by IRQ 58
Enabling non-boot CPUs ...
CPU1 is up
CPU2 is up
CPU3 is up
PM: noirq resume of devices complete after 0.959 msecs
PM: early resume of devices complete after 0.696 msecs
usb 1-1: reset high-speed USB device number 7 using ci_hdrc
dpm_run_callback(): usb_dev_resume+0x0/0x10 returns -71
PM: Device 1-1 failed to resume async: error -71
PM: resume of devices complete after 359.687 msecs
PM: resume devices took 0.360 seconds
Restarting tasks ...
usb 1-1: USB disconnect, device number 7
done.
PM: suspend exit 1970-01-01 00:06:48.366812000 UTC
forenex victor debug main.c suspend mem
PM: forenex victor suspend.
PM: suspend entry 1970-01-01 00:06:48.480050334 UTC
PM: Syncing filesystems ... done.
Freezing user space processes ...
usb 1-1: new high-speed USB device number 8 using ci_hdrc
(elapsed 0.001 seconds) done.
Freezing remaining freezable tasks ...
usb 1-1: New USB device found, idVendor=0424, idProduct=2514
usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
hub 1-1:1.0: USB hub found
PM: Wakeup pending, aborting suspend
active wakeup source: NETLINK

Freezing of tasks aborted after 0.178 seconds
Restarting kernel threads ... done.
Restarting tasks ... done.
PM: suspend exit 1970-01-01 00:06:48.694244000 UTC
hub 1-1:1.0: config failed, can't read hub descriptor (err -22)
forenex victor debug main.c suspend mem
PM: forenex victor suspend.
PM: suspend entry 1970-01-01 00:06:48.805094000 UTC
PM: Syncing filesystems ... done.
Freezing user space processes ... (elapsed 0.001 seconds) done.
Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
PM: suspend of devices complete after 86.701 msecs
PM: suspend devices took 0.090 seconds
PM: late suspend of devices complete after 1.254 msecs
PM: noirq suspend of devices complete after 1.238 msecs
Disabling non-boot CPUs ...
CPU1: shutdown
CPU2: shutdown
CPU3: shutdown

How can I avoid it?

Or there is the issue with hardware design?

Or there is any pin that will cause system detect to send "mem" power state?

[igorpadykov]

Hi tsung

one can try to comment places where system sends mem to power state.

NXP BSPs are designed for use with pmic to reduce system power consumption.

For understanding system behaviour one can try with linux minimal image

and use linux documentation from

i.MX Software|NXP 

Best regards
igor
-----------------------------------------------------------------------------------------------------------------------
Note: If this post answers your question, please click the Correct Answer button. Thank you!
-----------------------------------------------------------------------------------------------------------------------

[wangtsungli · Accepted solution]

I found out where did system send mem to kernel driver.

In framework PowerManagmentService.java will send system to sleep for many reason.

In my case, system will go to sleep mode because Screen timeout.

I tried to avoid this reason and it solve my problem.

But I think this is not a right way to solve it.