renderer: 1) no file information 2) not playing other files

Get answers about how to share with different devices.

Moderator: Gurus

Guest

renderer: 1) no file information 2) not playing other files

Post by Guest » Mon Nov 16, 2015 8:51 am

Hello!

I have two small problems when using a DLNA renderer to play my MMW playlist. PC with all the music and MMW runs under win10. I'm using a Webradio which is connected over the home network (UpNP, DLNA, <or something>... :) ). In <preferences> -> <player> I've chosen the Webradio to be the player (UpNP renderer / DLNA) for MediaMonkey.

First issue: Files that I added to my archive are playing just fine. However, no track information is displayed on the display of my renderer. Only a path with my IP, the port and some track ID is shown, for example: "123.456.789.9:1234/ItemID=1234". Further information (Artist, album) are not available either. Using the Webradio via the WMP "play to" function all that information is available: Artist and track name are showing up as a "title" and the correct information about artist and album are displayed when I browse the file information of the renderer.
Is there a way to make this work under MMfW, as well?
Remark: my music files are tagged correctly and quite extensive.

Second issue: Only files that are in the MediaMonkey archive can be played over the renderer. If a add a file to my playlist that isn't in the archive playback doesn't start. Again, WMP's "play to" function plays files in the archive and other files, too. How can I realize this using MMfW?

Lowlander
Posts: 46281
Joined: Sat Sep 06, 2003 5:53 pm
Location: MediaMonkey 5

Re: renderer: 1) no file information 2) not playing other fi

Post by Lowlander » Mon Nov 16, 2015 10:48 am

1) Can you pull files from a DLNA server from the Webradio (instead of current Push 'Play To' method you're using)? If so when pulling from MediaMonkey does Track info display now?

2) Not sure if this is meant to be possible or not.
Lowlander (MediaMonkey user since 2003)

Guest

Re: renderer: 1) no file information 2) not playing other fi

Post by Guest » Mon Nov 16, 2015 12:09 pm

Thanks!

I don't know if I got you correctly. My media is on the same PC as the MediaMonkey software is. I activated Windows media sharing but excluded music there because - justforfun - I activated DLNA acces to the MediaMonkey music library. So all my music is shared with MediaMonkey ('cause MM media sharing is more convenient and faster than the Windows media sharing).
When I use the Webradio to browse my music (which is located on the same PC as MediaMonkey is) the information shows up correctly. I can search in albums, artists, year of release

Lowlander
Posts: 46281
Joined: Sat Sep 06, 2003 5:53 pm
Location: MediaMonkey 5

Re: renderer: 1) no file information 2) not playing other fi

Post by Lowlander » Mon Nov 16, 2015 2:17 pm

Then capture the problem in a debug log (step 4b) and send the log to support: http://www.mediamonkey.com/forum/viewto ... ?f=20&t=69
Lowlander (MediaMonkey user since 2003)

Hobbit
Posts: 6
Joined: Wed Nov 18, 2015 4:39 am

"play to": no metadata shown & non-archive files NOT played

Post by Hobbit » Wed Nov 18, 2015 6:39 am

Hi!

I've already posted my problem here. I was told to create a bug report in this sub forum. So, here it is :)

PC: Win10 x64, MediaMonkey f. W. 4.1.9.1764.
Settings: Connection with Windows Homegroup. Media Sharing activated for PCs. UpNP streaming activated. MediaMonkey media sharing (UPnP/DLNA) activated. Sharing service activated. MediaMonkey "server" shows up under [explorer => network => multimedia].
Homegroup: amongst others: web radios amongst others that can access files shared in the homegroup. Windows "Play to" works as well as MediaMonkey's setting [choose player => UPnP/DLNA renderer => web radio]

HOWEVER: When playing a file with MediaMonkey on the UPnP/DLNA device file information is not displayed. Instead some network path is shown: 123.456.789.0:1234/itemID=1234.mp3
In addition, playing a file which does not belong to the MediaMonkey archive is not possible! In the ladder case playback won't even start (I assume that the "not playing" problem is linked to the fact that non-archive files don't have a "link" that can be transmitted to the renderer.) or stops immediately.


I tried to produce a log file but it seems as if there was nothing (important) logged at all. When I play files that are not in my archive (the files that aren't played on the renderer) DebugView just does nothing.
Log of two mp3 files played on the renderer:

Code: Select all

00000001	0.00000000	[4636] shell\twinui\nowplayingsessionmanager\localprovider\baseprovider\lib\baseprovider.cpp(516)\NPSMDesktopProvider.dll!00007FFF2DD4E7B8: (caller: 00007FFF2DD449F9) ReturnHr[PreRelease](252) tid(1f44) 80070490 Element nicht gefunden. 	
00000002	2.27530670	[4636] shell\twinui\nowplayingsessionmanager\localprovider\baseprovider\lib\baseprovider.cpp(516)\NPSMDesktopProvider.dll!00007FFF2DD4E7B8: (caller: 00007FFF2DD449F9) ReturnHr[PreRelease](253) tid(1f44) 80070490 Element nicht gefunden. 	
00000003	282.07366943	[4964] base\appmodel\execmodel\modern\lifetimemanager\plmutil.cpp(281)\modernexecserver.dll!00007FFF458534DE: (caller: 00007FFF4584D3FB) ReturnHr[PreRelease](101) tid(1ca4) 80070002 Das System kann die angegebene Datei nicht finden. 	
00000004	433.31951904	[4636] shell\lib\bindctx.cpp(1144)\explorerframe.dll!00007FFF3F4F8EA4: (caller: 00007FFF3F5405BE) ReturnHr[PreRelease](225) tid(358) 80070057 Falscher Parameter. 	
00000005	624.47717285	[4636] shell\twinui\nowplayingsessionmanager\localprovider\baseprovider\lib\baseprovider.cpp(516)\NPSMDesktopProvider.dll!00007FFF2DD4E7B8: (caller: 00007FFF2DD449F9) ReturnHr[PreRelease](254) tid(1ef4) 80070490 Element nicht gefunden. 	
00000006	629.97540283	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](1) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000007	629.97735596	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](2) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000008	629.97937012	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](3) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000009	629.98126221	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](4) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000010	629.98309326	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](5) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000011	629.98480225	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](6) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000012	629.98675537	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](7) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000013	629.98876953	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](8) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000014	629.99047852	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](9) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000015	629.99328613	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](10) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000016	629.99523926	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](11) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000017	629.99713135	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](12) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000018	629.99890137	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](13) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000019	630.00079346	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](14) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000020	630.00274658	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](15) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000021	630.00463867	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](16) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000022	630.00646973	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](17) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000023	630.01037598	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](18) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000024	630.01354980	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](19) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000025	630.01580811	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](20) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000026	630.01800537	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](21) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000027	630.02001953	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](22) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
00000028	630.02215576	[1488] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!73F7069D: (caller: 73F706F1) ReturnHr[PreRelease](23) tid(27b4) 80030002 %1 wurde nicht gefunden. 	
Log of skipping through (and trying to play) tracks that are not in my archive:

Code: Select all

00000001	0.00000000	[5592] base\appmodel\visualelementdatamodel\notificationobjfactory\src\notificationparser\src\notificationparser.cpp(253)\NotificationObjFactory.dll!00007FF8BE27AE26: (caller: 00007FF8BE275FC7) Exception(7) tid(1308) C00CE225 	
00000002	0.00100188	[5592] base\appmodel\visualelementdatamodel\notificationobjfactory\src\ctile.cpp(410)\NotificationObjFactory.dll!00007FF8BE2792F5: (caller: 00007FF8C240103C) ReturnHr(7) tid(1308) C00CE225 	
00000003	2.36052465	[5592] Type of item #0 of subgroup #0: image	
00000004	2.36059546	[5592] Type of item #0 of subgroup #1: image	
00000005	4.88382673	[5592] windows\dxaml\xcp\components\style\optimizedstyle.cpp(478)\Windows.UI.Xaml.dll!00007FF8D47AD47D: (caller: 00007FF8D46B78C1) Exception(12) tid(1654) 80004005 Unbekannter Fehler 	
00000006	4.88390875	[5592] windows\dxaml\xcp\core\core\elements\style.cpp(374)\Windows.UI.Xaml.dll!00007FF8D48D58F0: (caller: 00007FF8D46AD87F) ReturnHr(12) tid(1654) 80004005 Unbekannter Fehler 	
00000007	5.15215063	[5592] Suspending	
00000008	12.21409416	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](100) tid(1550) 80030002 %1 wurde nicht gefunden. 	
00000009	12.21432686	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](101) tid(1550) 80030002 %1 wurde nicht gefunden. 	
00000010	12.21512032	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](102) tid(1550) 80030002 %1 wurde nicht gefunden. 	
00000011	12.25122738	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](103) tid(8c8) 8004B203 	
00000012	12.25273609	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](104) tid(8c8) 8004B203 	
00000013	12.25338078	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](105) tid(8c8) 8004B203 	
00000014	12.25772095	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](106) tid(1438) 8004B203 	
00000015	12.25791168	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](107) tid(1438) 8004B203 	
00000016	12.25818253	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](108) tid(1438) 8004B203 	
00000017	12.25843906	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](109) tid(1438) 8004B203 	
00000018	12.25868511	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](110) tid(1438) 8004B203 	
00000019	12.25885105	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](111) tid(1438) 8004B203 	
00000020	12.26427078	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](112) tid(1780) 8004B203 	
00000021	12.26464367	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](113) tid(1780) 8004B203 	
00000022	12.27746391	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](114) tid(17b0) 8004B200 	
00000023	12.28986549	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](115) tid(1780) 8004B200 	
00000024	12.29282475	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](116) tid(1780) 8004B200 	
00000025	12.29527283	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](117) tid(1780) 8004B200 	
00000026	12.29698181	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](118) tid(1780) 8004B200 	
00000027	12.30724430	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](119) tid(1780) 8004B200 	
00000028	12.30899620	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](120) tid(1780) 8004B200 	
00000029	12.31401348	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](121) tid(1780) 8004B200 	
00000030	12.31585217	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](122) tid(1780) 8004B200 	
00000031	12.31808662	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](123) tid(1780) 8004B200 	
00000032	12.32061768	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](124) tid(1780) 8004B200 	
00000033	112.48360443	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](125) tid(8d0) 8004B200 	
00000034	112.48965454	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](126) tid(8d0) 8004B200 	
00000035	112.49657440	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](127) tid(8d0) 8004B200 	
00000036	112.49919128	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](128) tid(8d0) 8004B200 	
00000037	112.49930573	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](129) tid(8d0) 8004B200 	
00000038	112.49940491	[1976] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!00007FF8C3385227: (caller: 00007FF8C338533F) ReturnHr[PreRelease](130) tid(8d0) 8004B200 	
00000039	167.91423035	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](1) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000040	167.91567993	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](2) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000041	167.91744995	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](3) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000042	167.91937256	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](4) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000043	167.92114258	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](5) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000044	167.92282104	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](6) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000045	167.92445374	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](7) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000046	167.92608643	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](8) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000047	167.92858887	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](9) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000048	167.93022156	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](10) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000049	167.93190002	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](11) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000050	167.93357849	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](12) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000051	167.93531799	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](13) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000052	167.93762207	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](14) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000053	167.93942261	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](15) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000054	167.94108582	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](16) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000055	167.94477844	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](17) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000056	167.97207642	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](18) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000057	167.99203491	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](19) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000058	168.00962830	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](20) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000059	168.02772522	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](21) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000060	168.04988098	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](22) tid(2390) 80030002 %1 wurde nicht gefunden. 	
00000061	168.07162476	[7760] shell\ext\thumbnailcache\lib\thumbcacheapi.cpp(226)\thumbcache.dll!72C1069D: (caller: 72C106F1) ReturnHr[PreRelease](23) tid(2390) 80030002 %1 wurde nicht gefunden. 	
edit: obviously, they didn't want my post in the "report bug" sub-forum. :)

Hobbit
Posts: 6
Joined: Wed Nov 18, 2015 4:39 am

