This is a weird, intermittent issue. there's random tracks that mediamonkey will stop playback on when they load, sometimes as much as 10-15 seconds into the tracks.
I've tried turning off all crossfading, plugins, etc and the issue persists. Seems to happen on various formats / bitrates, etc.
My PC specs are:
Windows 10 pro
Processor: Intel(R) Core(TM) i5-3470 CPU @ 3.20GHz (4 CPUs), ~3.2GHz
Memory: 16384MB RAM
Video Card: NVIDIA GeForce GTX 750 Ti
Sound Card: ASUS Xonar DSX
I ran MM in debug and captured output from both a normal song and a song that stops.
first the working song:
Code: Select all
[845480] Saving of Now Playing selection started
[845480] BQ: Added new task. Currently 1 tasks in queue.
[845480] BQ: Currently running 0 threads of 1
[845480] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 0, All: 34
[845480] TWAPluginEngine.Stop - going to stop input plugin
[845480] Going to stop.
[845480] PrepareDockedVideo: Begin
[845480] PrepareDockedVideo: Reduced window or audio
[845480] PrepareDockedVideo: End
[845480] Thread 'BackgroundQueue' has started 850492
[845480] OpenQuery - Preparing query SELECT Playlists.IDPlaylist, Playlists.PlaylistName FROM Playlists WHERE Playlists.IDPlaylist IN (SELECT PlaylistSongs.IDPlaylist FROM PlaylistSongs WHERE PlaylistSongs.IDSong IN (SELECT ID FROM Songs ORDER BY LastTimePlayed DESC LIMIT 200) GROUP BY PlaylistSongs.IDPlaylist) LIMIT 10
[845480] 850492 DB lock finished, took 55151.
[845480] TGenThread.Create: ThreadName: PlaybackStarter_Var , Running Threads: Internal: 0, All: 35
[845480] Player: Setting current track: D:\Users\sween\Music\MediaMonkey\_flac\The Offspring\[1994] Smash\06 Something to Believe In [1006 kbps flac].flac
[845480] PrepareDockedVideo: Switching=false IsStartingPlayback=true WasManuallyChanged=false
[845480] PrepareDockedVideo: End
[845480] Player: _Play() procedure entering.
[845480] Player: W7 icon updated.
[845480] Player: Updating playlist entry.
[845480] Going to play file: D:\Users\sween\Music\MediaMonkey\_flac\The Offspring\[1994] Smash\06 Something to Believe In [1006 kbps flac].flac
[845480] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 1, All: 36
[845480] 927716 DB open SQL: SELECT Lyrics, Comment FROM Songs WHERE Songs.ID=?
[845480] MM4 [927716] TLyricsScroller.createOverlay: rows: 6
[845480] MM4 [844568] UpdateSongPictures: D:\Users\sween\Music\MediaMonkey\_flac\The Offspring\[1994] Smash\06 Something to Believe In [1006 kbps flac].flac
[845480] GetFileInfo: D:\Users\sween\Music\MediaMonkey\_flac\The Offspring\[1994] Smash\06 Something to Believe In [1006 kbps flac].flac
[845480] Winamp Playlist sim - WM_USER message 6
[845480] Winamp Playlist sim - WM_USER message 1073741830
[845480] FLAC: FORMAT_DecodeInit().
[845480] FLAC: Calling FLAC__stream_decoder_init_stream().
[845480] FLAC: StreamDecoderMetadataCallback.
[845480] FH.ReadFileInfo openned
[845480] Added Covers: 2
[845480] f_flac: FORMAT_CloseFile
[845480] MM4 [927716] TImagePlus.Paint: start
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] Thread 'anonymous' has started 226244
[845480] Added Cover Lists: 2
[845480] GetFileInfo: readPictures=spAlways
[845480] f_flac: FORMAT_OpenFile
[845480] Added Covers: 5
[845480] 226244 DB prepare SQL: SELECT Songs.* FROM Songs WHERE Songs.IDMedia=? AND Songs.SongPath=?
[845480] 226244 DB open SQL: SELECT Songs.* FROM Songs WHERE Songs.IDMedia=? AND Songs.SongPath=?
[845480] GetFileInfo: Found in DB
[845480] 226244 DB open SQL: SELECT * FROM Covers WHERE IDSong=37390 ORDER BY CoverOrder
[845480] 226244 DB lock finished, took 593.
[845480] Remaining Covers: 5
[845480] Added Covers: 7
[845480] MM4 [927716] TStretcher.PerformStretch: Threads[2], source[75, 75], target[160,160]
[845480] BQ: Starting a new task.
[845480] MMDS: Written 101376 bytes
[845480] Win7Tools - Thumbnail - Cover should be loaded
[845480] Win7Tools - Thumbnail - Loading cover
[845480] BQ: Added new task. Currently 1 tasks in queue.
[845480] BQ: There are threads waiting, resume one.
[845480] BQ: Starting a new task.
[845480] BQ: Starting a new thread.
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 5, All: 39
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MM4 [927716] TStretcher.PerformStretch: Finished
[845480] Remaining Covers: 7
[845480] Remaining Covers: 5
[845480] DB: Deleting prepared query: SELECT Songs.* FROM Songs WHERE Songs.IDMedia=? AND Songs.SongPath=?
[845480] MMDS: Written 101376 bytes
[845480] Remaining Covers: 3
[845480] BQ: Starting a new task.
[845480] MMDS: Written 101376 bytes
[845480] MM4 [927716] TImagePlus.Paint: finished
[845480] MMDS: Written 101376 bytes
[845480] Keep only 5 previous songs:
[845480] Saving of Now Playing selection started
[845480] Saving of Now Playing selection finished
[845480] RestoreNowPlayingSelection: PlayerLock locked
[845480] RestoreNowPlayingSelection: PlayerLock unlocked
[845480] Auto DJ is performing
[845480] OpenQuery - Preparing query Select Playlists.* from Playlists WHERE IDPlaylist=63
[845480] 395276 DB lock finished, took 1000.
[845480] 395276 DB query prepare finished, took 111.
[845480] 395276 DB prepare SQL: SELECT ID, Name, View FROM Views WHERE ID = ?
[845480] 395276 DB open SQL: SELECT ID, Name, View FROM Views WHERE ID = ?
[845480] 395276 DB open SQL: SELECT Songs.*
[845480] FROM Songs WHERE ((Songs.Rating>=96 and Songs.Rating<=100) OR (Songs.Rating>=86 and Songs.Rating<=95) OR (Songs.Rating>=76 and Songs.Rating<=85) OR (Songs.Rating>=66 and Songs.Rating<=75) OR (Songs.Rating>=56 and Songs.Rating<=65) OR Songs.Rating<0) AND (upperw(Songs.Extension) <> upperw('m4p')) AND Songs.LastTimePlayed<43159.2083333333 AND Songs.TrackType in (0,4,3) ORDER BY Random(*)
[845480] MM4 [927716] TStretcher.PerformStretch: Threads[4], source[500, 500], target[167,167]
[845480] BQ: Starting a new task.
[845480] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 5, All: 39
[845480] MM4 [927716] TStretcher.PerformStretch: Finished
[845480] Thread 'BackgroundQueue' has started 863372
[845480] PrepareDockedVideo: Begin
[845480] PrepareDockedVideo: Reduced window or audio
[845480] PrepareDockedVideo: End
[845480] MM4 [927716] TImagePlus.Paint: start
[845480] MM4 [927716] TImagePlus.Paint: start
[845480] MM4 [927716] TLyricsScroller.createOverlay: finished
[845480] MM4 [927716] TLyricsScroller.createOverlay: finished
[845480] MM4 [927716] TImagePlus.Paint: finished
[845480] Win7Tools - Thumbnail - add rating stars
[845480] Win7Tools - Thumbnail - add rating stars
[845480] BQ: Added new task. Currently 1 tasks in queue.
[845480] BQ: There are threads waiting, resume one.
[845480] 395276 DB lock finished, took 788017.
[845480] UpdateLastModifiedForAutoPlaylist started, idPlaylist = 63 Tracks count = 20
[845480] OpenQuery - Preparing query SELECT LastContentHash, LastModified FROM Playlists WHERE IDPlaylist = 63
[845480] 395276 DB exec SQL: UPDATE Playlists SET LastContentHash = 'NZI1PI92MH711U3P', LastModified = '2018-03-01 23:51:50' WHERE IDPlaylist = 63
[845480] 395276 DB lock finished, took 26929.
[845480] OpenQuery - Preparing query SELECT * FROM Playlists WHERE IDPlaylist=63
[845480] UpdateLastModifiedForAutoPlaylist finished, idPlaylist = 63 Oldhash = 7B5SP6HHGFJHRG5J Newhash = NZI1PI92MH711U3P
[845480] Player: Adding track D:\Users\sween\Music\MediaMonkey\_flac\Various Artists\[0000] The Sixties Collection Volume 1\05 He's So Fine [783 kbps flac].flac
[845480] TGenThread.Create: ThreadName: PlayerEntriesUpdater_Var , Running Threads: Internal: 7, All: 39
[845480] Auto DJ: Performing finished
[845480] DB: Deleting prepared query: SELECT * FROM Filters WHERE ID=?
[845480] Thread 'PlaybackStarter_Var'has finished 395276
[845480] Thread 'PlayerEntriesUpdater_Var' has started 847420
[845480] Going 'PlayerEntriesUpdater_Var'to make final callback 847420
[845480] Thread 'IsSongAccessibleAsync'has finished 865284
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[3880] 138364 0000000000000000 ENTER: DllCanUnloadNow
[845480] MMDS: Written 101376 bytes
[845480] Going 'BackgroundQueue'to make final callback 858420
[845480] Going 'BackgroundQueue'to make final callback 863372
[845480] Going 'BackgroundQueue'to make final callback 850492
[845480] Going 'BackgroundQueue'to make final callback 844568
[845480] Thread 'BackgroundQueue'has finished 844568
[845480] MMDS: Written 101376 bytes
[845480] Win7Tools - Thumbnail - add rating stars
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] Win7Tools - Thumbnail - add rating stars
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] TGenThread.Create: ThreadName: UpdateDriveLetters_Var , Running Threads: Internal: 1, All: 32
[845480] PostponeComputerSleep: Enabled = 0
[845480] Thread 'UpdateDriveLetters_Var' has started 903456
[845480] >UpdateDriveLetters - end<
[845480] Thread 'UpdateDriveLetters_Var'has finished 903456
[845480] Win7Tools - Thumbnail - add rating stars
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: ***Playback pointer crossed buffer end***
[845480] MMDS: Written 101376 bytes
[845480] Win7Tools - Thumbnail - add rating stars
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] Win7Tools - Thumbnail - add rating stars
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] Win7Tools - Thumbnail - add rating stars
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] MMDS: ***Playback pointer crossed buffer end***
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Written 101376 bytes
[845480] Win7Tools - Thumbnail - add rating stars
[845480] MMDS: Written 101376 bytes
[845480] MMDS: Pause starting
[845480] MMDS: Pause finished
[845480] PrepareDockedVideo: Begin
[845480] PrepareDockedVideo: Reduced window or audio
[845480] PrepareDockedVideo: End
Code: Select all
[19284] Lizard Mode: Priviledged process
[19284] Lizard Mode: Reverting to default M/KB Configuration
[845480] MM4 [927716] TImagePlus.Paint: start
[845480] Saving of Now Playing selection started
[845480] SaveNowPlayingSelection: PlayerLock unlocked
[845480] PrepareDockedVideo: Switching=false IsStartingPlayback=false WasManuallyChanged=false
[845480] PrepareDockedVideo: End
[845480] TGenThread.Create: ThreadName: PlaybackStarter_Var , Running Threads: Internal: 0, All: 31
[845480] Thread 'PlaybackStarter_Var' has started 886900
[845480] Player: W7 icon updated.
[845480] Player: Setting current track: D:\Users\sween\Music\MediaMonkey\_flac\Nightwish\[2007] Dark Passion Play\12 7 Days to the Wolves [1032 kbps flac].flac
[845480] Player: Song is not cached, try to play the original file
[845480] Player: Playback started
[845480] Winamp Playlist sim - WM_USER message 5
[845480] Winamp Playlist sim - WM_USER message 1073741829
[845480] Going 'PlaybackStarter_Var'to make final callback 886900
[845480] Thread 'PlaybackStarter_Var'has finished 886900
[845480] PrepareDockedVideo: Reduced window or audio
[845480] PrepareDockedVideo: End
[3880] 8916 0000000000000000 ENTER: DllCanUnloadNow
[845480] TGenThread.Create: ThreadName: UpdateDriveLetters_Var , Running Threads: Internal: 0, All: 31
[845480] PostponeComputerSleep: Enabled = 0
[845480] >UpdateDriveLetters - start<
[845480] >UpdateDriveLetters - end<
[845480] Thread 'UpdateDriveLetters_Var'has finished 357724