2026-10-15 12:58:30.610 T:1176 info : Loading skin file: Settings.xml, load type: KEEP_IN_MEMORY 2026-10-15 12:58:35.943 T:1176 info : Loading skin file: SettingsCategory.xml, load type: KEEP_IN_MEMORY 2026-10-15 12:58:41.331 T:1176 info : Log level changed to "trace" 2026-10-15 12:58:41.331 T:1176 info : Enabled debug logging due to GUI setting. Level 2. 2026-10-15 12:58:41.332 T:1176 debug : ------ Window Init () ------ 2026-10-15 12:58:44.250 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x6c, xkb keysym: 0xff54 (Down) 2026-10-15 12:58:44.250 T:1180 debug : CLibInputKeyboard::ProcessKey - using delay: 400ms repeat: 80ms 2026-10-15 12:58:44.250 T:9179 debug : Thread Timer start, auto delete: false 2026-10-15 12:58:44.255 T:1176 debug : Keyboard: scancode: 0x6c, sym: 0x112 (down), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:44.255 T:1176 debug : bool CInputManager::HandleKey(const CKey&): down (0xf081) pressed, window 10016, action is Down 2026-10-15 12:58:44.347 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x6c, xkb keysym: 0xff54 (Down) 2026-10-15 12:58:44.347 T:9179 debug : Thread Timer 139821485512384 terminating 2026-10-15 12:58:44.359 T:1176 debug : Keyboard: scancode: 0x6c, sym: 0x112 (down), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:45.050 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x6c, xkb keysym: 0xff54 (Down) 2026-10-15 12:58:45.050 T:1180 debug : CLibInputKeyboard::ProcessKey - using delay: 400ms repeat: 80ms 2026-10-15 12:58:45.051 T:9180 debug : Thread Timer start, auto delete: false 2026-10-15 12:58:45.055 T:1176 debug : Keyboard: scancode: 0x6c, sym: 0x112 (down), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:45.055 T:1176 debug : bool CInputManager::HandleKey(const CKey&): down (0xf081) pressed, window 10016, action is Down 2026-10-15 12:58:45.173 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x6c, xkb keysym: 0xff54 (Down) 2026-10-15 12:58:45.173 T:9180 debug : Thread Timer 139821485512384 terminating 2026-10-15 12:58:45.176 T:1176 debug : Keyboard: scancode: 0x6c, sym: 0x112 (down), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:45.450 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x6c, xkb keysym: 0xff54 (Down) 2026-10-15 12:58:45.450 T:1180 debug : CLibInputKeyboard::ProcessKey - using delay: 400ms repeat: 80ms 2026-10-15 12:58:45.450 T:9181 debug : Thread Timer start, auto delete: false 2026-10-15 12:58:45.459 T:1176 debug : Keyboard: scancode: 0x6c, sym: 0x112 (down), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:45.459 T:1176 debug : bool CInputManager::HandleKey(const CKey&): down (0xf081) pressed, window 10016, action is Down 2026-10-15 12:58:45.546 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x6c, xkb keysym: 0xff54 (Down) 2026-10-15 12:58:45.547 T:9181 debug : Thread Timer 139821485512384 terminating 2026-10-15 12:58:45.559 T:1176 debug : Keyboard: scancode: 0x6c, sym: 0x112 (down), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:45.673 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x6c, xkb keysym: 0xff54 (Down) 2026-10-15 12:58:45.673 T:1180 debug : CLibInputKeyboard::ProcessKey - using delay: 400ms repeat: 80ms 2026-10-15 12:58:45.673 T:9182 debug : Thread Timer start, auto delete: false 2026-10-15 12:58:45.684 T:1176 debug : Keyboard: scancode: 0x6c, sym: 0x112 (down), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:45.684 T:1176 debug : bool CInputManager::HandleKey(const CKey&): down (0xf081) pressed, window 10016, action is Down 2026-10-15 12:58:45.750 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x6c, xkb keysym: 0xff54 (Down) 2026-10-15 12:58:45.750 T:9182 debug : Thread Timer 139821485512384 terminating 2026-10-15 12:58:45.759 T:1176 debug : Keyboard: scancode: 0x6c, sym: 0x112 (down), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:46.250 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x6c, xkb keysym: 0xff54 (Down) 2026-10-15 12:58:46.250 T:1180 debug : CLibInputKeyboard::ProcessKey - using delay: 400ms repeat: 80ms 2026-10-15 12:58:46.250 T:9183 debug : Thread Timer start, auto delete: false 2026-10-15 12:58:46.252 T:1176 debug : Keyboard: scancode: 0x6c, sym: 0x112 (down), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:46.252 T:1176 debug : bool CInputManager::HandleKey(const CKey&): down (0xf081) pressed, window 10016, action is Down 2026-10-15 12:58:46.400 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x6c, xkb keysym: 0xff54 (Down) 2026-10-15 12:58:46.400 T:9183 debug : Thread Timer 139821485512384 terminating 2026-10-15 12:58:46.409 T:1176 debug : Keyboard: scancode: 0x6c, sym: 0x112 (down), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:46.823 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x9e, xkb keysym: 0x1008ff26 (XF86Back) 2026-10-15 12:58:46.823 T:1180 debug : CLibInputKeyboard::ProcessKey - using delay: 400ms repeat: 80ms 2026-10-15 12:58:46.823 T:9184 debug : Thread Timer start, auto delete: false 2026-10-15 12:58:46.833 T:1176 debug : Keyboard: scancode: 0x9e, sym: 0xa6 (), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:46.950 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x9e, xkb keysym: 0x1008ff26 (XF86Back) 2026-10-15 12:58:46.950 T:9184 debug : Thread Timer 139821485512384 terminating 2026-10-15 12:58:46.959 T:1176 debug : Keyboard: scancode: 0x9e, sym: 0xa6 (), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:46.959 T:1176 debug : bool CInputManager::HandleKey(const CKey&): browser_back (0xf0b0) pressed, window 10016, action is Back 2026-10-15 12:58:46.961 T:1176 debug : CGUIWindowManager::PreviousWindow: Deactivate 2026-10-15 12:58:47.260 T:1176 debug : ------ Window Deinit (SettingsCategory.xml) ------ 2026-10-15 12:58:47.260 T:1176 debug : FreeVisualisation() done 2026-10-15 12:58:47.276 T:1176 debug : CGUIWindowManager::PreviousWindow: Activate new 2026-10-15 12:58:47.276 T:1176 debug : ------ Window Init (Settings.xml) ------ 2026-10-15 12:58:48.400 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x9e, xkb keysym: 0x1008ff26 (XF86Back) 2026-10-15 12:58:48.400 T:1180 debug : CLibInputKeyboard::ProcessKey - using delay: 400ms repeat: 80ms 2026-10-15 12:58:48.400 T:9185 debug : Thread Timer start, auto delete: false 2026-10-15 12:58:48.403 T:1176 debug : Keyboard: scancode: 0x9e, sym: 0xa6 (), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:48.523 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x9e, xkb keysym: 0x1008ff26 (XF86Back) 2026-10-15 12:58:48.523 T:9185 debug : Thread Timer 139821485512384 terminating 2026-10-15 12:58:48.532 T:1176 debug : Keyboard: scancode: 0x9e, sym: 0xa6 (), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:48.532 T:1176 debug : bool CInputManager::HandleKey(const CKey&): browser_back (0xf0b0) pressed, window 10004, action is Back 2026-10-15 12:58:48.532 T:1176 debug : CGUIWindowManager::PreviousWindow: Deactivate 2026-10-15 12:58:48.827 T:1176 debug : ------ Window Deinit (Settings.xml) ------ 2026-10-15 12:58:48.827 T:1176 debug : FreeVisualisation() done 2026-10-15 12:58:48.843 T:1176 debug : CGUIWindowManager::PreviousWindow: Activate new 2026-10-15 12:58:48.843 T:1176 debug : ------ Window Init (Home.xml) ------ 2026-10-15 12:58:48.845 T:1176 debug : CDirectoryProvider[favourites://]: refreshing... 2026-10-15 12:58:48.845 T:1176 debug : CDirectoryProvider[addons://sources/game/]: refreshing... 2026-10-15 12:58:50.924 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x6a, xkb keysym: 0xff53 (Right) 2026-10-15 12:58:50.924 T:1180 debug : CLibInputKeyboard::ProcessKey - using delay: 400ms repeat: 80ms 2026-10-15 12:58:50.924 T:9186 debug : Thread Timer start, auto delete: false 2026-10-15 12:58:50.928 T:1176 debug : Keyboard: scancode: 0x6a, sym: 0x113 (right), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:50.928 T:1176 debug : bool CInputManager::HandleKey(const CKey&): right (0xf083) pressed, window 10000, action is Right 2026-10-15 12:58:50.997 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x6a, xkb keysym: 0xff53 (Right) 2026-10-15 12:58:50.997 T:9186 debug : Thread Timer 139821485512384 terminating 2026-10-15 12:58:51.009 T:1176 debug : Keyboard: scancode: 0x6a, sym: 0x113 (right), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:51.523 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x69, xkb keysym: 0xff51 (Left) 2026-10-15 12:58:51.523 T:1180 debug : CLibInputKeyboard::ProcessKey - using delay: 400ms repeat: 80ms 2026-10-15 12:58:51.523 T:9187 debug : Thread Timer start, auto delete: false 2026-10-15 12:58:51.526 T:1176 debug : Keyboard: scancode: 0x69, sym: 0x114 (left), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:51.526 T:1176 debug : bool CInputManager::HandleKey(const CKey&): left (0xf082) pressed, window 10000, action is Left 2026-10-15 12:58:51.650 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x69, xkb keysym: 0xff51 (Left) 2026-10-15 12:58:51.651 T:9187 debug : Thread Timer 139821485512384 terminating 2026-10-15 12:58:51.660 T:1176 debug : Keyboard: scancode: 0x69, sym: 0x114 (left), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:51.850 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x6c, xkb keysym: 0xff54 (Down) 2026-10-15 12:58:51.850 T:1180 debug : CLibInputKeyboard::ProcessKey - using delay: 400ms repeat: 80ms 2026-10-15 12:58:51.851 T:9188 debug : Thread Timer start, auto delete: false 2026-10-15 12:58:51.857 T:1176 debug : Keyboard: scancode: 0x6c, sym: 0x112 (down), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:51.857 T:1176 debug : bool CInputManager::HandleKey(const CKey&): down (0xf081) pressed, window 10000, action is Down 2026-10-15 12:58:51.950 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x6c, xkb keysym: 0xff54 (Down) 2026-10-15 12:58:51.950 T:9188 debug : Thread Timer 139821485512384 terminating 2026-10-15 12:58:51.959 T:1176 debug : Keyboard: scancode: 0x6c, sym: 0x112 (down), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:52.100 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x6c, xkb keysym: 0xff54 (Down) 2026-10-15 12:58:52.100 T:1180 debug : CLibInputKeyboard::ProcessKey - using delay: 400ms repeat: 80ms 2026-10-15 12:58:52.100 T:9189 debug : Thread Timer start, auto delete: false 2026-10-15 12:58:52.109 T:1176 debug : Keyboard: scancode: 0x6c, sym: 0x112 (down), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:52.109 T:1176 debug : bool CInputManager::HandleKey(const CKey&): down (0xf081) pressed, window 10000, action is Down 2026-10-15 12:58:52.173 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x6c, xkb keysym: 0xff54 (Down) 2026-10-15 12:58:52.173 T:9189 debug : Thread Timer 139821485512384 terminating 2026-10-15 12:58:52.176 T:1176 debug : Keyboard: scancode: 0x6c, sym: 0x112 (down), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:53.223 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x6a, xkb keysym: 0xff53 (Right) 2026-10-15 12:58:53.224 T:1180 debug : CLibInputKeyboard::ProcessKey - using delay: 400ms repeat: 80ms 2026-10-15 12:58:53.224 T:9190 debug : Thread Timer start, auto delete: false 2026-10-15 12:58:53.224 T:1176 debug : Keyboard: scancode: 0x6a, sym: 0x113 (right), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:53.224 T:1176 debug : bool CInputManager::HandleKey(const CKey&): right (0xf083) pressed, window 10000, action is Right 2026-10-15 12:58:53.323 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x6a, xkb keysym: 0xff53 (Right) 2026-10-15 12:58:53.324 T:9190 debug : Thread Timer 139821485512384 terminating 2026-10-15 12:58:53.326 T:1176 debug : Keyboard: scancode: 0x6a, sym: 0x113 (right), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:53.523 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x161, xkb keysym: 0x1008ffa0 (XF86Select) 2026-10-15 12:58:53.523 T:1180 debug : CLibInputKeyboard::ProcessKey - using delay: 400ms repeat: 80ms 2026-10-15 12:58:53.524 T:9191 debug : Thread Timer start, auto delete: false 2026-10-15 12:58:53.526 T:1176 debug : Keyboard: scancode: 0x161, sym: 0x1f9 (), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:53.623 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x161, xkb keysym: 0x1008ffa0 (XF86Select) 2026-10-15 12:58:53.624 T:9191 debug : Thread Timer 139821485512384 terminating 2026-10-15 12:58:53.626 T:1176 debug : Keyboard: scancode: 0x161, sym: 0x1f9 (), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:53.626 T:1176 debug : bool CInputManager::HandleKey(const CKey&): select (0xf0f2) pressed, window 10000, action is Select 2026-10-15 12:58:53.626 T:1176 debug : Activating window ID: 10025 2026-10-15 12:58:53.928 T:1176 debug : ------ Window Deinit (Home.xml) ------ 2026-10-15 12:58:53.928 T:1176 debug : FreeVisualisation() done 2026-10-15 12:58:53.944 T:1176 debug : ------ Window Init (MyVideoNav.xml) ------ 2026-10-15 12:58:53.944 T:1176 debug : CGUIMediaWindow::GetDirectory (library://video/files.xml/) 2026-10-15 12:58:53.944 T:1176 debug : ParentPath = [/var/media/sdb1-ata-Samsung_SSD_980_/] 2026-10-15 12:58:53.957 T:9192 debug : Thread BackgroundLoader start, auto delete: false 2026-10-15 12:58:53.957 T:1176 debug : [threads] name: 'BackgroundLoader' priority: '1' 2026-10-15 12:58:53.959 T:9192 debug : Thread BackgroundLoader 139821523965632 terminating 2026-10-15 12:58:54.374 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x161, xkb keysym: 0x1008ffa0 (XF86Select) 2026-10-15 12:58:54.374 T:1180 debug : CLibInputKeyboard::ProcessKey - using delay: 400ms repeat: 80ms 2026-10-15 12:58:54.374 T:9193 debug : Thread Timer start, auto delete: false 2026-10-15 12:58:54.376 T:1176 debug : Keyboard: scancode: 0x161, sym: 0x1f9 (), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:54.500 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x161, xkb keysym: 0x1008ffa0 (XF86Select) 2026-10-15 12:58:54.500 T:9193 debug : Thread Timer 139821485512384 terminating 2026-10-15 12:58:54.511 T:1176 debug : Keyboard: scancode: 0x161, sym: 0x1f9 (), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:54.512 T:1176 debug : bool CInputManager::HandleKey(const CKey&): select (0xf0f2) pressed, window 10025, action is Select 2026-10-15 12:58:54.512 T:1176 debug : CGUIMediaWindow::GetDirectory (/var/media/sdb1-ata-Samsung_SSD_980_/) 2026-10-15 12:58:54.512 T:1176 debug : ParentPath = [sources://video/] 2026-10-15 12:58:54.512 T:9194 debug : Thread waiting start, auto delete: false 2026-10-15 12:58:54.513 T:9194 debug : Thread waiting 139821159159488 terminating 2026-10-15 12:58:54.527 T:9195 debug : Thread BackgroundLoader start, auto delete: false 2026-10-15 12:58:54.527 T:1176 debug : [threads] name: 'BackgroundLoader' priority: '1' 2026-10-15 12:58:54.531 T:9195 debug : Thread BackgroundLoader 139821523965632 terminating 2026-10-15 12:58:55.047 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x161, xkb keysym: 0x1008ffa0 (XF86Select) 2026-10-15 12:58:55.047 T:1180 debug : CLibInputKeyboard::ProcessKey - using delay: 400ms repeat: 80ms 2026-10-15 12:58:55.047 T:9196 debug : Thread Timer start, auto delete: false 2026-10-15 12:58:55.059 T:1176 debug : Keyboard: scancode: 0x161, sym: 0x1f9 (), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:55.150 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x161, xkb keysym: 0x1008ffa0 (XF86Select) 2026-10-15 12:58:55.150 T:9196 debug : Thread Timer 139821485512384 terminating 2026-10-15 12:58:55.156 T:1176 debug : Keyboard: scancode: 0x161, sym: 0x1f9 (), unicode: 0x00, modifier: 0x0 2026-10-15 12:58:55.156 T:1176 debug : bool CInputManager::HandleKey(const CKey&): select (0xf0f2) pressed, window 10025, action is Select 2026-10-15 12:58:55.157 T:1176 debug : OnPlayMedia /var/media/sdb1-ata-Samsung_SSD_980_/test.mkv 2026-10-15 12:58:55.161 T:1176 debug : CPlayerCoreFactory::GetPlayers(/var/media/sdb1-ata-Samsung_SSD_980_/test.mkv) 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: system rules 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: matches rule: system rules 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: rtmp 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: rtsp 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: streams 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: dvd 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: discimage 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: nsv 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: radio 2026-10-15 12:58:55.161 T:1176 debug : CPlayerCoreFactory::GetPlayers: matched 0 rules with players 2026-10-15 12:58:55.161 T:1176 debug : CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 2026-10-15 12:58:55.161 T:1176 debug : CPlayerCoreFactory::GetPlayers: for video=true, audio=false 2026-10-15 12:58:55.161 T:1176 debug : CPlayerCoreFactory::GetPlayers: for video=true, audio=true 2026-10-15 12:58:55.161 T:1176 debug : CPlayerCoreFactory::GetPlayers: added 1 players 2026-10-15 12:58:55.161 T:1176 debug : CPlayerCoreFactory::GetPlayers(/var/media/sdb1-ata-Samsung_SSD_980_/test.mkv) 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: system rules 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: matches rule: system rules 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: rtmp 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: rtsp 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: streams 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: dvd 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: discimage 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: nsv 2026-10-15 12:58:55.161 T:1176 debug : CPlayerSelectionRule::GetPlayers: considering rule: radio 2026-10-15 12:58:55.161 T:1176 debug : CPlayerCoreFactory::GetPlayers: matched 0 rules with players 2026-10-15 12:58:55.161 T:1176 debug : CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 2026-10-15 12:58:55.161 T:1176 debug : CPlayerCoreFactory::GetPlayers: for video=true, audio=false 2026-10-15 12:58:55.161 T:1176 debug : CPlayerCoreFactory::GetPlayers: for video=true, audio=true 2026-10-15 12:58:55.161 T:1176 debug : CPlayerCoreFactory::GetPlayers: added 1 players 2026-10-15 12:58:55.161 T:1176 debug : Radio UECP (RDS) Processor - new CDVDRadioRDSData 2026-10-15 12:58:55.161 T:1176 debug : Audio ID3 tag processor - new CVideoPlayerAudioID3 2026-10-15 12:58:55.161 T:1176 info : VideoPlayer::OpenFile: /var/media/sdb1-ata-Samsung_SSD_980_/test.mkv 2026-10-15 12:58:55.161 T:1176 debug : GLES: HQ scaler precision=10, intermediate format=0x8059 2026-10-15 12:58:55.162 T:9197 debug : Thread VideoPlayer start, auto delete: false 2026-10-15 12:58:55.162 T:1176 debug : virtual void CApplicationPlayerCallback::OnPlayBackStarted(const CFileItem&): call 2026-10-15 12:58:55.162 T:9198 debug : Thread BackgroundLoader start, auto delete: false 2026-10-15 12:58:55.162 T:9197 info : Creating InputStream 2026-10-15 12:58:55.162 T:1176 debug : [threads] name: 'BackgroundLoader' priority: '1' 2026-10-15 12:58:55.165 T:5778 debug : Loading settings for /var/media/sdb1-ata-Samsung_SSD_980_/test.mkv 2026-10-15 12:58:55.165 T:1176 debug : CVideoGUIInfo::InitCurrentItem(/var/media/sdb1-ata-Samsung_SSD_980_/test.mkv) 2026-10-15 12:58:55.165 T:1176 debug : CPlayerGUIInfo::InitCurrentItem(/var/media/sdb1-ata-Samsung_SSD_980_/test.mkv) 2026-10-15 12:58:55.167 T:9197 debug : ScanForExternalSubtitles: Searching for subtitles... 2026-10-15 12:58:55.167 T:9197 debug : ScanForExternalSubtitles: END (total time: 0 ms) 2026-10-15 12:58:55.167 T:9197 info : Creating Demuxer 2026-10-15 12:58:55.167 T:9197 debug : Open - probing detected format [matroska,webm] 2026-10-15 12:58:55.168 T:9198 debug : Thread BackgroundLoader 139821523965632 terminating 2026-10-15 12:58:55.193 T:9197 debug : Open - avformat_find_stream_info starting 2026-10-15 12:58:55.193 T:9197 debug : Open - av_find_stream_info finished 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Input #0, matroska,webm, from '/var/media/sdb1-ata-Samsung_SSD_980_/test.mkv': 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Metadata: 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: encoder : libebml v1.4.5 + libmatroska v1.7.1 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: creation_time : 2026-08-29T18:50:27.000000Z 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Duration: 00:47:44.88, start: 0.000000, bitrate: 88252 kb/s 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Chapters: 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Chapter #0:0: start 0.000000, end 11.011000 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Metadata: 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: title : Chapter 01 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Chapter #0:1: start 11.011000, end 575.449875 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Metadata: 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: title : Chapter 02 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Chapter #0:2: start 575.449875, end 1281.613667 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Metadata: 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: title : Chapter 03 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Chapter #0:3: start 1281.613667, end 2155.486667 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Metadata: 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: title : Chapter 04 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Chapter #0:4: start 2155.486667, end 2783.530750 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Metadata: 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: title : Chapter 05 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Chapter #0:5: start 2783.530750, end 2853.851000 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Metadata: 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: title : Chapter 06 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Chapter #0:6: start 2853.851000, end 2864.862000 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Metadata: 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: title : Chapter 07 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Stream #0:0(eng): Video: hevc (Main 10), yuv420p10le(tv, bt2020nc/bt2020/smpte2084), 3840x2160 [SAR 1:1 DAR 16:9], 23.98 fps, 23.98 tbr, 1k tbn (default) 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Metadata: 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: BPS : 83280432 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: DURATION : 00:47:44.862000000 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: NUMBER_OF_FRAMES: 68688 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: NUMBER_OF_BYTES : 29823368423 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: SOURCE_ID : 001011 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: _STATISTICS_WRITING_APP: mkvmerge v99.0 ('Buka') 64-bit 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: _STATISTICS_WRITING_DATE_UTC: 2026-08-29 18:50:27 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES SOURCE_ID 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Side data: 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: DOVI configuration record: version: 1.0, profile: 7, level: 6, rpu flag: 1, el flag: 1, bl flag: 1, compatibility id: 6, compression: 0 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: HEVC enhancement-layer decoder configuration: (175 bytes) 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Stream #0:1(eng): Audio: dts (dca) (DTS-HD MA), 48000 Hz, 5.1(side), s32p (24 bit) (default) 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Metadata: 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: title : Surround 5.1 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: BPS : 3627754 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: DURATION : 00:47:44.875000000 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: NUMBER_OF_FRAMES: 268582 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: NUMBER_OF_BYTES : 1299132964 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: SOURCE_ID : 001100 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: _STATISTICS_WRITING_APP: mkvmerge v99.0 ('Buka') 64-bit 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: _STATISTICS_WRITING_DATE_UTC: 2026-08-29 18:50:27 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES SOURCE_ID 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Stream #0:2(eng): Audio: flac, 48000 Hz, stereo, s32 (24 bit) 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Metadata: 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: title : Stereo 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: BPS : 1299352 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: DURATION : 00:47:44.861000000 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: NUMBER_OF_FRAMES: 29843 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: NUMBER_OF_BYTES : 465308027 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: _STATISTICS_WRITING_APP: mkvmerge v99.0 ('Buka') 64-bit 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: _STATISTICS_WRITING_DATE_UTC: 2026-08-29 18:50:27 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Stream #0:3(eng): Subtitle: hdmv_pgs_subtitle (pgssub), 1920x1080 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: Metadata: 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: title : English (SDH) 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: BPS : 40906 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: DURATION : 00:47:34.289000000 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: NUMBER_OF_FRAMES: 1542 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: NUMBER_OF_BYTES : 14594837 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: SOURCE_ID : 0012A0 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: _STATISTICS_WRITING_APP: mkvmerge v99.0 ('Buka') 64-bit 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: _STATISTICS_WRITING_DATE_UTC: 2026-08-29 18:50:27 2026-10-15 12:58:55.193 T:9197 info : ffmpeg[0x1f9d9340]: _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES SOURCE_ID 2026-10-15 12:58:55.193 T:9197 debug : CDVDDemuxFFmpeg::AddStream ID: 0 2026-10-15 12:58:55.193 T:9197 debug : CDVDDemuxFFmpeg::AddStream ID: 1 2026-10-15 12:58:55.193 T:9197 debug : CDVDDemuxFFmpeg::AddStream ID: 2 2026-10-15 12:58:55.193 T:9197 debug : CDVDDemuxFFmpeg::AddStream ID: 3 2026-10-15 12:58:55.193 T:9197 info : Opening stream: 0 source: 256 2026-10-15 12:58:55.265 T:1176 debug : ------ Window Init (DialogBusy.xml) ------ 2026-10-15 12:58:55.267 T:1176 debug : OnLostDevice - notify display change event 2026-10-15 12:58:55.267 T:1176 info : VideoPlayer: OnLostDisplay received 2026-10-15 12:58:55.267 T:1176 debug : Flush - flushing renderer 2026-10-15 12:58:55.267 T:1176 debug : virtual bool KODI::WINDOWING::GBM::CDRMUtils::SetMode(const RESOLUTION_INFO&): Found crtc mode: 3840x2160 @ 24 Hz 2026-10-15 12:58:55.267 T:1176 debug : virtual void KODI::WINDOWING::GBM::CDRMAtomic::FlipPage(gbm_bo*, bool, bool, bool): Execute modeset at next commit 2026-10-15 12:58:55.406 T:1176 info : DVBridge signal committed: connector=402 crtc=376 dv=0 hdr_blob=0 colorspace=0 max_bpc=16 rgb=0 mode=3840x2160 clock_khz=296703 totals=5500x2250 flags=5 vscan=0 active=1 2026-10-15 12:58:55.406 T:1176 info : GLES: Maximum texture width: 16384 2026-10-15 12:58:55.406 T:1209 debug : CALSAHControlMonitor - Monitored ALSA hctl value changed 2026-10-15 12:58:55.407 T:9197 info : Creating video codec: hevc 2026-10-15 12:58:55.407 T:9197 info : DVBridge stream candidate: profile=7 level=6 compatibility=6 native_eligible=true software=false interlaced=false stereo=false mode=0 (selection probe, not active output) 2026-10-15 12:58:55.407 T:9197 info : Skipped 1 duplicate messages.. 2026-10-15 12:58:55.407 T:9197 info : CDVDVideoCodecFFmpeg::Open() Using codec: HEVC (High Efficiency Video Coding) 2026-10-15 12:58:55.407 T:9197 debug : CDVDVideoCodecFFmpeg - Updated codec: ff-hevc 2026-10-15 12:58:55.407 T:9197 debug : CVideoPlayerVideo::OpenStream - open stream with codec: hevc 2026-10-15 12:58:55.407 T:9197 info : Creating video thread 2026-10-15 12:58:55.407 T:9199 debug : Thread VideoPlayerVideo start, auto delete: false 2026-10-15 12:58:55.407 T:9199 info : running thread: video_thread 2026-10-15 12:58:55.407 T:9197 debug : bool CEdl::ReadEditDecisionLists(const CFileItem&, float, std::chrono::milliseconds): Checking for edit decision lists (EDL) for: /var/media/sdb1-ata-Samsung_SSD_980_/test.mkv 2026-10-15 12:58:55.407 T:9199 debug : CVideoPlayerVideo - CDVDMsg::GENERAL_PAUSE: true 2026-10-15 12:58:55.411 T:9197 debug : CVideoPlayer::OpenStream: m_bFullScreenVideo set pre-Configure, viewport 3840x2160 2026-10-15 12:58:55.411 T:9197 info : Opening stream: 1 source: 256 2026-10-15 12:58:55.411 T:9197 info : Finding audio codec for: 86020 2026-10-15 12:58:55.411 T:9197 info : void CVideoPlayerAudio::OpenStream(CDVDStreamInfo&, std::unique_ptr): Allowing max Out-Of-Sync Value of 50 ms 2026-10-15 12:58:55.411 T:9197 info : Creating audio thread 2026-10-15 12:58:55.411 T:9200 debug : Thread VideoPlayerAudio start, auto delete: false 2026-10-15 12:58:55.411 T:9200 info : running thread: CVideoPlayerAudio::Process() 2026-10-15 12:58:55.411 T:9197 info : Opening stream: 3 source: 256 2026-10-15 12:58:55.411 T:9197 debug : Created subtitles overlay codec: ff-pgssub 2026-10-15 12:58:55.411 T:9197 debug : CVideoPlayer::SetCaching - caching state 2 2026-10-15 12:58:55.411 T:9197 debug : CDVDClock::SetSpeedAdjust - adjusted:0.000000 2026-10-15 12:58:55.412 T:1176 debug : CWinSystemGbmGLESContext::PresentRender - Sending display reset to all clients 2026-10-15 12:58:55.412 T:1176 info : VideoPlayer: OnResetDisplay received 2026-10-15 12:58:55.412 T:1207 debug : CActiveAE - display reset event 2026-10-15 12:58:55.412 T:9199 debug : CVideoPlayerVideo - CDVDMsg::GENERAL_PAUSE: false 2026-10-15 12:58:55.412 T:1208 info : void ActiveAE::CActiveAESink::OpenSink(): initialize sink 2026-10-15 12:58:55.412 T:1208 debug : void ActiveAE::CActiveAESink::OpenSink(): trying to open device ALSA:hdmi:CARD=Generic,DEV=1 2026-10-15 12:58:55.412 T:1208 info : CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=Generic,DEV=1" 2026-10-15 12:58:55.421 T:9200 debug : CVideoPlayerAudio - CDVDMsg::GENERAL_PAUSE: true 2026-10-15 12:58:55.421 T:9200 debug : CDVDAudio::Pause - pausing audio stream 2026-10-15 12:58:55.421 T:9200 debug : CVideoPlayerAudio - CDVDMsg::GENERAL_PAUSE: false 2026-10-15 12:58:55.428 T:1208 info : CAESinkALSA::Initialize - Opened device "hdmi:CARD=Generic,DEV=1,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x02" 2026-10-15 12:58:55.428 T:1208 info : CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 2026-10-15 12:58:55.428 T:1208 info : CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 2026-10-15 12:58:55.428 T:1208 debug : CAESinkALSA::InitializeHW - Request: periodSize 2400, bufferSize 9600 2026-10-15 12:58:55.433 T:1208 debug : CAESinkALSA::InitializeHW - Got: periodSize 2400, bufferSize 9600 2026-10-15 12:58:55.433 T:1208 debug : CAESinkALSA::InitializeHW - Setting timeout to 200 ms 2026-10-15 12:58:55.433 T:1208 debug : CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 2026-10-15 12:58:55.433 T:1208 debug : CAESinkALSA::GetChannelLayout - Requested Layout: FL, FR 2026-10-15 12:58:55.433 T:1208 debug : CAESinkALSA::GetChannelLayout - Got Layout: FL, FR (ALSA: FL FR) 2026-10-15 12:58:55.433 T:1208 debug : void ActiveAE::CActiveAESink::OpenSink(): ALSA Initialized: 2026-10-15 12:58:55.433 T:1208 debug : Output Device : Device not found 2026-10-15 12:58:55.433 T:1208 debug : Sample Rate : 48000 2026-10-15 12:58:55.433 T:1208 debug : Sample Format : AE_FMT_S32NE 2026-10-15 12:58:55.433 T:1208 debug : Channel Count : 2 2026-10-15 12:58:55.433 T:1208 debug : Channel Layout: FL, FR 2026-10-15 12:58:55.433 T:1208 debug : Frames : 2400 2026-10-15 12:58:55.433 T:1208 debug : Frame Size : 8 2026-10-15 12:58:55.433 T:1207 debug : void ActiveAE::CActiveAE::ConfigureLowLatency(): Low latency mode: true - Initial buffer level: 20ms (resample: false) 2026-10-15 12:58:55.434 T:1207 debug : CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2026-10-15 12:58:55.462 T:9197 debug : CVideoPlayer::HandleMessages - player 2 reported state: 0 2026-10-15 12:58:55.462 T:9197 debug : CVideoPlayer::HandleMessages - player 1 reported state: 0 2026-10-15 12:58:55.462 T:5780 debug : virtual void CApplicationPlayerCallback::OnAVChange(): call 2026-10-15 12:58:55.462 T:9197 debug : CVideoPlayer::SetCaching - caching state 1 2026-10-15 12:58:55.462 T:9199 debug : CVideoPlayerVideo - Stillframe left, switching to normal playback 2026-10-15 12:58:55.462 T:9197 debug : CDVDClock::SetSpeedAdjust - adjusted:0.000000 2026-10-15 12:58:55.462 T:5778 debug : virtual void CApplicationPlayerCallback::OnAVChange(): call 2026-10-15 12:58:55.462 T:9197 debug : CVideoPlayer::CheckContinuity - wrapback :2, prev:167000.000000, curr:0.000000, diff:-167000.000000 2026-10-15 12:58:55.463 T:9201 debug : Thread Vaapi-Output start, auto delete: false 2026-10-15 12:58:55.463 T:9201 info : COutput::OnStartup: Output Thread created 2026-10-15 12:58:55.463 T:9199 debug : CDVDVideoCodecFFmpeg - Updated codec: ff-hevc-vaapi 2026-10-15 12:58:55.472 T:9200 debug : CDVDAudio::Pause - pausing audio stream 2026-10-15 12:58:55.472 T:9200 info : CAEStreamParser::SyncDTS - dtsHD MA stream detected (8 channels, 48000Hz, 16bit BE, period: 8192, syncword: 0x41a29547, target rate: 0x18, framesize 2080)) 2026-10-15 12:58:55.472 T:9200 info : CVideoPlayerAudio: display reset occurred, checking for passthrough 2026-10-15 12:58:55.472 T:9200 info : Creating audio stream (codec: dts, channels: 8, sample rate: 48000, pass-through) 2026-10-15 12:58:55.472 T:9200 debug : CVideoPlayerAudio:: synctype set to 0: clock feedback 2026-10-15 12:58:55.480 T:9197 debug : CVideoPlayer::SetCaching - caching state 2 2026-10-15 12:58:55.480 T:9197 debug : CDVDClock::SetSpeedAdjust - adjusted:0.000000 2026-10-15 12:58:55.514 T:9199 debug : CRenderManager::Configure - change configuration. 3840x2160. display: 3840x2160. framerate: 23.98. 2026-10-15 12:58:55.534 T:1208 info : void ActiveAE::CActiveAESink::OpenSink(): initialize sink 2026-10-15 12:58:55.536 T:1176 debug : DeleteRenderer - deleting renderer 2026-10-15 12:58:55.536 T:1176 debug : LinuxRendererGLES: Cleaning up GLES resources 2026-10-15 12:58:55.536 T:1176 debug : GLES: HQ scaler precision=10, intermediate format=0x8059 2026-10-15 12:58:55.536 T:1176 debug : LinuxRendererGLES::Configure: fps: 23.976, 3840x2160, colorimetry: BT2020_YCC, 10bit, limited range 2026-10-15 12:58:55.536 T:1176 debug : CBaseRenderer::ManageRenderArea: viewRect 0x0 -> 3840x2160 2026-10-15 12:58:55.536 T:1176 debug : virtual void KODI::WINDOWING::GBM::CWinSystemGbm::SetColorimetry(const VideoPicture*): setting connector colorspace to BT2020_RGB (source BT2020_YCC) 2026-10-15 12:58:55.538 T:1176 info : DVBridge renderer init: rgb=8/8/8 samples=0 linear=true direct_target=true renderer=true packer=true 2026-10-15 12:58:55.539 T:1176 debug : CGuiCompositeShaderGLES::CreateLUTs - created PQ LUT (256 entries) 2026-10-15 12:58:55.539 T:1176 debug : GLES: Requested render method: 0 2026-10-15 12:58:55.539 T:1176 debug : GLES: using shader format: NV12 red/red/green 2026-10-15 12:58:55.539 T:1176 debug : GLES: using tonemap method: off 2026-10-15 12:58:55.539 T:1176 info : GLES: Selecting YUV 2 RGB shader 2026-10-15 12:58:55.539 T:1176 debug : GLES: using shader format: NV12 red/red/green 2026-10-15 12:58:55.539 T:1176 debug : GLES: using tonemap method: off 2026-10-15 12:58:55.540 T:1176 debug : CRenderManager::Configure - 4 2026-10-15 12:58:55.540 T:9197 debug : CVideoPlayer::HandleMessages - player started 2 2026-10-15 12:58:55.540 T:5781 debug : virtual void CApplicationPlayerCallback::OnAVChange(): call 2026-10-15 12:58:55.543 T:1176 debug : Skipped 1 duplicate messages.. 2026-10-15 12:58:55.543 T:1176 debug : CWinSystemGbmGLESContext: created GUI FBO 3840x2160 2026-10-15 12:58:55.543 T:1176 info : CB1 FEL upscaling: VAAPI unavailable, using full shader FEL reconstruction 2026-10-15 12:58:55.543 T:1176 info : DVBridge policy requested: source=1732/1/1732 policy=1732 requested=1 effective=1 eligible=true fallback=false 2026-10-15 12:58:55.543 T:1176 info : DVBridge output admission: generation=1 source_known=true gpu_known=true native_dv=true hdr10=true requested=Dolby Vision Standard effective=Dolby Vision Standard reason=none 2026-10-15 12:58:55.548 T:1176 info : DVBridge first frame: source=3840x2160 output=3840x2160 offset=0,0 enhancement=true fel=true cm4=true direct=true 2026-10-15 12:58:55.548 T:1176 info : DVBridge policy prepared: source=1732/1/1732 policy=1732 mode=1 2026-10-15 12:58:55.734 T:1208 debug : void ActiveAE::CActiveAESink::OpenSink(): trying to open device ALSA:hdmi:CARD=Generic,DEV=1 2026-10-15 12:58:55.734 T:1208 info : CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=Generic,DEV=1" 2026-10-15 12:58:55.737 T:1208 info : CAESinkALSA::Initialize - Opened device "hdmi:CARD=Generic,DEV=1,AES0=0x06,AES1=0x82,AES2=0x00,AES3=0x09" 2026-10-15 12:58:55.737 T:1208 debug : CAESinkALSA::InitializeHW - Request: periodSize 9600, bufferSize 38400 2026-10-15 12:58:55.743 T:1208 debug : CAESinkALSA::InitializeHW - Got: periodSize 9600, bufferSize 38400 2026-10-15 12:58:55.743 T:1208 debug : CAESinkALSA::InitializeHW - Setting timeout to 200 ms 2026-10-15 12:58:55.743 T:1208 debug : CAESinkALSA::GetChannelLayout - Input Channel Count: 8 Output Channel Count: 8 2026-10-15 12:58:55.743 T:1208 debug : CAESinkALSA::GetChannelLayout - Requested Layout: RAW, RAW, RAW, RAW, RAW, RAW, RAW, RAW 2026-10-15 12:58:55.743 T:1208 debug : CAESinkALSA::GetChannelLayout - Got Layout: RAW, RAW, RAW, RAW, RAW, RAW, RAW, RAW (ALSA: none) 2026-10-15 12:58:55.743 T:1208 debug : void ActiveAE::CActiveAESink::OpenSink(): ALSA Initialized: 2026-10-15 12:58:55.743 T:1208 debug : Output Device : Device not found 2026-10-15 12:58:55.743 T:1208 debug : Sample Rate : 192000 2026-10-15 12:58:55.743 T:1208 debug : Sample Format : AE_FMT_S16NE 2026-10-15 12:58:55.743 T:1208 debug : Channel Count : 8 2026-10-15 12:58:55.743 T:1208 debug : Channel Layout: RAW, RAW, RAW, RAW, RAW, RAW, RAW, RAW 2026-10-15 12:58:55.743 T:1208 debug : Frames : 9600 2026-10-15 12:58:55.743 T:1208 debug : Frame Size : 16 2026-10-15 12:58:55.747 T:1207 debug : void ActiveAE::CActiveAE::ConfigureLowLatency(): Low latency mode: true - Initial buffer level: 20ms (resample: false) 2026-10-15 12:58:55.747 T:1207 debug : CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2026-10-15 12:58:55.748 T:9200 debug : Skipped 1 duplicate messages.. 2026-10-15 12:58:55.748 T:9200 debug : CDVDAudio::Pause - pausing audio stream 2026-10-15 12:58:55.753 T:9197 debug : CVideoPlayer::HandleMessages - player started 1 2026-10-15 12:58:55.753 T:9197 debug : CVideoPlayer::SetCaching - caching state 3 2026-10-15 12:58:55.753 T:5780 debug : virtual void CApplicationPlayerCallback::OnAVChange(): call 2026-10-15 12:58:55.753 T:9197 debug : CDVDClock::SetSpeedAdjust - adjusted:0.000000 2026-10-15 12:58:55.753 T:9197 debug : CVideoPlayer::SetCaching - caching state 0 2026-10-15 12:58:55.753 T:9197 debug : CDVDClock::SetSpeedAdjust - adjusted:0.000000 2026-10-15 12:58:55.753 T:9197 debug : VideoPlayer::Sync - Audio - pts: 298000.000000, cache: 504929.917901, totalcache: 800000.011921 2026-10-15 12:58:55.753 T:9197 debug : VideoPlayer::Sync - Video - pts: 0.000000, cache: 50000.000000, totalcache: 100000.000000 2026-10-15 12:58:55.753 T:9200 debug : CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(-206929.917901), level: 92, cache: 499671.097901 2026-10-15 12:58:55.753 T:9199 debug : CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(-206929.917901) 2026-10-15 12:58:55.753 T:9200 debug : CDVDAudio::Resume - resume audio stream 2026-10-15 12:58:55.753 T:1207 debug : ActiveAE - start sync of audio stream 2026-10-15 12:58:55.753 T:5780 debug : virtual void CApplicationPlayerCallback::OnAVStarted(const CFileItem&): call 2026-10-15 12:58:55.771 T:1209 debug : CALSAHControlMonitor - Monitored ALSA hctl value changed 2026-10-15 12:58:55.771 T:1207 debug : CActiveAE - device change event 2026-10-15 12:58:55.771 T:1209 debug : CALSAHControlMonitor - Monitored ALSA hctl value changed 2026-10-15 12:58:55.771 T:1176 info : DVBridge signal committed: connector=402 crtc=376 dv=1 hdr_blob=0 colorspace=0 max_bpc=8 rgb=1 mode=3840x2160 clock_khz=296703 totals=5500x2250 flags=5 vscan=0 active=1 2026-10-15 12:58:55.771 T:1176 info : DVBridge policy committed: source=1732/1/1732 policy=1732 mode=1 bits=8 authored_legacy=false samples=0 creative_status=0 creative_reason=0 applied=0 edited=0 2026-10-15 12:58:55.771 T:1176 info : DVBridge output selection: requested=Dolby Vision Standard effective=Dolby Vision Standard preset=0 reason=none minimum_link_bits=0 profile=7 bl=true el=true rpu=true hdr_origin=source-RPU 2026-10-15 12:58:55.773 T:1176 debug : Activating window ID: 12005 2026-10-15 12:58:55.773 T:1176 debug : ------ Window Deinit (MyVideoNav.xml) ------ 2026-10-15 12:58:55.773 T:1176 debug : FreeVisualisation() done 2026-10-15 12:58:55.773 T:1176 debug : ------ Window Init (VideoFullScreen.xml) ------ 2026-10-15 12:58:55.775 T:5780 debug : virtual void CApplicationPlayerCallback::OnAVChange(): call 2026-10-15 12:58:55.813 T:1176 debug : ------ Window Deinit (DialogBusy.xml) ------ 2026-10-15 12:58:55.861 T:9199 info : DVBridge playback health: interval_ms=0 output_attempts=1 source_fps=23.976 speed=1000 stalled=false pts_s=0.209 drop_total=0 skip_total=0 drop_delta=0 skip_delta=0 counters_reset=false video_queue_pct=94 video_queue_s=3.753 bitrate_mbps=0.00 render_avg_pct=unavailable transitions=9 pts_valid=true (speed 1000=normal; attempts are not display flips) 2026-10-15 12:58:55.940 T:9199 info : CDVDVideoCodecFFmpeg::CDropControl: calculated diff time: 41727 2026-10-15 12:58:56.004 T:1207 info : CAESinkALSA - Unable to open device "default" for playback 2026-10-15 12:58:56.011 T:1207 debug : CAESinkALSA - HDMI device "hdmi:CARD=Generic,DEV=0" may be unconnected (no ELD data) 2026-10-15 12:58:56.011 T:1207 debug : CAESinkALSA - HDMI device "hdmi:CARD=Generic,DEV=2" may be unconnected (no ELD data) 2026-10-15 12:58:56.012 T:1207 debug : CAESinkALSA - HDMI device "hdmi:CARD=Generic,DEV=3" may be unconnected (no ELD data) 2026-10-15 12:58:56.015 T:1207 info : CAESinkALSA - Unable to open device "surround21:CARD=Generic_1,DEV=0" for playback 2026-10-15 12:58:56.016 T:1207 debug : PulseAudio: Context authorizing 2026-10-15 12:58:56.016 T:1207 debug : PulseAudio: Context setting name 2026-10-15 12:58:56.016 T:1207 debug : PulseAudio: Context ready 2026-10-15 12:58:56.016 T:1207 warning : Pulseaudio module module-allow-passthrough not loaded - opening PT devices might fail 2026-10-15 12:58:56.016 T:1207 info : Found 2 Lists of Devices 2026-10-15 12:58:56.016 T:1207 info : Enumerated ALSA devices: 2026-10-15 12:58:56.016 T:1207 info : Device 1 2026-10-15 12:58:56.016 T:1207 info : m_deviceName : hdmi:CARD=Generic,DEV=0 2026-10-15 12:58:56.016 T:1207 info : m_displayName : HD-Audio Generic 2026-10-15 12:58:56.016 T:1207 info : m_displayNameExtra: HDMI #0 2026-10-15 12:58:56.016 T:1207 info : m_deviceType : AE_DEVTYPE_HDMI 2026-10-15 12:58:56.016 T:1207 info : m_channels : FL, FR 2026-10-15 12:58:56.016 T:1207 info : m_sampleRates : 32000,44100,48000,88200,96000,176400,192000 2026-10-15 12:58:56.016 T:1207 info : m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW 2026-10-15 12:58:56.016 T:1207 info : m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_MA,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD 2026-10-15 12:58:56.016 T:1207 info : Device 2 2026-10-15 12:58:56.016 T:1207 info : m_deviceName : hdmi:CARD=Generic,DEV=1 2026-10-15 12:58:56.016 T:1207 info : m_displayName : HD-Audio Generic 2026-10-15 12:58:56.016 T:1207 info : m_displayNameExtra: SNY SONY TV *30 on HDMI #1 2026-10-15 12:58:56.016 T:1207 info : m_deviceType : AE_DEVTYPE_HDMI 2026-10-15 12:58:56.016 T:1207 info : m_channels : FL, FR, LFE, FC, BL, BR, BC, BLOC, BROC 2026-10-15 12:58:56.016 T:1207 info : m_sampleRates : 32000,44100,48000,88200,96000,176400,192000 2026-10-15 12:58:56.016 T:1207 info : m_dataFormats : AE_FMT_RAW,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW 2026-10-15 12:58:56.016 T:1207 info : m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_MA,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD 2026-10-15 12:58:56.016 T:1207 info : Device 3 2026-10-15 12:58:56.016 T:1207 info : m_deviceName : hdmi:CARD=Generic,DEV=2 2026-10-15 12:58:56.016 T:1207 info : m_displayName : HD-Audio Generic 2026-10-15 12:58:56.016 T:1207 info : m_displayNameExtra: HDMI #2 2026-10-15 12:58:56.016 T:1207 info : m_deviceType : AE_DEVTYPE_HDMI 2026-10-15 12:58:56.016 T:1207 info : m_channels : FL, FR 2026-10-15 12:58:56.016 T:1207 info : m_sampleRates : 32000,44100,48000,88200,96000,176400,192000 2026-10-15 12:58:56.016 T:1207 info : m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW 2026-10-15 12:58:56.016 T:1207 info : m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_MA,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD 2026-10-15 12:58:56.016 T:1207 info : Device 4 2026-10-15 12:58:56.016 T:1207 info : m_deviceName : hdmi:CARD=Generic,DEV=3 2026-10-15 12:58:56.016 T:1207 info : m_displayName : HD-Audio Generic 2026-10-15 12:58:56.016 T:1207 info : m_displayNameExtra: HDMI #3 2026-10-15 12:58:56.016 T:1207 info : m_deviceType : AE_DEVTYPE_HDMI 2026-10-15 12:58:56.016 T:1207 info : m_channels : FL, FR 2026-10-15 12:58:56.016 T:1207 info : m_sampleRates : 32000,44100,48000,88200,96000,176400,192000 2026-10-15 12:58:56.016 T:1207 info : m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW 2026-10-15 12:58:56.016 T:1207 info : m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_MA,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD 2026-10-15 12:58:56.016 T:1207 info : Device 5 2026-10-15 12:58:56.016 T:1207 info : m_deviceName : @:CARD=Generic_1,DEV=0 2026-10-15 12:58:56.016 T:1207 info : m_displayName : HD-Audio Generic 2026-10-15 12:58:56.016 T:1207 info : m_displayNameExtra: ALC897 Analog 2026-10-15 12:58:56.016 T:1207 info : m_deviceType : AE_DEVTYPE_PCM 2026-10-15 12:58:56.016 T:1207 info : m_channels : FL, FR 2026-10-15 12:58:56.016 T:1207 info : m_sampleRates : 48000 2026-10-15 12:58:56.016 T:1207 info : m_dataFormats : AE_FMT_S32NE 2026-10-15 12:58:56.016 T:1207 info : m_streamTypes : No passthrough capabilities 2026-10-15 12:58:56.016 T:1207 info : Enumerated PULSE devices: 2026-10-15 12:58:56.016 T:1207 info : Device 1 2026-10-15 12:58:56.016 T:1207 info : m_deviceName : Default 2026-10-15 12:58:56.016 T:1207 info : m_displayName : Default 2026-10-15 12:58:56.016 T:1207 info : m_displayNameExtra: Bluetooth Audio (PULSEAUDIO) 2026-10-15 12:58:56.016 T:1207 info : m_deviceType : AE_DEVTYPE_PCM 2026-10-15 12:58:56.016 T:1207 info : m_channels : FL, FR 2026-10-15 12:58:56.016 T:1207 info : m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000 2026-10-15 12:58:56.016 T:1207 info : m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT 2026-10-15 12:58:56.016 T:1207 info : m_streamTypes : No passthrough capabilities 2026-10-15 12:58:56.016 T:1208 info : void ActiveAE::CActiveAESink::OpenSink(): initialize sink 2026-10-15 12:58:56.016 T:1208 debug : void ActiveAE::CActiveAESink::OpenSink(): trying to open device ALSA:hdmi:CARD=Generic,DEV=1 2026-10-15 12:58:56.016 T:1208 info : CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=Generic,DEV=1" 2026-10-15 12:58:56.018 T:1208 info : CAESinkALSA::Initialize - Opened device "hdmi:CARD=Generic,DEV=1,AES0=0x06,AES1=0x82,AES2=0x00,AES3=0x09" 2026-10-15 12:58:56.018 T:1208 debug : CAESinkALSA::InitializeHW - Request: periodSize 9600, bufferSize 38400 2026-10-15 12:58:56.018 T:1208 debug : CAESinkALSA::InitializeHW - Got: periodSize 9600, bufferSize 38400 2026-10-15 12:58:56.018 T:1208 debug : CAESinkALSA::InitializeHW - Setting timeout to 200 ms 2026-10-15 12:58:56.018 T:1208 debug : CAESinkALSA::GetChannelLayout - Input Channel Count: 8 Output Channel Count: 8 2026-10-15 12:58:56.018 T:1208 debug : CAESinkALSA::GetChannelLayout - Requested Layout: RAW, RAW, RAW, RAW, RAW, RAW, RAW, RAW 2026-10-15 12:58:56.018 T:1208 debug : CAESinkALSA::GetChannelLayout - Got Layout: RAW, RAW, RAW, RAW, RAW, RAW, RAW, RAW (ALSA: none) 2026-10-15 12:58:56.018 T:1208 debug : void ActiveAE::CActiveAESink::OpenSink(): ALSA Initialized: 2026-10-15 12:58:56.018 T:1208 debug : Output Device : Device not found 2026-10-15 12:58:56.018 T:1208 debug : Sample Rate : 192000 2026-10-15 12:58:56.018 T:1208 debug : Sample Format : AE_FMT_S16NE 2026-10-15 12:58:56.018 T:1208 debug : Channel Count : 8 2026-10-15 12:58:56.018 T:1208 debug : Channel Layout: RAW, RAW, RAW, RAW, RAW, RAW, RAW, RAW 2026-10-15 12:58:56.018 T:1208 debug : Frames : 9600 2026-10-15 12:58:56.018 T:1208 debug : Frame Size : 16 2026-10-15 12:58:56.021 T:1207 debug : void ActiveAE::CActiveAE::ConfigureLowLatency(): Low latency mode: true - Initial buffer level: 20ms (resample: false) 2026-10-15 12:58:56.021 T:1207 debug : CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2026-10-15 12:58:56.021 T:1207 debug : Skipped 2 duplicate messages.. 2026-10-15 12:58:56.021 T:1207 debug : ActiveAE::SyncStream - average error of 67.028985, start adjusting 2026-10-15 12:58:56.069 T:1207 debug : ActiveAE::SyncStream - average error 27.028985 below threshold of 30.000000 2026-10-15 12:58:57.119 T:1207 debug : ActiveAE::SyncStream - average error 118.143061 above threshold of 100.000000 2026-10-15 12:58:57.173 T:1207 debug : ActiveAE::SyncStream - average error 28.143061 below threshold of 30.000000 2026-10-15 12:59:00.741 T:9199 debug : CPtsTracker: detected pattern of length 1: 41708.33, frameduration: 41708.333333 2026-10-15 12:59:05.869 T:9199 info : DVBridge playback health: interval_ms=10009 output_attempts=239 source_fps=23.976 speed=1000 stalled=false pts_s=10.177 drop_total=0 skip_total=0 drop_delta=0 skip_delta=0 counters_reset=false video_queue_pct=95 video_queue_s=3.795 bitrate_mbps=33.09 render_avg_pct=unavailable transitions=0 pts_valid=true (speed 1000=normal; attempts are not display flips) 2026-10-15 12:59:06.372 T:9199 debug : CDVDVideoCodecFFmpeg - Updated codec: ff-hevc 2026-10-15 12:59:06.372 T:9218 debug : Thread Vaapi-Output start, auto delete: false 2026-10-15 12:59:06.372 T:9218 info : COutput::OnStartup: Output Thread created 2026-10-15 12:59:06.372 T:9199 debug : CDVDVideoCodecFFmpeg - Updated codec: ff-hevc-vaapi 2026-10-15 12:59:06.386 T:9199 warning : CVideoSurfaces::ClearReference - surface invalid 2026-10-15 12:59:06.386 T:9199 warning : VAAPI::Decode - ignoring frame of a previous decoder generation 2026-10-15 12:59:06.386 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 12:59:06.388 T:9199 warning : CVideoSurfaces::ClearReference - surface invalid 2026-10-15 12:59:06.388 T:9199 warning : VAAPI::Decode - ignoring frame of a previous decoder generation 2026-10-15 12:59:06.388 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 12:59:06.395 T:9199 debug : Skipped 1 duplicate messages.. 2026-10-15 12:59:06.395 T:9199 warning : CVideoSurfaces::ClearReference - surface invalid 2026-10-15 12:59:06.395 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 12:59:13.446 T:9200 debug : Skipped 5405 duplicate messages.. 2026-10-15 12:59:13.446 T:9200 info : CVideoPlayerAudio::Process - stream stalled 2026-10-15 12:59:13.448 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 12:59:13.453 T:9197 debug : Skipped 4 duplicate messages.. 2026-10-15 12:59:13.453 T:9197 debug : CVideoPlayer::HandlePlaySpeed - audio stream stalled, triggering re-sync 2026-10-15 12:59:13.453 T:9197 debug : CVideoPlayer::FlushBuffers - flushing buffers 2026-10-15 12:59:13.453 T:9200 debug : CDVDAudio::Flush - flush audio stream 2026-10-15 12:59:13.454 T:9200 debug : CDVDAudio::Pause - pausing audio stream 2026-10-15 12:59:13.454 T:9199 debug : CVideoPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 2026-10-15 12:59:13.454 T:9200 debug : CVideoPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 2026-10-15 12:59:13.454 T:9197 debug : CVideoPlayer::SetCaching - caching state 2 2026-10-15 12:59:13.454 T:9197 debug : CDVDClock::SetSpeedAdjust - adjusted:0.000000 2026-10-15 12:59:13.454 T:9197 debug : demuxer seek to: 17494.000000 2026-10-15 12:59:13.454 T:9197 info : DVBridge stream candidate: profile=7 level=6 compatibility=6 native_eligible=true software=false interlaced=false stereo=false mode=0 (selection probe, not active output) 2026-10-15 12:59:13.454 T:9199 debug : CVideoPlayerVideo - Stillframe left, switching to normal playback 2026-10-15 12:59:13.454 T:9199 error : ffmpeg[0x1f4cfd70]: [hevc] Could not find ref with POC 12 2026-10-15 12:59:13.454 T:9199 error : ffmpeg[0x1f4cfd70]: [hevc] Error constructing the frame RPS. 2026-10-15 12:59:13.454 T:9199 debug : ffmpeg[0x1f4cfd70]: [hevc] Skipping invalid undecodable NALU: 1 2026-10-15 12:59:13.455 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 12:59:13.456 T:1176 debug : ------ Window Init (DialogSeekBar.xml) ------ 2026-10-15 12:59:13.456 T:9197 debug : DV FEL: random-access preroll begins at 16934000 us for 17494 ms seek 2026-10-15 12:59:13.456 T:9197 debug : SeekTime - seek ended up on time 16934 2026-10-15 12:59:13.456 T:9197 debug : demuxer seek to: 17494.000000, success 2026-10-15 12:59:13.456 T:9197 debug : CVideoPlayer::FlushBuffers - flushing buffers 2026-10-15 12:59:13.464 T:9200 debug : CDVDAudio::Pause - pausing audio stream 2026-10-15 12:59:13.465 T:9200 debug : CDVDAudio::Flush - flush audio stream 2026-10-15 12:59:13.465 T:9200 debug : CDVDAudio::Pause - pausing audio stream 2026-10-15 12:59:13.465 T:9200 debug : CVideoPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 2026-10-15 12:59:13.465 T:9199 debug : CVideoPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 2026-10-15 12:59:13.465 T:9197 debug : CheckPlayerInit - dropping packet type:2 dts:16934000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.465 T:9199 debug : CVideoPlayerVideo - Stillframe left, switching to normal playback 2026-10-15 12:59:13.465 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:16939000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.465 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:16949000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.465 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:16960000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.465 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:16970000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.465 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:16981000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.465 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:16992000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.465 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17002000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.465 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17013000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.465 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17024000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.465 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17034000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.465 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17045000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.465 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17055000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.465 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17066000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.465 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17077000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.465 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17087000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.465 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17098000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.465 T:9197 debug : CheckPlayerInit - dropping packet type:2 dts:17100000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CVideoPlayer::CheckContinuity - wrapback :2, prev:17100000.000000, curr:16934000.000000, diff:-166000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:2 dts:16934000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:2 dts:16975000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:2 dts:17017000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17110000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17120000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17131000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17141000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17152000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17163000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17173000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17184000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17195000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17205000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17216000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17226000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17237000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17247000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17258000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:2 dts:17059000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:2 dts:17100000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:2 dts:17142000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:2 dts:17184000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17270000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.466 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17280000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17291000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17301000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17312000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17323000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17333000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17344000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17355000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17365000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17376000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17386000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17397000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17408000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17418000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17429000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:2 dts:17226000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:2 dts:17267000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:2 dts:17309000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:2 dts:17351000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17440000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17450000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17461000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17471000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17482000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:1 dts:17493000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:2 dts:17392000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:2 dts:17434000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.467 T:9197 debug : CheckPlayerInit - dropping packet type:2 dts:17476000.000000 to get to start point at 17494000.000000 2026-10-15 12:59:13.468 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 12:59:13.475 T:9200 debug : Skipped 4 duplicate messages.. 2026-10-15 12:59:13.475 T:9200 info : CAEStreamParser::SyncDTS - dtsHD MA stream detected (8 channels, 48000Hz, 16bit BE, period: 8192, syncword: 0x41a29547, target rate: 0x18, framesize 4364)) 2026-10-15 12:59:13.477 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 12:59:13.498 T:1176 debug : Skipped 5 duplicate messages.. 2026-10-15 12:59:13.498 T:1176 debug : ------ Window Init (Custom_1109_TopBarOverlay.xml) ------ 2026-10-15 12:59:13.502 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 12:59:13.521 T:9197 debug : Skipped 5 duplicate messages.. 2026-10-15 12:59:13.521 T:9197 debug : CVideoPlayer::HandleMessages - player started 1 2026-10-15 12:59:13.521 T:5779 debug : virtual void CApplicationPlayerCallback::OnAVChange(): call 2026-10-15 12:59:13.521 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 12:59:16.492 T:9201 debug : Skipped 2224 duplicate messages.. 2026-10-15 12:59:16.492 T:9201 warning : COutput::StateMachine - signal: 3 form port: timer not handled for state: 2 2026-10-15 12:59:16.494 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 12:59:16.835 T:1176 debug : Skipped 262 duplicate messages.. 2026-10-15 12:59:16.835 T:1176 debug : ------ Window Deinit (DialogSeekBar.xml) ------ 2026-10-15 12:59:16.835 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 12:59:16.877 T:1176 debug : Skipped 31 duplicate messages.. 2026-10-15 12:59:16.877 T:1176 debug : ------ Window Deinit (Custom_1109_TopBarOverlay.xml) ------ 2026-10-15 12:59:16.877 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 12:59:18.464 T:9197 debug : Skipped 1224 duplicate messages.. 2026-10-15 12:59:18.464 T:9197 debug : CVideoPlayer::SetCaching - caching state 0 2026-10-15 12:59:18.464 T:9197 debug : CDVDClock::SetSpeedAdjust - adjusted:0.000000 2026-10-15 12:59:18.466 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 12:59:25.759 T:1176 debug : Skipped 5656 duplicate messages.. 2026-10-15 12:59:25.759 T:1176 info : DVBridge renderer summary: prepared=720 direct=720 composed=0 presented=720 presentation_failures=0 stage_failures=0 2026-10-15 12:59:25.760 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 12:59:26.493 T:9201 debug : Skipped 577 duplicate messages.. 2026-10-15 12:59:26.493 T:9201 warning : COutput::StateMachine - signal: 3 form port: timer not handled for state: 2 2026-10-15 12:59:26.493 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 12:59:36.493 T:9201 debug : Skipped 7748 duplicate messages.. 2026-10-15 12:59:36.493 T:9201 warning : COutput::StateMachine - signal: 3 form port: timer not handled for state: 2 2026-10-15 12:59:36.493 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 12:59:37.438 T:1176 debug : Skipped 729 duplicate messages.. 2026-10-15 12:59:37.438 T:1176 debug : void {anonymous}::DrmFbDestroyCallback(gbm_bo*, void*): Removing framebuffer: 457 2026-10-15 12:59:37.439 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 12:59:43.522 T:5780 debug : Skipped 4715 duplicate messages.. 2026-10-15 12:59:43.522 T:5780 debug : Thread JobWorker 139820908496576 terminating (autodelete) 2026-10-15 12:59:43.522 T:5779 debug : Thread JobWorker 139821451941568 terminating (autodelete) 2026-10-15 12:59:43.522 T:5782 debug : Thread JobWorker 139821259802304 terminating (autodelete) 2026-10-15 12:59:43.522 T:5781 debug : Thread JobWorker 139821282780864 terminating (autodelete) 2026-10-15 12:59:43.522 T:5778 debug : Thread JobWorker 139821607528128 terminating (autodelete) 2026-10-15 12:59:43.523 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 12:59:46.493 T:9201 debug : Skipped 2297 duplicate messages.. 2026-10-15 12:59:46.493 T:9201 warning : COutput::StateMachine - signal: 3 form port: timer not handled for state: 2 2026-10-15 12:59:46.494 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 12:59:55.789 T:1176 debug : Skipped 7207 duplicate messages.. 2026-10-15 12:59:55.789 T:1176 info : DVBridge renderer summary: prepared=1440 direct=1440 composed=0 presented=1440 presentation_failures=0 stage_failures=0 2026-10-15 12:59:55.790 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 12:59:56.494 T:9201 debug : Skipped 557 duplicate messages.. 2026-10-15 12:59:56.494 T:9201 warning : COutput::StateMachine - signal: 3 form port: timer not handled for state: 2 2026-10-15 12:59:56.494 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 13:00:06.494 T:9201 debug : Skipped 7744 duplicate messages.. 2026-10-15 13:00:06.494 T:9201 warning : COutput::StateMachine - signal: 3 form port: timer not handled for state: 2 2026-10-15 13:00:06.495 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 13:00:16.494 T:9201 debug : Skipped 7789 duplicate messages.. 2026-10-15 13:00:16.494 T:9201 warning : COutput::StateMachine - signal: 3 form port: timer not handled for state: 2 2026-10-15 13:00:16.494 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 13:00:19.145 T:1176 debug : Skipped 2051 duplicate messages.. 2026-10-15 13:00:19.145 T:1176 debug : void {anonymous}::DrmFbDestroyCallback(gbm_bo*, void*): Removing framebuffer: 456 2026-10-15 13:00:19.146 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 13:00:25.818 T:1176 debug : Skipped 5204 duplicate messages.. 2026-10-15 13:00:25.818 T:1176 info : DVBridge renderer summary: prepared=2160 direct=2160 composed=0 presented=2160 presentation_failures=0 stage_failures=0 2026-10-15 13:00:25.819 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 13:00:26.494 T:9201 debug : Skipped 525 duplicate messages.. 2026-10-15 13:00:26.494 T:9201 warning : COutput::StateMachine - signal: 3 form port: timer not handled for state: 2 2026-10-15 13:00:26.494 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 13:00:36.494 T:9201 debug : Skipped 7833 duplicate messages.. 2026-10-15 13:00:36.494 T:9201 warning : COutput::StateMachine - signal: 3 form port: timer not handled for state: 2 2026-10-15 13:00:36.495 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 13:00:46.494 T:9201 debug : Skipped 7806 duplicate messages.. 2026-10-15 13:00:46.494 T:9201 warning : COutput::StateMachine - signal: 3 form port: timer not handled for state: 2 2026-10-15 13:00:46.495 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 13:00:55.847 T:1176 debug : Skipped 7285 duplicate messages.. 2026-10-15 13:00:55.847 T:1176 info : DVBridge renderer summary: prepared=2880 direct=2880 composed=0 presented=2880 presentation_failures=0 stage_failures=0 2026-10-15 13:00:55.848 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 13:00:56.495 T:9201 debug : Skipped 502 duplicate messages.. 2026-10-15 13:00:56.495 T:9201 warning : COutput::StateMachine - signal: 3 form port: timer not handled for state: 2 2026-10-15 13:00:56.496 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 13:01:06.495 T:9201 debug : Skipped 7817 duplicate messages.. 2026-10-15 13:01:06.495 T:9201 warning : COutput::StateMachine - signal: 3 form port: timer not handled for state: 2 2026-10-15 13:01:06.496 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 13:01:16.495 T:9201 debug : Skipped 7943 duplicate messages.. 2026-10-15 13:01:16.495 T:9201 warning : COutput::StateMachine - signal: 3 form port: timer not handled for state: 2 2026-10-15 13:01:16.496 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 13:01:22.023 T:1180 debug : Skipped 4327 duplicate messages.. 2026-10-15 13:01:22.023 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x9e, xkb keysym: 0x1008ff26 (XF86Back) 2026-10-15 13:01:22.023 T:1180 debug : CLibInputKeyboard::ProcessKey - using delay: 400ms repeat: 80ms 2026-10-15 13:01:22.023 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 13:01:22.023 T:9875 debug : Thread Timer start, auto delete: false 2026-10-15 13:01:22.025 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 13:01:22.040 T:1176 debug : Skipped 11 duplicate messages.. 2026-10-15 13:01:22.040 T:1176 debug : Keyboard: scancode: 0x9e, sym: 0xa6 (), unicode: 0x00, modifier: 0x0 2026-10-15 13:01:22.041 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 13:01:22.457 T:1176 debug : Skipped 328 duplicate messages.. 2026-10-15 13:01:22.457 T:1176 debug : Keyboard: scancode: 0x9e, sym: 0xa6 (), unicode: 0x00, modifier: 0x0 2026-10-15 13:01:22.457 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 13:01:22.457 T:1176 debug : bool CInputManager::HandleKey(const CKey&): long-browser_back (0x100f0b0) pressed, window 12005, action is Stop 2026-10-15 13:01:22.457 T:1176 info : CVideoPlayer::CloseFile() 2026-10-15 13:01:22.457 T:1176 debug : DeleteRenderer - deleting renderer 2026-10-15 13:01:22.457 T:1176 debug : LinuxRendererGLES: Cleaning up GLES resources 2026-10-15 13:01:22.458 T:9199 debug : CVideoPlayerVideo - video decoder returned error 2026-10-15 13:01:22.459 T:9197 info : CVideoPlayer::OnExit() 2026-10-15 13:01:22.459 T:9197 info : Closing stream player 1 2026-10-15 13:01:22.459 T:9197 info : Waiting for audio thread to exit 2026-10-15 13:01:22.460 T:9200 info : thread end: CVideoPlayerAudio::OnExit() 2026-10-15 13:01:22.460 T:9200 debug : Thread VideoPlayerAudio 139821443548864 terminating 2026-10-15 13:01:22.460 T:9197 info : Closing audio device 2026-10-15 13:01:22.460 T:9197 debug : CDVDAudio::Flush - flush audio stream 2026-10-15 13:01:22.460 T:1207 debug : CActiveAE::DiscardStream - audio stream deleted 2026-10-15 13:01:22.460 T:1207 debug : CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2026-10-15 13:01:22.460 T:1208 debug : Skipped 2 duplicate messages.. 2026-10-15 13:01:22.460 T:1208 info : void ActiveAE::CActiveAESink::OpenSink(): initialize sink 2026-10-15 13:01:22.460 T:1208 debug : void ActiveAE::CActiveAESink::OpenSink(): trying to open device ALSA:hdmi:CARD=Generic,DEV=1 2026-10-15 13:01:22.460 T:1208 info : CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=Generic,DEV=1" 2026-10-15 13:01:22.460 T:9197 info : Deleting audio codec 2026-10-15 13:01:22.460 T:9197 info : Closing stream player 2 2026-10-15 13:01:22.460 T:9197 info : waiting for video thread to exit 2026-10-15 13:01:22.478 T:1208 info : CAESinkALSA::Initialize - Opened device "hdmi:CARD=Generic,DEV=1,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x02" 2026-10-15 13:01:22.478 T:1208 info : CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 2026-10-15 13:01:22.478 T:1208 info : CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 2026-10-15 13:01:22.478 T:1208 debug : CAESinkALSA::InitializeHW - Request: periodSize 2400, bufferSize 9600 2026-10-15 13:01:22.489 T:1208 debug : CAESinkALSA::InitializeHW - Got: periodSize 2400, bufferSize 9600 2026-10-15 13:01:22.489 T:1208 debug : CAESinkALSA::InitializeHW - Setting timeout to 200 ms 2026-10-15 13:01:22.490 T:1208 debug : CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 2026-10-15 13:01:22.490 T:1208 debug : CAESinkALSA::GetChannelLayout - Requested Layout: FL, FR 2026-10-15 13:01:22.490 T:1208 debug : CAESinkALSA::GetChannelLayout - Got Layout: FL, FR (ALSA: FL FR) 2026-10-15 13:01:22.490 T:1208 debug : void ActiveAE::CActiveAESink::OpenSink(): ALSA Initialized: 2026-10-15 13:01:22.490 T:1208 debug : Output Device : Device not found 2026-10-15 13:01:22.490 T:1208 debug : Sample Rate : 48000 2026-10-15 13:01:22.490 T:1208 debug : Sample Format : AE_FMT_S32NE 2026-10-15 13:01:22.490 T:1208 debug : Channel Count : 2 2026-10-15 13:01:22.490 T:1208 debug : Channel Layout: FL, FR 2026-10-15 13:01:22.490 T:1208 debug : Frames : 2400 2026-10-15 13:01:22.490 T:1208 debug : Frame Size : 8 2026-10-15 13:01:22.491 T:1207 debug : void ActiveAE::CActiveAE::ConfigureLowLatency(): Low latency mode: true - Initial buffer level: 20ms (resample: false) 2026-10-15 13:01:22.491 T:1207 debug : CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2026-10-15 13:01:22.655 T:1209 debug : Skipped 1 duplicate messages.. 2026-10-15 13:01:22.655 T:1209 debug : CALSAHControlMonitor - Monitored ALSA hctl value changed 2026-10-15 13:01:22.655 T:1207 debug : CActiveAE - device change event 2026-10-15 13:01:22.655 T:1176 info : DVBridge signal committed: connector=402 crtc=376 dv=0 hdr_blob=0 colorspace=0 max_bpc=16 rgb=0 mode=3840x2160 clock_khz=296703 totals=5500x2250 flags=5 vscan=0 active=1 2026-10-15 13:01:22.655 T:1176 info : DVBridge renderer reset: prepared=3518 direct=3518 composed=0 presented=3518 presentation_failures=0 stage_failures=0 2026-10-15 13:01:22.655 T:1209 debug : CALSAHControlMonitor - Monitored ALSA hctl value changed 2026-10-15 13:01:22.655 T:1176 debug : virtual bool KODI::WINDOWING::GBM::CWinSystemGbm::SetHDR(const VideoPicture*): clearing HDR_OUTPUT_METADATA 2026-10-15 13:01:22.655 T:1176 debug : virtual void KODI::WINDOWING::GBM::CWinSystemGbm::SetColorimetry(const VideoPicture*): setting connector colorspace to Default (source Default) 2026-10-15 13:01:22.655 T:1176 info : VAAPI::Close 2026-10-15 13:01:22.655 T:9201 info : COutput::OnExit: Output Thread terminated 2026-10-15 13:01:22.655 T:9201 debug : Thread Vaapi-Output 139821435156160 terminating 2026-10-15 13:01:22.655 T:1176 debug : EGL Config Attributes: 2026-10-15 13:01:22.655 T:1176 debug : EGL_BUFFER_SIZE: 32 2026-10-15 13:01:22.655 T:1176 debug : EGL_ALPHA_SIZE: 8 2026-10-15 13:01:22.655 T:1176 debug : EGL_BLUE_SIZE: 8 2026-10-15 13:01:22.655 T:1176 debug : EGL_GREEN_SIZE: 8 2026-10-15 13:01:22.655 T:1176 debug : EGL_RED_SIZE: 8 2026-10-15 13:01:22.655 T:1176 debug : EGL_DEPTH_SIZE: 16 2026-10-15 13:01:22.655 T:1176 debug : EGL_STENCIL_SIZE: 0 2026-10-15 13:01:22.655 T:1176 debug : EGL_CONFIG_CAVEAT: 0x3038 2026-10-15 13:01:22.655 T:1176 debug : EGL_CONFIG_ID: 42 2026-10-15 13:01:22.655 T:1176 debug : EGL_LEVEL: 0 2026-10-15 13:01:22.655 T:1176 debug : EGL_MAX_PBUFFER_HEIGHT: 4096 2026-10-15 13:01:22.655 T:1176 debug : EGL_MAX_PBUFFER_PIXELS: 0 2026-10-15 13:01:22.655 T:1176 debug : EGL_MAX_PBUFFER_WIDTH: 4096 2026-10-15 13:01:22.655 T:1176 debug : EGL_NATIVE_RENDERABLE: 1 2026-10-15 13:01:22.655 T:1176 debug : EGL_NATIVE_VISUAL_ID: 875713089 2026-10-15 13:01:22.655 T:1176 debug : EGL_NATIVE_VISUAL_TYPE: 0x3038 2026-10-15 13:01:22.655 T:1176 debug : EGL_SAMPLES: 0 2026-10-15 13:01:22.655 T:1176 debug : EGL_SAMPLE_BUFFERS: 0 2026-10-15 13:01:22.655 T:1176 debug : EGL_SURFACE_TYPE: 4 2026-10-15 13:01:22.655 T:1176 debug : EGL_TRANSPARENT_TYPE: 0x3038 2026-10-15 13:01:22.655 T:1176 debug : EGL_TRANSPARENT_BLUE_VALUE: 0 2026-10-15 13:01:22.655 T:1176 debug : EGL_TRANSPARENT_GREEN_VALUE: 0 2026-10-15 13:01:22.655 T:1176 debug : EGL_TRANSPARENT_RED_VALUE: 0 2026-10-15 13:01:22.655 T:1176 debug : EGL_BIND_TO_TEXTURE_RGB: 0 2026-10-15 13:01:22.655 T:1176 debug : EGL_BIND_TO_TEXTURE_RGBA: 0 2026-10-15 13:01:22.655 T:1176 debug : EGL_MIN_SWAP_INTERVAL: 1 2026-10-15 13:01:22.655 T:1176 debug : EGL_MAX_SWAP_INTERVAL: 1 2026-10-15 13:01:22.655 T:1176 debug : EGL_LUMINANCE_SIZE: 0 2026-10-15 13:01:22.655 T:1176 debug : EGL_ALPHA_MASK_SIZE: 0 2026-10-15 13:01:22.655 T:1176 debug : EGL_COLOR_BUFFER_TYPE: 0x308e 2026-10-15 13:01:22.655 T:1176 debug : EGL_RENDERABLE_TYPE: 77 2026-10-15 13:01:22.655 T:1176 debug : EGL_CONFORMANT: 77 2026-10-15 13:01:22.655 T:1176 debug : bool KODI::WINDOWING::GBM::CDRMPlane::SupportsFormatAndModifier(uint32_t, uint64_t): found plane format (AR24) and modifier (AMD_GFX11,64KB_R_X,PIPE_XOR_BITS=2,PACKERS=2,DCC,DCC_MAX_COMPRESSED_BLOCK=64B,DCC_INDEPENDENT_64B,DCC_INDEPENDENT_128B,DCC_RETILE) 2026-10-15 13:01:22.655 T:1176 info : bool KODI::WINDOWING::GBM::CDRMUtils::FindGuiPlane(uint32_t, uint64_t): Using existing gui plane [3840x2160] id:206, format:AR24, modifier:AMD_GFX11,64KB_R_X,PIPE_XOR_BITS=2,PACKERS=2,DCC,DCC_MAX_COMPRESSED_BLOCK=64B,DCC_INDEPENDENT_64B,DCC_INDEPENDENT_128B,DCC_RETILE, crtc id:376 2026-10-15 13:01:22.655 T:1176 debug : virtual void KODI::WINDOWING::GBM::CWinSystemGbm::SetColorimetry(const VideoPicture*): setting connector colorspace to Default (source Default) 2026-10-15 13:01:22.655 T:1176 debug : virtual bool KODI::WINDOWING::GBM::CWinSystemGbm::SetHDR(const VideoPicture*): clearing HDR_OUTPUT_METADATA 2026-10-15 13:01:22.655 T:1176 info : VideoPlayer: waiting for threads to exit 2026-10-15 13:01:22.655 T:9199 info : thread end: video_thread 2026-10-15 13:01:22.655 T:9199 debug : Thread VideoPlayerVideo 139821477119680 terminating 2026-10-15 13:01:22.656 T:9197 info : deleting video codec 2026-10-15 13:01:22.662 T:9197 info : VAAPI::Close 2026-10-15 13:01:22.662 T:9218 info : COutput::OnExit: Output Thread terminated 2026-10-15 13:01:22.662 T:9218 debug : Thread Vaapi-Output 139821142374080 terminating 2026-10-15 13:01:22.662 T:9197 info : Closing stream player 3 2026-10-15 13:01:22.662 T:9884 debug : Thread JobWorker start, auto delete: true 2026-10-15 13:01:22.662 T:9884 debug : [threads] name: 'JobWorker' priority: '1' 2026-10-15 13:01:22.662 T:9197 debug : Thread VideoPlayer 139821159159488 terminating 2026-10-15 13:01:22.663 T:1176 info : VideoPlayer: finished waiting 2026-10-15 13:01:22.663 T:1176 info : CVideoPlayer::CloseFile() 2026-10-15 13:01:22.663 T:1176 info : VideoPlayer: waiting for threads to exit 2026-10-15 13:01:22.663 T:1176 info : VideoPlayer: finished waiting 2026-10-15 13:01:22.663 T:1176 debug : Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 2026-10-15 13:01:22.663 T:1176 debug : Audio ID3 tag processor - delete ~CVideoPlayerAudioID3 2026-10-15 13:01:22.664 T:9884 info : Deleting settings information for files /var/media/sdb1-ata-Samsung_SSD_980_/test.mkv 2026-10-15 13:01:22.664 T:9884 debug : DoWork - Saving file state for video item /var/media/sdb1-ata-Samsung_SSD_980_/test.mkv 2026-10-15 13:01:22.671 T:9884 debug : static void CSaveFileState::DoWork(CFileItem&, CBookmark&, bool): Finished saving file state for video item /var/media/sdb1-ata-Samsung_SSD_980_/test.mkv (listing update not needed) 2026-10-15 13:01:22.671 T:9884 debug : virtual void CApplicationPlayerCallback::OnPlayBackStopped(): call 2026-10-15 13:01:22.673 T:1176 debug : CGUIWindowManager::PreviousWindow: Deactivate 2026-10-15 13:01:22.673 T:1176 debug : ------ Window Deinit (VideoFullScreen.xml) ------ 2026-10-15 13:01:22.675 T:1176 debug : OnLostDevice - notify display change event 2026-10-15 13:01:22.896 T:1207 info : CAESinkALSA - Unable to open device "default" for playback 2026-10-15 13:01:22.902 T:1207 debug : CAESinkALSA - HDMI device "hdmi:CARD=Generic,DEV=0" may be unconnected (no ELD data) 2026-10-15 13:01:22.903 T:1207 debug : CAESinkALSA - HDMI device "hdmi:CARD=Generic,DEV=2" may be unconnected (no ELD data) 2026-10-15 13:01:22.903 T:1207 debug : CAESinkALSA - HDMI device "hdmi:CARD=Generic,DEV=3" may be unconnected (no ELD data) 2026-10-15 13:01:22.906 T:1207 info : CAESinkALSA - Unable to open device "surround21:CARD=Generic_1,DEV=0" for playback 2026-10-15 13:01:22.907 T:1207 debug : PulseAudio: Context authorizing 2026-10-15 13:01:22.907 T:1207 debug : PulseAudio: Context setting name 2026-10-15 13:01:22.907 T:1207 debug : PulseAudio: Context ready 2026-10-15 13:01:22.907 T:1207 warning : Pulseaudio module module-allow-passthrough not loaded - opening PT devices might fail 2026-10-15 13:01:22.907 T:1207 info : Found 2 Lists of Devices 2026-10-15 13:01:22.907 T:1207 info : Enumerated ALSA devices: 2026-10-15 13:01:22.907 T:1207 info : Device 1 2026-10-15 13:01:22.907 T:1207 info : m_deviceName : hdmi:CARD=Generic,DEV=0 2026-10-15 13:01:22.907 T:1207 info : m_displayName : HD-Audio Generic 2026-10-15 13:01:22.907 T:1207 info : m_displayNameExtra: HDMI #0 2026-10-15 13:01:22.907 T:1207 info : m_deviceType : AE_DEVTYPE_HDMI 2026-10-15 13:01:22.907 T:1207 info : m_channels : FL, FR 2026-10-15 13:01:22.907 T:1207 info : m_sampleRates : 32000,44100,48000,88200,96000,176400,192000 2026-10-15 13:01:22.907 T:1207 info : m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW 2026-10-15 13:01:22.907 T:1207 info : m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_MA,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD 2026-10-15 13:01:22.907 T:1207 info : Device 2 2026-10-15 13:01:22.907 T:1207 info : m_deviceName : hdmi:CARD=Generic,DEV=1 2026-10-15 13:01:22.907 T:1207 info : m_displayName : HD-Audio Generic 2026-10-15 13:01:22.907 T:1207 info : m_displayNameExtra: SNY SONY TV *30 on HDMI #1 2026-10-15 13:01:22.907 T:1207 info : m_deviceType : AE_DEVTYPE_HDMI 2026-10-15 13:01:22.907 T:1207 info : m_channels : FL, FR, LFE, FC, BL, BR, BC, BLOC, BROC 2026-10-15 13:01:22.907 T:1207 info : m_sampleRates : 32000,44100,48000,88200,96000,176400,192000 2026-10-15 13:01:22.907 T:1207 info : m_dataFormats : AE_FMT_RAW,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW 2026-10-15 13:01:22.907 T:1207 info : m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_MA,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD 2026-10-15 13:01:22.907 T:1207 info : Device 3 2026-10-15 13:01:22.907 T:1207 info : m_deviceName : hdmi:CARD=Generic,DEV=2 2026-10-15 13:01:22.907 T:1207 info : m_displayName : HD-Audio Generic 2026-10-15 13:01:22.907 T:1207 info : m_displayNameExtra: HDMI #2 2026-10-15 13:01:22.907 T:1207 info : m_deviceType : AE_DEVTYPE_HDMI 2026-10-15 13:01:22.907 T:1207 info : m_channels : FL, FR 2026-10-15 13:01:22.907 T:1207 info : m_sampleRates : 32000,44100,48000,88200,96000,176400,192000 2026-10-15 13:01:22.907 T:1207 info : m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW 2026-10-15 13:01:22.907 T:1207 info : m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_MA,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD 2026-10-15 13:01:22.907 T:1207 info : Device 4 2026-10-15 13:01:22.907 T:1207 info : m_deviceName : hdmi:CARD=Generic,DEV=3 2026-10-15 13:01:22.907 T:1207 info : m_displayName : HD-Audio Generic 2026-10-15 13:01:22.907 T:1207 info : m_displayNameExtra: HDMI #3 2026-10-15 13:01:22.907 T:1207 info : m_deviceType : AE_DEVTYPE_HDMI 2026-10-15 13:01:22.907 T:1207 info : m_channels : FL, FR 2026-10-15 13:01:22.907 T:1207 info : m_sampleRates : 32000,44100,48000,88200,96000,176400,192000 2026-10-15 13:01:22.907 T:1207 info : m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW 2026-10-15 13:01:22.907 T:1207 info : m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_MA,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD 2026-10-15 13:01:22.907 T:1207 info : Device 5 2026-10-15 13:01:22.907 T:1207 info : m_deviceName : @:CARD=Generic_1,DEV=0 2026-10-15 13:01:22.907 T:1207 info : m_displayName : HD-Audio Generic 2026-10-15 13:01:22.907 T:1207 info : m_displayNameExtra: ALC897 Analog 2026-10-15 13:01:22.907 T:1207 info : m_deviceType : AE_DEVTYPE_PCM 2026-10-15 13:01:22.907 T:1207 info : m_channels : FL, FR 2026-10-15 13:01:22.907 T:1207 info : m_sampleRates : 48000 2026-10-15 13:01:22.907 T:1207 info : m_dataFormats : AE_FMT_S32NE 2026-10-15 13:01:22.907 T:1207 info : m_streamTypes : No passthrough capabilities 2026-10-15 13:01:22.907 T:1207 info : Enumerated PULSE devices: 2026-10-15 13:01:22.907 T:1207 info : Device 1 2026-10-15 13:01:22.907 T:1207 info : m_deviceName : Default 2026-10-15 13:01:22.907 T:1207 info : m_displayName : Default 2026-10-15 13:01:22.907 T:1207 info : m_displayNameExtra: Bluetooth Audio (PULSEAUDIO) 2026-10-15 13:01:22.907 T:1207 info : m_deviceType : AE_DEVTYPE_PCM 2026-10-15 13:01:22.907 T:1207 info : m_channels : FL, FR 2026-10-15 13:01:22.907 T:1207 info : m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000 2026-10-15 13:01:22.907 T:1207 info : m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT 2026-10-15 13:01:22.907 T:1207 info : m_streamTypes : No passthrough capabilities 2026-10-15 13:01:22.908 T:1208 info : void ActiveAE::CActiveAESink::OpenSink(): initialize sink 2026-10-15 13:01:22.908 T:1208 debug : void ActiveAE::CActiveAESink::OpenSink(): trying to open device ALSA:hdmi:CARD=Generic,DEV=1 2026-10-15 13:01:22.908 T:1208 info : CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=Generic,DEV=1" 2026-10-15 13:01:22.910 T:1208 info : CAESinkALSA::Initialize - Opened device "hdmi:CARD=Generic,DEV=1,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x02" 2026-10-15 13:01:22.910 T:1208 info : CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 2026-10-15 13:01:22.910 T:1208 info : CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 2026-10-15 13:01:22.910 T:1208 debug : CAESinkALSA::InitializeHW - Request: periodSize 2400, bufferSize 9600 2026-10-15 13:01:22.910 T:1208 debug : CAESinkALSA::InitializeHW - Got: periodSize 2400, bufferSize 9600 2026-10-15 13:01:22.910 T:1208 debug : CAESinkALSA::InitializeHW - Setting timeout to 200 ms 2026-10-15 13:01:22.910 T:1208 debug : CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 2026-10-15 13:01:22.910 T:1208 debug : CAESinkALSA::GetChannelLayout - Requested Layout: FL, FR 2026-10-15 13:01:22.910 T:1208 debug : CAESinkALSA::GetChannelLayout - Got Layout: FL, FR (ALSA: FL FR) 2026-10-15 13:01:22.910 T:1208 debug : void ActiveAE::CActiveAESink::OpenSink(): ALSA Initialized: 2026-10-15 13:01:22.910 T:1208 debug : Output Device : Device not found 2026-10-15 13:01:22.910 T:1208 debug : Sample Rate : 48000 2026-10-15 13:01:22.910 T:1208 debug : Sample Format : AE_FMT_S32NE 2026-10-15 13:01:22.910 T:1208 debug : Channel Count : 2 2026-10-15 13:01:22.910 T:1208 debug : Channel Layout: FL, FR 2026-10-15 13:01:22.910 T:1208 debug : Frames : 2400 2026-10-15 13:01:22.910 T:1208 debug : Frame Size : 8 2026-10-15 13:01:22.910 T:1207 debug : void ActiveAE::CActiveAE::ConfigureLowLatency(): Low latency mode: true - Initial buffer level: 20ms (resample: false) 2026-10-15 13:01:22.910 T:1207 debug : CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2026-10-15 13:01:22.962 T:1176 debug : virtual bool KODI::WINDOWING::GBM::CDRMUtils::SetMode(const RESOLUTION_INFO&): Found crtc mode: 3840x2160 @ 60 Hz 2026-10-15 13:01:22.962 T:1176 debug : virtual void KODI::WINDOWING::GBM::CDRMAtomic::FlipPage(gbm_bo*, bool, bool, bool): Execute modeset at next commit 2026-10-15 13:01:23.111 T:1176 info : DVBridge signal committed: connector=402 crtc=376 dv=0 hdr_blob=0 colorspace=0 max_bpc=16 rgb=0 mode=3840x2160 clock_khz=594000 totals=4400x2250 flags=5 vscan=0 active=1 2026-10-15 13:01:23.111 T:1209 debug : CALSAHControlMonitor - Monitored ALSA hctl value changed 2026-10-15 13:01:23.111 T:1176 info : GLES: Maximum texture width: 16384 2026-10-15 13:01:23.112 T:1176 debug : CGUIWindowManager::PreviousWindow: Activate new 2026-10-15 13:01:23.112 T:1176 debug : ------ Window Init (MyVideoNav.xml) ------ 2026-10-15 13:01:23.113 T:1176 debug : CGUIMediaWindow::GetDirectory (/var/media/sdb1-ata-Samsung_SSD_980_/) 2026-10-15 13:01:23.113 T:1176 debug : ParentPath = [sources://video/] 2026-10-15 13:01:23.127 T:9886 debug : Thread BackgroundLoader start, auto delete: false 2026-10-15 13:01:23.127 T:1176 debug : [threads] name: 'BackgroundLoader' priority: '1' 2026-10-15 13:01:23.127 T:1176 debug : Keyboard: scancode: 0x9e, sym: 0xa6 (), unicode: 0x00, modifier: 0x0 2026-10-15 13:01:23.129 T:9886 debug : Skipped 7 duplicate messages.. 2026-10-15 13:01:23.129 T:9886 debug : Thread BackgroundLoader 139821523965632 terminating 2026-10-15 13:01:23.135 T:9887 debug : Thread JobWorker start, auto delete: true 2026-10-15 13:01:23.135 T:9887 debug : [threads] name: 'JobWorker' priority: '1' 2026-10-15 13:01:23.140 T:1176 debug : KODI::WINDOWING::GBM::drm_fb* KODI::WINDOWING::GBM::CDRMUtils::DrmFbGetFromBo(gbm_bo*): Using modifier: AMD_GFX11,64KB_R_X,PIPE_XOR_BITS=2,PACKERS=2,DCC,DCC_MAX_COMPRESSED_BLOCK=64B,DCC_INDEPENDENT_64B,DCC_INDEPENDENT_128B,DCC_RETILE 2026-10-15 13:01:23.162 T:1176 debug : CWinSystemGbmGLESContext::PresentRender - Sending display reset to all clients 2026-10-15 13:01:23.162 T:1207 debug : CActiveAE - display reset event 2026-10-15 13:01:23.162 T:1208 info : void ActiveAE::CActiveAESink::OpenSink(): initialize sink 2026-10-15 13:01:23.162 T:1208 debug : void ActiveAE::CActiveAESink::OpenSink(): trying to open device ALSA:hdmi:CARD=Generic,DEV=1 2026-10-15 13:01:23.162 T:1208 info : CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=Generic,DEV=1" 2026-10-15 13:01:23.162 T:1176 debug : Keyboard: scancode: 0x9e, sym: 0xa6 (), unicode: 0x00, modifier: 0x0 2026-10-15 13:01:23.164 T:1208 info : CAESinkALSA::Initialize - Opened device "hdmi:CARD=Generic,DEV=1,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x02" 2026-10-15 13:01:23.164 T:1208 info : CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 2026-10-15 13:01:23.164 T:1208 info : CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 2026-10-15 13:01:23.164 T:1208 debug : CAESinkALSA::InitializeHW - Request: periodSize 2400, bufferSize 9600 2026-10-15 13:01:23.165 T:1208 debug : CAESinkALSA::InitializeHW - Got: periodSize 2400, bufferSize 9600 2026-10-15 13:01:23.165 T:1208 debug : CAESinkALSA::InitializeHW - Setting timeout to 200 ms 2026-10-15 13:01:23.165 T:1208 debug : CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2 2026-10-15 13:01:23.165 T:1208 debug : CAESinkALSA::GetChannelLayout - Requested Layout: FL, FR 2026-10-15 13:01:23.165 T:1208 debug : CAESinkALSA::GetChannelLayout - Got Layout: FL, FR (ALSA: FL FR) 2026-10-15 13:01:23.166 T:1208 debug : void ActiveAE::CActiveAESink::OpenSink(): ALSA Initialized: 2026-10-15 13:01:23.166 T:1208 debug : Output Device : Device not found 2026-10-15 13:01:23.166 T:1208 debug : Sample Rate : 48000 2026-10-15 13:01:23.166 T:1208 debug : Sample Format : AE_FMT_S32NE 2026-10-15 13:01:23.166 T:1208 debug : Channel Count : 2 2026-10-15 13:01:23.166 T:1208 debug : Channel Layout: FL, FR 2026-10-15 13:01:23.166 T:1208 debug : Frames : 2400 2026-10-15 13:01:23.166 T:1208 debug : Frame Size : 8 2026-10-15 13:01:23.166 T:1207 debug : void ActiveAE::CActiveAE::ConfigureLowLatency(): Low latency mode: true - Initial buffer level: 20ms (resample: false) 2026-10-15 13:01:23.166 T:1207 debug : CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2026-10-15 13:01:23.169 T:1176 debug : EGL Debugging: Error: EGL_BAD_PARAMETER Command: eglClientWaitSyncKHR Type: EGL_DEBUG_MSG_ERROR_KHR Message: _eglClientWaitSyncCommon 2026-10-15 13:01:23.212 T:1176 debug : KODI::WINDOWING::GBM::drm_fb* KODI::WINDOWING::GBM::CDRMUtils::DrmFbGetFromBo(gbm_bo*): Using modifier: AMD_GFX11,64KB_R_X,PIPE_XOR_BITS=2,PACKERS=2,DCC,DCC_MAX_COMPRESSED_BLOCK=64B,DCC_INDEPENDENT_64B,DCC_INDEPENDENT_128B,DCC_RETILE 2026-10-15 13:01:23.229 T:1176 debug : Keyboard: scancode: 0x9e, sym: 0xa6 (), unicode: 0x00, modifier: 0x0 2026-10-15 13:01:24.100 T:1180 debug : Skipped 10 duplicate messages.. 2026-10-15 13:01:24.100 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x9e, xkb keysym: 0x1008ff26 (XF86Back) 2026-10-15 13:01:24.101 T:9875 debug : Thread Timer 139821485512384 terminating 2026-10-15 13:01:24.107 T:1176 debug : Keyboard: scancode: 0x9e, sym: 0xa6 (), unicode: 0x00, modifier: 0x0 2026-10-15 13:01:26.874 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x9e, xkb keysym: 0x1008ff26 (XF86Back) 2026-10-15 13:01:26.874 T:1180 debug : CLibInputKeyboard::ProcessKey - using delay: 400ms repeat: 80ms 2026-10-15 13:01:26.874 T:9908 debug : Thread Timer start, auto delete: false 2026-10-15 13:01:26.878 T:1176 debug : Keyboard: scancode: 0x9e, sym: 0xa6 (), unicode: 0x00, modifier: 0x0 2026-10-15 13:01:27.050 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x9e, xkb keysym: 0x1008ff26 (XF86Back) 2026-10-15 13:01:27.050 T:9908 debug : Thread Timer 139821485512384 terminating 2026-10-15 13:01:27.054 T:1176 debug : Keyboard: scancode: 0x9e, sym: 0xa6 (), unicode: 0x00, modifier: 0x0 2026-10-15 13:01:27.054 T:1176 debug : bool CInputManager::HandleKey(const CKey&): browser_back (0xf0b0) pressed, window 10025, action is Back 2026-10-15 13:01:27.054 T:1176 debug : CGUIMediaWindow::GetDirectory (sources://video/) 2026-10-15 13:01:27.054 T:1176 debug : ParentPath = [] 2026-10-15 13:01:27.054 T:9909 debug : Thread waiting start, auto delete: false 2026-10-15 13:01:27.066 T:9909 debug : Thread waiting 139821477119680 terminating 2026-10-15 13:01:27.077 T:9910 debug : Thread BackgroundLoader start, auto delete: false 2026-10-15 13:01:27.077 T:1176 debug : [threads] name: 'BackgroundLoader' priority: '1' 2026-10-15 13:01:27.079 T:9910 debug : Thread BackgroundLoader 139821523965632 terminating 2026-10-15 13:01:27.573 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x9e, xkb keysym: 0x1008ff26 (XF86Back) 2026-10-15 13:01:27.573 T:1180 debug : CLibInputKeyboard::ProcessKey - using delay: 400ms repeat: 80ms 2026-10-15 13:01:27.573 T:9916 debug : Thread Timer start, auto delete: false 2026-10-15 13:01:27.578 T:1176 debug : Keyboard: scancode: 0x9e, sym: 0xa6 (), unicode: 0x00, modifier: 0x0 2026-10-15 13:01:27.723 T:1180 debug : void CLibInputKeyboard::ProcessKey(libinput_event_keyboard*): libinput key: 0x9e, xkb keysym: 0x1008ff26 (XF86Back) 2026-10-15 13:01:27.724 T:9916 debug : Thread Timer 139821485512384 terminating 2026-10-15 13:01:27.728 T:1176 debug : Keyboard: scancode: 0x9e, sym: 0xa6 (), unicode: 0x00, modifier: 0x0 2026-10-15 13:01:27.728 T:1176 debug : bool CInputManager::HandleKey(const CKey&): browser_back (0xf0b0) pressed, window 10025, action is Back 2026-10-15 13:01:27.728 T:1176 debug : CGUIWindowManager::PreviousWindow: Deactivate 2026-10-15 13:01:28.030 T:1176 debug : ------ Window Deinit (MyVideoNav.xml) ------ 2026-10-15 13:01:28.030 T:1176 debug : FreeVisualisation() done 2026-10-15 13:01:28.045 T:1176 debug : CGUIWindowManager::PreviousWindow: Activate new 2026-10-15 13:01:28.045 T:1176 debug : ------ Window Init (Home.xml) ------ 2026-10-15 13:01:28.045 T:1176 debug : CDirectoryProvider[addons://]: refreshing... 2026-10-15 13:01:28.046 T:1176 debug : CDirectoryProvider[addons://sources/video/]: refreshing... 2026-10-15 13:01:28.046 T:1176 debug : CDirectoryProvider[addons://sources/audio/]: refreshing... 2026-10-15 13:01:28.046 T:9917 debug : Thread JobWorker start, auto delete: true 2026-10-15 13:01:28.046 T:9917 debug : [threads] name: 'JobWorker' priority: '1' 2026-10-15 13:01:28.046 T:1176 debug : CDirectoryProvider[addons://sources/game/]: refreshing... 2026-10-15 13:01:28.046 T:1176 debug : CDirectoryProvider[addons://sources/executable/]: refreshing... 2026-10-15 13:01:28.046 T:1176 debug : CDirectoryProvider[addons://sources/image/]: refreshing... 2026-10-15 13:01:28.046 T:1176 debug : CDirectoryProvider[library://video/]: refreshing... 2026-10-15 13:01:28.046 T:1176 debug : CDirectoryProvider[sources://video/]: refreshing... 2026-10-15 13:01:28.046 T:1176 debug : CDirectoryProvider[special://videoplaylists/]: refreshing... 2026-10-15 13:01:28.046 T:1176 debug : CDirectoryProvider[favourites://]: refreshing... 2026-10-15 13:01:28.046 T:1176 debug : CDirectoryProvider[addons://sources/game/]: refreshing... 2026-10-15 13:01:28.046 T:9887 debug : CAddonDatabase: SELECT repo.id FROM repo .. took 0 ms 2026-10-15 13:01:28.048 T:9884 debug : CMultiPathDirectory::GetDirectory(multipath://special%3a%2f%2fprofile%2fplaylists%2fvideo/special%3a%2f%2fprofile%2fplaylists%2fmixed/) 2026-10-15 13:01:28.048 T:9884 debug : Getting Directory (special://profile/playlists/video) 2026-10-15 13:01:28.048 T:9884 debug : Getting Directory (special://profile/playlists/mixed) 2026-10-15 13:01:28.048 T:9884 debug : CMultiPathDirectory::MergeItems, items = 0 2026-10-15 13:01:28.050 T:9887 debug : CAddonDatabase: query SELECT addons.*, repo.addonID AS repoID FROM addons JOIN addonlinkrepo ON addons.id=addonlinkrepo.idAddon JOIN repo ON repo.id=addonlinkrepo.idRepo WHERE addonlinkrepo.idRepo IN (1,2,3) ORDER BY repo.addonID, addons.addonID returned 1603 rows in 3 ms 2026-10-15 13:01:28.078 T:9887 debug : CAddonDatabase::GetAddons took 31 ms 2026-10-15 13:01:28.080 T:9887 debug : CAddonMgr::GetAvailableUpdatesOrOutdatedAddons took 34 ms