NextPVR Forums
  • ______
  • Home
  • New Posts
  • Wiki
  • Members
  • Help
  • Search
  • Register
  • Login
  • Home
  • Wiki
  • Members
  • Help
  • Search
NextPVR Forums Public NextPVR Support Legacy (v4.x and earlier) v
« Previous 1 … 228 229 230 231 232 … 433 Next »
REDUX: Can't Skip Analog Recordings After v2.5.9->3.1.1 Upgrade

REDUX: Can't Skip Analog Recordings After v2.5.9->3.1.1 Upgrade
Braklet
Offline

Senior Member
Posts: 532
Threads: 60
Joined: Sep 2006
#1
2014-01-13, 03:43 PM
A few weeks ago, I experienced a problem skipping ahead in currently-recording ATSC broadcasts. Sub found a timing problem that only affects XP users like myself.

Well, it happened again last night, except this time the culprit was an analog recording from my HVR-2250 card. Same symptoms as before, with an "Unhandled Exception" popup from npvr.exe. I checked NPVR.log and found evidence similar to that reported before.


Code:
2014-01-12 21:02:42.727    [DEBUG][1]    Playing video file: E:\Video\NPVR\Worlds Dumbest\Worlds Dumbest_20140112_20002100.ts
2014-01-12 21:02:42.742    [DEBUG][1]    Using 'NPVR TS Reader2'
2014-01-12 21:02:42.742    [DEBUG][1]    File in use. Maybe still recording.
2014-01-12 21:02:42.742    [DEBUG][1]    Timing.info reports duration 4056594ms
2014-01-12 21:02:42.805    [DEBUG][1]    RenderDemux()
2014-01-12 21:02:42.805    [DEBUG][1]    Adding system HE-AAC decoder
2014-01-12 21:02:42.805    [DEBUG][1]    Adding system AC3 decoder
2014-01-12 21:02:42.805    [DEBUG][1]    Adding system MPEG1 Layer2 decoder
2014-01-12 21:02:42.805    [DEBUG][1]    about to load decoder
2014-01-12 21:02:42.883    [DEBUG][1]    added decoder to graph
2014-01-12 21:02:42.883    [DEBUG][1]    adding audio renderer: Default DirectSound Device
2014-01-12 21:02:42.992    [DEBUG][1]    Adding system E-AC3 decoder
2014-01-12 21:02:43.008    [DEBUG][1]    Adding system MPEG2 decoder
2014-01-12 21:02:43.008    [DEBUG][1]    Adding VMR9 Custom renderer
2014-01-12 21:02:43.024    [DEBUG][1]    DISPLAYMODE: 1920x1080  60
2014-01-12 21:02:43.039    [DEBUG][1]    CAllocator::AddRef (m_refCount=2)
2014-01-12 21:02:43.039    [DEBUG][1]    CAllocator::AddRef (m_refCount=3)
2014-01-12 21:02:43.039    [DEBUG][1]    CAllocator::AddRef (m_refCount=4)
2014-01-12 21:02:43.055    [DEBUG][1]    about to load decoder
2014-01-12 21:02:43.133    [DEBUG][1]    added decoder to graph
2014-01-12 21:02:43.195    [ERROR][1]    ConnectPins: Failed to find output pin named ~CC
2014-01-12 21:02:43.195    [ERROR][1]    ConnectPins: Failed to find output pin named ~CC Out
2014-01-12 21:02:43.242    [DEBUG][1]    Static Reference clock set to: MPEG1 Audio Renderer
2014-01-12 21:02:43.742    [DEBUG][1]    restoring last aspect ratio
2014-01-12 21:02:43.742    [DEBUG][1]    Source Aspect Ratio: 704x576
2014-01-12 21:02:43.742    [DEBUG][1]    Playback graph running...
2014-01-12 21:02:43.742    [DEBUG][1]    Graph filter list:
2014-01-12 21:02:43.742    [DEBUG][1]     - NPVR CC Dump
2014-01-12 21:02:43.742    [DEBUG][1]     - Video Mixing Renderer 9
2014-01-12 21:02:43.742    [DEBUG][1]     - NPVR PES Collector (Teletext)
2014-01-12 21:02:43.742    [DEBUG][1]     - NPVR PES Collector (DVBSubs)
2014-01-12 21:02:43.742    [DEBUG][1]     - MPEG1 Audio Renderer
2014-01-12 21:02:43.742    [DEBUG][1]     - Line 21 Decoder
2014-01-12 21:02:43.742    [DEBUG][1]     - NVIDIA Audio Decoder
2014-01-12 21:02:43.742    [DEBUG][1]     - NVIDIA Video Decoder
2014-01-12 21:02:43.742    [DEBUG][1]     - MPEG-2 Demultiplexer
2014-01-12 21:02:43.742    [DEBUG][1]     - NPVR TS Reader2
2014-01-12 21:02:44.789    [DEBUG][1]    ActivatePopup: null
2014-01-12 21:02:44.789    [DEBUG][1]    deactivating old popup: ShowDetailsPopup
2014-01-12 21:02:44.789    [DEBUG][1]    Going to dispose popup at end of animation
2014-01-12 21:02:44.789    [DEBUG][1]    OnKeyDown() done. Took 2062.447265625 ms
2014-01-12 21:02:44.789    [DEBUG][1]    GetEventCode() returned: 0x000d
2014-01-12 21:02:44.789    [DEBUG][1]    GetEventCode() returned: 0x000e
2014-01-12 21:02:44.789    [DEBUG][1]    audio renderer now MPEG1
2014-01-12 21:02:44.789    [DEBUG][1]    Dynamic reference clock set to: MPEG1 Audio Renderer
2014-01-12 21:02:44.789    [DEBUG][1]    Reference clock was already se correctly. No change required.
2014-01-12 21:02:44.789    [DEBUG][1]    GetEventCode() returned: 0x8102
2014-01-12 21:02:44.789    [DEBUG][1]    Aspect ratio now: 4x3
2014-01-12 21:02:44.789    [DEBUG][1]    Resolution is now: 720x480
2014-01-12 21:02:44.789    [DEBUG][1]    Source Aspect Ratio: 4x3
2014-01-12 21:02:44.789    [DEBUG][1]    GetEventCode() returned: 0x8101
2014-01-12 21:02:44.789    [DEBUG][1]    GetEventCode() returned: 0x8065
[...]
2014-01-12 21:02:44.789    [DEBUG][1]    GetEventCode() returned: 0x8065
2014-01-12 21:02:44.805    [DEBUG][1]    GetDuration returning 0
2014-01-12 21:02:44.805    [DEBUG][1]    Updating OSD.
2014-01-12 21:02:44.898    [DEBUG][1]    GetDuration returning 0
2014-01-12 21:02:45.008    [DEBUG][1]    GetDuration returning 0
2014-01-12 21:02:45.055    [DEBUG][1]    Calling dispose on old popup(2): ShowDetailsPopup
2014-01-12 21:02:45.055    [DEBUG][1]    ShowDetailsPopup.Dispose()
2014-01-12 21:02:45.055    [DEBUG][1]    UiStatic.Dispose()
2014-01-12 21:02:45.117    [DEBUG][1]    GetDuration returning 0
2014-01-12 21:02:45.227    [DEBUG][1]    GetDuration returning 0
[...]
2014-01-12 21:02:48.227    [DEBUG][1]    appcommand: 11 +(lParam: B0000, wParam: E40352)
2014-01-12 21:02:48.227    [DEBUG][1]    OnKeyDown() called: {CTRL}Right, Control
2014-01-12 21:02:48.242    [DEBUG][1]    GetDuration returning 0
2014-01-12 21:02:48.242    [DEBUG][1]    User is trying to skip.
2014-01-12 21:02:48.242    [DEBUG][1]    Current position is: 4.49723863601685
2014-01-12 21:02:48.242    [DEBUG][1]    Asking for position: -2
2014-01-12 21:02:48.242    [DEBUG][1]    Pause()
2014-01-12 21:02:48.258    [DEBUG][1]    SetPosition(-2.000000)
2014-01-12 21:02:48.258    [DEBUG][1]    SetPosition@skipmap
2014-01-12 21:02:48.258    [DEBUG][1]    SetPosition@skipmap2
2014-01-12 21:02:48.258    [DEBUG][1]    SetPosition@skipmap3
2014-01-12 21:02:48.258    [DEBUG][1]    SetPosition@skipmap4
2014-01-12 21:02:48.258    [DEBUG][1]    SetPosition@skipmap5
2014-01-12 21:02:48.258    [DEBUG][1]    Using timing.info, jumping to time -2.000000 (offset 0)
2014-01-12 21:02:48.258    [DEBUG][1]    SetPosition@skipmap6
2014-01-12 21:02:48.258    [DEBUG][1]    SetPosition@skipmap7
2014-01-12 21:02:48.258    [DEBUG][1]    GetDuration returning 0
2014-01-12 21:02:48.258    [DEBUG][1]    after skip disk offset 4230000
2014-01-12 21:02:48.258    [DEBUG][1]    SetPosition@exit
2014-01-12 21:02:48.258    [DEBUG][1]    Play()
2014-01-12 21:02:48.273    [DEBUG][1]    skippedWhilePaused enabled (position: 4.51263475418091)
2014-01-12 21:02:48.273    [DEBUG][1]    SetPosition(4.712635)
2014-01-12 21:02:48.273    [DEBUG][1]    SetPosition@skipmap
2014-01-12 21:02:48.273    [DEBUG][1]    SetPosition@skipmap2
2014-01-12 21:02:48.273    [DEBUG][1]    SetPosition@skipmap3
2014-01-12 21:02:48.273    [DEBUG][1]    SetPosition@skipmap4
2014-01-12 21:02:48.273    [DEBUG][1]    SetPosition@skipmap5
2014-01-12 21:02:48.273    [DEBUG][1]    Using timing.info, jumping to time 4.712635 (offset 2401700)
2014-01-12 21:02:48.273    [DEBUG][1]    SetPosition@skipmap6
2014-01-12 21:02:48.273    [DEBUG][1]    SetPosition@skipmap7
2014-01-12 21:02:48.445    [DEBUG][1]    GetEventCode() returned: 0x000e
2014-01-12 21:02:48.445    [DEBUG][1]    raw message: 0
2014-01-12 21:02:48.461    [DEBUG][1]    GetDuration returning 0
[...]
2014-01-12 21:02:48.836    [DEBUG][1]    Hiding OSD.
2014-01-12 21:02:48.945    [DEBUG][1]    GetDuration returning 0
2014-01-12 21:02:49.055    [DEBUG][1]    GetDuration returning 0
[...]
2014-01-12 21:02:55.289    [DEBUG][1]    GetDuration returning 0
2014-01-12 21:02:55.320    [DEBUG][1]    OnKeyDown() called: Escape
2014-01-12 21:02:55.320    [DEBUG][1]    About to store playback position information
2014-01-12 21:02:55.320    [DEBUG][1]    GetDuration returning 0
2014-01-12 21:02:55.320    [DEBUG][1]    PlaybackPositionHelper.StorePlaybackPosition(Worlds

Dumbest_20140112_20002100.ts, 4, 0)
2014-01-12 21:02:55.320    [DEBUG][1]    PlaybackPositionHelper.DeletePlaybackPosition(E:\Video\NPVR\Worlds

Dumbest\Worlds Dumbest_20140112_20002100.ts)
2014-01-12 21:02:55.336    [DEBUG][1]    Stopping graph@1

