NextPVR Forums

Full Version: MVP Crash when skipping past end of recording in progress
You're currently viewing a stripped down version of our content. View the full version with proper formatting.
Pages: 1 2
I was watching a show last night that was still recording and had two instances where the MVP crashed when it caught up with the end of the stream. I'm running v94.13 with comskip set to run after the recording is complete so it hadn't run yet.

The first crash occurred after pressing the skip forward button:

Code:
11/14/2005 8:47:12 PM.781    VERBOSE    [15]    Request 200000 bytes (file size:2183438272   file location: 2160948357)
11/14/2005 8:47:12 PM.781    VERBOSE    [15]    about to check
11/14/2005 8:47:12 PM.781    VERBOSE    [15]    ...livetv mode
11/14/2005 8:47:12 PM.781    VERBOSE    [47]    MVP data read: 1   (4)
11/14/2005 8:47:12 PM.781    VERBOSE    [47]    User pressed: 43
11/14/2005 8:47:12 PM.781    VERBOSE    [47]    Skipping forward: 0
11/14/2005 8:47:12 PM.781    VERBOSE    [47]    mvpVideoDuration: 2892
11/14/2005 8:47:12 PM.781    VERBOSE    [47]    MVPSetPlaybackPosition() request to set position to: 2891 seconds
11/14/2005 8:47:12 PM.781    VERBOSE    [47]    MVP not sending frame
11/14/2005 8:47:12 PM.781    VERBOSE    [47]    MVP request processed
11/14/2005 8:47:12 PM.843    VERBOSE    [47]    MVP data read: 1   (9)
11/14/2005 8:47:12 PM.843    VERBOSE    [47]    PACK9: 00000080D081C5000000
11/14/2005 8:47:12 PM.843    VERBOSE    [47]    MVP request processed
11/14/2005 8:47:12 PM.968    VERBOSE    [15]    Stream Length: 2183571392
11/14/2005 8:47:12 PM.968    VERBOSE    [15]    Stream Duration: 2892
11/14/2005 8:47:12 PM.968    VERBOSE    [15]    requestedPositionInSeconds: 2891
11/14/2005 8:47:12 PM.968    VERBOSE    [15]    Set position to:2182816353
11/14/2005 8:47:12 PM.968    VERBOSE    [15]    Received request to seek to pos:2182816353
11/14/2005 8:47:13 PM.000    VERBOSE    [15]    Request 200000 bytes (file size:2183593920   file location: 2182816353)
11/14/2005 8:47:13 PM.000    VERBOSE    [15]    about to check
11/14/2005 8:47:13 PM.000    VERBOSE    [15]    ...livetv mode
11/14/2005 8:47:13 PM.062    VERBOSE    [15]    Request 200000 bytes (file size:2183671744   file location: 2183016353)
11/14/2005 8:47:13 PM.062    VERBOSE    [15]    about to check
11/14/2005 8:47:13 PM.062    VERBOSE    [15]    ...livetv mode
11/14/2005 8:47:13 PM.062    VERBOSE    [47]    MVP data read: 1   (9)
11/14/2005 8:47:13 PM.062    VERBOSE    [47]    PACK9: 000000821E2FA1000000
11/14/2005 8:47:13 PM.062    VERBOSE    [47]    MVP request processed
11/14/2005 8:47:13 PM.093    VERBOSE    [47]    MVP data read: 1   (7)
11/14/2005 8:47:13 PM.093    VERBOSE    [47]    MVP request processed
11/14/2005 8:47:13 PM.156    VERBOSE    [15]    Request 200000 bytes (file size:2183745472   file location: 2183216353)
11/14/2005 8:47:13 PM.156    VERBOSE    [15]    about to check
11/14/2005 8:47:13 PM.156    VERBOSE    [15]    ...livetv mode
11/14/2005 8:47:13 PM.156    VERBOSE    [47]    MVP data read: 1   (9)
11/14/2005 8:47:13 PM.156    VERBOSE    [47]    PACK9: 00000082213CE1000000
11/14/2005 8:47:13 PM.156    VERBOSE    [47]    MVP request processed
11/14/2005 8:47:13 PM.218    VERBOSE    [15]    Request 200000 bytes (file size:2183765952   file location: 2183416353)
11/14/2005 8:47:13 PM.218    VERBOSE    [15]    about to check
11/14/2005 8:47:13 PM.218    VERBOSE    [15]    ...livetv mode
11/14/2005 8:47:13 PM.218    VERBOSE    [47]    MVP data read: 1   (9)
11/14/2005 8:47:13 PM.218    VERBOSE    [47]    PACK9: 00000082244A21000000
11/14/2005 8:47:13 PM.218    VERBOSE    [47]    MVP request processed
11/14/2005 8:47:13 PM.281    VERBOSE    [15]    Request 200000 bytes (file size:2183819200   file location: 2183616353)
11/14/2005 8:47:13 PM.281    VERBOSE    [15]    about to check
11/14/2005 8:47:13 PM.281    VERBOSE    [15]    ...livetv mode
11/14/2005 8:47:13 PM.281    VERBOSE    [47]    MVP data read: 1   (9)
11/14/2005 8:47:13 PM.281    VERBOSE    [47]    PACK9: 00000082275761000000
11/14/2005 8:47:13 PM.281    VERBOSE    [47]    MVP request processed
11/14/2005 8:47:13 PM.343    VERBOSE    [15]    Request 200000 bytes (file size:2183890880   file location: 2183816353)
11/14/2005 8:47:13 PM.343    VERBOSE    [15]    about to check
11/14/2005 8:47:13 PM.343    VERBOSE    [15]    ...livetv mode
11/14/2005 8:47:13 PM.343    VERBOSE    [47]    MVP data read: 1   (9)
11/14/2005 8:47:13 PM.343    VERBOSE    [47]    PACK9: 000000822A64A1000000
11/14/2005 8:47:13 PM.343    VERBOSE    [47]    MVP request processed
11/14/2005 8:47:13 PM.359    ERROR    [15]    Media stream thread caught exception: Specified cast is not valid.
11/14/2005 8:47:13 PM.359    ERROR    [15]       at xae10db17d26ba033.xbb1566157f5f8b1f.xf9d81bb81f7c2ff0()
11/14/2005 8:47:13 PM.437    VERBOSE    [2]    getValue() loading new key/value into cache: /settings/NetRadioBufferSize
11/14/2005 8:47:13 PM.437    VERBOSE    [2]    getValue: /settings/NetRadioBufferSize : 96000
11/14/2005 8:47:13 PM.437    INFO    [2]    NetRadio buffer size is: 96000
11/14/2005 8:47:13 PM.578    VERBOSE    [47]    MVP data read: 1   (9)
11/14/2005 8:47:13 PM.578    VERBOSE    [47]    PACK9: 00000080CD7485000000
11/14/2005 8:47:13 PM.578    VERBOSE    [47]    MVP request processed

