Playback ending prematurely
#1
Hello,

I've noticed that playing files from rars ends 2-3s before it should. I'm running Dharma RC1 and I think DSPlayer had the same problem.

I'd assume this is related to rars, because I didn't find anything related in trac and rars isn't too popular format to store your video files. Anyhow, I found a similar problem with DVD playback: http://trac.xbmc.org/ticket/5478

So, anyone else noticed similar problems? I'll make a full trac entry if you guys think this is a bug.

System:
Win7 64-bit, Intel C2D E8600, ATI Radeon 4870 w/ 10.11

Here's my debug log at the end:
Code:
21:19:37 T:3348 M:1869598720 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
21:19:37 T:3900 M:1869443072  NOTICE: CDVDPlayer::OnExit()
21:19:37 T:3900 M:1869443072  NOTICE: DVDPlayer: eof, waiting for queues to empty
21:19:37 T:3900 M:1869443072  NOTICE: DVDPlayer: closing audio stream
21:19:37 T:3900 M:1869443072  NOTICE: Closing audio stream
21:19:37 T:3900 M:1869443072  NOTICE: CDVDMessageQueue(audio)::WaitUntilEmpty
21:19:37 T:5044 M:1869443072 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
21:19:37 T:3900 M:1869443072  NOTICE: Waiting for audio thread to exit
21:19:37 T:5044 M:1869443072  NOTICE: thread end: CDVDPlayerAudio::OnExit()
21:19:37 T:3900 M:1869508608  NOTICE: Closing audio device
21:19:38 T:3900 M:1869090816  NOTICE: Deleting audio codec
21:19:38 T:3900 M:1869115392  NOTICE: DVDPlayer: closing video stream
21:19:38 T:3900 M:1869115392  NOTICE: Closing video stream
21:19:38 T:3900 M:1869115392  NOTICE: CDVDMessageQueue(video)::WaitUntilEmpty
21:19:38 T:3900 M:1869115392  NOTICE: waiting for video thread to exit
21:19:38 T:3348 M:1869115392   ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true
21:19:38 T:3348 M:1869115392  NOTICE: thread end: video_thread
21:19:38 T:3900 M:1869152256  NOTICE: deleting video codec
21:19:38 T:3900 M:1874862080  NOTICE: DVDPlayer: closing subtitle stream
21:19:38 T:3900 M:1874862080  NOTICE: Closing subtitle stream
21:19:38 T:3900 M:1874862080  NOTICE: CDVDPlayer::OnExit() deleting demuxer
21:19:38 T:3900 M:1875091456  NOTICE: CDVDPlayer::OnExit() deleting input stream
21:19:39 T:3472 M:1827069952 WARNING: XFILE::CVideoDatabaseDirectory::GetLabel - Unknown nodetype requested 12
21:19:39 T:3472 M:1823186944  NOTICE: CDVDPlayer::CloseFile()
21:19:39 T:3472 M:1823182848 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
21:19:39 T:3472 M:1823182848  NOTICE: DVDPlayer: waiting for threads to exit
21:19:39 T:3472 M:1823178752  NOTICE: DVDPlayer: finished waiting
21:19:39 T:3472 M:1827823616 WARNING: XFILE::CVideoDatabaseDirectory::GetLabel - Unknown nodetype requested 12
Reply
#2
Generally, it is recommended that you post your full debug log using pastebin.
Reply
#3
natethomas Wrote:Generally, it is recommended that you post your full debug log using pastebin.
I will when I watch something with the full debugging thing on. I just decided to ask if someone else has noticed similar behavior.
Reply
#4
Okay, double post, but bumping it up, because of the added info. Here's a full debug log http://codepad.org/EqeBCiXs

So, the most interesting part is this I guess:
Code:
23:12:23 T:2396 M:1748959232   ERROR: ffmpeg[95C]: [matroska] Read error
23:12:31 T:1072 M:1746415616 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
23:12:31 T:1072 M:1746432000    INFO: CDVDPlayerVideo - Stillframe detected, switching to forced 23.976025 fps
23:12:31 T:1072 M:1746432000   DEBUG: CPullupCorrection: pattern lost
23:12:31 T:3980 M:1748779008   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_EOF
23:12:31 T:3980 M:1748779008 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
23:12:31 T:2396 M:1748779008  NOTICE: CDVDPlayer::OnExit()
And this is happening with all the files.
Reply
#5
Jani Wrote:Okay, double post, but bumping it up, because of the added info. Here's a full debug log http://codepad.org/EqeBCiXs

So, the most interesting part is this I guess:
Code:
23:12:23 T:2396 M:1748959232   ERROR: ffmpeg[95C]: [matroska] Read error
23:12:31 T:1072 M:1746415616 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
23:12:31 T:1072 M:1746432000    INFO: CDVDPlayerVideo - Stillframe detected, switching to forced 23.976025 fps
23:12:31 T:1072 M:1746432000   DEBUG: CPullupCorrection: pattern lost
23:12:31 T:3980 M:1748779008   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_EOF
23:12:31 T:3980 M:1748779008 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
23:12:31 T:2396 M:1748779008  NOTICE: CDVDPlayer::OnExit()
And this is happening with all the files.

That link isn't a debug log.

JR
Reply
#6
jhsrennie Wrote:That link isn't a debug log.
Hmm, codepad has cutted my paste for some reason. Let me try an another site.

EDIT: ok, here we go: http://privatepaste.com/001f601e81 . I forgot the debugging first, but I turned it on half way thru the first series. At least the second series, Better With You, is debugged fully.
Reply

Logout Mark Read Team Forum Stats Members Help
Playback ending prematurely0