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
Area 51 - Testing Area
TSWriter deadlock potential fix.
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: 1033933" data-attributes="member: 82144"><p>Okay, so I think you just ruled out that plugin.</p><p></p><p>It starts here:</p><p>[collapse][2013-10-16 21:40:29,729] [Log ] [DVB EPG timer] [INFO ] - dvbs: Tune<img src="data:image/gif;base64,R0lGODlhAQABAIAAAAAAAP///yH5BAEAAAAALAAAAAABAAEAAAIBRAA7" class="smilie smilie--sprite smilie--sprite8" alt=":D" title="Big Grin :D" loading="lazy" data-shortname=":D" />VBS:tv:TVNZ U Freq:12483000 ONID:47 TSID:22 SID:1904 PMT:0x10B FTA:True LCN:10000 SymbolRate:22500 Modulation:ModNotSet Polarisation:LinearH InnerFecRate:Rate3_4 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet</p><p>[2013-10-16 21:40:29,729] [Log ] [DVB EPG timer] [INFO ] - dvb:GetNewSubChannel:0 #0</p><p>[2013-10-16 21:40:29,731] [Log ] [DVB EPG timer] [INFO ] - TvDvbChannel ctor new subchIndex:0</p><p>[2013-10-16 21:40:29,731] [Log ] [DVB EPG timer] [INFO ] - card: AddTuneEvent card: 4018 / subch: 0</p><p>[2013-10-16 21:40:29,732] [Log ] [DVB EPG timer] [INFO ] - LNB low:10750 hi:10750 switch:0</p><p>[2013-10-16 21:40:29,732] [Log ] [DVB EPG timer] [INFO ] - dvbs:channel modulation is set to ModNotSet</p><p>[2013-10-16 21:40:29,732] [Log ] [DVB EPG timer] [INFO ] - dvbs:channel FECRate is set to Rate3_4</p><p>[2013-10-16 21:40:29,833] [Log ] [DVB EPG timer] [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:" />ubmiting tunerequest Channel:U subChannel:0</p><p>[2013-10-16 21:40:29,833] [Log ] [DVB EPG timer] [INFO ] - dvb:using existing subchannel:0</p><p>[2013-10-16 21:40:29,833] [Log ] [DVB EPG timer] [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:" />ubmit tunerequest size:1 new:0</p><p>[2013-10-16 21:40:29,834] [Log ] [DVB EPG timer] [INFO ] - subch:0 OnBeforeTune</p><p>[2013-10-16 21:40:29,835] [Log ] [DVB EPG timer] [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:" />ubmit tunerequest calling put_TuneRequest</p><p>[2013-10-16 21:40:29,835] [Log ] [DVB EPG timer] [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:" />ubmit tunerequest done calling put_TuneRequest</p><p>[2013-10-16 21:40:29,835] [Log ] [DVB EPG timer] [INFO ] - subch:0 OnAfterTune</p><p>[2013-10-16 21:40:29,836] [Log ] [DVB EPG timer] [INFO ] - RunGraph</p><p>[2013-10-16 21:40:29,836] [Log ] [DVB EPG timer] [INFO ] - subch:0 OnGraphStart</p><p>[2013-10-16 21:40:29,837] [Log ] [DVB EPG timer] [INFO ] - dvb: RunGraph</p><p>[2013-10-16 21:40:30,041] [Log ] [DVB EPG timer] [INFO ] - dvb: LockInOnSignal ok</p><p>[2013-10-16 21:40:30,042] [Log ] [DVB EPG timer] [INFO ] - subch:0 OnGraphStarted</p><p>[2013-10-16 21:40:30,042] [Log ] [DVB EPG timer] [INFO ] - subch:0 SetupPmtGrabber<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" />id 10B sid:770</p><p>[2013-10-16 21:40:30,042] [Log ] [DVB EPG timer] [INFO ] - subch:0 set pmt grabber pmt:10B sid:770</p><p>[2013-10-16 21:40:30,043] [Log ] [DVB EPG timer] [DEBUG] - WaitForPMT: Waiting for PMT 10B</p><p>[2013-10-16 21:40:40,043] [Log ] [DVB EPG timer] [DEBUG] - WaitForPMT: Timed out waiting for PMT after 10 seconds. Increase the PMT timeout value?</p><p>[2013-10-16 21:40:40,043] [Log ] [DVB EPG timer] [DEBUG] - Setting to 0 to search for new PMT.</p><p>[2013-10-16 21:40:40,043] [Log ] [DVB EPG timer] [INFO ] - subch:0 SetupPmtGrabber<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" />id 0 sid:770</p><p>[2013-10-16 21:40:40,043] [Log ] [DVB EPG timer] [INFO ] - subch:0 set pmt grabber pmt:0 sid:770</p><p>[2013-10-16 21:40:40,044] [Log ] [DVB EPG timer] [DEBUG] - WaitForPMT: Waiting for PMT 0</p><p>[2013-10-16 21:40:50,044] [Log ] [DVB EPG timer] [DEBUG] - WaitForPMT: Timed out waiting for PMT after 10 seconds. Increase the PMT timeout value?</p><p>[2013-10-16 21:40:50,044] [Log ] [DVB EPG timer] [DEBUG] - Setting to 0 to search for new PMT.</p><p>[2013-10-16 21:40:50,044] [Log ] [DVB EPG timer] [INFO ] - tvcard:FreeSubChannel: subchannels count 1 subch#0</p><p>[2013-10-16 21:40:50,045] [Log ] [DVB EPG timer] [INFO ] - DVB subch:0 Decompose()</p><p>[2013-10-16 21:40:50,046] [Log ] [DVB EPG timer] [INFO ] - FreeSubChannel CA: freeing sub channel : 0</p><p>[2013-10-16 21:40:50,047] [Log ] [DVB EPG timer] [INFO ] - tvcard:FreeSubChannel : no subchannels present, pausing graph</p><p>[2013-10-16 21:40:50,047] [Log ] [DVB EPG timer] [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>[2013-10-16 21:40:50,047] [Log ] [DVB EPG timer] [INFO ] - tvcard:FreeAllSubChannels</p><p>[2013-10-16 21:40:50,047] [Log ] [DVB EPG timer] [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[/collapse]</p><p></p><p>The graph is not fully stopped, but we can see that TsWriter stops:</p><p></p><p></p><p>So again, some upstream filter is not able to stop successfully. Here is where I think I would start to suspect TBS drivers.</p><p></p><p>Eventually we see:</p><p>[collapse][2013-10-16 22:04:33,912] [Log ] [17 ] [INFO ] - Controller: epg stop</p><p>[2013-10-16 22:04:33,912] [EPG ] [17 ] [INFO ] - EPG: grabber stopped..</p><p>[2013-10-16 22:04:33,912] [EPG ] [17 ] [INFO ] - EpgCard: card: 4018 stop grabbing</p><p>[2013-10-16 22:04:33,912] [EPG ] [17 ] [INFO ] - EpgGrabbing: Stop - user epg</p><p>[2013-10-16 22:04:33,912] [Log ] [17 ] [INFO ] - user:epg remove</p><p>[2013-10-16 22:04:42,535] [Log ] [17 ] [INFO ] - Controller: epg stop</p><p>[2013-10-16 22:04:42,541] [Log ] [17 ] [INFO ] - Controller: epg start</p><p>[2013-10-16 22:04:42,583] [EPG ] [17 ] [INFO ] - EPG: grabber initialized for 17 transponders..</p><p>[2013-10-16 22:04:45,776] [Log ] [20 ] [INFO ] - Controller: StartTimeShifting TV1 1</p><p>[2013-10-16 22:04:45,776] [Log ] [20 ] [INFO ] - Controller: epg stop</p><p>[2013-10-16 22:04:45,777] [EPG ] [20 ] [INFO ] - EPG: grabber stopped..</p><p>[2013-10-16 22:04:45,777] [Log ] [20 ] [INFO ] - Controller: find free card for channel TV1</p><p>[2013-10-16 22:04:45,777] [Log ] [20 ] [INFO ] - Controller: find card for channel TV1</p><p>[2013-10-16 22:04:45,778] [Log ] [20 ] [INFO ] - Controller: got 2 tuning details for TV1</p><p>[2013-10-16 22:04:45,778] [Log ] [20 ] [INFO ] - Controller: channel #1 DVBT:tv:TVNZ TV ONE Freq:530000 ONID:8746 TSID:25 SID:1200 PMT:0x64 FTA:True LCN:1 BandWidth:8</p><p>[2013-10-16 22:04:45,779] [Log ] [20 ] [INFO ] - Controller: card:8 type:RadioWebStream is disabled</p><p>[2013-10-16 22:04:45,779] [Log ] [20 ] [INFO ] - Controller: card:7 type:Analog is disabled</p><p>[2013-10-16 22:04:45,779] [Log ] [20 ] [INFO ] - Controller: card:4015 type<img src="data:image/gif;base64,R0lGODlhAQABAIAAAAAAAP///yH5BAEAAAAALAAAAAABAAEAAAIBRAA7" class="smilie smilie--sprite smilie--sprite8" alt=":D" title="Big Grin :D" loading="lazy" data-shortname=":D" />vbS cannot tune to channel</p><p>[2013-10-16 22:04:45,779] [Log ] [20 ] [INFO ] - Controller: card:4016 type<img src="data:image/gif;base64,R0lGODlhAQABAIAAAAAAAP///yH5BAEAAAAALAAAAAABAAEAAAIBRAA7" class="smilie smilie--sprite smilie--sprite8" alt=":D" title="Big Grin :D" loading="lazy" data-shortname=":D" />vbS cannot tune to channel</p><p>[2013-10-16 22:04:45,780] [Log ] [20 ] [INFO ] - Controller: card:4017 type<img src="data:image/gif;base64,R0lGODlhAQABAIAAAAAAAP///yH5BAEAAAAALAAAAAABAAEAAAIBRAA7" class="smilie smilie--sprite smilie--sprite8" alt=":D" title="Big Grin :D" loading="lazy" data-shortname=":D" />vbS cannot tune to channel</p><p>[2013-10-16 22:04:45,780] [Log ] [20 ] [INFO ] - Controller: card:4018 type<img src="data:image/gif;base64,R0lGODlhAQABAIAAAAAAAP///yH5BAEAAAAALAAAAAABAAEAAAIBRAA7" class="smilie smilie--sprite smilie--sprite8" alt=":D" title="Big Grin :D" loading="lazy" data-shortname=":D" />vbS cannot tune to channel</p><p>[2013-10-16 22:04:45,780] [Log ] [20 ] [INFO ] - Controller: card:6 type<img src="data:image/gif;base64,R0lGODlhAQABAIAAAAAAAP///yH5BAEAAAAALAAAAAABAAEAAAIBRAA7" class="smilie smilie--sprite smilie--sprite8" alt=":D" title="Big Grin :D" loading="lazy" data-shortname=":D" />vbT can tune to channel</p><p>[2013-10-16 22:04:45,781] [Log ] [20 ] [INFO ] - Controller: channel #2 DVBS:tv:TVNZ TV ONE Freq:12483000 ONID:47 TSID:22 SID:1035 PMT:0x10D FTA:True LCN:10000 SymbolRate:22500 Modulation:ModNotSet Polarisation:LinearH InnerFecRate:Rate3_4 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet</p><p>[2013-10-16 22:04:45,781] [Log ] [20 ] [INFO ] - Controller: card:8 type:RadioWebStream is disabled</p><p>[2013-10-16 22:04:45,781] [Log ] [20 ] [INFO ] - Controller: card:7 type:Analog is disabled</p><p>[2013-10-16 22:04:45,782] [Log ] [20 ] [INFO ] - Controller: card:4015 type<img src="data:image/gif;base64,R0lGODlhAQABAIAAAAAAAP///yH5BAEAAAAALAAAAAABAAEAAAIBRAA7" class="smilie smilie--sprite smilie--sprite8" alt=":D" title="Big Grin :D" loading="lazy" data-shortname=":D" />vbS can tune to channel</p><p>[2013-10-16 22:04:45,782] [Log ] [20 ] [INFO ] - Controller: card:4016 type<img src="data:image/gif;base64,R0lGODlhAQABAIAAAAAAAP///yH5BAEAAAAALAAAAAABAAEAAAIBRAA7" class="smilie smilie--sprite smilie--sprite8" alt=":D" title="Big Grin :D" loading="lazy" data-shortname=":D" />vbS can tune to channel</p><p>[2013-10-16 22:04:45,783] [Log ] [20 ] [INFO ] - Controller: card:4017 type<img src="data:image/gif;base64,R0lGODlhAQABAIAAAAAAAP///yH5BAEAAAAALAAAAAABAAEAAAIBRAA7" class="smilie smilie--sprite smilie--sprite8" alt=":D" title="Big Grin :D" loading="lazy" data-shortname=":D" />vbS can tune to channel</p><p>[2013-10-16 22:04:45,783] [Log ] [20 ] [INFO ] - Controller: card:4018 type<img src="data:image/gif;base64,R0lGODlhAQABAIAAAAAAAP///yH5BAEAAAAALAAAAAABAAEAAAIBRAA7" class="smilie smilie--sprite smilie--sprite8" alt=":D" title="Big Grin :D" loading="lazy" data-shortname=":D" />vbS can tune to channel</p><p>[2013-10-16 22:04:45,784] [Log ] [20 ] [INFO ] - Controller: card:6 type<img src="data:image/gif;base64,R0lGODlhAQABAIAAAAAAAP///yH5BAEAAAAALAAAAAABAAEAAAIBRAA7" class="smilie smilie--sprite smilie--sprite8" alt=":D" title="Big Grin :D" loading="lazy" data-shortname=":D" />vbT cannot tune to channel</p><p>[2013-10-16 22:04:45,784] [Log ] [20 ] [INFO ] - Controller: found 5 card(s) for channel</p><p>[2013-10-16 22:04:45,784] [Log ] [20 ] [INFO ] - AdvancedCardAllocation.GetAvailableCardsForChannel took 6 msec</p><p>[2013-10-16 22:04:45,784] [Log ] [20 ] [INFO ] - Controller: found 5 free card(s)</p><p>[2013-10-16 22:04:45,785] [Log ] [20 ] [INFO ] - AdvancedCardAllocation.GetFreeCardsForChannel took 7 msec</p><p>[2013-10-16 22:04:45,785] [Log ] [20 ] [DEBUG] - CardReservationBase.RequestCardTuneReservation: placed reservation with id=1639, tuningdetails=DVBS:tv:TVNZ TV ONE Freq:12483000 ONID:47 TSID:22 SID:1035 PMT:0x10D FTA:True LCN:10000 SymbolRate:22500 Modulation:ModNotSet Polarisation:LinearH InnerFecRate:Rate3_4 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet</p><p>[2013-10-16 22:04:45,786] [Log ] [20 ] [DEBUG] - CardReservationBase.RequestCardTuneReservation: placed reservation with id=1640, tuningdetails=DVBS:tv:TVNZ TV ONE Freq:12483000 ONID:47 TSID:22 SID:1035 PMT:0x10D FTA:True LCN:10000 SymbolRate:22500 Modulation:ModNotSet Polarisation:LinearH InnerFecRate:Rate3_4 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet</p><p>[2013-10-16 22:04:45,786] [Log ] [20 ] [DEBUG] - CardReservationBase.RequestCardTuneReservation: placed reservation with id=1641, tuningdetails=DVBS:tv:TVNZ TV ONE Freq:12483000 ONID:47 TSID:22 SID:1035 PMT:0x10D FTA:True LCN:10000 SymbolRate:22500 Modulation:ModNotSet Polarisation:LinearH InnerFecRate:Rate3_4 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet</p><p>[2013-10-16 22:04:45,786] [Log ] [20 ] [DEBUG] - CardReservationBase.HasUserHigherPriorityThanBlockingUser: True - user 'setuptv-1--1' with prio=2 vs blocking user 'epg' with prio=1</p><p>[2013-10-16 22:04:45,787] [Log ] [20 ] [INFO ] - card: WaitForCancelledTuneToFinish card: 4018 / subch: 0</p><p>[/collapse]</p><p></p><p>At the end you can see the fact that the graph failed to stop for tuner 4018 is blocking the other 3 tuners from being used.</p><p></p><p>I'm sorry but I'm not really able to explain what is going with any more certainty. It looks like TV Server is behaving as intended, but unusual failure conditions related to your TBS tuners are causing TV Server to also be unreliable.</p><p></p><p>At this point I would recommend to fix any outdated tuning details, including U and PRIME and re-introduce the plugin.</p></blockquote><p></p>
[QUOTE="mm1352000, post: 1033933, member: 82144"] Okay, so I think you just ruled out that plugin. It starts here: [collapse][2013-10-16 21:40:29,729] [Log ] [DVB EPG timer] [INFO ] - dvbs: Tune:DVBS:tv:TVNZ U Freq:12483000 ONID:47 TSID:22 SID:1904 PMT:0x10B FTA:True LCN:10000 SymbolRate:22500 Modulation:ModNotSet Polarisation:LinearH InnerFecRate:Rate3_4 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet [2013-10-16 21:40:29,729] [Log ] [DVB EPG timer] [INFO ] - dvb:GetNewSubChannel:0 #0 [2013-10-16 21:40:29,731] [Log ] [DVB EPG timer] [INFO ] - TvDvbChannel ctor new subchIndex:0 [2013-10-16 21:40:29,731] [Log ] [DVB EPG timer] [INFO ] - card: AddTuneEvent card: 4018 / subch: 0 [2013-10-16 21:40:29,732] [Log ] [DVB EPG timer] [INFO ] - LNB low:10750 hi:10750 switch:0 [2013-10-16 21:40:29,732] [Log ] [DVB EPG timer] [INFO ] - dvbs:channel modulation is set to ModNotSet [2013-10-16 21:40:29,732] [Log ] [DVB EPG timer] [INFO ] - dvbs:channel FECRate is set to Rate3_4 [2013-10-16 21:40:29,833] [Log ] [DVB EPG timer] [INFO ] - dvb:Submiting tunerequest Channel:U subChannel:0 [2013-10-16 21:40:29,833] [Log ] [DVB EPG timer] [INFO ] - dvb:using existing subchannel:0 [2013-10-16 21:40:29,833] [Log ] [DVB EPG timer] [INFO ] - dvb:Submit tunerequest size:1 new:0 [2013-10-16 21:40:29,834] [Log ] [DVB EPG timer] [INFO ] - subch:0 OnBeforeTune [2013-10-16 21:40:29,835] [Log ] [DVB EPG timer] [INFO ] - dvb:Submit tunerequest calling put_TuneRequest [2013-10-16 21:40:29,835] [Log ] [DVB EPG timer] [INFO ] - dvb:Submit tunerequest done calling put_TuneRequest [2013-10-16 21:40:29,835] [Log ] [DVB EPG timer] [INFO ] - subch:0 OnAfterTune [2013-10-16 21:40:29,836] [Log ] [DVB EPG timer] [INFO ] - RunGraph [2013-10-16 21:40:29,836] [Log ] [DVB EPG timer] [INFO ] - subch:0 OnGraphStart [2013-10-16 21:40:29,837] [Log ] [DVB EPG timer] [INFO ] - dvb: RunGraph [2013-10-16 21:40:30,041] [Log ] [DVB EPG timer] [INFO ] - dvb: LockInOnSignal ok [2013-10-16 21:40:30,042] [Log ] [DVB EPG timer] [INFO ] - subch:0 OnGraphStarted [2013-10-16 21:40:30,042] [Log ] [DVB EPG timer] [INFO ] - subch:0 SetupPmtGrabber:pid 10B sid:770 [2013-10-16 21:40:30,042] [Log ] [DVB EPG timer] [INFO ] - subch:0 set pmt grabber pmt:10B sid:770 [2013-10-16 21:40:30,043] [Log ] [DVB EPG timer] [DEBUG] - WaitForPMT: Waiting for PMT 10B [2013-10-16 21:40:40,043] [Log ] [DVB EPG timer] [DEBUG] - WaitForPMT: Timed out waiting for PMT after 10 seconds. Increase the PMT timeout value? [2013-10-16 21:40:40,043] [Log ] [DVB EPG timer] [DEBUG] - Setting to 0 to search for new PMT. [2013-10-16 21:40:40,043] [Log ] [DVB EPG timer] [INFO ] - subch:0 SetupPmtGrabber:pid 0 sid:770 [2013-10-16 21:40:40,043] [Log ] [DVB EPG timer] [INFO ] - subch:0 set pmt grabber pmt:0 sid:770 [2013-10-16 21:40:40,044] [Log ] [DVB EPG timer] [DEBUG] - WaitForPMT: Waiting for PMT 0 [2013-10-16 21:40:50,044] [Log ] [DVB EPG timer] [DEBUG] - WaitForPMT: Timed out waiting for PMT after 10 seconds. Increase the PMT timeout value? [2013-10-16 21:40:50,044] [Log ] [DVB EPG timer] [DEBUG] - Setting to 0 to search for new PMT. [2013-10-16 21:40:50,044] [Log ] [DVB EPG timer] [INFO ] - tvcard:FreeSubChannel: subchannels count 1 subch#0 [2013-10-16 21:40:50,045] [Log ] [DVB EPG timer] [INFO ] - DVB subch:0 Decompose() [2013-10-16 21:40:50,046] [Log ] [DVB EPG timer] [INFO ] - FreeSubChannel CA: freeing sub channel : 0 [2013-10-16 21:40:50,047] [Log ] [DVB EPG timer] [INFO ] - tvcard:FreeSubChannel : no subchannels present, pausing graph [2013-10-16 21:40:50,047] [Log ] [DVB EPG timer] [INFO ] - dvb:StopGraph called [2013-10-16 21:40:50,047] [Log ] [DVB EPG timer] [INFO ] - tvcard:FreeAllSubChannels [2013-10-16 21:40:50,047] [Log ] [DVB EPG timer] [INFO ] - dvb:StopGraph[/collapse] The graph is not fully stopped, but we can see that TsWriter stops: So again, some upstream filter is not able to stop successfully. Here is where I think I would start to suspect TBS drivers. Eventually we see: [collapse][2013-10-16 22:04:33,912] [Log ] [17 ] [INFO ] - Controller: epg stop [2013-10-16 22:04:33,912] [EPG ] [17 ] [INFO ] - EPG: grabber stopped.. [2013-10-16 22:04:33,912] [EPG ] [17 ] [INFO ] - EpgCard: card: 4018 stop grabbing [2013-10-16 22:04:33,912] [EPG ] [17 ] [INFO ] - EpgGrabbing: Stop - user epg [2013-10-16 22:04:33,912] [Log ] [17 ] [INFO ] - user:epg remove [2013-10-16 22:04:42,535] [Log ] [17 ] [INFO ] - Controller: epg stop [2013-10-16 22:04:42,541] [Log ] [17 ] [INFO ] - Controller: epg start [2013-10-16 22:04:42,583] [EPG ] [17 ] [INFO ] - EPG: grabber initialized for 17 transponders.. [2013-10-16 22:04:45,776] [Log ] [20 ] [INFO ] - Controller: StartTimeShifting TV1 1 [2013-10-16 22:04:45,776] [Log ] [20 ] [INFO ] - Controller: epg stop [2013-10-16 22:04:45,777] [EPG ] [20 ] [INFO ] - EPG: grabber stopped.. [2013-10-16 22:04:45,777] [Log ] [20 ] [INFO ] - Controller: find free card for channel TV1 [2013-10-16 22:04:45,777] [Log ] [20 ] [INFO ] - Controller: find card for channel TV1 [2013-10-16 22:04:45,778] [Log ] [20 ] [INFO ] - Controller: got 2 tuning details for TV1 [2013-10-16 22:04:45,778] [Log ] [20 ] [INFO ] - Controller: channel #1 DVBT:tv:TVNZ TV ONE Freq:530000 ONID:8746 TSID:25 SID:1200 PMT:0x64 FTA:True LCN:1 BandWidth:8 [2013-10-16 22:04:45,779] [Log ] [20 ] [INFO ] - Controller: card:8 type:RadioWebStream is disabled [2013-10-16 22:04:45,779] [Log ] [20 ] [INFO ] - Controller: card:7 type:Analog is disabled [2013-10-16 22:04:45,779] [Log ] [20 ] [INFO ] - Controller: card:4015 type:DvbS cannot tune to channel [2013-10-16 22:04:45,779] [Log ] [20 ] [INFO ] - Controller: card:4016 type:DvbS cannot tune to channel [2013-10-16 22:04:45,780] [Log ] [20 ] [INFO ] - Controller: card:4017 type:DvbS cannot tune to channel [2013-10-16 22:04:45,780] [Log ] [20 ] [INFO ] - Controller: card:4018 type:DvbS cannot tune to channel [2013-10-16 22:04:45,780] [Log ] [20 ] [INFO ] - Controller: card:6 type:DvbT can tune to channel [2013-10-16 22:04:45,781] [Log ] [20 ] [INFO ] - Controller: channel #2 DVBS:tv:TVNZ TV ONE Freq:12483000 ONID:47 TSID:22 SID:1035 PMT:0x10D FTA:True LCN:10000 SymbolRate:22500 Modulation:ModNotSet Polarisation:LinearH InnerFecRate:Rate3_4 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet [2013-10-16 22:04:45,781] [Log ] [20 ] [INFO ] - Controller: card:8 type:RadioWebStream is disabled [2013-10-16 22:04:45,781] [Log ] [20 ] [INFO ] - Controller: card:7 type:Analog is disabled [2013-10-16 22:04:45,782] [Log ] [20 ] [INFO ] - Controller: card:4015 type:DvbS can tune to channel [2013-10-16 22:04:45,782] [Log ] [20 ] [INFO ] - Controller: card:4016 type:DvbS can tune to channel [2013-10-16 22:04:45,783] [Log ] [20 ] [INFO ] - Controller: card:4017 type:DvbS can tune to channel [2013-10-16 22:04:45,783] [Log ] [20 ] [INFO ] - Controller: card:4018 type:DvbS can tune to channel [2013-10-16 22:04:45,784] [Log ] [20 ] [INFO ] - Controller: card:6 type:DvbT cannot tune to channel [2013-10-16 22:04:45,784] [Log ] [20 ] [INFO ] - Controller: found 5 card(s) for channel [2013-10-16 22:04:45,784] [Log ] [20 ] [INFO ] - AdvancedCardAllocation.GetAvailableCardsForChannel took 6 msec [2013-10-16 22:04:45,784] [Log ] [20 ] [INFO ] - Controller: found 5 free card(s) [2013-10-16 22:04:45,785] [Log ] [20 ] [INFO ] - AdvancedCardAllocation.GetFreeCardsForChannel took 7 msec [2013-10-16 22:04:45,785] [Log ] [20 ] [DEBUG] - CardReservationBase.RequestCardTuneReservation: placed reservation with id=1639, tuningdetails=DVBS:tv:TVNZ TV ONE Freq:12483000 ONID:47 TSID:22 SID:1035 PMT:0x10D FTA:True LCN:10000 SymbolRate:22500 Modulation:ModNotSet Polarisation:LinearH InnerFecRate:Rate3_4 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet [2013-10-16 22:04:45,786] [Log ] [20 ] [DEBUG] - CardReservationBase.RequestCardTuneReservation: placed reservation with id=1640, tuningdetails=DVBS:tv:TVNZ TV ONE Freq:12483000 ONID:47 TSID:22 SID:1035 PMT:0x10D FTA:True LCN:10000 SymbolRate:22500 Modulation:ModNotSet Polarisation:LinearH InnerFecRate:Rate3_4 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet [2013-10-16 22:04:45,786] [Log ] [20 ] [DEBUG] - CardReservationBase.RequestCardTuneReservation: placed reservation with id=1641, tuningdetails=DVBS:tv:TVNZ TV ONE Freq:12483000 ONID:47 TSID:22 SID:1035 PMT:0x10D FTA:True LCN:10000 SymbolRate:22500 Modulation:ModNotSet Polarisation:LinearH InnerFecRate:Rate3_4 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet [2013-10-16 22:04:45,786] [Log ] [20 ] [DEBUG] - CardReservationBase.HasUserHigherPriorityThanBlockingUser: True - user 'setuptv-1--1' with prio=2 vs blocking user 'epg' with prio=1 [2013-10-16 22:04:45,787] [Log ] [20 ] [INFO ] - card: WaitForCancelledTuneToFinish card: 4018 / subch: 0 [/collapse] At the end you can see the fact that the graph failed to stop for tuner 4018 is blocking the other 3 tuners from being used. I'm sorry but I'm not really able to explain what is going with any more certainty. It looks like TV Server is behaving as intended, but unusual failure conditions related to your TBS tuners are causing TV Server to also be unreliable. At this point I would recommend to fix any outdated tuning details, including U and PRIME and re-introduce the plugin. [/QUOTE]
Insert quotes…
Verification
Post reply
Forums
MediaPortal 1
Area 51 - Testing Area
TSWriter deadlock potential fix.
Contact us
RSS
Top
Bottom