Bug Stop Start Stop Start
#1
Hi Guys,

I am very new to RPI and after searching the internet I can find no other references to this issue so I'm hoping you can help. I have installed on a Raspberry PI (Model B+) the following build of CarPC .. http://engineering-diy.blogspot.co.uk/20...-2014.html

Everything works except in XBMC i'm finding that playing any type of media, it pauses and then plays then pauses and then plays again - all on its own! - every two seconds. Please see log below.

Code:
18:11:30 T:3044163584   DEBUG: ProcessMouse: trying mouse action leftclick
18:11:30 T:3044163584   DEBUG: Adding file /home/pi/Music/Batman.mp3 to music playlist
18:11:30 T:3044163584   DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc
18:11:30 T:3044163584   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd
18:11:30 T:3044163584   DEBUG: CPlayerCoreFactory::GetPlayers(/home/pi/Music/Batman.mp3)
18:11:30 T:3044163584   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
18:11:30 T:3044163584   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
18:11:30 T:3044163584   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
18:11:30 T:3044163584   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
18:11:30 T:3044163584   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
18:11:30 T:3044163584   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
18:11:30 T:3044163584   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
18:11:30 T:3044163584   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
18:11:30 T:3044163584   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
18:11:30 T:3044163584   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
18:11:30 T:3044163584   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
18:11:30 T:3044163584   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
18:11:30 T:3044163584   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
18:11:30 T:3044163584   DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
18:11:30 T:3044163584   DEBUG: CPlayerCoreFactory::GetPlayers: adding audiodefaultplayer (3)
18:11:30 T:3044163584   DEBUG: CPlayerCoreFactory::GetPlayers: for video=0, audio=1
18:11:30 T:3044163584   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: PAPlayer (3)
18:11:30 T:3044163584   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
18:11:30 T:3044163584   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
18:11:30 T:3044163584   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: OMXPlayer (4)
18:11:30 T:3044163584   DEBUG: CPlayerCoreFactory::GetPlayers: added 3 players
18:11:30 T:3044163584   DEBUG: CFileCache::Open - opening </home/pi/Music/Batman.mp3> using cache
18:11:30 T:2858415168  NOTICE: Thread FileCache start, auto delete: false
18:11:30 T:2858415168    INFO: CFileCache::Process - Hit eof.
18:11:30 T:3044163584    INFO: AudioDecoder: File is queued
18:11:30 T:3044163584   DEBUG: AudioDecoder::GetReplayGain - Final Replaygain applied: 1.000000, Track/Album Gain 89.000000, Peak 0.000000
18:11:30 T:3042620480   DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
18:11:30 T:3044163584    INFO: PAPlayer::PrepareStream - Ready
18:11:30 T:3044163584   DEBUG: PlayFile : OpenFile succeed, play state 1
18:11:30 T:2936009792  NOTICE: Thread PAPlayer start, auto delete: false
18:11:30 T:2936009792   DEBUG: PAPlayer::Process - Playback started
18:11:30 T:3034231872    INFO: CActiveAESink::OpenSink - initialize sink
18:11:30 T:3034231872   DEBUG: CActiveAESink::OpenSink - trying to open device PI:Analogue
18:11:30 T:2936009792   DEBUG: OnPlayBackStarted : play state was 1, starting 0
18:11:30 T:3034231872   DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008
18:11:30 T:3034231872   DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:35280 bytes/s=352800.00
18:11:30 T:3034231872   DEBUG: CAESinkPi:Initialize
18:11:30 T:3034231872   DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0xaad5a5b0
18:11:30 T:3034231872   DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17640), nBufferAlignmen(16)
18:11:30 T:3034231872   DEBUG: CActiveAESink::OpenSink - SinkPi Initialized:
18:11:30 T:3034231872   DEBUG:   Output Device : Analogue
18:11:30 T:3034231872   DEBUG:   Sample Rate   : 44100
18:11:30 T:3034231872   DEBUG:   Sample Format : AE_FMT_FLOAT
18:11:30 T:3034231872   DEBUG:   Channel Count : 2
18:11:30 T:3034231872   DEBUG:   Channel Layout: FL,FR
18:11:30 T:3034231872   DEBUG:   Frames        : 4410
18:11:30 T:3034231872   DEBUG:   Frame Samples : 8820
18:11:30 T:3034231872   DEBUG:   Frame Size    : 8
18:11:30 T:3044163584   DEBUG: CGUIInfoManager::SetCurrentSong(/home/pi/Music/Batman.mp3)
18:11:30 T:3044163584   DEBUG: Loading additional tag info for file /home/pi/Music/Batman.mp3
18:11:31 T:3044163584   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
18:11:31 T:3044163584   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
18:11:31 T:3044163584   DEBUG: CAnnouncementManager - Announcement: OnPause from xbmc
18:11:31 T:3044163584   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPause
18:11:32 T:3044163584   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
18:11:32 T:3044163584   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
18:11:34 T:3044163584   DEBUG: CAnnouncementManager - Announcement: OnPause from xbmc
18:11:34 T:3044163584   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPause
18:11:36 T:3044163584   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
18:11:36 T:3044163584   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
18:11:38 T:3044163584   DEBUG: CAnnouncementManager - Announcement: OnPause from xbmc
18:11:38 T:3044163584   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPause
18:11:40 T:3044163584   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
18:11:40 T:3044163584   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
18:11:41 T:3044163584   DEBUG: ------ Window Deinit (Pointer.xml) ------
18:11:42 T:3044163584   DEBUG: CAnnouncementManager - Announcement: OnPause from xbmc
18:11:42 T:3044163584   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPause
18:11:44 T:3044163584   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
18:11:44 T:3044163584   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
18:11:46 T:3044163584    INFO: input device was unplugged HID 1241:1177
18:11:46 T:3044163584   DEBUG: CAnnouncementManager - Announcement: OnPause from xbmc
18:11:46 T:3044163584   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPause
18:11:48 T:3044163584   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
18:11:48 T:3044163584   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
18:11:50 T:3044163584   DEBUG: CAnnouncementManager - Announcement: OnPause from xbmc
18:11:50 T:3044163584   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPause
18:11:51 T:3044163584   DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/ImageLib-arm.so)
18:11:51 T:3044163584   DEBUG: Unloading: ImageLib-arm.so
18:11:52 T:3044163584   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
18:11:52 T:3044163584   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
18:11:54 T:3044163584    INFO: Found input device /dev/input/event0
18:11:54 T:3044163584    INFO: opened device 'HID 1241:1177' (file name /dev/input/event0), m_bSkipNonKeyEvents 0
18:11:54 T:3044163584 WARNING: no keymap support (requires /dev/tty0 - CONFIG_VT)
18:11:54 T:3044163584   DEBUG: CAnnouncementManager - Announcement: OnPause from xbmc
18:11:54 T:3044163584   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPause
18:11:56 T:3044163584   DEBUG: ------ Window Init (Pointer.xml) ------
18:11:56 T:3044163584   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
18:11:56 T:3044163584   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
18:11:57 T:2900358208   DEBUG: Thread JobWorker 2900358208 terminating (autodelete)
18:11:58 T:3044163584   DEBUG: CAnnouncementManager - Announcement: OnPause from xbmc
18:11:58 T:3044163584   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPause
18:11:59 T:3044163584   DEBUG: ProcessMouse: trying mouse action leftclick
18:11:59 T:3042620480   DEBUG: CActiveAE::DiscardStream - audio stream deleted
18:11:59 T:3042620480   DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
18:11:59 T:2858415168   DEBUG: Previous line repeats 3 times.
18:11:59 T:2858415168   DEBUG: Thread FileCache 2858415168 terminating
18:11:59 T:2936009792   DEBUG: OnPlayBackStopped : play state was 2, starting 0
18:11:59 T:2936009792   DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
18:11:59 T:2936009792   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
18:11:59 T:2936009792   DEBUG: Thread PAPlayer 2936009792 terminating
18:11:59 T:2936009792  NOTICE: Thread JobWorker start, auto delete: true
18:11:59 T:2936009792   DEBUG: DoWork - Saving file state for audio item /home/pi/Music/Batman.mp3
18:12:06 T:3044163584   DEBUG: ProcessMouse: trying mouse action leftclick
18:12:06 T:3044163584   DEBUG: Activating window ID: 10000
18:12:06 T:3044163584   DEBUG: ------ Window Deinit (MyMusicSongs.xml) ------
18:12:06 T:3044163584   DEBUG: ------ Window Init (Home.xml) ------
18:12:06 T:2858415168  NOTICE: Thread LanguageInvoker start, auto delete: false
18:12:06 T:2858415168    INFO: initializing python engine.
18:12:06 T:2858415168   DEBUG: CPythonInvoker(6, special://skin/scripts/check_calibration.py): start processing
18:12:06 T:3044163584   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib-arm.so)
18:12:06 T:3044163584   DEBUG: Loading: /usr/local/lib/xbmc/system/ImageLib-arm.so
18:12:07 T:2858415168  NOTICE: -->Python Interpreter Initialized<--
18:12:07 T:2858415168   DEBUG: CPythonInvoker(6, special://skin/scripts/check_calibration.py): the source file to load is "special://skin/scripts/check_calibration.py" ("/home/pi/.xbmc/addons/skin.CarPC-touch/scripts/check_calibration.py")
18:12:07 T:2858415168   DEBUG: CPythonInvoker(6, special://skin/scripts/check_calibration.py): setting the Python path to /home/pi/.xbmc/addons/skin.CarPC-touch/scripts:/home/pi/.xbmc/addons/script.module.simplejson/lib:/usr/local/share/xbmc/addons/script.module.pil/lib:/home/pi/.xbmc/addons/script.common.plugin.cache/lib:/home/pi/.xbmc/addons/script.module.simple.downloader/lib:/usr/local/share/xbmc/addons/xbmc.debug/:/home/pi/.xbmc/addons/script.module.parsedom/lib:/home/pi/.xbmc/addons/script.module.xbmcswift2/lib:/home/pi/.xbmc/addons/script.module.feedparser/lib:/usr/local/share/xbmc/addons/script.module.pysqlite/lib:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/gtk-2.0:/usr/lib/pymodules/python2.7
18:12:07 T:2858415168   DEBUG: CPythonInvoker(6, special://skin/scripts/check_calibration.py): entering source directory /home/pi/.xbmc/addons/skin.CarPC-touch/scripts
18:12:07 T:2858415168    INFO: CPythonInvoker(6, special://skin/scripts/check_calibration.py): script successfully run
18:12:07 T:2858415168    INFO: Python script stopped
18:12:07 T:2858415168   DEBUG: Thread LanguageInvoker 2858415168 terminating
18:12:12 T:3044163584   DEBUG: ------ Window Deinit (Pointer.xml) ------
18:12:29 T:2936009792   DEBUG: Thread JobWorker 2936009792 terminating (autodelete)
18:12:37 T:3044163584   DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/ImageLib-arm.so)
18:12:37 T:3044163584   DEBUG: Unloading: ImageLib-arm.so
18:15:30 T:3044163584   DEBUG: ------ Window Init (Pointer.xml) ------

This is happening without me pressing any buttons, the file type, music, video, if the media is on a USB stick - makes no difference and I have no idea how to stop it happening. It only happens in XBMC because if I play it using omxplayer from a terminal window, it plays perfectly.

It's these lines in the log that worry me ...

Code:
18:11:54 T:3044163584   DEBUG: CAnnouncementManager - Announcement: OnPause from xbmc
18:11:54 T:3044163584   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPause
18:11:56 T:3044163584   DEBUG: ------ Window Init (Pointer.xml) ------
18:11:56 T:3044163584   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
18:11:56 T:3044163584   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay

Any help will be greatly appreciated.

Many thanks,

Shane
Reply
#2
Any hint of where to even start looking? It's like your constantly pressing the PLAY/PAUSE button over and over again.

It does this with any skin, any file type, in both videos and music and any player (DVDPlayer, OMSPlayer & PAPlayer).

Help! Anyone?
Reply
#3
No worries .. I found the solution,

Anyone having the same issue and your using CarPC and you don't have the two rotary controller plugged in yet, you have to comment 4 lines of code in:

/home/pi/config/gpio_description.

Shane
Reply

Logout Mark Read Team Forum Stats Members Help
Stop Start Stop Start0