I have 2 Vero 4k’s on the latest stable update. Recently, if the TV had been off and I switch to the OSMC Input, the screen stays dimmed until I reload the skin. This is happening on 2 different TV’s.
Any suggestions?
1 Like
I suggest debug enabled logs showing the on/off/on of the TV and you pressing a remote button to get OSMC alive.
Ok the logs are here
HTTPS://paste.osmc.tv/walajevoba
In this case a switched inputs and left it long enough for the screen to dim and then switched back and had to reload the skin.
It was approx 07:15 when I reloaded the skin
How are you reloading the skin?
And when did you switch on/off/on your TV? And did you press remote buttons after you switched on?
So, this seems to be the relevant section :
http://paste.osmc.tv/izufiqifib
I reloaded the skin from the power menu. All i did this time was to swithc inputs and allow the screensaver to kick in… I then switched the input back to OSMC and navigated around the menu, then reloaded the skin.
i had the same issue, rebooting the vero solved it for me
I currently have this issue. I’ve rebooted multiple times and completely powered off all devices to no avail. The first time it happened I rebooted. The second time it happened I rebooted, then decided to just try the Black screensaver. Next time I could not access the device because it wouldn’t come out of black mode. I rebooted using the Kodi mobile device and changed to the google images screensaver. The google images screensaver works and i can get out of it, but it heats up the Vero pretty badly, so I don’t want to keep that one on.
Can you SSH in when this happens / is the device responding to ping?
Sorry, I wasn’t clear about that part. The device responds and I can watch movies, navigate, everything, but at 20% brightness. I can even get to the screensaver and adjust the dim percentage. I can adjust it up and when tested it will brighten, but will stay at that brightness. The only way to fix it is to reload the skin or reboot.
A couple days has passed since all this happened and I just re-enabled Dim and tested. It is working as expected now, of course! However, the previous issues I had happened after extended periods of the screensaver being active, so that will be the real test.
Same issue on an RPI3 with the July update (not yet latest one). On the menu screen, TV ON, dimming after a moment and never able to get it back. The box host a torrent server and I was connected to it, ping/ssh ok too. I was able to launch movies/browsing menu. To get it back I restarted the whole RPI, only occured once up to now
not being able to debug at the moment, but just to add that I’m seeing same thing on a Vero 4K+, connected through a Marantz receiver, and I use an alternative skin.
There’s no standby implementation for Raspberry Pi, so it may be an issue with a skin/add-on/screensaver.
Hi Sam, yes I was not clear enough about my issue. This is only a dim issue, never came back up to now. Kodi was still responsive but dimmed (dark as it is to spare the screen)
Just wanted to report, that I had today first time the same issue on my Vero 4k (latest July Release): The Vero4k stayed in dim mode - rebooting the Vero4k helped.
I think it’s a kodi bug. Looking in to this.
I also had this bug happen to me once as well, rebooting the device fixes said issue and it happened on a Vero 4k with the July update.
This issue is now happening again for me. I will reboot, but before doing so I allowed the screensaver to kick in multiple times. Every time has resulted in me having to reload the skin. See recent logs.
Blockquote
2019-08-31 10:50:29.553 T:3056554720 DEBUG: Thread BackgroundLoader 3056554720 terminating
2019-08-31 10:50:58.745 T:4064321536 DEBUG: SECTION:UnloadDelayed(DLL: libamcodec.so)
2019-08-31 10:50:59.464 T:2847703776 DEBUG: Thread JobWorker 2847703776 terminating (autodelete)
2019-08-31 10:50:59.480 T:3048162016 DEBUG: Thread JobWorker 3048162016 terminating (autodelete)
2019-08-31 10:50:59.480 T:3093246688 DEBUG: Thread JobWorker 3093246688 terminating (autodelete)
2019-08-31 10:50:59.486 T:3013604064 DEBUG: Thread JobWorker 3013604064 terminating (autodelete)
2019-08-31 10:52:03.977 T:4064321536 NOTICE: NFS is idle. Closing the remaining connections.
2019-08-31 10:52:09.472 T:3770663648 DEBUG: GetSongsByWhereJSON query: SELECT sv., song_artist.idArtist AS idArtist, songartist.strArtist AS strArtist FROM (SELECT song.idSong, strTitle, song.strGenres, song.iYear, iTimesPlayed, lastPlayed, rating, path.strPath || strFilename AS strPathFile, album.strAlbum AS strAlbum FROM song JOIN album ON album.idAlbum = song.idAlbum JOIN path ON path.idPath = song.idPath WHERE ((CAST(song.iTimesPlayed as DECIMAL(5,1)) < 1)) ORDER BY RANDOM() LIMIT 20) AS sv JOIN song_artist ON song_artist.idSong = sv.idSong AND song_artist.idRole = 1 JOIN artist AS songartist ON songartist.idArtist = song_artist.idArtist GROUP BY sv.idSong, song_artist.idArtist ORDER BY sv.idSong, song_artist.iOrder
2019-08-31 10:52:09.517 T:3770663648 DEBUG: GetSongsByWhereJSON - query took 45 ms
2019-08-31 10:52:09.558 T:3770663648 DEBUG: GetAlbumsByWhereJSON query: SELECT a1., album_artist.idArtist AS idArtist, artist.strArtist AS strArtist FROM (SELECT albumview.idAlbum, strAlbum, strReview, strGenres, strThemes, strMoods, strStyles, strType, strLabel, fRating, iYear, iTimesPlayed, art.url AS thumbnail FROM albumview LEFT JOIN art ON art.media_id = idAlbum AND art.media_type = ‘album’ AND art.type = ‘thumb’ WHERE albumview.strReleaseType = ‘album’ ORDER BY RANDOM() LIMIT 20) AS a1 JOIN album_artist ON album_artist.idAlbum = a1.idAlbum JOIN artist ON artist.idArtist = album_artist.idArtist GROUP BY a1.idAlbum, album_artist.idArtist ORDER BY a1.idAlbum, album_artist.iOrder
2019-08-31 10:52:09.581 T:3770663648 DEBUG: GetAlbumsByWhereJSON - query took 23 ms
2019-08-31 10:53:29.020 T:4064318176 DEBUG: CAnnouncementManager - Announcement: OnScreensaverActivated from xbmc
2019-08-31 10:53:29.021 T:4064318176 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverActivated
2019-08-31 10:53:29.024 T:4064321536 DEBUG: CAddonSettings[screensaver.xbmc.builtin.dim]: loading setting definitions
2019-08-31 10:53:29.025 T:4064321536 DEBUG: CAddonSettings[screensaver.xbmc.builtin.dim]: trying to load setting definitions from old format…
2019-08-31 10:53:29.025 T:4064321536 DEBUG: CAddonSettings[screensaver.xbmc.builtin.dim]: loading setting values
2019-08-31 10:53:29.025 T:4064321536 DEBUG: ------ Window Init () ------
2019-08-31 10:53:29.142 T:3779056352 DEBUG: Skin Helper Service → Kodi_Monitor: sender xbmc - method: GUI.OnScreensaverActivated - data: null
2019-08-31 10:57:00.518 T:3013604064 DEBUG: Thread JobWorker start, auto delete: true
2019-08-31 10:57:30.518 T:3013604064 DEBUG: Thread JobWorker 3013604064 terminating (autodelete)
2019-08-31 10:59:04.750 T:3747607264 DEBUG: PushCecKeypress - received key d8 duration 0
2019-08-31 10:59:04.778 T:4064318176 DEBUG: CAnnouncementManager - Announcement: OnScreensaverDeactivated from xbmc
2019-08-31 10:59:04.779 T:4064318176 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverDeactivated
2019-08-31 10:59:04.779 T:4064321536 DEBUG: HandleKey: menu (0xd8) pressed, screen saver/dpms woken up
2019-08-31 10:59:04.825 T:3747607264 DEBUG: PushCecKeypress - received key d8 duration 75
2019-08-31 10:59:04.845 T:3779056352 DEBUG: Skin Helper Service → Kodi_Monitor: sender xbmc - method: GUI.OnScreensaverDeactivated - data: {“shuttingdown”:false}
2019-08-31 10:59:06.786 T:3747607264 DEBUG: PushCecKeypress - received key d8 duration 0
2019-08-31 10:59:06.823 T:4064321536 DEBUG: HandleKey: menu (0xd8) pressed, action is Back
2019-08-31 10:59:06.824 T:4064321536 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
2019-08-31 10:59:06.861 T:3747607264 DEBUG: PushCecKeypress - received key d8 duration 75
2019-08-31 10:59:07.485 T:4064321536 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
2019-08-31 10:59:07.488 T:4064321536 DEBUG: FreeVisualisation() done
2019-08-31 10:59:07.498 T:4064321536 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
2019-08-31 10:59:07.498 T:4064321536 DEBUG: ------ Window Init (Home.xml) ------
2019-08-31 10:59:07.499 T:4064321536 DEBUG: CDirectoryProvider[videodb://movies/titles/]: refreshing…
2019-08-31 10:59:07.499 T:3013604064 DEBUG: Thread JobWorker start, auto delete: true
2019-08-31 10:59:07.500 T:4064321536 DEBUG: CDirectoryProvider[videodb://tvshows/titles/]: refreshing…
2019-08-31 10:59:07.500 T:3093246688 DEBUG: Thread JobWorker start, auto delete: true
2019-08-31 10:59:07.503 T:4064321536 DEBUG: CDirectoryProvider[special://skin/extras/playlists/recentmovies.xsp]: refreshing…
2019-08-31 10:59:07.504 T:3048162016 DEBUG: Thread JobWorker start, auto delete: true
2019-08-31 10:59:07.504 T:4064321536 DEBUG: CDirectoryProvider[special://skin/extras/playlists/recentmovies.xsp]: refreshing…
2019-08-31 10:59:07.504 T:4064321536 DEBUG: CDirectoryProvider[videodb://recentlyaddedmovies/]: refreshing…
2019-08-31 10:59:07.505 T:4064321536 DEBUG: CDirectoryProvider[videodb://recentlyaddedepisodes/]: refreshing…
2019-08-31 10:59:07.505 T:4064321536 DEBUG: CDirectoryProvider[sources://video/]: refreshing…
2019-08-31 10:59:07.505 T:4064321536 DEBUG: CDirectoryProvider[special://skin/extras/InProgressMovies.xsp]: refreshing…
2019-08-31 10:59:07.505 T:4064321536 DEBUG: CDirectoryProvider[plugin://service.library.data.provider?type=randomepisodes&reload=20190831155209]: refreshing…
2019-08-31 10:59:07.517 T:2847703776 DEBUG: Thread LanguageInvoker start, auto delete: false
2019-08-31 10:59:07.517 T:2847703776 INFO: initializing python engine.
2019-08-31 10:59:07.517 T:2847703776 DEBUG: CPythonInvoker(93, /home/osmc/.kodi/addons/script.skinshortcuts/default.py): start processing
2019-08-31 10:59:07.522 T:3747607264 DEBUG: PushCecKeypress - received key a9 duration 0
2019-08-31 10:59:07.537 T:3162071776 DEBUG: Thread JobWorker start, auto delete: true
2019-08-31 10:59:07.598 T:4064321536 DEBUG: HandleKey: 169 (0xa9, obc86) pressed, action is Left
2019-08-31 10:59:07.599 T:3162071776 DEBUG: ffmpeg[BC7962E0]: [swscaler] No accelerated colorspace conversion found from yuv420p to bgra.
2019-08-31 10:59:07.778 T:3747607264 DEBUG: Previous line repeats 1 times.
2019-08-31 10:59:07.779 T:3747607264 DEBUG: PushCecKeypress - received key a9 duration 255
2019-08-31 10:59:07.980 T:2847703776 DEBUG: -->Python Interpreter Initialized<–
2019-08-31 10:59:07.981 T:2847703776 DEBUG: CPythonInvoker(93, /home/osmc/.kodi/addons/script.skinshortcuts/default.py): the source file to load is “/home/osmc/.kodi/addons/script.skinshortcuts/default.py”
2019-08-31 10:59:07.982 T:2847703776 DEBUG: CPythonInvoker(93, /home/osmc/.kodi/addons/script.skinshortcuts/default.py): setting the Python path to /home/osmc/.kodi/addons/script.skinshortcuts:/home/osmc/.kodi/addons/script.module.simplejson/lib:/home/osmc/.kodi/addons/script.module.unidecode/lib:/usr/lib/python2.7:/usr/lib/python2.7/plat-arm-linux-gnueabihf:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PILcompat:/usr/lib/python2.7/dist-packages/gtk-2.0
2019-08-31 10:59:07.982 T:2847703776 DEBUG: CPythonInvoker(93, /home/osmc/.kodi/addons/script.skinshortcuts/default.py): entering source directory /home/osmc/.kodi/addons/script.skinshortcuts
2019-08-31 10:59:07.982 T:2847703776 DEBUG: CPythonInvoker(93, /home/osmc/.kodi/addons/script.skinshortcuts/default.py): instantiating addon using automatically obtained id of “script.skinshortcuts” dependent on version 2.20.0 of the xbmc.python api
2019-08-31 10:59:08.038 T:3162071776 DEBUG: NFS: Context for 192.168.1.40/Media not open - get a new context.
2019-08-31 10:59:08.071 T:3162071776 DEBUG: NFS: Connected to server 192.168.1.40 and export /Media
2019-08-31 10:59:08.071 T:3162071776 DEBUG: NFS: chunks: r/w 524288/524288
2019-08-31 10:59:08.080 T:3162071776 DEBUG: StartScript - calling plugin Library Data Provider(‘plugin://service.library.data.provider/’,‘40’,‘?type=randomepisodes&reload=20190831155209’,‘resume:false’)
2019-08-31 10:59:08.083 T:3124212448 DEBUG: Thread LanguageInvoker start, auto delete: false
2019-08-31 10:59:08.083 T:3124212448 INFO: initializing python engine.
2019-08-31 10:59:08.083 T:3124212448 DEBUG: CPythonInvoker(94, /home/osmc/.kodi/addons/service.library.data.provider/plugin.py): start processing
2019-08-31 10:59:08.292 T:3048162016 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
2019-08-31 10:59:08.298 T:3048162016 DEBUG: GetArtistsByWhere query: SELECT COUNT(DISTINCT artistview.idArtist) FROM artistview WHERE (EXISTS (SELECT 1 FROM song_artist WHERE song_artist.idArtist = artistview.idArtist AND song_artist.idRole = 1) OR EXISTS (SELECT 1 FROM album_artist WHERE album_artist.idArtist = artistview.idArtist)) AND (artistview.strArtist != ‘’)
2019-08-31 10:59:09.304 T:2847703776 DEBUG: CAddonSettings[script.skinshortcuts]: loading setting definitions
2019-08-31 10:59:09.304 T:2847703776 DEBUG: CAddonSettings[script.skinshortcuts]: trying to load setting definitions from old format…
2019-08-31 10:59:09.304 T:2847703776 DEBUG: CAddonSettings[script.skinshortcuts]: loading setting values
2019-08-31 10:59:09.305 T:3124212448 DEBUG: -->Python Interpreter Initialized<–
2019-08-31 10:59:09.305 T:3124212448 DEBUG: CPythonInvoker(94, /home/osmc/.kodi/addons/service.library.data.provider/plugin.py): the source file to load is “/home/osmc/.kodi/addons/service.library.data.provider/plugin.py”
2019-08-31 10:59:09.306 T:3124212448 DEBUG: CPythonInvoker(94, /home/osmc/.kodi/addons/service.library.data.provider/plugin.py): setting the Python path to /home/osmc/.kodi/addons/service.library.data.provider:/home/osmc/.kodi/addons/script.module.routing/lib:/home/osmc/.kodi/addons/script.module.simplejson/lib:/usr/lib/python2.7:/usr/lib/python2.7/plat-arm-linux-gnueabihf:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PILcompat:/usr/lib/python2.7/dist-packages/gtk-2.0
2019-08-31 10:59:09.306 T:3124212448 DEBUG: CPythonInvoker(94, /home/osmc/.kodi/addons/service.library.data.provider/plugin.py): entering source directory /home/osmc/.kodi/addons/service.library.data.provider
2019-08-31 10:59:09.306 T:3124212448 DEBUG: CPythonInvoker(94, /home/osmc/.kodi/addons/service.library.data.provider/plugin.py): instantiating addon using automatically obtained id of “service.library.data.provider” dependent on version 2.25.0 of the xbmc.python api
2019-08-31 10:59:09.378 T:3124212448 DEBUG: CAddonSettings[service.library.data.provider]: loading setting definitions
2019-08-31 10:59:09.378 T:3124212448 DEBUG: CAddonSettings[service.library.data.provider]: trying to load setting definitions from old format…
2019-08-31 10:59:09.380 T:3124212448 DEBUG: CAddonSettings[service.library.data.provider]: loading setting definitions
2019-08-31 10:59:09.380 T:3124212448 DEBUG: CAddonSettings[service.library.data.provider]: trying to load setting definitions from old format…
2019-08-31 10:59:09.381 T:3124212448 DEBUG: CAddonSettings[service.library.data.provider]: loading setting definitions
2019-08-31 10:59:09.381 T:3124212448 DEBUG: CAddonSettings[service.library.data.provider]: trying to load setting definitions from old format…
2019-08-31 10:59:09.382 T:3124212448 DEBUG: CAddonSettings[service.library.data.provider]: loading setting definitions
2019-08-31 10:59:09.382 T:3124212448 DEBUG: CAddonSettings[service.library.data.provider]: trying to load setting definitions from old format…
2019-08-31 10:59:09.683 T:3124212448 DEBUG: Library Data Provider: script version 0.3.2 started
2019-08-31 10:59:09.683 T:3124212448 DEBUG: CAddonSettings[service.library.data.provider]: loading setting definitions
2019-08-31 10:59:09.684 T:3124212448 DEBUG: CAddonSettings[service.library.data.provider]: trying to load setting definitions from old format…
2019-08-31 10:59:09.712 T:2847703776 DEBUG: CAddonSettings[script.skinshortcuts]: loading setting definitions
2019-08-31 10:59:09.712 T:2847703776 DEBUG: CAddonSettings[script.skinshortcuts]: trying to load setting definitions from old format…
2019-08-31 10:59:09.712 T:2847703776 DEBUG: CAddonSettings[script.skinshortcuts]: loading setting values
2019-08-31 10:59:09.735 T:3072324320 DEBUG: Thread Timer start, auto delete: false
2019-08-31 10:59:09.768 T:2847703776 INFO: CPythonInvoker(93, /home/osmc/.kodi/addons/script.skinshortcuts/default.py): script successfully run
2019-08-31 10:59:09.775 T:2847703776 DEBUG: onExecutionDone(93, /home/osmc/.kodi/addons/script.skinshortcuts/default.py)
2019-08-31 10:59:09.776 T:3072324320 DEBUG: Thread Timer 3072324320 terminating
2019-08-31 10:59:09.777 T:3063931616 DEBUG: Thread Timer start, auto delete: false
2019-08-31 10:59:09.921 T:2847703776 INFO: Python interpreter stopped
2019-08-31 10:59:09.921 T:2847703776 DEBUG: Thread LanguageInvoker 2847703776 terminating
2019-08-31 10:59:10.145 T:3124212448 DEBUG: Library Data Provider: script version 0.3.2 stopped
2019-08-31 10:59:10.146 T:3124212448 INFO: CPythonInvoker(94, /home/osmc/.kodi/addons/service.library.data.provider/plugin.py): script successfully run
2019-08-31 10:59:10.151 T:3124212448 DEBUG: onExecutionDone(94, /home/osmc/.kodi/addons/service.library.data.provider/plugin.py)
2019-08-31 10:59:10.284 T:3063931616 DEBUG: Thread Timer 3063931616 terminating
2019-08-31 10:59:10.313 T:3124212448 INFO: Python interpreter stopped
2019-08-31 10:59:10.313 T:3124212448 DEBUG: Thread LanguageInvoker 3124212448 terminating
2019-08-31 10:59:37.637 T:3093246688 DEBUG: Thread JobWorker 3093246688 terminating (autodelete)
2019-08-31 10:59:38.413 T:3048162016 DEBUG: Thread JobWorker 3048162016 terminating (autodelete)
2019-08-31 10:59:38.584 T:3013604064 DEBUG: Thread JobWorker 3013604064 terminating (autodelete)
2019-08-31 10:59:40.171 T:3162071776 DEBUG: Thread JobWorker 3162071776 terminating (autodelete)
Difficult to tell from log snippets, but Kodi v18.4 might resolve some issues here.
Got it. Will that be in the next OSMC release? Could you use more detailed logs?