Multi-tune fails (SubmitTuneRequest: returns 0x1) with Vista TV Pack or Windows 7 (1 Viewer)

markius

Portal Pro
December 26, 2006
175
4
Maidstone, UK
Home Country
England England
TV-Server Version: 1.0
MediaPortal Version: 1.0
MediaPortal Skin: BlueThree Wide
Windows Version: Vista Ultimate SP1
CPU Type: Pentium M 760 (2.0GHz/533/2Mb)
HDD: Seagate 300Gb 7200RPM SATA 150
Memory: 2GB PC2-4200
Motherboard: MSI Speedster-FA4 (MS-9625)
Video Card: ASUS EAH3450 512MB
Video Card Driver:
Sound Card: Intel ICH6 HD Audio / Realtek ALC880
Sound Card AC3:
Sound Card Driver:
1. TV Card: BlackGold BGT3540
1. TV Card Type: 2xDVB-T, 2xDVB-S
1. TV Card Driver: 6.0.0.39
2. TV Card:
2. TV Card Type:
2. TV Card Driver:
3. TV Card:
3. TV Card Type:
3. TV Card Driver:
4. TV Card:
4. TV Card Type:
4. TV Card Driver:
MPEG2 Video Codec: PowerDVD
MPEG2 Audio Codec: PowerDVD
h.264 Video Codec: PowerDVD
Satelite/CableTV Provider: Astra 28.2°E & Eurobird 28.5°E
HTPC Case: Antec Aria
Cooling: Stock
Power Supply: Stock
Remote: MCE (mark 2)
TV: Samsung 26in LCD LW26A33W
TV - HTPC Connection: Sub-D

UPDATE
This problem has been pinned down to systems that have either the Vista Media Center TV Pack 2008 or Windows 7 installed.


Overlapping recordings on the same fail because of a problem with subchannels.

Use case
* The TV Service is configured to pre-record for 5 minutes and post record for 15 minutes.

* Two records are scheduled back to back on the same channel:
Recording A BBC1 22:00 - 22:30 [Effective 21:55 - 22:45]
Recording B BBC1 22:30 - 23:00 [Effective 22:25 - 23:15]

Timeline
21:55 Time to record Recording A
21:55 TvService finds a free card and tunes to BBC1 - Recording A begins

22:25 Time to record Recording B
22:25 TvService finds a card that is already tuned to BBC1 and tries to create a new subchannel
22:25 Tune request fails (SubmitTuneRequest returns 0x01)
22:26 Time to record Recording B
22:26 TvService finds a card that is already tuned to BBC1 and tries to create a new subchannel
22:26 Tune request fails (SubmitTuneRequest returns 0x01)
...
... Repeated continuously until
...
22:44 Time to record Recording B
22:44 TvService finds a card that is already tuned to BBC1 and tries to create a new subchannel
22:44 Tune request fails (SubmitTuneRequest returns 0x01)

22:45 End Recording A
22:45 TvService fully releases the tuner (FreeAllSubchannels) and Recording A ends

22:45 Time to record Recording B
22:45 TvService finds a free card and tunes to BBC1 - Recording B begins

23:15 End Recording B
23:15 TvService fully releases the tuner (FreeAllSubchannels) and Recording B ends

Additional use case
Update: A very similar issue seems to break manual recording. With manual recordings the TvServer attempts to re-use a subchannel instead of create a new one but the result is the same: SubmitTuneRequest: returns 0x1). I've attached some additional logs for this use case.

If you need any more information please let me know

Cheers
Mark

Log
The following snippet is an example of what happens when recording B starts. A more complete log is attached

