View Issue Details

IDProjectCategoryView StatusLast Update
0008501MMW v4Playerpublic2011-10-14 01:19
Reporterrusty Assigned To 
PriorityurgentSeveritymajorReproducibilityunable to reproduce
Status closedResolutionno change required 
Product Version4.0 
Target Version4.0 
Summary0008501: Some tracks that play in MM3 don't play in MM4 in specific environments
DescriptionA user is experiencing a problem in which a track that plays correctly in MM3 doesn't play in MM4.

Log attached. Any ideas?
Additional Informationhttp://www.mediamonkey.com/forum/viewtopic.php?p=314161#p314161
TagsNo tags attached.
Attached Files
playback_issue.txt (18,483 bytes)   
[7048] Winamp sim - WM_USER message 104
[7048] Winamp sim - WM_USER message 104
[7048] Winamp sim - WM_USER message 104
[7048] Forms: Accepted WM_ACTIVATEAPP +
[7048] Forms: RestoreTopMost: Starting
[7048] Winamp simulation window received messsage 28
[7048] MainForm: NC Activate +
[1212] 11/17:38:10.166 Thr(00499ab8) PDCi.c PDCi::handleTrackerConnectFailure:2088: W: Tracker connect failure 0 for tor# 2
[7048] Winamp sim - WM_USER message 104
[7048] Winamp sim - WM_USER message 104
[7048] Winamp sim - WM_USER message 104
[1212] 11/17:38:11.686 Thr(02454380) PDSwarmConn.cpp PDSwarmConn::logStats:665: I: PDSwarmConn stats: (final) type 'tcpOpen' pid '2D5044323336302D364334464343413635453634' ip '78.98.244.56:56406' hash 'E2C12AE03DBC6B2C2CFA9529ABCFFF30189CC238' sent '198' received '198'
[1212] 11/17:38:11.686 Thr(02454380) PDSwarmConn.cpp PDSwarmConn::logStats:666: I:
[1212] 11/17:38:11.768 Thr(02454380) PDPseudoTcpChannel.cpp PDPseudoTcpChannel::PseudoTcpNotify::OnTcpOpen:411: I: PseudoTCP connection established to 89.73.58.31:39658
[1212] 11/17:38:11.786 Thr(02454380) PDPseudoTcpChannel.cpp PDPseudoTcpChannel::PseudoTcpNotify::OnTcpOpen:411: I: PseudoTCP connection established to 94.71.158.78:12388
[1212] 11/17:38:11.794 Thr(02454380) PDPseudoTcpChannel.cpp PDPseudoTcpChannel::PseudoTcpNotify::OnTcpOpen:411: I: PseudoTCP connection established to 80.108.239.202:57480
[7048] Winamp sim - WM_USER message 104
[1212] 11/17:38:11.923 Thr(02454380) PDPseudoTcpChannel.cpp PDPseudoTcpChannel::PseudoTcpNotify::OnTcpOpen:411: I: PseudoTCP connection established to 83.24.58.242:63967
[7048] Saving of Now Playing selection started
[7048] SaveNowPlayingSelection: PlayerLock unlocked
[7048] _Stop: started
[7048] BQ: Starting a new task.
[7048] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 0, All: 31
[7048] SynchronizingAfterTagging finished
[7048] Going to stop playback in dll: C:\Users\BriceGdT\AppData\Roaming\MediaMonkey\Plugins\in_wmp3.dll
[7048] Thread registered, going to initialize 7148
[7048] 7148 DB open SQL: 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
[7048] 7148 DB lock finished, took 5725.
[7048] TWAPluginEngine.Stop - input plugin stopped
[7048] PrepareDockedVideo: Begin
[7048] PrepareDockedVideo: Reduced window or audio
[7048] PrepareDockedVideo: End
[7048] TGenThread.Create: ThreadName: PlaybackStarter_Var , Running Threads: Internal: 1, All: 31
[7048] Player: Setting current track: D:\MP3\_Album\_Jazz\_Soul Jazz\Stevie Wonder\1976 - Songs In The Key of Life\Stevie Wonder - Songs In The Key Of Life - 01 - Love's In Need Of Love Today.mp3
[7048] Thread 'PlaybackStarter_Var' has started 6928
[7048] Thread registered, going to initialize 6928
[7048] Thread initialized 6928
[7048] Player: _Play() procedure entering.
[7048] Remaining Cover Lists: 12
[7048] Player: W7 icon updated.
[7048] Player: Updating playlist entry.
[7048] Player: Track entry prepared, going to start playback.
[7048] Going to play file: D:\MP3\_Album\_Jazz\_Soul Jazz\Stevie Wonder\1976 - Songs In The Key of Life\Stevie Wonder - Songs In The Key Of Life - 01 - Love's In Need Of Love Today.mp3
[7048] Going to start playback.
[7048] SkinWrapper: SetCover
[7048] BQ: Starting a new task.
[7048] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 2, All: 32
[7048] Thread 'BackgroundQueue' has started 6012
[7048] Thread initialized 6012
[7048] Winamp simulation window received messsage 12
[7048] Winamp sim - message processing finished
[7048] BQ: Starting a new thread.
[7048] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 3, All: 33
[7048] Thread 'BackgroundQueue' has started 6464
[7048] Thread initialized 6464
[7048] Winamp sim - WM_USER message 603
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] 3680 DB lock finished, took 145.
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] Winamp sim - WM_USER message 603
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] Winamp sim - WM_USER message 603
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] StretchStart
[7048] BQ: Starting a new task.
[7048] BQ: Starting a new thread.
[7048] StretchEnd
[7048] Thread 'BackgroundQueue' has started 3604
[7048] Thread initialized 3604
[7048] StretchStart
[7048] BQ: Starting a new thread.
[7048] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 5, All: 36
[7048] Thread 'BackgroundQueue' has started 3644
[7048] Thread initialized 3644
[7048] StretchEnd
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] TWAInputPlugin.Play finishing
[7048] Player: There is a problem in playing this file, try the next one
[7048] _Stop: started
[7048] Winamp Playlist sim - WM_USER message 0
[7048] Winamp sim - WM_USER message 104
[7048] Winamp Playlist sim - message left to the default processing
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] Winamp sim - WM_USER message 603
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] 6928 DB open SQL: 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
[7048] 6928 DB lock finished, took 5664.
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] PrepareDockedVideo: Begin
[7048] _Stop: finished
[7048] Player: Next track prepared, going to start playback
[7048] PrepareDockedVideo: Switching=true IsStartingPlayback=true WasManuallyChanged=false
[7048] SkinWrapper: SetCover
[7048] BQ: Starting a new task.
[7048] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 6, All: 36
[7048] Thread 'BackgroundQueue' has started 5536
[7048] Thread initialized 5536
[7048] Winamp sim - message left to the default processing
[7048] BQ: Starting a new task.
[7048] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 7, All: 37
[7048] Thread 'BackgroundQueue' has started 7104
[7048] Thread initialized 7104
[7048] PrepareDockedVideo: Switching=false IsStartingPlayback=true WasManuallyChanged=false
[7048] PrepareDockedVideo: Audio
[7048] Player: _Play() procedure entering.
[7048] Player: W7 icon updated.
[7048] Player: Updating playlist entry.
[7048] Player: Track entry prepared, going to start playback.
[7048] Going to play file: D:\MP3\_Album\_Jazz\_Soul Jazz\Stevie Wonder\1976 - Songs In The Key of Life\Stevie Wonder - Songs In The Key Of Life - 02 - Have A Talk With God.mp3
[7048] Going to start playback.
[7048] Winamp sim - WM_USER message 603
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] Winamp sim - WM_USER message 603
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] StretchStart
[7048] BQ: There are threads waiting, resume one.
[7048] StretchStart
[7048] BQ: There are threads waiting, resume one.
[7048] StretchEnd
[7048] Winamp sim - WM_USER message 125
[7048] Winamp sim - WM_USER message 3026
[7048] Winamp sim - WM_USER message 214
[7048] Winamp sim - WM_USER message 125
[7048] Winamp sim - WM_USER message 3026
[7048] Winamp sim - WM_USER message 214
[7048] Winamp sim - WM_USER message 125
[7048] Winamp sim - WM_USER message 125
[7048] Winamp sim - WM_USER message 290
[7048] Winamp sim - WM_USER message 211
[7048] Winamp sim - WM_USER message 125
[7048] Winamp sim - WM_USER message 290
[7048] Winamp sim - WM_USER message 211
[7048] Winamp sim - WM_USER message 104
[7048] 6928 DB lock finished, took 5830.
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] PrepareDockedVideo: Begin
[7048] _Stop: finished
[7048] Player: Next track prepared, going to start playback
[7048] PrepareDockedVideo: Switching=true IsStartingPlayback=true WasManuallyChanged=false
[7048] Remaining Covers: 37
[7048] Remaining Covers: 35
[7048] SkinWrapper: SetCover
[7048] BQ: Starting a new task.
[7048] Winamp simulation window received messsage 12
[7048] Winamp sim - message processing finished
[7048] BQ: There are threads waiting, resume one.
[7048] PrepareDockedVideo: Begin
[7048] PrepareDockedVideo: Reduced window or audio
[7048] PrepareDockedVideo: End
[7048] Player: W7 icon updated.
[7048] Player: Updating playlist entry.
[7048] Player: Track entry prepared, going to start playback.
[7048] Going to play file: D:\MP3\_Album\_Jazz\_Soul Jazz\Stevie Wonder\1976 - Songs In The Key of Life\Stevie Wonder - Songs In The Key Of Life - 03 - Village Ghetto Land.mp3
[7048] Going to start playback.
[7048] Winamp sim - WM_USER message 603
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] Winamp sim - WM_USER message 603
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] StretchStart
[7048] BQ: There are threads waiting, resume one.
[7048] StretchStart
[7048] BQ: There are threads waiting, resume one.
[7048] StretchEnd
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] Winamp sim - WM_USER message 125
[7048] Winamp sim - WM_USER message 214
[7048] Winamp sim - WM_USER message 125
[7048] Winamp sim - WM_USER message 3026
[7048] Winamp sim - WM_USER message 214
[7048] Winamp sim - WM_USER message 125
[7048] Winamp sim - WM_USER message 105
[7048] Winamp sim - WM_USER message 211
[7048] Winamp sim - WM_USER message 211
[7048] Winamp sim - WM_USER message 125
[7048] Winamp sim - WM_USER message 290
[7048] Winamp sim - WM_USER message 211
[7048] Winamp sim - WM_USER message 125
[7048] Winamp sim - WM_USER message 105
[7048] Winamp sim - WM_USER message 104
[7048] TWAInputPlugin.Play finishing
[7048] Player: There is a problem in playing this file, try the next one
[7048] Player: Next command started
[7048] _Stop: started
[7048] Winamp sim - WM_USER message 104
[7048] Winamp Playlist sim - message left to the default processing
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] Winamp sim - WM_USER message 603
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] 3680 DB lock finished, took 283.
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] TEventedAutoObject Created, Class: TSDBApplication
[1212] 11/17:38:13.548 Thr(02454380) PDPseudoTcpChannel.cpp PDPseudoTcpChannel::PseudoTcpNotify::OnTcpClosed:446: I: OnTcpClosed getting called
[1212] 11/17:38:13.548 Thr(02454380) PDSwarmConn.cpp PDSwarmConn::logStats:665: I: PDSwarmConn stats: (final) type 'udpIndependent' pid '2D5044323336302D353131333133323237313533' ip '90.16.181.103:52174' hash 'E2C12AE03DBC6B2C2CFA9529ABCFFF30189CC238' sent '0' received '0'
[1212] 11/17:38:13.548 Thr(02454380) PDSwarmConn.cpp PDSwarmConn::logStats:666: I:
[7048] 6928 DB open SQL: 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
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] PrepareDockedVideo: Begin
[7048] _Stop: finished
[7048] Player: Next track prepared, going to start playback
[7048] PrepareDockedVideo: Switching=true IsStartingPlayback=true WasManuallyChanged=false
[7048] Remaining Covers: 33
[7048] Remaining Covers: 31
[7048] SkinWrapper: SetCover
[7048] BQ: Starting a new task.
[7048] UpdateSongPictures: D:\Norbert\Duke Ellington - The Duke Ellington Centennial Edition (24CD BOXSET)\Duke Ellington - The Duke Ellington Centennial Edition (disc 5)\ 14. Keep A Song In Your Soul.mp3
[7048] GetFileInfo: D:\Norbert\Duke Ellington - The Duke Ellington Centennial Edition (24CD BOXSET)\Duke Ellington - The Duke Ellington Centennial Edition (disc 5)\ 14. Keep A Song In Your Soul.mp3
[7048] GetFileInfo: D:\Norbert\Duke Ellington - The Duke Ellington Centennial Edition (24CD BOXSET)\Duke Ellington - The Duke Ellington Centennial Edition (disc 5)\ 14. Keep A Song In Your Soul.mp3
[7048] MP3.ReadHeader - File size 6481440
[7048] MP3.ReadHeader framestarts: 4336, 4336
[7048] MP3: Going to read tag from D:\Norbert\Duke Ellington - The Duke Ellington Centennial Edition (24CD BOXSET)\Duke Ellington - The Duke Ellington Centennial Edition (disc 5)\ 14. Keep A Song In Your Soul.mp3
[7048] 6464 DB prepare SQL: SELECT Songs.* FROM Songs WHERE Songs.IDMedia=? AND Songs.SongPath=?
[7048] 6464 DB open SQL: SELECT Songs.* FROM Songs WHERE Songs.IDMedia=? AND Songs.SongPath=?
[7048] Winamp simulation window received messsage 12
[7048] Winamp sim - message processing finished
[7048] BQ: There are threads waiting, resume one.
[7048] PrepareDockedVideo: Switching=false IsStartingPlayback=true WasManuallyChanged=false
[7048] PrepareDockedVideo: Audio
[7048] Player: _Play() procedure entering.
[7048] Player: W7 icon updated.
[7048] Player: Updating playlist entry.
[7048] Player: Track entry prepared, going to start playback.
[7048] Plugin C:\Users\BriceGdT\AppData\Roaming\MediaMonkey\Plugins\in_wmp3.dll can play D:\Norbert\Duke Ellington - The Duke Ellington Centennial Edition (24CD BOXSET)\Duke Ellington - The Duke Ellington Centennial Edition (disc 5)\ 14. Keep A Song In Your Soul.mp3
[7048] TWAInputPlugin.Play starting
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] Winamp sim - WM_USER message 603
[7048] GetFileInfo: Found in DB
[7048] 6464 DB open SQL: SELECT * FROM Covers WHERE IDSong=71584 ORDER BY CoverOrder
[7048] 6464 DB lock finished, took 316.
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] BQ: Starting a new task.
[7048] StretchEnd
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] TWAInputPlugin.Play finishing
[7048] Winamp sim - WM_USER message 603
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] Winamp Playlist sim - WM_USER message 3
[7048] Winamp sim - WM_USER message 104
[7048] Winamp Playlist sim - message left to the default processing
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] Winamp sim - WM_USER message 603
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] 3680 DB lock finished, took 284.
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] Events: Destroying TScriptExec: C:\Users\BriceGdT\AppData\Roaming\MediaMonkey\Scripts\ScrobblerDJ.vbs
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] Events: Successfully finished event: AutoArtFinder
[7048] PrepareDockedVideo: Begin
[7048] PrepareDockedVideo: Switching=false IsStartingPlayback=false WasManuallyChanged=false
[7048] PrepareDockedVideo: Audio
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] TEventedAutoObject Created, Class: TSDBApplication
[7048] TEventedAutoObject Destroying, Class: TSDBApplication
[7048] Winamp sim - WM_USER message 125
[7048] Winamp sim - WM_USER message 3026
[7048] Winamp sim - WM_USER message 214
[7048] Winamp sim - WM_USER message 125
[7048] Winamp sim - WM_USER message 3026
[7048] Winamp sim - WM_USER message 214
[7048] Winamp sim - WM_USER message 125
[7048] Winamp sim - WM_USER message 125
[7048] Winamp sim - WM_USER message 290
[7048] Winamp sim - WM_USER message 211
[7048] Winamp sim - WM_USER message 125
[7048] Winamp sim - WM_USER message 290
[7048] Winamp sim - WM_USER message 211
[7048] Winamp sim - WM_USER message 104
[7048] Winamp sim - WM_USER message 104
[7048] Winamp sim - WM_USER message 104
[7048] MainForm: NC Activate -
[7048] Forms: Accepted WM_ACTIVATEAPP -
[7048] Forms: NormalizeTopMost: Starting
[7048] Winamp simulation window received messsage 28
[7048] Winamp sim - WM_USER message 104
[1212] 11/17:38:15.663 Thr(024129d8) PDPseudoTcpChannel.cpp PDPseudoTcpChannel::PseudoTcpNotify::OnTcpOpen:411: I: PseudoTCP connection established to 198.82.58.177:63914
[7048] Winamp sim - WM_USER message 104
[7048] Going 'BackgroundQueue'to make final callback 3644
[7048] Going 'BackgroundQueue'to make final callback 7148
[7048] Thread 'BackgroundQueue'has finished 6012
[7048] Going 'BackgroundQueue'to make final callback 7104
[7048] Winamp sim - WM_USER message 104
[1212] 11/17:38:16.636 Thr(02454380) PDPseudoTcpChannel.cpp PDPseudoTcpChannel::PseudoTcpNotify::OnTcpClosed:446: I: OnTcpClosed getting called
[1212] 11/17:38:16.636 Thr(02454380) PDSwarmConn.cpp PDSwarmConn::logStats:665: I: PDSwarmConn stats: (final) type 'udpIndependent' pid '2D5044323336302D374634423542394332453530' ip '93.133.23.208:54568' hash 'E2C12AE03DBC6B2C2CFA9529ABCFFF30189CC238' sent '0' received '0'
[1212] 11/17:38:16.636 Thr(02454380) PDSwarmConn.cpp PDSwarmConn::logStats:666: I:
[7048] Going 'BackgroundQueue'to make final callback 3604
[7048] Going 'BackgroundQueue'to make final callback 6464
[7048] Thread 'BackgroundQueue'has finished 6464
[7048] Thread 'BackgroundQueue'has finished 5536
playback_issue.txt (18,483 bytes)   
Fixed in build

Activities

rusty

2011-10-11 18:41

administrator   ~0028197

User indicated that it was related to the wrong version of in_wmp3.dll being installed.

It's still unclear why the wrong version was there.

Need to verify that install of MM4 correctly replaces that file.

peke

2011-10-14 01:19

developer   ~0028264

User confirmed that plugin version was the issue and I verified thatr MM install corect one by installing 1444 over the 1307