View unanswered posts    View active topics

Board index LinHES General

All times are UTC - 6 hours





Post new topic Reply to topic  Page 1 of 1
  [ 6 posts ] 
Print view Previous topic   Next topic  
Author Message
Search for:
garetjax67
PostPosted: Thu Feb 17, 2011 2:43 pm 
Offline
Joined: Tue Jul 11, 2006 5:58 pm
Posts: 51
I have no idea where to begin with this.

I have a single FE/BE machine connected to a consumer grade gig switch. Also, connected to this network is my HDhomerun using only OTA.

I am having this problem: Every once in awhile my recordings appear to be missing 10-30seconds the video or they do not record at all. When the video is missing time it will be playing just fine get a little blocky like a bad signal and then snap back to clear, but you just missed something dialog or scene change. Here is the really strange thing the problem gets worse over time. I have found that if it go into setup and delete all my tuner (two hdhomerun tuners 1 unit) everything works fine for about a week, then it starts all over again.

Any ideas on where to even begin? Logs to look at? anything? The WAF is going quickly.
Top
 Profile  
 
Big boy stan
 Post subject:
PostPosted: Thu Feb 17, 2011 4:05 pm 
Offline
Joined: Wed Jan 04, 2006 10:20 am
Posts: 387
Location: South New Jersey, USA
What does your backend or frontend logs show?

Probably unrelated but I used to get the same problem if mythfilldatabase ran while recording or watching a recording.

_________________
LINHES 8.6.1 BE/FE - MSI K9N6SGM-V with AMD A64 X2 4600+, 4GB Ram. 1.5TB WD. HDHR Prime. Nvidia GT210. MCE remote.
FrontEnd - Dell Vostro 400 3.0GHz Core2Duo NVidia GeForce210. MCE Remote
Top
 Profile  
 
luxluthor
 Post subject:
PostPosted: Thu Feb 17, 2011 5:31 pm 
Offline
Joined: Thu Oct 19, 2006 11:21 am
Posts: 51
I had freezes with acpi running. I had to change the boot up parms so there was noacpi on boot up.
Top
 Profile  
 
garetjax67
 Post subject:
PostPosted: Sun Feb 20, 2011 12:02 pm 
Offline
Joined: Tue Jul 11, 2006 5:58 pm
Posts: 51
I have no idea what is going on in the log, but here is the part with a known "bad" recording. Looks like mythfilldb is running during the recording. Where is this scheduled?

