2013-05-11, 11:58
@Raphael78. Got exactly the same problem. Won't play anything with cover art and music is garbled as per your clip.
(2013-05-10, 13:28)Johnkg Wrote:(2013-05-10, 01:46)Raphael78 Wrote: @Johnkg : Do you know where I could find older version of OE, or Raspbmc, or Xbian ? Oldest I can find for OE is the r12577 from november 2012, for Raspbmc and Xbian I can't find any older versions.
Afraid not. Not so long ago pichimney went back months and months, but it looks like they are now only showing the last 60 or so builds.
@Popcornmix: I will give rbej's version a go... Can I extract SYSTEM, KERNEL, the firmware files and update my current OE build via SSH, or do I need to build a fresh SD?
(2013-05-11, 01:38)Raphael78 Wrote: Tried both Rbej's Frodo 12.2 Final & Gotham Branch versions (fresh sd card install), and this is what happened (with both) :
- Impossible to play any song which has a cover info in it : xbmc just freezes, and considering the amount of errors lines named image_decode timeout, I suppose it crashes trying to decode the image.
- No cover info in files, but AAC/FLAC album : sound is chopped at something like 10Hz, as if the decoder wasn't fast enough (link for audio : http://we.tl/KbcA5YD9Mf )Code:23:25:47 T:3041042960 DEBUG: CPlayerCoreFactory::GetPlayers(/var/media/Media/Music/Aaron Parks/James Farm/01-joshua_redman-coax.mp3)
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
23:25:47 T:3041042960 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
23:25:47 T:3041042960 DEBUG: SECTION:LoadDLL(libmad.so.0)
23:25:47 T:3041042960 DEBUG: Loading: libmad.so.0
23:25:47 T:3041042960 DEBUG: CPlayerCoreFactory::GetPlayers: adding audiodefaultplayer (4)
23:25:47 T:3041042960 DEBUG: CPlayerCoreFactory::GetPlayers: for video=0, audio=1
23:25:47 T:3041042960 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: PAPlayer (3)
23:25:47 T:3041042960 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
23:25:47 T:3041042960 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
23:25:47 T:3041042960 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: OMXPlayer (4)
23:25:47 T:3041042960 DEBUG: CPlayerCoreFactory::GetPlayers: added 3 players
23:25:47 T:3041042960 NOTICE: COMXPlayer: Opening: /var/media/Media/Music/Aaron Parks/James Farm/01-joshua_redman-coax.mp3
23:25:47 T:3041042960 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.clock handle 0x2e15958 dllopen : 1
23:25:47 T:3041042960 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.clock input port 80 output port 81
23:25:47 T:3041042960 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
23:25:47 T:3041042960 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
23:25:47 T:3041042960 DEBUG: LinuxRendererGL: Cleaning up GL resources
23:25:47 T:3041042960 DEBUG: DllSwScale: Using libswscale system library
23:25:47 T:2888139872 NOTICE: Thread OMXPlayer start, auto delete: false
23:25:47 T:2888139872 NOTICE: Creating InputStream
23:25:47 T:2888139872 NOTICE: Creating Demuxer
23:25:47 T:2888139872 DEBUG: DllAvUtilBase: Using libavutil system library
23:25:47 T:2888139872 DEBUG: DllAvCodec: Using libavcodec system library
23:25:47 T:2888139872 DEBUG: DllAvFormat: Using libavformat system library
23:25:47 T:2888139872 DEBUG: Open - probing detected format [mp3]
23:25:47 T:2888139872 DEBUG: Open - avformat_find_stream_info starting
23:25:48 T:2888139872 DEBUG: ffmpeg[AC258460]: [mp3] max_analyze_duration 5000000 reached at 5015510 microseconds
23:25:48 T:2888139872 DEBUG: Open - av_find_stream_info finished
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: Input #0, mp3, from '/var/media/Media/Music/Aaron Parks/James Farm/01-joshua_redman-coax.mp3':
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: Metadata:
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: title : Coax
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: track : 1/10
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: encoder : Lame3.98
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: genre : Jazz
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: encoded_by : Lame
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: artist : Aaron Parks
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: album : James Farm
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: date : 2011
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: Duration: 00:07:10.71, start: 0.000000, bitrate: 236 kb/s
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: Stream #0:0: Audio: mp3, 44100 Hz, stereo, s16p, 235 kb/s
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: Stream #0:1: Video: mjpeg, yuvj420p, 499x443 [SAR 72:72 DAR 499:443], 90k tbr, 90k tbn, 90k tbc
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: Metadata:
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: title :
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: comment : Cover (front)
23:25:48 T:2888139872 NOTICE: Opening video stream: 1 source: 256
23:25:48 T:2888139872 DEBUG: DllBcm: Using omx system library
23:25:48 T:2888139872 INFO: OMXPlayerVideo::OpenDecoder : Invalid framerate 90000, using forced 25fps and just trust timestamps
23:25:48 T:2888139872 DEBUG: OMXClock::OMXStop
23:25:48 T:2888139872 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.video_decode handle 0x32d5b60 dllopen : 1
23:25:48 T:2888139872 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.video_decode input port 130 output port 131
23:25:48 T:2994730080 DEBUG: CecLogMessage - GetPhysicalAddress - physical address = 1200
23:25:48 T:2994730080 DEBUG: CecLogMessage - physical address changed to 1200
23:25:48 T:2994730080 DEBUG: CecLogMessage - physical address unchanged (1200)
23:25:48 T:2888139872 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.video_render handle 0x3967ec8 dllopen : 1
23:25:48 T:2888139872 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.video_render input port 90 output port 90
23:25:48 T:2888139872 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.video_scheduler handle 0x3564b68 dllopen : 1
23:25:48 T:2888139872 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.video_scheduler input port 10 output port 11
23:25:48 T:2888139872 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.video_decode) - port(130), nBufferCountMin(1), nBufferCountActual(60), nBufferSize(81920), nBufferAlignmen(16)
23:25:48 T:2888139872 DEBUG: COMXVideo::Open - decoder_component(0x0x32d5b60), input_port(0x82), output_port(0x83) deinterlace 0 hdmiclocksync 0
23:25:48 T:2888139872 INFO: OMXPlayerVideo::OpenDecoder : Video codec omx-mjpeg width 499 height 443 profile -99 fps 25.000000
23:25:48 T:2888139872 INFO: OMXPlayerVideo::OpenDecoder fps: 25.000000 hdmi_ntsc_freqs 0
23:25:48 T:2888139872 NOTICE: OMXClock using video as reference
23:25:48 T:2888139872 DEBUG: OMXClock::OMXReset audio / video : 0 / 1 start audio / video : 0 / 1 wait mask 2
23:25:48 T:2888139872 NOTICE: Creating video thread
23:25:48 T:2888139872 DEBUG: OMXClock::OMXSetSpeed 1 buffering 0
23:25:48 T:2866578528 NOTICE: Thread OMXPlayerVideo start, auto delete: false
23:25:48 T:2888139872 NOTICE: Opening audio stream: 0 source: 256
23:25:48 T:2888139872 DEBUG: DllBcm: Using omx system library
23:25:48 T:2888139872 DEBUG: DllAvUtilBase: Using libavutil system library
23:25:48 T:2888139872 DEBUG: DllAvCodec: Using libavcodec system library
23:25:48 T:2888139872 DEBUG: DllAvFormat: Using libswresample system library
23:25:48 T:2888139872 NOTICE: Creating audio thread
23:25:48 T:2888139872 DEBUG: OMXClock::OMXSetSpeed 1 buffering 0
23:25:48 T:2834297952 NOTICE: Thread OMXPlayerAudio start, auto delete: false
23:25:48 T:2866578528 DEBUG: COMXPlayerVideo - CDVDMsg::PLAYER_STARTED 0
23:25:48 T:2866578528 DEBUG: COMXPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
23:25:48 T:2834297952 DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_STARTED 0
23:25:48 T:2888139872 DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: /var/media/Media/Music/Aaron Parks/James Farm/01-joshua_redman-coax.mp3
23:25:48 T:2888139872 DEBUG: COMXPlayer::SetCaching - caching state 3
23:25:48 T:2888139872 DEBUG: OMXClock::OMXSetSpeed 0 buffering 0
23:25:48 T:2834297952 DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_SETSPEED 0
23:25:48 T:2834297952 DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_STARTED 0
23:25:48 T:2866578528 DEBUG: COMXPlayerVideo - CDVDMsg::PLAYER_SETSPEED 0
23:25:48 T:2866578528 DEBUG: COMXPlayerVideo - CDVDMsg::PLAYER_STARTED 0
23:25:48 T:2866578528 INFO: COMXPlayerVideo - Stillframe left, switching to normal playback
23:25:48 T:2866578528 DEBUG: OMXVideo::Decode VDec : setStartTime 0.000000
23:25:48 T:2834297952 DEBUG: COMXAudioCodecOMX::Decode(0x3980960,104) format=6(8) chan=2 samples=1152 size=4608/9216,2304/4608,2304 data=0x34d4820,0x34d5120,(nil),(nil),(nil),(nil),(nil),(nil)
23:25:48 T:2866578528 ERROR: Output - renderer not started
23:25:48 T:2888139872 DEBUG: COMXPlayer::HandleMessages - player started 2
23:25:48 T:2834297952 DEBUG: COMXAudioCodecOMX::GetData size=0/9216/9216 cont=1 buf=0x3f08370
23:25:48 T:2834297952 DEBUG: OMXClock::OMXStop
23:25:48 T:3041042960 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.image_decode handle 0x39437e8 dllopen : 1
23:25:48 T:2834297952 DEBUG: DllAvUtilBase: Using libavutil system library
23:25:48 T:2834297952 DEBUG: COMXAudio::SetCodingType OMX_AUDIO_CodingPCM
23:25:48 T:3041042960 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321
23:25:48 T:3041042960 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.resize handle 0x39f7560 dllopen : 1
23:25:48 T:2834297952 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.audio_render handle 0x353a4f8 dllopen : 1
23:25:48 T:3041042960 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61
23:25:48 T:2834297952 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100
23:25:48 T:3041042960 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(3), nBufferSize(81920), nBufferAlignmen(16)
23:25:48 T:2834297952 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.audio_decode handle 0x34aaf78 dllopen : 1
23:25:48 T:2834297952 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_decode input port 120 output port 121
23:25:48 T:2834297952 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.audio_mixer handle 0x3979050 dllopen : 1
23:25:48 T:2834297952 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_mixer input port 232 output port 231
23:25:48 T:2834297952 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_decode) - port(120), nBufferCountMin(4), nBufferCountActual(43), nBufferSize(16384), nBufferAlignmen(16)
23:25:48 T:2834297952 DEBUG: COMXAudio::Initialize Ouput bps 16 samplerate 44100 channels 2 buffer size 705600 bytes per second 352800
23:25:48 T:2834297952 DEBUG: COMXAudio::Initialize Input bps 32 samplerate 44100 channels 2 buffer size 705600 bytes per second 352800
23:25:48 T:2834297952 DEBUG: COMXAudio::Initialize device hdmi passthrough 0 hwdecode 0
23:25:48 T:2834297952 INFO: Audio codec channels 2 samplerate 44100 bitspersample 16
23:25:48 T:2834297952 NOTICE: OMXClock using audio as reference
23:25:48 T:2834297952 DEBUG: OMXClock::OMXReset audio / video : 1 / 1 start audio / video : 1 / 1 wait mask 3
23:25:48 T:2834297952 DEBUG: COMXAudio::Decode ADec : setStartTime 0.000000
23:25:48 T:2834297952 DEBUG: pcm->direction : input
23:25:48 T:2834297952 DEBUG: pcm->nPortIndex : 232
23:25:48 T:2834297952 DEBUG: pcm->eNumData : 0
23:25:48 T:2834297952 DEBUG: pcm->eEndian : 1
23:25:48 T:2834297952 DEBUG: pcm->bInterleaved : 1
23:25:48 T:2834297952 DEBUG: pcm->nBitPerSample : 16
23:25:48 T:2834297952 DEBUG: pcm->ePCMMode : 0
23:25:48 T:2834297952 DEBUG: pcm->nChannels : 2
23:25:48 T:2834297952 DEBUG: pcm->nSamplingRate : 44100
23:25:48 T:2834297952 DEBUG: OMX_AUDIO_ChannelLF
23:25:48 T:2834297952 DEBUG: OMX_AUDIO_ChannelRF
23:25:48 T:2834297952 DEBUG: pcm->direction : output
23:25:48 T:2834297952 DEBUG: pcm->nPortIndex : 100
23:25:48 T:2834297952 DEBUG: pcm->eNumData : 0
23:25:48 T:2834297952 DEBUG: pcm->eEndian : 1
23:25:48 T:2834297952 DEBUG: pcm->bInterleaved : 1
23:25:48 T:2834297952 DEBUG: pcm->nBitPerSample : 16
23:25:48 T:2834297952 DEBUG: pcm->ePCMMode : 0
23:25:48 T:2834297952 DEBUG: pcm->nChannels : 2
23:25:48 T:2834297952 DEBUG: pcm->nSamplingRate : 44100
23:25:48 T:2834297952 DEBUG: OMX_AUDIO_ChannelLF
23:25:48 T:2834297952 DEBUG: OMX_AUDIO_ChannelRF
23:25:48 T:2888139872 DEBUG: COMXPlayer::HandleMessages - player started 1
23:25:48 T:2888139872 DEBUG: COMXPlayer::SetCaching - caching state 0
23:25:48 T:2888139872 DEBUG: OMXClock::OMXSetSpeed 1 buffering 0
23:25:48 T:2834297952 DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_SETSPEED 1000
23:25:48 T:2834297952 DEBUG: COMXPlayerAudio - CDVDMsg::GENERAL_RESYNC(26122.448980, 1)
23:25:48 T:2866578528 DEBUG: COMXPlayerVideo - CDVDMsg::PLAYER_SETSPEED 1000
23:25:48 T:2834297952 DEBUG: OMXClock::OMXAudioBufferStart
23:25:48 T:2888139872 DEBUG: COMXPlayer::SetCaching - caching state 1
23:25:48 T:2888139872 DEBUG: OMXClock::OMXSetSpeed 0 buffering 0
23:25:48 T:2866578528 DEBUG: COMXPlayerVideo - CDVDMsg::PLAYER_SETSPEED 0
23:25:48 T:2866578528 DEBUG: COMXPlayerVideo - CDVDMsg::PLAYER_STARTED 1
23:25:48 T:2888139872 DEBUG: COMXPlayer::HandleMessages - player started 2
23:25:48 T:2834297952 DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_SETSPEED 0
23:25:48 T:2834297952 DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_STARTED 1
23:25:48 T:2888139872 DEBUG: COMXPlayer::HandleMessages - player started 1
23:25:48 T:2888139872 DEBUG: COMXPlayer::SetCaching - caching state 0
23:25:48 T:2888139872 DEBUG: OMXClock::OMXSetSpeed 1 buffering 0
23:25:48 T:2834297952 DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_SETSPEED 1000
23:25:48 T:2834297952 DEBUG: OMXClock::OMXAudioBufferStart
23:25:48 T:2866578528 DEBUG: COMXPlayerVideo - CDVDMsg::PLAYER_SETSPEED 1000
23:25:48 T:2834297952 INFO: COMXPlayerAudio - Switching to normal playback
23:25:48 T:2834297952 DEBUG: OMXClock::OMXAudioBufferStop
23:25:48 T:2834297952 DEBUG: OMXClock::OMXSetSpeed 1 buffering 0
23:25:48 T:2959819872 DEBUG: CecLogMessage - key auto-released: select (0)
23:25:48 T:2959819872 DEBUG: PushCecKeypress - received key b duration 1070
23:25:49 T:3041042960 ERROR: COMXCoreComponent::WaitForEvent OMX.broadcom.image_decode wait event 0x00000003 timeout 1000
23:25:49 T:3041042960 ERROR: COMXImage::Decode HandlePortSettingChange() failed
23:25:51 T:3041042960 ERROR: COMXCoreComponent::WaitForCommand OMX.broadcom.image_decode wait timeout event.eEvent 0x00000000 event.command 0x00000002 event.nData2 320
23:25:53 T:3041042960 ERROR: COMXCoreComponent::WaitForCommand OMX.broadcom.image_decode wait timeout event.eEvent 0x00000000 event.command 0x00000001 event.nData2 320
23:25:55 T:3041042960 ERROR: COMXCoreComponent::WaitForCommand OMX.broadcom.image_decode wait timeout event.eEvent 0x00000000 event.command 0x00000001 event.nData2 321
23:25:55 T:3041042960 ERROR: COMXCoreComponent::SetStateForComponent - OMX.broadcom.image_decode failed with omx_err(0x80001000)
23:25:55 T:3041042960 ERROR: Previous line repeats 2 times.
23:25:55 T:3041042960 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x39f7560 dllopen : 1
23:25:57 T:3041042960 ERROR: COMXCoreComponent::WaitForCommand OMX.broadcom.image_decode wait timeout event.eEvent 0x00000000 event.command 0x00000001 event.nData2 320
23:25:59 T:3041042960 ERROR: COMXCoreComponent::WaitForCommand OMX.broadcom.image_decode wait timeout event.eEvent 0x00000000 event.command 0x00000001 event.nData2 321
23:25:59 T:3041042960 ERROR: COMXCoreComponent::SetStateForComponent - OMX.broadcom.image_decode failed with omx_err(0x80001000)
23:25:59 T:3041042960 ERROR: Previous line repeats 2 times.
23:25:59 T:3041042960 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x39437e8 dllopen : 1
23:26:15 T:2921694304 DEBUG: Thread JobWorker 2921694304 terminating (autodelete)
- When I was able to find an album without cover info, and in mp3 format : heard 3 glitches in half an hour.
(2013-05-11, 01:38)Raphael78 Wrote: Tried both Rbej's Frodo 12.2 Final & Gotham Branch versions (fresh sd card install), and this is what happened (with both) :
- Impossible to play any song which has a cover info in it : xbmc just freezes, and considering the amount of errors lines named image_decode timeout, I suppose it crashes trying to decode the image.
(2013-05-11, 13:50)rbej Wrote:(2013-05-11, 01:38)Raphael78 Wrote: Tried both Rbej's Frodo 12.2 Final & Gotham Branch versions (fresh sd card install), and this is what happened (with both) :
- Impossible to play any song which has a cover info in it : xbmc just freezes, and considering the amount of errors lines named image_decode timeout, I suppose it crashes trying to decode the image.
- No cover info in files, but AAC/FLAC album : sound is chopped at something like 10Hz, as if the decoder wasn't fast enough (link for audio : http://we.tl/KbcA5YD9Mf )Code:23:25:47 T:3041042960 DEBUG: CPlayerCoreFactory::GetPlayers(/var/media/Media/Music/Aaron Parks/James Farm/01-joshua_redman-coax.mp3)
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
23:25:47 T:3041042960 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
23:25:47 T:3041042960 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
23:25:47 T:3041042960 DEBUG: SECTION:LoadDLL(libmad.so.0)
23:25:47 T:3041042960 DEBUG: Loading: libmad.so.0
23:25:47 T:3041042960 DEBUG: CPlayerCoreFactory::GetPlayers: adding audiodefaultplayer (4)
23:25:47 T:3041042960 DEBUG: CPlayerCoreFactory::GetPlayers: for video=0, audio=1
23:25:47 T:3041042960 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: PAPlayer (3)
23:25:47 T:3041042960 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
23:25:47 T:3041042960 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
23:25:47 T:3041042960 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: OMXPlayer (4)
23:25:47 T:3041042960 DEBUG: CPlayerCoreFactory::GetPlayers: added 3 players
23:25:47 T:3041042960 NOTICE: COMXPlayer: Opening: /var/media/Media/Music/Aaron Parks/James Farm/01-joshua_redman-coax.mp3
23:25:47 T:3041042960 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.clock handle 0x2e15958 dllopen : 1
23:25:47 T:3041042960 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.clock input port 80 output port 81
23:25:47 T:3041042960 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
23:25:47 T:3041042960 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
23:25:47 T:3041042960 DEBUG: LinuxRendererGL: Cleaning up GL resources
23:25:47 T:3041042960 DEBUG: DllSwScale: Using libswscale system library
23:25:47 T:2888139872 NOTICE: Thread OMXPlayer start, auto delete: false
23:25:47 T:2888139872 NOTICE: Creating InputStream
23:25:47 T:2888139872 NOTICE: Creating Demuxer
23:25:47 T:2888139872 DEBUG: DllAvUtilBase: Using libavutil system library
23:25:47 T:2888139872 DEBUG: DllAvCodec: Using libavcodec system library
23:25:47 T:2888139872 DEBUG: DllAvFormat: Using libavformat system library
23:25:47 T:2888139872 DEBUG: Open - probing detected format [mp3]
23:25:47 T:2888139872 DEBUG: Open - avformat_find_stream_info starting
23:25:48 T:2888139872 DEBUG: ffmpeg[AC258460]: [mp3] max_analyze_duration 5000000 reached at 5015510 microseconds
23:25:48 T:2888139872 DEBUG: Open - av_find_stream_info finished
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: Input #0, mp3, from '/var/media/Media/Music/Aaron Parks/James Farm/01-joshua_redman-coax.mp3':
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: Metadata:
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: title : Coax
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: track : 1/10
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: encoder : Lame3.98
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: genre : Jazz
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: encoded_by : Lame
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: artist : Aaron Parks
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: album : James Farm
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: date : 2011
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: Duration: 00:07:10.71, start: 0.000000, bitrate: 236 kb/s
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: Stream #0:0: Audio: mp3, 44100 Hz, stereo, s16p, 235 kb/s
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: Stream #0:1: Video: mjpeg, yuvj420p, 499x443 [SAR 72:72 DAR 499:443], 90k tbr, 90k tbn, 90k tbc
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: Metadata:
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: title :
23:25:48 T:2888139872 INFO: ffmpeg[AC258460]: comment : Cover (front)
23:25:48 T:2888139872 NOTICE: Opening video stream: 1 source: 256
23:25:48 T:2888139872 DEBUG: DllBcm: Using omx system library
23:25:48 T:2888139872 INFO: OMXPlayerVideo::OpenDecoder : Invalid framerate 90000, using forced 25fps and just trust timestamps
23:25:48 T:2888139872 DEBUG: OMXClock::OMXStop
23:25:48 T:2888139872 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.video_decode handle 0x32d5b60 dllopen : 1
23:25:48 T:2888139872 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.video_decode input port 130 output port 131
23:25:48 T:2994730080 DEBUG: CecLogMessage - GetPhysicalAddress - physical address = 1200
23:25:48 T:2994730080 DEBUG: CecLogMessage - physical address changed to 1200
23:25:48 T:2994730080 DEBUG: CecLogMessage - physical address unchanged (1200)
23:25:48 T:2888139872 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.video_render handle 0x3967ec8 dllopen : 1
23:25:48 T:2888139872 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.video_render input port 90 output port 90
23:25:48 T:2888139872 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.video_scheduler handle 0x3564b68 dllopen : 1
23:25:48 T:2888139872 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.video_scheduler input port 10 output port 11
23:25:48 T:2888139872 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.video_decode) - port(130), nBufferCountMin(1), nBufferCountActual(60), nBufferSize(81920), nBufferAlignmen(16)
23:25:48 T:2888139872 DEBUG: COMXVideo::Open - decoder_component(0x0x32d5b60), input_port(0x82), output_port(0x83) deinterlace 0 hdmiclocksync 0
23:25:48 T:2888139872 INFO: OMXPlayerVideo::OpenDecoder : Video codec omx-mjpeg width 499 height 443 profile -99 fps 25.000000
23:25:48 T:2888139872 INFO: OMXPlayerVideo::OpenDecoder fps: 25.000000 hdmi_ntsc_freqs 0
23:25:48 T:2888139872 NOTICE: OMXClock using video as reference
23:25:48 T:2888139872 DEBUG: OMXClock::OMXReset audio / video : 0 / 1 start audio / video : 0 / 1 wait mask 2
23:25:48 T:2888139872 NOTICE: Creating video thread
23:25:48 T:2888139872 DEBUG: OMXClock::OMXSetSpeed 1 buffering 0
23:25:48 T:2866578528 NOTICE: Thread OMXPlayerVideo start, auto delete: false
23:25:48 T:2888139872 NOTICE: Opening audio stream: 0 source: 256
23:25:48 T:2888139872 DEBUG: DllBcm: Using omx system library
23:25:48 T:2888139872 DEBUG: DllAvUtilBase: Using libavutil system library
23:25:48 T:2888139872 DEBUG: DllAvCodec: Using libavcodec system library
23:25:48 T:2888139872 DEBUG: DllAvFormat: Using libswresample system library
23:25:48 T:2888139872 NOTICE: Creating audio thread
23:25:48 T:2888139872 DEBUG: OMXClock::OMXSetSpeed 1 buffering 0
23:25:48 T:2834297952 NOTICE: Thread OMXPlayerAudio start, auto delete: false
23:25:48 T:2866578528 DEBUG: COMXPlayerVideo - CDVDMsg::PLAYER_STARTED 0
23:25:48 T:2866578528 DEBUG: COMXPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
23:25:48 T:2834297952 DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_STARTED 0
23:25:48 T:2888139872 DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: /var/media/Media/Music/Aaron Parks/James Farm/01-joshua_redman-coax.mp3
23:25:48 T:2888139872 DEBUG: COMXPlayer::SetCaching - caching state 3
23:25:48 T:2888139872 DEBUG: OMXClock::OMXSetSpeed 0 buffering 0
23:25:48 T:2834297952 DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_SETSPEED 0
23:25:48 T:2834297952 DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_STARTED 0
23:25:48 T:2866578528 DEBUG: COMXPlayerVideo - CDVDMsg::PLAYER_SETSPEED 0
23:25:48 T:2866578528 DEBUG: COMXPlayerVideo - CDVDMsg::PLAYER_STARTED 0
23:25:48 T:2866578528 INFO: COMXPlayerVideo - Stillframe left, switching to normal playback
23:25:48 T:2866578528 DEBUG: OMXVideo::Decode VDec : setStartTime 0.000000
23:25:48 T:2834297952 DEBUG: COMXAudioCodecOMX::Decode(0x3980960,104) format=6(8) chan=2 samples=1152 size=4608/9216,2304/4608,2304 data=0x34d4820,0x34d5120,(nil),(nil),(nil),(nil),(nil),(nil)
23:25:48 T:2866578528 ERROR: Output - renderer not started
23:25:48 T:2888139872 DEBUG: COMXPlayer::HandleMessages - player started 2
23:25:48 T:2834297952 DEBUG: COMXAudioCodecOMX::GetData size=0/9216/9216 cont=1 buf=0x3f08370
23:25:48 T:2834297952 DEBUG: OMXClock::OMXStop
23:25:48 T:3041042960 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.image_decode handle 0x39437e8 dllopen : 1
23:25:48 T:2834297952 DEBUG: DllAvUtilBase: Using libavutil system library
23:25:48 T:2834297952 DEBUG: COMXAudio::SetCodingType OMX_AUDIO_CodingPCM
23:25:48 T:3041042960 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321
23:25:48 T:3041042960 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.resize handle 0x39f7560 dllopen : 1
23:25:48 T:2834297952 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.audio_render handle 0x353a4f8 dllopen : 1
23:25:48 T:3041042960 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61
23:25:48 T:2834297952 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100
23:25:48 T:3041042960 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(3), nBufferSize(81920), nBufferAlignmen(16)
23:25:48 T:2834297952 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.audio_decode handle 0x34aaf78 dllopen : 1
23:25:48 T:2834297952 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_decode input port 120 output port 121
23:25:48 T:2834297952 DEBUG: COMXCoreComponent::Initialize : OMX.broadcom.audio_mixer handle 0x3979050 dllopen : 1
23:25:48 T:2834297952 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_mixer input port 232 output port 231
23:25:48 T:2834297952 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_decode) - port(120), nBufferCountMin(4), nBufferCountActual(43), nBufferSize(16384), nBufferAlignmen(16)
23:25:48 T:2834297952 DEBUG: COMXAudio::Initialize Ouput bps 16 samplerate 44100 channels 2 buffer size 705600 bytes per second 352800
23:25:48 T:2834297952 DEBUG: COMXAudio::Initialize Input bps 32 samplerate 44100 channels 2 buffer size 705600 bytes per second 352800
23:25:48 T:2834297952 DEBUG: COMXAudio::Initialize device hdmi passthrough 0 hwdecode 0
23:25:48 T:2834297952 INFO: Audio codec channels 2 samplerate 44100 bitspersample 16
23:25:48 T:2834297952 NOTICE: OMXClock using audio as reference
23:25:48 T:2834297952 DEBUG: OMXClock::OMXReset audio / video : 1 / 1 start audio / video : 1 / 1 wait mask 3
23:25:48 T:2834297952 DEBUG: COMXAudio::Decode ADec : setStartTime 0.000000
23:25:48 T:2834297952 DEBUG: pcm->direction : input
23:25:48 T:2834297952 DEBUG: pcm->nPortIndex : 232
23:25:48 T:2834297952 DEBUG: pcm->eNumData : 0
23:25:48 T:2834297952 DEBUG: pcm->eEndian : 1
23:25:48 T:2834297952 DEBUG: pcm->bInterleaved : 1
23:25:48 T:2834297952 DEBUG: pcm->nBitPerSample : 16
23:25:48 T:2834297952 DEBUG: pcm->ePCMMode : 0
23:25:48 T:2834297952 DEBUG: pcm->nChannels : 2
23:25:48 T:2834297952 DEBUG: pcm->nSamplingRate : 44100
23:25:48 T:2834297952 DEBUG: OMX_AUDIO_ChannelLF
23:25:48 T:2834297952 DEBUG: OMX_AUDIO_ChannelRF
23:25:48 T:2834297952 DEBUG: pcm->direction : output
23:25:48 T:2834297952 DEBUG: pcm->nPortIndex : 100
23:25:48 T:2834297952 DEBUG: pcm->eNumData : 0
23:25:48 T:2834297952 DEBUG: pcm->eEndian : 1
23:25:48 T:2834297952 DEBUG: pcm->bInterleaved : 1
23:25:48 T:2834297952 DEBUG: pcm->nBitPerSample : 16
23:25:48 T:2834297952 DEBUG: pcm->ePCMMode : 0
23:25:48 T:2834297952 DEBUG: pcm->nChannels : 2
23:25:48 T:2834297952 DEBUG: pcm->nSamplingRate : 44100
23:25:48 T:2834297952 DEBUG: OMX_AUDIO_ChannelLF
23:25:48 T:2834297952 DEBUG: OMX_AUDIO_ChannelRF
23:25:48 T:2888139872 DEBUG: COMXPlayer::HandleMessages - player started 1
23:25:48 T:2888139872 DEBUG: COMXPlayer::SetCaching - caching state 0
23:25:48 T:2888139872 DEBUG: OMXClock::OMXSetSpeed 1 buffering 0
23:25:48 T:2834297952 DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_SETSPEED 1000
23:25:48 T:2834297952 DEBUG: COMXPlayerAudio - CDVDMsg::GENERAL_RESYNC(26122.448980, 1)
23:25:48 T:2866578528 DEBUG: COMXPlayerVideo - CDVDMsg::PLAYER_SETSPEED 1000
23:25:48 T:2834297952 DEBUG: OMXClock::OMXAudioBufferStart
23:25:48 T:2888139872 DEBUG: COMXPlayer::SetCaching - caching state 1
23:25:48 T:2888139872 DEBUG: OMXClock::OMXSetSpeed 0 buffering 0
23:25:48 T:2866578528 DEBUG: COMXPlayerVideo - CDVDMsg::PLAYER_SETSPEED 0
23:25:48 T:2866578528 DEBUG: COMXPlayerVideo - CDVDMsg::PLAYER_STARTED 1
23:25:48 T:2888139872 DEBUG: COMXPlayer::HandleMessages - player started 2
23:25:48 T:2834297952 DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_SETSPEED 0
23:25:48 T:2834297952 DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_STARTED 1
23:25:48 T:2888139872 DEBUG: COMXPlayer::HandleMessages - player started 1
23:25:48 T:2888139872 DEBUG: COMXPlayer::SetCaching - caching state 0
23:25:48 T:2888139872 DEBUG: OMXClock::OMXSetSpeed 1 buffering 0
23:25:48 T:2834297952 DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_SETSPEED 1000
23:25:48 T:2834297952 DEBUG: OMXClock::OMXAudioBufferStart
23:25:48 T:2866578528 DEBUG: COMXPlayerVideo - CDVDMsg::PLAYER_SETSPEED 1000
23:25:48 T:2834297952 INFO: COMXPlayerAudio - Switching to normal playback
23:25:48 T:2834297952 DEBUG: OMXClock::OMXAudioBufferStop
23:25:48 T:2834297952 DEBUG: OMXClock::OMXSetSpeed 1 buffering 0
23:25:48 T:2959819872 DEBUG: CecLogMessage - key auto-released: select (0)
23:25:48 T:2959819872 DEBUG: PushCecKeypress - received key b duration 1070
23:25:49 T:3041042960 ERROR: COMXCoreComponent::WaitForEvent OMX.broadcom.image_decode wait event 0x00000003 timeout 1000
23:25:49 T:3041042960 ERROR: COMXImage::Decode HandlePortSettingChange() failed
23:25:51 T:3041042960 ERROR: COMXCoreComponent::WaitForCommand OMX.broadcom.image_decode wait timeout event.eEvent 0x00000000 event.command 0x00000002 event.nData2 320
23:25:53 T:3041042960 ERROR: COMXCoreComponent::WaitForCommand OMX.broadcom.image_decode wait timeout event.eEvent 0x00000000 event.command 0x00000001 event.nData2 320
23:25:55 T:3041042960 ERROR: COMXCoreComponent::WaitForCommand OMX.broadcom.image_decode wait timeout event.eEvent 0x00000000 event.command 0x00000001 event.nData2 321
23:25:55 T:3041042960 ERROR: COMXCoreComponent::SetStateForComponent - OMX.broadcom.image_decode failed with omx_err(0x80001000)
23:25:55 T:3041042960 ERROR: Previous line repeats 2 times.
23:25:55 T:3041042960 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x39f7560 dllopen : 1
23:25:57 T:3041042960 ERROR: COMXCoreComponent::WaitForCommand OMX.broadcom.image_decode wait timeout event.eEvent 0x00000000 event.command 0x00000001 event.nData2 320
23:25:59 T:3041042960 ERROR: COMXCoreComponent::WaitForCommand OMX.broadcom.image_decode wait timeout event.eEvent 0x00000000 event.command 0x00000001 event.nData2 321
23:25:59 T:3041042960 ERROR: COMXCoreComponent::SetStateForComponent - OMX.broadcom.image_decode failed with omx_err(0x80001000)
23:25:59 T:3041042960 ERROR: Previous line repeats 2 times.
23:25:59 T:3041042960 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x39437e8 dllopen : 1
23:26:15 T:2921694304 DEBUG: Thread JobWorker 2921694304 terminating (autodelete)
- When I was able to find an album without cover info, and in mp3 format : heard 3 glitches in half an hour.
http://trac.xbmc.org/ticket/14319
(2013-05-11, 15:46)Raphael78 Wrote: @popcornmix : apart from these problems, I assume that the fact I still have the glitches with these different versions should narrow the possibilities about the location of the problem ? Any idea what else I could try, or how I could check if audio frames are actually being dropped ?
(2013-05-11, 18:47)popcornmix Wrote:(2013-05-11, 15:46)Raphael78 Wrote: @popcornmix : apart from these problems, I assume that the fact I still have the glitches with these different versions should narrow the possibilities about the location of the problem ? Any idea what else I could try, or how I could check if audio frames are actually being dropped ?
The most interesting test is that command line omxplayer can play the same files correctly.
This suggests the problem isn't on the GPU, or HDMI interface, but in XBMC code.
It could be when the ARM processor is busy, it causes an underrun and a glitch, but I don't think that's likely. There is a couple of seconds of audio queued up between ARM and GPU, and we're much less busy playing music than playing video.
xbmc does try to detect discontinuities in the timestamps coming in. If it incorrectly does this it might cause a glitch.
I'm currently working on a rewrite of the clock code for command line omxplayer with the intention of porting that back to xbmc if it is successful, so that may be a fix.
(2013-05-11, 18:47)popcornmix Wrote: I'm currently working on a rewrite of the clock code for command line omxplayer with the intention of porting that back to xbmc if it is successful, so that may be a fix.
(2013-06-08, 09:19)thhb Wrote: Just found this: https://github.com/xbmc/xbmc/commit/4cbd...785dd489af
Could this be that the fix you meant? If so, is there a way for me to try it?
(2013-06-08, 11:36)popcornmix Wrote:(2013-06-08, 09:19)thhb Wrote: Just found this: https://github.com/xbmc/xbmc/commit/4cbd...785dd489af
Could this be that the fix you meant? If so, is there a way for me to try it?
Not specifically that commit, but this build has some improvements in and could help:
http://forum.xbmc.org/showthread.php?tid...pid1438531
(2013-07-23, 01:25)padred123 Wrote: Can this be done on RaspBMC? I read the instructions on applying those "updates" but it only refers OpenLEC... Just want to be sure cuz this glitch has been making me crazy and I'd luv to finally solve it. (sorry for the noob questions)