The second crash was a bit different.

Code:
11/14/2005 8:54:45 PM.968    VERBOSE    [47]    Request 200000 bytes (file size:2525896640   file location: 2508160108)
11/14/2005 8:54:45 PM.968    VERBOSE    [47]    about to check
11/14/2005 8:54:45 PM.968    VERBOSE    [47]    ...livetv mode
11/14/2005 8:54:46 PM.000    VERBOSE    [48]    MVP data read: 1   (4)
11/14/2005 8:54:46 PM.000    VERBOSE    [48]    User pressed: 43
11/14/2005 8:54:46 PM.000    VERBOSE    [48]    Skipping forward: 1
11/14/2005 8:54:46 PM.000    VERBOSE    [48]    mvpVideoDuration: 3345
11/14/2005 8:54:46 PM.000    VERBOSE    [48]    MVPSetPlaybackPosition() request to set position to: 3351 seconds
11/14/2005 8:54:46 PM.000    VERBOSE    [48]    MVP not sending frame
11/14/2005 8:54:46 PM.000    VERBOSE    [48]    MVP request processed
11/14/2005 8:54:46 PM.031    VERBOSE    [48]    MVP data read: 1   (9)
11/14/2005 8:54:46 PM.031    VERBOSE    [48]    PACK9: 000000958289AC000000
11/14/2005 8:54:46 PM.031    VERBOSE    [48]    MVP request processed
11/14/2005 8:54:46 PM.062    VERBOSE    [47]    Stream Length: 2525994944
11/14/2005 8:54:46 PM.062    VERBOSE    [47]    Stream Duration: 3345
11/14/2005 8:54:46 PM.062    VERBOSE    [47]    requestedPositionInSeconds: 3351
11/14/2005 8:54:46 PM.062    VERBOSE    [47]    Set position to:-1769037887
11/14/2005 8:54:46 PM.078    ERROR    [47]    Media stream thread caught exception: An attempt was made to move the file pointer before the beginning of the file.

11/14/2005 8:54:46 PM.093    ERROR    [47]       at System.IO.__Error.WinIOError(Int32 errorCode, String str)
   at System.IO.FileStream.SeekCore(Int64 offset, SeekOrigin origin)
   at System.IO.FileStream.Seek(Int64 offset, SeekOrigin origin)
   at xae10db17d26ba033.xbb1566157f5f8b1f.xf9d81bb81f7c2ff0()
11/14/2005 8:54:46 PM.109    VERBOSE    [2]    getValue() loading new key/value into cache: /settings/NetRadioBufferSize
11/14/2005 8:54:46 PM.109    VERBOSE    [2]    getValue: /settings/NetRadioBufferSize : 96000
11/14/2005 8:54:46 PM.109    INFO    [2]    NetRadio buffer size is: 96000