Code:
1646 2011-02-14 19:00:02.506 Started recording: How I Met Your Mother "Desperation Day": channel 2041 on cardid 1, sourceid 2
   1647 2011-02-14 19:00:03.685 TVRec(1): rec->GetFileName(): '/myth/tv/2041_20110214190000.mpg'
   1648 2011-02-14 19:00:54.006 ProgramInfo(): Updated pathname '':'' -> '2041_20110214190000.mpg'
   1649 2011-02-14 19:00:54.016 JobQueue: Commercial Flagging Starting for How I Met Your Mother "Desperation Day" recorded from channel 2041 at Mon Feb 14 19:00:00 2011
   1650 2011-02-14 19:00:54.067 ProgramInfo(): Updated pathname '':'' -> '2041_20110214190000.mpg'
   1651 2011-02-14 19:00:54.239 Using runtime prefix = /usr
   1652 2011-02-14 19:00:54.242 Using configuration directory = /home/mythtv/.mythtv
   1653 2011-02-14 19:00:54.243 Empty LocalHostName.
   1654 2011-02-14 19:00:54.244 Using localhost value of Sloth
   1655 2011-02-14 19:00:54.252 New DB connection, total: 1
   1656 2011-02-14 19:00:54.257 Connected to database 'mythconverg' at host: localhost
   1657 2011-02-14 19:00:54.257 Closing DB connection named 'DBManager0'
   1658 2011-02-14 19:00:54.259 Connected to database 'mythconverg' at host: localhost
   1659 2011-02-14 19:00:54.263 ProgramInfo(): Updated pathname '':'' -> '2041_20110214190000.mpg'
   1660 2011-02-14 19:00:54.325 MythContext: Connecting to backend server: 192.168.11.11:6543 (try 1 of 1)
   1661 2011-02-14 19:00:54.429 Using protocol version 23056
   1662 2011-02-14 19:00:54.372 MythContext: Connecting to backend server: 192.168.11.11:6543 (try 1 of 1)
   1663 2011-02-14 19:00:54.430 MainServer::ANN Playback
   1664 2011-02-14 19:00:54.434 adding: Sloth as a client (events: 0)
   1665 2011-02-14 19:00:54.431 Using protocol version 23056
   1666 2011-02-14 19:00:54.436 MainServer::ANN Monitor
   1667 2011-02-14 19:00:54.445 adding: Sloth as a client (events: 1)
   1668 2011-02-14 19:00:54.445 MainServer::ANN Monitor
   1669 2011-02-14 19:00:54.458 adding: Sloth as a client (events: 0)
   1670 2011-02-14 19:00:54.466 ProgramInfo(): Updated pathname '':'' -> '2041_20110214190000.mpg'
   1671 2011-02-14 19:00:54.528 ProgramInfo(): Updated pathname '':'' -> '2041_20110214190000.mpg'
   1672 2011-02-14 19:00:54.574 [mpeg2video @ 0xb6ebe840]mpeg_decode_postinit() failure
   1673 2011-02-14 19:00:54.575 [mpeg2video @ 0xb6ebe840]mpeg_decode_postinit() failure
   1674 2011-02-14 19:00:54.577 [mpeg2video @ 0xb6ebe840]mpeg_decode_postinit() failure
   1675 2011-02-14 19:00:54.578 [mpeg2video @ 0xb6ebe840]mpeg_decode_postinit() failure
   1676 2011-02-14 19:00:54.579 [mpeg2video @ 0xb6ebe840]mpeg_decode_postinit() failure
   1677 2011-02-14 19:00:54.580 [mpeg2video @ 0xb6ebe840]mpeg_decode_postinit() failure
   1678 2011-02-14 19:00:54.581 [mpeg2video @ 0xb6ebe840]mpeg_decode_postinit() failure
   1679 2011-02-14 19:00:54.582 [mpeg2video @ 0xb6ebe840]mpeg_decode_postinit() failure
   1680 2011-02-14 19:00:54.589 [mpeg2video @ 0xb6ebe840]mpeg_decode_postinit() failure
   1681 2011-02-14 19:00:54.595 [mpeg2video @ 0xb6ebe840]mpeg_decode_postinit() failure
   1682 2011-02-14 19:00:54.603 [mpeg2video @ 0xb6ebe840]mpeg_decode_postinit() failure
   1683 2011-02-14 19:00:54.610 [mpeg2video @ 0xb6ebe840]mpeg_decode_postinit() failure
   1684 2011-02-14 19:00:54.615 [mpeg2video @ 0xb6ebe840]mpeg_decode_postinit() failure
   1685 2011-02-14 19:00:54.622 [mpeg2video @ 0xb6ebe840]mpeg_decode_postinit() failure
   1686 2011-02-14 19:00:54.834 AFD: Opened codec 0xb18052c0, id(MPEG2VIDEO) type(Video)
   1687 2011-02-14 19:00:54.835 AFD: codec AC3 has 6 channels
   1688 2011-02-14 19:00:54.842 AFD: Opened codec 0xb1805d20, id(AC3) type(Audio)
   1689 2011-02-14 19:00:54.848 AFD: codec AC3 has 1 channels
   1690 2011-02-14 19:00:54.855 AFD: Opened codec 0xb1804430, id(AC3) type(Audio)
   1691 2011-02-14 19:00:54.863 MythContext: Connecting to backend server: 192.168.11.11:6543 (try 1 of 1)
   1692 2011-02-14 19:00:54.871 Using protocol version 23056
   1693 2011-02-14 19:00:54.880 MainServer::ANN Playback
   1694 2011-02-14 19:00:54.885 adding: Sloth as a client (events: 0)
   1695 2011-02-14 19:00:54.892 RecBase(1:1): GetKeyframePositions(1184,9223372036854775807,#16) out of 97
   1696 2011-02-14 19:01:01.823 MainServer::ANN Monitor
   1697 2011-02-14 19:01:01.825 adding: Sloth as a client (events: 0)
   1698 2011-02-14 19:06:28.471 AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
   1699 2011-02-14 19:08:35.751 RecBase(1:1): GetKeyframePositions(1424,9223372036854775807,#881) out of 978
   1700 2011-02-14 19:08:36.393 [mpeg2video @ 0xb6ebe840]invalid mb type in B Frame at 75 48
   1701 2011-02-14 19:08:36.395 [mpeg2video @ 0xb6ebe840]ac-tex damaged at 24 49
   1702 2011-02-14 19:08:36.396 [mpeg2video @ 0xb6ebe840]ac-tex damaged at 52 50
   1703 2011-02-14 19:08:36.397 [mpeg2video @ 0xb6ebe840]slice mismatch
   1704 2011-02-14 19:08:36.397 [mpeg2video @ 0xb6ebe840]mb incr damaged
   1705 2011-02-14 19:08:36.398 [mpeg2video @ 0xb6ebe840]ac-tex damaged at 30 53


The mpeg2video lines go on for quite awhile. . . .

Code:
 2742 2011-02-14 19:13:56.649 [mpeg2video @ 0xb6ebe840]invalid mb type in B Frame at 45 58
   2743 2011-02-14 19:13:56.650 [mpeg2video @ 0xb6ebe840]00 motion_type at 44 59
   2744 2011-02-14 19:13:56.656 [mpeg2video @ 0xb6ebe840]00 motion_type at 0 4
   2745 2011-02-14 19:13:56.662 [mpeg2video @ 0xb6ebe840]00 motion_type at 0 5
   2746 2011-02-14 19:13:56.668 [mpeg2video @ 0xb6ebe840]00 motion_type at 0 6
   2747 2011-02-14 19:13:56.675 [mpeg2video @ 0xb6ebe840]00 motion_type at 0 7
   2748 2011-02-14 19:13:56.681 [mpeg2video @ 0xb6ebe840]00 motion_type at 0 8
   2749 2011-02-14 19:13:56.688 [mpeg2video @ 0xb6ebe840]00 motion_type at 0 9
   2750 2011-02-14 19:13:56.781 [mpeg2video @ 0xb6ebe840]00 motion_type at 0 10
   2751 2011-02-14 19:13:56.781 [mpeg2video @ 0xb6ebe840]00 motion_type at 8 57
   2752 2011-02-14 19:13:56.826 [mpeg2video @ 0xb6ebe840]00 motion_type at 1 58
   2753 2011-02-14 19:13:56.832 [mpeg2video @ 0xb6ebe840]00 motion_type at 1 59
   2754 2011-02-14 19:13:56.838 [mpeg2video @ 0xb6ebe840]00 motion_type at 12 60
   2755 2011-02-14 19:13:56.845 [mpeg2video @ 0xb6ebe840]00 motion_type at 5 61
   2756 2011-02-14 19:13:56.852 [mpeg2video @ 0xb6ebe840]00 motion_type at 2 62
   2757 2011-02-14 19:13:56.858 [mpeg2video @ 0xb6ebe840]00 motion_type at 20 63
   2758 2011-02-14 19:13:56.865 [mpeg2video @ 0xb6ebe840]ac-tex damaged at 2 64
   2759 2011-02-14 19:13:56.959 [mpeg2video @ 0xb6ebe840]00 motion_type at 4 65
   2760 2011-02-14 19:13:56.959 [mpeg2video @ 0xb6ebe840]00 motion_type at 2 66
   2761 2011-02-14 19:13:57.004 [mpeg2video @ 0xb6ebe840]00 motion_type at 8 67
   2762 2011-02-14 19:20:28.681 AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
   2763 2011-02-14 19:22:28.599 UPnpMedia: BuildMediaMap VIDEO scan starting in :/myth/video:
   2764 2011-02-14 19:22:29.813 UPnpMedia: BuildMediaMap Done. Found 649 objects
   2765 2011-02-14 19:30:00.066 TVRec(1): Changing from RecordingOnly to None
   2766 2011-02-14 19:30:00.115 ProgramInfo(): Updated pathname '':'' -> '2041_20110214190000.mpg'
   2767 2011-02-14 19:30:00.157 Finished recording How I Met Your Mother "Desperation Day": channel 2041
   2768 2011-02-14 19:30:00.243 ProgramInfo(2041_20110214190000.mpg): Recording designated 1080i/p because width was 1920
   2769 2011-02-14 19:30:00.256 ProgramInfo(): Updated pathname '':'' -> '2041_20110214190000.mpg'
   2770 2011-02-14 19:30:00.262 Reschedule requested for id 0.
   2771 2011-02-14 19:30:00.308 ProgramInfo(): Updated pathname '':'' -> '2041_20110214190000.mpg'
   2772 2011-02-14 19:30:00.472 ProgramInfo(): Updated pathname '':'' -> '2041_20110214190000.mpg'
   2773 2011-02-14 19:30:00.542 Finished recording How I Met Your Mother "Desperation Day": channel 2041
   2774 2011-02-14 19:30:00.851 Scheduled 20 items in 0.6 = 0.00 match + 0.59 place
   2775 2011-02-14 19:30:00.884 ProgramInfo(): Updated pathname '':'' -> '2041_20110214190000.mpg'
   2776 2011-02-14 19:30:00.940 ProgramInfo(): Updated pathname '':'' -> '2041_20110214190000.mpg'
   2777 2011-02-14 19:30:03.997 [mpeg2video @ 0xb6ebe840]ac-tex damaged at 73 40
   2778 2011-02-14 19:30:04.849 ProgramInfo(): Updated pathname '':'' -> '2041_20110214190000.mpg'
   2779 2011-02-14 19:30:05.084 mythbackend version: branches/release-0-23-fixes [25661M] www.mythtv.org
Top
 Profile  
 
jzigmyth
 Post subject:
PostPosted: Sun Feb 20, 2011 5:03 pm 
Offline
Joined: Thu Mar 02, 2006 5:42 pm
Posts: 410
Location: middleton wi usa atsc
It looks like commercial flagging is running during recording. I don't know how much horsepower you have, but on my machine I have scheduled comm flagging to start running late at night and end late the next morning (times when I'm not likely to be recording). Comm flagging during recording messed things up (It's been so long, I don't remember exactly how it messed up).

You might also want to check how much free space is left in each of your partitions. Errors getting worse over time could indicate a partition filling up with big log files or something. Maybe a restart clears something out? Just guessing here.

Next time it screws up, you can check space and inodes with these:
Code:
df -h


Code:
df -i
Top
 Profile  
 
garetjax67
 Post subject:
PostPosted: Tue Mar 01, 2011 9:16 pm 
Offline
Joined: Tue Jul 11, 2006 5:58 pm
Posts: 51
It happened again -- Here are the logs, hope this mean something to someone. . .

here is the disk output
Code:
[root@Sloth mythtv]# df -h
Filesystem            Size  Used Avail Use% Mounted on
/dev/sda1             4.9G  2.8G  1.8G  61% /
none                 1013M     0 1013M   0% /dev/shm
/dev/sda3             911G  504G  361G  59% /myth
[root@Sloth mythtv]# df -i
Filesystem            Inodes   IUsed   IFree IUse% Mounted on
/dev/sda1             320000  118839  201161   38% /
none                  221516       1  221515    1% /dev/shm
/dev/sda3            60604416   25646 60578770    1% /myth


Code:
2011-02-28 19:00:02.931 TVRec(1): Changing from None to RecordingOnly
2011-02-28 19:00:02.951 TVRec(1): HW Tuner: 1->1
2011-02-28 19:00:02.969 ProgramInfo(): Updated pathname '':'' -> '2041_20110228190000.mpg'
2011-02-28 19:00:03.105 AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
2011-02-28 19:00:03.377 Started recording: How I Met Your Mother "Heart Failure": channel 2041 on cardid 1, sourceid 2
2011-02-28 19:00:04.210 TVRec(1): rec->GetFileName(): '/myth/tv/2041_20110228190000.mpg'
2011-02-28 19:01:01.823 MainServer::ANN Monitor
2011-02-28 19:01:01.827 adding: Sloth as a client (events: 0)
2011-02-28 19:06:22.592 AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
2011-02-28 19:09:49.707 UPnpMedia: BuildMediaMap VIDEO scan starting in :/myth/video:
2011-02-28 19:09:50.294 UPnpMedia: BuildMediaMap Done. Found 262 objects
2011-02-28 19:20:22.626 AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
2011-02-28 19:30:00.185 TVRec(1): Changing from RecordingOnly to None
2011-02-28 19:30:00.251 ProgramInfo(): Updated pathname '':'' -> '2041_20110228190000.mpg'
2011-02-28 19:30:00.338 Finished recording How I Met Your Mother "Heart Failure": channel 2041
2011-02-28 19:30:00.413 Reschedule requested for id 0.
2011-02-28 19:30:00.479 ProgramInfo(): Updated pathname '':'' -> '2041_20110228190000.mpg'
2011-02-28 19:30:00.573 ProgramInfo(2041_20110228190000.mpg): Recording designated 1080i/p because width was 1920
2011-02-28 19:30:00.653 Scheduled 8 items in 0.2 = 0.05 match + 0.19 place
2011-02-28 19:30:00.678 ProgramInfo(): Updated pathname '':'' -> '2041_20110228190000.mpg'
2011-02-28 19:30:00.811 ProgramInfo(): Updated pathname '':'' -> '2041_20110228190000.mpg'
2011-02-28 19:30:00.820 Finished recording How I Met Your Mother "Heart Failure": channel 2041
2011-02-28 19:30:00.923 ProgramInfo(): Updated pathname '':'' -> '2041_20110228190000.mpg'
2011-02-28 19:30:04.534 mythbackend version: branches/release-0-23-fixes [25661M] www.mythtv.org
2011-02-28 19:30:04.549 Using runtime prefix = /usr
2011-02-28 19:30:04.549 Using configuration directory = /home/mythtv/.mythtv
2011-02-28 19:30:04.582 Empty LocalHostName.
2011-02-28 19:30:04.582 Using localhost value of Sloth
2011-02-28 19:30:04.676 New DB connection, total: 1
2011-02-28 19:30:04.722 Connected to database 'mythconverg' at host: localhost
2011-02-28 19:30:04.734 Closing DB connection named 'DBManager0'
2011-02-28 19:30:04.735 Connected to database 'mythconverg' at host: localhost
2011-02-28 19:30:04.746 Current MythTV Schema Version (DBSchemaVer): 1254
2011-02-28 19:30:04.748 ProgramInfo(): Updated pathname '':'' -> '2041_20110228190000.mpg'
2011-02-28 19:30:05.023 [mpeg2video @ 0xb6eb4840]mpeg_decode_postinit() failure
2011-02-28 19:30:05.025 [mpeg2video @ 0xb6eb4840]mpeg_decode_postinit() failure
2011-02-28 19:30:05.069 [mpeg2video @ 0xb6eb4840]mpeg_decode_postinit() failure
2011-02-28 19:30:05.070 [mpeg2video @ 0xb6eb4840]mpeg_decode_postinit() failure
2011-02-28 19:30:05.073 [mpeg2video @ 0xb6eb4840]mpeg_decode_postinit() failure
2011-02-28 19:30:05.074 [mpeg2video @ 0xb6eb4840]mpeg_decode_postinit() failure
2011-02-28 19:30:05.076 [mpeg2video @ 0xb6eb4840]mpeg_decode_postinit() failure
2011-02-28 19:30:05.078 [mpeg2video @ 0xb6eb4840]mpeg_decode_postinit() failure
2011-02-28 19:30:05.080 [mpeg2video @ 0xb6eb4840]mpeg_decode_postinit() failure
2011-02-28 19:30:05.085 [mpeg2video @ 0xb6eb4840]mpeg_decode_postinit() failure
2011-02-28 19:30:05.091 [mpeg2video @ 0xb6eb4840]mpeg_decode_postinit() failure
2011-02-28 19:30:05.100 [mpeg2video @ 0xb6eb4840]mpeg_decode_postinit() failure
2011-02-28 19:30:05.105 [mpeg2video @ 0xb6eb4840]mpeg_decode_postinit() failure
2011-02-28 19:30:05.112 [mpeg2video @ 0xb6eb4840]mpeg_decode_postinit() failure
2011-02-28 19:30:07.797 AFD: Opened codec 0x9823080, id(MPEG2VIDEO) type(Video)
2011-02-28 19:30:07.801 AFD: codec AC3 has 6 channels
2011-02-28 19:30:07.808 AFD: Opened codec 0x9824980, id(AC3) type(Audio)
2011-02-28 19:30:07.909 AFD: codec AC3 has 1 channels
2011-02-28 19:30:07.910 AFD: Opened codec 0x9824f00, id(AC3) type(Audio)
2011-02-28 19:30:08.450 Preview: Grabbed preview '/myth/tv/2041_20110228190000.mpg' 1920x1088@64s
2011-02-28 19:30:08.663 ~MythContext waiting for threads to exit.
2011-02-28 19:30:12.995 ProgramInfo(): Updated pathname '':'' -> '2041_20110228190000.mpg'
2011-02-28 19:30:13.001 JobQueue: Commercial Flagging Starting for How I Met Your Mother "Heart Failure" recorded from channel 2041 at Mon Feb 28 19:00:00 2011
2011-02-28 19:30:13.052 ProgramInfo(): Updated pathname '':'' -> '2041_20110228190000.mpg'
2011-02-28 19:30:13.261 Using runtime prefix = /usr
2011-02-28 19:30:13.264 Using configuration directory = /home/mythtv/.mythtv
2011-02-28 19:30:13.265 Empty LocalHostName.
2011-02-28 19:30:13.266 Using localhost value of Sloth
2011-02-28 19:30:13.274 New DB connection, total: 1
2011-02-28 19:30:13.279 Connected to database 'mythconverg' at host: localhost
2011-02-28 19:30:13.280 Closing DB connection named 'DBManager0'
2011-02-28 19:30:13.282 Connected to database 'mythconverg' at host: localhost
2011-02-28 19:30:13.285 ProgramInfo(): Updated pathname '':'' -> '2041_20110228190000.mpg'
2011-02-28 19:30:13.327 MythContext: Connecting to backend server: 192.168.11.11:6543 (try 1 of 1)
[/code]
Top
 Profile  
 

Display posts from previous:  Sort by  
Post new topic Reply to topic  Page 1 of 1
  [ 6 posts ] 


Board index LinHES General

All times are UTC - 6 hours




Who is online

Users browsing this forum: No registered users and 8 guests

You cannot post new topics in this forum
You cannot reply to topics in this forum
You cannot edit your posts in this forum
You cannot delete your posts in this forum
You cannot post attachments in this forum

Jump to:  
Powered by phpBB® Forum Software © phpBB Group

Theme Created By ceyhansuyu