Author |
Message |
declanh
|
Posted: Thu Mar 22, 2007 1:56 am |
|
Joined: Wed Aug 24, 2005 3:44 am
Posts: 210
|
As this thread is getting rather long I have updated the first post with the story so far
It seems the error "Error Was encountered while displaying video" happens during LiveTV watching in knoppmyth r5e50 and some previous versions
1) its been around for at least a year
2) there does not seem to be any commonality as to what hardware config it manifests itself in - a random collection of AMD/Intel processors and variety of motherboard
3) Its reported mainly here with DVB and HDTV recording but thats not definitive
4) It seems to happen at the program boundary when the backend wants to take a new 'LiveTV recording' file and the front end attempts to open it
5) There is a suggestion that it may be that the frontend is trying to open the new recording file before its been created
6) There is a suggestion that it could be related to Mysql DB performance problems
7) Some tweaks to my.cnf were applied and seemed to help a bit but the problem is still present
8 ) Mythtv has a ticket for this http://svn.mythtv.org/trac/ticket/2335
9) Ive tried various other distros and mythtv and its happening with mythdora and ubuntu + myth - so its unlikely to be a knoppmyth issue
10) mythtv .20 changes have been applied to r5e50 with no success
11) I seems that pressing the pause button during livetv can alleviate the problem as it gives the frontend more time to open the new file - this is not a solution for the channel surfer tho.
Original posting is below this line
---------------------------------------------------------------
I think ive got this problem, and searching the forums/google it looks like others have it too.
When watching live TV it seems that *sometimes* not 100% of the time playback will crash with the above error when the backend decides to "take a new file" as a result of the schedule change. note that its just playback not the whole frontend that crashes....
Ive had this happen 4 times now in 1 night, each time on a program scheduling boundary.
Worryingly i dont seem to be able to find anyone else thats had it and solved it (there was a rumour that the noapic option in lilo.conf would help for nforce boards but i dont have an nforce board)
here is the backend log from around the time of the last playback crash
at 4am
Code: 2007-03-22 03:57:36.626 EITScanner: Now looking for EIT data on multiplex of channel 10 2007-03-22 03:57:37.701 Scheduled 9 items in 1.9 = 1.70 match + 0.20 place 2007-03-22 04:00:01.035 Finished recording Abductees: channel 1004 2007-03-22 04:00:01.349 TVRec(1): Enabling Full LiveTV UI. 2007-03-22 04:00:02.694 TVRec(1): RingBufferChanged() 2007-03-22 04:00:02.814 Finished recording Wild Things: channel 1004 2007-03-22 04:00:02.865 TVRec(1): Enabling Full LiveTV UI. 2007-03-22 04:00:02.960 Finished recording Abductees: channel 1004 2007-03-22 04:00:02.966 Preview Error: Previewer file '/myth/tv/1004_20070322040000.mpg' is not valid. 2007-03-22 04:00:03.054 TVRec(1): RingBufferChanged() 2007-03-22 04:00:03.147 Finished recording Wild Things: channel 1004 0: start_time: 3992.732 duration: 80.903 1: start_time: 3992.693 duration: 80.901 2: start_time: 3992.692 duration: 80.903 3: start_time: 3992.692 duration: 80.942 stream: start_time: 44363.247 duration: 899.358 bitrate=4734 kb/s 2007-03-22 04:00:05.359 AFD: Opened codec 0x83b97d0, id(MPEG2VIDEO) type(Video) 2007-03-22 04:00:05.386 AFD: Opened codec 0x85f8420, id(MP3) type(Audio) 2007-03-22 04:00:05.406 AFD: Opened codec 0x8412090, id(MP3) type(Audio) 2007-03-22 04:00:05.437 AFD: Opened codec 0x84124a0, id(DVB_SUBTITLE) type(Subtitle) 2007-03-22 04:00:05.510 NVP: Recording does not have position map. Run 'mythcommflag --file 1004_20070322034501.mpg --rebuild' to fix 2007-03-22 04:00:07.353 TVRec(1): Changing from WatchingLiveTV to None 2007-03-22 04:00:07.808 Finished recording Wild Things: channel 1004 2007-03-22 04:01:07.979 EITScanner: Added 19 EIT Events 2007-03-22 04:01:07.984 Reschedule requested for id -1. 2007-03-22 04:01:08.585 Scheduled 9 items in 0.6 = 0.48 match + 0.12 place 2007-03-22 04:01:28.703 EITScanner: Now looking for EIT data on multiplex of channel 18 2007-03-22 04:01:42.469 EITScanner: Added 260 EIT Events 2007-03-22 04:01:52.697 EITScanner: Added 267 EIT Events 2007-03-22 04:01:52.824 EITScanner: Now looking for EIT data on multiplex of channel 11 2007-03-22 04:02:47.394 Expiring Wild Things from Thu Mar 22 04:00:00 2007, 2 MBytes, forced expire (LiveTV recording) 2007-03-22 04:02:55.448 EITScanner: Now looking for EIT data on multiplex of channel 15 2007-03-22 04:02:59.946 EITScanner: Added 41 EIT Events 2007-03-22 04:04:05.808 EITScanner: Added 54 EIT Events 2007-03-22 04:04:05.811 Reschedule requested for id -1.
Does anyone have a quick fix for this , or should i take r5e50 back to the workbench and reinstate my r5a16 box which did not exhibit this problem, and be prepared for a long troubleshooting session
Last edited by declanh on Tue Apr 24, 2007 1:01 pm, edited 2 times in total.
|
|
Top |
|
 |
