2025-11-30 10:40:03.905 T:1781 debug : OnPlayMedia /storage/fs/videos/Filme/AF/cato.mkv 2025-11-30 10:40:03.937 T:1781 debug : CPlayerCoreFactory::GetPlayers(/storage/fs/videos/Filme/AF/cato.mkv) 2025-11-30 10:40:03.937 T:1781 debug : CPlayerSelectionRule::GetPlayers: considering rule: system rules 2025-11-30 10:40:03.937 T:1781 debug : CPlayerSelectionRule::GetPlayers: matches rule: system rules 2025-11-30 10:40:03.937 T:1781 debug : CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 2025-11-30 10:40:03.937 T:1781 debug : CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 2025-11-30 10:40:03.937 T:1781 debug : CPlayerSelectionRule::GetPlayers: considering rule: rtmp 2025-11-30 10:40:03.937 T:1781 debug : CPlayerSelectionRule::GetPlayers: considering rule: rtsp 2025-11-30 10:40:03.937 T:1781 debug : CPlayerSelectionRule::GetPlayers: considering rule: streams 2025-11-30 10:40:03.937 T:1781 debug : CPlayerSelectionRule::GetPlayers: considering rule: dvd 2025-11-30 10:40:03.937 T:1781 debug : CPlayerSelectionRule::GetPlayers: considering rule: discimage 2025-11-30 10:40:03.938 T:1781 debug : CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 2025-11-30 10:40:03.938 T:1781 debug : CPlayerSelectionRule::GetPlayers: considering rule: nsv 2025-11-30 10:40:03.938 T:1781 debug : CPlayerSelectionRule::GetPlayers: considering rule: radio 2025-11-30 10:40:03.938 T:1781 debug : CPlayerCoreFactory::GetPlayers: matched 0 rules with players 2025-11-30 10:40:03.938 T:1781 debug : CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 2025-11-30 10:40:03.938 T:1781 debug : CPlayerCoreFactory::GetPlayers: for video=true, audio=false 2025-11-30 10:40:03.938 T:1781 debug : CPlayerCoreFactory::GetPlayers: for video=true, audio=true 2025-11-30 10:40:03.938 T:1781 debug : CPlayerCoreFactory::GetPlayers: added 1 players 2025-11-30 10:40:03.948 T:1781 debug : Radio UECP (RDS) Processor - new CDVDRadioRDSData 2025-11-30 10:40:03.948 T:1781 debug : Audio ID3 tag processor - new CVideoPlayerAudioID3 2025-11-30 10:40:03.948 T:1781 info : VideoPlayer::OpenFile: /storage/fs/videos/Filme/AF/cato.mkv 2025-11-30 10:40:03.948 T:1965 debug : Thread VideoPlayer start, auto delete: false 2025-11-30 10:40:03.948 T:1781 debug : OnPlayBackStarted: CApplication::OnPlayBackStarted 2025-11-30 10:40:03.949 T:1965 info : Creating InputStream 2025-11-30 10:40:03.950 T:1966 debug : Thread BackgroundLoader start, auto delete: false 2025-11-30 10:40:03.950 T:1781 debug : [threads] name: 'BackgroundLoader' priority: '1' 2025-11-30 10:40:03.973 T:1930 debug : Loading settings for /storage/fs/videos/Filme/AF/cato.mkv 2025-11-30 10:40:03.985 T:1965 debug : ScanForExternalSubtitles: Searching for subtitles... 2025-11-30 10:40:03.987 T:1965 debug : ScanForExternalSubtitles: END (total time: 2 ms) 2025-11-30 10:40:03.987 T:1965 info : Creating Demuxer 2025-11-30 10:40:03.989 T:1965 debug : Open - probing detected format [matroska,webm] 2025-11-30 10:40:04.004 T:1966 debug : Thread BackgroundLoader 281469951930112 terminating 2025-11-30 10:40:04.018 T:1965 debug : Open - avformat_find_stream_info starting 2025-11-30 10:40:04.021 T:1781 debug : CVideoGUIInfo::InitCurrentItem(/storage/fs/videos/Filme/AF/cato.mkv) 2025-11-30 10:40:04.022 T:1781 debug : CPlayerGUIInfo::InitCurrentItem(/storage/fs/videos/Filme/AF/cato.mkv) 2025-11-30 10:40:04.027 T:1965 debug : Open - av_find_stream_info finished 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: Input #0, matroska,webm, from '/storage/fs/videos/Filme/AF/cato.mkv': 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: Metadata: 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: title : cato.mkv 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: creation_time : 2021-12-24T12:21:15.000000Z 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: ENCODER : Lavf58.20.100 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: Duration: 01:42:07.07, start: 0.000000, bitrate: 2910 kb/s 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: Stream #0:0: Video: hevc (Main), yuv420p(tv, bt709), 1920x1038 [SAR 1:1 DAR 320:173], 23.98 fps, 23.98 tbr, 1k tbn (default) 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: Metadata: 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: BPS : 2140335 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: DURATION : 01:37:05.038000000 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: NUMBER_OF_FRAMES: 146902 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: NUMBER_OF_BYTES : 1639239819 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: _STATISTICS_WRITING_APP: mkvmerge v62.0.0 ('Apollo') 64-bit 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: _STATISTICS_WRITING_DATE_UTC: 2021-12-24 12:21:15 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: Stream #0:1(ger): Audio: ac3, 48000 Hz, 5.1(side), fltp, 384 kb/s (default) 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: Metadata: 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: title : Surround 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: BPS : 384000 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: DURATION : 01:37:05.072000000 2025-11-30 10:40:04.028 T:1965 info : ffmpeg[0x21dd1b60]: NUMBER_OF_FRAMES: 191471 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: NUMBER_OF_BYTES : 294099456 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: _STATISTICS_WRITING_APP: mkvmerge v62.0.0 ('Apollo') 64-bit 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: _STATISTICS_WRITING_DATE_UTC: 2021-12-24 12:21:15 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: Stream #0:2(eng): Audio: ac3, 48000 Hz, 5.1(side), fltp, 384 kb/s 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: Metadata: 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: title : Surround 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: BPS : 384000 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: DURATION : 01:37:05.072000000 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: NUMBER_OF_FRAMES: 191471 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: NUMBER_OF_BYTES : 294099456 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: _STATISTICS_WRITING_APP: mkvmerge v62.0.0 ('Apollo') 64-bit 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: _STATISTICS_WRITING_DATE_UTC: 2021-12-24 12:21:15 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: Stream #0:3(ger): Subtitle: ass 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: Metadata: 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: title : Full 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: BPS : 84 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: DURATION : 01:35:38.663000000 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: NUMBER_OF_FRAMES: 1292 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: NUMBER_OF_BYTES : 64095 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: _STATISTICS_WRITING_APP: mkvmerge v62.0.0 ('Apollo') 64-bit 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: _STATISTICS_WRITING_DATE_UTC: 2021-12-24 12:21:15 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: Stream #0:4(eng): Subtitle: ass 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: Metadata: 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: title : Full 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: BPS : 94 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: DURATION : 01:20:10.577000000 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: NUMBER_OF_FRAMES: 1211 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: NUMBER_OF_BYTES : 64192 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: _STATISTICS_WRITING_APP: mkvmerge v62.0.0 ('Apollo') 64-bit 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: _STATISTICS_WRITING_DATE_UTC: 2021-12-24 12:21:15 2025-11-30 10:40:04.029 T:1965 info : ffmpeg[0x21dd1b60]: _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES 2025-11-30 10:40:04.029 T:1965 debug : CDVDDemuxFFmpeg::AddStream ID: 0 2025-11-30 10:40:04.030 T:1965 debug : CDVDDemuxFFmpeg::AddStream ID: 1 2025-11-30 10:40:04.030 T:1965 debug : CDVDDemuxFFmpeg::AddStream ID: 2 2025-11-30 10:40:04.030 T:1965 debug : CDVDDemuxFFmpeg::AddStream ID: 3 2025-11-30 10:40:04.030 T:1965 debug : CDVDDemuxFFmpeg::AddStream ID: 4 2025-11-30 10:40:04.030 T:1965 info : Opening stream: 0 source: 256 2025-11-30 10:40:04.030 T:1965 info : [WHITELIST] Searching the whitelist for: width: 1920, height: 1038, fps: 23.976, 3D: false 2025-11-30 10:40:04.030 T:1965 debug : [WHITELIST] Using the default whitelist because the user whitelist is empty 2025-11-30 10:40:04.030 T:1965 debug : [WHITELIST] Searching for an exact resolution with an exact refresh rate 2025-11-30 10:40:04.031 T:1965 debug : [WHITELIST] Matched an exact resolution with an exact refresh rate 1920x1080 @ 23.976025 Hz (24) 2025-11-30 10:40:04.031 T:1965 debug : [WHITELIST] Searching for an exact resolution with double the refresh rate 2025-11-30 10:40:04.031 T:1965 info : Display resolution ADJUST : 1920x1080 @ 23.976025 Hz (24) (weight: 0.000) 2025-11-30 10:40:04.083 T:1806 debug : [plugin.video.youtube] Clear property |busy| 2025-11-30 10:40:04.084 T:1806 debug : [plugin.video.youtube] Get property |play_with|: '' 2025-11-30 10:40:04.122 T:1781 debug : ------ Window Init (DialogBusy.xml) ------ 2025-11-30 10:40:04.123 T:1781 debug : OnLostDevice - notify display change event 2025-11-30 10:40:04.364 T:1781 info : VideoPlayer: OnLostDisplay received 2025-11-30 10:40:04.364 T:1781 warning : CDVDMessageQueue(audio)::Put MSGQ_NOT_INITIALIZED 2025-11-30 10:40:04.364 T:1781 warning : CDVDMessageQueue(video)::Put MSGQ_NOT_INITIALIZED 2025-11-30 10:40:04.364 T:1781 debug : Flush - flushing renderer 2025-11-30 10:40:04.364 T:1781 debug : CDRMUtils::SetMode - found crtc mode: 1920x1080 @ 24 Hz 2025-11-30 10:40:04.364 T:1781 info : GLES: Maximum texture width: 4096 2025-11-30 10:40:04.366 T:1965 info : Creating video codec with codec id: 173 2025-11-30 10:40:04.366 T:1965 info : CDVDVideoCodecDRMPRIME::Open - using decoder HEVC (High Efficiency Video Coding) 2025-11-30 10:40:04.367 T:1965 debug : CDVDVideoCodecDRMPRIME::Open - using drm device for av_hwdevice_ctx: /dev/dri/card0 2025-11-30 10:40:04.377 T:1965 error : ffmpeg[0x21dd1b60]: Impossible to convert between the formats supported by the filter 'src' and the filter 'auto_scale_0' 2025-11-30 10:40:04.377 T:1965 error : CDVDVideoCodecDRMPRIME::FilterOpen - avfilter_graph_config: Function not implemented (-38) 2025-11-30 10:40:04.378 T:1965 debug : CDVDVideoCodecDRMPRIME::FilterTest - no deinterlacing filter found 2025-11-30 10:40:04.378 T:1965 debug : CVideoPlayerVideo::OpenStream - open stream with codec id: 173 2025-11-30 10:40:04.379 T:1965 info : Creating video thread 2025-11-30 10:40:04.380 T:1975 debug : Thread VideoPlayerVideo start, auto delete: false 2025-11-30 10:40:04.380 T:1975 info : running thread: video_thread 2025-11-30 10:40:04.380 T:1975 debug : CVideoPlayerVideo - CDVDMsg::GENERAL_PAUSE: true 2025-11-30 10:40:04.380 T:1965 debug : ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: /storage/fs/videos/Filme/AF/cato.mkv 2025-11-30 10:40:04.380 T:1965 info : Opening stream: 1 source: 256 2025-11-30 10:40:04.380 T:1965 info : Finding audio codec for: 86019 2025-11-30 10:40:04.381 T:1965 info : CDVDAudioCodecFFmpeg::Open() Successful opened audio decoder ac3 2025-11-30 10:40:04.381 T:1965 info : OpenStream: Allowing max Out-Of-Sync Value of 50 ms 2025-11-30 10:40:04.382 T:1965 info : Creating audio thread 2025-11-30 10:40:04.382 T:1976 debug : Thread VideoPlayerAudio start, auto delete: false 2025-11-30 10:40:04.382 T:1976 info : running thread: CVideoPlayerAudio::Process() 2025-11-30 10:40:04.382 T:1965 info : Opening stream: 3 source: 256 2025-11-30 10:40:04.382 T:1965 info : CDVDSubtitlesLibass: Using libass version 1701000 2025-11-30 10:40:04.382 T:1965 info : CDVDSubtitlesLibass: Creating ASS library structure 2025-11-30 10:40:04.382 T:1965 info : CDVDSubtitlesLibass: Initializing ASS Renderer 2025-11-30 10:40:04.382 T:1965 debug : CDVDSubtitlesLibass: [ass] libass API version: 0x1701000 2025-11-30 10:40:04.382 T:1965 debug : CDVDSubtitlesLibass: [ass] libass source: tarball: 0.17.1 2025-11-30 10:40:04.383 T:1965 debug : CDVDSubtitlesLibass: [ass] Shaper: FriBidi 1.0.13 (SIMPLE) HarfBuzz-ng 8.3.1 (COMPLEX) 2025-11-30 10:40:04.383 T:1965 info : CDVDSubtitlesLibass: Initializing ASS library font settings 2025-11-30 10:40:04.390 T:1781 debug : EGL Debugging: Error: EGL_BAD_SURFACE Command: eglSwapBuffers Type: EGL_DEBUG_MSG_ERROR_KHR Message: dri2_swap_buffers 2025-11-30 10:40:04.392 T:1781 debug : CDRMAtomic::FlipPage - Execute modeset at next commit 2025-11-30 10:40:04.392 T:1976 debug : CVideoPlayerAudio - CDVDMsg::GENERAL_PAUSE: true 2025-11-30 10:40:04.437 T:1965 debug : CDVDSubtitlesLibass: [ass] Using font provider fontconfig 2025-11-30 10:40:04.437 T:1965 info : CDVDSubtitlesLibass: Creating new ASS track 2025-11-30 10:40:04.437 T:1965 debug : Created subtitles overlay codec: SSA Subtitle Decoder 2025-11-30 10:40:04.437 T:1965 debug : CVideoPlayer::SetCaching - caching state 2 2025-11-30 10:40:04.437 T:1976 debug : CDVDAudio::Pause - pausing audio stream 2025-11-30 10:40:04.437 T:1965 debug : CDVDClock::SetSpeedAdjust - adjusted:0.000000 2025-11-30 10:40:04.481 T:1781 debug : CWinSystemGbmGLESContext::PresentRender - Sending display reset to all clients 2025-11-30 10:40:04.481 T:1781 info : VideoPlayer: OnResetDisplay received 2025-11-30 10:40:04.481 T:1976 debug : CVideoPlayerAudio - CDVDMsg::GENERAL_PAUSE: false 2025-11-30 10:40:04.481 T:1788 debug : CActiveAE - display reset event 2025-11-30 10:40:04.481 T:1975 debug : CVideoPlayerVideo - CDVDMsg::GENERAL_PAUSE: false 2025-11-30 10:40:04.482 T:1789 info : CActiveAESink::OpenSink - initialize sink 2025-11-30 10:40:04.482 T:1789 debug : CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=HDMI,DEV=0 2025-11-30 10:40:04.482 T:1789 info : CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=HDMI,DEV=0" 2025-11-30 10:40:04.487 T:1965 debug : CVideoPlayer::HandleMessages - player 2 reported state: 0 2025-11-30 10:40:04.487 T:1965 debug : CVideoPlayer::HandleMessages - player 1 reported state: 0 2025-11-30 10:40:04.487 T:1925 debug : OnAVChange: CApplication::OnAVChange 2025-11-30 10:40:04.488 T:1965 debug : CVideoPlayer::SetCaching - caching state 1 2025-11-30 10:40:04.488 T:1965 debug : CDVDClock::SetSpeedAdjust - adjusted:0.000000 2025-11-30 10:40:04.489 T:1965 debug : CVideoPlayer::CheckContinuity - wrapback :2, prev:214000.000000, curr:5000.000000, diff:-209000.000000 2025-11-30 10:40:04.491 T:1975 debug : CVideoPlayerVideo - Stillframe left, switching to normal playback 2025-11-30 10:40:04.493 T:1789 info : CAESinkALSA::Initialize - Opened device "hdmi:CARD=HDMI,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00" 2025-11-30 10:40:04.493 T:1789 info : CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 2025-11-30 10:40:04.493 T:1789 info : CAESinkALSA::InitializeHW - Using data format AE_FMT_S24NE4 2025-11-30 10:40:04.493 T:1789 debug : CAESinkALSA::InitializeHW - Request: periodSize 2205, bufferSize 8820 2025-11-30 10:40:04.493 T:1789 debug : CAESinkALSA::InitializeHW - Got: periodSize 2205, bufferSize 8820 2025-11-30 10:40:04.493 T:1789 debug : CAESinkALSA::InitializeHW - Setting timeout to 200 ms 2025-11-30 10:40:04.494 T:1789 debug : CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 2025-11-30 10:40:04.494 T:1976 debug : CDVDAudio::Pause - pausing audio stream 2025-11-30 10:40:04.495 T:1976 info : CVideoPlayerAudio: display reset occurred, checking for passthrough 2025-11-30 10:40:04.496 T:1789 debug : CAESinkALSA::GetChannelLayout - Requested Layout: FL, FR 2025-11-30 10:40:04.496 T:1789 debug : CAESinkALSA::GetChannelLayout - Got Layout: FL, FR (ALSA: FL FR) 2025-11-30 10:40:04.496 T:1976 info : CDVDAudioCodecFFmpeg::Open() Successful opened audio decoder ac3 2025-11-30 10:40:04.497 T:1976 info : Creating audio stream (codec id: 86019, channels: 6, sample rate: 48000, no pass-through) 2025-11-30 10:40:04.497 T:1789 debug : CActiveAESink::OpenSink - ALSA Initialized: 2025-11-30 10:40:04.497 T:1789 debug : Output Device : HDMI 2025-11-30 10:40:04.497 T:1789 debug : Sample Rate : 44100 2025-11-30 10:40:04.497 T:1789 debug : Sample Format : AE_FMT_S24NE4 2025-11-30 10:40:04.497 T:1789 debug : Channel Count : 2 2025-11-30 10:40:04.497 T:1789 debug : Channel Layout: FL, FR 2025-11-30 10:40:04.497 T:1789 debug : Frames : 2205 2025-11-30 10:40:04.497 T:1789 debug : Frame Size : 8 2025-11-30 10:40:04.500 T:1788 debug : CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2025-11-30 10:40:04.501 T:1976 debug : CVideoPlayerAudio:: synctype set to 0: clock feedback 2025-11-30 10:40:04.502 T:1789 info : CActiveAESink::OpenSink - initialize sink 2025-11-30 10:40:04.534 T:1965 debug : CVideoPlayer::SetCaching - caching state 2 2025-11-30 10:40:04.534 T:1965 debug : CDVDClock::SetSpeedAdjust - adjusted:0.000000 2025-11-30 10:40:04.554 T:1967 error : ffmpeg[0x0]: [hevc] ff_v4l2_request_query_control: query control failed, Invalid argument (22) 2025-11-30 10:40:04.593 T:1975 debug : CRenderManager::Configure - change configuration. 1920x1038. display: 1920x1038. framerate: 23.98. 2025-11-30 10:40:04.651 T:1789 debug : CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=HDMI,DEV=0 2025-11-30 10:40:04.651 T:1789 info : CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=HDMI,DEV=0" 2025-11-30 10:40:04.652 T:1781 debug : DeleteRenderer - deleting renderer 2025-11-30 10:40:04.652 T:1781 debug : LinuxRendererGLES: Cleaning up GLES resources 2025-11-30 10:40:04.652 T:1781 debug : CDRMPlane::SupportsFormatAndModifier - found plane format (NV12) and modifier (LINEAR) 2025-11-30 10:40:04.652 T:1781 debug : CRenderManager::Configure - 5 2025-11-30 10:40:04.655 T:1930 debug : OnAVChange: CApplication::OnAVChange 2025-11-30 10:40:04.656 T:1965 debug : CVideoPlayer::HandleMessages - player started 2 2025-11-30 10:40:04.658 T:1789 info : CAESinkALSA::Initialize - Opened device "hdmi:CARD=HDMI,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x02" 2025-11-30 10:40:04.658 T:1789 info : CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 2025-11-30 10:40:04.659 T:1789 info : CAESinkALSA::InitializeHW - Using data format AE_FMT_S24NE4 2025-11-30 10:40:04.659 T:1789 debug : CAESinkALSA::InitializeHW - Request: periodSize 2400, bufferSize 9600 2025-11-30 10:40:04.659 T:1789 debug : CAESinkALSA::InitializeHW - Got: periodSize 2400, bufferSize 9600 2025-11-30 10:40:04.659 T:1789 debug : CAESinkALSA::InitializeHW - Setting timeout to 200 ms 2025-11-30 10:40:04.659 T:1789 debug : CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 2025-11-30 10:40:04.659 T:1789 debug : CAESinkALSA::GetChannelLayout - Requested Layout: FL, FR 2025-11-30 10:40:04.659 T:1789 debug : CAESinkALSA::GetChannelLayout - Got Layout: FL, FR (ALSA: FL FR) 2025-11-30 10:40:04.660 T:1789 debug : CActiveAESink::OpenSink - ALSA Initialized: 2025-11-30 10:40:04.660 T:1789 debug : Output Device : HDMI 2025-11-30 10:40:04.660 T:1789 debug : Sample Rate : 48000 2025-11-30 10:40:04.660 T:1789 debug : Sample Format : AE_FMT_S24NE4 2025-11-30 10:40:04.660 T:1789 debug : Channel Count : 2 2025-11-30 10:40:04.660 T:1789 debug : Channel Layout: FL, FR 2025-11-30 10:40:04.660 T:1789 debug : Frames : 2400 2025-11-30 10:40:04.660 T:1789 debug : Frame Size : 8 2025-11-30 10:40:04.661 T:1781 debug : CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 61 2025-11-30 10:40:04.661 T:1781 debug : CDRMAtomic::FlipPage - Execute modeset at next commit 2025-11-30 10:40:04.665 T:1788 debug : CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2025-11-30 10:40:04.666 T:1976 info : Skipped 1 duplicate messages.. 2025-11-30 10:40:04.666 T:1976 debug : CDVDAudio::Pause - pausing audio stream 2025-11-30 10:40:04.676 T:1965 debug : CVideoPlayer::HandleMessages - player started 1 2025-11-30 10:40:04.676 T:1965 debug : CVideoPlayer::SetCaching - caching state 3 2025-11-30 10:40:04.676 T:1923 debug : OnAVChange: CApplication::OnAVChange 2025-11-30 10:40:04.676 T:1965 debug : CDVDClock::SetSpeedAdjust - adjusted:0.000000 2025-11-30 10:40:04.676 T:1965 debug : CVideoPlayer::SetCaching - caching state 0 2025-11-30 10:40:04.676 T:1965 debug : CDVDClock::SetSpeedAdjust - adjusted:0.000000 2025-11-30 10:40:04.676 T:1965 debug : VideoPlayer::Sync - Audio - pts: 288000.000000, cache: 508621.511119, totalcache: 800000.011921 2025-11-30 10:40:04.676 T:1965 debug : VideoPlayer::Sync - Video - pts: 5000.000000, cache: 50000.000000, totalcache: 100000.000000 2025-11-30 10:40:04.676 T:1976 debug : CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(-220621.511119), level: 96, cache: 505462.761119 2025-11-30 10:40:04.676 T:1975 debug : CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(-220621.511119) 2025-11-30 10:40:04.676 T:1976 debug : CDVDAudio::Resume - resume audio stream 2025-11-30 10:40:04.677 T:1924 debug : OnAVStarted: CApplication::OnAVStarted 2025-11-30 10:40:04.677 T:1788 debug : ActiveAE - start sync of audio stream 2025-11-30 10:40:04.733 T:1781 debug : Activating window ID: 12005 2025-11-30 10:40:04.734 T:1781 debug : ------ Window Deinit (MyVideoNav.xml) ------ 2025-11-30 10:40:04.734 T:1781 debug : FreeVisualisation() done 2025-11-30 10:40:04.735 T:1781 debug : ------ Window Init (VideoFullScreen.xml) ------ 2025-11-30 10:40:04.736 T:1781 info : Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY 2025-11-30 10:40:04.740 T:1781 info : [WHITELIST] Searching the whitelist for: width: 1920, height: 1038, fps: 23.976, 3D: false 2025-11-30 10:40:04.741 T:1781 debug : [WHITELIST] Using the default whitelist because the user whitelist is empty 2025-11-30 10:40:04.741 T:1781 debug : [WHITELIST] Searching for an exact resolution with an exact refresh rate 2025-11-30 10:40:04.741 T:1781 debug : [WHITELIST] Matched an exact resolution with an exact refresh rate 1920x1080 @ 23.976025 Hz (24) 2025-11-30 10:40:04.741 T:1781 debug : [WHITELIST] Searching for an exact resolution with double the refresh rate 2025-11-30 10:40:04.741 T:1781 info : Display resolution ADJUST : 1920x1080 @ 23.976025 Hz (24) (weight: 0.000) 2025-11-30 10:40:04.743 T:1923 debug : OnAVChange: CApplication::OnAVChange 2025-11-30 10:40:04.744 T:1781 debug : CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 62 2025-11-30 10:40:04.766 T:1806 debug : [plugin.video.youtube] Get property |play_with|: '' 2025-11-30 10:40:04.766 T:1806 debug : [plugin.video.youtube] Pop property |player_json|: '' 2025-11-30 10:40:04.773 T:1781 debug : ------ Window Deinit (DialogBusy.xml) ------ 2025-11-30 10:40:04.775 T:1781 debug : CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 56 2025-11-30 10:40:04.812 T:1788 debug : ActiveAE::SyncStream - average error of 20.850255, start adjusting 2025-11-30 10:40:04.812 T:1788 debug : ActiveAE::SyncStream - average error 0.850255 below threshold of 30.000000 2025-11-30 10:40:04.818 T:1781 debug : CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 58 2025-11-30 10:40:06.365 T:1806 debug : [plugin.video.youtube] Clear property |plugin_sleeping| 2025-11-30 10:40:06.365 T:1806 debug : [plugin.video.youtube] Set property |plugin_sleeping|: 'true' 2025-11-30 10:40:09.613 T:1975 debug : CPtsTracker: detected pattern of length 1: 41708.33, frameduration: 41708.333333 2025-11-30 10:40:16.328 T:1807 debug : script.module.slyguy - SIGNAL: on_donor_unset 2025-11-30 10:40:34.744 T:1930 debug : Thread JobWorker 281469968248576 terminating (autodelete) 2025-11-30 10:40:34.744 T:1923 debug : Thread JobWorker 281470018973440 terminating (autodelete) 2025-11-30 10:40:34.744 T:1924 debug : Thread JobWorker 281472149679872 terminating (autodelete) 2025-11-30 10:40:34.744 T:1925 debug : Thread JobWorker 281470035619584 terminating (autodelete) 2025-11-30 10:40:46.361 T:1807 debug : script.module.slyguy - SIGNAL: on_donor_unset