Mailing List Archive: MythTV: Users

0.25-fixes 'Video Frame Buffering Failed Too Many Times' whenever a new program starts (Live TV)

1 2

View All

Index | Next | Previous | View Threaded

snharris99 at live

Apr 21, 2012, 10:55 AM

Post #26 of 39 (1053 views)
Permalink

Re: 0.25-fixes 'Video Frame Buffering Failed Too Many Times' whenever a new program starts (Live TV) [In reply to]

>>>>Then the fixes aren't in there yet as the roOt cause hasn't been
>>>> identified yet.
>>
>> I’m so confused, because everyone keeps saying the “fix” hasn’t been
>> ported
>> to 0.25/fixes yet, but my system magically started being near flawless
>> with
>> live TV transitions right at the same time the “fixes” in 10490 were
>> reported. Prior to that, it had a 100% failure rate.

>The problem seems to affect different systems in different ways.
>You're just one of the lucky ones. :)

>Jim

But that's where my confusion is coming from. My system was *useless* for
live TV up until the "oldfile / stop reads" commit / revert in 10490.
However, unless I'm not understanding, because I'm running 0.25+fixes, none
of these "fixes" in 10490 should have made their way to my system....but
it's fixed and suddenly.

_______________________________________________
mythtv-users mailing list
mythtv-users [at] mythtv
http://www.mythtv.org/mailman/listinfo/mythtv-users

snharris99 at live

Apr 21, 2012, 12:26 PM

Post #27 of 39 (1052 views)
Permalink

Re: 0.25-fixes 'Video Frame Buffering Failed TooMany Times' whenever a new program starts (Live TV) [In reply to]

>>>>>Then the fixes aren't in there yet as the roOt cause hasn't been
>>>>> identified yet.
>>>
>>> I’m so confused, because everyone keeps saying the “fix” hasn’t been
>>> ported
>>> to 0.25/fixes yet, but my system magically started being near flawless
>>> with
>>> live TV transitions right at the same time the “fixes” in 10490 were
>>> reported. Prior to that, it had a 100% failure rate.

>>The problem seems to affect different systems in different ways.
>>You're just one of the lucky ones. :)

>>Jim

>But that's where my confusion is coming from. My system was *useless* for
>live TV up until the "oldfile / stop reads" commit / revert in 10490.
>However, unless I'm not understanding, because I'm running 0.25+fixes, none
>of these "fixes" in 10490 should have made their way to my system....but
>it's fixed and suddenly.

I may stand corrected. I sat down to start watching some TV, and it seems
to be back to it's old tricks. "Video Frame Buffering Failed Too Many
Times".

_______________________________________________
mythtv-users mailing list
mythtv-users [at] mythtv
http://www.mythtv.org/mailman/listinfo/mythtv-users

stichnot at gmail

Apr 21, 2012, 2:12 PM

Post #28 of 39 (1053 views)
Permalink

Re: 0.25-fixes 'Video Frame Buffering Failed TooMany Times' whenever a new program starts (Live TV) [In reply to]

On Sat, Apr 21, 2012 at 12:26 PM, Scott & Nicole Harris
<snharris99 [at] live> wrote:
>>> The problem seems to affect different systems in different ways.
>>> You're just one of the lucky ones. :)
>
>> But that's where my confusion is coming from. My system was *useless* for
>> live TV up until the "oldfile / stop reads" commit / revert in 10490.
>> However, unless I'm not understanding, because I'm running 0.25+fixes, none
>> of these "fixes" in 10490 should have made their way to my system....but
>> it's fixed and suddenly.
>
>
> I may stand corrected. I sat down to start watching some TV, and it seems
> to be back to it's old tricks. "Video Frame Buffering Failed Too Many
> Times".

I think only one commit in this area has gone to fixes/0.25, with a
couple other subsequent commits going only to Master.

The latest commit to Master may (crossing my fingers) solve the bulk
of the problem. My plan is to let that bake for a week or two and
then commit everything to fixes/0.25. I'd appreciate hearing from
folks running Master whether this changes anything.

Jim
_______________________________________________
mythtv-users mailing list
mythtv-users [at] mythtv
http://www.mythtv.org/mailman/listinfo/mythtv-users

michael at waremanfamily

Apr 21, 2012, 6:25 PM

