DECOMPOSE fails, TVSERVICE unresponsive with DUAL tuner DVB-T cards. (1 Viewer)

[SciDoctor]

Thanks

Can you post the last lines of your log which includes the decompose of tuners prior to standby/hibernation.

Also how is the card shown in the device manager .

As one item or as two seperate items.

 

[Paranoid Delusion]

2008-04-08 13:59:17.179751 [7]: Controller: epg stopped...
2008-04-08 13:59:17.179751 [7]: Controller: dispose card:Nova-DT DVB-T Tuner (Dev1 Path0)
2008-04-08 13:59:17.179751 [7]: dvbecompose
2008-04-08 13:59:17.179751 [7]: tvcard:FreeAllSubChannels:
2008-04-08 13:59:17.179751 [7]: stop
2008-04-08 13:59:20.036014 [7]: remove all filters
2008-04-08 13:59:20.039920 [7]: free...
2008-04-08 13:59:20.042849 [7]: free pins...
2008-04-08 13:59:20.043826 [7]: free graph...
2008-04-08 13:59:20.044802 [7]: free devices...
2008-04-08 13:59:20.045779 [7]: decompose done...
2008-04-08 13:59:20.045779 [7]: Controller: dispose card:Nova-DT DVB-T Tuner (Dev1 Path1)
2008-04-08 13:59:20.045779 [7]: Controller: dispose card:RadioWebStream Card (builtin)
2008-04-08 13:59:20.045779 [7]: RadioWebStreamispose()
2008-04-08 13:59:21.790784 [RTSP Streaming thread]: RTSP: Streamer stopped
2008-04-08 14:03:16.503906 [7]: TV service PowerEventThread 30
2008-04-08 14:03:18.581898 [7]: OnPowerEvent: PowerStatus: ResumeAutomatic
2008-04-08 14:03:18.582874 [7]: PowerScheduler: System has resumed automatically from standby
2008-04-08 14:03:18.584827 [7]: PowerScheduler: reinitializing the tvservice TVController
2008-04-08 14:03:18.584827 [7]: Controller: DeInit.
2008-04-08 14:03:18.584827 [7]: Controller: dispose card:Nova-DT DVB-T Tuner (Dev1 Path0)
2008-04-08 14:03:18.584827 [7]: Controller: dispose card:Nova-DT DVB-T Tuner (Dev1 Path1)
2008-04-08 14:03:18.585804 [7]: Controller: dispose card:RadioWebStream Card (builtin)
2008-04-08 14:03:18.585804 [7]: RadioWebStreamispose()
2008-04-08 14:03:18.585804 [7]: C:\ProgramData\MediaPortal TV Server\gentle.config
2008-04-08 14:03:18.587757 [7]: Controller: using SQLServer database connection: Password

TvCard is shown as

Hauppauge Nova-DT Dual DVB-T Tuner Device (+IR)

Any commonality with yours

 

[SciDoctor]

Thanks that helps and I can see that within the session prior to standby just one of the tuners was used.

Can you schedule two concurant recordings on different muxs, say bbc1 and five so that both tuners are used and then allow to standby hibernate.

Please post the same end log section.

From researching the different dual tuner cards there is some differences ;as your T500 is two seperate tuners with a usb/pci hub with nothing shared and other have a demod chip shared between the two tuner sections .

 

[Paranoid Delusion]

These are the logs for 2 recordings set at same time, whilst i was at quiz last night, MP refused to start after resume, stuck at loading plugins, to late at night, so just rebooted after getting logs.

View attachment 19420

Although both shows identical recordings times (2100 hrs), Bionic woman did not start producing file till 21.03 and showed recorded time of just 57 minutes against 1.03 for other show (correct 1 min pre and 2 min post).

Take it plugin could not access TVServer, that why MP failed to load, if tvserver crashed its set to restart after 1 minute anyway so should not be that.
Will repeat similar this afternoon to find out which has failed, either card to decompose correctly and release cards (surely no tuner available message ?) or maybe something unrelated causing this.

 

[SciDoctor]

Looked through your logs and you have the same BUG as me .

2008-04-08 22:03:12.894427 [7]: stop
2008-04-08 22:03:13.269427 [RTSP Streaming thread]: RTSP: Streamer stopped
2008-04-08 22:03:15.769427 [7]: remove all filters
2008-04-08 22:03:15.785052 [7]: free...
2008-04-08 22:03:15.785052 [7]: free pins...
2008-04-08 22:03:15.785052 [7]: free graph...
2008-04-08 22:03:15.785052 [7]: free devices...
2008-04-08 22:03:15.785052 [7]: decompose done...
2008-04-08 22:03:15.785052 [7]: Controller: dispose card:Nova-DT DVB-T Tuner (Dev1 Path1)
2008-04-08 22:03:15.785052 [7]: dvbecompose
2008-04-08 22:03:15.785052 [7]: tvcard:FreeAllSubChannels:
2008-04-08 22:03:15.785052 [7]: stop
2008-04-08 22:03:18.675677 [7]: remove all filters
2008-04-08 22:03:18.691302 [7]: free...
2008-04-08 22:03:18.691302 [7]: free pins...
2008-04-08 23:31:04.625000 [19]: WindowsController: ExitWindows performed, result: True




Failure to fully decompose the second tuner of the dual tuner card when both tuners have been used; the tvserver is then unresponsive and still unresponsive once returned from standby/hibernation.

