Black video on some media
dnar
Newbie
Posts: 4
#1
2013-05-17, 19:59
OS: Crystalubuntu 2
Hardware: AppleTV 1
XBMC: Frodo

I'm a noob, but have not been able to find an answer to the issue I'm having. I have my movie source as my iTunes library. Some of the movies in my library, when played, display a black screen for video but play the audio. The movie is not DRM protected, and all movies play in iTunes, Quicktime, etc, so I know the movie is playable. What I've noticed in the log for these movies is:
Quote:09:00:51 T:2852100928 DEBUG: CAFPFile::Open - opened iTunes/iTunes Music/Movies/Zathura.m4v, fd=0
09:00:51 T:2852100928 DEBUG: Open - probing detected format [mov,mp4,m4a,3gp,3g2,mj2]
09:00:52 T:2852100928 DEBUG: Open - avformat_find_stream_info starting
09:00:52 T:2852100928 DEBUG: Open - av_find_stream_info finished
09:00:52 T:2852100928 DEBUG: CAFPFile::Close closing fd 0
09:00:52 T:2852100928 ERROR: SQL: SQL error or missing database
Query: INSERT INTO streamdetails (idFile, iStreamType, strVideoCodec, fVideoAspect, iVideoWidth, iVideoHeight, iVideoDuration) VALUES (1072,0,'avc1',NaN,0,0,6084)
09:00:52 T:2852100928 ERROR: SetStreamDetailsForFileId (1072) failed

Not sure why the SQL INSERT fails unless the width and height of 0 are not allowed. When I play the movie Zathura with VLC, it is able to determine width and height and play the movie (on my Mac), it reports for stream 0,
Quote:Type Video
Codec H264 - MPEG-4 AVC (part 10)(avc1)
Language English
Resolution 720x448
Frame rate 23.971824
Decoded format Planar 4:2:0 YUV

MPEG Streamclip reports:
Quote:Stream: Zathura.m4v
Path: /Volumes/iTunes/iTunes Music/Movies/Zathura.m4v

Duration: 1:41:24
Data Size: 2.50 GB
Bit Rate: 3.52 Mbps

Video Tracks:
H.264, 720 × 448, ~23.976 fps, 2.92 Mbps

Audio Tracks:
MPEG-4 Audio stereo, 48 kHz, 160 kbps
?, 0.001 kHz, 448 kbps

Stream Files:
Zathura.m4v (2.50 GB)

And Quicktime 7 reports,
Quote:Format: H.264, 720 x 448 (1,121 x 448) AAC, 48000 Hz, Stereo (L R)
FPS: 23.97
Data size: 2.68 GB
Data rate: 3.53 Mbit/s
Current size: 1,121 x 448 (Actual)


So can anyone explain why these movies don't play in XBMC and if there is anything I can do to fix the issue?

Thanks

Dnar
Find
Reply
Ned Scott
Banned
Posts: 31,445
#2
2013-05-18, 13:20
debug log (wiki)?
Find
Reply
dnar
Newbie
Posts: 4
#3
2013-05-18, 17:42
Ned,
I've enclosed the debug log for "Bambi II". VLC reports:

Stream 0:
Type: Video
Codec: H264 - MPEG-4 AVC (part 10) (avc1)
Language: English
Resolution: 720x480
Frame Rate: 23.971126
Decoded format: Planar 4:2:0 YUV
Stream 1:
Type: Audio
Codec: MPEG AAC Audio (mp4a)
Language: English
Channels: Stereo
Sample rate: 48000 Hz
Stream 2:
Type: Audio
Codec A52 Audio (ada AC3)(a62)
Language: English
Description: Surround
Sample rate: 48000 Hz
Bitrate: 192 kb/s

I have enclosed the debug log below. I edited out what I hope was unnecessary information to make the log smaller. If there appears to be something that I've deleted that you need, I'll replay and submit the entire log. I have also found a solution. I first tried "MPEG Streamclip" opening and "save as" to produce a copy without conversion. That produced a playable movie, however, the resulting file only contained streams 0 and 1. The AC3 stream was missing. I then tried pay ware software called "SimpleMovieX" and opened and then a "save as" to produce a copy without conversion. That worked. All three streams exist in the resulting file and all three are playable. So whatever was causing XBMC not to play the movie was fixed using that program (however, Quicktime, VLC, and MPEG Streamclip could all play the video, although I cannot verify if they all could play stream 2).