Re: renderer: 1) no file information 2) not playing other fi

Post by Hobbit » Fri Jan 22, 2016 11:44 am

I'd like to give an update to one of my problems:
I've had issues with my renderer (web radio with UPnP) not showing file information like <artist> - <song name> in its display when playing a file in Media Monkey. Instead when a song is played my device only shows a path like: "123.456.789.9:1234/ItemID=1234". Now I've made the following experience: When it comes to entering a date to the tag of a song I usually put in just the release year of the album (e.g. "2010").
If I now put in some exact release date including release day and month of the album (I come from Germany, so the date looks like "DD.MM.YYYY". "DD/MM/YYY" seems to work, as well) ...the problem seems to be solved and the correct tag is displayed in the display of my web radio :o This is just weird!

Can someone reproduce my findings? Is there a chance of improving Media Monkey in a way that the year of the album release only is enough for a song to be displayed correctly on a renderer?

Peke
Posts: 12500
Joined: Tue Jun 10, 2003 7:21 pm
Location: Serbia
Contact:

Re: renderer: 1) no file information 2) not playing other fi

Post by Peke » Sun Jan 24, 2016 3:05 am

Hi,
Log file do not contain any MMW logs.

What is the support ticket ID you opened?
Best regards,
Pavle
MediaMonkey Team lead QA/Tech Support guru
Admin of Free MediaMonkey addon Site HappyMonkeying
Image
Image
How to add SCREENSHOTS to forum

Hobbit
Posts: 6
Joined: Wed Nov 18, 2015 4:39 am

Re: renderer: 1) no file information 2) not playing other fi

Post by Hobbit » Tue Jan 26, 2016 9:06 am

I've just drawn a new ticket: #JDB-801-66059

Here's the log file I attached to my bug report:

Code: Select all

