Some Recordings skip to end after any skip

[megabnx]

After moving to a new place that actually has OTA reception, I started playing around with the HDHomeRun setup I used way back when in college. After many hours of setup, I thought I had everything working. I was able to get schedule information synced every day, I had commercial detection tagging all my recordings, life was wonderful. Being an old man, I was more or less only recording Jeopardy. My roommate then tried recording something and had a weird problem. He recorded a program on a different station, and shortly after starting, the screen froze and he was back in the recording menu with a prompt asking if he wanted to delete his finished recording. I quickly discovered that there was a commercial detected at the start of the program. If I removed the commercial tags, the recording would play just fine. However, if I attempted to skip around the recording at all, I got a frozen screen for about 10 seconds, and then eventually was booted back to the recording menu with the end of video prompt. As a sanity test I opened the raw file in a few other video players (vlc/mpc) and the video worked just fine. My guess is that there's just enough corruption that nPVR can't build a seek index, but my other video players are smart enough to just deal with it. I use ffdshow to decode both the sound and audio, and to confirm that the problem wasn't there I tried alternating disabling the video and audio decoders. In both tests, the playback would end as soon as I did any skip. As a further test, I tried recording a few other short bits from the "bad" station. I could skip just fine in these tests. Im guessing that the actual recording was just long enough to pick up enough corruption to break everything.

I finally started looking through the npvr.log hoping to find anything. This is what I saw when I made a skip in the "corrupted file"

Code:

