Recorded Show deletes by itself???

[Brent]

Had a weird problem tonight that the wife is asking me to run by the experts.

We had a shows "Men in Trees" recording from 8 to 10pm tonight. It recorded and showed recording during that time, but after 10pm dissapeared from the recorded shows. I show the xml file from the recording, but the actual show deleted at 10pm. Here's an expert from the log:

Wed 6/11 22:00:01.785 Removing from schedule cause expired A[1760416,1756508,"Men in Trees",30821@0611.21:00,60]
Wed 6/11 22:00:01.789 Removing from schedule cause expired A[1757110,1757037,"George Lopez",11006@0611.21:30,30]
Wed 6/11 22:00:01.792 Removing from schedule cause expired A[2021116,2018441,"Oprah Winfrey",16451@0611.21:00,60]


Any ideas of what is going on????

[Opus4]

Was there an EPG update in the evening that changed the listings? Were the recordings corrupted & then deleted? Is your schedule lookahead set too large & it just now noticed that the shows were over & removed them from the schedule?

Those lines look like they are talking about the schedule, not file deletions... the log should have other info about deleted files.

- Andy

[Brent]

The last entry in the log that seems to show the deletion:

Wed 6/11 22:00:00.024 MARK 1 currRecord=null enc=Silicondust HDHomeRun Tuner 101012C3-0 clients=[] ir=false
Wed 6/11 22:00:00.025 Seeker in AUTOMATIC mode nextRecord=null nextTTA=9223372036854775807
Wed 6/11 22:00:00.025 newRecord=null
Wed 6/11 22:00:00.025 NOTHING TO RECORD FOR NOW...
Wed 6/11 22:00:00.026 MARK 1 currRecord=A[1760416,1756508,"Men in Trees",30821@0611.21:00,60] enc=Silicondust HDHomeRun Tuner 101012C3-1 clients=[] ir=false
Wed 6/11 22:00:00.026 Current record is over.
Wed 6/11 22:00:00.027 Seeker.endRecord(Wed 6/11 22:00:00.020) currRecord=A[1760416,1756508,"Men in Trees",30821@0611.21:00,60]
Wed 6/11 22:00:00.027 VF.submitJob(VFJob[InactiveFile r=0.0 t=0 file=null ifn=\\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-11.mpg])
Wed 6/11 22:00:00.028 VF.submitJob(VFJob[InactiveFile r=0.0 t=0 file=null ifn=\\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-11.mpg])
Wed 6/11 22:00:00.028 VF processing job VFJob[InactiveFile r=0.0 t=0 file=null ifn=\\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-11.mpg] nPlayin=false
Wed 6/11 22:00:00.029 VF discarding job VFJob[InactiveFile r=0.0 t=0 file=null ifn=\\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-11.mpg]
Wed 6/11 22:00:00.029 VF processing job null nPlayin=false
Wed 6/11 22:00:00.030 VF thread is now waiting for 0:00:00.000
Wed 6/11 22:00:00.066 stopEncoding0 called (config:0x49000)
Wed 6/11 22:00:00.070 Stopped graph res=0x0
Wed 6/11 22:00:00.125 Seeker in AUTOMATIC mode nextRecord=null nextTTA=9223372036854775807
Wed 6/11 22:00:00.126 newRecord=null
Wed 6/11 22:00:00.126 NOTHING TO RECORD FOR NOW...
Wed 6/11 22:00:00.126 MARK 1 currRecord=null enc=Hauppauge HD PVR Capture Device clients=[] ir=false
Wed 6/11 22:00:00.127 Seeker in AUTOMATIC mode nextRecord=null nextTTA=9223372036854775807
Wed 6/11 22:00:00.127 newRecord=null
Wed 6/11 22:00:00.127 NOTHING TO RECORD FOR NOW...
Wed 6/11 22:00:00.128 MARK 1 currRecord=null enc=Hauppauge WinTV PVR PCI II Capture #2 clients=[] ir=false
Wed 6/11 22:00:00.128 Seeker in AUTOMATIC mode nextRecord=null nextTTA=9223372036854775807
Wed 6/11 22:00:00.128 newRecord=null
Wed 6/11 22:00:00.129 NOTHING TO RECORD FOR NOW...
Wed 6/11 22:00:00.129 VF processing job null nPlayin=false
Wed 6/11 22:00:00.129 VF thread is now waiting for 0:00:00.000
Wed 6/11 22:00:00.130 RootFile=\\livingroom\ssageshows fstype=null fileLength=2106621952
Wed 6/11 22:00:00.130 VF processing job null nPlayin=false
Wed 6/11 22:00:00.131 Checking video directories for new files
Wed 6/11 22:00:00.131 VF thread is now waiting for 0:00:00.000
Wed 6/11 22:00:00.315 Diskspace checking is running
Wed 6/11 22:00:00.315 Verifying existence of all TV media files in database fixDurs=false avoidArchive=true
Wed 6/11 22:00:00.596 Scheduler awoken
Wed 6/11 22:00:00.704 MediaFile verification deleting segment this=MediaFile[id=2065119 A[1760416,1756508,"Men in Trees",30821@0611.21:00,60] host=LivingRoom encodedBy=Silicondust HDHomeRun Tuner 101012C3-1 KMBCDT format=MPEG2-PS 0:00:00 0 kbps [] \\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-0.mpg, Seg0[Wed 6/11 21:00:02.277-Wed 6/11 21:05:04.261], Seg1[Wed 6/11 21:05:04.274-Wed 6/11 21:11:02.320], Seg2[Wed 6/11 21:11:02.322-Wed 6/11 21:16:11.141], Seg3[Wed 6/11 21:16:11.143-Wed 6/11 21:21:22.174], Seg4[Wed 6/11 21:21:22.176-Wed 6/11 21:27:21.557], Seg5[Wed 6/11 21:27:21.559-Wed 6/11 21:32:32.249], Seg6[Wed 6/11 21:32:32.262-Wed 6/11 21:37:43.412], Seg7[Wed 6/11 21:37:43.414-Wed 6/11 21:42:54.234], Seg8[Wed 6/11 21:42:54.236-Wed 6/11 21:48:05.298], Seg9[Wed 6/11 21:48:05.301-Wed 6/11 21:53:16.271], Seg10[Wed 6/11 21:53:16.284-Wed 6/11 21:58:27.344], Seg11[Wed 6/11 21:58:27.348-Wed 6/11 22:00:00.020]] segfile=\\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-0.mpg
Wed 6/11 22:00:00.763 MediaFile verification deleting segment this=MediaFile[id=2065119 A[1760416,1756508,"Men in Trees",30821@0611.21:00,60] host=LivingRoom encodedBy=Silicondust HDHomeRun Tuner 101012C3-1 KMBCDT format=MPEG2-PS 0:00:00 0 kbps [] \\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-1.mpg, Seg0[Wed 6/11 21:05:04.274-Wed 6/11 21:11:02.320], Seg1[Wed 6/11 21:11:02.322-Wed 6/11 21:16:11.141], Seg2[Wed 6/11 21:16:11.143-Wed 6/11 21:21:22.174], Seg3[Wed 6/11 21:21:22.176-Wed 6/11 21:27:21.557], Seg4[Wed 6/11 21:27:21.559-Wed 6/11 21:32:32.249], Seg5[Wed 6/11 21:32:32.262-Wed 6/11 21:37:43.412], Seg6[Wed 6/11 21:37:43.414-Wed 6/11 21:42:54.234], Seg7[Wed 6/11 21:42:54.236-Wed 6/11 21:48:05.298], Seg8[Wed 6/11 21:48:05.301-Wed 6/11 21:53:16.271], Seg9[Wed 6/11 21:53:16.284-Wed 6/11 21:58:27.344], Seg10[Wed 6/11 21:58:27.348-Wed 6/11 22:00:00.020]] segfile=\\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-1.mpg
Wed 6/11 22:00:00.798 MediaFile verification deleting segment this=MediaFile[id=2065119 A[1760416,1756508,"Men in Trees",30821@0611.21:00,60] host=LivingRoom encodedBy=Silicondust HDHomeRun Tuner 101012C3-1 KMBCDT format=MPEG2-PS 0:00:00 0 kbps [] \\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-2.mpg, Seg0[Wed 6/11 21:11:02.322-Wed 6/11 21:16:11.141], Seg1[Wed 6/11 21:16:11.143-Wed 6/11 21:21:22.174], Seg2[Wed 6/11 21:21:22.176-Wed 6/11 21:27:21.557], Seg3[Wed 6/11 21:27:21.559-Wed 6/11 21:32:32.249], Seg4[Wed 6/11 21:32:32.262-Wed 6/11 21:37:43.412], Seg5[Wed 6/11 21:37:43.414-Wed 6/11 21:42:54.234], Seg6[Wed 6/11 21:42:54.236-Wed 6/11 21:48:05.298], Seg7[Wed 6/11 21:48:05.301-Wed 6/11 21:53:16.271], Seg8[Wed 6/11 21:53:16.284-Wed 6/11 21:58:27.344], Seg9[Wed 6/11 21:58:27.348-Wed 6/11 22:00:00.020]] segfile=\\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-2.mpg
Wed 6/11 22:00:00.861 MediaFile verification deleting segment this=MediaFile[id=2065119 A[1760416,1756508,"Men in Trees",30821@0611.21:00,60] host=LivingRoom encodedBy=Silicondust HDHomeRun Tuner 101012C3-1 KMBCDT format=MPEG2-PS 0:00:00 0 kbps [] \\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-3.mpg, Seg0[Wed 6/11 21:16:11.143-Wed 6/11 21:21:22.174], Seg1[Wed 6/11 21:21:22.176-Wed 6/11 21:27:21.557], Seg2[Wed 6/11 21:27:21.559-Wed 6/11 21:32:32.249], Seg3[Wed 6/11 21:32:32.262-Wed 6/11 21:37:43.412], Seg4[Wed 6/11 21:37:43.414-Wed 6/11 21:42:54.234], Seg5[Wed 6/11 21:42:54.236-Wed 6/11 21:48:05.298], Seg6[Wed 6/11 21:48:05.301-Wed 6/11 21:53:16.271], Seg7[Wed 6/11 21:53:16.284-Wed 6/11 21:58:27.344], Seg8[Wed 6/11 21:58:27.348-Wed 6/11 22:00:00.020]] segfile=\\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-3.mpg
Wed 6/11 22:00:00.879 MediaFile verification deleting segment this=MediaFile[id=2065119 A[1760416,1756508,"Men in Trees",30821@0611.21:00,60] host=LivingRoom encodedBy=Silicondust HDHomeRun Tuner 101012C3-1 KMBCDT format=MPEG2-PS 0:00:00 0 kbps [] \\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-4.mpg, Seg0[Wed 6/11 21:21:22.176-Wed 6/11 21:27:21.557], Seg1[Wed 6/11 21:27:21.559-Wed 6/11 21:32:32.249], Seg2[Wed 6/11 21:32:32.262-Wed 6/11 21:37:43.412], Seg3[Wed 6/11 21:37:43.414-Wed 6/11 21:42:54.234], Seg4[Wed 6/11 21:42:54.236-Wed 6/11 21:48:05.298], Seg5[Wed 6/11 21:48:05.301-Wed 6/11 21:53:16.271], Seg6[Wed 6/11 21:53:16.284-Wed 6/11 21:58:27.344], Seg7[Wed 6/11 21:58:27.348-Wed 6/11 22:00:00.020]] segfile=\\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-4.mpg
Wed 6/11 22:00:00.959 MediaFile verification deleting segment this=MediaFile[id=2065119 A[1760416,1756508,"Men in Trees",30821@0611.21:00,60] host=LivingRoom encodedBy=Silicondust HDHomeRun Tuner 101012C3-1 KMBCDT format=MPEG2-PS 0:00:00 0 kbps [] \\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-5.mpg, Seg0[Wed 6/11 21:27:21.559-Wed 6/11 21:32:32.249], Seg1[Wed 6/11 21:32:32.262-Wed 6/11 21:37:43.412], Seg2[Wed 6/11 21:37:43.414-Wed 6/11 21:42:54.234], Seg3[Wed 6/11 21:42:54.236-Wed 6/11 21:48:05.298], Seg4[Wed 6/11 21:48:05.301-Wed 6/11 21:53:16.271], Seg5[Wed 6/11 21:53:16.284-Wed 6/11 21:58:27.344], Seg6[Wed 6/11 21:58:27.348-Wed 6/11 22:00:00.020]] segfile=\\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-5.mpg
Wed 6/11 22:00:01.053 MediaFile verification deleting segment this=MediaFile[id=2065119 A[1760416,1756508,"Men in Trees",30821@0611.21:00,60] host=LivingRoom encodedBy=Silicondust HDHomeRun Tuner 101012C3-1 KMBCDT format=MPEG2-PS 0:00:00 0 kbps [] \\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-6.mpg, Seg0[Wed 6/11 21:32:32.262-Wed 6/11 21:37:43.412], Seg1[Wed 6/11 21:37:43.414-Wed 6/11 21:42:54.234], Seg2[Wed 6/11 21:42:54.236-Wed 6/11 21:48:05.298], Seg3[Wed 6/11 21:48:05.301-Wed 6/11 21:53:16.271], Seg4[Wed 6/11 21:53:16.284-Wed 6/11 21:58:27.344], Seg5[Wed 6/11 21:58:27.348-Wed 6/11 22:00:00.020]] segfile=\\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-6.mpg
Wed 6/11 22:00:01.160 MediaFile verification deleting segment this=MediaFile[id=2065119 A[1760416,1756508,"Men in Trees",30821@0611.21:00,60] host=LivingRoom encodedBy=Silicondust HDHomeRun Tuner 101012C3-1 KMBCDT format=MPEG2-PS 0:00:00 0 kbps [] \\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-7.mpg, Seg0[Wed 6/11 21:37:43.414-Wed 6/11 21:42:54.234], Seg1[Wed 6/11 21:42:54.236-Wed 6/11 21:48:05.298], Seg2[Wed 6/11 21:48:05.301-Wed 6/11 21:53:16.271], Seg3[Wed 6/11 21:53:16.284-Wed 6/11 21:58:27.344], Seg4[Wed 6/11 21:58:27.348-Wed 6/11 22:00:00.020]] segfile=\\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-7.mpg
Wed 6/11 22:00:01.327 MediaFile verification deleting segment this=MediaFile[id=2065119 A[1760416,1756508,"Men in Trees",30821@0611.21:00,60] host=LivingRoom encodedBy=Silicondust HDHomeRun Tuner 101012C3-1 KMBCDT format=MPEG2-PS 0:00:00 0 kbps [] \\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-8.mpg, Seg0[Wed 6/11 21:42:54.236-Wed 6/11 21:48:05.298], Seg1[Wed 6/11 21:48:05.301-Wed 6/11 21:53:16.271], Seg2[Wed 6/11 21:53:16.284-Wed 6/11 21:58:27.344], Seg3[Wed 6/11 21:58:27.348-Wed 6/11 22:00:00.020]] segfile=\\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-8.mpg
Wed 6/11 22:00:01.476 MediaFile verification deleting segment this=MediaFile[id=2065119 A[1760416,1756508,"Men in Trees",30821@0611.21:00,60] host=LivingRoom encodedBy=Silicondust HDHomeRun Tuner 101012C3-1 KMBCDT format=MPEG2-PS 0:00:00 0 kbps [] \\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-9.mpg, Seg0[Wed 6/11 21:48:05.301-Wed 6/11 21:53:16.271], Seg1[Wed 6/11 21:53:16.284-Wed 6/11 21:58:27.344], Seg2[Wed 6/11 21:58:27.348-Wed 6/11 22:00:00.020]] segfile=\\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-9.mpg
Wed 6/11 22:00:01.505 MediaFile verification deleting segment this=MediaFile[id=2065119 A[1760416,1756508,"Men in Trees",30821@0611.21:00,60] host=LivingRoom encodedBy=Silicondust HDHomeRun Tuner 101012C3-1 KMBCDT format=MPEG2-PS 0:00:00 0 kbps [] \\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-10.mpg, Seg0[Wed 6/11 21:53:16.284-Wed 6/11 21:58:27.344], Seg1[Wed 6/11 21:58:27.348-Wed 6/11 22:00:00.020]] segfile=\\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-10.mpg
Wed 6/11 22:00:01.622 MediaFile failing verify testFile=\\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-11.mpg isFile=true len=0 isTV=true isRecording=false
Wed 6/11 22:00:01.622 Removing MediaFile because it failed verification:MediaFile[id=2065119 A[1760416,1756508,"Men in Trees",30821@0611.21:00,60] host=LivingRoom encodedBy=Silicondust HDHomeRun Tuner 101012C3-1 KMBCDT format=MPEG2-PS 0:00:00 0 kbps [] \\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-11.mpg, Seg0[Wed 6/11 21:58:27.348-Wed 6/11 22:00:00.020]]
Wed 6/11 22:00:01.628 Deleted media segment file \\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-11.mpg dtime=6 len=0

