[mythtv-users] MythTV stops/doesn't start recording

Sat Apr 18 10:40:11 UTC 2009

Zitat von Jarle Thorsen <jarlethorsen at gmail.com>: 

> I have seen similar behaviour on my system (running dvb-s). So far I have been thinking that there was an issue with multirec (and decryption), and have now turned off multirec in an effort to get more stable recordings. Time will show if my assumptions were correct...
>
> -- 
> Jarle Thorsen

That would be major bummer, because multirec is the only option if you have encrypted channels and don't want to afford yet another card from your greedy providers that think that encrypting all channels (even the free one) over DVB is a great idea. This is a good example of you-do-not-get-what-you-pay-for (talking about the provider here, not the Myth). 

Sorry for the rant, but this HTPC adventure has long turned from fun to frustration for me.

Anyway, here is another snippet from the logs. This one I managed to collect from a recording that simply stopped at one point. I have no idea if this is another symptom of the bug that causes recording not to record anything, or a completely different thing. 

This was a multirec recording of two encrypted channels, so this seems to work, at least sometimes. This is the log from the moment when one of the two recordings finished, everything is fine at that point: 

2009-04-16 23:00:00.234 DVBRec(1:0): Wrote PMT @1459222348 + 1413760
2009-04-16 23:00:00.287 DVBRec(2:0): Wrote PAT @1550144840 + 0
2009-04-16 23:00:00.288 DVBRec(1:0): Wrote PAT @1459251300 + 353440
2009-04-16 23:00:00.309 DVBRec(2:0): Wrote PMT @1550145028 + 1449104
2009-04-16 23:00:00.687 DVBRec(1:0): Wrote PMT @1459402076 + 1343072
2009-04-16 23:00:00.690 TVRec(2): ClearFlags(FinishRecording,) -> FrontendReady,
RunMainLoop,RecorderRunning,RingBufferReady,
2009-04-16 23:00:00.713 TVRec(2): Changing from RecordingOnly to None
2009-04-16 23:00:00.714 TVRec(2): ClearFlags(FrontendReady,CancelNextRecording,)
 -> RunMainLoop,RecorderRunning,RingBufferReady,