2016-01-13 13:42:31.447    [DEBUG][1]    User is trying to skip.
2016-01-13 13:42:31.447    [DEBUG][1]    Current position is: 15.583833694458
2016-01-13 13:42:31.447    [DEBUG][1]    Asking for position: 75.5838317871094
2016-01-13 13:42:31.448    [DEBUG][1]    Pause()
2016-01-13 13:42:31.460    [DEBUG][1]    SetPosition(75.583832)
2016-01-13 13:42:31.460    [DEBUG][1]    SetPosition@skipmap
2016-01-13 13:42:31.460    [DEBUG][1]    SetPosition@skipmap2
2016-01-13 13:42:31.460    [DEBUG][1]    SetPosition@skipmap3
2016-01-13 13:42:31.460    [DEBUG][1]    SetPosition@skipmap4
2016-01-13 13:42:31.460    [DEBUG][1]    SetPosition@skipmap5
2016-01-13 13:42:31.460    [DEBUG][1]    Using timing.info, jumping to time 75.583832 (offset 124178888)
2016-01-13 13:42:31.460    [DEBUG][1]    SetPosition@skipmap6
2016-01-13 13:42:31.460    [DEBUG][1]    SetPosition@skipmap7
2016-01-13 13:42:31.512    [DEBUG][1]    after skip disk offset 124216488
2016-01-13 13:42:31.512    [DEBUG][1]    SetPosition@exit
2016-01-13 13:42:31.515    [DEBUG][1]    Play()
2016-01-13 13:42:31.515    [DEBUG][1]    skippedWhilePaused enabled (position: 75.5838317871094)
2016-01-13 13:42:31.515    [DEBUG][1]    SetPosition(75.783829)
2016-01-13 13:42:31.515    [DEBUG][1]    SetPosition@skipmap
2016-01-13 13:42:31.515    [DEBUG][1]    SetPosition@skipmap2
2016-01-13 13:42:31.515    [DEBUG][1]    SetPosition@skipmap3
2016-01-13 13:42:31.515    [DEBUG][1]    SetPosition@skipmap4
2016-01-13 13:42:31.515    [DEBUG][1]    SetPosition@skipmap5
2016-01-13 13:42:31.515    [DEBUG][1]    Using timing.info, jumping to time 75.783829 (offset 124178888)
2016-01-13 13:42:31.515    [DEBUG][1]    SetPosition@skipmap6
2016-01-13 13:42:31.515    [DEBUG][1]    SetPosition@skipmap7
2016-01-13 13:42:31.517    [DEBUG][1]    after skip disk offset 124291688
2016-01-13 13:42:31.517    [DEBUG][1]    SetPosition@exit
2016-01-13 13:42:31.517    [DEBUG][1]    After skipping position reports as: 75.7838287353516
2016-01-13 13:42:31.517    [DEBUG][1]    GetEventCode() returned: 0x000e
2016-01-13 13:42:31.541    [DEBUG][1]    Updating OSD.
2016-01-13 13:42:31.844    [DEBUG][1]    Updating OSD.
2016-01-13 13:42:32.826    [DEBUG][1]    Updating OSD.
2016-01-13 13:42:33.804    [DEBUG][1]    Updating OSD.
2016-01-13 13:42:34.817    [DEBUG][1]    Updating OSD.
2016-01-13 13:42:35.545    [DEBUG][1]    Hiding OSD.
2016-01-13 13:43:13.442    [DEBUG][1]    GetEventCode() returned: 0x0003
2016-01-13 13:43:13.442    [DEBUG][1]    GetEventCode() returned: 0x0001
2016-01-13 13:43:13.442    [DEBUG][1]    About to store playback position information
2016-01-13 13:43:13.442    [DEBUG][1]    PlaybackPositionHelper.StorePlaybackPosition(Galavant_20160110_20002101.ts, 3778, 3778)
2016-01-13 13:43:13.442    [DEBUG][1]    PlaybackPositionHelper.DeletePlaybackPosition(C:\Temp\Galavant\Galavant_20160110_20002101.ts)
2016-01-13 13:43:13.777    [DEBUG][1]    Stop@0
2016-01-13 13:43:13.778    [DEBUG][1]    Stopping graph@1
2016-01-13 13:43:13.784    [DEBUG][1]    Stopping graph@2
2016-01-13 13:43:13.788    [DEBUG][1]    Stopping graph@3
2016-01-13 13:43:13.788    [DEBUG][1]    CAllocator::Release (m_refCount=3)
2016-01-13 13:43:13.788    [DEBUG][1]    Removing filter  NPVR CC Dump
2016-01-13 13:43:13.789    [DEBUG][1]    Removing filter  Video Mixing Renderer 9
2016-01-13 13:43:13.790    [DEBUG][1]    CAllocator::Release (m_refCount=2)
2016-01-13 13:43:13.790    [DEBUG][1]    CAllocator::Release (m_refCount=1)
2016-01-13 13:43:13.790    [DEBUG][1]    CAllocator::Release (m_refCount=0)
2016-01-13 13:43:13.790    [DEBUG][1]    CAllocator::Release() deleting instance
2016-01-13 13:43:13.816    [DEBUG][1]    Removing filter  NPVR PES Collector (Teletext)
2016-01-13 13:43:13.816    [DEBUG][1]    Removing filter  NPVR PES Collector (DVBSubs)
2016-01-13 13:43:13.816    [DEBUG][1]    Removing filter  AC3 Audio Renderer
2016-01-13 13:43:13.817    [DEBUG][1]    Removing filter  Line 21 Decoder
2016-01-13 13:43:13.817    [DEBUG][1]    Removing filter  ffdshow Video Decoder
2016-01-13 13:43:13.823    [DEBUG][1]    Removing filter  ffdshow Audio Decoder
2016-01-13 13:43:13.829    [DEBUG][1]    Removing filter  NPVR CC Extractor
2016-01-13 13:43:13.829    [DEBUG][1]    Removing filter  MPEG-2 Demultiplexer
2016-01-13 13:43:13.829    [DEBUG][1]    Removing filter  NPVR TS Reader2
2016-01-13 13:43:13.831    [DEBUG][1]    PlaybackPositionHelper.GetPlaybackPosition(C:\Temp\Galavant\Galavant_20160110_20002101.ts)
2016-01-13 13:43:13.850    [DEBUG][1]    play to completion

Nothing here is alerting me to any problems. As a control, I wanted to see what events were logged when I skip in a functional recording

Code:

