0013022: Tracks fail to delete on USB sync (though playlists delete successfully) on KitKat write limited devices - MantisBT

ID	Project	Category	View Status	Date Submitted	Last Update

0013022	MMW v4	Synchronization	public	2015-12-14 04:27	2015-12-18 19:04

Reporter	rusty	Assigned To
Priority	immediate	Severity	block	Reproducibility	always
Status	closed	Resolution	fixed
Fixed in Version	4.1.10

Summary	0013022: Tracks fail to delete on USB sync (though playlists delete successfully) on KitKat write limited devices
Description	When testing USB sync of MMW 1776 against an Android device running kitkat (MMA 520), tracks fail to delete. Tested as follows: 0 Reboot the device 1 Install and run MMA, then wait for it to exit 2 USB Sync several playlists -->Sync is successful (verified hierarchy and ratings in MMA). 3 Wait for MMA to exit 4 Remove a playlist from the auto-sync list, and initiate USB sync -->MMW prompts to delete the playlist, but not any of the tracks!! EDIT: the key to replicating this is that MMA was installed prior to usb-synchronization, causing MMW to sync to an app-specific folder instead of to /Music. i.e. the bug is specific to USB sync to app-specific folders.
Tags	No tags attached.
Attached Files	tracks_fail_to_delete_on_usb_sync.LOG (82,693 bytes) 00000001 0.00000000 [6408] TGenThread.Create: ThreadName: UpdateDriveLetters_Var , Running Threads: Internal: 0, All: 84 00000002 0.00907531 [6408] PostponeComputerSleep: Enabled = 0 00000003 0.01077615 [6408] Thread 'UpdateDriveLetters_Var' has started 10128 00000004 0.01097409 [6408] Thread initialized 10128 00000005 0.02511673 [6408] >UpdateDriveLetters - end< 00000006 0.02527069 [6408] Going 'UpdateDriveLetters_Var'to make final callback 10128 00000007 0.02548183 [6408] Thread 'UpdateDriveLetters_Var'has finished 10128 00000008 3.91617870 [6408] Winamp simulation window received messsage 28 00000009 3.91752028 [6408] MainForm: NC Activate + 00000010 3.93917727 [1020] shell\twinui\nowplayingsessionmanager\localprovider\baseprovider\lib\baseprovider.cpp(516)\NPSMDesktopProvider.dll!00007FFB2B91E7B8: (caller: 00007FFB2B9149F9) ReturnHr[PreRelease](99) tid(2130) 80070490 Element not found. 00000011 3.99037194 [6408] New thread starting 1 00000012 4.01524734 [6408] TGenThread.Create: ThreadName: , Running Threads: Internal: 0, All: 88 00000013 4.02607727 [6408] Thread '' has started 10284 00000014 4.02652359 [6408] Thread initialized 10284 00000015 4.04884863 [6408] Prgrs: Creating a new level. 00000016 4.04914331 [6408] Prgrs: All data: Max: 1, TextFormat: Synchronizing Sam-Tab84 - Card: 00000017 4.05158091 [6408] Prgrs: Status: Thread: 10284, Levels: 2, Sub: 0 00000018 4.05270481 [6408] TAndroidDBHandler.OpenAndroidDB: StoragePrefix = /storage/extSdCard/ 00000019 4.05291367 [6408] TDevices.GetFirstDeviceStorage: Candidate: 0:RF2FA0ME90L!USB@\\?\USB#VID_04E8&PID_6860&MS_COMP_MTP&SAMSUNG_Android#8&4ebaa9b&2&0000#{f33fdc04-d1ac-4e8e-9a30-19bbd4b108ae}$0 00000020 4.05375004 [6408] WMDM: Executing action id:14 00000021 4.12491131 [6408] WMDM: GetStorageFromPath: mmstore.db.synced was not found 00000022 4.12553215 [6408] WMDM: Finished action id: 14 00000023 4.12578964 [6408] WMDM: Scanning device content 00000024 4.12607908 [6408] WMDM: Starting action id: 6 00000025 4.12621784 [6408] WMDM: GetStorageFromPath: \MediaMonkey\files 00000026 4.13077545 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\storageInfo.xml 00000027 4.13439655 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0013 00000028 4.13781118 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\.trashed 00000029 4.14109230 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0000 00000030 4.14435911 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0001 00000031 4.15057564 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0002 00000032 4.15465784 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0003 00000033 4.15805578 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0004 00000034 4.16150141 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0005 00000035 4.16796160 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0006 00000036 4.17474174 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0008 00000037 4.17805243 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0009 00000038 4.18242931 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0010 00000039 4.18587971 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0011 00000040 4.18974876 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0012 00000041 4.19320250 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0019 00000042 4.20094872 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0015 00000043 4.20429802 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0016 00000044 4.20785809 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0017 00000045 4.21135759 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0018 00000046 4.21486759 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0020 00000047 4.21825361 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\.trashed 00000048 4.25214243 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.synced.0001 00000049 4.27023649 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.synced.0002 00000050 4.28953028 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.synced.0003 00000051 4.38491726 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.synced.0006 00000052 4.38801527 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\.trashed 00000053 4.39101601 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db 00000054 4.39389372 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\.trashed 00000055 4.39746094 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\.trashed 00000056 4.40080690 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\.trashed 00000057 4.40373516 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.synced.0008 00000058 4.40679502 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\sync_finished 00000059 4.40798759 [6408] WMDM: Finished execution of action id:6 00000060 4.40870190 [6408] WMDM: Starting action id: 14 00000061 4.40910196 [6408] WMDM: GetStorageFromPath: \MediaMonkey\files\mmstore.db.synced.0001 00000062 4.43356514 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0001) 00000063 4.43426514 [6408] WMDM: Incomplete file was deleted. 00000064 4.43447018 [6408] WMDM: GetStorageFromPath: \MediaMonkey\files\mmstore.db.synced.0001 00000065 4.49496698 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0001) 00000066 4.49519539 [6408] WMDM: Finished execution of action id:14 00000067 4.49555302 [6408] WMDM: Starting action id: 7 00000068 4.52505255 [6408] WMDM: storagecontrol.Delete (rename): 0 00000069 4.52536106 [6408] WMDM: Finished execution of action id:7 00000070 4.52560329 [6408] WMDM: Starting action id: 8 00000071 4.52798128 [6408] WMDM: Finished action id: 8 00000072 4.52893734 [6408] WMDM: Executing action id:14 00000073 4.53929996 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0002) 00000074 4.54000092 [6408] WMDM: Downloading file \MediaMonkey\files\mmstore.db.synced.0002 -> C:\Users\Russell\AppData\Local\Temp\24B3.tmp 00000075 4.62049770 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0002) 00000076 4.68872786 [6408] WMDM: storagecontrol.Delete (rename): 0 00000077 4.68894196 [6408] WMDM: Finished execution of action id:7 00000078 4.68922424 [6408] WMDM: Starting action id: 8 00000079 4.69141769 [6408] WMDM: Finished action id: 8 00000080 4.69277668 [6408] WMDM: Starting action id: 14 00000081 4.69295120 [6408] WMDM: GetStorageFromPath: \MediaMonkey\files\mmstore.db.synced.0003 00000082 4.71314192 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0003) 00000083 4.71391249 [6408] WMDM: Downloading file \MediaMonkey\files\mmstore.db.synced.0003 -> C:\Users\Russell\AppData\Local\Temp\24B3.tmp 00000084 4.79182720 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0003) 00000085 4.86668348 [6408] WMDM: storagecontrol.Delete (rename): 0 00000086 4.86695766 [6408] WMDM: Finished execution of action id:7 00000087 4.86729193 [6408] WMDM: Starting action id: 8 00000088 4.87008810 [6408] WMDM: Finished action id: 8 00000089 4.87078667 [6408] WMDM: Executing action id:14 00000090 4.87096977 [6408] WMDM: Downloading file \MediaMonkey\files\mmstore.db.synced.0004 -> C:\Users\Russell\AppData\Local\Temp\24B3.tmp 00000091 4.89107656 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0004) 00000092 4.89133883 [6408] WMDM: Downloading file \MediaMonkey\files\mmstore.db.synced.0004 -> C:\Users\Russell\AppData\Local\Temp\24B3.tmp 00000093 4.96823835 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0004) 00000094 4.96847296 [6408] WMDM: Finished execution of action id:14 00000095 4.96897888 [6408] WMDM: Starting action id: 7 00000096 5.04350281 [6408] WMDM: Finished action id: 7 00000097 5.04398203 [6408] WMDM: Executing action id:8 00000098 5.04443836 [6408] WMDM: GetStorageFromPath: \MediaMonkey\files\ 00000099 5.04848194 [6408] WMDM: Finished action id: 8 00000100 5.04967785 [6408] WMDM: Executing action id:14 00000101 5.05011320 [6408] WMDM: Downloading file \MediaMonkey\files\mmstore.db.synced.0005 -> C:\Users\Russell\AppData\Local\Temp\24B3.tmp 00000102 5.07237673 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0005) 00000103 5.07299376 [6408] WMDM: Incomplete file was deleted. 00000104 5.07321882 [6408] WMDM: GetStorageFromPath: \MediaMonkey\files\mmstore.db.synced.0005 00000105 5.17680693 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0005) 00000106 5.17700338 [6408] WMDM: Finished execution of action id:14 00000107 5.17730331 [6408] WMDM: Starting action id: 7 00000108 5.24216509 [6408] WMDM: storagecontrol.Delete (rename): 0 00000109 5.24319458 [6408] WMDM: Executing action id:8 00000110 5.24842167 [6408] WMDM: Finished action id: 8 00000111 5.24988413 [6408] WMDM: Executing action id:14 00000112 5.25029421 [6408] WMDM: Downloading file \MediaMonkey\files\mmstore.db.synced.0006 -> C:\Users\Russell\AppData\Local\Temp\24B3.tmp 00000113 5.26812792 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0006) 00000114 5.26897764 [6408] WMDM: Downloading file \MediaMonkey\files\mmstore.db.synced.0006 -> C:\Users\Russell\AppData\Local\Temp\24B3.tmp 00000115 5.37912130 [6408] WMDM: Starting action id: 7 00000116 5.43844700 [6408] WMDM: storagecontrol.Delete (rename): 0 00000117 5.43872547 [6408] WMDM: Finished execution of action id:7 00000118 5.43902206 [6408] WMDM: Starting action id: 8 00000119 5.44109869 [6408] WMDM: Finished action id: 8 00000120 5.50469255 [6408] WMDM: Finished action id: 14 00000121 5.50522518 [6408] TAndroidDBHandler.OpenAndroidDB: Used DB: \MediaMonkey\files\mmstore.db.synced 00000122 5.51371479 [6408] OpenQuery - Preparing query SELECT null FROM info 00000123 5.51409531 [6408] OpenQuery - Preparing query SELECT null FROM media 00000124 5.51441288 [6408] OpenQuery - Preparing query SELECT null FROM albums 00000125 5.51511812 [6408] OpenQuery - Preparing query SELECT null FROM composers 00000126 5.51584291 [6408] OpenQuery - Preparing query SELECT null FROM media_artists_map 00000127 5.51615047 [6408] OpenQuery - Preparing query SELECT null FROM media_composers_map 00000128 5.51638937 [6408] TSQLiteDatabase.ExecSQL: REINDEX; 00000129 5.54793119 [6408] OpenQuery - Preparing query SELECT null FROM sync_operations 00000130 5.54865742 [6408] TAndroidDBHandler.DownloadDB: DB temp path: C:\Users\Russell\AppData\Local\Temp\24B3.tmp , StoragePrefix = /storage/extSdCard/ 00000131 5.54884386 [6408] WMDM: Executing action id:7 00000132 5.54914665 [6408] WMDM: GetStorageFromPath: \MediaMonkey\files\sync_finished 00000133 5.65747643 [6408] WMDM: storagecontrol.Delete (rename): 0 00000134 5.65763807 [6408] WMDM: Finished execution of action id:7 00000135 5.65793276 [6408] WMDM: Starting action id: 8 00000136 5.66112137 [6408] WMDM: Finished action id: 8 00000137 5.66284513 [6408] WMDM: Executing action id:1 00000138 5.66298056 [6408] WMDM: GetStorageFromPath: \MediaMonkey\files\sync_started 00000139 5.74035406 [6408] WMDM: GetStorageFromPath: sync_started was not found 00000140 5.74102068 [6408] WMDM: GetStorageFromPath: \MediaMonkey\files\ 00000141 5.85542107 [6408] WMDM: Uploading result, Insert3: 0 (C:\Users\Russell\AppData\Local\Temp\2043.tmp -> \MediaMonkey\files\sync_started) 00000142 5.85557365 [6408] WMDM: Finished execution of action id:1 00000143 5.85803175 [6408] WMDM: Executing action id:1 00000144 5.85820627 [6408] WMDM: GetStorageFromPath: \MediaMonkey\files\file_time_delta 00000145 5.87695360 [6408] WMDM: GetStorageFromPath: file_time_delta was not found 00000146 5.87789917 [6408] WMDM: GetStorageFromPath: \MediaMonkey\files\ 00000147 5.96638727 [6408] WMDM: Uploading result, Insert3: 0 (C:\Users\Russell\AppData\Local\Temp\75D9.tmp -> \MediaMonkey\files\file_time_delta) 00000148 5.96657753 [6408] WMDM: Finished execution of action id:1 00000149 6.01311827 [6408] WMDM: Executing action id:7 00000150 6.08501911 [6408] WMDM: storagecontrol.Delete (rename): 0 00000151 6.08519840 [6408] WMDM: Finished execution of action id:7 00000152 6.08549786 [6408] WMDM: Starting action id: 8 00000153 6.08857203 [6408] WMDM: Finished action id: 8 00000154 6.08885813 [6408] OpenQuery - Preparing query SELECT server_delta_time FROM info 00000155 6.12381220 [6408] TGenThread.Create: ThreadName: ScanDeviceContent_Var , Running Threads: Internal: 1, All: 88 00000156 6.13062668 [6408] Thread 'ScanDeviceContent_Var' has started 9348 00000157 6.13087368 [6408] Thread initialized 9348 00000158 6.15153027 [6408] Device: Scan: Get tracks from the last synchronization 00000159 6.15177202 [6408] OpenQuery - Preparing query SELECT * FROM DeviceTracks WHERE IDDevice = 220 00000160 6.15243196 [6408] 9348 DB prepare SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000161 6.15301037 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000162 6.15377140 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000163 6.15423632 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000164 6.15480280 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000165 6.15520477 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000166 6.15579033 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000167 6.15618944 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000168 6.15693283 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000169 6.15752363 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000170 6.15825891 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000171 6.15892696 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000172 6.15959597 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000173 6.16002369 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000174 6.16041803 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000175 6.16091347 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000176 6.16146040 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000177 6.16198015 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000178 6.16269922 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000179 6.16309834 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000180 6.16389894 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000181 6.16437006 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000182 6.16539288 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000183 6.16636038 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000184 6.16678047 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000185 6.16714811 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000186 6.16750956 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000187 6.16797733 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000188 6.16840887 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000189 6.16887760 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000190 6.16928005 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000191 6.16974926 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000192 6.17017221 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000193 6.17053509 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000194 6.17089272 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000195 6.17124081 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000196 6.17166758 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000197 6.17208767 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000198 6.17248440 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000199 6.17290163 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000200 6.17361116 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000201 6.17401648 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000202 6.17440891 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000203 6.17539120 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000204 6.17609215 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000205 6.17656708 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000206 6.17697525 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000207 6.17738724 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000208 6.17801523 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000209 6.17844105 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000210 6.17888212 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000211 6.17929888 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000212 6.18072987 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000213 6.18135643 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000214 6.18184900 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000215 6.18221426 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000216 6.18294096 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000217 6.18372011 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000218 6.18414736 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000219 6.18457937 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000220 6.18499136 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000221 6.18538046 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000222 6.18577814 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000223 6.18616533 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000224 6.18655491 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000225 6.18701553 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000226 6.18753529 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000227 6.18824053 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000228 6.18980598 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000229 6.19029045 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000230 6.19087601 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000231 6.19135952 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000232 6.19187689 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000233 6.19227791 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000234 6.19271612 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000235 6.19311285 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000236 6.19350529 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000237 6.19389057 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000238 6.19432116 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000239 6.19468307 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000240 6.19505262 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000241 6.19548607 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000242 6.19586563 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000243 6.19627047 [6408] 9348 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000244 6.19671488 [6408] Device: Scan: Get the real device content 00000245 6.19821262 [6408] TAndroidDBHandler.ReadContent 00000246 6.20833015 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Unknown\Unknown\00 Shir Lamaalot - Yosef Karduner (Tehilim 121).m4a 00000247 6.20914125 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Everly Brothers\Unknown\00 Everly Brothers - Bye Bye Love.mp3 00000248 6.20968342 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Leonard Cohen\Unknown\00 Leonard Cohen - Dance Me To The End Of Love.mp3 00000249 6.21019411 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Gordon Lightfoot\Unknown\11 Gordon Lightfoot - Sundown.mp3 00000250 6.21119452 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Various\2011 Billboard Charts Hot 100 Songs\09 Maroon 5 - Moves Like Jagger.mp3 00000251 6.21188354 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\The Silencers\A Blues For Buddha\09 The Silencers - Sacred Child.mp3 00000252 6.21249390 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Michael Franti & Spearhead\All Rebel Rockers\06 Michael Franti & Spe - Say Hey (I Love You).mp3 00000253 6.21320534 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Tom Petty & The Heartbreakers\Anthology - Through The Years\01 Tom Petty & The Hear - Breakdown.mp3 00000254 6.21376657 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Various Artists\Billboard Hot 100 Singles Chart\71 Elle King - Ex's & Oh's.mp3 00000255 6.21427298 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Various\Billboard Top100 Single Charts vom 22.12.2012\08 Fun - Some Nights.mp3 00000256 6.21483183 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Nick Drake\Bryter Layter\04 Nick Drake - One Of These Things First.mp3 00000257 6.21531248 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Rachel Portman\Chocolat - Soundtrack\04 Rachel Portman - Vianne Sets Up Shop.mp3 00000258 6.21639442 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Simon And Garfunkel\Collected Works remastered '92- The Sounds of Silence\18 Simon And Garfunkel - Anji.mp3 00000259 6.21709204 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Shloime Daskal\Dance with Shloime Daskal\02 Shloime Daskal - Od Yishama.mp3 00000260 6.21759415 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Green Day\Dookie\04 Green Day - Longview.mp3 00000261 6.21808147 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\various\Everything is Illuminated - OST\10 Tin Hat Trio - Fear of the South.mp3 00000262 6.21859789 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Various Artists\Festival of Light\03 Flairck - The Emigrant.mp3 00000263 6.21908760 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Franz Ferdinand\Franz Ferdinand\11 Franz Ferdinand - 40 ft.mp3 00000264 6.21961021 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Genesis\Genesis Archives 1 - 1967-1975\12 Genesis - The Magic Of Time.mp3 00000265 6.22013140 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Shlomo & Neshama Carlebach\Ha Neshama Shel Shlomo\06 Shlomo & Neshama Car - Ein K'Elokeinu.mp3 00000266 6.22062111 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Various Artists\Happy Chanukah Songs\07 Various Artists - Kad Katan.mp3 00000267 6.22108889 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Inasense\Inasense\00 Inasense - Ki Va Moed.mp3 00000268 6.22157907 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Eddie Vedder\Into the Wild\08 Eddie Vedder - Society.mp3 00000269 6.22203445 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Yaakov Shwekey\Kolot\09 Yaakov Shwekey - Et Rikod.mp3 00000270 6.22248173 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Unknown\Live In Melbourne\13 Shlomo Katz - Niggun Nevo.mp3 00000271 6.22293043 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Hans Zimmer\MI2\00 Hans Zimmer - MI-2.mp3 00000272 6.22340250 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Van Halen\Ou812\07 Van Halen - Finish What Ya Started.mp3 00000273 6.22388554 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Piamenta\Piamenta\11 Piamenta - Asher Boro.mp3 00000274 6.22436237 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Various test\Rock'n Roll Hit Party\08 Jerry Lee Lewis - Great Balls Of Fire.mp3 00000275 6.22521687 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Heather Nova\Siren\05 Heather Nova - Valley Of Sound.mp3 00000276 6.22592878 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Adam Sandler\Stan and Judy's Kid\12 Adam Sandler - Chanukah Song Part 2.mp3 00000277 6.22704172 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Various\Take Five\02 Dave Brubeck Quartet - Take Five.mp3 00000278 6.22767496 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\The Moshav Band\The Best Of - Higher and Higher\07 The Moshav Band - Eliyahu Hanavi.mp3 00000279 6.22841215 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Idan Raichel\The Idan Raichel Project\02 Idan Raichel - Mi'Ma'amakim (Out Of The Depths).mp3 00000280 6.23020077 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Lake & Palmer Emerson\The Ultimate Collection\09 Lake & Palmer Emerso - I Believe in Father Christmas.mp3 00000281 6.23091507 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Project X\The Ultimate Wedding Experienc\06 Project X - Ut Ut.mp3 00000282 6.23141575 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Alexi Murdoch\Time Without Consequence\08 Alexi Murdoch - Blue Mind.mp3 00000283 6.23193264 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Various Artists\To Life!- Songs of Chanukah and Other Jewish Celebrations\02 Theodore Bikel - Chanukah- Chanukah, Oh Chanukah.mp3 00000284 6.23251581 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Various Artists\To Life!- Songs of Chanukah and Other Jewish Celebrations\04 Jay Levy - Chanukah- Sevivon (Spin Little Dreydl).mp3 00000285 6.23397112 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Death Cab for Cutie\Transatlanticism\03 Death Cab for Cutie - Title and Registration.mp3 00000286 6.23450804 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Tori Amos\Under the Pink\08 Tori Amos - Cornflake Girl.mp3 00000287 6.23501730 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Benny Friedman\Yesh Tikvah\01 Benny Friedman - Yesh Tikvah.mp3 00000288 6.23565435 [6408] OpenQuery - Preparing query SELECT media._data FROM media, playlist_items_map WHERE playlist_items_map.playlist_id = 1 AND playlist_items_map.item_id = media._id ORDER BY playlist_items_map.play_order 00000289 6.23629141 [6408] OpenQuery - Preparing query SELECT media._data FROM media, playlist_items_map WHERE playlist_items_map.playlist_id = 5 AND playlist_items_map.item_id = media._id ORDER BY playlist_items_map.play_order 00000290 6.23682833 [6408] OpenQuery - Preparing query SELECT media._data FROM media, playlist_items_map WHERE playlist_items_map.playlist_id = 6 AND playlist_items_map.item_id = media._id ORDER BY playlist_items_map.play_order 00000291 6.23734856 [6408] OpenQuery - Preparing query SELECT media._data FROM media, playlist_items_map WHERE playlist_items_map.playlist_id = 7 AND playlist_items_map.item_id = media._id ORDER BY playlist_items_map.play_order 00000292 6.23790073 [6408] OpenQuery - Preparing query SELECT media._data FROM media, playlist_items_map WHERE playlist_items_map.playlist_id = 4 AND playlist_items_map.item_id = media._id ORDER BY playlist_items_map.play_order 00000293 6.23833036 [6408] OpenQuery - Preparing query SELECT media._data FROM media, playlist_items_map WHERE playlist_items_map.playlist_id = 3 AND playlist_items_map.item_id = media._id ORDER BY playlist_items_map.play_order 00000294 6.23882866 [6408] OpenQuery - Preparing query SELECT media._data FROM media, playlist_items_map WHERE playlist_items_map.playlist_id = 2 AND playlist_items_map.item_id = media._id ORDER BY playlist_items_map.play_order 00000295 6.23927689 [6408] Device: Scan: Delete the tracks from the last synchronization that are no longer presented on the device 00000296 6.24199724 [6408] Device: Scan terminating 00000297 6.24236965 [6408] Going 'ScanDeviceContent_Var'to make final callback 9348 00000298 6.24340868 [6408] Thread 'ScanDeviceContent_Var'has finished 9348 00000299 6.28080606 [6408] 10284 DB open SQL: SELECT * FROM DeviceTracks WHERE IDDevice=220 00000300 6.28140116 [6408] 10284 DB lock finished, took 652. 00000301 6.28249741 [6408] OpenQuery - Preparing query SELECT _data, _id FROM media WHERE wifi_item_id is null 00000302 6.28300238 [6408] OpenQuery - Preparing query SELECT media._id, media.wifi_item_id, modifications.field_id, modifications.old_value, modifications.new_value, modifications.time_stamp FROM modifications, media WHERE pc_synced = 0 AND media._id = modifications.media_id AND media.wifi_item_id is not null ORDER BY modifications.media_id, modifications.time_stamp, modifications._id 00000303 6.28370762 [6408] 10284 DB open SQL: SELECT * FROM SynchCollection WHERE SynchCollection.IDDevice=220 AND IDCollection=1 00000304 6.28418350 [6408] 10284 DB lock finished, took 504. 00000305 6.28437710 [6408] 10284 DB open SQL: SELECT * FROM SynchLocation WHERE IDDevice=220 AND FilterID=1 00000306 6.28480291 [6408] 10284 DB lock finished, took 439. 00000307 6.28500080 [6408] 10284 DB open SQL: SELECT Albums.ID, Albums.Album, Albums.Artist, SynchAlbum.MaskPath, SynchAlbum.PersonType, SynchAlbum.IDArtist FROM Albums INNER JOIN SynchAlbum ON (Albums.ID=SynchAlbum.IDAlbum AND SynchAlbum.IDDevice=220 AND SynchAlbum.FilterID=1) 00000308 6.28546000 [6408] 10284 DB lock finished, took 482. 00000309 6.28565550 [6408] 10284 DB open SQL: SELECT Artists.Id, Artists.Artist, SynchArtist.MaskPath, SynchArtist.PersonType, SynchArtist.ArtistNodeType FROM Artists INNER JOIN SynchArtist ON (Artists.ID=SynchArtist.IDArtist AND SynchArtist.IDDevice=220 AND SynchArtist.FilterID=1) WHERE SynchArtist.PartialCheck<>1 00000310 6.28611946 [6408] 10284 DB lock finished, took 488. 00000311 6.28631115 [6408] 10284 DB open SQL: SELECT IDGenre FROM SynchGenre WHERE IDDevice=220 AND FilterID=1 00000312 6.28671265 [6408] 10284 DB lock finished, took 406. 00000313 6.28690052 [6408] 10284 DB open SQL: SELECT Rating FROM SynchRating WHERE IDDevice=220 AND FilterID=1 00000314 6.28728294 [6408] 10284 DB lock finished, took 386. 00000315 6.28747129 [6408] 10284 DB open SQL: SELECT Podcasts.Id, SynchPodcast.MaskPath FROM Podcasts INNER JOIN SynchPodcast ON (Podcasts.ID=SynchPodcast.IDPodcast AND SynchPodcast.IDDevice=220 AND SynchPodcast.FilterID=1) 00000316 6.28791857 [6408] 10284 DB lock finished, took 467. 00000317 6.28811502 [6408] OpenQuery - Preparing query SELECT * FROM DeviceCollectionConfig WHERE IDDevice=220 AND IDCollection=1 00000318 6.28913116 [6408] Synchronize: Preparing whole Collections 00000319 6.28931236 [6408] OpenQuery - Preparing query SELECT * FROM SynchCollection WHERE SynchCollection.IDDevice=220 AND IDCollection=2 00000320 6.29001617 [6408] Synchronize: Preparing locations 00000321 6.29017019 [6408] OpenQuery - Preparing query SELECT * FROM SynchLocation WHERE IDDevice=220 AND FilterID=2 00000322 6.29071331 [6408] Synchronize: Preparing albums 00000323 6.29089594 [6408] OpenQuery - Preparing query SELECT Albums.ID, Albums.Album, Albums.Artist, SynchAlbum.MaskPath, SynchAlbum.PersonType, SynchAlbum.IDArtist FROM Albums INNER JOIN SynchAlbum ON (Albums.ID=SynchAlbum.IDAlbum AND SynchAlbum.IDDevice=220 AND SynchAlbum.FilterID=2) 00000324 6.29138947 [6408] Synchronize: Preparing artists 00000325 6.29156876 [6408] OpenQuery - Preparing query SELECT Artists.Id, Artists.Artist, SynchArtist.MaskPath, SynchArtist.PersonType, SynchArtist.ArtistNodeType FROM Artists INNER JOIN SynchArtist ON (Artists.ID=SynchArtist.IDArtist AND SynchArtist.IDDevice=220 AND SynchArtist.FilterID=2) WHERE SynchArtist.PartialCheck<>1 00000326 6.29217529 [6408] Synchronize: Preparing Genres 00000327 6.29235554 [6408] OpenQuery - Preparing query SELECT IDGenre FROM SynchGenre WHERE IDDevice=220 AND FilterID=2 00000328 6.29279995 [6408] Synchronize: Preparing Ratings 00000329 6.29297781 [6408] OpenQuery - Preparing query SELECT Rating FROM SynchRating WHERE IDDevice=220 AND FilterID=2 00000330 6.29338551 [6408] Synchronize: Preparing podcasts 00000331 6.29356146 [6408] OpenQuery - Preparing query SELECT Podcasts.Id, SynchPodcast.MaskPath FROM Podcasts INNER JOIN SynchPodcast ON (Podcasts.ID=SynchPodcast.IDPodcast AND SynchPodcast.IDDevice=220 AND SynchPodcast.FilterID=2) 00000332 6.29404593 [6408] 10284 DB open SQL: SELECT * FROM DeviceCollectionConfig WHERE IDDevice=220 AND IDCollection=2 00000333 6.29467535 [6408] 10284 DB lock finished, took 713. 00000334 6.29521418 [6408] 10284 DB open SQL: SELECT * FROM SynchCollection WHERE SynchCollection.IDDevice=220 AND IDCollection=3 00000335 6.29563427 [6408] 10284 DB lock finished, took 428. 00000336 6.29582548 [6408] 10284 DB open SQL: SELECT * FROM SynchLocation WHERE IDDevice=220 AND FilterID=3 00000337 6.29624319 [6408] 10284 DB lock finished, took 429. 00000338 6.29643965 [6408] 10284 DB open SQL: SELECT Albums.ID, Albums.Album, Albums.Artist, SynchAlbum.MaskPath, SynchAlbum.PersonType, SynchAlbum.IDArtist FROM Albums INNER JOIN SynchAlbum ON (Albums.ID=SynchAlbum.IDAlbum AND SynchAlbum.IDDevice=220 AND SynchAlbum.FilterID=3) 00000339 6.29697275 [6408] 10284 DB lock finished, took 540. 00000340 6.29718399 [6408] 10284 DB open SQL: SELECT Artists.Id, Artists.Artist, SynchArtist.MaskPath, SynchArtist.PersonType, SynchArtist.ArtistNodeType FROM Artists INNER JOIN SynchArtist ON (Artists.ID=SynchArtist.IDArtist AND SynchArtist.IDDevice=220 AND SynchArtist.FilterID=3) WHERE SynchArtist.PartialCheck<>1 00000341 6.29825783 [6408] 10284 DB lock finished, took 518. 00000342 6.29846954 [6408] 10284 DB open SQL: SELECT IDGenre FROM SynchGenre WHERE IDDevice=220 AND FilterID=3 00000343 6.29894495 [6408] 10284 DB lock finished, took 498. 00000344 6.29913330 [6408] 10284 DB open SQL: SELECT Rating FROM SynchRating WHERE IDDevice=220 AND FilterID=3 00000345 6.29991770 [6408] 10284 DB lock finished, took 882. 00000346 6.30020189 [6408] 10284 DB open SQL: SELECT Podcasts.Id, SynchPodcast.MaskPath FROM Podcasts INNER JOIN SynchPodcast ON (Podcasts.ID=SynchPodcast.IDPodcast AND SynchPodcast.IDDevice=220 AND SynchPodcast.FilterID=3) 00000347 6.30066681 [6408] 10284 DB lock finished, took 530. 00000348 6.30086184 [6408] OpenQuery - Preparing query SELECT Kind, Number FROM DeviceCollectionConfig WHERE IDDevice=220 AND IDCollection=3 00000349 6.30219603 [6408] Synchronize: Preparing whole Collections 00000350 6.30237865 [6408] OpenQuery - Preparing query SELECT * FROM SynchCollection WHERE SynchCollection.IDDevice=220 AND IDCollection=4 00000351 6.30286837 [6408] Synchronize: Preparing locations 00000352 6.30304432 [6408] OpenQuery - Preparing query SELECT * FROM SynchLocation WHERE IDDevice=220 AND FilterID=4 00000353 6.30348635 [6408] Synchronize: Preparing albums 00000354 6.30373669 [6408] OpenQuery - Preparing query SELECT Albums.ID, Albums.Album, Albums.Artist, SynchAlbum.MaskPath, SynchAlbum.PersonType, SynchAlbum.IDArtist FROM Albums INNER JOIN SynchAlbum ON (Albums.ID=SynchAlbum.IDAlbum AND SynchAlbum.IDDevice=220 AND SynchAlbum.FilterID=4) 00000355 6.30428648 [6408] Synchronize: Preparing artists 00000356 6.30447388 [6408] OpenQuery - Preparing query SELECT Artists.Id, Artists.Artist, SynchArtist.MaskPath, SynchArtist.PersonType, SynchArtist.ArtistNodeType FROM Artists INNER JOIN SynchArtist ON (Artists.ID=SynchArtist.IDArtist AND SynchArtist.IDDevice=220 AND SynchArtist.FilterID=4) WHERE SynchArtist.PartialCheck<>1 00000357 6.30539179 [6408] Synchronize: Preparing Genres 00000358 6.30567026 [6408] OpenQuery - Preparing query SELECT IDGenre FROM SynchGenre WHERE IDDevice=220 AND FilterID=4 00000359 9.73616886 [1020] shell\twinui\nowplayingsessionmanager\localprovider\baseprovider\lib\baseprovider.cpp(516)\NPSMDesktopProvider.dll!00007FFB2B91E7B8: (caller: 00007FFB2B9149F9) ReturnHr[PreRelease](101) tid(2130) 80070490 Element not found. 00000360 12.74941158 [6408] Forms: RestoreTopMost: Level: 1 00000361 12.77814960 [6408] MainForm: NC Activate + 00000362 12.78551579 [6408] Prgrs: Creating a new level. 00000363 12.78899097 [6408] Prgrs: All data: Max: 0, TextFormat: (Removing old content) 00000364 12.79299641 [6408] WMDM: Executing action id:7 00000365 12.90854549 [6408] WMDM: storagecontrol.Delete: 0 00000366 12.90915775 [6408] WMDM: Starting action id: 7 00000367 13.01422596 [6408] WMDM: storagecontrol.Delete: 0 00000368 13.01460266 [6408] WMDM: Finished execution of action id:7 00000369 13.11823368 [6408] WMDM: storagecontrol.Delete: 0 00000370 13.11865330 [6408] WMDM: Finished execution of action id:7 00000371 13.11901283 [6408] WMDM: Starting action id: 7 00000372 13.21739483 [6408] WMDM: storagecontrol.Delete: 0 00000373 13.21768093 [6408] WMDM: Finished execution of action id:7 00000374 13.21807766 [6408] WMDM: Starting action id: 7 00000375 13.34980965 [6408] WMDM: GetStorageFromPath: Test Hierarchy.m3u was not found 00000376 13.35044479 [6408] WMDM: Finished execution of action id:7 00000377 13.35082245 [6408] WMDM: Starting action id: 7 00000378 13.45589924 [6408] WMDM: storagecontrol.Delete: 0 00000379 13.45619011 [6408] WMDM: Finished execution of action id:7 00000380 13.45663548 [6408] WMDM: Starting action id: 7 00000381 13.54794407 [6408] WMDM: storagecontrol.Delete: 0 00000382 13.54846668 [6408] WMDM: Executing action id:8 00000383 13.64729691 [6408] WMDM: storagecontrol.Delete: 0 00000384 13.71375179 [6408] WMDM: Finished action id: 8 00000385 13.71407509 [6408] TDevice.DeleteFromDeviceTracks: Count = 7 00000386 13.71460629 [6408] 10284 DB prepare SQL: DELETE FROM DeviceTracks WHERE DevicePath = ? AND IDDevice = ? 00000387 13.71487331 [6408] 10284 DB exec SQL: DELETE FROM DeviceTracks WHERE DevicePath = ? AND IDDevice = ? 00000388 13.71509552 [6408] 10284 DB lock finished, took 63. 00000389 13.71556950 [6408] 10284 DB lock successful. 00000390 13.71601486 [6408] 10284 DB exec SQL: DELETE FROM DeviceTracks WHERE DevicePath = ? AND IDDevice = ? 00000391 13.71620750 [6408] 10284 DB lock finished, took 36. 00000392 13.71662045 [6408] 10284 DB lock successful. 00000393 13.71704578 [6408] 10284 DB exec SQL: DELETE FROM DeviceTracks WHERE DevicePath = ? AND IDDevice = ? 00000394 13.71724701 [6408] 10284 DB lock finished, took 34. 00000395 13.71763706 [6408] 10284 DB lock successful. 00000396 13.71805191 [6408] 10284 DB exec SQL: DELETE FROM DeviceTracks WHERE DevicePath = ? AND IDDevice = ? 00000397 13.71824360 [6408] 10284 DB lock finished, took 33. 00000398 13.71879101 [6408] Prgrs: Updating previous level from: 0.1 by 0 00000399 13.72241211 [6408] Prgrs: Status: Thread: 10284, Levels: 1, Sub: 0 00000400 13.72279930 [6408] Prgrs: Status: Thread: 10284, Levels: 2, Sub: 0 00000401 13.72310734 [6408] OpenQuery - Preparing query SELECT * FROM DeviceCollectionConfig WHERE IDDevice=220 00000402 13.72369576 [6408] WMDM: Executing action id:11 00000403 13.72410011 [6408] WMDM: EnumStorage: 0 00000404 13.72655010 [6408] WMDM: Finished action id: 11 00000405 13.72699261 [6408] Prgrs: All data: Max: 0, TextFormat: (Copying %d of %d%s: %s) 00000406 13.72755337 [6408] Prgrs: Maximum: 0 00000407 13.72804546 [6408] Prgrs: Updating previous level from: 0.1 by 0.9 00000408 13.72926712 [6408] Synchronize: Finished 00000409 13.72999477 [6408] TAndroidDBHandler.DeleteFiles 00000410 13.73018837 [6408] TSQLiteDatabase.ExecSQL: DELETE FROM media WHERE _data = '/storage/extSdCard/Android/data/com.ventismedia.android.mediamonkey/files/Playlists/Channukah.m3u' 00000411 13.73458385 [6408] TSQLiteDatabase.ExecSQL: DELETE FROM playlists WHERE _data = '/storage/extSdCard/Android/data/com.ventismedia.android.mediamonkey/files/Playlists/Channukah.m3u' 00000412 13.73736858 [6408] TAndroidDBHandler.Delete: /storage/extSdCard/Android/data/com.ventismedia.android.mediamonkey/files/Playlists/Hierarchy 1.m3u 00000413 13.74090767 [6408] TSQLiteDatabase.ExecSQL: DELETE FROM playlists WHERE _data = '/storage/extSdCard/Android/data/com.ventismedia.android.mediamonkey/files/Playlists/Hierarchy 1.m3u' 00000414 13.74403763 [6408] TAndroidDBHandler.Delete: /storage/extSdCard/Android/data/com.ventismedia.android.mediamonkey/files/Playlists/Hierarchy 2.m3u 00000415 13.75398064 [6408] TSQLiteDatabase.ExecSQL: DELETE FROM playlists WHERE _data = '/storage/extSdCard/Android/data/com.ventismedia.android.mediamonkey/files/Playlists/Hierarchy 2.m3u' 00000416 13.75698376 [6408] TAndroidDBHandler.Delete: /storage/extSdCard/Android/data/com.ventismedia.android.mediamonkey/files/Playlists/Hierarchy 3.m3u 00000417 13.76066399 [6408] TSQLiteDatabase.ExecSQL: DELETE FROM playlists WHERE _data = '/storage/extSdCard/Android/data/com.ventismedia.android.mediamonkey/files/Playlists/Hierarchy 3.m3u' 00000418 13.76342869 [6408] TAndroidDBHandler.Delete: /storage/extSdCard/Android/data/com.ventismedia.android.mediamonkey/files/Playlists/Test Hierarchy.m3u 00000419 13.76709366 [6408] TSQLiteDatabase.ExecSQL: DELETE FROM playlists WHERE _data = '/storage/extSdCard/Android/data/com.ventismedia.android.mediamonkey/files/Playlists/Test Hierarchy.m3u' 00000420 13.76955223 [6408] TAndroidDBHandler.Delete: /storage/extSdCard/Android/data/com.ventismedia.android.mediamonkey/files/Playlists/Test list 2.m3u 00000421 13.77307701 [6408] TSQLiteDatabase.ExecSQL: DELETE FROM playlists WHERE _data = '/storage/extSdCard/Android/data/com.ventismedia.android.mediamonkey/files/Playlists/Test list 2.m3u' 00000422 13.77607727 [6408] TAndroidDBHandler.Delete: /storage/extSdCard/Android/data/com.ventismedia.android.mediamonkey/files/Playlists/Test list.m3u 00000423 13.78114891 [6408] TSQLiteDatabase.ExecSQL: DELETE FROM playlists WHERE _data = '/storage/extSdCard/Android/data/com.ventismedia.android.mediamonkey/files/Playlists/Test list.m3u' 00000424 13.78430843 [6408] 10284 DB open SQL: SELECT * FROM DeviceCollectionConfig WHERE IDDevice=220 00000425 13.78485107 [6408] 10284 DB lock finished, took 586. 00000426 13.78554726 [6408] TSQLiteDatabase.ExecSQL: BEGIN EXCLUSIVE 00000427 13.78597069 [6408] TSQLiteDatabase.ExecSQL: INSERT INTO deviceConfig (config, storageRoot) VALUES ('<?xml version="1.0" encoding="UTF-8"?> 00000428 13.78597069 [6408] <DeviceConfig> 00000429 13.78597069 [6408] <DeviceName>Sam-Tab84 - Card</DeviceName> 00000430 13.78597069 [6408] <Visible>1</Visible> 00000431 13.78597069 [6408] <WirelessIDString>3251fad0-3a91-4038-ad0a-b32d2944bed2.1.dd64215d-4ed1-4829-9455-ae2852c38f82</WirelessIDString> 00000432 13.78597069 [6408] <MediaMonkeyVersion>4.1.10.1776</MediaMonkeyVersion> 00000433 13.78597069 [6408] <DatabaseID>1379276446</DatabaseID> 00000434 13.78597069 [6408] <MusicMask>\Music\%R\%L\%2T $Left(%A,20) - %S</MusicMask> 00000435 13.78597069 [6408] <ClassMusicMask>\Music\Classical\%C\%L\%2T $Left(%A,20) - %S</ClassMusicMask> 00000436 13.78597069 [6408] <AudiobookMask>\Music\Audiobooks\%L - %A\%2T %S</AudiobookMask> 00000437 13.78597069 [6408] <PodcastMask>\Music\Podcasts\%ZU\%ZP %S</PodcastMask> 00000438 13.78597069 [6408] <VideoPodcastMask>\Video\Podcasts\%ZU\%ZP %S</VideoPodcastMask> 00000439 13.78597069 [6408] <VideoMask>\Video\%S - %Y</VideoMask> 00000440 13.78597069 [6408] <MusicVideoMask>\Video\Music Video\%R - %L\%2T %S</MusicVideoMask> 00000441 13.78597069 [6408] <TVMask>\Video\TV\%ZV\%2ZY %S</TVMask> 00000442 13.78597069 [6408] <CreateM3Us>1</CreateM3Us> 00000443 13.78597069 [6408] <M3U> 00000444 13.78597069 [6408] <DestDirectory>\Playlists\</DestDirectory> 00000445 13.78597069 [6408] <M3UForPlaylists>1</M3UForPlaylists> 00000446 13.78597069 [6408] <M3UForArists>0</M3UForArists> 00000447 13.78597069 [6408] <M3UForAlbums>0</M3UForAlbums> 00000448 13.78597069 [6408] <M3UForLocations>0</M3UForLocations> 00000449 13.78597069 [6408] <UseRelativePaths>0</UseRelativePaths> 00000450 13.78597069 [6408] <UseAnsiStyle>0</UseAnsiStyle> 00000451 13.78597069 [6408] <UseExtendedM3U>0</UseExtendedM3U> 00000452 13.78597069 [6408] <LinuxFolderSeparator>0</LinuxFolderSeparator> 00000453 13.78597069 [6408] <Organize>-1</Organize> 00000454 13.78597069 [6408] </M3U> 00000455 13.78597069 [6408] <TAGGING> 00000456 13.78597069 [6408] <SyncAAMask>albumart.jpg</SyncAAMask> 00000457 13.78597069 [6408] <SaveAAToFolder>1</SaveAAToFolder> 00000458 13.78597069 [6408] <SaveAAToTag>0</SaveAAToTag> 00000459 13.78597069 [6408] <RemoveAAFromTag>0</RemoveAAFromTag> 00000460 13.78597069 [6408] <RemoveAAByteRate>300</RemoveAAByteRate> 00000461 13.78597069 [6408] <FirstGenre>1</FirstGenre> 00000462 13.78597069 [6408] <FirstArtist>0</FirstArtist> 00000463 13.78597069 [6408] </TAGGING> 00000464 13.78597069 [6408] <AUTOSYNC> 00000465 13.78597069 [6408] <DeleteUnsynch>1</DeleteUnsynch> 00000466 13.78597069 [6408] <DeleteConfirm>1</DeleteConfirm> 00000467 13.78597069 [6408] <DeleteUnknown>1</DeleteUnknown> 00000468 13.78597069 [6408] <DeleteConfirmUnknown>1</DeleteConfirmUnknown> 00000469 13.78597069 [6408] <ResyncOnMaskChange>1</ResyncOnMaskChange> 00000470 13.78597069 [6408] <ReserveSpaceMB>0</ReserveSpaceMB> 00000471 13.78597069 [6408] <BiDirSync>0</BiDirSync> 00000472 13.78597069 [6408] <BiDirConfirm>1</BiDirConfirm> 00000473 13.78597069 [6408] <BiDirSyncMetadata>1</BiDirSyncMetadata> 00000474 13.78597069 [6408] <BiDirFolder>\Music\</BiDirFolder> 00000475 13.78597069 [6408] <BiDirFolder>\Music\Audiobooks\</BiDirFolder> 00000476 13.78597069 [6408] <BiDirFolder>\Music\Classical\</BiDirFolder> 00000477 13.78597069 [6408] <BiDirFolder>\Music\Podcasts\</BiDirFolder> 00000478 13.78597069 [6408] <BiDirFolder>\Video\</BiDirFolder> 00000479 13.78597069 [6408] <BiDirFolder>\Video\Music Video\</BiDirFolder> 00000480 13.78597069 [6408] <BiDirFolder>\Video\Podcasts\</BiDirFolder> 00000481 13.78597069 [6408] <BiDirFolder>\Video\TV\</BiDirFolder> 00000482 13.78597069 [6408] <ScanFolder>\Music\</ScanFolder> 00000483 13.78597069 [6408] <ScanFolder>\Music\Audiobooks\</ScanFolder> 00000484 13.78597069 [6408] <ScanFolder>\Music\Classical\</ScanFolder> 00000485 13.78597069 [6408] <ScanFolder>\Music\Podcasts\</ScanFolder> 00000486 13.78597069 [6408] <ScanFolder>\Video\</ScanFolder> 00000487 13.78597069 [6408] <ScanFolder>\Video\Music Video\</ScanFolder> 00000488 13.78597069 [6408] <ScanFolder>\Video\Podcasts\</ScanFolder> 00000489 13.78597069 [6408] <ScanFolder>\Video\TV\</ScanFolder> 00000490 13.78597069 [6408] <SynchOnConnect>0</SynchOnConnect> 00000491 13.78597069 [6408] <ScanOnConnect>1</ScanOnConnect> 00000492 13.78597069 [6408] <AutoUnmount>0</AutoUnmount> 00000493 13.78597069 [6408] <canBiDiSynch>1</canBiDiSynch> 00000494 13.78597069 [6408] <CanEject>1</CanEject> 00000495 13.78597069 [6408] </AUTOSYNC> 00000496 13.78597069 [6408] </DeviceConfig> 00000497 13.78597069 [6408] ' , '/storage/extSdCard/') 00000498 13.78626442 [6408] SQLiteDB - Close 00000499 13.78643417 [6408] TSQLiteDatabase.ExecSQL: COMMIT 00000500 14.01318741 [6408] WMDM: storagecontrol.Delete (rename): 0 00000501 14.01334095 [6408] WMDM: Finished execution of action id:7 00000502 14.01376343 [6408] WMDM: Starting action id: 8 00000503 14.01744366 [6408] WMDM: Finished action id: 8 00000504 14.08604336 [6408] WMDM: GetStorageFromPath: mmstore.db.synced.0009 was not found 00000505 14.08671474 [6408] WMDM: Uploading file C:\Users\Russell\AppData\Local\Temp\24B3.tmp -> \MediaMonkey\files\mmstore.db.synced.0009 00000506 14.29982758 [6408] WMDM: Uploading result, Insert3: 0 (C:\Users\Russell\AppData\Local\Temp\24B3.tmp -> \MediaMonkey\files\mmstore.db.synced.0009) 00000507 14.30002689 [6408] WMDM: Finished execution of action id:1 00000508 14.30129051 [6408] TAndroidDBHandler.UploadDB: finished 00000509 14.30148602 [6408] WMDM: Executing action id:7 00000510 14.51964664 [6408] WMDM: storagecontrol.Delete (rename): 0 00000511 14.52000999 [6408] WMDM: Finished execution of action id:7 00000512 14.52344131 [6408] WMDM: Finished action id: 8 00000513 14.52505684 [6408] WMDM: Executing action id:1 00000514 14.60072708 [6408] WMDM: GetStorageFromPath: sync_finished was not found 00000515 14.60133934 [6408] WMDM: GetStorageFromPath: \MediaMonkey\files\ 00000516 14.71904659 [6408] WMDM: Uploading result, Insert3: 0 (C:\Users\Russell\AppData\Local\Temp\5A03.tmp -> \MediaMonkey\files\sync_finished) 00000517 14.71926117 [6408] WMDM: Finished execution of action id:1 00000518 14.72043419 [6408] 10284 DB exec SQL: UPDATE Devices SET LastAutoSynch=42351.951300752 WHERE ID=220 00000519 14.72216702 [6408] 10284 DB lock finished, took 2012. 00000520 14.75547504 [6408] TGenThread.Create: ThreadName: UpdateSize_Var , Running Threads: Internal: 1, All: 85 00000521 14.76268196 [6408] Prgrs: Status: Thread: 10284, Levels: 0, Sub: 0 00000522 14.76911640 [6408] Thread 'UpdateSize_Var' has started 11828 00000523 14.76937962 [6408] Thread initialized 11828 00000524 14.76957893 [6408] Size counting: Get tracks from all collections: 00000525 14.77109241 [6408] Size counting: Hash library files presented on the sync-list: 0 00000526 14.79127979 [6408] Size counting: Sync-List tracks count: 0 00000527 14.79272842 [6408] Size counting: Device tracks count: 83 00000528 14.79612732 [6408] Size counting: All tracks count: 83 00000529 14.80045223 [6408] Size counting: Finishing counting: 00000530 14.80090809 [6408] Size counting: LblSize updated 00000531 14.80117989 [6408] Going 'UpdateSize_Var'to make final callback 11828 00000532 15.73860455 [1020] shell\lib\bindctx.cpp(1144)\explorerframe.dll!00007FFB25EC8EA4: (caller: 00007FFB25F105BE) ReturnHr[PreRelease](643) tid(154c) 80070057 The parameter is incorrect. 00000533 16.23500633 [6408] TGenThread.Create: ThreadName: _ManageTransactions , Running Threads: Internal: 0, All: 84 00000534 16.24597740 [6408] Thread '_ManageTransactions' has started 12144 00000535 16.24622536 [6408] Thread initialized 12144 00000536 16.24645996 [6408] Thread '_ManageTransactions'has finished 12144 00000537 18.24143600 [6408] TGenThread.Create: ThreadName: _ManageTransactions , Running Threads: Internal: 0, All: 84 00000538 18.25144386 [6408] Thread '_ManageTransactions' has started 10536 00000539 18.25163269 [6408] Thread initialized 10536 00000540 18.25181007 [6408] Thread '_ManageTransactions'has finished 10536 00000541 20.23154259 [6408] TGenThread.Create: ThreadName: _ManageTransactions , Running Threads: Internal: 0, All: 84 00000542 20.24323273 [6408] Thread '_ManageTransactions' has started 10720 00000543 20.24342346 [6408] Thread initialized 10720 00000544 20.24359894 [6408] Thread '_ManageTransactions'has finished 10720 00000545 22.23589706 [6408] TGenThread.Create: ThreadName: _ManageTransactions , Running Threads: Internal: 0, All: 84 00000546 22.24657249 [6408] Thread '_ManageTransactions' has started 11084 00000547 22.24676514 [6408] Thread initialized 11084 00000548 22.24693680 [6408] Thread '_ManageTransactions'has finished 11084 00000549 24.23626518 [6408] TGenThread.Create: ThreadName: _ManageTransactions , Running Threads: Internal: 0, All: 84 00000550 24.25377846 [6408] Thread '_ManageTransactions' has started 9576 00000551 24.25411987 [6408] Thread initialized 9576 00000552 24.28108215 [6408] Going '_ManageTransactions'to make final callback 9576 00000553 24.28131866 [6408] Thread '_ManageTransactions'has finished 9576 00000554 30.01202202 [6408] TGenThread.Create: ThreadName: UpdateDriveLetters_Var , Running Threads: Internal: 0, All: 84 00000555 30.02144432 [6408] PostponeComputerSleep: Enabled = 0 00000556 30.02318954 [6408] Thread registered, going to initialize 10636 00000557 30.02380943 [6408] >UpdateDriveLetters - start< 00000558 30.03361702 [6408] >UpdateDriveLetters - end< 00000559 30.03384209 [6408] Thread 'UpdateDriveLetters_Var'has finished 10636 00000560 35.23141098 [6408] TGenThread.Create: ThreadName: ScanDeviceContent_Var , Running Threads: Internal: 0, All: 84 00000561 35.24129105 [6408] Thread 'ScanDeviceContent_Var' has started 9744 00000562 35.24149323 [6408] Thread initialized 9744 00000563 35.25985718 [6408] Device: Scan: Get tracks from the last synchronization 00000564 35.26003647 [6408] OpenQuery - Preparing query SELECT * FROM DeviceTracks WHERE IDDevice = 220 00000565 35.26064301 [6408] 9744 DB prepare SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000566 35.26110458 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000567 35.26196289 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000568 35.26230621 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000569 35.26290512 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000570 35.26334000 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000571 35.26369476 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000572 35.26404190 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000573 35.26458359 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000574 35.26523590 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000575 35.26578903 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000576 35.26622009 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000577 35.26668930 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000578 35.26704788 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000579 35.26740265 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000580 35.26781082 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000581 35.26839066 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000582 35.26892090 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000583 35.26936340 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000584 35.26971054 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000585 35.27007675 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000586 35.27043533 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000587 35.27078629 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000588 35.27125549 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000589 35.27171326 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000590 35.27207947 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000591 35.27241898 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000592 35.27275467 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000593 35.27312088 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000594 35.27350235 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000595 35.27420425 [6408] 9744 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 00000596 35.27465439 [6408] 9744 DB lock finished, took 60. 00000597 35.27504730 [6408] 9744 DB lock finished, took 37. 00000598 35.27540207 [6408] 9744 DB lock finished, took 36. 00000599 35.27574539 [6408] 9744 DB lock finished, took 34. 00000600 35.27609634 [6408] 9744 DB lock finished, took 33. 00000601 35.27644730 [6408] 9744 DB lock finished, took 32. 00000602 35.27678299 [6408] 9744 DB lock finished, took 33. 00000603 35.27712631 [6408] 9744 DB lock finished, took 32. 00000604 35.27746582 [6408] 9744 DB lock finished, took 34. 00000605 35.27807236 [6408] 9744 DB lock finished, took 37. 00000606 35.27842331 [6408] 9744 DB lock finished, took 35. 00000607 35.27876663 [6408] 9744 DB lock finished, took 34. 00000608 35.27911758 [6408] 9744 DB lock finished, took 36. 00000609 35.27957916 [6408] 9744 DB lock finished, took 36. 00000610 35.27993774 [6408] 9744 DB lock finished, took 35. 00000611 35.28028107 [6408] 9744 DB lock finished, took 33. 00000612 35.28067017 [6408] 9744 DB lock finished, took 76. 00000613 35.28145218 [6408] 9744 DB lock finished, took 55. 00000614 35.28184509 [6408] 9744 DB lock finished, took 38. 00000615 35.28226089 [6408] 9744 DB lock finished, took 62. 00000616 35.28261566 [6408] 9744 DB lock finished, took 35. 00000617 35.28319550 [6408] 9744 DB lock finished, took 37. 00000618 35.28367996 [6408] 9744 DB lock finished, took 35. 00000619 35.28414154 [6408] 9744 DB lock finished, took 37. 00000620 35.28459549 [6408] 9744 DB lock finished, took 35. 00000621 35.28512955 [6408] 9744 DB lock finished, took 36. 00000622 35.28560257 [6408] 9744 DB lock finished, took 37. 00000623 35.28595352 [6408] 9744 DB lock finished, took 38. 00000624 35.28631973 [6408] 9744 DB lock finished, took 34. 00000625 35.28667450 [6408] 9744 DB lock finished, took 35. 00000626 35.28702164 [6408] 9744 DB lock finished, took 34. 00000627 35.28736115 [6408] 9744 DB lock finished, took 34. 00000628 35.28769684 [6408] 9744 DB lock finished, took 32. 00000629 35.28807068 [6408] 9744 DB lock finished, took 76. 00000630 35.28844070 [6408] 9744 DB lock finished, took 33. 00000631 35.28882980 [6408] 9744 DB lock finished, took 69. 00000632 35.29068756 [6408] 9744 DB lock finished, took 51. 00000633 35.29105759 [6408] 9744 DB lock finished, took 46. 00000634 35.29142761 [6408] 9744 DB lock finished, took 45. 00000635 35.29179001 [6408] 9744 DB lock finished, took 35. 00000636 35.29214859 [6408] 9744 DB lock finished, took 35. 00000637 35.29251099 [6408] 9744 DB lock finished, took 33. 00000638 35.29288483 [6408] 9744 DB lock finished, took 34. 00000639 35.29324341 [6408] 9744 DB lock finished, took 34. 00000640 35.29360199 [6408] 9744 DB lock finished, took 33. 00000641 35.29394913 [6408] 9744 DB lock finished, took 37. 00000642 35.29428482 [6408] 9744 DB lock finished, took 35. 00000643 35.29465103 [6408] 9744 DB lock finished, took 34. 00000644 35.29500580 [6408] 9744 DB lock finished, took 34. 00000645 35.29534531 [6408] 9744 DB lock finished, took 34. 00000646 35.29568863 [6408] TAndroidDBHandler.HandleStorageInfo: Exists 00000647 35.29629135 [6408] TDevices.GetFirstDeviceStorage for: 0:RF2FA0ME90L!USB@\\?\USB#VID_04E8&PID_6860&MS_COMP_MTP&SAMSUNG_Android#8&4ebaa9b&2&0000#{f33fdc04-d1ac-4e8e-9a30-19bbd4b108ae}$1 00000648 35.29645538 [6408] TDevices.GetFirstDeviceStorage: We have found the first (zero) storage 0:RF2FA0ME90L!USB@\\?\USB#VID_04E8&PID_6860&MS_COMP_MTP&SAMSUNG_Android#8&4ebaa9b&2&0000#{f33fdc04-d1ac-4e8e-9a30-19bbd4b108ae}$0 00000649 35.29708099 [6408] WMDM: Starting action id: 14 00000650 35.29726028 [6408] WMDM: GetStorageFromPath: \MediaMonkey\files\mmstore.db.synced 00000651 35.43913651 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0004 00000652 35.44249725 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0005 00000653 35.44629669 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0006 00000654 35.45070267 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0007 00000655 35.45415878 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0008 00000656 35.45750809 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0009 00000657 35.46079254 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0010 00000658 35.46503830 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0011 00000659 35.46903610 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0012 00000660 35.47245789 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0019 00000661 35.47583389 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0014 00000662 35.47956848 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0015 00000663 35.48328018 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0016 00000664 35.48680496 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0017 00000665 35.49050522 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0018 00000666 35.49408340 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.processed.0020 00000667 35.49738312 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\.trashed 00000668 35.53249359 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.synced.0001 00000669 35.55250549 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.synced.0002 00000670 35.56966400 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.synced.0003 00000671 35.58644485 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.synced.0004 00000672 35.59034729 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\.trashed 00000673 35.59416580 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\.trashed 00000674 35.61108017 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.synced.0005 00000675 35.61500931 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\.trashed 00000676 35.61879349 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\.trashed 00000677 35.63692093 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.synced.0006 00000678 35.64132309 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\.trashed 00000679 35.64504242 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db 00000680 35.64942932 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\.trashed 00000681 35.65669632 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\.trashed 00000682 35.68097687 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\.trashed 00000683 35.70015717 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\.trashed 00000684 35.71884155 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\.trashed 00000685 35.73840332 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\mmstore.db.synced.0009 00000686 35.76451111 [6408] Sync Status: Unsupported file extension - \MediaMonkey\files\sync_finished 00000687 35.76582718 [6408] WMDM: Finished execution of action id:6 00000688 35.76653290 [6408] WMDM: Starting action id: 14 00000689 35.76671982 [6408] WMDM: GetStorageFromPath: \MediaMonkey\files\mmstore.db.synced.0001 00000690 35.77690506 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0001) 00000691 35.77735138 [6408] WMDM: Downloading file \MediaMonkey\files\mmstore.db.synced.0001 -> C:\Users\Russell\AppData\Local\Temp\2347.tmp 00000692 35.87781906 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0001) 00000693 35.87808609 [6408] WMDM: Finished execution of action id:14 00000694 35.87845612 [6408] WMDM: Starting action id: 7 00000695 35.93559647 [6408] WMDM: storagecontrol.Delete (rename): 0 00000696 35.93604660 [6408] WMDM: Finished execution of action id:7 00000697 35.93667984 [6408] WMDM: Starting action id: 8 00000698 35.94067001 [6408] WMDM: Finished action id: 8 00000699 35.94218826 [6408] WMDM: Executing action id:14 00000700 35.94241714 [6408] WMDM: Downloading file \MediaMonkey\files\mmstore.db.synced.0002 -> C:\Users\Russell\AppData\Local\Temp\2347.tmp 00000701 35.95518112 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0002) 00000702 35.95584488 [6408] WMDM: Downloading file \MediaMonkey\files\mmstore.db.synced.0002 -> C:\Users\Russell\AppData\Local\Temp\2347.tmp 00000703 36.02504349 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0002) 00000704 36.02521133 [6408] WMDM: Finished execution of action id:14 00000705 36.02559280 [6408] WMDM: Starting action id: 7 00000706 36.10174179 [6408] WMDM: storagecontrol.Delete (rename): 0 00000707 36.10201645 [6408] WMDM: Finished execution of action id:7 00000708 36.10237122 [6408] WMDM: Starting action id: 8 00000709 36.10519791 [6408] WMDM: Finished action id: 8 00000710 36.10609436 [6408] WMDM: Executing action id:14 00000711 36.10630417 [6408] WMDM: GetStorageFromPath: \MediaMonkey\files\mmstore.db.synced.0003 00000712 36.12190247 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0003) 00000713 36.12262344 [6408] WMDM: Downloading file \MediaMonkey\files\mmstore.db.synced.0003 -> C:\Users\Russell\AppData\Local\Temp\2347.tmp 00000714 36.19637680 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0003) 00000715 36.19661331 [6408] WMDM: Finished execution of action id:14 00000716 36.19698715 [6408] WMDM: Starting action id: 7 00000717 36.26938248 [6408] WMDM: storagecontrol.Delete (rename): 0 00000718 36.26987839 [6408] WMDM: Executing action id:8 00000719 36.27239990 [6408] WMDM: Finished action id: 8 00000720 36.27336502 [6408] WMDM: Executing action id:14 00000721 36.27362061 [6408] WMDM: GetStorageFromPath: \MediaMonkey\files\mmstore.db.synced.0004 00000722 36.29045486 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0004) 00000723 36.29076004 [6408] WMDM: GetStorageFromPath: \MediaMonkey\files\mmstore.db.synced.0004 00000724 36.42847824 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0004) 00000725 36.42862701 [6408] WMDM: Finished execution of action id:14 00000726 36.42899704 [6408] WMDM: Starting action id: 7 00000727 36.49150467 [6408] WMDM: storagecontrol.Delete (rename): 0 00000728 36.49183655 [6408] WMDM: Finished execution of action id:7 00000729 36.49247360 [6408] WMDM: Starting action id: 8 00000730 36.49633408 [6408] WMDM: Finished action id: 8 00000731 36.49779510 [6408] WMDM: Executing action id:14 00000732 36.49823380 [6408] WMDM: GetStorageFromPath: \MediaMonkey\files\mmstore.db.synced.0005 00000733 36.51588440 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0005) 00000734 36.51728821 [6408] WMDM: Incomplete file was deleted. 00000735 36.51786423 [6408] WMDM: GetStorageFromPath: \MediaMonkey\files\mmstore.db.synced.0005 00000736 36.60884094 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0005) 00000737 36.60904694 [6408] WMDM: Finished execution of action id:14 00000738 36.60939789 [6408] WMDM: Starting action id: 7 00000739 36.67413712 [6408] WMDM: storagecontrol.Delete (rename): 0 00000740 36.67429733 [6408] WMDM: Finished execution of action id:7 00000741 36.67467880 [6408] WMDM: Starting action id: 8 00000742 36.67705154 [6408] WMDM: Finished action id: 8 00000743 36.67813873 [6408] WMDM: Executing action id:14 00000744 36.67836380 [6408] WMDM: GetStorageFromPath: \MediaMonkey\files\mmstore.db.synced.0006 00000745 36.69523621 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0006) 00000746 36.69626999 [6408] WMDM: Downloading file \MediaMonkey\files\mmstore.db.synced.0006 -> C:\Users\Russell\AppData\Local\Temp\2347.tmp 00000747 36.77245331 [6408] WMDM: Downloading result: 80004005 (\MediaMonkey\files\mmstore.db.synced.0006) 00000748 36.77262878 [6408] WMDM: Finished execution of action id:14 00000749 36.77299881 [6408] WMDM: Starting action id: 7 00000750 36.92168808 [6408] WMDM: Downloading result: 0 (\MediaMonkey\files\mmstore.db.synced.0009) 00000751 36.92189407 [6408] WMDM: Finished execution of action id:14 00000752 36.92305374 [6408] SQLiteDatabase::Init - initialized DB C:\Users\Russell\AppData\Local\Temp\2347.tmp with code 0 00000753 36.93051910 [6408] TAndroidDBHandler.CheckDBIsCorrect: started 00000754 36.93082809 [6408] OpenQuery - Preparing query SELECT null FROM playlists 00000755 36.93157196 [6408] OpenQuery - Preparing query SELECT null FROM modifications 00000756 36.93198776 [6408] OpenQuery - Preparing query SELECT null FROM composers 00000757 36.93233109 [6408] OpenQuery - Preparing query SELECT null FROM playlist_items_map 00000758 36.93262863 [6408] OpenQuery - Preparing query SELECT null FROM media_artists_map 00000759 36.93292618 [6408] OpenQuery - Preparing query SELECT null FROM media_composers_map 00000760 36.93316269 [6408] TSQLiteDatabase.ExecSQL: REINDEX; 00000761 36.96787643 [6408] OpenQuery - Preparing query SELECT db_version, app_version FROM info 00000762 36.97095490 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Unknown\Unknown\00 Shir Lamaalot - Yosef Karduner (Tehilim 121).m4a 00000763 36.97154236 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Everly Brothers\Unknown\00 Everly Brothers - Bye Bye Love.mp3 00000764 36.97202301 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Leonard Cohen\Unknown\00 Leonard Cohen - Dance Me To The End Of Love.mp3 00000765 36.97247696 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Gordon Lightfoot\Unknown\11 Gordon Lightfoot - Sundown.mp3 00000766 36.97295380 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Various\2011 Billboard Charts Hot 100 Songs\09 Maroon 5 - Moves Like Jagger.mp3 00000767 36.97341919 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\The Silencers\A Blues For Buddha\09 The Silencers - Sacred Child.mp3 00000768 36.97388840 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Michael Franti & Spearhead\All Rebel Rockers\06 Michael Franti & Spe - Say Hey (I Love You).mp3 00000769 36.97435379 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Tom Petty & The Heartbreakers\Anthology - Through The Years\01 Tom Petty & The Hear - Breakdown.mp3 00000770 36.97481155 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Various Artists\Billboard Hot 100 Singles Chart\71 Elle King - Ex's & Oh's.mp3 00000771 36.97547531 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Various\Billboard Top100 Single Charts vom 22.12.2012\08 Fun - Some Nights.mp3 00000772 36.97612381 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Nick Drake\Bryter Layter\04 Nick Drake - One Of These Things First.mp3 00000773 36.97956467 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Franz Ferdinand\Franz Ferdinand\11 Franz Ferdinand - 40 ft.mp3 00000774 36.98197174 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Eddie Vedder\Into the Wild\08 Eddie Vedder - Society.mp3 00000775 36.98231506 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Yaakov Shwekey\Kolot\09 Yaakov Shwekey - Et Rikod.mp3 00000776 36.98275375 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Unknown\Live In Melbourne\13 Shlomo Katz - Niggun Nevo.mp3 00000777 36.98320389 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Hans Zimmer\MI2\00 Hans Zimmer - MI-2.mp3 00000778 36.98367691 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Van Halen\Ou812\07 Van Halen - Finish What Ya Started.mp3 00000779 36.98463821 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Piamenta\Piamenta\11 Piamenta - Asher Boro.mp3 00000780 36.98526001 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Johnny Kidd and The Pirates\Roy Buckley\00 Johnny Kidd and The - Shakin All Over.aac 00000781 36.98574448 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Talking Heads\Speaking in Tongues\04 Talking Heads - Slippery People.mp3 00000782 36.98635101 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Supertramp\Surely\02 Supertramp - It's A Long Road.mp3 00000783 36.98667908 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Hans Zimmer\testalb\00 Hans Zimmer - True Romance.mp3 00000784 36.98732758 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\The doors\The Best Of The Doors CD2\03 The doors - L.A. Woman.mp3 00000785 36.99027634 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Olivia Newton-John\Two of a Kind\00 Olivia Newton-John - Twist Of Fate.mp3 00000786 36.99074936 [6408] Device: Adding to device content: \Android\data\com.ventismedia.android.mediamonkey\files\Music\Various\USA Billboard Year End Charts Top 100 2013 [Bubanee]\63 One Republic - Counting Stars.mp3 00000787 36.99132919 [6408] OpenQuery - Preparing query SELECT _data, _id, parent_id, name FROM playlists ORDER BY name 00000788 37.00368500 [6408] SQLiteDB::Close - result 0 00000789 37.00521851 [6408] Device: Scan: Merge with the real content scanned from the device (and get its metadata) 00000790 37.00723648 [6408] Device: Scan terminated 00000791 37.00740051 [6408] DB: Deleting prepared query: SELECT * FROM Songs WHERE Songs.ID=? 00000792 37.50577927 [1020] shell\lib\bindctx.cpp(1144)\explorerframe.dll!00007FFB25EC8EA4: (caller: 00007FFB25F105BE) ReturnHr[PreRelease](646) tid(154c) 80070057 The parameter is incorrect. 00000793 60.01866531 [6408] TGenThread.Create: ThreadName: UpdateDriveLetters_Var , Running Threads: Internal: 0, All: 85 00000794 60.03451157 [6408] PostponeComputerSleep: Enabled = 0 00000795 60.03685379 [6408] Thread 'UpdateDriveLetters_Var' has started 11612 00000796 60.03721619 [6408] Thread initialized 11612 00000797 60.04870987 [6408] >UpdateDriveLetters - end< 00000798 60.04920578 [6408] Thread 'UpdateDriveLetters_Var'has finished 11612 00000799 90.01085663 [6408] TGenThread.Create: ThreadName: UpdateDriveLetters_Var , Running Threads: Internal: 0, All: 84 00000800 90.02124786 [6408] Thread 'UpdateDriveLetters_Var' has started 3260 00000801 90.03260803 [6408] >UpdateDriveLetters - end< 00000802 90.03322601 [6408] Thread 'UpdateDriveLetters_Var'has finished 3260 00000803 120.01127625 [6408] TGenThread.Create: ThreadName: UpdateDriveLetters_Var , Running Threads: Internal: 0, All: 84 00000804 120.02070618 [6408] PostponeComputerSleep: Enabled = 0 00000805 120.02215576 [6408] Thread 'UpdateDriveLetters_Var' has started 9296 00000806 120.02265930 [6408] Thread initialized 9296 00000807 120.04006195 [6408] >UpdateDriveLetters - end< 00000808 120.04148102 [6408] Thread 'UpdateDriveLetters_Var'has finished 9296 00000809 150.01089478 [6408] TGenThread.Create: ThreadName: UpdateDriveLetters_Var , Running Threads: Internal: 0, All: 84 00000810 150.01950073 [6408] PostponeComputerSleep: Enabled = 0 00000811 150.02116394 [6408] Thread registered, going to initialize 12076 00000812 150.02130127 [6408] >UpdateDriveLetters - start< 00000813 150.03773499 [6408] >UpdateDriveLetters - end< 00000814 150.03793335 [6408] Thread 'UpdateDriveLetters_Var'has finished 12076 00000815 180.01728821 [6408] TGenThread.Create: ThreadName: UpdateDriveLetters_Var , Running Threads: Internal: 0, All: 84 00000816 180.03305054 [6408] PostponeComputerSleep: Enabled = 0 00000817 180.03507996 [6408] Thread registered, going to initialize 9412 00000818 180.03524780 [6408] >UpdateDriveLetters - start< 00000819 180.04588318 [6408] >UpdateDriveLetters - end< 00000820 180.04609680 [6408] Thread 'UpdateDriveLetters_Var'has finished 9412 00000821 210.00294495 [6408] TGenThread.Create: ThreadName: UpdateDriveLetters_Var , Running Threads: Internal: 0, All: 84 00000822 210.01528931 [6408] PostponeComputerSleep: Enabled = 0 00000823 210.02720642 [6408] >UpdateDriveLetters - end< 00000824 240.01647949 [6408] TGenThread.Create: ThreadName: UpdateDriveLetters_Var , Running Threads: Internal: 0, All: 84 00000825 240.03207397 [6408] PostponeComputerSleep: Enabled = 0 00000826 240.03407288 [6408] Thread registered, going to initialize 11236 00000827 240.03424072 [6408] >UpdateDriveLetters - start< 00000828 240.05201721 [6408] >UpdateDriveLetters - end< 00000829 240.05218506 [6408] Thread 'UpdateDriveLetters_Var'has finished 11236 00000830 253.69979858 [4340] base\appmodel\execmodel\modern\lifetimemanager\suspendresume.cpp(4128)\modernexecserver.dll!00007FFB2AB8A91C: (caller: 00007FFB2ABBD003) ReturnHr[PreRelease](83) tid(2990) 8000000D An illegal state change was requested. 00000831 270.01226807 [6408] TGenThread.Create: ThreadName: UpdateDriveLetters_Var , Running Threads: Internal: 0, All: 83 00000832 270.02154541 [6408] PostponeComputerSleep: Enabled = 0 00000833 270.02386475 [6408] Thread 'UpdateDriveLetters_Var' has started 12168 00000834 270.04098511 [6408] >UpdateDriveLetters - end< 00000835 270.04119873 [6408] Thread 'UpdateDriveLetters_Var'has finished 12168 00000836 300.01217651 [6408] TGenThread.Create: ThreadName: UpdateDriveLetters_Var , Running Threads: Internal: 0, All: 87 00000837 300.02099609 [6408] PostponeComputerSleep: Enabled = 0 00000838 300.02261353 [6408] Thread registered, going to initialize 11832 00000839 300.02291870 [6408] >UpdateDriveLetters - start< 00000840 300.03280640 [6408] >UpdateDriveLetters - end< 00000841 300.03302002 [6408] Thread 'UpdateDriveLetters_Var'has finished 11832 tracks_fail_to_delete_on_usb_sync.LOG (82,693 bytes) bug_13022_log.zip (376,273 bytes)