[BobPhoenix]

Originally Posted by Brent

The last entry in the log that seems to show the deletion:

The file is segmented badly. The last one is segment 11 (\\livingroom\ssageshows\sageshows\MeninTrees-TakingtheLead-1760416-11.mpg). I would say it was a corrupted recording and that is why it was deleted.

[Brent]

Any thoughts on how to troubleshoot? After looking through the log some more it looks like the HDHR kept stopping & restarting in the middle of the recording. Not sure if I should focus on the HDHR or on SageTV at this point. I don't think we've ever had this happen before.

[carlgar]

Search the log for encoder halt, if found probably commication problem with HDHR. Check for loose ethernet connection or bad cable.

[Brent]

Originally Posted by carlgar

Search the log for encoder halt, if found probably commication problem with HDHR. Check for loose ethernet connection or bad cable.

Good idea. I'll have to check the HDHR cabling and run some test records to see how it goes.

By the way, thanks to everyone for your input and assistance.

[carlgar]

Here is a sample of the actual line you should search for:

SEEKER HAS DETECTED A HALT IN THE ENCODER...TRYING TO RESET IT

[Brent]

Originally Posted by carlgar

Here is a sample of the actual line you should search for:

SEEKER HAS DETECTED A HALT IN THE ENCODER...TRYING TO RESET IT