Again, I'm running NPVR v3.1.1 on a HTPC with XP SP3 and all current updates. Let me know if I can extract anything else helpful to the fix.

TIA!
johnsonx42
Offline

Posting Freak
Posts: 7,298
Threads: 189
Joined: Sep 2008
#2
2014-01-13, 04:24 PM
did you check the timing.info for that analog recording? it's probably got the same 0 timestamps throughout.

the timing data for analog recordings is generated in a different program (NPVRWriter.ax) than for digital recordings; sub likely had the same problematic snippet of code in that one, which fails on XP systems.
server: NextPVR 5.0.7/Win10 2004/64-bit/AMD A6-7400k/hvr-2250 & hvr-1250/Winegard Flatwave antenna/Schedules Direct
main client: NextPVR 5.0.7 Desktop Client; LG 50UH5500 WebOS 3.0 TV
johnsonx42
Offline

Posting Freak
Posts: 7,298
Threads: 189
Joined: Sep 2008
#3
2014-01-13, 04:29 PM
oh, just realized sub probably can't make a patch for 3.1.1 any more. if not, you can probably use this one here: http://forums.nextpvr.com/showthread.php...post467068, or get the original one from the 3.1.1 installer.
server: NextPVR 5.0.7/Win10 2004/64-bit/AMD A6-7400k/hvr-2250 & hvr-1250/Winegard Flatwave antenna/Schedules Direct
main client: NextPVR 5.0.7 Desktop Client; LG 50UH5500 WebOS 3.0 TV
Braklet
Offline

