[johnmax]

Didnt have this with Camelot, but I upgraded to Dharma B4 and pretty much every movie I try to play I select it and I get the "working" message and it is "working" for almost a minute, and 90% of the time it doesnt play and I get the "one or more items failed to play..." message. If I click on the movie again, it plays instantly then. What causes this? I am running Confluence skin, and the videos are on a SMB network shared folder.

Pastebin link to debug log:
http://pastebin.com/bXDHPSVD

[ronie]

same here, but that's because i put my discs to sleep after being idle for 15 minutes.

so yes, when i first try to play a video it takes some time for the disc to spin-up and apparently xbmc times-out waiting for the video before the disc is ready.

might be the same issue at your end.

[johnmax]

My disks arent going to sleep. The data is stored on a machine running Windows Home Server.

[johnmax]

Some lines from the log:

First unsuccessful attempt at playing Baby Einstein Numbers Nursery:

17:44:25 T:3316 M:737603584 NOTICE: DVDPlayer: Opening: smb://HOMESERVER/Videos/Baby Einstein/07BE_NUMBERS_NURSERY.avi
17:44:25 T:3316 M:737599488 WARNING: CDVDMessageQueue(player):ut MSGQ_NOT_INITIALIZED
17:44:25 T:3728 M:737513472 NOTICE: Creating InputStream
17:44:26 T:3728 M:737341440 NOTICE: Creating Demuxer
17:44:47 T:3672 M:619872256 WARNING: could not find codec parameters for smb://HOMESERVER/Videos/Harry Potter/Harry Potter (1) and The Sorcerer's Stone (2001).m2ts
17:45:17 T:520 M:618422272 WARNING: could not find codec parameters for smb://HOMESERVER/Videos/Harry Potter/Harry Potter (5) and The Order of The Phoenix (2007).m2ts
17:45:17 T:3728 M:809271296 WARNING: could not find codec parameters for smb://HOMESERVER/Videos/Baby Einstein/07BE_NUMBERS_NURSERY.avi
17:45:17 T:3728 M:812388352 ERROR: CDVDPlayer::OpenDemuxStream - Error creating demuxer
17:45:17 T:3728 M:812388352 NOTICE: CDVDPlayer::OnExit()
17:45:17 T:3728 M:812388352 NOTICE: CDVDPlayer::OnExit() deleting input stream
17:45:17 T:3316 M:812699648 ERROR: Playlist Player: skipping unplayable item: 0, path [smb://HOMESERVER/Videos/Baby Einstein/07BE_NUMBERS_NURSERY.avi]
17:45:17 T:3316 M:812695552 NOTICE: CDVDPlayer::CloseFile()
17:45:17 T:3316 M:812695552 WARNING: CDVDMessageQueue(player):ut MSGQ_NOT_INITIALIZED
17:45:17 T:3316 M:812695552 NOTICE: DVDPlayer: waiting for threads to exit
17:45:17 T:3316 M:812695552 NOTICE: DVDPlayer: finished waiting

Why the heck is it looking for other codecs for other files while it should be playing my selected movie

and then the second attempt when it played right away:

17:45:23 T:3316 M:811581440 NOTICE: DVDPlayer: Opening: smb://HOMESERVER/Videos/Baby Einstein/07BE_NUMBERS_NURSERY.avi
17:45:23 T:3316 M:811577344 WARNING: CDVDMessageQueue(player):ut MSGQ_NOT_INITIALIZED
17:45:23 T:2372 M:811569152 NOTICE: Creating InputStream
17:45:23 T:2372 M:811606016 NOTICE: Creating Demuxer
17:45:24 T:2372 M:806907904 NOTICE: Opening video stream: 0 source: 256
17:45:24 T:2372 M:806907904 NOTICE: Creating video codec with codec id: 13
17:45:24 T:2372 M:806842368 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-4 part 2
17:45:24 T:2372 M:806002688 NOTICE: Creating video thread
17:45:24 T:2372 M:805969920 NOTICE: Opening audio stream: 1 source: 256
17:45:24 T:2372 M:805965824 NOTICE: Finding audio codec for: 86017
17:45:24 T:2372 M:805908480 ERROR: CDVDAudioCodecPassthroughFFmpeg::Open - FFmpeg SPDIF muxer does not support this codec
17:45:24 T:1688 M:805552128 NOTICE: running thread: video_thread
17:45:24 T:2372 M:804261888 NOTICE: Creating audio thread
17:45:24 T:1324 M:804241408 NOTICE: running thread: CDVDPlayerAudio:rocess()
17:45:24 T:1688 M:804347904 NOTICE: fps: 29.970030, pwidth: 640, pheight: 480, dwidth: 640, dheight: 480
17:45:24 T:1688 M:804339712 NOTICE: Display resolution DESKTOP : 1024x768 @ 60.00 - Full Screen (12)
17:45:24 T:1324 M:802369536 NOTICE: Creating audio device with codec id: 86017, channels: 2, sample rate: 48000, no pass-through
17:46:38 T:2752 M:801587200 NOTICE: ES: Client from 192.168.0.102 timed out
18:13:57 T:1324 M:769060864 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
18:13:58 T:2372 M:769576960 NOTICE: CDVDPlayer::OnExit()
18:13:58 T:2372 M:769576960 NOTICE: DVDPlayer: eof, waiting for queues to empty
18:13:58 T:2372 M:769576960 NOTICE: DVDPlayer: closing audio stream
18:13:58 T:2372 M:769576960 NOTICE: Closing audio stream
18:13:58 T:2372 M:769576960 NOTICE: CDVDMessageQueue(audio)::WaitUntilEmpty
18:13:58 T:2372 M:769576960 NOTICE: Waiting for audio thread to exit
18:13:58 T:1324 M:769576960 NOTICE: thread end: CDVDPlayerAudio::OnExit()
18:13:58 T:1688 M:769548288 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
18:13:58 T:2372 M:769581056 NOTICE: Closing audio device
18:13:58 T:2372 M:769794048 NOTICE: Deleting audio codec
18:13:58 T:2372 M:769867776 NOTICE: DVDPlayer: closing video stream
18:13:58 T:2372 M:769892352 NOTICE: Closing video stream
18:13:58 T:2372 M:769892352 NOTICE: CDVDMessageQueue(video)::WaitUntilEmpty
18:13:58 T:2372 M:769892352 NOTICE: waiting for video thread to exit
18:13:58 T:1688 M:769892352 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true
18:13:58 T:1688 M:769892352 NOTICE: thread end: video_thread
18:13:58 T:2372 M:769937408 NOTICE: deleting video codec
18:13:58 T:2372 M:772091904 NOTICE: CDVDPlayer::OnExit() deleting demuxer
18:13:58 T:2372 M:775086080 NOTICE: CDVDPlayer::OnExit() deleting input stream
18:13:58 T:3316 M:777043968 WARNING: Skin has invalid include: StudioFlaggingConditions
18:14:00 T:3316 M:775188480 WARNING: Previous line repeats 7 times.
18:14:00 T:3316 M:775188480 NOTICE: CDVDPlayer::CloseFile()
18:14:00 T:3316 M:772812800 WARNING: CDVDMessageQueue(player):ut MSGQ_NOT_INITIALIZED
18:14:00 T:3316 M:772808704 NOTICE: DVDPlayer: waiting for threads to exit
18:14:00 T:3316 M:772788224 NOTICE: DVDPlayer: finished waiting

And I notice tons of errors throughout the whole log like this snippet:

18:14:01 T:2600 M:775131136 ERROR: CDVDDemuxFFmpeg::Open - error probing input format, smb://HOMESERVER/Videos/funny stuff 5/bubbless.avi
18:14:01 T:2600 M:775135232 ERROR: CDVDFileInfo::ExtractThumb - Error creating demuxer
18:14:01 T:1880 M:775090176 ERROR: CDVDDemuxFFmpeg::Open - error probing input format, smb://HOMESERVER/Videos/funny stuff 5/bubbless.avi
18:14:01 T:1868 M:773713920 ERROR: InputStream: dvd streams not supported for thumb extraction, file: smb://HOMESERVER/Videos/Classical Baby/VIDEO_TS.IFO
18:14:01 T:1880 M:775405568 ERROR: CDVDDemuxFFmpeg::Open - error probing input format, smb://HOMESERVER/Videos/Funny stuff 8/main.avi
18:14:02 T:1880 M:775348224 ERROR: InputStream: dvd streams not supported for thumb extraction, file: smb://HOMESERVER/Videos/funny stuff 6saved2/funny stuff 6saved25.img
18:14:04 T:1868 M:775196672 ERROR: CDVDDemuxFFmpeg::Open - Error, could not open file smb://HOMESERVER/Videos/Maddy/1249146077.mov
18:14:04 T:1868 M:775221248 ERROR: CDVDFileInfo::ExtractThumb - Error creating demuxer
18:14:04 T:2600 M:775151616 ERROR: CDVDDemuxFFmpeg::Open - Error, could not open file smb://HOMESERVER/Videos/Maddy/1249146077.mov
18:14:04 T:1880 M:775131136 ERROR: CDVDDemuxFFmpeg::Open - Error, could not open file smb://HOMESERVER/Videos/Maddy/1252597814.mov
18:14:04 T:1880 M:775135232 ERROR: CDVDFileInfo::ExtractThumb - Error creating demuxer
18:14:04 T:1120 M:775098368 ERROR: CDVDDemuxFFmpeg::Open - Error, could not open file smb://HOMESERVER/Videos/Maddy/1252597814.mov
18:14:05 T:2600 M:774201344 WARNING: could not find codec parameters for smb://HOMESERVER/Videos/Mickey Mouse Clubhouse [24 episodes][312x214]/~uTorrentPartFile_A6E439C7.dat
18:14:37 T:1880 M:606330880 WARNING: could not find codec parameters for smb://HOMESERVER/Videos/Harry Potter/Harry Potter (1) and The Sorcerer's Stone (2001).m2ts
18:15:02 T:3316 M:649728000 NOTICE: DVDPlayer: Opening: smb://HOMESERVER/Videos/Boobah/Boobah - Building Blocks.mpg
18:15:02 T:3316 M:649728000 WARNING: CDVDMessageQueue(player):ut MSGQ_NOT_INITIALIZED
18:15:02 T:2808 M:649719808 NOTICE: Creating InputStream
18:15:02 T:2808 M:648437760 NOTICE: Creating Demuxer
18:15:07 T:2600 M:615358464 WARNING: could not find codec parameters for smb://HOMESERVER/Videos/Harry Potter/Harry Potter (5) and The Order of The Phoenix (2007).m2ts
18:15:08 T:2808 M:790986752 NOTICE: Opening video stream: 1 source: 256
18:15:08 T:2808 M:790994944 NOTICE: Creating video codec with codec id: 2
18:15:08 T:2808 M:791154688 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-2 video
18:15:08 T:2808 M:791154688 NOTICE: Creating video thread

What the heck is going on?

[johnmax]

Bump- Anyone

[Tompen]

Your first log snippet looks like ticket 10671

[johnmax]

I guess no resolution to that ticket yet?

[johnmax]

Tried movies on the local disk. Same problem. Very frustrating. Sure its a nice fancy interface, but if it takes 2 minutes to play a movie, then whats the point? Maybe i'll just go back to the old fashioned way...

[triumvirrr]

Just an idea because of all the opened files that seem to have nothing to do with the intended movie:
Could it be, that your videostacking regex is going crazy?

[duffyblue]

I have had this error in the past, with different releases, but unfortunately I can't recall how I fixed it.

Have you tried a complete uninstall? Including deleting all remaining directories, such as the Application Data folder?

[johnmax]

Just an idea because of all the opened files that seem to have nothing to do with the intended movie:
Could it be, that your videostacking regex is going crazy?

Umm im kinda a newb with XBMC. Care to elaborate? Perhaps I should do a search...

I have had this error in the past, with different releases, but unfortunately I can't recall how I fixed it.

Have you tried a complete uninstall? Including deleting all remaining directories, such as the Application Data folder?

I didnt really want to do that as I finally have XBMC configured the way I want it. But at this point with it kinda unusable perhaps I should...

[duffyblue]

I didnt really want to do that as I finally have XBMC configured the way I want it. But at this point with it kinda unusable perhaps I should...

Backup the files to another location and delete, if it doesn't work restore the files.

[johnmax]

yea i guess I may. What do I really need to save- just the stuff in the appdata location? Or anything in the program folder too?

[natethomas]

To save movie and tv data, go to:

Settings>Video>Library

Then Export Video Library and choose Separate. You'll lose your played or not played status, but the rest of the info should be accurate.

Before deleting anything, you might post the full debug log on pastebin.com and, edit your first post to say that you did that and provide the link to pastebin, then edit the title by including [debug log posted]. That'll get the devs looking at it.

[johnmax]

Ok updated with debug log pastebin link