[Android] blank sd card format issue on BSP 4.2.2

[charleshuang]

Hi,

We find a sd card format issue on BSP 4.2.2. This issue can be also reproduced on Freescale demo board.

The reproduce steps are as follows.

1. Insert a unformat SD card. For example, use 'fdisk' to delete all the partitions on SD card first, and then just insert into Android system.

2. It will show "blank sd card" notification at left-top corner.

3. Click the notification and it will pop up a dialog to tell you can format this sd card.

4. Click to "Format"

After that, the system will crash.

Here is the logcat for reference.

===

06-05 07:30:30.854 I/ActivityManager( 2509): START u0 {cmp=com.android.systemui/com.android.internal.app.ExternalMediaFormatActivity bnds=[48,76][528,140]} from pid -1

06-05 07:30:30.854 W/ActivityManager( 2509): startActivity called from non-Activity context; forcing Intent.FLAG_ACTIVITY_NEW_TASK for: Intent { flg=0x800000 cmp=com.android.systemui/com.android.internal.app.ExternalMediaFormatActivity bnds=[48,76][528,140] }

06-05 07:30:30.864 W/KeyguardViewMediator( 2509): verifyUnlock called when not externally disabled

06-05 07:30:30.874 D/ExternalMediaFormatActivity( 2634): onCreate!

06-05 07:30:30.964 E/BufferQueue( 2220): [com.android.systemui/com.android.internal.app.ExternalMediaFormatActivity] dequeueBuffer: can't dequeue multiple buffers without setting the buffer count

06-05 07:30:31.034 I/ActivityManager( 2509): Displayed com.android.systemui/com.android.internal.app.ExternalMediaFormatActivity: +162ms

06-05 07:30:31.164 D/PhoneStatusBar( 2634): disable: < expand icons* alerts ticker* system_info back home recent clock* search >

06-05 07:30:33.934 W/audio_hw_primary( 2223): do_out_standby... 1075713192

06-05 07:30:34.434 W/audio_hw_primary( 2223): hdmi: card 1, port 0 device 0x400

06-05 07:30:34.434 W/audio_hw_primary( 2223): rate 44100, channel 2 period_size 0x300

06-05 07:30:34.444 W/dalvikvm( 2509): threadid=11: thread exiting with uncaught exception (group=0x417bf930)

06-05 07:30:34.444 W/MountService( 2509): getVolumeState(/storage/emulated/legacy): Unknown volume

06-05 07:30:34.494 D/dalvikvm( 2509): GC_CONCURRENT freed 252K, 54% free 4762K/10328K, paused 3ms+5ms, total 52ms

06-05 07:30:34.494 D/dalvikvm( 2509): WAIT_FOR_CONCURRENT_GC blocked 42ms

06-05 07:30:34.494 D/dalvikvm( 2509): WAIT_FOR_CONCURRENT_GC blocked 43ms

06-05 07:30:34.494 E/AndroidRuntime( 2509): *** FATAL EXCEPTION IN SYSTEM PROCESS: android.server.ServerThread

06-05 07:30:34.494 E/AndroidRuntime( 2509): java.lang.RuntimeException: binder: release 2509:2509 transaction 25160 in, still active

Unable to start service com.androbinder: send failed reply for transaction 25160 to 2860:2860

id.internal.os.storage.ExternalStbinder: release 2509:2749 transaction 25127 in, still active

orageFormatter@41cb5f00 with Intebinder: send failed reply for transaction 25127 to 2634:2634

nt { act=com.android.internal.os.storage.FORMAT_ONLY cmp=android/com.android.internal.os.storage.ExternalStorageFormatter }: java.lang.IllegalArgumentException

06-05 07:30:34.494 E/AndroidRuntime( 2509):     at android.app.ActivityThread.handleServiceArgs(Actbinder: 2634:2634 transaction failed 29189, size 104-4

ivityThread.java:2673)

06-05 07:30:34.494 E/AndroidRuntime( 2509):     at android.app.ActivityThread.access$1900(ActivityThread.javbinder: 2860:2860 transaction failed 29189, size 276-8

a:141)

06-05 07:30:34.494 E/AndroidRuntime( 2509):     at android.app.ActivityThread$H.handleMessage(ActivityThread.java:1331)

06-05 07:30:34.494 E/AndroidRuntime( 2509):     at android.os.Handler.dispatchMessage(Handler.java:99)

06-05 07:30:34.494 E/AndroidRuntime( 2509):     at android.os.Looper.loop(Looper.java:137)

06-05 07:30:34.494 E/AndroidRuntime( 2509):     at com.android.server.ServerThread.run(SystemServer.java:1010)

06-05 07:30:34.494 E/AndroidRuntime( 2509): Caused by: java.lang.IllegalArgumentException

06-05 07:30:34.494 E/AndroidRuntime( 2509):     at com.android.server.MountService.getVolumeState(MountService.java:1499)

06-05 07:30:34.494 E/AndroidRuntime( 2509):     at com.android.server.MountService.unmountVolume(MountService.java:1523)

06-05 07:30:34.494 E/AndroidRuntime( 2509):     at com.android.internal.os.storage.ExternalStorageFormatter.updateProgressState(ExternalStorageFormatter.java:156)

06-05 07:30:34.494 E/AndroidRuntime( 2509):     at com.android.internal.os.storage.ExternalStorageFormatter.onStartCommand(ExternalStorageFormatter.java:97)

06-05 07:30:34.494 E/AndroidRuntime( 2509):     at android.app.ActivityThread.handleServiceArgs(ActivityThread.java:2656)

06-05 07:30:34.494 E/AndroidRuntime( 2509):     ... 5 more

===

Thanks,

Daniel

[Bio_TICFSL · Accepted solution]

This can be closed

[danielhung]

Hello Freescale,

Does any one can support this issue?

Thanks!

[PeterChan]

Hello Daniel,

The exception is caused by the Android attempts to format an invalid volume. Attached is my patch to solve this issue. Would you please take a try?

Thanks,

Peter

[weikeng-jimmy]

Hi Sir,

Thanks , it's can fix the issue.