tuxonice-kernel-old when it is hibernating,how to cancel hibernating?

when it is hibernating,how to cancel hibernating?

Open wangxy0929 opened this issue 8 years ago • 37 comments

for the smart device, if the system is hibernating, when users press the power key, it did'not respond, until the hibernation done; so users want that if they press the power key, it should cancel the hibernating. so how to cancel it?

Jan 22 '16 02:01 wangxy0929

If you're using a Userspace user interface program, you can press escape to cancel hibernating - or to cancel resuming.

Jan 22 '16 02:01 NigelCunningham

NO, i am not using a userspace user interface program, my platform is Android smart devices. the kernel is linux.

for example, i have converted the scripts to c code, and compile it to a binary.

adb shell "echo "hibboot=1" > /proc/lk_env" adb shell "echo "resume=swap:/dev/mmcblk0p7:344064" > /proc/lk_env" adb shell "echo "swap:/dev/mmcblk0p7:344064" > /sys/power/tuxonice/resume" adb shell "echo "IPOD_HIB_WAKELOCK" > /sys/power/wake_lock" adb shell sync adb shell "echo 100>/proc/sys/vm/swappiness" adb shell "echo 3 > /proc/sys/vm/drop_caches" adb shell "echo 70>/sys/power/tuxonice/compression/expected_compression" adb shell "echo 1>/sys/power/tuxonice/no_multithreaded_io" adb shell "echo "/data/.ipoh.img">/sys/power/tuxonice/swap/swapfilename" adb shell "echo "disk" > /sys/power/state"

so when the system excute the script that which is adb shell "echo "disk" > /sys/power/state", the screen is black, there are three keys in my smart devices, they are power key, VOL+, VOL- . so when it is hibernating, if i want to cancel the hibernating, i don not know how to do it.

Jan 22 '16 02:01 wangxy0929

You'd need to port the userspace user interface too - the kernel will listen to a netlink socket and take instructions from that which will allow you to cancel hibernation.

Jan 22 '16 03:01 NigelCunningham

thanks very much. can you tell me how to port the userspace user interface? what are the kernel configs need to open? only need to open the TOI_USERUI? in kernel-3.10/arch/arm64/$platfrom/platfrom_defconfig, I can't find the TOI_USERUI. there are the configs in my deconfigs:

CONFIG_TOI_CORE=y #CONFIG_TOI_FILES is not set CONFIG_TOI_sWAP=y CONFIG_TOI_CRYPTO=y CONFIG_TOI_DEFAULT_IMAGE_SIZE_LIMIT=2 CONFIG_TOI_KEEP_IMAGE=y CONFIG_TOI_REPLACE_SWSUSP=y #CONFIG_TOI_IGNORE_LATE_INITCALL is not set CONFIG_TOI_DEFAULT_WAIT=2 CONFIG_TOI_DEFAULT_EXTRA_PAGES_ALLOWANCE=200 #CONFIG_TOI_CHECKSUM is not set CONFIG_TOI=y CONFIG_TOI_ZRAM_SUPPORT=y CONFIG_TOI_FIXUP=y CONFIG_TOI_ENHANCE=y

CONFIG_HIBERNATE_CALLBACKS=y CONFIG_HIBERNATION=y CONFIG_ARCH_HIBERNATION_POSSIBLE=y

Jan 22 '16 03:01 wangxy0929

In addition to TuxOnIce, you need the NETLINK options. If you've already made a C program, you should be able to add to it something along the lines of the code in the userui repo. You'll find it at https://github.com/NigelCunningham/Tuxonice-Userui.

Regards,

Nigel

Jan 22 '16 03:01 NigelCunningham

Dear NigelCunningham:

thanks for help me. but i am facing a problem, i have downloaded the source :tuxonice-userui-1.0.tar.gz, and extract the tarball, complile it by running "make install", but there is an error: mng_splash.h:7:20:fatal error: libmng.h:No such file or directory. comilation terminated.

thanks a lot.

Jan 22 '16 05:01 wangxy0929

Dear NigelCunningham: i have checked our branch, in kernel-3.10/kernel/power directory, there are tunonice_netlink.c tunonice_netlink.h tunonice_ui.c tunonice_ui.h tunonice_userui.c user.c but i don't know how to make it work?

Jan 22 '16 07:01 wangxy0929

Dear NigelCunningham: the last mail you sent to me , is to fix my issue?thanks very much.

Jan 25 '16 01:01 wangxy0929

untitled

can you help me how to fix this error? thx!

Feb 16 '16 02:02 wangxy0929

@wangxy0929 Maybe you should port libmng? http://linux.die.net/man/3/libmng

Feb 16 '16 13:02 mikroskeem

untitled

for my branch, in kernel-3.10/kernel/power/, the directory is user_interface, so on my platform, there is only /sys/power/tuxonice/user_interface, there is no /sys/power/tuxonice/user_interface/program. but in the Readme, It say
tuxoniceui_fbsplash binary into /sys/power/tuxonice/user_interface/program.

now, how to do the next?

|root@mt8665_sd_p1_64:/sys/power/tuxonice/user_interface # pwd pwd /sys/power/tuxonice/user_interface

Feb 17 '16 01:02 wangxy0929

dear mikroskeem:

i have downloaded the tuxonice-usrui source code, and complie it to tuxoniceui_text. i set the CONFIG_TOI_USERUI_DEFAULT_PATH ="/sys/power/tuxonice/user_interface/program"

now , on my platform, in the /sys/power/tuxonice/user_interface directory: root@mt8665_sd_p1_64:/ # cd /sys/power/tuxonice/user_interface cd /sys/power/tuxonice/user_interface root@mt8665_sd_p1_64:/sys/power/tuxonice/user_interface # ls ls debug debug_sections default_console_level enable_escape enabled log_everything pause_between_steps program progress_granularity

and cat program: root@mt8665_sd_p1_64:/sys/power/tuxonice/user_interface # cat program cat program /usr/local/sbin/tuxoniceui_text

so how can i run the tuxoniceui_text. when it hibernaing. and how to cancle it?

thx!

Feb 17 '16 03:02 wangxy0929

The kernel code will start the program when you start a cycle and tell it to quit at the end of the cycle.

If you want the userui to run in the first part of resuming (prior to the atomic restore), you'll also want to include the binary at the same path in the initramfs or initrd.

Regards

Nigel

On 17 February 2016 2:07:41 pm LHDT, wangxy0929 [email protected] wrote:

dear mikroskeem:

i have downloaded the tuxonice-usrui source code, and complie it to tuxoniceui_text. i set the CONFIG_TOI_USERUI_DEFAULT_PATH ="/sys/power/tuxonice/user_interface/program"

now , on my platform, in the /sys/power/tuxonice/user_interface directory: root@mt8665_sd_p1_64:/ # cd /sys/power/tuxonice/user_interface cd /sys/power/tuxonice/user_interface root@mt8665_sd_p1_64:/sys/power/tuxonice/user_interface # ls ls debug debug_sections default_console_level enable_escape enabled log_everything pause_between_steps program progress_granularity

and cat program: root@mt8665_sd_p1_64:/sys/power/tuxonice/user_interface # cat program cat program /usr/local/sbin/tuxoniceui_text

so how can i run the tuxoniceui_text. when it hibernaing. and how to cancle it?

thx!

Reply to this email directly or view it on GitHub: https://github.com/NigelCunningham/tuxonice-kernel/issues/6#issuecomment-184991738

Sent from my Android device with K-9 Mail. Please excuse my brevity.

Feb 17 '16 06:02 NigelCunningham

Dear NigelCunningham & mikroskeem:

i put the tuxoniceui_text into /system/bin/tuxoniceui_text, and create a soft link:

1|root@mt8665_sd_p1_64:/sbin # ln -s /sys/power/tuxonice/user_interface/program /system/lib/tuxoniceui_text n -s /sys/power/tuxonice/user_interface/program /system/lib/tuxoniceui_text < root@mt8665_sd_p1_64:/sbin #

but when hibernating, there is an error: (160217_15:08:45.642)[ 278.188004]<0>.(0)[3436:ipod]Failed to launch userspace program '/system/bin/tuxoniceui_text': Error -8 (160217_15:08:45.642)[ 278.189171]<0>.(0)[3436:ipod]Launch userspace program failed.

please tell me how can i do next step? thx very much.

Feb 17 '16 08:02 wangxy0929

Dear NigelCunningham & mikroskeem:

i modify the API:toi_launch_userspace_program(), add /system/bin to the path . "PATH=/system/bin:/sbin:/user/sbin:/bin:/usr/bin/"

then i set the CONFIG_TOI_USERUI_DEFAULT_PATH ="/system/bin/tuxoniceui", and put the tuxoniceui to /system/bin/ on my platform.

when it hibernating, from the log we can see there is no error. but how can i cancle hibernating? press any key? or do other anything?

(160218_16:38:12.175)[ 417.970912]<0>.(0)[4442:ipod]userui_prepare_console:538[ 417.971662]<0>.(0)[4442:ipod] toi_netlink_setup:307[ 417.972329]<0>.(0)[4442:ipod] [toi_launch_userspace_program:1169] command = /system/bin/tuxoniceui,channel_no=22 (160218_16:38:12.175)[ 417.979427]ADDLOG datagram_poll sk_queue_empty mask:0[ 417.986946]<0>.(0)[4442:ipod]wxy toi_launch_userspace_program:1209[ 417.987747]<0>.(0)[4442:ipod]wxy [toi_netlink_setup:316]

Feb 18 '16 08:02 wangxy0929

Hi again.

You shouldn't need to modify any paths. Just put the absolute path to the userui binary in /sys/power/tuxonice/userui/program (or set the config option that controls the default to that value, as you say above you've done). Ohhh... the other thing you need to do is echo 1 > /sys/power/tuxonice/userui/enable_escape.

Hope that helps!

Feb 18 '16 09:02 NigelCunningham

Dear NigelCunningham & mikroskeem:

i have made changes to your proposal. when it is hibernating, i press the "ESC" key, but there is no respond. how can i do , can cancle hibernating? thx!

Feb 19 '16 03:02 wangxy0929

Dear NigelCunningham & mikroskeem: i have made changes to your proposal. when it is hibernating, i press the "ESC" key, but there is no respond. how can i do , can cancle hibernating?

this feature is very important to us, look forward to you reply us. thx!

Feb 22 '16 08:02 wangxy0929

Dear sirs: i have not fix this issue already, can you help me.thx!

Mar 03 '16 06:03 wangxy0929

Sorry for the slow reply - too much else to keep me busy.

When you press escape, does the userui say it's trying to abort the hibernation? If it does, it would seem that the message isn't getting from the userui to the kernel. It would be helpful if you provided the output from the kernel post-resume.

Mar 04 '16 09:03 NigelCunningham

Dear sirs： i set the default path : #define CONFIG_TOI_USERUI_DEFAULT_PATH "/system/bin/tuxoniceui" and i install the tuxoniceui into /system/bin/tuxoniceui on platform,:

when download the binary into plarform, i check it's path: C:\Users>adb shell root@8665_sd_p1_64:/ # ls /system/bin/tuxoniceui ls /system/bin/tuxoniceui /system/bin/tuxoniceui

before hibernating, echo 1 > /sys/power/tuxonice/user_interface/enable_escape.

When it is hibernating, i press the ESC key of keyboard, there is no respond. and can't see it's trying to abort the hibernation on uart log .

can you help me ? thanks very much!

Mar 10 '16 07:03 wangxy0929

Dear sirs: i trace the tuxonice, and found the error: userspace ui: Failed to contact userspace process.

launch_user_program

and launch userprogram successfully: (160310_18:27:36.058)[ 125.754457]<0>.(0)[2446:ipod]wxy [toi_launch_userspace_program:1350] command = /system/bin/tuxoniceui (160310_18:27:36.058)[ 125.755608]<0>.(0)[2446:ipod]CPU: 0 PID: 2446 Comm: ipod Tainted: G W 3.10.65 #1 (160310_18:27:36.058)[ 125.756633]<0>.(0)[2446:ipod]Call trace: (160310_18:27:36.058)[ 125.757132]<0>.(0)[2446:ipod][] dump_backtrace+0x0/0x130 (160310_18:27:36.058)[ 125.757990]<0>.(0)[2446:ipod][] show_stack+0x10/0x1c (160310_18:27:36.058)[ 125.758807]<0>.(0)[2446:ipod][] dump_stack+0x1c/0x28 (160310_18:27:36.058)[ 125.759623]<0>.(0)[2446:ipod][] toi_launch_userspace_program+0x50/0x284 (160310_18:27:36.059)[ 125.760643]<0>.(0)[2446:ipod][] toi_netlink_setup+0xd0/0x160 (160310_18:27:36.059)[ 125.761546]<0>.(0)[2446:ipod][] userui_prepare_console+0x6c/0xac (160310_18:27:36.059)[ 125.762528]<0>.(0)[2446:ipod][] do_prepare_image+0x27c/0x3a0 (160310_18:27:36.059)[ 125.763430]<0>.(0)[2446:ipod][] toi_try_hibernate+0x188/0x2d4 (160310_18:27:36.059)[ 125.764341]<0>.(0)[2446:ipod][] try_tuxonice_hibernate+0x18/0x2c (160310_18:27:36.059)[ 125.765287]<0>.(0)[2446:ipod][] hibernate+0x12c/0x270 (160310_18:27:36.059)[ 125.766115]<0>.(0)[2446:ipod][] mtk_hibernate+0x10/0x14c (160310_18:27:36.059)[ 125.766972]<0>.(0)[2446:ipod][] state_store+0x148/0x1c8 (160310_18:27:36.059)[ 125.767819]<0>.(0)[2446:ipod][] kobj_attr_store+0x10/0x24 (160310_18:27:36.059)[ 125.768688]<0>.(0)[2446:ipod][] sysfs_write_file+0xdc/0x15c (160310_18:27:36.059)[ 125.769580]<0>.(0)[2446:ipod][] vfs_write+0xa4/0x18c (160310_18:27:36.059)[ 125.770393]<0>.(0)[2446:ipod][] SyS_write+0x40/0x8c (160310_18:27:36.059)[ 125.771198]<0>.(0)[2446:ipod]wxy [toi_launch_userspace_program:1366] command = /system/bin/tuxoniceui (160310_18:27:36.059)[ 125.782904]<0>.(0)[2446:ipod]wxy [toi_launch_userspace_program:1392] command = /system/bin/tuxoniceui

can you help me ? thx!

Mar 10 '16 10:03 wangxy0929

Dear sirs： i traced the tuxonice, and found the error: userspace ui: Failed to contact userspace process. i try to found some material about it in google.com; but there is no progress.

can you help me? i'm look forward to you to reply me. thx!

Mar 14 '16 06:03 wangxy0929

by the way: root@8665_sd_p1_64:/ # cd /system/bin cd /system/bin root@8665_sd_p1_64:/system/bin # ls -al tuxoniceui ls -al tuxoniceui -rwxr-xr-x root shell 297512 2016-03-10 06:33 tuxoniceui root@8665_sd_p1_64:/system/bin # tuxoniceui -t tuxoniceui -t [2J[2J[?25l[?1c[24;0H[24;18H R: Enable reboot after hibernating [5;30HT U X O N I C E[8;0H [8;40H[9;20H[[9;59H][11;1H[?25l[?1c[24;0H[24;18H R: Enable reboot after hibernating [5;30HT U X O N I C E[8;0H [8;29HFreezing processes ...[9;20H[[9;59H][11;1H[?25l[?1c[24;0H[24;18H R: Enable reboot after hibernating [5;30HT U X O N I C E[8;0H [8;30HPreparing image ...[9;20H[[9;59H][11;1H[?25l[?1c[24;0H[24;18H R: Enabl e reboot after hibernating [5;30HT U X O N I C E[8;0H [8;31HWriting caches ...[9;20H[[9;59H][11;1H[?25l[?1c[9;21H 0/1024 MB [11;1H[?25l[?1c[9;21H 2/1024 MB [11;1H[?25l[?1c[9;21H 4/1024 MB [11;1H[?25l[?1c[9;21H 6/1024 MB [11;1H[?25l[?1c[9;21H 8/1024 MB [11;1H[?25l[?1c[9;21H 10/1024 MB [11;1H[?25l[?1c[9;21H 12/1024 MB [11;1H[?25l[?1c[9;21H 14/1024 MB [11;1H[?25l[?1c[9;21H 16/1024 MB [11;1H[?25l[?1c[9;21H 18/1024 MB [11;1H[?25l[?1c[9;21H 20/1024 MB [11;1H[?25l[?1c[9;21H 22/1024 MB [11;1H[?25l[?1c[9;21H 24/1024 MB [11;1H[?25l[?1c[9;21H 26/1024 MB [11;1H[?25l[?1c[9;21H- 28/1024 MB [11;1H[?25l[?1c[9;21H- 30/1024 MB [11;1H[?25l[?1c[9;21H- 32/1024 MB [11;1H[?25l[?1c[9;21H- 34/1024 MB [11;1H[?25l[?1c[9;21H- 36/1024 MB [11;1H[?25l[?1c[9;21H- 38/1024 MB [11;1H[?25l[?1c[9;21H- 40/1024 MB [11;1H[?25l[?1c[9;21H- 42/1024 MB [11;1H[?25l[?1c[9;21H- 44/1024 MB [11;1H[?25l[?1c[9;21H- 46/1024 MB [11;1H[?25l[?1c[9;21H- 48/1024 MB [11;1H[?25l[?1c[9;21H- 50/1024 MB [11;1H[?25l[?1c[9;21H- 52/1024 MB [11;1H[?25l[?1c[9;21H-- 54/1024 MB [11;1H[?25l[?1c[9;21H-- 56/1024 MB [11;1H[?25l[?1c[9;21H-- 58/1024 MB [11;1H[?25l[?1c[9;21H-- 60/1024 MB [11;1H[?25l[?1c[9;21H-- 62/1024 MB [11;1H[?25l[?1c[9;21H-- 64/1024 MB [11;1H[?25l[?1c[9;21H-- 66/1024 MB [11;1H[?25l[?1c[9;21H-- 68/1024 MB [11;1H[?25l[?1c[9;21H-- 70/1024 MB [11;1H[?25l[?1c[9;21H-- 72/1024 MB [11;1H[?25l[?1c[9;21H-- 74/1024 MB [11;1H[?25l[?1c[9;21H-- 76/1024 MB [11;1H[?25l[?1c[9;21H-- 78/1024 MB [11;1H[?25l[?1c[9;21H-- 80/1024 MB [11;1H[?25l[?1c[9;21H--- 82/1024 MB [11;1H[?25l[?1c[9;21H--- 84/1024 MB [11;1H[?25l[?1c[9;21H--- 86/1024 MB [11;1H[?25l[?1c[9;21H--- 88/1024 MB [11;1H[?25l[?1c[9;21H--- 90/1024 MB [11;1H[?25l[?1c[9;21H--- 92/1024 MB [11;1H[?25l[?1c[9;21H--- 94/1024 MB [11;1H[?25l[?1c[9;21H--- 96/10 24 MB [11;1H[?25l[?1c[9;21H--- 98/1024 MB [11;1H[?25l[?1c[9;21H--- 100/1024 MB [11;1H[?25l[?1c[9;21H--- 102/1024 MB [11;1H[?25l[?1c[9;21H--- 104/1024 MB [11;1H[?25l[?1c[9;21H--- 106/1024 MB [11;1H[?25l[?1c[9;21H---- 108/1024 MB [11;1H[?25l[?1c[9;21H---- 110/1024 MB [11;1H[?25l[?1c[9;21H---- 112/1024 MB [11;1H[?25l[?1c[9;21H---- 114/1024 MB [11;1H[?25l[?1c[9;21H---- 116/1024 MB [11;1H[?25l[?1c[9;21H---- 118/1024 MB [11;1H[?25l[?1c[9;21H---- 120/1024 MB [11;1H[?25l[?1c[9;21H---- 122/1024 MB [11;1H[?25l[?1c[9;21H---- 124/1024 MB [11;1H[?25l[?1c[9;21H---- 126/1024 MB [11;1H[?25l[?1c[9;21H---- 128/1024 MB [11;1H[?25l[?1c[9;21H---- 130/1024 MB [11;1H[?25l[?1c[9;21H---- 132/1024 MB [11;1H[?25l[?1c[9;21H---- 134/1024 MB [11;1H[?25l[?1c[9;21H----- 136/1024 MB [11;1H[?25l[?1c[9;21H----- 138/1024 MB [11;1H[?25l[?1c[9;21H----- 140/1024 MB [11;1H[?25l[?1c[9;21H----- 142/1024 MB [11;1H[?25l[?1c[9;21H----- 144/1024 MB [11;1H[?25l[?1c[9;21H----- 146/1024 MB [11;1H[?25l[?1c[9;21H----- 148/1024 MB [11;1H[?25l[?1c[9;21H----- 150/1024 MB [11;1H[?25l[?1c[9;21H----- 152/1024 MB [11;1H[?25l[?1c[9;21H----- 154/1024 MB [11;1H[?25l[?1c[9;21H----- 156/1024 MB [11;1H[?25l[?1c[9;21H----- 158/1024 MB [11;1H[?25l[?1c[9;21H----- 160/1024 MB [11;1H[?25l[?1c[9;21H------ 162/1024 MB [11;1H[?25l[?1c[9;21H------ 164/1024 MB [11;1H[?25l[?1c[9;21H------ 166/1024 MB [11;1H[?25l[?1c[9;21H------ 168/1024 MB [11;1H[?25l[?1c[9;21H------ 170/1024 MB [11;1H[?25l[?1c[9;21H------ 172/1024 MB [11;1H[?25l[?1c[9;21H- ----- 174/1024 MB [11;1H[?25l[?1c[9;21H------ 176/1024 MB [11;1H[?25l[?1c[9;21H------ 178/1024 MB [11;1H[?25l[?1c[9;21H------ 180/1024 MB [11;1H[?25l[?1c[9;21H------ 182/1024 MB [11;1H[?25l[?1c[9;21H------ 184/1024 MB [11;1H[?25l[?1c[9;21H------ 186/1024 MB [11;1H[?25l[?1c[9;21H------ 188/1024 MB [11;1H[?25l[?1c[9;21H------- 190/1024 MB [11;1H[?25l[?1c[9;21H------- 192/1024 MB [11;1H[?25l[?1c[9;21H------- 194/1024 MB [11;1H[?25l[?1c[9;21H------- 196/1024 MB [11;1H[?25l[?1c[9;21H------- 198/1024 MB [11;1H[?25l[?1c[ 9;21H------- 200/1024 MB [11;1H[?25l[?1c[9;21H------- 202/1024 MB [11;1H[?25l[?1c[9;21H------- 204/1024 MB [11;1H[?25l[?1c[9;21H------- 206/1024 MB [11;1H[?25l[?1c[9;21H------- 208/1024 MB [11;1H[?25l[?1c[9;21H------- 210/1024 MB [11;1H[?25l[?1c[9;21H------- 212/1024 MB [11;1H[?25l[?1c[9;21H------- 214/1024 MB [11;1H[?25l[?1c[9;21H-------- 216/1024 MB [11;1H[?25l[?1c[9;21H-------- 218/1024 MB [11;1H[?25l[?1c[9;21H-------- 220/1024 MB [11;1H[?25l[?1c[9;21H-------- 222/1024 MB [11;1H[?25l[?1c[9;21H-------- 224/1024 MB [11;1H[?25l

Mar 14 '16 07:03 wangxy0929

It's good that you can run it with the test argument. This confirms that the binary has any dependencies available (if it's not statically compiled), is executable and so on. I see above some netlink debugging messages. Are you able to provide the full content of them? That might help me see what's happening.

Mar 14 '16 09:03 NigelCunningham

tuxoniceui.txt

please receive the attachment.

Mar 14 '16 09:03 wangxy0929

Sorry - what I meant was the netlink debugging messages - like these ones from above:

(160218_16:38:12.175) [ 417.970912]<0>.(0)[4442:ipod]userui_prepare_console:538 [ 417.971662]<0>.(0)[4442:ipod] toi_netlink_setup:307 [ 417.972329]<0>.(0)[4442:ipod][toi_launch_userspace_program:1169] command = /system/bin/tuxoniceui,channel_no=22 (160218_16:38:12.175) [ 417.979427]ADDLOG datagram_poll sk_queue_empty mask:0 [ 417.986946]<0>.(0)[4442:ipod]wxy toi_launch_userspace_program:1209 [ 417.987747]<0>.(0)[4442:ipod]wxy [toi_netlink_setup:316]

Mar 14 '16 09:03 NigelCunningham

