2005-11-15, 05:00 PM
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:
The second crash was a bit different.
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.
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.