2016-01-13 13:45:28.211    [DEBUG][1]    User is trying to skip.
2016-01-13 13:45:28.211    [DEBUG][1]    Current position is: 43.2552070617676
2016-01-13 13:45:28.211    [DEBUG][1]    Asking for position: 103.25520324707
2016-01-13 13:45:28.211    [DEBUG][1]    Pause()
2016-01-13 13:45:28.232    [DEBUG][1]    SetPosition(103.255203)
2016-01-13 13:45:28.232    [DEBUG][1]    SetPosition@skipmap
2016-01-13 13:45:28.232    [DEBUG][1]    SetPosition@skipmap2
2016-01-13 13:45:28.232    [DEBUG][1]    SetPosition@skipmap3
2016-01-13 13:45:28.232    [DEBUG][1]    SetPosition@skipmap4
2016-01-13 13:45:28.232    [DEBUG][1]    SetPosition@skipmap5
2016-01-13 13:45:28.232    [DEBUG][1]    Using timing.info, jumping to time 103.255203 (offset 147740176)
2016-01-13 13:45:28.232    [DEBUG][1]    SetPosition@skipmap6
2016-01-13 13:45:28.232    [DEBUG][1]    SetPosition@skipmap7
2016-01-13 13:45:28.279    [DEBUG][1]    after skip disk offset 147777776
2016-01-13 13:45:28.279    [DEBUG][1]    SetPosition@exit
2016-01-13 13:45:28.279    [DEBUG][1]    Play()
2016-01-13 13:45:28.279    [DEBUG][1]    skippedWhilePaused enabled (position: 103.25520324707)
2016-01-13 13:45:28.279    [DEBUG][1]    SetPosition(103.455200)
2016-01-13 13:45:28.279    [DEBUG][1]    SetPosition@skipmap
2016-01-13 13:45:28.279    [DEBUG][1]    SetPosition@skipmap2
2016-01-13 13:45:28.279    [DEBUG][1]    SetPosition@skipmap3
2016-01-13 13:45:28.279    [DEBUG][1]    SetPosition@skipmap4
2016-01-13 13:45:28.279    [DEBUG][1]    SetPosition@skipmap5
2016-01-13 13:45:28.280    [DEBUG][1]    Using timing.info, jumping to time 103.455200 (offset 147740176)
2016-01-13 13:45:28.280    [DEBUG][1]    SetPosition@skipmap6
2016-01-13 13:45:28.280    [DEBUG][1]    SetPosition@skipmap7
2016-01-13 13:45:28.280    [DEBUG][1]    after skip disk offset 147852976
2016-01-13 13:45:28.281    [DEBUG][1]    SetPosition@exit
2016-01-13 13:45:28.281    [DEBUG][1]    After skipping position reports as: 103.455200195313
2016-01-13 13:45:28.281    [DEBUG][1]    GetEventCode() returned: 0x000e
2016-01-13 13:45:28.306    [DEBUG][1]    Updating OSD.
2016-01-13 13:45:28.933    [DEBUG][1]    Updating OSD.
2016-01-13 13:45:30.022    [DEBUG][1]    Updating OSD.
2016-01-13 13:45:31.011    [DEBUG][1]    Updating OSD.
2016-01-13 13:45:31.980    [DEBUG][1]    Updating OSD.

Everything looks mostly the same for 35 lines, but the corrupt recording has a 30 second gap before returning an eventcode of 0x0003 and 0x0001 which means nothing to me. At this point I'm out of ideas. Does anyone have any ideas how I can fix this problem, or at least better track down where the problem is?

Thanks

[sub]

I can't see anything obviously wrong there. I would switch back to the EVR renderer though.

If you've got a sample recording you'd like to supply, I can try skipping in it here, and see how damaged the file is.

[careads]

I am having what sounds like the same problem with skip, fast forward and seek while playing back some scheduled .ts recordings, and so I thought that I would add to this thread. I see other threads with similar issues.

Skip, fast forward and seek may work in the first minute or so, but when they are used past the first minute, the screen goes blank for a while and then NextPVR returns to recordings.