2009-01-09 23:50:10.282134 [Scheduler timer]: Scheduler : time to record TvDatabase.Channel 09/01/2009 23:50:10-10/01/2009 00:20:00 Family Guy
2009-01-09 23:50:10.283110 [Scheduler timer]: Controller: find free card for channel BBC THREE
2009-01-09 23:50:10.285063 [Scheduler timer]: Controller: got 2 tuning details for BBC THREE
2009-01-09 23:50:10.285063 [Scheduler timer]: Controller: channel #1 DVBT:tv:BBC BBC THREE Freq:778000 ONID:9018 TSID:4108 SID:4351 PMT:0x10FF FTA:True LCN:7 BandWidth:8
2009-01-09 23:50:10.315335 [Scheduler timer]: Controller: card:7 type:RadioWebStream cannot tune to channel
2009-01-09 23:50:10.333888 [Scheduler timer]: Controller: card:8 type:DvbT is tuned to different transponder
2009-01-09 23:50:10.334865 [Scheduler timer]: Controller: card:8 type:DvbT is available priority:-93 #users:1 same transponder:False
2009-01-09 23:50:10.338771 [Scheduler timer]: Controller: card:9 type:DvbT is tuned to same transponder no CA present
2009-01-09 23:50:10.338771 [Scheduler timer]: Controller: card:9 type:DvbT is available priority:6 #users:1 same transponder:True
2009-01-09 23:50:10.341700 [Scheduler timer]: Controller: card:10 type:DvbS cannot tune to channel
2009-01-09 23:50:10.344630 [Scheduler timer]: Controller: card:11 type:DvbS cannot tune to channel
2009-01-09 23:50:10.344630 [Scheduler timer]: Controller: card:12 type:Analog is disabled
2009-01-09 23:50:10.345606 [Scheduler timer]: Controller: card:13 type:Analog is disabled
2009-01-09 23:50:10.345606 [Scheduler timer]: Controller: channel #2 DVBS:tv:BSkyB BBC THREE Freq:10773000 ONID:2 TSID:2045 SID:6319 PMT:0x10D FTA:True LCN:3 SymbolRate:22000 Modulation:ModNotSet Polarisation:LinearH InnerFecRate:Rate5_6 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet
2009-01-09 23:50:10.348536 [Scheduler timer]: Controller: card:7 type:RadioWebStream cannot tune to channel
2009-01-09 23:50:10.353418 [Scheduler timer]: Controller: card:10 type:DvbS is available priority:5 #users:0 same transponder:False
2009-01-09 23:50:10.357324 [Scheduler timer]: Controller: card:11 type:DvbS is available priority:4 #users:0 same transponder:False
2009-01-09 23:50:10.357324 [Scheduler timer]: Controller: card:12 type:Analog is disabled
2009-01-09 23:50:10.358301 [Scheduler timer]: Controller: card:13 type:Analog is disabled
2009-01-09 23:50:10.358301 [Scheduler timer]: Controller: found 4 available
2009-01-09 23:50:10.358301 [Scheduler timer]: Scheduler : record on free card:9 priority:6
2009-01-09 23:50:10.360254 [Scheduler timer]: Scheduler : record, first tune to channel
2009-01-09 23:50:10.374901 [28]: card: Tune 9 to BBC THREE
2009-01-09 23:50:10.375878 [28]: card: user: scheduler86:9:-1 tune DVBT:tv:BBC BBC THREE Freq:778000 ONID:9018 TSID:4108 SID:4351 PMT:0x10FF FTA:True LCN:7 BandWidth:8
2009-01-09 23:50:10.381737 [28]: dvbt: Tune:DVBT:tv:BBC BBC THREE Freq:778000 ONID:9018 TSID:4108 SID:4351 PMT:0x10FF FTA:True LCN:7 BandWidth:8
2009-01-09 23:50:10.382713 [28]: dvbt: tune: Assigning oldChannel
2009-01-09 23:50:10.382713 [28]: dvbt: tune: Current Channel != null DVBT:tv:BBC BBC THREE Freq:778000 ONID:9018 TSID:4108 SID:4351 PMT:0x10FF FTA:False LCN:7 BandWidth:8
2009-01-09 23:50:10.383690 [28]: dvbt: tune: Graph is tunning
2009-01-09 23:50:10.384666 [28]: dvbt: tune: Getting default locator
2009-01-09 23:50:10.384666 [28]: dvbt: tune: Putting bandwidth 8
2009-01-09 23:50:10.385643 [28]: dvbt: tune: put_ONID 9018
2009-01-09 23:50:10.385643 [28]: dvbt: tune: put_SID 4351
2009-01-09 23:50:10.386619 [28]: dvbt: tune: put_TSID 4108
2009-01-09 23:50:10.386619 [28]: dvbt: tune: Carrier frequency 778000
2009-01-09 23:50:10.386619 [28]: dvbt: tune: put_Locator
2009-01-09 23:50:10.387596 [28]: dvbt: tune: Submitting tune request: SubId -1, channel DVBT:tv:BBC BBC THREE Freq:778000 ONID:9018 TSID:4108 SID:4351 PMT:0x10FF FTA:True LCN:7 BandWidth:8
2009-01-09 23:50:10.387596 [28]: dvbt: tune: Submitting tune request: System.__ComObject
2009-01-09 23:50:10.389549 [28]: dvb:confused:ubmiting tunerequest Channel:BBC THREE subChannel:-1
2009-01-09 23:50:10.390525 [28]: dvb:Getting new subchannel
2009-01-09 23:50:10.390525 [28]: dvb:GetNewSubChannel:1 #2
2009-01-09 23:50:10.391502 [28]: dvb:confused:ubmit tunerequest size:2 new:2
2009-01-09 23:50:10.392478 [28]: subch:2 OnBeforeTune
2009-01-09 23:50:10.394431 [28]: dvb:confused:ubmit tunerequest calling put_TuneRequest
2009-01-09 23:50:10.395408 [28]: dvb:confused:ubmit tunerequest done calling put_TuneRequest
2009-01-09 23:50:10.395408 [28]: dvb:confused:ubmitTuneRequest returns:0x1
2009-01-09 23:50:10.395408 [28]: dvb:confused:ubmitTuneRequest failed - removing subchannel: 2
2009-01-09 23:50:26.018431 [Scheduler timer]: Recording Family Guy added in _recordingsInProgressList
2009-01-09 23:50:26.018431 [Scheduler timer]: Scheduler : time to record TvDatabase.Channel 09/01/2009 23:50:26-10/01/2009 00:20:00 Family Guy
2009-01-09 23:50:26.019408 [Scheduler timer]: Controller: find free card for channel BBC THREE
2009-01-09 23:50:26.022337 [Scheduler timer]: Controller: got 2 tuning details for BBC THREE
2009-01-09 23:50:26.023314 [Scheduler timer]: Controller: channel #1 DVBT:tv:BBC BBC THREE Freq:778000 ONID:9018 TSID:4108 SID:4351 PMT:0x10FF FTA:True LCN:7 BandWidth:8
2009-01-09 23:50:26.080927 [Scheduler timer]: Controller: card:7 type:RadioWebStream cannot tune to channel
2009-01-09 23:50:26.084833 [Scheduler timer]: Controller: card:8 type:DvbT is tuned to different transponder
2009-01-09 23:50:26.085810 [Scheduler timer]: Controller: card:8 type:DvbT is available priority:-93 #users:1 same transponder:False
2009-01-09 23:50:26.088739 [Scheduler timer]: Controller: card:9 type:DvbT is tuned to same transponder no CA present
2009-01-09 23:50:26.089716 [Scheduler timer]: Controller: card:9 type:DvbT is available priority:6 #users:1 same transponder:True
2009-01-09 23:50:26.091669 [Scheduler timer]: Controller: card:10 type:DvbS cannot tune to channel
2009-01-09 23:50:26.094598 [Scheduler timer]: Controller: card:11 type:DvbS cannot tune to channel
2009-01-09 23:50:26.094598 [Scheduler timer]: Controller: card:12 type:Analog is disabled
2009-01-09 23:50:26.095575 [Scheduler timer]: Controller: card:13 type:Analog is disabled
2009-01-09 23:50:26.095575 [Scheduler timer]: Controller: channel #2 DVBS:tv:BSkyB BBC THREE Freq:10773000 ONID:2 TSID:2045 SID:6319 PMT:0x10D FTA:True LCN:3 SymbolRate:22000 Modulation:ModNotSet Polarisation:LinearH InnerFecRate:Rate5_6 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet
2009-01-09 23:50:26.097528 [Scheduler timer]: Controller: card:7 type:RadioWebStream cannot tune to channel
2009-01-09 23:50:26.102410 [Scheduler timer]: Controller: card:10 type:DvbS is available priority:5 #users:0 same transponder:False
2009-01-09 23:50:26.108269 [Scheduler timer]: Controller: card:11 type:DvbS is available priority:4 #users:0 same transponder:False
2009-01-09 23:50:26.108269 [Scheduler timer]: Controller: card:12 type:Analog is disabled
2009-01-09 23:50:26.109246 [Scheduler timer]: Controller: card:13 type:Analog is disabled
2009-01-09 23:50:26.110222 [Scheduler timer]: Controller: found 4 available
2009-01-09 23:50:26.110222 [Scheduler timer]: Scheduler : record on free card:9 priority:6
2009-01-09 23:50:26.111199 [Scheduler timer]: Scheduler : record, first tune to channel
2009-01-09 23:50:26.114128 [28]: card: Tune 9 to BBC THREE
2009-01-09 23:50:26.115105 [28]: card: user: scheduler86:9:-1 tune DVBT:tv:BBC BBC THREE Freq:778000 ONID:9018 TSID:4108 SID:4351 PMT:0x10FF FTA:True LCN:7 BandWidth:8
2009-01-09 23:50:26.121940 [28]: dvbt: Tune:DVBT:tv:BBC BBC THREE Freq:778000 ONID:9018 TSID:4108 SID:4351 PMT:0x10FF FTA:True LCN:7 BandWidth:8
2009-01-09 23:50:26.122917 [28]: dvbt: tune: Assigning oldChannel
2009-01-09 23:50:26.124870 [28]: dvbt: tune: Current Channel != null DVBT:tv:BBC BBC THREE Freq:778000 ONID:9018 TSID:4108 SID:4351 PMT:0x10FF FTA:False LCN:7 BandWidth:8
2009-01-09 23:50:26.124870 [28]: dvbt: tune: Graph is tunning
2009-01-09 23:50:26.125846 [28]: dvbt: tune: Getting default locator
2009-01-09 23:50:26.125846 [28]: dvbt: tune: Putting bandwidth 8
2009-01-09 23:50:26.126823 [28]: dvbt: tune: put_ONID 9018
2009-01-09 23:50:26.126823 [28]: dvbt: tune: put_SID 4351
2009-01-09 23:50:26.127799 [28]: dvbt: tune: put_TSID 4108
2009-01-09 23:50:26.127799 [28]: dvbt: tune: Carrier frequency 778000
2009-01-09 23:50:26.128776 [28]: dvbt: tune: put_Locator
2009-01-09 23:50:26.128776 [28]: dvbt: tune: Submitting tune request: SubId -1, channel DVBT:tv:BBC BBC THREE Freq:778000 ONID:9018 TSID:4108 SID:4351 PMT:0x10FF FTA:True LCN:7 BandWidth:8
2009-01-09 23:50:26.129752 [28]: dvbt: tune: Submitting tune request: System.__ComObject
2009-01-09 23:50:26.129752 [28]: dvb:confused:ubmiting tunerequest Channel:BBC THREE subChannel:-1
2009-01-09 23:50:26.130729 [28]: dvb:Getting new subchannel
2009-01-09 23:50:26.130729 [28]: dvb:GetNewSubChannel:1 #3
2009-01-09 23:50:26.189319 [28]: dvb:confused:ubmit tunerequest size:2 new:3
2009-01-09 23:50:26.189319 [28]: subch:3 OnBeforeTune
2009-01-09 23:50:26.190295 [28]: dvb:confused:ubmit tunerequest calling put_TuneRequest
2009-01-09 23:50:26.191272 [28]: dvb:confused:ubmit tunerequest done calling put_TuneRequest
2009-01-09 23:50:26.191272 [28]: dvb:confused:ubmitTuneRequest returns:0x1
2009-01-09 23:50:26.192248 [28]: dvb:confused:ubmitTuneRequest failed - removing subchannel: 3
2009-01-09 23:50:28.172590 [28]: PowerScheduler: User input detected at 09/01/2009 23:50:28
2009-01-09 23:50:42.034984 [Scheduler timer]: Recording Family Guy added in _recordingsInProgressList
2009-01-09 23:50:42.034984 [Scheduler timer]: Scheduler : time to record TvDatabase.Channel 09/01/2009 23:50:42-10/01/2009 00:20:00 Family Guy
 