I have the full logs if you need any more data. Hopefully this can be resolved with some slight tweaking of the skip logic for active recordings.
Resurrecting an old thread here, but the same thing happened to me last night:

Code:
3/7/2006 10:03:27 PM.537    VERBOSE    [427]    Request 200000 bytes (file size:1804627904   file location: 1804295133)
3/7/2006 10:03:27 PM.537    VERBOSE    [427]    ...livetv mode
3/7/2006 10:03:27 PM.615    VERBOSE    [429]    MVP data read: 1   (9)
3/7/2006 10:03:27 PM.615    VERBOSE    [429]    MVP request processed
3/7/2006 10:03:27 PM.834    VERBOSE    [427]    Request 200000 bytes (file size:1804627904   file location: 1804495133)
3/7/2006 10:03:27 PM.834    VERBOSE    [427]    ...livetv mode
3/7/2006 10:03:27 PM.834    ERROR    [427]    Media stream thread caught exception: Specified cast is not valid.
3/7/2006 10:03:27 PM.850    ERROR    [427]       at xae10db17d26ba033.xbb1566157f5f8b1f.xf9d81bb81f7c2ff0()
3/7/2006 10:03:27 PM.865    VERBOSE    [427]    eventText=
3/7/2006 10:03:27 PM.865    VERBOSE    [427]    type= CurrentAudioTrack
3/7/2006 10:03:27 PM.865    VERBOSE    [427]    current audio track!
3/7/2006 10:03:27 PM.865    VERBOSE    [427]    eventText=
3/7/2006 10:03:27 PM.865    VERBOSE    [427]    type= VideoStopping
3/7/2006 10:03:28 PM.006    VERBOSE    [427]    MVP Streaming thread waiting for connection
3/7/2006 10:03:28 PM.131    VERBOSE    [429]    MVP data read: 1   (9)
3/7/2006 10:03:28 PM.131    VERBOSE    [429]    MVP request processed
3/7/2006 10:03:28 PM.131    VERBOSE    [426]    flushDatabaseConnections()
<end of file>
This also happens to me every time, MVP disconnects whenever I catch up, and try to skip past the end of a recording in progress. Has happened with at least the last 3 releases. Any solution?
roy Wrote:This also happens to me every time, MVP disconnects whenever I catch up, and try to skip past the end of a recording in progress. Has happened with at least the last 3 releases. Any solution?
I've just tried to reproduce this here without any luck.

Are you using v0.97.9?

What I tried was doing a quick record from the TV Guide, then going to the Recordings screen, viewing the 'pending' list and playing the in-progress recording. The recording was only about 10 seconds long when I started watching. I press the skip button to jump forward a minute, and it correctly detected this would be past the end of the movie, so instead placed me about two seconds back from the current recording position. Do you have a different set of steps you can provide to reproduce this problem?
Howdy sub, welcome back. I get this one as well. Followed your steps.

Had about 10 seconds worth, skip worked. But then I tried the other one (whatever ctrl-right key on the remote is called) The 1 minute skip and BAM, reboot MVP.
sub Wrote:What I tried was doing a quick record from the TV Guide, then going to the Recordings screen, viewing the 'pending' list and playing the in-progress recording. The recording was only about 10 seconds long when I started watching. I press the skip button to jump forward a minute, and it correctly detected this would be past the end of the movie, so instead placed me about two seconds back from the current recording position. Do you have a different set of steps you can provide to reproduce this problem?

I just did exactly those steps and - disconnect. Logs attached (yes, 97.9). I'm thinking comskip may be involved. I have comskip set to run during recording, and sometimes, I think, if comskip tries to skip to the end of a recording in progress, this also will cause crash.

Thanks
Can you see if the patch I posted at http://forums.gbpvr.com/showpost.php?p=1...ostcount=2 helps this problem for you?
sub Wrote:Can you see if the patch I posted at http://forums.gbpvr.com/showpost.php?p=1...ostcount=2 helps this problem for you?

That helped me, I couldn't make it crash. Normally find if I try skipping around inside a currently active recording i'lll pretty much kill it. With that patch i was ok backwards and forwards with short skip and normal skip.

I'll test further under normal conditions (i.e watching a recording and skipping the ads). But looks good so far....cheers.
sub Wrote:Can you see if the patch I posted at http://forums.gbpvr.com/showpost.php?p=1...ostcount=2 helps this problem for you?

Yes! Looks good here. Problem solved. Also resolved crash/disconnect when hitting the end of recording viewed in progress.

This will be a big boost to the WAF. Big Grin Thank you.
sub Wrote:Can you see if the patch I posted at http://forums.gbpvr.com/showpost.php?p=1...ostcount=2 helps this problem for you?

I have this problem too. I've tried to apply the patch but I'm not sure what to do. I'm running v0.97.9. Do I replace gbpvr.exe with the one in the zip file?
Pages: 1 2