Post #29 of 39 (1060 views)
Permalink

Re: 0.25-fixes 'Video Frame Buffering Failed TooMany Times' whenever a new program starts (Live TV) [In reply to]

On Sat, Apr 21, 2012 at 4:12 PM, Jim Stichnoth <stichnot [at] gmail> wrote:

> The latest commit to Master may (crossing my fingers) solve the bulk
> of the problem. My plan is to let that bake for a week or two and
> then commit everything to fixes/0.25. I'd appreciate hearing from
> folks running Master whether this changes anything.
>
> Jim

Jim,

I just saw this ( http://code.mythtv.org/trac/ticket/10490#comment:29 ) -
keeping fingers crossed it works.

Many thanks for tracking this down for us! Even though I know most
probably never watch live - it's gets a lot of use in our house - with the
TV being background noise to a home worker. I did see a slight change today
- again on a program change the stream 'hung' on the frontend - then we
dropped back to the main menu - then LiveTV spawned again instead of
throwing the buffer failed message. Very strange.

Michael.

warpme at o2

Apr 22, 2012, 8:47 AM

Post #30 of 39 (1063 views)
Permalink

Re: 0.25-fixes 'Video Frame Buffering Failed TooMany Times' whenever a new program starts (Live TV) [In reply to]

On 4/21/12 11:12 PM, Jim Stichnoth wrote:
> On Sat, Apr 21, 2012 at 12:26 PM, Scott& Nicole Harris
> <snharris99 [at] live> wrote:
>>>> The problem seems to affect different systems in different ways.
>>>> You're just one of the lucky ones. :)
>>> But that's where my confusion is coming from. My system was *useless* for
>>> live TV up until the "oldfile / stop reads" commit / revert in 10490.
>>> However, unless I'm not understanding, because I'm running 0.25+fixes, none
>>> of these "fixes" in 10490 should have made their way to my system....but
>>> it's fixed and suddenly.
>>
>> I may stand corrected. I sat down to start watching some TV, and it seems
>> to be back to it's old tricks. "Video Frame Buffering Failed Too Many
>> Times".
> I think only one commit in this area has gone to fixes/0.25, with a
> couple other subsequent commits going only to Master.
>
> The latest commit to Master may (crossing my fingers) solve the bulk
> of the problem. My plan is to let that bake for a week or two and
> then commit everything to fixes/0.25. I'd appreciate hearing from
> folks running Master whether this changes anything.
>
> Jim
> _______________________________________________
> mythtv-users mailing list
> mythtv-users [at] mythtv
> http://www.mythtv.org/mailman/listinfo/mythtv-users
>
Jim,

FYI
I backported all recent (0349883 & 7c7852f) master LiveTV commits to
0.25-fixes and unfortunately livetv works much worse for me compared to
current vanilla 0.25-fixes.
With recent commits from master almost every transition ends in main
menu, while current 0.25-fixes ends let say 1 on 10.
With current 0.25-fixes I also observed another trigger causing livetv
"return main menu": pressing info on just switched new livetv segment.
Doing this causes hang on livetv playback every 2-4 tries.
Sorry passing not nice feedback....

My sys has separate BE & FE. FE are disk-less PXE booted over GE
network. BE part is ext3.

-br

Attachments:

warpme.vcf (83 B)

stichnot at gmail

Apr 22, 2012, 9:11 AM

Post #31 of 39 (1065 views)
Permalink

Re: 0.25-fixes 'Video Frame Buffering Failed TooMany Times' whenever a new program starts (Live TV) [In reply to]

On Sun, Apr 22, 2012 at 8:47 AM, Warpme <warpme [at] o2> wrote:
> FYI
> I backported all recent (0349883 & 7c7852f) master LiveTV commits to
> 0.25-fixes and unfortunately livetv works much worse for me compared to
> current vanilla 0.25-fixes.
> With recent commits from master almost every transition ends in main menu,
> while current 0.25-fixes ends let say 1 on 10.
> With current 0.25-fixes I also observed another trigger causing livetv
> "return main menu": pressing info on just switched new livetv segment. Doing
> this causes hang on livetv playback every 2-4 tries.
> Sorry passing not nice feedback....
>
> My sys has separate BE & FE. FE are disk-less PXE booted over GE network. BE
> part is ext3.

Thanks for the feedback, now I have another person to bug for feedback
on future changes. :)