Fixed in build	1778

Ludek 2015-12-14 09:32 developer ~0043635 Last edited: 2015-12-14 11:32	I see, you tested the non-default development config 0012961:0043543 : I see content of your \MeidaMonkey\files\ dir: \MediaMonkey\files\storageInfo.xml \MediaMonkey\files\mmstore.db.processed.0013 \MediaMonkey\files\.trashed \MediaMonkey\files\mmstore.db.processed.0000 \MediaMonkey\files\mmstore.db.processed.0001 \MediaMonkey\files\mmstore.db.processed.0002 \MediaMonkey\files\mmstore.db.processed.0003 \MediaMonkey\files\mmstore.db.processed.0004 \MediaMonkey\files\mmstore.db.processed.0005 \MediaMonkey\files\mmstore.db.processed.0006 \MediaMonkey\files\mmstore.db.processed.0008 \MediaMonkey\files\mmstore.db.processed.0009 \MediaMonkey\files\mmstore.db.processed.0010 \MediaMonkey\files\mmstore.db.processed.0011 \MediaMonkey\files\mmstore.db.processed.0012 \MediaMonkey\files\mmstore.db.processed.0019 \MediaMonkey\files\mmstore.db.processed.0015 \MediaMonkey\files\mmstore.db.processed.0016 \MediaMonkey\files\mmstore.db.processed.0017 \MediaMonkey\files\mmstore.db.processed.0018 \MediaMonkey\files\mmstore.db.processed.0020 \MediaMonkey\files\.trashed \MediaMonkey\files\mmstore.db.synced.0001 \MediaMonkey\files\mmstore.db.synced.0002 \MediaMonkey\files\mmstore.db.synced.0003 \MediaMonkey\files\mmstore.db.synced.0006 \MediaMonkey\files\.trashed \MediaMonkey\files\mmstore.db \MediaMonkey\files\.trashed \MediaMonkey\files\.trashed \MediaMonkey\files\.trashed \MediaMonkey\files\mmstore.db.synced.0008 \MediaMonkey\files\sync_finished i.e. content of the directory in the non-default developer config from 0012961:0043543 isn't refreshed and MMW is trying to download mmstore.db.synced.000X previously uploaded by MMW for MMA to process. Nevertheless the log is missing some important debug lines, because you started DbgView after MMW start so it is not visible which from the mmstore.db.synced.000X databases was successfully downloaded, for most of them there is MTP error 80004005 indicating that the file probably no longer exists in Android (was deleted/renamed by MMA). I will try to simulate this somehow, could you tell me which configuration from 0012961:0043543 did you use? I suppose you did not submit MMA debug log? Leaving the files like mmstore.db.processed.0019 in the folder previously indicated that MMA failed to process the database, but in this case it will be probably just disabling of [ ] Allow deletion in MediaMonkey folder config.