Here is the log:
Code:
09:34:58 T:2733357888   DEBUG: DoWork - trying to extract filestream details from video file afp://itunes:[email protected]/iTunes/iTunes Music/Movies/Bambi II.m4v
09:34:58 T:2733357888   DEBUG: CAFPFile::Open - opened iTunes/iTunes Music/Movies/Bambi II.m4v, fd=0
09:34:58 T:2733357888   DEBUG: Open - probing detected format [mov,mp4,m4a,3gp,3g2,mj2]
09:34:59 T:2733357888   DEBUG: Open - avformat_find_stream_info starting
09:34:59 T:2733357888   DEBUG: ffmpeg[A2EBBB40]: [mov,mp4,m4a,3gp,3g2,mj2] max_analyze_duration 5000000 reached at 5024000
09:34:59 T:2733357888   DEBUG: ffmpeg[A2EBBB40]: [mov,mp4,m4a,3gp,3g2,mj2] decoding for stream 0 failed
09:34:59 T:2733357888   DEBUG: ffmpeg[A2EBBB40]: [mov,mp4,m4a,3gp,3g2,mj2] Could not find codec parameters (Video: h264 (avc1 / 0x31637661), 1169 kb/s)
09:34:59 T:2733357888   DEBUG: ffmpeg[A2EBBB40]: [mov,mp4,m4a,3gp,3g2,mj2] decoding for stream 3 failed
09:34:59 T:2733357888   DEBUG: Open - av_find_stream_info finished
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]: Input #0, mov,mp4,m4a,3gp,3g2,mj2, from 'afp://itunes:[email protected]/iTunes/iTunes Music/Movies/Bambi II.m4v':
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:   Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     major_brand     : mp42
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     minor_version   : 0
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     compatible_brands: mp42isom
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     creation_time   : 2008-07-11 21:21:14
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     encoder         : HandBrake svn1554M 2008070301
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     title           : Bambi II
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     artist          : Patrick Stewart, Cree Summer, Keith Ferguson, Brian Pimental, Andrea Bowen
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     date            : 2006-09-26T02:00:00Z
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     genre           : Kids & Family
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     description     : Join Bambi as he reunites with his father, The Great Prince, who must now raise the young fawn and teach him the ways of the forest.  But, in the adventure of a lifetime, the proud parent discovers that there is much that he can learn from his spirited yo
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     synopsis        : Picking up shortly after the original movie's end, Bambi follows his father, the Great Prince, into the forest after his mother's death and the Great Prince must teach the young fawn, and his friends Thumper, Flower and Owl, how a deer survives in the for
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     media_type      : 0
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:   Duration: 01:12:25.47, start: 0.000000, bitrate: 1779 kb/s
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Chapter #0.0: start 0.000000, end 327.432333
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       title           : Chapter  1
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Chapter #0.1: start 327.432333, end 559.375563
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       title           : Chapter  2
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Chapter #0.2: start 559.375563, end 780.044917
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       title           : Chapter  3
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Chapter #0.3: start 780.044917, end 1012.606917
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       title           : Chapter  4
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Chapter #0.4: start 1012.606917, end 1229.155687
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       title           : Chapter  5
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Chapter #0.5: start 1229.155687, end 1567.275646
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       title           : Chapter  6
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Chapter #0.6: start 1567.275646, end 1833.666771
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       title           : Chapter  7
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Chapter #0.7: start 1833.666771, end 2084.989292
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       title           : Chapter  8
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Chapter #0.8: start 2084.989292, end 2322.274771
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       title           : Chapter  9
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Chapter #0.9: start 2322.274771, end 2578.212187
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       title           : Chapter 10
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Chapter #0.10: start 2578.212187, end 2887.595771
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       title           : Chapter 11
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Chapter #0.11: start 2887.595771, end 3145.854562
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       title           : Chapter 12
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Chapter #0.12: start 3145.854562, end 3149.567167
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       title           : Chapter 13
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Chapter #0.13: start 3149.567167, end 3249.081688
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       title           : Chapter 14
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Chapter #0.14: start 3249.081688, end 3605.282813
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       title           : Chapter 15
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Chapter #0.15: start 3605.282813, end 3877.719917
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       title           : Chapter 16
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Chapter #0.16: start 3877.719917, end 4340.655542
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       title           : Chapter 17
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Chapter #0.17: start 4340.655542, end 4341.422979
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       title           : Chapter 18
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Stream #0:0(eng): Video: h264 (avc1 / 0x31637661), 1169 kb/s, SAR 853:720 DAR 0:0, 23.97 fps, 48k tbr, 48k tbn, 96k tbc
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       creation_time   : 2008-07-11 21:21:14
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       handler_name    :
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Stream #0:1(eng): Audio: aac (mp4a / 0x6134706D), 48000 Hz, stereo, s16, 159 kb/s
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       creation_time   : 2008-07-11 21:21:14
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       handler_name    :
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Stream #0:2(eng): Audio: ac3 (ac-3 / 0x332D6361), 48000 Hz, 5.1(side), s16, 448 kb/s
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       creation_time   : 2008-07-11 21:21:14
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       handler_name    :
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Stream #0:3(eng): Subtitle: mov_text (text / 0x74786574)
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:     Metadata:
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       creation_time   : 2008-07-11 21:21:14
09:34:59 T:2733357888    INFO: ffmpeg[A2EBBB40]:       handler_name    :
09:34:59 T:2733357888   DEBUG: CAFPFile::Close closing fd 0
09:34:59 T:2733357888   ERROR: SQL: SQL error or missing database
                                            Query: INSERT INTO streamdetails (idFile, iStreamType, strVideoCodec, fVideoAspect, iVideoWidth, iVideoHeight, iVideoDuration) VALUES (568,0,'avc1',NaN,0,0,4345)
