2020-06-01 08:23:32.931 T:3011372368 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 2020-06-01 08:23:32.931 T:3011372368 NOTICE: Enabled debug logging due to GUI setting. Level 2. 2020-06-01 08:23:32.931 T:3011372368 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 2020-06-01 08:23:32.931 T:3011372368 NOTICE: Enabled debug logging due to GUI setting. Level 2. 2020-06-01 08:23:32.933 T:3011372368 DEBUG: ------ Window Init () ------ 2020-06-01 08:23:33.090 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:23:33.098 T:3011372368 DEBUG: Keyboard: scancode: 0x20, sym: 0x0064, unicode: 0x0004, modifier: 0xc3 2020-06-01 08:23:33.164 T:3011372368 DEBUG: Keyboard: scancode: 0x1d, sym: 0x0132, unicode: 0x0000, modifier: 0x3 2020-06-01 08:23:33.164 T:3011372368 DEBUG: Keyboard: scancode: 0x2a, sym: 0x0130, unicode: 0x0000, modifier: 0x0 2020-06-01 08:23:33.869 T:3011372368 DEBUG: ------ Window Deinit () ------ 2020-06-01 08:26:33.336 T:3011372368 DEBUG: CAddonSettings[screensaver.xbmc.builtin.dim]: loading setting definitions 2020-06-01 08:26:33.336 T:3011372368 DEBUG: CAddonSettings[screensaver.xbmc.builtin.dim]: trying to load setting definitions from old format... 2020-06-01 08:26:33.336 T:3011372368 DEBUG: ------ Window Init () ------ 2020-06-01 08:26:41.297 T:3011372368 DEBUG: Keyboard: scancode: 0x1d, sym: 0x0132, unicode: 0x0000, modifier: 0xc0 2020-06-01 08:26:41.298 T:3011372368 DEBUG: HandleKey: ctrl-leftctrl (0x1f0d0) pressed, screen saver/dpms woken up 2020-06-01 08:26:41.343 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:26:41.343 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:26:41.364 T:3011372368 DEBUG: Keyboard: scancode: 0x12, sym: 0x0065, unicode: 0x0005, modifier: 0xc0 2020-06-01 08:26:41.364 T:3011372368 DEBUG: HandleKey: ctrl-e (0x1f045) pressed, action is ActivateWindow(videos) 2020-06-01 08:26:41.364 T:3011372368 DEBUG: Activating window ID: 10025 2020-06-01 08:26:41.439 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:26:41.703 T:3011372368 DEBUG: ------ Window Deinit (Home.xml) ------ 2020-06-01 08:26:41.703 T:3011372368 DEBUG: FreeVisualisation() done 2020-06-01 08:26:41.735 T:3011372368 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 2020-06-01 08:26:41.735 T:3011372368 INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY 2020-06-01 08:26:41.835 T:3011372368 DEBUG: CGUIMediaWindow::GetDirectory () 2020-06-01 08:26:41.835 T:3011372368 DEBUG: ParentPath = [] 2020-06-01 08:26:41.862 T:2881561456 DEBUG: Thread BackgroundLoader start, auto delete: false 2020-06-01 08:26:41.869 T:2881561456 DEBUG: Thread BackgroundLoader 2881561456 terminating 2020-06-01 08:26:41.871 T:3011372368 DEBUG: Keyboard: scancode: 0x12, sym: 0x0065, unicode: 0x0005, modifier: 0xc0 2020-06-01 08:26:41.871 T:3011372368 DEBUG: Keyboard: scancode: 0x1d, sym: 0x0132, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:42.334 T:3011372368 DEBUG: ------ Window Deinit () ------ 2020-06-01 08:26:44.223 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:26:44.223 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:26:44.231 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:44.231 T:3011372368 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-06-01 08:26:44.319 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:26:44.331 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:44.831 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:26:44.832 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:26:44.843 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:44.843 T:3011372368 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-06-01 08:26:44.991 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:26:44.998 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:45.600 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:26:45.600 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:26:45.602 T:3011372368 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 2020-06-01 08:26:45.696 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:26:45.698 T:3011372368 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 2020-06-01 08:26:45.698 T:3011372368 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 2020-06-01 08:26:45.698 T:3011372368 DEBUG: CGUIMediaWindow::GetDirectory (library://video/files.xml/) 2020-06-01 08:26:45.698 T:3011372368 DEBUG: ParentPath = [] 2020-06-01 08:26:45.699 T:2881561456 DEBUG: Thread waiting start, auto delete: false 2020-06-01 08:26:45.719 T:2881561456 DEBUG: Thread waiting 2881561456 terminating 2020-06-01 08:26:45.740 T:2881561456 DEBUG: Thread BackgroundLoader start, auto delete: false 2020-06-01 08:26:45.748 T:2881561456 DEBUG: Thread BackgroundLoader 2881561456 terminating 2020-06-01 08:26:48.736 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:26:48.736 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:26:48.764 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:48.764 T:3011372368 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-06-01 08:26:48.896 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:26:48.897 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:49.120 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:26:49.120 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:26:49.131 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:49.131 T:3011372368 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-06-01 08:26:49.216 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:26:49.231 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:49.408 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:26:49.408 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:26:49.411 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:49.411 T:3011372368 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-06-01 08:26:49.472 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:26:49.497 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:49.696 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:26:49.696 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:26:49.705 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:49.706 T:3011372368 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-06-01 08:26:49.856 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:26:49.864 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:50.016 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:26:50.016 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:26:50.031 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:50.031 T:3011372368 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-06-01 08:26:50.112 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:26:50.131 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:51.072 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:26:51.073 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:26:51.075 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:51.075 T:3011372368 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-06-01 08:26:51.168 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:26:51.198 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:51.744 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:26:51.745 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:26:51.764 T:3011372368 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 2020-06-01 08:26:51.841 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:26:51.864 T:3011372368 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 2020-06-01 08:26:51.864 T:3011372368 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 2020-06-01 08:26:51.865 T:3011372368 DEBUG: CGUIMediaWindow::GetDirectory (smb://192.168.1.120/video/Vegyes/) 2020-06-01 08:26:51.865 T:3011372368 DEBUG: ParentPath = [sources://video/] 2020-06-01 08:26:51.865 T:2881561456 DEBUG: Thread waiting start, auto delete: false 2020-06-01 08:26:51.965 T:3011372368 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2020-06-01 08:26:52.801 T:2881561456 DEBUG: Thread waiting 2881561456 terminating 2020-06-01 08:26:52.831 T:3011372368 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2020-06-01 08:26:52.837 T:2881561456 DEBUG: Thread BackgroundLoader start, auto delete: false 2020-06-01 08:26:54.192 T:2881561456 DEBUG: Thread BackgroundLoader 2881561456 terminating 2020-06-01 08:26:55.233 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:26:55.233 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:26:55.240 T:3011372368 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:55.240 T:3011372368 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2020-06-01 08:26:55.617 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:26:55.631 T:3011372368 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:56.065 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:26:56.065 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:26:56.097 T:3011372368 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:56.098 T:3011372368 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2020-06-01 08:26:56.289 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:26:56.292 T:3011372368 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:56.513 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:26:56.513 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:26:56.514 T:3011372368 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:56.514 T:3011372368 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2020-06-01 08:26:56.577 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:26:56.597 T:3011372368 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:56.993 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:26:56.993 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:26:56.998 T:3011372368 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:56.998 T:3011372368 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2020-06-01 08:26:57.089 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:26:57.097 T:3011372368 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:57.985 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:26:57.986 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:26:57.997 T:3011372368 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:57.998 T:3011372368 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2020-06-01 08:26:58.081 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:26:58.097 T:3011372368 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:58.498 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:26:58.498 T:3011372368 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:58.498 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:26:58.498 T:3011372368 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2020-06-01 08:26:58.594 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:26:58.598 T:3011372368 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2020-06-01 08:26:59.106 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:26:59.106 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:26:59.131 T:3011372368 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 2020-06-01 08:26:59.266 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:26:59.298 T:3011372368 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 2020-06-01 08:26:59.298 T:3011372368 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 2020-06-01 08:26:59.298 T:3011372368 DEBUG: CGUIMediaWindow::GetDirectory (smb://192.168.1.120/video/Vegyes/Teszt/) 2020-06-01 08:26:59.298 T:3011372368 DEBUG: ParentPath = [smb://192.168.1.120/video/Vegyes/] 2020-06-01 08:26:59.299 T:2881561456 DEBUG: Thread waiting start, auto delete: false 2020-06-01 08:26:59.399 T:3011372368 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2020-06-01 08:26:59.413 T:2881561456 DEBUG: Thread waiting 2881561456 terminating 2020-06-01 08:26:59.431 T:3011372368 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2020-06-01 08:26:59.457 T:2881561456 DEBUG: Thread BackgroundLoader start, auto delete: false 2020-06-01 08:26:59.625 T:2881561456 DEBUG: Thread BackgroundLoader 2881561456 terminating 2020-06-01 08:27:03.874 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:27:03.875 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:27:03.897 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:03.898 T:3011372368 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-06-01 08:27:03.898 T:2863063920 DEBUG: Thread JobWorker start, auto delete: true 2020-06-01 08:27:04.375 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:04.376 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:04.431 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:04.431 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:04.464 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:04.464 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:04.497 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:04.498 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:04.531 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:04.531 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:04.564 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:04.564 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:04.598 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:04.598 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:04.631 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:04.631 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:04.664 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:04.664 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:04.698 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:04.698 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:04.731 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:04.731 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:04.764 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:04.764 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:04.798 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:04.798 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:04.831 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:04.831 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:04.864 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:04.864 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:04.898 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:04.898 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:04.931 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:04.931 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:04.964 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:04.964 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:04.998 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:04.998 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:05.031 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:05.031 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:05.064 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:05.064 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:05.098 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:05.098 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:05.131 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:05.131 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:05.164 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:05.164 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:05.197 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:05.198 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:05.231 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:05.231 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:05.251 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:27:05.264 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:05.264 T:3011372368 DEBUG: HandleKey: long-down (0x100f081) pressed, action is Down 2020-06-01 08:27:05.264 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:08.835 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:27:08.835 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:27:08.842 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:08.842 T:3011372368 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-06-01 08:27:09.059 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:27:09.064 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:09.635 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:27:09.635 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:27:09.664 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:09.664 T:3011372368 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-06-01 08:27:09.795 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:27:09.797 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:10.531 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:27:10.531 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:27:10.564 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:10.564 T:3011372368 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-06-01 08:27:10.691 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:27:10.697 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:11.683 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:27:11.684 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:27:11.687 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:11.687 T:3011372368 DEBUG: HandleKey: down (0xf081) pressed, action is Down 2020-06-01 08:27:11.844 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:27:11.864 T:3011372368 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 2020-06-01 08:27:18.244 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:27:18.245 T:2881561456 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:27:18.254 T:3011372368 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 2020-06-01 08:27:18.501 T:2881561456 DEBUG: Thread Timer 2881561456 terminating 2020-06-01 08:27:18.531 T:3011372368 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 2020-06-01 08:27:18.531 T:3011372368 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 2020-06-01 08:27:18.537 T:3011372368 DEBUG: OnPlayMedia smb://192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf10.mkv 2020-06-01 08:27:18.547 T:3011372368 DEBUG: CPlayerCoreFactory::GetPlayers(smb://192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf10.mkv) 2020-06-01 08:27:18.547 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 2020-06-01 08:27:18.547 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 2020-06-01 08:27:18.547 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 2020-06-01 08:27:18.547 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 2020-06-01 08:27:18.547 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 2020-06-01 08:27:18.547 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 2020-06-01 08:27:18.547 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 2020-06-01 08:27:18.547 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 2020-06-01 08:27:18.547 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 2020-06-01 08:27:18.547 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 2020-06-01 08:27:18.547 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 2020-06-01 08:27:18.547 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 2020-06-01 08:27:18.547 T:3011372368 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 2020-06-01 08:27:18.547 T:3011372368 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 2020-06-01 08:27:18.548 T:3011372368 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 2020-06-01 08:27:18.548 T:3011372368 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 2020-06-01 08:27:18.548 T:3011372368 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 2020-06-01 08:27:18.550 T:3011372368 DEBUG: CMMALPool::CMMALPool Created pool 0x25e0a30 of size 26 x 0 for port vc.ril.video_decode:out:0(I420) 2020-06-01 08:27:18.554 T:3011372368 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 2020-06-01 08:27:18.554 T:3011372368 NOTICE: VideoPlayer::OpenFile: smb://192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf10.mkv 2020-06-01 08:27:18.554 T:3011372368 DEBUG: CMMALRenderer::CMMALRenderer 2020-06-01 08:27:18.554 T:2746278768 DEBUG: Thread MMALProcess start, auto delete: false 2020-06-01 08:27:18.554 T:3011372368 DEBUG: OnPlayBackStarted: CApplication::OnPlayBackStarted 2020-06-01 08:27:18.554 T:2871456624 DEBUG: Thread VideoPlayer start, auto delete: false 2020-06-01 08:27:18.554 T:2746278768 DEBUG: CMMALRenderer::Run - starting 2020-06-01 08:27:18.554 T:2871456624 NOTICE: Creating InputStream 2020-06-01 08:27:18.554 T:2644824944 DEBUG: Thread BackgroundLoader start, auto delete: false 2020-06-01 08:27:18.564 T:2863063920 DEBUG: Loading settings for smb://192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf10.mkv 2020-06-01 08:27:18.573 T:2871456624 DEBUG: CSMBFile::Open - opened smb://USERNAME:PASSWORD@192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf10.mkv, fd=10000 2020-06-01 08:27:18.575 T:2871456624 DEBUG: ScanForExternalSubtitles: Searching for subtitles... 2020-06-01 08:27:18.584 T:2871456624 DEBUG: ScanForExternalSubtitles: END (total time: 8 ms) 2020-06-01 08:27:18.584 T:2871456624 NOTICE: Creating Demuxer 2020-06-01 08:27:18.598 T:3011372368 DEBUG: CVideoGUIInfo::InitCurrentItem(smb://192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf10.mkv) 2020-06-01 08:27:18.598 T:3011372368 DEBUG: CPlayerGUIInfo::InitCurrentItem(smb://192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf10.mkv) 2020-06-01 08:27:18.616 T:2871456624 DEBUG: Open - probing detected format [matroska,webm] 2020-06-01 08:27:18.616 T:2871456624 DEBUG: Open - avformat_find_stream_info starting 2020-06-01 08:27:18.638 T:2871456624 DEBUG: Open - av_find_stream_info finished 2020-06-01 08:27:18.639 T:2871456624 INFO: ffmpeg[AB26F370]: Input #0, matroska,webm, from 'smb://192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf10.mkv': 2020-06-01 08:27:18.639 T:2871456624 INFO: ffmpeg[AB26F370]: Metadata: 2020-06-01 08:27:18.639 T:2871456624 INFO: ffmpeg[AB26F370]: title : Big Buck Bunny, Sunflower version 2020-06-01 08:27:18.639 T:2871456624 INFO: ffmpeg[AB26F370]: GENRE : Animation 2020-06-01 08:27:18.639 T:2871456624 INFO: ffmpeg[AB26F370]: creation_time : 2020-05-30T21:02:41.000000Z 2020-06-01 08:27:18.639 T:2871456624 INFO: ffmpeg[AB26F370]: ARTIST : Blender Foundation 2008, Janus Bager Kristensen 2013 2020-06-01 08:27:18.639 T:2871456624 INFO: ffmpeg[AB26F370]: COMPOSER : Sacha Goedegebure 2020-06-01 08:27:18.639 T:2871456624 INFO: ffmpeg[AB26F370]: SUMMARY : Creative Commons Attribution 3.0 - http://bbb3d.renderfarming.net 2020-06-01 08:27:18.639 T:2871456624 INFO: ffmpeg[AB26F370]: ENCODER : Lavf58.29.100 2020-06-01 08:27:18.639 T:2871456624 INFO: ffmpeg[AB26F370]: Duration: 00:01:00.05, start: 0.000000, bitrate: 49444 kb/s 2020-06-01 08:27:18.639 T:2871456624 INFO: ffmpeg[AB26F370]: Stream #0:0: Video: hevc (Main 10), yuv420p10le(tv, bt709), 3840x2160 [SAR 1:1 DAR 16:9], 30 fps, 30 tbr, 1k tbn, 30 tbc (default) 2020-06-01 08:27:18.639 T:2871456624 INFO: ffmpeg[AB26F370]: Metadata: 2020-06-01 08:27:18.639 T:2871456624 INFO: ffmpeg[AB26F370]: DURATION : 00:01:00.044000000 2020-06-01 08:27:18.639 T:2871456624 INFO: ffmpeg[AB26F370]: Stream #0:1: Audio: aac (LC), 48000 Hz, stereo, fltp (default) 2020-06-01 08:27:18.639 T:2871456624 INFO: ffmpeg[AB26F370]: Metadata: 2020-06-01 08:27:18.639 T:2871456624 INFO: ffmpeg[AB26F370]: title : Stereo 2020-06-01 08:27:18.639 T:2871456624 INFO: ffmpeg[AB26F370]: DURATION : 00:01:00.053000000 2020-06-01 08:27:18.639 T:2871456624 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0 2020-06-01 08:27:18.639 T:2871456624 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 1 2020-06-01 08:27:18.640 T:2871456624 NOTICE: Opening stream: 0 source: 256 2020-06-01 08:27:18.640 T:2871456624 NOTICE: Whitelist search for: width: 3840, height: 2160, fps: 30.000, 3D: false 2020-06-01 08:27:18.640 T:2871456624 DEBUG: Whitelist is empty using default one 2020-06-01 08:27:18.640 T:2871456624 DEBUG: Trying to find exact refresh rate 2020-06-01 08:27:18.640 T:2871456624 DEBUG: No exact whitelisted resolution matched, trying double refresh rate 2020-06-01 08:27:18.640 T:2871456624 DEBUG: No double whitelisted resolution matched, trying 3:2 pullback 2020-06-01 08:27:18.640 T:2871456624 DEBUG: No 3:2 pullback refresh rate whitelisted resolution matched, trying current resolution 2020-06-01 08:27:18.640 T:2871456624 DEBUG: Matched current Resolution 3840x2160 @ 30.000000 Hz (16) 2020-06-01 08:27:18.640 T:2871456624 NOTICE: Display resolution ADJUST : 3840x2160 @ 30.000000 Hz (16) (weight: 0.000) 2020-06-01 08:27:18.677 T:2644824944 DEBUG: Thread BackgroundLoader 2644824944 terminating 2020-06-01 08:27:18.698 T:3011372368 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2020-06-01 08:27:18.699 T:2871456624 NOTICE: Creating video codec with codec id: 173 2020-06-01 08:27:18.699 T:2871456624 ERROR: CMMALVideo::Open : Video codec unknown: ad 2020-06-01 08:27:18.699 T:2871456624 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: HEVC (High Efficiency Video Coding) 2020-06-01 08:27:18.700 T:2871456624 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-hevc 2020-06-01 08:27:18.700 T:2871456624 DEBUG: CVideoPlayerVideo::OpenStream - open stream with codec id: 173 2020-06-01 08:27:18.701 T:2871456624 DEBUG: CMMALPool::CMMALPool Created pool 0xae410470 of size 26 x 0 for port vc.ril.video_decode:out:0(I420) 2020-06-01 08:27:18.701 T:2871456624 DEBUG: CMMALPool::~CMMALPool Destroying pool 0x25e0a30 for port vc.ril.video_decode:out:0(I420) 2020-06-01 08:27:18.702 T:2871456624 NOTICE: Creating video thread 2020-06-01 08:27:18.702 T:2881561456 DEBUG: Thread VideoPlayerVideo start, auto delete: false 2020-06-01 08:27:18.702 T:2881561456 NOTICE: running thread: video_thread 2020-06-01 08:27:18.702 T:2881561456 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_PAUSE: 0 2020-06-01 08:27:18.702 T:2871456624 DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: smb://192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf10.mkv 2020-06-01 08:27:18.702 T:2871456624 NOTICE: Opening stream: 1 source: 256 2020-06-01 08:27:18.702 T:2871456624 NOTICE: Finding audio codec for: 86018 2020-06-01 08:27:18.704 T:2871456624 NOTICE: CDVDAudioCodecFFmpeg::Open() Successful opened audio decoder aac 2020-06-01 08:27:18.704 T:2871456624 NOTICE: Creating audio thread 2020-06-01 08:27:18.705 T:2871456624 DEBUG: CVideoPlayer::SetCaching - caching state 2 2020-06-01 08:27:18.705 T:2871456624 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 2020-06-01 08:27:18.705 T:2636432240 DEBUG: Thread VideoPlayerAudio start, auto delete: false 2020-06-01 08:27:18.705 T:2871456624 DEBUG: CVideoPlayer::HandleMessages - player 2 reported state: 0 2020-06-01 08:27:18.705 T:2636432240 NOTICE: running thread: CVideoPlayerAudio::Process() 2020-06-01 08:27:18.705 T:2863063920 DEBUG: OnAVChange: CApplication::OnAVChange 2020-06-01 08:27:18.705 T:2871456624 DEBUG: CVideoPlayer::SetCaching - caching state 1 2020-06-01 08:27:18.705 T:2636432240 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_PAUSE: 0 2020-06-01 08:27:18.705 T:2871456624 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 2020-06-01 08:27:18.708 T:2636432240 DEBUG: CDVDAudio::Pause - pausing audio stream 2020-06-01 08:27:18.708 T:2871456624 DEBUG: CVideoPlayer::HandleMessages - player 1 reported state: 0 2020-06-01 08:27:18.708 T:2636432240 DEBUG: CDVDAudio::Pause - pausing audio stream 2020-06-01 08:27:18.709 T:2881561456 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback 2020-06-01 08:27:18.709 T:2636432240 NOTICE: Creating audio stream (codec id: 86018, channels: 2, sample rate: 48000, no pass-through) 2020-06-01 08:27:18.709 T:2636432240 DEBUG: CVideoPlayerAudio:: synctype set to 0: clock feedback 2020-06-01 08:27:18.709 T:2980148080 INFO: CActiveAESink::OpenSink - initialize sink 2020-06-01 08:27:18.709 T:2980148080 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 2020-06-01 08:27:18.709 T:2980148080 DEBUG: CAESinkPi:Initialize Format:24 Channels:2 Samplerate:48000 framesize:8 bufsize:19200 bytes/s=384000.00 dest=PI:HDMI 2020-06-01 08:27:18.710 T:2871456624 DEBUG: CVideoPlayer::CheckContinuity - wrapback :2, prev:144000.000000, curr:111000.000000, diff:-33000.000000 2020-06-01 08:27:18.710 T:2980148080 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 2020-06-01 08:27:18.712 T:2980148080 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0xaff030f0 2020-06-01 08:27:18.714 T:2980148080 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(19200), nBufferAlignment(16) 2020-06-01 08:27:18.714 T:2881561456 NOTICE: CDecoder::Open - fmt:188 2020-06-01 08:27:18.714 T:2881561456 DEBUG: CDecoder::Open MMAL - source requires 1 references 2020-06-01 08:27:18.715 T:2980148080 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 2020-06-01 08:27:18.715 T:2980148080 DEBUG: Output Device : HDMI 2020-06-01 08:27:18.715 T:2980148080 DEBUG: Sample Rate : 48000 2020-06-01 08:27:18.715 T:2980148080 DEBUG: Sample Format : AE_FMT_FLOATP 2020-06-01 08:27:18.715 T:2980148080 DEBUG: Channel Count : 2 2020-06-01 08:27:18.715 T:2980148080 DEBUG: Channel Layout: FL, FR 2020-06-01 08:27:18.716 T:2980148080 DEBUG: Frames : 2400 2020-06-01 08:27:18.716 T:2980148080 DEBUG: Frame Size : 8 2020-06-01 08:27:18.717 T:2881561456 DEBUG: CMMALPool::CMMALPool Created pool 0x24f92f0 of size 26 x 0 for port vc.ril.video_decode:out:0(I420) 2020-06-01 08:27:18.717 T:2881561456 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-hevc-mmal 2020-06-01 08:27:18.724 T:2988540784 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2020-06-01 08:27:18.727 T:2881561456 DEBUG: Previous line repeats 1 times. 2020-06-01 08:27:18.728 T:2881561456 DEBUG: CMMALPool::Configure pool:0x24f92f0 3840x2160 (3840x2160) pix:188 size:0 fmt:Y10C 2020-06-01 08:27:18.731 T:2871456624 DEBUG: CVideoPlayer::HandleMessages - player started 1 2020-06-01 08:27:18.731 T:2863063920 DEBUG: OnAVChange: CApplication::OnAVChange 2020-06-01 08:27:18.753 T:2881561456 DEBUG: ffmpeg[ABC12370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:27:18.845 T:2881561456 DEBUG: Previous line repeats 4 times. 2020-06-01 08:27:18.845 T:2881561456 DEBUG: CRenderManager::Configure - change configuration. 3840x2160. display: 3840x2160. framerate: 30.00. 2020-06-01 08:27:18.869 T:3011372368 DEBUG: DeleteRenderer - deleting renderer 2020-06-01 08:27:18.869 T:3011372368 DEBUG: CMMALRenderer::~CMMALRenderer 2020-06-01 08:27:18.869 T:3011372368 DEBUG: CMMALRenderer::UnInitMMAL 2020-06-01 08:27:18.870 T:2746278768 DEBUG: CMMALRenderer::Run - stopping 2020-06-01 08:27:18.870 T:2746278768 DEBUG: Thread MMALProcess 2746278768 terminating 2020-06-01 08:27:18.870 T:3011372368 DEBUG: CMMALRenderer::CMMALRenderer 2020-06-01 08:27:18.870 T:2746278768 DEBUG: Thread MMALProcess start, auto delete: false 2020-06-01 08:27:18.870 T:3011372368 DEBUG: CMMALRenderer::Configure - 3840x2160->3840x2160@30.00 flags:21 format:-1 orient:0 2020-06-01 08:27:18.870 T:2746278768 DEBUG: CMMALRenderer::Run - starting 2020-06-01 08:27:18.870 T:3011372368 DEBUG: CRenderManager::Configure - 6 2020-06-01 08:27:18.870 T:2863063920 DEBUG: OnAVChange: CApplication::OnAVChange 2020-06-01 08:27:18.871 T:2871456624 DEBUG: CVideoPlayer::HandleMessages - player started 2 2020-06-01 08:27:18.871 T:2871456624 DEBUG: VideoPlayer::Sync - Audio - pts: 299000.000000, cache: 413203.533785, totalcache: 699999.988079 2020-06-01 08:27:18.872 T:2871456624 DEBUG: VideoPlayer::Sync - Video - pts: 111000.000000, cache: 50000.000000, totalcache: 100000.000000 2020-06-01 08:27:18.872 T:2871456624 DEBUG: CVideoPlayer::SetCaching - caching state 0 2020-06-01 08:27:18.872 T:2871456624 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 2020-06-01 08:27:18.872 T:2881561456 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(-114203.533785) 2020-06-01 08:27:18.873 T:2636432240 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(-114203.533785), level: 64, cache: 370690.293452 2020-06-01 08:27:18.873 T:2636432240 DEBUG: CDVDAudio::Resume - resume audio stream 2020-06-01 08:27:18.874 T:2863063920 DEBUG: OnAVStarted: CApplication::OnAVStarted 2020-06-01 08:27:18.874 T:2988540784 DEBUG: ActiveAE - start sync of audio stream 2020-06-01 08:27:18.876 T:2470527856 DEBUG: Thread JobWorker start, auto delete: true 2020-06-01 08:27:18.881 T:2746278768 DEBUG: CMMALRenderer::CheckConfigurationVout Changing Vout dimensions from 0x0 (0x0) to 3840x2160 (0x0) Y10C 2020-06-01 08:27:18.887 T:2746278768 DEBUG: CMMALRenderer::SetVideoRect 0,0,3840,2160 -> 0,0,1920,1080 (o:0 v:0 d:0 i:0) 2020-06-01 08:27:18.887 T:2746278768 DEBUG: CMMALRenderer::SetVideoRect 0,0,3840,2160 -> 0,0,3840,2160 t:100000 2020-06-01 08:27:18.888 T:2429129584 DEBUG: Thread MMALRenderer start, auto delete: false 2020-06-01 08:27:18.888 T:2429129584 DEBUG: CMMALRenderer::Process - starting 2020-06-01 08:27:18.898 T:3011372368 DEBUG: CMMALRenderer::RenderUpdate - vsync -1 (+19601) 2020-06-01 08:27:18.898 T:3011372368 DEBUG: CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 75 2020-06-01 08:27:18.901 T:2881561456 DEBUG: ffmpeg[ABC12370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:27:18.935 T:3011372368 DEBUG: Previous line repeats 3 times. 2020-06-01 08:27:18.935 T:3011372368 DEBUG: Activating window ID: 12005 2020-06-01 08:27:18.936 T:3011372368 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 2020-06-01 08:27:18.937 T:3011372368 DEBUG: FreeVisualisation() done 2020-06-01 08:27:18.938 T:3011372368 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 2020-06-01 08:27:18.938 T:3011372368 INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY 2020-06-01 08:27:18.946 T:3011372368 NOTICE: Whitelist search for: width: 3840, height: 2160, fps: 30.000, 3D: false 2020-06-01 08:27:18.946 T:3011372368 DEBUG: Whitelist is empty using default one 2020-06-01 08:27:18.946 T:3011372368 DEBUG: Trying to find exact refresh rate 2020-06-01 08:27:18.946 T:3011372368 DEBUG: No exact whitelisted resolution matched, trying double refresh rate 2020-06-01 08:27:18.946 T:3011372368 DEBUG: No double whitelisted resolution matched, trying 3:2 pullback 2020-06-01 08:27:18.946 T:3011372368 DEBUG: No 3:2 pullback refresh rate whitelisted resolution matched, trying current resolution 2020-06-01 08:27:18.947 T:3011372368 DEBUG: Matched current Resolution 3840x2160 @ 30.000000 Hz (16) 2020-06-01 08:27:18.947 T:3011372368 NOTICE: Display resolution ADJUST : 3840x2160 @ 30.000000 Hz (16) (weight: 0.078) 2020-06-01 08:27:18.947 T:2881561456 DEBUG: ffmpeg[ABC12370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:27:18.949 T:2863063920 DEBUG: Previous line repeats 4 times. 2020-06-01 08:27:18.949 T:2863063920 DEBUG: OnAVChange: CApplication::OnAVChange 2020-06-01 08:27:18.950 T:3011372368 DEBUG: CMMALRenderer::SetVideoRect 0,0,3840,2160 -> 0,0,1920,1080 (o:0 v:0 d:0 i:0) 2020-06-01 08:27:18.954 T:3011372368 DEBUG: CMMALRenderer::SetVideoRect 0,0,3840,2160 -> 0,0,3840,2160 t:100000 2020-06-01 08:27:18.955 T:3011372368 DEBUG: CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 66 2020-06-01 08:27:18.965 T:3011372368 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2020-06-01 08:27:18.974 T:2988540784 DEBUG: ActiveAE::SyncStream - average error of -0.569804, start adjusting 2020-06-01 08:27:18.974 T:2988540784 DEBUG: ActiveAE::SyncStream - average error -0.007304 below threshold of 30.000000 2020-06-01 08:27:18.992 T:2881561456 DEBUG: ffmpeg[ABC12370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:27:19.184 T:2881561456 DEBUG: Previous line repeats 42 times. 2020-06-01 08:27:19.184 T:2881561456 NOTICE: CDVDVideoCodecFFmpeg::CDropControl: calculated diff time: 33272 2020-06-01 08:27:19.203 T:2881561456 DEBUG: ffmpeg[ABC12370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:27:20.023 T:2636432240 DEBUG: Previous line repeats 119 times. 2020-06-01 08:27:20.023 T:2636432240 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-37134.111531, adjusted:-33333.333333 2020-06-01 08:27:20.069 T:2881561456 DEBUG: ffmpeg[ABC12370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:27:22.886 T:2881561456 DEBUG: Previous line repeats 407 times. 2020-06-01 08:27:22.886 T:2881561456 DEBUG: CPtsTracker: detected pattern of length 1: 33333.32, frameduration: 33333.333333 2020-06-01 08:27:22.903 T:2881561456 DEBUG: ffmpeg[ABC12370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:27:29.240 T:2881561456 DEBUG: Previous line repeats 868 times. 2020-06-01 08:27:29.240 T:2881561456 DEBUG: CPtsTracker: pattern lost on diff 66000.000000, number of losses 1 2020-06-01 08:27:29.250 T:2881561456 DEBUG: ffmpeg[ABC12370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:27:37.937 T:2881561456 DEBUG: Previous line repeats 1164 times. 2020-06-01 08:27:37.937 T:2881561456 DEBUG: CPtsTracker: detected pattern of length 1: 33333.33, frameduration: 33333.333333 2020-06-01 08:27:37.947 T:2881561456 DEBUG: ffmpeg[ABC12370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:27:46.998 T:2881561456 DEBUG: Previous line repeats 1249 times. 2020-06-01 08:27:46.998 T:2881561456 DEBUG: CPtsTracker: pattern lost on diff 67000.000000, number of losses 2 2020-06-01 08:27:47.008 T:2881561456 DEBUG: ffmpeg[ABC12370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:27:48.949 T:2470527856 DEBUG: Previous line repeats 222 times. 2020-06-01 08:27:48.949 T:2470527856 DEBUG: Thread JobWorker 2470527856 terminating (autodelete) 2020-06-01 08:27:48.950 T:2863063920 DEBUG: Thread JobWorker 2863063920 terminating (autodelete) 2020-06-01 08:27:49.036 T:2881561456 DEBUG: ffmpeg[ABC12370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:28:02.757 T:2881561456 DEBUG: Previous line repeats 1701 times. 2020-06-01 08:28:02.758 T:2881561456 DEBUG: CPtsTracker: detected pattern of length 1: 33333.33, frameduration: 33333.333333 2020-06-01 08:28:02.771 T:2881561456 DEBUG: ffmpeg[ABC12370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:28:18.630 T:2636432240 DEBUG: Previous line repeats 2263 times. 2020-06-01 08:28:18.630 T:2636432240 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_EOF 2020-06-01 08:28:18.639 T:2881561456 DEBUG: ffmpeg[ABC12370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:28:18.718 T:2871456624 DEBUG: Previous line repeats 9 times. 2020-06-01 08:28:18.718 T:2871456624 NOTICE: CVideoPlayer::OnExit() 2020-06-01 08:28:18.718 T:2871456624 NOTICE: VideoPlayer: eof, waiting for queues to empty 2020-06-01 08:28:18.718 T:2871456624 NOTICE: Closing stream player 1 2020-06-01 08:28:18.718 T:2871456624 NOTICE: CDVDMessageQueue(audio)::WaitUntilEmpty 2020-06-01 08:28:18.718 T:2871456624 NOTICE: Waiting for audio thread to exit 2020-06-01 08:28:18.718 T:2636432240 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 2020-06-01 08:28:18.719 T:2636432240 NOTICE: thread end: CVideoPlayerAudio::OnExit() 2020-06-01 08:28:18.719 T:2871456624 NOTICE: Closing audio device 2020-06-01 08:28:18.719 T:2636432240 DEBUG: Thread VideoPlayerAudio 2636432240 terminating 2020-06-01 08:28:18.765 T:2881561456 DEBUG: CDVDVideoCodecFFmpeg::GetPicture - eof hw accel 2020-06-01 08:28:18.830 T:2988540784 DEBUG: CActiveAE::DiscardStream - audio stream deleted 2020-06-01 08:28:18.830 T:2988540784 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2020-06-01 08:28:18.830 T:2871456624 DEBUG: Previous line repeats 1 times. 2020-06-01 08:28:18.830 T:2871456624 NOTICE: Deleting audio codec 2020-06-01 08:28:18.847 T:2871456624 NOTICE: Closing stream player 2 2020-06-01 08:28:18.847 T:2871456624 NOTICE: CDVDMessageQueue(video)::WaitUntilEmpty 2020-06-01 08:28:18.848 T:2881561456 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 2020-06-01 08:28:18.848 T:2871456624 NOTICE: waiting for video thread to exit 2020-06-01 08:28:18.848 T:2881561456 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true 2020-06-01 08:28:18.848 T:2881561456 NOTICE: thread end: video_thread 2020-06-01 08:28:18.848 T:2881561456 DEBUG: Thread VideoPlayerVideo 2881561456 terminating 2020-06-01 08:28:18.848 T:2871456624 NOTICE: deleting video codec 2020-06-01 08:28:18.921 T:2881561456 DEBUG: Thread JobWorker start, auto delete: true 2020-06-01 08:28:18.938 T:2871456624 DEBUG: CSMBFile::Close closing fd 10000 2020-06-01 08:28:19.007 T:2988540784 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2020-06-01 08:28:19.055 T:2871456624 DEBUG: Thread VideoPlayer 2871456624 terminating 2020-06-01 08:28:19.064 T:2881561456 INFO: Deleting settings information for files smb://192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf10.mkv 2020-06-01 08:28:19.084 T:2980148080 INFO: CActiveAESink::OpenSink - initialize sink 2020-06-01 08:28:19.084 T:2871456624 DEBUG: Thread JobWorker start, auto delete: true 2020-06-01 08:28:19.084 T:2881561456 DEBUG: DoWork - Saving file state for video item smb://192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf10.mkv 2020-06-01 08:28:19.088 T:2881561456 DEBUG: DoWork - Marking video item smb://192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf10.mkv as watched 2020-06-01 08:28:19.107 T:2881561456 DEBUG: OnPlayBackEnded: CApplication::OnPlayBackEnded 2020-06-01 08:28:19.136 T:3011372368 NOTICE: CVideoPlayer::CloseFile() 2020-06-01 08:28:19.136 T:3011372368 DEBUG: DeleteRenderer - deleting renderer 2020-06-01 08:28:19.136 T:3011372368 DEBUG: CMMALRenderer::~CMMALRenderer 2020-06-01 08:28:19.136 T:3011372368 DEBUG: CMMALRenderer::UnInitMMAL 2020-06-01 08:28:19.164 T:2429129584 DEBUG: CMMALRenderer::Process - stopping 2020-06-01 08:28:19.164 T:2429129584 DEBUG: Thread MMALRenderer 2429129584 terminating 2020-06-01 08:28:19.183 T:2980148080 DEBUG: CAESinkPi:Drain delay:99ms now:0ms 2020-06-01 08:28:19.183 T:2980148080 DEBUG: CAESinkPi:Deinitialize 2020-06-01 08:28:19.183 T:2980148080 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 2020-06-01 08:28:19.190 T:2980148080 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0xaff030f0 2020-06-01 08:28:19.190 T:2980148080 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 2020-06-01 08:28:19.190 T:2980148080 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:17640 bytes/s=352800.00 dest=PI:HDMI 2020-06-01 08:28:19.190 T:2980148080 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 2020-06-01 08:28:19.191 T:2980148080 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0xaff77750 2020-06-01 08:28:19.193 T:2980148080 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(17648), nBufferAlignment(16) 2020-06-01 08:28:19.193 T:2980148080 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 2020-06-01 08:28:19.193 T:2980148080 DEBUG: Output Device : HDMI 2020-06-01 08:28:19.193 T:2980148080 DEBUG: Sample Rate : 44100 2020-06-01 08:28:19.193 T:2980148080 DEBUG: Sample Format : AE_FMT_FLOAT 2020-06-01 08:28:19.193 T:2980148080 DEBUG: Channel Count : 2 2020-06-01 08:28:19.193 T:2980148080 DEBUG: Channel Layout: FL, FR 2020-06-01 08:28:19.193 T:2980148080 DEBUG: Frames : 2205 2020-06-01 08:28:19.193 T:2980148080 DEBUG: Frame Size : 8 2020-06-01 08:28:19.305 T:2988540784 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2020-06-01 08:28:19.306 T:2746278768 DEBUG: Previous line repeats 1 times. 2020-06-01 08:28:19.306 T:2746278768 DEBUG: CMMALPool::~CMMALPool Destroying pool 0x24f92f0 for port vc.ril.video_decode:out:0(I420) 2020-06-01 08:28:19.327 T:2746278768 DEBUG: CMMALRenderer::Run - stopping 2020-06-01 08:28:19.327 T:2746278768 DEBUG: Thread MMALProcess 2746278768 terminating 2020-06-01 08:28:19.327 T:3011372368 NOTICE: VideoPlayer: waiting for threads to exit 2020-06-01 08:28:19.327 T:3011372368 NOTICE: VideoPlayer: finished waiting 2020-06-01 08:28:19.327 T:3011372368 NOTICE: CVideoPlayer::CloseFile() 2020-06-01 08:28:19.327 T:3011372368 NOTICE: VideoPlayer: waiting for threads to exit 2020-06-01 08:28:19.327 T:3011372368 NOTICE: VideoPlayer: finished waiting 2020-06-01 08:28:19.339 T:3011372368 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 2020-06-01 08:28:19.339 T:3011372368 DEBUG: CMMALPool::~CMMALPool Destroying pool 0xae410470 for port vc.ril.video_decode:out:0(I420) 2020-06-01 08:28:19.340 T:3011372368 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 2020-06-01 08:28:19.340 T:3011372368 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 2020-06-01 08:28:19.346 T:3011372368 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 2020-06-01 08:28:19.351 T:3011372368 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 2020-06-01 08:28:19.368 T:3011372368 DEBUG: CGUIMediaWindow::GetDirectory (smb://192.168.1.120/video/Vegyes/Teszt/) 2020-06-01 08:28:19.368 T:3011372368 DEBUG: ParentPath = [smb://192.168.1.120/video/Vegyes/Teszt/] 2020-06-01 08:28:19.517 T:2644824944 DEBUG: Thread BackgroundLoader start, auto delete: false 2020-06-01 08:28:19.723 T:2644824944 DEBUG: Thread BackgroundLoader 2644824944 terminating 2020-06-01 08:28:19.905 T:3011372368 DEBUG: CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 66 2020-06-01 08:28:19.957 T:3011372368 DEBUG: CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 75 2020-06-01 08:28:23.111 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:28:23.111 T:2644824944 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:28:23.131 T:3011372368 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2020-06-01 08:28:23.131 T:3011372368 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2020-06-01 08:28:23.246 T:2644824944 DEBUG: Thread Timer 2644824944 terminating 2020-06-01 08:28:23.264 T:3011372368 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2020-06-01 08:28:23.790 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:28:23.791 T:2644824944 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:28:23.797 T:3011372368 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2020-06-01 08:28:23.798 T:3011372368 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2020-06-01 08:28:23.919 T:2644824944 DEBUG: Thread Timer 2644824944 terminating 2020-06-01 08:28:23.931 T:3011372368 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2020-06-01 08:28:24.463 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:28:24.463 T:2644824944 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:28:24.464 T:3011372368 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2020-06-01 08:28:24.464 T:3011372368 DEBUG: HandleKey: up (0xf080) pressed, action is Up 2020-06-01 08:28:24.559 T:2644824944 DEBUG: Thread Timer 2644824944 terminating 2020-06-01 08:28:24.564 T:3011372368 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 2020-06-01 08:28:26.607 T:3001021296 DEBUG: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms 2020-06-01 08:28:26.607 T:2644824944 DEBUG: Thread Timer start, auto delete: false 2020-06-01 08:28:26.631 T:3011372368 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 2020-06-01 08:28:26.767 T:2644824944 DEBUG: Thread Timer 2644824944 terminating 2020-06-01 08:28:26.797 T:3011372368 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x000d, modifier: 0x0 2020-06-01 08:28:26.798 T:3011372368 DEBUG: HandleKey: return (0xf00d) pressed, action is Select 2020-06-01 08:28:26.803 T:3011372368 DEBUG: OnPlayMedia smb://192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf07.mkv 2020-06-01 08:28:26.817 T:3011372368 DEBUG: CPlayerCoreFactory::GetPlayers(smb://192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf07.mkv) 2020-06-01 08:28:26.817 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 2020-06-01 08:28:26.817 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 2020-06-01 08:28:26.817 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 2020-06-01 08:28:26.817 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 2020-06-01 08:28:26.817 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 2020-06-01 08:28:26.817 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 2020-06-01 08:28:26.817 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 2020-06-01 08:28:26.817 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 2020-06-01 08:28:26.817 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 2020-06-01 08:28:26.817 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 2020-06-01 08:28:26.817 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 2020-06-01 08:28:26.817 T:3011372368 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 2020-06-01 08:28:26.817 T:3011372368 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 2020-06-01 08:28:26.817 T:3011372368 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 2020-06-01 08:28:26.817 T:3011372368 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 2020-06-01 08:28:26.817 T:3011372368 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 2020-06-01 08:28:26.817 T:3011372368 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 2020-06-01 08:28:26.822 T:3011372368 DEBUG: CMMALPool::CMMALPool Created pool 0x2623320 of size 26 x 0 for port vc.ril.video_decode:out:0(I420) 2020-06-01 08:28:26.826 T:3011372368 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 2020-06-01 08:28:26.826 T:3011372368 NOTICE: VideoPlayer::OpenFile: smb://192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf07.mkv 2020-06-01 08:28:26.826 T:3011372368 DEBUG: CMMALRenderer::CMMALRenderer 2020-06-01 08:28:26.826 T:2746278768 DEBUG: Thread MMALProcess start, auto delete: false 2020-06-01 08:28:26.827 T:3011372368 DEBUG: OnPlayBackStarted: CApplication::OnPlayBackStarted 2020-06-01 08:28:26.827 T:2625688432 DEBUG: Thread VideoPlayer start, auto delete: false 2020-06-01 08:28:26.827 T:2746278768 DEBUG: CMMALRenderer::Run - starting 2020-06-01 08:28:26.827 T:2439283568 DEBUG: Thread BackgroundLoader start, auto delete: false 2020-06-01 08:28:26.827 T:2625688432 NOTICE: Creating InputStream 2020-06-01 08:28:26.839 T:2881561456 DEBUG: Loading settings for smb://192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf07.mkv 2020-06-01 08:28:26.848 T:2625688432 DEBUG: CSMBFile::Open - opened smb://USERNAME:PASSWORD@192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf07.mkv, fd=10000 2020-06-01 08:28:26.850 T:2625688432 DEBUG: ScanForExternalSubtitles: Searching for subtitles... 2020-06-01 08:28:26.858 T:2625688432 DEBUG: ScanForExternalSubtitles: END (total time: 8 ms) 2020-06-01 08:28:26.858 T:2625688432 NOTICE: Creating Demuxer 2020-06-01 08:28:26.864 T:3011372368 DEBUG: CVideoGUIInfo::InitCurrentItem(smb://192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf07.mkv) 2020-06-01 08:28:26.864 T:3011372368 DEBUG: CPlayerGUIInfo::InitCurrentItem(smb://192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf07.mkv) 2020-06-01 08:28:26.897 T:2625688432 DEBUG: Open - probing detected format [matroska,webm] 2020-06-01 08:28:26.898 T:2625688432 DEBUG: Open - avformat_find_stream_info starting 2020-06-01 08:28:26.926 T:2625688432 DEBUG: Open - av_find_stream_info finished 2020-06-01 08:28:26.926 T:2625688432 INFO: ffmpeg[9C80D370]: Input #0, matroska,webm, from 'smb://192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf07.mkv': 2020-06-01 08:28:26.926 T:2625688432 INFO: ffmpeg[9C80D370]: Metadata: 2020-06-01 08:28:26.926 T:2625688432 INFO: ffmpeg[9C80D370]: title : Big Buck Bunny, Sunflower version 2020-06-01 08:28:26.926 T:2625688432 INFO: ffmpeg[9C80D370]: GENRE : Animation 2020-06-01 08:28:26.926 T:2625688432 INFO: ffmpeg[9C80D370]: creation_time : 2020-05-31T12:27:53.000000Z 2020-06-01 08:28:26.926 T:2625688432 INFO: ffmpeg[9C80D370]: ARTIST : Blender Foundation 2008, Janus Bager Kristensen 2013 2020-06-01 08:28:26.926 T:2625688432 INFO: ffmpeg[9C80D370]: COMPOSER : Sacha Goedegebure 2020-06-01 08:28:26.926 T:2625688432 INFO: ffmpeg[9C80D370]: SUMMARY : Creative Commons Attribution 3.0 - http://bbb3d.renderfarming.net 2020-06-01 08:28:26.926 T:2625688432 INFO: ffmpeg[9C80D370]: ENCODER : Lavf58.29.100 2020-06-01 08:28:26.926 T:2625688432 INFO: ffmpeg[9C80D370]: Duration: 00:01:00.05, start: 0.000000, bitrate: 75511 kb/s 2020-06-01 08:28:26.926 T:2625688432 INFO: ffmpeg[9C80D370]: Stream #0:0: Video: hevc (Main 10), yuv420p10le(tv, bt709), 3840x2160 [SAR 1:1 DAR 16:9], 30 fps, 30 tbr, 1k tbn, 30 tbc (default) 2020-06-01 08:28:26.926 T:2625688432 INFO: ffmpeg[9C80D370]: Metadata: 2020-06-01 08:28:26.926 T:2625688432 INFO: ffmpeg[9C80D370]: DURATION : 00:01:00.044000000 2020-06-01 08:28:26.927 T:2625688432 INFO: ffmpeg[9C80D370]: Stream #0:1: Audio: aac (LC), 48000 Hz, stereo, fltp (default) 2020-06-01 08:28:26.927 T:2625688432 INFO: ffmpeg[9C80D370]: Metadata: 2020-06-01 08:28:26.927 T:2625688432 INFO: ffmpeg[9C80D370]: title : Stereo 2020-06-01 08:28:26.927 T:2625688432 INFO: ffmpeg[9C80D370]: DURATION : 00:01:00.053000000 2020-06-01 08:28:26.927 T:2625688432 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0 2020-06-01 08:28:26.927 T:2625688432 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 1 2020-06-01 08:28:26.927 T:2625688432 NOTICE: Opening stream: 0 source: 256 2020-06-01 08:28:26.927 T:2625688432 NOTICE: Whitelist search for: width: 3840, height: 2160, fps: 30.000, 3D: false 2020-06-01 08:28:26.927 T:2625688432 DEBUG: Whitelist is empty using default one 2020-06-01 08:28:26.927 T:2625688432 DEBUG: Trying to find exact refresh rate 2020-06-01 08:28:26.927 T:2625688432 DEBUG: No exact whitelisted resolution matched, trying double refresh rate 2020-06-01 08:28:26.927 T:2625688432 DEBUG: No double whitelisted resolution matched, trying 3:2 pullback 2020-06-01 08:28:26.928 T:2625688432 DEBUG: No 3:2 pullback refresh rate whitelisted resolution matched, trying current resolution 2020-06-01 08:28:26.928 T:2625688432 DEBUG: Matched current Resolution 3840x2160 @ 30.000000 Hz (16) 2020-06-01 08:28:26.928 T:2625688432 NOTICE: Display resolution ADJUST : 3840x2160 @ 30.000000 Hz (16) (weight: 0.000) 2020-06-01 08:28:26.948 T:2439283568 DEBUG: Thread BackgroundLoader 2439283568 terminating 2020-06-01 08:28:26.965 T:3011372368 DEBUG: ------ Window Init (DialogBusy.xml) ------ 2020-06-01 08:28:26.966 T:2625688432 NOTICE: Creating video codec with codec id: 173 2020-06-01 08:28:26.966 T:2625688432 ERROR: CMMALVideo::Open : Video codec unknown: ad 2020-06-01 08:28:26.966 T:2625688432 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: HEVC (High Efficiency Video Coding) 2020-06-01 08:28:26.966 T:2625688432 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-hevc 2020-06-01 08:28:26.966 T:2625688432 DEBUG: CVideoPlayerVideo::OpenStream - open stream with codec id: 173 2020-06-01 08:28:26.968 T:2625688432 DEBUG: CMMALPool::CMMALPool Created pool 0xb2416370 of size 26 x 0 for port vc.ril.video_decode:out:0(I420) 2020-06-01 08:28:26.968 T:2625688432 DEBUG: CMMALPool::~CMMALPool Destroying pool 0x2623320 for port vc.ril.video_decode:out:0(I420) 2020-06-01 08:28:26.968 T:2625688432 NOTICE: Creating video thread 2020-06-01 08:28:26.968 T:2644824944 DEBUG: Thread VideoPlayerVideo start, auto delete: false 2020-06-01 08:28:26.968 T:2644824944 NOTICE: running thread: video_thread 2020-06-01 08:28:26.968 T:2644824944 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_PAUSE: 0 2020-06-01 08:28:26.968 T:2625688432 DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: smb://192.168.1.120/video/Vegyes/Teszt/bbb_sunflower_2160p_30fps_10bit_main10_5.1_rf07.mkv 2020-06-01 08:28:26.969 T:2625688432 NOTICE: Opening stream: 1 source: 256 2020-06-01 08:28:26.969 T:2625688432 NOTICE: Finding audio codec for: 86018 2020-06-01 08:28:26.989 T:2625688432 NOTICE: CDVDAudioCodecFFmpeg::Open() Successful opened audio decoder aac 2020-06-01 08:28:26.989 T:2625688432 NOTICE: Creating audio thread 2020-06-01 08:28:26.989 T:2653422448 DEBUG: Thread VideoPlayerAudio start, auto delete: false 2020-06-01 08:28:26.989 T:2653422448 NOTICE: running thread: CVideoPlayerAudio::Process() 2020-06-01 08:28:26.989 T:2653422448 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_PAUSE: 0 2020-06-01 08:28:26.989 T:2625688432 DEBUG: CVideoPlayer::SetCaching - caching state 2 2020-06-01 08:28:26.989 T:2625688432 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 2020-06-01 08:28:26.989 T:2625688432 DEBUG: CVideoPlayer::HandleMessages - player 2 reported state: 0 2020-06-01 08:28:26.990 T:2881561456 DEBUG: OnAVChange: CApplication::OnAVChange 2020-06-01 08:28:26.990 T:2625688432 DEBUG: CVideoPlayer::HandleMessages - player 1 reported state: 0 2020-06-01 08:28:26.990 T:2625688432 DEBUG: CVideoPlayer::SetCaching - caching state 1 2020-06-01 08:28:26.990 T:2625688432 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 2020-06-01 08:28:26.990 T:2644824944 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback 2020-06-01 08:28:26.993 T:2625688432 DEBUG: CVideoPlayer::CheckContinuity - wrapback :2, prev:144000.000000, curr:111000.000000, diff:-33000.000000 2020-06-01 08:28:26.999 T:2653422448 DEBUG: CDVDAudio::Pause - pausing audio stream 2020-06-01 08:28:26.999 T:2653422448 DEBUG: Previous line repeats 1 times. 2020-06-01 08:28:26.999 T:2653422448 NOTICE: Creating audio stream (codec id: 86018, channels: 2, sample rate: 48000, no pass-through) 2020-06-01 08:28:27.000 T:2653422448 DEBUG: CVideoPlayerAudio:: synctype set to 0: clock feedback 2020-06-01 08:28:27.003 T:2644824944 NOTICE: CDecoder::Open - fmt:188 2020-06-01 08:28:27.003 T:2644824944 DEBUG: CDecoder::Open MMAL - source requires 1 references 2020-06-01 08:28:27.007 T:2644824944 DEBUG: CMMALPool::CMMALPool Created pool 0xb2e18ca0 of size 26 x 0 for port vc.ril.video_decode:out:0(I420) 2020-06-01 08:28:27.007 T:2644824944 DEBUG: CDVDVideoCodecFFmpeg - Updated codec: ff-hevc-mmal 2020-06-01 08:28:27.022 T:2644824944 DEBUG: CMMALPool::Configure pool:0xb2e18ca0 3840x2160 (3840x2160) pix:188 size:0 fmt:Y10C 2020-06-01 08:28:27.047 T:2980148080 INFO: CActiveAESink::OpenSink - initialize sink 2020-06-01 08:28:27.051 T:2644824944 DEBUG: ffmpeg[9DA4D370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:28:27.140 T:2644824944 DEBUG: Previous line repeats 4 times. 2020-06-01 08:28:27.140 T:2644824944 DEBUG: CRenderManager::Configure - change configuration. 3840x2160. display: 3840x2160. framerate: 30.00. 2020-06-01 08:28:27.147 T:2980148080 DEBUG: CAESinkPi:Drain delay:100ms now:0ms 2020-06-01 08:28:27.147 T:2980148080 DEBUG: CAESinkPi:Deinitialize 2020-06-01 08:28:27.147 T:2980148080 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 2020-06-01 08:28:27.154 T:2980148080 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0xaff77750 2020-06-01 08:28:27.154 T:2980148080 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 2020-06-01 08:28:27.154 T:2980148080 DEBUG: CAESinkPi:Initialize Format:24 Channels:2 Samplerate:48000 framesize:8 bufsize:19200 bytes/s=384000.00 dest=PI:HDMI 2020-06-01 08:28:27.154 T:2980148080 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 2020-06-01 08:28:27.155 T:2980148080 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0xaff3f758 2020-06-01 08:28:27.157 T:2980148080 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(19200), nBufferAlignment(16) 2020-06-01 08:28:27.157 T:2980148080 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 2020-06-01 08:28:27.157 T:2980148080 DEBUG: Output Device : HDMI 2020-06-01 08:28:27.157 T:2980148080 DEBUG: Sample Rate : 48000 2020-06-01 08:28:27.157 T:2980148080 DEBUG: Sample Format : AE_FMT_FLOATP 2020-06-01 08:28:27.157 T:2980148080 DEBUG: Channel Count : 2 2020-06-01 08:28:27.157 T:2980148080 DEBUG: Channel Layout: FL, FR 2020-06-01 08:28:27.157 T:2980148080 DEBUG: Frames : 2400 2020-06-01 08:28:27.157 T:2980148080 DEBUG: Frame Size : 8 2020-06-01 08:28:27.160 T:2988540784 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 2020-06-01 08:28:27.167 T:3011372368 DEBUG: Previous line repeats 1 times. 2020-06-01 08:28:27.167 T:3011372368 DEBUG: DeleteRenderer - deleting renderer 2020-06-01 08:28:27.167 T:3011372368 DEBUG: CMMALRenderer::~CMMALRenderer 2020-06-01 08:28:27.167 T:3011372368 DEBUG: CMMALRenderer::UnInitMMAL 2020-06-01 08:28:27.167 T:2746278768 DEBUG: CMMALRenderer::Run - stopping 2020-06-01 08:28:27.167 T:2746278768 DEBUG: Thread MMALProcess 2746278768 terminating 2020-06-01 08:28:27.167 T:3011372368 DEBUG: CMMALRenderer::CMMALRenderer 2020-06-01 08:28:27.167 T:3011372368 DEBUG: CMMALRenderer::Configure - 3840x2160->3840x2160@30.00 flags:21 format:-1 orient:0 2020-06-01 08:28:27.167 T:2746278768 DEBUG: Thread MMALProcess start, auto delete: false 2020-06-01 08:28:27.167 T:3011372368 DEBUG: CRenderManager::Configure - 6 2020-06-01 08:28:27.167 T:2746278768 DEBUG: CMMALRenderer::Run - starting 2020-06-01 08:28:27.173 T:2746278768 DEBUG: CMMALRenderer::CheckConfigurationVout Changing Vout dimensions from 0x0 (0x0) to 3840x2160 (0x0) Y10C 2020-06-01 08:28:27.175 T:2625688432 DEBUG: CVideoPlayer::HandleMessages - player started 1 2020-06-01 08:28:27.175 T:2625688432 DEBUG: CVideoPlayer::HandleMessages - player started 2 2020-06-01 08:28:27.175 T:2871456624 DEBUG: OnAVChange: CApplication::OnAVChange 2020-06-01 08:28:27.175 T:2625688432 DEBUG: VideoPlayer::Sync - Audio - pts: 299000.000000, cache: 367129.885785, totalcache: 699999.988079 2020-06-01 08:28:27.175 T:2625688432 DEBUG: VideoPlayer::Sync - Video - pts: 111000.000000, cache: 50000.000000, totalcache: 100000.000000 2020-06-01 08:28:27.175 T:2625688432 DEBUG: CVideoPlayer::SetCaching - caching state 0 2020-06-01 08:28:27.175 T:2871456624 DEBUG: OnAVChange: CApplication::OnAVChange 2020-06-01 08:28:27.175 T:2625688432 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 2020-06-01 08:28:27.180 T:2653422448 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(-68129.885785), level: 56, cache: 404245.274452 2020-06-01 08:28:27.180 T:2746278768 DEBUG: CMMALRenderer::SetVideoRect 0,0,3840,2160 -> 0,0,1920,1080 (o:0 v:0 d:0 i:0) 2020-06-01 08:28:27.180 T:2455741296 DEBUG: Thread MMALRenderer start, auto delete: false 2020-06-01 08:28:27.180 T:2644824944 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(-68129.885785) 2020-06-01 08:28:27.180 T:2455741296 DEBUG: CMMALRenderer::Process - starting 2020-06-01 08:28:27.180 T:2653422448 DEBUG: CDVDAudio::Resume - resume audio stream 2020-06-01 08:28:27.180 T:2988540784 DEBUG: ActiveAE - start sync of audio stream 2020-06-01 08:28:27.180 T:2746278768 DEBUG: CMMALRenderer::SetVideoRect 0,0,3840,2160 -> 0,0,3840,2160 t:100000 2020-06-01 08:28:27.180 T:2881561456 DEBUG: OnAVStarted: CApplication::OnAVStarted 2020-06-01 08:28:27.198 T:3011372368 DEBUG: CMMALRenderer::RenderUpdate - vsync -1 (+21650) 2020-06-01 08:28:27.198 T:3011372368 DEBUG: CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 75 2020-06-01 08:28:27.209 T:2644824944 DEBUG: ffmpeg[9DA4D370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:28:27.232 T:3011372368 DEBUG: Previous line repeats 3 times. 2020-06-01 08:28:27.232 T:3011372368 DEBUG: Activating window ID: 12005 2020-06-01 08:28:27.233 T:3011372368 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 2020-06-01 08:28:27.233 T:3011372368 DEBUG: FreeVisualisation() done 2020-06-01 08:28:27.234 T:3011372368 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 2020-06-01 08:28:27.236 T:3011372368 NOTICE: Whitelist search for: width: 3840, height: 2160, fps: 30.000, 3D: false 2020-06-01 08:28:27.237 T:3011372368 DEBUG: Whitelist is empty using default one 2020-06-01 08:28:27.237 T:3011372368 DEBUG: Trying to find exact refresh rate 2020-06-01 08:28:27.237 T:3011372368 DEBUG: No exact whitelisted resolution matched, trying double refresh rate 2020-06-01 08:28:27.237 T:3011372368 DEBUG: No double whitelisted resolution matched, trying 3:2 pullback 2020-06-01 08:28:27.237 T:3011372368 DEBUG: No 3:2 pullback refresh rate whitelisted resolution matched, trying current resolution 2020-06-01 08:28:27.237 T:3011372368 DEBUG: Matched current Resolution 3840x2160 @ 30.000000 Hz (16) 2020-06-01 08:28:27.237 T:3011372368 NOTICE: Display resolution ADJUST : 3840x2160 @ 30.000000 Hz (16) (weight: 0.069) 2020-06-01 08:28:27.239 T:3011372368 DEBUG: CDRMUtils::DrmFbDestroyCallback - removing framebuffer: 66 2020-06-01 08:28:27.241 T:2881561456 DEBUG: OnAVChange: CApplication::OnAVChange 2020-06-01 08:28:27.259 T:2644824944 DEBUG: ffmpeg[9DA4D370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:28:27.264 T:3011372368 DEBUG: Previous line repeats 4 times. 2020-06-01 08:28:27.264 T:3011372368 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 2020-06-01 08:28:27.265 T:2455741296 DEBUG: CMMALRenderer::SetVideoRect 0,0,3840,2160 -> 0,0,1920,1080 (o:0 v:0 d:0 i:0) 2020-06-01 08:28:27.265 T:2455741296 DEBUG: CMMALRenderer::SetVideoRect 0,0,3840,2160 -> 0,0,3840,2160 t:100000 2020-06-01 08:28:27.301 T:2644824944 DEBUG: ffmpeg[9DA4D370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:28:27.310 T:2988540784 DEBUG: Previous line repeats 4 times. 2020-06-01 08:28:27.310 T:2988540784 DEBUG: ActiveAE::SyncStream - average error of -35.725903, start adjusting 2020-06-01 08:28:27.310 T:2988540784 DEBUG: ActiveAE::SyncStream - average error -0.017570 below threshold of 30.000000 2020-06-01 08:28:27.322 T:2644824944 DEBUG: ffmpeg[9DA4D370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:28:27.479 T:2644824944 DEBUG: Previous line repeats 37 times. 2020-06-01 08:28:27.479 T:2644824944 NOTICE: CDVDVideoCodecFFmpeg::CDropControl: calculated diff time: 33272 2020-06-01 08:28:27.483 T:2644824944 DEBUG: ffmpeg[9DA4D370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:28:28.324 T:2653422448 DEBUG: Previous line repeats 124 times. 2020-06-01 08:28:28.324 T:2653422448 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:-29455.456932, adjusted:-33333.333333 2020-06-01 08:28:28.368 T:2644824944 DEBUG: ffmpeg[9DA4D370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:28:31.154 T:2644824944 DEBUG: Previous line repeats 402 times. 2020-06-01 08:28:31.154 T:2644824944 DEBUG: CPtsTracker: detected pattern of length 1: 33333.32, frameduration: 33333.333333 2020-06-01 08:28:31.205 T:2644824944 DEBUG: ffmpeg[9DA4D370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:28:36.058 T:2644824944 DEBUG: Previous line repeats 666 times. 2020-06-01 08:28:36.058 T:2644824944 DEBUG: CPtsTracker: pattern lost on diff 67000.000000, number of losses 1 2020-06-01 08:28:36.073 T:2644824944 DEBUG: ffmpeg[9DA4D370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:28:50.717 T:2644824944 DEBUG: Previous line repeats 1605 times. 2020-06-01 08:28:50.718 T:2644824944 DEBUG: CPtsTracker: detected pattern of length 1: 33333.33, frameduration: 33333.333333 2020-06-01 08:28:50.737 T:2644824944 DEBUG: ffmpeg[9DA4D370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:28:55.169 T:2644824944 DEBUG: Previous line repeats 578 times. 2020-06-01 08:28:55.169 T:2644824944 DEBUG: CPtsTracker: pattern lost on diff 67000.000000, number of losses 2 2020-06-01 08:28:55.180 T:2644824944 DEBUG: ffmpeg[9DA4D370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:28:57.241 T:2871456624 DEBUG: Previous line repeats 136 times. 2020-06-01 08:28:57.241 T:2871456624 DEBUG: Thread JobWorker 2871456624 terminating (autodelete) 2020-06-01 08:28:57.242 T:2881561456 DEBUG: Thread JobWorker 2881561456 terminating (autodelete) 2020-06-01 08:28:57.254 T:2644824944 DEBUG: ffmpeg[9DA4D370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL 2020-06-01 08:28:58.667 T:3011372368 DEBUG: Previous line repeats 96 times. 2020-06-01 08:28:58.667 T:3011372368 DEBUG: CMMALRenderer::RenderUpdate - vsync 22592 (+1) 2020-06-01 08:28:58.722 T:2644824944 DEBUG: ffmpeg[9DA4D370]: [hevc] av_rpi_zc_ref: *** Not one of our buffers: NULL