declanh
|
Posted: Thu Mar 22, 2007 1:45 pm |
|
Joined: Wed Aug 24, 2005 3:44 am
Posts: 210
|
Ive posted thie following in a thread about the EIT data causing stuttering but I think its more correctly put in here so im reposting
I think I have now come to the conclusion that its not EIT data thats causing the stutter its the switch to an new recording file at each change in the recording schedule.
I ran the frontend interactively from an xterm and was able to watch its logging to the terminal....
it shows
Code: 2007-03-22 18:38:18.089 TV: Changing from None to WatchingLiveTV 2007-03-22 18:38:18.170 Using realtime priority. 2007-03-22 18:38:18.199 Video timing method: DRM 2007-03-22 18:38:18.360 VideoOutputXv: XvMCTex: Init failed 2007-03-22 18:38:18.362 VideoOutputXv: XVideo Adaptor Name: 'ATI Radeon Video Overlay' 2007-03-22 18:38:19.289 AFD: Opened codec 0x95d9e90, id(MPEG2VIDEO) type(Video) 2007-03-22 18:38:19.336 AFD: Opened codec 0x95d9a70, id(MP3) type(Audio) 2007-03-22 18:38:19.339 AFD: Opened codec 0x95d9140, id(MP3) type(Audio) 2007-03-22 18:38:19.342 AFD: Opened codec 0x95edae0, id(DVB_SUBTITLE) type(Subtitle) 2007-03-22 18:38:19.389 Opening OSS audio device '/dev/dsp'. 2007-03-22 18:38:19.404 NVP: Enabling Audio 2007-03-22 19:00:02.742 NVP: prebuffering pause 2007-03-22 19:00:04.470 NVP: Prebuffer wait timed out 10 times. 2007-03-22 19:00:06.203 NVP: Prebuffer wait timed out 10 times. [b]2007-03-22 19:00:07.557 RingBuf(/myth/tv/1004_20070322190000.mpg): Invalid file (fd -1) when opening '/myth/tv/1004_20070322190000.mpg'. 2007-03-22 19:00:07.567 NVP, Error: SwitchToProgram's OpenFile failed. 2007-03-22 19:00:07.567 NVP, Error: Unknown error, exiting decoder [/b]2007-03-22 19:00:07.577 TV: Attempting to change from WatchingLiveTV to None
Im drawing the conclusion here that the front end is trying to open the new backend recording file too fast (before its created) and failing....
anyone else seen this and can think of a work around ?
|
|
Top |
|
 |
declanh
|
Posted: Fri Mar 23, 2007 2:48 am |
|
Joined: Wed Aug 24, 2005 3:44 am
Posts: 210
|
declanh wrote: I ran the frontend interactively from an xterm and was able to watch its logging to the terminal.... it shows Code: 2007-03-22 18:38:18.089 TV: Changing from None to WatchingLiveTV 2007-03-22 18:38:18.170 Using realtime priority. 2007-03-22 18:38:18.199 Video timing method: DRM 2007-03-22 18:38:18.360 VideoOutputXv: XvMCTex: Init failed 2007-03-22 18:38:18.362 VideoOutputXv: XVideo Adaptor Name: 'ATI Radeon Video Overlay' 2007-03-22 18:38:19.289 AFD: Opened codec 0x95d9e90, id(MPEG2VIDEO) type(Video) 2007-03-22 18:38:19.336 AFD: Opened codec 0x95d9a70, id(MP3) type(Audio) 2007-03-22 18:38:19.339 AFD: Opened codec 0x95d9140, id(MP3) type(Audio) 2007-03-22 18:38:19.342 AFD: Opened codec 0x95edae0, id(DVB_SUBTITLE) type(Subtitle) 2007-03-22 18:38:19.389 Opening OSS audio device '/dev/dsp'. 2007-03-22 18:38:19.404 NVP: Enabling Audio 2007-03-22 19:00:02.742 NVP: prebuffering pause 2007-03-22 19:00:04.470 NVP: Prebuffer wait timed out 10 times. 2007-03-22 19:00:06.203 NVP: Prebuffer wait timed out 10 times. [b]2007-03-22 19:00:07.557 RingBuf(/myth/tv/1004_20070322190000.mpg): Invalid file (fd -1) when opening '/myth/tv/1004_20070322190000.mpg'. 2007-03-22 19:00:07.567 NVP, Error: SwitchToProgram's OpenFile failed. 2007-03-22 19:00:07.567 NVP, Error: Unknown error, exiting decoder [/b]2007-03-22 19:00:07.577 TV: Attempting to change from WatchingLiveTV to None
Im drawing the conclusion here that the front end is trying to open the new backend recording file too fast (before its created) and failing.... anyone else seen this and can think of a work around ?
Links to some more info on this
http://svn.mythtv.org/trac/ticket/1153
http://svn.mythtv.org/trac/ticket/2335
even tho the first ticket is closed if you read the history its still clearly a problem 2 months ago
it seems that pausing live tv for a few seconds can stop this error(not tried that yet so cant verify), but my wife watches livetv all the time and I dont think she'll wear this 
|
|
Top |
|
 |