Senior Member
Posts: 532
Threads: 60
Joined: Sep 2006
#4
2014-01-13, 04:50 PM
johnsonx42 Wrote:did you check the timing.info for that analog recording? it's probably got the same 0 timestamps throughout.

the timing data for analog recordings is generated in a different program (NPVRWriter.ax) than for digital recordings; sub likely had the same problematic snippet of code in that one, which fails on XP systems.

Timing.info for that same file looks OK, of course this is many hours since it finished recording:
Code:
0,0
891,361900
1797,658000
2703,1118600
3672,1743700
4578,2401700
5469,2993900
6453,3586100
7344,4244100
8219,4836300
9110,5428500
10016,5922000
10906,6547100
11891,7205100
12781,7797300
13688,8290800
14563,8784300
15453,9475200
[...]

What's interesting is that NPVR.log indicates that "GetDuration returning 0" and "Using timing.info, jumping to time -2.000000 (offset 0)" in response to my attempts to skip ahead. This time the analog timing.info looks correct, but npvr.exe is doing something that seems to cause another div/0 exception.
Braklet
Offline

Senior Member
Posts: 532
Threads: 60
Joined: Sep 2006
#5
2014-01-13, 04:52 PM
johnsonx42 Wrote:oh, just realized sub probably can't make a patch for 3.1.1 any more. if not, you can probably use this one here: http://forums.nextpvr.com/showthread.php...post467068, or get the original one from the 3.1.1 installer.