2009-04-16 23:00:00.717 TVRec(2): Request: Program(no) channel() input() flags(C
loseRec,KillRingBuffer,)
2009-04-16 23:00:00.758 DVBSH(0): RemoveListener(0x9d41a88) -- begin
2009-04-16 23:00:00.759 DVBRec(2:0): Wrote PAT @1550346376 + 1343072
2009-04-16 23:00:00.776 DVBRec(1:0): Wrote PAT @1459440804 + 1767200
2009-04-16 23:00:00.784 DVBSH(0): RemoveListener(0x9d41a88) -- locked
2009-04-16 23:00:00.847 DVBSH(0): RemoveListener(0x9d41a88) -- end
2009-04-16 23:00:00.858 DVBRec(2:0): Close() fd(-1) -- begin
2009-04-16 23:00:00.864 DVBRec(2:0): Close() fd(-1) -- end
2009-04-16 23:00:00.848 DVBSH(0): RemovePIDFilter(0x215)
2009-04-16 23:00:01.017 PIDInfo(0): Closing filter for pid 0x215
2009-04-16 23:00:01.439 DVBSH(0): RemovePIDFilter(0x216)
2009-04-16 23:00:01.448 PIDInfo(0): Closing filter for pid 0x216
2009-04-16 23:00:01.444 TVRec(2): ClearFlags(RecorderRunning,) -> RunMainLoop,RingBufferReady,
2009-04-16 23:00:01.483 DVBSH(0): RemovePIDFilter(0x217)
2009-04-16 23:00:01.633 PIDInfo(0): Closing filter for pid 0x217
2009-04-16 23:00:01.602 TVRec(2): FinishedRecording(Germany's Next Topmodel - by Heidi Klum) in recgroup: Default
2009-04-16 23:00:01.505 TVRec(2): SetFlags(FrontendReady,) -> FrontendReady,RunMainLoop,RingBufferReady,
2009-04-16 23:00:01.659 DVBSH(0): RemovePIDFilter(0x218)
2009-04-16 23:00:01.883 PIDInfo(0): Closing filter for pid 0x218
2009-04-16 23:00:01.758 Reschedule requested for id 0.
2009-04-16 23:00:01.734 Finished recording Germany's Next Topmodel - by Heidi Klum "10": channel 5040
2009-04-16 23:00:01.977 DVBRec(1:0): Wrote PMT @1459592144 + 848256
2009-04-16 23:00:04.100 Using runtime prefix = /usr
2009-04-16 23:00:02.867 Cardid 1: max bitrate 142089 KB/min
2009-04-16 23:00:04.614 Empty LocalHostName.
2009-04-16 23:00:04.148 TVRec(2): ClearFlags(RecorderRunning,) -> FrontendReady,RunMainLoop,RingBufferReady,
2009-04-16 23:00:04.624 Using localhost value of htpc
2009-04-16 23:00:04.625 TVRec(2): Tearing down RingBuffer
2009-04-16 23:00:04.495 DVBRec(1:0): Wrote PAT @1459620908 + 600848
2009-04-16 23:00:04.681 DVBRec(1:0): Wrote PMT @1459863240 + 494816
2009-04-16 23:00:04.662 Scheduled 127 items in 2.9 = 0.33 match + 2.57 place
2009-04-16 23:00:04.696 New DB connection, total: 1
2009-04-16 23:00:04.658 TVRec(2): ClearFlags(PENDINGACTIONS,) -> FrontendReady,RunMainLoop,RingBufferReady,
2009-04-16 23:00:04.696 DVBRec(1:0): Wrote PAT @1459911368 + 353440
2009-04-16 23:00:04.707 Maximal bitrate of busy encoders is 142089 KB/min
2009-04-16 23:00:04.715 DVBRec(1:0): Wrote PMT @1460108580 + 989632
2009-04-16 23:00:04.732 DVBRec(1:0): Wrote PAT @1460146932 + 742224
2009-04-16 23:00:04.733 DVBRec(1:0): Wrote PMT @1460322712 + 883600

Recording on source 1 then continued just fine for a while, until: 

2009-04-16 23:06:38.332 DVBRec(1:0): Wrote PAT @1673043584 + 1625824
2009-04-16 23:06:38.736 DVBRec(1:0): Wrote PMT @1673286104 + 1661168
2009-04-16 23:06:38.808 DVBRec(1:0): Wrote PAT @1673334232 + 1237040
2009-04-16 23:06:43.990 DVBRec(1:0): PID 0x203 discontinuity detected

After that, no more DVBRec log entries, until the end of the scheduled recording. Myth just continues as if everything was fine. Though obviously it's not.

2009-04-16 23:14:16.074 AutoExpire: ExpireLiveTV(10000)
2009-04-16 23:14:16.074 AutoExpire: FillDBOrdered: Adding Short LiveTV programsin starttime order
2009-04-16 23:14:16.076 AutoExpire: SendDeleteMessages. Nothing to expire.
2009-04-16 23:15:00.235 TVRec(1): ClearFlags(FinishRecording,) -> FrontendReady,RunMainLoop,RecorderRunning,RingBufferReady,
2009-04-16 23:15:00.240 TVRec(1): Changing from RecordingOnly to None
2009-04-16 23:15:00.240 TVRec(1): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,RecorderRunning,RingBufferReady,
2009-04-16 23:15:00.241 TVRec(1): Request: Program(no) channel() input() flags(CloseRec,KillRingBuffer,)
2009-04-16 23:15:00.243 TVRec(1): FinishedRecording(Bones - Die Knochenj<E4>gerin) in recgroup: Default
2009-04-16 23:15:00.246 Finished recording Bones - Die Knochenj<E4>gerin "Zwei Amerikaner in Gro<DF>britannien": channel 5039
2009-04-16 23:15:00.297 Reschedule requested for id 0.
2009-04-16 23:15:00.319 DVBSH(0): RemoveListener(0xb0f0e238) -- begin
2009-04-16 23:15:00.336 DVBSH(0): RemoveListener(0xb0f0e238) -- locked
2009-04-16 23:15:00.336 DVBSH(0): RemovePIDFilter(0x0)
2009-04-16 23:15:00.340 PIDInfo(0): Closing filter for pid 0x0
2009-04-16 23:15:00.347 DVBSH(0): RemovePIDFilter(0x10)

and so on. 

Maybe this helps anyone helping me?

Jan.

-- 
Do you need professional PHP or Horde consulting?
http://horde.org/consulting/
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://mythtv.org/pipermail/mythtv-users/attachments/20090418/8d0db74d/attachment.htm>