Yep, I'm seeing that log entry multiple times during the recording and then a restart. The deletion of the file/s seemed to happen at the end of the recording.

I'll be checking the HDHR and its connections out tonight. Thanks,

[carlgar]

I would start at the HDHR itself. The HDHR connection seems to allow a lot of play for the cable slide in and and out. I pushed my cables in all of the way. I now search my logs on a daily basis but have not seen any more halts since I determined the cause.

[pjpjpjpj]

Originally Posted by carlgar

The HDHR connection seems to allow a lot of play for the cable slide in and and out. I pushed my cables in all of the way.

Two words: RUBBER BANDS.

(after reading this thread, I will be installing those "firmware updates" on my HDHR's tonight).

[carlgar]

I just discovered I had a encoder halt last night and lost about 5 minutes on one of my recordings. I am not very happy with the HDHRs at this point. The halt occurred with my newest HDHR which is a revision 2. I think the ethernet connection may be a basic flaw with the HDHR.
I have my doubts if it will solve the problem but I now have rubber bands holding the ethernet cables in the HDHRs.

[timnelsonic]

I had this exact same problem several times a few weeks back and found it was related to an almost-full hard-drive. When I added more drive space, the problem went away. Not sure if that's your issue or not. Also not sure why this caused my issue, since it was almost full, not entirely full.

[timnelsonic]

Originally Posted by timnelsonic

I had this exact same problem several times a few weeks back and found it was related to an almost-full hard-drive. When I added more drive space, the problem went away. Not sure if that's your issue or not. Also not sure why this caused my issue, since it was almost full, not entirely full.

Update: Two months later, my hard drive got near-full again, and the same problem started happening. Shows record, then delete themselves right away. For some reason Sage is not deleting old shows, just new ones. Not sure why. I haven't had time to dig into the logs yet to figure it out.

By the way, for some reason Sage doesn't do any clean up on my old files. They just pile up, even if they are set to delete if space is needed. Since installing many months ago, I don't think I've ever had a show get deleted by Sage...they just pile up until I delete them manually. Anyone have thoughts on this?

[Opus4]

Originally Posted by timnelsonic

By the way, for some reason Sage doesn't do any clean up on my old files. They just pile up, even if they are set to delete if space is needed.

You've double-checked your Favorites to make sure that AutoDelete is set to Yes? Select a recording, choose Record Options, then choose Adjust Favorite Options to verify the Favs being used.

And, remember: Manual Recordings and Archived recordings can never be automatically deleted.

If that isn't it, maybe there is a permissions problem with file deletion on the recording drives. If everything is OK, check with tech support.

- Andy