View Issue Details

IDProjectCategoryView StatusLast Update
0011700MMANavigationpublic2014-11-30 19:53
Reportermarek Assigned To 
PriorityurgentSeverityminorReproducibilityrandom
Status resolvedResolutionunable to reproduce 
Product Version1.0.4 
Target Version1.1.0 
Summary0011700: Deletion of tracks is sometimes slow
DescriptionWhen I delete tracks, some tracks takes up to 15 seconds to delete.

Observed on 4.3 a 4.4

Logs are attached.
TagsNo tags attached.
Attached Files
log-slowdeletion.txt (45,845 bytes)   
01-09 12:39:52.320: I/MiniPlayerActivity(16862): onPause HomeFragment
01-09 12:39:52.325: D/MiniPlayerActivity(16862): ACTION_USER_PRESENT unregisterReceiver
01-09 12:39:52.330: D/BaseActivity(16862): onPause HomeActivity
01-09 12:39:52.330: D/ActionBarActivity(16862): HomeActivity mIsBackPressed: false
01-09 12:39:52.330: D/UIUtils(16862): setAppVisibility: false
01-09 12:39:52.350: D/StorageObserverService(16862): APP_GO_TO_BACKGROUND received
01-09 12:39:52.365: D/MediaStoreSyncObserver(16862): App goes to background
01-09 12:39:52.370: D/BaseActivity(16862): onCreate LibraryActivity
01-09 12:39:52.370: D/BaseActivity(16862): mUseLockScreenPlayer false
01-09 12:39:52.380: D/BaseActivity(16862): receiverRegistered false
01-09 12:39:52.380: D/TrialTimeUtils(16862): com.ventismedia.android.mediamonkey isProVersionInstalled: false signatureMatch:-4
01-09 12:39:52.385: W/ActionBarActivity(16862): setContentView
01-09 12:39:52.415: I/SinglePaneActivity(16862): onCreate
01-09 12:39:52.415: D/LibraryActivity(16862): Type: 0
01-09 12:39:52.415: D/SinglePaneActivity(16862): Add to backstack:true
01-09 12:39:52.420: I/MiniPlayerActivity(16862): onCreate AlbumsFragment
01-09 12:39:52.420: D/MiniPlayerActivity(16862): forceInitTrackListModel
01-09 12:39:52.420: D/BaseActivity(16862): onStart LibraryActivity
01-09 12:39:52.435: I/LibraryViewFragment(16862): onActivityCreated
01-09 12:39:52.445: I/MiniPlayerActivity(16862): onStart AlbumsFragment
01-09 12:39:52.450: D/MediaMonkeyStoreProvider 1(16862): Query: /readonly/audio/albums;Projection:[_id, album, album_art, artists, number_of_tracks, type];Selection:(type=0);Args:null
01-09 12:39:52.455: D/TrialTimeUtils(16862): com.ventismedia.android.mediamonkey isProVersionInstalled: false signatureMatch:-4
01-09 12:39:52.465: W/ExternalSQLiteOpenHelper(16862): Opened /data/data/com.ventismedia.android.mediamonkey/databases/mmstore.db in read-only mode
01-09 12:39:52.485: D/BaseActivity(16862): onResume LibraryActivity
01-09 12:39:52.490: D/BaseActivity(16862): mUseLockScreenPlayer false
01-09 12:39:52.490: D/BaseActivity(16862): receiverRegistered false
01-09 12:39:52.495: D/UIUtils(16862): isAppVisible: false
01-09 12:39:52.495: D/UIUtils(16862): setAppVisibility: true
01-09 12:39:52.505: I/MiniPlayerActivity(16862): onResume AlbumsFragment
01-09 12:39:52.505: D/PlaybackService(16862): Service is not running
01-09 12:39:52.510: D/MiniPlayerActivity(16862): ACTION_USER_PRESENT registerReceiver
01-09 12:39:52.525: D/dalvikvm(16862): GC_CONCURRENT freed 791K, 18% free 5484K/6616K, paused 3ms+3ms, total 41ms
01-09 12:39:52.525: D/dalvikvm(16862): WAIT_FOR_CONCURRENT_GC blocked 16ms
01-09 12:39:52.530: D/TrackListModel(16862): Get current track from preferences
01-09 12:39:52.530: W/MiniPlayerActivity(16862): Do nothing...
01-09 12:39:52.530: I/ContentService(16862): Service is not running
01-09 12:39:52.535: D/ExtendedListFragment(16862): onResume
01-09 12:39:52.535: D/ExtendedListFragment(16862): initTitleListener
01-09 12:39:52.545: D/StorageObserverService(16862): APP_GO_TO_FOREGROUND received
01-09 12:39:52.545: D/MediaStoreSyncObserver(16862): App goes to foreground
01-09 12:39:52.545: D/MediaStoreSyncObserver(16862): On wake up
01-09 12:39:52.545: D/SyncLauncher(16862): Application goes to foreground
01-09 12:39:52.545: I/StorageObserverService(16862): Service is running
01-09 12:39:52.570: D/ExternalSQLiteOpenHelper(16862): getReadableDatabase - return READABLE
01-09 12:39:52.665: D/MediaMonkeyStoreProvider 5(16862): Query - end (215 ms): /readonly/audio/albums
01-09 12:39:52.670: D/MediaMonkeyStoreProvider 1(16862): Query: /readonly/audio/media;Projection:[_id];Selection:(type=?) AND (album_id IS NULL);Args:[0]
01-09 12:39:52.670: D/MediaMonkeyStoreProvider 5(16862): Query - end (2 ms): /readonly/audio/media
01-09 12:39:52.815: D/dalvikvm(16862): GC_CONCURRENT freed 588K, 13% free 5875K/6720K, paused 3ms+5ms, total 29ms
01-09 12:39:52.890: D/BaseActivity(16862): onSaveInstanceState HomeActivity
01-09 12:39:52.895: I/MiniPlayerActivity(16862): onStop HomeFragment
01-09 12:39:52.895: D/BaseActivity(16862): onStop HomeActivity
01-09 12:39:53.960: I/LibraryActivity(16862): onBackPressed
01-09 12:39:54.000: D/dalvikvm(16862): GC_FOR_ALLOC freed 417K, 12% free 6481K/7304K, paused 35ms, total 36ms
01-09 12:39:54.015: I/MiniPlayerActivity(16862): onPause AlbumsFragment
01-09 12:39:54.015: D/MiniPlayerActivity(16862): ACTION_USER_PRESENT unregisterReceiver
01-09 12:39:54.020: D/BaseActivity(16862): onPause LibraryActivity
01-09 12:39:54.020: D/ExtendedListFragment(16862): onPause
01-09 12:39:54.020: D/ActionBarActivity(16862): LibraryActivity mIsBackPressed: true
01-09 12:39:54.020: D/UIUtils(16862): setAppVisibility: false
01-09 12:39:54.035: D/StorageObserverService(16862): APP_GO_TO_BACKGROUND received
01-09 12:39:54.040: D/MediaStoreSyncObserver(16862): App goes to background
01-09 12:39:54.040: D/BaseActivity(16862): onStart HomeActivity
01-09 12:39:54.050: I/MiniPlayerActivity(16862): onStart HomeFragment
01-09 12:39:54.050: D/BaseActivity(16862): onResume HomeActivity
01-09 12:39:54.050: D/BaseActivity(16862): mUseLockScreenPlayer false
01-09 12:39:54.050: D/BaseActivity(16862): receiverRegistered false
01-09 12:39:54.055: D/UIUtils(16862): isAppVisible: false
01-09 12:39:54.055: D/UIUtils(16862): setAppVisibility: true
01-09 12:39:54.060: I/MiniPlayerActivity(16862): onResume HomeFragment
01-09 12:39:54.060: D/PlaybackService(16862): Service is not running
01-09 12:39:54.060: D/MiniPlayerActivity(16862): ACTION_USER_PRESENT registerReceiver
01-09 12:39:54.065: D/TrackListModel(16862): Get current track from preferences
01-09 12:39:54.065: W/MiniPlayerActivity(16862): Do nothing...
01-09 12:39:54.070: D/HomeActivity(16862): onResume
01-09 12:39:54.070: I/ContentService(16862): Service is not running
01-09 12:39:54.100: D/StorageObserverService(16862): APP_GO_TO_FOREGROUND received
01-09 12:39:54.100: D/MediaStoreSyncObserver(16862): App goes to foreground
01-09 12:39:54.105: D/MediaStoreSyncObserver(16862): On wake up
01-09 12:39:54.105: D/SyncLauncher(16862): Application goes to foreground
01-09 12:39:54.105: I/StorageObserverService(16862): Service is running
01-09 12:39:54.375: I/MiniPlayerActivity(16862): onStop AlbumsFragment
01-09 12:39:54.375: D/BaseActivity(16862): onStop LibraryActivity
01-09 12:39:54.405: D/ExtendedListFragment(16862): onStop
01-09 12:39:54.410: I/MiniPlayerActivity(16862): onDestroy AlbumsFragment
01-09 12:39:54.415: I/SinglePaneActivity(16862): onDestroy
01-09 12:39:54.420: D/BaseActivity(16862): onDestroy LibraryActivity
01-09 12:39:54.470: I/LibraryViewFragment(16862): onDestroy
01-09 12:40:12.545: I/MiniPlayerActivity(16862): onPause HomeFragment
01-09 12:40:12.545: D/MiniPlayerActivity(16862): ACTION_USER_PRESENT unregisterReceiver
01-09 12:40:12.550: D/BaseActivity(16862): onPause HomeActivity
01-09 12:40:12.555: D/ActionBarActivity(16862): HomeActivity mIsBackPressed: false
01-09 12:40:12.555: D/UIUtils(16862): setAppVisibility: false
01-09 12:40:12.570: D/StorageObserverService(16862): APP_GO_TO_BACKGROUND received
01-09 12:40:12.570: D/MediaStoreSyncObserver(16862): App goes to background
01-09 12:40:12.575: D/BaseActivity(16862): onCreate LibraryActivity
01-09 12:40:12.575: D/BaseActivity(16862): mUseLockScreenPlayer false
01-09 12:40:12.580: D/BaseActivity(16862): receiverRegistered false
01-09 12:40:12.580: D/TrialTimeUtils(16862): com.ventismedia.android.mediamonkey isProVersionInstalled: false signatureMatch:-4
01-09 12:40:12.585: W/ActionBarActivity(16862): setContentView
01-09 12:40:12.630: I/SinglePaneActivity(16862): onCreate
01-09 12:40:12.630: D/LibraryActivity(16862): Type: 0
01-09 12:40:12.630: D/SinglePaneActivity(16862): Add to backstack:true
01-09 12:40:12.640: D/dalvikvm(16862): GC_CONCURRENT freed 1257K, 19% free 6581K/8084K, paused 3ms+15ms, total 57ms
01-09 12:40:12.640: I/MiniPlayerActivity(16862): onCreate MediaFragment
01-09 12:40:12.645: D/MiniPlayerActivity(16862): forceInitTrackListModel
01-09 12:40:12.645: D/BaseActivity(16862): onStart LibraryActivity
01-09 12:40:12.655: I/LibraryViewFragment(16862): onActivityCreated
01-09 12:40:12.655: I/MiniPlayerActivity(16862): onStart MediaFragment
01-09 12:40:12.665: D/TrialTimeUtils(16862): com.ventismedia.android.mediamonkey isProVersionInstalled: false signatureMatch:-4
01-09 12:40:12.690: D/BaseActivity(16862): onResume LibraryActivity
01-09 12:40:12.690: D/MediaMonkeyStoreProvider 1(16862): Query: /readonly/audio/media;Projection:[_id, title, track, album_art, artists, duration, type];Selection:(type=0);Args:null
01-09 12:40:12.695: D/BaseActivity(16862): mUseLockScreenPlayer false
01-09 12:40:12.695: D/BaseActivity(16862): receiverRegistered false
01-09 12:40:12.695: D/UIUtils(16862): isAppVisible: false
01-09 12:40:12.700: D/UIUtils(16862): setAppVisibility: true
01-09 12:40:12.705: I/MiniPlayerActivity(16862): onResume MediaFragment
01-09 12:40:12.705: D/PlaybackService(16862): Service is not running
01-09 12:40:12.705: D/MiniPlayerActivity(16862): ACTION_USER_PRESENT registerReceiver
01-09 12:40:12.705: D/TrackListModel(16862): Get current track from preferences
01-09 12:40:12.710: W/MiniPlayerActivity(16862): Do nothing...
01-09 12:40:12.710: I/ContentService(16862): Service is not running
01-09 12:40:12.710: D/ExtendedListFragment(16862): onResume
01-09 12:40:12.715: D/ExtendedListFragment(16862): initTitleListener
01-09 12:40:12.715: D/MediaFragment(16862): onResume 
01-09 12:40:12.715: D/MediaFragment(16862): updateCurrentTrackId
01-09 12:40:12.715: I/TrackListModel(16862): getCurrentTrackInfo
01-09 12:40:12.725: D/StorageObserverService(16862): APP_GO_TO_FOREGROUND received
01-09 12:40:12.725: D/MediaStoreSyncObserver(16862): App goes to foreground
01-09 12:40:12.730: D/MediaStoreSyncObserver(16862): On wake up
01-09 12:40:12.730: D/SyncLauncher(16862): Application goes to foreground
01-09 12:40:12.730: I/StorageObserverService(16862): Service is running
01-09 12:40:12.755: D/MediaMonkeyStoreProvider 5(16862): Query - end (3 ms): /readonly/audio/media
01-09 12:40:13.005: D/dalvikvm(16862): GC_CONCURRENT freed 1354K, 20% free 6595K/8208K, paused 2ms+4ms, total 36ms
01-09 12:40:13.010: D/dalvikvm(16862): WAIT_FOR_CONCURRENT_GC blocked 25ms
01-09 12:40:13.010: I/dalvikvm-heap(16862): Grow heap (frag case) to 6.782MB for 106292-byte allocation
01-09 12:40:13.030: D/dalvikvm(16862): GC_FOR_ALLOC freed 3K, 20% free 6698K/8312K, paused 21ms, total 21ms
01-09 12:40:13.095: D/BaseActivity(16862): onSaveInstanceState HomeActivity
01-09 12:40:13.095: I/MiniPlayerActivity(16862): onStop HomeFragment
01-09 12:40:13.095: D/BaseActivity(16862): onStop HomeActivity
01-09 12:40:15.940: I/ExtendedListFragment(16862): onItemLongClick
01-09 12:40:15.945: D/ExtendedListFragment(16862): deselectAll
01-09 12:40:16.000: I/ExtendedListFragment(16862): switched ToContextualMode
01-09 12:40:16.920: D/MediaFragment(16862): Selected:Select all
01-09 12:40:17.040: I/dalvikvm(16862): Jit: resizing JitTable from 4096 to 8192
01-09 12:40:18.255: D/MediaFragment(16862): Selected:Delete
01-09 12:40:18.500: I/MiniPlayerActivity(16862): onPause MediaFragment
01-09 12:40:18.505: D/MiniPlayerActivity(16862): ACTION_USER_PRESENT unregisterReceiver
01-09 12:40:18.505: D/BaseActivity(16862): onPause LibraryActivity
01-09 12:40:18.505: D/ExtendedListFragment(16862): onPause
01-09 12:40:18.510: D/ActionBarActivity(16862): LibraryActivity mIsBackPressed: false
01-09 12:40:18.510: D/UIUtils(16862): setAppVisibility: false
01-09 12:40:18.525: D/StorageObserverService(16862): APP_GO_TO_BACKGROUND received
01-09 12:40:18.525: D/MediaStoreSyncObserver(16862): App goes to background
01-09 12:40:18.530: D/BaseActivity(16862): onCreate DialogActivity
01-09 12:40:18.530: D/BaseActivity(16862): mUseLockScreenPlayer false
01-09 12:40:18.530: D/BaseActivity(16862): receiverRegistered false
01-09 12:40:18.535: D/TrialTimeUtils(16862): com.ventismedia.android.mediamonkey isProVersionInstalled: false signatureMatch:-4
01-09 12:40:18.540: D/BaseActivity(16862): onStart DialogActivity
01-09 12:40:18.565: D/BaseActivity(16862): onResume DialogActivity
01-09 12:40:18.565: D/BaseActivity(16862): mUseLockScreenPlayer false
01-09 12:40:18.565: D/BaseActivity(16862): receiverRegistered false
01-09 12:40:18.920: D/LibraryActivity(16862): onSaveInstanceState
01-09 12:40:18.925: D/BaseActivity(16862): onSaveInstanceState LibraryActivity
01-09 12:40:19.420: W/ResourceType(16862): No known package when getting name for resource number 0xffffffff
01-09 12:40:19.425: E/ViewInitHelper(16862): View not found. Resource with ID 2131099785 cannot be found in LinearLayout (-1)
01-09 12:40:19.425: W/ResourceType(16862): No known package when getting name for resource number 0xffffffff
01-09 12:40:19.430: E/ViewInitHelper(16862): View not found. Resource with ID 2131099781 cannot be found in LinearLayout (-1)
01-09 12:40:19.455: W/ResourceType(16862): No known package when getting name for resource number 0xffffffff
01-09 12:40:19.455: E/ViewInitHelper(16862): View not found. Resource with ID 16908310 cannot be found in LinearLayout (-1)
01-09 12:40:19.465: W/ResourceType(16862): No known package when getting name for resource number 0xffffffff
01-09 12:40:19.465: E/ViewInitHelper(16862): View not found. Resource with ID 16908331 cannot be found in LinearLayout (-1)
01-09 12:40:19.470: W/ResourceType(16862): No known package when getting name for resource number 0xffffffff
01-09 12:40:19.470: E/ViewInitHelper(16862): View not found. Resource with ID 2131099784 cannot be found in LinearLayout (-1)
01-09 12:40:19.530: D/dalvikvm(16862): GC_CONCURRENT freed 1015K, 16% free 7024K/8352K, paused 9ms+6ms, total 55ms
01-09 12:40:19.540: W/ResourceType(16862): No known package when getting name for resource number 0xffffffff
01-09 12:40:19.540: E/ViewInitHelper(16862): View not found. Resource with ID 2131099782 cannot be found in LinearLayout (-1)
01-09 12:40:19.560: D/MediaMonkeyStoreProvider 1(16862): Insert: /begin
01-09 12:40:19.560: D/TransactionManager 13(16862): ThreadSerializer is turning off, starting new one...
01-09 12:40:19.580: D/MediaMonkeyStoreProvider 5(16862): Insert - end (17 ms): /begin
01-09 12:40:19.580: D/MediaMonkeyStoreProvider 1(16862): Delete: /audio/media/87,Selection:null;Args:null
01-09 12:40:19.585: D/TransactionManager(16862): acquireWakeLock
01-09 12:40:19.585: W/TransactionManager(16862): New ThreadSerializer id from -1 to 609
01-09 12:40:19.610: E/SQLiteLog(16862): (5) statement aborts at 1: [PRAGMA journal_mode=PERSIST] 
01-09 12:40:19.610: W/SQLiteConnection(16862): Could not change the database journal mode of '/data/data/com.ventismedia.android.mediamonkey/databases/mmstore.db' from 'wal' to 'PERSIST' because the database is locked.  This usually means that there are other open connections to the database which prevents the database from enabling or disabling write-ahead logging mode.  Proceeding without changing the journal mode.
01-09 12:40:19.660: D/TransactionManager 14(16862): Transaction begin by thread with id 609
01-09 12:40:19.690: D/Provider(16862): delete repeatIfLocked
01-09 12:40:19.705: I/MediaMonkeyStoreProvider(16862): count 1
01-09 12:40:19.720: D/MediaMonkeyStoreProvider 5(16862): Delete - end (136 ms): /audio/media/87
01-09 12:40:19.720: D/MediaMonkeyStoreProvider 1(16862): Delete: /audio/media/94,Selection:null;Args:null
01-09 12:40:19.725: D/MediaMonkeyStoreProvider 1(16862): Query: /readonly/audio/media;Projection:[_id, title, track, album_art, artists, duration, type];Selection:(type=0);Args:null
01-09 12:40:19.730: D/THREAD CONTROL(16862): Not queried by db thread!!! 611 (609)
01-09 12:40:19.740: D/MediaMonkeyStoreProvider 5(16862): Query - end (11 ms): /readonly/audio/media
01-09 12:40:19.740: D/StorageUtils(16862): deleteCleanDirectory : /storage/sdcard1/Music/Pink Floyd/Is There Anybody Out There - The Wall Live 1980-81 - Disc 2
01-09 12:40:19.765: D/Provider(16862): delete repeatIfLocked
01-09 12:40:42.625: D/StopWatch(16862): StopWatch (Thread(608)) time:22902 summaryTime:22903
01-09 12:40:42.625: I/MediaMonkeyStoreProvider(16862): count 1
01-09 12:40:42.625: D/StopWatch(16862): 11:40:19.0726::<D>::StopWatch::Processing start:::TransactionManager.java.run():1339 CTT: 0 ERT:0
01-09 12:40:42.625: D/StopWatch(16862): 11:40:19.0726::<D>::StopWatch::Processing start unlockedMain:::TransactionManager.java.run():1341 CTT: 0 ERT:0
01-09 12:40:42.625: D/StopWatch(16862): 11:40:19.0726::<D>::StopWatch::getWritableDatabase start:::TransactionManager.java.run():1354 CTT: 0 ERT:0
01-09 12:40:42.625: D/StopWatch(16862): 11:40:19.0727::<D>::StopWatch::getWritableDatabase end:::TransactionManager.java.run():1356 CTT: 1 ERT:0
01-09 12:40:42.625: D/StopWatch(16862): 11:40:19.0727::<D>::StopWatch::dbLock locking...:::TransactionManager.java.run():1401 CTT: 1 ERT:1
01-09 12:40:42.625: D/StopWatch(16862): 11:40:19.0727::<D>::StopWatch::dbLock locked:::TransactionManager.java.run():1403 CTT: 1 ERT:1
01-09 12:40:42.625: D/StopWatch(16862): 11:40:19.0727::<D>::StopWatch::process callback start inTransaction:true:::TransactionManager.java.run():1406 CTT: 1 ERT:1
01-09 12:40:42.630: D/StopWatch(16862): 11:40:42.0627::<D>::StopWatch::process callback end - returned:::TransactionManager.java.run():1408 CTT: 22822 ERT:22901
01-09 12:40:42.630: D/StopWatch(16862): 11:40:42.0628::<D>::StopWatch::process callback end:::TransactionManager.java.run():1439 CTT: 22823 ERT:22902
01-09 12:40:42.630: D/StopWatch(16862): 11:40:42.0628::<D>::StopWatch::dbLock unlocking...:::TransactionManager.java.run():1440 CTT: 22823 ERT:22902
01-09 12:40:42.630: D/StopWatch(16862): 11:40:42.0628::<D>::StopWatch::dbLock unlocked:::TransactionManager.java.run():1442 CTT: 22823 ERT:22902
01-09 12:40:42.630: V/Request(16862): dalvik.system.VMStack.getThreadStackTrace(Native Method)
01-09 12:40:42.630: V/Request(16862): java.lang.Thread.getStackTrace(Thread.java:591)
01-09 12:40:42.630: V/Request(16862): com.ventismedia.android.mediamonkey.db.TransactionManager$Request.<init>(TransactionManager.java:678)
01-09 12:40:42.630: V/Request(16862): com.ventismedia.android.mediamonkey.db.TransactionManager$DbSerializer.put(TransactionManager.java:1591)
01-09 12:40:42.630: V/Request(16862): com.ventismedia.android.mediamonkey.db.TransactionManager.doInBackground(TransactionManager.java:373)
01-09 12:40:42.630: V/Request(16862): com.ventismedia.android.mediamonkey.db.MediaMonkeyStoreProvider.doDeleteInTransactionManager(MediaMonkeyStoreProvider.java:1710)
01-09 12:40:42.630: V/Request(16862): com.ventismedia.android.mediamonkey.db.MediaMonkeyStoreProvider.delete(MediaMonkeyStoreProvider.java:893)
01-09 12:40:42.630: V/Request(16862): android.content.ContentProvider$Transport.delete(ContentProvider.java:228)
01-09 12:40:42.630: V/Request(16862): android.content.ContentResolver.delete(ContentResolver.java:958)
01-09 12:40:42.635: V/Request(16862): com.ventismedia.android.mediamonkey.ui.dialogs.UriDeleteProgressDialogFragment.delete(UriDeleteProgressDialogFragment.java:39)
01-09 12:40:42.635: V/Request(16862): com.ventismedia.android.mediamonkey.ui.dialogs.DeleteProgressDialogFragment$1.run(DeleteProgressDialogFragment.java:66)
01-09 12:40:42.640: D/MediaMonkeyStoreProvider 1(16862): Query: /readonly/audio/media;Projection:[_id, title, track, album_art, artists, duration, type];Selection:(type=0);Args:null
01-09 12:40:42.640: D/THREAD CONTROL(16862): Not queried by db thread!!! 613 (609)
01-09 12:40:42.650: D/MediaMonkeyStoreProvider 5(16862): Query - end (9 ms): /readonly/audio/media
01-09 12:40:42.660: D/MediaMonkeyStoreProvider 5(16862): Delete - end (22939 ms): /audio/media/94
01-09 12:40:42.665: D/MediaMonkeyStoreProvider 1(16862): Delete: /audio/media/95,Selection:null;Args:null
01-09 12:40:42.665: D/MediaMonkeyStoreProvider 1(16862): Query: /readonly/audio/media;Projection:[_id, title, track, album_art, artists, duration, type];Selection:(type=0);Args:null
01-09 12:40:42.665: D/THREAD CONTROL(16862): Not queried by db thread!!! 613 (609)
01-09 12:40:42.710: D/MediaMonkeyStoreProvider 5(16862): Query - end (46 ms): /readonly/audio/media
01-09 12:40:42.720: D/StorageUtils(16862): deleteCleanDirectory : /storage/sdcard1/Music/Pink Floyd/Works
01-09 12:40:42.730: D/dalvikvm(16862): GC_CONCURRENT freed 1559K, 21% free 7032K/8836K, paused 4ms+6ms, total 60ms
01-09 12:40:42.730: D/dalvikvm(16862): WAIT_FOR_CONCURRENT_GC blocked 11ms
01-09 12:40:42.730: D/dalvikvm(16862): WAIT_FOR_CONCURRENT_GC blocked 20ms
01-09 12:40:42.760: D/StorageUtils(16862): deleteCleanDirectory : /storage/sdcard1/Music/Pink Floyd
01-09 12:40:42.800: D/Provider(16862): delete repeatIfLocked
01-09 12:41:03.075: I/MediaMonkeyStoreProvider(16862): count 1
01-09 12:41:03.080: D/StopWatch(16862): StopWatch (Thread(608)) time:20408 summaryTime:20409
01-09 12:41:03.080: D/StopWatch(16862): 11:40:42.0673::<D>::StopWatch::Processing start:::TransactionManager.java.run():1339 CTT: 1 ERT:0
01-09 12:41:03.080: D/StopWatch(16862): 11:40:42.0679::<D>::StopWatch::Processing start unlockedMain:::TransactionManager.java.run():1341 CTT: 1 ERT:6
01-09 12:41:03.080: D/StopWatch(16862): 11:40:42.0680::<D>::StopWatch::getWritableDatabase start:::TransactionManager.java.run():1354 CTT: 2 ERT:7
01-09 12:41:03.080: D/StopWatch(16862): 11:40:42.0680::<D>::StopWatch::getWritableDatabase end:::TransactionManager.java.run():1356 CTT: 2 ERT:7
01-09 12:41:03.085: D/MediaMonkeyStoreProvider 1(16862): Query: /readonly/audio/media;Projection:[_id, title, track, album_art, artists, duration, type];Selection:(type=0);Args:null
01-09 12:41:03.090: D/THREAD CONTROL(16862): Not queried by db thread!!! 610 (609)
01-09 12:41:03.100: D/MediaMonkeyStoreProvider 5(16862): Delete - end (20432 ms): /audio/media/95
01-09 12:41:03.100: D/StopWatch(16862): 11:40:42.0681::<D>::StopWatch::dbLock locking...:::TransactionManager.java.run():1401 CTT: 2 ERT:8
01-09 12:41:03.100: D/StopWatch(16862): 11:40:42.0681::<D>::StopWatch::dbLock locked:::TransactionManager.java.run():1403 CTT: 3 ERT:8
01-09 12:41:03.100: D/StopWatch(16862): 11:40:42.0682::<D>::StopWatch::process callback start inTransaction:true:::TransactionManager.java.run():1406 CTT: 3 ERT:8
01-09 12:41:03.100: D/StopWatch(16862): 11:41:03.079::<D>::StopWatch::process callback end - returned:::TransactionManager.java.run():1408 CTT: 19667 ERT:20406
01-09 12:41:03.100: D/MediaMonkeyStoreProvider 1(16862): Delete: /audio/media/91,Selection:null;Args:null
01-09 12:41:03.100: D/StopWatch(16862): 11:41:03.080::<D>::StopWatch::process callback end:::TransactionManager.java.run():1439 CTT: 19667 ERT:20407
01-09 12:41:03.100: D/StopWatch(16862): 11:41:03.080::<D>::StopWatch::dbLock unlocking...:::TransactionManager.java.run():1440 CTT: 19668 ERT:20407
01-09 12:41:03.100: D/StopWatch(16862): 11:41:03.080::<D>::StopWatch::dbLock unlocked:::TransactionManager.java.run():1442 CTT: 19668 ERT:20407
01-09 12:41:03.100: V/Request(16862): dalvik.system.VMStack.getThreadStackTrace(Native Method)
01-09 12:41:03.100: V/Request(16862): java.lang.Thread.getStackTrace(Thread.java:591)
01-09 12:41:03.100: V/Request(16862): com.ventismedia.android.mediamonkey.db.TransactionManager$Request.<init>(TransactionManager.java:678)
01-09 12:41:03.100: V/Request(16862): com.ventismedia.android.mediamonkey.db.TransactionManager$DbSerializer.put(TransactionManager.java:1591)
01-09 12:41:03.100: V/Request(16862): com.ventismedia.android.mediamonkey.db.TransactionManager.doInBackground(TransactionManager.java:373)
01-09 12:41:03.100: V/Request(16862): com.ventismedia.android.mediamonkey.db.MediaMonkeyStoreProvider.doDeleteInTransactionManager(MediaMonkeyStoreProvider.java:1710)
01-09 12:41:03.105: V/Request(16862): com.ventismedia.android.mediamonkey.db.MediaMonkeyStoreProvider.delete(MediaMonkeyStoreProvider.java:893)
01-09 12:41:03.105: V/Request(16862): android.content.ContentProvider$Transport.delete(ContentProvider.java:228)
01-09 12:41:03.105: V/Request(16862): android.content.ContentResolver.delete(ContentResolver.java:958)
01-09 12:41:03.105: V/Request(16862): com.ventismedia.android.mediamonkey.ui.dialogs.UriDeleteProgressDialogFragment.delete(UriDeleteProgressDialogFragment.java:39)
01-09 12:41:03.105: V/Request(16862): com.ventismedia.android.mediamonkey.ui.dialogs.DeleteProgressDialogFragment$1.run(DeleteProgressDialogFragment.java:66)
01-09 12:41:03.105: D/MediaMonkeyStoreProvider 5(16862): Query - end (15 ms): /readonly/audio/media
01-09 12:41:03.160: D/StorageUtils(16862): deleteCleanDirectory : /storage/sdcard1/Music/Buty/D�evo
01-09 12:41:03.210: D/Provider(16862): delete repeatIfLocked
01-09 12:41:19.490: D/StopWatch(16862): StopWatch (Thread(608)) time:16388 summaryTime:16388
01-09 12:41:19.490: I/MediaMonkeyStoreProvider(16862): count 1
01-09 12:41:19.495: D/StopWatch(16862): 11:41:03.0109::<D>::StopWatch::Processing start:::TransactionManager.java.run():1339 CTT: 1 ERT:1
01-09 12:41:19.495: D/StopWatch(16862): 11:41:03.0111::<D>::StopWatch::Processing start unlockedMain:::TransactionManager.java.run():1341 CTT: 1 ERT:3
01-09 12:41:19.495: D/StopWatch(16862): 11:41:03.0111::<D>::StopWatch::getWritableDatabase start:::TransactionManager.java.run():1354 CTT: 1 ERT:3
01-09 12:41:19.495: D/StopWatch(16862): 11:41:03.0111::<D>::StopWatch::getWritableDatabase end:::TransactionManager.java.run():1356 CTT: 2 ERT:3
01-09 12:41:19.495: D/StopWatch(16862): 11:41:03.0112::<D>::StopWatch::dbLock locking...:::TransactionManager.java.run():1401 CTT: 2 ERT:3
01-09 12:41:19.495: D/StopWatch(16862): 11:41:03.0112::<D>::StopWatch::dbLock locked:::TransactionManager.java.run():1403 CTT: 2 ERT:4
01-09 12:41:19.495: D/StopWatch(16862): 11:41:03.0112::<D>::StopWatch::process callback start inTransaction:true:::TransactionManager.java.run():1406 CTT: 3 ERT:4
01-09 12:41:19.495: D/StopWatch(16862): 11:41:19.0495::<D>::StopWatch::process callback end - returned:::TransactionManager.java.run():1408 CTT: 16037 ERT:16387
01-09 12:41:19.495: D/StopWatch(16862): 11:41:19.0496::<D>::StopWatch::process callback end:::TransactionManager.java.run():1439 CTT: 16037 ERT:16388
01-09 12:41:19.495: D/StopWatch(16862): 11:41:19.0496::<D>::StopWatch::dbLock unlocking...:::TransactionManager.java.run():1440 CTT: 16038 ERT:16388
01-09 12:41:19.495: D/StopWatch(16862): 11:41:19.0496::<D>::StopWatch::dbLock unlocked:::TransactionManager.java.run():1442 CTT: 16038 ERT:16388
01-09 12:41:19.500: V/Request(16862): dalvik.system.VMStack.getThreadStackTrace(Native Method)
01-09 12:41:19.500: V/Request(16862): java.lang.Thread.getStackTrace(Thread.java:591)
01-09 12:41:19.500: V/Request(16862): com.ventismedia.android.mediamonkey.db.TransactionManager$Request.<init>(TransactionManager.java:678)
01-09 12:41:19.500: V/Request(16862): com.ventismedia.android.mediamonkey.db.TransactionManager$DbSerializer.put(TransactionManager.java:1591)
01-09 12:41:19.500: V/Request(16862): com.ventismedia.android.mediamonkey.db.TransactionManager.doInBackground(TransactionManager.java:373)
01-09 12:41:19.500: V/Request(16862): com.ventismedia.android.mediamonkey.db.MediaMonkeyStoreProvider.doDeleteInTransactionManager(MediaMonkeyStoreProvider.java:1710)
01-09 12:41:19.500: V/Request(16862): com.ventismedia.android.mediamonkey.db.MediaMonkeyStoreProvider.delete(MediaMonkeyStoreProvider.java:893)
01-09 12:41:19.500: V/Request(16862): android.content.ContentProvider$Transport.delete(ContentProvider.java:228)
01-09 12:41:19.500: V/Request(16862): android.content.ContentResolver.delete(ContentResolver.java:958)
01-09 12:41:19.500: V/Request(16862): com.ventismedia.android.mediamonkey.ui.dialogs.UriDeleteProgressDialogFragment.delete(UriDeleteProgressDialogFragment.java:39)
01-09 12:41:19.500: V/Request(16862): com.ventismedia.android.mediamonkey.ui.dialogs.DeleteProgressDialogFragment$1.run(DeleteProgressDialogFragment.java:66)
01-09 12:41:19.505: D/MediaMonkeyStoreProvider 1(16862): Query: /readonly/audio/media;Projection:[_id, title, track, album_art, artists, duration, type];Selection:(type=0);Args:null
01-09 12:41:19.505: D/THREAD CONTROL(16862): Not queried by db thread!!! 611 (609)
01-09 12:41:19.510: D/MediaMonkeyStoreProvider 5(16862): Query - end (5 ms): /readonly/audio/media
01-09 12:41:19.515: D/MediaMonkeyStoreProvider 1(16862): Query: /readonly/audio/media;Projection:[_id, title, track, album_art, artists, duration, type];Selection:(type=0);Args:null
01-09 12:41:19.515: D/THREAD CONTROL(16862): Not queried by db thread!!! 601 (609)
01-09 12:41:19.520: D/MediaMonkeyStoreProvider 5(16862): Query - end (4 ms): /readonly/audio/media
01-09 12:41:19.520: D/MediaMonkeyStoreProvider 5(16862): Delete - end (16418 ms): /audio/media/91
01-09 12:41:19.520: D/MediaMonkeyStoreProvider 1(16862): Delete: /audio/media/93,Selection:null;Args:null
01-09 12:41:19.555: D/Provider(16862): delete repeatIfLocked
01-09 12:41:19.595: D/dalvikvm(16862): GC_CONCURRENT freed 1462K, 21% free 7018K/8836K, paused 2ms+9ms, total 37ms
01-09 12:41:32.905: I/MediaMonkeyStoreProvider(16862): count 1
01-09 12:41:32.905: D/StopWatch(16862): StopWatch (Thread(608)) time:13382 summaryTime:13382
01-09 12:41:32.910: D/StopWatch(16862): 11:41:19.0528::<D>::StopWatch::Processing start:::TransactionManager.java.run():1339 CTT: 0 ERT:0
01-09 12:41:32.910: D/StopWatch(16862): 11:41:19.0533::<D>::StopWatch::Processing start unlockedMain:::TransactionManager.java.run():1341 CTT: 1 ERT:5
01-09 12:41:32.910: D/MediaMonkeyStoreProvider 1(16862): Query: /readonly/audio/media;Projection:[_id, title, track, album_art, artists, duration, type];Selection:(type=0);Args:null
01-09 12:41:32.915: D/StopWatch(16862): 11:41:19.0533::<D>::StopWatch::getWritableDatabase start:::TransactionManager.java.run():1354 CTT: 1 ERT:5
01-09 12:41:32.915: D/StopWatch(16862): 11:41:19.0533::<D>::StopWatch::getWritableDatabase end:::TransactionManager.java.run():1356 CTT: 1 ERT:5
01-09 12:41:32.915: D/StopWatch(16862): 11:41:19.0533::<D>::StopWatch::dbLock locking...:::TransactionManager.java.run():1401 CTT: 1 ERT:5
01-09 12:41:32.915: D/StopWatch(16862): 11:41:19.0533::<D>::StopWatch::dbLock locked:::TransactionManager.java.run():1403 CTT: 1 ERT:5
01-09 12:41:32.915: D/StopWatch(16862): 11:41:19.0534::<D>::StopWatch::process callback start inTransaction:true:::TransactionManager.java.run():1406 CTT: 1 ERT:6
01-09 12:41:32.915: D/StopWatch(16862): 11:41:32.0909::<D>::StopWatch::process callback end - returned:::TransactionManager.java.run():1408 CTT: 12788 ERT:13381
01-09 12:41:32.915: D/StopWatch(16862): 11:41:32.0909::<D>::StopWatch::process callback end:::TransactionManager.java.run():1439 CTT: 12788 ERT:13381
01-09 12:41:32.915: D/StopWatch(16862): 11:41:32.0910::<D>::StopWatch::dbLock unlocking...:::TransactionManager.java.run():1440 CTT: 12789 ERT:13381
01-09 12:41:32.920: D/StopWatch(16862): 11:41:32.0910::<D>::StopWatch::dbLock unlocked:::TransactionManager.java.run():1442 CTT: 12789 ERT:13382
01-09 12:41:32.920: V/Request(16862): dalvik.system.VMStack.getThreadStackTrace(Native Method)
01-09 12:41:32.920: V/Request(16862): java.lang.Thread.getStackTrace(Thread.java:591)
01-09 12:41:32.920: V/Request(16862): com.ventismedia.android.mediamonkey.db.TransactionManager$Request.<init>(TransactionManager.java:678)
01-09 12:41:32.920: V/Request(16862): com.ventismedia.android.mediamonkey.db.TransactionManager$DbSerializer.put(TransactionManager.java:1591)
01-09 12:41:32.920: V/Request(16862): com.ventismedia.android.mediamonkey.db.TransactionManager.doInBackground(TransactionManager.java:373)
01-09 12:41:32.920: V/Request(16862): com.ventismedia.android.mediamonkey.db.MediaMonkeyStoreProvider.doDeleteInTransactionManager(MediaMonkeyStoreProvider.java:1710)
01-09 12:41:32.920: V/Request(16862): com.ventismedia.android.mediamonkey.db.MediaMonkeyStoreProvider.delete(MediaMonkeyStoreProvider.java:893)
01-09 12:41:32.920: V/Request(16862): android.content.ContentProvider$Transport.delete(ContentProvider.java:228)
01-09 12:41:32.920: V/Request(16862): android.content.ContentResolver.delete(ContentResolver.java:958)
01-09 12:41:32.920: V/Request(16862): com.ventismedia.android.mediamonkey.ui.dialogs.UriDeleteProgressDialogFragment.delete(UriDeleteProgressDialogFragment.java:39)
01-09 12:41:32.920: V/Request(16862): com.ventismedia.android.mediamonkey.ui.dialogs.DeleteProgressDialogFragment$1.run(DeleteProgressDialogFragment.java:66)
01-09 12:41:32.925: D/THREAD CONTROL(16862): Not queried by db thread!!! 613 (609)
01-09 12:41:32.935: D/MediaMonkeyStoreProvider 5(16862): Query - end (7 ms): /readonly/audio/media
01-09 12:41:32.940: D/MediaMonkeyStoreProvider 5(16862): Delete - end (13416 ms): /audio/media/93
01-09 12:41:32.945: D/MediaMonkeyStoreProvider 1(16862): Delete: /audio/media/96,Selection:null;Args:null
01-09 12:41:32.980: D/StorageUtils(16862): deleteCleanDirectory : /storage/sdcard1/Music/Propellerheads/Decksandrumsandrockandroll
01-09 12:41:33.010: D/MediaMonkeyStoreProvider 1(16862): Query: /readonly/audio/media;Projection:[_id, title, track, album_art, artists, duration, type];Selection:(type=0);Args:null
01-09 12:41:33.010: D/THREAD CONTROL(16862): Not queried by db thread!!! 607 (609)
01-09 12:41:33.015: D/MediaMonkeyStoreProvider 5(16862): Query - end (3 ms): /readonly/audio/media
01-09 12:41:33.030: D/StorageUtils(16862): deleteCleanDirectory : /storage/sdcard1/Music/Propellerheads
01-09 12:41:33.055: D/Provider(16862): delete repeatIfLocked
01-09 12:41:43.100: I/MediaMonkeyStoreProvider(16862): count 1
01-09 12:41:43.105: D/StopWatch(16862): StopWatch (Thread(608)) time:10156 summaryTime:10157
01-09 12:41:43.105: D/StopWatch(16862): 11:41:32.0951::<D>::StopWatch::Processing start:::TransactionManager.java.run():1339 CTT: 0 ERT:0
01-09 12:41:43.105: D/StopWatch(16862): 11:41:32.0952::<D>::StopWatch::Processing start unlockedMain:::TransactionManager.java.run():1341 CTT: 1 ERT:0
01-09 12:41:43.105: D/MediaMonkeyStoreProvider 1(16862): Query: /readonly/audio/media;Projection:[_id, title, track, album_art, artists, duration, type];Selection:(type=0);Args:null
01-09 12:41:43.105: D/StopWatch(16862): 11:41:32.0952::<D>::StopWatch::getWritableDatabase start:::TransactionManager.java.run():1354 CTT: 1 ERT:1
01-09 12:41:43.110: D/StopWatch(16862): 11:41:32.0952::<D>::StopWatch::getWritableDatabase end:::TransactionManager.java.run():1356 CTT: 1 ERT:1
01-09 12:41:43.110: D/StopWatch(16862): 11:41:32.0952::<D>::StopWatch::dbLock locking...:::TransactionManager.java.run():1401 CTT: 1 ERT:1
01-09 12:41:43.110: D/StopWatch(16862): 11:41:32.0953::<D>::StopWatch::dbLock locked:::TransactionManager.java.run():1403 CTT: 2 ERT:2
01-09 12:41:43.110: D/StopWatch(16862): 11:41:32.0953::<D>::StopWatch::process callback start inTransaction:true:::TransactionManager.java.run():1406 CTT: 2 ERT:2
01-09 12:41:43.110: D/StopWatch(16862): 11:41:43.0105::<D>::StopWatch::process callback end - returned:::TransactionManager.java.run():1408 CTT: 9562 ERT:10154
01-09 12:41:43.115: D/StopWatch(16862): 11:41:43.0106::<D>::StopWatch::process callback end:::TransactionManager.java.run():1439 CTT: 9563 ERT:10154
01-09 12:41:43.115: D/StopWatch(16862): 11:41:43.0106::<D>::StopWatch::dbLock unlocking...:::TransactionManager.java.run():1440 CTT: 9563 ERT:10155
01-09 12:41:43.115: D/StopWatch(16862): 11:41:43.0106::<D>::StopWatch::dbLock unlocked:::TransactionManager.java.run():1442 CTT: 9563 ERT:10155
01-09 12:41:43.115: V/Request(16862): dalvik.system.VMStack.getThreadStackTrace(Native Method)
01-09 12:41:43.115: V/Request(16862): java.lang.Thread.getStackTrace(Thread.java:591)
01-09 12:41:43.115: V/Request(16862): com.ventismedia.android.mediamonkey.db.TransactionManager$Request.<init>(TransactionManager.java:678)
01-09 12:41:43.115: V/Request(16862): com.ventismedia.android.mediamonkey.db.TransactionManager$DbSerializer.put(TransactionManager.java:1591)
01-09 12:41:43.115: V/Request(16862): com.ventismedia.android.mediamonkey.db.TransactionManager.doInBackground(TransactionManager.java:373)
01-09 12:41:43.115: V/Request(16862): com.ventismedia.android.mediamonkey.db.MediaMonkeyStoreProvider.doDeleteInTransactionManager(MediaMonkeyStoreProvider.java:1710)
01-09 12:41:43.115: V/Request(16862): com.ventismedia.android.mediamonkey.db.MediaMonkeyStoreProvider.delete(MediaMonkeyStoreProvider.java:893)
01-09 12:41:43.115: V/Request(16862): android.content.ContentProvider$Transport.delete(ContentProvider.java:228)
01-09 12:41:43.115: V/Request(16862): android.content.ContentResolver.delete(ContentResolver.java:958)
01-09 12:41:43.115: V/Request(16862): com.ventismedia.android.mediamonkey.ui.dialogs.UriDeleteProgressDialogFragment.delete(UriDeleteProgressDialogFragment.java:39)
01-09 12:41:43.120: V/Request(16862): com.ventismedia.android.mediamonkey.ui.dialogs.DeleteProgressDialogFragment$1.run(DeleteProgressDialogFragment.java:66)
01-09 12:41:43.120: D/MediaMonkeyStoreProvider 5(16862): Delete - end (10176 ms): /audio/media/96
01-09 12:41:43.120: D/THREAD CONTROL(16862): Not queried by db thread!!! 610 (609)
01-09 12:41:43.120: D/MediaMonkeyStoreProvider 1(16862): Delete: /audio/media/90,Selection:null;Args:null
01-09 12:41:43.130: D/MediaMonkeyStoreProvider 5(16862): Query - end (5 ms): /readonly/audio/media
01-09 12:41:43.150: D/MediaMonkeyStoreProvider 1(16862): Query: /readonly/audio/media;Projection:[_id, title, track, album_art, artists, duration, type];Selection:(type=0);Args:null
01-09 12:41:43.150: D/THREAD CONTROL(16862): Not queried by db thread!!! 611 (609)
01-09 12:41:43.175: D/dalvikvm(16862): GC_FOR_ALLOC freed 1418K, 21% free 7015K/8836K, paused 27ms, total 27ms
01-09 12:41:43.180: D/StorageUtils(16862): deleteCleanDirectory : /storage/sdcard1/Music/Buty/Votom
01-09 12:41:43.180: D/MediaMonkeyStoreProvider 5(16862): Query - end (34 ms): /readonly/audio/media
01-09 12:41:43.225: D/StorageUtils(16862): deleteCleanDirectory : /storage/sdcard1/Music/Buty
01-09 12:41:43.250: D/Provider(16862): delete repeatIfLocked
01-09 12:41:49.565: I/MediaMonkeyStoreProvider(16862): count 1
01-09 12:41:49.570: D/MediaMonkeyStoreProvider 1(16862): Query: /readonly/audio/media;Projection:[_id, title, track, album_art, artists, duration, type];Selection:(type=0);Args:null
01-09 12:41:49.575: D/THREAD CONTROL(16862): Not queried by db thread!!! 601 (609)
01-09 12:41:49.585: D/MediaMonkeyStoreProvider 5(16862): Query - end (10 ms): /readonly/audio/media
01-09 12:41:49.595: D/MediaMonkeyStoreProvider 5(16862): Delete - end (6470 ms): /audio/media/90
01-09 12:41:49.595: D/MediaMonkeyStoreProvider 1(16862): Query: /readonly/audio/media;Projection:[_id, title, track, album_art, artists, duration, type];Selection:(type=0);Args:null
01-09 12:41:49.595: D/THREAD CONTROL(16862): Not queried by db thread!!! 613 (609)
01-09 12:41:49.600: D/MediaMonkeyStoreProvider 1(16862): Delete: /audio/media/88,Selection:null;Args:null
01-09 12:41:49.610: D/MediaMonkeyStoreProvider 5(16862): Query - end (14 ms): /readonly/audio/media
01-09 12:41:49.630: D/Provider(16862): delete repeatIfLocked
01-09 12:41:49.645: I/MediaMonkeyStoreProvider(16862): count 1
01-09 12:41:49.655: D/MediaMonkeyStoreProvider 5(16862): Delete - end (54 ms): /audio/media/88
01-09 12:41:49.655: D/MediaMonkeyStoreProvider 1(16862): Delete: /audio/media/89,Selection:null;Args:null
01-09 12:41:49.680: D/StorageUtils(16862): deleteCleanDirectory : /storage/sdcard0/SmartVoiceRecorder
01-09 12:41:49.685: D/MediaMonkeyStoreProvider 1(16862): Query: /readonly/audio/media;Projection:[_id, title, track, album_art, artists, duration, type];Selection:(type=0);Args:null
01-09 12:41:49.685: D/THREAD CONTROL(16862): Not queried by db thread!!! 607 (609)
01-09 12:41:49.700: D/Provider(16862): delete repeatIfLocked
01-09 12:41:49.705: D/MediaMonkeyStoreProvider 5(16862): Query - end (20 ms): /readonly/audio/media
01-09 12:41:49.710: I/MediaMonkeyStoreProvider(16862): count 1
01-09 12:41:49.720: D/MediaMonkeyStoreProvider 5(16862): Delete - end (65 ms): /audio/media/89
01-09 12:41:49.720: D/MediaMonkeyStoreProvider 1(16862): Delete: /audio/media/92,Selection:null;Args:null
01-09 12:41:49.755: D/dalvikvm(16862): GC_CONCURRENT freed 1512K, 21% free 7026K/8836K, paused 2ms+5ms, total 30ms
01-09 12:41:49.765: D/StorageUtils(16862): deleteCleanDirectory : /storage/sdcard1/Music/Rise Against/Appeal To Reason
01-09 12:41:49.780: D/MediaMonkeyStoreProvider 1(16862): Query: /readonly/audio/media;Projection:[_id, title, track, album_art, artists, duration, type];Selection:(type=0);Args:null
01-09 12:41:49.785: D/THREAD CONTROL(16862): Not queried by db thread!!! 601 (609)
01-09 12:41:49.785: D/MediaMonkeyStoreProvider 5(16862): Query - end (2 ms): /readonly/audio/media
01-09 12:41:49.810: D/StorageUtils(16862): deleteCleanDirectory : /storage/sdcard1/Music/Rise Against
01-09 12:41:49.835: D/Provider(16862): delete repeatIfLocked
01-09 12:41:52.920: I/MediaMonkeyStoreProvider(16862): count 1
01-09 12:41:52.925: D/MediaMonkeyStoreProvider 1(16862): Query: /readonly/audio/media;Projection:[_id, title, track, album_art, artists, duration, type];Selection:(type=0);Args:null
01-09 12:41:52.925: D/THREAD CONTROL(16862): Not queried by db thread!!! 613 (609)
01-09 12:41:52.935: D/MediaMonkeyStoreProvider 5(16862): Query - end (12 ms): /readonly/audio/media
01-09 12:41:52.945: D/MediaMonkeyStoreProvider 5(16862): Delete - end (3225 ms): /audio/media/92
01-09 12:41:52.950: D/MediaMonkeyStoreProvider 1(16862): Insert: /commit
01-09 12:41:52.950: D/MediaMonkeyStoreProvider 5(16862): Insert - end (1 ms): /commit
01-09 12:41:52.955: D/TransactionManager(16862): repeatIfLocked inTransaction, isDbLockedByCurrentThread:true
01-09 12:41:52.960: D/MediaMonkeyStoreProvider 1(16862): Insert: /end_transaction
01-09 12:41:52.960: D/MediaMonkeyStoreProvider 1(16862): Query: /readonly/audio/media;Projection:[_id, title, track, album_art, artists, duration, type];Selection:(type=0);Args:null
01-09 12:41:52.960: D/THREAD CONTROL(16862): Not queried by db thread!!! 610 (609)
01-09 12:41:52.985: D/MediaMonkeyStoreProvider 5(16862): Query - end (23 ms): /readonly/audio/media
01-09 12:41:53.045: D/TransactionManager 14(16862): End Transaction by thread with id 609
01-09 12:41:53.050: D/MediaMonkeyStoreProvider 1(16862): Query: /readonly/audio/media;Projection:[_id, title, track, album_art, artists, duration, type];Selection:(type=0);Args:null
01-09 12:41:53.050: D/THREAD CONTROL(16862): Not queried by db thread!!! 607 (609)
01-09 12:41:53.055: D/MediaMonkeyStoreProvider 5(16862): Query - end (4 ms): /readonly/audio/media
01-09 12:41:53.060: D/TransactionManager(16862): No transaction to end.
01-09 12:41:53.060: D/MediaMonkeyStoreProvider 5(16862): Insert - end (101 ms): /end_transaction
01-09 12:41:53.060: D/StorageUtils(16862): Scan files: [/storage/sdcard0, /storage/sdcard1]
01-09 12:41:53.220: D/MediaStoreSyncService(16862): Service is not running
01-09 12:41:53.225: D/StorageObserverService(16862): Publish database event received.
01-09 12:41:53.225: D/BaseActivity(16862): onPause DialogActivity
01-09 12:41:53.235: D/ExtendedListFragment(16862): onActivityResult: request:1,result:1
01-09 12:41:53.240: D/ExtendedListFragment(16862): deselectAll
01-09 12:41:53.240: D/BaseActivity(16862): onResume LibraryActivity
01-09 12:41:53.240: D/BaseActivity(16862): mUseLockScreenPlayer false
01-09 12:41:53.240: D/BaseActivity(16862): receiverRegistered false
01-09 12:41:53.245: D/UIUtils(16862): isAppVisible: false
01-09 12:41:53.245: D/UIUtils(16862): setAppVisibility: true
01-09 12:41:53.250: I/MiniPlayerActivity(16862): onResume MediaFragment
01-09 12:41:53.250: D/PlaybackService(16862): Service is not running
01-09 12:41:53.275: D/dalvikvm(16862): GC_FOR_ALLOC freed 1519K, 22% free 6903K/8836K, paused 25ms, total 25ms
01-09 12:41:53.275: D/MiniPlayerActivity(16862): ACTION_USER_PRESENT registerReceiver
01-09 12:41:53.290: D/TrackListModel(16862): Get current track from preferences
01-09 12:41:53.290: W/MiniPlayerActivity(16862): Do nothing...
01-09 12:41:53.290: I/ContentService(16862): Service is not running
01-09 12:41:53.295: D/ExtendedListFragment(16862): onResume
01-09 12:41:53.295: D/ExtendedListFragment(16862): initTitleListener
01-09 12:41:53.305: D/MediaFragment(16862): onResume 
01-09 12:41:53.305: D/MediaFragment(16862): updateCurrentTrackId
01-09 12:41:53.305: I/TrackListModel(16862): getCurrentTrackInfo
01-09 12:41:53.330: D/StorageObserverService(16862): APP_GO_TO_FOREGROUND received
01-09 12:41:53.335: D/MediaStoreSyncObserver(16862): App goes to foreground
01-09 12:41:53.335: D/MediaStoreSyncObserver(16862): On wake up
01-09 12:41:53.335: D/SyncLauncher(16862): Application goes to foreground
01-09 12:41:53.335: I/StorageObserverService(16862): Service is running
01-09 12:41:53.340: D/BaseActivity(16862): onStop DialogActivity
01-09 12:41:53.340: D/DialogActivity(16862): onDestroy
01-09 12:41:53.340: D/BaseActivity(16862): onDestroy DialogActivity
01-09 12:41:53.530: D/StorageUtils(16862): Scanned /storage/sdcard0, uri=content://media/external/file/99708
01-09 12:41:53.625: D/StorageUtils(16862): Scanned /storage/sdcard1, uri=content://media/external/file/99709
01-09 12:41:54.060: D/TransactionManager(16862): ThreadSerializer exiting
01-09 12:41:54.060: D/TransactionManager(16862): releaseWakeLock
01-09 12:41:54.075: I/TransactionManager(16862): ThreadSerializer exit
log-slowdeletion.txt (45,845 bytes)   
Fixed in build

Activities

rusty

2014-11-25 22:41

administrator   ~0041153

I can't replicate this in 1.1.0.343. Has this issue already been resolved?

martin

2014-11-27 16:33

developer   ~0041184

Lot of changes made since this time . I can't replicate this issue too. Can you Marek?

marek

2014-11-30 19:53

developer   ~0041222

No, resolving.