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
Support
General Support
Avermedia A825 dual tuner - occasionally stops one tuner when starting the other one
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="feizex" data-source="post: 808152" data-attributes="member: 96644"><p>Hi,</p><p></p><p>I have been tracking this down ever since I installed MP a couple of years ago. </p><p></p><p>The problem is that I can't use both tuners reliably. Because occasionally when one is in use and MP tries tuning the other, it will stop the one already in use.</p><p></p><p>Currently my workaround is to disable one of the tuners on this card (USB stick). Obviously that is sub-optimal.</p><p></p><p>Sometimes I can tune on both channels OK. But other times tuning one, stops the other.</p><p></p><p>I think perhaps this is an issue peculiar to this card. But then, maybe it is MP fully resetting the card when it should only reset one tuner.</p><p></p><p>I have attached one instance of failure logs with some notes. Sorry it is a bit long. I have * the point of failure.</p><p></p><p>Please help.</p><p></p><p>Thanks,</p><p>Feizex.</p><p><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" /></p><p></p><p><strong>MediaPortal Version</strong>: MediaPortal 1.2.1.0</p><p><strong>Windows Version</strong>: Windows XP (Service Pack 3)</p><p><strong>CPU Type</strong>: AMD Phenom II dual-core 3.1GHz</p><p><strong>1. TV Card</strong>: Avermedia TwinStar (A825) Dual DVB-T USB</p><p><strong>3. TV Card</strong>: WinFast DTV2000H (PCI)</p><p></p><p>[CODE]</p><p>Recording begins on card 3 at 19:30:04. </p><p>The MP client card tune at 19:41:56 to card 4 stops recording on card 3. </p><p></p><p></p><p>recording starts at 7.30pm</p><p>tswriter</p><p>29-10-2011 19:28:25.125 Recorder:Pid 247 Continuity error... 9 ( prev 7 ) - bad signal?</p><p>29-10-2011 19:30:03.00 analyzer: reset</p><p>29-10-2011 19:30:03.00 PatParser:Reset(0)</p><p>29-10-2011 19:30:03.00 NIT:Reset</p><p>29-10-2011 19:30:03.00 PatParser::Reset done</p><p>29-10-2011 19:30:03.00 cagrabber: reset</p><p>29-10-2011 19:30:03.00 epg: reset</p><p>29-10-2011 19:30:03.00 epg:ResetEPG()</p><p>29-10-2011 19:30:03.00 mhw reset</p><p>29-10-2011 19:30:03.954 CMpTsFilter::Pause()</p><p>29-10-2011 19:30:04.204 CMpTsFilter::Run()</p><p>29-10-2011 19:30:04.204 pmtgrabber: set callback:fdfa18</p><p>29-10-2011 19:30:04.204 pmtgrabber: grab pmt:401 sid:301</p><p>29-10-2011 19:30:04.282 pmtgrabber: got pmt 401 sid:301</p><p>29-10-2011 19:30:04.282 pmtgrabber: PMT pids changed from:</p><p>29-10-2011 19:30:04.282 pcr pid: 0 </p><p>29-10-2011 19:30:04.282 pmt pid: 0 </p><p>29-10-2011 19:30:04.282 pmtgrabber: PMT pids changed to:</p><p>29-10-2011 19:30:04.282 pcr pid: a1 </p><p>29-10-2011 19:30:04.282 pmt pid: 401 </p><p>29-10-2011 19:30:04.282 video pid: a1 type: MPEG2</p><p>29-10-2011 19:30:04.282 audio pid: 51 language: eng type: MPEG2 - audio</p><p>29-10-2011 19:30:04.282 pmtgrabber: got new pmt version:12 ffffffff, service_id:301</p><p>29-10-2011 19:30:04.282 pmtgrabber: do callback pid 401</p><p>29-10-2011 19:30:04.297 analyzer: set video pid:a1</p><p>29-10-2011 19:30:04.297 analyzer: reset</p><p>29-10-2011 19:30:04.297 analyzer: set audio pid:51</p><p>29-10-2011 19:30:04.297 analyzer: reset</p><p>29-10-2011 19:30:04.360 Recorder: RECORD set filename:D:\tv\MediaPortal Capture\SBS ONE\Big, Bigger, Biggest\Big, Bigger, Biggest 2011-10-29.ts</p><p>29-10-2011 19:30:04.360 Recorder: RECORD Received from TvService: pmt pid:0x401 serviceId: 0x301 pmtlength:128</p><p>29-10-2011 19:30:04.360 Recorder: RECORD Old pids cleared</p><p>29-10-2011 19:30:04.360 Recorder: RECORD got pmt - tableid: 0x2 section_length: 128 sid: 0x301</p><p>29-10-2011 19:30:04.360 Recorder: RECORD PMT parsed - Pid 0x401 ServiceId 0x301 stream count: 5</p><p>29-10-2011 19:30:04.360 Recorder: RECORD pcr pid:0xa1</p><p>29-10-2011 19:30:04.360 Recorder: RECORD SetPcrPid clear old PIDs</p><p>29-10-2011 19:30:04.360 Recorder: RECORD add video stream pid: 0xa1 fake pid: 0x30 stream type: 0x2 logical type: 0x2 descriptor length: 16</p><p>29-10-2011 19:30:04.360 Recorder: RECORD add audio stream pid: 0x51 fake pid: 0x40 stream type: 0x4 logical type: 0x4 descriptor length: 17</p><p>29-10-2011 19:30:04.360 Recorder: RECORD add teletext stream pid: 0x29 fake pid: 0x8c stream type: 0x6 logical type: 0x56 descriptor length: 15</p><p>29-10-2011 19:30:04.360 Recorder: RECORD stream rejected - pid: 0x33 stream type: 0x6 logical type: 0xffffffff descriptor length: 8</p><p>29-10-2011 19:30:04.360 Recorder: RECORD stream rejected - pid: 0x1388 stream type: 0xb logical type: 0xb descriptor length: 23</p><p>29-10-2011 19:30:04.375 Recorder: RECORD SetVideoAudioObserver observer ok</p><p>29-10-2011 19:30:04.407 Recorder: RECORD Start 'D:\tv\MediaPortal Capture\SBS ONE\Big, Bigger, Biggest\Big, Bigger, Biggest 2011-10-29.ts'</p><p>29-10-2011 19:30:04.469 Recorder: RECORD start of audio detected</p><p>29-10-2011 19:30:04.766 Recorder: RECORD start of video detected</p><p>29-10-2011 19:30:04.766 Recorder: RECORD clear TS packet queue</p><p>29-10-2011 19:30:04.782 CDiskRecorder::WriteToRecording() - Reset write buffer throttle</p><p>29-10-2011 19:30:04.782 Recorder: RECORD Info : Next broadcaster program clock reference rollover : 0 days 20:55:04 0</p><p>29-10-2011 19:33:51.688 Recorder: TIMESHIFT Stop 'D:\tv\MediaPortal Capture\Timeshift\live4-0.ts.tsbuffer'</p><p></p><p>tvlog - 7.30pm recording</p><p>2011-10-29 19:20:51.954000 [PowerEventThread(8)]: TV service PowerEventThread 30</p><p>2011-10-29 19:30:02.969625 [scheduler thread(26)]: Scheduler: Time to record SBS ONE 7:30 PM-8:30 PM Big, Bigger, Biggest</p><p>2011-10-29 19:30:02.969625 [scheduler thread(26)]: Controller: find free card for channel SBS ONE</p><p>2011-10-29 19:30:02.969625 [scheduler thread(26)]: Controller: find card for channel SBS ONE</p><p>2011-10-29 19:30:02.969625 [scheduler thread(26)]: Controller: got 1 tuning details for SBS ONE</p><p>2011-10-29 19:30:02.969625 [scheduler thread(26)]: Controller: channel #1 DVBT:tv:SBS SBS ONE Freq:571500 ONID:12802 TSID:768 SID:769 PMT:0x401 FTA:True LCN:3 BandWidth:7 </p><p>2011-10-29 19:30:02.969625 [scheduler thread(26)]: Controller: card:4 type:DvbT can tune to channel</p><p>2011-10-29 19:30:02.969625 [scheduler thread(26)]: Controller: card:4 type:DvbT users: 1</p><p>2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: card:3 type:DvbT can tune to channel</p><p>2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: card:3 type:DvbT users: 0</p><p>2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: card:7 type:DvbT can tune to channel</p><p>2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: card:7 type:DvbT users: 0</p><p>2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: card:1 type:DvbIP is disabled</p><p>2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: card:6 type:RadioWebStream is disabled</p><p>2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: card:8 type:Analog is disabled</p><p>2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: found 3 card(s) for channel</p><p>2011-10-29 19:30:02.985250 [scheduler thread(26)]: AdvancedCardAllocation.GetAvailableCardsForChannel took 11 msec</p><p>2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: card:3 type:DvbT is available</p><p>2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: card:7 type:DvbT is available</p><p>2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: card:4 type:DvbT is not available, tuned to different transponder</p><p>2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: found 2 free card(s)</p><p>2011-10-29 19:30:02.985250 [scheduler thread(26)]: AdvancedCardAllocation.GetFreeCardsForChannel took 13 msec</p><p>2011-10-29 19:30:02.985250 [scheduler thread(26)]: scheduler: try max 2 of 2 FREE cards for recording</p><p>2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: epg stop</p><p>2011-10-29 19:30:02.985250 [scheduler thread(26)]: Scheduler : record, first tune to channel</p><p>2011-10-29 19:30:02.985250 [scheduler thread(26)]: card: Tune 3 to SBS ONE</p><p>2011-10-29 19:30:02.985250 [scheduler thread(26)]: card: user: scheduler1171:3:-1 tune DVBT:tv:SBS SBS ONE Freq:571500 ONID:12802 TSID:768 SID:769 PMT:0x401 FTA:True LCN:3 BandWidth:7</p><p>2011-10-29 19:30:03.000875 [scheduler thread(26)]: dvbt: Tune:DVBT:tv:SBS SBS ONE Freq:571500 ONID:12802 TSID:768 SID:769 PMT:0x401 FTA:True LCN:3 BandWidth:7</p><p>2011-10-29 19:30:03.000875 [scheduler thread(26)]: dvb:Submiting tunerequest Channel:SBS ONE subChannel:-1 </p><p>2011-10-29 19:30:03.000875 [scheduler thread(26)]: dvb:Getting new subchannel</p><p>2011-10-29 19:30:03.000875 [scheduler thread(26)]: dvb:GetNewSubChannel:0 #0</p><p>2011-10-29 19:30:03.000875 [scheduler thread(26)]: TvDvbChannel ctor new subchIndex:0</p><p>2011-10-29 19:30:03.000875 [scheduler thread(26)]: dvb:Submit tunerequest size:1 new:0</p><p>2011-10-29 19:30:03.000875 [scheduler thread(26)]: subch:0 OnBeforeTune</p><p>2011-10-29 19:30:03.000875 [scheduler thread(26)]: dvb:Submit tunerequest calling put_TuneRequest</p><p>2011-10-29 19:30:03.938375 [scheduler thread(26)]: dvb:Submit tunerequest done calling put_TuneRequest</p><p>2011-10-29 19:30:03.938375 [scheduler thread(26)]: subch:0 OnAfterTune</p><p>2011-10-29 19:30:03.954000 [scheduler thread(26)]: RunGraph</p><p>2011-10-29 19:30:03.954000 [scheduler thread(26)]: subch:0 OnGraphStart</p><p>2011-10-29 19:30:03.954000 [scheduler thread(26)]: dvb: RunGraph</p><p>2011-10-29 19:30:04.204000 [scheduler thread(26)]: dvb: LockedInOnSignal ok</p><p>2011-10-29 19:30:04.204000 [scheduler thread(26)]: subch:0 OnGraphStarted</p><p>2011-10-29 19:30:04.204000 [scheduler thread(26)]: subch:0 SetupPmtGrabber:pid 401 sid:301</p><p>2011-10-29 19:30:04.204000 [scheduler thread(26)]: subch:0 set pmt grabber pmt:401 sid:301</p><p>2011-10-29 19:30:04.204000 [scheduler thread(26)]: WaitForPMT: Waiting for PMT 401</p><p>2011-10-29 19:30:04.282125 [(14)]: subch:0 OnPMTReceived() pmt:401 ran:True dynamic:False</p><p>2011-10-29 19:30:04.282125 [scheduler thread(26)]: WaitForPMT: Found PMT after 0.078125 seconds.</p><p>2011-10-29 19:30:04.282125 [scheduler thread(26)]: subch:0 SendPmt:301 301 FFFFFFFF 12</p><p>2011-10-29 19:30:04.282125 [scheduler thread(26)]: Decode pmt</p><p>2011-10-29 19:30:04.282125 [scheduler thread(26)]: Set descriptor data with length 3</p><p>2011-10-29 19:30:04.282125 [scheduler thread(26)]: Set descriptor data with length 3</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: PROBLEM : descriptor lengths dont match 6 9</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: Set descriptor data with length 3</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: PROBLEM : descriptor lengths dont match 7 10</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: Set descriptor data with length 3</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: Set descriptor data with length 3</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 SendPMT: Channel is FTA, nothing to do.</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 SetMpegPidMapping</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 pid:A1 pcr</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 pid:401 pmt</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 pid:A1 video type:MPEG-2</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 map pid:A1 video type:MPEG-2</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 pid:51 audio lang: type:MPEG-1</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 map pid:51 audio lang: type:MPEG-1</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 pid:29 teletext type:6</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 map pid:29 teletext type:6</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 pid:33 type:6</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 pid:1388 type:B</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 stop tif</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: WaitForPmt: PMT handling took 0.015625 seconds.</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: dvbt: tune: Graph running. Returning TvLibrary.Implementations.DVB.TvDvbChannel</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: card: Tuner locked: True</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: **************************************************</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: ***** SIGNAL LEVEL: 100, SIGNAL QUALITY: 20 *****</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: **************************************************</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: card: tuned user: scheduler1171 subchannel: 0</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: user:scheduler1171 add</p><p>2011-10-29 19:30:04.297750 [scheduler thread(26)]: Scheduler: MakeFileName() using "seriesformat" (_isSerie=True)</p><p>2011-10-29 19:30:04.360250 [scheduler thread(26)]: Scheduler : record to D:\tv\MediaPortal Capture\SBS ONE\Big, Bigger, Biggest\Big, Bigger, Biggest 2011-10-29.ts</p><p>2011-10-29 19:30:04.360250 [scheduler thread(26)]: Recorder.start add audioVideoEventHandler</p><p>2011-10-29 19:30:04.360250 [scheduler thread(26)]: card: StartRecording 3 D:\tv\MediaPortal Capture\SBS ONE\Big, Bigger, Biggest\Big, Bigger, Biggest 2011-10-29.ts</p><p>2011-10-29 19:30:04.360250 [scheduler thread(26)]: StartRecording to D:\tv\MediaPortal Capture\SBS ONE\Big, Bigger, Biggest\Big, Bigger, Biggest 2011-10-29.ts</p><p>2011-10-29 19:30:04.360250 [scheduler thread(26)]: subch:0 StartRecord(D:\tv\MediaPortal Capture\SBS ONE\Big, Bigger, Biggest\Big, Bigger, Biggest 2011-10-29.ts)</p><p>2011-10-29 19:30:04.360250 [scheduler thread(26)]: subch:0-0 tswriter StartRecording...</p><p>2011-10-29 19:30:04.360250 [scheduler thread(26)]: SetRecorderPids</p><p>2011-10-29 19:30:04.375875 [scheduler thread(26)]: Set video / audio observer</p><p>2011-10-29 19:30:04.407125 [scheduler thread(26)]: DVB subch:0 Started recording</p><p>2011-10-29 19:30:04.407125 [scheduler thread(26)]: card: WaitForRecordingFile - waiting _eventAudio & _eventVideo</p><p>2011-10-29 19:30:04.469625 [(14)]: PID seen - type = Audio</p><p>2011-10-29 19:30:04.469625 [(14)]: Recorder audioVideoEventHandler Audio</p><p>2011-10-29 19:30:04.766500 [(14)]: PID seen - type = Video</p><p>2011-10-29 19:30:04.766500 [(14)]: Recorder audioVideoEventHandler Video</p><p>2011-10-29 19:30:04.782125 [scheduler thread(26)]: card: WaitForRecordingFile - video and audio are seen after 0.375 seconds</p><p>2011-10-29 19:30:04.782125 [Channel state thread(29)]: Controller: DoSetChannelStates for 19 channels</p><p>2011-10-29 19:30:04.782125 [scheduler thread(26)]: Scheduler: adding new row in db for title="Big, Bigger, Biggest" of type="0"</p><p>2011-10-29 19:30:04.797750 [Channel state thread(29)]: ChannelStates.GetChannelMapping took 10 msec</p><p>2011-10-29 19:30:04.797750 [Channel state thread(29)]: ChannelStates.GetTuningChannels took 4 msec</p><p>2011-10-29 19:30:04.813375 [Channel state thread(29)]: ChannelStates.GetAllTimeshiftingAndRecordingChannels took 12 msec</p><p>2011-10-29 19:30:04.813375 [Channel state thread(29)]: ChannelStates.DoSetChannelStates took 29 msec</p><p>2011-10-29 19:30:04.813375 [scheduler thread(26)]: Scheduler: recList: count: 1 add scheduleid: 1171 card: AF9015 BDA Filter</p><p>2011-10-29 19:30:53.079000 [PowerEventThread(8)]: TV service PowerEventThread 30</p><p></p><p></p><p>TV Log - Below is when my recording stopped 19:41:56 (recording started 4 seconds late) - selected channel on remote machine - recording stopped and did not restart - WHY!!!</p><p>2011-10-29 19:35:56.594625 [Channel state thread(17)]: ChannelStates.DoSetChannelStates took 29 msec</p><p>2011-10-29 19:40:54.101000 [PowerEventThread(8)]: TV service PowerEventThread 30</p><p>2011-10-29 19:40:54.101000 [PowerEventThread(8)]: TV service PowerEventThread 30</p><p>2011-10-29 19:41:51.726000 [(21)]: CiMenuSupported called cardid 7</p><p>2011-10-29 19:41:51.726000 [(21)]: CiMenuSupported card WinFast DTV2000 H BDA DVB-T Tuner/Demod (Philips FMD1216ME) supported: False</p><p>2011-10-29 19:41:56.835375 [(21)]: Controller: TimeShiftingWouldUseCard 7 Digital 1</p><p>2011-10-29 19:41:56.835375 [(21)]: Controller: find free card for channel 7 Digital</p><p>2011-10-29 19:41:56.835375 [(21)]: Controller: find card for channel 7 Digital</p><p>2011-10-29 19:41:56.835375 [(21)]: Controller: got 1 tuning details for 7 Digital</p><p>2011-10-29 19:41:56.835375 [(21)]: Controller: channel #1 DVBT:tv:Seven Network 7 Digital Freq:177500 ONID:4115 TSID:1282 SID:1312 PMT:0x200 FTA:True LCN:7 BandWidth:7 </p><p>2011-10-29 19:41:56.835375 [(21)]: Controller: card:4 type:DvbT can tune to channel</p><p>2011-10-29 19:41:56.835375 [(21)]: Controller: card:4 type:DvbT users: 0</p><p>2011-10-29 19:41:56.835375 [(21)]: Controller: card:3 type:DvbT can tune to channel</p><p>2011-10-29 19:41:56.835375 [(21)]: Controller: card:3 type:DvbT users: 1</p><p>2011-10-29 19:41:56.835375 [(21)]: Controller: card:7 type:DvbT can tune to channel</p><p>2011-10-29 19:41:56.835375 [(21)]: Controller: card:7 type:DvbT users: 0</p><p>2011-10-29 19:41:56.835375 [(21)]: Controller: card:1 type:DvbIP is disabled</p><p>2011-10-29 19:41:56.835375 [(21)]: Controller: card:6 type:RadioWebStream is disabled</p><p>2011-10-29 19:41:56.835375 [(21)]: Controller: card:8 type:Analog is disabled</p><p>2011-10-29 19:41:56.835375 [(21)]: Controller: found 3 card(s) for channel</p><p>2011-10-29 19:41:56.835375 [(21)]: AdvancedCardAllocation.GetAvailableCardsForChannel took 5 msec</p><p>2011-10-29 19:41:56.835375 [(21)]: Controller: card:4 type:DvbT is available</p><p>2011-10-29 19:41:56.835375 [(21)]: Controller: card:7 type:DvbT is available</p><p>2011-10-29 19:41:56.835375 [(21)]: Controller: card:3 type:DvbT is not available, tuned to different transponder</p><p>2011-10-29 19:41:56.835375 [(21)]: Controller: found 2 free card(s)</p><p>2011-10-29 19:41:56.851000 [(21)]: AdvancedCardAllocation.GetFreeCardsForChannel took 7 msec</p><p>2011-10-29 19:41:56.851000 [(21)]: CiMenuSupported called cardid 4</p><p>2011-10-29 19:41:56.851000 [(21)]: CiMenuSupported card AF9015 BDA Filter 2 supported: False</p><p>2011-10-29 19:41:56.913500 [(21)]: Controller: StartTimeShifting 7 Digital 1</p><p>2011-10-29 19:41:56.913500 [(21)]: Controller: find free card for channel 7 Digital</p><p>2011-10-29 19:41:56.913500 [(21)]: Controller: find card for channel 7 Digital</p><p>2011-10-29 19:41:56.913500 [(21)]: Controller: got 1 tuning details for 7 Digital</p><p>2011-10-29 19:41:56.913500 [(21)]: Controller: channel #1 DVBT:tv:Seven Network 7 Digital Freq:177500 ONID:4115 TSID:1282 SID:1312 PMT:0x200 FTA:True LCN:7 BandWidth:7 </p><p>2011-10-29 19:41:56.913500 [(21)]: Controller: card:4 type:DvbT can tune to channel</p><p>2011-10-29 19:41:56.913500 [(21)]: Controller: card:4 type:DvbT users: 0</p><p>2011-10-29 19:41:56.913500 [(21)]: Controller: card:3 type:DvbT can tune to channel</p><p>2011-10-29 19:41:56.913500 [(21)]: Controller: card:3 type:DvbT users: 1</p><p>2011-10-29 19:41:56.913500 [(21)]: Controller: card:7 type:DvbT can tune to channel</p><p>2011-10-29 19:41:56.913500 [(21)]: Controller: card:7 type:DvbT users: 0</p><p>2011-10-29 19:41:56.913500 [(21)]: Controller: card:1 type:DvbIP is disabled</p><p>2011-10-29 19:41:56.913500 [(21)]: Controller: card:6 type:RadioWebStream is disabled</p><p>2011-10-29 19:41:56.913500 [(21)]: Controller: card:8 type:Analog is disabled</p><p>2011-10-29 19:41:56.913500 [(21)]: Controller: found 3 card(s) for channel</p><p>2011-10-29 19:41:56.913500 [(21)]: AdvancedCardAllocation.GetAvailableCardsForChannel took 5 msec</p><p>2011-10-29 19:41:56.913500 [(21)]: Controller: card:4 type:DvbT is available</p><p>2011-10-29 19:41:56.913500 [(21)]: Controller: card:7 type:DvbT is available</p><p>2011-10-29 19:41:56.913500 [(21)]: Controller: card:3 type:DvbT is not available, tuned to different transponder</p><p>2011-10-29 19:41:56.913500 [(21)]: Controller: found 2 free card(s)</p><p>2011-10-29 19:41:56.913500 [(21)]: AdvancedCardAllocation.GetFreeCardsForChannel took 7 msec</p><p>2011-10-29 19:41:56.913500 [(21)]: Controller: try max 2 of 2 cards for timeshifting</p><p></p><p>*this causes the analyser reset below that is spot on the time that the recorder stopped!</p><p>*2011-10-29 19:41:56.929125 [(21)]: card: CardTune 4 7 Digital boysroom:4:-1</p><p>2011-10-29 19:41:56.929125 [(21)]: card: Tune 4 to 7 Digital</p><p>2011-10-29 19:41:56.929125 [(21)]: card: user: boysroom:4:-1 tune DVBT:tv:Seven Network 7 Digital Freq:177500 ONID:4115 TSID:1282 SID:1312 PMT:0x200 FTA:True LCN:7 BandWidth:7</p><p>2011-10-29 19:41:56.929125 [(21)]: TimeShifter.OnBeforeTune: resetting audio/video events</p><p>2011-10-29 19:41:56.929125 [(21)]: dvbt: Tune:DVBT:tv:Seven Network 7 Digital Freq:177500 ONID:4115 TSID:1282 SID:1312 PMT:0x200 FTA:True LCN:7 BandWidth:7</p><p>2011-10-29 19:41:56.929125 [(21)]: dvb:Submiting tunerequest Channel:7 Digital subChannel:-1 </p><p>2011-10-29 19:41:56.929125 [(21)]: dvb:Getting new subchannel</p><p>2011-10-29 19:41:56.929125 [(21)]: dvb:GetNewSubChannel:0 #0</p><p>2011-10-29 19:41:56.929125 [(21)]: TvDvbChannel ctor new subchIndex:0</p><p>2011-10-29 19:41:56.929125 [(21)]: dvb:Submit tunerequest size:1 new:0</p><p>2011-10-29 19:41:56.929125 [(21)]: subch:0 OnBeforeTune</p><p>2011-10-29 19:41:56.929125 [(21)]: dvb:Submit tunerequest calling put_TuneRequest</p><p>2011-10-29 19:41:57.913500 [(21)]: dvb:Submit tunerequest done calling put_TuneRequest</p><p>2011-10-29 19:41:57.913500 [(21)]: subch:0 OnAfterTune</p><p>2011-10-29 19:41:57.913500 [(21)]: RunGraph</p><p>2011-10-29 19:41:57.913500 [(21)]: subch:0 OnGraphStart</p><p>2011-10-29 19:41:57.913500 [(21)]: dvb: RunGraph</p><p>2011-10-29 19:41:58.163500 [(21)]: dvb: LockedInOnSignal ok</p><p>2011-10-29 19:41:58.163500 [(21)]: subch:0 OnGraphStarted</p><p>2011-10-29 19:41:58.163500 [(21)]: subch:0 SetupPmtGrabber:pid 200 sid:520</p><p>2011-10-29 19:41:58.163500 [(21)]: subch:0 set pmt grabber pmt:200 sid:520</p><p>2011-10-29 19:41:58.163500 [(21)]: TimeShifter.OnAfterTune: resetting audio/video time</p><p>2011-10-29 19:41:58.163500 [(21)]: WaitForPMT: Waiting for PMT 200</p><p>2011-10-29 19:41:58.226000 [(3)]: subch:0 OnPMTReceived() pmt:200 ran:True dynamic:False</p><p>2011-10-29 19:41:58.226000 [(21)]: WaitForPMT: Found PMT after 0.0625 seconds.</p><p>2011-10-29 19:41:58.226000 [(21)]: subch:0 SendPmt:520 520 FFFFFFFF 12</p><p>2011-10-29 19:41:58.226000 [(21)]: Decode pmt</p><p>2011-10-29 19:41:58.226000 [(21)]: Set descriptor data with length 6</p><p>2011-10-29 19:41:58.226000 [(21)]: Set descriptor data with length 7</p><p>2011-10-29 19:41:58.226000 [(21)]: Set descriptor data with length 3</p><p>2011-10-29 19:41:58.226000 [(21)]: subch:0 SendPMT: Channel is FTA, nothing to do.</p><p>2011-10-29 19:41:58.226000 [(21)]: subch:0 SetMpegPidMapping</p><p>2011-10-29 19:41:58.226000 [(21)]: subch:0 pid:201 pcr</p><p>2011-10-29 19:41:58.226000 [(21)]: subch:0 pid:200 pmt</p><p>2011-10-29 19:41:58.226000 [(21)]: subch:0 pid:201 video type:MPEG-2</p><p>2011-10-29 19:41:58.226000 [(21)]: subch:0 map pid:201 video type:MPEG-2</p><p>2011-10-29 19:41:58.226000 [(21)]: subch:0 pid:202 audio lang:eng type:MPEG-1</p><p>2011-10-29 19:41:58.226000 [(21)]: subch:0 map pid:202 audio lang:eng type:MPEG-1</p><p>2011-10-29 19:41:58.226000 [(21)]: subch:0 pid:204 teletext type:6</p><p>2011-10-29 19:41:58.226000 [(21)]: subch:0 map pid:204 teletext type:6</p><p>2011-10-29 19:41:58.226000 [(21)]: subch:0 pid:299 type:B</p><p>2011-10-29 19:41:58.226000 [(21)]: subch:0 stop tif</p><p>2011-10-29 19:41:58.226000 [(21)]: WaitForPmt: PMT handling took 0 seconds.</p><p>2011-10-29 19:41:58.226000 [(21)]: dvbt: tune: Graph running. Returning TvLibrary.Implementations.DVB.TvDvbChannel</p><p>2011-10-29 19:41:58.226000 [(21)]: card: Tuner locked: True</p><p>2011-10-29 19:41:58.226000 [(21)]: **************************************************</p><p>2011-10-29 19:41:58.226000 [(21)]: ***** SIGNAL LEVEL: 100, SIGNAL QUALITY: 100 *****</p><p>2011-10-29 19:41:58.226000 [(21)]: **************************************************</p><p>2011-10-29 19:41:58.226000 [(21)]: card: tuned user: boysroom subchannel: 0</p><p>2011-10-29 19:41:58.226000 [(21)]: user:boysroom add</p><p>2011-10-29 19:41:58.226000 [(21)]: card2:boysroom 4 0</p><p>2011-10-29 19:41:58.226000 [(21)]: Controller: boysroom 4 0</p><p>2011-10-29 19:41:58.226000 [(21)]: control2:boysroom 4 0</p><p>2011-10-29 19:41:58.241625 [(21)]: Controller: delete timeshift files D:\tv\MediaPortal Capture\Timeshift\live4-0.ts</p><p>2011-10-29 19:41:58.241625 [(21)]: card: StartTimeShifting 4 D:\tv\MediaPortal Capture\Timeshift\live4-0.ts </p><p>2011-10-29 19:41:58.241625 [(21)]: card: CAM enabled : False</p><p>2011-10-29 19:41:58.241625 [(21)]: subch:0 SetTimeShiftFileName:D:\tv\MediaPortal Capture\Timeshift\live4-0.ts</p><p>2011-10-29 19:41:58.241625 [(21)]: Set video / audio observer</p><p>2011-10-29 19:41:58.241625 [(21)]: subch:0 SetTimeShiftFileName fill in pids</p><p>2011-10-29 19:41:58.241625 [(21)]: subch:0-0 tswriter StartTimeshifting...</p><p>2011-10-29 19:41:58.257250 [(21)]: card: WaitForTimeShiftFile - waiting _eventAudio & _eventVideo</p><p>2011-10-29 19:41:58.257250 [(3)]: PID seen - type = Video</p><p>2011-10-29 19:41:58.257250 [(3)]: audioVideoEventHandler Video</p><p>2011-10-29 19:41:58.429125 [(3)]: PID seen - type = Audio</p><p>2011-10-29 19:41:58.429125 [(3)]: audioVideoEventHandler Audio</p><p>2011-10-29 19:41:58.429125 [(21)]: card: WaitForTimeShiftFile - video and audio are seen after 0.171875 seconds</p><p>2011-10-29 19:41:58.429125 [(21)]: user:boysroom card:4 sub:0 add stream:D:\tv\MediaPortal Capture\Timeshift\live4-0.ts.tsbuffer</p><p>2011-10-29 19:41:58.429125 [(21)]: RTSP: add stream stream4.0 file:D:\tv\MediaPortal Capture\Timeshift\live4-0.ts.tsbuffer</p><p>2011-10-29 19:41:58.429125 [(21)]: Controller: StartTimeShifting started on card:4 to D:\tv\MediaPortal Capture\Timeshift\live4-0.ts.tsbuffer</p><p>2011-10-29 19:41:58.429125 [(21)]: user:boysroom remove</p><p>2011-10-29 19:41:58.429125 [(21)]: subch:0-0 tswriter StopTimeshifting...</p><p>2011-10-29 19:41:58.429125 [(21)]: tvcard:FreeSubChannel: subchannels count 1 subch#0 keep graph=False</p><p>2011-10-29 19:41:58.429125 [(21)]: DVB subch:0 Decompose()</p><p>2011-10-29 19:41:58.429125 [(21)]: FreeSubChannel CA: freeing sub channel : 0</p><p>2011-10-29 19:41:58.429125 [(21)]: tvcard:FreeSubChannel : no subchannels present, pausing graph</p><p>2011-10-29 19:41:58.429125 [(21)]: dvb:StopGraph called</p><p>2011-10-29 19:41:58.429125 [(21)]: tvcard:FreeAllSubChannels</p><p>2011-10-29 19:41:58.429125 [(21)]: dvb:StopGraph</p><p>2011-10-29 19:41:58.429125 [(21)]: dvb:StopGraph called</p><p>2011-10-29 19:41:58.444750 [(21)]: tvcard:FreeAllSubChannels</p><p>2011-10-29 19:41:58.444750 [(21)]: dvb:StopGraph filterstate already stopped, returning.</p><p>2011-10-29 19:41:58.444750 [TS_File_Cleanup(24)]: card: delete timeshift files D:\tv\MediaPortal Capture\Timeshift\live7-0.ts</p><p>2011-10-29 19:41:58.444750 [TS_File_Cleanup(24)]: card: trying to delete D:\tv\MediaPortal Capture\Timeshift\live7-0.ts.tsbuffer</p><p>2011-10-29 19:41:58.444750 [Channel state thread(19)]: Controller: DoSetChannelStates for 19 channels</p><p>2011-10-29 19:41:58.444750 [Channel state thread(19)]: ChannelStates.GetChannelMapping took 4 msec</p><p>2011-10-29 19:41:58.444750 [Channel state thread(19)]: ChannelStates.GetTuningChannels took 4 msec</p><p>2011-10-29 19:41:58.460375 [(21)]: CiMenuSupported called cardid 4</p><p>2011-10-29 19:41:58.460375 [(21)]: CiMenuSupported card AF9015 BDA Filter 2 supported: False</p><p>2011-10-29 19:41:58.460375 [Channel state thread(19)]: ChannelStates.GetAllTimeshiftingAndRecordingChannels took 14 msec</p><p>2011-10-29 19:41:58.460375 [Channel state thread(19)]: ChannelStates.DoSetChannelStates took 25 msec</p><p>2011-10-29 19:42:03.444750 [TS_File_Cleanup(24)]: card: delete timeshift files D:\tv\MediaPortal Capture\Timeshift\live7-0.ts</p><p>2011-10-29 19:42:03.444750 [TS_File_Cleanup(24)]: card: trying to delete D:\tv\MediaPortal Capture\Timeshift\live7-0.ts.tsbuffer</p><p>2011-10-29 19:42:03.444750 [TS_File_Cleanup(24)]: card: deleted file D:\tv\MediaPortal Capture\Timeshift\live7-0.ts.tsbuffer</p><p>2011-10-29 19:42:03.444750 [TS_File_Cleanup(24)]: card: trying to delete D:\tv\MediaPortal Capture\Timeshift\live7-0.ts.tsbuffer1.ts</p><p>2011-10-29 19:42:03.444750 [TS_File_Cleanup(24)]: card: deleted file D:\tv\MediaPortal Capture\Timeshift\live7-0.ts.tsbuffer1.ts</p><p>2011-10-29 19:44:03.960375 [(21)]: CiMenuSupported called cardid 4</p><p>2011-10-29 19:44:03.960375 [(21)]: CiMenuSupported card AF9015 BDA Filter 2 supported: False</p><p></p><p></p><p></p><p>TSwriter - Continuity error at 19:39 - but there is nothing in TV log above at this time and recording does not stop till 19:41:56 (per recording)...</p><p>29-10-2011 19:35:56.563 CDiskRecorder::Flush() - Throttle to 15416 bytes</p><p>29-10-2011 19:35:56.563 Recorder: TIMESHIFT start of audio detected</p><p>29-10-2011 19:35:56.610 CDiskRecorder::Flush() - Throttle to 32336 bytes (max)</p><p>29-10-2011 19:39:46.47 Recorder:Pid 207 Continuity error... 6 ( prev 8 ) - bad signal?</p><p>29-10-2011 19:39:46.47 Recorder:Pid 2d0 Continuity error... 2 ( prev 0 ) - bad signal?</p><p>29-10-2011 19:39:46.63 Recorder:Pid 247 Continuity error... 3 ( prev 1 ) - bad signal?</p><p>*29-10-2011 19:41:56.929 analyzer: reset</p><p>29-10-2011 19:41:56.929 PatParser:Reset(0)</p><p>29-10-2011 19:41:56.929 NIT:Reset</p><p>29-10-2011 19:41:56.929 PatParser::Reset done</p><p>29-10-2011 19:41:56.929 cagrabber: reset</p><p>29-10-2011 19:41:56.929 epg: reset</p><p>29-10-2011 19:41:56.929 epg:ResetEPG()</p><p>29-10-2011 19:41:56.929 mhw reset</p><p>29-10-2011 19:41:57.913 CMpTsFilter::Pause()</p><p>29-10-2011 19:41:58.163 CMpTsFilter::Run()</p><p>29-10-2011 19:41:58.163 pmtgrabber: set callback:fdfc18</p><p>29-10-2011 19:41:58.163 pmtgrabber: grab pmt:200 sid:520</p><p>29-10-2011 19:41:58.226 pmtgrabber: got pmt 200 sid:520</p><p>29-10-2011 19:41:58.226 pmtgrabber: PMT pids changed from:</p><p>29-10-2011 19:41:58.226 pcr pid: 0 </p><p>29-10-2011 19:41:58.226 pmt pid: 0 </p><p>29-10-2011 19:41:58.226 pmtgrabber: PMT pids changed to:</p><p>29-10-2011 19:41:58.226 pcr pid: 201 </p><p>29-10-2011 19:41:58.226 pmt pid: 200 </p><p>29-10-2011 19:41:58.226 video pid: 201 type: MPEG2</p><p>29-10-2011 19:41:58.226 audio pid: 202 language: eng type: MPEG1 - audio</p><p>29-10-2011 19:41:58.226 pmtgrabber: got new pmt version:12 ffffffff, service_id:520</p><p>29-10-2011 19:41:58.226 pmtgrabber: do callback pid 200</p><p>29-10-2011 19:41:58.226 analyzer: set video pid:201</p><p>29-10-2011 19:41:58.226 analyzer: reset</p><p>29-10-2011 19:41:58.226 analyzer: set audio pid:202</p><p>29-10-2011 19:41:58.226 analyzer: reset</p><p>29-10-2011 19:41:58.241 Recorder: TIMESHIFT SetVideoAudioObserver observer ok</p><p>29-10-2011 19:41:58.241 Recorder: TIMESHIFT set filename:D:\tv\MediaPortal Capture\Timeshift\live4-0.ts.tsbuffer</p><p>29-10-2011 19:41:58.241 CDiskRecorder::SetChannelType() - Channel type is 0</p><p>29-10-2011 19:41:58.241 CDiskRecorder::SetChannelType() - Channel type is 0</p><p>29-10-2011 19:41:58.241 Recorder: TIMESHIFT paused=yes</p><p>29-10-2011 19:41:58.241 Recorder: TIMESHIFT Received from TvService: pmt pid:0x200 serviceId: 0x520 pmtlength:69</p><p>29-10-2011 19:41:58.241 Recorder: TIMESHIFT Old pids cleared</p><p>29-10-2011 19:41:58.241 Recorder: TIMESHIFT got pmt - tableid: 0x2 section_length: 69 sid: 0x520</p><p>29-10-2011 19:41:58.241 Recorder: TIMESHIFT PMT parsed - Pid 0x200 ServiceId 0x520 stream count: 4</p><p>29-10-2011 19:41:58.241 Recorder: TIMESHIFT pcr pid:0x201</p><p>29-10-2011 19:41:58.241 Recorder: TIMESHIFT SetPcrPid clear old PIDs</p><p>29-10-2011 19:41:58.241 Recorder: TIMESHIFT add video stream pid: 0x201 fake pid: 0x30 stream type: 0x2 logical type: 0x2 descriptor length: 5</p><p>29-10-2011 19:41:58.241 Recorder: TIMESHIFT add audio stream pid: 0x202 fake pid: 0x40 stream type: 0x3 logical type: 0x3 descriptor length: 6</p><p>29-10-2011 19:41:58.241 Recorder: TIMESHIFT add teletext stream pid: 0x204 fake pid: 0x8e stream type: 0x6 logical type: 0x56 descriptor length: 7</p><p>29-10-2011 19:41:58.241 Recorder: TIMESHIFT stream rejected - pid: 0x299 stream type: 0xb logical type: 0xb descriptor length: 18</p><p>29-10-2011 19:41:58.241 Recorder: TIMESHIFT paused=no</p><p>29-10-2011 19:41:58.241 Recorder: TIMESHIFT Start 'D:\tv\MediaPortal Capture\Timeshift\live4-0.ts.tsbuffer'</p><p>29-10-2011 19:41:58.257 Recorder: TIMESHIFT start of video detected</p><p>29-10-2011 19:41:58.288 Recorder: TIMESHIFT clear TS packet queue</p><p>29-10-2011 19:41:58.288 CDiskRecorder::WriteToTimeshiftFile() - Reset write buffer throttle</p><p>29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 376 bytes</p><p>29-10-2011 19:41:58.288 Recorder: TIMESHIFT Info : Next broadcaster program clock reference rollover : 0 days 04:34:33 0</p><p>29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 564 bytes</p><p>29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 940 bytes</p><p>29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 940 bytes</p><p>29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 940 bytes</p><p>29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 940 bytes</p><p>29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 940 bytes</p><p>29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 1880 bytes</p><p>29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 1880 bytes</p><p>29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 1880 bytes</p><p>29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 1880 bytes</p><p>29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 1880 bytes</p><p>29-10-2011 19:41:58.304 CDiskRecorder::Flush() - Throttle to 3760 bytes</p><p>29-10-2011 19:41:58.304 CDiskRecorder::Flush() - Throttle to 3760 bytes</p><p>29-10-2011 19:41:58.304 CDiskRecorder::Flush() - Throttle to 3760 bytes</p><p>29-10-2011 19:41:58.304 CDiskRecorder::Flush() - Throttle to 6016 bytes</p><p>29-10-2011 19:41:58.335 CDiskRecorder::Flush() - Throttle to 7520 bytes</p><p>29-10-2011 19:41:58.335 CDiskRecorder::Flush() - Throttle to 9400 bytes</p><p>29-10-2011 19:41:58.351 CDiskRecorder::Flush() - Throttle to 15416 bytes</p><p>29-10-2011 19:41:58.382 CDiskRecorder::Flush() - Throttle to 32336 bytes (max)</p><p>29-10-2011 19:41:58.429 Recorder: TIMESHIFT start of audio detected</p><p>29-10-2011 19:41:58.429 Recorder: TIMESHIFT Stop 'D:\tv\MediaPortal Capture\Timeshift\live7-0.ts.tsbuffer'</p><p>29-10-2011 19:41:58.429 Recorder: TIMESHIFT Reset</p><p>29-10-2011 19:41:58.429 CDiskRecorder::Reset() - Reset write buffer throttle</p><p>29-10-2011 19:41:58.429 del m_pVideoAnalyzer</p><p>29-10-2011 19:41:58.429 analyzer: reset</p><p>29-10-2011 19:41:58.429 del m_pPmtGrabber</p><p>29-10-2011 19:41:58.429 del m_pRecorder</p><p>29-10-2011 19:41:58.429 del m_pTimeShifting</p><p>29-10-2011 19:41:58.429 del m_pTeletextGrabber</p><p>29-10-2011 19:41:58.429 del m_pCaGrabber</p><p>29-10-2011 19:41:58.429 del done...</p><p>29-10-2011 19:41:58.429 CMpTsFilter::Pause()</p><p>29-10-2011 19:41:58.429 CMpTsFilter::Stop()</p><p>29-10-2011 19:44:09.913 Recorder: TIMESHIFT paused=yes</p><p>29-10-2011 19:44:09.913 epg: reset</p><p>29-10-2011 19:44:09.913 epg:ResetEPG()</p><p>29-10-2011 19:44:09.913 mhw reset</p><p>29-10-2011 19:44:10.835 pmtgrabber: set callback:fdfc18</p><p>29-10-2011 19:44:10.835 pmtgrabber: grab pmt:100 sid:421</p><p>29-10-2011 19:44:10.851 pmtgrabber: got pmt 100 sid:421</p><p>29-10-2011 19:44:10.851 pmtgrabber: PMT pids changed from:</p><p>29-10-2011 19:44:10.851 pcr pid: 0 </p><p>29-10-2011 19:44:10.851 pmt pid: 100 </p><p>29-10-2011 19:44:10.851 pmtgrabber: PMT pids changed to:</p><p>29-10-2011 19:44:10.851 pcr pid: 87 </p><p>29-10-2011 19:44:10.851 pmt pid: 100 </p><p>29-10-2011 19:44:10.851 video pid: 207 type: MPEG2</p><p>29-10-2011 19:44:10.851 audio pid: 2d0 language: eng type: MPEG2 - audio</p><p>29-10-2011 19:44:10.851 pmtgrabber: got new pmt version:2 ffffffff, service_id:421</p><p></p><p>[/CODE]</p></blockquote><p></p>
[QUOTE="feizex, post: 808152, member: 96644"] Hi, I have been tracking this down ever since I installed MP a couple of years ago. The problem is that I can't use both tuners reliably. Because occasionally when one is in use and MP tries tuning the other, it will stop the one already in use. Currently my workaround is to disable one of the tuners on this card (USB stick). Obviously that is sub-optimal. Sometimes I can tune on both channels OK. But other times tuning one, stops the other. I think perhaps this is an issue peculiar to this card. But then, maybe it is MP fully resetting the card when it should only reset one tuner. I have attached one instance of failure logs with some notes. Sorry it is a bit long. I have * the point of failure. Please help. Thanks, Feizex. :thx: [b]MediaPortal Version[/b]: MediaPortal 1.2.1.0 [b]Windows Version[/b]: Windows XP (Service Pack 3) [b]CPU Type[/b]: AMD Phenom II dual-core 3.1GHz [b]1. TV Card[/b]: Avermedia TwinStar (A825) Dual DVB-T USB [b]3. TV Card[/b]: WinFast DTV2000H (PCI) [CODE] Recording begins on card 3 at 19:30:04. The MP client card tune at 19:41:56 to card 4 stops recording on card 3. recording starts at 7.30pm tswriter 29-10-2011 19:28:25.125 Recorder:Pid 247 Continuity error... 9 ( prev 7 ) - bad signal? 29-10-2011 19:30:03.00 analyzer: reset 29-10-2011 19:30:03.00 PatParser:Reset(0) 29-10-2011 19:30:03.00 NIT:Reset 29-10-2011 19:30:03.00 PatParser::Reset done 29-10-2011 19:30:03.00 cagrabber: reset 29-10-2011 19:30:03.00 epg: reset 29-10-2011 19:30:03.00 epg:ResetEPG() 29-10-2011 19:30:03.00 mhw reset 29-10-2011 19:30:03.954 CMpTsFilter::Pause() 29-10-2011 19:30:04.204 CMpTsFilter::Run() 29-10-2011 19:30:04.204 pmtgrabber: set callback:fdfa18 29-10-2011 19:30:04.204 pmtgrabber: grab pmt:401 sid:301 29-10-2011 19:30:04.282 pmtgrabber: got pmt 401 sid:301 29-10-2011 19:30:04.282 pmtgrabber: PMT pids changed from: 29-10-2011 19:30:04.282 pcr pid: 0 29-10-2011 19:30:04.282 pmt pid: 0 29-10-2011 19:30:04.282 pmtgrabber: PMT pids changed to: 29-10-2011 19:30:04.282 pcr pid: a1 29-10-2011 19:30:04.282 pmt pid: 401 29-10-2011 19:30:04.282 video pid: a1 type: MPEG2 29-10-2011 19:30:04.282 audio pid: 51 language: eng type: MPEG2 - audio 29-10-2011 19:30:04.282 pmtgrabber: got new pmt version:12 ffffffff, service_id:301 29-10-2011 19:30:04.282 pmtgrabber: do callback pid 401 29-10-2011 19:30:04.297 analyzer: set video pid:a1 29-10-2011 19:30:04.297 analyzer: reset 29-10-2011 19:30:04.297 analyzer: set audio pid:51 29-10-2011 19:30:04.297 analyzer: reset 29-10-2011 19:30:04.360 Recorder: RECORD set filename:D:\tv\MediaPortal Capture\SBS ONE\Big, Bigger, Biggest\Big, Bigger, Biggest 2011-10-29.ts 29-10-2011 19:30:04.360 Recorder: RECORD Received from TvService: pmt pid:0x401 serviceId: 0x301 pmtlength:128 29-10-2011 19:30:04.360 Recorder: RECORD Old pids cleared 29-10-2011 19:30:04.360 Recorder: RECORD got pmt - tableid: 0x2 section_length: 128 sid: 0x301 29-10-2011 19:30:04.360 Recorder: RECORD PMT parsed - Pid 0x401 ServiceId 0x301 stream count: 5 29-10-2011 19:30:04.360 Recorder: RECORD pcr pid:0xa1 29-10-2011 19:30:04.360 Recorder: RECORD SetPcrPid clear old PIDs 29-10-2011 19:30:04.360 Recorder: RECORD add video stream pid: 0xa1 fake pid: 0x30 stream type: 0x2 logical type: 0x2 descriptor length: 16 29-10-2011 19:30:04.360 Recorder: RECORD add audio stream pid: 0x51 fake pid: 0x40 stream type: 0x4 logical type: 0x4 descriptor length: 17 29-10-2011 19:30:04.360 Recorder: RECORD add teletext stream pid: 0x29 fake pid: 0x8c stream type: 0x6 logical type: 0x56 descriptor length: 15 29-10-2011 19:30:04.360 Recorder: RECORD stream rejected - pid: 0x33 stream type: 0x6 logical type: 0xffffffff descriptor length: 8 29-10-2011 19:30:04.360 Recorder: RECORD stream rejected - pid: 0x1388 stream type: 0xb logical type: 0xb descriptor length: 23 29-10-2011 19:30:04.375 Recorder: RECORD SetVideoAudioObserver observer ok 29-10-2011 19:30:04.407 Recorder: RECORD Start 'D:\tv\MediaPortal Capture\SBS ONE\Big, Bigger, Biggest\Big, Bigger, Biggest 2011-10-29.ts' 29-10-2011 19:30:04.469 Recorder: RECORD start of audio detected 29-10-2011 19:30:04.766 Recorder: RECORD start of video detected 29-10-2011 19:30:04.766 Recorder: RECORD clear TS packet queue 29-10-2011 19:30:04.782 CDiskRecorder::WriteToRecording() - Reset write buffer throttle 29-10-2011 19:30:04.782 Recorder: RECORD Info : Next broadcaster program clock reference rollover : 0 days 20:55:04 0 29-10-2011 19:33:51.688 Recorder: TIMESHIFT Stop 'D:\tv\MediaPortal Capture\Timeshift\live4-0.ts.tsbuffer' tvlog - 7.30pm recording 2011-10-29 19:20:51.954000 [PowerEventThread(8)]: TV service PowerEventThread 30 2011-10-29 19:30:02.969625 [scheduler thread(26)]: Scheduler: Time to record SBS ONE 7:30 PM-8:30 PM Big, Bigger, Biggest 2011-10-29 19:30:02.969625 [scheduler thread(26)]: Controller: find free card for channel SBS ONE 2011-10-29 19:30:02.969625 [scheduler thread(26)]: Controller: find card for channel SBS ONE 2011-10-29 19:30:02.969625 [scheduler thread(26)]: Controller: got 1 tuning details for SBS ONE 2011-10-29 19:30:02.969625 [scheduler thread(26)]: Controller: channel #1 DVBT:tv:SBS SBS ONE Freq:571500 ONID:12802 TSID:768 SID:769 PMT:0x401 FTA:True LCN:3 BandWidth:7 2011-10-29 19:30:02.969625 [scheduler thread(26)]: Controller: card:4 type:DvbT can tune to channel 2011-10-29 19:30:02.969625 [scheduler thread(26)]: Controller: card:4 type:DvbT users: 1 2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: card:3 type:DvbT can tune to channel 2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: card:3 type:DvbT users: 0 2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: card:7 type:DvbT can tune to channel 2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: card:7 type:DvbT users: 0 2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: card:1 type:DvbIP is disabled 2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: card:6 type:RadioWebStream is disabled 2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: card:8 type:Analog is disabled 2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: found 3 card(s) for channel 2011-10-29 19:30:02.985250 [scheduler thread(26)]: AdvancedCardAllocation.GetAvailableCardsForChannel took 11 msec 2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: card:3 type:DvbT is available 2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: card:7 type:DvbT is available 2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: card:4 type:DvbT is not available, tuned to different transponder 2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: found 2 free card(s) 2011-10-29 19:30:02.985250 [scheduler thread(26)]: AdvancedCardAllocation.GetFreeCardsForChannel took 13 msec 2011-10-29 19:30:02.985250 [scheduler thread(26)]: scheduler: try max 2 of 2 FREE cards for recording 2011-10-29 19:30:02.985250 [scheduler thread(26)]: Controller: epg stop 2011-10-29 19:30:02.985250 [scheduler thread(26)]: Scheduler : record, first tune to channel 2011-10-29 19:30:02.985250 [scheduler thread(26)]: card: Tune 3 to SBS ONE 2011-10-29 19:30:02.985250 [scheduler thread(26)]: card: user: scheduler1171:3:-1 tune DVBT:tv:SBS SBS ONE Freq:571500 ONID:12802 TSID:768 SID:769 PMT:0x401 FTA:True LCN:3 BandWidth:7 2011-10-29 19:30:03.000875 [scheduler thread(26)]: dvbt: Tune:DVBT:tv:SBS SBS ONE Freq:571500 ONID:12802 TSID:768 SID:769 PMT:0x401 FTA:True LCN:3 BandWidth:7 2011-10-29 19:30:03.000875 [scheduler thread(26)]: dvb:Submiting tunerequest Channel:SBS ONE subChannel:-1 2011-10-29 19:30:03.000875 [scheduler thread(26)]: dvb:Getting new subchannel 2011-10-29 19:30:03.000875 [scheduler thread(26)]: dvb:GetNewSubChannel:0 #0 2011-10-29 19:30:03.000875 [scheduler thread(26)]: TvDvbChannel ctor new subchIndex:0 2011-10-29 19:30:03.000875 [scheduler thread(26)]: dvb:Submit tunerequest size:1 new:0 2011-10-29 19:30:03.000875 [scheduler thread(26)]: subch:0 OnBeforeTune 2011-10-29 19:30:03.000875 [scheduler thread(26)]: dvb:Submit tunerequest calling put_TuneRequest 2011-10-29 19:30:03.938375 [scheduler thread(26)]: dvb:Submit tunerequest done calling put_TuneRequest 2011-10-29 19:30:03.938375 [scheduler thread(26)]: subch:0 OnAfterTune 2011-10-29 19:30:03.954000 [scheduler thread(26)]: RunGraph 2011-10-29 19:30:03.954000 [scheduler thread(26)]: subch:0 OnGraphStart 2011-10-29 19:30:03.954000 [scheduler thread(26)]: dvb: RunGraph 2011-10-29 19:30:04.204000 [scheduler thread(26)]: dvb: LockedInOnSignal ok 2011-10-29 19:30:04.204000 [scheduler thread(26)]: subch:0 OnGraphStarted 2011-10-29 19:30:04.204000 [scheduler thread(26)]: subch:0 SetupPmtGrabber:pid 401 sid:301 2011-10-29 19:30:04.204000 [scheduler thread(26)]: subch:0 set pmt grabber pmt:401 sid:301 2011-10-29 19:30:04.204000 [scheduler thread(26)]: WaitForPMT: Waiting for PMT 401 2011-10-29 19:30:04.282125 [(14)]: subch:0 OnPMTReceived() pmt:401 ran:True dynamic:False 2011-10-29 19:30:04.282125 [scheduler thread(26)]: WaitForPMT: Found PMT after 0.078125 seconds. 2011-10-29 19:30:04.282125 [scheduler thread(26)]: subch:0 SendPmt:301 301 FFFFFFFF 12 2011-10-29 19:30:04.282125 [scheduler thread(26)]: Decode pmt 2011-10-29 19:30:04.282125 [scheduler thread(26)]: Set descriptor data with length 3 2011-10-29 19:30:04.282125 [scheduler thread(26)]: Set descriptor data with length 3 2011-10-29 19:30:04.297750 [scheduler thread(26)]: PROBLEM : descriptor lengths dont match 6 9 2011-10-29 19:30:04.297750 [scheduler thread(26)]: Set descriptor data with length 3 2011-10-29 19:30:04.297750 [scheduler thread(26)]: PROBLEM : descriptor lengths dont match 7 10 2011-10-29 19:30:04.297750 [scheduler thread(26)]: Set descriptor data with length 3 2011-10-29 19:30:04.297750 [scheduler thread(26)]: Set descriptor data with length 3 2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 SendPMT: Channel is FTA, nothing to do. 2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 SetMpegPidMapping 2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 pid:A1 pcr 2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 pid:401 pmt 2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 pid:A1 video type:MPEG-2 2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 map pid:A1 video type:MPEG-2 2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 pid:51 audio lang: type:MPEG-1 2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 map pid:51 audio lang: type:MPEG-1 2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 pid:29 teletext type:6 2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 map pid:29 teletext type:6 2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 pid:33 type:6 2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 pid:1388 type:B 2011-10-29 19:30:04.297750 [scheduler thread(26)]: subch:0 stop tif 2011-10-29 19:30:04.297750 [scheduler thread(26)]: WaitForPmt: PMT handling took 0.015625 seconds. 2011-10-29 19:30:04.297750 [scheduler thread(26)]: dvbt: tune: Graph running. Returning TvLibrary.Implementations.DVB.TvDvbChannel 2011-10-29 19:30:04.297750 [scheduler thread(26)]: card: Tuner locked: True 2011-10-29 19:30:04.297750 [scheduler thread(26)]: ************************************************** 2011-10-29 19:30:04.297750 [scheduler thread(26)]: ***** SIGNAL LEVEL: 100, SIGNAL QUALITY: 20 ***** 2011-10-29 19:30:04.297750 [scheduler thread(26)]: ************************************************** 2011-10-29 19:30:04.297750 [scheduler thread(26)]: card: tuned user: scheduler1171 subchannel: 0 2011-10-29 19:30:04.297750 [scheduler thread(26)]: user:scheduler1171 add 2011-10-29 19:30:04.297750 [scheduler thread(26)]: Scheduler: MakeFileName() using "seriesformat" (_isSerie=True) 2011-10-29 19:30:04.360250 [scheduler thread(26)]: Scheduler : record to D:\tv\MediaPortal Capture\SBS ONE\Big, Bigger, Biggest\Big, Bigger, Biggest 2011-10-29.ts 2011-10-29 19:30:04.360250 [scheduler thread(26)]: Recorder.start add audioVideoEventHandler 2011-10-29 19:30:04.360250 [scheduler thread(26)]: card: StartRecording 3 D:\tv\MediaPortal Capture\SBS ONE\Big, Bigger, Biggest\Big, Bigger, Biggest 2011-10-29.ts 2011-10-29 19:30:04.360250 [scheduler thread(26)]: StartRecording to D:\tv\MediaPortal Capture\SBS ONE\Big, Bigger, Biggest\Big, Bigger, Biggest 2011-10-29.ts 2011-10-29 19:30:04.360250 [scheduler thread(26)]: subch:0 StartRecord(D:\tv\MediaPortal Capture\SBS ONE\Big, Bigger, Biggest\Big, Bigger, Biggest 2011-10-29.ts) 2011-10-29 19:30:04.360250 [scheduler thread(26)]: subch:0-0 tswriter StartRecording... 2011-10-29 19:30:04.360250 [scheduler thread(26)]: SetRecorderPids 2011-10-29 19:30:04.375875 [scheduler thread(26)]: Set video / audio observer 2011-10-29 19:30:04.407125 [scheduler thread(26)]: DVB subch:0 Started recording 2011-10-29 19:30:04.407125 [scheduler thread(26)]: card: WaitForRecordingFile - waiting _eventAudio & _eventVideo 2011-10-29 19:30:04.469625 [(14)]: PID seen - type = Audio 2011-10-29 19:30:04.469625 [(14)]: Recorder audioVideoEventHandler Audio 2011-10-29 19:30:04.766500 [(14)]: PID seen - type = Video 2011-10-29 19:30:04.766500 [(14)]: Recorder audioVideoEventHandler Video 2011-10-29 19:30:04.782125 [scheduler thread(26)]: card: WaitForRecordingFile - video and audio are seen after 0.375 seconds 2011-10-29 19:30:04.782125 [Channel state thread(29)]: Controller: DoSetChannelStates for 19 channels 2011-10-29 19:30:04.782125 [scheduler thread(26)]: Scheduler: adding new row in db for title="Big, Bigger, Biggest" of type="0" 2011-10-29 19:30:04.797750 [Channel state thread(29)]: ChannelStates.GetChannelMapping took 10 msec 2011-10-29 19:30:04.797750 [Channel state thread(29)]: ChannelStates.GetTuningChannels took 4 msec 2011-10-29 19:30:04.813375 [Channel state thread(29)]: ChannelStates.GetAllTimeshiftingAndRecordingChannels took 12 msec 2011-10-29 19:30:04.813375 [Channel state thread(29)]: ChannelStates.DoSetChannelStates took 29 msec 2011-10-29 19:30:04.813375 [scheduler thread(26)]: Scheduler: recList: count: 1 add scheduleid: 1171 card: AF9015 BDA Filter 2011-10-29 19:30:53.079000 [PowerEventThread(8)]: TV service PowerEventThread 30 TV Log - Below is when my recording stopped 19:41:56 (recording started 4 seconds late) - selected channel on remote machine - recording stopped and did not restart - WHY!!! 2011-10-29 19:35:56.594625 [Channel state thread(17)]: ChannelStates.DoSetChannelStates took 29 msec 2011-10-29 19:40:54.101000 [PowerEventThread(8)]: TV service PowerEventThread 30 2011-10-29 19:40:54.101000 [PowerEventThread(8)]: TV service PowerEventThread 30 2011-10-29 19:41:51.726000 [(21)]: CiMenuSupported called cardid 7 2011-10-29 19:41:51.726000 [(21)]: CiMenuSupported card WinFast DTV2000 H BDA DVB-T Tuner/Demod (Philips FMD1216ME) supported: False 2011-10-29 19:41:56.835375 [(21)]: Controller: TimeShiftingWouldUseCard 7 Digital 1 2011-10-29 19:41:56.835375 [(21)]: Controller: find free card for channel 7 Digital 2011-10-29 19:41:56.835375 [(21)]: Controller: find card for channel 7 Digital 2011-10-29 19:41:56.835375 [(21)]: Controller: got 1 tuning details for 7 Digital 2011-10-29 19:41:56.835375 [(21)]: Controller: channel #1 DVBT:tv:Seven Network 7 Digital Freq:177500 ONID:4115 TSID:1282 SID:1312 PMT:0x200 FTA:True LCN:7 BandWidth:7 2011-10-29 19:41:56.835375 [(21)]: Controller: card:4 type:DvbT can tune to channel 2011-10-29 19:41:56.835375 [(21)]: Controller: card:4 type:DvbT users: 0 2011-10-29 19:41:56.835375 [(21)]: Controller: card:3 type:DvbT can tune to channel 2011-10-29 19:41:56.835375 [(21)]: Controller: card:3 type:DvbT users: 1 2011-10-29 19:41:56.835375 [(21)]: Controller: card:7 type:DvbT can tune to channel 2011-10-29 19:41:56.835375 [(21)]: Controller: card:7 type:DvbT users: 0 2011-10-29 19:41:56.835375 [(21)]: Controller: card:1 type:DvbIP is disabled 2011-10-29 19:41:56.835375 [(21)]: Controller: card:6 type:RadioWebStream is disabled 2011-10-29 19:41:56.835375 [(21)]: Controller: card:8 type:Analog is disabled 2011-10-29 19:41:56.835375 [(21)]: Controller: found 3 card(s) for channel 2011-10-29 19:41:56.835375 [(21)]: AdvancedCardAllocation.GetAvailableCardsForChannel took 5 msec 2011-10-29 19:41:56.835375 [(21)]: Controller: card:4 type:DvbT is available 2011-10-29 19:41:56.835375 [(21)]: Controller: card:7 type:DvbT is available 2011-10-29 19:41:56.835375 [(21)]: Controller: card:3 type:DvbT is not available, tuned to different transponder 2011-10-29 19:41:56.835375 [(21)]: Controller: found 2 free card(s) 2011-10-29 19:41:56.851000 [(21)]: AdvancedCardAllocation.GetFreeCardsForChannel took 7 msec 2011-10-29 19:41:56.851000 [(21)]: CiMenuSupported called cardid 4 2011-10-29 19:41:56.851000 [(21)]: CiMenuSupported card AF9015 BDA Filter 2 supported: False 2011-10-29 19:41:56.913500 [(21)]: Controller: StartTimeShifting 7 Digital 1 2011-10-29 19:41:56.913500 [(21)]: Controller: find free card for channel 7 Digital 2011-10-29 19:41:56.913500 [(21)]: Controller: find card for channel 7 Digital 2011-10-29 19:41:56.913500 [(21)]: Controller: got 1 tuning details for 7 Digital 2011-10-29 19:41:56.913500 [(21)]: Controller: channel #1 DVBT:tv:Seven Network 7 Digital Freq:177500 ONID:4115 TSID:1282 SID:1312 PMT:0x200 FTA:True LCN:7 BandWidth:7 2011-10-29 19:41:56.913500 [(21)]: Controller: card:4 type:DvbT can tune to channel 2011-10-29 19:41:56.913500 [(21)]: Controller: card:4 type:DvbT users: 0 2011-10-29 19:41:56.913500 [(21)]: Controller: card:3 type:DvbT can tune to channel 2011-10-29 19:41:56.913500 [(21)]: Controller: card:3 type:DvbT users: 1 2011-10-29 19:41:56.913500 [(21)]: Controller: card:7 type:DvbT can tune to channel 2011-10-29 19:41:56.913500 [(21)]: Controller: card:7 type:DvbT users: 0 2011-10-29 19:41:56.913500 [(21)]: Controller: card:1 type:DvbIP is disabled 2011-10-29 19:41:56.913500 [(21)]: Controller: card:6 type:RadioWebStream is disabled 2011-10-29 19:41:56.913500 [(21)]: Controller: card:8 type:Analog is disabled 2011-10-29 19:41:56.913500 [(21)]: Controller: found 3 card(s) for channel 2011-10-29 19:41:56.913500 [(21)]: AdvancedCardAllocation.GetAvailableCardsForChannel took 5 msec 2011-10-29 19:41:56.913500 [(21)]: Controller: card:4 type:DvbT is available 2011-10-29 19:41:56.913500 [(21)]: Controller: card:7 type:DvbT is available 2011-10-29 19:41:56.913500 [(21)]: Controller: card:3 type:DvbT is not available, tuned to different transponder 2011-10-29 19:41:56.913500 [(21)]: Controller: found 2 free card(s) 2011-10-29 19:41:56.913500 [(21)]: AdvancedCardAllocation.GetFreeCardsForChannel took 7 msec 2011-10-29 19:41:56.913500 [(21)]: Controller: try max 2 of 2 cards for timeshifting *this causes the analyser reset below that is spot on the time that the recorder stopped! *2011-10-29 19:41:56.929125 [(21)]: card: CardTune 4 7 Digital boysroom:4:-1 2011-10-29 19:41:56.929125 [(21)]: card: Tune 4 to 7 Digital 2011-10-29 19:41:56.929125 [(21)]: card: user: boysroom:4:-1 tune DVBT:tv:Seven Network 7 Digital Freq:177500 ONID:4115 TSID:1282 SID:1312 PMT:0x200 FTA:True LCN:7 BandWidth:7 2011-10-29 19:41:56.929125 [(21)]: TimeShifter.OnBeforeTune: resetting audio/video events 2011-10-29 19:41:56.929125 [(21)]: dvbt: Tune:DVBT:tv:Seven Network 7 Digital Freq:177500 ONID:4115 TSID:1282 SID:1312 PMT:0x200 FTA:True LCN:7 BandWidth:7 2011-10-29 19:41:56.929125 [(21)]: dvb:Submiting tunerequest Channel:7 Digital subChannel:-1 2011-10-29 19:41:56.929125 [(21)]: dvb:Getting new subchannel 2011-10-29 19:41:56.929125 [(21)]: dvb:GetNewSubChannel:0 #0 2011-10-29 19:41:56.929125 [(21)]: TvDvbChannel ctor new subchIndex:0 2011-10-29 19:41:56.929125 [(21)]: dvb:Submit tunerequest size:1 new:0 2011-10-29 19:41:56.929125 [(21)]: subch:0 OnBeforeTune 2011-10-29 19:41:56.929125 [(21)]: dvb:Submit tunerequest calling put_TuneRequest 2011-10-29 19:41:57.913500 [(21)]: dvb:Submit tunerequest done calling put_TuneRequest 2011-10-29 19:41:57.913500 [(21)]: subch:0 OnAfterTune 2011-10-29 19:41:57.913500 [(21)]: RunGraph 2011-10-29 19:41:57.913500 [(21)]: subch:0 OnGraphStart 2011-10-29 19:41:57.913500 [(21)]: dvb: RunGraph 2011-10-29 19:41:58.163500 [(21)]: dvb: LockedInOnSignal ok 2011-10-29 19:41:58.163500 [(21)]: subch:0 OnGraphStarted 2011-10-29 19:41:58.163500 [(21)]: subch:0 SetupPmtGrabber:pid 200 sid:520 2011-10-29 19:41:58.163500 [(21)]: subch:0 set pmt grabber pmt:200 sid:520 2011-10-29 19:41:58.163500 [(21)]: TimeShifter.OnAfterTune: resetting audio/video time 2011-10-29 19:41:58.163500 [(21)]: WaitForPMT: Waiting for PMT 200 2011-10-29 19:41:58.226000 [(3)]: subch:0 OnPMTReceived() pmt:200 ran:True dynamic:False 2011-10-29 19:41:58.226000 [(21)]: WaitForPMT: Found PMT after 0.0625 seconds. 2011-10-29 19:41:58.226000 [(21)]: subch:0 SendPmt:520 520 FFFFFFFF 12 2011-10-29 19:41:58.226000 [(21)]: Decode pmt 2011-10-29 19:41:58.226000 [(21)]: Set descriptor data with length 6 2011-10-29 19:41:58.226000 [(21)]: Set descriptor data with length 7 2011-10-29 19:41:58.226000 [(21)]: Set descriptor data with length 3 2011-10-29 19:41:58.226000 [(21)]: subch:0 SendPMT: Channel is FTA, nothing to do. 2011-10-29 19:41:58.226000 [(21)]: subch:0 SetMpegPidMapping 2011-10-29 19:41:58.226000 [(21)]: subch:0 pid:201 pcr 2011-10-29 19:41:58.226000 [(21)]: subch:0 pid:200 pmt 2011-10-29 19:41:58.226000 [(21)]: subch:0 pid:201 video type:MPEG-2 2011-10-29 19:41:58.226000 [(21)]: subch:0 map pid:201 video type:MPEG-2 2011-10-29 19:41:58.226000 [(21)]: subch:0 pid:202 audio lang:eng type:MPEG-1 2011-10-29 19:41:58.226000 [(21)]: subch:0 map pid:202 audio lang:eng type:MPEG-1 2011-10-29 19:41:58.226000 [(21)]: subch:0 pid:204 teletext type:6 2011-10-29 19:41:58.226000 [(21)]: subch:0 map pid:204 teletext type:6 2011-10-29 19:41:58.226000 [(21)]: subch:0 pid:299 type:B 2011-10-29 19:41:58.226000 [(21)]: subch:0 stop tif 2011-10-29 19:41:58.226000 [(21)]: WaitForPmt: PMT handling took 0 seconds. 2011-10-29 19:41:58.226000 [(21)]: dvbt: tune: Graph running. Returning TvLibrary.Implementations.DVB.TvDvbChannel 2011-10-29 19:41:58.226000 [(21)]: card: Tuner locked: True 2011-10-29 19:41:58.226000 [(21)]: ************************************************** 2011-10-29 19:41:58.226000 [(21)]: ***** SIGNAL LEVEL: 100, SIGNAL QUALITY: 100 ***** 2011-10-29 19:41:58.226000 [(21)]: ************************************************** 2011-10-29 19:41:58.226000 [(21)]: card: tuned user: boysroom subchannel: 0 2011-10-29 19:41:58.226000 [(21)]: user:boysroom add 2011-10-29 19:41:58.226000 [(21)]: card2:boysroom 4 0 2011-10-29 19:41:58.226000 [(21)]: Controller: boysroom 4 0 2011-10-29 19:41:58.226000 [(21)]: control2:boysroom 4 0 2011-10-29 19:41:58.241625 [(21)]: Controller: delete timeshift files D:\tv\MediaPortal Capture\Timeshift\live4-0.ts 2011-10-29 19:41:58.241625 [(21)]: card: StartTimeShifting 4 D:\tv\MediaPortal Capture\Timeshift\live4-0.ts 2011-10-29 19:41:58.241625 [(21)]: card: CAM enabled : False 2011-10-29 19:41:58.241625 [(21)]: subch:0 SetTimeShiftFileName:D:\tv\MediaPortal Capture\Timeshift\live4-0.ts 2011-10-29 19:41:58.241625 [(21)]: Set video / audio observer 2011-10-29 19:41:58.241625 [(21)]: subch:0 SetTimeShiftFileName fill in pids 2011-10-29 19:41:58.241625 [(21)]: subch:0-0 tswriter StartTimeshifting... 2011-10-29 19:41:58.257250 [(21)]: card: WaitForTimeShiftFile - waiting _eventAudio & _eventVideo 2011-10-29 19:41:58.257250 [(3)]: PID seen - type = Video 2011-10-29 19:41:58.257250 [(3)]: audioVideoEventHandler Video 2011-10-29 19:41:58.429125 [(3)]: PID seen - type = Audio 2011-10-29 19:41:58.429125 [(3)]: audioVideoEventHandler Audio 2011-10-29 19:41:58.429125 [(21)]: card: WaitForTimeShiftFile - video and audio are seen after 0.171875 seconds 2011-10-29 19:41:58.429125 [(21)]: user:boysroom card:4 sub:0 add stream:D:\tv\MediaPortal Capture\Timeshift\live4-0.ts.tsbuffer 2011-10-29 19:41:58.429125 [(21)]: RTSP: add stream stream4.0 file:D:\tv\MediaPortal Capture\Timeshift\live4-0.ts.tsbuffer 2011-10-29 19:41:58.429125 [(21)]: Controller: StartTimeShifting started on card:4 to D:\tv\MediaPortal Capture\Timeshift\live4-0.ts.tsbuffer 2011-10-29 19:41:58.429125 [(21)]: user:boysroom remove 2011-10-29 19:41:58.429125 [(21)]: subch:0-0 tswriter StopTimeshifting... 2011-10-29 19:41:58.429125 [(21)]: tvcard:FreeSubChannel: subchannels count 1 subch#0 keep graph=False 2011-10-29 19:41:58.429125 [(21)]: DVB subch:0 Decompose() 2011-10-29 19:41:58.429125 [(21)]: FreeSubChannel CA: freeing sub channel : 0 2011-10-29 19:41:58.429125 [(21)]: tvcard:FreeSubChannel : no subchannels present, pausing graph 2011-10-29 19:41:58.429125 [(21)]: dvb:StopGraph called 2011-10-29 19:41:58.429125 [(21)]: tvcard:FreeAllSubChannels 2011-10-29 19:41:58.429125 [(21)]: dvb:StopGraph 2011-10-29 19:41:58.429125 [(21)]: dvb:StopGraph called 2011-10-29 19:41:58.444750 [(21)]: tvcard:FreeAllSubChannels 2011-10-29 19:41:58.444750 [(21)]: dvb:StopGraph filterstate already stopped, returning. 2011-10-29 19:41:58.444750 [TS_File_Cleanup(24)]: card: delete timeshift files D:\tv\MediaPortal Capture\Timeshift\live7-0.ts 2011-10-29 19:41:58.444750 [TS_File_Cleanup(24)]: card: trying to delete D:\tv\MediaPortal Capture\Timeshift\live7-0.ts.tsbuffer 2011-10-29 19:41:58.444750 [Channel state thread(19)]: Controller: DoSetChannelStates for 19 channels 2011-10-29 19:41:58.444750 [Channel state thread(19)]: ChannelStates.GetChannelMapping took 4 msec 2011-10-29 19:41:58.444750 [Channel state thread(19)]: ChannelStates.GetTuningChannels took 4 msec 2011-10-29 19:41:58.460375 [(21)]: CiMenuSupported called cardid 4 2011-10-29 19:41:58.460375 [(21)]: CiMenuSupported card AF9015 BDA Filter 2 supported: False 2011-10-29 19:41:58.460375 [Channel state thread(19)]: ChannelStates.GetAllTimeshiftingAndRecordingChannels took 14 msec 2011-10-29 19:41:58.460375 [Channel state thread(19)]: ChannelStates.DoSetChannelStates took 25 msec 2011-10-29 19:42:03.444750 [TS_File_Cleanup(24)]: card: delete timeshift files D:\tv\MediaPortal Capture\Timeshift\live7-0.ts 2011-10-29 19:42:03.444750 [TS_File_Cleanup(24)]: card: trying to delete D:\tv\MediaPortal Capture\Timeshift\live7-0.ts.tsbuffer 2011-10-29 19:42:03.444750 [TS_File_Cleanup(24)]: card: deleted file D:\tv\MediaPortal Capture\Timeshift\live7-0.ts.tsbuffer 2011-10-29 19:42:03.444750 [TS_File_Cleanup(24)]: card: trying to delete D:\tv\MediaPortal Capture\Timeshift\live7-0.ts.tsbuffer1.ts 2011-10-29 19:42:03.444750 [TS_File_Cleanup(24)]: card: deleted file D:\tv\MediaPortal Capture\Timeshift\live7-0.ts.tsbuffer1.ts 2011-10-29 19:44:03.960375 [(21)]: CiMenuSupported called cardid 4 2011-10-29 19:44:03.960375 [(21)]: CiMenuSupported card AF9015 BDA Filter 2 supported: False TSwriter - Continuity error at 19:39 - but there is nothing in TV log above at this time and recording does not stop till 19:41:56 (per recording)... 29-10-2011 19:35:56.563 CDiskRecorder::Flush() - Throttle to 15416 bytes 29-10-2011 19:35:56.563 Recorder: TIMESHIFT start of audio detected 29-10-2011 19:35:56.610 CDiskRecorder::Flush() - Throttle to 32336 bytes (max) 29-10-2011 19:39:46.47 Recorder:Pid 207 Continuity error... 6 ( prev 8 ) - bad signal? 29-10-2011 19:39:46.47 Recorder:Pid 2d0 Continuity error... 2 ( prev 0 ) - bad signal? 29-10-2011 19:39:46.63 Recorder:Pid 247 Continuity error... 3 ( prev 1 ) - bad signal? *29-10-2011 19:41:56.929 analyzer: reset 29-10-2011 19:41:56.929 PatParser:Reset(0) 29-10-2011 19:41:56.929 NIT:Reset 29-10-2011 19:41:56.929 PatParser::Reset done 29-10-2011 19:41:56.929 cagrabber: reset 29-10-2011 19:41:56.929 epg: reset 29-10-2011 19:41:56.929 epg:ResetEPG() 29-10-2011 19:41:56.929 mhw reset 29-10-2011 19:41:57.913 CMpTsFilter::Pause() 29-10-2011 19:41:58.163 CMpTsFilter::Run() 29-10-2011 19:41:58.163 pmtgrabber: set callback:fdfc18 29-10-2011 19:41:58.163 pmtgrabber: grab pmt:200 sid:520 29-10-2011 19:41:58.226 pmtgrabber: got pmt 200 sid:520 29-10-2011 19:41:58.226 pmtgrabber: PMT pids changed from: 29-10-2011 19:41:58.226 pcr pid: 0 29-10-2011 19:41:58.226 pmt pid: 0 29-10-2011 19:41:58.226 pmtgrabber: PMT pids changed to: 29-10-2011 19:41:58.226 pcr pid: 201 29-10-2011 19:41:58.226 pmt pid: 200 29-10-2011 19:41:58.226 video pid: 201 type: MPEG2 29-10-2011 19:41:58.226 audio pid: 202 language: eng type: MPEG1 - audio 29-10-2011 19:41:58.226 pmtgrabber: got new pmt version:12 ffffffff, service_id:520 29-10-2011 19:41:58.226 pmtgrabber: do callback pid 200 29-10-2011 19:41:58.226 analyzer: set video pid:201 29-10-2011 19:41:58.226 analyzer: reset 29-10-2011 19:41:58.226 analyzer: set audio pid:202 29-10-2011 19:41:58.226 analyzer: reset 29-10-2011 19:41:58.241 Recorder: TIMESHIFT SetVideoAudioObserver observer ok 29-10-2011 19:41:58.241 Recorder: TIMESHIFT set filename:D:\tv\MediaPortal Capture\Timeshift\live4-0.ts.tsbuffer 29-10-2011 19:41:58.241 CDiskRecorder::SetChannelType() - Channel type is 0 29-10-2011 19:41:58.241 CDiskRecorder::SetChannelType() - Channel type is 0 29-10-2011 19:41:58.241 Recorder: TIMESHIFT paused=yes 29-10-2011 19:41:58.241 Recorder: TIMESHIFT Received from TvService: pmt pid:0x200 serviceId: 0x520 pmtlength:69 29-10-2011 19:41:58.241 Recorder: TIMESHIFT Old pids cleared 29-10-2011 19:41:58.241 Recorder: TIMESHIFT got pmt - tableid: 0x2 section_length: 69 sid: 0x520 29-10-2011 19:41:58.241 Recorder: TIMESHIFT PMT parsed - Pid 0x200 ServiceId 0x520 stream count: 4 29-10-2011 19:41:58.241 Recorder: TIMESHIFT pcr pid:0x201 29-10-2011 19:41:58.241 Recorder: TIMESHIFT SetPcrPid clear old PIDs 29-10-2011 19:41:58.241 Recorder: TIMESHIFT add video stream pid: 0x201 fake pid: 0x30 stream type: 0x2 logical type: 0x2 descriptor length: 5 29-10-2011 19:41:58.241 Recorder: TIMESHIFT add audio stream pid: 0x202 fake pid: 0x40 stream type: 0x3 logical type: 0x3 descriptor length: 6 29-10-2011 19:41:58.241 Recorder: TIMESHIFT add teletext stream pid: 0x204 fake pid: 0x8e stream type: 0x6 logical type: 0x56 descriptor length: 7 29-10-2011 19:41:58.241 Recorder: TIMESHIFT stream rejected - pid: 0x299 stream type: 0xb logical type: 0xb descriptor length: 18 29-10-2011 19:41:58.241 Recorder: TIMESHIFT paused=no 29-10-2011 19:41:58.241 Recorder: TIMESHIFT Start 'D:\tv\MediaPortal Capture\Timeshift\live4-0.ts.tsbuffer' 29-10-2011 19:41:58.257 Recorder: TIMESHIFT start of video detected 29-10-2011 19:41:58.288 Recorder: TIMESHIFT clear TS packet queue 29-10-2011 19:41:58.288 CDiskRecorder::WriteToTimeshiftFile() - Reset write buffer throttle 29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 376 bytes 29-10-2011 19:41:58.288 Recorder: TIMESHIFT Info : Next broadcaster program clock reference rollover : 0 days 04:34:33 0 29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 564 bytes 29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 940 bytes 29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 940 bytes 29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 940 bytes 29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 940 bytes 29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 940 bytes 29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 1880 bytes 29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 1880 bytes 29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 1880 bytes 29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 1880 bytes 29-10-2011 19:41:58.288 CDiskRecorder::Flush() - Throttle to 1880 bytes 29-10-2011 19:41:58.304 CDiskRecorder::Flush() - Throttle to 3760 bytes 29-10-2011 19:41:58.304 CDiskRecorder::Flush() - Throttle to 3760 bytes 29-10-2011 19:41:58.304 CDiskRecorder::Flush() - Throttle to 3760 bytes 29-10-2011 19:41:58.304 CDiskRecorder::Flush() - Throttle to 6016 bytes 29-10-2011 19:41:58.335 CDiskRecorder::Flush() - Throttle to 7520 bytes 29-10-2011 19:41:58.335 CDiskRecorder::Flush() - Throttle to 9400 bytes 29-10-2011 19:41:58.351 CDiskRecorder::Flush() - Throttle to 15416 bytes 29-10-2011 19:41:58.382 CDiskRecorder::Flush() - Throttle to 32336 bytes (max) 29-10-2011 19:41:58.429 Recorder: TIMESHIFT start of audio detected 29-10-2011 19:41:58.429 Recorder: TIMESHIFT Stop 'D:\tv\MediaPortal Capture\Timeshift\live7-0.ts.tsbuffer' 29-10-2011 19:41:58.429 Recorder: TIMESHIFT Reset 29-10-2011 19:41:58.429 CDiskRecorder::Reset() - Reset write buffer throttle 29-10-2011 19:41:58.429 del m_pVideoAnalyzer 29-10-2011 19:41:58.429 analyzer: reset 29-10-2011 19:41:58.429 del m_pPmtGrabber 29-10-2011 19:41:58.429 del m_pRecorder 29-10-2011 19:41:58.429 del m_pTimeShifting 29-10-2011 19:41:58.429 del m_pTeletextGrabber 29-10-2011 19:41:58.429 del m_pCaGrabber 29-10-2011 19:41:58.429 del done... 29-10-2011 19:41:58.429 CMpTsFilter::Pause() 29-10-2011 19:41:58.429 CMpTsFilter::Stop() 29-10-2011 19:44:09.913 Recorder: TIMESHIFT paused=yes 29-10-2011 19:44:09.913 epg: reset 29-10-2011 19:44:09.913 epg:ResetEPG() 29-10-2011 19:44:09.913 mhw reset 29-10-2011 19:44:10.835 pmtgrabber: set callback:fdfc18 29-10-2011 19:44:10.835 pmtgrabber: grab pmt:100 sid:421 29-10-2011 19:44:10.851 pmtgrabber: got pmt 100 sid:421 29-10-2011 19:44:10.851 pmtgrabber: PMT pids changed from: 29-10-2011 19:44:10.851 pcr pid: 0 29-10-2011 19:44:10.851 pmt pid: 100 29-10-2011 19:44:10.851 pmtgrabber: PMT pids changed to: 29-10-2011 19:44:10.851 pcr pid: 87 29-10-2011 19:44:10.851 pmt pid: 100 29-10-2011 19:44:10.851 video pid: 207 type: MPEG2 29-10-2011 19:44:10.851 audio pid: 2d0 language: eng type: MPEG2 - audio 29-10-2011 19:44:10.851 pmtgrabber: got new pmt version:2 ffffffff, service_id:421 [/CODE] [/QUOTE]
Insert quotes…
Verification
Post reply
Forums
MediaPortal 1
Support
General Support
Avermedia A825 dual tuner - occasionally stops one tuner when starting the other one
Contact us
RSS
Top
Bottom