On my system running Master, transitions have pretty much stopped
failing with the "video frame buffering failed" messages. However,
there is often a 15-20 second freeze between transitions which I'm now
looking into, so I don't consider it fixed by any means. Behavior
tends to be slightly different depending on whether I'm viewing ATSC
OTA or HDPVR content. I suspect that has to do with bitrate -- lower
bitrate recordings may be more likely to show the bugs as they are
more likely to cause false EOF conditions.

FWIW, my FE/BE setup is similar to yours, except the file systems are ext4.

Progress is unfortunately slow, as I have limited windows of time to
play around with the production backend, and then it takes time to
study frontend and backend logs that are 20-30 MB each...

Jim
_______________________________________________
mythtv-users mailing list
mythtv-users [at] mythtv
http://www.mythtv.org/mailman/listinfo/mythtv-users

stichnot at gmail

Apr 22, 2012, 10:35 AM

Post #32 of 39 (1060 views)
Permalink

Re: 0.25-fixes 'Video Frame Buffering Failed TooMany Times' whenever a new program starts (Live TV) [In reply to]

On Sun, Apr 22, 2012 at 9:11 AM, Jim Stichnoth <stichnot [at] gmail> wrote:
> On Sun, Apr 22, 2012 at 8:47 AM, Warpme <warpme [at] o2> wrote:
>> FYI
>> I backported all recent (0349883 & 7c7852f) master LiveTV commits to
>> 0.25-fixes and unfortunately livetv works much worse for me compared to
>> current vanilla 0.25-fixes.
>> With recent commits from master almost every transition ends in main menu,
>> while current 0.25-fixes ends let say 1 on 10.
>> With current 0.25-fixes I also observed another trigger causing livetv
>> "return main menu": pressing info on just switched new livetv segment. Doing
>> this causes hang on livetv playback every 2-4 tries.
>> Sorry passing not nice feedback....
>>
>> My sys has separate BE & FE. FE are disk-less PXE booted over GE network. BE
>> part is ext3.
>
> Thanks for the feedback, now I have another person to bug for feedback
> on future changes. :)
>
> On my system running Master, transitions have pretty much stopped
> failing with the "video frame buffering failed" messages. However,
> there is often a 15-20 second freeze between transitions which I'm now
> looking into, so I don't consider it fixed by any means. Behavior
> tends to be slightly different depending on whether I'm viewing ATSC
> OTA or HDPVR content. I suspect that has to do with bitrate -- lower
> bitrate recordings may be more likely to show the bugs as they are
> more likely to cause false EOF conditions.
>
> FWIW, my FE/BE setup is similar to yours, except the file systems are ext4.
>
> Progress is unfortunately slow, as I have limited windows of time to
> play around with the production backend, and then it takes time to
> study frontend and backend logs that are 20-30 MB each...

For those people still seeing the problem in Master, I would
appreciate hearing if the following makes any difference. In
libs/libmythtv/ringbuffer.cpp, find the single instance of
"remotefile->SetTimeout(true);" (in the RingBuffer::run() method) and
comment it out. Only the frontend needs to be restarted with this
change. I'm still seeing problems with this mechanism even after the
related commits to Master.

Jim
_______________________________________________
mythtv-users mailing list
mythtv-users [at] mythtv
http://www.mythtv.org/mailman/listinfo/mythtv-users

stichnot at gmail

Apr 23, 2012, 12:16 PM

Post #33 of 39 (1025 views)
Permalink

Re: 0.25-fixes 'Video Frame Buffering Failed TooMany Times' whenever a new program starts (Live TV) [In reply to]

On Sun, Apr 22, 2012 at 8:47 AM, Warpme <warpme [at] o2> wrote:
> FYI
> I backported all recent (0349883 & 7c7852f) master LiveTV commits to
> 0.25-fixes and unfortunately livetv works much worse for me compared to
> current vanilla 0.25-fixes.
> With recent commits from master almost every transition ends in main menu,
> while current 0.25-fixes ends let say 1 on 10.
> With current 0.25-fixes I also observed another trigger causing livetv
> "return main menu": pressing info on just switched new livetv segment. Doing
> this causes hang on livetv playback every 2-4 tries.
> Sorry passing not nice feedback....