00000001	0.00000000	[5472] shell\twinui\nowplayingsessionmanager\localprovider\baseprovider\lib\baseprovider.cpp(516)\NPSMDesktopProvider.dll!00007FFBEB3FE7E8: (caller: 00007FFBEB3F4A09) ReturnHr[PreRelease](274) tid(149c) 80070490 Element nicht gefunden. 	
00000002	0.20505723	[5336] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00000003	0.40655458	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00000004	0.40672857	[5336] UPnP: Control Request -> Action: TransportInfoResponse	
00000005	1.19407856	[5336] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00000006	1.40984571	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00000007	1.41007924	[5336] UPnP: Control Request: SetTransportStatus: STOPPED	
00000008	2.20643210	[5336] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00000009	2.42691398	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00000010	2.42722869	[5336] UPnP: Control Request: SetTransportStatus: STOPPED	
00000011	3.19202256	[5336] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00000012	3.40771246	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00000013	3.40794349	[5336] UPnP: Control Request: SetTransportStatus: STOPPED	
00000014	4.19477558	[5336] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00000015	4.40676069	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00000016	4.40697956	[5336] UPnP: Control Request: SetTransportStatus: STOPPED	
00000017	5.19553471	[5336] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00000018	5.40670776	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00000019	5.40693569	[5336] UPnP: Control Request: SetTransportStatus: STOPPED	
00000020	6.19720936	[5336] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00000021	6.40655136	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00000022	6.40670395	[5336] UPnP: Control Request: SetTransportStatus: STOPPED	
00000023	6.58954096	[5336] Forms: Accepted WM_ACTIVATEAPP +	
00000024	6.58974600	[5336] Forms: RestoreTopMost: Starting	
00000025	6.59232855	[5336] MainForm: NC Activate +	
00000026	6.61513281	[5472] shell\twinui\nowplayingsessionmanager\localprovider\baseprovider\lib\baseprovider.cpp(516)\NPSMDesktopProvider.dll!00007FFBEB3FE7E8: (caller: 00007FFBEB3F4A09) ReturnHr[PreRelease](275) tid(149c) 80070490 Element nicht gefunden. 	
00000027	6.74310923	[5336] TGenThread.Create: ThreadName: PlaybackStarter_Var , Running Threads: Internal: 0, All: 31	
00000028	6.74804640	[5336] PrepareDockedVideo: Begin	
00000029	6.74815464	[5336] PrepareDockedVideo: Reduced window or audio	
00000030	6.74831533	[5336] PrepareDockedVideo: End	
00000031	6.74894428	[5336] Player: _Play() procedure entering.	
00000032	6.75314951	[5336] Player: W7 icon updated.	
00000033	6.75325394	[5336] Player: Invalid track position, resetting to 0.	
00000034	6.75345087	[5336] PrepareDockedVideo: Begin	
00000035	6.75353909	[5336] PrepareDockedVideo: Reduced window or audio	
00000036	6.75367498	[5336] PrepareDockedVideo: End	
00000037	6.75376415	[5336] BQ: Starting a new task.	
00000038	6.75386000	[5336] BQ: Starting a new thread.	
00000039	6.77115202	[5336] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 1, All: 32	
00000040	6.77555323	[5336] 3472 DB prepare SQL: SELECT Lyrics, Comment FROM Songs WHERE Songs.ID=?	
00000041	6.77573586	[5336] 3472 DB open SQL: SELECT Lyrics, Comment FROM Songs WHERE Songs.ID=? 	
00000042	6.77643681	[5336] Thread 'BackgroundQueue' has started 1464	
00000043	6.77671766	[5336] Added Cover Lists: 1	
00000044	6.77681828	[5336] GetFileInfo: readPictures=spAlways	
00000045	6.77710056	[5336] MP3.ReadHeader C:\Users\Oliver Eichler\Music\Schandmaul\Narrenkönig\Schandmaul - Walpurgisnacht.mp3	
00000046	6.77723217	[5336] MP3.ReadHeader - Found ID3v2, length: 45821	
00000047	6.77741385	[5336] MP3.ReadHeader CheckMoreHeaders started	
00000048	6.77749968	[5336] MP3.ReadHeader CheckMoreHeaders finished	
00000049	6.77759552	[5336] MP3: Going to read tag from C:\Users\Oliver Eichler\Music\Schandmaul\Narrenkönig\Schandmaul - Walpurgisnacht.mp3	
00000050	6.78089046	[5336] Added Covers: 1	
00000051	6.78103924	[5336] 1464 DB prepare SQL: SELECT Songs.* FROM Songs WHERE Songs.IDMedia=? AND Songs.SongPath=?	
00000052	6.78127146	[5336] 1464 DB open SQL: SELECT Songs.* FROM Songs WHERE Songs.IDMedia=? AND Songs.SongPath=? 	
00000053	6.78163815	[5336] GetFileInfo: Found in DB	
00000054	6.78172779	[5336] 1464 DB open SQL: SELECT * FROM Covers WHERE IDSong=24338 ORDER BY CoverOrder 	
00000055	6.78200102	[5336] 1464 DB lock finished, took 457.	
00000056	6.78209209	[5336] Remaining Covers: 1	
00000057	6.78218031	[5336] Added Covers: 3	
00000058	6.96661139	[5336] BQ: Added new task. Currently 1 tasks in queue.	
00000059	6.96671915	[5336] BQ: Currently running 1 threads of 8	
00000060	6.98491001	[5336] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 2, All: 35	
00000061	6.99036455	[5336] Thread 'BackgroundQueue' has started 8204	
00000062	7.11401701	[5336] StretchStart	
00000063	7.11477280	[5336] BQ: Starting a new task.	
00000064	7.11485004	[5336] BQ: Added new task. Currently 2 tasks in queue.	
00000065	7.11492538	[5336] BQ: Currently running 2 threads of 8	
00000066	7.13372946	[5336] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 3, All: 36	
00000067	7.13783550	[5336] BQ: Added new task. Currently 2 tasks in queue.	
00000068	7.13791895	[5336] BQ: There are threads waiting, resume one.	
00000069	7.13800144	[5336] BQ: Starting a new task.	
00000070	7.13807917	[5336] BQ: Added new task. Currently 1 tasks in queue.	
00000071	7.13815737	[5336] BQ: There are threads waiting, resume one.	
00000072	7.13823986	[5336] BQ: Starting a new task.	
00000073	7.13832569	[5336] BQ: Added new task. Currently 1 tasks in queue.	
00000074	7.13844824	[5336] BQ: There are threads waiting, resume one.	
00000075	7.13886023	[5336] Thread 'BackgroundQueue' has started 10132	
00000076	7.19501686	[5336] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00000077	7.41226149	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00000078	7.41236448	[5336] UPnP: Control Request: SetTransportStatus: STOPPED	
00000079	8.25944424	[5336] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00000080	8.48823833	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00000081	8.48834133	[5336] UPnP: Control Request: SetTransportStatus: STOPPED	
00000082	8.69930077	[5336] Winamp simulation window received messsage 12	
00000083	8.69940853	[5336] BQ: Starting a new task.	
00000084	8.70043659	[5336] Player: Updating playlist entry.	
00000085	8.70052814	[5336] Player: Track entry prepared, going to start playback.	
00000086	8.70078468	[5336] UPnP: Get IP Addresses	
00000087	8.70093441	[5336] GetNetworkAdapters started	
00000088	8.73396492	[5336] GetNetworkAdapters finished: Count = 1	
00000089	8.73449230	[5336] 11000 DB query prepare finished, took 92.	
00000090	8.73468876	[5336] 11000 DB lock finished, took 214.	
00000091	8.73484516	[5336] GetProtocolInfoFromExt URI: http://192.168.178.11:55345/ItemID=24338.mp3	
00000092	8.73491669	[5336] PLT_MimeType::GetMimeTypeFromExtension: No context !	
00000093	8.73499966	[5336] GetSimpleDIDLForSong DIDL: <DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/"><item id="1" parentID="0" restricted="1"><dc:title>Walpurgisnacht</dc:title><dc:date>2002-10-07</dc:date><upnp:artist role="Performer">Schandmaul</upnp:artist><upnp:artist role="AlbumArtist">Schandmaul</upnp:artist><upnp:album>Narrenkönig</upnp:album><upnp:genre></upnp:genre><upnp:albumArtURI dlna:profileID="JPEG_TN">http://192.168.178.11:55345/3076.jpg</upnp:albumArtURI><upnp:originalTrackNumber>1</upnp:originalTrackNumber><res duration="0:04:07.558" size="4997120" bitrate="160000" sampleFrequency="44100" nrAudioChannels="2" protocolInfo="http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01500000000000000000000000000000">http://192.168.178.11:55345/ItemID=24338.mp3</res><upnp:class>object.item.audioItem.musicTrack</upnp:class></item></DIDL-Lite>	
00000094	8.73520088	[5336] TRemotePlayer.InvokeAction(SetAVTransportURI, http://192.168.178.11:55345/ItemID=24338.mp3, )	
00000095	8.77909565	[5336] UPNP Server: File Request: /ItemID=24338.mp3 , Range: < -1, -1>	
00000096	8.77918148	[5336] TMediaServer.Get(ea4381da-eabb-4b55-9061-446a736dd117)	
00000097	8.77926159	[5336] PostponeComputerSleep: Enabled = 1	
00000098	8.77937889	[5336] OpenQuery - Preparing query SELECT * FROM RemoteClients WHERE MAC = '00-22-61-E7-38-9C'  	
00000099	8.78018284	[5336] 6672 DB prepare SQL: SELECT * FROM Songs WHERE Songs.ID=?	
00000100	8.78040218	[5336] 6672 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 	
00000101	8.78078270	[5336] _BrowseRequest finished	
00000102	8.78092575	[5336] UPnP Server: Creating HTTP entity	
00000103	8.78594971	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=24338.mp3	
00000104	8.79873848	[5336] UPnP: OnSetAVTransportURIResult	
00000105	8.79897118	[5336] TRemotePlayer.InvokeAction(Play, , )	
00000106	8.83710384	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=24338.mp3	
00000107	8.88749123	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=24338.mp3	
00000108	8.93777657	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=24338.mp3	
00000109	8.95252705	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00000110	8.95267105	[5336] UPnP: Control Request -> Action: TransportInfoResponse	
00000111	8.98839951	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=24338.mp3	
00000112	9.19257164	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=24338.mp3	
00000113	9.23228264	[5336] UPnP: OnGetTransportInfoResponse: TRANSITIONING	
00000114	9.23250198	[5336] UPnP: Control Request: SetTransportStatus: TRANSITIONING	
00000115	9.24307156	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=24338.mp3	
00000116	9.24327469	[5336] Player: Playback started	
00000117	9.24404621	[5336] PrepareDockedVideo: Begin	
00000118	9.24428844	[5336] PrepareDockedVideo: Switching=false IsStartingPlayback=false WasManuallyChanged=false	
00000119	9.24458694	[5336] PrepareDockedVideo: Audio	
00000120	9.24518394	[5336] Thread 'PlaybackStarter_Var'has finished 11000	
00000121	9.31667900	[5336] ReadExternalStream: Read = 65536, Offset = 196608, Size = 4997120, Portion = 0.04, File: C:\Users\Oliver Eichler\Music\Schandmaul\Narrenkönig\Schandmaul - Walpurgisnacht.mp3	

[...]

00001255	256.41601563	[5336] UPnP: Control Request: SetTransportStatus: PLAYING	
00001256	256.64187622	[5336] UPnP: OnGetPositionInfoResponse: http://192.168.178.11:55345/ItemID=24338.mp3	
00001257	257.20791626	[5336] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00001258	257.41555786	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00001259	257.41564941	[5336] UPnP: Control Request: SetTransportStatus: STOPPED	
00001260	257.41577148	[5336] Player: Next command started	
00001261	257.41589355	[5336] Player: Next track prepared, going to start playback	
00001262	257.41613770	[5336] PrepareDockedVideo: Switching=true IsStartingPlayback=false WasManuallyChanged=false	
00001263	257.41622925	[5336] BQ: Starting a new task.	
00001264	257.41632080	[5336] BQ: Starting a new thread.	
00001265	257.43368530	[5336] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 0, All: 29	
00001266	257.43832397	[5336] 3472 DB open SQL: SELECT Lyrics, Comment FROM Songs WHERE Songs.ID=? 	
00001267	257.43923950	[5336] Thread 'BackgroundQueue' has started 5444	
00001268	257.70458984	[5336] StretchStart	
00001269	257.70480347	[5336] BQ: Starting a new task.	
00001270	257.70489502	[5336] BQ: Starting a new thread.	
00001271	257.72244263	[5336] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 1, All: 30	
00001272	257.72769165	[5336] Thread 'BackgroundQueue' has started 7840	
00001273	257.72860718	[5336] StretchEnd	
00001274	257.73446655	[5336] BQ: Added new task. Currently 1 tasks in queue.	
00001275	257.73455811	[5336] BQ: There are threads waiting, resume one.	
00001276	257.94674683	[5336] StretchStart	
00001277	257.94787598	[5336] BQ: Added new task. Currently 1 tasks in queue.	
00001278	257.94796753	[5336] BQ: There are threads waiting, resume one.	
00001279	257.94805908	[5336] BQ: Starting a new task.	
00001280	257.94812012	[5336] BQ: Starting a new thread.	
00001281	257.96768188	[5336] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 2, All: 31	
00001282	257.97232056	[5336] BQ: Added new task. Currently 2 tasks in queue.	
00001283	257.97244263	[5336] BQ: There are threads waiting, resume one.	
00001284	257.97250366	[5336] BQ: Starting a new task.	
00001285	257.97259521	[5336] BQ: Added new task. Currently 1 tasks in queue.	
00001286	257.97265625	[5336] BQ: There are threads waiting, resume one.	
00001287	257.97274780	[5336] BQ: Starting a new task.	
00001288	257.97283936	[5336] BQ: Added new task. Currently 1 tasks in queue.	
00001289	257.97293091	[5336] BQ: There are threads waiting, resume one.	
00001290	257.97338867	[5336] Thread 'BackgroundQueue' has started 9740	
00001291	258.27313232	[5336] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00001292	258.53793335	[5336] Winamp simulation window received messsage 12	
00001293	258.53808594	[5336] BQ: Starting a new task.	
00001294	258.54373169	[5336] Winamp simulation window received messsage 14	
00001295	258.54394531	[5336] PrepareDockedVideo: Begin	
00001296	258.54400635	[5336] PrepareDockedVideo: Reduced window or audio	
00001297	258.54415894	[5336] PrepareDockedVideo: End	
00001298	258.56484985	[5336] TGenThread.Create: ThreadName: PlaybackStarter_Var , Running Threads: Internal: 3, All: 33	
00001299	258.57037354	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00001300	258.57049561	[5336] UPnP: Control Request: SetTransportStatus: STOPPED	
00001301	258.57147217	[5336] Player: _Play() procedure entering.	
00001302	258.57546997	[5336] Player: W7 icon updated.	
00001303	258.57556152	[5336] Player: Updating playlist entry.	
00001304	258.57562256	[5336] Player: Track entry prepared, going to start playback.	
00001305	258.57583618	[5336] TRemotePlayer.PlayURI(C:\Users\Oliver Eichler\Music\In Extremo\Weckt Die Toten\In Extremo - Palästinalied.mp3, 23294)	
00001306	258.57604980	[5336] GetNetworkAdapters started	
00001307	258.59869385	[5336] GetNetworkAdapters finished: Count = 1	
00001308	258.59921265	[5336] 7552 DB query prepare finished, took 96.	
00001309	258.59942627	[5336] 7552 DB lock finished, took 234.	
00001310	258.59957886	[5336] GetProtocolInfoFromExt URI: http://192.168.178.11:55345/ItemID=23294.mp3	
00001311	258.59963989	[5336] PLT_MimeType::GetMimeTypeFromExtension: No context !	
00001312	258.59973145	[5336] GetSimpleDIDLForSong DIDL: <DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/"><item id="1" parentID="0" restricted="1"><dc:title>Palästinalied</dc:title><dc:date>1998</dc:date><upnp:artist role="Performer">In Extremo</upnp:artist><upnp:artist role="AlbumArtist">In Extremo</upnp:artist><upnp:album>Weckt Die Toten</upnp:album><upnp:genre></upnp:genre><upnp:albumArtURI dlna:profileID="JPEG_TN">http://192.168.178.11:55345/2944.jpg</upnp:albumArtURI><upnp:originalTrackNumber>7</upnp:originalTrackNumber><res duration="0:05:22.499" size="5251072" bitrate="128000" sampleFrequency="44100" nrAudioChannels="2" protocolInfo="http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01500000000000000000000000000000">http://192.168.178.11:55345/ItemID=23294.mp3</res><upnp:class>object.item.audioItem.musicTrack</upnp:class></item></DIDL-Lite>	
00001313	258.59991455	[5336] TRemotePlayer.InvokeAction(SetAVTransportURI, http://192.168.178.11:55345/ItemID=23294.mp3, )	
00001314	258.64123535	[5336] UPNP Server: File Request: /ItemID=23294.mp3 , Range: < -1, -1>	
00001315	258.64132690	[5336] TMediaServer.Get(ea4381da-eabb-4b55-9061-446a736dd117)	
00001316	258.64141846	[5336] 5372 DB open SQL: SELECT * FROM RemoteClients WHERE MAC = '00-22-61-E7-38-9C'  	
00001317	258.64190674	[5336] 5372 DB lock finished, took 856.	
00001318	258.64221191	[5336] 5372 DB query prepare finished, took 273.	
00001319	258.64239502	[5336] 5372 DB lock finished, took 214.	
00001320	258.64266968	[5336] UPnP Server: Serving file C:\Users\Oliver Eichler\Music\In Extremo\Weckt Die Toten\In Extremo - Palästinalied.mp3, ExternalStream = 1, FileLen = 5251072	
00001321	258.65029907	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=23294.mp3	
00001322	258.65982056	[5336] UPnP: OnSetAVTransportURIResult	
00001323	258.65994263	[5336] TRemotePlayer.InvokeAction(Play, , )	
00001324	258.70083618	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=23294.mp3	
00001325	258.75134277	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=23294.mp3	
00001326	258.80187988	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=23294.mp3	
00001327	258.82775879	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00001328	258.82785034	[5336] UPnP: Control Request: SetTransportStatus: STOPPED	
00001329	258.85244751	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=23294.mp3	
00001330	258.90295410	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=23294.mp3	
00001331	258.91323853	[5336] UPNP Server: File Request: /ItemID=23294.mp3 , Range: < -1, -1>	
00001332	258.91336060	[5336] TMediaServer.Get(ea4381da-eabb-4b55-9061-446a736dd117)	
00001333	258.91345215	[5336] 11200 DB open SQL: SELECT * FROM RemoteClients WHERE MAC = '00-22-61-E7-38-9C'  	
00001334	258.91397095	[5336] 11200 DB lock finished, took 916.	
00001335	258.91427612	[5336] 11200 DB query prepare finished, took 274.	
00001336	258.91445923	[5336] 11200 DB lock finished, took 220.	
00001337	258.91473389	[5336] UPnP Server: Serving file C:\Users\Oliver Eichler\Music\In Extremo\Weckt Die Toten\In Extremo - Palästinalied.mp3, ExternalStream = 1, FileLen = 5251072	
00001338	258.94909668	[5336] UPNP Server: File Request: /ItemID=23294.mp3 , Range: < 0, -1>	
00001339	258.94924927	[5336] TMediaServer.Get(ea4381da-eabb-4b55-9061-446a736dd117)	
00001340	258.94934082	[5336] 1076 DB open SQL: SELECT * FROM RemoteClients WHERE MAC = '00-22-61-E7-38-9C'  	
00001341	258.94982910	[5336] 1076 DB lock finished, took 859.	
00001342	258.95013428	[5336] 1076 DB query prepare finished, took 268.	
00001343	258.95034790	[5336] 1076 DB lock finished, took 209.	
00001344	258.95059204	[5336] UPnP Server: Serving file C:\Users\Oliver Eichler\Music\In Extremo\Weckt Die Toten\In Extremo - Palästinalied.mp3, ExternalStream = 1, FileLen = 5251072	
00001345	258.95101929	[5336] ReadExternalStream: Read = 65536, Offset = 0, Size = 5251072, Portion = 0.00, File: C:\Users\Oliver Eichler\Music\In Extremo\Weckt Die Toten\In Extremo - Palästinalied.mp3	
00001346	258.95349121	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=23294.mp3	
00001347	258.95669556	[5336] ReadExternalStream: Read = 65536, Offset = 131072, Size = 5251072, Portion = 0.02, File: C:\Users\Oliver Eichler\Music\In Extremo\Weckt Die Toten\In Extremo - Palästinalied.mp3	
00001348	259.12393188	[5336] UPnP: OnGetTransportInfoResponse: TRANSITIONING	
00001349	259.12405396	[5336] UPnP: Control Request: SetTransportStatus: TRANSITIONING	
00001350	259.12808228	[5336] ReadExternalStream: Read = 65536, Offset = 196608, Size = 5251072, Portion = 0.04, File: C:\Users\Oliver Eichler\Music\In Extremo\Weckt Die Toten\In Extremo - Palästinalied.mp3	
00001351	259.15560913	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=23294.mp3	
00001352	259.15573120	[5336] Player: Playback started	
00001353	259.15612793	[5336] PrepareDockedVideo: Begin	
00001354	259.15625000	[5336] PrepareDockedVideo: Switching=false IsStartingPlayback=false WasManuallyChanged=false	
00001355	259.15640259	[5336] PrepareDockedVideo: Audio	
00001356	259.15682983	[5336] Thread 'PlaybackStarter_Var'has finished 7552	
00001357	259.17364502	[5336] UpdateSongPictures: C:\Users\Oliver Eichler\Music\In Extremo\Weckt Die Toten\In Extremo - Palästinalied.mp3	
00001358	259.17373657	[5336] GetFileInfo: C:\Users\Oliver Eichler\Music\In Extremo\Weckt Die Toten\In Extremo - Palästinalied.mp3	
00001359	259.17379761	[5336] GetFileInfo: C:\Users\Oliver Eichler\Music\In Extremo\Weckt Die Toten\In Extremo - Palästinalied.mp3	
00001360	259.17401123	[5336] MP3.ReadHeader - File size 5251072	
00001361	259.17413330	[5336] MP3.ReadHeader framestarts: 90948, 90948	
00001362	259.17422485	[5336] MP3.ReadHeader CheckMoreHeaders Endtest: 94020	
00001363	259.17431641	[5336] MP3.ReadHeader finished	
00001364	259.17630005	[5336] Added Covers: 7	
00001365	259.17642212	[5336] 3472 DB prepare SQL: SELECT Songs.* FROM Songs WHERE Songs.IDMedia=? AND Songs.SongPath=?	
00001366	259.17669678	[5336] 3472 DB open SQL: SELECT Songs.* FROM Songs WHERE Songs.IDMedia=? AND Songs.SongPath=? 	
00001367	259.17703247	[5336] GetFileInfo: Found in DB	
00001368	259.17712402	[5336] 3472 DB open SQL: SELECT * FROM Covers WHERE IDSong=23294 ORDER BY CoverOrder 	
00001369	259.17733765	[5336] 3472 DB lock finished, took 362.	
00001370	259.17745972	[5336] Remaining Covers: 7	
00001371	259.17752075	[5336] Added Covers: 9	
00001372	259.24279785	[5336] StretchStart	
00001373	259.24340820	[5336] ReadExternalStream: Read = 65536, Offset = 262144, Size = 5251072, Portion = 0.05, File: C:\Users\Oliver Eichler\Music\In Extremo\Weckt Die Toten\In Extremo - Palästinalied.mp3	
00001374	259.24356079	[5336] BQ: Starting a new task.	
00001375	259.24929810	[5336] StretchEnd	
00001376	259.24951172	[5336] Remaining Covers: 7	
00001377	259.25122070	[5336] Remaining Covers: 6	
00001378	259.37594604	[5336] ReadExternalStream: Read = 65536, Offset = 327680, Size = 5251072, Portion = 0.06, File: C:\Users\Oliver Eichler\Music\In Extremo\Weckt Die Toten\In Extremo - Palästinalied.mp3	
00001379	259.39120483	[5336] UPnP: OnGetTransportInfoResponse: PLAYING	
00001380	259.39132690	[5336] UPnP: Control Request: SetTransportStatus: PLAYING	
00001381	259.43936157	[5336] UPnP: OnGetPositionInfoResponse: http://192.168.178.11:55345/ItemID=23294.mp3	
00001382	259.44992065	[5336] UPnP: Control Request: Waiting...	
00001383	259.62054443	[5336] UPnP: OnGetPositionInfoResponse: http://192.168.178.11:55345/ItemID=23294.mp3	
00001384	260.20809937	[5336] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00001385	260.41720581	[5336] UPnP: OnGetTransportInfoResponse: PLAYING	
00001386	260.41732788	[5336] UPnP: Control Request: SetTransportStatus: PLAYING	
00001387	260.64093018	[5336] UPnP: OnGetPositionInfoResponse: http://192.168.178.11:55345/ItemID=23294.mp3	
00001388	261.09954834	[5336] Going 'BackgroundQueue'to make final callback 7840	
00001389	261.20971680	[5336] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00001390	261.41598511	[5336] UPnP: OnGetTransportInfoResponse: PLAYING	
00001391	261.41607666	[5336] UPnP: Control Request: SetTransportStatus: PLAYING	
00001392	261.53833008	[5336] Going 'BackgroundQueue'to make final callback 5444	
00001393	261.53851318	[5336] Thread 'BackgroundQueue'has finished 5444	
00001394	261.64086914	[5336] UPnP: OnGetPositionInfoResponse: http://192.168.178.11:55345/ItemID=23294.mp3	
00001395	262.07296753	[5336] ReadExternalStream: Read = 65536, Offset = 393216, Size = 5251072, Portion = 0.07, File: C:\Users\Oliver Eichler\Music\In Extremo\Weckt Die Toten\In Extremo - Palästinalied.mp3	
00001396	262.21041870	[5336] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00001397	262.24932861	[5336] Going 'BackgroundQueue'to make final callback 9740	
00001398	262.41735840	[5336] UPnP: OnGetTransportInfoResponse: PLAYING	
00001399	262.41748047	[5336] UPnP: Control Request: SetTransportStatus: PLAYING	
00001400	262.64465332	[5336] UPnP: OnGetPositionInfoResponse: http://192.168.178.11:55345/ItemID=23294.mp3	
00001401	263.20840454	[5336] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00001402	263.41738892	[5336] UPnP: OnGetTransportInfoResponse: PLAYING	
00001403	263.41744995	[5336] UPnP: Control Request: SetTransportStatus: PLAYING

[...]

	
00004688	1026.02697754	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00004689	1026.02709961	[5336] UPnP: Control Request: SetTransportStatus: STOPPED	
00004690	1026.02722168	[5336] Player: Next command started	
00004691	1026.02734375	[5336] Player: Next track prepared, going to start playback	
00004692	1026.02758789	[5336] PrepareDockedVideo: Switching=true IsStartingPlayback=false WasManuallyChanged=false	
00004693	1026.02770996	[5336] Remaining Covers: 4	
00004694	1026.02783203	[5336] BQ: Added new task. Currently 1 tasks in queue.	
00004695	1026.02783203	[5336] BQ: Currently running 0 threads of 8	
00004696	1026.04272461	[5336] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 0, All: 28	
00004697	1026.04785156	[5336] 3472 DB open SQL: SELECT Lyrics, Comment FROM Songs WHERE Songs.ID=? 	
00004698	1026.04870605	[5336] Thread 'BackgroundQueue' has started 7644	
00004699	1026.04895020	[5336] Added Cover Lists: 2	
00004700	1026.04907227	[5336] GetFileInfo: readPictures=spAlways	
00004701	1026.04919434	[5336] MP3.ReadHeader C:\Users\Oliver Eichler\Music\Schandmaul\Narrenkönig\Schandmaul - Vogelfrei.mp3	
00004702	1026.04931641	[5336] MP3.ReadHeader - Found ID3v2, length: 46427	
00004703	1026.04943848	[5336] MP3.ReadHeader CheckMoreHeaders started	
00004704	1026.04943848	[5336] MP3.ReadHeader CheckMoreHeaders finished	
00004705	1026.04956055	[5336] MP3: Going to read tag from C:\Users\Oliver Eichler\Music\Schandmaul\Narrenkönig\Schandmaul - Vogelfrei.mp3	
00004706	1026.05187988	[5336] MP3: Tag read from C:\Users\Oliver Eichler\Music\Schandmaul\Narrenkönig\Schandmaul - Vogelfrei.mp3	
00004707	1026.05212402	[5336] 7644 DB query prepare finished, took 365.	
00004708	1026.05236816	[5336] 7644 DB lock finished, took 237.	
00004709	1026.05249023	[5336] UpdateSongPictures: CoverList.LoadForSongId, C:\Users\Oliver Eichler\Music\Schandmaul\Narrenkönig\Schandmaul - Vogelfrei.mp3	
00004710	1026.05261230	[5336] OpenQuery - Preparing query SELECT * FROM Covers WHERE IDSong=24336 ORDER BY CoverOrder 	
00004711	1026.05285645	[5336] Added Covers: 6	
00004712	1026.05297852	[5336] Added Covers: 6	
00004713	1026.18725586	[5336] StretchStart	
00004714	1026.18750000	[5336] BQ: Starting a new task.	
00004715	1026.18762207	[5336] BQ: Starting a new thread.	
00004716	1026.20263672	[5336] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 1, All: 29	
00004717	1026.20837402	[5336] Thread 'BackgroundQueue' has started 8536	
00004718	1026.20922852	[5336] StretchEnd	
00004719	1026.21276855	[5336] Remaining Covers: 6	
00004720	1026.21289063	[5336] BQ: Starting a new task.	
00004721	1026.45544434	[5336] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 2, All: 30	
00004722	1026.46032715	[5336] BQ: Added new task. Currently 2 tasks in queue.	
00004723	1026.46044922	[5336] BQ: There are threads waiting, resume one.	
00004724	1026.46057129	[5336] BQ: Starting a new task.	
00004725	1026.46057129	[5336] BQ: Added new task. Currently 1 tasks in queue.	
00004726	1026.46069336	[5336] BQ: There are threads waiting, resume one.	
00004727	1026.46069336	[5336] BQ: Starting a new task.	
00004728	1026.46081543	[5336] BQ: Added new task. Currently 1 tasks in queue.	
00004729	1026.46093750	[5336] BQ: There are threads waiting, resume one.	
00004730	1026.46179199	[5336] Thread 'BackgroundQueue' has started 8048	
00004731	1026.87353516	[5336] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00004732	1027.92541504	[5336] Winamp simulation window received messsage 12	
00004733	1027.92553711	[5336] BQ: Starting a new task.	
00004734	1027.93066406	[5336] Winamp simulation window received messsage 14	
00004735	1027.93090820	[5336] PrepareDockedVideo: Begin	
00004736	1027.93090820	[5336] PrepareDockedVideo: Reduced window or audio	
00004737	1027.93103027	[5336] PrepareDockedVideo: End	
00004738	1027.95361328	[5336] TGenThread.Create: ThreadName: PlaybackStarter_Var , Running Threads: Internal: 3, All: 33	
00004739	1027.95837402	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00004740	1027.95837402	[5336] UPnP: Control Request: SetTransportStatus: STOPPED	
00004741	1027.95971680	[5336] Player: _Play() procedure entering.	
00004742	1027.96398926	[5336] Player: W7 icon updated.	
00004743	1027.96411133	[5336] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00004744	1027.96423340	[5336] Player: Setting current track: C:\Users\Oliver Eichler\Music\Schandmaul\Narrenkönig\Schandmaul - Vogelfrei.mp3	
00004745	1027.96435547	[5336] Player: Song is not cached, try to play the original file	
00004746	1027.96459961	[5336] UPnP: Get IP Addresses	
00004747	1027.98742676	[5336] GetNetworkAdapters finished: Count = 1	
00004748	1027.98791504	[5336] 2044 DB query prepare finished, took 97.	
00004749	1027.98803711	[5336] 2044 DB lock finished, took 222.	
00004750	1027.98815918	[5336] GetProtocolInfoFromExt URI: http://192.168.178.11:55345/ItemID=24336.mp3	
00004751	1027.98828125	[5336] PLT_MimeType::GetMimeTypeFromExtension: No context !	
00004752	1027.98840332	[5336] GetSimpleDIDLForSong DIDL: <DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/"><item id="1" parentID="0" restricted="1"><dc:title>Vogelfrei</dc:title><dc:date>2002-10-07</dc:date><upnp:artist role="Performer">Schandmaul</upnp:artist><upnp:artist role="AlbumArtist">Schandmaul</upnp:artist><upnp:album>Narrenkönig</upnp:album><upnp:genre></upnp:genre><upnp:albumArtURI dlna:profileID="JPEG_TN">http://192.168.178.11:55345/3076.jpg</upnp:albumArtURI><upnp:originalTrackNumber>9</upnp:originalTrackNumber><res duration="0:05:06.202" size="6170624" bitrate="160000" sampleFrequency="44100" nrAudioChannels="2" protocolInfo="http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01500000000000000000000000000000">http://192.168.178.11:55345/ItemID=24336.mp3</res><upnp:class>object.item.audioItem.musicTrack</upnp:class></item></DIDL-Lite>	
00004753	1027.98852539	[5336] TRemotePlayer.InvokeAction(SetAVTransportURI, http://192.168.178.11:55345/ItemID=24336.mp3, )	
00004754	1028.03442383	[5336] UPNP Server: File Request: /ItemID=24336.mp3 , Range: < -1, -1>	
00004755	1028.03454590	[5336] TMediaServer.Get(ea4381da-eabb-4b55-9061-446a736dd117)	
00004756	1028.03454590	[5336] PostponeComputerSleep: Enabled = 1	
00004757	1028.03466797	[5336] OpenQuery - Preparing query SELECT * FROM RemoteClients WHERE MAC = '00-22-61-E7-38-9C'  	
00004758	1028.03527832	[5336] 9940 DB prepare SQL: SELECT * FROM Songs WHERE Songs.ID=?	
00004759	1028.03552246	[5336] 9940 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 	
00004760	1028.03588867	[5336] _BrowseRequest finished	
00004761	1028.03601074	[5336] UPnP Server: Creating HTTP entity	
00004762	1028.03881836	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=24336.mp3	
00004763	1028.05358887	[5336] UPnP: OnSetAVTransportURIResult	
00004764	1028.05371094	[5336] TRemotePlayer.InvokeAction(Play, , )	
00004765	1028.08947754	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=24336.mp3	
00004766	1028.14001465	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=24336.mp3	
00004767	1028.16796875	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00004768	1028.16796875	[5336] UPnP: Control Request: SetTransportStatus: STOPPED	
00004769	1028.19055176	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=24336.mp3	
00004770	1028.24108887	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=24336.mp3	
00004771	1028.29162598	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=24336.mp3	
00004772	1028.30627441	[5336] UPNP Server: File Request: /ItemID=24336.mp3 , Range: < -1, -1>	
00004773	1028.30627441	[5336] TMediaServer.Get(ea4381da-eabb-4b55-9061-446a736dd117)	
00004774	1028.30639648	[5336] 4556 DB open SQL: SELECT * FROM RemoteClients WHERE MAC = '00-22-61-E7-38-9C'  	
00004775	1028.30688477	[5336] 4556 DB lock finished, took 902.	
00004776	1028.30725098	[5336] 4556 DB query prepare finished, took 298.	
00004777	1028.30737305	[5336] 4556 DB lock finished, took 212.	
00004778	1028.30761719	[5336] UPnP Server: Serving file C:\Users\Oliver Eichler\Music\Schandmaul\Narrenkönig\Schandmaul - Vogelfrei.mp3, ExternalStream = 1, FileLen = 6170624	
00004779	1028.54431152	[5336] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:55345/ItemID=24336.mp3	
00004780	1028.54443359	[5336] Player: Playback started	
00004781	1028.54479980	[5336] DB: Deleting prepared query: SELECT NULL FROM Covers WHERE Covers.IDSong = ? 	
00004782	1028.54492188	[5336] PrepareDockedVideo: Switching=false IsStartingPlayback=false WasManuallyChanged=false	
00004783	1028.54504395	[5336] PrepareDockedVideo: Audio	
00004784	1028.54577637	[5336] ReadExternalStream: Read = 65536, Offset = 196608, Size = 6170624, Portion = 0.03, File: C:\Users\Oliver Eichler\Music\Schandmaul\Narrenkönig\Schandmaul - Vogelfrei.mp3	
00004785	1028.55151367	[5336] UpdateSongPictures: C:\Users\Oliver Eichler\Music\Schandmaul\Narrenkönig\Schandmaul - Vogelfrei.mp3	
00004786	1028.55163574	[5336] GetFileInfo: C:\Users\Oliver Eichler\Music\Schandmaul\Narrenkönig\Schandmaul - Vogelfrei.mp3	
00004787	1028.55163574	[5336] GetFileInfo: C:\Users\Oliver Eichler\Music\Schandmaul\Narrenkönig\Schandmaul - Vogelfrei.mp3	
00004788	1028.55187988	[5336] MP3.ReadHeader - File size 6170624	
00004789	1028.55200195	[5336] MP3.ReadHeader framestarts: 46437, 46437	
00004790	1028.55212402	[5336] MP3.ReadHeader CheckMoreHeaders Endtest: 49509	
00004791	1028.55224609	[5336] MP3.ReadHeader finished	
00004792	1028.55444336	[5336] Added Covers: 7	
00004793	1028.55456543	[5336] 3472 DB open SQL: SELECT Songs.* FROM Songs WHERE Songs.IDMedia=? AND Songs.SongPath=? 	
00004794	1028.55493164	[5336] GetFileInfo: Found in DB	
00004795	1028.55493164	[5336] 3472 DB open SQL: SELECT * FROM Covers WHERE IDSong=24336 ORDER BY CoverOrder 	
00004796	1028.55517578	[5336] 3472 DB lock finished, took 386.	
00004797	1028.55529785	[5336] Remaining Covers: 7	
00004798	1028.55541992	[5336] Added Covers: 9	
00004799	1028.61340332	[5336] ReadExternalStream: Read = 65536, Offset = 262144, Size = 6170624, Portion = 0.04, File: C:\Users\Oliver Eichler\Music\Schandmaul\Narrenkönig\Schandmaul - Vogelfrei.mp3	
00004800	1028.63049316	[5336] StretchStart	
00004801	1028.63085938	[5336] BQ: Added new task. Currently 1 tasks in queue.	
00004802	1028.63098145	[5336] BQ: There are threads waiting, resume one.	
00004803	1028.63354492	[5336] Remaining Covers: 8	
00004804	1028.63366699	[5336] Remaining Cover Lists: 2	
00004805	1028.73437500	[5336] UPnP: OnGetTransportInfoResponse: PLAYING	
00004806	1028.73449707	[5336] UPnP: Control Request: SetTransportStatus: PLAYING	
00004807	1028.78430176	[5336] UPnP: OnGetPositionInfoResponse: http://192.168.178.11:55345/ItemID=24336.mp3	
00004808	1028.79443359	[5336] UPnP: Control Request: Waiting...	
00004809	1028.97485352	[5336] UPnP: OnGetPositionInfoResponse: http://192.168.178.11:55345/ItemID=24336.mp3	
00004810	1029.02807617	[5336] UPnP: OnGetTransportInfoResponse: PLAYING	
00004811	1029.03869629	[5336] UPnP: Control Request: Waiting...	
00004812	1029.03869629	[5336] UPnP: Control Request: SetTransportStatus: PLAYING	
00004813	1029.25537109	[5336] UPnP: OnGetPositionInfoResponse: http://192.168.178.11:55345/ItemID=24336.mp3	
00004814	1029.52050781	[5336] Going 'BackgroundQueue'to make final callback 8536	
00004815	1030.02673340	[5336] UPnP: OnGetTransportInfoResponse: PLAYING	
00004816	1030.02685547	[5336] UPnP: Control Request: SetTransportStatus: PLAYING	
00004817	1030.25329590	[5336] UPnP: OnGetPositionInfoResponse: http://192.168.178.11:55345/ItemID=24336.mp3	
00004818	1030.92541504	[5336] Going 'BackgroundQueue'to make final callback 7644	
00004819	1030.92553711	[5336] Thread 'BackgroundQueue'has finished 7644	
00004820	1031.02807617	[5336] UPnP: OnGetTransportInfoResponse: PLAYING	
00004821	1031.02819824	[5336] UPnP: Control Request: SetTransportStatus: PLAYING	
00004822	1031.25439453	[5336] UPnP: OnGetPositionInfoResponse: http://192.168.178.11:55345/ItemID=24336.mp3	
00004823	1031.63342285	[5336] Going 'BackgroundQueue'to make final callback 8048	
00004824	1031.91638184	[5336] ReadExternalStream: Read = 65536, Offset = 393216, Size = 6170624, Portion = 0.06, File: C:\Users\Oliver Eichler\Music\Schandmaul\Narrenkönig\Schandmaul - Vogelfrei.mp3	
00004825	1032.02673340	[5336] UPnP: OnGetTransportInfoResponse: PLAYING	
00004826	1032.02685547	[5336] UPnP: Control Request: SetTransportStatus: PLAYING	
00004827	1032.23522949	[5336] UPnP: OnGetPositionInfoResponse: http://192.168.178.11:55345/ItemID=24336.mp3
[...]
00005926	1334.03540039	[5336] UPnP: Control Request: SetTransportStatus: PLAYING	
00005927	1334.25964355	[5336] UPnP: OnGetPositionInfoResponse: http://192.168.178.11:55345/ItemID=24336.mp3	
00005928	1334.81970215	[5336] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00005929	1335.03686523	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00005930	1335.03698730	[5336] UPnP: Control Request: SetTransportStatus: STOPPED	
00005931	1335.03710938	[5336] Player: Next command started	
00005932	1335.03723145	[5336] PrepareDockedVideo: Switching=false IsStartingPlayback=false WasManuallyChanged=false	
00005933	1335.03735352	[5336] PrepareDockedVideo: Audio	
00005934	1336.03674316	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00005935	1336.03674316	[5336] UPnP: Control Request: SetTransportStatus: STOPPED
[...]	
00005948	1343.03857422	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00005949	1343.03881836	[5336] UPnP: Control Request: SetTransportStatus: STOPPED	
00005950	1343.14660645	[2592] base\appmodel\execmodel\modern\lifetimemanager\suspendresume.cpp(4263)\modernexecserver.dll!00007FFBFDDC102A: (caller: 00007FFBFDDA78E3) ReturnHr[PreRelease](144) tid(24cc) 8000000D Eine unzulässige Statusänderung wurde angefordert. 	
00005951	1344.03588867	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00005952	1344.03613281	[5336] UPnP: Control Request: SetTransportStatus: STOPPED	
[...]	
00005959	1348.03503418	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00005960	1348.03527832	[5336] UPnP: Control Request: SetTransportStatus: STOPPED	
00005961	1348.22595215	[5336] TGenThread.Create: ThreadName: UpdateDriveLetters_Var , Running Threads: Internal: 0, All: 26	
00005962	1348.23156738	[5336] Thread 'UpdateDriveLetters_Var' has started 6424	
00005963	1348.23498535	[5336] >UpdateDriveLetters - end<	
00005964	1348.23510742	[5336] Thread 'UpdateDriveLetters_Var'has finished 6424	
00005965	1349.03503418	[5336] UPnP: OnGetTransportInfoResponse: STOPPED	
00005966	1349.03527832	[5336] UPnP: Control Request: SetTransportStatus: STOPPED	
[...]
I condensed this log to 3 mp3 files. The original log contains 5 files. I've cut out many lines which seemed to be obsolete to the problem.

I played 5 files. File #1, #3 and #5 have "full" information about the release date of the album ("DD.MM.YYYY"). Song #2 and #4 have only the year of release ("YYYY"). For #1, #3 and #5 all file information is correctly transmitted and displayed on my renderer. #2 and #4 lead only to displaying the already mentioned network path. I found some command lines where it says "found ID3v2". This line only shows up for files #1, #3 and #5 and can be found in line 00000046, 00002860 and 00004702. Maybe this helps to find a solution?

Hobbit
Posts: 6
Joined: Wed Nov 18, 2015 4:39 am

Re: renderer: 1) no file information 2) not playing other fi

Post by Hobbit » Tue Feb 09, 2016 4:00 am

Two weeks have passed since I had drawn a ticket for my issue. I'm wondering whether I could expect an answer to my little problem by that time?

I'd be very happy if someone could help me. :)
Here's my bug report ticket.

Hobbit
Posts: 6
Joined: Wed Nov 18, 2015 4:39 am

Re: renderer: 1) no file information 2) not playing other fi