(160314_18:15:58.776)[ 248.189371]<0>-(0)[140:kworker/u8:4][SPM] wake up by EINT, timer_out = 403632, r13 = 0x40000, debug_flag = 0x9f (160314_18:15:58.808)[ 248.189371]<0>-(0)[140:kworker/u8:4][SPM] r12 = 0x20, raw_sta = 0x20, idle_sta = 0x9fe, event_reg = 0x90100000, isr = 0x0 (160314_18:15:58.808)[ 248.189371]<0>-(0)[140:kworker/u8:4][SPM] suspend dormant state = 0, md32_flag = 0x0, md32_flag2 = 0 (160314_18:15:58.808)[ 248.189371]<0>-(0)[140:kworker/u8:4][SPM] log_wakesta_index = 1 (160314_18:15:58.808)[ 248.189371]<0>-(0)[140:kworker/u8:4][SPM] VRF18_0 = 0x0 (160314_18:15:58.808)[ 248.189371]<0>-(0)[140:kworker/u8:4][SPM] ddr out = 938000, get ddr = 938000 (160314_18:15:58.808)[ 248.189371]<0>-(0)[140:kworker/u8:4][WDT] resume(1) (160314_18:15:58.808)[ 248.189533]<0>-(0)[140:kworker/u8:4][ccci1/mcd]ccci_modem_sysresume (160314_18:15:58.808)[ 248.190314]<0>-(0)[140:kworker/u8:4][ccci1/mcd]Resume no need reset cldma for md_state=1 (160314_18:15:58.808)[ 248.191355]<0>-(0)[140:kworker/u8:4][PMIC] [mt_pmic_eint_irq] receive interrupt (160314_18:15:58.808)[ 248.192263]<0>-(0)[140:kworker/u8:4][PMIC] wake_up_pmic[ 248.193333]<0>.(0)[53:pmic_thread][PMIC] [PMIC_INT] pwrap_eint_status=0x1 (160314_18:15:58.808)[ 248.194189]<0>.(0)[53:pmic_thread][PMIC] [PMIC_INT] addr[0x2c4]=0x200 (160314_18:15:58.808)[ 248.194989]<0>.(0)[53:pmic_thread][PMIC] [PMIC_INT]RG_INT_STATUS_RTC[ 248.195823]<0>.(0)[53:pmic_thread]x_rtc_common: rtc_tasklet_handler start (160314_18:15:58.808)[ 248.196787]<0>.(0)[53:pmic_thread]x_rtc_hal: pdn1 = 0x 0 (160314_18:15:58.808)[ 248.197497]<0>.(0)[53:pmic_thread]x_rtc_common: alarm time is up (160314_18:15:58.808)[ 248.198284]<0>.(0)[53:pmic_thread][PMIC] [PMIC_INT] addr[0x2c6]=0x0 (160314_18:15:58.808)[ 248.199070]<0>.(0)[53:pmic_thread][PMIC] [PMIC_INT] addr[0x2c8]=0x0 (160314_18:15:58.808)[ 248.199850]<0>.(0)[53:pmic_thread][PWRAP] clear EINT flag mt_pmic_wrap_eint_status=0x0 (160314_18:15:58.808)[ 248.200844]<0>.(0)[53:pmic_thread][PMIC] [PMIC_INT] after ,int_status_val[0x2c4]=0x0 (160314_18:15:58.808)[ 248.201814]<0>.(0)[53:pmic_thread][PMIC] [PMIC_INT] after ,int_status_val[0x2c6]=0x0 (160314_18:15:58.808)[ 248.202838]<0>.(0)[53:pmic_thread][PMIC] [PMIC_INT] after ,int_status_val[0x2c8]=0x0 (160314_18:15:58.808)[ 248.206551]<0>.(0)[2520:kworker/0:3]x_rtc_common: set al time = 2016/03/15 10:11:47 (1) (160314_18:15:58.808)[ 248.207752]<0>-(0)[2520:kworker/0:3]x_rtc_hal: rtc set alarm time = 2016/03/15 (2) 10:11:47 (160314_18:15:58.808)[ 248.208818]<0>-(0)[2520:kworker/0:3]x_rtc_hal: a = 3 (160314_18:15:58.808)[ 248.209460]<0>-(0)[2520:kworker/0:3]x_rtc_hal: b = 15 (160314_18:15:58.808)[ 248.210113]<0>-(0)[2520:kworker/0:3]x_rtc_hal: c = 25610 (160314_18:15:58.808)[ 248.215550]<0>.(0)[140:kworker/u8:4][SLP] @@@@@@@@@@@@@@@@@@@@ (160314_18:15:58.808)[ 248.216281]<0>.(0)[140:kworker/u8:4][SLP] Chip_pm_finish (160314_18:15:58.808)[ 248.216938]<0>.(0)[140:kworker/u8:4][SLP] @@@@@@@@@@@@@@@@@@@@ (160314_18:15:58.808)[ 248.218237][sd]msdc0 -> PM Resume (160314_18:15:58.808)[ 248.218642]<0>.(0)[140:kworker/u8:4][sd]msdc LDO<12> power on<3000000> (160314_18:15:58.808)[ 248.219489]<0>.(0)[140:kworker/u8:4][PMIC] regulator_is_enabled(name=VEMC_3V3 id=0 en_reg=57d vol_reg=64b en=0) (160314_18:15:58.808)[ 248.220771]<0>.(0)[140:kworker/u8:4][PMIC] regulator_enable(name=VEMC_3V3 id=0 en_reg=57d vol_reg=64b) [a24]=0x8102 (160314_18:15:58.808)[ 248.222073][PMIC] hwPowerOn:12:VEMC_3V3 volt:3000000 name:msdc cnt:1 (160314_18:15:58.808)[ 248.223366]<0>.(0)[140:kworker/u8:4][sd]0: VEMC_EN[0x0A24]=0xc102, should:bit1=1, VEMC_VOL[0x0A64]=0x8f20,should:bit[5:4]=2b'10[ 248.223366]<0> (160314_18:15:58.823)[ 248.235166]msdc0 -> !!! Set<200000KHz> Source<400000KHz> -> sclk<200000KHz> state<3> mode<3> div<0> hs400_src<1> (160314_18:15:58.823)[ 248.236464]<0>.(0)[140:kworker/u8:4][sd]msdc0 select card<0x00010000>[ 248.241555]<0>.(0)[140:kworker/u8:4]kpd: kpd_early_suspend wake up source resume!! (0) (160314_18:15:58.823)[ 248.242682]<0>.(0)[140:kworker/u8:4]kpd: enable kpd work! (160314_18:15:58.823)[ 248.243456]<0>.(0)[140:kworker/u8:4]kpd: KEYPAD is enabled (160314_18:15:58.823)[ 248.244136]<0>.(0)[140:kworker/u8:4]kpd: resume!! (0) (160314_18:15:58.823)[ 248.245119]<0>.(0)[140:kworker/u8:4][ccci1/mcd]ccci_modem_resume (160314_18:15:58.823)[ 248.246179]<0>.(0)[140:kworker/u8:4]M4UM4U restore in resume (160314_18:15:58.823)[ 248.247987]<0>.(0)[140:kworker/u8:4]* MT auxadc driver resume!! ******** (160314_18:15:58.823)[ 248.248936]<0>.(0)[140:kworker/u8:4]x_uart_switch_to_rx port:0x0 (160314_18:15:58.823)[ 248.249711]<0>-(0)[140:kworker/u8:4][GPIO] 513: modebefore1 set pin[74],addr=370,(ffffff8000036000,ffffff8000036370) (160314_18:15:58.823)[ 248.251050]<0>-(0)[140:kworker/u8:4][GPIO] 543: mt_set_gpio_mode_base:pin:74, mode:1, value:0xc11249 (160314_18:15:58.823)[ 248.252231]<0>-(0)[140:kworker/u8:4]No Flow Control (160314_18:15:58.823)[ 248.253334]<0>.(0)[140:kworker/u8:4][UART0] Resume(0)! (160314_18:15:58.823)[ 248.254120]<0>.(0)[140:kworker/u8:4]x_uart_switch_to_rx port:0x1 (160314_18:15:58.823)[ 248.254894]<0>-(0)[140:kworker/u8:4][GPIO] 513: modebefore1 set pin[76],addr=370,(ffffff8000036000,ffffff8000036370) (160314_18:15:58.823)[ 248.256232]<0>-(0)[140:kworker/u8:4][GPIO] 543: mt_set_gpio_mode_base:pin:76, mode:1, value:0xc91249 (160314_18:15:58.823)[ 248.257468]<0>.(0)[140:kworker/u8:4][UART1] Resume(0)! (160314_18:15:58.823)[ 248.258145]<0>.(0)[140:kworker/u8:4]x_uart_switch_to_rx port:0x2 (160314_18:15:58.823)[ 248.258918]<0>-(0)[140:kworker/u8:4][GPIO] 513: modebefore1 set pin[57],addr=350,(ffffff8000036000,ffffff8000036350) (160314_18:15:58.823)[ 248.260255]<0>-(0)[140:kworker/u8:4][GPIO] 543: mt_set_gpio_mode_base:pin:57, mode:1, value:0x2481249 (160314_18:15:58.823)[ 248.261429]<0>.(0)[140:kworker/u8:4][UART2] Resume(0)! (160314_18:15:58.823)[ 248.262103]<0>.(0)[140:kworker/u8:4]x_uart_switch_to_rx port:0x3 (160314_18:15:58.823)[ 248.262965]<0>.(0)[71:fuse_log][BLOCK_TAG] FUSEIO {4088:lookup(0,1,135)} (160314_18:15:58.823)[ 248.263920]<0>.(0)[140:kworker/u8:4]GPIO_UART_URXD3_PIN is not properly set p2 (160314_18:15:58.979)[ 248.264927]<0>.(0)[140:kworker/u8:4]kworker/u8:4]AUDNCP_CLKDIV_CON4 = 0x0 (160314_18:15:58.979)[ 248.377028]<0>.(0)[140:kworker/u8:4]TOP_CKPDN_CON0 = 0xfefc (160314_18:15:58.979)[ 248.377725]<0>.(0)[140:kworker/u8:4]GPIO_MODE3 = 0x249 (160314_18:15:58.979)[ 248.378362]<0>.(0)[140:kworker/u8:4]-Ana_Log_Print (160314_18:15:58.979)[ 248.378977]<0>.(0)[140:kworker/u8:4]AFE_UL_DL_CON0 = 0x0 (160314_18:15:58.979)[ 248.379641]<0>.(0)[140:kworker/u8:4]AFE_DL_SRC2_CON0_H = 0x7300 (160314_18:15:58.979)[ 248.380381]<0>.(0)[140:kworker/u8:4]AFE_DL_SRC2_CON0_L = 0x0 (160314_18:15:58.979)[ 248.381088]<0>.(0)[140:kworker/u8:4]AFE_DL_SDM_CON0 = 0x0 (160314_18:15:58.979)[ 248.381773]<0>.(0)[140:kworker/u8:4]AFE_DL_SDM_CON1 = 0x1e (160314_18:15:58.979)[ 248.382608]<0>.(0)[140:kworker/u8:4]AFE_UL_SRC0_CON0_H = 0x0 (160314_18:15:58.979)[ 248.383419]<0>.(0)[140:kworker/u8:4]AFE_UL_SRC0_CON0_L = 0x0 (160314_18:15:58.979)[ 248.384127]<0>.(0)[140:kworker/u8:4]AFE_UL_SRC1_CON0_H = 0xe1 (160314_18:15:58.979)[ 248.384915]<0>.(0)[140:kworker/u8:4]AFE_UL_SRC1_CON0_L = 0x8e18 (160314_18:15:58.979)[ 248.385656]<0>.(0)[140:kworker/u8:4]PMIC_AFE_TOP_CON0 = 0x0 (160314_18:15:58.979)[ 248.386363]<0>.(0)[140:kworker/u8:4]AFE_AUDIO_TOP_CON0 = 0x7a (160314_18:15:58.979)[ 248.387081]<0>.(0)[140:kworker/u8:4]PMIC_AFE_TOP_CON0 = 0x0 (160314_18:15:58.979)[ 248.387788]<0>.(0)[140:kworker/u8:4]AFE_DL_SRC_MON0 = 0x0 (160314_18:15:58.979)[ 248.388474]<0>.(0)[140:kworker/u8:4]AFE_DL_SDM_TEST0 = 0x7010 (160314_18:15:58.979)[ 248.389203]<0>.(0)[140:kworker/u8:4]AFE_MON_DEBUG0 = 0x0 (160314_18:15:58.979)[ 248.389867]<0>.(0)[140:kworker/u8:4]AFUNC_AUD_CON0 = 0xc3a1 (160314_18:15:58.979)[ 248.390563]<0>.(0)[140:kworker/u8:4]AFUNC_AUD_CON1 = 0x0 (160314_18:15:58.979)[ 248.391226]<0>.(0)[140:kworker/u8:4]AFUNC_AUD_CON2 = 0xb (160314_18:15:58.979)[ 248.391890]<0>.(0)[140:kworker/u8:4]AFUNC_AUD_CON3 = 0x0 (160314_18:15:58.979)[ 248.392966]<0>.(0)[140:kworker/u8:4]AFUNC_AUD_CON4 = 0x0 (160314_18:15:58.979)[ 248.393736]<0>.(0)[140:kworker/u8:4]AFUNC_AUD_MON0 = 0x0 (160314_18:15:58.979)[ 248.394400]<0>.(0)[140:kworker/u8:4]AFUNC_AUD_MON1 = 0x0 (160314_18:15:58.979)[ 248.395136]<0>.(0)[140:kworker/u8:4]AUDRC_TUNE_MON0 = 0x0 (160314_18:15:58.979)[ 248.395823]<0>.(0)[140:kworker/u8:4]AFE_UP8X_FIFO_CFG0 = 0x1 (160314_18:15:58.979)[ 248.396531]<0>.(0)[140:kworker/u8:4]AFE_UP8X_FIFO_LOG_MON0 = 0x3 (160314_18:15:58.979)[ 248.397281]<0>.(0)[140:kworker/u8:4]AFE_UP8X_FIFO_LOG_MON1 = 0x0 (160314_18:15:58.979)[ 248.398031]<0>.(0)[140:kworker/u8:4]AFE_DL_DC_COMP_CFG0 = 0x0 (160314_18:15:58.979)[ 248.398760]<0>.(0)[140:kworker/u8:4]AFE_DL_DC_COMP_CFG1 = 0x0 (160314_18:15:58.979)[ 248.399488]<0>.(0)[140:kworker/u8:4]AFE_DL_DC_COMP_CFG2 = 0x0 (160314_18:15:58.979)[ 248.400217]<0>.(0)[140:kworker/u8:4]AFE_PMIC_NEWIF_CFG0 = 0x7330 (160314_18:15:58.979)[ 248.400978]<0>.(0)[140:kworker/u8:4]AFE_PMIC_NEWIF_CFG1 = 0x18 (160314_18:15:58.979)[ 248.401718]<0>.(0)[140:kworker/u8:4]AFE_PMIC_NEWIF_CFG2 = 0x302f (160314_18:15:58.979)[ 248.402624]<0>.(0)[140:kworker/u8:4]AFE_PMIC_NEWIF_CFG3 = 0xf872 (160314_18:15:58.979)[ 248.403490]<0>.(0)[140:kworker/u8:4]AFE_SGEN_CFG0 = 0x8 (160314_18:15:58.979)[ 248.404154]<0>.(0)[140:kworker/u8:4]AFE_SGEN_CFG1 = 0x101 (160314_18:15:58.979)[ 248.404910]<0>.(0)[140:kworker/u8:4]AFE_VOW_TOP = 0x0 (160314_18:15:58.979)[ 248.405553]<0>.(0)[140:kworker/u8:4]AFE_VOW_CFG0 = 0x0 (160314_18:15:58.979)[ 248.406206]<0>.(0)[140:kworker/u8:4]AFE_VOW_CFG1 = 0x0 (160314_18:15:58.979)[ 248.406859]<0>.(0)[140:kworker/u8:4]AFE_VOW_CFG2 = 0x0 (160314_18:15:58.979)[ 248.407511]<0>.(0)[140:kworker/u8:4]AFE_VOW_CFG3 = 0x0 (160314_18:15:58.979)[ 248.408164]<0>.(0)[140:kworker/u8:4]AFE_VOW_CFG4 = 0x0 (160314_18:15:58.979)[ 248.408817]<0>.(0)[140:kworker/u8:4]AFE_VOW_CFG5 = 0x0 (160314_18:15:58.979)[ 248.409469]<0>.(0)[140:kworker/u8:4]AFE_VOW_MON0 = 0x0 (160314_18:15:58.979)[ 248.410122]<0>.(0)[140:kworker/u8:4]AFE_VOW_MON1 = 0x0 (160314_18:15:58.979)[ 248.410775]<0>.(0)[140:kworker/u8:4]AFE_VOW_MON2 = 0x0 (160314_18:15:58.979)[ 248.411427]<0>.(0)[140:kworker/u8:4]AFE_VOW_MON3 = 0x0 (160314_18:15:58.979)[ 248.412079]<0>.(0)[140:kworker/u8:4]AFE_VOW_MON4 = 0x0 (160314_18:15:58.979)[ 248.413128]<0>.(0)[140:kworker/u8:4]AFE_VOW_MON5 = 0x0 (160314_18:15:58.979)[ 248.413887]<0>.(0)[140:kworker/u8:4]AFE_DCCLK_CFG0 = 0xfe2 (160314_18:15:58.995)[ 248.414573]<0>.(0)[140:kworker/u8:4]AFE_DCCLK_CFG1 = 0x1005 (160314_18:15:58.995)[ 248.415344]<0>.(0)[140:kworker/u8:4]TOP_CON = 0x133 (160314_18:15:58.995)[ 248.415965]<0>.(0)[140:kworker/u8:4]TOP_STATUS = 0x0 (160314_18:15:58.995)[ 248.416586]<0>.(0)[140:kworker/u8:4]TOP_CKPDN_CON0 = 0xfefc (160314_18:15:58.995)[ 248.417282]<0>.(0)[140:kworker/u8:4]TOP_CKPDN_CON1 = 0x4ac (160314_18:15:58.995)[ 248.417967]<0>.(0)[140:kworker/u8:4]TOP_CKPDN_CON2 = 0x7673 (160314_18:15:58.995)[ 248.418664]<0>.(0)[140:kworker/u8:4]TOP_CKPDN_CON3 = 0x5e4 (160314_18:15:58.995)[ 248.419350]<0>.(0)[140:kworker/u8:4]TOP_CKSEL_CON0 = 0x280 (160314_18:15:58.995)[ 248.420035]<0>.(0)[140:kworker/u8:4]TOP_CKSEL_CON1 = 0x0 (160314_18:15:58.995)[ 248.420698]<0>.(0)[140:kworker/u8:4]TOP_CKSEL_CON2 = 0x0 (160314_18:15:58.995)[ 248.421361]<0>.(0)[140:kworker/u8:4]TOP_CKDIVSEL_CON = 0x1 (160314_18:15:58.995)[ 248.422058]<0>.(0)[140:kworker/u8:4]TOP_CKHWEN_CON = 0x30ff (160314_18:15:58.995)[ 248.422897]<0>.(0)[140:kworker/u8:4]TOP_CKTST_CON0 = 0x0 (160314_18:15:58.995)[ 248.423665]<0>.(0)[140:kworker/u8:4]TOP_CKTST_CON1 = 0x0 (160314_18:15:58.995)[ 248.424330]<0>.(0)[140:kworker/u8:4]TOP_CKTST_CON2 = 0x0 (160314_18:15:58.995)[ 248.425062]<0>.(0)[140:kworker/u8:4]TOP_CLKSQ = 0x8102 (160314_18:15:58.995)[ 248.425716]<0>.(0)[140:kworker/u8:4]TOP_RST_CON0 = 0x0 (160314_18:15:58.995)[ 248.426369]<0>.(0)[140:kworker/u8:4]TEST_CON0 = 0x0 (160314_18:15:58.995)[ 248.426989]<0>.(0)[140:kworker/u8:4]TEST_OUT = 0x4 (160314_18:15:58.995)[ 248.427599]<0>.(0)[140:kworker/u8:4]AFE_MON_DEBUG0= 0x0 (160314_18:15:58.995)[ 248.428251]<0>.(0)[140:kworker/u8:4]ZCD_CON0 = 0x0 (160314_18:15:58.995)[ 248.428861]<0>.(0)[140:kworker/u8:4]ZCD_CON1 = 0x488 (160314_18:15:58.995)[ 248.429491]<0>.(0)[140:kworker/u8:4]ZCD_CON2 = 0x60c (160314_18:15:58.995)[ 248.430122]<0>.(0)[140:kworker/u8:4]ZCD_CON3 = 0x1f (160314_18:15:58.995)[ 248.430742]<0>.(0)[140:kworker/u8:4]ZCD_CON4 = 0x707 (160314_18:15:58.995)[ 248.431373]<0>.(0)[140:kworker/u8:4]ZCD_CON5 = 0x3f3f (160314_18:15:58.995)[ 248.432015]<0>.(0)[140:kworker/u8:4]LDO_CON1 = 0xe128 (160314_18:15:58.995)[ 248.432795]<0>.(0)[140:kworker/u8:4]LDO_CON2 = 0xc102 (160314_18:15:58.995)[ 248.433541]<0>.(0)[140:kworker/u8:4]LDO_VCON1 = 0xc002 (160314_18:15:58.995)[ 248.434195]<0>.(0)[140:kworker/u8:4]SPK_CON0 = 0x0 (160314_18:15:58.995)[ 248.434873]<0>.(0)[140:kworker/u8:4]SPK_CON1 = 0x0 (160314_18:15:58.995)[ 248.435484]<0>.(0)[140:kworker/u8:4]SPK_CON2 = 0x14 (160314_18:15:58.995)[ 248.436106]<0>.(0)[140:kworker/u8:4]SPK_CON3 = 0x0 (160314_18:15:58.995)[ 248.436715]<0>.(0)[140:kworker/u8:4]SPK_CON4 = 0x0 (160314_18:15:58.995)[ 248.437324]<0>.(0)[140:kworker/u8:4]SPK_CON5 = 0x94 (160314_18:15:58.995)[ 248.437944]<0>.(0)[140:kworker/u8:4]SPK_CON6 = 0x0 (160314_18:15:58.995)[ 248.438553]<0>.(0)[140:kworker/u8:4]SPK_CON7 = 0x4531 (160314_18:15:58.995)[ 248.439195]<0>.(0)[140:kworker/u8:4]SPK_CON8 = 0x0 (160314_18:15:58.995)[ 248.439804]<0>.(0)[140:kworker/u8:4]SPK_CON9 = 0x2000 (160314_18:15:58.995)[ 248.440445]<0>.(0)[140:kworker/u8:4]SPK_CON10 = 0x0 (160314_18:15:58.995)[ 248.441065]<0>.(0)[140:kworker/u8:4]SPK_CON11 = 0x0 (160314_18:15:58.995)[ 248.441685]<0>.(0)[140:kworker/u8:4]SPK_CON12 = 0x0 (160314_18:15:58.995)[ 248.442305]<0>.(0)[140:kworker/u8:4]SPK_CON13 = 0x0 (160314_18:15:58.995)[ 248.443321]<0>.(0)[140:kworker/u8:4]SPK_CON14 = 0x0 (160314_18:15:58.995)[ 248.444051]<0>.(0)[140:kworker/u8:4]SPK_CON15 = 0x0 (160314_18:15:58.995)[ 248.444672]<0>.(0)[140:kworker/u8:4]SPK_CON16 = 0x0 (160314_18:15:58.995)[ 248.445365]<0>.(0)[140:kworker/u8:4]SPK_ANA_CON0 = 0x5800 (160314_18:15:58.995)[ 248.446052]<0>.(0)[140:kworker/u8:4]SPK_ANA_CON1 = 0x0 (160314_18:15:58.995)[ 248.446705]<0>.(0)[140:kworker/u8:4]SPK_ANA_CON3 = 0x0 (160314_18:15:58.995)[ 248.447357]<0>.(0)[140:kworker/u8:4]AUDDEC_ANA_CON0 = 0x0 (160314_18:15:58.995)[ 248.448042]<0>.(0)[140:kworker/u8:4]AUDDEC_ANA_CON1 = 0x480 (160314_18:15:58.995)[ 248.448749]<0>.(0)[140:kworker/u8:4]AUDDEC_ANA_CON2 = 0x1 (160314_18:15:58.995)[ 248.449434]<0>.(0)[140:kworker/u8:4]AUDDEC_ANA_CON3 = 0x72 (160314_18:15:58.995)[ 248.450130]<0>.(0)[140:kworker/u8:4]AUDDEC_ANA_CON4 = 0x0 (160314_18:15:58.995)[ 248.450816]<0>.(0)[140:kworker/u8:4]AUDDEC_ANA_CON5 = 0x5490 (160314_18:15:58.995)[ 248.451534]<0>.(0)[140:kworker/u8:4]AUDDEC_ANA_CON6 = 0x1 (160314_18:15:58.995)[ 248.452219]<0>.(0)[140:kworker/u8:4]AUDDEC_ANA_CON7 = 0x0 (160314_18:15:58.995)[ 248.453070]<0>.(0)[140:kworker/u8:4]AUDDEC_ANA_CON8 = 0x2 (160314_18:15:58.995)[ 248.453860]<0>.(0)[140:kworker/u8:4]AUDENC_ANA_CON0 = 0x0 (160314_18:15:58.995)[ 248.454547]<0>.(0)[140:kworker/u8:4]AUDENC_ANA_CON1 = 0x0 (160314_18:15:58.995)[ 248.455303]<0>.(0)[140:kworker/u8:4]AUDENC_ANA_CON2 = 0x0 (160314_18:15:58.995)[ 248.455989]<0>.(0)[140:kworker/u8:4]AUDENC_ANA_CON3 = 0x0 (160314_18:15:58.995)[ 248.456675]<0>.(0)[140:kworker/u8:4]AUDENC_ANA_CON4 = 0x800 (160314_18:15:58.995)[ 248.457383]<0>.(0)[140:kworker/u8:4]AUDENC_ANA_CON5 = 0x0 (160314_18:15:58.995)[ 248.458070]<0>.(0)[140:kworker/u8:4]AUDENC_ANA_CON6 = 0x555 (160314_18:15:58.995)[ 248.458777]<0>.(0)[140:kworker/u8:4]AUDENC_ANA_CON7 = 0x0 (160314_18:15:58.995)[ 248.459463]<0>.(0)[140:kworker/u8:4]AUDENC_ANA_CON8 = 0x4 (160314_18:15:58.995)[ 248.460148]<0>.(0)[140:kworker/u8:4]AUDENC_ANA_CON9 = 0x0 (160314_18:15:58.995)[ 248.460835]<0>.(0)[140:kworker/u8:4]AUDENC_ANA_CON10 = 0x0 (160314_18:15:58.995)[ 248.461531]<0>.(0)[140:kworker/u8:4]AUDNCP_CLKDIV_CON0 = 0x0 (160314_18:15:58.995)[ 248.462237]<0>.(0)[140:kworker/u8:4]AUDNCP_CLKDIV_CON1 = 0x0 (160314_18:15:58.995)[ 248.463351]<0>.(0)[140:kworker/u8:4]AUDNCP_CLKDIV_CON2 = 0x2b (160314_18:15:58.995)[ 248.464212]<0>.(0)[140:kworker/u8:4]AUDNCP_CLKDIV_CON3 = 0x1 (160314_18:15:58.995)[ 248.464920]<0>.(0)[140:kworker/u8:4]AUDNCP_CLKDIV_CON4 = 0x0 (160314_18:15:58.995)[ 248.465704]<0>.(0)[140:kworker/u8:4]TOP_CKPDN_CON0 = 0xfefc (160314_18:15:58.995)[ 248.466401]<0>.(0)[140:kworker/u8:4]GPIO_MODE3 = 0x249 (160314_18:15:58.995)[ 248.467039]<0>.(0)[140:kworker/u8:4]-Ana_Log_Print (160314_18:15:59.088)[ 248.467686]<0>-(0)[140:kworker/u8:4]-----------AudDrv_Clk_On, Aud_AFE_Clk_cntr:0 (160314_18:15:59.088)[ 248.468628]<0>-(0)[140:kworker/u8:4]------------AudDrv_Clk_Off, Aud_AFE_Clk_cntr:0 (160314_18:15:59.088)[ 248.470158]<0>-(0)[140:kworker/u8:4]M4Ularb(0) restore (160314_18:15:59.088)[ 248.476062]<0>-(0)[113:kworker/u9:1]M4Ularb(0) backup (160314_18:15:59.088)[ 248.477199]<0>.(0)[140:kworker/u8:4]wxy calling xfb_pm_resume start. (160314_18:15:59.088)[ 248.478019]<0>.(0)[140:kworker/u8:4]wxy calling xfb_pm_resume exit. (160314_18:15:59.088)[ 248.478833]<0>.(0)[140:kworker/u8:4]wxy calling xfb_resume start. (160314_18:15:59.088)[ 248.479624]<0>.(0)[140:kworker/u8:4]DISP/xFB [FB Driver] xfb_resume() (160314_18:15:59.088)[ 248.480470]<0>.(0)[140:kworker/u8:4]wxy calling xfb_resume exit. (160314_18:15:59.088)[ 248.481974]<0>.(0)[140:kworker/u8:4][PMIC] * MT pmic driver resume!! ******** (160314_18:15:59.088)[ 248.484208]<0>.(0)[140:kworker/u8:4][PMIC] Reg[0xec2]=0x8a12, Reg[0xec4]=0xb9a1, Reg[0x2ac]=0x28f (160314_18:15:59.088)[ 248.486442]<0>.(0)[140:kworker/u8:4][PMIC] Reg[0xcd2]=0xd7b3, Reg[0xcd4]=0xd096, Reg[0x2b8]=0xb40 (160314_18:15:59.088)[ 248.488357]<0>.(0)[140:kworker/u8:4][HPS] hps_resume (160314_18:15:59.088)[ 248.491648]<0>.(0)[140:kworker/u8:4][wdk]bind kicker thread[149] to cpu1[ 248.493152]<0>.(0)[140:kworker/u8:4][WDK]cpu 1 plug on kick wdt (160314_18:15:59.088)[ 248.497000]<0>.(0)[140:kworker/u8:4][wdk]bind kicker thread[150] to cpu2[ 248.497937]<0>.(0)[140:kworker/u8:4][WDK]cpu 2 plug on kick wdt (160314_18:15:59.088)[ 248.501784]<0>.(0)[140:kworker/u8:4][wdk]bind kicker thread[151] to cpu3[ 248.502898]<1>.(1)[140:kworker/u8:4][WDK]cpu 3 plug on kick wdt (160314_18:15:59.088)[ 248.503958]<1>.(1)[140:kworker/u8:4]can't online cpu 4 because it is not configured as may-hotadd at boot time (160314_18:15:59.088)[ 248.505210]<1>.(1)[140:kworker/u8:4][HPS] state: 1, enabled: 1, early_suspend_enabled: 1, suspend_enabled: 1, rush_boost_enabled: 0 (160314_18:15:59.088)[ 248.509796]<1>.(1)[140:kworker/u8:4][Gsensor] set interrupt:reg_mode:=41, Enable mode = 0 (160314_18:15:59.088)[ 248.510823]<1>-(1)[140:kworker/u8:4][GPIO] 513: modebefore1 set pin[66],addr=360,(ffffff8000036000,ffffff8000036360) (160314_18:15:59.088)[ 248.512162]<1>-(1)[140:kworker/u8:4][GPIO] 543: mt_set_gpio_mode_base:pin:66, mode:0, value:0x11400000 (160314_18:15:59.088)[ 248.516753]<1>.(1)[140:kworker/u8:4][Gsensor] mc3xxx int flag =41 (160314_18:15:59.088)[ 248.518102]<1>.(1)[140:kworker/u8:4][Gsensor] [MC3XXX_ConfigRegRange] set 0x0 (160314_18:15:59.088)[ 248.519581]<1>.(1)[140:kworker/u8:4][Gsensor] MC3XXX_Init[ 248.520862]<1>.(1)[140:kworker/u8:4][Gsensor] MC3XXX_SetResolution[ 248.521653]<1>.(1)[140:kworker/u8:4][Gsensor] [MC3XXX_SetResolution] s_bResolution: 2 (160314_18:15:59.088)[ 248.522684]<1>.(1)[140:kworker/u8:4][Gsensor] MC3XXX_SetSampleRate[ 248.525620]<1>.(1)[140:kworker/u8:4][Gsensor] [MC3XXX_ConfigRegRange] set 0x0 (160314_18:15:59.088)[ 248.526512]<1>.(1)[140:kworker/u8:4][Gsensor] [MC3XXX_SetGain] gain: 1024 / 1024 / 1024 (160314_18:15:59.088)[ 248.529575]<1>.(1)[140:kworker/u8:4][Gsensor] [MC3XXX_Init] init ok. (160314_18:15:59.088)[ 248.530365]<1>.(1)[140:kworker/u8:4][Gsensor] Sensor power status should not be set again!!! (160314_18:15:59.088)[ 248.532309]<1>.(1)[140:kworker/u8:4][Gsensor] set power read MC3XXX_REG_MODE_FEATURE =43 (160314_18:15:59.088)[ 248.535052]<1>.(1)[140:kworker/u8:4][battery_meter_resume] sleep time = 11, g_spm_timer = 639 (160314_18:15:59.088)[ 248.537734]x_ICUSB [DBG], <usb_dev_resume(), 279> (160314_18:15:59.088)[ 248.538335]<0>.(0)[140:kworker/u8:4]usb usb1: usb_resume_both: READY TO RESUME BOTH (160314_18:15:59.088)[ 248.539305]x_ICUSB [DBG], <usb_resume_device(), 1131> (160314_18:15:59.088)[ 248.539950]<0>.(0)[140:kworker/u8:4]x_ICUSB [DBG], <generic_resume(), 253> udev : 18446743799732224000x_ICUSB [DBG], <generic_resume(), 262> udev : 18446743799732224000 (160314_18:15:59.088)[ 248.541893]x_ICUSB [DBG], <usb_resume_device(), 1134> (160314_18:15:59.088)[ 248.543222]<3>-(3)[140:kworker/u8:4][MUSB]musb_readb 122: [MUSB]:access musb_readb function when usb clock is off 0x60 (160314_18:15:59.088)[ 248.544585]<3>-(3)[140:kworker/u8:4][MUSB]musb_hub_control 364: port status 00000100,devctl=0x99 (160314_18:15:59.088)[ 248.548123]<3>.(3)[140:kworker/u8:4][SLP] @@@@@@@@@@@@@@@@@@@@ (160314_18:15:59.088)[ 248.548850]<3>.(3)[140:kworker/u8:4][SLP] Chip_pm_end (160314_18:15:59.088)[ 248.549477]<3>.(3)[140:kworker/u8:4][SLP] @@@@@@@@@@@@@@@@@@@@ (160314_18:15:59.088)[ 248.550216]Restarting tasks ... [ 248.551573]<0>.(0)[725:CCCIReadThread][ccci1/chr]MD state 0 (160314_18:15:59.088)[ 248.552157]<0>.(2)[140:kworker/u8:4][battery_pm_event] pm_event 4 (160314_18:15:59.088)[ 248.552166]<0>.(2)[140:kworker/u8:4]slp_get_wake_reason=4 (160314_18:15:59.088)[ 248.552172]<0>.(2)[140:kworker/u8:4]battery resume NOT by pcm timer!! (160314_18:15:59.088)[ 248.552184]<0>.(2)[140:kworker/u8:4]@bs=0@ (160314_18:15:59.088)[ 248.552239]<0>.(2)[140:kworker/u8:4]WQ warning! work (try_to_suspend, ffffffc000e598d8) execute more than 1 sec, time: 133428028238 ns (160314_18:15:59.088)[ 248.552469]<0>-(2)[139:kworker/u8:3][sd]msdc1 -> Card insert<0> Block bad card<0> <- msdc_ops_get_cd() : L<8148> PID<kworker/u8:3><0x8b> (160314_18:15:59.088)[ 248.552517]<0>.(3)[3885:ipod][ipodmain]vbusMonitorThread CurrVbusStatus = 1, vbusStatus = 0, vbus_status= 0 (160314_18:15:59.088)[ 248.552517]<0>. (160314_18:15:59.088)[ 248.553386]<0>.(3)[3876:ipod][ipodmain]write_to_file: path: /sys/power/wake_lock, buf: IPOD_WAKELOCK, size: 13 force:1 (160314_18:15:59.088)[ 248.553530]<0>-(2)[139:kworker/u8:3][sd]msdc2 -> Card insert<0> Block bad card<0> <- msdc_ops_get_cd() : L<8148> PID<kworker/u8:3><0x8b> (160314_18:15:59.088)[ 248.553660]<0>.(3)[3876:ipod][ipodmain]write_to_file: path: /sys/power/wake_unlock, buf: IPOD_WAKELOCK, size: 13 force:1 (160314_18:15:59.088)[ 248.553856]<0>.(3)[3889:ipod][libipod]write_to_file: path: /sys/power/wake_lock, buf: IPOD_ALARM_WAKELOCK, size: 19, force: 1 (160314_18:15:59.088)[ 248.554022]<0>.(3)[3889:ipod][libipod]rtc0 fd = 19, result = 4, data = 416 (160314_18:15:59.088)[ 248.554114]<0>.(3)[3889:ipod]x_rtc_common: power-on = 1970/01/01 00:00:00 (0)(0) (160314_18:15:59.088)[ 248.554152]<0>.(3)[3889:ipod][libipod]alarm fd = 15, result = 0 (160314_18:15:59.088)[ 248.554201]<0>.(3)[3889:ipod][libipod]alarm result:0x0, alrm.enabled:0, alrm.pending:0 (160314_18:15:59.088)[ 248.554253]<0>.(3)[3889:ipod][libipod]get_time: 1457950558 (160314_18:15:59.088)[ 248.554633]<0>.(3)[3889:ipod][libipod]Could not open '/sys/class/power_supply/wireless/online' (160314_18:15:59.088)[ 248.554680]<0>.(3)[3889:ipod][ipodmain]status_cb: EVENT_CHECK_CHARGING(12), 0, 0 (160314_18:15:59.088)[ 248.554736]<0>.(3)[3889:ipod][libipod]in is_charging_source_available(), usb:0 ac:0 wireless:0 status_cb(EVENT_CHECK_CHARGING):0 (160314_18:15:59.088)[ 248.554736]<0> (160314_18:15:59.088)[ 248.554777]<0>.(3)[3889:ipod][libipod][IPO-H] mode (1) (160314_18:15:59.088)[ 248.554942]<0>.(3)[3889:ipod][libipod]system free memory: 226720 kB (160314_18:15:59.088)[ 248.554942]<0> (160314_18:15:59.088)[ 248.555340]<0>.(2)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=1%, duty 16566308, period 1152702900, req_cnt=16 (160314_18:15:59.166)[ 248.555353]<0>.(2)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=3117710 sectors offset, req_cnt=9, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:15:59.166)[ 248.555365]<0>.(2)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Read Diversity=761870 sectors offset, req_cnt=7, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:15:59.166)[ 248.555376]<0>.(2)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=15872 kB/s, size: 126976 bytes, time:8 ms (160314_18:15:59.166)[ 248.555386]<0>.(2)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Read Throughput=5120 kB/s, size: 40960 bytes, time:8 ms (160314_18:15:59.166)[ 248.555399]<0>.(2)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:15:59.166)[ 248.555418]<0>.(2)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00888:00000:00000000:00010:00040960}{00418:00001:00004096:00000:00000000}{00791:00001:00004096:00000:00000000} (160314_18:15:59.166)[ 248.555431]<0>.(2)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115296)(FD:0)(ND:130392)(WB:0)(NW:137872) (160314_18:15:59.166)done. (160314_18:15:59.166)[ 248.587650]<3>.(3)[3889:ipod][libipod]swap file does not exist, going to create and init. (160314_18:15:59.166)[ 248.587650]<3> (160314_18:15:59.166)[ 248.587763]<3>.(0)[438:ccci_mdinit][ccci1/ipc]CCCI_IPC_WAIT_TIME_UPDATE (160314_18:15:59.166)[ 248.594567]<1>.(1)[3889:ipod][libipod][IPOH] allow compressed ratio 0. (160314_18:15:59.166)[ 248.595683]<1>.(1)[3889:ipod][libipod][IPOH] expected compressed ratio 68. (160314_18:15:59.166)[ 248.596626]<1>.(1)[3889:ipod][libipod]meminfo: total/free/shared/buffer/totalhigh/freehigh: 928980/226100/0/288/0/0 kB. (160314_18:15:59.166)[ 248.598044]<1>.(1)[3889:ipod][libipod]swapfile size: 239 MB, total DRAM: 907 MB. (160314_18:15:59.166)[ 248.599116]<1>.(1)[3889:ipod][libipod]bsize/frsize/blocks/bfree:4096/4096/99186/99084 (160314_18:15:59.166)[ 248.599116]<1> (160314_18:15:59.166)[ 248.600372]<1>.(1)[3889:ipod][libipod]storage status: 396336/396744 kB (160314_18:15:59.166)[ 248.600372]<1> (160314_18:15:59.166)[ 248.601455]<1>.(1)[3889:ipod][libipod]Current length: 0. (160314_18:15:59.166)[ 248.602167]<1>.(1)[3889:ipod][libipod]Current block size: 4096. (160314_18:15:59.166)[ 248.603043]<1>.(1)[3889:ipod][libipod]Current block allocated: 0. (160314_18:15:59.166)[ 248.603860]<1>.(1)[3889:ipod][libipod]Increaseing file to: 251290624. (160314_18:15:59.166)[ 248.608670]<0>.(0)[3889:ipod][libipod]preallocate successfully. (160314_18:15:59.166)[ 248.608670]<0> (160314_18:15:59.166)[ 248.609735]<0>.(0)[3889:ipod][libipod]Setting up swapspace version 1, size = 251286528 bytes (160314_18:15:59.166)[ 248.609735]<0> (160314_18:15:59.166)[ 248.616108]<3>.(3)[3889:ipod][libipod]mkswap successfully. (160314_18:15:59.166)[ 248.616108]<3> (160314_18:15:59.166)[ 248.617327]<3>.(3)[3889:ipod][libipod]resume offset = 16384 (160314_18:15:59.166)[ 248.617327]<3> (160314_18:15:59.166)[ 248.618369]<3>.(3)[3889:ipod][libipod]WARN: try symbolic '/emmc@cache' of swap partition failed: No such file or directory. (160314_18:15:59.166)[ 248.618369]<3> (160314_18:15:59.166)[ 248.620317]<3>.(3)[3889:ipod][KL_ENV]name :resume,value: swap:/dev/mmcblk0p21:16384 (160314_18:15:59.166)[ 248.621278]<3>.(3)[3889:ipod][KL_ENV]set env, name=resume,value=swap:/dev/mmcblk0p21:16384 (160314_18:15:59.166)[ 248.625905]<0>.(0)[3889:ipod]WXY toi_start_anything:204[ 248.626612]<0>.(0)[3889:ipod]WXY toi_start_anything:217[ 248.627294]<0>.(0)[3889:ipod]WXY toi_start_anything:225[ 248.628026]<0>.(0)[3889:ipod]WXY toi_start_anything:234[ 248.628710]<0>.(0)[3889:ipod]WXY toi_start_anything:244[ 248.629394]<0>.(0)[3889:ipod][toi_initialise_modules:393] this_module->name = allocation debugging (160314_18:15:59.166)[ 248.630511]<0>.(0)[3889:ipod]WXY toi_start_anything:252[ 248.631193]<0>.(0)[3889:ipod]hibernate_or_resume(0x00000000), resume_file="" (160314_18:15:59.166)[ 248.632108]<0>.(0)[3889:ipod]WXY toi_attempt_to_parse_resume_device:108[ 248.633467]<0>.(0)[3889:ipod]WXY toi_attempt_to_parse_resume_device:118[ 248.634329]<0>.(0)[3889:ipod]WXY [toi_attempt_to_parse_resume_device:131] resume_file = , quiet = 1 (160314_18:15:59.166)[ 248.635456]<0>.(0)[3889:ipod]WXY [toi_bio_parse_sig_location:1708] commandline = (160314_18:15:59.166)[ 248.636387]<0>.(0)[3889:ipod]WXY toi_bio_parse_sig_location:1724[ 248.637168]<0>.(0)[3889:ipod]WXY toi_bio_parse_sig_location:1738[ 248.637949]<0>.(0)[3889:ipod]WXY [toi_bio_parse_sig_location:1756] devstart = (160314_18:15:59.166)[ 248.638851]<0>.(0)[3889:ipod][HIB/TOI] [try_to_open_resume_device()]commandline="" (160314_18:15:59.182)[ 248.639793]<0>.(0)[3889:ipod][HIB/TOI] [try_to_open_resume_device()]skip scanning for image... (160314_18:15:59.182)[ 248.640909]<0>.(0)[3889:ipod]WXY try_to_open_resume_device:1617[ 248.641679]<0>.(0)[3889:ipod]WXY try_to_open_resume_device:1630[ 248.642762]<0>.(0)[3889:ipod]WXY try_to_open_resume_device:1640[ 248.643563]<0>.(0)[3889:ipod]WXY try_to_open_resume_device:1653[ 248.644329]<0>.(0)[3889:ipod]WXY try_to_open_resume_device:1659[ 248.645101]<0>.(0)[3889:ipod]WXY [toi_attempt_to_parse_resume_device:136] result =1 (160314_18:15:59.182)[ 248.646054]<0>.(0)[3889:ipod]WXY toi_attempt_to_parse_resume_device:165[ 248.646911]<0>.(0)[3889:ipod]WXY toi_start_anything:261[ 248.647596]<0>.(0)[3889:ipod][toi_initialise_modules:393] this_module->name = usm (160314_18:15:59.182)[ 248.648528]<0>.(0)[3889:ipod][toi_initialise_modules:393] this_module->name = printk ui (160314_18:15:59.182)[ 248.649526]<0>.(0)[3889:ipod][toi_initialise_modules:393] this_module->name = poweroff (160314_18:15:59.182)[ 248.650512]<0>.(0)[3889:ipod][toi_initialise_modules:393] this_module->name = userui (160314_18:15:59.182)[ 248.651478]<0>.(0)[3889:ipod][toi_initialise_modules:393] this_module->name = compression (160314_18:15:59.182)[ 248.652716]<0>.(0)[3889:ipod][toi_initialise_modules:393] this_module->name = block i/o (160314_18:15:59.182)[ 248.653719]<0>.(0)[3889:ipod][toi_initialise_modules:393] this_module->name = swap storage (160314_18:15:59.260)[ 248.654751]<0>.(0)[3889:ipod]WXY toi_attempt_to_parse_resume_device:108[ 248.655604]<0>.(0)[3889:ipod]WXY toi_attempt_to_parse_resume_device:118[ 248.656462]<0>.(0)[3889:ipod]WXY [toi_attempt_to_parse_resume_device:131] resume_file = swap:/dev/mmcblk0p21:16384, quiet = 0 (160314_18:15:59.260)[ 248.657873]<0>.(0)[3889:ipod]WXY [toi_bio_parse_sig_location:1708] commandline = swap:/dev/mmcblk0p21:16384 (160314_18:15:59.260)[ 248.659085]<0>.(0)[3889:ipod]WXY toi_bio_parse_sig_location:1724[ 248.659906]<0>.(0)[3889:ipod]WXY toi_bio_parse_sig_location:1738[ 248.660688]<0>.(0)[3889:ipod]WXY [toi_bio_parse_sig_location:1756] devstart = /dev/mmcblk0p21 (160314_18:15:59.260)[ 248.661751]<0>.(0)[3889:ipod][HIB/TOI] [try_to_open_resume_device()]commandline="/dev/mmcblk0p21" (160314_18:15:59.260)[ 248.663433]<2>.(2)[3889:ipod]WXY try_to_open_resume_device:1617[ 248.664202]<2>.(2)[3889:ipod]WXY try_to_open_resume_device:1630[ 248.665023]<2>.(2)[3889:ipod]WXY try_to_open_resume_device:1653[ 248.665789]<2>.(2)[3889:ipod]WXY try_to_open_resume_device:1682[ 248.666559]<2>.(2)[3889:ipod]WXY open_resume_dev_t:1237[ 248.667242]<2>.(2)[3889:ipod]WXY open_resume_dev_t:1253[ 248.667939]<2>.(2)[3889:ipod]WXY open_resume_dev_t:1267[ 248.668620]<2>.(2)[3889:ipod]WXY [toi_bio_image_exists:391]. (160314_18:15:59.260)[ 248.669323]<2>.(2)[3889:ipod]WXY open_resume_dev_t:1243[ 248.670006]<2>.(2)[3889:ipod]WXY open_resume_dev_t:1249[ 248.670689]<2>.(2)[3889:ipod]WXY [toi_bio_image_exists:399]. (160314_18:15:59.260)[ 248.671776]<2>.(2)[3889:ipod]WXY toi_check_for_signature:315[ 248.672581]<2>.(2)[3889:ipod]WXY toi_check_for_signature:327[ 248.673307]<2>.(2)[3889:ipod]WXY toi_check_for_signature:347[ 248.674034]<2>.(2)[3889:ipod]WXY [toi_bio_image_exists:403]. result = 0, toi_sig_data->resumed_before = 0 (160314_18:15:59.260)[ 248.675225]<2>.(2)[3889:ipod]TuxOnIce: No image found. (160314_18:15:59.260)[ 248.675867]<2>.(2)[3889:ipod]WXY [toi_bio_parse_sig_location:1777] signature_found = 0 (160314_18:15:59.260)[ 248.676854]<2>.(2)[3889:ipod]WXY [toi_attempt_to_parse_resume_device:136] result =0 (160314_18:15:59.260)[ 248.677814]<2>.(2)[3889:ipod]WXY toi_attempt_to_parse_resume_device:153[ 248.678671]<2>.(2)[3889:ipod]WXY toi_attempt_to_parse_resume_device:165[ 248.679531]<2>.(2)[3889:ipod][HIB/TOI] [toi_finish_anything()]hibernate_or_resume(0) (160314_18:15:59.260)[ 248.680500]<2>.(2)[3889:ipod]CPU: 2 PID: 3889 Comm: ipod Tainted: G W 3.10.65 #5 (160314_18:15:59.260)[ 248.681527]<2>.(2)[3889:ipod]Call trace: (160314_18:15:59.260)[ 248.682028]<2>.(2)[3889:ipod][] dump_backtrace+0x0/0x130 (160314_18:15:59.260)[ 248.682991]<2>.(2)[3889:ipod][] show_stack+0x10/0x1c (160314_18:15:59.260)[ 248.683815]<2>.(2)[3889:ipod][] dump_stack+0x1c/0x28 (160314_18:15:59.260)[ 248.684632]<2>.(2)[3889:ipod][] toi_cleanup_modules+0x1c/0xf4 (160314_18:15:59.260)[ 248.685546]<2>.(2)[3889:ipod][] toi_finish_anything+0x5c/0x1ec (160314_18:15:59.260)[ 248.686469]<2>.(2)[3889:ipod][] toi_attr_store+0x78/0x2c8 (160314_18:15:59.260)[ 248.687339]<2>.(2)[3889:ipod][] sysfs_write_file+0xdc/0x15c (160314_18:15:59.260)[ 248.688231]<2>.(2)[3889:ipod][] vfs_write+0xa4/0x18c (160314_18:15:59.260)[ 248.689046]<2>.(2)[3889:ipod][] SyS_write+0x40/0x8c (160314_18:15:59.260)[ 248.689848]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:426] this_module->name = allocation debugging (160314_18:15:59.260)[ 248.691334]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:426] this_module->name = poweroff (160314_18:15:59.260)[ 248.692766]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:426] this_module->name = compression (160314_18:15:59.260)[ 248.694168]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:426] this_module->name = block i/o (160314_18:15:59.260)[ 248.695534]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:426] this_module->name = swap storage (160314_18:15:59.260)[ 248.696933]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:429] this_module->name = swap storage (160314_18:15:59.260)[ 248.698332]<2>.(2)[3889:ipod][HIB/TOI] [toi_finish_anything()]WXY toi_finish_anything:163[ 248.699392]<2>.(2)[3889:ipod][HIB/TOI] [toi_finish_anything()]WXY toi_finish_anything:165[ 248.700446]<2>.(2)[3889:ipod][HIB/TOI] [toi_finish_anything()]WXY toi_finish_anything:180[ 248.701502]<2>.(2)[3889:ipod][HIB/TOI] [toi_finish_anything()]WXY toi_finish_anything:185[ 248.702820]<2>.(2)[3889:ipod][libipod]resume command : swap:/dev/mmcblk0p21:16384 (160314_18:15:59.260)[ 248.702820]<2> (160314_18:15:59.260)[ 248.704133]<2>.(2)[3889:ipod][libipod]susp_to_disk... (160314_18:15:59.260)[ 248.704826]<2>.(2)[3889:ipod][libipod]IPO-H current bootup count 0 (160314_18:15:59.260)[ 248.705641]<2>.(2)[3889:ipod][libipod]radio off checking start (160314_18:15:59.260)[ 248.706411]<2>.(2)[3889:ipod][ipodmain]status_cb: EVENT_RADIOOFF_CHECK(9), 0, 0 (160314_18:15:59.260)[ 248.707381]<2>.(2)[3889:ipod][libipod]radio off checking finish (160314_18:15:59.260)[ 248.708177]<2>.(2)[3889:ipod][ipodmain]ipod_trigger_chganim: inDraw:0, config:9 (160314_18:15:59.260)[ 248.709158]<2>.(2)[3889:ipod][libipod]write_to_file: path: /sys/power/wake_lock, buf: IPOD_HIB_WAKELOCK, size: 17, force: 1 (160314_18:15:59.260)[ 248.719948]ADDLOG datagram_poll sk_queue_empty mask:0 (160314_18:15:59.340)[ 248.721977]<0>.(0)[217:servicemanager]ADDLOG datagram_poll sk_queue_empty mask:0[ 248.753002]<1>.(1)[3885:ipod][ipodmain]vbusMonitorThread CurrVbusStatus = 1, vbusStatus = 0, vbus_status= 0 (160314_18:15:59.340)[ 248.753002]<1>. (160314_18:15:59.418)[ 248.855797]ADDLOG datagram_poll sk_queue_empty mask:0 (160314_18:15:59.496)[ 248.865947]<2>.(2)[217:servicemanager]ADDLOG datagram_poll sk_queue_empty mask:0ADDLOG datagram_poll sk_queue_empty mask:0[ 248.922482]<0>.(0)[2520:kworker/0:3][Auxadc] [AUXADC] ch=4 raw=1573 data=691 (160314_18:15:59.496)[ 248.954938]<2>.(2)[3885:ipod][ipodmain]vbusMonitorThread CurrVbusStatus = 1, vbusStatus = 0, vbus_status= 0 (160314_18:15:59.496)[ 248.954938]<2>. (160314_18:15:59.699)[ 249.111698]<1>.(1)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=79%, duty 444920159, period 556357500, req_cnt=66 (160314_18:15:59.699)[ 249.113032]<1>.(1)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=2426519 sectors offset, req_cnt=18, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:15:59.699)[ 249.114611]<1>.(1)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Read Diversity=1225118 sectors offset, req_cnt=48, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:15:59.699)[ 249.116173]<1>.(1)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=580 kB/s, size: 229376 bytes, time:395 ms (160314_18:15:59.699)[ 249.117430]<1>.(1)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Read Throughput=10114 kB/s, size: 495616 bytes, time:49 ms (160314_18:15:59.699)[ 249.118690]<1>.(1)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:3 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:15:59.699)[ 249.119861]<1>.(1)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {03889:00004:00016384:00041:00167936}{00369:00001:00004096:00001:00004096}{00482:00000:00000000:00002:00008192}{00225:00000:00000000:00001:00004096}{00226:00000:00000000:00002:00008192}{00791:00005:00020480:00002:00008192}{02754:00000:00000000:00001:00004096}{00418:00000:00000000:00020:00081920}{00158:00002:00008192:00001:00004096}{00419:00002:00008192:00011:00045056}{00253:00000:00000000:00001:00004096}{03981:00000:00000000:00052:00212992}{00162:00000:00000000:00001:00004096}{00860:00000:00000000:00001:00004096}{00368:00000:00000000:00001:00004096}{02050:00000:00000000:00001:00004096}{03081:00001:00004096:00000:00000000} (160314_18:15:59.699)[ 249.127446]<1>.(1)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115796)(FD:20)(ND:130488)(WB:76)(NW:137872) (160314_18:15:59.699)[ 249.156823]<3>.(3)[3885:ipod][ipodmain]vbusMonitorThread CurrVbusStatus = 1, vbusStatus = 0, vbus_status= 0 (160314_18:15:59.699)[ 249.156823]<3>. (160314_18:15:59.902)[ 249.315828]<0>.(0)[4093:MediaScannerSer][BLOCK_TAG] FUSEIO {3064:lookup(0,61,15317)}{3063:lookup(0,4,18997)}{3064:opendir(0,15,5337)}{3063:statfs(0,1,440)}{3064:readdir(0,108,82390)}{3064:getattr(0,63,10906)}{3064:releasedir(0,14,322)}{3064:unknown(0,1,886)}{4093:lookup(0,25,160971)}{4093:opendir(0,3,486)}{4093:readdir(0,29,151470)}{4093:getattr(0,22,2479)} (160314_18:15:59.902)[ 249.358705]<0>.(0)[3885:ipod][ipodmain]vbusMonitorThread CurrVbusStatus = 1, vbusStatus = 0, vbus_status= 0 (160314_18:15:59.902)[ 249.358705]<0>. (160314_18:16:00.104)[ 249.542749]<0>.(0)[71:fuse_log][BLOCK_TAG] FUSEIO {4093:releasedir(0,2,21)}{4093:readdir(0,25,3202)}{4093:getattr(0,22,2568)}{4093:lookup(0,23,38769)}{4093:opendir(0,1,174)} (160314_18:16:00.104)[ 249.560594]<1>.(1)[3885:ipod][ipodmain]vbusMonitorThread CurrVbusStatus = 1, vbusStatus = 0, vbus_status= 0 (160314_18:16:00.104)[ 249.560594]<1>. (160314_18:16:00.245)[ 249.676851]<1>.(1)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=98%, duty 559309076, period 565153000, req_cnt=10 (160314_18:16:00.245)[ 249.678128]<1>.(1)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=799828 sectors offset, req_cnt=7, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:00.245)[ 249.679681]<1>.(1)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Read Diversity=285640 sectors offset, req_cnt=3, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:00.245)[ 249.681220]<1>.(1)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=121 kB/s, size: 65536 bytes, time:541 ms (160314_18:16:00.245)[ 249.682556]<1>.(1)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Read Throughput=1686 kB/s, size: 28672 bytes, time:17 ms (160314_18:16:00.245)[ 249.683825]<1>.(1)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:00.245)[ 249.684965]<1>.(1)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00001:00004096:00001:00004096}{00791:00001:00004096:00000:00000000}{00418:00000:00000000:00001:00004096}{03889:00003:00012288:00000:00000000}{00158:00001:00004096:00000:00000000} (160314_18:16:00.245)[ 249.687647]<1>.(1)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115796)(FD:20)(ND:130488)(WB:0)(NW:138020) (160314_18:16:00.323)[ 249.755404]<0>.(0)[3064:mdl_recycle][BLOCK_TAG] FUSEIO {3064:R(4096,1,58361),W(0,0,0)}{3064:getattr(0,5,873)}{3064:open(0,1,224)}{4093:lookup(0,3,264691)}{3064:flush(0,1,62)}{4093:opendir(0,1,258)}{3064:release(0,1,11)}{4093:readdir(0,4,826)}{3064:opendir(0,2,344)}{4093:getattr(0,2,238)}{3064:readdir(0,7,9639)}{3064:releasedir(0,1,9)}{3064:lookup(0,1,233)} (160314_18:16:00.323)[ 249.762725]<3>.(3)[3885:ipod][ipodmain]vbusMonitorThread CurrVbusStatus = 1, vbusStatus = 0, vbus_status= 0 (160314_18:16:00.323)[ 249.762725]<3>. (160314_18:16:00.416)[ 249.848134]<2>.(2)[3889:ipod][SOFTIRQ DURATION WARN] SoftIRQ:9, dur:15699692 ns > 10 ms,(s:249832412167,e:249848111859) (160314_18:16:00.416)[ 249.849496]<2>.(2)[3889:ipod] IRQ occurrs in this duration, IRQ[30:arch_timer], dur:48308 ns (s:249842347167, e:249842395475) (160314_18:16:00.416)[ 249.849496]<2> (160314_18:16:00.416)[ 249.853470]<1>.(1)[1:init]init: starting 'fuelgauged' (160314_18:16:00.416)[ 249.887248]<2>.(2)[3889:ipod][SOFTIRQ DURATION WARN] SoftIRQ:9, dur:24820231 ns > 10 ms,(s:249862408090,e:249887228321) (160314_18:16:00.416)[ 249.888605]<2>.(2)[3889:ipod] IRQ occurrs in this duration, IRQ[30:arch_timer], dur:44153 ns (s:249882345629, e:249882389782) (160314_18:16:00.416)[ 249.888605]<2> (160314_18:16:00.416)[ 249.895584]<2>.(2)[3889:ipod][libipod][IPOH] expected compressed ratio 68. (160314_18:16:00.416)[ 249.896515]<2>.(2)[3889:ipod][libipod][IPOH] overall expected compressed ratio 70 (160314_18:16:00.416)[ 249.897602]<2>.(2)[3889:ipod]WXY toi_start_anything:204[ 249.898295]<2>.(2)[3889:ipod]WXY toi_start_anything:217[ 249.898975]<2>.(2)[3889:ipod]WXY toi_start_anything:225[ 249.899661]<2>.(2)[3889:ipod]WXY toi_start_anything:234[ 249.900342]<2>.(2)[3889:ipod]WXY toi_start_anything:244[ 249.901027]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = allocation debugging (160314_18:16:00.416)[ 249.902145]<2>.(2)[3889:ipod]WXY toi_start_anything:252[ 249.902911]<2>.(2)[3889:ipod]WXY toi_start_anything:261[ 249.903601]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = usm (160314_18:16:00.480)[ 249.904537]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = printk ui (160314_18:16:00.495)[ 249.905535]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = poweroff (160314_18:16:00.495)[ 249.906531]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = userui (160314_18:16:00.495)[ 249.907206]<2>.(3)[4095:fuelgauged]x_FG: get control socket error, reason:Protocol not supported (160314_18:16:00.495)[ 249.908631]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = compression (160314_18:16:00.495)[ 249.909656]<2>.(3)[1:init]init: process 'fuelgauged', pid 4095 exited (160314_18:16:00.495)[ 249.909684]<2>.(3)[1:init]init: process 'fuelgauged' killing any children in process group (160314_18:16:00.495)[ 249.911502]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = block i/o (160314_18:16:00.495)[ 249.933773]<2>.(2)[3889:ipod][SOFTIRQ DURATION WARN] SoftIRQ:9, dur:21210846 ns > 10 ms,(s:249912542859,e:249933753705) (160314_18:16:00.495)[ 249.935133]<2>.(2)[3889:ipod] IRQ occurrs in this duration, IRQ[30:arch_timer], dur:39308 ns (s:249932345167, e:249932384475) (160314_18:16:00.495)[ 249.935133]<2> (160314_18:16:00.495)[ 249.936853]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = swap storage (160314_18:16:00.495)[ 249.937892]<2>.(2)[3889:ipod][HIB/TOI] [toi_finish_anything()]hibernate_or_resume(0) (160314_18:16:00.495)[ 249.938861]<2>.(2)[3889:ipod]CPU: 2 PID: 3889 Comm: ipod Tainted: G W 3.10.65 #5 (160314_18:16:00.495)[ 249.939888]<2>.(2)[3889:ipod]Call trace: (160314_18:16:00.495)[ 249.940390]<2>.(2)[3889:ipod][] dump_backtrace+0x0/0x130 (160314_18:16:00.495)[ 249.941252]<2>.(2)[3889:ipod][] show_stack+0x10/0x1c (160314_18:16:00.495)[ 249.942069]<2>.(2)[3889:ipod][] dump_stack+0x1c/0x28 (160314_18:16:00.495)[ 249.942979]<2>.(2)[3889:ipod][] toi_cleanup_modules+0x1c/0xf4 (160314_18:16:00.495)[ 249.943902]<2>.(2)[3889:ipod][] toi_finish_anything+0x5c/0x1ec (160314_18:16:00.495)[ 249.944829]<2>.(2)[3889:ipod][] toi_attr_store+0x78/0x2c8 (160314_18:16:00.495)[ 249.945701]<2>.(2)[3889:ipod][] sysfs_write_file+0xdc/0x15c (160314_18:16:00.495)[ 249.946596]<2>.(2)[3889:ipod][] vfs_write+0xa4/0x18c (160314_18:16:00.495)[ 249.947413]<2>.(2)[3889:ipod][] SyS_write+0x40/0x8c (160314_18:16:00.495)[ 249.948217]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:426] this_module->name = allocation debugging (160314_18:16:00.495)[ 249.949704]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:426] this_module->name = poweroff (160314_18:16:00.495)[ 249.951062]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:426] this_module->name = compression (160314_18:16:00.495)[ 249.952531]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:426] this_module->name = block i/o (160314_18:16:00.495)[ 249.953908]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:426] this_module->name = swap storage (160314_18:16:00.495)[ 249.955308]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:429] this_module->name = swap storage (160314_18:16:00.495)[ 249.956707]<2>.(2)[3889:ipod][HIB/TOI] [toi_finish_anything()]WXY toi_finish_anything:163[ 249.957760]<2>.(2)[3889:ipod][HIB/TOI] [toi_finish_anything()]WXY toi_finish_anything:165[ 249.958811]<2>.(2)[3889:ipod][HIB/TOI] [toi_finish_anything()]WXY toi_finish_anything:180[ 249.959865]<2>.(2)[3889:ipod][HIB/TOI] [toi_finish_anything()]WXY toi_finish_anything:185[ 249.961097]<2>.(2)[3889:ipod]WXY toi_start_anything:204[ 249.961784]<2>.(2)[3889:ipod]WXY toi_start_anything:217[ 249.962531]<2>.(2)[3889:ipod]WXY toi_start_anything:225[ 249.963217]<2>.(2)[3889:ipod]WXY toi_start_anything:234[ 249.963897]<2>.(2)[3889:ipod]WXY toi_start_anything:244[ 249.964584]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = allocation debugging (160314_18:16:00.495)[ 249.964653]<2>.(0)[3885:ipod][ipodmain]vbusMonitorThread CurrVbusStatus = 1, vbusStatus = 0, vbus_status= 0 (160314_18:16:00.495)[ 249.964653]<2>. (160314_18:16:00.495)[ 249.967133]<2>.(2)[3889:ipod]WXY toi_start_anything:252[ 249.967813]<2>.(2)[3889:ipod]WXY toi_start_anything:261[ 249.968498]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = usm (160314_18:16:00.495)[ 249.969431]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = printk ui (160314_18:16:00.495)[ 249.970428]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = poweroff (160314_18:16:00.495)[ 249.971416]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = userui (160314_18:16:00.495)[ 249.972443]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = compression (160314_18:16:00.495)[ 249.973472]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = block i/o (160314_18:16:00.495)[ 249.974470]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = swap storage (160314_18:16:00.495)[ 249.975504]<2>.(2)[3889:ipod][HIB/TOI] [toi_finish_anything()]hibernate_or_resume(0) (160314_18:16:00.495)[ 249.976475]<2>.(2)[3889:ipod]CPU: 2 PID: 3889 Comm: ipod Tainted: G W 3.10.65 #5 (160314_18:16:00.495)[ 249.977502]<2>.(2)[3889:ipod]Call trace: (160314_18:16:00.495)[ 249.978003]<2>.(2)[3889:ipod][] dump_backtrace+0x0/0x130 (160314_18:16:00.495)[ 249.978864]<2>.(2)[3889:ipod][] show_stack+0x10/0x1c (160314_18:16:00.495)[ 249.979685]<2>.(2)[3889:ipod][] dump_stack+0x1c/0x28 (160314_18:16:00.495)[ 249.980502]<2>.(2)[3889:ipod][] toi_cleanup_modules+0x1c/0xf4 (160314_18:16:00.495)[ 249.981418]<2>.(2)[3889:ipod][] toi_finish_anything+0x5c/0x1ec (160314_18:16:00.495)[ 249.982342]<2>.(2)[3889:ipod][] toi_attr_store+0x78/0x2c8 (160314_18:16:00.573)[ 249.983273]<2>.(2)[3889:ipod][] sysfs_write_file+0xdc/0x15c (160314_18:16:00.573)[ 249.984172]<2>.(2)[3889:ipod][] vfs_write+0xa4/0x18c (160314_18:16:00.573)[ 249.984990]<2>.(2)[3889:ipod][] SyS_write+0x40/0x8c (160314_18:16:00.573)[ 249.985796]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:426] this_module->name = allocation debugging (160314_18:16:00.573)[ 249.987285]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:426] this_module->name = poweroff (160314_18:16:00.573)[ 249.988642]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:426] this_module->name = compression (160314_18:16:00.573)[ 249.990032]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:426] this_module->name = block i/o (160314_18:16:00.573)[ 249.991400]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:426] this_module->name = swap storage (160314_18:16:00.573)[ 249.992876]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:429] this_module->name = swap storage (160314_18:16:00.573)[ 249.994283]<2>.(2)[3889:ipod][HIB/TOI] [toi_finish_anything()]WXY toi_finish_anything:163[ 249.995336]<2>.(2)[3889:ipod][HIB/TOI] [toi_finish_anything()]WXY toi_finish_anything:165[ 249.996387]<2>.(2)[3889:ipod][HIB/TOI] [toi_finish_anything()]WXY toi_finish_anything:180[ 249.997440]<2>.(2)[3889:ipod][HIB/TOI] [toi_finish_anything()]WXY toi_finish_anything:185[ 249.998715]<2>.(2)[3889:ipod]WXY toi_start_anything:204[ 249.999401]<2>.(2)[3889:ipod]WXY toi_start_anything:217[ 250.000083]<2>.(2)[3889:ipod]WXY toi_start_anything:225[ 250.000768]<2>.(2)[3889:ipod]WXY toi_start_anything:234[ 250.001449]<2>.(2)[3889:ipod]WXY toi_start_anything:244[ 250.002136]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = allocation debugging (160314_18:16:00.573)[ 250.003399]<2>.(2)[3889:ipod]WXY toi_start_anything:252[ 250.004083]<2>.(2)[3889:ipod]WXY toi_start_anything:261[ 250.004767]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = usm (160314_18:16:00.573)[ 250.005700]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = printk ui (160314_18:16:00.573)[ 250.006697]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = poweroff (160314_18:16:00.573)[ 250.007685]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = userui (160314_18:16:00.573)[ 250.008650]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = compression (160314_18:16:00.573)[ 250.009670]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = block i/o (160314_18:16:00.573)[ 250.010668]<2>.(2)[3889:ipod][toi_initialise_modules:393] this_module->name = swap storage (160314_18:16:00.573)[ 250.011701]<2>.(2)[3889:ipod][HIB/TOI] [toi_finish_anything()]hibernate_or_resume(0) (160314_18:16:00.573)[ 250.012737]<2>.(2)[3889:ipod]CPU: 2 PID: 3889 Comm: ipod Tainted: G W 3.10.65 #5 (160314_18:16:00.573)[ 250.013771]<2>.(2)[3889:ipod]Call trace: (160314_18:16:00.573)[ 250.014270]<2>.(2)[3889:ipod][] dump_backtrace+0x0/0x130 (160314_18:16:00.573)[ 250.015133]<2>.(2)[3889:ipod][] show_stack+0x10/0x1c (160314_18:16:00.573)[ 250.015953]<2>.(2)[3889:ipod][] dump_stack+0x1c/0x28 (160314_18:16:00.573)[ 250.016772]<2>.(2)[3889:ipod][] toi_cleanup_modules+0x1c/0xf4 (160314_18:16:00.573)[ 250.017687]<2>.(2)[3889:ipod][] toi_finish_anything+0x5c/0x1ec (160314_18:16:00.573)[ 250.018612]<2>.(2)[3889:ipod][] toi_attr_store+0x78/0x2c8 (160314_18:16:00.573)[ 250.019483]<2>.(2)[3889:ipod][] sysfs_write_file+0xdc/0x15c (160314_18:16:00.573)[ 250.020379]<2>.(2)[3889:ipod][] vfs_write+0xa4/0x18c (160314_18:16:00.573)[ 250.021196]<2>.(2)[3889:ipod][] SyS_write+0x40/0x8c (160314_18:16:00.573)[ 250.022000]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:426] this_module->name = allocation debugging (160314_18:16:00.573)[ 250.023550]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:426] this_module->name = poweroff (160314_18:16:00.573)[ 250.024914]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:426] this_module->name = compression (160314_18:16:00.573)[ 250.026305]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:426] this_module->name = block i/o (160314_18:16:00.573)[ 250.027673]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:426] this_module->name = swap storage (160314_18:16:00.573)[ 250.029073]<2>.(2)[3889:ipod][HIB/TOI] [toi_cleanup_modules()]WXY [toi_cleanup_modules:429] this_module->name = swap storage (160314_18:16:00.573)[ 250.030472]<2>.(2)[3889:ipod][HIB/TOI] [toi_finish_anything()]WXY toi_finish_anything:163[ 250.031524]<2>.(2)[3889:ipod][HIB/TOI] [toi_finish_anything()]WXY toi_finish_anything:165[ 250.032639]<2>.(2)[3889:ipod][HIB/TOI] [toi_finish_anything()]WXY toi_finish_anything:180[ 250.033697]<2>.(2)[3889:ipod][HIB/TOI] [toi_finish_anything()]WXY toi_finish_anything:185[ 250.034882]<2>.(2)[3889:ipod][HIB/PM][state_store]entry (4) (160314_18:16:00.573)[ 250.035578]<2>.(2)[3889:ipod][HIB/PM][state_store]trigger hibernation... (160314_18:16:00.573)[ 250.036412]<2>.(2)[3889:ipod][HIB/CORE] disable ftrace mode (160314_18:16:00.573)[ 250.051657]<0>.(0)[3889:ipod][HIB/CORE] disable hotplug (160314_18:16:00.573)[ 250.052315]<0>.(0)[3889:ipod][HIB/CORE] unplug cores (160314_18:16:00.573)[ 250.055331]<2>.(2)[3889:ipod]CPU3: shutdown (160314_18:16:00.573)[ 250.055947]<2>.(2)[3889:ipod][WDK]cpu 3 plug off, kick wdt (160314_18:16:00.573)[ 250.059357]<0>.(0)[3889:ipod]CPU2: shutdown (160314_18:16:00.573)[ 250.059965]<0>.(0)[3889:ipod][WDK]cpu 2 plug off, kick wdt (160314_18:16:00.651)[ 250.063308]<0>.(0)[3889:ipod]CPU1: shutdown (160314_18:16:00.651)[ 250.063918]<0>.(0)[3889:ipod][WDK]cpu 1 plug off, kick wdt (160314_18:16:00.651)[ 250.065442]<0>.(0)[3889:ipod]wxy [hibernate:651]PM: entering hibernate() (160314_18:16:00.651)[ 250.066285]<0>.(0)[3889:ipod]wxy [hibernate:655]PM: entering try_tuxonice_hibernate() (160314_18:16:00.651)[ 250.067272]<0>.(0)[3889:ipod]WXY toi_try_hibernate:1249[ 250.067955]<0>.(0)[3889:ipod]WXY toi_start_anything:204[ 250.068639]<0>.(0)[3889:ipod]WXY toi_start_anything:217[ 250.069321]<0>.(0)[3889:ipod]WXY toi_start_anything:225[ 250.070006]<0>.(0)[3889:ipod]WXY toi_start_anything:234[ 250.070687]<0>.(0)[3889:ipod]WXY toi_start_anything:240[ 250.071373]<0>.(0)[3889:ipod]WXY toi_start_anything:244[ 250.072056]<0>.(0)[3889:ipod][toi_initialise_modules:393] this_module->name = allocation debugging (160314_18:16:00.651)[ 250.074084]<0>.(0)[3889:ipod]WXY toi_start_anything:252[ 250.074765]<0>.(0)[3889:ipod]WXY toi_start_anything:261[ 250.075449]<0>.(0)[3889:ipod][toi_initialise_modules:393] this_module->name = usm (160314_18:16:00.651)[ 250.076382]<0>.(0)[3889:ipod][toi_initialise_modules:393] this_module->name = printk ui (160314_18:16:00.651)[ 250.077380]<0>.(0)[3889:ipod][toi_initialise_modules:393] this_module->name = poweroff (160314_18:16:00.651)[ 250.078367]<0>.(0)[3889:ipod][toi_initialise_modules:393] this_module->name = userui (160314_18:16:00.651)[ 250.079332]<0>.(0)[3889:ipod][toi_initialise_modules:393] this_module->name = compression (160314_18:16:00.651)[ 250.080352]<0>.(0)[3889:ipod][toi_initialise_modules:393] this_module->name = block i/o (160314_18:16:00.651)[ 250.081350]<0>.(0)[3889:ipod]WXY open_resume_dev_t:1243[ 250.082032]<0>.(0)[3889:ipod]WXY open_resume_dev_t:1249[ 250.083344]<0>.(0)[3889:ipod][toi_initialise_modules:393] this_module->name = swap storage (160314_18:16:00.651)[ 250.084379]<0>.(0)[3889:ipod]CPU: 0 PID: 3889 Comm: ipod Tainted: G W 3.10.65 #5 (160314_18:16:00.651)[ 250.085405]<0>.(0)[3889:ipod]Call trace: (160314_18:16:00.651)[ 250.085903]<0>.(0)[3889:ipod][] dump_backtrace+0x0/0x130 (160314_18:16:00.651)[ 250.086762]<0>.(0)[3889:ipod][] show_stack+0x10/0x1c (160314_18:16:00.651)[ 250.087579]<0>.(0)[3889:ipod][] dump_stack+0x1c/0x28 (160314_18:16:00.651)[ 250.088438]<0>.(0)[3889:ipod][] toi_swap_initialise+0x2c/0xf8 (160314_18:16:00.651)[ 250.089353]<0>.(0)[3889:ipod][] toi_initialise_modules+0xb0/0xd8 (160314_18:16:00.651)[ 250.090299]<0>.(0)[3889:ipod][] toi_start_anything+0x328/0x398 (160314_18:16:00.651)[ 250.091223]<0>.(0)[3889:ipod][] toi_try_hibernate+0x64/0x2d4 (160314_18:16:00.651)[ 250.092125]<0>.(0)[3889:ipod][] try_tuxonice_hibernate+0x18/0x2c (160314_18:16:00.651)[ 250.093468]<0>.(0)[3889:ipod][] hibernate+0x12c/0x270 (160314_18:16:00.651)[ 250.094299]<0>.(0)[3889:ipod][] x_hibernate+0x10/0x14c (160314_18:16:00.651)[ 250.095158]<0>.(0)[3889:ipod][] state_store+0x148/0x1c8 (160314_18:16:00.651)[ 250.096006]<0>.(0)[3889:ipod][] kobj_attr_store+0x10/0x24 (160314_18:16:00.651)[ 250.096876]<0>.(0)[3889:ipod][] sysfs_write_file+0xdc/0x15c (160314_18:16:00.651)[ 250.097769]<0>.(0)[3889:ipod][] vfs_write+0xa4/0x18c (160314_18:16:00.651)[ 250.098584]<0>.(0)[3889:ipod][] SyS_write+0x40/0x8c (160314_18:16:00.651)[ 250.099383]<0>.(0)[3889:ipod]11 enable_swapfile toi_swapon_status = 0,swapfilename = /cache/.ipoh.img (160314_18:16:00.651)[ 250.100535]<0>.(0)[3889:ipod][HIB/TOI] [enable_swapfile()]22 enable_swapfile swapfilename = /cache/.ipoh.img (160314_18:16:00.729)[ 250.161008]<0>.(0)[3889:ipod]33 enable_swapfile toi_swapon_status = 0,swapfilename = /cache/.ipoh.img (160314_18:16:00.729)[ 250.162156]<0>.(0)[3889:ipod]44 enable_swapfile toi_swapon_status = 1,swapfilename = /cache/.ipoh.img (160314_18:16:00.729)[ 250.163551]<0>.(0)[3889:ipod]WXY toi_try_hibernate:1257[ 250.164231]<0>.(0)[3889:ipod]WXY toi_try_hibernate:1261[ 250.165265]<0>.(0)[3885:ipod][ipodmain]vbusMonitorThread CurrVbusStatus = 1, vbusStatus = 0, vbus_status= 0 (160314_18:16:00.729)[ 250.165265]<0>. (160314_18:16:00.729)[ 250.166722]<0>.(0)[3889:ipod]WXY toi_try_hibernate:1271[ 250.167402]<0>.(0)[3889:ipod]step 1 @line:917 (160314_18:16:00.729)[ 250.167945]<0>.(0)[3889:ipod]WXY [can_hibernate:686] . (160314_18:16:00.729)[ 250.168584]<0>.(0)[3889:ipod]WXY [can_hibernate:693] passed. (160314_18:16:00.729)[ 250.169289]<0>.(0)[3889:ipod]WXY [can_hibernate:708] passed. (160314_18:16:00.729)[ 250.169994]<0>.(0)[3889:ipod]WXY [can_hibernate:724] passed. (160314_18:16:00.729)[ 250.170700]<0>.(0)[3889:ipod]WXY [do_prepare_image:923] can_hibernate() =1 (160314_18:16:00.729)[ 250.171557]<0>.(0)[3889:ipod]WXY [do_prepare_image:924] test_result_state(TOI_KEPT_IMAGE)=0 (160314_18:16:00.729)[ 250.172646]<0>.(0)[3889:ipod]WXY [do_prepare_image:925] test_action_state(TOI_KEEP_IMAGE) = 0 (160314_18:16:00.729)[ 250.173706]<0>.(0)[3889:ipod]WXY [can_hibernate:686] . (160314_18:16:00.729)[ 250.174345]<0>.(0)[3889:ipod]WXY [can_hibernate:693] passed. (160314_18:16:00.729)[ 250.175050]<0>.(0)[3889:ipod]WXY [can_hibernate:708] passed. (160314_18:16:00.729)[ 250.175755]<0>.(0)[3889:ipod]WXY [can_hibernate:724] passed. (160314_18:16:00.729)[ 250.176461]<0>.(0)[3889:ipod]WXY do_prepare_image:933[ 250.177121]<0>.(0)[3889:ipod]step 2 @line:935 (160314_18:16:00.729)[ 250.177887]<0>.(0)[3889:ipod]wxy userui_prepare_console:574[ 250.178610]<0>.(0)[3889:ipod]wxy userui_prepare_console:581[ 250.179456]<0>.(0)[3889:ipod]wxy [toi_launch_userspace_program:1350] command = /system/bin/tuxoniceui (160314_18:16:00.729)[ 250.180609]<0>.(0)[3889:ipod]CPU: 0 PID: 3889 Comm: ipod Tainted: G W 3.10.65 #5 (160314_18:16:00.729)[ 250.181634]<0>.(0)[3889:ipod]Call trace: (160314_18:16:00.729)[ 250.182133]<0>.(0)[3889:ipod][] dump_backtrace+0x0/0x130 (160314_18:16:00.729)[ 250.183716]<0>.(0)[3889:ipod][] show_stack+0x10/0x1c (160314_18:16:00.729)[ 250.184535]<0>.(0)[3889:ipod][] dump_stack+0x1c/0x28 (160314_18:16:00.729)[ 250.185353]<0>.(0)[3889:ipod][] toi_launch_userspace_program+0x50/0x284 (160314_18:16:00.729)[ 250.186374]<0>.(0)[3889:ipod][] toi_netlink_setup+0xd0/0x160 (160314_18:16:00.729)[ 250.187277]<0>.(0)[3889:ipod][] userui_prepare_console+0x6c/0xac (160314_18:16:00.729)[ 250.188223]<0>.(0)[3889:ipod][] do_prepare_image+0x27c/0x3a0 (160314_18:16:00.729)[ 250.189125]<0>.(0)[3889:ipod][] toi_try_hibernate+0x188/0x2d4 (160314_18:16:00.729)[ 250.190038]<0>.(0)[3889:ipod][] try_tuxonice_hibernate+0x18/0x2c (160314_18:16:00.729)[ 250.190984]<0>.(0)[3889:ipod][] hibernate+0x12c/0x270 (160314_18:16:00.729)[ 250.191813]<0>.(0)[3889:ipod][] x_hibernate+0x10/0x14c (160314_18:16:00.729)[ 250.193014]<0>.(0)[3889:ipod][] state_store+0x148/0x1c8 (160314_18:16:00.729)[ 250.193865]<0>.(0)[3889:ipod][] kobj_attr_store+0x10/0x24 (160314_18:16:00.729)[ 250.194735]<0>.(0)[3889:ipod][] sysfs_write_file+0xdc/0x15c (160314_18:16:00.729)[ 250.195628]<0>.(0)[3889:ipod][] vfs_write+0xa4/0x18c (160314_18:16:00.729)[ 250.196443]<0>.(0)[3889:ipod][] SyS_write+0x40/0x8c (160314_18:16:00.729)[ 250.197253]<0>.(0)[3889:ipod]wxy [toi_launch_userspace_program:1366] command = /system/bin/tuxoniceui (160314_18:16:00.729)[ 250.198409]<0>.(0)[3889:ipod]wxy [toi_launch_userspace_program:1392] command = /system/bin/tuxoniceui (160314_18:16:00.729)[ 250.202246]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=15%, duty 79778466, period 525395600, req_cnt=58 (160314_18:16:00.729)[ 250.203635]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=2695162 sectors offset, req_cnt=5, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:00.729)[ 250.205199]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Read Diversity=617023 sectors offset, req_cnt=53, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:00.729)[ 250.206750]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=384 kB/s, size: 24576 bytes, time:64 ms (160314_18:16:00.729)[ 250.207985]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Read Throughput=48605 kB/s, size: 729088 bytes, time:15 ms (160314_18:16:00.729)[ 250.209246]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:1 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:00.729)[ 250.210410]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {03081:00001:00004096:00000:00000000}{00418:00000:00000000:00002:00008192}{00419:00000:00000000:00004:00016384}{00482:00000:00000000:00005:00020480}{04095:00000:00000000:00167:00684032}{00791:00000:00000000:00001:00004096}{00846:00000:00000000:00001:00004096}{00368:00000:00000000:00001:00004096}{02050:00000:00000000:00001:00004096}{03981:00000:00000000:00013:00053248}{03889:00000:00000000:00008:00032768}{02727:00000:00000000:00001:00004096}{02555:00000:00000000:00001:00004096}{00338:00000:00000000:00001:00004096} (160314_18:16:00.809)[ 250.217672]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:116184)(FD:192)(ND:130800)(WB:0)(NW:138088) (160314_18:16:00.809)[ 250.221195]<0>.(0)[254:logd.auditd]ADDLOG datagram_poll sk_queue_empty mask:0.(0)[3889:ipod]wxy [toi_launch_userspace_program:1411] command = /system/bin/tuxoniceui (160314_18:16:00.887)[ 250.339280]<0>.(0)[4093:MediaScannerSer][BLOCK_TAG] FUSEIO {3064:unlink(107962368,2,654)}{4093:readdir(0,67,10757)}{4093:getattr(0,60,8381)}{4093:lookup(0,62,39713)}{4093:releasedir(0,2,25)}{4093:opendir(0,2,290)}{3064:readdir(0,8,1117)}{3064:releasedir(0,2,23)}{3064:rmdir(4096,1,1035)}{3064:getattr(0,3,420)}{3064:opendir(0,2,263)}{3064:lookup(0,1,179)} (160314_18:16:00.887)[ 250.367189]<0>.(0)[3885:ipod][ipodmain]vbusMonitorThread CurrVbusStatus = 1, vbusStatus = 0, vbus_status= 0 (160314_18:16:00.887)[ 250.367189]<0>. (160314_18:16:01.153)[ 250.569113]<0>.(0)[3885:ipod][ipodmain]vbusMonitorThread CurrVbusStatus = 1, vbusStatus = 0, vbus_status= 0 (160314_18:16:01.168)[ 250.569113]<0>. (160314_18:16:01.168)[ 250.621517]<0>.(0)[3887:ipod][libipod]Could not open '/sys/class/power_supply/wireless/online' (160314_18:16:01.168)[ 250.623500]<0>.(0)[3887:ipod][ipodmain]status_cb: EVENT_CHECK_CHARGING(12), 0, 0 (160314_18:16:01.168)[ 250.624491]<0>.(0)[3887:ipod][libipod]in is_charging_source_available(), usb:0 ac:0 wireless:0 status_cb(EVENT_CHECK_CHARGING):0 (160314_18:16:01.168)[ 250.624491]<0> (160314_18:16:01.168)[ 250.626162]<0>.(0)[3887:ipod][libipod]pm monitor safe (160314_18:16:01.246)[ 250.682628]<0>.(0)[71:fuse_log][BLOCK_TAG] FUSEIO {4093:unknown(0,3,267)}{4093:readdir(0,60,8141)}{4093:getattr(0,52,5047)}{4093:lookup(0,55,12129)}{4093:opendir(0,3,304)}{3063:getattr(0,1,200)}{3063:statfs(0,1,80)}{3063:lookup(0,1,2337)} (160314_18:16:01.295)[ 250.763853]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload < 1%, duty 5575308, period 561608846, req_cnt=13 (160314_18:16:01.326)[ 250.765152]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Read Diversity=922245 sectors offset, req_cnt=13, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:01.326)[ 250.766702]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Read Throughput=85196 kB/s, size: 425984 bytes, time:5 ms (160314_18:16:01.326)[ 250.767950]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:01.326)[ 250.769103]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {04096:00000:00000000:00074:00303104}{03889:00000:00000000:00001:00004096}{01709:00000:00000000:00002:00008192}{03981:00000:00000000:00001:00004096}{02544:00000:00000000:00001:00004096}{02754:00000:00000000:00001:00004096}{02450:00000:00000000:00001:00004096}{00419:00000:00000000:00003:00012288}{00418:00000:00000000:00026:00106496}{00225:00000:00000000:00001:00004096} (160314_18:16:01.326)[ 250.774212]<0>.(0)[3885:ipod][ipodmain]vbusMonitorThread CurrVbusStatus = 1, vbusStatus = 0, vbus_status= 0 (160314_18:16:01.326)[ 250.774212]<0>. (160314_18:16:01.326)[ 250.777532]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:116652)(FD:192)(ND:130800)(WB:0)(NW:138088) (160314_18:16:01.529)[ 250.976129]<0>.(0)[3885:ipod][ipodmain]vbusMonitorThread CurrVbusStatus = 1, vbusStatus = 0, vbus_status= 0 (160314_18:16:01.529)[ 250.976129]<0>. (160314_18:16:01.732)[ 251.178108]<0>.(0)[3885:ipod][ipodmain]vbusMonitorThread CurrVbusStatus = 1, vbusStatus = 0, vbus_status= 0 (160314_18:16:01.732)[ 251.178108]<0>. (160314_18:16:01.810)[ 251.283636]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload < 1%, duty 4966461, period 519783308, req_cnt=19 (160314_18:16:01.810)[ 251.284912]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Read Diversity=235857 sectors offset, req_cnt=18, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:01.810)[ 251.286462]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=61440 kB/s, size: 61440 bytes, time:1 ms (160314_18:16:01.810)[ 251.287708]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Read Throughput=24576 kB/s, size: 73728 bytes, time:3 ms (160314_18:16:01.810)[ 251.288947]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:01.810)[ 251.290086]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00418:00000:00000000:00001:00004096}{00419:00000:00000000:00002:00008192}{04093:00000:00000000:00015:00061440}{00339:00000:00000000:00001:00004096}{00968:00000:00000000:00001:00004096} (160314_18:16:01.888)[ 251.302797]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:116692)(FD:220)(ND:130880)(WB:0)(NW:138140) (160314_18:16:01.966)[ 251.380069]<0>.(0)[3885:ipod][ipodmain]vbusMonitorThread CurrVbusStatus = 1, vbusStatus = 0, vbus_status= 0 (160314_18:16:01.966)[ 251.380069]<0>. (160314_18:16:02.106)[ 251.575251]<0>-(0)[4093:MediaScannerSer][PMIC] bat_percent_notify_task is called (160314_18:16:02.106)[ 251.576212]<0>.(0)[54:bat_percent_not][PMIC] [upmu_get_rgs_chrdet] CHRDET status = 0 (160314_18:16:02.106)[ 251.577173]<0>.(0)[54:bat_percent_not][PMIC] bat_per_level=0,bat_per_val=100 (160314_18:16:02.106)[ 251.582042]<0>.(0)[3885:ipod][ipodmain]vbusMonitorThread CurrVbusStatus = 1, vbusStatus = 0, vbus_status= 0 (160314_18:16:02.106)[ 251.582042]<0>. (160314_18:16:02.247)[ 251.682671]<0>.(0)[71:fuse_log][BLOCK_TAG] FUSEIO {4093:readdir(0,59,7349)}{4093:getattr(0,62,8710)}{4093:lookup(0,56,25455)}{4093:unknown(0,2,177)}{3064:readdir(0,16,25700)}{3064:releasedir(0,4,48)}{3064:rmdir(8192,2,830)}{3064:getattr(0,6,998)}{3064:opendir(0,4,377)}{4093:opendir(0,2,199)}{3064:lookup(0,2,350)}{3064:unlink(126660608,2,947)} (160314_18:16:02.325)[ 251.784924]<0>.(0)[3885:ipod][ipodmain]vbusMonitorThread CurrVbusStatus = 1, vbusStatus = 0, vbus_status= 0 (160314_18:16:02.325)[ 251.784924]<0>. (160314_18:16:02.325)[ 251.808424]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload < 1%, duty 298154, period 524782769, req_cnt=1 (160314_18:16:02.325)[ 251.809660]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:02.325)[ 251.810788]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00418:00000:00000000:00001:00004096} (160314_18:16:02.325)[ 251.811862]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:116744)(FD:272)(ND:130932)(WB:0)(NW:138140) (160314_18:16:02.527)[ 251.986875]<0>.(0)[3885:ipod][ipodmain]vbusMonitorThread CurrVbusStatus = 1, vbusStatus = 0, vbus_status= 0 (160314_18:16:02.527)[ 251.986875]<0>. (160314_18:16:02.730)[ 252.188843]<0>.(0)[3885:ipod][ipodmain]vbusMonitorThread CurrVbusStatus = 1, vbusStatus = 0, vbus_status= 0 (160314_18:16:02.730)[ 252.188843]<0>. (160314_18:16:02.808)[ 252.222641]<0>.(0)[3889:ipod]userspace ui: Failed to contact userspace process. (160314_18:16:02.808)[ 252.223675]<0>.(0)[3889:ipod][KL_ENV]set env, name=hibboot,value=1 (160314_18:16:02.808)[ 252.226521]<0>.(0)[3889:ipod][battery_pm_event] pm_event 1 (160314_18:16:02.808)[ 252.227204]<0>.(0)[3889:ipod][battery_timer_pause] battery exist battery_timer_pause (160314_18:16:02.808)[ 252.228173]<0>.(0)[3889:ipod]@bs=1@ (160314_18:16:02.808)[ 252.228604]Starting other threads (0).wxy userui_prepare_status:314[ 252.229416]<0>.(0)[3889:ipod]wxy userui_prepare_status:322[ 252.230131]<0>.(0)[3889:ipod]Freezing processes & syncing filesystems. (160314_18:16:02.808)[ 252.230944][HIB/TOI] [attempt_to_freeze()]WXY Syncing filesystems ... (160314_18:16:02.808)[ 252.252025]<0>.(0)[3889:ipod][HIB/TOI] [attempt_to_freeze()]WXY done. (160314_18:16:02.808)[ 252.252962]<0>.(0)[3889:ipod]wxy attempt_to_freeze:1012[ 252.253641]Freezing user space processes ... [ 252.255132]<0>.(0)[438:ccci_mdinit][ccci1/ipc]CCCI_IPC_WAIT_TIME_UPDATE wakeup (160314_18:16:02.808)(elapsed 0.004 seconds) done. (160314_18:16:02.808)[ 252.258613]Freezing remaining freezable tasks ... (elapsed 0.002 seconds) wxy freeze_kernel_threads:207[ 252.261956]done.wxy freeze_kernel_threads:211[ 252.263042]<0>.(0)3889:ipod[ 252.263406]<0>.(0)[3889:ipod]wxy freeze_kernel_threads:222[ 252.264122]<0>.(0)[3889:ipod]wxy attempt_to_freeze:1024[ 252.264805]<0>.(0)[3889:ipod]wxy attempt_to_freeze:1029[ 252.266505]<0>.(0)[3889:ipod]wxy attempt_to_freeze:1040[ 252.267186]<0>.(0)[3889:ipod][HIB/TOI] [toi_prepare_image()]@line:1158 return value (1) (160314_18:16:03.011)[ 252.446877]<0>.(0)[3889:ipod]Free:67993(67993). Sets:63990(63990),111967(111967). Nosave:2-0=2. Storage:0/61166(53387=>52787). Needed:0,0,0(100,1301,2000,-2) (PS2:no) (160314_18:16:03.011)[ 252.448740]<0>.(0)[3889:ipod]wxy userui_prepare_status:314[ 252.449451]<0>.(0)[3889:ipod]wxy userui_prepare_status:322[ 252.450166]<0>.(0)[3889:ipod]Preparing Image. Try 1. (160314_18:16:03.276)[ 252.696551]<0>.(0)[3889:ipod]Free:68397(68397). Sets:63988(63988),111562(111562). Nosave:2-0=2. Storage:0/61166(53265=>52665). Needed:0,0,0(100,1301,2000,-2) (PS2:no) (160314_18:16:03.276)[ 252.698413]<0>.(0)[3889:ipod][HIB/TOI] [try_allocate_extra_memory()]PASS: Want 65988 extra pages for pageset1, got 111562, free:68397 (160314_18:16:03.276)[ 252.699903]Restarting kernel threads ... done. (160314_18:16:03.276)[ 252.701486]<0>.(0)[133:mmcqd/0][BLOCK_TAG] MMC Queue Thread:133, 135, 134, 0, 0 (160314_18:16:03.276)[ 252.702775]<0>.(0)[133:mmcqd/0][BLOCK_TAG] MMC CID: 0 0 0 0 (160314_18:16:03.276)[ 252.703481]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=5%, duty 51775770, period 893071200, req_cnt=17 (160314_18:16:03.276)[ 252.704728]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=2586800 sectors offset, req_cnt=16, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:03.276)[ 252.706300]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=6906 kB/s, size: 352256 bytes, time:51 ms (160314_18:16:03.276)[ 252.707559]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:03.276)[ 252.708689]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00418:00000:00000000:00001:00004096}{00419:00001:00004096:00000:00000000} (160314_18:16:03.276)[ 252.710163]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115184)(FD:16)(ND:130944)(WB:0)(NW:138460) (160314_18:16:03.276)[ 252.741004]Freezing remaining freezable tasks ... (elapsed 0.002 seconds) wxy freeze_kernel_threads:207[ 252.744388]done.wxy freeze_kernel_threads:211[ 252.744954]<0>.(0)3889:ipod[ 252.745324]<0>.(0)[3889:ipod]wxy freeze_kernel_threads:222[ 252.803186]<0>.(0)[71:fuse_log][BLOCK_TAG] FUSEIO {3064:readdir(0,8,6770)}{3064:releasedir(0,2,23)}{3064:rmdir(4096,1,249)}{3064:getattr(0,3,290)}{3064:opendir(0,2,550)}{3064:lookup(0,1,182)}{3064:unlink(53428224,1,442)} (160314_18:16:03.497)[ 252.957741]<0>.(0)[3889:ipod]Free:68383(68383). Sets:64002(64002),111562(111562). Nosave:2-0=2. Storage:61156/61156(53269=>52669). Needed:0,0,0(100,1301,2000,-2) (PS2:no) (160314_18:16:03.497)[ 252.959753]<0>.(0)[3889:ipod][HIB/TOI] [toi_prepare_image()]@line1195 return value (1) (160314_18:16:03.497)[ 252.960744]<0>.(0)[3889:ipod][HIB/TOI] [toi_prepare_image()]@line:1198 return value (0) (160314_18:16:03.497)[ 252.961737]<0>.(0)[3889:ipod]wxy toi_prepare_image:1202[ 252.962666]<0>.(0)[3889:ipod]wxy toi_prepare_image:1213[ 252.963450]<0>.(0)[3889:ipod][HIB/TOI] [toi_prepare_image()]Image preparation complete. (160314_18:16:03.497)[ 252.964445]<0>.(0)[3889:ipod][HIB/TOI] [toi_prepare_image()]@line:1227 return value (0) (160314_18:16:03.497)[ 252.965461]<0>.(0)[3889:ipod]wxy toi_prepare_image:1228[ 252.966139]<0>.(0)[3889:ipod]step 3 @line:940 (160314_18:16:03.497)[ 252.966682]<0>.(0)[3889:ipod]after calling do_toi_step(STEP_HIBERNATE_PREPARE_IMAGE), result(0) (160314_18:16:03.497)[ 252.967767]<0>.(0)[3889:ipod]WXY toi_try_hibernate:1282[ 252.968449]<0>.(0)[3889:ipod]WXY toi_try_hibernate:1286[ 252.969135]<0>.(0)[3889:ipod]wxy userui_prepare_status:314[ 252.969849]<0>.(0)[3889:ipod]wxy userui_prepare_status:322[ 252.970564]<0>.(0)[3889:ipod]Starting to save the image.. (160314_18:16:03.497)[ 252.971237]<0>.(0)[3889:ipod]wxy userui_message:256[ 252.971878]<0>.(0)[3889:ipod]wxy userui_message:278[ 252.972834]<0>.(0)[3889:ipod]wxy __save_image:771[ 252.973496]<0>.(0)[3889:ipod]wxy [__save_image:775] write_pageset(&pagedir2) (160314_18:16:03.497)[ 252.974371]<0>.(0)[3889:ipod][HIB/TOI] [write_pageset()]start to writing caches... (160314_18:16:03.497)[ 252.975313]<0>.(0)[3889:ipod]wxy userui_prepare_status:314[ 252.976029]<0>.(0)[3889:ipod]wxy userui_prepare_status:322[ 252.976744]<0>.(0)[3889:ipod]Writing caches... (160314_18:16:03.825)[ 253.241467]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=26%, duty 145578848, period 539972800, req_cnt=45 (160314_18:16:03.825)[ 253.243074]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=449808 sectors offset, req_cnt=2, break_cnt=0, tract_cnt=3, bit_cnt=0 (160314_18:16:03.825)[ 253.244626]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Read Diversity=810897 sectors offset, req_cnt=43, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:03.825)[ 253.246175]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7598 kB/s, size: 1048576 bytes, time:138 ms (160314_18:16:03.825)[ 253.247481]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Read Throughput=31012 kB/s, size: 217088 bytes, time:7 ms (160314_18:16:03.825)[ 253.248728]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:03.825)[ 253.249872]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {03889:00000:00000000:00039:00159744}{00213:00000:00000000:00014:00057344}{04095:00000:00000000:00009:00036864}{00419:00011:00045056:00000:00000000}{00418:00008:00032768:00000:00000000}{00791:00002:00008192:00000:00000000}{02380:00001:00004096:00000:00000000} (160314_18:16:03.825)[ 253.253819]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:04.340)[ 253.801275]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=63%, duty 353637077, period 559807700, req_cnt=18 (160314_18:16:04.340)[ 253.802844]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=18, break_cnt=0, tract_cnt=14, bit_cnt=0 (160314_18:16:04.340)[ 253.804462]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=25515 kB/s, size: 9007104 bytes, time:353 ms (160314_18:16:04.340)[ 253.805827]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:04.340)[ 253.806993]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00028:00114688:00000:00000000}{00418:00024:00098304:00000:00000000}{00253:00002:00008192:00000:00000000}{00226:00001:00004096:00000:00000000}{03081:00001:00004096:00000:00000000}{00791:00023:00094208:00000:00000000}{02519:00001:00004096:00000:00000000}{03011:00001:00004096:00000:00000000}{01614:00003:00012288:00000:00000000}{03350:00003:00012288:00000:00000000}{01511:00001:00004096:00000:00000000}{03684:00002:00008192:00000:00000000}{02318:00001:00004096:00000:00000000}{02607:00001:00004096:00000:00000000}{02450:00003:00012288:00000:00000000} (160314_18:16:04.340)[ 253.814141]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:04.918)[ 254.375155]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=99%, duty 572215846, period 573884300, req_cnt=8 (160314_18:16:04.918)[ 254.376418]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=8, break_cnt=0, tract_cnt=7, bit_cnt=0 (160314_18:16:04.918)[ 254.377913]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7268 kB/s, size: 4157440 bytes, time:572 ms (160314_18:16:04.918)[ 254.379195]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:04.918)[ 254.380327]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {02450:00004:00016384:00000:00000000}{00419:00004:00016384:00000:00000000}{00791:00009:00036864:00000:00000000} (160314_18:16:04.918)[ 254.382203]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:05.433)[ 254.891663]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=99%, duty 514773002, period 516503300, req_cnt=7 (160314_18:16:05.433)[ 254.893122]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=7, break_cnt=0, tract_cnt=2, bit_cnt=0 (160314_18:16:05.433)[ 254.894718]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=6709 kB/s, size: 3448832 bytes, time:514 ms (160314_18:16:05.433)[ 254.896072]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:05.433)[ 254.897205]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00791:00007:00028672:00000:00000000}{02450:00004:00016384:00000:00000000}{00419:00003:00012288:00000:00000000} (160314_18:16:05.433)[ 254.899082]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:06.010)[ 255.424481]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=100%, duty 533258230, period 532823900, req_cnt=7 (160314_18:16:06.010)[ 255.425754]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=7, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:06.010)[ 255.427249]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=5924 kB/s, size: 3158016 bytes, time:533 ms (160314_18:16:06.010)[ 255.428530]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:06.010)[ 255.429663]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00004:00016384:00000:00000000}{00791:00007:00028672:00000:00000000}{02450:00003:00012288:00000:00000000} (160314_18:16:06.010)[ 255.431539]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:06.463)[ 255.912273]WXY ...20% (160314_18:16:06.541)[ 255.993596]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=99%, duty 566278155, period 569115300, req_cnt=10 (160314_18:16:06.541)[ 255.994945]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=10, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:06.541)[ 255.996453]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7475 kB/s, size: 4231168 bytes, time:566 ms (160314_18:16:06.541)[ 255.997735]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:06.541)[ 255.998868]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00791:00010:00040960:00000:00000000}{02450:00005:00020480:00000:00000000}{00419:00005:00020480:00000:00000000} (160314_18:16:06.541)[ 256.000746]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:07.133)[ 256.549223]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=100%, duty 556125768, period 555620900, req_cnt=10 (160314_18:16:07.133)[ 256.550515]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=10, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:07.133)[ 256.552022]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7411 kB/s, size: 4120576 bytes, time:556 ms (160314_18:16:07.133)[ 256.553480]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:07.133)[ 256.554712]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00791:00010:00040960:00000:00000000}{02450:00005:00020480:00000:00000000}{00419:00005:00020480:00000:00000000} (160314_18:16:07.133)[ 256.556659]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:07.635)[ 257.099067]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=98%, duty 541161924, period 549844700, req_cnt=10 (160314_18:16:07.635)[ 257.100345]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=10, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:07.635)[ 257.101853]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7457 kB/s, size: 4034560 bytes, time:541 ms (160314_18:16:07.635)[ 257.103310]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:07.635)[ 257.104542]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00791:00010:00040960:00000:00000000}{02450:00005:00020480:00000:00000000}{00419:00005:00020480:00000:00000000} (160314_18:16:07.635)[ 257.106488]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:08.209)[ 257.663615]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=100%, duty 565340075, period 564552100, req_cnt=11 (160314_18:16:08.209)[ 257.664976]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:08.209)[ 257.666484]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7829 kB/s, size: 4423680 bytes, time:565 ms (160314_18:16:08.209)[ 257.667766]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:08.209)[ 257.668900]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00791:00011:00045056:00000:00000000}{02450:00006:00024576:00000:00000000}{00419:00005:00020480:00000:00000000} (160314_18:16:08.209)[ 257.670778]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:08.279)[ 257.739106]<0>.(0)[133:mmcqd/0][BLOCK_TAG] MMC Queue Thread:133, 135, 134, 0, 0 (160314_18:16:08.279)[ 257.740035]<0>.(0)[133:mmcqd/0][BLOCK_TAG] MMC CID: 0 0 0 0 (160314_18:16:08.798)[ 258.228815]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=99%, duty 564574385, period 565195500, req_cnt=11 (160314_18:16:08.798)[ 258.230095]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:08.798)[ 258.231602]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7785 kB/s, size: 4390912 bytes, time:564 ms (160314_18:16:08.798)[ 258.233376]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:08.798)[ 258.234612]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00006:00024576:00000:00000000}{00791:00011:00045056:00000:00000000}{02450:00005:00020480:00000:00000000} (160314_18:16:08.798)[ 258.236561]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:09.331)[ 258.772013]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=99%, duty 542088076, period 543196900, req_cnt=7 (160314_18:16:09.331)[ 258.773794]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=7, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:09.331)[ 258.775395]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=5206 kB/s, size: 2822144 bytes, time:542 ms (160314_18:16:09.331)[ 258.776752]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:09.331)[ 258.777887]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00791:00007:00028672:00000:00000000}{02450:00004:00016384:00000:00000000}{00419:00003:00012288:00000:00000000} (160314_18:16:09.331)[ 258.779765]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:09.887)[ 259.349210]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=99%, duty 576627769, period 577198000, req_cnt=10 (160314_18:16:09.887)[ 259.350491]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=10, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:09.887)[ 259.351998]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=6712 kB/s, size: 3866624 bytes, time:576 ms (160314_18:16:09.887)[ 259.353855]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:09.887)[ 259.355088]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00005:00020480:00000:00000000}{00791:00010:00040960:00000:00000000}{02450:00005:00020480:00000:00000000} (160314_18:16:09.887)[ 259.357039]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:10.038)WXY ...40% (160314_18:16:10.416)[ 259.905613]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=100%, duty 557282692, period 556404000, req_cnt=11 (160314_18:16:10.416)[ 259.906904]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:10.416)[ 259.908412]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7530 kB/s, size: 4194304 bytes, time:557 ms (160314_18:16:10.416)[ 259.909693]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:10.416)[ 259.910827]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00006:00024576:00000:00000000}{00791:00011:00045056:00000:00000000}{02450:00005:00020480:00000:00000000} (160314_18:16:10.416)[ 259.912934]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:10.966)[ 260.455202]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=98%, duty 542962924, period 549591900, req_cnt=11 (160314_18:16:10.966)[ 260.456477]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:10.966)[ 260.457985]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7897 kB/s, size: 4280320 bytes, time:542 ms (160314_18:16:10.966)[ 260.459267]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:10.976)[ 260.460400]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00791:00011:00045056:00000:00000000}{02450:00006:00024576:00000:00000000}{00419:00005:00020480:00000:00000000} (160314_18:16:10.976)[ 260.462277]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:11.542)[ 261.006964]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=100%, duty 554092155, period 551758200, req_cnt=11 (160314_18:16:11.542)[ 261.008255]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:11.542)[ 261.009763]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7504 kB/s, size: 4157440 bytes, time:554 ms (160314_18:16:11.542)[ 261.011044]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:11.542)[ 261.012178]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00006:00024576:00000:00000000}{00791:00011:00045056:00000:00000000}{02450:00005:00020480:00000:00000000} (160314_18:16:11.542)[ 261.014293]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:12.104)[ 261.569315]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=97%, duty 549281155, period 562352300, req_cnt=11 (160314_18:16:12.104)[ 261.570594]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:12.104)[ 261.572101]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7781 kB/s, size: 4272128 bytes, time:549 ms (160314_18:16:12.104)[ 261.573562]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:12.104)[ 261.574793]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00791:00011:00045056:00000:00000000}{02450:00006:00024576:00000:00000000}{00419:00005:00020480:00000:00000000} (160314_18:16:12.104)[ 261.576743]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:12.104)[ 261.578079]<0>-(0)[0:swapper/0][PMIC] bat_percent_notify_task is called (160314_18:16:12.104)[ 261.578933]<0>.(0)[54:bat_percent_not][PMIC] [upmu_get_rgs_chrdet] CHRDET status = 0 (160314_18:16:12.104)[ 261.579895]<0>.(0)[54:bat_percent_not][PMIC] bat_per_level=0,bat_per_val=100 (160314_18:16:12.666)[ 262.128604]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=100%, duty 561606845, period 559286700, req_cnt=12 (160314_18:16:12.666)[ 262.129894]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=12, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:12.666)[ 262.131402]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=8235 kB/s, size: 4620288 bytes, time:561 ms (160314_18:16:12.666)[ 262.133252]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:12.666)[ 262.134485]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00006:00024576:00000:00000000}{00791:00012:00049152:00000:00000000}{02450:00006:00024576:00000:00000000} (160314_18:16:12.666)[ 262.136437]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:13.180)[ 262.650626]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=100%, duty 526498153, period 522022000, req_cnt=11 (160314_18:16:13.180)[ 262.651917]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:13.180)[ 262.653610]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7942 kB/s, size: 4177920 bytes, time:526 ms (160314_18:16:13.180)[ 262.654991]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:13.180)[ 262.656198]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00006:00024576:00000:00000000}{00791:00011:00045056:00000:00000000}{02450:00005:00020480:00000:00000000} (160314_18:16:13.180)[ 262.658076]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:13.294)[ 262.756197]<0>.(0)[133:mmcqd/0][BLOCK_TAG] MMC Queue Thread:133, 135, 134, 0, 0 (160314_18:16:13.304)[ 262.757126]<0>.(0)[133:mmcqd/0][BLOCK_TAG] MMC CID: 0 0 0 0 (160314_18:16:13.760)[ 263.211415]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=98%, duty 553503153, period 560788600, req_cnt=11 (160314_18:16:13.760)[ 263.212883]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:13.760)[ 263.214492]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7814 kB/s, size: 4321280 bytes, time:553 ms (160314_18:16:13.760)[ 263.215847]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:13.760)[ 263.216981]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00791:00011:00045056:00000:00000000}{02450:00006:00024576:00000:00000000}{00419:00005:00020480:00000:00000000} (160314_18:16:13.760)[ 263.218858]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:13.959)WXY ...60% (160314_18:16:14.288)[ 263.742966]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=100%, duty 533136308, period 531552700, req_cnt=11 (160314_18:16:14.288)[ 263.744361]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:14.288)[ 263.745945]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7784 kB/s, size: 4149248 bytes, time:533 ms (160314_18:16:14.288)[ 263.747227]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:14.288)[ 263.748360]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00006:00024576:00000:00000000}{00791:00011:00045056:00000:00000000}{02450:00005:00020480:00000:00000000} (160314_18:16:14.288)[ 263.750238]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:14.868)[ 264.296762]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=98%, duty 546259001, period 553795800, req_cnt=11 (160314_18:16:14.868)[ 264.298042]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:14.868)[ 264.299550]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7929 kB/s, size: 4329472 bytes, time:546 ms (160314_18:16:14.868)[ 264.300831]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:14.868)[ 264.301964]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00791:00011:00045056:00000:00000000}{02450:00006:00024576:00000:00000000}{00419:00005:00020480:00000:00000000} (160314_18:16:14.868)[ 264.304001]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:15.379)[ 264.814628]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=100%, duty 522514461, period 517866000, req_cnt=11 (160314_18:16:15.379)[ 264.815918]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:15.379)[ 264.817426]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=8003 kB/s, size: 4177920 bytes, time:522 ms (160314_18:16:15.379)[ 264.818707]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:15.379)[ 264.819841]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00006:00024576:00000:00000000}{00791:00011:00045056:00000:00000000}{02450:00005:00020480:00000:00000000} (160314_18:16:15.379)[ 264.821719]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:15.899)[ 265.367612]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=97%, duty 540519768, period 552985000, req_cnt=11 (160314_18:16:15.899)[ 265.368888]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:15.899)[ 265.370396]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=8025 kB/s, size: 4333568 bytes, time:540 ms (160314_18:16:15.899)[ 265.371677]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:15.899)[ 265.373300]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00791:00011:00045056:00000:00000000}{02450:00006:00024576:00000:00000000}{00419:00005:00020480:00000:00000000} (160314_18:16:15.899)[ 265.375278]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:16.481)[ 265.896038]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=101%, duty 534278767, period 528424300, req_cnt=11 (160314_18:16:16.481)[ 265.897329]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:16.481)[ 265.898837]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7846 kB/s, size: 4190208 bytes, time:534 ms (160314_18:16:16.481)[ 265.900118]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:16.481)[ 265.901252]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00006:00024576:00000:00000000}{00791:00011:00045056:00000:00000000}{02450:00005:00020480:00000:00000000} (160314_18:16:16.481)[ 265.903605]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:16.481)[ 265.942366]<0>-(0)[0:swapper/0]printk_delayed:start[ 265.942997]<0>-(0)[0:swapper/0][WDK], local_bit:0x0, cpu:0,RT265932683091[ 265.942997]<0>[WDK], local_bit:0x1, cpu:0, check bit0x:1,RT265932688245[ 265.942997]<0>[WDK]: kick Ex WDT,RT265932691399[ 265.942997]<0>[thread:148][RT:265932761014] 2016-03-14 10:16:15.425280 UTC; android time 2016-03-14 10:16:15.425280 (160314_18:16:16.481)[ 265.946603]<0>-(0)[0:swapper/0]printk_delayed:done[ 265.947237]<0>-(0)[0:swapper/0][HRTIMER DURATION WARN] HRTIMER:tick_sched_timer+0x0/0x194, dur:4869000 ns > 3 ms,(s:265942351553,e:265947220553) (160314_18:16:16.481)[ 265.948860]<0>-(0)[0:swapper/0][ISR DURATION WARN] IRQ[30:arch_timer], dur:6503846 ns > 3 ms,(s:265942346322,e:265948850168) (160314_18:16:17.058)[ 266.470753]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=98%, duty 566446229, period 574713600, req_cnt=11 (160314_18:16:17.058)[ 266.472034]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:17.058)[ 266.473798]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7656 kB/s, size: 4333568 bytes, time:566 ms (160314_18:16:17.058)[ 266.475178]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:17.058)[ 266.476385]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00791:00011:00045056:00000:00000000}{02450:00006:00024576:00000:00000000}{00419:00005:00020480:00000:00000000} (160314_18:16:17.058)[ 266.478264]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:17.563)[ 266.988832]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=101%, duty 525652232, period 518079500, req_cnt=11 (160314_18:16:17.563)[ 266.990123]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:17.563)[ 266.991630]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7934 kB/s, size: 4165632 bytes, time:525 ms (160314_18:16:17.563)[ 266.993459]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:17.563)[ 266.994696]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00006:00024576:00000:00000000}{00791:00011:00045056:00000:00000000}{02450:00005:00020480:00000:00000000} (160314_18:16:17.563)[ 266.996648]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:18.080)[ 267.536339]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=97%, duty 531780538, period 547509900, req_cnt=11 (160314_18:16:18.080)[ 267.537615]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:18.080)[ 267.539122]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=8176 kB/s, size: 4341760 bytes, time:531 ms (160314_18:16:18.080)[ 267.540404]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:18.080)[ 267.541538]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00791:00011:00045056:00000:00000000}{02450:00006:00024576:00000:00000000}{00419:00005:00020480:00000:00000000} (160314_18:16:18.080)[ 267.543892]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:18.342)[ 267.791464]<0>.(0)[133:mmcqd/0][BLOCK_TAG] MMC Queue Thread:133, 135, 134, 0, 0 (160314_18:16:18.342)[ 267.792583]<0>.(0)[133:mmcqd/0][BLOCK_TAG] MMC CID: 0 0 0 0 (160314_18:16:18.684)[ 268.105570]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=99%, duty 568503383, period 569232800, req_cnt=12 (160314_18:16:18.684)[ 268.106846]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=12, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:18.684)[ 268.108353]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=8192 kB/s, size: 4653056 bytes, time:568 ms (160314_18:16:18.684)[ 268.109634]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:18.684)[ 268.110768]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00006:00024576:00000:00000000}{00791:00012:00049152:00000:00000000}{02450:00006:00024576:00000:00000000} (160314_18:16:18.684)[ 268.112803]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:18.762)WXY ...80% (160314_18:16:19.198)[ 268.639129]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=99%, duty 533283921, period 533554300, req_cnt=11 (160314_18:16:19.198)[ 268.640409]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:19.198)[ 268.641916]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7869 kB/s, size: 4194304 bytes, time:533 ms (160314_18:16:19.198)[ 268.643451]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:19.198)[ 268.644681]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00006:00024576:00000:00000000}{00791:00011:00045056:00000:00000000}{02450:00005:00020480:00000:00000000} (160314_18:16:19.198)[ 268.646629]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:19.785)[ 269.210299]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=100%, duty 571827464, period 571169000, req_cnt=11 (160314_18:16:19.785)[ 269.211591]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=1638 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:19.785)[ 269.213720]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7324 kB/s, size: 4182016 bytes, time:571 ms (160314_18:16:19.785)[ 269.215102]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:19.785)[ 269.216313]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00791:00011:00045056:00000:00000000}{02450:00006:00024576:00000:00000000}{00419:00005:00020480:00000:00000000} (160314_18:16:19.785)[ 269.218192]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:20.295)[ 269.743183]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=99%, duty 531657383, period 532885700, req_cnt=10 (160314_18:16:20.295)[ 269.744565]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=10, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:20.295)[ 269.746148]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7274 kB/s, size: 3862528 bytes, time:531 ms (160314_18:16:20.295)[ 269.747431]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:20.295)[ 269.748564]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00005:00020480:00000:00000000}{00791:00010:00040960:00000:00000000}{02450:00005:00020480:00000:00000000} (160314_18:16:20.295)[ 269.750441]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:20.879)[ 270.293408]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=97%, duty 539017847, period 550229900, req_cnt=9 (160314_18:16:20.879)[ 270.294747]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=9, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:20.879)[ 270.296245]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=6618 kB/s, size: 3567616 bytes, time:539 ms (160314_18:16:20.879)[ 270.297526]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:20.879)[ 270.298659]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00004:00016384:00000:00000000}{00791:00008:00032768:00000:00000000}{02450:00004:00016384:00000:00000000} (160314_18:16:20.879)[ 270.300537]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:21.386)[ 270.807722]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=101%, duty 521908310, period 514308300, req_cnt=11 (160314_18:16:21.386)[ 270.809013]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:21.386)[ 270.810520]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7940 kB/s, size: 4136960 bytes, time:521 ms (160314_18:16:21.386)[ 270.811802]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:21.386)[ 270.813422]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00006:00024576:00000:00000000}{00791:00012:00049152:00000:00000000}{02450:00006:00024576:00000:00000000} (160314_18:16:21.386)[ 270.815399]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:21.903)[ 271.374416]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=98%, duty 556580538, period 566694100, req_cnt=11 (160314_18:16:21.903)[ 271.375695]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:21.903)[ 271.377203]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7794 kB/s, size: 4333568 bytes, time:556 ms (160314_18:16:21.903)[ 271.378485]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:21.903)[ 271.379618]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00005:00020480:00000:00000000}{00791:00010:00040960:00000:00000000}{02450:00005:00020480:00000:00000000} (160314_18:16:21.903)[ 271.381496]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:22.103)[ 271.580800]<0>-(0)[0:swapper/0][PMIC] bat_percent_notify_task is called (160314_18:16:22.103)[ 271.581660]<0>.(0)[54:bat_percent_not][PMIC] [upmu_get_rgs_chrdet] CHRDET status = 0 (160314_18:16:22.103)[ 271.582715]<0>.(0)[54:bat_percent_not][PMIC] bat_per_level=0,bat_per_val=100 (160314_18:16:22.451)[ 271.905825]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=101%, duty 537234924, period 531409700, req_cnt=11 (160314_18:16:22.451)[ 271.907115]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:22.451)[ 271.908623]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7726 kB/s, size: 4149248 bytes, time:537 ms (160314_18:16:22.451)[ 271.909905]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:22.451)[ 271.911039]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00006:00024576:00000:00000000}{00791:00012:00049152:00000:00000000}{02450:00006:00024576:00000:00000000} (160314_18:16:22.451)[ 271.913471]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:22.772)[ 272.232646]<0>.(0)[89:hang_detect][Hang_Detect] init found pid:1. (160314_18:16:22.772)[ 272.233480]<0>.(0)[89:hang_detect][Hang_Detect] surfaceflinger found pid:219. (160314_18:16:22.772)[ 272.234394]<0>.(0)[89:hang_detect][Hang_Detect] system_server found pid:791. (160314_18:16:22.772)[ 272.235270]<0>.(0)[89:hang_detect][Hang_Detect] ndroid.systemui found pid:987. (160314_18:16:22.772)[ 272.236168]<0>.(0)[89:hang_detect][Hang_Detect] hang_detect thread counts down 9:10. (160314_18:16:22.772)[ 272.268137]<0>.(0)[3889:ipod]wxy write_pageset:959[ 272.268763]<0>.(0)[3889:ipod][HIB/TOI] [write_pageset()]@line:961 return value(0) (160314_18:16:22.772)[ 272.269699]<0>.(0)[3889:ipod]wxy userui_prepare_status:314[ 272.270410]<0>.(0)[3889:ipod]wxy userui_prepare_status:322[ 272.271125]<0>.(0)[3889:ipod]Doing atomic copy/restore. (160314_18:16:22.852)[ 272.273937]<0>.(0)[3889:ipod]usb usb1: usb_suspend_both: READY TO SUSPEND BOTH (160314_18:16:22.852)[ 272.274863]<0>.(0)[3889:ipod]usb usb1: usb_suspend_both: BEFORE usb_suspend_device (160314_18:16:22.852)[ 272.275801]x_ICUSB [DBG], <usb_suspend_device(), 1092> (160314_18:16:22.852)[ 272.276457]<0>.(0)[3889:ipod]x_ICUSB [DBG], <generic_suspend(), 222> udev : 18446743799732224000x_ICUSB [DBG], <generic_suspend(), 231> (160314_18:16:22.852)[ 272.278054]<0>.(0)[3889:ipod]usb usb1: usb_suspend_both: AFTER usb_suspend_device (160314_18:16:22.852)[ 272.278984]<0>.(0)[3889:ipod]usb usb1: usb_suspend_both: SUSPEND SUCCESS: status: 0 (160314_18:16:23.075)[ 272.512042]<0>.(0)[3889:ipod][battery_meter_suspend] ffffffc000673364:ffffffc000673364 (160314_18:16:23.075)[ 272.515793]<0>.(0)[3889:ipod][HPS] hps_freeze (160314_18:16:23.075)[ 272.516338]<0>.(0)[3889:ipod][HPS] state: 2, enabled: 0, early_suspend_enabled: 1, suspend_enabled: 1, rush_boost_enabled: 0 (160314_18:16:23.075)[ 272.518686]<0>.(0)[3889:ipod][PMIC] * MT pmic driver suspend!! ******** (160314_18:16:23.075)[ 272.519677]<0>.(0)[3889:ipod][PMIC] Reg[0xec2]=0x8a12, Reg[0xec4]=0x89a1, Reg[0x2ac]=0x20f (160314_18:16:23.075)[ 272.520754]<0>.(0)[3889:ipod][PMIC] Reg[0xcd2]=0xd7b3, Reg[0xcd4]=0xd096, Reg[0x2b8]=0x340 (160314_18:16:23.075)[ 272.522947]<0>.(0)[3889:ipod]wxy calling xfb_pm_freeze start. (160314_18:16:23.075)[ 272.523692]<0>.(0)[3889:ipod]wxy calling xfb_pm_freeze exit. (160314_18:16:23.075)[ 272.525998]x_pm_ops_suspend_ipox_routing_pm_ops_suspend (160314_18:16:23.075)[ 272.526700]<0>-(0)[3889:ipod]-----------AudDrv_Clk_On, Aud_AFE_Clk_cntr:0 (160314_18:16:23.075)[ 272.527667]<0>-(0)[3889:ipod]------------AudDrv_Clk_Off, Aud_AFE_Clk_cntr:0 (160314_18:16:23.075)[ 272.528555]<0>.(0)[3889:ipod]SetAnalogSuspend bEnable ==1 mAnaSuspend = 0 (160314_18:16:23.075)[ 272.529417]<0>.(0)[3889:ipod]AFE_UL_DL_CON0 = 0x0 (160314_18:16:23.075)[ 272.530005]<0>.(0)[3889:ipod]AFE_DL_SRC2_CON0_H = 0x7300 (160314_18:16:23.075)[ 272.530669]<0>.(0)[3889:ipod]AFE_DL_SRC2_CON0_L = 0x0 (160314_18:16:23.075)[ 272.531300]<0>.(0)[3889:ipod]AFE_DL_SDM_CON0 = 0x0 (160314_18:16:23.075)[ 272.531910]<0>.(0)[3889:ipod]AFE_DL_SDM_CON1 = 0x1e (160314_18:16:23.075)[ 272.532693]<0>.(0)[3889:ipod]AFE_UL_SRC0_CON0_H = 0x0 (160314_18:16:23.075)[ 272.533357]<0>.(0)[3889:ipod]AFE_UL_SRC0_CON0_L = 0x0 (160314_18:16:23.075)[ 272.533989]<0>.(0)[3889:ipod]AFE_UL_SRC1_CON0_H = 0xe1 (160314_18:16:23.075)[ 272.534631]<0>.(0)[3889:ipod]AFE_UL_SRC1_CON0_L = 0x8e18 (160314_18:16:23.075)[ 272.535295]<0>.(0)[3889:ipod]PMIC_AFE_TOP_CON0 = 0x0 (160314_18:16:23.075)[ 272.535926]<0>.(0)[3889:ipod]AFE_AUDIO_TOP_CON0 = 0x7a (160314_18:16:23.075)[ 272.536568]<0>.(0)[3889:ipod]PMIC_AFE_TOP_CON0 = 0x0 (160314_18:16:23.075)[ 272.537198]<0>.(0)[3889:ipod]AFE_DL_SRC_MON0 = 0x0 (160314_18:16:23.075)[ 272.537808]<0>.(0)[3889:ipod]AFE_DL_SDM_TEST0 = 0x7010 (160314_18:16:23.075)[ 272.538461]<0>.(0)[3889:ipod]AFE_MON_DEBUG0 = 0x0 (160314_18:16:23.075)[ 272.539048]<0>.(0)[3889:ipod]AFUNC_AUD_CON0 = 0xc3a1 (160314_18:16:23.075)[ 272.539668]<0>.(0)[3889:ipod]AFUNC_AUD_CON1 = 0x0 (160314_18:16:23.075)[ 272.540255]<0>.(0)[3889:ipod]AFUNC_AUD_CON2 = 0xb (160314_18:16:23.075)[ 272.540843]<0>.(0)[3889:ipod]AFUNC_AUD_CON3 = 0x0 (160314_18:16:23.075)[ 272.541430]<0>.(0)[3889:ipod]AFUNC_AUD_CON4 = 0x0 (160314_18:16:23.075)[ 272.542017]<0>.(0)[3889:ipod]AFUNC_AUD_MON0 = 0x0 (160314_18:16:23.075)[ 272.542902]<0>.(0)[3889:ipod]AFUNC_AUD_MON1 = 0x0 (160314_18:16:23.075)[ 272.543492]<0>.(0)[3889:ipod]AUDRC_TUNE_MON0 = 0x0 (160314_18:16:23.075)[ 272.544102]<0>.(0)[3889:ipod]AFE_UP8X_FIFO_CFG0 = 0x1 (160314_18:16:23.075)[ 272.544732]<0>.(0)[3889:ipod]AFE_UP8X_FIFO_LOG_MON0 = 0x3 (160314_18:16:23.075)[ 272.545406]<0>.(0)[3889:ipod]AFE_UP8X_FIFO_LOG_MON1 = 0x0 (160314_18:16:23.075)[ 272.546081]<0>.(0)[3889:ipod]AFE_DL_DC_COMP_CFG0 = 0x0 (160314_18:16:23.075)[ 272.546733]<0>.(0)[3889:ipod]AFE_DL_DC_COMP_CFG1 = 0x0 (160314_18:16:23.075)[ 272.547386]<0>.(0)[3889:ipod]AFE_DL_DC_COMP_CFG2 = 0x0 (160314_18:16:23.075)[ 272.548038]<0>.(0)[3889:ipod]AFE_PMIC_NEWIF_CFG0 = 0x7330 (160314_18:16:23.075)[ 272.548723]<0>.(0)[3889:ipod]AFE_PMIC_NEWIF_CFG1 = 0x18 (160314_18:16:23.075)[ 272.549387]<0>.(0)[3889:ipod]AFE_PMIC_NEWIF_CFG2 = 0x302f (160314_18:16:23.075)[ 272.550072]<0>.(0)[3889:ipod]AFE_PMIC_NEWIF_CFG3 = 0xf872 (160314_18:16:23.075)[ 272.550758]<0>.(0)[3889:ipod]AFE_SGEN_CFG0 = 0x8 (160314_18:16:23.075)[ 272.551345]<0>.(0)[3889:ipod]AFE_SGEN_CFG1 = 0x101 (160314_18:16:23.075)[ 272.551954]<0>.(0)[3889:ipod]AFE_VOW_TOP = 0x0 (160314_18:16:23.075)[ 272.552646]<0>.(0)[3889:ipod]AFE_VOW_CFG0 = 0x0 (160314_18:16:23.075)[ 272.553224]<0>.(0)[3889:ipod]AFE_VOW_CFG1 = 0x0 (160314_18:16:23.075)[ 272.553827]<0>.(0)[3889:ipod]AFE_VOW_CFG2 = 0x0 (160314_18:16:23.075)[ 272.554404]<0>.(0)[3889:ipod]AFE_VOW_CFG3 = 0x0 (160314_18:16:23.075)[ 272.554981]<0>.(0)[3889:ipod]AFE_VOW_CFG4 = 0x0 (160314_18:16:23.075)[ 272.555558]<0>.(0)[3889:ipod]AFE_VOW_CFG5 = 0x0 (160314_18:16:23.075)[ 272.556134]<0>.(0)[3889:ipod]AFE_VOW_MON0 = 0x0 (160314_18:16:23.075)[ 272.556710]<0>.(0)[3889:ipod]AFE_VOW_MON1 = 0x0 (160314_18:16:23.075)[ 272.557287]<0>.(0)[3889:ipod]AFE_VOW_MON2 = 0x0 (160314_18:16:23.075)[ 272.557863]<0>.(0)[3889:ipod]AFE_VOW_MON3 = 0x0 (160314_18:16:23.075)[ 272.558440]<0>.(0)[3889:ipod]AFE_VOW_MON4 = 0x0 (160314_18:16:23.075)[ 272.559016]<0>.(0)[3889:ipod]AFE_VOW_MON5 = 0x0 (160314_18:16:23.075)[ 272.559593]<0>.(0)[3889:ipod]AFE_DCCLK_CFG0 = 0xfe2 (160314_18:16:23.075)[ 272.560202]<0>.(0)[3889:ipod]AFE_DCCLK_CFG1 = 0x1005 (160314_18:16:23.075)[ 272.560823]<0>.(0)[3889:ipod]TOP_CON = 0x133 (160314_18:16:23.075)[ 272.561367]<0>.(0)[3889:ipod]TOP_STATUS = 0x0 (160314_18:16:23.075)[ 272.561913]<0>.(0)[3889:ipod]TOP_CKPDN_CON0 = 0xfefc (160314_18:16:23.075)[ 272.562570]<0>.(0)[3889:ipod]TOP_CKPDN_CON1 = 0x4ac (160314_18:16:23.075)[ 272.563181]<0>.(0)[3889:ipod]TOP_CKPDN_CON2 = 0x7673 (160314_18:16:23.075)[ 272.563801]<0>.(0)[3889:ipod]TOP_CKPDN_CON3 = 0x5e4 (160314_18:16:23.075)[ 272.564410]<0>.(0)[3889:ipod]TOP_CKSEL_CON0 = 0x280 (160314_18:16:23.075)[ 272.565019]<0>.(0)[3889:ipod]TOP_CKSEL_CON1 = 0x0 (160314_18:16:23.075)[ 272.565606]<0>.(0)[3889:ipod]TOP_CKSEL_CON2 = 0x0 (160314_18:16:23.075)[ 272.566194]<0>.(0)[3889:ipod]TOP_CKDIVSEL_CON = 0x1 (160314_18:16:23.075)[ 272.566814]<0>.(0)[3889:ipod]TOP_CKHWEN_CON = 0x30ff (160314_18:16:23.075)[ 272.567433]<0>.(0)[3889:ipod]TOP_CKTST_CON0 = 0x0 (160314_18:16:23.075)[ 272.568021]<0>.(0)[3889:ipod]TOP_CKTST_CON1 = 0x0 (160314_18:16:23.075)[ 272.568609]<0>.(0)[3889:ipod]TOP_CKTST_CON2 = 0x0 (160314_18:16:23.075)[ 272.569198]<0>.(0)[3889:ipod]TOP_CLKSQ = 0x8102 (160314_18:16:23.075)[ 272.569774]<0>.(0)[3889:ipod]TOP_RST_CON0 = 0x0 (160314_18:16:23.075)[ 272.570351]<0>.(0)[3889:ipod]TEST_CON0 = 0x0 (160314_18:16:23.075)[ 272.570894]<0>.(0)[3889:ipod]TEST_OUT = 0x4 (160314_18:16:23.075)[ 272.571427]<0>.(0)[3889:ipod]AFE_MON_DEBUG0= 0x0 (160314_18:16:23.075)[ 272.572004]<0>.(0)[3889:ipod]ZCD_CON0 = 0x0 (160314_18:16:23.075)[ 272.572871]<0>.(0)[3889:ipod]ZCD_CON1 = 0x488 (160314_18:16:23.075)[ 272.573429]<0>.(0)[3889:ipod]ZCD_CON2 = 0x60c (160314_18:16:23.075)[ 272.573984]<0>.(0)[3889:ipod]ZCD_CON3 = 0x1f (160314_18:16:23.138)[ 272.574528]<0>.(0)[3889:ipod]ZCD_CON4 = 0x707 (160314_18:16:23.158)[ 272.575083]<0>.(0)[3889:ipod]ZCD_CON5 = 0x3f3f (160314_18:16:23.158)[ 272.575649]<0>.(0)[3889:ipod]LDO_CON1 = 0xe128 (160314_18:16:23.158)[ 272.576214]<0>.(0)[3889:ipod]LDO_CON2 = 0xc102 (160314_18:16:23.158)[ 272.576781]<0>.(0)[3889:ipod]LDO_VCON1 = 0xc002 (160314_18:16:23.158)[ 272.577358]<0>.(0)[3889:ipod]SPK_CON0 = 0x0 (160314_18:16:23.158)[ 272.577890]<0>.(0)[3889:ipod]SPK_CON1 = 0x0 (160314_18:16:23.158)[ 272.578423]<0>.(0)[3889:ipod]SPK_CON2 = 0x14 (160314_18:16:23.158)[ 272.578967]<0>.(0)[3889:ipod]SPK_CON3 = 0x0 (160314_18:16:23.158)[ 272.579500]<0>.(0)[3889:ipod]SPK_CON4 = 0x0 (160314_18:16:23.158)[ 272.580034]<0>.(0)[3889:ipod]SPK_CON5 = 0x94 (160314_18:16:23.158)[ 272.580578]<0>.(0)[3889:ipod]SPK_CON6 = 0x0 (160314_18:16:23.158)[ 272.581111]<0>.(0)[3889:ipod]SPK_CON7 = 0x4531 (160314_18:16:23.158)[ 272.581677]<0>.(0)[3889:ipod]SPK_CON8 = 0x0 (160314_18:16:23.158)[ 272.582210]<0>.(0)[3889:ipod]SPK_CON9 = 0x2000 (160314_18:16:23.158)[ 272.582966]<0>.(0)[3889:ipod]SPK_CON10 = 0x0 (160314_18:16:23.158)[ 272.583538]<0>.(0)[3889:ipod]SPK_CON11 = 0x0 (160314_18:16:23.158)[ 272.584082]<0>.(0)[3889:ipod]SPK_CON12 = 0x0 (160314_18:16:23.158)[ 272.584647]<0>.(0)[3889:ipod]SPK_CON13 = 0x0 (160314_18:16:23.158)[ 272.585191]<0>.(0)[3889:ipod]SPK_CON14 = 0x0 (160314_18:16:23.158)[ 272.585735]<0>.(0)[3889:ipod]SPK_CON15 = 0x0 (160314_18:16:23.158)[ 272.586279]<0>.(0)[3889:ipod]SPK_CON16 = 0x0 (160314_18:16:23.158)[ 272.586823]<0>.(0)[3889:ipod]SPK_ANA_CON0 = 0x5800 (160314_18:16:23.158)[ 272.587433]<0>.(0)[3889:ipod]SPK_ANA_CON1 = 0x0 (160314_18:16:23.158)[ 272.588010]<0>.(0)[3889:ipod]SPK_ANA_CON3 = 0x0 (160314_18:16:23.158)[ 272.588587]<0>.(0)[3889:ipod]AUDDEC_ANA_CON0 = 0x0 (160314_18:16:23.158)[ 272.589197]<0>.(0)[3889:ipod]AUDDEC_ANA_CON1 = 0x480 (160314_18:16:23.158)[ 272.589828]<0>.(0)[3889:ipod]AUDDEC_ANA_CON2 = 0x1 (160314_18:16:23.158)[ 272.590437]<0>.(0)[3889:ipod]AUDDEC_ANA_CON3 = 0x72 (160314_18:16:23.158)[ 272.591057]<0>.(0)[3889:ipod]AUDDEC_ANA_CON4 = 0x0 (160314_18:16:23.158)[ 272.591667]<0>.(0)[3889:ipod]AUDDEC_ANA_CON5 = 0x5490 (160314_18:16:23.158)[ 272.592309]<0>.(0)[3889:ipod]AUDDEC_ANA_CON6 = 0x1 (160314_18:16:23.158)[ 272.593209]<0>.(0)[3889:ipod]AUDDEC_ANA_CON7 = 0x0 (160314_18:16:23.158)[ 272.593820]<0>.(0)[3889:ipod]AUDDEC_ANA_CON8 = 0x2 (160314_18:16:23.158)[ 272.594429]<0>.(0)[3889:ipod]AUDENC_ANA_CON0 = 0x0 (160314_18:16:23.158)[ 272.595039]<0>.(0)[3889:ipod]AUDENC_ANA_CON1 = 0x0 (160314_18:16:23.158)[ 272.595648]<0>.(0)[3889:ipod]AUDENC_ANA_CON2 = 0x0 (160314_18:16:23.158)[ 272.596257]<0>.(0)[3889:ipod]AUDENC_ANA_CON3 = 0x0 (160314_18:16:23.158)[ 272.596866]<0>.(0)[3889:ipod]AUDENC_ANA_CON4 = 0x800 (160314_18:16:23.158)[ 272.597498]<0>.(0)[3889:ipod]AUDENC_ANA_CON5 = 0x0 (160314_18:16:23.158)[ 272.598107]<0>.(0)[3889:ipod]AUDENC_ANA_CON6 = 0x555 (160314_18:16:23.158)[ 272.598738]<0>.(0)[3889:ipod]AUDENC_ANA_CON7 = 0x0 (160314_18:16:23.158)[ 272.599347]<0>.(0)[3889:ipod]AUDENC_ANA_CON8 = 0x4 (160314_18:16:23.158)[ 272.599956]<0>.(0)[3889:ipod]AUDENC_ANA_CON9 = 0x0 (160314_18:16:23.158)[ 272.600566]<0>.(0)[3889:ipod]AUDENC_ANA_CON10 = 0x0 (160314_18:16:23.158)[ 272.601185]<0>.(0)[3889:ipod]AUDNCP_CLKDIV_CON0 = 0x0 (160314_18:16:23.158)[ 272.601816]<0>.(0)[3889:ipod]AUDNCP_CLKDIV_CON1 = 0x0 (160314_18:16:23.158)[ 272.602622]<0>.(0)[3889:ipod]AUDNCP_CLKDIV_CON2 = 0x2b (160314_18:16:23.158)[ 272.603267]<0>.(0)[3889:ipod]AUDNCP_CLKDIV_CON3 = 0x1 (160314_18:16:23.158)[ 272.603922]<0>.(0)[3889:ipod]AUDNCP_CLKDIV_CON4 = 0x0 (160314_18:16:23.158)[ 272.604554]<0>.(0)[3889:ipod]TOP_CKPDN_CON0 = 0xfefc (160314_18:16:23.158)[ 272.605175]<0>.(0)[3889:ipod]GPIO_MODE3 = 0x249 (160314_18:16:23.158)[ 272.605736]<0>.(0)[3889:ipod]-Ana_Log_Print (160314_18:16:23.158)[ 272.606274]<0>.(0)[3889:ipod]AFE_UL_DL_CON0 = 0x0 (160314_18:16:23.158)[ 272.606862]<0>.(0)[3889:ipod]AFE_DL_SRC2_CON0_H = 0x7300 (160314_18:16:23.158)[ 272.607525]<0>.(0)[3889:ipod]AFE_DL_SRC2_CON0_L = 0x0 (160314_18:16:23.158)[ 272.608156]<0>.(0)[3889:ipod]AFE_DL_SDM_CON0 = 0x0 (160314_18:16:23.158)[ 272.608765]<0>.(0)[3889:ipod]AFE_DL_SDM_CON1 = 0x1e (160314_18:16:23.158)[ 272.609387]<0>.(0)[3889:ipod]AFE_UL_SRC0_CON0_H = 0x0 (160314_18:16:23.158)[ 272.610017]<0>.(0)[3889:ipod]AFE_UL_SRC0_CON0_L = 0x0 (160314_18:16:23.158)[ 272.610648]<0>.(0)[3889:ipod]AFE_UL_SRC1_CON0_H = 0xe1 (160314_18:16:23.158)[ 272.611291]<0>.(0)[3889:ipod]AFE_UL_SRC1_CON0_L = 0x8e18 (160314_18:16:23.158)[ 272.611954]<0>.(0)[3889:ipod]PMIC_AFE_TOP_CON0 = 0x0 (160314_18:16:23.158)[ 272.612951]<0>.(0)[3889:ipod]AFE_AUDIO_TOP_CON0 = 0x7a (160314_18:16:23.158)[ 272.613594]<0>.(0)[3889:ipod]PMIC_AFE_TOP_CON0 = 0x0 (160314_18:16:23.158)[ 272.614225]<0>.(0)[3889:ipod]AFE_DL_SRC_MON0 = 0x0 (160314_18:16:23.158)[ 272.614834]<0>.(0)[3889:ipod]AFE_DL_SDM_TEST0 = 0x7010 (160314_18:16:23.158)[ 272.615487]<0>.(0)[3889:ipod]AFE_MON_DEBUG0 = 0x0 (160314_18:16:23.158)[ 272.616075]<0>.(0)[3889:ipod]AFUNC_AUD_CON0 = 0xc3a1 (160314_18:16:23.158)[ 272.616694]<0>.(0)[3889:ipod]AFUNC_AUD_CON1 = 0x0 (160314_18:16:23.158)[ 272.617282]<0>.(0)[3889:ipod]AFUNC_AUD_CON2 = 0xb (160314_18:16:23.158)[ 272.617869]<0>.(0)[3889:ipod]AFUNC_AUD_CON3 = 0x0 (160314_18:16:23.158)[ 272.618456]<0>.(0)[3889:ipod]AFUNC_AUD_CON4 = 0x0 (160314_18:16:23.158)[ 272.619044]<0>.(0)[3889:ipod]AFUNC_AUD_MON0 = 0x0 (160314_18:16:23.158)[ 272.619631]<0>.(0)[3889:ipod]AFUNC_AUD_MON1 = 0x0 (160314_18:16:23.158)[ 272.620219]<0>.(0)[3889:ipod]AUDRC_TUNE_MON0 = 0x0 (160314_18:16:23.158)[ 272.620828]<0>.(0)[3889:ipod]AFE_UP8X_FIFO_CFG0 = 0x1 (160314_18:16:23.158)[ 272.621459]<0>.(0)[3889:ipod]AFE_UP8X_FIFO_LOG_MON0 = 0x3 (160314_18:16:23.158)[ 272.622133]<0>.(0)[3889:ipod]AFE_UP8X_FIFO_LOG_MON1 = 0x0 (160314_18:16:23.158)[ 272.623172]<0>.(0)[3889:ipod]AFE_DL_DC_COMP_CFG0 = 0x0 (160314_18:16:23.158)[ 272.623827]<0>.(0)[3889:ipod]AFE_DL_DC_COMP_CFG1 = 0x0 (160314_18:16:23.158)[ 272.624480]<0>.(0)[3889:ipod]AFE_DL_DC_COMP_CFG2 = 0x0 (160314_18:16:23.158)[ 272.625133]<0>.(0)[3889:ipod]AFE_PMIC_NEWIF_CFG0 = 0x7330 (160314_18:16:23.158)[ 272.625819]<0>.(0)[3889:ipod]AFE_PMIC_NEWIF_CFG1 = 0x18 (160314_18:16:23.158)[ 272.626482]<0>.(0)[3889:ipod]AFE_PMIC_NEWIF_CFG2 = 0x302f (160314_18:16:23.158)[ 272.627167]<0>.(0)[3889:ipod]AFE_PMIC_NEWIF_CFG3 = 0xf872 (160314_18:16:23.158)[ 272.627852]<0>.(0)[3889:ipod]AFE_SGEN_CFG0 = 0x8 (160314_18:16:23.158)[ 272.628439]<0>.(0)[3889:ipod]AFE_SGEN_CFG1 = 0x101 (160314_18:16:23.158)[ 272.629048]<0>.(0)[3889:ipod]AFE_VOW_TOP = 0x0 (160314_18:16:23.158)[ 272.629614]<0>.(0)[3889:ipod]AFE_VOW_CFG0 = 0x0 (160314_18:16:23.158)[ 272.630190]<0>.(0)[3889:ipod]AFE_VOW_CFG1 = 0x0 (160314_18:16:23.158)[ 272.630766]<0>.(0)[3889:ipod]AFE_VOW_CFG2 = 0x0 (160314_18:16:23.158)[ 272.631342]<0>.(0)[3889:ipod]AFE_VOW_CFG3 = 0x0 (160314_18:16:23.158)[ 272.631919]<0>.(0)[3889:ipod]AFE_VOW_CFG4 = 0x0 (160314_18:16:23.158)[ 272.632552]<0>.(0)[3889:ipod]AFE_VOW_CFG5 = 0x0 (160314_18:16:23.158)[ 272.633129]<0>.(0)[3889:ipod]AFE_VOW_MON0 = 0x0 (160314_18:16:23.158)[ 272.633706]<0>.(0)[3889:ipod]AFE_VOW_MON1 = 0x0 (160314_18:16:23.158)[ 272.634282]<0>.(0)[3889:ipod]AFE_VOW_MON2 = 0x0 (160314_18:16:23.158)[ 272.634859]<0>.(0)[3889:ipod]AFE_VOW_MON3 = 0x0 (160314_18:16:23.158)[ 272.635435]<0>.(0)[3889:ipod]AFE_VOW_MON4 = 0x0 (160314_18:16:23.158)[ 272.636011]<0>.(0)[3889:ipod]AFE_VOW_MON5 = 0x0 (160314_18:16:23.158)[ 272.636587]<0>.(0)[3889:ipod]AFE_DCCLK_CFG0 = 0xfe2 (160314_18:16:23.158)[ 272.637196]<0>.(0)[3889:ipod]AFE_DCCLK_CFG1 = 0x1005 (160314_18:16:23.158)[ 272.637816]<0>.(0)[3889:ipod]TOP_CON = 0x133 (160314_18:16:23.158)[ 272.638360]<0>.(0)[3889:ipod]TOP_STATUS = 0x0 (160314_18:16:23.158)[ 272.638904]<0>.(0)[3889:ipod]TOP_CKPDN_CON0 = 0xfefc (160314_18:16:23.158)[ 272.639524]<0>.(0)[3889:ipod]TOP_CKPDN_CON1 = 0x4ac (160314_18:16:23.158)[ 272.640133]<0>.(0)[3889:ipod]TOP_CKPDN_CON2 = 0x7673 (160314_18:16:23.158)[ 272.640754]<0>.(0)[3889:ipod]TOP_CKPDN_CON3 = 0x5e4 (160314_18:16:23.158)[ 272.641363]<0>.(0)[3889:ipod]TOP_CKSEL_CON0 = 0x280 (160314_18:16:23.158)[ 272.641972]<0>.(0)[3889:ipod]TOP_CKSEL_CON1 = 0x0 (160314_18:16:23.158)[ 272.642691]<0>.(0)[3889:ipod]TOP_CKSEL_CON2 = 0x0 (160314_18:16:23.158)[ 272.643304]<0>.(0)[3889:ipod]TOP_CKDIVSEL_CON = 0x1 (160314_18:16:23.158)[ 272.643925]<0>.(0)[3889:ipod]TOP_CKHWEN_CON = 0x30ff (160314_18:16:23.158)[ 272.644545]<0>.(0)[3889:ipod]TOP_CKTST_CON0 = 0x0 (160314_18:16:23.158)[ 272.645132]<0>.(0)[3889:ipod]TOP_CKTST_CON1 = 0x0 (160314_18:16:23.158)[ 272.645719]<0>.(0)[3889:ipod]TOP_CKTST_CON2 = 0x0 (160314_18:16:23.158)[ 272.646306]<0>.(0)[3889:ipod]TOP_CLKSQ = 0x8102 (160314_18:16:23.158)[ 272.646883]<0>.(0)[3889:ipod]TOP_RST_CON0 = 0x0 (160314_18:16:23.158)[ 272.647459]<0>.(0)[3889:ipod]TEST_CON0 = 0x0 (160314_18:16:23.158)[ 272.648002]<0>.(0)[3889:ipod]TEST_OUT = 0x4 (160314_18:16:23.158)[ 272.648535]<0>.(0)[3889:ipod]AFE_MON_DEBUG0= 0x0 (160314_18:16:23.158)[ 272.649111]<0>.(0)[3889:ipod]ZCD_CON0 = 0x0 (160314_18:16:23.158)[ 272.649645]<0>.(0)[3889:ipod]ZCD_CON1 = 0x488 (160314_18:16:23.158)[ 272.650199]<0>.(0)[3889:ipod]ZCD_CON2 = 0x60c (160314_18:16:23.158)[ 272.650754]<0>.(0)[3889:ipod]ZCD_CON3 = 0x1f (160314_18:16:23.158)[ 272.651298]<0>.(0)[3889:ipod]ZCD_CON4 = 0x707 (160314_18:16:23.158)[ 272.651853]<0>.(0)[3889:ipod]ZCD_CON5 = 0x3f3f (160314_18:16:23.158)[ 272.652698]<0>.(0)[3889:ipod]LDO_CON1 = 0xe128 (160314_18:16:23.168)[ 272.653266]<0>.(0)[3889:ipod]LDO_CON2 = 0xc102 (160314_18:16:23.168)[ 272.653831]<0>.(0)[3889:ipod]LDO_VCON1 = 0xc002 (160314_18:16:23.168)[ 272.654408]<0>.(0)[3889:ipod]SPK_CON0 = 0x0 (160314_18:16:23.168)[ 272.654941]<0>.(0)[3889:ipod]SPK_CON1 = 0x0 (160314_18:16:23.238)[ 272.655474]<0>.(0)[3889:ipod]SPK_CON2 = 0x14 (160314_18:16:23.238)[ 272.656018]<0>.(0)[3889:ipod]SPK_CON3 = 0x0 (160314_18:16:23.238)[ 272.656550]<0>.(0)[3889:ipod]SPK_CON4 = 0x0 (160314_18:16:23.238)[ 272.657084]<0>.(0)[3889:ipod]SPK_CON5 = 0x94 (160314_18:16:23.238)[ 272.657627]<0>.(0)[3889:ipod]SPK_CON6 = 0x0 (160314_18:16:23.238)[ 272.658160]<0>.(0)[3889:ipod]SPK_CON7 = 0x4531 (160314_18:16:23.238)[ 272.658725]<0>.(0)[3889:ipod]SPK_CON8 = 0x0 (160314_18:16:23.238)[ 272.659258]<0>.(0)[3889:ipod]SPK_CON9 = 0x2000 (160314_18:16:23.238)[ 272.659823]<0>.(0)[3889:ipod]SPK_CON10 = 0x0 (160314_18:16:23.238)[ 272.660367]<0>.(0)[3889:ipod]SPK_CON11 = 0x0 (160314_18:16:23.238)[ 272.660910]<0>.(0)[3889:ipod]SPK_CON12 = 0x0 (160314_18:16:23.238)[ 272.661454]<0>.(0)[3889:ipod]SPK_CON13 = 0x0 (160314_18:16:23.238)[ 272.661998]<0>.(0)[3889:ipod]SPK_CON14 = 0x0 (160314_18:16:23.238)[ 272.662667]<0>.(0)[3889:ipod]SPK_CON15 = 0x0 (160314_18:16:23.238)[ 272.663212]<0>.(0)[3889:ipod]SPK_CON16 = 0x0 (160314_18:16:23.238)[ 272.663781]<0>.(0)[3889:ipod]SPK_ANA_CON0 = 0x5800 (160314_18:16:23.238)[ 272.664392]<0>.(0)[3889:ipod]SPK_ANA_CON1 = 0x0 (160314_18:16:23.238)[ 272.664968]<0>.(0)[3889:ipod]SPK_ANA_CON3 = 0x0 (160314_18:16:23.238)[ 272.665545]<0>.(0)[3889:ipod]AUDDEC_ANA_CON0 = 0x0 (160314_18:16:23.238)[ 272.666154]<0>.(0)[3889:ipod]AUDDEC_ANA_CON1 = 0x480 (160314_18:16:23.238)[ 272.666785]<0>.(0)[3889:ipod]AUDDEC_ANA_CON2 = 0x1 (160314_18:16:23.238)[ 272.667394]<0>.(0)[3889:ipod]AUDDEC_ANA_CON3 = 0x72 (160314_18:16:23.238)[ 272.668014]<0>.(0)[3889:ipod]AUDDEC_ANA_CON4 = 0x0 (160314_18:16:23.238)[ 272.668623]<0>.(0)[3889:ipod]AUDDEC_ANA_CON5 = 0x5490 (160314_18:16:23.238)[ 272.669264]<0>.(0)[3889:ipod]AUDDEC_ANA_CON6 = 0x1 (160314_18:16:23.238)[ 272.669873]<0>.(0)[3889:ipod]AUDDEC_ANA_CON7 = 0x0 (160314_18:16:23.238)[ 272.670482]<0>.(0)[3889:ipod]AUDDEC_ANA_CON8 = 0x2 (160314_18:16:23.238)[ 272.671091]<0>.(0)[3889:ipod]AUDENC_ANA_CON0 = 0x0 (160314_18:16:23.238)[ 272.671701]<0>.(0)[3889:ipod]AUDENC_ANA_CON1 = 0x0 (160314_18:16:23.238)[ 272.672310]<0>.(0)[3889:ipod]AUDENC_ANA_CON2 = 0x0 (160314_18:16:23.238)[ 272.673226]<0>.(0)[3889:ipod]AUDENC_ANA_CON3 = 0x0 (160314_18:16:23.238)[ 272.673838]<0>.(0)[3889:ipod]AUDENC_ANA_CON4 = 0x800 (160314_18:16:23.238)[ 272.674469]<0>.(0)[3889:ipod]AUDENC_ANA_CON5 = 0x0 (160314_18:16:23.238)[ 272.675078]<0>.(0)[3889:ipod]AUDENC_ANA_CON6 = 0x555 (160314_18:16:23.238)[ 272.675709]<0>.(0)[3889:ipod]AUDENC_ANA_CON7 = 0x0 (160314_18:16:23.238)[ 272.676318]<0>.(0)[3889:ipod]AUDENC_ANA_CON8 = 0x4 (160314_18:16:23.238)[ 272.676927]<0>.(0)[3889:ipod]AUDENC_ANA_CON9 = 0x0 (160314_18:16:23.238)[ 272.677537]<0>.(0)[3889:ipod]AUDENC_ANA_CON10 = 0x0 (160314_18:16:23.238)[ 272.678157]<0>.(0)[3889:ipod]AUDNCP_CLKDIV_CON0 = 0x0 (160314_18:16:23.238)[ 272.678787]<0>.(0)[3889:ipod]AUDNCP_CLKDIV_CON1 = 0x0 (160314_18:16:23.238)[ 272.679418]<0>.(0)[3889:ipod]AUDNCP_CLKDIV_CON2 = 0x2b (160314_18:16:23.238)[ 272.680060]<0>.(0)[3889:ipod]AUDNCP_CLKDIV_CON3 = 0x1 (160314_18:16:23.238)[ 272.680690]<0>.(0)[3889:ipod]AUDNCP_CLKDIV_CON4 = 0x0 (160314_18:16:23.238)[ 272.681321]<0>.(0)[3889:ipod]TOP_CKPDN_CON0 = 0xfefc (160314_18:16:23.238)[ 272.681941]<0>.(0)[3889:ipod]GPIO_MODE3 = 0x249 (160314_18:16:23.238)[ 272.682622]<0>.(0)[3889:ipod]-Ana_Log_Print (160314_18:16:23.238)[ 272.684416]<0>.(0)[3889:ipod][Power/CPU_Thermal]tscpu_thermal_suspend (160314_18:16:23.238)[ 272.685686]<0>.(0)[3889:ipod]* MT auxadc driver suspend!! ******** (160314_18:16:23.238)[ 272.687730]<0>.(0)[3889:ipod]M4UM4U backup in suspend (160314_18:16:23.238)[ 272.688657]<0>.(0)[3889:ipod][ccci1/mcd]ccci_modem_suspend (160314_18:16:23.238)[ 272.689624]<0>.(0)[3889:ipod]kpd: disable kpd work! (160314_18:16:23.238)[ 272.690227]<0>.(0)[3889:ipod]kpd: KEYPAD is disabled (160314_18:16:23.238)[ 272.690846]<0>.(0)[3889:ipod]kpd: kpd_early_suspend wake up source disable!! (1) (160314_18:16:23.238)[ 272.691767]<0>.(0)[3889:ipod]kpd: suspend!! (1) (160314_18:16:23.238)[ 272.697317]<0>.(0)[3889:ipod]Disabling non-boot CPUs ... (160314_18:16:23.238)[ 272.698110]<0>-(0)[3889:ipod][ccci1/mcd]ccci_modem_syssuspend (160314_18:16:23.238)[ 272.698820]<0>-(0)[3889:ipod][HIB/TOI] [toi_go_atomic()]SUCCEEDED @line:489 suspend(1) pm_state(1) (160314_18:16:23.238)[ 272.698820]<0>-(0)[3889:ipod][HIB/TOI] [__save_image()]calling toi_hibernate() (160314_18:16:23.238)[ 272.698820]<0>-(0)[3889:ipod][mt_psci_cpu_suspend] hibernating (160314_18:16:23.699)[ 272.698820]<0>-(0)[3889:ipod][HIB/TOI] [__save_image()]calling toi_end_atomic() toi_in_hibernate(1) temp_result(0) (160314_18:16:23.709)[ 272.698986]<0>-(0)[3889:ipod][ccci1/mcd]ccci_modem_sysresume (160314_18:16:23.709)[ 272.699692]<0>-(0)[3889:ipod][ccci1/mcd]Resume no need reset cldma for md_state=1 (160314_18:16:23.709)[ 272.708025]<0>.(0)[3889:ipod]kpd: kpd_early_suspend wake up source resume!! (0) (160314_18:16:23.709)[ 272.708934]<0>.(0)[3889:ipod]kpd: enable kpd work! (160314_18:16:23.719)[ 272.709530]<0>.(0)[3889:ipod]kpd: KEYPAD is enabled (160314_18:16:23.719)[ 272.710137]<0>.(0)[3889:ipod]kpd: resume!! (0) (160314_18:16:23.719)[ 272.710962]<0>.(0)[3889:ipod][ccci1/mcd]ccci_modem_resume (160314_18:16:23.719)[ 272.711944]<0>.(0)[3889:ipod]M4UM4U restore in resume (160314_18:16:23.719)[ 272.713739]<0>.(0)[3889:ipod]* MT auxadc driver resume!! ******** (160314_18:16:23.719)[ 272.714611]<0>.(0)[3889:ipod]x_uart_switch_to_rx port:0x0 (160314_18:16:23.719)[ 272.715310]<0>-(0)[3889:ipod][GPIO] 513: modebefore1 set pin[74],addr=370,(ffffff8000036000,ffffff8000036370) (160314_18:16:23.719)[ 272.716572]<0>-(0)[3889:ipod][GPIO] 543: mt_set_gpio_mode_base:pin:74, mode:1, value:0xc91249 (160314_18:16:23.719)[ 272.717676]<0>-(0)[3889:ipod]No Flow Control (160314_18:16:23.719)[ 272.718210]<0>.(0)[3889:ipod][UART0] Resume(0)! (160314_18:16:23.719)[ 272.718807]<0>.(0)[3889:ipod]x_uart_switch_to_rx port:0x1 (160314_18:16:23.719)[ 272.719503]<0>-(0)[3889:ipod][GPIO] 513: modebefore1 set pin[76],addr=370,(ffffff8000036000,ffffff8000036370) (160314_18:16:23.719)[ 272.720765]<0>-(0)[3889:ipod][GPIO] 543: mt_set_gpio_mode_base:pin:76, mode:1, value:0xc91249 (160314_18:16:23.719)[ 272.721852]<0>.(0)[3889:ipod][UART1] Resume(0)! (160314_18:16:23.719)[ 272.722907]<0>.(0)[3889:ipod]x_uart_switch_to_rx port:0x2 (160314_18:16:23.719)[ 272.723604]<0>-(0)[3889:ipod][GPIO] 513: modebefore1 set pin[57],addr=350,(ffffff8000036000,ffffff8000036350) (160314_18:16:23.719)[ 272.724866]<0>-(0)[3889:ipod][GPIO] 543: mt_set_gpio_mode_base:pin:57, mode:1, value:0x2481249 (160314_18:16:23.719)[ 272.725994]<0>.(0)[3889:ipod][UART2] Resume(0)! (160314_18:16:23.719)[ 272.726594]<0>.(0)[3889:ipod]x_uart_switch_to_rx port:0x3 (160314_18:16:23.719)[ 272.727284]<0>.(0)[3889:ipod]GPIO_UART_URXD3_PIN is not properly set p2 (160314_18:16:23.719)[ 272.728114]<0>.(0)[3889:ipod][UART3] Resume(0)! (160314_18:16:23.719)[ 272.728711]<0>.(0)[3889:ipod]x_uart_switch_to_rx port:0x4 (160314_18:16:23.719)[ 272.729406]<0>.(0)[3889:ipod][UART4] Resume(0)! (160314_18:16:23.719)[ 272.730217]<0>.(0)[3889:ipod][Power/CPU_Thermal]tscpu_thermal_resume (160314_18:16:23.719)[ 272.731290]<0>.(0)[3889:ipod]thermal_direct_mode_config(en:0x0,mode:0x1) (160314_18:16:23.719)[ 272.732138]<0>.(0)[3889:ipod]thermal_direct_mode_config(en:0x1,mode:0x1) (160314_18:16:23.719)[ 272.733067]<0>-(0)[3889:ipod][PTP] base_ops_init02(PTP_DET_CPU) start (ptp_level = 0x00000000). (160314_18:16:23.719)[ 272.734149]<0>-(0)[3889:ipod][PTP] DCVOFFSETIN = 0xFFFFFDDD (160314_18:16:23.719)[ 272.734842]<0>-(0)[3889:ipod][PTP] AGEVOFFSETIN = 0x00000000 (160314_18:16:23.719)[ 272.735556]<0>-(0)[3889:ipod][PTP] base_ops_set_phase(PTP_DET_CPU) start (phase = 1). (160314_18:16:23.719)[ 272.736784]<0>-(0)[3889:ipod][PTP] base_ops_mon_mode(PTP_DET_CPU) start (ptp_level = 0x00000000). (160314_18:16:23.719)[ 272.737889]<0>-(0)[3889:ipod][Power/CPU_Thermal]ts_MTS=513, ts_BTS=1766 (160314_18:16:23.719)[ 272.739428]<0>-(0)[3889:ipod][PTP] base_ops_set_phase(PTP_DET_CPU) start (phase = 2). (160314_18:16:23.719)[ 272.740415]<0>-(0)[3889:ipod][ISR DURATION WARN] IRQ[157:ptp], dur:3876000 ns > 3 ms,(s:272736527322,e:272740403322) (160314_18:16:23.719)[ 272.743211]x_pm_ops_suspend_ipox_routing_pm_ops_suspend (160314_18:16:23.719)[ 272.745397]<0>.(0)[3889:ipod]wxy calling xfb_pm_resume start. (160314_18:16:23.719)[ 272.746140]<0>.(0)[3889:ipod]wxy calling xfb_pm_resume exit. (160314_18:16:23.719)[ 272.746878]<0>.(0)[3889:ipod]wxy calling xfb_resume start. (160314_18:16:23.719)[ 272.747594]<0>.(0)[3889:ipod]DISP/xFB [FB Driver] xfb_resume() (160314_18:16:23.719)[ 272.748364]<0>.(0)[3889:ipod]wxy calling xfb_resume exit. (160314_18:16:23.719)[ 272.749785]<0>.(0)[3889:ipod][PMIC] * MT pmic driver resume!! ******** (160314_18:16:23.719)[ 272.751799]<0>.(0)[3889:ipod][PMIC] Reg[0xec2]=0x8a12, Reg[0xec4]=0xb9a1, Reg[0x2ac]=0x28f (160314_18:16:23.719)[ 272.754451]<0>.(0)[3889:ipod][PMIC] Reg[0xcd2]=0xd7b3, Reg[0xcd4]=0xd096, Reg[0x2b8]=0xb40 (160314_18:16:23.719)[ 272.756283]<0>.(0)[3889:ipod][HPS] hps_restore (160314_18:16:23.719)[ 272.756838]<0>.(0)[3889:ipod][HPS] state: 1, enabled: 0, early_suspend_enabled: 1, suspend_enabled: 1, rush_boost_enabled: 0 (160314_18:16:23.789)[ 272.761639]<0>.(0)[3889:ipod][Gsensor] set interrupt:reg_mode:=41, Enable mode = 0 (160314_18:16:23.789)[ 272.762647]<0>-(0)[3889:ipod][GPIO] 513: modebefore1 set pin[66],addr=360,(ffffff8000036000,ffffff8000036360) (160314_18:16:23.789)[ 272.763910]<0>-(0)[3889:ipod][GPIO] 543: mt_set_gpio_mode_base:pin:66, mode:0, value:0x11400000 (160314_18:16:23.789)[ 272.767678]<0>.(0)[3889:ipod][Gsensor] mc3xxx int flag =41 (160314_18:16:23.789)[ 272.768953]<0>.(0)[3889:ipod][Gsensor] [MC3XXX_ConfigRegRange] set 0x0 (160314_18:16:23.789)[ 272.770359]<0>.(0)[3889:ipod][Gsensor] MC3XXX_Init[ 272.771566]<0>.(0)[3889:ipod][Gsensor] MC3XXX_SetResolution[ 272.772282]<0>.(0)[3889:ipod][Gsensor] [MC3XXX_SetResolution] s_bResolution: 2 (160314_18:16:23.789)[ 272.773685]<0>.(0)[3889:ipod][Gsensor] MC3XXX_SetSampleRate[ 272.776796]<0>.(0)[3889:ipod][Gsensor] [MC3XXX_ConfigRegRange] set 0x0 (160314_18:16:23.789)[ 272.777611]<0>.(0)[3889:ipod][Gsensor] [MC3XXX_SetGain] gain: 1024 / 1024 / 1024 (160314_18:16:23.789)[ 272.780572]<0>.(0)[3889:ipod][Gsensor] [MC3XXX_Init] init ok. (160314_18:16:23.789)[ 272.781286]<0>.(0)[3889:ipod][Gsensor] Sensor power status should not be set again!!! (160314_18:16:23.789)[ 272.783164]<0>.(0)[3889:ipod][Gsensor] set power read MC3XXX_REG_MODE_FEATURE =43 (160314_18:16:23.789)[ 272.785099]<0>.(0)[3889:ipod][battery_meter_resume] sleep time = 12, g_spm_timer = 639 (160314_18:16:23.789)[ 272.787315]<0>.(0)[3889:ipod]usb usb1: usb_resume_both: READY TO RESUME BOTH (160314_18:16:23.789)[ 272.788191]x_ICUSB [DBG], <usb_resume_device(), 1131> (160314_18:16:23.789)[ 272.788836]<0>.(0)[3889:ipod]x_ICUSB [DBG], <generic_resume(), 253> udev : 18446743799732224000x_ICUSB [DBG], <generic_resume(), 262> udev : 18446743799732224000 (160314_18:16:23.789)[ 272.790703]x_ICUSB [DBG], <usb_resume_device(), 1134> (160314_18:16:23.789)[ 272.791454]<0>-(0)[3889:ipod][MUSB]musb_readb 122: [MUSB]:access musb_readb function when usb clock is off 0x60 (160314_18:16:23.789)[ 272.792738]<0>-(0)[3889:ipod][MUSB]musb_hub_control 364: port status 00000100,devctl=0x99 (160314_18:16:23.789)[ 272.796442]<0>.(0)[3889:ipod]wxy userui_prepare_status:314[ 272.797160]<0>.(0)[3889:ipod]wxy userui_prepare_status:322[ 272.797873]<0>.(0)[3889:ipod]Post atomic. (160314_18:16:23.789)[ 272.798374]<0>.(0)[3889:ipod]wxy __save_image:831[ 272.798992]<0>.(0)[3889:ipod][HIB/TOI] [__save_image()]@line:832 (160314_18:16:23.789)[ 272.800456]<0>.(0)[3889:ipod]wxy __save_image:839[ 272.801074]<0>.(0)[3889:ipod]wxy userui_message:256[ 272.801740]<0>.(0)[3889:ipod]wxy userui_message:278[ 272.802437]<0>.(0)[3889:ipod]wxy [__save_image:842] write_pageset(&pagedir1) (160314_18:16:23.789)[ 272.803316]<0>.(0)[3889:ipod][HIB/TOI] [write_pageset()]start to writing kernel & process data... (160314_18:16:23.789)[ 272.804421]<0>.(0)[3889:ipod]wxy userui_prepare_status:314[ 272.805136]<0>.(0)[3889:ipod]wxy userui_prepare_status:322[ 272.805851]<0>.(0)[3889:ipod]Writing kernel & process data... (160314_18:16:23.789)[ 272.815925]<0>.(0)[133:mmcqd/0][BLOCK_TAG] MMC Queue Thread:133, 135, 134, 0, 0 (160314_18:16:23.789)[ 272.816845]<0>.(0)[133:mmcqd/0][BLOCK_TAG] MMC CID: 0 0 0 0 (160314_18:16:23.789)[ 272.817552]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=41%, duty 375023308, period 910108000, req_cnt=9 (160314_18:16:23.789)[ 272.818810]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=9, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:23.789)[ 272.820306]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=8355 kB/s, size: 3133440 bytes, time:375 ms (160314_18:16:23.789)[ 272.821588]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:23.872)[ 272.862685]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00419:00004:00016384:00000:00000000}{00791:00006:00024576:00000:00000000}{02450:00003:00012288:00000:00000000} (160314_18:16:23.872)[ 272.864571]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:24.308)[ 273.357753]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=85%, duty 462807153, period 541819400, req_cnt=30 (160314_18:16:24.338)[ 273.359032]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=30, break_cnt=0, tract_cnt=2, bit_cnt=0 (160314_18:16:24.338)[ 273.360538]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=8803 kB/s, size: 4067328 bytes, time:462 ms (160314_18:16:24.338)[ 273.361819]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:24.338)[ 273.363189]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {02450:00015:00061440:00000:00000000}{00418:00002:00008192:00000:00000000} (160314_18:16:24.338)[ 273.364761]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:24.909)[ 273.904833]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=99%, duty 542020230, period 547084300, req_cnt=14 (160314_18:16:24.919)[ 273.906106]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=14, break_cnt=0, tract_cnt=2, bit_cnt=0 (160314_18:16:24.919)[ 273.907612]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=8290 kB/s, size: 4493312 bytes, time:542 ms (160314_18:16:24.919)[ 273.908894]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:24.919)[ 273.910023]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00418:00007:00028672:00000:00000000}{02450:00007:00028672:00000:00000000} (160314_18:16:24.919)[ 273.911498]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:25.445)[ 274.433783]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=99%, duty 525124847, period 528950300, req_cnt=10 (160314_18:16:25.445)[ 274.435132]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=10, break_cnt=0, tract_cnt=5, bit_cnt=0 (160314_18:16:25.445)[ 274.436639]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7138 kB/s, size: 3747840 bytes, time:525 ms (160314_18:16:25.445)[ 274.437920]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:25.445)[ 274.439050]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00418:00005:00020480:00000:00000000}{02450:00005:00020480:00000:00000000} (160314_18:16:25.445)[ 274.440524]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:25.893)[ 274.933956]WXY ...20% (160314_18:16:25.971)[ 274.980806]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=93%, duty 512993386, period 547018000, req_cnt=8 (160314_18:16:25.971)[ 274.982075]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=8, break_cnt=0, tract_cnt=3, bit_cnt=0 (160314_18:16:25.971)[ 274.983761]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=5624 kB/s, size: 2879488 bytes, time:512 ms (160314_18:16:25.971)[ 274.985142]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:25.971)[ 274.986347]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00418:00004:00016384:00000:00000000}{02450:00004:00016384:00000:00000000} (160314_18:16:25.971)[ 274.987824]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:26.549)[ 275.546181]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=103%, duty 583887537, period 565376200, req_cnt=10 (160314_18:16:26.549)[ 275.547471]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=10, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:26.549)[ 275.548979]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=6049 kB/s, size: 3526656 bytes, time:583 ms (160314_18:16:26.549)[ 275.550260]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:26.549)[ 275.551391]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00418:00005:00020480:00000:00000000}{02450:00005:00020480:00000:00000000} (160314_18:16:26.549)[ 275.553342]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:27.129)WXY ...40%[ 276.165452]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=97%, duty 604914385, period 619271000, req_cnt=12 (160314_18:16:27.129)[ 276.166731]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=12, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:27.129)[ 276.168266]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=6903 kB/s, size: 4169728 bytes, time:604 ms (160314_18:16:27.129)[ 276.169548]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:27.129)[ 276.170679]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00418:00006:00024576:00000:00000000}{02450:00006:00024576:00000:00000000} (160314_18:16:27.129)[ 276.172154]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:27.725)[ 276.756952]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=100%, duty 597215306, period 591498900, req_cnt=12 (160314_18:16:27.725)[ 276.758243]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=12, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:27.725)[ 276.759750]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=6970 kB/s, size: 4161536 bytes, time:597 ms (160314_18:16:27.725)[ 276.761032]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:27.725)[ 276.762163]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00418:00006:00024576:00000:00000000}{02450:00006:00024576:00000:00000000} (160314_18:16:27.725)[ 276.764125]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:28.255)[ 277.288459]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=105%, duty 558837770, period 531506900, req_cnt=11 (160314_18:16:28.255)[ 277.289751]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:28.255)[ 277.291258]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=6606 kB/s, size: 3686400 bytes, time:558 ms (160314_18:16:28.255)[ 277.293029]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:28.255)[ 277.294259]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00418:00006:00024576:00000:00000000}{02450:00005:00020480:00000:00000000} (160314_18:16:28.255)[ 277.295807]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:28.808)[ 277.822285]<0>.(0)[133:mmcqd/0][BLOCK_TAG] MMC Queue Thread:133, 135, 134, 0, 0 (160314_18:16:28.808)[ 277.823486]<0>.(0)[133:mmcqd/0][BLOCK_TAG] MMC CID: 0 0 0 0 (160314_18:16:28.808)[ 277.824294]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=98%, duty 528408074, period 533829600, req_cnt=12 (160314_18:16:28.808)[ 277.825640]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=12, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:28.808)[ 277.827148]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7811 kB/s, size: 4124672 bytes, time:528 ms (160314_18:16:28.808)[ 277.828429]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:28.808)[ 277.829560]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {02450:00006:00024576:00000:00000000}{00418:00006:00024576:00000:00000000} (160314_18:16:28.808)[ 277.831036]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:29.304)WXY ...80%[ 278.364352]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=87%, duty 473797386, period 542068300, req_cnt=11 (160314_18:16:29.305)[ 278.365703]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=11, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:29.306)[ 278.367212]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=8295 kB/s, size: 3923968 bytes, time:473 ms (160314_18:16:29.306)[ 278.368493]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:29.306)[ 278.369624]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {02450:00006:00024576:00000:00000000}{00418:00005:00020480:00000:00000000} (160314_18:16:29.306)[ 278.371100]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:29.911)[ 278.909189]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=110%, duty 603576308, period 544831800, req_cnt=12 (160314_18:16:29.911)[ 278.910481]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=12, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:29.911)[ 278.911988]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=6874 kB/s, size: 4145152 bytes, time:603 ms (160314_18:16:29.911)[ 278.913533]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:29.911)[ 278.914763]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00418:00006:00024576:00000:00000000}{02450:00006:00024576:00000:00000000} (160314_18:16:29.911)[ 278.916311]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:30.423)[ 279.409843]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=98%, duty 493548540, period 500653600, req_cnt=10 (160314_18:16:30.423)[ 279.411123]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=10, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:30.423)[ 279.413206]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=7086 kB/s, size: 3493888 bytes, time:493 ms (160314_18:16:30.423)[ 279.414588]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:30.423)[ 279.415794]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00418:00005:00020480:00000:00000000}{02450:00005:00020480:00000:00000000} (160314_18:16:30.423)[ 279.417271]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:30.868)[ 279.903602]<0>.(0)[3889:ipod]wxy write_pageset:959[ 279.904250]<0>.(0)[3889:ipod][HIB/TOI] [write_pageset()]@line:961 return value(0) (160314_18:16:30.868)[ 279.910404]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Workload=104%, duty 521129769, period 500567600, req_cnt=25 (160314_18:16:30.868)[ 279.911686]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Diversity=0 sectors offset, req_cnt=10, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:30.868)[ 279.913675]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Read Diversity=771516 sectors offset, req_cnt=15, break_cnt=0, tract_cnt=0, bit_cnt=0 (160314_18:16:30.868)[ 279.915323]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Write Throughput=6317 kB/s, size: 3272704 bytes, time:518 ms (160314_18:16:30.868)[ 279.916668]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd:133 Read Throughput=30720 kB/s, size: 61440 bytes, time:2 ms (160314_18:16:30.868)[ 279.917905]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd metarw WR:0 NWR:0 HR:0 WDR:0 HDR:0 WW:0 NWW:0 HW:0 (160314_18:16:30.868)[ 279.919038]<0>.(0)[133:mmcqd/0][BLOCK_TAG] mmcqd pid:133 {00418:00004:00016384:00000:00000000}{02450:00004:00016384:00000:00000000}{03889:00000:00000000:00015:00061440} (160314_18:16:30.868)[ 279.920914]<0>.(0)[133:mmcqd/0][BLOCK_TAG] vmstat (FP:115224)(FD:0)(ND:130976)(WB:0)(NW:138468) (160314_18:16:30.953)[ 279.930992]<0>.(0)[3889:ipod]WXY [toi_bio_mark_have_image:138] toi_sig_data->resumed_before=0 (160314_18:16:30.953)[ 279.933718]<0>.(0)[3889:ipod]WXY toi_try_hibernate:1289[ 279.934420]<0>.(0)[3889:ipod]WXY [toi_try_hibernate:1309] result = 0, toi_in_hibernate=1 (160314_18:16:30.953)[ 279.935425]<0>.(0)[3889:ipod]WXY toi_try_hibernate:1313[ 279.936107]<0>.(0)[3889:ipod]WXY do_post_image_write:738[ 279.936801]<0>.(0)[3889:ipod]WXY do_post_image_write:743[ 279.937495]<0>.(0)[3889:ipod]WXY toi_power_down:262[ 279.938141]<0>.(0)[3889:ipod]CPU: 0 PID: 3889 Comm: ipod Tainted: G W 3.10.65 #5 (160314_18:16:30.953)[ 279.939166]<0>.(0)[3889:ipod]Call trace: (160314_18:16:30.953)[ 279.939664]<0>.(0)[3889:ipod][] dump_backtrace+0x0/0x130 (160314_18:16:30.953)[ 279.940522]<0>.(0)[3889:ipod][] show_stack+0x10/0x1c (160314_18:16:30.953)[ 279.941338]<0>.(0)[3889:ipod][] dump_stack+0x1c/0x28 (160314_18:16:30.953)[ 279.942154]<0>.(0)[3889:ipod][] __toi_power_down+0x20/0x1e8 (160314_18:16:30.953)[ 279.943384]<0>.(0)[3889:ipod][] toi_power_down+0x2c/0x3c (160314_18:16:30.953)[ 279.944244]<0>.(0)[3889:ipod][] do_post_image_write+0x48/0x60 (160314_18:16:30.953)[ 279.945156]<0>.(0)[3889:ipod][] toi_try_hibernate+0x2b4/0x2d4 (160314_18:16:30.953)[ 279.946067]<0>.(0)[3889:ipod][] try_tuxonice_hibernate+0x18/0x2c (160314_18:16:30.953)[ 279.947012]<0>.(0)[3889:ipod][] hibernate+0x12c/0x270 (160314_18:16:30.953)[ 279.947841]<0>.(0)[3889:ipod][] x_hibernate+0x10/0x14c (160314_18:16:30.953)[ 279.948698]<0>.(0)[3889:ipod][] state_store+0x148/0x1c8 (160314_18:16:30.953)[ 279.949544]<0>.(0)[3889:ipod][] kobj_attr_store+0x10/0x24 (160314_18:16:30.953)[ 279.950414]<0>.(0)[3889:ipod][] sysfs_write_file+0xdc/0x15c (160314_18:16:30.953)[ 279.951305]<0>.(0)[3889:ipod][] vfs_write+0xa4/0x18c (160314_18:16:30.953)[ 279.952119]<0>.(0)[3889:ipod][] SyS_write+0x40/0x8c (160314_18:16:30.953)[ 279.953083]<0>.(0)[3889:ipod]WXY __toi_power_down:62[ 279.953729]<0>.(0)[3889:ipod]WXY __toi_power_down:67[ 279.954380]<0>.(0)[3889:ipod]WXY [__toi_power_down:72] method=0 (160314_18:16:30.953)[ 279.955117]<0>.(0)[3889:ipod]WXY __toi_power_down:124[ 279.956226]<0>.(0)[3889:ipod]* battery driver shutdown!! ******** (160314_18:16:30.953)[ 279.957058]<0>.(0)[3889:ipod]battery_meter_shutdown[ 279.959239]<0>.(0)[3889:ipod][LED]mt65xx_leds_shutdown (160314_18:16:30.953)[ 279.959872]<0>.(0)[3889:ipod][LED]mt65xx_leds_shutdown: turn off backlight (160314_18:16:30.953)[ 279.960729]<0>.(0)[3889:ipod][LED]backlight control through BLS!!1 (160314_18:16:30.953)[ 279.961918]<0>.(0)[3889:ipod][MUSB]musb_shutdown 1378: shut down (160314_18:16:30.953)[ 279.962771]<0>-(0)[3889:ipod][MUSB]musb_writeb 138: [MUSB]:access musb_writeb function when usb clock is off 0xB (160314_18:16:30.953)[ 279.964099]<0>-(0)[3889:ipod][MUSB]musb_writew 90: [MUSB]:access musb_writew function when usb clock is off 0x6 (160314_18:16:30.953)[ 279.965413]<0>-(0)[3889:ipod][MUSB]musb_writew 90: [MUSB]:access musb_writew function when usb clock is off 0x8 (160314_18:16:30.953)[ 279.966726]<0>-(0)[3889:ipod][MUSB]musb_writew 90: [MUSB]:access musb_writew function when usb clock is off 0x4 (160314_18:16:30.953)[ 279.968040]<0>-(0)[3889:ipod][MUSB]musb_writew 90: [MUSB]:access musb_writew function when usb clock is off 0x2 (160314_18:16:30.953)[ 279.969354]<0>-(0)[3889:ipod][MUSB]musb_writeb 138: [MUSB]:access musb_writeb function when usb clock is off 0xA (160314_18:16:30.953)[ 279.970641]<0>-(0)[3889:ipod][MUSB]mt_usb_disable 337: <0,0>,<3,5,3,3> (160314_18:16:30.953)[ 279.971491]<0>-(0)[3889:ipod][MUSB]musb_writeb 138: [MUSB]:access musb_writeb function when usb clock is off 0x60 (160314_18:16:30.953)[ 279.973291]<0>.(0)[3889:ipod][PMIC] * MT pmic driver shutdown!! ******** (160314_18:16:30.953)[ 279.974302]<0>.(0)[3889:ipod]DISP/xFB [FB Driver] xfb_shutdown() (160314_18:16:31.031)[ 280.023214]<0>.(0)[3889:ipod]DISP/xFB xfb has been power off (160314_18:16:31.031)[ 280.023977]<0>.(0)[3889:ipod]JPEG Codec shutdown (160314_18:16:31.031)[ 280.024769]<0>.(0)[3889:ipod][gps]null pointer!! (160314_18:16:31.031)[ 280.025372]<0>.(0)[3889:ipod]mt_pwm_shutdown (160314_18:16:31.031)[ 280.025914]<0>.(0)[3889:ipod]* MT auxadc driver shutdown!! ******** (160314_18:16:31.031)[ 280.026850]<0>.(0)[3889:ipod]* x WDT driver shutdown!! ******** (160314_18:16:31.031)[ 280.027744]<0>.(0)[3889:ipod]******** x WDT driver shutdown done ******** (160314_18:16:31.031)[ 280.028783]<0>.(0)[3889:ipod]Power down. (160314_18:16:31.031)[ 280.029270]<0>-(0)[3889:ipod]machine_shutdown: start, Proess(ipod:3889). father init:1. grandfather swapper/0:0. (160314_18:16:31.733)[ 280.730731]<0>-(0)[3889:ipod]ram_console: save kernel log (0x10000) to emmc! (160314_18:16:31.733)[ 280.731603]<0>-(0)[3889:ipod]mt_power_off (160314_18:16:31.733)[ 280.732429]<0>-(0)[3889:ipod]Phone with charger (160314_18:16:31.733)[ 280.732996]<0>-(0)[3889:ipod][pmic_chrdet_status] No charger (160314_18:16:31.733)[

Mar 14 '16 10:03 wangxy0929

Dear nigel： because of confidential information of company, i can not send the attachment to you, so we only paste the log to here , please understand.

Mar 14 '16 10:03 wangxy0929

Dear Nigel： can you provider some clues to me ,thanks

Mar 15 '16 01:03 wangxy0929

tuxonice-kernel-old tuxonice-kernel-old copied to clipboard

when it is hibernating,how to cancel hibernating?

tuxonice-kernel-old
tuxonice-kernel-old copied to clipboard