View Issue Details

IDProjectCategoryView StatusLast Update
0009701MMAPlaybackpublic2012-09-25 23:59
Reportermambo-simonAssigned To 
PriorityimmediateSeveritymajorReproducibilityalways
Status closedResolutionfixed 
PlatformGalaxy SOSAndroidOS Versionv2.3.3
Target Version1.0.1Fixed in Version1.0.1 
Summary0009701: Video not displayed (Galaxy S: Gingerbread)
Description** Reproduced only in in Samsung Galaxy S so far
Videos can be played, and the player started - audio can be heard but no video shown
Steps To Reproduce1. Select any video file
2. Start player
Expected: Normal video playback
Actual: Audio heard, but no video
Additional Information-Sometimes the video will flash up for a very short(-0.5s) time, often in the wrong aspect ratio, then disapper.
-Audio and seek bar behaviour is as expected for normal playback
- Log attached but not sure if this is useful
TagsNo tags attached.
Attached Files
GalaxyS_Video_playback.txt (21,713 bytes)   
Issue: Crash on video playback
Device: Samsung Galaxy S
OS: 2.3.3
Build Reference: Gingerbread.OMKE3

MediaMonkey: Build 21
Media: Any MP4 video file
Reproducability: 10/10

**  100% reproducable on Galaxy S
Issue : Crash video playback
1. Start MM
2. Go to Video list
3. Select Video
** Expected: Move to Video player screen, video plays
** Actual: screen goes black, then crash dialog

Comment: 
- 100% reproducable on Galaxy 
- Same crash (based on logs) also observed in HTC Desire (OS2.3.7 Cyanogen ) 