Post by Hobbit » Wed Mar 02, 2016 5:42 am

I still have no clue why changing the release date from YYYY to DD.MM.YYYY can solve my issue and why that could be the solution.
I found out that many settings are saved in the MediaMonkey.ini file. Maybe, can I manipulate the file in such a way that "date" is checked just for the year ("YYYY") and not for the exact date or something like that in order to have no "confilcts" when playing the file to my renderer? Could anyone tell me how this can be done?


Cheers!

Hobbit
Posts: 6
Joined: Wed Nov 18, 2015 4:39 am

Re: renderer: 1) no file information 2) not playing other fi

Post by Hobbit » Sat Mar 26, 2016 6:03 am

It is me again! :) Still, I have no solution to my issue of tags like "artist" or "track title" being not transferred to my renderers (as I said it actually works if I enter some exact date and not the release year only). I have extracted probably important parts of the log of playing two mp3 files: one being tagged with release YEAR only, the other being tagged with the exact DATE of release. Obviously, there are differences in processing the information given by the files but I have absolutely no idea what it means.
Here's the log of a mp3 file being tagged with the year of release only:

Code: Select all

00001570	170.21682739	[5148] Player: Next command started	
00001571	170.21691895	[5148] Player: Setting current track: C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Alan Parsons Project - Sirius.mp3	
00001572	170.21699524	[5148] Player: Next track prepared, going to start playback	
00001573	170.21745300	[5148] PrepareDockedVideo: Begin	
00001574	170.21755981	[5148] PrepareDockedVideo: Switching=true IsStartingPlayback=false WasManuallyChanged=false	
00001575	170.21769714	[5148] BQ: Added new task. Currently 1 tasks in queue.	
00001576	170.21775818	[5148] BQ: Starting a new task.	
00001577	170.21788025	[5148] BQ: Currently running 0 threads of 8	
00001578	170.21795654	[5148] BQ: Starting a new thread.	
00001579	170.24240112	[5148] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 0, All: 27	
00001580	170.24900818	[5148] 2212 DB open SQL: SELECT Lyrics, Comment FROM Songs WHERE Songs.ID=? 	
00001581	170.24931335	[5148] 2212 DB lock finished, took 433.	
00001582	170.25019836	[5148] Thread 'BackgroundQueue' has started 1724	
00001583	170.27160645	[5148] UpdateSongPictures: C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Alan Parsons Project - Sirius.mp3	
00001584	170.27168274	[5148] Added Cover Lists: 2	
00001585	170.27172852	[5148] GetFileInfo: C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Alan Parsons Project - Sirius.mp3	
00001586	170.27175903	[5148] GetFileInfo: readPictures=spAlways	
00001587	170.27182007	[5148] GetFileInfo: C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Alan Parsons Project - Sirius.mp3	
00001588	170.27200317	[5148] MP3.ReadHeader C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Alan Parsons Project - Sirius.mp3	
00001589	170.27207947	[5148] MP3.ReadHeader - File size 4722688	
00001590	170.27215576	[5148] MP3.ReadHeader - Found ID3v2, length: 23645	
00001591	170.27258301	[5148] MP3.ReadHeader framestarts: 23655, 23655	
00001592	170.27267456	[5148] MP3.ReadHeader finished	
00001593	170.27275085	[5148] MP3: Going to read tag from C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Alan Parsons Project - Sirius.mp3	
00001594	170.27421570	[5148] Added Covers: 2	
00001595	170.27427673	[5148] MP3: Tag read from C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Alan Parsons Project - Sirius.mp3	
00001596	170.27433777	[5148] 1724 DB prepare SQL: SELECT Songs.* FROM Songs WHERE Songs.IDMedia=? AND Songs.SongPath=?	
00001597	170.27456665	[5148] 1724 DB query prepare finished, took 357.	
00001598	170.27461243	[5148] 1724 DB open SQL: SELECT Songs.* FROM Songs WHERE Songs.IDMedia=? AND Songs.SongPath=? 	
00001599	170.27478027	[5148] 1724 DB lock finished, took 287.	
00001600	170.27494812	[5148] GetFileInfo: Found in DB	
00001601	170.27499390	[5148] UpdateSongPictures: CoverList.LoadForSongId, C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Alan Parsons Project - Sirius.mp3	
00001602	170.27503967	[5148] 1724 DB open SQL: SELECT * FROM Covers WHERE IDSong=472 ORDER BY CoverOrder 	
00001603	170.27508545	[5148] OpenQuery - Preparing query SELECT * FROM Covers WHERE IDSong=472 ORDER BY CoverOrder 	
00001604	170.27526855	[5148] 1724 DB lock finished, took 369.	
00001605	170.27529907	[5148] Added Covers: 3	
00001606	170.27536011	[5148] Remaining Covers: 2	
00001607	170.33128357	[5148] StretchStart	
00001608	170.33212280	[5148] BQ: Added new task. Currently 1 tasks in queue.	
00001609	170.33213806	[5148] BQ: Starting a new task.	
00001610	170.33219910	[5148] BQ: Currently running 1 threads of 8	
00001611	170.33219910	[5148] BQ: Starting a new thread.	
00001612	170.34417725	[5148] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 1, All: 28	
00001613	170.34835815	[5148] BQ: Added new task. Currently 2 tasks in queue.	
00001614	170.34838867	[5148] BQ: Starting a new task.	
00001615	170.34843445	[5148] BQ: Currently running 2 threads of 8	
00001616	170.34848022	[5148] BQ: Starting a new thread.	
00001617	170.34927368	[5148] Thread 'BackgroundQueue' has started 3256	
00001618	170.36033630	[5148] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 1, All: 29	
00001619	170.36441040	[5148] BQ: Added new task. Currently 3 tasks in queue.	
00001620	170.36445618	[5148] BQ: Starting a new task.	
00001621	170.36451721	[5148] BQ: Currently running 3 threads of 8	
00001622	170.36453247	[5148] BQ: Starting a new thread.	
00001623	170.36532593	[5148] Thread 'BackgroundQueue' has started 4996	
00001624	170.37796021	[5148] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 2, All: 30	
00001625	170.38217163	[5148] BQ: Added new task. Currently 3 tasks in queue.	
00001626	170.38223267	[5148] BQ: Starting a new task.	
00001627	170.38227844	[5148] BQ: There are threads waiting, resume one.	
00001628	170.38235474	[5148] StretchEnd	
00001629	170.38308716	[5148] Thread 'BackgroundQueue' has started 7308	
00001630	170.38880920	[5148] BQ: Added new task. Currently 1 tasks in queue.	
00001631	170.38885498	[5148] BQ: Starting a new task.	
00001632	170.38890076	[5148] BQ: There are threads waiting, resume one.	
00001633	170.41978455	[5148] StretchStart	
00001634	170.42062378	[5148] BQ: Added new task. Currently 1 tasks in queue.	
00001635	170.42066956	[5148] BQ: Starting a new task.	
00001636	170.42070007	[5148] BQ: There are threads waiting, resume one.	
00001637	170.42073059	[5148] BQ: Added new task. Currently 2 tasks in queue.	
00001638	170.42077637	[5148] BQ: Starting a new task.	
00001639	170.42080688	[5148] BQ: There are threads waiting, resume one.	
00001640	170.42085266	[5148] BQ: Added new task. Currently 2 tasks in queue.	
00001641	170.42088318	[5148] BQ: Starting a new task.	
00001642	170.42092896	[5148] BQ: There are threads waiting, resume one.	
00001643	170.42094421	[5148] BQ: Added new task. Currently 2 tasks in queue.	
00001644	170.42098999	[5148] BQ: Starting a new task.	
00001645	170.42103577	[5148] BQ: Currently running 4 threads of 8	
00001646	170.42109680	[5148] BQ: Starting a new thread.	
00001647	170.43431091	[5148] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 4, All: 31	
00001648	170.43847656	[5148] StretchEnd	
00001649	170.43936157	[5148] Thread 'BackgroundQueue' has started 4768	
00001650	170.47734070	[5148] Winamp simulation window received messsage 12	
00001651	170.47741699	[5148] BQ: Added new task. Currently 1 tasks in queue.	
00001652	170.47746277	[5148] BQ: Starting a new task.	
00001653	170.47749329	[5148] BQ: There are threads waiting, resume one.	
00001654	170.54656982	[5148] Winamp simulation window received messsage 14	
00001655	170.57075500	[5148] Winamp simulation window received messsage 49662	
00001656	170.59120178	[5148] PrepareDockedVideo: Begin	
00001657	170.61155701	[5148] PrepareDockedVideo: Switching=false IsStartingPlayback=false WasManuallyChanged=false	
00001658	170.63180542	[5148] PrepareDockedVideo: Reduced window or audio	
00001659	170.65208435	[5148] PrepareDockedVideo: Audio	
00001660	170.67564392	[5148] PrepareDockedVideo: End	
00001661	170.69580078	[5148] TGenThread.Create: ThreadName: PlaybackStarter_Var , Running Threads: Internal: 5, All: 32	
00001662	170.71559143	[5148] Thread 'PlaybackStarter_Var' has started 1856	
00001663	170.73872375	[5148] Player: _Play() procedure entering.	
00001664	170.74928284	[5148] Player: W7 icon updated.	
00001665	170.77653503	[5148] Player: Going to handle the current track.	
00001666	170.79742432	[5148] Player: Updating playlist entry.	
00001667	170.82723999	[5148] Player: Setting current track: C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Alan Parsons Project - Sirius.mp3	
00001668	170.82733154	[5148] Player: Track entry prepared, going to start playback.	
00001669	170.82746887	[5148] Player: Song is not cached, try to play the original file	
00001670	170.82768250	[5148] TRemotePlayer.PlayURI(C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Alan Parsons Project - Sirius.mp3, 472)	
00001671	170.82777405	[5148] UPnP: Get IP Addresses	
00001672	170.82797241	[5148] GetNetworkAdapters started	
00001673	170.88014221	[5148] GetNetworkAdapters finished: Count = 1	
00001674	170.88058472	[5148] 1856 DB prepare SQL: SELECT NULL FROM Covers WHERE Covers.IDSong = ?	
00001675	170.88069153	[5148] 1856 DB query prepare finished, took 120.	
00001676	170.88075256	[5148] 1856 DB open SQL: SELECT NULL FROM Covers WHERE Covers.IDSong = ? 	
00001677	170.88090515	[5148] 1856 DB lock finished, took 225.	
00001678	170.88096619	[5148] TRemotePlayer.PlayURI: Generated our URI:http://192.168.178.11:63038/ItemID=472.mp3	
00001679	170.88107300	[5148] GetProtocolInfoFromExt URI: http://192.168.178.11:63038/ItemID=472.mp3	
00001680	170.88110352	[5148] UPnP: GetProtocolInfo	
00001681	170.88111877	[5148] PLT_MimeType::GetMimeTypeFromExtension: No context !	
00001682	170.88117981	[5148] PLT_MimeType::GetMimeTypeFromExtension: No context !	
00001683	170.88122559	[5148] GetSimpleDIDLForSong DIDL: <DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/"><item id="1" parentID="0" restricted="1"><dc:title>Sirius</dc:title><dc:date>1982</dc:date><upnp:artist role="Performer">Alan Parsons Project</upnp:artist><upnp:artist role="AlbumArtist">Alan Parsons Project</upnp:artist><upnp:album>Eye In The Sky</upnp:album><upnp:genre></upnp:genre><upnp:albumArtURI dlna:profileID="JPEG_TN">http://192.168.178.11:63038/75.jpg</upnp:albumArtURI><upnp:originalTrackNumber>1</upnp:originalTrackNumber><res duration="0:01:57.472" size="4722688" bitrate="320000" sampleFrequency="44100" nrAudioChannels="2" protocolInfo="http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01500000000000000000000000000000">http://192.168.178.11:63038/ItemID=472.mp3</res><upnp:class>object.item.audioItem.musicTrack</upnp:class></item></DIDL-Lite>	
00001684	170.88125610	[5148] TRemotePlayer.InvokeAction(Stop, , )	
00001685	170.88139343	[5148] TRemotePlayer.InvokeAction(SetAVTransportURI, http://192.168.178.11:63038/ItemID=472.mp3, )	
00001686	170.88154602	[5148] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00001687	170.92462158	[5148] UPNP Server: File Request: /ItemID=472.mp3 , Range: < -1, -1>	
00001688	170.92472839	[5148] _BrowseRequest started	
00001689	170.92485046	[5148] TMediaServer.Get(ced1b8fd-46cb-4c32-b8f6-981be0563840)	
00001690	170.92494202	[5148] TMediaServer.Get(ced1b8fd-46cb-4c32-b8f6-981be0563840): found: Musik Vostro3560 MMW	
00001691	170.92503357	[5148] PostponeComputerSleep: Enabled = 1	
00001692	170.92518616	[5148] 6864 DB open SQL: SELECT * FROM RemoteClients WHERE MAC = '00-22-61-E7-38-9C'  	
00001693	170.92529297	[5148] OpenQuery - Preparing query SELECT * FROM RemoteClients WHERE MAC = '00-22-61-E7-38-9C'  	
00001694	170.92573547	[5148] 6864 DB lock finished, took 902.	
00001695	170.92588806	[5148] 6864 DB prepare SQL: SELECT * FROM Songs WHERE Songs.ID=?	
00001696	170.92633057	[5148] 6864 DB query prepare finished, took 676.	
00001697	170.92643738	[5148] 6864 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 	
00001698	170.92674255	[5148] 6864 DB lock finished, took 407.	
00001699	170.92732239	[5148] _BrowseRequest finished	
00001700	170.92739868	[5148] UPnP Server: Serving file C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Alan Parsons Project - Sirius.mp3, ExternalStream = 1, FileLen = 4722688	
00001701	170.92762756	[5148] UPnP Server: Creating HTTP entity	
00001702	170.93235779	[5148] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:63038/ItemID=472.mp3	
00001703	170.94462585	[5148] UPnP: OnSetAVTransportURIResult	
00001704	170.94474792	[5148] UPnP: Control Request -> Action: SetAVTransportURIResponse	
00001705	170.94483948	[5148] TRemotePlayer.InvokeAction(Play, , )	
00001706	170.98274231	[5148] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:63038/ItemID=472.mp3	
00001707	171.06222534	[5148] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:63038/ItemID=472.mp3	
00001708	171.11927795	[5148] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:63038/ItemID=472.mp3	
00001709	171.14015198	[5148] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00001710	171.16084290	[5148] UPnP: OnGetTransportInfoResponse: STOPPED	
00001711	171.18218994	[5148] UPnP: Control Request -> Action: TransportInfoResponse	
00001712	171.20336914	[5148] UPnP: Control Request: SetTransportStatus: STOPPED	
00001713	171.22421265	[5148] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:63038/ItemID=472.mp3	
00001714	171.24501038	[5148] UPNP Server: File Request: /ItemID=472.mp3 , Range: < -1, -1>	
00001715	171.26544189	[5148] _BrowseRequest started	
00001716	171.28564453	[5148] TMediaServer.Get(ced1b8fd-46cb-4c32-b8f6-981be0563840)	
00001717	171.31518555	[5148] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:63038/ItemID=472.mp3	
00001718	171.31524658	[5148] TMediaServer.Get(ced1b8fd-46cb-4c32-b8f6-981be0563840): found: Musik Vostro3560 MMW	
00001719	171.31532288	[5148] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00001720	171.31538391	[5148] 7396 DB open SQL: SELECT * FROM RemoteClients WHERE MAC = '00-22-61-E7-38-9C'  	
00001721	171.31546021	[5148] OpenQuery - Preparing query SELECT * FROM RemoteClients WHERE MAC = '00-22-61-E7-38-9C'  	
00001722	171.31576538	[5148] 7396 DB lock finished, took 654.	
00001723	171.31587219	[5148] 7396 DB prepare SQL: SELECT * FROM Songs WHERE Songs.ID=?	
00001724	171.31610107	[5148] 7396 DB query prepare finished, took 408.	
00001725	171.31616211	[5148] 7396 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 	
00001726	171.31632996	[5148] 7396 DB lock finished, took 235.	
00001727	171.31665039	[5148] _BrowseRequest finished	
00001728	171.31669617	[5148] UPnP Server: Serving file C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Alan Parsons Project - Sirius.mp3, ExternalStream = 1, FileLen = 4722688	
00001729	171.31678772	[5148] UPnP Server: Creating HTTP entity	
00001730	171.35131836	[5148] UPNP Server: File Request: /ItemID=472.mp3 , Range: < 0, -1>	
00001731	171.35142517	[5148] _BrowseRequest started	
00001732	171.35151672	[5148] TMediaServer.Get(ced1b8fd-46cb-4c32-b8f6-981be0563840)	
00001733	171.35157776	[5148] TMediaServer.Get(ced1b8fd-46cb-4c32-b8f6-981be0563840): found: Musik Vostro3560 MMW	
00001734	171.35168457	[5148] 1924 DB open SQL: SELECT * FROM RemoteClients WHERE MAC = '00-22-61-E7-38-9C'  	
00001735	171.35176086	[5148] OpenQuery - Preparing query SELECT * FROM RemoteClients WHERE MAC = '00-22-61-E7-38-9C'  	
00001736	171.35218811	[5148] 1924 DB lock finished, took 850.	
00001737	171.35234070	[5148] 1924 DB prepare SQL: SELECT * FROM Songs WHERE Songs.ID=?	
00001738	171.35263062	[5148] UPnP: OnGetTransportInfoResponse: TRANSITIONING	
00001739	171.35273743	[5148] 1924 DB query prepare finished, took 606.	
00001740	171.35285950	[5148] UPnP: Control Request -> Action: TransportInfoResponse	
00001741	171.35298157	[5148] 1924 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 	
00001742	171.35310364	[5148] UPnP: Control Request: SetTransportStatus: TRANSITIONING	
00001743	171.35321045	[5148] TRemotePlayer.InvokeAction(GetPositionInfo, , )	
00001744	171.35331726	[5148] 1924 DB lock finished, took 458.	
00001745	171.35382080	[5148] _BrowseRequest finished	
00001746	171.35392761	[5148] UPnP Server: Serving file C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Alan Parsons Project - Sirius.mp3, ExternalStream = 1, FileLen = 4722688	
00001747	171.35415649	[5148] UPnP Server: Creating HTTP entity	
00001748	171.35720825	[5148] ReadExternalStream: Read = 65536, Offset = 0, Size = 4722688, Portion = 0.00, File: C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Alan Parsons Project - Sirius.mp3	
00001749	171.35786438	[5148] ReadExternalStream: Read = 65536, Offset = 65536, Size = 4722688, Portion = 0.01, File: C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Alan Parsons Project - Sirius.mp3	
00001750	171.36566162	[5148] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:63038/ItemID=472.mp3	
00001751	171.36578369	[5148] TRemotePlayer.PlayURI: Result:0	
00001752	171.36589050	[5148] Player: Playback started	
00001753	171.36645508	[5148] Going 'PlaybackStarter_Var'to make final callback 1856	
00001754	171.36650085	[5148] DB: Deleting prepared query: SELECT NULL FROM Covers WHERE Covers.IDSong = ? 	
00001755	171.36695862	[5148] PrepareDockedVideo: Begin	
00001756	171.36700439	[5148] PrepareDockedVideo: Switching=false IsStartingPlayback=false WasManuallyChanged=false	
00001757	171.36712646	[5148] PrepareDockedVideo: Reduced window or audio	
00001758	171.36721802	[5148] PrepareDockedVideo: Audio	
00001759	171.36724854	[5148] Thread 'PlaybackStarter_Var'has finished 1856	
00001760	171.36750793	[5148] PrepareDockedVideo: End	
And see here the log of a file containing the exact date of release:

Code: Select all

00002752	289.21218872	[5148] Player: Next command started	
00002753	289.21228027	[5148] Player: Setting current track: C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Equilibrium - Wirtshaus Gaudi.mp3	
00002754	289.21237183	[5148] Player: Next track prepared, going to start playback	
00002755	289.21286011	[5148] PrepareDockedVideo: Begin	
00002756	289.21295166	[5148] PrepareDockedVideo: Switching=true IsStartingPlayback=false WasManuallyChanged=false	
00002757	289.21310425	[5148] Remaining Cover Lists: 1	
00002758	289.21319580	[5148] Remaining Covers: 1	
00002759	289.21325684	[5148] BQ: Added new task. Currently 1 tasks in queue.	
00002760	289.21337891	[5148] BQ: Starting a new task.	
00002761	289.21343994	[5148] BQ: Currently running 0 threads of 3	
00002762	289.21353149	[5148] BQ: Starting a new thread.	
00002763	289.24215698	[5148] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 0, All: 26	
00002764	289.24887085	[5148] Thread 'BackgroundQueue' has started 3536	
00002765	289.33691406	[5148] StretchStart	
00002766	289.33767700	[5148] BQ: Added new task. Currently 1 tasks in queue.	
00002767	289.33770752	[5148] BQ: Starting a new task.	
00002768	289.33776855	[5148] BQ: Currently running 1 threads of 8	
00002769	289.33776855	[5148] BQ: Starting a new thread.	
00002770	289.35034180	[5148] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 1, All: 27	
00002771	289.35449219	[5148] BQ: Added new task. Currently 2 tasks in queue.	
00002772	289.35452271	[5148] BQ: Starting a new task.	
00002773	289.35458374	[5148] BQ: Currently running 2 threads of 8	
00002774	289.35461426	[5148] BQ: Starting a new thread.	
00002775	289.35537720	[5148] Thread 'BackgroundQueue' has started 724	
00002776	289.36712646	[5148] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 1, All: 28	
00002777	289.37115479	[5148] BQ: Added new task. Currently 3 tasks in queue.	
00002778	289.37121582	[5148] BQ: Starting a new task.	
00002779	289.37121582	[5148] BQ: Currently running 3 threads of 8	
00002780	289.37127686	[5148] BQ: Starting a new thread.	
00002781	289.37203979	[5148] Thread 'BackgroundQueue' has started 8744	
00002782	289.38510132	[5148] TGenThread.Create: ThreadName: BackgroundQueue , Running Threads: Internal: 2, All: 29	
00002783	289.38909912	[5148] BQ: Added new task. Currently 3 tasks in queue.	
00002784	289.38912964	[5148] BQ: Starting a new task.	
00002785	289.38916016	[5148] BQ: There are threads waiting, resume one.	
00002786	289.38922119	[5148] BQ: Added new task. Currently 1 tasks in queue.	
00002787	289.38925171	[5148] BQ: Starting a new task.	
00002788	289.38931274	[5148] BQ: There are threads waiting, resume one.	
00002789	289.38940430	[5148] StretchEnd	
00002790	289.39001465	[5148] Thread 'BackgroundQueue' has started 3796	
00002791	290.10345459	[5148] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00002792	290.15618896	[5148] Winamp simulation window received messsage 12	
00002793	290.15625000	[5148] BQ: Added new task. Currently 1 tasks in queue.	
00002794	290.15631104	[5148] BQ: Starting a new task.	
00002795	290.15637207	[5148] BQ: There are threads waiting, resume one.	
00002796	290.19729614	[5148] Winamp simulation window received messsage 14	
00002797	290.19741821	[5148] Winamp simulation window received messsage 49662	
00002798	290.19754028	[5148] PrepareDockedVideo: Begin	
00002799	290.19757080	[5148] PrepareDockedVideo: Switching=false IsStartingPlayback=false WasManuallyChanged=false	
00002800	290.19760132	[5148] PrepareDockedVideo: Reduced window or audio	
00002801	290.19763184	[5148] PrepareDockedVideo: Audio	
00002802	290.19775391	[5148] PrepareDockedVideo: End	
00002803	290.21160889	[5148] TGenThread.Create: ThreadName: PlaybackStarter_Var , Running Threads: Internal: 4, All: 31	
00002804	290.21685791	[5148] Thread 'PlaybackStarter_Var' has started 2408	
00002805	290.21694946	[5148] Player: _Play() procedure entering.	
00002806	290.22027588	[5148] Player: W7 icon updated.	
00002807	290.22033691	[5148] Player: Going to handle the current track.	
00002808	290.22039795	[5148] Player: Updating playlist entry.	
00002809	290.22042847	[5148] Player: Setting current track: C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Equilibrium - Wirtshaus Gaudi.mp3	
00002810	290.22045898	[5148] Player: Track entry prepared, going to start playback.	
00002811	290.22048950	[5148] Player: Song is not cached, try to play the original file	
00002812	290.22073364	[5148] TRemotePlayer.PlayURI(C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Equilibrium - Wirtshaus Gaudi.mp3, 487)	
00002813	290.22082520	[5148] UPnP: Get IP Addresses	
00002814	290.22094727	[5148] GetNetworkAdapters started	
00002815	290.26763916	[5148] GetNetworkAdapters finished: Count = 1	
00002816	290.26812744	[5148] 2408 DB prepare SQL: SELECT NULL FROM Covers WHERE Covers.IDSong = ?	
00002817	290.26821899	[5148] 2408 DB query prepare finished, took 107.	
00002818	290.26828003	[5148] 2408 DB open SQL: SELECT NULL FROM Covers WHERE Covers.IDSong = ? 	
00002819	290.26843262	[5148] 2408 DB lock finished, took 227.	
00002820	290.26846313	[5148] TRemotePlayer.PlayURI: Generated our URI:http://192.168.178.11:63038/ItemID=487.mp3	
00002821	290.26858521	[5148] GetProtocolInfoFromExt URI: http://192.168.178.11:63038/ItemID=487.mp3	
00002822	290.26861572	[5148] UPnP: GetProtocolInfo	
00002823	290.26864624	[5148] PLT_MimeType::GetMimeTypeFromExtension: No context !	
00002824	290.26867676	[5148] PLT_MimeType::GetMimeTypeFromExtension: No context !	
00002825	290.26873779	[5148] GetSimpleDIDLForSong DIDL: <DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/"><item id="1" parentID="0" restricted="1"><dc:title>Wirtshaus Gaudi</dc:title><dc:date>2014-06-06</dc:date><upnp:artist role="Performer">Equilibrium</upnp:artist><upnp:artist role="AlbumArtist">Equilibrium</upnp:artist><upnp:album>Erdentempel</upnp:album><upnp:genre></upnp:genre><upnp:albumArtURI dlna:profileID="JPEG_TN">http://192.168.178.11:63038/89.jpg</upnp:albumArtURI><upnp:originalTrackNumber>8</upnp:originalTrackNumber><res duration="0:02:41.097" size="5216384" bitrate="256000" sampleFrequency="44100" nrAudioChannels="2" protocolInfo="http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01500000000000000000000000000000">http://192.168.178.11:63038/ItemID=487.mp3</res><upnp:class>object.item.audioItem.musicTrack</upnp:class></item></DIDL-Lite>	
00002826	290.26876831	[5148] TRemotePlayer.InvokeAction(Stop, , )	
00002827	290.26889038	[5148] TRemotePlayer.InvokeAction(SetAVTransportURI, http://192.168.178.11:63038/ItemID=487.mp3, )	
00002828	290.31314087	[5148] UPNP Server: File Request: /ItemID=487.mp3 , Range: < -1, -1>	
00002829	290.31323242	[5148] _BrowseRequest started	
00002830	290.31335449	[5148] TMediaServer.Get(ced1b8fd-46cb-4c32-b8f6-981be0563840)	
00002831	290.31344604	[5148] TMediaServer.Get(ced1b8fd-46cb-4c32-b8f6-981be0563840): found: Musik Vostro3560 MMW	
00002832	290.31356812	[5148] 2960 DB open SQL: SELECT * FROM RemoteClients WHERE MAC = '00-22-61-E7-38-9C'  	
00002833	290.31365967	[5148] OpenQuery - Preparing query SELECT * FROM RemoteClients WHERE MAC = '00-22-61-E7-38-9C'  	
00002834	290.31417847	[5148] 2960 DB lock finished, took 957.	
00002835	290.31433105	[5148] 2960 DB prepare SQL: SELECT * FROM Songs WHERE Songs.ID=?	
00002836	290.31475830	[5148] 2960 DB query prepare finished, took 622.	
00002837	290.31481934	[5148] 2960 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 	
00002838	290.31512451	[5148] 2960 DB lock finished, took 438.	
00002839	290.31573486	[5148] _BrowseRequest finished	
00002840	290.31582642	[5148] UPnP Server: Serving file C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Equilibrium - Wirtshaus Gaudi.mp3, ExternalStream = 1, FileLen = 5216384	
00002841	290.31604004	[5148] UPnP Server: Creating HTTP entity	
00002842	290.31942749	[5148] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:63038/ItemID=487.mp3	
00002843	290.31951904	[5148] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
00002844	290.33566284	[5148] UPnP: OnSetAVTransportURIResult	
00002845	290.33581543	[5148] UPnP: Control Request -> Action: SetAVTransportURIResponse	
00002846	290.33590698	[5148] TRemotePlayer.InvokeAction(Play, , )	
00002847	290.33883667	[5148] UPnP: OnGetTransportInfoResponse: TRANSITIONING	
00002848	290.34930420	[5148] UPnP: Control Request: Waiting...	
00002849	290.35943604	[5148] UPnP: Control Request: Waiting...	
00002850	290.37008667	[5148] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:63038/ItemID=487.mp3	
00002851	290.37020874	[5148] UPnP: Control Request: Waiting...	
00002852	290.38125610	[5148] UPnP: Control Request: Waiting...	
00002853	290.39147949	[5148] UPnP: Control Request: Waiting...	
00002854	290.40173340	[5148] UPnP: Control Request: Waiting...	
00002855	290.40182495	[5148] UPnP: Control Request -> Action: TransportInfoResponse	
00002856	290.40191650	[5148] UPnP: Control Request: SetTransportStatus: TRANSITIONING	
00002857	290.40203857	[5148] TRemotePlayer.InvokeAction(GetPositionInfo, , )	
00002858	290.42071533	[5148] TRemotePlayer.PlayURI: Waiting for playback start, URI: http://192.168.178.11:63038/ItemID=487.mp3	
00002859	290.42086792	[5148] TRemotePlayer.PlayURI: Result:0	
00002860	290.42095947	[5148] Player: Playback started	
00002861	290.42135620	[5148] Going 'PlaybackStarter_Var'to make final callback 2408	
00002862	290.42147827	[5148] DB: Deleting prepared query: SELECT NULL FROM Covers WHERE Covers.IDSong = ? 	
00002863	290.42156982	[5148] PrepareDockedVideo: Begin	
00002864	290.42172241	[5148] PrepareDockedVideo: Switching=false IsStartingPlayback=false WasManuallyChanged=false	
00002865	290.42190552	[5148] PrepareDockedVideo: Reduced window or audio	
00002866	290.42208862	[5148] PrepareDockedVideo: Audio	
00002867	290.42242432	[5148] PrepareDockedVideo: End	
00002868	290.42254639	[5148] Thread 'PlaybackStarter_Var'has finished 2408	
00002869	290.56646729	[5148] UPnP: OnGetTransportInfoResponse: STOPPED	
00002870	290.59280396	[5148] UPnP: Control Request -> Action: TransportInfoResponse	
00002871	290.61578369	[5148] UPnP: Control Request: SetTransportStatus: STOPPED	
00002872	290.63732910	[5148] UPNP Server: File Request: /ItemID=487.mp3 , Range: < -1, -1>	
00002873	290.65890503	[5148] TRemotePlayer.SetTransportStatus: Transition from PLAYING -> STOPPED, current track: Wirtshaus Gaudi, ID: 487, URI on client: http://192.168.178.11:63038/ItemID=472.mp3	
00002874	290.68072510	[5148] _BrowseRequest started	
00002875	290.70245361	[5148] UPnP: OnGetPositionInfoResponse: http://192.168.178.11:63038/ItemID=487.mp3	
00002876	290.71432495	[5148] TMediaServer.Get(ced1b8fd-46cb-4c32-b8f6-981be0563840)	
00002877	290.74389648	[5148] UPnP: Control Request -> Action: PositionInfoResponse	
00002878	290.76678467	[5148] TMediaServer.Get(ced1b8fd-46cb-4c32-b8f6-981be0563840): found: Musik Vostro3560 MMW	
00002879	290.78985596	[5148] 3972 DB open SQL: SELECT * FROM RemoteClients WHERE MAC = '00-22-61-E7-38-9C'  	
00002880	290.82092285	[5148] OpenQuery - Preparing query SELECT * FROM RemoteClients WHERE MAC = '00-22-61-E7-38-9C'  	
00002881	290.82095337	[5148] 3972 DB lock finished, took 47736.	
00002882	290.82113647	[5148] 3972 DB prepare SQL: SELECT * FROM Songs WHERE Songs.ID=?	
00002883	290.82138062	[5148] 3972 DB query prepare finished, took 364.	
00002884	290.82144165	[5148] 3972 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 	
00002885	290.82162476	[5148] 3972 DB lock finished, took 335.	
00002886	290.82189941	[5148] _BrowseRequest finished	
00002887	290.82192993	[5148] UPnP Server: Serving file C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Equilibrium - Wirtshaus Gaudi.mp3, ExternalStream = 1, FileLen = 5216384	
00002888	290.82205200	[5148] UPnP Server: Creating HTTP entity	
00002889	290.84866333	[5148] UPNP Server: File Request: /ItemID=487.mp3 , Range: < 0, -1>	
00002890	290.84872437	[5148] _BrowseRequest started	
00002891	290.84875488	[5148] TMediaServer.Get(ced1b8fd-46cb-4c32-b8f6-981be0563840)	
00002892	290.84881592	[5148] TMediaServer.Get(ced1b8fd-46cb-4c32-b8f6-981be0563840): found: Musik Vostro3560 MMW	
00002893	290.84884644	[5148] 5572 DB open SQL: SELECT * FROM RemoteClients WHERE MAC = '00-22-61-E7-38-9C'  	
00002894	290.84887695	[5148] OpenQuery - Preparing query SELECT * FROM RemoteClients WHERE MAC = '00-22-61-E7-38-9C'  	
00002895	290.84912109	[5148] 5572 DB lock finished, took 468.	
00002896	290.84918213	[5148] 5572 DB prepare SQL: SELECT * FROM Songs WHERE Songs.ID=?	
00002897	290.84939575	[5148] 5572 DB query prepare finished, took 324.	
00002898	290.84942627	[5148] 5572 DB open SQL: SELECT * FROM Songs WHERE Songs.ID=? 	
00002899	290.84957886	[5148] 5572 DB lock finished, took 202.	
00002900	290.84982300	[5148] _BrowseRequest finished	
00002901	290.84988403	[5148] UPnP Server: Serving file C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Equilibrium - Wirtshaus Gaudi.mp3, ExternalStream = 1, FileLen = 5216384	
00002902	290.84997559	[5148] UPnP Server: Creating HTTP entity	
00002903	290.85031128	[5148] ReadExternalStream: Read = 65536, Offset = 0, Size = 5216384, Portion = 0.00, File: C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Equilibrium - Wirtshaus Gaudi.mp3	
00002904	290.85067749	[5148] ReadExternalStream: Read = 65536, Offset = 65536, Size = 5216384, Portion = 0.01, File: C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Equilibrium - Wirtshaus Gaudi.mp3	
00002905	290.85772705	[5148] ReadExternalStream: Read = 65536, Offset = 131072, Size = 5216384, Portion = 0.03, File: C:\Users\Oliver Eichler\Downloads\Downloads Musik\[korrekt getaggt]\Equilibrium - Wirtshaus Gaudi.mp3	
00002906	291.11312866	[5148] TRemotePlayer.InvokeAction(GetTransportInfo, , )	
Can anyone explain why there are diferences?
Thanks in advance

Ludek
Posts: 3080
Joined: Fri Mar 09, 2007 9:00 am

Re: renderer: 1) no file information 2) not playing other fi

Post by Ludek » Mon Apr 04, 2016 5:08 am

Hi,
added as http://www.ventismedia.com/mantis/view.php?id=13198 to tweak this for 4.1.12

EDIT: Seeing this was already tracked in the past as http://www.ventismedia.com/mantis/view.php?id=11882

Post Reply