2015-01-27, 05:45
Stating the obvious I know but confirming you have purchased the mpeg2 and VC-1 licences for the RPi config.txt file ?
(2015-01-27, 06:04)gustafarian Wrote: offs
It seems to be an inability for the RPI to play AC3 audio when it is in a ISO or DVD format and when Passthrough with AC3 is enabled.
Quote:The DVD audio works if output is set to 2 channel but then the music mp3 doesn't work and I don't get ac3 pass through
(2015-02-09, 04:41)wrxtasy Wrote:Quote:The DVD audio works if output is set to 2 channel but then the music mp3 doesn't work and I don't get ac3 pass through
Give this a go....
Release - AUTOMATIC (and/or manual) AUDIO SWITCHER for different Audio Output
(2015-01-29, 11:12)gustafarian Wrote: Right.i have overclocked to 1000ghz and upped gpu=128.no effect. I have tried with a few dvd folder rips with ac3 5.1 and still bad sound, ihave exported a log file and around line 950 it says cdvdplayeraudio:handlesyncerror1. Log below.
(2015-02-09, 12:18)wrxtasy Wrote:(2015-01-29, 11:12)gustafarian Wrote: Right.i have overclocked to 1000ghz and upped gpu=128.no effect. I have tried with a few dvd folder rips with ac3 5.1 and still bad sound, ihave exported a log file and around line 950 it says cdvdplayeraudio:handlesyncerror1. Log below.
Also this setting below because looking at your log Kodi may still be trying to use OMXPlayer for these DVD iso's.
Kodi > Settings > Video > Acceleration > Allow hardware acceleration (OMXPlayer) > Disable
just leave MMAL selected.
19:47:15 T:2689594432 ERROR: NFS: Failed to stat(volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VIDEO_TS.IFO) stat call failed with "NFS: Lookup of /Video/Movies/Star Wars - Episode I.DVD/VIDEO_TS.IFO failed with NFS3ERR_NOENT(-2)"
19:47:15 T:2689594432 DEBUG: CNFSFile::Open - opened volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VIDEO_TS/VIDEO_TS.IFO
19:47:15 T:2689594432 DEBUG: msg: NAME OPEN FAILED
19:47:15 T:2689594432 INFO: msg: libdvdnav: vm: DVD Title:
19:47:15 T:2689594432 INFO: msg: libdvdnav: Unable to find map file '/storage/.dvdnav/.map'
19:47:15 T:2689594432 INFO: msg: libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions:
19:47:15 T:2689594432 INFO: msg: 1
19:47:15 T:2689594432 INFO: msg: 2
19:47:15 T:2689594432 INFO: msg: 3
19:47:15 T:2689594432 INFO: msg: 4
19:47:15 T:2689594432 INFO: msg: 5
19:47:15 T:2689594432 INFO: msg: 6
19:47:15 T:2689594432 INFO: msg: 7
19:47:15 T:2689594432 INFO: msg: 8
19:47:15 T:2689594432 DEBUG: msg:
19:47:15 T:2689594432 ERROR: NFS: Failed to stat(volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VIDEO_TS.VOB) stat call failed with "NFS: Lookup of /Video/Movies/Star Wars - Episode I.DVD/VIDEO_TS.VOB failed with NFS3ERR_NOENT(-2)"
19:47:15 T:2689594432 ERROR: NFS: Failed to stat(volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VIDEO_TS/VIDEO_TS.VOB) stat call failed with "NFS: Lookup of /Video/Movies/Star Wars - Episode I.DVD/VIDEO_TS/VIDEO_TS.VOB failed with NFS3ERR_NOENT(-2)"
19:47:15 T:2689594432 ERROR: NFS: Failed to stat(volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/video_ts/VIDEO_TS.VOB) stat call failed with "NFS: Lookup of /Video/Movies/Star Wars - Episode I.DVD/video_ts/VIDEO_TS.VOB failed with NFS3ERR_NOENT(-2)"
19:47:15 T:2689594432 DEBUG: Open - Setting region mask ff
19:47:15 T:2689594432 NOTICE: DVDPlayer: playing a file with menu's
19:47:15 T:2689594432 NOTICE: Creating Demuxer
19:47:15 T:2689594432 ERROR: NFS: Failed to stat(volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VTS_01_0.IFO) stat call failed with "NFS: Lookup of /Video/Movies/Star Wars - Episode I.DVD/VTS_01_0.IFO failed with NFS3ERR_NOENT(-2)"
19:47:15 T:2689594432 DEBUG: CNFSFile::Open - opened volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VIDEO_TS/VTS_01_0.IFO
19:47:15 T:2689594432 DEBUG: DVDNAV_HIGHLIGHT: Highlight button 1
19:47:15 T:2689594432 ERROR: NFS: Failed to stat(volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VTS_01_1.VOB) stat call failed with "NFS: Lookup of /Video/Movies/Star Wars - Episode I.DVD/VTS_01_1.VOB failed with NFS3ERR_NOENT(-2)"
19:47:15 T:2689594432 DEBUG: CNFSFile::Open - opened volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VIDEO_TS/VTS_01_1.VOB
19:47:18 T:2689594432 ERROR: NFS: Failed to stat(volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VTS_01_2.VOB) stat call failed with "NFS: Lookup of /Video/Movies/Star Wars - Episode I.DVD/VTS_01_2.VOB failed with NFS3ERR_NOENT(-2)"
19:47:18 T:2689594432 DEBUG: CNFSFile::Open - opened volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VIDEO_TS/VTS_01_2.VOB
19:47:20 T:2689594432 ERROR: NFS: Failed to stat(volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VTS_01_3.VOB) stat call failed with "NFS: Lookup of /Video/Movies/Star Wars - Episode I.DVD/VTS_01_3.VOB failed with NFS3ERR_NOENT(-2)"
19:47:20 T:2689594432 DEBUG: CNFSFile::Open - opened volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VIDEO_TS/VTS_01_3.VOB
19:47:23 T:2689594432 ERROR: NFS: Failed to stat(volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VTS_01_4.VOB) stat call failed with "NFS: Lookup of /Video/Movies/Star Wars - Episode I.DVD/VTS_01_4.VOB failed with NFS3ERR_NOENT(-2)"
19:47:23 T:2689594432 DEBUG: CNFSFile::Open - opened volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VIDEO_TS/VTS_01_4.VOB
19:47:25 T:2804229184 DEBUG: Thread JobWorker 2804229184 terminating (autodelete)
19:47:25 T:2700080192 DEBUG: Thread JobWorker 2700080192 terminating (autodelete)
19:47:25 T:2710484032 DEBUG: Thread JobWorker 2710484032 terminating (autodelete)
19:47:25 T:2837783616 DEBUG: Thread JobWorker 2837783616 terminating (autodelete)
19:47:26 T:2689594432 ERROR: NFS: Failed to stat(volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VTS_01_5.VOB) stat call failed with "NFS: Lookup of /Video/Movies/Star Wars - Episode I.DVD/VTS_01_5.VOB failed with NFS3ERR_NOENT(-2)"
19:47:26 T:2689594432 DEBUG: CNFSFile::Open - opened volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VIDEO_TS/VTS_01_5.VOB
19:47:27 T:2812617792 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers
19:47:28 T:2689594432 ERROR: NFS: Failed to stat(volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VTS_01_6.VOB) stat call failed with "NFS: Lookup of /Video/Movies/Star Wars - Episode I.DVD/VTS_01_6.VOB failed with NFS3ERR_NOENT(-2)"
19:47:28 T:2689594432 DEBUG: CNFSFile::Open - opened volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VIDEO_TS/VTS_01_6.VOB
19:47:29 T:2812617792 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers
19:47:31 T:2689594432 ERROR: NFS: Failed to stat(volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VTS_01_7.VOB) stat call failed with "NFS: Lookup of /Video/Movies/Star Wars - Episode I.DVD/VTS_01_7.VOB failed with NFS3ERR_NOENT(-2)"
19:47:31 T:2689594432 ERROR: NFS: Failed to stat(volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VIDEO_TS/VTS_01_7.VOB) stat call failed with "NFS: Lookup of /Video/Movies/Star Wars - Episode I.DVD/VIDEO_TS/VTS_01_7.VOB failed with NFS3ERR_NOENT(-2)"
19:47:31 T:2689594432 ERROR: NFS: Failed to stat(volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/video_ts/VTS_01_7.VOB) stat call failed with "NFS: Lookup of /Video/Movies/Star Wars - Episode I.DVD/video_ts/VTS_01_7.VOB failed with NFS3ERR_NOENT(-2)"
19:47:31 T:2689594432 DEBUG: - DVDNAV_VTS_CHANGE (HOLDING)
19:47:31 T:2689594432 DEBUG: Open - avformat_find_stream_info starting
19:47:31 T:2689594432 WARNING: could not find codec parameters for nfs://10.1.1.65/volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VIDEO_TS/VIDEO_TS.IFO
19:47:31 T:2689594432 DEBUG: Open - av_find_stream_info finished
19:47:31 T:2689594432 INFO: ffmpeg[A04FF440]: Input #0, mpeg, from 'nfs://10.1.1.65/volume1/Multimedia/Video/Movies/Star Wars - Episode I.DVD/VIDEO_TS/VIDEO_TS.IFO':
19:47:31 T:2689594432 INFO: ffmpeg[A04FF440]: Duration: N/A, bitrate: N/A
19:47:31 T:2689594432 NOTICE: OMXPlayerUnsuitable OMXPlayer unsuitable due to dvd menus
19:47:31 T:3032478784 INFO: CAESinkALSA - Unable to open device "default" for playback
19:47:31 T:3032478784 NOTICE: Found 1 Lists of Devices
19:47:31 T:3032478784 NOTICE: Enumerated PI devices:
19:47:31 T:3032478784 NOTICE: Device 1
19:47:31 T:3032478784 NOTICE: m_deviceName : HDMI
19:47:31 T:3032478784 NOTICE: m_displayName : HDMI
19:47:31 T:3032478784 NOTICE: m_displayNameExtra:
19:47:31 T:3032478784 NOTICE: m_deviceType : AE_DEVTYPE_HDMI
19:47:31 T:3032478784 NOTICE: m_channels : FL,FR
19:47:31 T:3032478784 NOTICE: m_sampleRates : 8000,11025,16000,22050,24000,32000,44100,48000,88200,96000,176400,192000
19:47:31 T:3032478784 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP,AE_FMT_AC3,AE_FMT_DTS,AE_FMT_EAC3
20:14:53 T:1831969856 DEBUG: GetSongsByWhere query = SELECT songview.* FROM songview WHERE ((CAST(songview.iTimesPlayed as DECIMAL(5,1)) < 1))
20:14:53 T:1872024640 DEBUG: PushCecKeypress - received key b duration 0
20:14:53 T:1969553408 DEBUG: OnKey: 11 (0x0b) pressed, action is Select
20:14:53 T:1969553408 DEBUG: OnPlayMedia nfs://10.1.1.65/volume1/Multimedia/Video/CHILDRENS MOVIES/Peppa Pig - Flying a Kite.mkv
20:14:53 T:1872024640 DEBUG: PushCecKeypress - received key b duration 185
20:14:53 T:1969553408 DEBUG: GetMovieId (nfs://10.1.1.65/volume1/Multimedia/Video/CHILDRENS MOVIES/Peppa Pig - Flying a Kite.mkv), query = select idMovie from movie where idFile=1368
20:14:53 T:1969553408 DEBUG: GetEpisodeId (nfs://10.1.1.65/volume1/Multimedia/Video/CHILDRENS MOVIES/Peppa Pig - Flying a Kite.mkv), query = select idEpisode from episode where idFile=1368
20:14:53 T:1969553408 DEBUG: GetMusicVideoId (nfs://10.1.1.65/volume1/Multimedia/Video/CHILDRENS MOVIES/Peppa Pig - Flying a Kite.mkv), query = select idMVideo from musicvideo where idFile=1368
20:14:53 T:1969553408 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc
20:14:53 T:1969553408 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd
20:14:53 T:1969553408 DEBUG: Loading settings for nfs://10.1.1.65/volume1/Multimedia/Video/CHILDRENS MOVIES/Peppa Pig - Flying a Kite.mkv
20:14:53 T:1969553408 DEBUG: CPlayerCoreFactory::GetPlayers(nfs://10.1.1.65/volume1/Multimedia/Video/CHILDRENS MOVIES/Peppa Pig - Flying a Kite.mkv)
20:14:53 T:1969553408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
20:14:53 T:1969553408 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
20:14:53 T:1969553408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
20:14:53 T:1969553408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
20:14:53 T:1969553408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
20:14:53 T:1969553408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
20:14:53 T:1969553408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
20:14:53 T:1969553408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
20:14:53 T:1969553408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
20:14:53 T:1969553408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
20:14:53 T:1969553408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
20:14:53 T:1969553408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
20:14:53 T:1969553408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
20:14:53 T:1969553408 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
20:14:53 T:1969553408 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
20:14:53 T:1969553408 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
20:14:53 T:1969553408 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
20:14:53 T:1969553408 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
20:14:53 T:1969553408 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
20:14:53 T:1969553408 NOTICE: DVDPlayer: Opening: nfs://10.1.1.65/volume1/Multimedia/Video/CHILDRENS MOVIES/Peppa Pig - Flying a Kite.mkv
20:14:53 T:1969553408 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
20:14:53 T:1969553408 DEBUG: CMMALRenderer::CMMALRenderer
20:14:53 T:1969553408 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
20:14:53 T:1969553408 DEBUG: CMMALRenderer::UnInit
20:14:53 T:1969553408 DEBUG: CMMALRenderer::PreInit
20:14:53 T:1659712576 NOTICE: Thread CMMALRenderer start, auto delete: false
20:14:53 T:1625289792 NOTICE: Thread DVDPlayer start, auto delete: false
20:14:53 T:1625289792 NOTICE: Creating InputStream
20:14:53 T:1625289792 DEBUG: CNFSFile::Open - opened volume1/Multimedia/Video/CHILDRENS MOVIES/Peppa Pig - Flying a Kite.mkv
20:14:53 T:1625289792 DEBUG: ScanForExternalSubtitles: Searching for subtitles...
20:14:54 T:1625289792 DEBUG: ScanForExternalSubtitles: END (total time: 53 ms)
20:14:54 T:1625289792 NOTICE: Creating Demuxer
20:14:54 T:1625289792 DEBUG: Open - probing detected format [matroska,webm]
20:14:54 T:1625289792 DEBUG: Open - avformat_find_stream_info starting
20:14:54 T:1625289792 DEBUG: Open - av_find_stream_info finished
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Input #0, matroska,webm, from 'nfs://10.1.1.65/volume1/Multimedia/Video/CHILDRENS MOVIES/Peppa Pig - Flying a Kite.mkv':
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Metadata:
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: encoder : libmkv 0.6.4.1
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Duration: 00:50:59.30, start: 0.000000, bitrate: 434 kb/s
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Chapter #0.0: start 0.000000, end 305.960000
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Metadata:
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: title : Chapter 1
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Chapter #0.1: start 305.960000, end 611.899933
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Metadata:
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: title : Chapter 2
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Chapter #0.2: start 611.899933, end 917.839867
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Metadata:
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: title : Chapter 3
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Chapter #0.3: start 917.839867, end 1223.779800
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Metadata:
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: title : Chapter 4
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Chapter #0.4: start 1223.779800, end 1529.719733
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Metadata:
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: title : Chapter 5
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Chapter #0.5: start 1529.719733, end 1835.659667
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Metadata:
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: title : Chapter 6
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Chapter #0.6: start 1835.659667, end 2141.599600
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Metadata:
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: title : Chapter 7
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Chapter #0.7: start 2141.599600, end 2447.539533
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Metadata:
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: title : Chapter 8
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Chapter #0.8: start 2447.539533, end 2753.479467
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Metadata:
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: title : Chapter 9
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Chapter #0.9: start 2753.479467, end 3059.299500
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Metadata:
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: title : Chapter 10
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Stream #0:0(eng): Video: h264 (Main), yuv420p(tv, smpte170m), 720x400, SAR 1:1 DAR 9:5, 25 fps, 25 tbr, 1k tbn, 180k tbc (default)
20:14:54 T:1625289792 INFO: ffmpeg[60DFF440]: Stream #0:1(eng): Audio: ac3, 48000 Hz, stereo, fltp, 192 kb/s (default)
20:14:54 T:1625289792 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0
20:14:54 T:1625289792 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1
20:14:54 T:1625289792 NOTICE: Opening stream: 0 source: 256
20:14:54 T:1625289792 NOTICE: Creating video codec with codec id: 28
20:14:54 T:1625289792 DEBUG: CDVDFactoryCodec: compiled in hardware support: AMCodec:no MediaCodec:no OpenMax:no libstagefright:no VDPAU:no VAAPI:no iMXVPU:no
20:14:54 T:1625289792 DEBUG: CDVDVideoCodecMMAL::CDVDVideoCodecMMAL 0x3581cc0
20:14:54 T:1625289792 DEBUG: FactoryCodec - Video: mmal-xxxx - Opening
20:14:54 T:1625289792 DEBUG: FactoryCodec - Video: mmal-h264 - Opened
20:14:54 T:1625289792 NOTICE: Creating video thread
20:14:54 T:1625289792 NOTICE: Opening stream: 1 source: 256
20:14:54 T:1625289792 NOTICE: Finding audio codec for: 86019
20:14:54 T:1625289792 DEBUG: FactoryCodec - Audio: passthrough - Opening
20:14:54 T:1625289792 DEBUG: FactoryCodec - Audio: passthrough - Opened
20:14:54 T:1625289792 NOTICE: Creating audio thread
20:14:54 T:1625289792 DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: nfs://10.1.1.65/volume1/Multimedia/Video/CHILDRENS MOVIES/Peppa Pig - Flying a Kite.mkv
20:14:54 T:1608512576 NOTICE: Thread DVDPlayerVideo start, auto delete: false
20:14:54 T:1608512576 NOTICE: running thread: video_thread
20:14:54 T:1608512576 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
20:14:54 T:1600123968 NOTICE: Thread DVDPlayerAudio start, auto delete: false
20:14:54 T:1600123968 NOTICE: running thread: CDVDPlayerAudio::Process()
20:14:54 T:1600123968 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
20:14:54 T:1625289792 DEBUG: OnPlayBackStarted: play state was 1, starting 1
20:14:54 T:1969553408 DEBUG: PlayFile: OpenFile succeed, play state 2
20:14:54 T:1969553408 DEBUG: OnPlayBackStarted: play state was 2, starting 0
20:14:54 T:1625289792 DEBUG: CDVDPlayer::SetCaching - caching state 3
20:14:54 T:1600123968 INFO: CAEStreamInfo::SyncAC3 - AC3 stream detected (2 channels, 48000Hz)
20:14:54 T:1600123968 NOTICE: Creating audio stream (codec id: 86019, channels: 2, sample rate: 48000, pass-through)
20:14:54 T:1600123968 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback
20:14:54 T:1608512576 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
20:14:54 T:1608512576 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(150000.000000, 0)
20:14:54 T:1608512576 NOTICE: fps: 25.000000, pwidth: 720, pheight: 400, dwidth: 720, dheight: 400
20:14:54 T:1608512576 DEBUG: OutputPicture - change configuration. 720x400. framerate: 25.00. format: MMAL
20:14:54 T:1608512576 DEBUG: CMMALRenderer::Configure - 720x400->[email protected] flags:12 format:18 ext:0 orient:0
20:14:54 T:1608512576 NOTICE: Display resolution USER : 1920x1080 (1920x1080) @ 59.94 - Full Screen (23)
20:14:54 T:1608512576 DEBUG: CMMALRenderer::init_vout
20:14:54 T:1949299776 INFO: CActiveAESink::OpenSink - initialize sink
20:14:54 T:1608512576 DEBUG: CXBMCRenderManager::Configure - 3
20:14:54 T:1625289792 DEBUG: CDVDPlayer::HandleMessages - player started 2
20:14:54 T:1969553408 DEBUG: CGUIInfoManager::SetCurrentMovie(nfs://10.1.1.65/volume1/Multimedia/Video/CHILDRENS MOVIES/Peppa Pig - Flying a Kite.mkv)
20:14:54 T:1949299776 DEBUG: CAESinkPi:Drain delay:99ms now:0ms
20:14:54 T:1949299776 DEBUG: CAESinkPi:Deinitialize
20:14:54 T:1949299776 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000
20:14:54 T:1949299776 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x277b370
20:14:54 T:1949299776 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI
20:14:54 T:1949299776 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 1 hdmi_channel_map 00000000
20:14:54 T:1949299776 DEBUG: CAESinkPi:Initialize Format:2 Channels:2 Samplerate:48000 framesize:4 bufsize:9600 bytes/s=192000.00 dest=PI:HDMI
20:14:54 T:1949299776 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x277b370
20:14:54 T:1949299776 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(9600), nBufferAlignmen(16)
20:14:54 T:1949299776 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized:
20:14:54 T:1949299776 DEBUG: Output Device : HDMI
20:14:54 T:1949299776 DEBUG: Sample Rate : 48000
20:14:54 T:1949299776 DEBUG: Sample Format : AE_FMT_S16NE
20:14:54 T:1949299776 DEBUG: Channel Count : 2
20:14:54 T:1949299776 DEBUG: Channel Layout: RAW,RAW
20:14:54 T:1949299776 DEBUG: Frames : 2400
20:14:54 T:1949299776 DEBUG: Frame Samples : 4800
20:14:54 T:1949299776 DEBUG: Frame Size : 4
20:14:54 T:1959785536 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
20:14:54 T:1625289792 DEBUG: Previous line repeats 1 times.
20:14:54 T:1625289792 DEBUG: CDVDPlayer::HandleMessages - player started 1
20:14:54 T:1625289792 DEBUG: CDVDPlayer::SetCaching - caching state 0
20:14:54 T:1600123968 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(32000.000000, 1)
20:14:54 T:1600123968 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError1 - was:-92339.001520, should be:-92331.001520, error:8.000000
20:14:54 T:1969553408 DEBUG: GetMovieId (nfs://10.1.1.65/volume1/Multimedia/Video/CHILDRENS MOVIES/Peppa Pig - Flying a Kite.mkv), query = select idMovie from movie where idFile=1368
20:14:54 T:1969553408 DEBUG: GetEpisodeId (nfs://10.1.1.65/volume1/Multimedia/Video/CHILDRENS MOVIES/Peppa Pig - Flying a Kite.mkv), query = select idEpisode from episode where idFile=1368
20:14:54 T:1969553408 DEBUG: GetMusicVideoId (nfs://10.1.1.65/volume1/Multimedia/Video/CHILDRENS MOVIES/Peppa Pig - Flying a Kite.mkv), query = select idMVideo from musicvideo where idFile=1368
20:14:54 T:1969553408 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
20:14:54 T:1969553408 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
20:14:54 T:1969553408 DEBUG: Activating window ID: 12005
20:14:54 T:1969553408 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
20:14:54 T:1969553408 DEBUG: ------ Window Init (VideoFullScreen.xml) ------
20:14:54 T:1969553408 INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY
20:14:54 T:1969553408 DEBUG: CMMALRenderer::SetVideoRect 0,0,720,400 -> 0,7,1920,1074 (o:0 v:0 d:0 i:0)
20:14:54 T:1969553408 DEBUG: CMMALRenderer::SetVideoRect 0,0,720,400 -> 0,7,1920,1067 mode:1
20:14:54 T:1969553408 DEBUG: ------ Window Deinit (DialogKaiToast.xml) ------
20:14:56 T:1600123968 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:1950170.998480, should be:1916217.855576, error:-33953.142904
20:14:57 T:1831969856 DEBUG: GetSongsByWhere() - took 4367 ms
20:14:58 T:1600123968 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:3916289.855576, should be:3900101.316753, error:-16188.538823
20:14:58 T:1831969856 DEBUG: Skin Widgets: Total time needed to request random queries: 0:00:10.752671
20:14:58 T:1831969856 DEBUG: RunQuery took 9 ms for 2 items query: select * from movieview WHERE (movieview.idFile IN (SELECT DISTINCT idFile FROM bookmark WHERE type = 1))
20:14:59 T:1831969856 DEBUG: RunQuery took 35 ms for 0 items query: SELECT * FROM tvshowview WHERE ( ((tvshowview.watchedcount > 0 AND tvshowview.watchedcount < tvshowview.totalCount) OR (tvshowview.watchedcount = 0 AND EXISTS (SELECT 1 FROM episodeview WHERE episodeview.idShow = tvshowview.idShow AND episodeview.resumeTimeInSeconds > 0))))
20:14:59 T:1831969856 DEBUG: GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE albumview.strAlbum <> ''
20:14:59 T:1831969856 DEBUG: GetAlbumsByWhere - query took 213 ms
20:14:59 T:1608512576 DEBUG: CPullupCorrection: detected pattern of length 1: 40000.00, frameduration: 40000.000000
20:15:00 T:1831969856 DEBUG: RunQuery took 6 ms for 0 items query: select * from musicvideoview
20:15:00 T:1831969856 DEBUG: Skin Widgets: Total time needed to request recommended queries: 0:00:01.617993
20:15:00 T:1872024640 DEBUG: PushCecKeypress - received key e0 duration 1183