D/MediaSync( 1336): In both databases: AKB48 - Beginner
D/MediaSync( 1336): In both databases: AKB48 (牁E��陽加, 小嶋陽菁E 篠田麻里孁E 秋�E才加, 宮澤佐汁E 松井玲奁E - イイカゲン
のススメ
D/MediaSync( 1336): In both databases: AKB48 - ヘビーローチE�Eション
D/MediaSync( 1336): In both databases: 一青突E- あこるでぁE��めE
D/MediaSync( 1336): In both databases: 一青突E- もらぁE��ぁE
D/MediaSync( 1336): In both databases: 一青突E- sunny side up
D/MediaSync( 1336): In both databases: 一青突E- イマドコ
D/MediaSync( 1336): In both databases: 一青突E- 犬
D/MediaSync( 1336): In both databases: 一青突E- 月天忁E
E/MediaProvider(  242): removeMediaDBData called
D/MediaSync( 1336): In both databases: 一青突E- ジャングルジム
D/MediaSync( 1336): In both databases: 一青突E- 忁E��わめE
D/MediaSync( 1336): In both databases: 一青突E- アリガ十、E
D/MediaSync( 1336): In both databases: 一青突E- 望春風
D/MediaSync( 1336): Media synchronization end
W/TransactionManager( 1336): No transaction to end.
D/GenreSync( 1336): GenreMedia synchronization start
D/GenreMsDao( 1336): 1 <unknown>
D/GenreMsDao( 1336): 2 Rock
D/GenreMsDao( 1336): 3 Alternative/Indie
D/GenreMsDao( 1336): 4 Pop
D/GenreMsDao( 1336): 5 Others
D/GenreMsDao( 1336): 6 Alternative & Punk
D/GenreMsDao( 1336): 7 ロチE��
D/GenreMsDao( 1336): 8 ポッチE
D/GenreMsDao( 1336): 9 ブルース
D/GenreMsDao( 1336): 10 そ�E仁E
D/GenreMsDao( 1336): 11 Blues
D/GenreMsDao( 1336): 12 TBB Music
D/GenreMsDao( 1336): 13 Classics
D/GenreMsDao( 1336): 14 Hip Hop/Rap
D/GenreMsDao( 1336): 15 R&B/Soul
D/GenreMsDao( 1336): 16 ????
D/GenreMsDao( 1336): 17 Domestic(J-Pops)
D/GenreMsDao( 1336): 18 Jazz
D/GenreMsDao( 1336): 19 J-POP
D/GenreMsDao( 1336): 20 Dance
D/GenreMsDao( 1336): 21 Rap & Hip-Hop
D/GenreMsDao( 1336): 22 Soul and R&B
D/GenreMsDao( 1336): 23 genre
D/GenreMsDao( 1336): 24 J-pop
D/GenreMsDao( 1336): 25 J-Pop
D/GenreMsDao( 1336): 26 J-R&B.Women
D/GenreMsDao( 1336): 27 J-R&B
D/GenreMsDao( 1336): 28 (250)
D/GenreMsDao( 1336): 29 DOMESTIC(J-POPS)
D/GenreMsDao( 1336): 30 Unknown
D/GenreMsDao( 1336): 31 kumiko
D/GenreMsDao( 1336): 32 Japanese Pop
D/GenreMsDao( 1336): 33 J-Rap
D/GenreMsDao( 1336): 34 Geeman
D/GenreMsDao( 1336): 35 Rap/Hip Hop
D/GenreMsDao( 1336): 36 J- POP
D/GenreMsDao( 1336): 37 World
D/GenreMsDao( 1336): 38 Alternative Pop Singer-Songwriter
D/GenreMsDao( 1336): 39 Japanese Pop & Rock
D/DB debug( 1336): DIRECT QUERY
D/DIRECT QUERY( 1336): SELECT _ms_id, _id FROM new_media;
D/MediaScanner(  242): prescan enter: path - /mnt/sdcard/MediaMonkey/files/mmstore.db
I/Database(  242): sqlite returned: error code = 17, msg = prepared statement aborts at 41: [SELECT _id, _data, date_modified FROM audio WHERE (_data=
?)]
D/MediaScanner(  242): prescan return
D/StorageUtils( 1336): Scanned /mnt/sdcard/MediaMonkey/files/mmstore.db, uri=null
D/dalvikvm(  242): GC_EXPLICIT freed 311K, 51% free 3056K/6151K, external 1596K/2108K, paused 23ms
D/EXEC_SQL( 1336): DELETE FROM new_media;
D/GenreSync( 1336): GenreMedia synchronization end
W/TransactionManager( 1336): No transaction to end.
I/StoresSyncService( 1336): Synchronization finished.
D/HomeActivity( 1336): Intent command received
D/ContentService( 1336): STOP_SYNC_ACTION received
D/CacheHelper( 1336): Clear caches
I/ContentService( 1336): doNextAction
D/ContentService( 1336): No task in queue
I/ContentService( 1336): onDestroy
D/MediaScannerService(  242): IMediaScannerService.scanFile: /mnt/sdcard/MediaMonkey/files/mmstore.db mimeType: null
D/MediaScannerService(  242): onStartCommand : intent - Intent { cmp=com.android.providers.media/.MediaScannerService (has extras) }
D/MediaScannerService(  242): onStartCommand : flags [2], startId [1]
D/MediaScannerService(  242): ServiceHandler:handleMessage volume[null], filePath[/mnt/sdcard/MediaMonkey/files/mmstore.db]
E/MediaProvider(  242): removeMediaDBData called
D/MediaScanner(  242): prescan enter: path - /mnt/sdcard/MediaMonkey/files/mmstore.db
D/dalvikvm(  127): GC_EXPLICIT freed 1352K, 46% free 7100K/12935K, external 6264K/7808K, paused 88ms
I/Database(  242): sqlite returned: error code = 17, msg = prepared statement aborts at 41: [SELECT _id, _data, date_modified FROM audio WHERE (_data=
?)]
D/MediaScanner(  242): prescan return
D/StorageUtils( 1336): Scanned /mnt/sdcard/MediaMonkey/files/mmstore.db, uri=null
I/TransactionManager( 1336): ThreadSerializer exit unlockMain 10
W/PowerManagerService(  127): Timer 0x3->0x3|0x0
I/InputReader(  127): dispatchTouch::touch event's action is 0
I/InputDispatcher(  127): Delivering touch to current input target: action: 0, channel '409df1a0 com.ventismedia.android.mediamonkey/com.ventismedia.a
ndroid.mediamonkey.ui.phone.HomeActivity (server)'
I/com.dropbox.android.service.CameraUploadService(  698): Starting camera upload scan...
I/InputReader(  127): dispatchTouch::touch event's action is 1
I/InputDispatcher(  127): Delivering touch to current input target: action: 1, channel '409df1a0 com.ventismedia.android.mediamonkey/com.ventismedia.a
ndroid.mediamonkey.ui.phone.HomeActivity (server)'
I/com.dropbox.android.service.CameraUploadService(  698): Finished querying providers.
I/com.dropbox.android.service.CameraUploadService(  698): Finished camera upload scan.
I/InputReader(  127): dispatchTouch::touch event's action is 0
I/InputDispatcher(  127): Delivering touch to current input target: action: 0, channel '409df1a0 com.ventismedia.android.mediamonkey/com.ventismedia.a
ndroid.mediamonkey.ui.phone.HomeActivity (server)'
I/InputReader(  127): dispatchTouch::touch event's action is 1
I/InputDispatcher(  127): Delivering touch to current input target: action: 1, channel '409df1a0 com.ventismedia.android.mediamonkey/com.ventismedia.a
ndroid.mediamonkey.ui.phone.HomeActivity (server)'
I/ActivityManager(  127): Starting: Intent { dat=content://com.ventismedia.android.mediamonkey.provider.MediaMonkeyStoreProvider/audio/media cmp=com.v
entismedia.android.mediamonkey/.library.LibraryActivity (has extras) } from pid 1336
W/ActivityManager(  127): Trying to launch com.ventismedia.android.mediamonkey/.library.LibraryActivity
E/ResourceType( 1336): Style contains key with bad entry: 0x01010336
E/ResourceType( 1336): Style contains key with bad entry: 0x01010339
I/SinglePaneActivity( 1336): onCreate
W/LOG     ( 1336): setContentView
I/MiniPlayerActivity( 1336): onCreate
I/LibraryViewFragment( 1336): onActivityCreated
D/VideoFragment( 1336): VideoCursorAdapter
W/THREAD CONTROL( 1336): Not queried by db thread!!! 21 (-1)
D/DB debug( 1336): Query - media
D/QUERY   ( 1336): select _id, title, _data, mime_type  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN medi
a_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE type=5
ORDER BY title COLLATE LOCALIZED ASC
D/ActionBarHelperBase( 1336): Custom view is invisible
D/dalvikvm( 1336): GC_CONCURRENT freed 794K, 51% free 3331K/6727K, external 3474K/3500K, paused 2ms+3ms
D/dalvikvm( 1336): GC_EXTERNAL_ALLOC freed 46K, 52% free 3284K/6727K, external 2197K/2743K, paused 23ms
D/TrackListModel( 1336): Loading current track preferences
D/TrackListModel( 1336): com.ventismedia.android.mediamonkey.player.video.VideoTrack:1
W/TransactionManager( 1336): New ThreadSerializer id from -1 to 22
D/DB debug( 1336): Query - media - id
D/QUERY   ( 1336): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=
media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE (type=5) AND (_id=?)
D/QUERY   ( 1336): [1]
D/TrackListModel( 1336): Loading current track preferences
D/TrackListModel( 1336): com.ventismedia.android.mediamonkey.player.video.VideoTrack:1
D/DB debug( 1336): Query - media - id
D/QUERY   ( 1336): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=
media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE (type=5) AND (_id=?)
D/QUERY   ( 1336): [1]
I/PlaybackService( 1336): Service is not running
I/MiniPlayerActivity( 1336): hideMiniPlayer
D/VideoFragment( 1336): setHolderForBindView
D/AsyncLoader( 1336): Request value 1
D/AsyncLoader( 1336): Thread starting...
I/ActivityManager(  127): Displayed com.ventismedia.android.mediamonkey/.library.LibraryActivity: +284ms
D/VideoFragment( 1336): Thumbnail exist
D/AsyncLoader( 1336): Loaded string for 1: [Ljava.lang.String;@405b7908
D/dalvikvm( 1336): GC_EXTERNAL_ALLOC freed 179K, 50% free 3369K/6727K, external 3171K/3867K, paused 23ms
I/TransactionManager( 1336): ThreadSerializer exit unlockMain 22
D/BatteryService(  127): update start
D/BatteryService(  127): updateBattery level:91 scale:100 status:2 health:2 present:true voltage: 4182 temperature: 390 technology: Li-ion AC powered:
false USB powered:true icon:17302213
I/StatusBarPolicy(  212): BAT. S:2 H:2
I/InputReader(  127): dispatchTouch::touch event's action is 0
I/InputDispatcher(  127): Delivering touch to current input target: action: 0, channel '40862028 com.ventismedia.android.mediamonkey/com.ventismedia.a
ndroid.mediamonkey.library.LibraryActivity (server)'
I/InputReader(  127): dispatchTouch::touch event's action is 1
I/InputDispatcher(  127): Delivering touch to current input target: action: 1, channel '40862028 com.ventismedia.android.mediamonkey/com.ventismedia.a
ndroid.mediamonkey.library.LibraryActivity (server)'
I/ActivityManager(  127): Starting: Intent { dat=file:///mnt/sdcard/Music/Coldplay%20-%20Paradise.mp4 typ=video/mp4 cmp=com.ventismedia.android.mediam
onkey/.ui.phone.NowVideoPlayingActivity } from pid 1336
W/ActivityManager(  127): Trying to launch com.ventismedia.android.mediamonkey/.ui.phone.NowVideoPlayingActivity
I/PlaybackService( 1336): onCreate
I/AudioService(  127):   Remote Control   registerMediaButtonEventReceiver() for ComponentInfo{com.ventismedia.android.mediamonkey/com.ventismedia.and
roid.mediamonkey.player.MediaButtonIntentReceiver}
I/PlaybackService( 1336): onStartCommand - intent:com.ventismedia.android.mediamonkey.player.PlaybackService.ADD_ACTION
D/PlaybackNotification( 1336): ColorText is light!
I/PlaybackService( 1336): Parsing intent
E/ResourceType( 1336): Style contains key with bad entry: 0x01010336
E/ResourceType( 1336): Style contains key with bad entry: 0x01010339
I/SinglePaneActivity( 1336): onCreate
W/LOG     ( 1336): setContentView
D/NowVideoPlayingFragment( 1336): onCreate
D/NowVideoPlayingFragment( 1336): onCreateView
W/TransactionManager( 1336): New ThreadSerializer id from -1 to 24
D/DB debug( 1336): Query - media - id
D/QUERY   ( 1336): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=
media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE (type=5) AND (_id=?)
D/QUERY   ( 1336): [1]
D/ActionBarHelperBase( 1336): Custom view is invisible
D/NowVideoPlayingFragment( 1336): onActivityPostCreated
I/PlaybackService( 1336): Service is running
D/NowPlayingSeekHelper( 1336): NowPlayingSeekHelper constructor
I/PlaybackService( 1336): onBind
D/NowVideoPlayingFragment( 1336): onServiceConnected
V/NowVideoPlayingFragment( 1336): surfaceCreated
D/AndroidRuntime( 1336): Shutting down VM
W/dalvikvm( 1336): threadid=1: thread exiting with uncaught exception (group=0x40015578)
E/ACRA    ( 1336): ACRA caught a NullPointerException exception for com.ventismedia.android.mediamonkey. Building report.
D/ACRA    ( 1336): Retrieve application default SharedPreferences.
I/ACRA    ( 1336): READ_LOGS granted! ACRA can include LogCat and DropBox data.
D/TrackListModel( 1336): Storing TrackList to preferences
D/ACRA    ( 1336): Retrieving logcat output...
D/ACRA    ( 1336): Retrieving logcat output...
D/ACRA    ( 1336): Retrieving logcat output...
D/dalvikvm( 1336): GC_CONCURRENT freed 1077K, 50% free 3680K/7303K, external 7470K/8456K, paused 2ms+3ms
E/Environment( 1336): getExternalStorageDirectoryUsbHost :: invalid call
E/Environment( 1336): getExternalStorageStateUsbHost :: invalid call
W/Settings( 1336): Setting usb_setting_mode has moved from android.provider.Settings.System to android.provider.Settings.Secure, returning read-only v
alue.
D/ACRA    ( 1336): Writing crash report file.
D/ACRA    ( 1336): Mark all pending reports as approved.
D/ACRA    ( 1336): Looking for error files in /data/data/com.ventismedia.android.mediamonkey/files
V/ACRA    ( 1336): About to start ReportSenderWorker from #handleException
D/ACRA    ( 1336): Add user comment to null
D/ACRA    ( 1336): #checkAndSendReports - start
D/ACRA    ( 1336): Looking for error files in /data/data/com.ventismedia.android.mediamonkey/files
I/ACRA    ( 1336): Sending file 1346724613000-approved.stacktrace
D/ACRA    ( 1336): Sending report ca4cc72b-1211-44c7-95aa-65fb3316535c
D/ACRA    ( 1336): Connect to https://spreadsheets.google.com/formResponse?formkey=dFhLd1dLdnRiLWY4b0x6SXkxX2E1WlE6MQ&amp;ifq
D/dalvikvm( 1336): GC_CONCURRENT freed 1888K, 54% free 3877K/8327K, external 6193K/7734K, paused 3ms+2ms
D/ACRA    ( 1336): Setting httpPost headers
D/ACRA    ( 1336): Sending request to https://spreadsheets.google.com/formResponse?formkey=dFhLd1dLdnRiLWY4b0x6SXkxX2E1WlE6MQ&amp;ifq
I/TransactionManager( 1336): ThreadSerializer exit unlockMain 24
D/ACRA    ( 1336): #checkAndSendReports - finish
E/AndroidRuntime( 1336): FATAL EXCEPTION: main
E/AndroidRuntime( 1336): java.lang.NullPointerException
E/AndroidRuntime( 1336):        at com.ventismedia.android.mediamonkey.player.TrackList.prepareCurrentTrack(TrackList.java:902)
E/AndroidRuntime( 1336):        at com.ventismedia.android.mediamonkey.player.PlaybackService.preparePlayer(PlaybackService.java:626)
E/AndroidRuntime( 1336):        at com.ventismedia.android.mediamonkey.player.video.NowVideoPlayingFragment.initializePlayerAndPlay(NowVideoPlayingFra
gment.java:428)
E/AndroidRuntime( 1336):        at com.ventismedia.android.mediamonkey.player.video.NowVideoPlayingFragment.surfaceCreated(NowVideoPlayingFragment.jav
a:367)
E/AndroidRuntime( 1336):        at android.view.SurfaceView.updateWindow(SurfaceView.java:543)
E/AndroidRuntime( 1336):        at android.view.SurfaceView.dispatchDraw(SurfaceView.java:348)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.drawChild(ViewGroup.java:1644)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.dispatchDraw(ViewGroup.java:1373)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.drawChild(ViewGroup.java:1644)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.dispatchDraw(ViewGroup.java:1373)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.drawChild(ViewGroup.java:1644)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.dispatchDraw(ViewGroup.java:1373)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.drawChild(ViewGroup.java:1644)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.dispatchDraw(ViewGroup.java:1373)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.drawChild(ViewGroup.java:1644)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.dispatchDraw(ViewGroup.java:1373)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.drawChild(ViewGroup.java:1644)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.dispatchDraw(ViewGroup.java:1373)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.drawChild(ViewGroup.java:1644)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.dispatchDraw(ViewGroup.java:1373)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.drawChild(ViewGroup.java:1644)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.dispatchDraw(ViewGroup.java:1373)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.drawChild(ViewGroup.java:1644)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.dispatchDraw(ViewGroup.java:1373)
E/AndroidRuntime( 1336):        at android.view.View.draw(View.java:6936)
E/AndroidRuntime( 1336):        at android.widget.FrameLayout.draw(FrameLayout.java:357)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.drawChild(ViewGroup.java:1646)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.dispatchDraw(ViewGroup.java:1373)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.drawChild(ViewGroup.java:1644)
E/AndroidRuntime( 1336):        at android.view.ViewGroup.dispatchDraw(ViewGroup.java:1373)
E/AndroidRuntime( 1336):        at android.view.View.draw(View.java:6936)
E/AndroidRuntime( 1336):        at android.widget.FrameLayout.draw(FrameLayout.java:357)
E/AndroidRuntime( 1336):        at com.android.internal.policy.impl.PhoneWindow$DecorView.draw(PhoneWindow.java:1904)
E/AndroidRuntime( 1336):        at android.view.ViewRoot.draw(ViewRoot.java:1527)
E/AndroidRuntime( 1336):        at android.view.ViewRoot.performTraversals(ViewRoot.java:1263)
E/AndroidRuntime( 1336):        at android.view.ViewRoot.handleMessage(ViewRoot.java:1865)
E/AndroidRuntime( 1336):        at android.os.Handler.dispatchMessage(Handler.java:99)
E/AndroidRuntime( 1336):        at android.os.Looper.loop(Looper.java:123)
E/AndroidRuntime( 1336):        at android.app.ActivityThread.main(ActivityThread.java:3687)
E/AndroidRuntime( 1336):        at java.lang.reflect.Method.invokeNative(Native Method)
E/AndroidRuntime( 1336):        at java.lang.reflect.Method.invoke(Method.java:507)
E/AndroidRuntime( 1336):        at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:842)
E/AndroidRuntime( 1336):        at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:600)
E/AndroidRuntime( 1336):        at dalvik.system.NativeStart.main(Native Method)
W/ActivityManager(  127):   Force finishing activity com.ventismedia.android.mediamonkey/.ui.phone.NowVideoPlayingActivity
W/ActivityManager(  127):   Force finishing activity com.ventismedia.android.mediamonkey/.library.LibraryActivity
E/        (  127): Dumpstate > /data/log/dumpstate_app_error
I/dumpstate( 1365): begin
W/ActivityManager(  127): Activity pause timeout for HistoryRecord{408627c8 com.ventismedia.android.mediamonkey/.ui.phone.NowVideoPlayingActivity}
W/PowerManagerService(  127): Timer 0x3->0x3|0x0
D/VoldCmdListener(   74): asec list
I/dumpstate( 1365): done
I/InputReader(  127): dispatchTouch::touch event's action is 0
I/InputDispatcher(  127): Delivering touch to current input target: action: 0, channel '4099bae8 申し訳ありません (server)'
D/BatteryService(  127): update start
I/InputReader(  127): dispatchTouch::touch event's action is 1
I/InputDispatcher(  127): Delivering touch to current input target: action: 1, channel '4099bae8 申し訳ありません (server)'
D/BatteryService(  127): updateBattery level:91 scale:100 status:2 health:2 present:true voltage: 4178 temperature: 390 technology: Li-ion AC powered:
false USB powered:true icon:17302213
I/Process ( 1336): Sending signal. PID: 1336 SIG: 9
I/StatusBarPolicy(  212): BAT. S:2 H:2
I/ActivityManager(  127): Process com.ventismedia.android.mediamonkey (pid 1336) has died.
W/ActivityManager(  127): Scheduling restart of crashed service com.ventismedia.android.mediamonkey/.player.PlaybackService in 5000ms
W/ActivityManager(  127): Scheduling restart of crashed service com.ventismedia.android.mediamonkey/.db.RemoteDatabaseObserverService in 15000ms
I/WindowManager(  127): WIN DEATH: Window{409df1a0 com.ventismedia.android.mediamonkey/com.ventismedia.android.mediamonkey.ui.phone.HomeActivity pause
d=false}
I/WindowManager(  127): WIN DEATH: Window{40862028 com.ventismedia.android.mediamonkey/com.ventismedia.android.mediamonkey.library.LibraryActivity pau
sed=true}
I/WindowManager(  127): WIN DEATH: Window{40951490 com.ventismedia.android.mediamonkey/com.ventismedia.android.mediamonkey.ui.phone.NowVideoPlayingAct
ivity paused=false}
I/WindowManager(  127): WIN DEATH: Window{4097ec68 SurfaceView paused=false}
I/Launcher(  252): onResume(). mIsNewIntent : false
E/        (  252): onResume() check 0
E/        (  252): onResume() check 1
E/Launcher(  252): setWindowOpaque()
E/        (  252): onResume() check 2, mRestoring : false
E/        (  252): onResume() check 3
E/        (  252): onResume() check 4
E/        (  252): onResume() check 5
I/Launcher(  252): onResume() ended
I/Launcher(  252): onWindowFocusChanged(true)
D/Launcher(  252): It's image wallpaper. suggestDesiredDimensions(-1,-1)
E/Launcher(  252): setWindowOpaque()
W/InputManagerService(  127): Got RemoteException sending setActive(false) notification to pid 1336 uid 10090
^C
D:\tools\AndroidAll\Android\platform-tools>
GalaxyS_Video_playback.txt (21,713 bytes)   
galaxyS_no_video.txt (18,820 bytes)   
V/ANDROID_DRM_TEST(   82): [106] seekTo(102296)
V/PVPlayer(   82): seekTo(102296)
V/ANDROID_DRM_TEST(   82): [106] setVolume(0.900000, 0.900000)
V/AudioSink(   82): setVolume(0.900000, 0.900000)
I/VideoTrack( 8253): updatePlaycount
V/PlayerDriver(   82): Send player code: 13
V/PlayerDriver(   82): handleSeek
W/TransactionManager( 8253): New ThreadSerializer id from -1 to 26
E/VideoMIO(   82): AndroidSurfaceOutput::setParametersSync()  VIDEO RENDERER 1
D/SEC_Overlay(  127): overlay_createOverlay:IN w=1280 h=720 format=272
D/SEC_Overlay(  127): src width, height are changed [w= 1280, h= 720]->[w=1280, h= 720]
I/SEC_Overlay(  127): Opened video1/fd=277/obj=006e2d90/shm=275/size=4096
D/SEC_Overlay(  127): overlay_setPosition(0) 0,0,480,800 => 0,0,480,800
I/SEC_Overlay(  127): Rotation/0
W/v4l2_utils(  127): v4l2_overlay_set_position:: (0,0,0,0)=>(0,0,480,800) rot=0
I/SEC_Overlay(  127): Postponing Stream Enable/1/0
I/VideoMIO(   82): initCheck() direct start
V/ANDROID_DRM_TEST(   82): [106] notify (0xb73a0, 5, 1280, 720)
V/PlayerDriver(   82): HandleInformationalEvent: 44
V/PlayerDriver(   82): HandleInformationalEvent: type=44 UNHANDLED
V/ANDROID_DRM_TEST(   82): [106] notify (0xb73a0, 200, 1, 44)
W/MediaPlayer( 8253): info/warning (1, 44)
V/PlayerDriver(   82): CommandCompleted
V/PlayerDriver(   82): Completed command PLAYER_SEEK status=1
V/ANDROID_DRM_TEST(   82): [106] notify (0xb73a0, 4, 0, 0)
V/AudioSink(   82): flush
V/AudioSink(   82): start
V/AudioPolicyManager(   82): startOutput() output 1, stream 3, session 121
V/AudioPolicyManager(   82): getDeviceForStrategy() from cache strategy 0, device 2
V/AudioPolicyManager(   82): getDeviceForStrategy() from cache strategy 0, device 2
V/AudioPolicyManager(   82): getNewDevice() selected device 2
V/AudioPolicyManager(   82): setOutputDevice() output 1 device 2 delayMs 0 force 0
V/AudioPolicyManager(   82): setOutputDevice() setting same device 2 or null device for output 1
D/AudioHardwareALSA(   82): Calling setDevice from write @..1874.
W/PowerManagerService(  127): Timer 0x3->0x3|0x0
I/AudioHardwareALSA(   82): Initialized ALSA PLAYBACK device AndroidPlayback_Speaker_normal
V/AudioHardwareALSA(   82): Set PLAYBACK PCM format to S16_LE (Signed 16 bit Little Endian)
D/AudioHardwareALSA(   82): Using 2 channels for PLAYBACK.
I/AudioHardwareALSA(   82): DEFAULT_SAMPLE_RATE is 44100, mDefaults->sampleRate is 44100
D/AudioHardwareALSA(   82): Set PLAYBACK sample rate to 44100 HZ
D/AudioHardwareALSA(   82): Buffer size: 4096
D/AudioHardwareALSA(   82): Latency: 92879
W/AudioFlinger(   82): write blocked for 93 msecs, 44 delayed writes, thread 0x2fc40
D/TrackListManager( 8253): Thread ending
V/PlayerDriver(   82): HandleInformationalEvent: 23
D/PlaybackService( 8253): updateNotification app is : in foreground
I/PlaybackService( 8253): hideNotification
V/PlayerDriver(   82): Send player code: 16
V/PlayerDriver(   82): status=4
V/ANDROID_DRM_TEST(   82): [106] isPlaying: 1
D/PlayerWidgetModel( 8253): Loading widget Ids
D/SEC_Overlay(  127): overlay_setPosition(0) 240,400,1,1 => 240,400,8,8
I/SEC_Overlay(  127): Rotation/0
V/NowVideoPlayingFragment( 8253): surfaceChanged Called width: 0height: 0
W/v4l2_utils(  127): v4l2_overlay_set_position:: (0,0,480,800)=>(240,400,8,8) rot=0
D/SEC_Overlay(  127): overlay_setPosition(0) 240,400,1,1 => 240,400,8,8
I/SEC_Overlay(  127): Nothing to do!
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer2 idx=2, fail=-1
I/MediaPlayer( 8253): Info (1,44)
V/PlaybackService( 8253): Media Info, Media Info Unknown 44
I/MediaPlayer( 8253): Info (1,44)
V/PlaybackService( 8253): Media Info, Media Info Unknown 44
D/NowPlayingBroadcastReceiver( 8253): Intent command received
D/NowPlayingBroadcastReceiver( 8253): Intent action: com.ventismedia.android.mediamonkey.player.PlaybackService.PLAYBACK_STATE_CHANGE_ACTION
D/TrackListModel( 8253): Loading current track preferences
D/TrackListModel( 8253): com.ventismedia.android.mediamonkey.player.video.VideoTrack:1
W/THREAD CONTROL( 8253): Not queried by db thread!!! 27 (26)
D/DB debug( 8253): Query - media
D/DB debug( 8253): Query - media - id
D/QUERY   ( 8253): select _id, title, _data, mime_type  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN medi
a_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE type=5
ORDER BY title COLLATE LOCALIZED ASC
D/QUERY   ( 8253): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=
media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE (type=5) AND (_id=?)
D/QUERY   ( 8253): [1]
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
D/dalvikvm( 8253): GC_EXTERNAL_ALLOC freed 443K, 46% free 3808K/7047K, external 3588K/3927K, paused 44ms
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
D/TrackListModel( 8253): Loading current track preferences
D/TrackListModel( 8253): com.ventismedia.android.mediamonkey.player.video.VideoTrack:1
D/DB debug( 8253): Query - media - id
D/QUERY   ( 8253): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=
media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE (type=5) AND (_id=?)
D/QUERY   ( 8253): [1]
D/NowPlayingBroadcastReceiver( 8253): Intent command received
D/NowPlayingBroadcastReceiver( 8253): Intent action: com.ventismedia.android.mediamonkey.player.PlaybackService.PLAYBACK_STATE_CHANGE_ACTION
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
D/TrackListModel( 8253): Loading current track preferences
D/TrackListModel( 8253): com.ventismedia.android.mediamonkey.player.video.VideoTrack:1
D/DB debug( 8253): Query - media - id
D/QUERY   ( 8253): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=
media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE (type=5) AND (_id=?)
D/QUERY   ( 8253): [1]
D/TrackListModel( 8253): Loading current track preferences
D/TrackListModel( 8253): com.ventismedia.android.mediamonkey.player.video.VideoTrack:1
D/DB debug( 8253): Query - media - id
D/QUERY   ( 8253): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=
media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE (type=5) AND (_id=?)
D/QUERY   ( 8253): [1]
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
D/NowPlayingBroadcastReceiver( 8253): Intent command received
D/NowPlayingBroadcastReceiver( 8253): Intent action: com.ventismedia.android.mediamonkey.player.PlaybackService.PLAYBACK_STATE_CHANGE_ACTION
V/ANDROID_DRM_TEST(   82): getCurrentPosition
V/PlayerDriver(   82): Send player code: 14
V/PlayerDriver(   82): position=103570
V/ANDROID_DRM_TEST(   82): [106] getCurrentPosition = 103570
D/NowPlayingServant( 8253): SeekBar on Progess changed
V/ANDROID_DRM_TEST(   82): getCurrentPosition
V/PlayerDriver(   82): Send player code: 14
V/PlayerDriver(   82): position=103576
V/ANDROID_DRM_TEST(   82): [106] getCurrentPosition = 103576
D/NowPlayingServant( 8253): SeekBar on Progess changed
D/SEC_Overlay(  127): overlay_setPosition(0) 240,400,1,1 => 240,400,8,8
I/SEC_Overlay(  127): Nothing to do!
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
V/PlayerDriver(   82): HandleInformationalEvent: 23
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
V/ANDROID_DRM_TEST(   82): getCurrentPosition
V/PlayerDriver(   82): Send player code: 14
V/PlayerDriver(   82): position=104578
V/ANDROID_DRM_TEST(   82): [106] getCurrentPosition = 104578
D/NowPlayingServant( 8253): SeekBar on Progess changed
I/TransactionManager( 8253): ThreadSerializer exit unlockMain 26
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
V/PlayerDriver(   82): HandleInformationalEvent: 23
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
V/ANDROID_DRM_TEST(   82): getCurrentPosition
V/PlayerDriver(   82): Send player code: 14
V/PlayerDriver(   82): position=105578
V/ANDROID_DRM_TEST(   82): [106] getCurrentPosition = 105578
D/NowPlayingServant( 8253): SeekBar on Progess changed
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
V/PlayerDriver(   82): HandleInformationalEvent: 23
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
D/BatteryService(  127): update start
D/BatteryService(  127): updateBattery level:50 scale:100 status:2 health:2 present:true voltage: 3906 temperature: 390 technology: Li-ion AC powered:
false USB powered:true icon:17302213
I/StatusBarPolicy(  212): BAT. S:2 H:2
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1
V/ANDROID_DRM_TEST(   82): getCurrentPosition
V/PlayerDriver(   82): Send player code: 14
V/PlayerDriver(   82): position=106580
V/ANDROID_DRM_TEST(   82): [106] getCurrentPosition = 106580
D/NowPlayingServant( 8253): SeekBar on Progess changed
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1
E/v4l2_utils(   82): Error = Invalid argument from qbuf
E/VideoMIO(   82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1
^C
D:\tools\AndroidAll\Android\platform-tools>
galaxyS_no_video.txt (18,820 bytes)   
galaxyS_no_video_log2.txt (75,217 bytes)   
09-19 14:42:07.085: I/InputReader(127): dispatchTouch::touch event's action is 0
09-19 14:42:07.085: I/InputDispatcher(127): Delivering touch to current input target: action: 0, channel '407c5fe8 com.ventismedia.android.mediamonkey/com.ventismedia.android.mediamonkey.ui.phone.HomeActivity (server)'
09-19 14:42:07.273: I/InputReader(127): dispatchTouch::touch event's action is 1
09-19 14:42:07.273: I/InputDispatcher(127): Delivering touch to current input target: action: 1, channel '407c5fe8 com.ventismedia.android.mediamonkey/com.ventismedia.android.mediamonkey.ui.phone.HomeActivity (server)'
09-19 14:42:08.128: I/InputReader(127): dispatchTouch::touch event's action is 0
09-19 14:42:08.132: I/InputDispatcher(127): Delivering touch to current input target: action: 0, channel '407c5fe8 com.ventismedia.android.mediamonkey/com.ventismedia.android.mediamonkey.ui.phone.HomeActivity (server)'
09-19 14:42:08.285: I/InputReader(127): dispatchTouch::touch event's action is 1
09-19 14:42:08.285: I/InputDispatcher(127): Delivering touch to current input target: action: 1, channel '407c5fe8 com.ventismedia.android.mediamonkey/com.ventismedia.android.mediamonkey.ui.phone.HomeActivity (server)'
09-19 14:42:08.308: I/ActivityManager(127): Starting: Intent { dat=content://com.ventismedia.android.mediamonkey.provider.MediaMonkeyStoreProvider/audio/media cmp=com.ventismedia.android.mediamonkey/.library.LibraryActivity (has extras) } from pid 15267
09-19 14:42:08.335: W/ActivityManager(127): Trying to launch com.ventismedia.android.mediamonkey/.library.LibraryActivity
09-19 14:42:08.343: E/ResourceType(15267): Style contains key with bad entry: 0x01010336
09-19 14:42:08.343: E/ResourceType(15267): Style contains key with bad entry: 0x01010339
09-19 14:42:08.343: I/SinglePaneActivity(15267): onCreate
09-19 14:42:08.343: W/LOG(15267): setContentView
09-19 14:42:08.355: I/MiniPlayerActivity(15267): onCreate
09-19 14:42:08.363: I/LibraryViewFragment(15267): onActivityCreated
09-19 14:42:08.363: D/VideoFragment(15267): VideoCursorAdapter
09-19 14:42:08.378: W/THREAD CONTROL(15267): Not queried by db thread!!! 25 (-1)
09-19 14:42:08.382: D/DB debug(15267): Query - media
09-19 14:42:08.386: D/QUERY(15267): select _id, title, _data, mime_type  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE type=5  ORDER BY title COLLATE LOCALIZED ASC
09-19 14:42:08.394: D/TrackListModel(15267): Loading current track preferences
09-19 14:42:08.394: D/TrackListModel(15267): com.ventismedia.android.mediamonkey.player.MediaMonkeyStoreTrack:50
09-19 14:42:08.394: W/TransactionManager(15267): New ThreadSerializer id from -1 to 26
09-19 14:42:08.398: D/DB debug(15267): Query - media - id
09-19 14:42:08.398: D/QUERY(15267): select _id, title, _data, album, album_id, artists, track, year, _ms_id, duration, bookmark, playcount, type, volume_leveling, album_art, rating, lyrics, mime_type  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE _id=? 
09-19 14:42:08.402: D/QUERY(15267): [50]
09-19 14:42:08.406: D/TrackListModel(15267): Loading current track preferences
09-19 14:42:08.406: D/TrackListModel(15267): com.ventismedia.android.mediamonkey.player.MediaMonkeyStoreTrack:50
09-19 14:42:08.410: D/DB debug(15267): Query - media - id
09-19 14:42:08.410: D/QUERY(15267): select _id, title, _data, album, album_id, artists, track, year, _ms_id, duration, bookmark, playcount, type, volume_leveling, album_art, rating, lyrics, mime_type  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE _id=? 
09-19 14:42:08.410: D/QUERY(15267): [50]
09-19 14:42:08.417: I/AudioService(127):   Remote Control   registerMediaButtonEventReceiver() for ComponentInfo{com.ventismedia.android.mediamonkey/com.ventismedia.android.mediamonkey.player.MediaButtonIntentReceiver}
09-19 14:42:08.417: I/ContentService(15267): Service is not running
09-19 14:42:08.425: D/PlaybackService(15267): Intent command received
09-19 14:42:08.425: D/PlaybackService(15267): updateNotification app is : in foreground
09-19 14:42:08.425: I/PlaybackService(15267): hideNotification 
09-19 14:42:08.460: D/VideoFragment(15267): setHolderForBindView
09-19 14:42:08.476: D/VideoFragment(15267): setHolderForBindView
09-19 14:42:08.488: D/VideoFragment(15267): setHolderForBindView
09-19 14:42:08.503: D/VideoFragment(15267): setHolderForBindView
09-19 14:42:08.515: D/VideoFragment(15267): setHolderForBindView
09-19 14:42:08.562: D/VideoFragment(15267): Thumbnail exist
09-19 14:42:08.582: I/ActivityManager(127): Displayed com.ventismedia.android.mediamonkey/.library.LibraryActivity: +249ms
09-19 14:42:08.597: D/VideoFragment(15267): Thumbnail exist
09-19 14:42:08.605: D/VideoFragment(15267): Thumbnail exist
09-19 14:42:08.613: D/VideoFragment(15267): Thumbnail exist
09-19 14:42:08.621: D/VideoFragment(15267): Thumbnail exist
09-19 14:42:08.714: D/dalvikvm(15267): GC_EXTERNAL_ALLOC freed 780K, 48% free 3775K/7239K, external 3763K/3806K, paused 27ms
09-19 14:42:09.625: I/TransactionManager(15267): ThreadSerializer exit unlockMain 26
09-19 14:42:11.289: W/PowerManagerService(127): Timer 0x7->0x3|0x0
09-19 14:42:11.289: I/PowerManagerService(127): Ulight 7->3|0
09-19 14:42:11.289: D/LightsService(127): BUTTON : 0
09-19 14:42:11.789: I/InputReader(127): dispatchTouch::touch event's action is 0
09-19 14:42:11.789: I/InputDispatcher(127): Delivering touch to current input target: action: 0, channel '408c1328 com.ventismedia.android.mediamonkey/com.ventismedia.android.mediamonkey.library.LibraryActivity (server)'
09-19 14:42:11.941: I/InputReader(127): dispatchTouch::touch event's action is 1
09-19 14:42:11.945: I/InputDispatcher(127): Delivering touch to current input target: action: 1, channel '408c1328 com.ventismedia.android.mediamonkey/com.ventismedia.android.mediamonkey.library.LibraryActivity (server)'
09-19 14:42:12.132: W/TransactionManager(15267): New ThreadSerializer id from -1 to 27
09-19 14:42:12.148: I/ActivityManager(127): Starting: Intent { dat=file:///mnt/sdcard/tmp/video/VID_20120904_102712.m4v typ=video/mp4 cmp=com.ventismedia.android.mediamonkey/.ui.phone.NowVideoPlayingActivity } from pid 15267
09-19 14:42:12.156: W/ActivityManager(127): Trying to launch com.ventismedia.android.mediamonkey/.ui.phone.NowVideoPlayingActivity
09-19 14:42:12.160: I/PlaybackService(15267): onStartCommand - intent:com.ventismedia.android.mediamonkey.player.PlaybackService.PLAY_ACTION
09-19 14:42:12.214: D/PlaybackNotification(15267): ColorText is light!
09-19 14:42:12.214: I/PlaybackService(15267): Parsing intent
09-19 14:42:12.218: D/TrackListManager(15267): Set clear request true
09-19 14:42:12.218: D/TrackListManager(15267): Add addable
09-19 14:42:12.218: D/TrackListManager(15267): Thread starting...
09-19 14:42:12.218: D/TrackListManager(15267): Clear request
09-19 14:42:12.218: D/TrackListManager(15267): Set clear request false
09-19 14:42:12.218: D/TrackListModel(15267): Storing TrackList to preferences
09-19 14:42:12.234: D/TrackList(15267): addMedia(Uri)
09-19 14:42:12.234: D/TrackListManager(15267): Add immidiate addable
09-19 14:42:12.234: D/TrackListManager(15267): Add addable
09-19 14:42:12.234: D/TrackListManager(15267): Standard request
09-19 14:42:12.234: D/DB debug(15267): Query - media - id
09-19 14:42:12.238: D/QUERY(15267): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE _id=? 
09-19 14:42:12.238: D/QUERY(15267): [2]
09-19 14:42:12.281: I/TrackList(15267): setCurrentTrack
09-19 14:42:12.281: D/TrackListModel(15267): Storing current track preferences
09-19 14:42:12.281: I/PlaybackService(15267): play
09-19 14:42:12.281: I/AudioService(127):   Remote Control   registerMediaButtonEventReceiver() for ComponentInfo{com.ventismedia.android.mediamonkey/com.ventismedia.android.mediamonkey.player.MediaButtonIntentReceiver}
09-19 14:42:12.281: I/AudioService(127):  AudioFocus  requestAudioFocus() from android.media.AudioManager@405c2dd0com.ventismedia.android.mediamonkey.player.PlaybackService@405a78b0
09-19 14:42:12.281: D/PlaybackService(15267): Waiting for play
09-19 14:42:12.281: D/PlaybackService(15267): prepareVideoToPlay
09-19 14:42:12.285: D/PlaybackService(15267): Video playback is not initialized
09-19 14:42:12.285: D/TrackListManager(15267): Add immidiate end
09-19 14:42:12.285: D/TrackListModel(15267): Storing TrackList to preferences
09-19 14:42:12.300: E/ResourceType(15267): Style contains key with bad entry: 0x01010336
09-19 14:42:12.300: E/ResourceType(15267): Style contains key with bad entry: 0x01010339
09-19 14:42:12.300: I/SinglePaneActivity(15267): onCreate
09-19 14:42:12.300: W/LOG(15267): setContentView
09-19 14:42:12.308: D/NowVideoPlayingFragment(15267): onCreate
09-19 14:42:12.308: D/NowVideoPlayingFragment(15267): onCreateView
09-19 14:42:12.390: D/dalvikvm(15267): GC_EXTERNAL_ALLOC freed 668K, 49% free 3741K/7303K, external 3867K/4142K, paused 29ms
09-19 14:42:12.425: D/NowVideoPlayingFragment(15267): onActivityPostCreated
09-19 14:42:12.433: D/NowPlayingSeekHelper(15267): NowPlayingSeekHelper constructor
09-19 14:42:12.433: I/AudioService(127):   Remote Control   registerMediaButtonEventReceiver() for ComponentInfo{com.ventismedia.android.mediamonkey/com.ventismedia.android.mediamonkey.player.MediaButtonIntentReceiver}
09-19 14:42:12.437: D/DB debug(15267): Query - media
09-19 14:42:12.437: D/QUERY(15267): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE type=5 AND (_data=?)  ORDER BY title COLLATE LOCALIZED ASC
09-19 14:42:12.437: D/QUERY(15267): [/mnt/sdcard/tmp/video/VID_20120904_102712.m4v]
09-19 14:42:12.453: D/NowPlayingBroadcastReceiver(15267): Intent command received
09-19 14:42:12.453: D/NowPlayingBroadcastReceiver(15267): Intent action: com.ventismedia.android.mediamonkey.player.PlaybackService.NEXT_TRACK_START_ACTION
09-19 14:42:12.453: D/TrackListModel(15267): Loading current track preferences
09-19 14:42:12.453: D/TrackListModel(15267): com.ventismedia.android.mediamonkey.player.video.VideoTrack:2
09-19 14:42:12.457: D/DB debug(15267): Query - media - id
09-19 14:42:12.457: D/QUERY(15267): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE (type=5) AND (_id=?) 
09-19 14:42:12.457: D/QUERY(15267): [2]
09-19 14:42:12.468: D/NowPlayingBroadcastReceiver(15267): Intent command received
09-19 14:42:12.468: D/NowPlayingBroadcastReceiver(15267): Intent action: com.ventismedia.android.mediamonkey.player.PlaybackService.NEXT_TRACK_START_ACTION
09-19 14:42:12.468: D/TrackListModel(15267): Loading current track preferences
09-19 14:42:12.468: D/TrackListModel(15267): com.ventismedia.android.mediamonkey.player.video.VideoTrack:2
09-19 14:42:12.472: D/DB debug(15267): Query - media - id
09-19 14:42:12.472: D/QUERY(15267): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE (type=5) AND (_id=?) 
09-19 14:42:12.472: D/QUERY(15267): [2]
09-19 14:42:12.484: D/NowVideoPlayingFragment(15267): onServiceConnected
09-19 14:42:12.484: D/NowVideoPlayingFragment(15267): initializePlayerAndPlay
09-19 14:42:12.484: D/NowPlayingServant(15267): MediaPlayer is null
09-19 14:42:12.484: D/PlaybackService(15267): Intent command received
09-19 14:42:12.484: D/PlaybackService(15267): updateNotification app is : in foreground
09-19 14:42:12.484: I/PlaybackService(15267): hideNotification 
09-19 14:42:12.484: I/PlaybackService(15267): onStartCommand - intent:com.ventismedia.android.mediamonkey.player.PlaybackService.PLAY_ACTION
09-19 14:42:12.484: I/PlaybackService(15267): Parsing intent
09-19 14:42:12.484: D/TrackListManager(15267): Set clear request true
09-19 14:42:12.484: D/TrackListManager(15267): Add addable
09-19 14:42:12.484: D/TrackListManager(15267): Clear request
09-19 14:42:12.484: D/TrackListManager(15267): Set clear request false
09-19 14:42:12.484: D/TrackListModel(15267): Storing TrackList to preferences
09-19 14:42:12.492: D/TrackList(15267): addMedia(Uri)
09-19 14:42:12.492: D/TrackListManager(15267): Add immidiate addable
09-19 14:42:12.492: D/TrackListManager(15267): Add addable
09-19 14:42:12.496: D/TrackListManager(15267): Standard request
09-19 14:42:12.496: D/DB debug(15267): Query - media - id
09-19 14:42:12.496: D/QUERY(15267): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE _id=? 
09-19 14:42:12.496: D/QUERY(15267): [2]
09-19 14:42:12.507: I/TrackList(15267): setCurrentTrack
09-19 14:42:12.507: D/TrackListModel(15267): Storing current track preferences
09-19 14:42:12.507: I/PlaybackService(15267): play
09-19 14:42:12.507: I/AudioService(127):   Remote Control   registerMediaButtonEventReceiver() for ComponentInfo{com.ventismedia.android.mediamonkey/com.ventismedia.android.mediamonkey.player.MediaButtonIntentReceiver}
09-19 14:42:12.507: I/AudioService(127):  AudioFocus  requestAudioFocus() from android.media.AudioManager@405c2dd0com.ventismedia.android.mediamonkey.player.PlaybackService@405a78b0
09-19 14:42:12.511: D/PlaybackService(15267): Waiting for play
09-19 14:42:12.511: D/PlaybackService(15267): prepareVideoToPlay
09-19 14:42:12.511: D/PlaybackService(15267): Video playback is not initialized
09-19 14:42:12.511: D/TrackListManager(15267): Add immidiate end
09-19 14:42:12.511: D/TrackListModel(15267): Storing TrackList to preferences
09-19 14:42:12.652: D/NowPlayingBroadcastReceiver(15267): Intent command received
09-19 14:42:12.656: D/NowPlayingBroadcastReceiver(15267): Intent action: com.ventismedia.android.mediamonkey.player.PlaybackService.NEXT_TRACK_START_ACTION
09-19 14:42:12.656: D/TrackListModel(15267): Loading current track preferences
09-19 14:42:12.656: D/TrackListModel(15267): com.ventismedia.android.mediamonkey.player.video.VideoTrack:2
09-19 14:42:12.656: D/DB debug(15267): Query - media - id
09-19 14:42:12.656: D/QUERY(15267): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE (type=5) AND (_id=?) 
09-19 14:42:12.656: D/QUERY(15267): [2]
09-19 14:42:12.667: D/NowPlayingBroadcastReceiver(15267): Intent command received
09-19 14:42:12.667: D/NowPlayingBroadcastReceiver(15267): Intent action: com.ventismedia.android.mediamonkey.player.PlaybackService.NEXT_TRACK_START_ACTION
09-19 14:42:12.667: D/TrackListModel(15267): Loading current track preferences
09-19 14:42:12.667: D/TrackListModel(15267): com.ventismedia.android.mediamonkey.player.video.VideoTrack:2
09-19 14:42:12.671: D/DB debug(15267): Query - media - id
09-19 14:42:12.671: D/QUERY(15267): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE (type=5) AND (_id=?) 
09-19 14:42:12.671: D/QUERY(15267): [2]
09-19 14:42:12.683: D/NowPlayingBroadcastReceiver(15267): Intent command received
09-19 14:42:12.683: D/NowPlayingBroadcastReceiver(15267): Intent action: com.ventismedia.android.mediamonkey.player.PlaybackService.NEXT_TRACK_START_ACTION
09-19 14:42:12.683: D/NowPlayingServant(15267): RECEIVE - NEXT_TRACK_START_ACTION
09-19 14:42:12.718: V/NowVideoPlayingFragment(15267): surfaceCreated
09-19 14:42:12.718: D/NowVideoPlayingFragment(15267): initializePlayerAndPlay
09-19 14:42:12.718: D/PlaybackService(15267): initVideoPlayback
09-19 14:42:12.718: D/PlaybackService(15267): onInitVideoPlayback
09-19 14:42:12.718: D/PlaybackService(15267): prepareVideoToPlay
09-19 14:42:12.718: V/ANDROID_DRM_TEST(82): Client(884) constructor
09-19 14:42:12.718: V/ANDROID_DRM_TEST(82): Create new client(884) from pid 15267, url=/mnt/sdcard/tmp/video/VID_20120904_102712.m4v, connId=884, audioSessionId=229
09-19 14:42:12.718: V/ANDROID_DRM_TEST(82): setDataSource(/mnt/sdcard/tmp/video/VID_20120904_102712.m4v)
09-19 14:42:12.718: V/ANDROID_DRM_TEST(82): player type = 1
09-19 14:42:12.718: V/ANDROID_DRM_TEST(82):  create PVPlayer
09-19 14:42:12.718: V/PlayerDriver(82): PVSuspensionState struct constructor
09-19 14:42:12.718: V/PVPlayer(82): PVPlayer constructor
09-19 14:42:12.718: V/PVPlayer(82): construct PlayerDriver
09-19 14:42:12.718: V/PlayerDriver(82): constructor
09-19 14:42:12.718: V/PlayerDriver(82): OpenCore hardware module not found
09-19 14:42:12.718: V/PlayerDriver(82): start player thread
09-19 14:42:12.722: V/PlayerDriver(82): startPlayerThread
09-19 14:42:12.722: V/PlayerDriver(82): InitializeForThread
09-19 14:42:12.722: V/PlayerDriver(82): OMX_MasterInit
09-19 14:42:12.722: V/PlayerDriver(82): OsclScheduler::Init
09-19 14:42:12.722: V/PlayerDriver(82): CreatePlayer
09-19 14:42:12.742: V/PlayerDriver(82): AddToScheduler
09-19 14:42:12.742: V/PlayerDriver(82): PendForExec
09-19 14:42:12.742: V/PlayerDriver(82): OsclActiveScheduler::Current
09-19 14:42:12.742: V/PlayerDriver(82): StartScheduler
09-19 14:42:12.746: V/PVPlayer(82): send PLAYER_SETUP
09-19 14:42:12.746: V/PlayerDriver(82): Send player code: 2
09-19 14:42:12.746: V/PlayerDriver(82): CommandCompleted
09-19 14:42:12.746: V/PlayerDriver(82): Completed command PLAYER_SETUP status=1
09-19 14:42:12.746: V/AudioSink(82): AudioOutput(229)
09-19 14:42:12.746: V/ANDROID_DRM_TEST(82):  setDataSource
09-19 14:42:12.746: V/PVPlayer(82): setDataSource(/mnt/sdcard/tmp/video/VID_20120904_102712.m4v)
09-19 14:42:12.746: I/PlayerDriver(82): PlayerDriver::isProtectedFile(/mnt/sdcard/tmp/video/VID_20120904_102712.m4v)
09-19 14:42:12.746: V/PlayerDriver(82): File EXT is : .m4v
09-19 14:42:12.746: E/PlayerDriver(82): PlayerDriver::it is a not Protected file
09-19 14:42:12.746: V/ANDROID_DRM_TEST(82): [884] setVideoSurface(0x63b68)
09-19 14:42:12.746: V/PVPlayer(82): setVideoSurface(0x63b68)
09-19 14:42:12.746: D/PlaybackService(15267): call prepare media player
09-19 14:42:12.746: V/ANDROID_DRM_TEST(82): [884] setVideoSurface(0x63cb0)
09-19 14:42:12.746: V/PVPlayer(82): setVideoSurface(0x63cb0)
09-19 14:42:12.746: V/ANDROID_DRM_TEST(82): [884] setAudioStreamType(3)
09-19 14:42:12.746: V/ANDROID_DRM_TEST(82): [884] prepareAsync
09-19 14:42:12.746: V/PVPlayer(82): prepareAsync
09-19 14:42:12.746: V/PVPlayer(82):   data source = /mnt/sdcard/tmp/video/VID_20120904_102712.m4v
09-19 14:42:12.746: V/PlayerDriver(82): Send player code: 3
09-19 14:42:12.746: V/PlayerDriver(82): handleSetDataSource
09-19 14:42:12.746: V/PlayerDriver(82): handleSetDataSource- scanning for extension
09-19 14:42:12.761: V/PlayerDriver(82): CommandCompleted
09-19 14:42:12.761: V/PlayerDriver(82): Completed command PLAYER_SET_DATA_SOURCE status=1
09-19 14:42:12.761: V/PVPlayer(82): run_init s=0, cancelled=0
09-19 14:42:12.761: V/PlayerDriver(82): Send player code: 6
09-19 14:42:12.761: V/PlayerDriver(82): release string is 2.3.3 len 5
09-19 14:42:12.769: E/(82): ASF_HeaderObjectLoad : ERROR code = 4
09-19 14:42:12.769: E/OsclAsyncFile(82): OsclAsyncFile::ConstructL!! 
09-19 14:42:12.886: V/PlayerDriver(82): HandleInformationalEvent: 41
09-19 14:42:12.890: V/PlayerDriver(82): .... with duration = 10880 ms
09-19 14:42:12.890: V/PlayerDriver(82): CommandCompleted
09-19 14:42:12.890: V/PlayerDriver(82): Completed command PLAYER_INIT status=1
09-19 14:42:12.890: V/PVPlayer(82): run_set_video_surface s=0, cancelled=0
09-19 14:42:12.890: V/PlayerDriver(82): Send player code: 4
09-19 14:42:12.890: W/PlayerDriver(82): Using generic video MIO
09-19 14:42:12.894: V/PlayerDriver(82): CommandCompleted
09-19 14:42:12.894: V/PlayerDriver(82): Completed command PLAYER_SET_VIDEO_SURFACE status=1
09-19 14:42:12.894: V/PVPlayer(82): run_set_audio_output s=0, cancelled=0
09-19 14:42:12.898: V/PlayerDriver(82): Send player code: 5
09-19 14:42:12.898: V/PlayerDriver(82): Create realtime output
09-19 14:42:12.902: V/PlayerDriver(82): CommandCompleted
09-19 14:42:12.902: V/PlayerDriver(82): Completed command PLAYER_SET_AUDIO_SINK status=1
09-19 14:42:12.902: V/PVPlayer(82): run_prepare s=0, cancelled=0
09-19 14:42:12.902: V/PlayerDriver(82): Send player code: 7
09-19 14:42:12.902: V/PlayerDriver(82): disable natpkt - 0
09-19 14:42:12.917: E/OsclAsyncFile(82): OsclAsyncFile::ConstructL!! 
09-19 14:42:13.046: E/OsclAsyncFile(82): OsclAsyncFile::ConstructL!! 
09-19 14:42:13.179: V/AudioSink(82): open(16000, 2, 1, 4, 229)
09-19 14:42:13.179: V/AudioSink(82): setVolume
09-19 14:42:13.191: V/PlayerDriver(82): HandleInformationalEvent: 44
09-19 14:42:13.191: V/PlayerDriver(82): HandleInformationalEvent: type=44 UNHANDLED
09-19 14:42:13.191: V/ANDROID_DRM_TEST(82): [884] notify (0xc6638, 200, 1, 44)
09-19 14:42:13.191: W/MediaPlayer(15267): info/warning (1, 44)
09-19 14:42:13.191: V/PlayerDriver(82): CommandCompleted
09-19 14:42:13.191: V/PlayerDriver(82): Completed command PLAYER_PREPARE status=1
09-19 14:42:13.191: V/PlayerDriver(82): PLAYER_PREPARE complete mDownloadContextData=0x0, mDataReadyReceived=0
09-19 14:42:13.191: V/ANDROID_DRM_TEST(82): [884] notify (0xc6638, 1, 0, 0)
09-19 14:42:13.191: V/NowVideoPlayingFragment(15267): surfaceChanged Called width: 480height: 800
09-19 14:42:13.199: V/PVPlayer(82): check_for_live_streaming s=0, cancelled=0
09-19 14:42:13.222: I/ActivityManager(127): Displayed com.ventismedia.android.mediamonkey/.ui.phone.NowVideoPlayingActivity: +1s67ms
09-19 14:42:13.238: I/MediaPlayer(15267): Info (1,44)
09-19 14:42:13.238: V/PlaybackService(15267): Media Info, Media Info Unknown 44
09-19 14:42:13.238: D/PlaybackService(15267): onPrepared
09-19 14:42:13.242: I/VideoUtils(15267): Video size by display change to width: 0 height: 0
09-19 14:42:13.242: I/VideoUtils(15267): Video size changed to width: 0 height: 0
09-19 14:42:13.242: I/PlaybackService(15267): play
09-19 14:42:13.242: I/AudioService(127):   Remote Control   registerMediaButtonEventReceiver() for ComponentInfo{com.ventismedia.android.mediamonkey/com.ventismedia.android.mediamonkey.player.MediaButtonIntentReceiver}
09-19 14:42:13.242: I/AudioService(127):  AudioFocus  requestAudioFocus() from android.media.AudioManager@405c2dd0com.ventismedia.android.mediamonkey.player.PlaybackService@405a78b0
09-19 14:42:13.242: D/PlaybackService(15267): Track can be played
09-19 14:42:13.242: V/PlayerDriver(82): Send player code: 16
09-19 14:42:13.242: V/PlayerDriver(82): status=3
09-19 14:42:13.242: V/ANDROID_DRM_TEST(82): [884] isPlaying: 0
09-19 14:42:13.246: V/ANDROID_DRM_TEST(82): [884] reset
09-19 14:42:13.246: E/PVPlayer(82): isDrmfile playing 0
09-19 14:42:13.246: V/PVPlayer(82): reset
09-19 14:42:13.246: V/PlayerDriver(82): Send player code: 18
09-19 14:42:13.246: V/PlayerDriver(82): handleCancelAllCommands
09-19 14:42:13.250: V/AudioSink(82): stop
09-19 14:42:13.250: V/AudioSink(82): stop
09-19 14:42:13.250: V/AudioSink(82): stop
09-19 14:42:13.250: V/AudioSink(82): stop
09-19 14:42:13.511: V/PlayerDriver(82): CommandCompleted
09-19 14:42:13.511: V/PlayerDriver(82): Completed command PLAYER_CANCEL_ALL_COMMANDS status=1
09-19 14:42:13.511: V/PlayerDriver(82): Send player code: 11
09-19 14:42:13.511: V/PlayerDriver(82): handleReset
09-19 14:42:13.511: E/PlayerDriver(82): PlayerDriver::handleTvOut state=[4]
09-19 14:42:13.511: E/PlayerDriver(82): PlayerDriver::it is not a DRM file.So don't resume TVOUT
09-19 14:42:13.511: V/PlayerDriver(82): CommandCompleted
09-19 14:42:13.511: V/PlayerDriver(82): Completed command PLAYER_RESET status=1
09-19 14:42:13.511: V/PlayerDriver(82): Send player code: 17
09-19 14:42:13.511: V/PlayerDriver(82): handleRemoveDataSource
09-19 14:42:13.511: V/PlayerDriver(82): CommandCompleted
09-19 14:42:13.511: V/PlayerDriver(82): Completed command PLAYER_REMOVE_DATA_SOURCE status=1
09-19 14:42:13.511: V/PVPlayer(82): unmap file
09-19 14:42:13.511: V/ANDROID_DRM_TEST(82): Client(885) constructor
09-19 14:42:13.511: V/ANDROID_DRM_TEST(82): Create new client(885) from pid 15267, url=/mnt/sdcard/tmp/video/VID_20120904_102712.m4v, connId=885, audioSessionId=229
09-19 14:42:13.511: V/ANDROID_DRM_TEST(82): setDataSource(/mnt/sdcard/tmp/video/VID_20120904_102712.m4v)
09-19 14:42:13.511: V/ANDROID_DRM_TEST(82): player type = 1
09-19 14:42:13.511: V/ANDROID_DRM_TEST(82):  create PVPlayer
09-19 14:42:13.511: V/PlayerDriver(82): PVSuspensionState struct constructor
09-19 14:42:13.511: V/PVPlayer(82): PVPlayer constructor
09-19 14:42:13.511: V/PVPlayer(82): construct PlayerDriver
09-19 14:42:13.511: V/PlayerDriver(82): constructor
09-19 14:42:13.511: V/PlayerDriver(82): OpenCore hardware module not found
09-19 14:42:13.511: V/PlayerDriver(82): start player thread
09-19 14:42:13.519: V/PlayerDriver(82): startPlayerThread
09-19 14:42:13.519: V/PlayerDriver(82): InitializeForThread
09-19 14:42:13.519: V/PlayerDriver(82): OMX_MasterInit
09-19 14:42:13.519: V/PlayerDriver(82): OsclScheduler::Init
09-19 14:42:13.519: V/PlayerDriver(82): CreatePlayer
09-19 14:42:13.527: V/PlayerDriver(82): AddToScheduler
09-19 14:42:13.527: V/PlayerDriver(82): PendForExec
09-19 14:42:13.527: V/PlayerDriver(82): OsclActiveScheduler::Current
09-19 14:42:13.527: V/PlayerDriver(82): StartScheduler
09-19 14:42:13.527: V/PVPlayer(82): send PLAYER_SETUP
09-19 14:42:13.527: V/PlayerDriver(82): Send player code: 2
09-19 14:42:13.527: V/PlayerDriver(82): CommandCompleted
09-19 14:42:13.527: V/PlayerDriver(82): Completed command PLAYER_SETUP status=1
09-19 14:42:13.527: V/AudioSink(82): AudioOutput(229)
09-19 14:42:13.527: V/ANDROID_DRM_TEST(82):  setDataSource
09-19 14:42:13.527: V/PVPlayer(82): setDataSource(/mnt/sdcard/tmp/video/VID_20120904_102712.m4v)
09-19 14:42:13.527: I/PlayerDriver(82): PlayerDriver::isProtectedFile(/mnt/sdcard/tmp/video/VID_20120904_102712.m4v)
09-19 14:42:13.527: V/PlayerDriver(82): File EXT is : .m4v
09-19 14:42:13.527: E/PlayerDriver(82): PlayerDriver::it is a not Protected file
09-19 14:42:13.527: V/ANDROID_DRM_TEST(82): disconnect(884) from pid 15267
09-19 14:42:13.527: V/PVPlayer(82): reset
09-19 14:42:13.527: V/PlayerDriver(82): Send player code: 18
09-19 14:42:13.527: V/PlayerDriver(82): handleCancelAllCommands
09-19 14:42:13.527: V/PlayerDriver(82): CommandCompleted
09-19 14:42:13.527: V/PlayerDriver(82): Completed command PLAYER_CANCEL_ALL_COMMANDS status=1
09-19 14:42:13.531: V/PlayerDriver(82): Send player code: 11
09-19 14:42:13.531: V/PlayerDriver(82): handleReset
09-19 14:42:13.531: E/PlayerDriver(82): PlayerDriver::handleTvOut state=[4]
09-19 14:42:13.531: E/PlayerDriver(82): PlayerDriver::it is not a DRM file.So don't resume TVOUT
09-19 14:42:13.531: V/PlayerDriver(82): CommandCompleted
09-19 14:42:13.531: V/PlayerDriver(82): Completed command PLAYER_RESET status=1
09-19 14:42:13.531: V/PlayerDriver(82): Send player code: 17
09-19 14:42:13.531: V/PlayerDriver(82): handleRemoveDataSource
09-19 14:42:13.531: V/PlayerDriver(82): CommandCompleted
09-19 14:42:13.531: V/PlayerDriver(82): Completed command PLAYER_REMOVE_DATA_SOURCE status=1
09-19 14:42:13.531: V/PVPlayer(82): unmap file
09-19 14:42:13.531: V/PVPlayer(82): PVPlayer destructor
09-19 14:42:13.531: V/PlayerDriver(82): Send player code: 1
09-19 14:42:13.531: V/PlayerDriver(82): DeletePlayer
09-19 14:42:13.531: V/PlayerDriver(82): destructor
09-19 14:42:13.531: V/PlayerDriver(82): OsclScheduler::Cleanup
09-19 14:42:13.531: V/PlayerDriver(82): PVSuspensionState struct destructor
09-19 14:42:13.531: V/ANDROID_DRM_TEST(82): [885] setVideoSurface(0x74480)
09-19 14:42:13.531: V/PVPlayer(82): setVideoSurface(0x74480)
09-19 14:42:13.531: V/ANDROID_DRM_TEST(82): Client(884) destructor pid = 15267
09-19 14:42:13.531: V/AudioSink(82): close
09-19 14:42:13.531: V/AudioPolicyManager(82): releaseOutput() 1
09-19 14:42:13.535: V/ANDROID_DRM_TEST(82): disconnect(884) from pid 15267
09-19 14:42:13.535: V/ANDROID_DRM_TEST(82): [885] setAudioStreamType(3)
09-19 14:42:13.535: V/ANDROID_DRM_TEST(82): [885] prepareAsync
09-19 14:42:13.535: V/PVPlayer(82): prepareAsync
09-19 14:42:13.535: V/PVPlayer(82):   data source = /mnt/sdcard/tmp/video/VID_20120904_102712.m4v
09-19 14:42:13.539: V/PlayerDriver(82): Send player code: 3
09-19 14:42:13.539: V/PlayerDriver(82): handleSetDataSource
09-19 14:42:13.539: V/PlayerDriver(82): handleSetDataSource- scanning for extension
09-19 14:42:13.550: V/PlayerDriver(82): CommandCompleted
09-19 14:42:13.550: V/PlayerDriver(82): Completed command PLAYER_SET_DATA_SOURCE status=1
09-19 14:42:13.550: V/PVPlayer(82): run_init s=0, cancelled=0
09-19 14:42:13.550: V/PlayerDriver(82): Send player code: 6
09-19 14:42:13.550: V/PlayerDriver(82): release string is 2.3.3 len 5
09-19 14:42:13.554: E/(82): ASF_HeaderObjectLoad : ERROR code = 4
09-19 14:42:13.554: E/OsclAsyncFile(82): OsclAsyncFile::ConstructL!! 
09-19 14:42:13.671: V/PlayerDriver(82): HandleInformationalEvent: 41
09-19 14:42:13.671: V/PlayerDriver(82): .... with duration = 10880 ms
09-19 14:42:13.671: V/PlayerDriver(82): CommandCompleted
09-19 14:42:13.671: V/PlayerDriver(82): Completed command PLAYER_INIT status=1
09-19 14:42:13.671: V/PVPlayer(82): run_set_video_surface s=0, cancelled=0
09-19 14:42:13.675: V/PlayerDriver(82): Send player code: 4
09-19 14:42:13.675: W/PlayerDriver(82): Using generic video MIO
09-19 14:42:13.675: V/PlayerDriver(82): CommandCompleted
09-19 14:42:13.675: V/PlayerDriver(82): Completed command PLAYER_SET_VIDEO_SURFACE status=1
09-19 14:42:13.675: V/PVPlayer(82): run_set_audio_output s=0, cancelled=0
09-19 14:42:13.675: V/PlayerDriver(82): Send player code: 5
09-19 14:42:13.675: V/PlayerDriver(82): Create realtime output
09-19 14:42:13.679: V/PlayerDriver(82): CommandCompleted
09-19 14:42:13.679: V/PlayerDriver(82): Completed command PLAYER_SET_AUDIO_SINK status=1
09-19 14:42:13.679: V/PVPlayer(82): run_prepare s=0, cancelled=0
09-19 14:42:13.679: V/PlayerDriver(82): Send player code: 7
09-19 14:42:13.679: V/PlayerDriver(82): disable natpkt - 0
09-19 14:42:13.683: E/OsclAsyncFile(82): OsclAsyncFile::ConstructL!! 
09-19 14:42:13.695: I/TransactionManager(15267): ThreadSerializer exit unlockMain 27
09-19 14:42:13.808: E/OsclAsyncFile(82): OsclAsyncFile::ConstructL!! 
09-19 14:42:13.859: D/BatteryService(127): update start
09-19 14:42:13.863: D/BatteryService(127): updateBattery level:75 scale:100 status:2 health:2 present:true voltage: 4010 temperature: 330 technology: Li-ion AC powered:false USB powered:true icon:17302213
09-19 14:42:13.882: I/StatusBarPolicy(212): BAT. S:2 H:2
09-19 14:42:13.941: V/AudioSink(82): open(16000, 2, 1, 4, 229)
09-19 14:42:13.941: V/AudioSink(82): setVolume
09-19 14:42:13.945: V/PlayerDriver(82): HandleInformationalEvent: 44
09-19 14:42:13.945: V/PlayerDriver(82): HandleInformationalEvent: type=44 UNHANDLED
09-19 14:42:13.945: V/ANDROID_DRM_TEST(82): [885] notify (0xf5678, 200, 1, 44)
09-19 14:42:13.945: W/MediaPlayer(15267): info/warning (1, 44)
09-19 14:42:13.945: V/PlayerDriver(82): CommandCompleted
09-19 14:42:13.945: V/PlayerDriver(82): Completed command PLAYER_PREPARE status=1
09-19 14:42:13.945: V/PlayerDriver(82): PLAYER_PREPARE complete mDownloadContextData=0x0, mDataReadyReceived=0
09-19 14:42:13.945: V/ANDROID_DRM_TEST(82): [885] notify (0xf5678, 1, 0, 0)
09-19 14:42:13.945: V/ANDROID_DRM_TEST(82): [885] setLooping(0)
09-19 14:42:13.945: V/PVPlayer(82): setLooping(0)
09-19 14:42:13.945: V/PVPlayer(82): check_for_live_streaming s=0, cancelled=0
09-19 14:42:13.949: V/PlayerDriver(82): Send player code: 12
09-19 14:42:13.949: V/ANDROID_DRM_TEST(82): [885] setVolume(1.000000, 1.000000)
09-19 14:42:13.949: V/AudioSink(82): setVolume(1.000000, 1.000000)
09-19 14:42:13.949: V/ANDROID_DRM_TEST(82): [885] setAuxEffectSendLevel(0.000000)
09-19 14:42:13.949: V/AudioSink(82): setAuxEffectSendLevel(0.000000)
09-19 14:42:13.949: V/ANDROID_DRM_TEST(82): [885] start
09-19 14:42:13.949: V/PVPlayer(82): setLooping(0)
09-19 14:42:13.949: V/PlayerDriver(82): Send player code: 12
09-19 14:42:13.949: E/PVPlayer(82): isDrmfile playing 0
09-19 14:42:13.949: E/ANDROID_DRM_TEST(82):   MediaPlayerService::mIsAnyDrmVideoPlaying : 0
09-19 14:42:13.949: V/PVPlayer(82): start
09-19 14:42:13.949: V/PlayerDriver(82): Send player code: 8
09-19 14:42:13.953: E/PlayerDriver(82): PlayerDriver::handleTvOut state=[1]
09-19 14:42:13.953: E/PlayerDriver(82): PlayerDriver::it is not a DRM file.So don't suspend TVOUT
09-19 14:42:13.953: V/PlayerDriver(82): CommandCompleted
09-19 14:42:13.953: V/PlayerDriver(82): Completed command PLAYER_START status=1
09-19 14:42:13.953: V/ANDROID_DRM_TEST(82): getDuration
09-19 14:42:13.953: V/PlayerDriver(82): Send player code: 15
09-19 14:42:13.953: V/PlayerDriver(82): CommandCompleted
09-19 14:42:13.953: V/PlayerDriver(82): Completed command PLAYER_GET_DURATION status=1
09-19 14:42:13.953: V/ANDROID_DRM_TEST(82): [885] getDuration = 10880
09-19 14:42:13.953: V/ANDROID_DRM_TEST(82): [885] seekTo(0)
09-19 14:42:13.953: V/PVPlayer(82): seekTo(0)
09-19 14:42:13.953: V/ANDROID_DRM_TEST(82): [885] setVolume(0.900000, 0.900000)
09-19 14:42:13.953: V/AudioSink(82): setVolume(0.900000, 0.900000)
09-19 14:42:13.953: I/VideoTrack(15267): updatePlaycount
09-19 14:42:13.960: V/PlayerDriver(82): Send player code: 13
09-19 14:42:13.960: V/PlayerDriver(82): handleSeek
09-19 14:42:13.988: W/TransactionManager(15267): New ThreadSerializer id from -1 to 29
09-19 14:42:14.093: D/PlaybackService(15267): updateNotification app is : in foreground
09-19 14:42:14.093: I/PlaybackService(15267): hideNotification 
09-19 14:42:14.097: V/PlayerDriver(82): Send player code: 16
09-19 14:42:14.097: V/PlayerDriver(82): status=4
09-19 14:42:14.097: V/ANDROID_DRM_TEST(82): [885] isPlaying: 1
09-19 14:42:14.113: D/PlayerWidgetModel(15267): Loading widget Ids
09-19 14:42:14.242: V/NowVideoPlayingFragment(15267): surfaceChanged Called width: 0height: 0
09-19 14:42:14.246: E/VideoMIO(82): AndroidSurfaceOutput::setParametersSync()  VIDEO RENDERER 1
09-19 14:42:14.250: D/SEC_Overlay(127): overlay_createOverlay:IN w=720 h=480 format=272
09-19 14:42:14.250: D/SEC_Overlay(127): src width, height are changed [w= 720, h= 480]->[w=720, h= 480]
09-19 14:42:14.253: I/SEC_Overlay(127): Opened video1/fd=291/obj=0042f0f8/shm=290/size=4096
09-19 14:42:14.257: I/SEC_Overlay(82): Postponing Stream Enable/0/1
09-19 14:42:14.257: I/VideoMIO(82): initCheck() direct start
09-19 14:42:14.257: V/ANDROID_DRM_TEST(82): [885] notify (0xf5678, 5, 720, 480)
09-19 14:42:14.261: V/PlayerDriver(82): HandleInformationalEvent: 44
09-19 14:42:14.261: V/PlayerDriver(82): HandleInformationalEvent: type=44 UNHANDLED
09-19 14:42:14.261: V/ANDROID_DRM_TEST(82): [885] notify (0xf5678, 200, 1, 44)
09-19 14:42:14.265: V/PlayerDriver(82): CommandCompleted
09-19 14:42:14.265: V/PlayerDriver(82): Completed command PLAYER_SEEK status=1
09-19 14:42:14.265: V/ANDROID_DRM_TEST(82): [885] notify (0xf5678, 4, 0, 0)
09-19 14:42:14.265: W/MediaPlayer(15267): info/warning (1, 44)
09-19 14:42:14.265: D/SEC_Overlay(127): overlay_setPosition(0) 240,400,1,1 => 240,400,8,8
09-19 14:42:14.265: I/SEC_Overlay(127): Rotation/0
09-19 14:42:14.265: W/v4l2_utils(127): v4l2_overlay_set_position:: (0,0,0,0)=>(240,400,8,8) rot=0
09-19 14:42:14.273: V/AudioSink(82): flush
09-19 14:42:14.273: V/AudioSink(82): start
09-19 14:42:14.273: V/AudioPolicyManager(82): startOutput() output 1, stream 3, session 229
09-19 14:42:14.273: V/AudioPolicyManager(82): getDeviceForStrategy() from cache strategy 0, device 2
09-19 14:42:14.273: V/AudioPolicyManager(82): getDeviceForStrategy() from cache strategy 0, device 2
09-19 14:42:14.273: V/AudioPolicyManager(82): getNewDevice() selected device 2
09-19 14:42:14.273: V/AudioPolicyManager(82): setOutputDevice() output 1 device 2 delayMs 0 force 0
09-19 14:42:14.273: V/AudioPolicyManager(82): setOutputDevice() setting same device 2 or null device for output 1
09-19 14:42:14.281: D/AudioHardwareALSA(82): Calling setDevice from write @..1874.
09-19 14:42:14.296: I/MediaPlayer(15267): Info (1,44)
09-19 14:42:14.296: V/PlaybackService(15267): Media Info, Media Info Unknown 44
09-19 14:42:14.296: D/NowPlayingBroadcastReceiver(15267): Intent command received
09-19 14:42:14.296: D/NowPlayingBroadcastReceiver(15267): Intent action: com.ventismedia.android.mediamonkey.player.PlaybackService.PLAYBACK_STATE_CHANGE_ACTION
09-19 14:42:14.296: D/TrackListModel(15267): Loading current track preferences
09-19 14:42:14.296: D/TrackListModel(15267): com.ventismedia.android.mediamonkey.player.video.VideoTrack:2
09-19 14:42:14.300: D/DB debug(15267): Query - media - id
09-19 14:42:14.300: W/THREAD CONTROL(15267): Not queried by db thread!!! 30 (29)
09-19 14:42:14.300: D/DB debug(15267): Query - media
09-19 14:42:14.300: D/QUERY(15267): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE (type=5) AND (_id=?) 
09-19 14:42:14.300: D/QUERY(15267): select _id, title, _data, mime_type  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE type=5  ORDER BY title COLLATE LOCALIZED ASC
09-19 14:42:14.300: D/QUERY(15267): [2]
09-19 14:42:14.335: I/AudioHardwareALSA(82): Initialized ALSA PLAYBACK device AndroidPlayback_Speaker_normal
09-19 14:42:14.335: V/AudioHardwareALSA(82): Set PLAYBACK PCM format to S16_LE (Signed 16 bit Little Endian)
09-19 14:42:14.335: D/AudioHardwareALSA(82): Using 2 channels for PLAYBACK.
09-19 14:42:14.335: I/AudioHardwareALSA(82): DEFAULT_SAMPLE_RATE is 44100, mDefaults->sampleRate is 44100
09-19 14:42:14.335: D/AudioHardwareALSA(82): Set PLAYBACK sample rate to 44100 HZ
09-19 14:42:14.335: D/AudioHardwareALSA(82): Buffer size: 4096
09-19 14:42:14.335: D/AudioHardwareALSA(82): Latency: 92879
09-19 14:42:14.359: W/AudioFlinger(82): write blocked for 78 msecs, 151 delayed writes, thread 0x2fc40
09-19 14:42:14.386: D/dalvikvm(15267): GC_EXTERNAL_ALLOC freed 392K, 48% free 3858K/7303K, external 3386K/4214K, paused 59ms
09-19 14:42:14.398: D/TrackListModel(15267): Loading current track preferences
09-19 14:42:14.398: D/TrackListModel(15267): com.ventismedia.android.mediamonkey.player.video.VideoTrack:2
09-19 14:42:14.402: D/DB debug(15267): Query - media - id
09-19 14:42:14.402: D/QUERY(15267): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE (type=5) AND (_id=?) 
09-19 14:42:14.406: D/QUERY(15267): [2]
09-19 14:42:14.421: D/NowPlayingBroadcastReceiver(15267): Intent command received
09-19 14:42:14.421: D/NowPlayingBroadcastReceiver(15267): Intent action: com.ventismedia.android.mediamonkey.player.PlaybackService.PLAYBACK_STATE_CHANGE_ACTION
09-19 14:42:14.425: D/TrackListModel(15267): Loading current track preferences
09-19 14:42:14.425: D/TrackListModel(15267): com.ventismedia.android.mediamonkey.player.video.VideoTrack:2
09-19 14:42:14.425: D/DB debug(15267): Query - media - id
09-19 14:42:14.425: D/QUERY(15267): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE (type=5) AND (_id=?) 
09-19 14:42:14.425: D/QUERY(15267): [2]
09-19 14:42:14.437: D/TrackListModel(15267): Loading current track preferences
09-19 14:42:14.437: D/TrackListModel(15267): com.ventismedia.android.mediamonkey.player.video.VideoTrack:2
09-19 14:42:14.441: D/DB debug(15267): Query - media - id
09-19 14:42:14.441: D/QUERY(15267): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE (type=5) AND (_id=?) 
09-19 14:42:14.441: D/QUERY(15267): [2]
09-19 14:42:14.457: D/NowPlayingBroadcastReceiver(15267): Intent command received
09-19 14:42:14.457: D/NowPlayingBroadcastReceiver(15267): Intent action: com.ventismedia.android.mediamonkey.player.PlaybackService.PLAYBACK_STATE_CHANGE_ACTION
09-19 14:42:14.457: V/ANDROID_DRM_TEST(82): getCurrentPosition
09-19 14:42:14.457: V/PlayerDriver(82): Send player code: 14
09-19 14:42:14.457: V/PlayerDriver(82): position=92
09-19 14:42:14.457: V/ANDROID_DRM_TEST(82): [885] getCurrentPosition = 92
09-19 14:42:14.457: D/NowPlayingServant(15267): SeekBar on Progess changed
09-19 14:42:14.460: V/ANDROID_DRM_TEST(82): getCurrentPosition
09-19 14:42:14.460: V/PlayerDriver(82): Send player code: 14
09-19 14:42:14.460: V/PlayerDriver(82): position=94
09-19 14:42:14.460: V/ANDROID_DRM_TEST(82): [885] getCurrentPosition = 94
09-19 14:42:14.460: D/NowPlayingServant(15267): SeekBar on Progess changed
09-19 14:42:14.472: D/SEC_Overlay(127): overlay_setPosition(0) 240,400,1,1 => 240,400,8,8
09-19 14:42:14.472: I/SEC_Overlay(127): Nothing to do!
09-19 14:42:14.476: I/MediaPlayer(15267): Info (1,44)
09-19 14:42:14.476: V/PlaybackService(15267): Media Info, Media Info Unknown 44
09-19 14:42:14.492: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:14.492: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:14.546: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:14.546: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:14.597: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:14.597: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:14.640: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:14.640: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:14.695: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:14.695: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:14.742: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:14.742: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:14.796: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:14.796: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:14.847: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:14.847: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:14.937: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:14.937: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:14.949: W/PowerManagerService(127): Timer 0x3->0x3|0x3
09-19 14:42:14.980: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:14.980: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:15.023: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.023: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:15.066: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.066: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:15.109: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.109: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:15.152: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.152: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:15.175: V/PlayerDriver(82): HandleInformationalEvent: 23
09-19 14:42:15.195: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.195: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:15.238: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.238: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:15.281: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.281: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:15.328: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.328: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:15.371: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.371: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:15.414: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.414: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:15.457: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.457: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:15.460: V/ANDROID_DRM_TEST(82): getCurrentPosition
09-19 14:42:15.460: V/PlayerDriver(82): Send player code: 14
09-19 14:42:15.460: V/PlayerDriver(82): position=1096
09-19 14:42:15.460: V/ANDROID_DRM_TEST(82): [885] getCurrentPosition = 1096
09-19 14:42:15.464: D/NowPlayingServant(15267): SeekBar on Progess changed
09-19 14:42:15.468: I/TransactionManager(15267): ThreadSerializer exit unlockMain 29
09-19 14:42:15.503: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.503: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:15.519: D/TrackListManager(15267): Thread ending
09-19 14:42:15.546: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.546: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:15.589: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.589: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:15.632: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.632: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:15.675: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.675: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:15.718: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.718: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:15.765: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.765: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:15.808: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.808: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:15.851: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.851: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:15.898: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.898: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:15.937: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.937: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:15.984: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:15.984: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:16.027: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.027: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:16.070: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.070: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:16.113: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.113: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:16.156: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.156: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:16.175: V/PlayerDriver(82): HandleInformationalEvent: 23
09-19 14:42:16.199: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.199: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:16.242: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.242: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:16.289: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.289: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:16.332: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.332: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:16.375: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.375: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:16.421: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.421: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:16.464: V/ANDROID_DRM_TEST(82): getCurrentPosition
09-19 14:42:16.464: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.464: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:16.464: V/PlayerDriver(82): Send player code: 14
09-19 14:42:16.464: V/PlayerDriver(82): position=2099
09-19 14:42:16.464: V/ANDROID_DRM_TEST(82): [885] getCurrentPosition = 2099
09-19 14:42:16.464: D/NowPlayingServant(15267): SeekBar on Progess changed
09-19 14:42:16.507: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.507: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:16.550: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.550: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:16.593: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.593: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:16.644: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.644: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:16.679: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.679: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:16.726: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.726: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:16.773: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.773: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:16.812: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.812: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:16.859: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.859: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:16.898: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.898: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:16.945: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.945: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:16.988: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:16.988: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:17.035: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.035: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:17.074: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.074: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:17.121: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.121: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:17.160: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.160: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:17.175: V/PlayerDriver(82): HandleInformationalEvent: 23
09-19 14:42:17.203: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.203: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:17.250: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.250: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:17.292: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.292: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:17.335: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.335: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:17.378: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.378: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:17.425: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.425: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:17.468: V/ANDROID_DRM_TEST(82): getCurrentPosition
09-19 14:42:17.468: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.468: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:17.468: V/PlayerDriver(82): Send player code: 14
09-19 14:42:17.468: V/PlayerDriver(82): position=3103
09-19 14:42:17.468: V/ANDROID_DRM_TEST(82): [885] getCurrentPosition = 3103
09-19 14:42:17.468: D/NowPlayingServant(15267): SeekBar on Progess changed
09-19 14:42:17.511: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.511: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:17.554: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.554: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:17.605: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.605: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:17.644: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.644: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:17.687: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.687: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:17.734: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.734: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:17.773: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.773: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:17.816: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.816: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:17.863: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.863: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:17.906: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.906: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:17.949: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.949: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:17.992: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:17.992: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:18.039: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.039: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:18.082: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.082: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:18.125: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.125: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:18.167: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.167: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:18.175: V/PlayerDriver(82): HandleInformationalEvent: 23
09-19 14:42:18.210: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.210: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:18.253: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.253: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:18.296: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.296: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:18.343: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.343: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:18.386: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.386: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:18.429: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.429: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:18.472: V/ANDROID_DRM_TEST(82): getCurrentPosition
09-19 14:42:18.472: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.472: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:18.472: V/PlayerDriver(82): Send player code: 14
09-19 14:42:18.476: V/PlayerDriver(82): position=4111
09-19 14:42:18.476: V/ANDROID_DRM_TEST(82): [885] getCurrentPosition = 4111
09-19 14:42:18.480: D/NowPlayingServant(15267): SeekBar on Progess changed
09-19 14:42:18.515: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.515: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:18.562: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.562: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:18.605: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.605: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:18.648: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.648: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:18.691: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.691: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:18.734: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.734: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:18.777: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.777: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:18.824: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.824: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:18.867: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.867: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:18.910: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.910: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:18.953: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.953: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:18.996: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:18.996: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:19.039: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:19.039: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:19.085: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:19.085: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:19.128: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:19.128: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:19.171: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:19.171: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:19.175: V/PlayerDriver(82): HandleInformationalEvent: 23
09-19 14:42:19.214: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:19.214: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:19.257: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:19.257: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:19.300: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:19.300: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:19.347: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:19.347: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:19.394: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:19.394: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:19.437: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:19.437: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:19.476: V/ANDROID_DRM_TEST(82): getCurrentPosition
09-19 14:42:19.476: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:19.476: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:19.480: V/PlayerDriver(82): Send player code: 14
09-19 14:42:19.480: V/PlayerDriver(82): position=5114
09-19 14:42:19.480: V/ANDROID_DRM_TEST(82): [885] getCurrentPosition = 5114
09-19 14:42:19.480: D/NowPlayingServant(15267): SeekBar on Progess changed
09-19 14:42:19.527: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:19.527: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:19.566: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:19.566: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:19.609: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:19.609: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:19.617: I/InputReader(127): dispatchTouch::touch event's action is 0
09-19 14:42:19.617: I/InputDispatcher(127): Delivering touch to current input target: action: 0, channel '40ab4270 com.ventismedia.android.mediamonkey/com.ventismedia.android.mediamonkey.ui.phone.NowVideoPlayingActivity (server)'
09-19 14:42:19.644: D/dalvikvm(15159): GC_EXPLICIT freed 98K, 49% free 2836K/5511K, external 2496K/3117K, paused 20ms
09-19 14:42:19.656: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:19.656: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:19.695: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:19.695: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=0, fail=-1 
09-19 14:42:19.742: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:19.742: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=1, fail=-1 
09-19 14:42:19.785: E/v4l2_utils(82): Error = Invalid argument from qbuf
09-19 14:42:19.785: E/VideoMIO(82): writeFrameBuf ZC queueBuffer1 idx=2, fail=-1 
09-19 14:42:19.804: I/InputReader(127): dispatchTouch::touch event's action is 1
09-19 14:42:19.804: I/InputDispatcher(127): Delivering touch to current input target: action: 1, channel '40ab4270 com.ventismedia.android.mediamonkey/com.ventismedia.android.mediamonkey.ui.phone.NowVideoPlayingActivity (server)'
09-19 14:42:19.808: D/NowPlayingServant(15267): onClick
09-19 14:42:19.808: D/AlbumArtOverlayHandler(15267): setCanceled: true
09-19 14:42:19.812: V/PlayerDriver(82): Send player code: 16
09-19 14:42:19.812: V/PlayerDriver(82): status=4
09-19 14:42:19.812: V/ANDROID_DRM_TEST(82): [885] isPlaying: 1
09-19 14:42:19.812: D/PlaybackService(15267): Intent command received
09-19 14:42:19.812: I/PlaybackService(15267): playOrPause
09-19 14:42:19.812: I/PlaybackService(15267): pause
09-19 14:42:19.816: V/ANDROID_DRM_TEST(82): [885] pause
09-19 14:42:19.816: V/PVPlayer(82): pause
09-19 14:42:19.816: V/PlayerDriver(82): Send player code: 10
09-19 14:42:19.816: V/PlayerDriver(82): call pause
09-19 14:42:19.816: V/PlayerDriver(82): HandleInformationalEvent: 23
09-19 14:42:19.820: V/PlayerDriver(82): CommandCompleted
09-19 14:42:19.820: V/PlayerDriver(82): Completed command PLAYER_PAUSE status=1
09-19 14:42:19.820: V/PlayerDriver(82): pause complete
09-19 14:42:19.820: V/ANDROID_DRM_TEST(82): getCurrentPosition
09-19 14:42:19.820: V/PlayerDriver(82): Send player code: 14
09-19 14:42:19.820: V/PlayerDriver(82): position=5453
09-19 14:42:19.820: V/ANDROID_DRM_TEST(82): [885] getCurrentPosition = 5453
09-19 14:42:19.820: I/VideoTrack(15267): updateBookmark
09-19 14:42:19.828: W/TransactionManager(15267): New ThreadSerializer id from -1 to 31
09-19 14:42:19.839: V/AudioSink(82): pause
09-19 14:42:19.839: V/AudioPolicyManager(82): stopOutput() output 1, stream 3, session 229
09-19 14:42:19.839: V/AudioPolicyManager(82): getNewDevice() selected device 0
09-19 14:42:19.839: V/AudioPolicyManager(82): setOutputDevice() output 1 device 0 delayMs 0 force 0
09-19 14:42:19.839: V/AudioPolicyManager(82): setOutputDevice() setting same device 0 or null device for output 1
09-19 14:42:19.871: D/PlaybackService(15267): updateNotification app is : in foreground
09-19 14:42:19.871: I/PlaybackService(15267): hideNotification 
09-19 14:42:19.875: V/PlayerDriver(82): Send player code: 16
09-19 14:42:19.875: V/PlayerDriver(82): status=5
09-19 14:42:19.875: V/ANDROID_DRM_TEST(82): [885] isPlaying: 0
09-19 14:42:19.882: D/PlayerWidgetModel(15267): Loading widget Ids
09-19 14:42:19.886: D/NowPlayingBroadcastReceiver(15267): Intent command received
09-19 14:42:19.886: D/NowPlayingBroadcastReceiver(15267): Intent action: com.ventismedia.android.mediamonkey.player.PlaybackService.PLAYBACK_STATE_CHANGE_ACTION
09-19 14:42:19.886: D/TrackListModel(15267): Loading current track preferences
09-19 14:42:19.890: D/TrackListModel(15267): com.ventismedia.android.mediamonkey.player.video.VideoTrack:2
09-19 14:42:19.890: D/DB debug(15267): Query - media - id
09-19 14:42:19.890: D/QUERY(15267): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE (type=5) AND (_id=?) 
09-19 14:42:19.890: D/QUERY(15267): [2]
09-19 14:42:19.902: D/TrackListModel(15267): Loading current track preferences
09-19 14:42:19.902: D/TrackListModel(15267): com.ventismedia.android.mediamonkey.player.video.VideoTrack:2
09-19 14:42:19.906: D/DB debug(15267): Query - media - id
09-19 14:42:19.906: D/QUERY(15267): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE (type=5) AND (_id=?) 
09-19 14:42:19.906: D/QUERY(15267): [2]
09-19 14:42:19.917: D/NowPlayingBroadcastReceiver(15267): Intent command received
09-19 14:42:19.917: D/NowPlayingBroadcastReceiver(15267): Intent action: com.ventismedia.android.mediamonkey.player.PlaybackService.PLAYBACK_STATE_CHANGE_ACTION
09-19 14:42:19.917: D/TrackListModel(15267): Loading current track preferences
09-19 14:42:19.917: D/TrackListModel(15267): com.ventismedia.android.mediamonkey.player.video.VideoTrack:2
09-19 14:42:19.921: D/DB debug(15267): Query - media - id
09-19 14:42:19.921: D/QUERY(15267): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE (type=5) AND (_id=?) 
09-19 14:42:19.921: D/QUERY(15267): [2]
09-19 14:42:19.933: D/TrackListModel(15267): Loading current track preferences
09-19 14:42:19.933: D/TrackListModel(15267): com.ventismedia.android.mediamonkey.player.video.VideoTrack:2
09-19 14:42:19.933: D/DB debug(15267): Query - media - id
09-19 14:42:19.933: D/QUERY(15267): select *  from (SELECT media.*, group_concat(artists.artist, ", ") AS artists FROM (media LEFT JOIN media_artists_map ON media._id=media_artists_map.media_id) LEFT JOIN artists ON artists._id=media_artists_map.artist_id  GROUP BY media._id)WHERE (type=5) AND (_id=?) 
09-19 14:42:19.933: D/QUERY(15267): [2]
09-19 14:42:19.945: D/NowPlayingBroadcastReceiver(15267): Intent command received
09-19 14:42:19.945: D/NowPlayingBroadcastReceiver(15267): Intent action: com.ventismedia.android.mediamonkey.player.PlaybackService.PLAYBACK_STATE_CHANGE_ACTION
09-19 14:42:19.949: V/ANDROID_DRM_TEST(82): getCurrentPosition
09-19 14:42:19.949: V/PlayerDriver(82): Send player code: 14
09-19 14:42:19.949: V/PlayerDriver(82): position=5453
09-19 14:42:19.949: V/ANDROID_DRM_TEST(82): [885] getCurrentPosition = 5453
09-19 14:42:19.949: D/NowPlayingServant(15267): SeekBar on Progess changed
09-19 14:42:19.949: D/NowPlayingBroadcastReceiver(15267): Intent command received
09-19 14:42:19.949: D/NowPlayingBroadcastReceiver(15267): Intent action: com.ventismedia.android.mediamonkey.player.PlaybackService.PLAYBACK_STATE_CHANGE_ACTION
09-19 14:42:19.949: D/NowPlayingBroadcastReceiver(15267): Intent command received
09-19 14:42:19.949: D/NowPlayingBroadcastReceiver(15267): Intent action: com.ventismedia.android.mediamonkey.player.PlaybackService.PLAYBACK_STATE_CHANGE_ACTION
09-19 14:42:19.953: D/NowPlayingBroadcastReceiver(15267): Intent command received
09-19 14:42:19.953: D/NowPlayingBroadcastReceiver(15267): Intent action: com.ventismedia.android.mediamonkey.player.PlaybackService.PLAYBACK_STATE_CHANGE_ACTION
09-19 14:42:20.539: I/WindowOrientationListener(127): orientation 299.30313 gives new rotation = 2
09-19 14:42:20.539: D/SEC_Overlay(127): overlay_setPosition(0) 400,559,1,1 => 400,559,8,8
09-19 14:42:20.539: I/SEC_Overlay(127): Rotation/270
09-19 14:42:20.539: W/v4l2_utils(127): v4l2_overlay_set_position:: (240,400,8,8)=>(233,400,8,8) rot=270
09-19 14:42:20.539: I/WindowManager(127): Setting rotation to 3, animFlags=0
09-19 14:42:20.542: I/ActivityManager(127): Config changed: { scale=1.0 imsi=0/0 loc=ja_JP touch=3 keys=1/1/2 nav=1/1 orien=2 layout=34 uiMode=17 seq=157 FlipFont=0}
09-19 14:42:20.562: D/PhoneApp(241): updateProximitySensorMode: state = IDLE
09-19 14:42:20.570: D/PhoneApp(241): updateProximitySensorMode: lock already released.
09-19 14:42:20.578: D/NowVideoPlayingFragment(15267): onConfigurationChanged
09-19 14:42:20.578: D/NowVideoPlayingFragment(15267): Landscape - onChange
09-19 14:42:20.582: I/VideoUtils(15267): Video size changed to width: 720 height: 480
09-19 14:42:20.582: D/AlbumArtOverlayHandler(15267): isHideDelayed: false
09-19 14:42:20.582: D/NowVideoPlayingActivity(15267): Activity Landscape - onChange
09-19 14:42:20.632: D/SEC_Overlay(127): overlay_setPosition(0) 400,559,1,1 => 400,559,8,8
09-19 14:42:20.632: I/SEC_Overlay(127): Nothing to do!
09-19 14:42:20.667: D/SEC_Overlay(127): overlay_setPosition(0) 400,559,1,1 => 400,559,8,8
09-19 14:42:20.667: I/SEC_Overlay(127): Nothing to do!
09-19 14:42:20.687: D/SEC_Overlay(127): overlay_setPosition(0) 400,559,1,1 => 400,559,8,8
09-19 14:42:20.687: I/SEC_Overlay(127): Nothing to do!
09-19 14:42:20.703: D/SEC_Overlay(127): overlay_setPosition(0) 400,559,1,1 => 400,559,8,8
09-19 14:42:20.703: I/SEC_Overlay(127): Nothing to do!
09-19 14:42:20.718: D/SEC_Overlay(127): overlay_setPosition(-1) 160,320,480,480 => 160,320,480,480
09-19 14:42:20.722: I/SEC_Overlay(127): Nothing to do!
09-19 14:42:20.722: V/NowVideoPlayingFragment(15267): surfaceChanged Called width: 480height: 480
09-19 14:42:20.738: D/SEC_Overlay(127): overlay_setPosition(-1) 160,320,480,480 => 160,320,480,480
09-19 14:42:20.738: I/SEC_Overlay(127): Nothing to do!
09-19 14:42:20.757: D/SEC_Overlay(127): overlay_setPosition(-1) 160,320,480,480 => 160,320,480,480
09-19 14:42:20.757: I/SEC_Overlay(127): Nothing to do!
09-19 14:42:20.804: D/SEC_Overlay(127): overlay_setPosition(0) 0,40,480,720 => 0,40,480,720
09-19 14:42:20.804: I/SEC_Overlay(127): Rotation/270
09-19 14:42:20.804: W/v4l2_utils(127): v4l2_overlay_set_position:: (233,400,8,8)=>(40,0,720,480) rot=270
09-19 14:42:20.804: V/NowVideoPlayingFragment(15267): surfaceChanged Called width: 720height: 480
09-19 14:42:20.816: D/SEC_Overlay(127): overlay_setPosition(0) 0,40,480,720 => 0,40,480,720
09-19 14:42:20.816: I/SEC_Overlay(127): Nothing to do!
09-19 14:42:20.835: D/SEC_Overlay(127): overlay_setPosition(0) 0,40,480,720 => 0,40,480,720
09-19 14:42:20.835: I/SEC_Overlay(127): Nothing to do!
09-19 14:42:20.851: D/SEC_Overlay(127): overlay_setPosition(0) 0,40,480,720 => 0,40,480,720
09-19 14:42:20.851: I/SEC_Overlay(127): Nothing to do!
09-19 14:42:20.957: I/TransactionManager(15267): ThreadSerializer exit unlockMain 31
09-19 14:42:21.421: V/WifiMonitor(127): Event [ SCAN-RESULTS ]
09-19 14:42:21.421: I/wpa_supplicant(10388): CTRL-EVENT-NO-CONNECTION
09-19 14:42:21.421: W/wpa_supplicant(10388): scan interval : value of timeout (128)
09-19 14:42:21.421: V/WifiMonitor(127): Event [CTRL-EVENT-NO-CONNECTION]
09-19 14:42:21.433: I/NetworkStatusReceiver(9158): action: android.net.wifi.SHOW_AP_LIST_DIALOG
09-19 14:42:21.433: E/WifiManager(9158): showApDialog
09-19 14:42:21.433: I/WifiService(127): isShowingAccessPointListDialog():false
09-19 14:42:21.437: I/WifiService(127): setShowAccessPointListDialog():false
09-19 14:42:21.437: I/wpa_supplicant(10388): SCAN_RESULTS : [20] 
09-19 14:42:21.445: I/wpa_supplicant(10388): SCAN_RESULTS : [20] 
galaxyS_no_video_log2.txt (75,217 bytes)   
Fixed in build33

Relationships

related to 0009694 closedmartin Playback/Thumbnail bugs with bookmarked videos 

Activities

mambo-simon

2012-09-13 06:49

reporter   ~0031967

MM Build 29 (did not occur in earlier builds)

martin

2012-09-14 22:53

developer   ~0031994

Attached Log from this issue is older than build 29, please check it again, there was similar problem with video playback, which was fixed

mambo-simon

2012-09-18 03:16

reporter   ~0032033

Apologies, the previous log was wrong - attached the log taken with with Build 30 (still reproducible)

- Galaxy S (2.3.3)

mambo-simon

2012-09-18 03:18

reporter   ~0032034

Still reproducible in build 30

rusty

2012-09-19 13:34

administrator   ~0032049

Last edited: 2012-09-19 13:35

Posted updated log from Simon (the bug occurs for all videos played on that device--videos that play without a problem on other devices).

jiri

2012-09-19 15:58

administrator   ~0032050

Not sure if it's the same problem but I reproduced something like this on 4.0.4 by:
1. Playing a video.
2. Pressing Back.
3. Force closing MM.
4. Starting MM.
5. Starting the Video again from the miniplayer => playback starts, but apparently in the audio mode only, the screen is different and only audio plays.

jiri

2012-09-19 21:36

administrator   ~0032063

This issue (from my previous note) seems to be fixed in the latest sources, I can't reproduce anymore.

jiri

2012-09-21 08:23

administrator   ~0032119

Setting as resolved, since there were some changes that possibly could have fixed it. Please reopen in case it's still there...

peke

2012-09-25 23:59

developer   ~0032185

Closing this as I can confirm fix was within latest MMA sources 100%

I had few MP4 files that started playback in native phone player only in Audio Mode (All files were larger than 30Min if matters), tested with MMA 30 and could reproduce, than tested with MMA 35 and bug was gone.