tscholl
|
Posted: Tue Mar 27, 2007 11:53 am |
|
Joined: Mon Apr 10, 2006 3:48 pm
Posts: 997
Location:
Lexington, Ky
|
Wish I had a solution, because I am having the same problem, with a similar error.
I agree that when it does occur, its always happen when the schedule starts a new recording for a new program.
Code: 2007-03-26 21:00:26.753 TVRec(2): HW Tuner: 2->2 2007-03-26 21:00:28.166 Finished recording Heroes: channel 1181 2007-03-26 21:00:28.249 Finished recording Heroes: channel 1181 2007-03-26 21:00:28.302 Preview Error: Previewer file '/myth/tv/1181_20070326210026.mpg' is not valid. 2007-03-26 21:02:25.832 Expiring Heroes from Mon Mar 26 21:00:00 2007, 49 MBytes, forced expire (LiveTV recording) 2007-03-26 21:02:25.848 autoexpire: Expiring Program: Expiring Heroes from Mon Mar 26 21:00:00 2007, 49 MBytes, forced expire (LiveTV recording) 2007-03-26 21:02:25.858 Expiring Heroes from Mon Mar 26 21:00:00 2007, 0 MBytes, forced expire (LiveTV recording) 2007-03-26 21:02:25.868 autoexpire: Expiring Program: Expiring Heroes from Mon Mar 26 21:00:00 2007, 0 MBytes, forced expire (LiveTV recording) 2007-03-26 21:59:53.881 Finished recording Heroes: channel 1181 0: start_time: 7127.169 duration: 320.816 1: start_time: 7127.149 duration: 320.809
In my case it may happen as many as two or three times in one evening, and other times not at all.
I will have to try the pause idea, and see if that makes a difference.
|
|
Top |
|
 |
declanh
|
Posted: Tue Mar 27, 2007 12:52 pm |
|
Joined: Wed Aug 24, 2005 3:44 am
Posts: 210
|
What type of hardware do you have - to see if there is any overlap
I have
MSI socket 478 mobo
Pentium 4 1.7Ghz
512mb ram
3 Hauppauge wintv nova-t DVB digital terrestrial card (2 new model 1 old model)
Ive tried it with just 1 card an it still happens
Going to try it on a ubuntu build if i cant find a fix to see if its an knoppix issue or a mythtv issue
ps - still dont know if the pausing livetv prevents the issue, not really that fussed if it does as i dont want to be forced into rememebering to pause livetv every time i channel change - this is too clumsy a work around for the problem.
|
|
Top |
|
 |
tscholl
|
Posted: Tue Mar 27, 2007 2:30 pm |
|
Joined: Mon Apr 10, 2006 3:48 pm
Posts: 997
Location:
Lexington, Ky
|
I'm running
KnoppMyth R5D1 - with Cecil's Myth 2.0 update
ASUS P4P800-E
XFX Geforce FX5200 Version 4.0
Intel Pentium 4
|
|
Top |
|
 |
Too Many Secrets
|
Posted: Tue Mar 27, 2007 3:11 pm |
|
Joined: Fri Oct 20, 2006 12:04 pm
Posts: 905
Location:
LA, CA
|
I see the same thing. Sometimes it happens, mostly no problem. I'm running R5D1, no .20 updates.
|
|
Top |
|
 |