Here is what I know:
* If skip, fast forward and seek are not used, all recordings play from start to finish without any issues.
* Only scheduled recordings on certain channels can have the problem.
* Live TV recordings do not have the problem on any channel.
* VLC doesn't have any issues playing back a problem .ts file.
* Windows Media Player also has seek problems starting after the first minute or so. After disabling Media Foundation with CodecTweakTool_599.exe, Window Media Player seeks work fine. This tweak doesn't help NextPVR.
* By copying a scheduled recording with the problem to a NextPVR video folder and renaming it from <file>.ts to <file>.mpeg, skip, fast forward and seek work fine.
* I have reproduced this problem on:
- Windows 7 Professional and Windows 7 Home Premium
- NextPVR 3.4.8 and 3.6.6
- HD HomeRun, recording ATSC
* I use these settings:
- Video renderer = EVR
- Video decoder = Microsoft DTV-DVD Video Decoder
- Audio decoder = LAV Audio Decoder
- Windows Media Center disabled
* Switched to AverMedia 716X BDA ATSC DC PCIe tuner card on a system having the problem with HD HomeRun, and the problem went away. I tried changing many things, so I'm not 100% sure that the AverMedia card was the difference.

Because a simple renaming of the file from .ts to .mpeg allows skip, fast forward and seek to work properly, it makes me think that I am missing some simple setting(s) somewhere.

sub, any suggestions? I have a 1GB video that has the problem. I can't create a smaller example file because the smallest NextPVR scheduled recording is 10 minutes. Is that too large to upload? If not, how do I upload it?

Thanks,
Andrew

[sub]

I'm happy to take a look at 1GB file. I don't provide any upload facility though - you'd need to use somewhere like dropbox / onedrive / google drive, then let me know the url for downloading the file from.

[Zeb]

That sounds like an HDHomerun issue that has been known for years. The solution used to be selecting Other: ATSC/QAM in the Silicondust software (instead of NextPVR), as I first learned in this May 2013 post: http://forums.nextpvr.com/showthread.php...post457164. It seems like mvallevand once pointed out an even earlier post, and BTW I"m sure that Martin knows more about this issue than I do. Unfortunately more recent versions of the Silicondust software no longer include the "Other" setting, and I don't know if any alternative solution has been found by anyone.

[ejb]

I am using a HDHomerun Extend and had a problem with some audio when the BDA compatibility setting was set to NPVR (this is the new setting in SD's software). I am now using the setting for BeyondTV and it seems to work perfectly - I have heard others have had success with the BDA compatibility setting on Media Portal.

[sub]

That sounds like an HDHomerun issue that has been known for years. The solution used to be selecting Other: ATSC/QAM in the Silicondust software (instead of NextPVR), as I first learned in this May 2013 post: http://forums.nextpvr.com/showthread.php...post457164. It seems like mvallevand once pointed out an even earlier post, and BTW I"m sure that Martin knows more about this issue than I do. Unfortunately more recent versions of the Silicondust software no longer include the "Other" setting, and I don't know if any alternative solution has been found by anyone.

From memory, selecting 'Mediaportal' is the same as selecting 'Other' in the past. (ie, tells drivers not to try to be too smart - just pass the whole stream to the listening appplication). 'BeyondTV' setting is probably the same too.

I tried to get them to change the defaults in the 'NextPVR' setting, but they were reluctant because they thought it was performing fine (and gives much lower network utilitization than other app profiles). In fairness, it does seem fine for most people, but there is some people that have issues with this profile.

[careads]

Zeb,
I've had the HD HomeRun for years and still had the original installation disk. This time I unchecked the option to check for on-line updates. Thanks. That appears to have done the trick.

sub,
I still had the old HD HomeRun software, so my problem is solved. In case you would like to investigate further to prevent this from happening to others, I was able to create a shorter example video by scheduling a recording and then canceling it after 3 minutes. Make sure your skip is not set too long. It is still curious to me that if you rename the .ts file to .mpeg skip, seek and fast forward work.

https://drive.google.com/file/d/0Bw5NuVe...sp=sharing

[sub]

Did you record this on an NTFS drive?

If so, can you do:

notepad "C:\Path\To\TMZ Live_20160203_18001900.ts:timing.info"

Then post that timing info?

[sub]

Generally when you get these sort of problems playing a .ts file, it's because the broadcast contained a screwy timeline. ie, like the last timestamp in the file is earlier than the first time stamp in the file. This screws up lots of players. Most broadcasters have pretty good timelines, but you get these from time to time.

NextPVR improves it's own accuracy while playing these problem recordings, by using that special timing.info embedded info. Basically we need to confirm you've got that timing.info, and if not why not (like using FAT32 drive, or you've been moving/manipulating the file post recording).