you will also find that you will need to kill the service as it is not essentialy crashed

You will also find that the drivers for your card perform perfectly in MCE, VMC 32/64 and MPtve2 through standby conditions.

I am also in a long test phase with three dual tuner cards .

Priorities set in the tvserver

Card1 tuner 1
Card2 tuner 1
Card3 tuner 1
Card1 tuner 2
Card2 tuner 2
Card3 tuner 2.

Test with a set of three different concurant mux recordings followed standby and then another three followed by standby and then four different concurant mux recordings followed by standy the five then six.

The tvserver performed faultlessly until four schedules completed when the bug hit and the second tuner failed to decompose.

This test will be repeated with the TVE2, I expect it to have no problems .

This very much shows that the problem is with the TVSERVER code.

Also looks like you have another new bug (SVN ?) as the logs show that the tvserver struggled/wouldn't build a graph on your second tuner . hence your second schedule 'Bionic Woman' recording wouldn't start until this was resolved.

 

[SciDoctor]

Any news on a bug fix?

Any new code that I can test ?

I do hope this bug doesn't remain in RC1.

Anyone with dual tuner dvb-t card that can show logs that under the same conditions they do not suffer from the same BUG.

 

[SciDoctor]

Another test was to put each tuner of a dual tuner card into a different group to see if the TVSERVER would act correctly ie a workaround.

This didn't work either so the code is faulty at such a basic level.

Any action by the TVSERVER to close both tuner graphs fails .

Scan with both tuners, both tuner graphs have now been active ; decompose now fails on second tuner graph.

Change recording directory for both tuners, both tuner graphs have now been active; decompose now fails on the second tuner graph.

Schedule recordings, concurant on different MUX, both tuners graphs have now been active; decompose now fails on second tuner graph.

The above failure will happen when either 'stop service' from SETUPTV or when the powerschedular runs the standby routine.

2008-04-14 11:19:06.539164 [4]: Controller: dispose card:AF9015 BDA Filter
2008-04-14 11:19:06.542093 [4]: dvbecompose
2008-04-14 11:19:06.543070 [4]: tvcard:FreeAllSubChannels:
2008-04-14 11:19:06.543070 [4]: stop
2008-04-14 11:19:07.344776 [4]: remove all filters
2008-04-14 11:19:07.347706 [4]: free...
2008-04-14 11:19:07.349659 [4]: free pins...
2008-04-14 11:19:07.350635 [4]: free graph...
2008-04-14 11:19:07.353565 [4]: free devices...
2008-04-14 11:19:07.355518 [4]: decompose done...
2008-04-14 11:19:07.356494 [4]: Controller: dispose card:AF9015 BDA Filter
2008-04-14 11:19:07.357471 [4]: dvbecompose
2008-04-14 11:19:07.358447 [4]: tvcard:FreeAllSubChannels:
2008-04-14 11:19:07.358447 [4]: stop
2008-04-14 11:19:08.225579 [4]: remove all filters
2008-04-14 11:19:08.229485 [4]: free...
2008-04-14 11:19:08.236321 [4]: free pins...


The above log is the same for now five different tested dual tuner cards in all tested OS (w2ksp4, xpsp2, VISTA32 and VISTA64)

Ok delving a bit deeper.

Looking at the devicenp for the two tuners of a dual tuner card and you will find only one character that is different

@devicenp:\\?\usb#vid_13d3&pid_3237&mi_00#6&262d5986&0&0000#{fd0a5af4-b41d-11d2-9c95-00c04f7971e0}\{9b365890-165f-11d0-a195-0020afd156e5}

@devicenp:\\?\usb#vid_13d3&pid_3237&mi_00#6&262d5986&0&0000#{fd0a5af4-b41d-11d2-9c95-00c04f7971e0}\{9b365890-165f-11d0-a195-0020afd156e4}


In this instance one is '4' and the other '5'

It could be that the TVSERVER isn't checking this properly and is mixing up the graphs on decompose, it decomposes the graph correctly for the first tuner and when it comes to do the same for the second tuner it can't find the graph and hangs here.

 

[Paranoid Delusion]

I've put this for the testers to check, not that many team members have dual dvb cards to be able to reproduce this one afaik.

Are your overlapping recordings working fine btw, mine seemed to, but will do some more testing today just to double check, and post current logs tonight.

Pointed everyone to this post, so hopefully we may get a solution (maybe not till after MP1).

 

[SciDoctor]

Many thanks .

Everything recording wise works as it should; concurant, overlapping , pre-post times, multi-channel-on-mux , multi-mux etc.

Just the above bug which means I would have to leave the HTPC on permenantly as hibernation/standby fails and freezes the TVSERVICE.

Also settng up from scratch causes the TVSETUP and TVSERVER to freeze everytime the tuners are decomposed.

I am more than willing to test any code .

 

[Paranoid Delusion]

Hi SciDoctor

Sorry for not getting back on this, just a tad busy atm.

waiting to get hands on svn that fixes log's handling, as this is totally screwed for me, did a dual recording this afternoon with no problems from resume with tvserver, so going to setup a few overnight and tomorrow, just hope i can get some decent logs or TVServer failure after not decomposing the graph on second tuner, as this is what this post is about.

Also asked petsa if he could check this out for us with his Terratec 2400i.

ps. also getting lots of ts files on channel changes as per your other post, whether this is now intentional do not know, as long as they are deleted at some point, don't care.