LE 9 on RasPi 2/3 - player crashes

adam.h. · February 3, 2019 at 11:48 AM

Freshly installed and tested on Raspberry 2 and 3 - player is not starting (log attached), the same avi works fine on Intel.

Is there any other log or settings which I can check?

adam.h. · February 3, 2019 at 12:32 PM

Some more debug info:

Code

12:22:52.911 T:1937097376   DEBUG: CPlayerCoreFactory::GetPlayers(/var/media/sda1-usb-Generic_Flash_Di/Aterrados.avi)
12:22:52.911 T:1937097376   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
12:22:52.911 T:1937097376   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
12:22:52.911 T:1937097376   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp
12:22:52.911 T:1937097376   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
12:22:52.911 T:1937097376   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
12:22:52.911 T:1937097376   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
12:22:52.911 T:1937097376   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
12:22:52.912 T:1937097376   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
12:22:52.912 T:1937097376   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
12:22:52.912 T:1937097376   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
12:22:52.912 T:1937097376   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
12:22:52.912 T:1937097376   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
12:22:52.912 T:1937097376   DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
12:22:52.912 T:1937097376   DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer)
12:22:52.912 T:1937097376   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
12:22:52.912 T:1937097376   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
12:22:52.912 T:1937097376   DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
12:22:52.917 T:1937097376   DEBUG: CMMALPool::CMMALPool Created pool 0x26830f0 of size 26 x 0 for port vc.ril.video_decode:out:0(I420)
12:22:52.926 T:1937097376   DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData
12:22:52.926 T:1937097376  NOTICE: VideoPlayer::OpenFile: /var/media/sda1-usb-Generic_Flash_Di/Aterrados.avi
12:22:52.927 T:1937097376   DEBUG: CMMALRenderer::CMMALRenderer
12:22:52.927 T:1937097376   DEBUG: OnPlayBackStarted: CApplication::OnPlayBackStarted
12:22:52.927 T:1673438064   DEBUG: Thread VideoPlayer start, auto delete: false
12:22:52.927 T:1807721328   DEBUG: Thread MMALProcess start, auto delete: false
12:22:52.927 T:1807721328   DEBUG: CMMALRenderer::Run - starting
12:22:52.929 T:1673438064  NOTICE: Creating InputStream
12:22:52.932 T:1673438064   DEBUG: ScanForExternalSubtitles: Searching for subtitles...
12:22:52.933 T:1673438064   DEBUG: ScanForExternalSubtitles: END (total time: 1 ms)
12:22:52.933 T:1673438064  NOTICE: Creating Demuxer
12:22:52.939 T:1673438064   DEBUG: ffmpeg[63BEA370]: Probing mp3 score:1 size:2048
12:22:52.941 T:1673438064   DEBUG: ffmpeg[63BEA370]: Probing mp3 score:1 size:4096
12:22:52.944 T:1799328624   DEBUG: Loading settings for /var/media/sda1-usb-Generic_Flash_Di/Aterrados.avi
12:22:52.944 T:1673438064   DEBUG: ffmpeg[63BEA370]: Probing mp3 score:1 size:8192
12:22:52.946 T:1937097376   DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x263fba0
12:22:52.948 T:1937097376   DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignment(16)
12:22:52.950 T:1673438064   DEBUG: ffmpeg[63BEA370]: Probing mp3 score:1 size:16384
12:22:52.953 T:1937097376   DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x263f7b0
12:22:52.954 T:1937097376   DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignment(16)
12:22:52.976 T:1937097376   DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x263fba0
12:22:52.978 T:1937097376   DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x263f7b0
12:22:52.983 T:1937097376   DEBUG: DecodeJpegToTexture: decoded special://skin/backgrounds/media-overlay.jpg 1280x720
12:22:53.013 T:1937097376   DEBUG: CVideoGUIInfo::InitCurrentItem(/var/media/sda1-usb-Generic_Flash_Di/Aterrados.avi)
12:22:53.081 T:1937097376   DEBUG: CPlayerGUIInfo::InitCurrentItem(/var/media/sda1-usb-Generic_Flash_Di/Aterrados.avi)
12:22:53.081 T:1937093488   DEBUG: CAnnouncementManager - Announcement: OnChanged from xbmc
12:22:53.081 T:1937093488   DEBUG: GOT ANNOUNCEMENT, type: 1024, from xbmc, message OnChanged
12:22:53.097 T:1937093488   DEBUG: GetMovieId (/var/media/sda1-usb-Generic_Flash_Di/Aterrados.avi), query = select idMovie from movie where idFile=1
12:22:53.098 T:1937093488   DEBUG: GetEpisodeId (/var/media/sda1-usb-Generic_Flash_Di/Aterrados.avi), query = select idEpisode from episode where idFile=1
12:22:53.100 T:1937093488   DEBUG: GetMusicVideoId (/var/media/sda1-usb-Generic_Flash_Di/Aterrados.avi), query = select idMVideo from musicvideo where idFile=1
12:22:53.105 T:1937093488   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
12:22:53.105 T:1937093488   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
12:22:53.181 T:1937097376   DEBUG: ------ Window Init (DialogBusy.xml) ------
12:22:53.493 T:1723794288   DEBUG: CecLogMessage - << Recorder 1 (1) -> TV (0): POLL
12:22:53.494 T:1723794288   DEBUG: CecLogMessage - << 10
12:22:53.674 T:1723794288   DEBUG: Previous line repeats 1 times.
12:22:53.674 T:1723794288   DEBUG: CecLogMessage - >> POLL not sent
12:22:53.753 T:1673438064   DEBUG: ffmpeg[63BEA370]: Format avi detected only with low score of 1, misdetection possible!
12:22:53.753 T:1673438064   DEBUG: Open - probing detected format [avi]
12:22:53.754 T:1673438064   ERROR: Open - Error, could not open file /var/media/sda1-usb-Generic_Flash_Di/Aterrados.avi
12:22:53.754 T:1673438064   ERROR: OpenDemuxStream - Error creating demuxer
12:22:53.754 T:1673438064  NOTICE: CVideoPlayer::OnExit()
12:22:53.755 T:1673438064   DEBUG: Thread VideoPlayer 1673438064 terminating
12:22:53.770 T:1799328624    INFO: Deleting settings information for files /var/media/sda1-usb-Generic_Flash_Di/Aterrados.avi
12:22:53.772 T:1673438064   DEBUG: Thread JobWorker start, auto delete: true
12:22:53.772 T:1799328624   DEBUG: DoWork - Saving file state for video item /var/media/sda1-usb-Generic_Flash_Di/Aterrados.avi
12:22:53.817 T:1799328624   DEBUG: OnPlayBackStopped: CApplication::OnPlayBackStopped
12:22:53.833 T:1937093488   DEBUG: GetMovieId (/var/media/sda1-usb-Generic_Flash_Di/Aterrados.avi), query = select idMovie from movie where idFile=1
12:22:53.834 T:1937093488   DEBUG: GetEpisodeId (/var/media/sda1-usb-Generic_Flash_Di/Aterrados.avi), query = select idEpisode from episode where idFile=1
12:22:53.835 T:1937093488   DEBUG: GetMusicVideoId (/var/media/sda1-usb-Generic_Flash_Di/Aterrados.avi), query = select idMVideo from musicvideo where idFile=1
12:22:53.839 T:1937097376  NOTICE: CVideoPlayer::CloseFile()
12:22:53.839 T:1937097376  NOTICE: VideoPlayer: waiting for threads to exit
12:22:53.839 T:1937093488   DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
12:22:53.839 T:1937097376  NOTICE: VideoPlayer: finished waiting
12:22:53.839 T:1937093488   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
12:22:53.840 T:1937097376   DEBUG: DeleteRenderer - deleting renderer
12:22:53.840 T:1937097376   DEBUG: CMMALRenderer::~CMMALRenderer
12:22:53.840 T:1937097376   DEBUG: CMMALRenderer::DestroyDeinterlace
12:22:53.840 T:1937097376   DEBUG: CMMALRenderer::UnInitMMAL
12:22:53.840 T:1807721328   DEBUG: CMMALRenderer::Run - stopping
12:22:53.840 T:1807721328   DEBUG: Thread MMALProcess 1807721328 terminating
12:22:53.844 T:1937097376   DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData
12:22:53.845 T:1937097376   DEBUG: CMMALPool::~CMMALPool Destroying pool 0x26830f0 for port vc.ril.video_decode:out:0(I420)
12:22:53.864 T:1937097376   DEBUG: ------ Window Deinit (DialogBusy.xml) -----

Display More

**vpeter** · February 3, 2019 at 1:28 PM

Enable Debug log in Kodi to see more.

adam.h. · February 3, 2019 at 1:54 PM

Quote from vpeter

Enable Debug log in Kodi to see more.

See above, are there any "more" debug settings?

**Klojum** · February 3, 2019 at 2:02 PM Official Post

Quote from adam.h.

Some more debug info:

Please use a pastebin website for large(r) text chunks. Logs are not that well displayed on our forum, and they also clogs up our forum server.

Also, provide the FULL uncut kodi.log with debugging enabled from the beginning. (Restart LibreELEC/Kodi for that).

adam.h. · February 3, 2019 at 6:29 PM

all logs: http://s000.tinyupload.com/?file_id=10904465663391830654

adam.h. · February 3, 2019 at 6:57 PM

This issue might be however related not to the file itself, but the usb stick - this avi file worked fine when I powered finally the SDD disc (see the other topic). But again, the same stick worked ok on LE 9 on Intel, while failed on RPI, pretty confusing...