home
products
contribute
download
documentation
forum
Home
Forums
New posts
Search forums
What's new
New posts
All posts
Latest activity
Members
Registered members
Current visitors
Donate
Log in
Register
What's new
Search
Search
Search titles only
By:
New posts
Search forums
Search titles only
By:
Menu
Log in
Register
Navigation
Install the app
Install
More options
Contact us
Close Menu
Forums
MediaPortal 1
Quality Assurance
Bugreports
Archive
MP 1.10.0 Final Hangs on Stop of TV
Contact us
RSS
JavaScript is disabled. For a better experience, please enable JavaScript in your browser before proceeding.
You are using an out of date browser. It may not display this or other websites correctly.
You should upgrade or use an
alternative browser
.
Reply to thread
Message
<blockquote data-quote="mm1352000" data-source="post: 1118573" data-attributes="member: 82144"><p>Hello ARE2 and Jeroen (happy new year!) <img src="data:image/gif;base64,R0lGODlhAQABAIAAAAAAAP///yH5BAEAAAAALAAAAAABAAEAAAIBRAA7" class="smilie smilie--sprite smilie--sprite1" alt=":)" title="Smile :)" loading="lazy" data-shortname=":)" /></p><p></p><p>To me this looks like a deadlock in TV Server.</p><p>In the client logs you can see:</p><p>[2015-01-06 20:25:35,986] [Log ] [MPMain ] [INFO ] - TVHome:turn tv off</p><p></p><p>Then on the server side:</p><p>[2015-01-06 20:25:36,089] [Log ] [19 ] [INFO ] - Controller: StopTimeShifting 5</p><p>[2015-01-06 20:25:36,094] [Log ] [PS StandbyWakeup] [DEBUG] - PS: LoadSettings()</p><p>[2015-01-06 20:25:36,104] [Log ] [19 ] [INFO ] - Controller: epg stop</p><p>[2015-01-06 20:25:36,105] [Log ] [19 ] [DEBUG] - CardTuner.RequestCardStopReservation: placed reservation with id=13, user=HTPC</p><p>[2015-01-06 20:25:36,209] [Log ] [19 ] [DEBUG] - CardTuner.Stop: ticket id=13, found=True</p><p>[2015-01-06 20:25:36,240] [Log ] [19 ] [INFO ] - Stop cardid=5, ticket=13, tunestate=Idle, stopstate=Stopping</p><p>[2015-01-06 20:25:36,241] [Log ] [19 ] [INFO ] - card Hauppauge WinTV 88x DVB-S/S2 Tuner/Demod: StopTimeShifting user:HTPC sub:0</p><p>[2015-01-06 20:25:36,242] [Log ] [19 ] [DEBUG] - card not IDLE - removing user: HTPC</p><p>[2015-01-06 20:25:36,244] [Log ] [19 ] [DEBUG] - usermanagement.RemoveUser: HTPC, subch: 0 of 1, card: 5</p><p>[2015-01-06 20:25:36,245] [Log ] [19 ] [INFO ] - user:HTPC remove</p><p>[2015-01-06 20:25:36,246] [Log ] [19 ] [INFO ] - subch:0-0 tswriter StopTimeshifting...</p><p>[2015-01-06 20:25:36,249] [Log ] [19 ] [INFO ] - tvcard:FreeSubChannel: subchannels count 1 subch#0</p><p>[2015-01-06 20:25:36,250] [Log ] [19 ] [INFO ] - DVB subch:0 Decompose()</p><p>[2015-01-06 20:25:36,253] [Log ] [19 ] [INFO ] - FreeSubChannel CA: freeing sub channel : 0</p><p>[2015-01-06 20:25:36,275] [Log ] [PS StandbyWakeup] [DEBUG] - PS: SetWakeupTimer()</p><p>[2015-01-06 20:25:36,279] [Log ] [19 ] [INFO ] - tvcard:FreeSubChannel : no subchannels present, pausing graph</p><p>[2015-01-06 20:25:36,281] [Log ] [19 ] [INFO ] - dvb<img src="data:image/gif;base64,R0lGODlhAQABAIAAAAAAAP///yH5BAEAAAAALAAAAAABAAEAAAIBRAA7" class="smilie smilie--sprite smilie--sprite5" alt=":confused:" title="Confused :confused:" loading="lazy" data-shortname=":confused:" />topGraph called</p><p>[2015-01-06 20:25:36,283] [Log ] [19 ] [INFO ] - tvcard:FreeAllSubChannels</p><p>[2015-01-06 20:25:36,284] [Log ] [19 ] [INFO ] - dvb<img src="data:image/gif;base64,R0lGODlhAQABAIAAAAAAAP///yH5BAEAAAAALAAAAAABAAEAAAIBRAA7" class="smilie smilie--sprite smilie--sprite5" alt=":confused:" title="Confused :confused:" loading="lazy" data-shortname=":confused:" />topGraph</p><p></p><p>Next line I'm expecting to see somewhere there is "debug: IMediaControl stopped! hr = 0x0 <img src="data:image/gif;base64,R0lGODlhAQABAIAAAAAAAP///yH5BAEAAAAALAAAAAABAAEAAAIBRAA7" class="smilie smilie--sprite smilie--sprite1" alt=":)" title="Smile :)" loading="lazy" data-shortname=":)" />", but it never comes. Deadlock. <img src="data:image/gif;base64,R0lGODlhAQABAIAAAAAAAP///yH5BAEAAAAALAAAAAABAAEAAAIBRAA7" class="smilie smilie--sprite smilie--sprite3" alt=":(" title="Frown :(" loading="lazy" data-shortname=":(" /></p><p></p><p>So, at this point the client is locked waiting for the server, and the server is locked waiting for the DirectShow/BDA graph to stop.</p><p></p><p>What more can be seen?</p><p>In the TsWriter log we see:</p><p>[2015-01-06 20:25:36,285] [bbb57b0] [914] - CMpTsFilter:<img src="data:image/gif;base64,R0lGODlhAQABAIAAAAAAAP///yH5BAEAAAAALAAAAAABAAEAAAIBRAA7" class="smilie smilie--sprite smilie--sprite7" alt=":p" title="Stick Out Tongue :p" loading="lazy" data-shortname=":p" />ause()</p><p>[2015-01-06 20:25:36,285] [bbb57b0] [914] - Pause filter...</p><p>[2015-01-06 20:25:36,285] [bbb57b0] [914] - HRESULT = 0x0</p><p>[2015-01-06 20:25:36,287] [bbb57b0] [914] - CMpTsFilter:<img src="data:image/gif;base64,R0lGODlhAQABAIAAAAAAAP///yH5BAEAAAAALAAAAAABAAEAAAIBRAA7" class="smilie smilie--sprite smilie--sprite5" alt=":confused:" title="Confused :confused:" loading="lazy" data-shortname=":confused:" />top()</p><p>[2015-01-06 20:25:36,287] [bbb57b0] [914] - Stop streaming...</p><p>[2015-01-06 20:25:36,287] [bbb57b0] [914] - Stop filter...</p><p>[2015-01-06 20:25:36,287] [bbb57b0] [914] - HRESULT = 0x0</p><p></p><p>So TsWriter receives the pause and stop commands, and obeys them successfully. I guess some other filter in the graph fails to stop. In my experience it has usually been the tuner filter, but we don't really have any way to know.</p><p></p><p>Either way, I'm pretty sure nothing has changed in this part of TV Server since MP 1.6. Have you "upgraded" the tuner driver, or changed something else with your PC?</p><p>Does downgrading to MP 1.7.1 fix the problem?</p><p></p><p>Regards,</p><p>mm</p></blockquote><p></p>
[QUOTE="mm1352000, post: 1118573, member: 82144"] Hello ARE2 and Jeroen (happy new year!) :) To me this looks like a deadlock in TV Server. In the client logs you can see: [2015-01-06 20:25:35,986] [Log ] [MPMain ] [INFO ] - TVHome:turn tv off Then on the server side: [2015-01-06 20:25:36,089] [Log ] [19 ] [INFO ] - Controller: StopTimeShifting 5 [2015-01-06 20:25:36,094] [Log ] [PS StandbyWakeup] [DEBUG] - PS: LoadSettings() [2015-01-06 20:25:36,104] [Log ] [19 ] [INFO ] - Controller: epg stop [2015-01-06 20:25:36,105] [Log ] [19 ] [DEBUG] - CardTuner.RequestCardStopReservation: placed reservation with id=13, user=HTPC [2015-01-06 20:25:36,209] [Log ] [19 ] [DEBUG] - CardTuner.Stop: ticket id=13, found=True [2015-01-06 20:25:36,240] [Log ] [19 ] [INFO ] - Stop cardid=5, ticket=13, tunestate=Idle, stopstate=Stopping [2015-01-06 20:25:36,241] [Log ] [19 ] [INFO ] - card Hauppauge WinTV 88x DVB-S/S2 Tuner/Demod: StopTimeShifting user:HTPC sub:0 [2015-01-06 20:25:36,242] [Log ] [19 ] [DEBUG] - card not IDLE - removing user: HTPC [2015-01-06 20:25:36,244] [Log ] [19 ] [DEBUG] - usermanagement.RemoveUser: HTPC, subch: 0 of 1, card: 5 [2015-01-06 20:25:36,245] [Log ] [19 ] [INFO ] - user:HTPC remove [2015-01-06 20:25:36,246] [Log ] [19 ] [INFO ] - subch:0-0 tswriter StopTimeshifting... [2015-01-06 20:25:36,249] [Log ] [19 ] [INFO ] - tvcard:FreeSubChannel: subchannels count 1 subch#0 [2015-01-06 20:25:36,250] [Log ] [19 ] [INFO ] - DVB subch:0 Decompose() [2015-01-06 20:25:36,253] [Log ] [19 ] [INFO ] - FreeSubChannel CA: freeing sub channel : 0 [2015-01-06 20:25:36,275] [Log ] [PS StandbyWakeup] [DEBUG] - PS: SetWakeupTimer() [2015-01-06 20:25:36,279] [Log ] [19 ] [INFO ] - tvcard:FreeSubChannel : no subchannels present, pausing graph [2015-01-06 20:25:36,281] [Log ] [19 ] [INFO ] - dvb:StopGraph called [2015-01-06 20:25:36,283] [Log ] [19 ] [INFO ] - tvcard:FreeAllSubChannels [2015-01-06 20:25:36,284] [Log ] [19 ] [INFO ] - dvb:StopGraph Next line I'm expecting to see somewhere there is "debug: IMediaControl stopped! hr = 0x0 :)", but it never comes. Deadlock. :( So, at this point the client is locked waiting for the server, and the server is locked waiting for the DirectShow/BDA graph to stop. What more can be seen? In the TsWriter log we see: [2015-01-06 20:25:36,285] [bbb57b0] [914] - CMpTsFilter::Pause() [2015-01-06 20:25:36,285] [bbb57b0] [914] - Pause filter... [2015-01-06 20:25:36,285] [bbb57b0] [914] - HRESULT = 0x0 [2015-01-06 20:25:36,287] [bbb57b0] [914] - CMpTsFilter::Stop() [2015-01-06 20:25:36,287] [bbb57b0] [914] - Stop streaming... [2015-01-06 20:25:36,287] [bbb57b0] [914] - Stop filter... [2015-01-06 20:25:36,287] [bbb57b0] [914] - HRESULT = 0x0 So TsWriter receives the pause and stop commands, and obeys them successfully. I guess some other filter in the graph fails to stop. In my experience it has usually been the tuner filter, but we don't really have any way to know. Either way, I'm pretty sure nothing has changed in this part of TV Server since MP 1.6. Have you "upgraded" the tuner driver, or changed something else with your PC? Does downgrading to MP 1.7.1 fix the problem? Regards, mm [/QUOTE]
Insert quotes…
Verification
Post reply
Forums
MediaPortal 1
Quality Assurance
Bugreports
Archive
MP 1.10.0 Final Hangs on Stop of TV
Contact us
RSS
Top
Bottom
