2019-07-12 21:39:08.397 T:8329 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 2019-07-12 21:39:08.398 T:8329 DEBUG: ------ Window Deinit (DialogVideoInfo.xml) ------ 2019-07-12 21:39:08.407 T:8334 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 2019-07-12 21:39:08.407 T:8334 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear 2019-07-12 21:39:08.408 T:8334 DEBUG: CAnnouncementManager - Announcement: OnAdd from xbmc 2019-07-12 21:39:08.408 T:8334 DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnAdd 2019-07-12 21:39:08.426 T:8329 DEBUG: CPlayerCoreFactory::GetPlayers(smb://192.168.178.31:445/NAS 3/Videos/HD-Filme 2/Filme/Russendisko.ts) 2019-07-12 21:39:08.426 T:8329 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 2019-07-12 21:39:08.426 T:8329 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 2019-07-12 21:39:08.426 T:8329 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 2019-07-12 21:39:08.426 T:8329 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 2019-07-12 21:39:08.426 T:8329 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 2019-07-12 21:39:08.426 T:8329 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 2019-07-12 21:39:08.426 T:8329 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 2019-07-12 21:39:08.426 T:8329 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 2019-07-12 21:39:08.426 T:8329 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 2019-07-12 21:39:08.426 T:8329 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 2019-07-12 21:39:08.427 T:8329 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 2019-07-12 21:39:08.427 T:8329 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 2019-07-12 21:39:08.427 T:8329 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 2019-07-12 21:39:08.427 T:8329 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 2019-07-12 21:39:08.427 T:8329 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 2019-07-12 21:39:08.427 T:8329 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 2019-07-12 21:39:08.427 T:8329 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 2019-07-12 21:39:08.427 T:10436 DEBUG: Thread RefClock start, auto delete: false 2019-07-12 21:39:08.427 T:10436 DEBUG: CVideoSyncAndroid::Setup setting up 2019-07-12 21:39:08.428 T:10436 DEBUG: CVideoSyncAndroid::GetFps Detected refreshrate: 50.000000 hertz 2019-07-12 21:39:08.428 T:10436 DEBUG: CVideoReferenceClock: Detected refreshrate: 50.000 hertz 2019-07-12 21:39:08.431 T:8329 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 2019-07-12 21:39:08.431 T:8329 NOTICE: VideoPlayer::OpenFile: smb://192.168.178.31:445/NAS 3/Videos/HD-Filme 2/Filme/Russendisko.ts 2019-07-12 21:39:08.431 T:8329 DEBUG: OnPlayBackStarted: CApplication::OnPlayBackStarted 2019-07-12 21:39:08.432 T:10437 DEBUG: Thread VideoPlayer start, auto delete: false 2019-07-12 21:39:08.432 T:10438 DEBUG: Thread BackgroundLoader start, auto delete: false 2019-07-12 21:39:08.432 T:10437 NOTICE: Creating InputStream 2019-07-12 21:39:08.452 T:10325 DEBUG: Loading settings for smb://192.168.178.31:445/NAS 3/Videos/HD-Filme 2/Filme/Russendisko.ts 2019-07-12 21:39:08.453 T:8329 DEBUG: CVideoGUIInfo::InitCurrentItem(smb://192.168.178.31:445/NAS 3/Videos/HD-Filme 2/Filme/Russendisko.ts) 2019-07-12 21:39:08.470 T:10438 DEBUG: Thread BackgroundLoader 10438 terminating 2019-07-12 21:39:08.476 T:8329 DEBUG: CPlayerGUIInfo::InitCurrentItem(smb://192.168.178.31:445/NAS 3/Videos/HD-Filme 2/Filme/Russendisko.ts) 2019-07-12 21:39:08.477 T:8334 DEBUG: CAnnouncementManager - Announcement: OnChanged from xbmc 2019-07-12 21:39:08.477 T:8334 DEBUG: GOT ANNOUNCEMENT, type: 1024, from xbmc, message OnChanged 2019-07-12 21:39:08.478 T:8334 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 2019-07-12 21:39:08.478 T:8334 DEBUG: void CXBMCApp::OnPlayBackStarted() 2019-07-12 21:39:08.491 T:8334 DEBUG: Visible Behind request: false 2019-07-12 21:39:08.492 T:8334 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 2019-07-12 21:39:08.577 T:8329 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2019-07-12 21:39:08.905 T:10437 DEBUG: CSMBFile::Open - opened smb://USERNAME:PASSWORD@192.168.178.31:445/NAS 3/Videos/HD-Filme 2/Filme/Russendisko.ts, fd=10000 2019-07-12 21:39:08.908 T:10437 DEBUG: ScanForExternalSubtitles: Searching for subtitles... 2019-07-12 21:39:08.927 T:10437 DEBUG: ScanForExternalSubtitles: END (total time: 20 ms) 2019-07-12 21:39:08.928 T:10437 NOTICE: Creating Demuxer 2019-07-12 21:39:09.001 T:10437 DEBUG: Open - avformat_find_stream_info starting 2019-07-12 21:39:09.031 T:10437 ERROR: ffmpeg[2D67BF94F0]: [h264] mmco: unref short failure 2019-07-12 21:39:09.031 T:10437 ERROR: Previous line repeats 1 times. 2019-07-12 21:39:09.031 T:10437 ERROR: ffmpeg[2D67BF94F0]: [h264] number of reference frames (0+4) exceeds max (3; probably corrupt input), discarding one 2019-07-12 21:39:09.249 T:10437 DEBUG: ffmpeg[2D67BF94F0]: [mpegts] start time for stream 1 is not set in estimate_timings_from_pts 2019-07-12 21:39:09.291 T:10437 DEBUG: ffmpeg[2D67BF94F0]: [mpegts] PES packet size mismatch 2019-07-12 21:39:09.310 T:10437 DEBUG: ffmpeg[2D67BF94F0]: [mpegts] Could not find codec parameters for stream 1 (Audio: ac3 ([6][0][0][0] / 0x0006), 0 channels, fltp): unspecified sample rate 2019-07-12 21:39:09.310 T:10437 DEBUG: ffmpeg[2D67BF94F0]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 2019-07-12 21:39:09.311 T:10437 DEBUG: Open - av_find_stream_info finished 2019-07-12 21:39:09.311 T:10437 INFO: ffmpeg[2D67BF94F0]: Input #0, mpegts, from 'smb://192.168.178.31:445/NAS 3/Videos/HD-Filme 2/Filme/Russendisko.ts': 2019-07-12 21:39:09.311 T:10437 INFO: ffmpeg[2D67BF94F0]: Duration: 01:34:51.72, start: 5.000000, bitrate: 7976 kb/s 2019-07-12 21:39:09.311 T:10437 INFO: ffmpeg[2D67BF94F0]: Program 131 2019-07-12 21:39:09.311 T:10437 INFO: ffmpeg[2D67BF94F0]: Metadata: 2019-07-12 21:39:09.311 T:10437 INFO: ffmpeg[2D67BF94F0]: service_name : DVR-UHD 2019-07-12 21:39:09.311 T:10437 INFO: ffmpeg[2D67BF94F0]: service_provider: HS 2019-07-12 21:39:09.312 T:10437 INFO: ffmpeg[2D67BF94F0]: Stream #0:0[0x4ff]: Video: h264 (High) ([27][0][0][0] / 0x001B), yuv420p(tv, bt709, top first), 1920x1080 [SAR 1:1 DAR 16:9], 25 fps, 50 tbr, 90k tbn, 50 tbc 2019-07-12 21:39:09.312 T:10437 INFO: ffmpeg[2D67BF94F0]: Stream #0:1[0x503](ger): Audio: ac3 ([6][0][0][0] / 0x0006), 0 channels, fltp (clean effects) 2019-07-12 21:39:09.312 T:10437 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0 2019-07-12 21:39:09.312 T:10437 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 1 2019-07-12 21:39:09.312 T:10437 NOTICE: Opening stream: 0 source: 256 2019-07-12 21:39:09.312 T:10437 NOTICE: Whitelist search for: width: 1920, height: 1080, fps: 50.000, 3D: false 2019-07-12 21:39:09.312 T:10437 DEBUG: Trying to find exact refresh rate 2019-07-12 21:39:09.313 T:10437 DEBUG: No exact whitelisted resolution matched, trying double refresh rate 2019-07-12 21:39:09.313 T:10437 DEBUG: No double whitelisted resolution matched, trying 3:2 pullback 2019-07-12 21:39:09.313 T:10437 DEBUG: No 3:2 pullback refresh rate whitelisted resolution matched, trying current resolution 2019-07-12 21:39:09.313 T:10437 DEBUG: Matched current Resolution 3840x2160 @ 50.000000 - Full Screen (24) 2019-07-12 21:39:09.313 T:10437 NOTICE: Display resolution ADJUST : 3840x2160 @ 50.000000 - Full Screen (24) (weight: 0.000) 2019-07-12 21:39:09.320 T:10437 WARNING: OpenStream - Unsupported stream 0. Stream disabled. 2019-07-12 21:39:09.320 T:10437 NOTICE: Opening stream: 1 source: 256 2019-07-12 21:39:09.320 T:10437 NOTICE: Finding audio codec for: 86019 2019-07-12 21:39:09.320 T:10437 DEBUG: CDVDAudioCodecAndroidMediaCodec::Open codec(86019), profile(-99), tag(6), extrasize(0) 2019-07-12 21:39:09.321 T:10437 INFO: CDVDAudioCodecAndroidMediaCodec::Open() Use default handling for non encrypted stream 2019-07-12 21:39:09.322 T:10437 NOTICE: CDVDAudioCodecFFmpeg::Open() Successful opened audio decoder ac3 2019-07-12 21:39:09.322 T:10437 NOTICE: Creating audio thread 2019-07-12 21:39:09.323 T:10440 DEBUG: Thread VideoPlayerAudio start, auto delete: false 2019-07-12 21:39:09.323 T:10440 NOTICE: running thread: CVideoPlayerAudio::Process() 2019-07-12 21:39:09.323 T:10440 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_PAUSE: 0 2019-07-12 21:39:09.323 T:10437 DEBUG: CVideoPlayer::SetCaching - caching state 2 2019-07-12 21:39:09.324 T:10437 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 2019-07-12 21:39:09.324 T:10433 DEBUG: OnAVChange: CApplication::OnAVChange 2019-07-12 21:39:09.324 T:10437 DEBUG: CVideoPlayer::HandleMessages - player 1 reported state: 0 2019-07-12 21:39:09.324 T:8334 DEBUG: CAnnouncementManager - Announcement: OnAVChange from xbmc 2019-07-12 21:39:09.324 T:8334 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVChange 2019-07-12 21:39:09.326 T:10437 DEBUG: CDVDDemuxFFmpeg::ParsePacket() fetching extradata, extradata_size(48) 2019-07-12 21:39:09.326 T:10437 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0 2019-07-12 21:39:09.326 T:10437 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 1 2019-07-12 21:39:09.326 T:10437 NOTICE: Opening stream: 0 source: 256 2019-07-12 21:39:09.326 T:10437 NOTICE: Whitelist search for: width: 1920, height: 1080, fps: 50.000, 3D: false 2019-07-12 21:39:09.327 T:10437 DEBUG: Trying to find exact refresh rate 2019-07-12 21:39:09.327 T:10437 DEBUG: No exact whitelisted resolution matched, trying double refresh rate 2019-07-12 21:39:09.327 T:10437 DEBUG: No double whitelisted resolution matched, trying 3:2 pullback 2019-07-12 21:39:09.327 T:10437 DEBUG: No 3:2 pullback refresh rate whitelisted resolution matched, trying current resolution 2019-07-12 21:39:09.327 T:10437 DEBUG: Matched current Resolution 3840x2160 @ 50.000000 - Full Screen (24) 2019-07-12 21:39:09.327 T:10437 NOTICE: Display resolution ADJUST : 3840x2160 @ 50.000000 - Full Screen (24) (weight: 0.000) 2019-07-12 21:39:09.333 T:10440 DEBUG: CDVDAudio::Pause - pausing audio stream 2019-07-12 21:39:09.336 T:10437 NOTICE: Creating video codec with codec id: 27 2019-07-12 21:39:09.337 T:10437 INFO: CBitstreamConverter::Open Invalid avcC 2019-07-12 21:39:09.338 T:10437 NOTICE: CDVDVideoCodecAndroidMediaCodec::Open Testing codec:OMX.Nvidia.mp4.decode 2019-07-12 21:39:09.338 T:10437 NOTICE: CDVDVideoCodecAndroidMediaCodec::Open Testing codec:OMX.Nvidia.h263.decode 2019-07-12 21:39:09.338 T:10437 NOTICE: CDVDVideoCodecAndroidMediaCodec::Open Testing codec:OMX.Nvidia.h264.decode 2019-07-12 21:39:09.344 T:10437 DEBUG: CDVDVideoCodecAndroidMediaCodec::Open m_codecname(OMX.Nvidia.h264.decode), colorFormat(2135033992) 2019-07-12 21:39:09.344 T:10437 DEBUG: CDVDVideoCodecAndroidMediaCodec::Open m_codecname(OMX.Nvidia.h264.decode), colorFormat(21) 2019-07-12 21:39:09.368 T:10437 DEBUG: CDVDVideoCodecAndroidMediaCodec::InjectExtraData 2019-07-12 21:39:09.398 T:10437 DEBUG: CDVDVideoCodecAndroidMediaCodec:: width(1920), height(1080), stride(0), slice-height(0), color-format(0) 2019-07-12 21:39:09.398 T:10437 DEBUG: CDVDVideoCodecAndroidMediaCodec:: crop-left(0), crop-top(0), crop-right(1919), crop-bottom(1079) 2019-07-12 21:39:09.398 T:10437 DEBUG: CDVDVideoCodecAndroidMediaCodec:: Multi-Surface Rendering 2019-07-12 21:39:09.398 T:10437 INFO: CDVDVideoCodecAndroidMediaCodec:: Open Android MediaCodec OMX.Nvidia.h264.decode 2019-07-12 21:39:09.399 T:10437 DEBUG: CDVDVideoCodecAndroidMediaCodec::UpdateFpsDuration fpsRate:50 fpsscale:1, fpsDur:20000 2019-07-12 21:39:09.399 T:10437 DEBUG: CVideoPlayerVideo::OpenStream - open stream with codec id: 27 2019-07-12 21:39:09.399 T:10437 NOTICE: Creating video thread 2019-07-12 21:39:09.399 T:10449 DEBUG: Thread VideoPlayerVideo start, auto delete: false 2019-07-12 21:39:09.399 T:10449 NOTICE: running thread: video_thread 2019-07-12 21:39:09.399 T:10449 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_PAUSE: 0 2019-07-12 21:39:09.400 T:10437 DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: smb://192.168.178.31:445/NAS 3/Videos/HD-Filme 2/Filme/Russendisko.ts 2019-07-12 21:39:09.401 T:10437 NOTICE: Opening stream: 1 source: 256 2019-07-12 21:39:09.402 T:10437 DEBUG: CVideoPlayer::HandleMessages - player 2 reported state: 0 2019-07-12 21:39:09.404 T:10437 DEBUG: CVideoPlayer::SetCaching - caching state 1 2019-07-12 21:39:09.404 T:10449 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback 2019-07-12 21:39:09.404 T:10437 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 2019-07-12 21:39:09.404 T:10440 DEBUG: CDVDAudio::Pause - pausing audio stream 2019-07-12 21:39:09.404 T:10449 DEBUG: CDVDVideoCodecAndroidMediaCodec::AddData current state (2) 2019-07-12 21:39:09.404 T:10437 DEBUG: Previous line repeats 1 times. 2019-07-12 21:39:09.405 T:10437 DEBUG: CVideoPlayer::HandleMessages - player 1 reported state: 0 2019-07-12 21:39:09.416 T:10449 DEBUG: CDVDVideoCodecAndroidMediaCodec::AddData current state (2) 2019-07-12 21:39:09.474 T:10437 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 1 2019-07-12 21:39:09.474 T:10437 NOTICE: Opening stream: 0 source: 256 2019-07-12 21:39:09.474 T:10437 NOTICE: Whitelist search for: width: 1920, height: 1080, fps: 50.000, 3D: false 2019-07-12 21:39:09.475 T:10437 DEBUG: Trying to find exact refresh rate 2019-07-12 21:39:09.475 T:10437 DEBUG: No exact whitelisted resolution matched, trying double refresh rate 2019-07-12 21:39:09.475 T:10437 DEBUG: No double whitelisted resolution matched, trying 3:2 pullback 2019-07-12 21:39:09.475 T:10437 DEBUG: No 3:2 pullback refresh rate whitelisted resolution matched, trying current resolution 2019-07-12 21:39:09.475 T:10437 DEBUG: Matched current Resolution 3840x2160 @ 50.000000 - Full Screen (24) 2019-07-12 21:39:09.475 T:10437 NOTICE: Display resolution ADJUST : 3840x2160 @ 50.000000 - Full Screen (24) (weight: 0.000) 2019-07-12 21:39:09.486 T:10437 NOTICE: Opening stream: 1 source: 256 2019-07-12 21:39:09.486 T:10437 NOTICE: Finding audio codec for: 86019 2019-07-12 21:39:09.487 T:10437 DEBUG: CDVDAudioCodecAndroidMediaCodec::Open codec(86019), profile(-99), tag(6), extrasize(0) 2019-07-12 21:39:09.487 T:10437 INFO: CDVDAudioCodecAndroidMediaCodec::Open() Use default handling for non encrypted stream 2019-07-12 21:39:09.488 T:10437 NOTICE: CDVDAudioCodecFFmpeg::Open() Successful opened audio decoder ac3 2019-07-12 21:39:09.490 T:10437 DEBUG: CVideoPlayer::HandleMessages - player 2 reported state: 0 2019-07-12 21:39:09.496 T:10440 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_PAUSE: 0 2019-07-12 21:39:09.496 T:10440 DEBUG: CDVDAudio::Pause - pausing audio stream 2019-07-12 21:39:09.496 T:10437 DEBUG: CVideoPlayer::HandleMessages - player 1 reported state: 0 2019-07-12 21:39:09.496 T:10432 DEBUG: OnAVChange: CApplication::OnAVChange 2019-07-12 21:39:09.496 T:10440 NOTICE: Creating audio stream (codec id: 86019, channels: 6, sample rate: 48000, no pass-through) 2019-07-12 21:39:09.497 T:8334 DEBUG: CAnnouncementManager - Announcement: OnAVChange from xbmc 2019-07-12 21:39:09.497 T:10440 DEBUG: CVideoPlayerAudio:: synctype set to 1: resample 2019-07-12 21:39:09.497 T:8334 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVChange 2019-07-12 21:39:09.530 T:8344 INFO: CActiveAESink::OpenSink - initialize sink 2019-07-12 21:39:09.530 T:8344 DEBUG: Draining Audio 2019-07-12 21:39:09.531 T:8344 DEBUG: CAESinkAUDIOTRACK::Deinitialize 2019-07-12 21:39:09.532 T:8344 DEBUG: Flushing might not be properly implemented, sleeping: 64 ms 2019-07-12 21:39:09.567 T:10449 DEBUG: CDVDVideoCodecAndroidMediaCodec:: width(1920), height(1080), stride(1920), slice-height(1080), color-format(326) 2019-07-12 21:39:09.567 T:10449 DEBUG: CDVDVideoCodecAndroidMediaCodec:: crop-left(0), crop-top(0), crop-right(1919), crop-bottom(1079) 2019-07-12 21:39:09.567 T:10449 DEBUG: CDVDVideoCodecAndroidMediaCodec:: Multi-Surface Rendering 2019-07-12 21:39:09.569 T:10449 DEBUG: CRenderManager::Configure - change configuration. 1920x1080. display: 1920x1080. framerate: 50.00. 2019-07-12 21:39:09.574 T:8329 DEBUG: DeleteRenderer - deleting renderer 2019-07-12 21:39:09.574 T:8329 DEBUG: LinuxRendererGLES: Cleaning up GLES resources 2019-07-12 21:39:09.584 T:8329 NOTICE: Instancing CRendererMediaCodecSurface 2019-07-12 21:39:09.584 T:8329 NOTICE: CRendererMediaCodecSurface::Configure 2019-07-12 21:39:09.585 T:8329 DEBUG: CRenderManager::Configure - 4 2019-07-12 21:39:09.585 T:10325 DEBUG: OnAVChange: CApplication::OnAVChange 2019-07-12 21:39:09.586 T:8334 DEBUG: CAnnouncementManager - Announcement: OnAVChange from xbmc 2019-07-12 21:39:09.586 T:8334 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVChange 2019-07-12 21:39:09.587 T:10437 DEBUG: CVideoPlayer::HandleMessages - player started 2 2019-07-12 21:39:09.597 T:8344 DEBUG: CAESinkAUDIOTRACK::Deinitialize 2019-07-12 21:39:09.597 T:8344 DEBUG: CActiveAESink::OpenSink - trying to open device AUDIOTRACK:AudioTrack 2019-07-12 21:39:09.597 T:8344 DEBUG: CAESinkAUDIOTRACK::Initialize requested: sampleRate 48000; format: AE_FMT_FLOATP; channels: 2 2019-07-12 21:39:09.597 T:8344 DEBUG: Updated SampleRate: 32000 Distance: 144000 2019-07-12 21:39:09.597 T:8344 DEBUG: Updated SampleRate: 44100 Distance: 35100 2019-07-12 21:39:09.597 T:8344 DEBUG: Updated SampleRate: 48000 Distance: 0 2019-07-12 21:39:09.597 T:8344 NOTICE: Trying to open: samplerate: 48000, channelMask: 12, encoding: 4 2019-07-12 21:39:09.598 T:8344 DEBUG: Minimum size we need for stream: 30800 2019-07-12 21:39:09.598 T:8344 DEBUG: Created Audiotrackbuffer with playing time of 160.416667 ms min buffer size: 61600 bytes 2019-07-12 21:39:09.602 T:8344 NOTICE: CAESinkAUDIOTRACK::Initializing with: m_sampleRate: 48000 format: AE_FMT_FLOAT (AE) method: PCM stream-type: PCM-STREAM min_buffer_size: 61600 m_frames: 3850 m_frameSize: 8 channels: 2 2019-07-12 21:39:09.604 T:8344 DEBUG: CActiveAESink::OpenSink - AUDIOTRACK Initialized: 2019-07-12 21:39:09.605 T:8344 DEBUG: Output Device : android 2019-07-12 21:39:09.605 T:8344 DEBUG: Sample Rate : 48000 2019-07-12 21:39:09.605 T:8344 DEBUG: Sample Format : AE_FMT_FLOAT 2019-07-12 21:39:09.605 T:8344 DEBUG: Channel Count : 2 2019-07-12 21:39:09.605 T:8344 DEBUG: Channel Layout: FL, FR 2019-07-12 21:39:09.605 T:8344 DEBUG: Frames : 3850 2019-07-12 21:39:09.605 T:8344 DEBUG: Frame Size : 8 2019-07-12 21:39:09.608 T:8343 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2019-07-12 21:39:09.613 T:10437 DEBUG: Previous line repeats 1 times. 2019-07-12 21:39:09.613 T:10437 DEBUG: CVideoPlayer::HandleMessages - player started 1 2019-07-12 21:39:09.613 T:10432 DEBUG: OnAVChange: CApplication::OnAVChange 2019-07-12 21:39:09.618 T:10437 DEBUG: VideoPlayer::Sync - Audio - pts: 402544.000000, cache: 320000.022650, totalcache: 760416.686535 2019-07-12 21:39:09.618 T:10437 DEBUG: VideoPlayer::Sync - Video - pts: 0.000000, cache: 50000.000000, totalcache: 100000.000000 2019-07-12 21:39:09.618 T:8334 DEBUG: CAnnouncementManager - Announcement: OnAVChange from xbmc 2019-07-12 21:39:09.618 T:10440 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(-100000.000000), level: 64, cache: 320000.022650 2019-07-12 21:39:09.618 T:10437 DEBUG: CVideoPlayer::SetCaching - caching state 0 2019-07-12 21:39:09.618 T:8334 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVChange 2019-07-12 21:39:09.618 T:10449 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(-100000.000000) 2019-07-12 21:39:09.619 T:10437 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 2019-07-12 21:39:09.619 T:10440 DEBUG: CDVDAudio::Resume - resume audio stream 2019-07-12 21:39:09.619 T:10432 DEBUG: OnAVStarted: CApplication::OnAVStarted 2019-07-12 21:39:09.627 T:8334 DEBUG: CAnnouncementManager - Announcement: OnAVStart from xbmc 2019-07-12 21:39:09.627 T:8343 DEBUG: ActiveAE - start sync of audio stream 2019-07-12 21:39:09.627 T:8329 DEBUG: Activating window ID: 12005 2019-07-12 21:39:09.628 T:8334 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVStart 2019-07-12 21:39:09.628 T:8329 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 2019-07-12 21:39:09.629 T:8329 DEBUG: FreeVisualisation() done 2019-07-12 21:39:09.631 T:8329 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 2019-07-12 21:39:09.631 T:8329 NOTICE: Whitelist search for: width: 1920, height: 1080, fps: 50.000, 3D: false 2019-07-12 21:39:09.631 T:8329 DEBUG: Trying to find exact refresh rate 2019-07-12 21:39:09.631 T:8329 DEBUG: No exact whitelisted resolution matched, trying double refresh rate 2019-07-12 21:39:09.631 T:8329 DEBUG: No double whitelisted resolution matched, trying 3:2 pullback 2019-07-12 21:39:09.632 T:8329 DEBUG: No 3:2 pullback refresh rate whitelisted resolution matched, trying current resolution 2019-07-12 21:39:09.632 T:8329 DEBUG: Matched current Resolution 3840x2160 @ 50.000000 - Full Screen (24) 2019-07-12 21:39:09.632 T:8329 NOTICE: Display resolution ADJUST : 3840x2160 @ 50.000000 - Full Screen (24) (weight: 2156274380903022592.000) 2019-07-12 21:39:09.632 T:10325 DEBUG: OnAVChange: CApplication::OnAVChange 2019-07-12 21:39:09.632 T:8334 DEBUG: CAnnouncementManager - Announcement: OnAVChange from xbmc 2019-07-12 21:39:09.633 T:8334 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnAVChange 2019-07-12 21:39:09.652 T:8329 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2019-07-12 21:39:09.740 T:8343 DEBUG: ActiveAE::SyncStream - average error of 98.417972, start adjusting 2019-07-12 21:39:09.740 T:8343 DEBUG: ActiveAE::SyncStream - average error 18.417972 below threshold of 30.000000 2019-07-12 21:39:09.752 T:8329 DEBUG: Inhibiting OS screen saver 2019-07-12 21:39:11.670 T:10449 DEBUG: CPtsTracker: detected pattern of length 1: 20000.00, frameduration: 20000.000000 2019-07-12 21:39:13.900 T:8343 DEBUG: ActiveAE::SyncStream - average error -520.718657 above threshold of 200.000000 2019-07-12 21:39:14.092 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.010323 below threshold of 30.000000 2019-07-12 21:39:15.116 T:8343 DEBUG: ActiveAE::SyncStream - average error -290.296629 above threshold of 200.000000 2019-07-12 21:39:15.212 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.004962 below threshold of 30.000000 2019-07-12 21:39:16.300 T:8343 DEBUG: ActiveAE::SyncStream - average error -243.118266 above threshold of 200.000000 2019-07-12 21:39:16.300 T:8343 DEBUG: ActiveAE::SyncStream - average error -2.493266 below threshold of 30.000000 2019-07-12 21:39:17.312 T:8343 DEBUG: ActiveAE::SyncStream - average error -213.460311 above threshold of 200.000000 2019-07-12 21:39:17.312 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.001977 below threshold of 30.000000 2019-07-12 21:39:18.396 T:8343 DEBUG: ActiveAE::SyncStream - average error -211.060714 above threshold of 200.000000 2019-07-12 21:39:18.396 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.019047 below threshold of 30.000000 2019-07-12 21:39:19.484 T:8343 DEBUG: ActiveAE::SyncStream - average error -217.913470 above threshold of 200.000000 2019-07-12 21:39:19.484 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.017636 below threshold of 30.000000 2019-07-12 21:39:20.571 T:8343 DEBUG: ActiveAE::SyncStream - average error -214.585945 above threshold of 200.000000 2019-07-12 21:39:20.572 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.002612 below threshold of 30.000000 2019-07-12 21:39:21.584 T:8343 DEBUG: ActiveAE::SyncStream - average error -204.820167 above threshold of 200.000000 2019-07-12 21:39:21.584 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.007667 below threshold of 30.000000 2019-07-12 21:39:22.667 T:8343 DEBUG: ActiveAE::SyncStream - average error -214.847220 above threshold of 200.000000 2019-07-12 21:39:22.668 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.013886 below threshold of 30.000000 2019-07-12 21:39:23.755 T:8343 DEBUG: ActiveAE::SyncStream - average error -216.109066 above threshold of 200.000000 2019-07-12 21:39:23.756 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.004900 below threshold of 30.000000 2019-07-12 21:39:24.843 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.090845 above threshold of 200.000000 2019-07-12 21:39:24.844 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.007511 below threshold of 30.000000 2019-07-12 21:39:25.931 T:8343 DEBUG: ActiveAE::SyncStream - average error -209.058055 above threshold of 200.000000 2019-07-12 21:39:25.932 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.016388 below threshold of 30.000000 2019-07-12 21:39:26.944 T:8343 DEBUG: ActiveAE::SyncStream - average error -210.170264 above threshold of 200.000000 2019-07-12 21:39:26.944 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.003598 below threshold of 30.000000 2019-07-12 21:39:28.027 T:8343 DEBUG: ActiveAE::SyncStream - average error -214.800421 above threshold of 200.000000 2019-07-12 21:39:28.028 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.008755 below threshold of 30.000000 2019-07-12 21:39:29.115 T:8343 DEBUG: ActiveAE::SyncStream - average error -214.999272 above threshold of 200.000000 2019-07-12 21:39:29.115 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.020106 below threshold of 30.000000 2019-07-12 21:39:30.203 T:8343 DEBUG: ActiveAE::SyncStream - average error -214.571410 above threshold of 200.000000 2019-07-12 21:39:30.203 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.008910 below threshold of 30.000000 2019-07-12 21:39:31.216 T:8343 DEBUG: ActiveAE::SyncStream - average error -205.094011 above threshold of 200.000000 2019-07-12 21:39:31.216 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.010678 below threshold of 30.000000 2019-07-12 21:39:32.299 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.100408 above threshold of 200.000000 2019-07-12 21:39:32.299 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.017074 below threshold of 30.000000 2019-07-12 21:39:33.387 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.454212 above threshold of 200.000000 2019-07-12 21:39:33.387 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.016712 below threshold of 30.000000 2019-07-12 21:39:34.475 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.269477 above threshold of 200.000000 2019-07-12 21:39:34.475 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.019477 below threshold of 30.000000 2019-07-12 21:39:38.571 T:8343 DEBUG: ActiveAE::SyncStream - average error -532.983819 above threshold of 200.000000 2019-07-12 21:39:38.667 T:8343 WARNING: ActiveAE - large audio sync error: -90023.425157 2019-07-12 21:39:38.668 T:8343 WARNING: ActiveAE - large audio sync error: -90018.422604 2019-07-12 21:39:38.763 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.004653 below threshold of 30.000000 2019-07-12 21:39:39.632 T:10433 DEBUG: Thread JobWorker 10433 terminating (autodelete) 2019-07-12 21:39:39.632 T:10432 DEBUG: Thread JobWorker 10432 terminating (autodelete) 2019-07-12 21:39:39.634 T:10325 DEBUG: Thread JobWorker 10325 terminating (autodelete) 2019-07-12 21:39:39.771 T:8343 DEBUG: ActiveAE::SyncStream - average error -249.302157 above threshold of 200.000000 2019-07-12 21:39:39.771 T:8343 DEBUG: ActiveAE::SyncStream - average error -8.677157 below threshold of 30.000000 2019-07-12 21:39:40.859 T:8343 DEBUG: ActiveAE::SyncStream - average error -242.856057 above threshold of 200.000000 2019-07-12 21:39:40.859 T:8343 DEBUG: ActiveAE::SyncStream - average error -2.231057 below threshold of 30.000000 2019-07-12 21:39:41.867 T:8343 DEBUG: ActiveAE::SyncStream - average error -201.275436 above threshold of 200.000000 2019-07-12 21:39:41.867 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.004603 below threshold of 30.000000 2019-07-12 21:39:42.955 T:8343 DEBUG: ActiveAE::SyncStream - average error -217.562964 above threshold of 200.000000 2019-07-12 21:39:42.956 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.000464 below threshold of 30.000000 2019-07-12 21:39:44.043 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.777070 above threshold of 200.000000 2019-07-12 21:39:44.043 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.006236 below threshold of 30.000000 2019-07-12 21:39:48.139 T:8343 DEBUG: ActiveAE::SyncStream - average error -532.234611 above threshold of 200.000000 2019-07-12 21:39:48.331 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.005444 below threshold of 30.000000 2019-07-12 21:39:49.339 T:8343 DEBUG: ActiveAE::SyncStream - average error -248.331165 above threshold of 200.000000 2019-07-12 21:39:49.339 T:8343 DEBUG: ActiveAE::SyncStream - average error -7.706165 below threshold of 30.000000 2019-07-12 21:39:50.427 T:8343 DEBUG: ActiveAE::SyncStream - average error -239.651022 above threshold of 200.000000 2019-07-12 21:39:50.427 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.005188 below threshold of 30.000000 2019-07-12 21:39:51.435 T:8343 DEBUG: ActiveAE::SyncStream - average error -203.123887 above threshold of 200.000000 2019-07-12 21:39:51.435 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.019720 below threshold of 30.000000 2019-07-12 21:39:52.523 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.210545 above threshold of 200.000000 2019-07-12 21:39:52.523 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.002212 below threshold of 30.000000 2019-07-12 21:39:53.611 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.830169 above threshold of 200.000000 2019-07-12 21:39:53.611 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.017669 below threshold of 30.000000 2019-07-12 21:39:57.707 T:8343 DEBUG: ActiveAE::SyncStream - average error -532.985905 above threshold of 200.000000 2019-07-12 21:39:57.899 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.006738 below threshold of 30.000000 2019-07-12 21:39:58.907 T:8343 DEBUG: ActiveAE::SyncStream - average error -238.625130 above threshold of 200.000000 2019-07-12 21:39:58.907 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.000130 below threshold of 30.000000 2019-07-12 21:39:59.995 T:8343 DEBUG: ActiveAE::SyncStream - average error -230.711748 above threshold of 200.000000 2019-07-12 21:39:59.995 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.003414 below threshold of 30.000000 2019-07-12 21:40:01.003 T:8343 DEBUG: ActiveAE::SyncStream - average error -202.270428 above threshold of 200.000000 2019-07-12 21:40:01.003 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.020428 below threshold of 30.000000 2019-07-12 21:40:02.091 T:8343 DEBUG: ActiveAE::SyncStream - average error -217.341400 above threshold of 200.000000 2019-07-12 21:40:02.091 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.008067 below threshold of 30.000000 2019-07-12 21:40:03.179 T:8343 DEBUG: ActiveAE::SyncStream - average error -216.018352 above threshold of 200.000000 2019-07-12 21:40:03.179 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.018352 below threshold of 30.000000 2019-07-12 21:40:07.275 T:8343 DEBUG: ActiveAE::SyncStream - average error -532.666931 above threshold of 200.000000 2019-07-12 21:40:07.371 T:8343 WARNING: ActiveAE - large audio sync error: -90027.173849 2019-07-12 21:40:07.371 T:8343 WARNING: ActiveAE - large audio sync error: -90015.173484 2019-07-12 21:40:07.467 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.000264 below threshold of 30.000000 2019-07-12 21:40:08.491 T:8343 DEBUG: ActiveAE::SyncStream - average error -255.099939 above threshold of 200.000000 2019-07-12 21:40:08.491 T:8343 DEBUG: ActiveAE::SyncStream - average error -14.474939 below threshold of 30.000000 2019-07-12 21:40:09.579 T:8343 DEBUG: ActiveAE::SyncStream - average error -249.749080 above threshold of 200.000000 2019-07-12 21:40:09.579 T:8343 DEBUG: ActiveAE::SyncStream - average error -9.124080 below threshold of 30.000000 2019-07-12 21:40:10.587 T:8343 DEBUG: ActiveAE::SyncStream - average error -206.495776 above threshold of 200.000000 2019-07-12 21:40:10.587 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.016609 below threshold of 30.000000 2019-07-12 21:40:11.675 T:8343 DEBUG: ActiveAE::SyncStream - average error -220.032344 above threshold of 200.000000 2019-07-12 21:40:11.675 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.011510 below threshold of 30.000000 2019-07-12 21:40:15.771 T:8343 DEBUG: ActiveAE::SyncStream - average error -532.905973 above threshold of 200.000000 2019-07-12 21:40:15.963 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.010139 below threshold of 30.000000 2019-07-12 21:40:16.987 T:8343 DEBUG: ActiveAE::SyncStream - average error -254.838931 above threshold of 200.000000 2019-07-12 21:40:16.987 T:8343 DEBUG: ActiveAE::SyncStream - average error -14.213931 below threshold of 30.000000 2019-07-12 21:40:18.075 T:8343 DEBUG: ActiveAE::SyncStream - average error -249.347891 above threshold of 200.000000 2019-07-12 21:40:18.075 T:8343 DEBUG: ActiveAE::SyncStream - average error -8.722891 below threshold of 30.000000 2019-07-12 21:40:19.082 T:8343 DEBUG: ActiveAE::SyncStream - average error -205.856809 above threshold of 200.000000 2019-07-12 21:40:19.083 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.002642 below threshold of 30.000000 2019-07-12 21:40:20.170 T:8343 DEBUG: ActiveAE::SyncStream - average error -220.564755 above threshold of 200.000000 2019-07-12 21:40:20.171 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.002255 below threshold of 30.000000 2019-07-12 21:40:21.259 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.363161 above threshold of 200.000000 2019-07-12 21:40:21.259 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.008995 below threshold of 30.000000 2019-07-12 21:40:22.271 T:8343 DEBUG: ActiveAE::SyncStream - average error -204.246201 above threshold of 200.000000 2019-07-12 21:40:22.271 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.017035 below threshold of 30.000000 2019-07-12 21:40:23.354 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.825825 above threshold of 200.000000 2019-07-12 21:40:23.355 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.013325 below threshold of 30.000000 2019-07-12 21:40:24.442 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.273727 above threshold of 200.000000 2019-07-12 21:40:24.443 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.002894 below threshold of 30.000000 2019-07-12 21:40:25.530 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.257901 above threshold of 200.000000 2019-07-12 21:40:25.531 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.007901 below threshold of 30.000000 2019-07-12 21:40:26.543 T:8343 DEBUG: ActiveAE::SyncStream - average error -203.901356 above threshold of 200.000000 2019-07-12 21:40:26.543 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.005523 below threshold of 30.000000 2019-07-12 21:40:27.610 T:8343 DEBUG: ActiveAE::SyncStream - average error -213.613247 above threshold of 200.000000 2019-07-12 21:40:27.611 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.009080 below threshold of 30.000000 2019-07-12 21:40:31.674 T:8343 DEBUG: ActiveAE::SyncStream - average error -536.093800 above threshold of 200.000000 2019-07-12 21:40:31.692 T:8343 WARNING: ActiveAE - large audio sync error: -89972.374498 2019-07-12 21:40:31.693 T:8343 WARNING: ActiveAE - large audio sync error: -89971.373092 2019-07-12 21:40:31.786 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.010467 below threshold of 30.000000 2019-07-12 21:40:32.874 T:8343 DEBUG: ActiveAE::SyncStream - average error -233.656007 above threshold of 200.000000 2019-07-12 21:40:32.875 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.010174 below threshold of 30.000000 2019-07-12 21:40:33.882 T:8343 DEBUG: ActiveAE::SyncStream - average error -227.862094 above threshold of 200.000000 2019-07-12 21:40:33.882 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.007928 below threshold of 30.000000 2019-07-12 21:40:34.971 T:8343 DEBUG: ActiveAE::SyncStream - average error -219.341174 above threshold of 200.000000 2019-07-12 21:40:34.974 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.007841 below threshold of 30.000000 2019-07-12 21:40:35.983 T:8343 DEBUG: ActiveAE::SyncStream - average error -203.986353 above threshold of 200.000000 2019-07-12 21:40:35.983 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.007186 below threshold of 30.000000 2019-07-12 21:40:37.066 T:8343 DEBUG: ActiveAE::SyncStream - average error -214.988790 above threshold of 200.000000 2019-07-12 21:40:37.066 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.009623 below threshold of 30.000000 2019-07-12 21:40:38.154 T:8343 DEBUG: ActiveAE::SyncStream - average error -216.226168 above threshold of 200.000000 2019-07-12 21:40:38.154 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.017834 below threshold of 30.000000 2019-07-12 21:40:39.242 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.565247 above threshold of 200.000000 2019-07-12 21:40:39.242 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.002747 below threshold of 30.000000 2019-07-12 21:40:40.330 T:8343 DEBUG: ActiveAE::SyncStream - average error -209.685349 above threshold of 200.000000 2019-07-12 21:40:40.330 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.018682 below threshold of 30.000000 2019-07-12 21:40:41.342 T:8343 DEBUG: ActiveAE::SyncStream - average error -208.369552 above threshold of 200.000000 2019-07-12 21:40:41.343 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.015386 below threshold of 30.000000 2019-07-12 21:40:42.426 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.921704 above threshold of 200.000000 2019-07-12 21:40:42.426 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.005038 below threshold of 30.000000 2019-07-12 21:40:43.514 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.728495 above threshold of 200.000000 2019-07-12 21:40:43.514 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.020162 below threshold of 30.000000 2019-07-12 21:40:44.602 T:8343 DEBUG: ActiveAE::SyncStream - average error -212.958441 above threshold of 200.000000 2019-07-12 21:40:44.602 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.000108 below threshold of 30.000000 2019-07-12 21:40:45.614 T:8343 DEBUG: ActiveAE::SyncStream - average error -205.466878 above threshold of 200.000000 2019-07-12 21:40:45.616 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.008545 below threshold of 30.000000 2019-07-12 21:40:46.682 T:8343 DEBUG: ActiveAE::SyncStream - average error -214.799556 above threshold of 200.000000 2019-07-12 21:40:46.684 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.007889 below threshold of 30.000000 2019-07-12 21:40:50.746 T:8343 DEBUG: ActiveAE::SyncStream - average error -540.063837 above threshold of 200.000000 2019-07-12 21:40:50.764 T:8343 WARNING: ActiveAE - large audio sync error: -89982.807459 2019-07-12 21:40:50.765 T:8343 WARNING: ActiveAE - large audio sync error: -89978.805428 2019-07-12 21:40:50.858 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.001337 below threshold of 30.000000 2019-07-12 21:40:51.946 T:8343 DEBUG: ActiveAE::SyncStream - average error -240.603398 above threshold of 200.000000 2019-07-12 21:40:51.946 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.020064 below threshold of 30.000000 2019-07-12 21:40:52.954 T:8343 DEBUG: ActiveAE::SyncStream - average error -228.489825 above threshold of 200.000000 2019-07-12 21:40:52.954 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.010658 below threshold of 30.000000 2019-07-12 21:40:54.042 T:8343 DEBUG: ActiveAE::SyncStream - average error -218.389511 above threshold of 200.000000 2019-07-12 21:40:54.042 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.014511 below threshold of 30.000000 2019-07-12 21:40:55.054 T:8343 DEBUG: ActiveAE::SyncStream - average error -204.381386 above threshold of 200.000000 2019-07-12 21:40:55.054 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.006386 below threshold of 30.000000 2019-07-12 21:40:56.138 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.526970 above threshold of 200.000000 2019-07-12 21:40:56.138 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.006137 below threshold of 30.000000 2019-07-12 21:40:57.226 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.767123 above threshold of 200.000000 2019-07-12 21:40:57.226 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.017123 below threshold of 30.000000 2019-07-12 21:40:58.314 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.318706 above threshold of 200.000000 2019-07-12 21:40:58.314 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.006206 below threshold of 30.000000 2019-07-12 21:40:59.326 T:8343 DEBUG: ActiveAE::SyncStream - average error -203.560307 above threshold of 200.000000 2019-07-12 21:40:59.326 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.018640 below threshold of 30.000000 2019-07-12 21:41:00.394 T:8343 DEBUG: ActiveAE::SyncStream - average error -213.771968 above threshold of 200.000000 2019-07-12 21:41:00.394 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.001134 below threshold of 30.000000 2019-07-12 21:41:04.458 T:8343 DEBUG: ActiveAE::SyncStream - average error -535.935923 above threshold of 200.000000 2019-07-12 21:41:04.476 T:8343 WARNING: ActiveAE - large audio sync error: -89980.815657 2019-07-12 21:41:04.476 T:8343 WARNING: ActiveAE - large audio sync error: -89970.814043 2019-07-12 21:41:04.570 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.019256 below threshold of 30.000000 2019-07-12 21:41:05.658 T:8343 DEBUG: ActiveAE::SyncStream - average error -241.496142 above threshold of 200.000000 2019-07-12 21:41:05.658 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.871142 below threshold of 30.000000 2019-07-12 21:41:06.666 T:8343 DEBUG: ActiveAE::SyncStream - average error -232.477680 above threshold of 200.000000 2019-07-12 21:41:06.666 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.019346 below threshold of 30.000000 2019-07-12 21:41:07.754 T:8343 DEBUG: ActiveAE::SyncStream - average error -214.680338 above threshold of 200.000000 2019-07-12 21:41:07.754 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.013672 below threshold of 30.000000 2019-07-12 21:41:08.766 T:8343 DEBUG: ActiveAE::SyncStream - average error -205.451314 above threshold of 200.000000 2019-07-12 21:41:08.767 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.013814 below threshold of 30.000000 2019-07-12 21:41:09.834 T:8343 DEBUG: ActiveAE::SyncStream - average error -212.996751 above threshold of 200.000000 2019-07-12 21:41:09.834 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.017584 below threshold of 30.000000 2019-07-12 21:41:13.898 T:8343 DEBUG: ActiveAE::SyncStream - average error -540.223381 above threshold of 200.000000 2019-07-12 21:41:14.010 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.015047 below threshold of 30.000000 2019-07-12 21:41:15.098 T:8343 DEBUG: ActiveAE::SyncStream - average error -250.801478 above threshold of 200.000000 2019-07-12 21:41:15.098 T:8343 DEBUG: ActiveAE::SyncStream - average error -10.176478 below threshold of 30.000000 2019-07-12 21:41:16.106 T:8343 DEBUG: ActiveAE::SyncStream - average error -240.499411 above threshold of 200.000000 2019-07-12 21:41:16.106 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.020244 below threshold of 30.000000 2019-07-12 21:41:17.194 T:8343 DEBUG: ActiveAE::SyncStream - average error -214.692279 above threshold of 200.000000 2019-07-12 21:41:17.194 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.004779 below threshold of 30.000000 2019-07-12 21:41:18.206 T:8343 DEBUG: ActiveAE::SyncStream - average error -205.846859 above threshold of 200.000000 2019-07-12 21:41:18.206 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.013525 below threshold of 30.000000 2019-07-12 21:41:19.290 T:8343 DEBUG: ActiveAE::SyncStream - average error -214.591884 above threshold of 200.000000 2019-07-12 21:41:19.290 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.008551 below threshold of 30.000000 2019-07-12 21:41:20.378 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.802624 above threshold of 200.000000 2019-07-12 21:41:20.378 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.010957 below threshold of 30.000000 2019-07-12 21:41:21.466 T:8343 DEBUG: ActiveAE::SyncStream - average error -214.451618 above threshold of 200.000000 2019-07-12 21:41:21.466 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.014118 below threshold of 30.000000 2019-07-12 21:41:22.284 T:8329 DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0 2019-07-12 21:41:22.367 T:8329 DEBUG: Previous line repeats 1 times. 2019-07-12 21:41:22.368 T:8329 DEBUG: HandleKey: return (0xf00d) pressed, action is OSD 2019-07-12 21:41:22.368 T:8329 DEBUG: ------ Window Init (VideoOSD.xml) ------ 2019-07-12 21:41:22.376 T:8329 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 2019-07-12 21:41:22.377 T:8329 DEBUG: ------ Window Init (Custom_1109_TopBarOverlay.xml) ------ 2019-07-12 21:41:22.478 T:8343 DEBUG: ActiveAE::SyncStream - average error -205.512134 above threshold of 200.000000 2019-07-12 21:41:22.478 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.012134 below threshold of 30.000000 2019-07-12 21:41:23.545 T:8343 DEBUG: ActiveAE::SyncStream - average error -213.662985 above threshold of 200.000000 2019-07-12 21:41:23.546 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.017152 below threshold of 30.000000 2019-07-12 21:41:27.625 T:8343 DEBUG: ActiveAE::SyncStream - average error -537.849412 above threshold of 200.000000 2019-07-12 21:41:27.817 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.016079 below threshold of 30.000000 2019-07-12 21:41:28.825 T:8343 DEBUG: ActiveAE::SyncStream - average error -241.500079 above threshold of 200.000000 2019-07-12 21:41:28.826 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.875079 below threshold of 30.000000 2019-07-12 21:41:29.913 T:8343 DEBUG: ActiveAE::SyncStream - average error -232.294871 above threshold of 200.000000 2019-07-12 21:41:29.914 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.003205 below threshold of 30.000000 2019-07-12 21:41:30.921 T:8343 DEBUG: ActiveAE::SyncStream - average error -201.670065 above threshold of 200.000000 2019-07-12 21:41:30.922 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.003399 below threshold of 30.000000 2019-07-12 21:41:32.009 T:8343 DEBUG: ActiveAE::SyncStream - average error -220.636666 above threshold of 200.000000 2019-07-12 21:41:32.010 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.011666 below threshold of 30.000000 2019-07-12 21:41:33.097 T:8343 DEBUG: ActiveAE::SyncStream - average error -211.376174 above threshold of 200.000000 2019-07-12 21:41:33.098 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.001174 below threshold of 30.000000 2019-07-12 21:41:37.193 T:8343 DEBUG: ActiveAE::SyncStream - average error -534.126877 above threshold of 200.000000 2019-07-12 21:41:37.289 T:8343 WARNING: ActiveAE - large audio sync error: -90019.294799 2019-07-12 21:41:37.290 T:8343 WARNING: ActiveAE - large audio sync error: -90016.293498 2019-07-12 21:41:37.385 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.001877 below threshold of 30.000000 2019-07-12 21:41:38.393 T:8343 DEBUG: ActiveAE::SyncStream - average error -245.447723 above threshold of 200.000000 2019-07-12 21:41:38.393 T:8343 DEBUG: ActiveAE::SyncStream - average error -4.822723 below threshold of 30.000000 2019-07-12 21:41:39.481 T:8343 DEBUG: ActiveAE::SyncStream - average error -237.498669 above threshold of 200.000000 2019-07-12 21:41:39.481 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.019503 below threshold of 30.000000 2019-07-12 21:41:40.489 T:8343 DEBUG: ActiveAE::SyncStream - average error -201.067196 above threshold of 200.000000 2019-07-12 21:41:40.489 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.004696 below threshold of 30.000000 2019-07-12 21:41:41.577 T:8343 DEBUG: ActiveAE::SyncStream - average error -219.453502 above threshold of 200.000000 2019-07-12 21:41:41.577 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.016002 below threshold of 30.000000 2019-07-12 21:41:42.665 T:8343 DEBUG: ActiveAE::SyncStream - average error -211.220357 above threshold of 200.000000 2019-07-12 21:41:42.665 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.012023 below threshold of 30.000000 2019-07-12 21:41:46.761 T:8343 DEBUG: ActiveAE::SyncStream - average error -534.036956 above threshold of 200.000000 2019-07-12 21:41:46.953 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.016122 below threshold of 30.000000 2019-07-12 21:41:47.961 T:8343 DEBUG: ActiveAE::SyncStream - average error -239.114372 above threshold of 200.000000 2019-07-12 21:41:47.961 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.010205 below threshold of 30.000000 2019-07-12 21:41:49.049 T:8343 DEBUG: ActiveAE::SyncStream - average error -230.553022 above threshold of 200.000000 2019-07-12 21:41:49.050 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.011355 below threshold of 30.000000 2019-07-12 21:41:50.057 T:8343 DEBUG: ActiveAE::SyncStream - average error -202.586315 above threshold of 200.000000 2019-07-12 21:41:50.057 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.002981 below threshold of 30.000000 2019-07-12 21:41:51.145 T:8343 DEBUG: ActiveAE::SyncStream - average error -220.718841 above threshold of 200.000000 2019-07-12 21:41:51.145 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.010508 below threshold of 30.000000 2019-07-12 21:41:52.233 T:8343 DEBUG: ActiveAE::SyncStream - average error -211.167699 above threshold of 200.000000 2019-07-12 21:41:52.233 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.001032 below threshold of 30.000000 2019-07-12 21:41:56.329 T:8343 DEBUG: ActiveAE::SyncStream - average error -533.990543 above threshold of 200.000000 2019-07-12 21:41:56.425 T:8343 WARNING: ActiveAE - large audio sync error: -90019.824079 2019-07-12 21:41:56.425 T:8343 WARNING: ActiveAE - large audio sync error: -90016.823610 2019-07-12 21:41:56.521 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.011377 below threshold of 30.000000 2019-07-12 21:41:57.529 T:8343 DEBUG: ActiveAE::SyncStream - average error -245.945471 above threshold of 200.000000 2019-07-12 21:41:57.529 T:8343 DEBUG: ActiveAE::SyncStream - average error -5.320471 below threshold of 30.000000 2019-07-12 21:41:58.617 T:8343 DEBUG: ActiveAE::SyncStream - average error -239.119068 above threshold of 200.000000 2019-07-12 21:41:58.617 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.014901 below threshold of 30.000000 2019-07-12 21:42:02.697 T:8343 DEBUG: ActiveAE::SyncStream - average error -538.221278 above threshold of 200.000000 2019-07-12 21:42:02.793 T:8343 WARNING: ActiveAE - large audio sync error: -90033.261679 2019-07-12 21:42:02.793 T:8343 WARNING: ActiveAE - large audio sync error: -90020.260585 2019-07-12 21:42:02.811 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.012945 below threshold of 30.000000 2019-07-12 21:42:03.897 T:8343 DEBUG: ActiveAE::SyncStream - average error -241.529659 above threshold of 200.000000 2019-07-12 21:42:03.897 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.904659 below threshold of 30.000000 2019-07-12 21:42:04.985 T:8343 DEBUG: ActiveAE::SyncStream - average error -244.642612 above threshold of 200.000000 2019-07-12 21:42:04.985 T:8343 DEBUG: ActiveAE::SyncStream - average error -4.017612 below threshold of 30.000000 2019-07-12 21:42:05.993 T:8343 DEBUG: ActiveAE::SyncStream - average error -201.601911 above threshold of 200.000000 2019-07-12 21:42:05.993 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.018578 below threshold of 30.000000 2019-07-12 21:42:07.081 T:8343 DEBUG: ActiveAE::SyncStream - average error -222.863280 above threshold of 200.000000 2019-07-12 21:42:07.081 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.009114 below threshold of 30.000000 2019-07-12 21:42:08.169 T:8343 DEBUG: ActiveAE::SyncStream - average error -212.471142 above threshold of 200.000000 2019-07-12 21:42:08.169 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.012808 below threshold of 30.000000 2019-07-12 21:42:09.181 T:8343 DEBUG: ActiveAE::SyncStream - average error -205.368659 above threshold of 200.000000 2019-07-12 21:42:09.183 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.014492 below threshold of 30.000000 2019-07-12 21:42:10.249 T:8343 DEBUG: ActiveAE::SyncStream - average error -214.684719 above threshold of 200.000000 2019-07-12 21:42:10.249 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.018052 below threshold of 30.000000 2019-07-12 21:42:14.313 T:8343 DEBUG: ActiveAE::SyncStream - average error -539.720260 above threshold of 200.000000 2019-07-12 21:42:14.425 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.011926 below threshold of 30.000000 2019-07-12 21:42:15.513 T:8343 DEBUG: ActiveAE::SyncStream - average error -239.812350 above threshold of 200.000000 2019-07-12 21:42:15.513 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.020683 below threshold of 30.000000 2019-07-12 21:42:16.521 T:8343 DEBUG: ActiveAE::SyncStream - average error -228.253515 above threshold of 200.000000 2019-07-12 21:42:16.523 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.003515 below threshold of 30.000000 2019-07-12 21:42:17.609 T:8343 DEBUG: ActiveAE::SyncStream - average error -218.607632 above threshold of 200.000000 2019-07-12 21:42:17.609 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.003466 below threshold of 30.000000 2019-07-12 21:42:18.621 T:8343 DEBUG: ActiveAE::SyncStream - average error -204.404204 above threshold of 200.000000 2019-07-12 21:42:18.621 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.008371 below threshold of 30.000000 2019-07-12 21:42:19.705 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.532109 above threshold of 200.000000 2019-07-12 21:42:19.705 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.011275 below threshold of 30.000000 2019-07-12 21:42:20.793 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.773702 above threshold of 200.000000 2019-07-12 21:42:20.793 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.002869 below threshold of 30.000000 2019-07-12 21:42:21.881 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.525187 above threshold of 200.000000 2019-07-12 21:42:21.881 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.004353 below threshold of 30.000000 2019-07-12 21:42:22.893 T:8343 DEBUG: ActiveAE::SyncStream - average error -203.404159 above threshold of 200.000000 2019-07-12 21:42:22.893 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.008326 below threshold of 30.000000 2019-07-12 21:42:23.960 T:8343 DEBUG: ActiveAE::SyncStream - average error -213.708417 above threshold of 200.000000 2019-07-12 21:42:23.961 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.000084 below threshold of 30.000000 2019-07-12 21:42:28.024 T:8343 DEBUG: ActiveAE::SyncStream - average error -536.120068 above threshold of 200.000000 2019-07-12 21:42:28.043 T:8343 WARNING: ActiveAE - large audio sync error: -89983.127646 2019-07-12 21:42:28.043 T:8343 WARNING: ActiveAE - large audio sync error: -89971.126916 2019-07-12 21:42:28.136 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.015901 below threshold of 30.000000 2019-07-12 21:42:29.224 T:8343 DEBUG: ActiveAE::SyncStream - average error -245.620388 above threshold of 200.000000 2019-07-12 21:42:29.225 T:8343 DEBUG: ActiveAE::SyncStream - average error -4.995388 below threshold of 30.000000 2019-07-12 21:42:30.232 T:8343 DEBUG: ActiveAE::SyncStream - average error -234.468314 above threshold of 200.000000 2019-07-12 21:42:30.233 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.009981 below threshold of 30.000000 2019-07-12 21:42:31.320 T:8343 DEBUG: ActiveAE::SyncStream - average error -214.705397 above threshold of 200.000000 2019-07-12 21:42:31.321 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.017897 below threshold of 30.000000 2019-07-12 21:42:32.333 T:8343 DEBUG: ActiveAE::SyncStream - average error -205.540191 above threshold of 200.000000 2019-07-12 21:42:32.333 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.019358 below threshold of 30.000000 2019-07-12 21:42:33.416 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.151524 above threshold of 200.000000 2019-07-12 21:42:33.417 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.005690 below threshold of 30.000000 2019-07-12 21:42:34.507 T:8343 DEBUG: ActiveAE::SyncStream - average error -218.366747 above threshold of 200.000000 2019-07-12 21:42:34.507 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.012580 below threshold of 30.000000 2019-07-12 21:42:35.595 T:8343 DEBUG: ActiveAE::SyncStream - average error -216.054474 above threshold of 200.000000 2019-07-12 21:42:35.595 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.012807 below threshold of 30.000000 2019-07-12 21:42:36.683 T:8343 DEBUG: ActiveAE::SyncStream - average error -208.431949 above threshold of 200.000000 2019-07-12 21:42:36.683 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.015283 below threshold of 30.000000 2019-07-12 21:42:37.695 T:8343 DEBUG: ActiveAE::SyncStream - average error -210.109385 above threshold of 200.000000 2019-07-12 21:42:37.696 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.005218 below threshold of 30.000000 2019-07-12 21:42:38.779 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.626253 above threshold of 200.000000 2019-07-12 21:42:38.780 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.001253 below threshold of 30.000000 2019-07-12 21:42:39.867 T:8343 DEBUG: ActiveAE::SyncStream - average error -213.235337 above threshold of 200.000000 2019-07-12 21:42:39.867 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.006171 below threshold of 30.000000 2019-07-12 21:42:40.955 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.599398 above threshold of 200.000000 2019-07-12 21:42:40.955 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.016064 below threshold of 30.000000 2019-07-12 21:42:41.967 T:8343 DEBUG: ActiveAE::SyncStream - average error -205.682042 above threshold of 200.000000 2019-07-12 21:42:41.967 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.015376 below threshold of 30.000000 2019-07-12 21:42:43.051 T:8343 DEBUG: ActiveAE::SyncStream - average error -214.364009 above threshold of 200.000000 2019-07-12 21:42:43.051 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.009842 below threshold of 30.000000 2019-07-12 21:42:44.139 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.987269 above threshold of 200.000000 2019-07-12 21:42:44.139 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.008102 below threshold of 30.000000 2019-07-12 21:42:45.227 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.187047 above threshold of 200.000000 2019-07-12 21:42:45.227 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.020381 below threshold of 30.000000 2019-07-12 21:42:49.323 T:8343 DEBUG: ActiveAE::SyncStream - average error -532.809598 above threshold of 200.000000 2019-07-12 21:42:49.515 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.017931 below threshold of 30.000000 2019-07-12 21:42:50.539 T:8343 DEBUG: ActiveAE::SyncStream - average error -258.233471 above threshold of 200.000000 2019-07-12 21:42:50.539 T:8343 DEBUG: ActiveAE::SyncStream - average error -17.608471 below threshold of 30.000000 2019-07-12 21:42:51.626 T:8343 DEBUG: ActiveAE::SyncStream - average error -252.844850 above threshold of 200.000000 2019-07-12 21:42:51.627 T:8343 DEBUG: ActiveAE::SyncStream - average error -12.219850 below threshold of 30.000000 2019-07-12 21:42:52.634 T:8343 DEBUG: ActiveAE::SyncStream - average error -209.868946 above threshold of 200.000000 2019-07-12 21:42:52.635 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.014779 below threshold of 30.000000 2019-07-12 21:42:53.722 T:8343 DEBUG: ActiveAE::SyncStream - average error -220.760044 above threshold of 200.000000 2019-07-12 21:42:53.723 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.010044 below threshold of 30.000000 2019-07-12 21:42:54.810 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.289625 above threshold of 200.000000 2019-07-12 21:42:54.811 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.018792 below threshold of 30.000000 2019-07-12 21:42:55.823 T:8343 DEBUG: ActiveAE::SyncStream - average error -204.420859 above threshold of 200.000000 2019-07-12 21:42:55.823 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.004192 below threshold of 30.000000 2019-07-12 21:42:56.906 T:8343 DEBUG: ActiveAE::SyncStream - average error -214.807129 above threshold of 200.000000 2019-07-12 21:42:56.907 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.015462 below threshold of 30.000000 2019-07-12 21:42:57.994 T:8343 DEBUG: ActiveAE::SyncStream - average error -215.972891 above threshold of 200.000000 2019-07-12 21:42:57.995 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.014557 below threshold of 30.000000 2019-07-12 21:42:59.082 T:8343 DEBUG: ActiveAE::SyncStream - average error -214.471073 above threshold of 200.000000 2019-07-12 21:42:59.083 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.012740 below threshold of 30.000000 2019-07-12 21:43:00.095 T:8343 DEBUG: ActiveAE::SyncStream - average error -204.917694 above threshold of 200.000000 2019-07-12 21:43:00.095 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.001027 below threshold of 30.000000 2019-07-12 21:43:01.162 T:8343 DEBUG: ActiveAE::SyncStream - average error -213.853601 above threshold of 200.000000 2019-07-12 21:43:01.163 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.020268 below threshold of 30.000000 2019-07-12 21:43:05.242 T:8343 DEBUG: ActiveAE::SyncStream - average error -537.369821 above threshold of 200.000000 2019-07-12 21:43:05.434 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.015654 below threshold of 30.000000 2019-07-12 21:43:06.447 T:8343 DEBUG: ActiveAE::SyncStream - average error -248.720530 above threshold of 200.000000 2019-07-12 21:43:06.447 T:8343 DEBUG: ActiveAE::SyncStream - average error -8.095530 below threshold of 30.000000 2019-07-12 21:43:07.530 T:8343 DEBUG: ActiveAE::SyncStream - average error -235.859748 above threshold of 200.000000 2019-07-12 21:43:07.530 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.005582 below threshold of 30.000000 2019-07-12 21:43:08.538 T:8343 DEBUG: ActiveAE::SyncStream - average error -203.073626 above threshold of 200.000000 2019-07-12 21:43:08.538 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.011126 below threshold of 30.000000 2019-07-12 21:43:09.626 T:8343 DEBUG: ActiveAE::SyncStream - average error -220.082527 above threshold of 200.000000 2019-07-12 21:43:09.627 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.020027 below threshold of 30.000000 2019-07-12 21:43:10.714 T:8343 DEBUG: ActiveAE::SyncStream - average error -211.155121 above threshold of 200.000000 2019-07-12 21:43:10.714 T:8343 DEBUG: ActiveAE::SyncStream - average error -0.009288 below threshold of 30.000000 2019-07-12 21:43:12.685 T:7230 DEBUG: CXBMCApp::onReceive - Got intent. Action: android.intent.action.MEDIA_BUTTON 2019-07-12 21:43:12.685 T:7230 INFO: Got MEDIA_BUTTON intent: 85, up:false 2019-07-12 21:43:12.685 T:7230 DEBUG: CXBMCApp::onReceive - Got intent. Action: android.intent.action.MEDIA_BUTTON 2019-07-12 21:43:12.685 T:7230 INFO: Got MEDIA_BUTTON intent: 85, up:true 2019-07-12 21:43:12.711 T:8329 DEBUG: Keyboard: scancode: 0x55, sym: 0x00b3, unicode: 0x0000, modifier: 0x0 2019-07-12 21:43:12.711 T:8329 DEBUG: Previous line repeats 1 times. 2019-07-12 21:43:12.711 T:8329 DEBUG: HandleKey: play_pause (0xf0bd) pressed, action is PlayPause 2019-07-12 21:43:12.711 T:8334 DEBUG: CAnnouncementManager - Announcement: OnPause from xbmc 2019-07-12 21:43:12.712 T:8334 DEBUG: void CXBMCApp::OnPlayBackPaused() 2019-07-12 21:43:12.714 T:8334 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPause 2019-07-12 21:43:12.748 T:10440 DEBUG: CDVDAudio::Pause - pausing audio stream 2019-07-12 21:43:12.794 T:8329 DEBUG: Uninhibiting OS screen saver 2019-07-12 21:43:14.429 T:8329 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 2019-07-12 21:43:14.429 T:8329 DEBUG: HandleKey: backspace (0xf008) pressed, action is Back 2019-07-12 21:43:14.629 T:8329 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 2019-07-12 21:43:14.732 T:8329 DEBUG: ------ Window Deinit (VideoOSD.xml) ------ 2019-07-12 21:43:19.050 T:8329 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 2019-07-12 21:43:19.100 T:8329 DEBUG: Previous line repeats 1 times. 2019-07-12 21:43:19.101 T:8329 DEBUG: HandleKey: backspace (0xf008) pressed, action is Fullscreen 2019-07-12 21:43:19.101 T:8329 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 2019-07-12 21:43:19.101 T:8329 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 2019-07-12 21:43:19.106 T:8329 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 2019-07-12 21:43:19.112 T:8329 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 2019-07-12 21:43:19.114 T:8329 DEBUG: CGUIMediaWindow::GetDirectory (videodb://recentlyaddedmovies/) 2019-07-12 21:43:19.114 T:8329 DEBUG: ParentPath = [videodb://recentlyaddedmovies/] 2019-07-12 21:43:19.148 T:10581 DEBUG: Thread BackgroundLoader start, auto delete: false 2019-07-12 21:43:19.192 T:10581 DEBUG: Thread BackgroundLoader 10581 terminating 2019-07-12 21:43:19.296 T:10583 DEBUG: Thread JobWorker start, auto delete: true 2019-07-12 21:43:19.303 T:10583 DEBUG: Previous line repeats 3 times. 2019-07-12 21:43:19.306 T:10583 DEBUG: ffmpeg[2D683ED4F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-07-12 21:43:19.307 T:10586 DEBUG: ffmpeg[2D69CFC4F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-07-12 21:43:19.309 T:10584 DEBUG: ffmpeg[2D684EA4F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-07-12 21:43:19.313 T:10585 DEBUG: ffmpeg[2D685E74F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-07-12 21:43:19.317 T:10583 DEBUG: ffmpeg[2D683ED4F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-07-12 21:43:19.318 T:10586 DEBUG: ffmpeg[2D69CFC4F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-07-12 21:43:19.328 T:10584 DEBUG: ffmpeg[2D684EA4F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-07-12 21:43:19.329 T:10583 DEBUG: ffmpeg[2D683ED4F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-07-12 21:43:19.329 T:10585 DEBUG: ffmpeg[2D685E74F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-07-12 21:43:19.410 T:8329 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 2019-07-12 21:43:19.410 T:8329 DEBUG: ------ Window Deinit (Custom_1109_TopBarOverlay.xml) ------ 2019-07-12 21:43:20.702 T:8329 DEBUG: Keyboard: scancode: 0x04, sym: 0x0008, unicode: 0x0000, modifier: 0x0 2019-07-12 21:43:20.869 T:8329 DEBUG: Previous line repeats 1 times. 2019-07-12 21:43:20.869 T:8329 DEBUG: HandleKey: backspace (0xf008) pressed, action is Back 2019-07-12 21:43:20.869 T:8329 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 2019-07-12 21:43:21.176 T:8329 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 2019-07-12 21:43:21.176 T:8329 DEBUG: FreeVisualisation() done 2019-07-12 21:43:21.186 T:8329 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 2019-07-12 21:43:21.186 T:8329 DEBUG: ------ Window Init (Home.xml) ------ 2019-07-12 21:43:21.186 T:8329 DEBUG: CDirectoryProvider[library://video/movies/]: refreshing.. 2019-07-12 21:43:21.186 T:8329 DEBUG: CDirectoryProvider[special://skin/playlists/inprogress_movies.xsp]: refreshing.. 2019-07-12 21:43:21.186 T:8329 DEBUG: CDirectoryProvider[special://skin/playlists/recent_unwatched_movies.xsp]: refreshing.. 2019-07-12 21:43:21.188 T:8329 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_movies.xsp]: refreshing.. 2019-07-12 21:43:21.189 T:8329 DEBUG: CDirectoryProvider[special://skin/playlists/random_movies.xsp]: refreshing.. 2019-07-12 21:43:21.189 T:8329 DEBUG: CDirectoryProvider[videodb://movies/genres/]: refreshing.. 2019-07-12 21:43:21.189 T:8329 DEBUG: CDirectoryProvider[videodb://movies/sets/]: refreshing.. 2019-07-12 21:43:21.189 T:8329 DEBUG: CDirectoryProvider[library://video/tvshows/]: refreshing.. 2019-07-12 21:43:21.189 T:8329 DEBUG: CDirectoryProvider[videodb://inprogresstvshows]: refreshing.. 2019-07-12 21:43:21.190 T:8329 DEBUG: CDirectoryProvider[special://skin/playlists/recent_unwatched_episodes.xsp]: refreshing.. 2019-07-12 21:43:21.190 T:8329 DEBUG: CDirectoryProvider[special://skin/playlists/unwatched_tvshows.xsp]: refreshing.. 2019-07-12 21:43:21.191 T:8329 DEBUG: CDirectoryProvider[videodb://tvshows/genres/]: refreshing.. 2019-07-12 21:43:21.191 T:8329 DEBUG: CDirectoryProvider[videodb://tvshows/studios/]: refreshing.. 2019-07-12 21:43:21.192 T:8329 DEBUG: CDirectoryProvider[addons://]: refreshing.. 2019-07-12 21:43:21.192 T:8329 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing.. 2019-07-12 21:43:21.192 T:8329 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing.. 2019-07-12 21:43:21.192 T:8329 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing.. 2019-07-12 21:43:21.192 T:8329 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing.. 2019-07-12 21:43:21.192 T:8329 DEBUG: CDirectoryProvider[androidapp://sources/apps/]: refreshing.. 2019-07-12 21:43:21.192 T:8329 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing.. 2019-07-12 21:43:21.192 T:8329 DEBUG: CDirectoryProvider[library://video/]: refreshing.. 2019-07-12 21:43:21.192 T:8329 DEBUG: CDirectoryProvider[sources://video/]: refreshing.. 2019-07-12 21:43:21.193 T:8329 DEBUG: CDirectoryProvider[special://videoplaylists/]: refreshing.. 2019-07-12 21:43:21.193 T:8329 DEBUG: CDirectoryProvider[favourites://]: refreshing.. 2019-07-12 21:43:21.194 T:8329 DEBUG: CDirectoryProvider[sources://pictures/]: refreshing.. 2019-07-12 21:43:21.194 T:8329 DEBUG: CDirectoryProvider[addons://sources/game/]: refreshing.. 2019-07-12 21:43:21.323 T:10583 DEBUG: ffmpeg[2D683ED4F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-07-12 21:43:21.351 T:10586 DEBUG: Previous line repeats 1 times. 2019-07-12 21:43:21.351 T:10586 DEBUG: ffmpeg[2D69CFC4F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-07-12 21:43:21.353 T:10583 DEBUG: ffmpeg[2D683ED4F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-07-12 21:43:21.355 T:10584 DEBUG: ffmpeg[2D684EA4F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-07-12 21:43:21.370 T:10586 DEBUG: ffmpeg[2D69CFC4F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-07-12 21:43:21.398 T:10585 DEBUG: Previous line repeats 1 times. 2019-07-12 21:43:21.398 T:10585 DEBUG: ffmpeg[2D685E74F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-07-12 21:43:21.400 T:10583 DEBUG: ffmpeg[2D683ED4F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-07-12 21:43:21.410 T:10584 DEBUG: ffmpeg[2D684EA4F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-07-12 21:43:21.414 T:10585 DEBUG: ffmpeg[2D685E74F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-07-12 21:43:21.418 T:10583 DEBUG: ffmpeg[2D683ED4F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-07-12 21:43:21.418 T:10586 DEBUG: ffmpeg[2D69CFC4F0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra. 2019-07-12 21:43:21.540 T:10583 DEBUG: CAddonMgr::GetAvailableUpdates took 80 ms 2019-07-12 21:43:21.595 T:10583 DEBUG: CAndroidAppDirectory::GetDirectory: apps 2019-07-12 21:43:21.651 T:10586 DEBUG: CMultiPathDirectory::GetDirectory(multipath://special%3a%2f%2fprofile%2fplaylists%2fvideo/special%3a%2f%2fprofile%2fplaylists%2fmixed/) 2019-07-12 21:43:21.651 T:10586 DEBUG: Getting Directory (special://profile/playlists/video) 2019-07-12 21:43:21.652 T:10586 DEBUG: Getting Directory (special://profile/playlists/mixed) 2019-07-12 21:43:21.653 T:10586 DEBUG: CMultiPathDirectory::MergeItems, items = 0 2019-07-12 21:43:21.691 T:10586 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update 2019-07-12 21:43:21.697 T:10586 DEBUG: GetArtistsByWhere query: SELECT COUNT(DISTINCT artistview.idArtist) FROM artistview WHERE (EXISTS (SELECT 1 FROM song_artist WHERE song_artist.idArtist = artistview.idArtist AND song_artist.idRole = 1) OR EXISTS (SELECT 1 FROM album_artist WHERE album_artist.idArtist = artistview.idArtist)) AND (artistview.strArtist != '') 2019-07-12 21:43:22.120 T:8329 DEBUG: Keyboard: scancode: 0x15, sym: 0x0114, unicode: 0x0000, modifier: 0x0 2019-07-12 21:43:22.120 T:8329 DEBUG: HandleKey: left (0xf082) pressed, action is Left 2019-07-12 21:43:22.187 T:8329 DEBUG: Keyboard: scancode: 0x15, sym: 0x0114, unicode: 0x0000, modifier: 0x0 2019-07-12 21:43:22.520 T:8329 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2019-07-12 21:43:22.521 T:8329 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2019-07-12 21:43:22.671 T:8329 DEBUG: Keyboard: scancode: 0x13, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2019-07-12 21:43:23.038 T:8329 DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0 2019-07-12 21:43:23.205 T:8329 DEBUG: Previous line repeats 1 times. 2019-07-12 21:43:23.205 T:8329 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 2019-07-12 21:43:23.205 T:8329 DEBUG: Activating window ID: 10111 2019-07-12 21:43:23.205 T:8329 DEBUG: ------ Window Init (DialogButtonMenu.xml) ------ 2019-07-12 21:43:23.205 T:8329 INFO: Loading skin file: DialogButtonMenu.xml, load type: KEEP_IN_MEMORY 2019-07-12 21:43:26.324 T:8329 DEBUG: Keyboard: scancode: 0x17, sym: 0x000d, unicode: 0x0000, modifier: 0x0 2019-07-12 21:43:26.391 T:8329 DEBUG: Previous line repeats 1 times. 2019-07-12 21:43:26.391 T:8329 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 2019-07-12 21:43:26.408 T:8329 NOTICE: Stopping player 2019-07-12 21:43:26.408 T:8329 NOTICE: CVideoPlayer::CloseFile() 2019-07-12 21:43:26.408 T:8329 DEBUG: DeleteRenderer - deleting renderer 2019-07-12 21:43:26.408 T:8329 NOTICE: VideoPlayer: waiting for threads to exit 2019-07-12 21:43:26.417 T:10437 NOTICE: CVideoPlayer::OnExit() 2019-07-12 21:43:26.417 T:10437 DEBUG: CVideoPlayer: updating file item stream details with current streams 2019-07-12 21:43:26.417 T:10437 NOTICE: Closing stream player 1 2019-07-12 21:43:26.417 T:10437 NOTICE: Waiting for audio thread to exit 2019-07-12 21:43:26.417 T:10440 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true 2019-07-12 21:43:26.417 T:10440 NOTICE: thread end: CVideoPlayerAudio::OnExit() 2019-07-12 21:43:26.417 T:10440 DEBUG: Thread VideoPlayerAudio 10440 terminating 2019-07-12 21:43:26.417 T:10437 NOTICE: Closing audio device 2019-07-12 21:43:26.442 T:10437 DEBUG: CDVDAudio::Flush - flush audio stream 2019-07-12 21:43:26.445 T:8343 DEBUG: CActiveAE::DiscardStream - audio stream deleted 2019-07-12 21:43:26.445 T:8343 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2019-07-12 21:43:26.448 T:10437 DEBUG: Previous line repeats 2 times. 2019-07-12 21:43:26.448 T:10437 NOTICE: Deleting audio codec 2019-07-12 21:43:26.448 T:10437 NOTICE: Closing stream player 2 2019-07-12 21:43:26.448 T:10437 NOTICE: waiting for video thread to exit 2019-07-12 21:43:26.448 T:10449 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true 2019-07-12 21:43:26.448 T:10449 NOTICE: thread end: video_thread 2019-07-12 21:43:26.448 T:10449 DEBUG: Thread VideoPlayerVideo 10449 terminating 2019-07-12 21:43:26.449 T:10437 NOTICE: deleting video codec 2019-07-12 21:43:26.449 T:10437 DEBUG: CDVDVideoCodecAndroidMediaCodec::SignalEndOfStream: state: 3 2019-07-12 21:43:26.449 T:10437 DEBUG: CDVDVideoCodecAndroidMediaCodec::SignalEndOfStream: ReleaseMediaCodecBuffers 2019-07-12 21:43:26.450 T:10437 DEBUG: CDVDVideoCodecAndroidMediaCodec::SignalEndOfStream: BUFFER_FLAG_END_OF_STREAM send 2019-07-12 21:43:26.461 T:10437 DEBUG: CMediaCodecVideoBufferPool::~CMediaCodecVideoBufferPool Releasing 4 buffers 2019-07-12 21:43:26.462 T:10437 DEBUG: CSMBFile::Close closing fd 10000 2019-07-12 21:43:26.463 T:8329 NOTICE: VideoPlayer: finished waiting 2019-07-12 21:43:26.464 T:8329 NOTICE: CVideoPlayer::CloseFile() 2019-07-12 21:43:26.464 T:10437 DEBUG: Thread VideoPlayer 10437 terminating 2019-07-12 21:43:26.465 T:8329 NOTICE: VideoPlayer: waiting for threads to exit 2019-07-12 21:43:26.466 T:8329 NOTICE: VideoPlayer: finished waiting 2019-07-12 21:43:26.467 T:8329 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 2019-07-12 21:43:26.468 T:10586 INFO: Deleting settings information for files smb://192.168.178.31:445/NAS 3/Videos/HD-Filme 2/Filme/Russendisko.ts 2019-07-12 21:43:26.469 T:10584 DEBUG: DoWork - Saving file state for video item smb://192.168.178.31:445/NAS 3/Videos/HD-Filme 2/Filme/Russendisko.ts 2019-07-12 21:43:26.486 T:8334 DEBUG: CAnnouncementManager - Announcement: OnUpdate from xbmc 2019-07-12 21:43:26.486 T:8334 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnUpdate 2019-07-12 21:43:26.494 T:8334 DEBUG: CAnnouncementManager - Announcement: OnUpdate from xbmc 2019-07-12 21:43:26.494 T:8334 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnUpdate 2019-07-12 21:43:26.510 T:10586 DEBUG: OnPlayBackStopped: CApplication::OnPlayBackStopped 2019-07-12 21:43:26.510 T:8334 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 2019-07-12 21:43:26.510 T:8334 DEBUG: void CXBMCApp::OnPlayBackStopped() 2019-07-12 21:43:26.512 T:8334 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 2019-07-12 21:43:26.518 T:10436 DEBUG: CVideoSyncAndroid::Cleanup cleaning up 2019-07-12 21:43:26.518 T:10436 DEBUG: Thread RefClock 10436 terminating 2019-07-12 21:43:26.518 T:8329 NOTICE: Storing total System Uptime 2019-07-12 21:43:26.519 T:8334 DEBUG: CAnnouncementManager - Announcement: OnQuit from xbmc 2019-07-12 21:43:26.519 T:8334 DEBUG: GOT ANNOUNCEMENT, type: 8, from xbmc, message OnQuit 2019-07-12 21:43:26.519 T:8329 NOTICE: Saving settings 2019-07-12 21:43:26.523 T:8329 NOTICE: Saving skin settings 2019-07-12 21:43:26.527 T:8329 NOTICE: Stopping all 2019-07-12 21:43:26.527 T:10583 DEBUG: Thread JobWorker 10583 terminating (autodelete) 2019-07-12 21:43:26.527 T:10585 DEBUG: Thread JobWorker 10585 terminating (autodelete) 2019-07-12 21:43:26.527 T:10584 DEBUG: Thread JobWorker 10584 terminating (autodelete) 2019-07-12 21:43:26.527 T:10586 DEBUG: Thread JobWorker 10586 terminating (autodelete) 2019-07-12 21:43:26.533 T:8329 DEBUG: NetworkMessage - Signaling network services to stop 2019-07-12 21:43:26.533 T:8329 NOTICE: ES: Stopping event server 2019-07-12 21:43:26.533 T:8329 DEBUG: NetworkMessage - Waiting for network services to stop 2019-07-12 21:43:26.533 T:8329 NOTICE: stopping zeroconf publishing 2019-07-12 21:43:26.533 T:8329 DEBUG: ZeroconfAndroid: Shutdown services 2019-07-12 21:43:26.533 T:8329 DEBUG: CZeroconfAndroid: Removed service servers.eventserver 2019-07-12 21:43:26.534 T:8329 DEBUG: CZeroconfAndroid: Removed service servers.jsonrpc-tpc 2019-07-12 21:43:26.545 T:8399 INFO: ZeroconfAndroid: Kodi (2924122b-31b0-c985-de00-1ba4c6045ac3.fritz.box)._xbmc-events._udp registration removed 2019-07-12 21:43:26.545 T:8399 INFO: ZeroconfAndroid: Kodi (2924122b-31b0-c985-de00-1ba4c6045ac3.fritz.box)._xbmc-jsonrpc._tcp registration removed 2019-07-12 21:43:26.634 T:8344 INFO: CActiveAESink::OpenSink - initialize sink 2019-07-12 21:43:26.634 T:8344 DEBUG: Draining Audio 2019-07-12 21:43:26.634 T:8344 DEBUG: CAESinkAUDIOTRACK::Deinitialize 2019-07-12 21:43:26.635 T:8344 DEBUG: Flushing might not be properly implemented, sleeping: 160 ms 2019-07-12 21:43:26.795 T:8344 DEBUG: CAESinkAUDIOTRACK::Deinitialize 2019-07-12 21:43:26.795 T:8344 DEBUG: CActiveAESink::OpenSink - trying to open device AUDIOTRACK:AudioTrack 2019-07-12 21:43:26.796 T:8344 DEBUG: CAESinkAUDIOTRACK::Initialize requested: sampleRate 44100; format: AE_FMT_FLOAT; channels: 2 2019-07-12 21:43:26.796 T:8344 DEBUG: Updated SampleRate: 32000 Distance: 108900 2019-07-12 21:43:26.796 T:8344 DEBUG: Updated SampleRate: 44100 Distance: 0 2019-07-12 21:43:26.796 T:8344 NOTICE: Trying to open: samplerate: 44100, channelMask: 12, encoding: 4 2019-07-12 21:43:26.796 T:8344 DEBUG: Minimum size we need for stream: 28360 2019-07-12 21:43:26.796 T:8344 DEBUG: Created Audiotrackbuffer with playing time of 160.770975 ms min buffer size: 56720 bytes 2019-07-12 21:43:26.799 T:8344 NOTICE: CAESinkAUDIOTRACK::Initializing with: m_sampleRate: 44100 format: AE_FMT_FLOAT (AE) method: PCM stream-type: PCM-STREAM min_buffer_size: 56720 m_frames: 3545 m_frameSize: 8 channels: 2 2019-07-12 21:43:26.800 T:8344 DEBUG: CActiveAESink::OpenSink - AUDIOTRACK Initialized: 2019-07-12 21:43:26.800 T:8344 DEBUG: Output Device : android 2019-07-12 21:43:26.800 T:8344 DEBUG: Sample Rate : 44100 2019-07-12 21:43:26.800 T:8344 DEBUG: Sample Format : AE_FMT_FLOAT 2019-07-12 21:43:26.800 T:8344 DEBUG: Channel Count : 2 2019-07-12 21:43:26.800 T:8344 DEBUG: Channel Layout: FL, FR 2019-07-12 21:43:26.800 T:8344 DEBUG: Frames : 3545 2019-07-12 21:43:26.800 T:8344 DEBUG: Frame Size : 8 2019-07-12 21:43:26.803 T:8343 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2019-07-12 21:43:27.448 T:8403 DEBUG: Previous line repeats 1 times. 2019-07-12 21:43:27.448 T:8403 DEBUG: Thread TCPServer 8403 terminating 2019-07-12 21:43:27.458 T:8400 NOTICE: ES: UDP Event server stopped 2019-07-12 21:43:27.458 T:8400 DEBUG: Thread EventServer 8400 terminating 2019-07-12 21:43:27.460 T:8329 DEBUG: CServiceAddonManager: stopping plugin.video.youtube. 2019-07-12 21:43:27.461 T:8329 DEBUG: CPythonInvoker(1, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.youtube/resources/lib/startup.py): trigger Monitor abort request 2019-07-12 21:43:27.461 T:8398 DEBUG: [plugin.video.youtube] PlaybackMonitor active threads: || 2019-07-12 21:43:27.462 T:8398 INFO: CPythonInvoker(1, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.youtube/resources/lib/startup.py): script successfully run 2019-07-12 21:43:27.462 T:8398 DEBUG: onExecutionDone(1, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.youtube/resources/lib/startup.py) 2019-07-12 21:43:27.482 T:8398 INFO: Python interpreter interrupted by user 2019-07-12 21:43:27.482 T:8329 DEBUG: CPythonInvoker(1, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.youtube/resources/lib/startup.py): script termination took 22ms 2019-07-12 21:43:27.482 T:8329 DEBUG: CServiceAddonManager: stopping service.xbmc.versioncheck. 2019-07-12 21:43:27.482 T:8398 DEBUG: Thread LanguageInvoker 8398 terminating 2019-07-12 21:43:27.482 T:8329 INFO: CServiceAddonManager: failed to stop service.xbmc.versioncheck (may have ended) 2019-07-12 21:43:27.483 T:8343 DEBUG: Thread ActiveAE 8343 terminating 2019-07-12 21:43:27.547 T:8344 DEBUG: Thread AESink 8344 terminating 2019-07-12 21:43:27.547 T:8329 DEBUG: Draining Audio 2019-07-12 21:43:27.547 T:8329 DEBUG: CAESinkAUDIOTRACK::Deinitialize 2019-07-12 21:43:27.548 T:8329 DEBUG: Flushing might not be properly implemented, sleeping: 160 ms 2019-07-12 21:43:27.708 T:8329 DEBUG: CAESinkAUDIOTRACK::Deinitialize 2019-07-12 21:43:27.709 T:8329 NOTICE: Application stopped 2019-07-12 21:43:27.909 T:8329 NOTICE: XBApplicationEx: destroying... 2019-07-12 21:43:27.914 T:8395 DEBUG: Thread PeripEventScanner 8395 terminating 2019-07-12 21:43:27.914 T:8384 DEBUG: Thread PeripBusAddon 8384 terminating 2019-07-12 21:43:27.931 T:8329 DEBUG: SECTION:UnloadDll(/data/app/org.xbmc.kodi-am8haA5vA-MCMclDowZIgg==/lib/arm64/libperipheral.joystick.so) 2019-07-12 21:43:27.932 T:8329 INFO: ADDON: Dll Destroyed - Joystick Support 2019-07-12 21:43:27.933 T:8329 NOTICE: unload skin 2019-07-12 21:43:27.933 T:8329 INFO: Unloading old skin ... 2019-07-12 21:43:27.934 T:8329 DEBUG: ------ Window Deinit (Home.xml) ------ 2019-07-12 21:43:27.934 T:8329 DEBUG: FreeVisualisation() done 2019-07-12 21:43:27.956 T:8329 DEBUG: Previous line repeats 2 times. 2019-07-12 21:43:27.956 T:8329 DEBUG: ------ Window Deinit (DialogButtonMenu.xml) ------ 2019-07-12 21:43:27.959 T:8329 WARNING: Cleanup: Having to cleanup texture lists/focus.png 2019-07-12 21:43:27.960 T:8329 DEBUG: CloseBundle - Closed bundle 2019-07-12 21:43:27.981 T:8329 DEBUG: Infobool 'window.isactive(home)' still used by 3 instances 2019-07-12 21:43:27.985 T:8329 NOTICE: CWinSystemAndroid::DestroyWindow 2019-07-12 21:43:27.988 T:8329 NOTICE: unload sections 2019-07-12 21:43:27.993 T:8334 DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc 2019-07-12 21:43:27.994 T:8420 DEBUG: Thread Timer 8420 terminating 2019-07-12 21:43:27.996 T:8329 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x2d63270780 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-07-12 21:43:27.996 T:8329 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x2d63270280 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-07-12 21:43:27.996 T:8329 INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0x2d63270180 with reference count 1 when destroying the associated plug-in context. Not releasing the object.' 2019-07-12 21:43:27.997 T:8329 DEBUG: object 0 --> 0 instances 2019-07-12 21:43:27.997 T:8329 DEBUG: object 1 --> 0 instances 2019-07-12 21:43:27.997 T:8329 DEBUG: object 2 --> 0 instances 2019-07-12 21:43:27.997 T:8329 DEBUG: object 3 --> 0 instances 2019-07-12 21:43:27.997 T:8329 DEBUG: object 4 --> 0 instances 2019-07-12 21:43:27.997 T:8329 DEBUG: object 5 --> 0 instances 2019-07-12 21:43:27.997 T:8329 DEBUG: object 6 --> 0 instances 2019-07-12 21:43:27.997 T:8329 DEBUG: object 7 --> 0 instances 2019-07-12 21:43:27.997 T:8329 DEBUG: object 8 --> 0 instances 2019-07-12 21:43:27.997 T:8329 DEBUG: object 9 --> 0 instances 2019-07-12 21:43:28.001 T:8329 NOTICE: CWinSystemAndroid::DestroyWindowSystem 2019-07-12 21:43:28.012 T:8340 DEBUG: Thread CWinEventsAndroid 8340 terminating 2019-07-12 21:43:28.018 T:8334 DEBUG: Thread Announce 8334 terminating 2019-07-12 21:43:28.021 T:8329 NOTICE: XBApplicationEx: application stopped!