Attachments

  • subchannels.zip
    30.6 KB
  • manual recording_tv.zip
    30.7 KB

iancalderban

Portal Pro
December 12, 2008
140
7
milton keynes
Home Country
United Kingdom United Kingdom
afraid I've not seen this and I have almost identical setup to you.

for channels such as BBC1 that exist on both dvb-t and dvb-s I went into the channel mappings etc and made sure that it can be viewed by all 4 tuners - dvb-t and dvb-s.

I have been able to record 2 consecutive programs that way. Even 2 consecutive on BBCHD which is only on dvb-s. I often record the back-to-back "in the night gardens" for my kids @ 6pm and 6.30.

I have seen something else which is doing my head in - corrupted recordings where on playback it seems to jump/stutter to frames from different recorded files - but I don't think thats the same problem at all

if you want to see any of my cfg / logs let me know which files (I am not an mp debugging expert. I can debug big ip networks, but not s/w!)
ta
Ian
 

markius

Portal Pro
December 26, 2006
175
4
Maidstone, UK
Home Country
England England
Hi Ian

I'd definately be interested to see the tv.log from around the time that "In the Night Gardens" records. Can I ask, do you have pre and post-recording padding configured?

I've not had much chance to do much further investigation of this over the last week or so... work has been manic... I've also been debugging IP networks but only in so far as trying to track down machines infected with the kido worm.

