SageTV Community  

Go Back   SageTV Community > SageTV Products > SageTV Software
Forum Rules FAQs Community Downloads Today's Posts Search

Notices

SageTV Software Discussion related to the SageTV application produced by SageTV. Questions, issues, problems, suggestions, etc. relating to the SageTV software application should be posted here. (Check the descriptions of the other forums; all hardware related questions go in the Hardware Support forum, etc. And, post in the customizations forum instead if any customizations are active.)

Reply
 
Thread Tools Search this Thread Display Modes
  #1  
Old 07-04-2007, 04:20 PM
coryking's Avatar
coryking coryking is offline
Sage User
 
Join Date: Nov 2006
Location: Seattle, WA (USA)
Posts: 62
Send a message via AIM to coryking
Missing first 5 minutes of many shows (with debug logs)

It looks like for some reason the system hiccups five minutes into a recording, starts recording to a new file and than deletes the original. You can see this starting at 11:05:01.930 and than rolling into the new file at 11:05:03.239

..... Ideas?
Code:

Wed 7/4 10:57:11.076 Ministry is waiting for 180 sec
Wed 7/4 11:00:00.008 Seeker awoken
Wed 7/4 11:00:00.009 MARK 1 currRecord=A[5758160,5758141,"Is It Real?",24959@0704.10:00,60] enc=Hauppauge WinTV PVR PCI II Capture clients=[] ir=true
Wed 7/4 11:00:00.009 Current record is over.
Wed 7/4 11:00:00.016 Seeker.endRecord(Wed 7/4 11:00:00.009) currRecord=A[5758160,5758141,"Is It Real?",24959@0704.10:00,60]
Wed 7/4 11:00:00.017 VF.submitJob(VFJob[InactiveFile r=0.0 t=0 file=null ifn=F:\video\IsItReal-PsychicAnimals-5758160-0.mpg])
Wed 7/4 11:00:00.077 defaultRecord=A[5758155,5758139,"Is It Real?",24959@0704.11:00,60]
Wed 7/4 11:00:00.077 Seeker in AUTOMATIC mode nextRecord=A[5756252,5756223,"Single In the City: The Hamptons",16409@0704.11:00,30] nextTTA=0
Wed 7/4 11:00:00.078 newRecord=A[5756252,5756223,"Single In the City: The Hamptons",16409@0704.11:00,30]
Wed 7/4 11:00:00.078 Change in record to another show. Entering device record mode. - LATER
Wed 7/4 11:00:00.078 Change in record to another show. Entering device record mode. - NOW
Wed 7/4 11:00:00.078 Seeker.startRecord(Hauppauge WinTV PVR PCI II Capture A[5756252,5756223,"Single In the City: The Hamptons",16409@0704.11:00,30], currTime=Wed 7/4 11:00:00.009) currRecord=null switch=true
Wed 7/4 11:00:00.109 Setting up MMC video for recording new show & tuning channel conn=Hauppauge WinTV PVR PCI II Capture Composite
Wed 7/4 11:00:00.121 Using quality setting "SVCD Standard Play" for recording
Wed 7/4 11:00:00.139 VideoStorage for new file: F:\video - Leave Free 5.0 GB
Wed 7/4 11:00:00.148 MediaFile created subfile:F:\video\SingleIntheCityTheHamptons-5756252-0.mpg MediaFile[id=5841330 A[5756252,5756223,"Single In the City: The Hamptons",16409@0704.11:00,30] host=octavia encodedBy=Hauppauge WinTV PVR PCI II Capture SVCD Standard Play format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 480x480 4:3 2000 kbps interlaced]#1 Audio[MP2 44100 Hz 2 channels 224 kbps]]]
Wed 7/4 11:00:00.167 Added:MediaFile[id=5841330 A[5756252,5756223,"Single In the City: The Hamptons",16409@0704.11:00,30] host=octavia encodedBy=Hauppauge WinTV PVR PCI II Capture SVCD Standard Play format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 480x480 4:3 2000 kbps interlaced]#1 Audio[MP2 44100 Hz 2 channels 224 kbps]] F:\video\SingleIntheCityTheHamptons-5756252-0.mpg, Seg0[Wed 7/4 11:00:00.140-Wed 12/31 16:00:00.000]]
Wed 7/4 11:00:00.195 Seeker channel string=502
Wed 7/4 11:00:00.217 switchOutputFile0 called
Wed 7/4 11:00:00.218 Switching Encoding to file F:\video\SingleIntheCityTheHamptons-5756252-0.mpg
Wed 7/4 11:00:00.219 RootFile=F:\ fstype=NTFS fileLength=0
Wed 7/4 11:00:00.238 Playing IR tune command of 502
Wed 7/4 11:00:00.240 Checking video directories for new files
Wed 7/4 11:00:00.276 Swapping MediaFile's file to be D:\SageTV\HowItsMade-4681123-0.mpg from MediaFile[id=4821353 A[4681123,3676878,"How It's Made",12500@0308.12:00,30] host=octavia encodedBy=Hauppauge WinTV PVR PCI II Capture Great format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]] G:\SageTV\HowItsMade-4681123-0.mpg, Seg0[Thu 3/8 12:00:00.495-Thu 3/8 12:22:52.755], Seg1[Thu 3/8 12:24:39.760-Thu 3/8 12:30:00.159]]
Wed 7/4 11:00:00.276 FAILED in MediaFile.setFiles because one of the new files ain't right: MediaFile[id=4821353 A[4681123,3676878,"How It's Made",12500@0308.12:00,30] host=octavia encodedBy=Hauppauge WinTV PVR PCI II Capture Great format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]] G:\SageTV\HowItsMade-4681123-0.mpg, Seg0[Thu 3/8 12:00:00.495-Thu 3/8 12:22:52.755], Seg1[Thu 3/8 12:24:39.760-Thu 3/8 12:30:00.159]] [D:\SageTV\HowItsMade-4681123-0.mpg]
Wed 7/4 11:00:00.277 Diskspace checking is running
Wed 7/4 11:00:00.278 Verifying existence of all TV media files in database fixDurs=false avoidArchive=true
Wed 7/4 11:00:00.299 Enforcing keep at most limits for the files...
Wed 7/4 11:00:00.354 needFreeSize = 0.2619 GB currFreeSize=1.256852992 GB
Wed 7/4 11:00:00.354 Seeker waiting for 29 mins.
Wed 7/4 11:00:00.476 Scheduler awoken
Wed 7/4 11:00:00.566 Scheduler.updateSchedule() called time=Wed 7/4 11:00:00.512 manual=[ManualRecord[A[2916814,2858798,"Robot Chicken",18151@0703.03:30,15] time=Mon 7/3 3:30:00.000 dur=0:15:00], ****SNIP**** A[5803271,5771719,"How It's Made",12500@0710.17:00,30], A[5806767,5671419,"Good Eats",33648@0710.20:00,30], A[5824503,1098315,"The Simpsons",10387@0713.18:00,30]]]} scheduleRandSize=1170
Wed 7/4 11:00:00.568 Removing from schedule cause expired A[5758160,5758141,"Is It Real?",24959@0704.10:00,60]
Wed 7/4 11:00:00.744 Seeker is starting the library import scan...
Wed 7/4 11:00:00.759 # Airs=1561
Wed 7/4 11:00:01.412 MUST SEE FINAL-Hauppauge WinTV PVR PCI II Capture-[A[5758585,5758551,"House Hunters",34215@0704.12:00,30],  ****SNIP**** 
Wed 7/4 11:00:01.419 Evaluating Potentials
Wed 7/4 11:00:01.766 COMPLETE SCHEDULE-----**&^%&*-------COMPLETE SCHEDULE
Wed 7/4 11:00:01.766 Hauppauge WinTV PVR PCI II Capture
Wed 7/4 11:00:01.767 [A[5756252,5756223,"Single In the City: The Hamptons",16409@0704.11:00,30], A[5757341,5324442,"Little People, Big World",19543@0704.11:30,30], <SNIP> A[5806767,5671419,"Good Eats",33648@0710.20:00,30], A[5824503,1098315,"The Simpsons",10387@0713.18:00,30]]
Wed 7/4 11:00:01.768 Seeker awoken
Wed 7/4 11:00:01.769 MARK 1 currRecord=A[5756252,5756223,"Single In the City: The Hamptons",16409@0704.11:00,30] enc=Hauppauge WinTV PVR PCI II Capture clients=[] ir=true
Wed 7/4 11:00:01.770 Seeker in AUTOMATIC mode nextRecord=A[5757341,5324442,"Little People, Big World",19543@0704.11:30,30] nextTTA=1798231
Wed 7/4 11:00:01.770 newRecord=A[5756252,5756223,"Single In the City: The Hamptons",16409@0704.11:00,30]
Wed 7/4 11:00:01.770 Keeping record just the way it is.
Wed 7/4 11:00:01.771 RootFile=F:\ fstype=NTFS fileLength=0
Wed 7/4 11:00:01.772 Checking video directories for new files
Wed 7/4 11:00:01.832 Swapping MediaFile's file to be D:\SageTV\HowItsMade-4681123-0.mpg from MediaFile[id=4821353 A[4681123,3676878,"How It's Made",12500@0308.12:00,30] host=octavia encodedBy=Hauppauge WinTV PVR PCI II Capture Great format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]] G:\SageTV\HowItsMade-4681123-0.mpg, Seg0[Thu 3/8 12:00:00.495-Thu 3/8 12:22:52.755], Seg1[Thu 3/8 12:24:39.760-Thu 3/8 12:30:00.159]]
Wed 7/4 11:00:01.832 FAILED in MediaFile.setFiles because one of the new files ain't right: MediaFile[id=4821353 A[4681123,3676878,"How It's Made",12500@0308.12:00,30] host=octavia encodedBy=Hauppauge WinTV PVR PCI II Capture Great format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]] G:\SageTV\HowItsMade-4681123-0.mpg, Seg0[Thu 3/8 12:00:00.495-Thu 3/8 12:22:52.755], Seg1[Thu 3/8 12:24:39.760-Thu 3/8 12:30:00.159]] [D:\SageTV\HowItsMade-4681123-0.mpg]
Wed 7/4 11:00:01.834 Diskspace checking is running
Wed 7/4 11:00:01.835 Verifying existence of all TV media files in database fixDurs=false avoidArchive=true
Wed 7/4 11:00:01.848 Enforcing keep at most limits for the files...
Wed 7/4 11:00:01.917 needFreeSize = 0.2619 GB currFreeSize=1.256852992 GB
Wed 7/4 11:00:01.917 Seeker waiting for 24 mins.
Wed 7/4 11:00:11.080 Ministry is waiting for 180 sec
Wed 7/4 11:03:11.085 Ministry is waiting for 180 sec
Wed 7/4 11:05:01.925 Seeker awoken
Wed 7/4 11:05:01.926 MARK 1 currRecord=A[5756252,5756223,"Single In the City: The Hamptons",16409@0704.11:00,30] enc=Hauppauge WinTV PVR PCI II Capture clients=[] ir=true
Wed 7/4 11:05:01.927 Seeker in AUTOMATIC mode nextRecord=A[5757341,5324442,"Little People, Big World",19543@0704.11:30,30] nextTTA=1498074
Wed 7/4 11:05:01.927 newRecord=A[5756252,5756223,"Single In the City: The Hamptons",16409@0704.11:00,30]
Wed 7/4 11:05:01.928 Keeping record just the way it is.
Wed 7/4 11:05:01.929 RootFile=F:\ fstype=NTFS fileLength=0
Wed 7/4 11:05:01.930 SEEKER HAS DETECTED A HALT IN THE ENCODER...TRYING TO RESET IT
Wed 7/4 11:05:02.000 VF.submitJob(VFJob[InactiveFile r=0.0 t=0 file=null ifn=F:\video\SingleIntheCityTheHamptons-5756252-0.mpg])
Wed 7/4 11:05:02.009 stopEncoding0 called
Wed 7/4 11:05:02.186 Stopped graph res=0x0
Wed 7/4 11:05:02.208 MediaFile startSegment enc=null MediaFile[id=5841330 A[5756252,5756223,"Single In the City: The Hamptons",16409@0704.11:00,30] host=octavia encodedBy=Hauppauge WinTV PVR PCI II Capture SVCD Standard Play format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 480x480 4:3 2000 kbps interlaced]#1 Audio[MP2 44100 Hz 2 channels 224 kbps]] F:\video\SingleIntheCityTheHamptons-5756252-0.mpg, Seg0[Wed 7/4 11:00:00.140-Wed 7/4 11:05:02.206]]
Wed 7/4 11:05:02.213 MediaFile created subfile:F:\video\SingleIntheCityTheHamptons-5756252-1.mpg MediaFile[id=5841330 A[5756252,5756223,"Single In the City: The Hamptons",16409@0704.11:00,30] host=octavia encodedBy=Hauppauge WinTV PVR PCI II Capture SVCD Standard Play format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 480x480 4:3 2000 kbps interlaced]#1 Audio[MP2 44100 Hz 2 channels 224 kbps]] F:\video\SingleIntheCityTheHamptons-5756252-0.mpg, Seg0[Wed 7/4 11:00:00.140-Wed 7/4 11:05:02.206]]
Wed 7/4 11:05:02.230 teardownGraph0 called for device='Hauppauge WinTV PVR PCI II Capture'
Wed 7/4 11:05:02.450 initGraph0 (ver 2.0.1) called capDev='Hauppauge WinTV PVR PCI II Capture-0', Country:'United States of America', TuningMode:
Wed 7/4 11:05:02.517 Add analog filters for device=Hauppauge WinTV PVR PCI II Capture
Wed 7/4 11:05:03.134 switchToConnector0 tuningMode:
Wed 7/4 11:05:03.134 switchToConnector0 80019416 type=2 index=0 contry:1
Wed 7/4 11:05:03.153 DONE: switchToConnector0 80019416 type=2 index=0
Wed 7/4 11:05:03.156 Set capture brightness: (0 255)-136 val:136 hr:0x0 Hauppauge WinTV PVR PCI II Capture-0
Wed 7/4 11:05:03.181 Playing IR tune command of 502
Wed 7/4 11:05:03.183 setEncodingProperties0 80019416 SVCD Standard Play
Wed 7/4 11:05:03.184 Set encoding property audiooutputmode to 0
Wed 7/4 11:05:03.203 Set encoding property audiocrc to 0
Wed 7/4 11:05:03.203 Set encoding property gopsize to 15
Wed 7/4 11:05:03.204 Set encoding property videobitrate to 2000000
Wed 7/4 11:05:03.204 Set encoding property peakvideobitrate to 2500000
Wed 7/4 11:05:03.204 Set encoding property inversetelecine to 0
Wed 7/4 11:05:03.204 Set encoding property closedgop to 0
Wed 7/4 11:05:03.204 Set encoding property vbr to 1
Wed 7/4 11:05:03.204 Set encoding property outputstreamtype to 12
Wed 7/4 11:05:03.204 Set encoding property width to 480
Wed 7/4 11:05:03.204 Set encoding property height to 480
Wed 7/4 11:05:03.204 Set encoding property audiobitrate to 224
Wed 7/4 11:05:03.204 Set encoding property audiosampling to 44100
Wed 7/4 11:05:03.205 Set encoding property disablefilter to 1
Wed 7/4 11:05:03.205 Set encoding property medianfilter to 3
Wed 7/4 11:05:03.205 Set encoding property fps to 30
Wed 7/4 11:05:03.205 Set encoding property ipb to 0
Wed 7/4 11:05:03.205 Set encoding property deinterlace to 0
Wed 7/4 11:05:03.205 Set encoding property aspectratio to 1
Wed 7/4 11:05:03.205 setupEncoding0 called for 80019416 'Hauppauge WinTV PVR PCI II Capture-0' (ver 1.0)
Wed 7/4 11:05:03.205 setupEncoding0 Trace1 
Wed 7/4 11:05:03.206 setupEncoding0 Trace2 
Wed 7/4 11:05:03.221 setupEncoding0 Trace3 
Wed 7/4 11:05:03.222 setupEncoding0 Trace4 
Wed 7/4 11:05:03.222 setupEncoding0 Trace6 
Wed 7/4 11:05:03.227 setupEncoding0 Trace6-1 
Wed 7/4 11:05:03.228 configureHCWEncoder is running for 'Hauppauge WinTV PVR PCI II Capture-0'.
Wed 7/4 11:05:03.228 configureHCWEncoder setup width 480 on VideoCapture Filter
Wed 7/4 11:05:03.228 configureHCWEncoder setup width 480 succeeded
Wed 7/4 11:05:03.228 configureHCWEncoder setup ouputstream 12 on capture filter
Wed 7/4 11:05:03.229 configureHCWEncoder setup ouputstream change 12 succeeded
Wed 7/4 11:05:03.229 configureHCWEncoder setup video GOP open/close 0 on video capture filter
Wed 7/4 11:05:03.229 configureHCWEncoder setup video GOP open/close succeeded
Wed 7/4 11:05:03.229 configureHCWEncoder setup BitRate 2000 mode:1 on capture filter
Wed 7/4 11:05:03.229 configureHCWEncoder setup BitRate succeeded
Wed 7/4 11:05:03.230 configureHCWEncoder setup GOP size failed
Wed 7/4 11:05:03.230 configureHCWEncoder inverse telecine failed
Wed 7/4 11:05:03.230 configureHCWEncoder setup audio BitRate 224 on Capture filter
Wed 7/4 11:05:03.230 configureHCWEncoder setup audio BitRate succeeded
Wed 7/4 11:05:03.230 configureHCWEncoder audio sampling rate 44100 on capture filter
Wed 7/4 11:05:03.231 configureHCWEncoder setup audio sampling rate succeeded
Wed 7/4 11:05:03.231 configureHCWEncoder setup audio channel succeeded
Wed 7/4 11:05:03.231 configureHCWEncoder setup audio crc on/off succeeded
Wed 7/4 11:05:03.231 configureHCWEncoder done 'Hauppauge WinTV PVR PCI II Capture-0'
Wed 7/4 11:05:03.231 setupEncoding0 Trace7 
Wed 7/4 11:05:03.231 setupEncoding0 Trace8 
Wed 7/4 11:05:03.232 setupEncoding0 Trace9 
Wed 7/4 11:05:03.235 setupEncoding0 Trace10 
Wed 7/4 11:05:03.239 Encoding to file F:\video\SingleIntheCityTheHamptons-5756252-1.mpg
Wed 7/4 11:05:03.239 setupEncoding0 Trace27 
Wed 7/4 11:05:03.239 setupEncoding0 Trace28 
Wed 7/4 11:05:03.240 startEncoding0 called for 'Hauppauge WinTV PVR PCI II Capture-0'
Wed 7/4 11:05:03.460 GetBroadcastStandard  for device:'Hauppauge WinTV PVR PCI II Capture-0'
Wed 7/4 11:05:03.461 Checking video directories for new files
Wed 7/4 11:05:03.489 Swapping MediaFile's file to be D:\SageTV\HowItsMade-4681123-0.mpg from MediaFile[id=4821353 A[4681123,3676878,"How It's Made",12500@0308.12:00,30] host=octavia encodedBy=Hauppauge WinTV PVR PCI II Capture Great format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]] G:\SageTV\HowItsMade-4681123-0.mpg, Seg0[Thu 3/8 12:00:00.495-Thu 3/8 12:22:52.755], Seg1[Thu 3/8 12:24:39.760-Thu 3/8 12:30:00.159]]
Wed 7/4 11:05:03.489 FAILED in MediaFile.setFiles because one of the new files ain't right: MediaFile[id=4821353 A[4681123,3676878,"How It's Made",12500@0308.12:00,30] host=octavia encodedBy=Hauppauge WinTV PVR PCI II Capture Great format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]] G:\SageTV\HowItsMade-4681123-0.mpg, Seg0[Thu 3/8 12:00:00.495-Thu 3/8 12:22:52.755], Seg1[Thu 3/8 12:24:39.760-Thu 3/8 12:30:00.159]] [D:\SageTV\HowItsMade-4681123-0.mpg]
Wed 7/4 11:05:03.490 Diskspace checking is running
Wed 7/4 11:05:03.491 Verifying existence of all TV media files in database fixDurs=false avoidArchive=true
Wed 7/4 11:05:03.514 Enforcing keep at most limits for the files...
Wed 7/4 11:05:03.592 needFreeSize = 0.2619 GB currFreeSize=1.256852992 GB
Wed 7/4 11:05:03.592 Seeker waiting for 19 mins.
Wed 7/4 11:05:05.672 Seeker has finished the library import scan.
Wed 7/4 11:06:11.089 Ministry is waiting for 180 sec
Wed 7/4 11:09:10.993 Ministry is waiting for 180 sec
Wed 7/4 11:10:03.494 Seeker awoken

Last edited by Opus4; 07-04-2007 at 05:04 PM. Reason: cleanup
Reply With Quote
  #2  
Old 07-04-2007, 04:54 PM
ke6guj ke6guj is offline
Sage Icon
 
Join Date: Jan 2005
Posts: 2,355
Try setting seeker/fast_mux_switch=false in sage.properties. That is the first suggestion if missing the first 5 minutes.
__________________
- Jack
__________________________________________
Server: AMD Phenom 9750, 2GB RAM, 2 Hauppauge PVR500, 1 Firewired DCT6200, 1 HDHomerun tuning 2 QAM channels, Vizio 37" HDTV LCD, 1 USB-UIRT

Clients: 1 MediaMVP, 1 Placeshifter Client, & 1 SageTV Client.
Reply With Quote
  #3  
Old 07-06-2007, 08:31 AM
Steep's Avatar
Steep Steep is offline
Sage User
 
Join Date: Sep 2006
Location: Atlanta, GA
Posts: 54
Thanks.

This is happening to me too. I've just assumed that my PC's clock wasn't synced up. I'll try ke6guj's suggestion and see what happens.
Reply With Quote
  #4  
Old 07-07-2007, 01:29 PM
coryking's Avatar
coryking coryking is offline
Sage User
 
Join Date: Nov 2006
Location: Seattle, WA (USA)
Posts: 62
Send a message via AIM to coryking
bingo!

That fix worked! Thanks!
Reply With Quote
Reply


Currently Active Users Viewing This Thread: 1 (0 members and 1 guests)
 

Posting Rules
You may not post new threads
You may not post replies
You may not post attachments
You may not edit your posts

BB code is On
Smilies are On
[IMG] code is On
HTML code is Off

Forum Jump

Similar Threads
Thread Thread Starter Forum Replies Last Post
Missing first 4 minutes Trevor SageTV Software 3 06-20-2005 11:40 PM
Missing first five minutes. dnlmln SageTV Beta Test Software 9 03-07-2005 12:15 PM
Missing first five minutes jelevin SageTV Beta Test Software 1 10-24-2004 05:28 AM
Missing shows after defrag comedian999 SageTV Software 0 07-07-2004 04:47 AM
Shows in multiple files, missing sections waffle SageTV Software 21 04-02-2004 11:10 AM


All times are GMT -6. The time now is 07:58 PM.


Powered by vBulletin® Version 3.8.11
Copyright ©2000 - 2023, vBulletin Solutions Inc.
Copyright 2003-2005 SageTV, LLC. All rights reserved.