| Issue 149: | Stock Music Player Skips When Starting Track | |
| 2 people starred this issue and may be notified of changes. | Back to list |
What steps will reproduce the problem? 1. Open Music application 2. Turn on shuffle mode 3. Press play 4. Listen for stuttering in first 15 seconds of track. What kernel are you running? 2.6.35.10-perf+cm9 mcostea@mcostea #1 It would really help if you could provide a logcat when the problem occurs. * Grab aLogcat: https://play.google.com/store/apps/details?id=org.jtb.alogcat&hl=en * Reproduce the problem * Open aLogcat and save the logcat * Attach it here: --------- beginning of /dev/log/system W/InputManagerService( 176): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@411255a0 --------- beginning of /dev/log/main I/AudioService( 176): AudioFocus abandonAudioFocus() from android.media.AudioManager@4145a7c0 I/AudioService( 176): AudioFocus requestAudioFocus() from android.media.AudioManager@41136118com.android.music.MediaPlaybackService$3@411350b8 I/AudioService( 176): Remote Control registerMediaButtonIntent() for PendingIntent{41395b78: PendingIntentRecord{415df960 com.android.music broadcastIntent}} D/lastfm.db.t_scrobblerqueue( 7991): SELECT * FROM t_scrobblerqueue WHERE CurrentTrack=1 W/AppWidgetService( 176): updateAppWidgetProvider: provider doesn't exist: ComponentInfo{fm.last.android/fm.last.android.RadioWidgetProvider} I/scrobbler( 7991): Duration was unavailable, looking it up! D/lastfm.db.t_scrobblerqueue( 7991): SELECT count(*) FROM t_scrobblerqueue WHERE CurrentTrack=0 D/lastfm.db.t_scrobblerqueue( 7991): Found 0 entries I/AudioHardwareMSM72XX( 105): set device to SND_DEVICE_SPEAKER device_id=0 I/AudioHardwareMSM72XX( 105): Enabling post proc features with mask 0x0000 W/System.err( 7991): java.lang.NoSuchFieldException: priority W/System.err( 7991): at java.lang.Class.getField(Class.java:787) W/System.err( 7991): at fm.last.android.scrobbler.ScrobblerService.handleIntent(ScrobblerService.java:613) W/System.err( 7991): at fm.last.android.scrobbler.ScrobblerService$IntentFromMediaDBTask.onPostExecute(ScrobblerService.java:699) W/System.err( 7991): at fm.last.android.scrobbler.ScrobblerService$IntentFromMediaDBTask.onPostExecute(ScrobblerService.java:1) W/System.err( 7991): at fm.last.android.utils.AsyncTaskEx.finish(AsyncTaskEx.java:420) W/System.err( 7991): at fm.last.android.utils.AsyncTaskEx.access$0(AsyncTaskEx.java:419) W/System.err( 7991): at fm.last.android.utils.AsyncTaskEx$InternalHandler.handleMessage(AsyncTaskEx.java:432) W/System.err( 7991): at android.os.Handler.dispatchMessage(Handler.java:99) W/System.err( 7991): at android.os.Looper.loop(Looper.java:137) W/System.err( 7991): at android.app.ActivityThread.main(ActivityThread.java:4424) W/System.err( 7991): at java.lang.reflect.Method.invokeNative(Native Method) W/System.err( 7991): at java.lang.reflect.Method.invoke(Method.java:511) W/System.err( 7991): at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:784) W/System.err( 7991): at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:551) W/System.err( 7991): at dalvik.system.NativeStart.main(Native Method) D/dalvikvm( 245): GC_CONCURRENT freed 1864K, 57% free 7436K/17159K, paused 5ms+9ms W/InputManagerService( 176): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@414959f8 D/lastfm.db.t_scrobblerqueue( 7991): SELECT count(*) FROM t_scrobblerqueue WHERE CurrentTrack=0 D/lastfm.db.t_scrobblerqueue( 7991): Found 0 entries D/lastfm.db.t_scrobblerqueue( 7991): DELETE FROM t_scrobblerqueue WHERE CurrentTrack=1 D/lastfm.db.t_scrobblerqueue( 7991): Inserted/replaced row with values PostedNowPlaying=true Loved=false Rating= Duration=195840 StartTime=1354956027 Artist=Ok Go TrackAuth= Title=Maybe, This Time Album=Oh No CurrentTrack=true I/ActivityManager( 176): START {act=com.android.music.PLAYBACK_VIEWER flg=0x10000000 cmp=com.android.music/.MediaPlaybackActivity bnds=[0,190][320,254]} from pid -1 W/KeyguardViewMediator( 176): verifyUnlock called when not externally disabled W/InputManagerService( 176): Starting input on non-focused client com.android.internal.view.IInputMethodClient$Stub$Proxy@414b6910 (uid=10007 pid=8009) V/PhoneStatusBar( 245): setLightsOn(true) I/ActivityManager( 176): Displayed com.android.music/.MediaPlaybackActivity: +476ms I/OMXCodec( 105): Attempting to allocate OMX node 'OMX.google.mp3.decoder' I/OMXCodec( 105): Successfully allocated OMX node 'OMX.google.mp3.decoder' I/AudioService( 176): AudioFocus requestAudioFocus() from android.media.AudioManager@41136118com.android.music.MediaPlaybackService$3@411350b8 I/AudioService( 176): Remote Control registerMediaButtonIntent() for PendingIntent{41352630: PendingIntentRecord{415df960 com.android.music broadcastIntent}} D/lastfm.db.t_scrobblerqueue( 7991): SELECT * FROM t_scrobblerqueue WHERE CurrentTrack=1 I/scrobbler( 7991): Duration was unavailable, looking it up! W/AppWidgetService( 176): updateAppWidgetProvider: provider doesn't exist: ComponentInfo{fm.last.android/fm.last.android.RadioWidgetProvider} D/lastfm.db.t_scrobblerqueue( 7991): SELECT count(*) FROM t_scrobblerqueue WHERE CurrentTrack=0 D/lastfm.db.t_scrobblerqueue( 7991): Found 0 entries W/System.err( 7991): java.lang.NoSuchFieldException: priority W/System.err( 7991): at java.lang.Class.getField(Class.java:787) W/System.err( 7991): at fm.last.android.scrobbler.ScrobblerService.handleIntent(ScrobblerService.java:613) W/System.err( 7991): at fm.last.android.scrobbler.ScrobblerService$IntentFromMediaDBTask.onPostExecute(ScrobblerService.java:699) W/System.err( 7991): at fm.last.android.scrobbler.ScrobblerService$IntentFromMediaDBTask.onPostExecute(ScrobblerService.java:1) W/System.err( 7991): at fm.last.android.utils.AsyncTaskEx.finish(AsyncTaskEx.java:420) W/System.err( 7991): at fm.last.android.utils.AsyncTaskEx.access$0(AsyncTaskEx.java:419) W/System.err( 7991): at fm.last.android.utils.AsyncTaskEx$InternalHandler.handleMessage(AsyncTaskEx.java:432) W/System.err( 7991): at android.os.Handler.dispatchMessage(Handler.java:99) W/System.err( 7991): at android.os.Looper.loop(Looper.java:137) W/System.err( 7991): at android.app.ActivityThread.main(ActivityThread.java:4424) W/System.err( 7991): at java.lang.reflect.Method.invokeNative(Native Method) W/System.err( 7991): at java.lang.reflect.Method.invoke(Method.java:511) W/System.err( 7991): at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:784) W/System.err( 7991): at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:551) W/System.err( 7991): at dalvik.system.NativeStart.main(Native Method) D/dalvikvm( 7805): GC_CONCURRENT freed 1840K, 41% free 6952K/11715K, paused 5ms+7ms D/lastfm.db.t_scrobblerqueue( 7991): SELECT count(*) FROM t_scrobblerqueue WHERE CurrentTrack=0 D/lastfm.db.t_scrobblerqueue( 7991): Found 0 entries D/lastfm.db.t_scrobblerqueue( 7991): DELETE FROM t_scrobblerqueue WHERE CurrentTrack=1 D/lastfm.db.t_scrobblerqueue( 7991): Inserted/replaced row with values PostedNowPlaying=true Loved=false Rating= Duration=238916 StartTime=1354956037 Artist=Spoon TrackAuth= Title=Got Nuffin Album=Transference CurrentTrack=true D/dalvikvm( 176): GC_CONCURRENT freed 1568K, 21% free 13764K/17415K, paused 27ms+23ms I/OMXCodec( 105): Attempting to allocate OMX node 'OMX.google.mp3.decoder' I/OMXCodec( 105): Successfully allocated OMX node 'OMX.google.mp3.decoder' I/AudioService( 176): AudioFocus requestAudioFocus() from android.media.AudioManager@41136118com.android.music.MediaPlaybackService$3@411350b8 I/AudioService( 176): Remote Control registerMediaButtonIntent() for PendingIntent{417aa580: PendingIntentRecord{415df960 com.android.music broadcastIntent}} D/lastfm.db.t_scrobblerqueue( 7991): SELECT * FROM t_scrobblerqueue WHERE CurrentTrack=1 I/scrobbler( 7991): Duration was unavailable, looking it up! W/AppWidgetService( 176): updateAppWidgetProvider: provider doesn't exist: ComponentInfo{fm.last.android/fm.last.android.RadioWidgetProvider} D/lastfm.db.t_scrobblerqueue( 7991): SELECT count(*) FROM t_scrobblerqueue WHERE CurrentTrack=0 D/lastfm.db.t_scrobblerqueue( 7991): Found 0 entries W/System.err( 7991): java.lang.NoSuchFieldException: priority W/System.err( 7991): at java.lang.Class.getField(Class.java:787) W/System.err( 7991): at fm.last.android.scrobbler.ScrobblerService.handleIntent(ScrobblerService.java:613) W/System.err( 7991): at fm.last.android.scrobbler.ScrobblerService$IntentFromMediaDBTask.onPostExecute(ScrobblerService.java:699) W/System.err( 7991): at fm.last.android.scrobbler.ScrobblerService$IntentFromMediaDBTask.onPostExecute(ScrobblerService.java:1) W/System.err( 7991): at fm.last.android.utils.AsyncTaskEx.finish(AsyncTaskEx.java:420) W/System.err( 7991): at fm.last.android.utils.AsyncTaskEx.access$0(AsyncTaskEx.java:419) W/System.err( 7991): at fm.last.android.utils.AsyncTaskEx$InternalHandler.handleMessage(AsyncTaskEx.java:432) W/System.err( 7991): at android.os.Handler.dispatchMessage(Handler.java:99) W/System.err( 7991): at android.os.Looper.loop(Looper.java:137) W/System.err( 7991): at android.app.ActivityThread.main(ActivityThread.java:4424) W/System.err( 7991): at java.lang.reflect.Method.invokeNative(Native Method) W/System.err( 7991): at java.lang.reflect.Method.invoke(Method.java:511) W/System.err( 7991): at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:784) W/System.err( 7991): at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:551) W/System.err( 7991): at dalvik.system.NativeStart.main(Native Method) D/dalvikvm( 245): GC_CONCURRENT freed 1683K, 57% free 7533K/17159K, paused 9ms+13ms D/lastfm.db.t_scrobblerqueue( 7991): SELECT count(*) FROM t_scrobblerqueue WHERE CurrentTrack=0 D/lastfm.db.t_scrobblerqueue( 7991): Found 0 entries D/lastfm.db.t_scrobblerqueue( 7991): DELETE FROM t_scrobblerqueue WHERE CurrentTrack=1 D/lastfm.db.t_scrobblerqueue( 7991): Inserted/replaced row with values PostedNowPlaying=true Loved=false Rating= Duration=115540 StartTime=1354956051 Artist=Ratatat TrackAuth= Title=Flynn Album=LP3 CurrentTrack=true D/dalvikvm( 7805): GC_CONCURRENT freed 1842K, 41% free 6953K/11715K, paused 4ms+5ms I/OMXCodec( 105): Attempting to allocate OMX node 'OMX.google.mp3.decoder' I/OMXCodec( 105): Successfully allocated OMX node 'OMX.google.mp3.decoder' I/AudioService( 176): AudioFocus requestAudioFocus() from android.media.AudioManager@41136118com.android.music.MediaPlaybackService$3@411350b8 I/AudioService( 176): Remote Control registerMediaButtonIntent() for PendingIntent{4127bc00: PendingIntentRecord{415df960 com.android.music broadcastIntent}} D/lastfm.db.t_scrobblerqueue( 7991): SELECT * FROM t_scrobblerqueue WHERE CurrentTrack=1 I/scrobbler( 7991): Duration was unavailable, looking it up! W/AppWidgetService( 176): updateAppWidgetProvider: provider doesn't exist: ComponentInfo{fm.last.android/fm.last.android.RadioWidgetProvider} D/lastfm.db.t_scrobblerqueue( 7991): SELECT count(*) FROM t_scrobblerqueue WHERE CurrentTrack=0 D/lastfm.db.t_scrobblerqueue( 7991): Found 0 entries W/System.err( 7991): java.lang.NoSuchFieldException: priority W/System.err( 7991): at java.lang.Class.getField(Class.java:787) W/System.err( 7991): at fm.last.android.scrobbler.ScrobblerService.handleIntent(ScrobblerService.java:613) W/System.err( 7991): at fm.last.android.scrobbler.ScrobblerService$IntentFromMediaDBTask.onPostExecute(ScrobblerService.java:699) W/System.err( 7991): at fm.last.android.scrobbler.ScrobblerService$IntentFromMediaDBTask.onPostExecute(ScrobblerService.java:1) W/System.err( 7991): at fm.last.android.utils.AsyncTaskEx.finish(AsyncTaskEx.java:420) W/System.err( 7991): at fm.last.android.utils.AsyncTaskEx.access$0(AsyncTaskEx.java:419) W/System.err( 7991): at fm.last.android.utils.AsyncTaskEx$InternalHandler.handleMessage(AsyncTaskEx.java:432) W/System.err( 7991): at android.os.Handler.dispatchMessage(Handler.java:99) W/System.err( 7991): at android.os.Looper.loop(Looper.java:137) W/System.err( 7991): at android.app.ActivityThread.main(ActivityThread.java:4424) W/System.err( 7991): at java.lang.reflect.Method.invokeNative(Native Method) W/System.err( 7991): at java.lang.reflect.Method.invoke(Method.java:511) W/System.err( 7991): at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:784) W/System.err( 7991): at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:551) W/System.err( 7991): at dalvik.system.NativeStart.main(Native Method) D/lastfm.db.t_scrobblerqueue( 7991): SELECT count(*) FROM t_scrobblerqueue WHERE CurrentTrack=0 D/lastfm.db.t_scrobblerqueue( 7991): Found 0 entries D/lastfm.db.t_scrobblerqueue( 7991): DELETE FROM t_scrobblerqueue WHERE CurrentTrack=1 D/lastfm.db.t_scrobblerqueue( 7991): Inserted/replaced row with values PostedNowPlaying=true Loved=false Rating= Duration=283580 StartTime=1354956067 Artist=4 Non Blondes TrackAuth= Title=Morphine and Chocolate Album=Bigger, Better, Faster, More? CurrentTrack=true I/OMXCodec( 105): Attempting to allocate OMX node 'OMX.google.mp3.decoder' I/OMXCodec( 105): Successfully allocated OMX node 'OMX.google.mp3.decoder' I/AudioService( 176): AudioFocus requestAudioFocus() from android.media.AudioManager@41136118com.android.music.MediaPlaybackService$3@411350b8 I/AudioService( 176): Remote Control registerMediaButtonIntent() for PendingIntent{4164c660: PendingIntentRecord{415df960 com.android.music broadcastIntent}} D/lastfm.db.t_scrobblerqueue( 7991): SELECT * FROM t_scrobblerqueue WHERE CurrentTrack=1 W/AppWidgetService( 176): updateAppWidgetProvider: provider doesn't exist: ComponentInfo{fm.last.android/fm.last.android.RadioWidgetProvider} I/scrobbler( 7991): Duration was unavailable, looking it up! D/dalvikvm( 245): GC_CONCURRENT freed 1794K, 57% free 7513K/17159K, paused 4ms+8ms D/lastfm.db.t_scrobblerqueue( 7991): SELECT count(*) FROM t_scrobblerqueue WHERE CurrentTrack=0 D/lastfm.db.t_scrobblerqueue( 7991): Found 0 entries W/System.err( 7991): java.lang.NoSuchFieldException: priority W/System.err( 7991): at java.lang.Class.getField(Class.java:787) W/System.err( 7991): at fm.last.android.scrobbler.ScrobblerService.handleIntent(ScrobblerService.java:613) W/System.err( 7991): at fm.last.android.scrobbler.ScrobblerService$IntentFromMediaDBTask.onPostExecute(ScrobblerService.java:699) W/System.err( 7991): at fm.last.android.scrobbler.ScrobblerService$IntentFromMediaDBTask.onPostExecute(ScrobblerService.java:1) W/System.err( 7991): at fm.last.android.utils.AsyncTaskEx.finish(AsyncTaskEx.java:420) W/System.err( 7991): at fm.last.android.utils.AsyncTaskEx.access$0(AsyncTaskEx.java:419) W/System.err( 7991): at fm.last.android.utils.AsyncTaskEx$InternalHandler.handleMessage(AsyncTaskEx.java:432) W/System.err( 7991): at android.os.Handler.dispatchMessage(Handler.java:99) W/System.err( 7991): at android.os.Looper.loop(Looper.java:137) W/System.err( 7991): at android.app.ActivityThread.main(ActivityThread.java:4424) W/System.err( 7991): at java.lang.reflect.Method.invokeNative(Native Method) W/System.err( 7991): at java.lang.reflect.Method.invoke(Method.java:511) W/System.err( 7991): at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:784) W/System.err( 7991): at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:551) W/System.err( 7991): at dalvik.system.NativeStart.main(Native Method) D/lastfm.db.t_scrobblerqueue( 7991): SELECT count(*) FROM t_scrobblerqueue WHERE CurrentTrack=0 D/lastfm.db.t_scrobblerqueue( 7991): Found 0 entries D/lastfm.db.t_scrobblerqueue( 7991): DELETE FROM t_scrobblerqueue WHERE CurrentTrack=1 D/lastfm.db.t_scrobblerqueue( 7991): Inserted/replaced row with values PostedNowPlaying=true Loved=false Rating= Duration=239047 StartTime=1354956069 Artist=Jack Johnson TrackAuth= Title=If I Had Eyes Album=Sleep Through The Static CurrentTrack=true D/dalvikvm( 7805): GC_CONCURRENT freed 1840K, 41% free 6951K/11715K, paused 6ms+8ms D/lastfm.db.t_scrobblerqueue( 7991): SELECT * FROM t_scrobblerqueue WHERE CurrentTrack=1 W/AppWidgetService( 176): updateAppWidgetProvider: provider doesn't exist: ComponentInfo{fm.last.android/fm.last.android.RadioWidgetProvider} D/lastfm.db.t_scrobblerqueue( 7991): SELECT count(*) FROM t_scrobblerqueue WHERE CurrentTrack=0 D/lastfm.db.t_scrobblerqueue( 7991): Found 0 entries D/dalvikvm( 245): GC_CONCURRENT freed 2040K, 58% free 7299K/17159K, paused 4ms+7ms D/lastfm.db.t_scrobblerqueue( 7991): SELECT count(*) FROM t_scrobblerqueue WHERE CurrentTrack=0 D/lastfm.db.t_scrobblerqueue( 7991): Found 0 entries D/lastfm.db.t_scrobblerqueue( 7991): DELETE FROM t_scrobblerqueue WHERE CurrentTrack=1 I/ActivityManager( 176): START {act=android.intent.action.MAIN cat=[android.intent.category.HOME] flg=0x10200000 cmp=com.android.launcher/com.android.launcher2.Launcher} from pid 176 W/Adreno200-EGLSUB( 359): SetSwapInterval() interval: 0 not set I/AudioHardwareMSM72XX( 105): set device to SND_DEVICE_SPEAKER device_id=0 I/AudioHardwareMSM72XX( 105): disabling post proc features with mask 0x0000 I/ActivityManager( 176): START {act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10200000 cmp=org.jtb.alogcat/.LogActivity} from pid 359 D/OpenGLRenderer( 359): Flushing caches (mode 1) D/OpenGLRenderer( 359): Flushing caches (mode 0) W/InputManagerService( 176): Starting input on non-focused client com.android.internal.view.IInputMethodClient$Stub$Proxy@411d0ac8 (uid=10023 pid=359) Please provide any additional information below. I have tried each governor, moving CPU clock speed up/down, closing all non-essential apps, attaining 80% free memory. I have been using Winamp to play music and playback is seamless. This problem was not present in past releases of Oxygen Gingerbread.
Dec 13, 2012
Project Member
#1
mihai.an...@gmail.com
Dec 13, 2012
No, it's on the internal storage. Should it be on SD?
Dec 13, 2012
No, it shouldn't... Linking it to SD card could result in a poor performance. But the music app works just fine on my end. (stock kernel, 729 performance, running any number of apps)
Dec 13, 2012
Ok. I checked in Titanium and sure enough, it gives me the option to convert to user app. I'll tinker around with that. I know when I upgraded to ICS, I didn't move it to SD. Thatmuch have been the setup I used with Gingerbread before Imoved over. Thanks for the suggestion.
Dec 13, 2012
I changed it in Titanium. Same issue is still happening. Usually jumps at around the 10 second mark. Was there a change in the buffering procedure between Gingerbread and ICS or something?
Dec 13, 2012
As far as i know the app has not changed. Libstagefright(android's codec system) has changed. From your logcat i see that the system uses software codecs to decode mp3. I'll investigate a bit to see if this is normal.
Status:
Started
Dec 14, 2012
I can confirm this I use winamp pro and have the same issue when starting a music jumps to 10~15 s
Dec 14, 2012
The issue is with the stock music app. I don't think this applies to third-party apps.
Dec 15, 2012
U're right but as I said i have the same with winamp :\ |