Uh oh, so does that mean v3.1.1 is orphaned? Considering that my analog recordings have good timing.info I don't think overwriting NPVRWriter.ax will have any effect.

Thanks!
Braklet
Offline

Senior Member
Posts: 532
Threads: 60
Joined: Sep 2006
#6
2014-01-13, 04:56 PM
Wonder if this is another case of GetTickCount64 versus GetTickCount as described here? Although that was in reference to NPVRTSMon.ax, so I doubt it.
sub
Online

Administrator

NextPVR HQ, New Zealand
Posts: 106,391
Threads: 767
Joined: Nov 2003
#7
2014-01-13, 05:01 PM
Braklet Wrote:Wonder if this is another case of GetTickCount64 versus GetTickCount as described here? Although that was in reference to NPVRTSMon.ax, so I doubt it.
See if this helps for new recordings.
Braklet
Offline

Senior Member
Posts: 532
Threads: 60
Joined: Sep 2006
#8
2014-01-13, 05:04 PM
sub Wrote:See if this helps for new recordings.

I'll give it a try tonight!

Many thanks for the help, sub.
Braklet
Offline

Senior Member
Posts: 532
Threads: 60
Joined: Sep 2006
#9
2014-01-14, 02:22 AM
sub Wrote:See if this helps for new recordings.

Skipping back and forth in an analog Quick Record seems to work fine. Thanks again, sub.
Braklet
Offline

Senior Member
Posts: 532
Threads: 60
Joined: Sep 2006
#10
2014-01-14, 02:51 PM
Hi johnsonx42, don't know if you're still rolling update collections but might want to add NPVRWriter.ax from this thread. Thanks!
« Next Oldest | Next Newest »

Users browsing this thread: 1 Guest(s)



Possibly Related Threads…
Thread Author Replies Views Last Post
  Failed recordings won't delete Spid4567 3 2,158 2023-07-14, 10:13 PM
Last Post: ZeDoZ
  Hauppauge WinTV-HVR-950 - Analog FM Radio No sound RazorRust 8 1,699 2022-04-02, 05:50 PM
Last Post: mvallevand
  All my recordings start 90 sec early ncsercs 2 1,184 2022-03-19, 03:28 AM
Last Post: sub
  Wake - Sleep Interaction -> Failed Recordings mikeh49 48 13,245 2021-03-21, 11:21 PM
Last Post: careads
  Most recordings are zero bytes virtualpaul 4 1,805 2021-01-29, 12:55 PM
Last Post: virtualpaul
  Recordings with Next PVR 4.2.5 (CL0116) have background music but no voice in record DavidF 4 1,820 2021-01-07, 08:47 AM
Last Post: sub
  Recordings not playing in browser FamilyGuyFan 1 1,302 2020-10-22, 10:18 PM
Last Post: mvallevand
  Recordings 1 minute off BobbyDing 7 2,520 2020-10-11, 08:07 PM
Last Post: mvallevand
  easy tools to remove adverts in recordings? V_J 6 3,632 2020-10-06, 02:37 AM
Last Post: Ehrlichia
  Black screen, no audio, & zero bit recordings mattman1968 1 1,438 2020-09-15, 12:19 AM
Last Post: mattman1968

  • View a Printable Version
  • Subscribe to this thread
Forum Jump:

© Designed by D&D, modified by NextPVR - Powered by MyBB

Linear Mode
Threaded Mode