Cheers
Mark
 

iancalderban

Portal Pro
December 12, 2008
140
7
milton keynes
Home Country
United Kingdom United Kingdom
Hi Ian

I'd definately be interested to see the tv.log from around the time that "In the Night Gardens" records. Can I ask, do you have pre and post-recording padding configured?

I've not had much chance to do much further investigation of this over the last week or so... work has been manic... I've also been debugging IP networks but only in so far as trying to track down machines infected with the kido worm.

Cheers
Mark

yes defo have pre (5) and post (10) . so I end up with overlapped recordings.
log attached. annoying they go in a hidden directoy on vista!

i just quickly watched them on ffwd - recording seem to overlap exactly as you'd expect.
Ian
 

Attachments

  • nightgardenbbchhdconsecutive.txt
    30.7 KB

markius

Portal Pro
December 26, 2006
175
4
Maidstone, UK
Home Country
England England
Hi Ian
Well, what can I say? Your setup really is working like it says on the tin! This leads me to some more questions:
* Is there a configuration setting that's breaking subchannels? I notice that you don't pre-load the cards whereas I do.
* Is the problem limited to certain channels?
* Is the problem limited to channels with multiple tuning details?

Hopefully I'll get some time to sit down and figure this out over the weekend. Failing that I'll have a bash at recording "In the Night Garden" back to back. Can you remind me, how is that schedule created on your system - every time on this channel, every time every channel or in some other way?