declanh
|
Posted: Tue Mar 27, 2007 4:03 pm |
|
Joined: Wed Aug 24, 2005 3:44 am
Posts: 210
|
tscholl wrote: I'm running
KnoppMyth R5D1 - with Cecil's Myth 2.0 update ASUS P4P800-E XFX Geforce FX5200 Version 4.0 Intel Pentium 4
which tuner cards do you have ?
|
|
Top |
|
 |
tscholl
|
Posted: Tue Mar 27, 2007 4:32 pm |
|
Joined: Mon Apr 10, 2006 3:48 pm
Posts: 997
Location:
Lexington, Ky
|
I have the following tuner cards installed:
Two - HD3000
PVR350
PVR150
I usually only watch live TV with the HD3000 cards so have only seen the problem there.
|
|
Top |
|
 |
declanh
|
Posted: Tue Mar 27, 2007 4:41 pm |
|
Joined: Wed Aug 24, 2005 3:44 am
Posts: 210
|
tscholl wrote: I have the following tuner cards installed:
Two - HD3000 PVR350 PVR150
I usually only watch live TV with the HD3000 cards so have only seen the problem there.
ok that rules out my tuner cards as being a specific compatibility problem..
so if its hardware it must be my motherboard or HD controller....
My motherboard (and CPU) was a pretty cheap ebay purchase so I could be persuaded to dump them if i was certain they were the issue... but given that its appearing on a variety of combinations I'm struggling to see what the commonality is
|
|
Top |
|
 |
tscholl
|
Posted: Tue Mar 27, 2007 4:46 pm |
|
Joined: Mon Apr 10, 2006 3:48 pm
Posts: 997
Location:
Lexington, Ky
|
I believe the problem is related to Myth and not your hardware.
When I was running R5C7, I rarely if ever had this problem. (Myth v19)
Mine started when I went to R5D1 and Myth (v20)
|
|
Top |
|
 |
declanh
|
Posted: Tue Mar 27, 2007 5:03 pm |
|
Joined: Wed Aug 24, 2005 3:44 am
Posts: 210
|
tscholl wrote: I believe the problem is related to Myth and not your hardware.
When I was running R5C7, I rarely if ever had this problem. (Myth v19)
Mine started when I went to R5D1 and Myth (v20)
Agreed, it does point to a myth issue. However given that we are in the minority and it seems that most people dont have the issue it makes me think the issue could lie with myth (0.20) and some other (hardware possibly?) factor.
Like I mentioned earlier, I might try the route of testing a ubuntu +mythtv install on the same hardware to see if the problem is still there with a different distro. But I more comfortable with KnoppMyth and dont really want to go that way in the long term because of 1) better "out of the box" functionality in knoppmyth and 2) this excellent forum for support.
|
|
Top |
|
 |
Girkers
|
Posted: Wed Mar 28, 2007 12:12 am |
|
Joined: Tue Mar 22, 2005 9:18 pm
Posts: 1422
Location:
Brisbane, Queensland, Australia
|
Just to let you know that I too have encountered this problem and it &*^%s the wife no end. Fortunately there is a ban on TV in my house at the moment so this is no longer an issue. I am using a current test version of KnoppMyth and it is still present.
_________________ Girkers
|
|
Top |
|
 |
declanh
|
Posted: Wed Mar 28, 2007 1:31 am |
|
Joined: Wed Aug 24, 2005 3:44 am
Posts: 210
|
Girkers wrote: Just to let you know that I too have encountered this problem and it &*^%s the wife no end. Fortunately there is a ban on TV in my house at the moment so this is no longer an issue. I am using a current test version of KnoppMyth and it is still present.
Yep, I cant sell any benefits in R5e50 to my wife if it crashes out of livetv multiple times/night. My main myth box is still on r5a16 and its still working well, i just wanted the latest features and a quieter box with 3 tuners this time. My other option im considering is upgrading to an historic version of knoppmyth based on myth 0.19 (ie newer than my current version but not based on 0.20 where the problem might lie). Are the old versions still avail for download - eg r5c7 ?
|
|
Top |
|
 |
techman83
|
Posted: Wed Mar 28, 2007 4:54 am |
|
Joined: Tue Aug 22, 2006 9:11 am
Posts: 127
Location:
Perth
|
I'm looking for an answer too! I have searched and searched and searched for an answer, but nada!
From what I gather its the frontend getting ahead of itself, so when the show times change over it creates a new file, so it needs to start the new file, but the file hasn't quite been created when it goes to play it and drops out.
How to resolve that issue... is a bridge that i'm not quite sure how to cross!!
_________________ DRM 'manages access' in the same way that jail 'manages freedom.'
_________________
Intel P4 2.6
Intel Desktop Board
2GB DDR400
nVidia 6600GT
Dvico HDTV+
Dvico Dual 4
200GB WD for Swap /boot & /
2x 500GB WD with LVM & XFS for /myth/tv
|
|
Top |
|
 |