[mythtv-commits] Ticket #1066: Mythbackend/LiveTV Ringbuffer occasionally doesn't transition to a new smoothly

MythTV mythtv at cvs.mythtv.org
Wed Jan 25 15:42:37 UTC 2006 

#1066: Mythbackend/LiveTV Ringbuffer occasionally doesn't transition to a new
smoothly
-------------------------------------+--------------------------------------
 Reporter:  Mark.Buechler at gmail.com  |        Owner:  ijr    
     Type:  defect                   |       Status:  closed 
 Priority:  minor                    |    Milestone:  unknown
Component:  mythtv                   |      Version:  head   
 Severity:  medium                   |   Resolution:  fixed  
-------------------------------------+--------------------------------------
Changes (by danielk):

  * resolution:  => fixed
  * status:  new => closed

Old description:

> While watching LiveTV at the point when the Ringbuffer changes files
> between programs many times mythbackend fails to transition in a smooth
> way. I get the following:
>
> ----------------- Cut --------------------
> 2006-01-18 15:26:33.657 DVBRec(1): PID 0x34 discontinuity detected
> 2006-01-18 15:30:00.476 TVRec(4): SwitchLiveTVRingBuffer(discont 0,
> set_rec 1)
> 2006-01-18 15:30:00.477 TVRec(4): GetProgramRingBufferForLiveTV()
> 2006-01-18 15:30:00.749 TVRec(4): StartedRecording(0x84f2760)
> fn(/shares/recordings/corbin2/9013_20060118153000.mpg)
> 2006-01-18 15:30:00.889 Chain: Updated endtime for '9013_20060118151151'
> to 20060118153000
> 2006-01-18 15:30:00.921 Finished recording Unknown: channel 9013
> 2006-01-18 15:30:00.999 scheduler: Finished recording
> 2006-01-18 15:30:01.000 Preview:
> 'myth://192.168.1.121:6543/9013_20060118151151.mpg' is not local,
>                         replacing with
> '/shares/recordings/corbin2/9013_20060118151151.mpg', which is local.
> 2006-01-18 15:30:01.024 Chain: Appended at 10 '9013_20060118153000'
> 2006-01-18 15:30:01.025 DTVRec(4): SetNextRecord(0x84f2760, 0xad170da0)
> 2006-01-18 15:30:01.260 TVRec(4): SetFlags(RingBufferReset,) ->
> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,SIParserRunning,RecorderRunning,RingBufferReset,
> 2006-01-18 15:30:01.260 TVRec(4): Enabling Full LiveTV UI.
> 0: start_time: 4626.257 duration: 98.051
> 1: start_time: 4626.243 duration: 98.041
> 2: start_time: 4626.243 duration: 98.041
> stream: start_time: 51402.706 duration: 1089.600 bitrate=18257 kb/s
> 2006-01-18 15:30:01.580 AFD: Opened codec 0xad45b630, id(MPEG2VIDEO)
> type(Video)
> 2006-01-18 15:30:01.583 AFD: Opened codec 0x8264c70, id(AC3) type(Audio)
> 2006-01-18 15:30:01.583 AFD: Audio Track #1 is A/V stream #1 and has 2
> channels in the English language(6647399).
> 2006-01-18 15:30:01.585 AFD: Opened codec 0x8350020, id(AC3) type(Audio)
> 2006-01-18 15:30:01.586 AFD: Audio Track #2 is A/V stream #2 and has 2
> channels in the English language(6647399).
> 2006-01-18 15:30:01.586 AFD: Trying to select audio track (w/lang)
> 2006-01-18 15:30:01.587 AFD: Selected track 1: English AC3 2ch (A/V
> Stream #1)
> 2006-01-18 15:30:01.587 AFD: Initializing audio parms from audio track #1
> 2006-01-18 15:30:01.587 AFD: Audio format changed
>                         from id(NONE)    -1Hz -1ch   0bps    ; id(NONE)
> -1Hz -1ch   0bps
>                         to   id( AC3) 48000Hz  2ch  16bps    ; id( AC3)
> 48000Hz  2ch  16bps
> 2006-01-18 15:30:02.056 DTVRec(4): ResetForNewFile(void)
> 2006-01-18 15:30:02.269 TVRec(4): SwitchLiveTVRingBuffer(discont 0,
> set_rec 1)
> 2006-01-18 15:30:02.270 TVRec(4): GetProgramRingBufferForLiveTV()
> 2006-01-18 15:30:02.302 RecBase(1): SetRingBuffer(0xad170da0)
> '/shares/recordings/corbin2/9013_20060118153000.mpg'
> 2006-01-18 15:30:02.302 TVRec(4): RingBufferChanged()
> 2006-01-18 15:30:02.336 TVRec(4): StartedRecording(0xad3a15a8)
> fn(/shares/recordings/corbin2/9013_20060118153002.mpg)
> 2006-01-18 15:30:02.374 Chain: Updated endtime for '9013_20060118153000'
> to 20060118153002
> 2006-01-18 15:30:02.403 Finished recording Unknown: channel 9013
> 2006-01-18 15:30:02.404 Preview:
> 'myth://192.168.1.121:6543/9013_20060118153000.mpg' is not local,
>                         replacing with
> '/shares/recordings/corbin2/9013_20060118153000.mpg', which is local.
> 2006-01-18 15:30:02.417 Preview Error: Previewer file
> '/shares/recordings/corbin2/9013_20060118153000.mpg' is not valid.
> 2006-01-18 15:30:02.444 Chain: Appended at 11 '9013_20060118153002'
> 2006-01-18 15:30:02.445 DTVRec(4): SetNextRecord(0xad3a15a8, 0xa239bdf0)
> 2006-01-18 15:30:02.453 TVRec(4): SetFlags(RingBufferReset,) ->
> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,SIParserRunning,RecorderRunning,RingBufferReset,
> 2006-01-18 15:30:02.454 TVRec(4): Enabling Full LiveTV UI.
> 2006-01-18 15:30:02.459 Chain: Updated endtime for '9013_20060118151151'
> to 20060118153002
> 2006-01-18 15:30:02.465 Finished recording Unknown: channel 9013
> 2006-01-18 15:30:02.501 DTVRec(4): ResetForNewFile(void)
> 2006-01-18 15:30:02.504 RecBase(1): SetRingBuffer(0xa239bdf0)
> '/shares/recordings/corbin2/9013_20060118153002.mpg'
> 2006-01-18 15:30:02.505 TVRec(4): RingBufferChanged()
> 2006-01-18 15:30:02.509 Chain: Updated endtime for '9013_20060118153000'
> to 20060118153002
> 2006-01-18 15:30:02.538 Finished recording Unknown: channel 9013
> 2006-01-18 15:30:11.498 Running HouseKeeping
> 2006-01-18 15:30:19.604 MainServer::HandleAnnounce Playback
> 2006-01-18 15:30:19.604 adding: pc4 as a client (events: 0)
> 2006-01-18 15:30:19.611 MainServer::HandleAnnounce FileTransfer
> 2006-01-18 15:30:19.611 adding: pc4 as a remote file transfer
> 2006-01-18 15:30:19.619 Invalid file handle when opening
> /shares/recordings/corbin2/9013_20060118153000.mpg.  6 retries remaining.
> 2006-01-18 15:30:20.121 Invalid file handle when opening
> /shares/recordings/corbin2/9013_20060118153000.mpg.  5 retries remaining.
> 2006-01-18 15:30:20.624 Invalid file handle when opening
> /shares/recordings/corbin2/9013_20060118153000.mpg.  4 retries remaining.
> 2006-01-18 15:30:21.127 Invalid file handle when opening
> /shares/recordings/corbin2/9013_20060118153000.mpg.  3 retries remaining.
> 2006-01-18 15:30:21.630 Invalid file handle when opening
> /shares/recordings/corbin2/9013_20060118153000.mpg.  2 retries remaining.
> 2006-01-18 15:30:22.133 Invalid file handle when opening
> /shares/recordings/corbin2/9013_20060118153000.mpg.  1 retries remaining.
> 2006-01-18 15:30:22.636 Invalid file handle when opening
> /shares/recordings/corbin2/9013_20060118153000.mpg.  0 retries remaining.
> 2006-01-18 15:30:23.148
> RingBuf(/shares/recordings/corbin2/9013_20060118153000.mpg) Error:
> Invalid file descriptor in 'safe_read()'
> 2006-01-18 15:30:23.416 MainServer::HandleAnnounce Playback
> 2006-01-18 15:30:23.416 adding: pc4 as a client (events: 0)
> 2006-01-18 15:30:23.423 MainServer::HandleAnnounce FileTransfer
> 2006-01-18 15:30:23.423 adding: pc4 as a remote file transfer
>
> -------------------- Cut -----------------------
>
> after which LiveTV is fine despite the message "Error: Invalid file
> descriptor in 'safe_read()'" In this case mythbackend starts successfully
> writing to 9013_20060118153002.mpg.
>
> This is running SVN 8641.
>
> - Mark.

New description:

 While watching LiveTV at the point when the Ringbuffer changes files
 between programs many times mythbackend fails to transition in a smooth
 way. I get the following:

 (see log)

 after which LiveTV is fine despite the message "Error: Invalid file
 descriptor in 'safe_read()'" In this case mythbackend starts successfully
 writing to 9013_20060118153002.mpg.

 This is running SVN 8641.

 - Mark.

Comment:

 It looks like this transition problem was fixed by [8703].

-- 
Ticket URL: <http://svn.mythtv.org/trac/ticket/1066>
MythTV <http://www.mythtv.org/>
MythTV

More information about the mythtv-commits mailing list