At this point, I have fixed all the "error to the main menu"
situations that I can reproduce, in both fixes/0.25 and master. There
are still a couple of minor issues I'm aware of: a slight glitch at
the program transition, and weird current time and duration
information in the progress bar after the first transition, but I
stopped seeing the failures.

After picking up the changes, if anyone still sees an error to the
main menu, I'd like to hear about it.

Jim
_______________________________________________
mythtv-users mailing list
mythtv-users [at] mythtv
http://www.mythtv.org/mailman/listinfo/mythtv-users

warpme at o2

Apr 23, 2012, 12:54 PM

Post #34 of 39 (1002 views)
Permalink

Re: 0.25-fixes 'Video Frame Buffering Failed TooMany Times' whenever a new program starts (Live TV) [In reply to]

On 4/23/12 9:16 PM, Jim Stichnoth wrote:
> On Sun, Apr 22, 2012 at 8:47 AM, Warpme<warpme [at] o2> wrote:
>> FYI
>> I backported all recent (0349883& 7c7852f) master LiveTV commits to
>> 0.25-fixes and unfortunately livetv works much worse for me compared to
>> current vanilla 0.25-fixes.
>> With recent commits from master almost every transition ends in main menu,
>> while current 0.25-fixes ends let say 1 on 10.
>> With current 0.25-fixes I also observed another trigger causing livetv
>> "return main menu": pressing info on just switched new livetv segment. Doing
>> this causes hang on livetv playback every 2-4 tries.
>> Sorry passing not nice feedback....
> At this point, I have fixed all the "error to the main menu"
> situations that I can reproduce, in both fixes/0.25 and master. There
> are still a couple of minor issues I'm aware of: a slight glitch at
> the program transition, and weird current time and duration
> information in the progress bar after the first transition, but I
> stopped seeing the failures.
>
> After picking up the changes, if anyone still sees an error to the
> main menu, I'd like to hear about it.
>
> Jim
> _______________________________________________
> mythtv-users mailing list
> mythtv-users [at] mythtv
> http://www.mythtv.org/mailman/listinfo/mythtv-users
>
Jim,

I just rebuild latest 0.25-fixes (v0.25-54-g46062bf-dirty-20120423) and
will let You know how it goes. So far testing briefly on few transitions
and looks OK. After few days of test I will report how it goes.