Ludek 2015-12-14 10:00 developer ~0043636 Last edited: 2015-12-14 13:33	OK, I would need to see the full debug log (i.e. also the situation how the mmstore.db.synced.0001 - 0008 files were created) as I cannot replicate even if the '[ ] Allow deletion in MediaMonkey folder' is disabled. In my case only the X versions of db.processed are there (as expected because of the config) To explain how this works: After USB sync MMW uploads file mmstore.db.synced.0001 for MMA to process. On the next USB sync if the file mmstore.db.synced.0001 can be downloaded without MTP error then MMW considers it as non-processed by MMA, deletes it and re-uploads new mmstore.db.synced.0001 , so normally there is just mmstore.db.synced.0001 But if the mmstore.db.synced.0001 file cannot be downloaded (MMA processed it and deleted file, but MTP content was not refreshed) then MMW uploads mmstore.db.synced.0002 file and so on... On each USB sync start MMW at first tries to find and download the mmstore.db.synced.000X file (meaning that MMA did not run to process it) and if it cannot be found or downloaded then MMW downloads the mmstore.db (actual MMA's database) Nevertheless for the current release we may just want to leave the config from 0012961:0043626 in its default (all checked) as the results of the non-default configs are quite unpredictable on various devices (as we can see here).

rusty 2015-12-14 20:58 administrator ~0043652	It seems then, that the bug is that MMA (or MMW) aren't accepting changes in configuration back to the default settings. In other words, I once changed the settings to '[ ] Allow deletion in MediaMonkey folder', and when it failed, I changed it back to the default of '[x] Allow deletion in MediaMonkey folder'. However, since then, USB synchronization between MMW and MMA is broken (even after I completely uninstalled and deleted all MMA settings on the Android device, and associated sync profiles in MMW). I regenerated logs for the following operations: 1 0001993:0006800 plug in device 2 0002829:0008600 initiate autosync of 3 playlists: Test Hierarchy, Test list, Test list 2 3 0005601:0017912 disconnect -->tracks and playlists have been synced correctly (verified in MMA) 4 0002424:0018235 reconnect and remove 2 playlists (test list, and test list 2) 5 0006680:0021807 initiate auto-sync --> prompt to delete playlists, but no prompt to delete tracks 6 23748 disconnect after sync operation completes --> verified in MMA that playlists are deleted but that tracks aren't (log attached) Any ideas how to get usb sync working again?

Ludek 2015-12-14 22:08 developer ~0043653 Last edited: 2015-12-14 22:25	I am able to simulate the issue now, the media files from /Android/data/... really fails to show in the deletion prompt. Looking into it now this probably never worked, because for some reason we added in the past that files from 'Android' or 'Media' folders are never deleted. I guess that it was because of the notifications and app specific audio files to not being listed for deletion. So the bug is that we should apply this only for the others media files that are unknown for us, but for the synced by us we should proceed.

Ludek 2015-12-14 22:38 developer ~0043655 Last edited: 2015-12-14 22:58	Fixed in 4.1.10.1778 I modified it the way that if the content is read from mmstore.db then all is available for deletion now (supposing that MMA's DB contains only media that should be available for deletion) To clarify: The rules are now same for all types of folders (in case MMA is installed). But if there isn't MMA installed then MMW must traverse all MTP content (folder by folder) and decide which files list to delete. And when this is the case then /Android/ and /Media/ content is ignored, because they are notifications and third party app specific audio files that shouldn't be deleted.

rusty 2015-12-15 06:12 administrator ~0043660	Cannot be verified due to 0012999

rusty 2015-12-15 21:35 administrator ~0043676	Verified MMW 1778 / MMA 523