Bug in V1.0 (1 Viewer)

[wupperi]

Hi all,

ich habe mir eben die V1.0 auf den Rechner gespielt, kommend von RC4.
Bei mir läuft Client und TVServer auf der gleichen Maschine, Vista 32 bit.

Im TV Modul habe ich jetzt ein ganz seltsames Verhalten:

Sobald ich auf Mein-TV gehe, sehe ich im Vorschaufenster den letzten Frame meines vor dem letzten Beenden von MP gesehenen Bildes.

Der TV Stream fängt erst dann an zu laufen, wenn ich einmal auf einen anderen Kanal wechsel, allerdings spielt er dann den Stream des Kanals ab, der vor dem letzten Auschalten aktiv war.

Im log sieht das so aus:

2008-12-22 21:47:35.422140 [Info.][CommandProcessor]: Commandprocessor: Stopping all tuners
2008-12-22 21:47:35.422140 [Info.][CommandProcessor]: Commandprocessor: Stopped
2008-12-22 21:47:35.493424 [Info.][MPMain]: ChannelNavigator::Reload()
2008-12-22 21:47:35.493424 [Info.][MPMain]: get channels from database
2008-12-22 21:47:35.548108 [Info.][MPMain]: found:1059 tv channels
2008-12-22 21:47:35.548108 [Info.][MPMain]: TvNotify:OnNotifiesChanged
2008-12-22 21:47:35.548108 [Info.][MPMain]: Checking if radio group for all radio channels exists
2008-12-22 21:47:35.599863 [Info.][MPMain]: Done.
2008-12-22 21:47:35.599863 [Info.][MPMain]: get all groups from database
2008-12-22 21:47:35.672124 [Info.][MPMain]: loaded 4 tv groups
2008-12-22 21:47:35.674077 [Info.][MPMain]: tv home initas Erste
2008-12-22 21:47:35.678959 [Info.][MPMain]: TVHome.ViewChannelAndCheck(): View channel=Das Erste
2008-12-22 21:47:36.888843 [Info.][MPMain]: succeededucceeded TvControl.VirtualCard
2008-12-22 21:47:36.894702 [Info.][MPMain]: tvhome:startplay
2008-12-22 21:47:36.898608 [Info.][MPMain]: tvhome:file:E:\timeshiftbuffer\live1-0.ts.tsbuffer
2008-12-22 21:47:36.909349 [Warn.][MPMain]: tvhome:startplay. Phase 1 - 16 ms - Done method initialization
2008-12-22 21:47:36.909349 [Info.][MPMain]: tvhome:startplay:E:\timeshiftbuffer\live1-0.ts.tsbuffer - using rtsp mode:False
2008-12-22 21:47:36.916185 [Info.][MPMain]: g_Player.Play(E:\timeshiftbuffer\live1-0.ts.tsbuffer TV)
2008-12-22 21:47:36.940597 [Info.][MPMain]: TSReaderPlayer play:E:\timeshiftbuffer\live1-0.ts.tsbuffer radio:False
2008-12-22 21:47:36.941574 [Info.][MPMain]: TSReaderPlayer: live tv
2008-12-22 21:47:36.942550 [Info.][MPMain]: TSReaderPlayer: Enabling DX9 exclusive mode
2008-12-22 21:47:36.942550 [Info.][MPMain]: TSReaderPlayerlay E:\timeshiftbuffer\live1-0.ts.tsbuffer
2008-12-22 21:47:36.972822 [Info.][MPMain]: TSReaderPlayer:cleanup DShow graph False
2008-12-22 21:47:36.972822 [Info.][MPMain]: TSReaderPlayer:grapbuilder=null
2008-12-22 21:47:36.984540 [Info.][MPMain]: TSReaderPlayer: Cleanup done
2008-12-22 21:47:37.004070 [Info.][MPMain]: TSReaderPlayer: GetInterfaces()
2008-12-22 21:47:37.005046 [Info.][MPMain]: TSReaderPlayer:cleanup DShow graph False
2008-12-22 21:47:37.005046 [Info.][MPMain]: TSReaderPlayer:grapbuilder=null
2008-12-22 21:47:37.016764 [Info.][MPMain]: TSReaderPlayer: Cleanup done
2008-12-22 21:47:37.025553 [Info.][MPMain]: TSReaderPlayer: add _vmr9
2008-12-22 21:47:37.034341 [Info.][MPMain]: VMR9: added EVR Renderer to graph
2008-12-22 21:47:37.115391 [Info.][MPMain]: TSReaderPlayer: add codecs
2008-12-22 21:47:37.319479 [Info.][MPMain]: added filter:CyberLink Video/SP Decoder (PDVD7) to graph
2008-12-22 21:47:37.821400 [Info.][MPMain]: added filter:CyberLink H.264/AVC Decoder (PDVD7.x) to graph
2008-12-22 21:47:37.946392 [Info.][MPMain]: added filter:CyberLink Audio Decode (PDVD7.x) to graph
2008-12-22 21:47:37.950298 [Info.][MPMain]: added filter:MONOGRAM AAC Decoder to graph
2008-12-22 21:47:37.957134 [Info.][MPMain]: DirectShowUtils: First try to insert new audio renderer Default DirectSound Device
2008-12-22 21:47:37.957134 [Info.][MPMain]: DirectShowUtils: Found audio renderer
2008-12-22 21:47:37.982523 [Info.][MPMain]: TSReaderPlayer:add TsReader to graph
2008-12-22 21:47:37.983499 [Info.][MPMain]: TSReaderPlayer: open file: E:\timeshiftbuffer\live1-0.ts.tsbuffer
2008-12-22 21:47:37.991311 [Info.][MPMain]: TsReaderPlayer: OnVideoFormatChanged - streamtype=MPEG2 resolution=720x576 aspect ratio=16:9 bitrate=15000000 isInterlaced=False
2008-12-22 21:47:37.993264 [Info.][MPMain]: TSReaderPlayer:render TsReader outputs
2008-12-22 21:47:38.200282 [Info.][MPMain]: PlaneScene: PresentSurface() dispose surfaces
2008-12-22 21:47:38.238366 [Info.][MPMain]: TSReaderPlayer: OnInitialized
2008-12-22 21:47:38.238366 [Info.][MPMain]: TSReaderPlayer:running pos:1,35 duration:0 0
2008-12-22 21:47:38.240319 [Info.][MPMain]: g_Player.OnStarted() E:\timeshiftbuffer\live1-0.ts.tsbuffer media:TV
2008-12-22 21:47:38.245201 [Info.][MPMain]: TvCropManager.SendCropMessage(): 0, 0, 0, 0
2008-12-22 21:47:38.285238 [Warn.][MPMain]: tvhome:startplay. Phase 2 - 1375 ms - Done starting g_Player.Play()
2008-12-22 21:47:38.286214 [Info.][MPMain]: tv home initas Erste done
2008-12-22 21:47:38.423901 [Info.][MPMain]: opening video database
2008-12-22 21:47:38.431713 [Info.][MPMain]: video database opened
2008-12-22 21:47:38.445384 [Info.][MPMain]: TSReaderPlayer:OnRequestAudioChange()
2008-12-22 21:47:38.455149 [Info.][MPMain]: Audio stream: switching to preferred MPEG audio stream 0, NOT based on LANG (none avail. matching )
2008-12-22 21:47:38.458078 [Info.][MPMain]: PlaneScene: Crop: top:0, bottom:0, left:0, right:0
2008-12-22 21:47:47.676238 [Info.][MPMain]: g_Player: ShowFullScreenWindow switching to fullscreen tv
2008-12-22 21:47:47.727993 [Info.][MPMain]: xml:\Program Files\Team MediaPortal\MediaPortal\Skin\Blue3\tvOSD.xml image id:350 width:0 height:0 gfx:-
2008-12-22 21:47:50.126277 [Info.][MPMain]: TVHome.ViewChannelAndCheck(): View channel=ZDF
2008-12-22 21:47:50.180961 [Info.][MPMain]: TSReaderPlayerause graph
2008-12-22 21:47:51.354714 [Info.][MPMain]: tvhomeeektoEnd(True, rtsp=False
2008-12-22 21:47:51.357643 [Info.][MPMain]: TsReaderPlayer:seekabs:136240000 start:0 end:136240000
2008-12-22 21:47:51.386938 [Info.][MPMain]: TsReaderPlayer seek done:0
2008-12-22 21:47:51.390844 [Info.][MPMain]: TSReaderPlayer: current pos:13,624 dur:13,624
2008-12-22 21:47:51.440646 [Info.][MPMain]: TSReaderPlayer:Continue graph
2008-12-22 21:47:51.442599 [Info.][MPMain]: succeededucceeded TvControl.VirtualCard
2008-12-22 21:47:52.432770 [Info.][VMRenderer]: PlaneScene: video WxH : 720x576
2008-12-22 21:47:52.432770 [Info.][VMRenderer]: PlaneScene: screen WxH : 1152x648
2008-12-22 21:48:01.319896 [Info.][MPMain]: TSReaderPlayer:OnRequestAudioChange()
2008-12-22 21:48:01.319896 [Info.][MPMain]: Audio stream: switching to preferred MPEG audio stream 0, NOT based on LANG (none avail. matching )
2008-12-22 21:48:04.077532 [Info.][VMRenderer]: planescene: PresentSurface() frame:0 enabled:True allowed:False 720x576
2008-12-22 21:48:04.097062 [Info.][VMRenderer]: planescene: PresentSurface() frame:1 enabled:True allowed:False 720x576
2008-12-22 21:48:17.181186 [Info.][MPMain]: TVHome.ViewChannelAndCheck(): View channel=Das Erste
2008-12-22 21:48:17.240752 [Info.][MPMain]: TSReaderPlayerause graph
2008-12-22 21:48:17.245635 [Info.][VMRenderer]: planescene: PresentSurface() frame:18 enabled:False allowed:True 720x576
2008-12-22 21:48:18.534615 [Info.][MPMain]: tvhomeeektoEnd(True, rtsp=False
2008-12-22 21:48:18.535591 [Info.][MPMain]: TsReaderPlayer:seekabs:397960000 start:0 end:397960000
2008-12-22 21:48:18.568792 [Info.][MPMain]: TsReaderPlayer seek done:0
2008-12-22 21:48:18.568792 [Info.][MPMain]: TSReaderPlayer: current pos:39,796 dur:39,796
2008-12-22 21:48:18.569769 [Info.][MPMain]: TSReaderPlayer:Continue graph
2008-12-22 21:48:18.570745 [Info.][MPMain]: succeededucceeded TvControl.VirtualCard
2008-12-22 21:48:18.676207 [Info.][MPMain]: TSReaderPlayer:OnRequestAudioChange()
2008-12-22 21:48:18.677184 [Info.][MPMain]: Audio stream: switching to preferred MPEG audio stream 0, NOT based on LANG (none avail. matching )
2008-12-22 21:48:26.975481 [Info.][MPMain]: tv home initas Erste
2008-12-22 21:48:26.976457 [Info.][MPMain]: tv home initas Erste done

Installiere ich dann wieder auf den RC4 Kandidaten zurück -> Kein Problem, Fernsehen startet ganz normal.

Ggfls ein Bug?
Hat noch jemand dieses Verhalten?

An die Admins: Falls off topic, bitte verschieben.

Gruss,
wupperi

 

[flokel]

Starte bitte mal MP im Debug modus (Link ist im start menü)
und poste das erstellte zip file hier.

 

[wupperi]

Here we go.

TV angeschaltet um 22:29:57h.
Dann ca 1 Minute gewartet, nichts passiert, dann gegen 22:30:45h umgeschaltet, ab da läufts dann normal.

 

[Ostrich]

Moin,
hab das Gleiche verhalten an 3 (von 3) Clients nachstellen können, TV-Aufzeichnungen werden zudem gar nicht erst angestartet. Hoffe mal auf version 1.01 bis zum neuen Jahr, und dass, wo ich über die feiertage eigentlich mein vista mediacenter in den Ruhestand schicken wollte ... nun hats ne Gnadenfrist!

Hoffe, jemand findet nen Workaround ..

harald
(der eigentlich nicht immer nu rummotzen will ...)

 

[wupperi]

Ich bin mittlerweile am verzweifeln.
Hatte meine Senderliste exportiert, dann meine DB auf dem SQL Server gelöscht.

Danach habe ich das Verhalten sowohl auf dem RC4 also auch auf der 1.0, jeweils mit den wieder importierten Kanälen. Bin kurz davor mein O/S neu aufzubügeln...


EDIT:

So, auch den RC4 komplett neu installiert, Kanäle nicht importiert sondern komplett neu suchen lassen, und: Sch....immer noch gleiches problem. Ich mach mal ein neues Vuista drauf und dann gleich die V1.

wupperi
(Der auch nicht meckern will, MP ist ein tolles Programm )

 

[flokel]

Moin,
hab das Gleiche verhalten an 3 (von 3) Clients nachstellen können, TV-Aufzeichnungen werden zudem gar nicht erst angestartet. Hoffe mal auf version 1.01 bis zum neuen Jahr, und dass, wo ich über die feiertage eigentlich mein vista mediacenter in den Ruhestand schicken wollte ... nun hats ne Gnadenfrist!

harald
(der eigentlich nicht immer nu rummotzen will ...)

Logs?

Ich kann das Verhalten auf meinem Server nicht reproduzieren.

Gruß,
Flo
(der eig. nicht jedes Mal extra nach Logs fragen will )

 

[Ostrich]

Flo: da haste natürlich recht! war wohl zu spät gestern, bin jetzt noch mal @work und dann bis 5. januar offline - brauch das einfach mal!

 

[wupperi]

Flo:

Vieleicht hilfts: Ich habe gestern Nacht im Log folgenden Eintrag ca 50x wiederholt gesehen:
PlaneScene: video WxH : 720x576
PlaneScene: screen WxH : 1152x648
PlaneScene: video WxH : 720x576
PlaneScene: screen WxH : 1152x648
PlaneScene: video WxH : 720x576
PlaneScene: screen WxH : 1152x648
PlaneScene: video WxH : 720x576
PlaneScene: screen WxH : 1152x648
PlaneScene: video WxH : 720x576
PlaneScene: screen WxH : 1152x648
usw...

Und zwar direkt nach dem Einschalten, wenn der erste Kanal quasi nur den ersten Frame zeigt.
Nach dem ersten Umschalten wars dann weg.

 

[OnkelChris]

das selbe verhalten wurde bei mir durch PowerDVD verursacht.

Nach ein bischen rumspielen, funktioniert bei mir folgende Kombination problemlos:

Videocodec: PowerDVD (7 oder 8 is egal)
Audiocodec: MPA (der mitgelieferte)

seitdem funktioniert alles problemlos. Ich habe keine weiteren Splitter oder Codecs installiert.
vielleicht hilft das dem ein oder anderen..

 

[wupperi]

Jau, das wars. Sh...das war die einizige Kombination, die ich nicht probiert habe.
Problem lässt sich nachstellen, wenn man als Audi Codec den PDVD einstellt (Problem da) bzw. rausnimmt (Problem weg).

Naja, dafür ist mein Vista wieder clean.
Danke an alle, die geholfen haben.