During those tests however I got BE deadlock :-(
Iit is repeatable as I remember few days ago I had it also.

Scenario:
-is 8:28PM, livetv plays.
-I have scheduled another recording at 8:30PM.
-just before 8:30PM I got pop-up with question: watch& record; back to
main menu & record; cancel recording and keep watching.
-I select cancel recording and decided to watching livetv.
-At 8:30PM livetv freezes and BE become deadlocked (famous PROTO_EMPTY
on all FE).

Unfortunately no logs as I was in panic & quickly restarted BE as all my
home mates become highly nervous about unresponsive system....

-br

Attachments:

warpme.vcf (83 B)

stichnot at gmail

Apr 23, 2012, 1:05 PM

Post #35 of 39 (1061 views)
Permalink

Re: 0.25-fixes 'Video Frame Buffering Failed TooMany Times' whenever a new program starts (Live TV) [In reply to]

On Mon, Apr 23, 2012 at 12:54 PM, Warpme <warpme [at] o2> wrote:
> I just rebuild latest 0.25-fixes (v0.25-54-g46062bf-dirty-20120423) and will
> let You know how it goes. So far testing briefly on few transitions and
> looks OK. After few days of test I will report how it goes.
>
> During those tests however I got BE deadlock :-(
> Iit is repeatable as I remember few days ago I had it also.
>
> Scenario:
> -is 8:28PM, livetv plays.
> -I have scheduled another recording at 8:30PM.
> -just before 8:30PM I got pop-up with question: watch& record; back to main
> menu & record; cancel recording and keep watching.
> -I select cancel recording and decided to watching livetv.
> -At 8:30PM livetv freezes and BE become deadlocked (famous PROTO_EMPTY on
> all FE).
>
> Unfortunately no logs as I was in panic & quickly restarted BE as all my
> home mates become highly nervous about unresponsive system....

That happened to me too, and I was able to capture a backtrace and
logs. I expect that should get fixed quickly. Fortunately it's a
completely unrelated problem.
http://code.mythtv.org/trac/ticket/10647

Jim
_______________________________________________
mythtv-users mailing list
mythtv-users [at] mythtv
http://www.mythtv.org/mailman/listinfo/mythtv-users

jaglover at gmail

Apr 23, 2012, 1:14 PM

Post #36 of 39 (1021 views)
Permalink

Re: 0.25-fixes 'Video Frame Buffering Failed TooMany Times' whenever a new program starts (Live TV) [In reply to]

On Mon, 23 Apr 2012 12:16:26 -0700
Jim Stichnoth <stichnot [at] gmail> wrote:

> After picking up the changes, if anyone still sees an error to the
> main menu, I'd like to hear about it.

Thank you for your work, below is the FE output on terminal, attempted
channel change, did git pull 10 min ago.

2012-04-23 15:11:55.228516 N Player(0): Waited 307ms for video buffers
UUUUUUuLAAAAAAAAAAAAAAAAAAAUUUUP 2012-04-23 15:12:07.391336 E
FileRingBuf(/home/mythtv/rec/1063_20120423151157.mpg): OpenFile(): File
too small (0B). 2012-04-23 15:12:07.391375 E Player(0):
JumpToProgram's OpenFile failed (card type: MPEG). 2012-04-23
15:12:07.391467 E LiveTVChain has 4 entries DUMMY: 1027 (15:11:46 to
15:11:47) MPEG: 1027 (15:11:47 to 15:11:56) discontinuous DUMMY: 1063
(15:11:56 to 15:11:57) discontinuous
* MPEG: 1063 (15:11:57 to 16:15:00) discontinuous

2012-04-23 15:12:07.391494 E Player(0): Unknown recorder error,
exiting decoder 2012-04-23 15:12:07.435504 I TV: Attempting to change
from WatchingLiveTV to None 2012-04-23 15:12:14.467509 E
MythSocket(2755ad0:47): readStringList: Error, timed out after 7000 ms.
2012-04-23 15:12:14.467575 E RemoteEncoder::SendReceiveStringList():
No response. 2012-04-23 15:12:14.467615 I TV: Changing from
WatchingLiveTV to None 2012-04-23 15:12:14.467657 I MythCoreContext:
Connecting to backend server: 192.168.2.4:6543 (try 1 of 1) 2012-04-23
15:12:14.468154 I Using protocol version 72 2012-04-23 15:12:14.490715
I TV: Exiting main playback loop. 2012-04-23 15:12:14.490727 E
MythSystemEventHandler: SendMythSystemPlayEvent() called with empty
ProgramInfo 2012-04-23 15:12:14.494802 I TV: Attempting to change from
None to WatchingLiveTV 2012-04-23 15:12:14.494910 I MythCoreContext:
Connecting to backend server: 192.168.2.4:6543 (try 1 of 1) 2012-04-23
15:12:14.495187 I Using protocol version 72 2012-04-23 15:12:14.499497
N TV: Spawning LiveTV Recorder -- begin 2012-04-23 15:12:21.502589 E
MythSocket(3f7dbb0:29): readStringList: Error, timed out after 7000 ms.
2012-04-23 15:12:21.502647 E RemoteEncoder::SendReceiveStringList():
No response. 2012-04-23 15:12:21.502669 N TV: Spawning LiveTV Recorder
-- end 2012-04-23 15:12:21.503222 E GetEntryAt(-1) failed. 2012-04-23
15:12:21.503233 E It appears that your backend may be misconfigured.
Check your backend logs to determine whether your capture cards,
lineups, channels, or storage configuration are reporting errors. This
issue is commonly caused by failing to complete all setup steps
properly. You may wish to review the documentation for mythtv-setup.
2012-04-23 15:12:21.503287 E EntryToProgram(0 [at] We Dec 31 18:00:00
1969) failed to get pginfo 2012-04-23 15:12:21.503299 E TV:
HandleStateChange(): LiveTV not successfully started 2012-04-23
15:12:21.503334 E TV: LiveTV not successfully started 2012-04-23
15:12:21.503369 I TV: Main UI disabled. 2012-04-23 15:12:21.503378 I
TV: Entering main playback loop. 2012-04-23 15:12:21.503672 I
ScreenSaverX11Private: DPMS Reactivated 1 2012-04-23 15:12:21.504289 I
ScreenSaverX11Private: DPMS Deactivated 1 2012-04-23 15:12:21.504317 I
TV: Exiting main playback loop. 2012-04-23 15:12:21.540783 N Resuming
idle timer

--
Cheers, Saul
_______________________________________________
mythtv-users mailing list
mythtv-users [at] mythtv
http://www.mythtv.org/mailman/listinfo/mythtv-users

jaglover at gmail

Apr 23, 2012, 1:19 PM

Post #37 of 39 (1011 views)
Permalink

Re: 0.25-fixes 'Video Frame Buffering Failed TooMany Times' whenever a new program starts (Live TV) [In reply to]

On Mon, 23 Apr 2012 15:14:54 -0500
"Saul A. Peebsen" <jaglover [at] gmail> wrote:

> On Mon, 23 Apr 2012 12:16:26 -0700
> Jim Stichnoth <stichnot [at] gmail> wrote:
>
> > After picking up the changes, if anyone still sees an error to the
> > main menu, I'd like to hear about it.
>
> Thank you for your work, below is the FE output on terminal, attempted
> channel change, did git pull 10 min ago.
>
>
> 2012-04-23 15:11:55.228516 N Player(0): Waited 307ms for video
...

Forgot to add, BE became unresponsive, nothing less than kill -9 shut
it down.

--
Cheers, Saul
_______________________________________________
mythtv-users mailing list
mythtv-users [at] mythtv
http://www.mythtv.org/mailman/listinfo/mythtv-users

stichnot at gmail

Apr 24, 2012, 6:24 AM

Post #38 of 39 (1003 views)
Permalink

Re: 0.25-fixes 'Video Frame Buffering Failed TooMany Times' whenever a new program starts (Live TV) [In reply to]

On Mon, Apr 23, 2012 at 1:19 PM, Saul A. Peebsen <jaglover [at] gmail> wrote:
> On Mon, 23 Apr 2012 15:14:54 -0500
> "Saul A. Peebsen" <jaglover [at] gmail> wrote:
>
>> On Mon, 23 Apr 2012 12:16:26 -0700
>> Jim Stichnoth <stichnot [at] gmail> wrote:
>>
>> > After picking up the changes, if anyone still sees an error to the
>> > main menu, I'd like to hear about it.
>>
>> Thank you for your work, below is the FE output on terminal, attempted
>> channel change, did git pull 10 min ago.
>>
>>
>> 2012-04-23 15:11:55.228516 N Player(0): Waited 307ms for video
> ...
>
> Forgot to add, BE became unresponsive, nothing less than kill -9 shut
> it down.

The unresponsive backend is a separate issue that I've also
encountered while testing live TV, but haven't looked into yet. If
you can reproduce it reliably, then a new ticket should be opened (but
first I need to figure out the best logging arguments).

Jim
_______________________________________________
mythtv-users mailing list
mythtv-users [at] mythtv
http://www.mythtv.org/mailman/listinfo/mythtv-users

michael at waremanfamily

Apr 24, 2012, 8:13 PM

Post #39 of 39 (992 views)
Permalink

Re: 0.25-fixes 'Video Frame Buffering Failed TooMany Times' whenever a new program starts (Live TV) [In reply to]

On Mon, Apr 23, 2012 at 2:16 PM, Jim Stichnoth <stichnot [at] gmail> wrote:
>At this point, I have fixed all the "error to the main menu"

> >situations that I can reproduce, in both fixes/0.25 and master. There

> >are still a couple of minor issues I'm aware of: a slight glitch at

> >the program transition, and weird current time and duration

> >information in the progress bar after the first transition, but I

> >stopped seeing the failures.

> >

> >After picking up the changes, if anyone still sees an error to the
>main menu, I'd like to hear about it.

Thanks Jim - I have 0.25.0+fixes.20120423.46062bf now on all my nodes. I'll
let it bake a few days and let you know. Unfortunately - everyone was out
today so not much LiveTV to go on.

Michael.

1 2

View All

Index | Next | Previous | View Threaded

Interested in having your list archived? Contact Gossamer Threads