09:34:59 T:2733357888   ERROR: SetStreamDetailsForFileId (568) failed
09:35:31 T:2683886400   DEBUG: Thread Jobworker 2683886400 terminating (autodelete)
09:35:31 T:2692279104   DEBUG: Thread Jobworker 2692279104 terminating (autodelete)
09:35:32 T:2733357888   DEBUG: Thread Jobworker 2733357888 terminating (autodelete)
09:35:33 T:3008653120   DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/players/dvdplayer/avcodec-53-i486-linux.so)
09:35:33 T:3008653120   DEBUG: Unloading: avcodec-53-i486-linux.so
09:35:33 T:3008653120   DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/players/dvdplayer/avformat-53-i486-linux.so)
09:35:33 T:3008653120   DEBUG: Unloading: avformat-53-i486-linux.so
09:36:17 T:3008653120   DEBUG: CAnnouncementManager - Announcement: OnScreensaverActivated from xbmc
09:36:17 T:3008653120   DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverActivated
09:36:17 T:3008653120   DEBUG: ------ Window Init () ------
09:36:17 T:3008653120   DEBUG: Alloc resources: 0.01ms  (0.01 ms skin load)
09:36:35 T:3008653120  NOTICE: AFP is idle. Closing the remaining connections.
09:38:17 T:3008653120    INFO: DPMS: enabled power-saving mode SUSPEND
09:38:18 T:3008653120   DEBUG: ------ Window Deinit () ------
09:48:24 T:3008653120    INFO: DPMS: disabled power-saving
09:48:24 T:3008653120   DEBUG: CAnnouncementManager - Announcement: OnScreensaverDeactivated from xbmc
09:48:24 T:3008653120   DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverDeactivated
09:48:26 T:2973780800    INFO: CAESinkALSA::Initialize - Attempting to open device "@"
09:48:26 T:2973780800    INFO: CAESinkALSA::Initialize - Opened device "front"
09:48:26 T:3008653120   DEBUG: CGUIMediaWindow::GetDirectory (sources://video/)
09:48:26 T:3008653120   DEBUG:   ParentPath = []
09:48:26 T:2973780800    INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
09:48:26 T:2973780800    INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
09:48:26 T:2973780800   DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2048, bufferSize 8192
09:48:26 T:2973780800   DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2048, bufferSize 8192
09:48:26 T:2973780800   DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 186 ms
09:48:26 T:2973780800   DEBUG: Resumed the Sink
09:48:26 T:2733357888  NOTICE: Thread Jobworker start, auto delete: true
09:48:26 T:2692279104  NOTICE: Thread Background Loader start, auto delete: false
09:48:26 T:2692279104   DEBUG: Thread Background Loader 2692279104 terminating
09:48:27 T:3008653120   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
09:48:28 T:3008653120   DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
09:48:28 T:3008653120   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
09:48:28 T:3008653120   DEBUG: ------ Window Init (Home.xml) ------
09:48:28 T:3008653120   DEBUG: Window Home.xml was already loaded
09:48:28 T:3008653120   DEBUG: Alloc resources: 113.42m
09:48:33 T:3008653120   DEBUG: ExecuteXBMCAction : Translating ActivateWindow(Videos,MovieTitles,return)
09:48:33 T:3008653120   DEBUG: ExecuteXBMCAction : To ActivateWindow(Videos,MovieTitles,return)
09:48:33 T:3008653120   DEBUG: Activating window ID: 10025
09:48:33 T:3008653120   DEBUG: ------ Window Deinit (Home.xml) ------
09:48:33 T:3008653120   DEBUG: ExecuteXBMCAction : Translating SetProperty(VideosDirectLink,True)
09:48:33 T:3008653120   DEBUG: ExecuteXBMCAction : To SetProperty(VideosDirectLink,True)
09:48:33 T:3008653120   DEBUG: ------ Window Init (MyVideoNav.xml) ------
09:48:33 T:3008653120   DEBUG: Window MyVideoNav.xml was already loaded
09:48:33 T:3008653120   DEBUG: Alloc resources: 29.26m
09:48:33 T:3008653120   DEBUG: CGUIMediaWindow::GetDirectory (videodb://1/2/)
09:48:33 T:3008653120   DEBUG:   ParentPath = [videodb://1/2/]
09:48:33 T:3008653120   DEBUG: RunQuery took 212 ms for 535 items query: select * from movieview
09:48:33 T:2692279104  NOTICE: Thread Background Loader start, auto delete: false
09:48:33 T:2683886400  NOTICE: Thread Jobworker start, auto delete: true
09:48:33 T:2733357888   DEBUG: DoWork - trying to extract filestream details from video file afp://itunes:[email protected]/iTunes/iTunes Music/Movies/Alien 3.m4v
09:48:34 T:2692279104   DEBUG: Thread Background Loader 2692279104 terminating
09:48:34 T:2692279104  NOTICE: Thread Background Loader start, auto delete: false
09:48:34 T:2692279104   DEBUG: Thread Background Loader 2692279104 terminating
09:48:35 T:2692279104  NOTICE: Thread Jobworker start, auto delete: true
09:48:35 T:2733357888   DEBUG: AFP: Connected to server server.dnar.net using UAM "DHX2"
09:48:35 T:2733357888   DEBUG: AFP: Connected to volume iTunes
09:48:35 T:2733357888   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avcodec-53-i486-linux.so)
09:48:35 T:2733357888   DEBUG: Loading: /usr/xbmc/lib/xbmc/system/players/dvdplayer/avcodec-53-i486-linux.so
09:48:35 T:2683886400   DEBUG: DoWork - took 317 ms to load special://masterprofile/Thumbnails/a/a7b2d5b3.jpg
09:48:35 T:2692279104   DEBUG: DoWork - took 195 ms to load special://masterprofile/Thumbnails/d/dd4bc42e.jpg
09:48:35 T:2733357888   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avformat-53-i486-linux.so)
09:48:35 T:2733357888   DEBUG: Loading: /usr/xbmc/lib/xbmc/system/players/dvdplayer/avformat-53-i486-linux.so
09:48:57 T:3008653120   DEBUG: OnPlayMedia afp://itunes:[email protected]/iTunes/iTunes Music/Movies/Bambi II.m4v
09:48:57 T:3008653120   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
09:48:57 T:3008653120   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
09:48:57 T:3008653120   DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc
09:48:57 T:3008653120   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd
09:48:57 T:2716326720   DEBUG: Open - avformat_find_stream_info starting
09:48:57 T:3008653120   DEBUG: CPlayerCoreFactory::GetPlayers(afp://itunes:[email protected]/iTunes/iTunes Music/Movies/Bambi II.m4v)
09:48:57 T:3008653120   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
09:48:57 T:3008653120   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
09:48:57 T:3008653120   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
09:48:57 T:3008653120   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
09:48:57 T:3008653120   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
09:48:57 T:3008653120   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
09:48:57 T:3008653120   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
09:48:57 T:3008653120   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
09:48:57 T:3008653120   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
09:48:57 T:3008653120   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
09:48:57 T:3008653120   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
09:48:57 T:3008653120   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
09:48:57 T:3008653120   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
09:48:57 T:3008653120   DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
09:48:57 T:3008653120   DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
09:48:57 T:3008653120   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
09:48:57 T:3008653120   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
09:48:57 T:3008653120   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
09:48:57 T:3008653120   DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
09:48:57 T:3008653120  NOTICE: DVDPlayer: Opening: afp://itunes:[email protected]/iTunes/iTunes Music/Movies/Bambi II.m4v
09:48:57 T:3008653120 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
09:48:57 T:3008653120   DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
09:48:57 T:3008653120   DEBUG: LinuxRendererGL: Cleaning up GL resources
09:48:57 T:3008653120   DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16
09:48:57 T:2778229568  NOTICE: Thread CDVDPlayer start, auto delete: false
09:48:57 T:2778229568  NOTICE: Creating InputStream
09:48:57 T:2778229568   DEBUG: CAFPFile::Open - opened iTunes/iTunes Music/Movies/Bambi II.m4v, fd=0
09:48:57 T:3008653120   DEBUG: ------ Window Init (DialogBusy.xml) ------
09:48:57 T:3008653120   DEBUG: Window DialogBusy.xml was already loaded
09:48:57 T:3008653120   DEBUG: Alloc resources: 0.06m
09:48:57 T:2716326720   DEBUG: ffmpeg[A1E7DB40]: [mov,mp4,m4a,3gp,3g2,mj2] max_analyze_duration 5000000 reached at 5024000
09:48:57 T:2716326720   DEBUG: ffmpeg[A1E7DB40]: [mov,mp4,m4a,3gp,3g2,mj2] decoding for stream 0 failed
09:48:57 T:2716326720   DEBUG: ffmpeg[A1E7DB40]: [mov,mp4,m4a,3gp,3g2,mj2] Could not find codec parameters (Video: h264 (avc1 / 0x31637661), 2420 kb/s)
09:48:57 T:2716326720   DEBUG: ffmpeg[A1E7DB40]: [mov,mp4,m4a,3gp,3g2,mj2] decoding for stream 3 failed
09:48:57 T:2716326720   DEBUG: Open - av_find_stream_info finished
09:49:05 T:2778229568   DEBUG: CrystalHD(new API): device opened
09:49:05 T:2778229568   DEBUG: CrystalHD: profile 42c01e
09:49:05 T:2778229568   DEBUG: CrystalHD: nal size 4
09:49:05 T:2778229568   DEBUG: CrystalHD: num sps 1
09:49:05 T:2778229568   DEBUG: CrystalHD: data size at end = 0
09:49:06 T:2778229568    INFO: DVDVideoCodecCrystalHD: Opened Broadcom Crystal HD Codec
09:49:06 T:2778229568   DEBUG: FactoryCodec - Video: chd-h264 - Opened
09:49:06 T:2778229568   ERROR: CDVDPlayerVideo::OpenStream - Invalid framerate 48000, using forced 25fps and just trust timestamps
09:49:06 T:2778229568  NOTICE: Creating video thread
09:49:06 T:2656123712  NOTICE: Thread CDVDPlayerVideo start, auto delete: false
09:49:06 T:2656123712  NOTICE: running thread: video_thread
09:49:06 T:2778229568  NOTICE: Opening audio stream: 2 source: 256
09:49:06 T:2778229568  NOTICE: Finding audio codec for: 86019
09:49:06 T:2778229568   DEBUG: FactoryCodec - Audio: FFmpeg - Opening
09:49:06 T:2778229568   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/swresample-0-i486-linux.so)
09:49:06 T:2778229568   DEBUG: Loading: /usr/xbmc/lib/xbmc/system/players/dvdplayer/swresample-0-i486-linux.so
09:49:06 T:2656123712   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
09:49:06 T:2664516416  NOTICE: Thread CMPCOutputThread start, auto delete: false
09:49:06 T:2664516416   DEBUG: CrystalHD: Output Thread Started...
09:49:06 T:2778229568   DEBUG: FactoryCodec - Audio: FFmpeg - Opened
09:49:06 T:2778229568  NOTICE: Creating audio thread
09:49:06 T:2644040512  NOTICE: Thread CDVDPlayerAudio start, auto delete: false
09:49:06 T:2778229568  NOTICE: Opening Subtitle stream: 3 source: 256
09:49:06 T:2778229568   DEBUG: FactoryCodec - Overlay: TX3G Subtitle Decoder - Opening
09:49:06 T:2778229568   DEBUG: FactoryCodec - Overlay: TX3G Subtitle Decoder - Opened
09:49:06 T:2778229568   DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: afp://itunes:[email protected]/iTunes/iTunes Music/Movies/Bambi II.m4v
09:49:06 T:2644040512  NOTICE: running thread: CDVDPlayerAudio::Process()
09:49:06 T:2692279104   DEBUG: Open - avformat_find_stream_info starting
09:49:06 T:2778229568    INFO: CAFPFile::Open: Unable to open file : '/iTunes Music/Movies/Bambi II.Vprj'
                                            unix_err:'2' error : 'No such file or directory'
09:49:06 T:2778229568   DEBUG: CAFPFile::Close closing fd 0
09:49:06 T:2778229568   ERROR: ReadVideoReDo - Could not open VideoReDo file: afp://itunes:[email protected]/iTunes/iTunes Music/Movies/Bambi II.Vprj
09:49:06 T:2778229568    INFO: CAFPFile::Open: Unable to open file : '/iTunes Music/Movies/Bambi II.edl'
                                            unix_err:'2' error : 'No such file or directory'
09:49:06 T:2778229568   DEBUG: CAFPFile::Close closing fd 0
09:49:06 T:2778229568   ERROR: ReadEdl - Could not open EDL file: afp://itunes:[email protected]/iTunes/iTunes Music/Movies/Bambi II.edl
09:49:06 T:2778229568    INFO: CAFPFile::Open: Unable to open file : '/iTunes Music/Movies/Bambi II.txt'
                                            unix_err:'2' error : 'No such file or directory'
09:49:06 T:2778229568   DEBUG: CAFPFile::Close closing fd 0
09:49:06 T:2778229568   ERROR: ReadComskip - Could not open Comskip file: afp://itunes:[email protected]/iTunes/iTunes Music/Movies/Bambi II.txt
09:49:06 T:2778229568    INFO: CAFPFile::Open: Unable to open file : '/iTunes Music/Movies/Bambi II.m4v.chapters.xml'
                                            unix_err:'2' error : 'No such file or directory'
09:49:06 T:2778229568   DEBUG: CAFPFile::Close closing fd 0
09:49:06 T:2778229568   ERROR: ReadBeyondTV - Could not load Beyond TV file: afp://itunes:[email protected]/iTunes/iTunes Music/Movies/Bambi II.m4v.chapters.xml. Failed to open file
09:49:06 T:2778229568   DEBUG: CDVDPlayer::SetCaching - caching state 3
09:49:06 T:2644040512  NOTICE: Creating audio stream (codec id: 86019, channels: 6, sample rate: 48000, no pass-through)
09:49:06 T:2644040512    INFO: CSoftAE::MakeStream - AE_FMT_S16NE, 48000, FL,FR,FC,LFE,SL,SR
09:49:06 T:2973780800   DEBUG: CSoftAE::Run - Sink restart flagged
09:49:06 T:2973780800    INFO: CSoftAE::LoadSettings - Stereo upmix is enabled
09:49:06 T:2973780800    INFO: CSoftAE::InternalOpenSink - sink incompatible, re-starting
09:49:06 T:2656123712    INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
09:49:06 T:2656123712   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(33354.166667, 0)
09:49:06 T:2778229568   DEBUG: CDVDPlayer::SetCaching - caching state 0
09:49:06 T:2664516416   DEBUG: CrystalHD: Format Change Detected. Flags: 0x00030000
09:49:06 T:2664516416   DEBUG: ----------------------------------
09:49:06 T:2664516416   DEBUG:     TimeStamp: 0
09:49:06 T:2664516416   DEBUG:     Picture Number: 0
09:49:06 T:2664516416   DEBUG:     Width: 720
09:49:06 T:2664516416   DEBUG:     Height: 480
09:49:06 T:2664516416   DEBUG:     Chroma: 0x001
09:49:06 T:2664516416   DEBUG:     Pulldown: 9
09:49:06 T:2664516416   DEBUG:     Flags: 0x00000000
09:49:06 T:2664516416   DEBUG:     Frame Rate/Res: 0
09:49:06 T:2664516416   DEBUG:     Aspect Ratio: 255
09:49:06 T:2664516416   DEBUG:     Color Primaries: 101056768
09:49:06 T:2664516416   DEBUG:     MetaData: 0
09:49:06 T:2664516416   DEBUG:     Session Number: 0
09:49:06 T:2664516416   DEBUG:     TimeStamp: 0
09:49:06 T:2664516416   DEBUG:     Custom Aspect: 0
09:49:06 T:2664516416   DEBUG:     Frames to Drop: 0
09:49:06 T:2664516416   DEBUG:     H264 Valid Fields: 0x00000000
09:49:06 T:2664516416   DEBUG: CrystalHD: dec_par x = 1, dec_par y = 1
09:49:06 T:2664516416   DEBUG: CrystalHD: resolution = 0  interlace = 0
09:49:06 T:2664516416   DEBUG: CrystalHD: No timestamp detected: 0
09:49:06 T:2664516416   DEBUG: CrystalHD: Added a new Buffer, ReadyListCount: 0
09:49:06 T:2656123712  NOTICE:  fps: 25.000000, pwidth: 720, pheight: 480, dwidth: -2147483648, dheight: 480
09:49:06 T:2656123712   DEBUG: OutputPicture - change configuration. 720x480. framerate: 25.00. format: YUY2
09:49:06 T:2664516416   DEBUG: CrystalHD: Added a new Buffer, ReadyListCount: 0
09:49:06 T:2664516416   DEBUG: CrystalHD: Added a new Buffer, ReadyListCount: 1
09:49:06 T:2664516416   DEBUG: CrystalHD: Added a new Buffer, ReadyListCount: 2
09:49:06 T:3008653120   DEBUG: CGUIInfoManager::SetCurrentMovie(afp://itunes:[email protected]/iTunes/iTunes Music/Movies/Bambi II.m4v)
09:49:06 T:2692279104   DEBUG: ffmpeg[A078EB40]: [mov,mp4,m4a,3gp,3g2,mj2] max_analyze_duration 5000000 reached at 5024000
09:49:06 T:2692279104   DEBUG: ffmpeg[A078EB40]: [mov,mp4,m4a,3gp,3g2,mj2] decoding for stream 0 failed
09:49:06 T:2692279104   DEBUG: ffmpeg[A078EB40]: [mov,mp4,m4a,3gp,3g2,mj2] Could not find codec parameters (Video: h264 (avc1 / 0x31637661), 3099 kb/s)
09:49:06 T:2692279104   DEBUG: ffmpeg[A078EB40]: [mov,mp4,m4a,3gp,3g2,mj2] decoding for stream 3 failed
09:49:06 T:2692279104   DEBUG: Open - av_find_stream_info finished
09:49:06 T:2664516416   DEBUG: CrystalHD: Added a new Buffer, ReadyListCount: 7
09:49:06 T:2664516416   DEBUG: CrystalHD: Added a new Buffer, ReadyListCount: 8
09:49:06 T:3008653120   DEBUG: GetMovieId (afp://itunes:[email protected]/iTunes/iTunes Music/Movies/Bambi II.m4v), query = select idMovie from movie where idFile=568
09:49:06 T:2664516416   DEBUG: CrystalHD: Added a new Buffer, ReadyListCount: 9
09:49:06 T:2692279104   DEBUG: CAFPFile::Close closing fd 0
09:49:06 T:2664516416   DEBUG: CrystalHD: Added a new Buffer, ReadyListCount: 10
09:49:06 T:2664516416   DEBUG: CrystalHD: Added a new Buffer, ReadyListCount: 11
09:49:07 T:2692279104   ERROR: SQL: SQL error or missing database
                                            Query: INSERT INTO streamdetails (idFile, iStreamType, strVideoCodec, fVideoAspect, iVideoWidth, iVideoHeight, iVideoDuration) VALUES (1037,0,'avc1',NaN,0,0,9757)
09:49:07 T:2656123712 WARNING: CRenderManager::Configure - timeout waiting for previous frame
09:49:07 T:2656123712  NOTICE: Display resolution DESKTOP : 1280x720 @ 60.00 - Full Screen (16)
09:49:07 T:2692279104   ERROR: SetStreamDetailsForFileId (1037) failed
09:49:07 T:2973780800    INFO: CAESinkALSA::Initialize - Attempting to open device "@"
09:49:07 T:2973780800    INFO: CAESinkALSA::Initialize - Opened device "sysdefault"
09:49:07 T:2973780800    INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
09:49:07 T:2973780800    INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
09:49:07 T:2973780800   DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 1024, bufferSize 8192
09:49:07 T:2973780800   DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 1024, bufferSize 8192
09:49:07 T:2973780800   DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 171 ms
09:49:07 T:2973780800   DEBUG: CSoftAE::InternalOpenSink - ALSA Initialized:
09:49:07 T:2973780800   DEBUG:   Output Device : Default (HDA Intel ALC889A Analog)
09:49:07 T:2973780800   DEBUG:   Sample Rate   : 48000
09:49:07 T:2973780800   DEBUG:   Sample Format : AE_FMT_S32NE
09:49:07 T:2973780800   DEBUG:   Channel Count : 2
09:49:07 T:2973780800   DEBUG:   Channel Layout: FL,FR
09:49:07 T:2973780800   DEBUG:   Frames        : 1024
09:49:07 T:2973780800   DEBUG:   Frame Samples : 2048
09:49:07 T:2973780800   DEBUG:   Frame Size    : 8
09:49:07 T:2973780800   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
09:49:07 T:2973780800   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 8192
09:49:07 T:2973780800   DEBUG: AERemap: Downmix normalization is disabled
09:49:07 T:3008653120   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
09:49:07 T:3008653120   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
09:49:07 T:3008653120   DEBUG: Activating window ID: 12005
09:49:07 T:3008653120   DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
09:49:07 T:3008653120   DEBUG: ------ Window Init (VideoFullScreen.xml) ------
09:49:07 T:2778229568   DEBUG: CDVDPlayer::HandleMessages - player started 2
09:49:07 T:3008653120   DEBUG: Window VideoFullScreen.xml was already loaded
09:49:07 T:3008653120   DEBUG: Alloc resources: 40.74m
09:49:07 T:2664516416   DEBUG: CrystalHD: Added a new Buffer, ReadyListCount: 12
09:49:07 T:2973780800   DEBUG: AERemap: Downmix normalization is disabled
09:49:07 T:2973780800   DEBUG: Previous line repeats 2 times.
09:49:07 T:2973780800   DEBUG: CSoftAEStream::CSoftAEStream - Converting from AE_FMT_S16NE to AE_FMT_FLOAT
09:49:07 T:2644040512   DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback
09:49:07 T:2644040512   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(32000.000000, 1)
09:49:07 T:2644040512   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:661.269999, should be:667.696000, error:6.426001
09:49:07 T:2778229568   DEBUG: CDVDPlayer::HandleMessages - player started 1
09:49:07 T:2973780800   DEBUG: CSoftAE::Run - Sink restart flagged
09:49:07 T:2973780800    INFO: CSoftAE::LoadSettings - Stereo upmix is enabled
09:49:07 T:2973780800    INFO: CSoftAE::InternalOpenSink - keeping old sink with : AE_FMT_FLOAT, FL,FR, 48000hz
09:49:07 T:2973780800   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
09:49:07 T:2973780800   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 8192
09:49:07 T:3008653120  NOTICE: Using GL_TEXTURE_2D
09:49:07 T:3008653120   DEBUG: GL: Requested render method: 0
09:49:07 T:3008653120   DEBUG: GL: BaseYUV2RGBGLSLShader: defines:
                                            #define XBMC_texture_rectangle 0
                                            #define XBMC_texture_rectangle_hack 0
                                            #define XBMC_STRETCH 0
                                            #define XBMC_YUY2
09:49:07 T:3008653120  NOTICE: GL: Selecting Single Pass YUV 2 RGB shader
09:49:07 T:3008653120   DEBUG: GL: Vertex Shader compilation log:
09:49:07 T:3008653120   DEBUG: GL: Vertex Shader compiled successfully
09:49:07 T:3008653120   DEBUG: GL: Pixel Shader compilation log:
09:49:07 T:3008653120   DEBUG: GL: Fragment Shader compiled successfully
09:49:07 T:3008653120  NOTICE: GL: NPOT texture support detected
09:49:07 T:3008653120  NOTICE: GL: Using GL_ARB_pixel_buffer_object
09:49:07 T:3008653120   DEBUG: ------ Window Deinit (DialogBusy.xml) ------
09:49:07 T:2644040512   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:526653.523000, should be:384000.000000, error:-142653.523000
09:49:09 T:2644040512   DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:2388943.617000, should be:2338178.944952, error:-50764.672048
09:49:25 T:2656123712   DEBUG: CPullupCorrection: detected pattern of length 2: 33369.33 50047.33, frameduration: 41708.333333
09:49:25 T:2656123712   DEBUG: CPullupCorrection: pattern lost on diff 33380.000000
09:49:30 T:2656123712   DEBUG: CPullupCorrection: detected pattern of length 2: 33365.33 50051.33, frameduration: 41708.333333
09:49:32 T:2656123712   DEBUG: CPullupCorrection: pattern lost on diff 33400.000000
09:49:37 T:2683886400   DEBUG: Thread Jobworker 2683886400 terminating (autodelete)
09:49:37 T:2733357888   DEBUG: Thread Jobworker 2733357888 terminating (autodelete)
09:49:37 T:2716326720   DEBUG: Thread Jobworker 2716326720 terminating (autodelete)
09:49:37 T:2692279104   DEBUG: Thread Jobworker 2692279104 terminating (autodelete)
09:49:37 T:2656123712   DEBUG: CPullupCorrection: detected pattern of length 2: 33356.67 50060.00, frameduration: 41708.333333
09:49:58 T:2877279040  NOTICE: ES: Client  from 127.0.0.1 timed out
09:50:03 T:3008653120  NOTICE: CDVDPlayer::CloseFile()
09:50:03 T:3008653120  NOTICE: DVDPlayer: waiting for threads to exit
09:50:03 T:2778229568  NOTICE: CDVDPlayer::OnExit()
09:50:03 T:2778229568  NOTICE: DVDPlayer: closing audio stream
09:50:03 T:2778229568  NOTICE: Closing audio stream
09:50:03 T:2778229568  NOTICE: Waiting for audio thread to exit
09:50:03 T:2644040512  NOTICE: thread end: CDVDPlayerAudio::OnExit()
09:50:03 T:2644040512   DEBUG: Thread CDVDPlayerAudio 2644040512 terminating
09:50:03 T:2778229568  NOTICE: Closing audio device
09:50:03 T:2778229568   DEBUG: CSoftAEStream::~CSoftAEStream - Destructed
09:50:03 T:2778229568  NOTICE: Deleting audio codec
09:50:03 T:2778229568  NOTICE: DVDPlayer: closing video stream
09:50:03 T:2778229568  NOTICE: Closing video stream
09:50:03 T:2778229568  NOTICE: waiting for video thread to exit
09:50:03 T:2973780800   DEBUG: CSoftAE::Run - Sink restart flagged
09:50:03 T:2973780800    INFO: CSoftAE::LoadSettings - Stereo upmix is enabled
09:50:03 T:2973780800    INFO: CSoftAE::InternalOpenSink - sink incompatible, re-starting
09:50:03 T:2656123712  NOTICE: thread end: video_thread
09:50:03 T:2656123712   DEBUG: Thread CDVDPlayerVideo 2656123712 terminating
09:50:03 T:2778229568  NOTICE: deleting video codec
09:50:03 T:2664516416   DEBUG: CrystalHD: Output Thread Stopped...
09:50:03 T:2664516416   DEBUG: Thread CMPCOutputThread 2664516416 terminating
09:50:03 T:2973780800    INFO: CAESinkALSA::Initialize - Attempting to open device "@"
09:50:03 T:2973780800    INFO: CAESinkALSA::Initialize - Opened device "front"
09:50:03 T:2973780800    INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
09:50:03 T:2973780800    INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
09:50:03 T:2973780800   DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2048, bufferSize 8192
09:50:03 T:2973780800   DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2048, bufferSize 8192
09:50:03 T:2973780800   DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 186 ms
09:50:03 T:2973780800   DEBUG: CSoftAE::InternalOpenSink - ALSA Initialized:
09:50:03 T:2973780800   DEBUG:   Output Device : Default (HDA Intel ALC889A Analog)
09:50:03 T:2973780800   DEBUG:   Sample Rate   : 44100
09:50:03 T:2973780800   DEBUG:   Sample Format : AE_FMT_S32NE
09:50:03 T:2973780800   DEBUG:   Channel Count : 2
09:50:03 T:2973780800   DEBUG:   Channel Layout: FL,FR
09:50:03 T:2973780800   DEBUG:   Frames        : 2048
09:50:03 T:2973780800   DEBUG:   Frame Samples : 4096
09:50:03 T:2973780800   DEBUG:   Frame Size    : 8
09:50:03 T:2973780800   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
09:50:03 T:2973780800   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 16384
09:50:03 T:2778229568   DEBUG: CrystalHD: device closed
09:50:03 T:2778229568  NOTICE: DVDPlayer: closing subtitle stream
09:50:03 T:2778229568  NOTICE: Closing subtitle stream
09:50:03 T:2778229568  NOTICE: CDVDPlayer::OnExit() deleting demuxer
09:50:03 T:2778229568  NOTICE: CDVDPlayer::OnExit() deleting input stream
09:50:03 T:2778229568   DEBUG: CAFPFile::Close closing fd 0
09:50:03 T:2778229568   DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
09:50:03 T:2778229568   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
09:50:03 T:3008653120  NOTICE: DVDPlayer: finished waiting
09:50:03 T:3008653120   DEBUG: LinuxRendererGL: Cleaning up GL resources
09:50:03 T:3008653120   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
09:50:03 T:3008653120   DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------
09:50:03 T:2778229568   DEBUG: Thread CDVDPlayer 2778229568 terminating
09:50:03 T:2973780800   DEBUG: AERemap: Downmix normalization is disabled
09:50:03 T:3008653120   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
09:50:03 T:3008653120   DEBUG: ------ Window Init (MyVideoNav.xml) ------
09:50:03 T:2973780800   DEBUG: AERemap: Downmix normalization is disabled
09:50:03 T:3008653120   DEBUG: Previous line repeats 1 times.
09:50:03 T:3008653120   DEBUG: Window MyVideoNav.xml was already loaded
09:50:03 T:3008653120   DEBUG: Alloc resources: 88.81m
09:50:03 T:3008653120   DEBUG: CGUIMediaWindow::GetDirectory (videodb://1/2/)
09:50:03 T:3008653120   DEBUG:   ParentPath = [videodb://1/2/]
09:50:03 T:3008653120   DEBUG: RunQuery took 183 ms for 535 items query: select * from movieview
09:50:04 T:2778229568  NOTICE: Thread Background Loader start, auto delete: false
09:50:04 T:2778229568   DEBUG: Thread Background Loader 2778229568 terminating
09:50:05 T:2778229568  NOTICE: Thread Background Loader start, auto delete: false
09:50:05 T:2778229568   DEBUG: Thread Background Loader 2778229568 terminating
09:50:05 T:3008653120  NOTICE: CDVDPlayer::CloseFile()
09:50:05 T:3008653120 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
09:50:05 T:3008653120  NOTICE: DVDPlayer: waiting for threads to exit
09:50:05 T:3008653120  NOTICE: DVDPlayer: finished waiting
09:50:05 T:3008653120   DEBUG: LinuxRendererGL: Cleaning up GL resources
09:50:05 T:3008653120   DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/ImageLib-i486-linux.so)
09:50:05 T:3008653120   DEBUG: Unloading: ImageLib-i486-linux.so
09:50:05 T:2778229568  NOTICE: Thread Jobworker start, auto delete: true

Thanks

Dnar
Find
Reply
Ned Scott
Banned
Posts: 31,445
#4
2013-05-18, 20:35
Can you upload a full debug log to http://xbmclogs.com ?

Also can you run MediaInfo (wiki) on the file? If the video was encoded with something like Handbrake, then the encoding settings will be exposed in the MediaInfo readout, and that might provide some hints as well.
Find
Reply
dnar
Newbie
Posts: 4
#5
2013-05-18, 20:50
Ned,

Here is the info for Bambi II from Media-info
Code:
File: /Volumes/iTunes/iTunes Music/Movies/Bambi II.m4v
Size: 921.9 MB
Format: QuickTime/MPEG-4/Motion JPEG 2000 format
Chapters count: 18
Stream count: 4
Duration: 01:12:25
Bit rate: 1779 kb/s
Meta info:
    description: Join Bambi as he reunites with his father, The Great Prince, who must now raise the young fawn and teach him the ways of the forest.  But, in the adventure of a lifetime, the proud parent discovers that there is much that he can learn from his spirited you
    synopsis: Picking up shortly after the original movie's end, Bambi follows his father, the Great Prince, into the forest after his mother's death and the Great Prince must teach the young fawn, and his friends Thumper, Flower and Owl, how a deer survives in the forest. But the Great Prince finds that his high-spirited son may have a lesson or two to teach him, as well.
    media_type: 0
    minor_version: 0
    encoder: HandBrake svn1554M 2008070301
    title: Bambi II
    major_brand: mp42
    date: 2006-09-26T02:00:00Z
    compatible_brands: mp42isom
    artist: Patrick Stewart, Cree Summer, Keith Ferguson, Brian Pimental, Andrea Bowen
    creation_time: 2008-07-11 21:21:14
    genre: Kids & Family

Stream 0
Type: video
Codec: h264
Codec profile: Constrained Baseline
FourCC: avc1
Duration: 01:12:21
Width: 720
Height: 480
Sample aspect ratio: 853:720
Display aspect ratio: 853:480
Pixel format: yuv420p
Frame rate: 23.98 fps
Bit rate: 1169 kb/s
Meta info:
    creation_time: 2008-07-11 21:21:14
    language: eng

Stream 1
Type: audio
Codec: aac
FourCC: mp4a
Duration: 01:12:24
Bit rate: 159 kb/s
Sample rate: 48000 Hz
Sample format: s16
Channel: 2
Meta info:
    creation_time: 2008-07-11 21:21:14
    language: eng

Stream 2
Type: audio
Codec: ac3
FourCC: ac-3
Duration: 01:12:25
Bit rate: 448 kb/s
Sample rate: 48000 Hz
Sample format: s16
Channel: 6
Meta info:
    creation_time: 2008-07-11 21:21:14
    language: eng

Stream 3
Type: subtitle
Codec: Unknown codec
Meta info:
    creation_time: 2008-07-11 21:21:14
    language: eng

I'll look up the upload instructions and try to get the entire log file uploaded this afternoon.

Dnar
Find
Reply
dnar
Newbie
Posts: 4
#6
2013-05-18, 21:22
Complete debug log posted from 09:34:58 until 09:50:05

http://xbmclogs.com/show.php?id=20166

Dnar
Find
Reply

Home
Search
Help
Logout Mark Read Team Forum Stats Members Help
Black video on some media0