Thanks for posting your log

Have a good weekend
Mark
 

iancalderban

Portal Pro
December 12, 2008
140
7
milton keynes
Home Country
United Kingdom United Kingdom
Hi Ian
Well, what can I say? Your setup really is working like it says on the tin! This leads me to some more questions:
* Is there a configuration setting that's breaking subchannels? I notice that you don't pre-load the cards whereas I do.
* Is the problem limited to certain channels?
* Is the problem limited to channels with multiple tuning details?

Hopefully I'll get some time to sit down and figure this out over the weekend. Failing that I'll have a bash at recording "In the Night Garden" back to back. Can you remind me, how is that schedule created on your system - every time on this channel, every time every channel or in some other way?

Thanks for posting your log

Have a good weekend
Mark

I just go into the EPG and press "record" . it often offers me a number of instances of the same program in the bottom right hand corner, so I usually setup a few days worth from there. I haven't found anything that will do same time same channel for me yet - is there a plugin for that?

I use djblu's tswriter for freesat epg, not sure if that makes a diff.

Ian
 

markius

Portal Pro
December 26, 2006
175
4
Maidstone, UK
Home Country
England England
OK so it doesn't seem to be related to preloading, or manually creating the recordings instead of using the scheduler.
I've tried with and without the DJblu tswriter and get the same result.

I suppose the next step would be reinstall the app but that's such a PIA when you receive 1000 channels - i've been trying to avoid it.

I've noticed one different between my log and your log. In my log file, when the second recording starts I see this:
Code:
Scheduler : record on recommended card:10 priority:5
But in your logs it says this:
Code:
Scheduler : record on free card:3 priority:5

I don't know what's the difference between a "free" card and a "recommended" card though

Mark
 

gibman

Retired Team Member
  • Premium Supporter
  • October 4, 2006
    2,998
    1,372
    Aarhus
    Home Country
    Denmark Denmark
    Some questions.

    Is the BBC1 channel FTA or scrambled ?
    Are u able to do b2b recordings on the dvb-s2 device ?

    Tried newer BDA drivers, or even older ones ?
    What card are u using ?
    Is it possible for you to try another dvb-t card, another brand ?

    Can u multitune the dvb-t device using 2 timeshifting sessions on the same BBC1 channel ?
    I guess you need a multiseat setup to test this.
    Or maybe u can tune BB1 in setuptv, and then tune the same channel in a windowed MP session...havent tried it.

    /gibman
     

    Users who are viewing this thread

    Top Bottom